2025-11-30 12:28:40.302545 | Job console starting... 2025-11-30 12:28:40.314533 | Updating repositories 2025-11-30 12:28:40.340570 | Preparing job workspace 2025-11-30 12:28:45.575304 | Running Ansible setup... 2025-11-30 12:28:49.487297 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-11-30 12:28:50.032476 | 2025-11-30 12:28:50.032635 | PLAY [localhost] 2025-11-30 12:28:50.041042 | 2025-11-30 12:28:50.041112 | TASK [Gathering Facts] 2025-11-30 12:28:51.034507 | localhost | ok 2025-11-30 12:28:51.063784 | 2025-11-30 12:28:51.063955 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-30 12:28:51.488857 | localhost -> localhost | changed 2025-11-30 12:28:51.493967 | 2025-11-30 12:28:51.494038 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-30 12:28:52.360724 | localhost -> localhost | changed 2025-11-30 12:28:52.378451 | 2025-11-30 12:28:52.378589 | TASK [Setup log path fact] 2025-11-30 12:28:52.403292 | localhost | ok 2025-11-30 12:28:52.427429 | 2025-11-30 12:28:52.427571 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-30 12:28:52.459057 | localhost | ok 2025-11-30 12:28:52.469022 | 2025-11-30 12:28:52.469106 | TASK [emit-job-header : Print job information] 2025-11-30 12:28:52.521942 | # Job Information 2025-11-30 12:28:52.522162 | Ansible Version: 2.15.12 2025-11-30 12:28:52.522218 | Job: vexxhost-hotstack-sno-2-bm 2025-11-30 12:28:52.522262 | Pipeline: github-experimental-trigger 2025-11-30 12:28:52.522302 | Executor: ze04.softwarefactory-project.io 2025-11-30 12:28:52.522341 | Triggered by: https://github.com/openstack-k8s-operators/hotstack/pull/235 2025-11-30 12:28:52.522381 | Log URL (when completed): https://logserver.rdoproject.org/ff4/rdoproject.org/ff46f3ed9540495c958812cdded33495/ 2025-11-30 12:28:52.522421 | Event ID: 03dedf90-cde8-11f0-980a-1e3854f28d5a 2025-11-30 12:28:52.530046 | 2025-11-30 12:28:52.530178 | LOOP [emit-job-header : Print node information] 2025-11-30 12:28:52.641877 | localhost | ok: 2025-11-30 12:28:52.642110 | localhost | # Node Information 2025-11-30 12:28:52.642169 | localhost | Inventory Hostname: hotstack 2025-11-30 12:28:52.642219 | localhost | Hostname: np0005540195 2025-11-30 12:28:52.642261 | localhost | Username: zuul 2025-11-30 12:28:52.642304 | localhost | Distro: CentOS 9 2025-11-30 12:28:52.642342 | localhost | Provider: vexxhost-nodepool-tripleo 2025-11-30 12:28:52.642380 | localhost | Region: RegionOne 2025-11-30 12:28:52.642417 | localhost | Label: cloud-centos-9-stream-tripleo-vexxhost 2025-11-30 12:28:52.642454 | localhost | Product Name: OpenStack Nova 2025-11-30 12:28:52.642489 | localhost | Interface IP: 38.102.83.70 2025-11-30 12:28:52.685897 | 2025-11-30 12:28:52.686010 | PLAY [all] 2025-11-30 12:28:52.699347 | 2025-11-30 12:28:52.699472 | TASK [Gather network facts] 2025-11-30 12:28:53.229193 | hotstack | ok 2025-11-30 12:28:53.260247 | 2025-11-30 12:28:53.260371 | TASK [include_role : start-zuul-console] 2025-11-30 12:28:53.282976 | hotstack | ok 2025-11-30 12:28:53.297828 | 2025-11-30 12:28:53.297910 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-30 12:28:53.729547 | hotstack | ok 2025-11-30 12:28:53.748148 | 2025-11-30 12:28:53.748272 | TASK [include_role : add-build-sshkey] 2025-11-30 12:28:53.784594 | hotstack | ok 2025-11-30 12:28:53.811076 | 2025-11-30 12:28:53.811169 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-30 12:28:54.090356 | hotstack -> localhost | ok 2025-11-30 12:28:54.101954 | 2025-11-30 12:28:54.102087 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-30 12:28:54.140725 | hotstack | ok 2025-11-30 12:28:54.167102 | hotstack | included: /var/lib/zuul/builds/ff46f3ed9540495c958812cdded33495/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-30 12:28:54.175803 | 2025-11-30 12:28:54.175891 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-30 12:28:54.780280 | hotstack -> localhost | Generating public/private rsa key pair. 2025-11-30 12:28:54.780473 | hotstack -> localhost | Your identification has been saved in /var/lib/zuul/builds/ff46f3ed9540495c958812cdded33495/work/ff46f3ed9540495c958812cdded33495_id_rsa. 2025-11-30 12:28:54.780505 | hotstack -> localhost | Your public key has been saved in /var/lib/zuul/builds/ff46f3ed9540495c958812cdded33495/work/ff46f3ed9540495c958812cdded33495_id_rsa.pub. 2025-11-30 12:28:54.780528 | hotstack -> localhost | The key fingerprint is: 2025-11-30 12:28:54.780549 | hotstack -> localhost | SHA256:Wg0v54K1TXOAJCxHlDDOnWUiG4xXa0T6mnCf73eKXWc zuul-build-sshkey 2025-11-30 12:28:54.780567 | hotstack -> localhost | The key's randomart image is: 2025-11-30 12:28:54.780585 | hotstack -> localhost | +---[RSA 3072]----+ 2025-11-30 12:28:54.780604 | hotstack -> localhost | | o=BO.+ | 2025-11-30 12:28:54.780624 | hotstack -> localhost | | .o+O+O . | 2025-11-30 12:28:54.780643 | hotstack -> localhost | | .=o= o . | 2025-11-30 12:28:54.780661 | hotstack -> localhost | | o + . | 2025-11-30 12:28:54.780730 | hotstack -> localhost | | . . . S * . | 2025-11-30 12:28:54.780755 | hotstack -> localhost | | o + * B o | 2025-11-30 12:28:54.780775 | hotstack -> localhost | | o = o o . E | 2025-11-30 12:28:54.780795 | hotstack -> localhost | | . +...o | 2025-11-30 12:28:54.780814 | hotstack -> localhost | | .+.oo | 2025-11-30 12:28:54.780831 | hotstack -> localhost | +----[SHA256]-----+ 2025-11-30 12:28:54.780880 | hotstack -> localhost | ok: Runtime: 0:00:00.161403 2025-11-30 12:28:54.786462 | 2025-11-30 12:28:54.786522 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-30 12:28:54.821757 | hotstack | ok 2025-11-30 12:28:54.835066 | hotstack | included: /var/lib/zuul/builds/ff46f3ed9540495c958812cdded33495/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-30 12:28:54.846162 | 2025-11-30 12:28:54.846252 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-30 12:28:54.871553 | hotstack | skipping: Conditional result was False 2025-11-30 12:28:54.879149 | 2025-11-30 12:28:54.879237 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-30 12:28:55.384645 | hotstack | changed 2025-11-30 12:28:55.394872 | 2025-11-30 12:28:55.395000 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-30 12:28:55.696956 | hotstack | ok 2025-11-30 12:28:55.707462 | 2025-11-30 12:28:55.707597 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-30 12:28:56.681250 | hotstack | changed 2025-11-30 12:28:56.691998 | 2025-11-30 12:28:56.692127 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-30 12:28:57.677088 | hotstack | changed 2025-11-30 12:28:57.687521 | 2025-11-30 12:28:57.687649 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-30 12:28:57.714487 | hotstack | skipping: Conditional result was False 2025-11-30 12:28:57.725581 | 2025-11-30 12:28:57.725765 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-30 12:28:58.150913 | hotstack -> localhost | changed 2025-11-30 12:28:58.172577 | 2025-11-30 12:28:58.172815 | TASK [add-build-sshkey : Add back temp key] 2025-11-30 12:28:58.465089 | hotstack -> localhost | Identity added: /var/lib/zuul/builds/ff46f3ed9540495c958812cdded33495/work/ff46f3ed9540495c958812cdded33495_id_rsa (zuul-build-sshkey) 2025-11-30 12:28:58.465480 | hotstack -> localhost | ok: Runtime: 0:00:00.013368 2025-11-30 12:28:58.477235 | 2025-11-30 12:28:58.477376 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-30 12:28:58.903553 | hotstack | ok 2025-11-30 12:28:58.936860 | 2025-11-30 12:28:58.937002 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-30 12:28:58.972545 | hotstack | skipping: Conditional result was False 2025-11-30 12:28:58.985255 | 2025-11-30 12:28:58.985339 | TASK [include_role : validate-host] 2025-11-30 12:28:59.015947 | hotstack | ok 2025-11-30 12:28:59.041079 | 2025-11-30 12:28:59.041172 | TASK [validate-host : Define zuul_info_dir fact] 2025-11-30 12:28:59.081920 | hotstack | ok 2025-11-30 12:28:59.088037 | 2025-11-30 12:28:59.088118 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-11-30 12:28:59.325855 | hotstack -> localhost | ok 2025-11-30 12:28:59.331541 | 2025-11-30 12:28:59.331605 | TASK [validate-host : Collect information about the host] 2025-11-30 12:29:00.174160 | hotstack | ok 2025-11-30 12:29:00.192053 | 2025-11-30 12:29:00.192187 | TASK [validate-host : Sanitize hostname] 2025-11-30 12:29:00.269600 | hotstack | ok 2025-11-30 12:29:00.279817 | 2025-11-30 12:29:00.279949 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-11-30 12:29:00.776612 | hotstack -> localhost | changed 2025-11-30 12:29:00.789877 | 2025-11-30 12:29:00.790015 | TASK [validate-host : Collect information about zuul worker] 2025-11-30 12:29:01.236349 | hotstack | ok 2025-11-30 12:29:01.246482 | 2025-11-30 12:29:01.246608 | TASK [validate-host : Write out all zuul information for each host] 2025-11-30 12:29:01.785537 | hotstack -> localhost | changed 2025-11-30 12:29:01.805805 | 2025-11-30 12:29:01.805935 | TASK [include_role : prepare-workspace-openshift] 2025-11-30 12:29:01.833117 | hotstack | skipping: Conditional result was False 2025-11-30 12:29:01.843159 | 2025-11-30 12:29:01.843280 | TASK [include_role : remove-zuul-sshkey] 2025-11-30 12:29:01.869614 | hotstack | skipping: Conditional result was False 2025-11-30 12:29:01.880431 | 2025-11-30 12:29:01.880555 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-11-30 12:29:02.208862 | hotstack | ok: "logs" 2025-11-30 12:29:02.209318 | hotstack | ok: All items complete 2025-11-30 12:29:02.209376 | 2025-11-30 12:29:02.458125 | hotstack | ok: "artifacts" 2025-11-30 12:29:02.698722 | hotstack | ok: "docs" 2025-11-30 12:29:02.707747 | 2025-11-30 12:29:02.707869 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-11-30 12:29:03.034381 | hotstack | changed: "logs" 2025-11-30 12:29:03.320069 | hotstack | changed: "artifacts" 2025-11-30 12:29:03.580714 | hotstack | changed: "docs" 2025-11-30 12:29:03.614023 | 2025-11-30 12:29:03.614092 | PLAY RECAP 2025-11-30 12:29:03.614146 | hotstack | ok: 22 changed: 9 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2025-11-30 12:29:03.614200 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-11-30 12:29:03.614228 | 2025-11-30 12:29:03.714988 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/pre.yaml@master] 2025-11-30 12:29:03.718619 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/hotstack/pre_stage1.yaml@master] 2025-11-30 12:29:04.279741 | 2025-11-30 12:29:04.279842 | PLAY [Create necessary files to deploy hotstack scenario] 2025-11-30 12:29:04.300196 | 2025-11-30 12:29:04.300291 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-11-30 12:29:04.741906 | hotstack | ok 2025-11-30 12:29:04.754885 | 2025-11-30 12:29:04.755043 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-11-30 12:29:07.864082 | hotstack | Output suppressed because no_log was given 2025-11-30 12:29:07.884661 | 2025-11-30 12:29:07.884836 | LOOP [add-authorized-keys : Enable access via build key on all nodes] 2025-11-30 12:29:08.408126 | hotstack | changed: 2025-11-30 12:29:08.408460 | hotstack | { 2025-11-30 12:29:08.408522 | 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-11-30 12:29:08.408570 | hotstack | } 2025-11-30 12:29:08.433732 | 2025-11-30 12:29:08.433919 | TASK [Assert cloud name and cloud secret] 2025-11-30 12:29:08.513497 | hotstack | Output suppressed because no_log was given 2025-11-30 12:29:08.523900 | 2025-11-30 12:29:08.524028 | TASK [Ensure openstack release repo is installed] 2025-11-30 12:29:12.698085 | hotstack | changed 2025-11-30 12:29:12.709086 | 2025-11-30 12:29:12.709213 | TASK [Install openstack client packages] 2025-11-30 12:29:29.065728 | hotstack | changed 2025-11-30 12:29:29.077587 | 2025-11-30 12:29:29.077765 | TASK [Ensure HotStack work dir] 2025-11-30 12:29:29.482731 | hotstack | changed 2025-11-30 12:29:29.493783 | 2025-11-30 12:29:29.493911 | LOOP [Ensure etc directories] 2025-11-30 12:29:29.823266 | hotstack | changed: "/etc/openstack" 2025-11-30 12:29:29.823757 | hotstack | changed: All items complete 2025-11-30 12:29:29.823825 | 2025-11-30 12:29:30.108464 | hotstack | changed: "/etc/hotstack" 2025-11-30 12:29:30.124338 | 2025-11-30 12:29:30.124474 | TASK [Ensure .ssh dir exists] 2025-11-30 12:29:30.386137 | hotstack | Output suppressed because no_log was given 2025-11-30 12:29:30.397409 | 2025-11-30 12:29:30.397538 | TASK [Ensure ssh keypair exists] 2025-11-30 12:29:40.958836 | hotstack | Output suppressed because no_log was given 2025-11-30 12:29:40.970325 | 2025-11-30 12:29:40.970455 | TASK [Generate CA cert file] 2025-11-30 12:29:41.007673 | hotstack | skipping: Conditional result was False 2025-11-30 12:29:41.019931 | 2025-11-30 12:29:41.020063 | TASK [Update CA certs] 2025-11-30 12:29:41.568209 | hotstack | skipping: Conditional result was False 2025-11-30 12:29:41.580744 | 2025-11-30 12:29:41.580874 | TASK [Set _auth_type fact] 2025-11-30 12:29:41.637752 | hotstack | Output suppressed because no_log was given 2025-11-30 12:29:41.647634 | 2025-11-30 12:29:41.647791 | TASK [Write clouds.yaml - user/password] 2025-11-30 12:29:42.797750 | hotstack | Output suppressed because no_log was given 2025-11-30 12:29:42.808225 | 2025-11-30 12:29:42.808356 | TASK [Create application credential for sushy-emulator] 2025-11-30 12:29:45.359149 | hotstack | Output suppressed because no_log was given 2025-11-30 12:29:45.369892 | 2025-11-30 12:29:45.370026 | TASK [Read application credential from file] 2025-11-30 12:29:45.744757 | hotstack | Output suppressed because no_log was given 2025-11-30 12:29:45.755039 | 2025-11-30 12:29:45.755170 | TASK [Delete temporary application credential file] 2025-11-30 12:29:46.015491 | hotstack | Output suppressed because no_log was given 2025-11-30 12:29:46.025384 | 2025-11-30 12:29:46.025504 | TASK [Assert application credential id and secret] 2025-11-30 12:29:46.112661 | hotstack | Output suppressed because no_log was given 2025-11-30 12:29:46.122610 | 2025-11-30 12:29:46.122758 | TASK [Write new clouds.yaml with application credentials] 2025-11-30 12:29:47.056723 | hotstack | Output suppressed because no_log was given 2025-11-30 12:29:47.066725 | 2025-11-30 12:29:47.066803 | TASK [Write hotstack cloud-secret.yaml] 2025-11-30 12:29:47.949848 | hotstack | Output suppressed because no_log was given 2025-11-30 12:29:47.959933 | 2025-11-30 12:29:47.960063 | TASK [Write clouds.yaml with application credentials] 2025-11-30 12:29:47.997973 | 2025-11-30 12:29:47.998208 | TASK [Write hotstack cloud-secret.yaml] 2025-11-30 12:29:48.066119 | 2025-11-30 12:29:48.066247 | PLAY RECAP 2025-11-30 12:29:48.066305 | hotstack | ok: 18 changed: 11 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-11-30 12:29:48.066332 | 2025-11-30 12:29:48.166896 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/hotstack/pre_stage1.yaml@master] 2025-11-30 12:29:48.172354 | PRE-RUN START: [trusted : review.rdoproject.org/config/playbooks/hotstack/pre_stage2.yaml@master] 2025-11-30 12:29:48.745572 | 2025-11-30 12:29:48.745697 | PLAY [Create hotstack scenario] 2025-11-30 12:29:48.768434 | 2025-11-30 12:29:48.768508 | TASK [Assert scenario is defined] 2025-11-30 12:29:48.854333 | hotstack | ok: All assertions passed 2025-11-30 12:29:48.866658 | 2025-11-30 12:29:48.866863 | TASK [Fetch bootstrap vars from remote to zuul executor] 2025-11-30 12:29:49.336877 | hotstack | Output suppressed because no_log was given 2025-11-30 12:29:49.348050 | 2025-11-30 12:29:49.348188 | TASK [Load bootstrap vars with template resolution] 2025-11-30 12:29:49.384797 | hotstack | Output suppressed because no_log was given 2025-11-30 12:29:49.395648 | 2025-11-30 12:29:49.395801 | TASK [Fetch automation vars from remote to zuul executor] 2025-11-30 12:29:49.830237 | hotstack | Output suppressed because no_log was given 2025-11-30 12:29:49.840729 | 2025-11-30 12:29:49.840862 | TASK [Load automation vars with template resolution] 2025-11-30 12:29:49.908758 | hotstack | Output suppressed because no_log was given 2025-11-30 12:29:49.918929 | 2025-11-30 12:29:49.919055 | TASK [Slurp zuul-build-sshkey from file] 2025-11-30 12:29:50.343650 | hotstack | Output suppressed because no_log was given 2025-11-30 12:29:50.355520 | 2025-11-30 12:29:50.355652 | TASK [Set up infrastructure (Heat stack)] 2025-11-30 12:29:50.382217 | hotstack | Output suppressed because no_log was given 2025-11-30 12:29:50.442787 | 2025-11-30 12:29:50.442917 | TASK [dataplane_ssh_keys : Ensure Dataplane ssh keypair exists] 2025-11-30 12:29:51.046613 | hotstack | changed 2025-11-30 12:29:51.058765 | 2025-11-30 12:29:51.058895 | TASK [dataplane_ssh_keys : Ensure Nova migration ssh keypair exists] 2025-11-30 12:29:51.525433 | hotstack | changed 2025-11-30 12:29:51.537112 | 2025-11-30 12:29:51.537244 | TASK [dataplane_ssh_keys : Set SSH public key facts] 2025-11-30 12:29:51.584505 | hotstack | ok 2025-11-30 12:29:51.596106 | 2025-11-30 12:29:51.596239 | TASK [dataplane_ssh_keys : Store SSH public key facts in file] 2025-11-30 12:29:52.654749 | hotstack | changed 2025-11-30 12:29:52.675766 | 2025-11-30 12:29:52.675897 | TASK [heat_stack : Assert config is defined] 2025-11-30 12:29:52.794358 | hotstack | ok: All assertions passed 2025-11-30 12:29:52.805170 | 2025-11-30 12:29:52.805300 | TASK [heat_stack : Get latest snapset and update stack parameters] 2025-11-30 12:29:52.853202 | hotstack | skipping: Conditional result was False 2025-11-30 12:29:52.866495 | 2025-11-30 12:29:52.866628 | TASK [heat_stack : Debug latest snapset information] 2025-11-30 12:29:52.913870 | hotstack | skipping: Conditional result was False 2025-11-30 12:29:52.926222 | 2025-11-30 12:29:52.926353 | TASK [heat_stack : Create stack] 2025-11-30 12:29:56.038099 | hotstack | ERROR 2025-11-30 12:29:56.038395 | hotstack | { 2025-11-30 12:29:56.038455 | hotstack | "extra_data": { 2025-11-30 12:29:56.038497 | hotstack | "data": null, 2025-11-30 12:29:56.038534 | hotstack | "details": "Property error: : resources.ironic1.properties.block_device_mapping_v2[1].disk_bus: : \"sata\" is not an allowed value [\"ide\", \"lame_bus\", \"scsi\", \"usb\", \"virtio\"]", 2025-11-30 12:29:56.038577 | hotstack | "response": "{\"code\": 400, \"title\": \"Bad Request\", \"explanation\": \"The server could not comply with the request since it is either malformed or otherwise incorrect.\", \"error\": {\"type\": \"StackValidationFailed\", \"traceback\": null, \"message\": \"Property error: : resources.ironic1.properties.block_device_mapping_v2[1].disk_bus: : \\\"sata\\\" is not an allowed value [\\\"ide\\\", \\\"lame_bus\\\", \\\"scsi\\\", \\\"usb\\\", \\\"virtio\\\"]\"}}" 2025-11-30 12:29:56.038616 | hotstack | }, 2025-11-30 12:29:56.038653 | hotstack | "msg": "BadRequestException: 400: Client Error for url: https://orchestration.rdo.mtl2.vexxhost.net/v1/4b633c451ac74233be3721a3635275e5/stacks, Property error: : resources.ironic1.properties.block_device_mapping_v2[1].disk_bus: : \"sata\" is not an allowed value [\"ide\", \"lame_bus\", \"scsi\", \"usb\", \"virtio\"]" 2025-11-30 12:29:56.038729 | hotstack | } failure 2025-11-30 12:29:56.042023 | 2025-11-30 12:29:56.042127 | PLAY RECAP 2025-11-30 12:29:56.042207 | hotstack | ok: 11 changed: 5 unreachable: 0 failed: 1 skipped: 2 rescued: 0 ignored: 0 2025-11-30 12:29:56.042251 | 2025-11-30 12:29:56.145741 | PRE-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/hotstack/pre_stage2.yaml@master] 2025-11-30 12:29:56.148482 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/hotstack/post.yaml@master] 2025-11-30 12:29:56.731449 | 2025-11-30 12:29:56.731558 | PLAY [Collect hotstack logs and clean up environment] 2025-11-30 12:29:56.752192 | 2025-11-30 12:29:56.752266 | TASK [Fetch stack outputs from remote to zuul executor] 2025-11-30 12:29:57.493248 | hotstack | Output suppressed because no_log was given 2025-11-30 12:29:57.504001 | 2025-11-30 12:29:57.504154 | TASK [Print message that log collection failed] 2025-11-30 12:29:57.542815 | hotstack | ok: WARNING: Log collection failed and may be incomplete. Continue with cleanup ... 2025-11-30 12:29:57.554002 | 2025-11-30 12:29:57.554147 | TASK [Set _auth_type fact] 2025-11-30 12:29:57.611171 | hotstack | Output suppressed because no_log was given 2025-11-30 12:29:57.621937 | 2025-11-30 12:29:57.622069 | TASK [Write clouds.yaml] 2025-11-30 12:29:58.803186 | hotstack | Output suppressed because no_log was given 2025-11-30 12:29:58.814761 | 2025-11-30 12:29:58.814895 | TASK [Delete application credentials] 2025-11-30 12:30:00.862513 | hotstack | changed 2025-11-30 12:30:00.873449 | 2025-11-30 12:30:00.873581 | TASK [Print message that application credential failed to delete] 2025-11-30 12:30:00.900496 | hotstack | skipping: Conditional result was False 2025-11-30 12:30:00.912829 | 2025-11-30 12:30:00.912959 | TASK [Print message that application credential deleted successfully] 2025-11-30 12:30:00.959443 | hotstack | ok: Application credential deleted successfully. 2025-11-30 12:30:00.969471 | 2025-11-30 12:30:00.969604 | TASK [Write clouds.yaml with application credentials] 2025-11-30 12:30:01.006297 | 2025-11-30 12:30:01.006535 | TASK [Delete the heat stack] 2025-11-30 07:30:02.386572 | hotstack | Unable to delete 1 of the 1 stacks. 2025-11-30 07:30:02.386971 | hotstack | ERROR: The Stack (hs-ff46f3ed9540495c958812cdded33495) could not be found. 2025-11-30 12:30:02.555055 | hotstack | ERROR 2025-11-30 12:30:02.555354 | hotstack | { 2025-11-30 12:30:02.555415 | hotstack | "delta": "0:00:01.164846", 2025-11-30 12:30:02.555455 | hotstack | "end": "2025-11-30 07:30:02.464968", 2025-11-30 12:30:02.555491 | hotstack | "msg": "non-zero return code", 2025-11-30 12:30:02.555531 | hotstack | "rc": 1, 2025-11-30 12:30:02.555568 | hotstack | "start": "2025-11-30 07:30:01.300122" 2025-11-30 12:30:02.555604 | hotstack | } 2025-11-30 12:30:02.555652 | hotstack | ERROR: Ignoring Errors 2025-11-30 12:30:02.566322 | 2025-11-30 12:30:02.566454 | TASK [Print message that stack failed to delete] 2025-11-30 12:30:02.613828 | hotstack | ok: WARNING: Stack failed to delete, continue with cleanup ... 2025-11-30 12:30:02.623728 | 2025-11-30 12:30:02.623852 | TASK [Print message that stack deleted successfully] 2025-11-30 12:30:02.650168 | hotstack | skipping: Conditional result was False 2025-11-30 12:30:02.661422 | 2025-11-30 12:30:02.661549 | TASK [Delete clouds.yaml] 2025-11-30 12:30:03.065766 | hotstack | Output suppressed because no_log was given 2025-11-30 12:30:03.105819 | 2025-11-30 12:30:03.105944 | PLAY RECAP 2025-11-30 12:30:03.106028 | hotstack | ok: 8 changed: 4 unreachable: 0 failed: 0 skipped: 3 rescued: 1 ignored: 1 2025-11-30 12:30:03.106069 | 2025-11-30 12:30:03.208887 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/hotstack/post.yaml@master] 2025-11-30 12:30:03.214412 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-11-30 12:30:03.765671 | 2025-11-30 12:30:03.765798 | PLAY [all] 2025-11-30 12:30:03.784205 | 2025-11-30 12:30:03.784288 | TASK [include_role : fetch-output] 2025-11-30 12:30:03.823131 | hotstack | ok 2025-11-30 12:30:03.839597 | 2025-11-30 12:30:03.839673 | TASK [fetch-output : Set log path for multiple nodes] 2025-11-30 12:30:03.904492 | hotstack | skipping: Conditional result was False 2025-11-30 12:30:03.912038 | 2025-11-30 12:30:03.912133 | TASK [fetch-output : Set log path for single node] 2025-11-30 12:30:03.957320 | hotstack | ok 2025-11-30 12:30:03.968135 | 2025-11-30 12:30:03.968273 | LOOP [fetch-output : Ensure local output dirs] 2025-11-30 12:30:04.403562 | hotstack -> localhost | ok: "/var/lib/zuul/builds/ff46f3ed9540495c958812cdded33495/work/logs" 2025-11-30 12:30:04.651440 | hotstack -> localhost | changed: "/var/lib/zuul/builds/ff46f3ed9540495c958812cdded33495/work/artifacts" 2025-11-30 12:30:04.914243 | hotstack -> localhost | changed: "/var/lib/zuul/builds/ff46f3ed9540495c958812cdded33495/work/docs" 2025-11-30 12:30:04.936294 | 2025-11-30 12:30:04.936474 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-11-30 12:30:05.632758 | hotstack | changed: .d..t...... ./ 2025-11-30 12:30:05.632962 | hotstack | changed: All items complete 2025-11-30 12:30:05.632988 | 2025-11-30 12:30:06.165858 | hotstack | changed: .d..t...... ./ 2025-11-30 12:30:06.681291 | hotstack | changed: .d..t...... ./ 2025-11-30 12:30:06.707484 | 2025-11-30 12:30:06.707729 | TASK [include_role : fetch-output-openshift] 2025-11-30 12:30:06.724822 | hotstack | skipping: Conditional result was False 2025-11-30 12:30:06.737933 | 2025-11-30 12:30:06.738079 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-11-30 12:30:07.172873 | hotstack -> localhost | ok: Item: artifacts Runtime: 0:00:00.008353 2025-11-30 12:30:07.379220 | hotstack -> localhost | ok: Item: docs Runtime: 0:00:00.007847 2025-11-30 12:30:07.436209 | 2025-11-30 12:30:07.436324 | PLAY [all] 2025-11-30 12:30:07.455327 | 2025-11-30 12:30:07.455412 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-11-30 12:30:07.931359 | hotstack | changed 2025-11-30 12:30:07.975948 | 2025-11-30 12:30:07.976037 | PLAY RECAP 2025-11-30 12:30:07.976114 | hotstack | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2025-11-30 12:30:07.976144 | 2025-11-30 12:30:08.079177 | POST-RUN END RESULT_NORMAL: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-ssh.yaml@master] 2025-11-30 12:30:08.084472 | POST-RUN START: [trusted : review.rdoproject.org/config/playbooks/base-minimal/post-logs.yaml@master] 2025-11-30 12:30:08.709771 | 2025-11-30 12:30:08.709891 | PLAY [localhost] 2025-11-30 12:30:08.727326 | 2025-11-30 12:30:08.727403 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-11-30 12:30:09.146278 | localhost | changed 2025-11-30 12:30:09.156064 | 2025-11-30 12:30:09.156219 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-11-30 12:30:09.191432 | localhost | ok 2025-11-30 12:30:09.209174 | 2025-11-30 12:30:09.209314 | TASK [add-fileserver : Create SSH private key tempfile] 2025-11-30 12:30:09.582540 | localhost | changed 2025-11-30 12:30:09.593924 | 2025-11-30 12:30:09.594065 | TASK [add-fileserver : Create SSH private key from secret] 2025-11-30 12:30:10.382479 | localhost | changed 2025-11-30 12:30:10.389208 | 2025-11-30 12:30:10.389293 | TASK [add-fileserver : Add fileserver ssh key] 2025-11-30 12:30:10.845533 | localhost | Identity added: /var/lib/zuul/builds/ff46f3ed9540495c958812cdded33495/work/tmp/ansible.rd0lxfs6 (/var/lib/zuul/builds/ff46f3ed9540495c958812cdded33495/work/tmp/ansible.rd0lxfs6) 2025-11-30 12:30:10.845762 | localhost | ok: Runtime: 0:00:00.009658 2025-11-30 12:30:10.850018 | 2025-11-30 12:30:10.850084 | TASK [add-fileserver : Remove SSH private key from disk] 2025-11-30 12:30:11.148277 | localhost | ok: Runtime: 0:00:00.008498 2025-11-30 12:30:11.158414 | 2025-11-30 12:30:11.158554 | TASK [add-fileserver : Add fileserver to inventory] 2025-11-30 12:30:11.225807 | localhost | changed 2025-11-30 12:30:11.234830 | 2025-11-30 12:30:11.234968 | TASK [add-fileserver : Add fileserver server to known hosts] 2025-11-30 12:30:11.656757 | localhost | changed 2025-11-30 12:30:11.699123 | 2025-11-30 12:30:11.699223 | PLAY [localhost] 2025-11-30 12:30:11.716562 | 2025-11-30 12:30:11.716639 | TASK [Generate bulk log download script] 2025-11-30 12:30:11.763587 | localhost | ok 2025-11-30 12:30:11.775502 | 2025-11-30 12:30:11.775571 | TASK [local-log-download : Check API endpoint is defined] 2025-11-30 12:30:11.815704 | localhost | ok: All assertions passed 2025-11-30 12:30:11.821715 | 2025-11-30 12:30:11.821799 | TASK [local-log-download : Create download script] 2025-11-30 12:30:12.303123 | localhost -> localhost | changed 2025-11-30 12:30:12.311968 | 2025-11-30 12:30:12.312030 | TASK [Register quick-download link] 2025-11-30 12:30:12.339612 | localhost | ok 2025-11-30 12:30:12.355204 | 2025-11-30 12:30:12.355258 | PLAY [logserver.rdoproject.org] 2025-11-30 12:30:12.365172 | 2025-11-30 12:30:12.365226 | TASK [Set zuul-log-path fact] 2025-11-30 12:30:12.381966 | logserver.rdoproject.org | ok 2025-11-30 12:30:12.390560 | 2025-11-30 12:30:12.390623 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-30 12:30:12.427027 | logserver.rdoproject.org | ok 2025-11-30 12:30:12.432021 | 2025-11-30 12:30:12.432081 | TASK [upload-logs : Create log directories] 2025-11-30 12:30:13.315371 | logserver.rdoproject.org | changed 2025-11-30 12:30:13.322190 | 2025-11-30 12:30:13.322449 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-11-30 12:30:13.656879 | logserver.rdoproject.org -> localhost | ok: Runtime: 0:00:00.008061 2025-11-30 12:30:13.666123 | 2025-11-30 12:30:13.666255 | TASK [upload-logs : Upload logs to log server] 2025-11-30 12:30:14.424784 | logserver.rdoproject.org | Output suppressed because no_log was given 2025-11-30 12:30:14.427603 | 2025-11-30 12:30:14.427664 | LOOP [upload-logs : Compress console log and json output] 2025-11-30 12:30:14.497766 | logserver.rdoproject.org | skipping: Conditional result was False 2025-11-30 12:30:14.511871 | logserver.rdoproject.org | skipping: Conditional result was False 2025-11-30 12:30:14.515868 | 2025-11-30 12:30:14.515959 | LOOP [upload-logs : Upload compressed console log and json output] 2025-11-30 12:30:14.581093 | logserver.rdoproject.org | skipping: Conditional result was False 2025-11-30 12:30:14.581488 | 2025-11-30 12:30:14.586161 | logserver.rdoproject.org | skipping: Conditional result was False 2025-11-30 12:30:14.596005 | 2025-11-30 12:30:14.596132 | LOOP [upload-logs : Upload console log and json output]