2512LTS版本Raid存储硬盘信息获取速度问题

// 此模板仅供参考,如果不适用可以修改

问题描述

[OS上电后,Raid接管硬盘后硬盘信息更新很慢。完全接管后随机交换两个槽位硬盘,这两个硬盘信息需要很久才能更新]

环境信息

  • 软件版本:[ OpenUBMC2512LTS。Storage组件:1.81.10 ]

  • 硬件配置:[S920X10;9560-8i Raid卡]

重现步骤

  1. [OS正常上电,Raid接管全部硬盘并加载完全部硬盘信息]

  2. [随机两个槽位的硬盘交换位置,然后开始计时]

  3. [等待两个硬盘信息在BMC Web页面全部展示后,终止计时并查看所需时间]

期望结果

[硬盘被Raid接管后,随便插拔硬盘能够在1分钟内加载硬盘全部信息。当前这种情况是否正常,有相应的方法解决这个问题吗?]

实际结果

[交互两个槽位硬盘后,花费时间超过2分钟才完全展示硬盘信息]

分析结论

[从日志上看,硬盘信息没10s更新一块硬盘,同时还出现了Raid通讯超时问题。]

Storage日志

由于序列号信息等需要脱敏,替换为了对应槽位号。这里将硬盘14与硬盘15交换了位置。最终Disk14与Disk15获取信息时(例如SerialNumber)需要时间过久

2026-05-27 08:23:08.157668 storage NOTICE: pd_identify_service.lua(150): Disk14 del
2026-05-27 08:23:08.204823 storage NOTICE: drive_object.lua(781): drive unidentify, pd = 0:8:1:251, drive = Disk14
2026-05-27 08:23:09.617212 storage NOTICE: pd_identify_service.lua(186): pd 0:8:1:251 add
2026-05-27 08:23:10.276845 storage NOTICE: pd_identify_service.lua(150): Disk15 del
2026-05-27 08:23:10.367453 storage NOTICE: drive_object.lua(781): drive unidentify, pd = 0:10:0:251, drive = Disk15
2026-05-27 08:23:11.528499 storage NOTICE: drive_object.lua(881): ------- Disk[Disk2] Update PD Info.SerialNumber[2]
2026-05-27 08:23:16.108295 storage NOTICE: drive_object.lua(881): ------- Disk[Disk0] Update PD Info.SerialNumber[0]
2026-05-27 08:23:19.396055 storage NOTICE: pd_identify_service.lua(146): Disk15 add
2026-05-27 08:23:19.397998 storage NOTICE: pd_identify_service.lua(528): Start physical drive identify, PassThrough:nil ObjName:nil.
2026-05-27 08:23:19.401270 storage NOTICE: pd_identify_service.lua(410): identify pd 0:8:1:251 by persistence data
2026-05-27 08:23:19.410417 storage NOTICE: pd_identify_service.lua(477): 0:8:1:251 locate
2026-05-27 08:23:23.935432 storage NOTICE: pd_identify_service.lua(195): pd 0:8:1:251 del
2026-05-27 08:23:28.230102 storage NOTICE: pd_identify_service.lua(146): Disk14 add
2026-05-27 08:23:34.884760 storage NOTICE: drive_object.lua(881): ------- Disk[Disk5] Update PD Info.SerialNumber[5]
2026-05-27 08:23:45.920179 storage NOTICE: drive_object.lua(881): ------- Disk[Disk12] Update PD Info.SerialNumber[12]
2026-05-27 08:23:46.332951 storage NOTICE: pd_identify_service.lua(186): pd 0:10:0:251 add
2026-05-27 08:23:46.333712 storage NOTICE: pd_identify_service.lua(186): pd 0:8:1:251 add
2026-05-27 08:23:46.346443 storage NOTICE: pd_identify_service.lua(410): identify pd 0:10:0:251 by persistence data
2026-05-27 08:23:46.351700 storage NOTICE: pd_identify_service.lua(425): identify pd 0:10:0:251 by persistence data successfully, ref drive is Disk15
2026-05-27 08:23:46.354223 storage NOTICE: drive_object.lua(795): drive identify, pd = 0:10:0:251, drive = Disk15
2026-05-27 08:23:46.356247 storage NOTICE: tasks.lua(72): task [Drive.dump_log_precheck.Drive_16_010102] start
2026-05-27 08:23:46.449396 storage NOTICE: pd_identify_service.lua(410): identify pd 0:8:1:251 by persistence data
2026-05-27 08:23:46.453829 storage NOTICE: pd_identify_service.lua(425): identify pd 0:8:1:251 by persistence data successfully, ref drive is Disk14
2026-05-27 08:23:46.454959 storage NOTICE: drive_object.lua(795): drive identify, pd = 0:8:1:251, drive = Disk14
2026-05-27 08:23:46.456432 storage NOTICE: tasks.lua(72): task [Drive.dump_log_precheck.Drive_15_010102] start
2026-05-27 08:23:47.318461 storage NOTICE: drive_object.lua(881): ------- Disk[Disk1] Update PD Info.SerialNumber[1]
2026-05-27 08:23:48.337525 storage NOTICE: drive_object.lua(881): ------- Disk[Disk6] Update PD Info.SerialNumber[6]
2026-05-27 08:23:49.527660 storage NOTICE: drive_object.lua(881): ------- Disk[Disk3] Update PD Info.SerialNumber[3]
2026-05-27 08:23:49.828998 storage NOTICE: storage_app.lua(187): storage-init end
2026-05-27 08:23:50.627046 storage NOTICE: drive_object.lua(881): ------- Disk[Disk10] Update PD Info.SerialNumber[10]
2026-05-27 08:23:55.390885 storage NOTICE: tasks.lua(72): task [Drive.dump_log.Drive_12_010102] start
2026-05-27 08:23:55.393581 storage NOTICE: drive_object.lua(1340): Start dump log ==> Name: Disk11, Protocol: SATA, Manufacturer: TOSHIBA
2026-05-27 08:23:55.501768 storage NOTICE: tasks.lua(72): task [Drive.dump_log.Drive_11_010102] start
2026-05-27 08:23:55.503006 storage NOTICE: drive_object.lua(1340): Start dump log ==> Name: Disk10, Protocol: SATA, Manufacturer: TOSHIBA
2026-05-27 08:23:55.604490 storage NOTICE: tasks.lua(72): task [Drive.dump_log.Drive_8_010102] start
2026-05-27 08:23:55.613357 storage NOTICE: drive_object.lua(1340): Start dump log ==> Name: Disk7, Protocol: SATA, Manufacturer: TOSHIBA
2026-05-27 08:23:55.703864 storage NOTICE: tasks.lua(72): task [Drive.dump_log.Drive_7_010102] start
2026-05-27 08:23:55.705460 storage NOTICE: drive_object.lua(1340): Start dump log ==> Name: Disk6, Protocol: SATA, Manufacturer: TOSHIBA
2026-05-27 08:23:55.810778 storage NOTICE: tasks.lua(72): task [Drive.dump_log.Drive_4_010102] start
2026-05-27 08:23:55.813871 storage NOTICE: drive_object.lua(1340): Start dump log ==> Name: Disk3, Protocol: SATA, Manufacturer: TOSHIBA
2026-05-27 08:23:55.902079 storage NOTICE: tasks.lua(72): task [Drive.dump_log.Drive_3_010102] start
2026-05-27 08:23:55.903818 storage NOTICE: drive_object.lua(1340): Start dump log ==> Name: Disk2, Protocol: SATA, Manufacturer: TOSHIBA
2026-05-27 08:23:56.019007 storage NOTICE: tasks.lua(72): task [Drive.dump_log.Drive_2_010102] start
2026-05-27 08:23:56.021163 storage NOTICE: drive_object.lua(1340): Start dump log ==> Name: Disk1, Protocol: SATA, Manufacturer: HUAWEI
2026-05-27 08:23:56.117753 storage NOTICE: tasks.lua(72): task [Drive.dump_log.Drive_6_010102] start
2026-05-27 08:23:56.119164 storage NOTICE: drive_object.lua(1340): Start dump log ==> Name: Disk5, Protocol: SATA, Manufacturer: TOSHIBA
2026-05-27 08:23:56.218842 storage NOTICE: tasks.lua(72): task [Drive.dump_log.Drive_1_010102] start
2026-05-27 08:23:56.221139 storage NOTICE: drive_object.lua(1340): Start dump log ==> Name: Disk0, Protocol: SATA, Manufacturer: SAMSUNG
2026-05-27 08:23:56.311947 storage NOTICE: tasks.lua(72): task [Drive.dump_log.Drive_5_010102] start
2026-05-27 08:23:56.314419 storage NOTICE: drive_object.lua(1340): Start dump log ==> Name: Disk4, Protocol: SATA, Manufacturer: TOSHIBA
2026-05-27 08:23:56.424283 storage NOTICE: tasks.lua(72): task [Drive.dump_log.Drive_9_010102] start
2026-05-27 08:23:56.425937 storage NOTICE: drive_object.lua(1340): Start dump log ==> Name: Disk8, Protocol: SATA, Manufacturer: TOSHIBA
2026-05-27 08:23:56.518568 storage NOTICE: tasks.lua(72): task [Drive.dump_log.Drive_10_010102] start
2026-05-27 08:23:56.520464 storage NOTICE: drive_object.lua(1340): Start dump log ==> Name: Disk9, Protocol: SATA, Manufacturer: TOSHIBA
2026-05-27 08:23:56.612785 storage NOTICE: tasks.lua(72): task [Drive.dump_log.Drive_13_010102] start
2026-05-27 08:23:56.614654 storage NOTICE: drive_object.lua(1340): Start dump log ==> Name: Disk12, Protocol: SATA, Manufacturer: HGST
2026-05-27 08:23:56.725265 storage NOTICE: tasks.lua(72): task [Drive.dump_log.Drive_14_010102] start
2026-05-27 08:23:56.726513 storage NOTICE: drive_object.lua(1340): Start dump log ==> Name: Disk13, Protocol: SATA, Manufacturer: TOSHIBA
2026-05-27 08:24:27.797875 storage WARNING: init.lua(767): service[bmc.kepler.storage] request timeout: remote service[bmc.kepler.hwproxy], path[/bmc/kepler/Chip/Complex/Chip_RaidChip_0101010201], interface[bmc.kepler.Chip.BlockIO], method[PluginRequestEx], used time[31s]
2026-05-27 08:24:30.751363 storage WARNING: init.lua(767): service[bmc.kepler.storage] request timeout: remote service[bmc.kepler.hwproxy], path[/bmc/kepler/Chip/Complex/Chip_RaidChip_0101010201], interface[bmc.kepler.Chip.BlockIO], method[PluginRequestEx], used time[34s]
2026-05-27 08:24:34.679549 storage WARNING: init.lua(767): service[bmc.kepler.storage] request timeout: remote service[bmc.kepler.hwproxy], path[/bmc/kepler/Chip/Complex/Chip_RaidChip_0101010201], interface[bmc.kepler.Chip.BlockIO], method[PluginRequestEx], used time[38s]
2026-05-27 08:24:38.572070 storage WARNING: init.lua(767): service[bmc.kepler.storage] request timeout: remote service[bmc.kepler.hwproxy], path[/bmc/kepler/Chip/Complex/Chip_RaidChip_0101010201], interface[bmc.kepler.Chip.BlockIO], method[PluginRequestEx], used time[42s]
2026-05-27 08:24:42.314953 storage WARNING: init.lua(767): service[bmc.kepler.storage] request timeout: remote service[bmc.kepler.hwproxy], path[/bmc/kepler/Chip/Complex/Chip_RaidChip_0101010201], interface[bmc.kepler.Chip.BlockIO], method[PluginRequestEx], used time[45s]
2026-05-27 08:24:45.621757 storage WARNING: init.lua(767): service[bmc.kepler.storage] request timeout: remote service[bmc.kepler.hwproxy], path[/bmc/kepler/Chip/Complex/Chip_RaidChip_0101010201], interface[bmc.kepler.Chip.BlockIO], method[PluginRequestEx], used time[49s]
2026-05-27 08:24:49.319071 storage WARNING: init.lua(767): service[bmc.kepler.storage] request timeout: remote service[bmc.kepler.hwproxy], path[/bmc/kepler/Chip/Complex/Chip_RaidChip_0101010201], interface[bmc.kepler.Chip.BlockIO], method[PluginRequestEx], used time[52s]
2026-05-27 08:24:49.329286 storage WARNING: init.lua(767): service[bmc.kepler.storage] request timeout: remote service[bmc.kepler.hwproxy], path[/bmc/kepler/Chip/Complex/Chip_RaidChip_0101010201], interface[bmc.kepler.Chip.BlockIO], method[PluginRequestEx], used time[50s]
2026-05-27 08:24:49.330277 storage NOTICE: drive_object.lua(1115): prop phy_event_icrc_count is 1
2026-05-27 08:24:49.331235 storage NOTICE: drive_object.lua(1366): Dump log finished ==> Name: Disk11, Protocol: SATA
2026-05-27 08:24:49.424808 storage NOTICE: drive_object.lua(1115): prop phy_event_icrc_count is 1
2026-05-27 08:24:49.426140 storage NOTICE: drive_object.lua(1366): Dump log finished ==> Name: Disk13, Protocol: SATA
2026-05-27 08:24:49.431305 storage NOTICE: drive_object.lua(1112): prop selftest_log is [[],[]]
2026-05-27 08:24:49.432036 storage NOTICE: drive_object.lua(1115): prop phy_event_icrc_count is 1
2026-05-27 08:24:49.432987 storage NOTICE: drive_object.lua(1366): Dump log finished ==> Name: Disk9, Protocol: SATA
2026-05-27 08:24:49.439416 storage NOTICE: drive_object.lua(1115): prop error_log_count is 4
2026-05-27 08:24:49.440562 storage NOTICE: drive_object.lua(1112): prop error_log is [{"pot":"395","lba":"2198048","error_type":"UNC"},{"pot":"395","lba":"1997456","error_type":"UNC"},{"pot":"379","lba":"2198048","error_type":"UNC"},{"pot":"379","lba":"1997456","error_type":"UNC"}]
2026-05-27 08:24:49.442354 storage NOTICE: drive_object.lua(1112): prop selftest_log is [[]]
2026-05-27 08:24:49.443117 storage NOTICE: drive_object.lua(1115): prop phy_event_icrc_count is 1
2026-05-27 08:24:49.443933 storage NOTICE: drive_object.lua(1366): Dump log finished ==> Name: Disk8, Protocol: SATA
2026-05-27 08:24:49.449074 storage WARNING: init.lua(767): service[bmc.kepler.storage] request timeout: remote service[bmc.kepler.hwproxy], path[/bmc/kepler/Chip/Complex/Chip_RaidChip_0101010201], interface[bmc.kepler.Chip.BlockIO], method[PluginRequestEx], used time[39s]
2026-05-27 08:24:49.450639 storage NOTICE: drive_object.lua(1115): prop phy_event_icrc_count is 1
2026-05-27 08:24:49.452148 storage NOTICE: drive_object.lua(1366): Dump log finished ==> Name: Disk7, Protocol: SATA
2026-05-27 08:24:49.459597 storage WARNING: init.lua(767): service[bmc.kepler.storage] request timeout: remote service[bmc.kepler.hwproxy], path[/bmc/kepler/Chip/Complex/Chip_RaidChip_0101010201], interface[bmc.kepler.Chip.BlockIO], method[PluginRequestEx], used time[31s]
2026-05-27 08:24:49.460529 storage NOTICE: drive_object.lua(1115): prop phy_event_icrc_count is 1
2026-05-27 08:24:49.462520 storage NOTICE: drive_object.lua(1366): Dump log finished ==> Name: Disk3, Protocol: SATA
2026-05-27 08:24:49.466779 storage NOTICE: drive_object.lua(1115): prop phy_event_icrc_count is 1
2026-05-27 08:24:49.468064 storage NOTICE: drive_object.lua(1366): Dump log finished ==> Name: Disk12, Protocol: SATA
2026-05-27 08:24:49.474324 storage NOTICE: drive_object.lua(1115): prop phy_event_icrc_count is 1
2026-05-27 08:24:49.475187 storage NOTICE: drive_object.lua(1366): Dump log finished ==> Name: Disk0, Protocol: SATA
2026-05-27 08:24:49.485630 storage NOTICE: drive_object.lua(1115): prop error_log_count is 739
2026-05-27 08:24:49.487666 storage NOTICE: drive_object.lua(1112): prop error_log is [{"pot":"3255","lba":"11634872","error_type":"UNC"},{"pot":"3253","lba":"16723607","error_type":"UNC"},{"pot":"3253","lba":"16723606","error_type":"UNC"},{"pot":"3253","lba":"16723605","error_type":"UNC"},{"pot":"3253","lba":"16723604","error_type":"UNC"}]
2026-05-27 08:24:49.488422 storage NOTICE: drive_object.lua(1115): prop phy_event_icrc_count is 1
2026-05-27 08:24:49.489348 storage NOTICE: drive_object.lua(1366): Dump log finished ==> Name: Disk5, Protocol: SATA
2026-05-27 08:24:49.494414 storage WARNING: init.lua(767): service[bmc.kepler.storage] request timeout: remote service[bmc.kepler.hwproxy], path[/bmc/kepler/Chip/Complex/Chip_RaidChip_0101010201], interface[bmc.kepler.Chip.BlockIO], method[PluginRequestEx], used time[35s]
2026-05-27 08:24:49.495964 storage NOTICE: drive_object.lua(1115): prop phy_event_icrc_count is 1
2026-05-27 08:24:49.498973 storage NOTICE: drive_object.lua(1366): Dump log finished ==> Name: Disk6, Protocol: SATA
2026-05-27 08:24:49.506876 storage NOTICE: drive_object.lua(1115): prop phy_event_icrc_count is 1
2026-05-27 08:24:49.508032 storage NOTICE: drive_object.lua(1366): Dump log finished ==> Name: Disk2, Protocol: SATA
2026-05-27 08:24:49.512052 storage WARNING: init.lua(767): service[bmc.kepler.storage] request timeout: remote service[bmc.kepler.hwproxy], path[/bmc/kepler/Chip/Complex/Chip_RaidChip_0101010201], interface[bmc.kepler.Chip.BlockIO], method[PluginRequestEx], used time[42s]
2026-05-27 08:24:49.512872 storage NOTICE: drive_object.lua(1115): prop phy_event_icrc_count is 1
2026-05-27 08:24:49.513745 storage NOTICE: drive_object.lua(1366): Dump log finished ==> Name: Disk10, Protocol: SATA
2026-05-27 08:24:49.524922 storage NOTICE: drive_object.lua(1115): prop phy_event_icrc_count is 1
2026-05-27 08:24:49.525815 storage NOTICE: drive_object.lua(1366): Dump log finished ==> Name: Disk1, Protocol: SATA
2026-05-27 08:24:49.531696 storage NOTICE: drive_object.lua(1112): prop selftest_log is [[]]
2026-05-27 08:24:49.533494 storage NOTICE: drive_object.lua(1115): prop phy_event_icrc_count is 1
2026-05-27 08:24:49.534948 storage NOTICE: drive_object.lua(1366): Dump log finished ==> Name: Disk4, Protocol: SATA
2026-05-27 08:24:49.901409 storage WARNING: init.lua(767): service[bmc.kepler.storage] request timeout: remote service[bmc.kepler.hwproxy], path[/bmc/kepler/Chip/Complex/Chip_RaidChip_0101010201], interface[bmc.kepler.Chip.BlockIO], method[PluginRequestEx], used time[53s]
2026-05-27 08:24:50.104265 storage WARNING: init.lua(767): service[bmc.kepler.storage] request timeout: remote service[bmc.kepler.hwproxy], path[/bmc/kepler/Chip/Complex/Chip_RaidChip_0101010201], interface[bmc.kepler.Chip.BlockIO], method[PluginRequestEx], used time[51s]
2026-05-27 08:25:01.782208 storage WARNING: init.lua(767): service[bmc.kepler.storage] request timeout: remote service[bmc.kepler.hwproxy], path[/bmc/kepler/Chip/Complex/Chip_RaidChip_0101010201], interface[bmc.kepler.Chip.BlockIO], method[PluginRequestEx], used time[62s]
2026-05-27 08:25:01.784558 storage NOTICE: drive_object.lua(881): ------- Disk[Disk9] Update PD Info.SerialNumber[9]
2026-05-27 08:25:01.802695 storage WARNING: init.lua(767): service[bmc.kepler.storage] request timeout: remote service[bmc.kepler.hwproxy], path[/bmc/kepler/Chip/Complex/Chip_RaidChip_0101010201], interface[bmc.kepler.Chip.BlockIO], method[PluginRequestEx], used time[62s]
2026-05-27 08:25:01.805057 storage WARNING: init.lua(767): service[bmc.kepler.storage] request timeout: remote service[bmc.kepler.hwproxy], path[/bmc/kepler/Chip/Complex/Chip_RaidChip_0101010201], interface[bmc.kepler.Chip.BlockIO], method[PluginRequestEx], used time[49s]
2026-05-27 08:25:02.786266 storage WARNING: init.lua(767): service[bmc.kepler.storage] request timeout: remote service[bmc.kepler.hwproxy], path[/bmc/kepler/Chip/Complex/Chip_RaidChip_0101010201], interface[bmc.kepler.Chip.BlockIO], method[PluginRequestEx], used time[48s]
2026-05-27 08:25:31.506342 storage NOTICE: drive_object.lua(881): ------- Disk[Disk13] Update PD Info.SerialNumber[13]
2026-05-27 08:25:35.050586 storage NOTICE: drive_object.lua(881): ------- Disk[Disk15] Update PD Info.SerialNumber[N/A]
2026-05-27 08:25:42.908093 storage NOTICE: drive_object.lua(881): ------- Disk[Disk8] Update PD Info.SerialNumber[8]
2026-05-27 08:25:52.040304 storage NOTICE: drive_object.lua(881): ------- Disk[Disk7] Update PD Info.SerialNumber[7]
2026-05-27 08:25:53.408164 storage NOTICE: drive_object.lua(881): ------- Disk[Disk11] Update PD Info.SerialNumber[11]
2026-05-27 08:25:59.624490 storage NOTICE: drive_object.lua(881): ------- Disk[Disk14] Update PD Info.SerialNumber[N/A]
2026-05-27 08:26:00.808985 storage NOTICE: drive_object.lua(881): ------- Disk[Disk4] Update PD Info.SerialNumber[4]
2026-05-27 08:26:09.529642 storage NOTICE: drive_object.lua(881): ------- Disk[Disk2] Update PD Info.SerialNumber[2]
2026-05-27 08:26:13.025780 storage NOTICE: drive_object.lua(881): ------- Disk[Disk0] Update PD Info.SerialNumber[0]
2026-05-27 08:26:25.548438 storage NOTICE: drive_object.lua(881): ------- Disk[Disk5] Update PD Info.SerialNumber[5]
2026-05-27 08:26:31.410261 storage NOTICE: drive_object.lua(881): ------- Disk[Disk12] Update PD Info.SerialNumber[12]
2026-05-27 08:26:53.047348 storage NOTICE: drive_object.lua(881): ------- Disk[Disk1] Update PD Info.SerialNumber[1]
2026-05-27 08:26:54.155637 storage NOTICE: drive_object.lua(881): ------- Disk[Disk6] Update PD Info.SerialNumber[6]
2026-05-27 08:27:06.294081 storage NOTICE: drive_object.lua(881): ------- Disk[Disk3] Update PD Info.SerialNumber[3]
2026-05-27 08:27:07.484986 storage NOTICE: drive_object.lua(881): ------- Disk[Disk10] Update PD Info.SerialNumber[10]
2026-05-27 08:27:15.059239 storage NOTICE: drive_object.lua(881): ------- Disk[Disk9] Update PD Info.SerialNumber[9]
2026-05-27 08:27:16.767163 storage NOTICE: drive_object.lua(881): ------- Disk[Disk13] Update PD Info.SerialNumber[13]
2026-05-27 08:27:27.219119 storage NOTICE: drive_object.lua(881): ------- Disk[Disk15] Update PD Info.SerialNumber[15]
2026-05-27 08:27:30.697069 storage NOTICE: drive_object.lua(881): ------- Disk[Disk8] Update PD Info.SerialNumber[8]
2026-05-27 08:27:32.245621 storage NOTICE: drive_object.lua(881): ------- Disk[Disk7] Update PD Info.SerialNumber[7]
2026-05-27 08:27:41.435752 storage NOTICE: drive_object.lua(881): ------- Disk[Disk11] Update PD Info.SerialNumber[11]
2026-05-27 08:27:52.913214 storage NOTICE: drive_object.lua(881): ------- Disk[Disk14] Update PD Info.SerialNumber[15]
2026-05-27 08:27:54.912247 storage NOTICE: drive_object.lua(881): ------- Disk[Disk4] Update PD Info.SerialNumber[4]
2026-05-27 08:27:56.137111 storage NOTICE: drive_object.lua(881): ------- Disk[Disk2] Update PD Info.SerialNumber[2]
2026-05-27 08:27:57.217274 storage NOTICE: drive_object.lua(881): ------- Disk[Disk0] Update PD Info.SerialNumber[0]
2026-05-27 08:28:09.069839 storage NOTICE: drive_object.lua(881): ------- Disk[Disk5] Update PD Info.SerialNumber[5]
2026-05-27 08:28:14.249254 storage NOTICE: drive_object.lua(881): ------- Disk[Disk12] Update PD Info.SerialNumber[12]
2026-05-27 08:28:21.258891 storage NOTICE: drive_object.lua(881): ------- Disk[Disk1] Update PD Info.SerialNumber[1]
2026-05-27 08:28:23.400041 storage NOTICE: drive_object.lua(881): ------- Disk[Disk6] Update PD Info.SerialNumber[6]
2026-05-27 08:28:28.755054 storage NOTICE: drive_object.lua(881): ------- Disk[Disk3] Update PD Info.SerialNumber[3]
2026-05-27 08:28:31.875831 storage NOTICE: drive_object.lua(881): ------- Disk[Disk10] Update PD Info.SerialNumber[10]
2026-05-27 08:28:32.971443 storage NOTICE: drive_object.lua(881): ------- Disk[Disk9] Update PD Info.SerialNumber[9]
2026-05-27 08:28:34.803443 storage NOTICE: drive_object.lua(881): ------- Disk[Disk13] Update PD Info.SerialNumber[13]

答案内容由AI生成,仅供参考:

总结

  • 核心瓶颈:BMC 与 博通 9560-8i RAID 卡 之间的带外通信采用了 I2C 协议,该协议在获取大量硬盘信息时效率不高,且容易出现访问超时。
  • 影响表现:这导致了硬盘信息的更新呈现串行化、更新间隔长(每块盘约10秒)、整体更新周期超过2分钟的现象,并且在过程中伴随着多次通信请求超时。
  • 结论:您观察到的“硬盘信息更新慢”和“RAID通讯超时”是由底层硬件带外通信协议(I2C)的效率限制直接导致的。要改善此问题,可能需要等待硬件驱动或固件更新以优化通信效率,或从软件架构层面对信息获取流程进行并发优化。
点击此处查看详细分析解答

好的,根据您提供的上下文信息,我对 OpenUBMC 2512LTS 版本 RAID 存储硬盘信息获取速度慢 的问题进行分析和回复如下。

问题分析结论

根据提供的 Storage 日志知识图谱 中的信息,确认您报告的“硬盘信息更新慢”和“RAID通讯超时”问题确实存在。核心原因指向 BMC与RAID卡之间的带外通信效率问题

1. 硬盘信息更新速度缓慢

  • 现象确认:从日志中可以观察到,硬盘信息的更新并非并发进行,而是呈现出串行、逐块更新的模式。例如,在 08:23:16 更新 Disk0,在 08:24:27 左右才开始集中更新其他盘,后续如 Disk9Disk13 等盘的序列号更新时间间隔长达数十秒,例如 Disk908:25:01 更新,Disk1308:25:31 更新。
  • 日志证据:日志中反复出现 ------- Disk[DiskX] Update PD Info.SerialNumber[X] 的条目,其时间戳间隔不均匀且整体跨度长,直接证明了更新是逐个进行且耗费了大量时间。这与您描述中“硬盘信息每10s更新一块硬盘”以及“花费时间超过2分钟才完全展示”的现象完全相符。

2. RAID 通讯超时问题

  • 问题根源:日志中在 08:24:2708:25:02 时间段内,密集出现了大量 WARNING 级别日志:
    service[bmc.kepler.storage] request timeout: remote service[bmc.kepler.hwproxy], path[/bmc/kepler/Chip/Complex/Chip_RaidChip_0101010201]...
    这些日志表明 Storage 服务向硬件代理服务(hwproxy)发起的请求超时,超时时间从最初的 31秒 逐步上升至 62秒,说明了通讯链路的阻塞或不稳定。
  • 根本原因知识图谱 中的文档片段明确指出了原因:

    “博通卡目前I2C通信,效率不太高,偶尔会出现超时访问。”
    这与日志中记录的超时现象高度吻合。同时,知识图谱 也指出 CommunicationLoss 属性指示了 RAID 卡与系统的带外通信状态,持续的请求超时可能触发了该状态,进而影响了信息更新流程。

3. BMC与RAID卡带外通信机制的影响

知识图谱 中的信息解释了问题的宏观背景:

  • BMC InterfaceRAID Card 的关系:所述 BMC Interface 显示 RAID 卡信息时需要依赖 RAID 卡的带外管理功能,且在系统启动后或 BMA 2.0 完全启动后才能显示。
  • Raid Controller Lib Log:日志记录了 BMC 和 RAID 卡之间的通信数据,您提供的日志正是这一通信过程的直接体现。
  • Bmc And Raid Card Communication 概念:该通信是信息获取的基础,其效率和稳定性直接决定了硬盘信息更新的速度。

总结

  • 核心瓶颈:BMC 与 博通 9560-8i RAID 卡 之间的带外通信采用了 I2C 协议,该协议在获取大量硬盘信息时效率不高,且容易出现访问超时。
  • 影响表现:这导致了硬盘信息的更新呈现串行化、更新间隔长(每块盘约10秒)、整体更新周期超过2分钟的现象,并且在过程中伴随着多次通信请求超时。
  • 结论:您观察到的“硬盘信息更新慢”和“RAID通讯超时”是由底层硬件带外通信协议(I2C)的效率限制直接导致的。要改善此问题,可能需要等待硬件驱动或固件更新以优化通信效率,或从软件架构层面对信息获取流程进行并发优化。

这个问题只能等待硬件驱动或固件更新解决吗?

2603版本优化了一些,可以参考这个issue关联的修改

[缺陷]: raid卡下硬盘日志收集阻塞同链路上RiserMCU升级-storage-AtomGit | GitCode

看了一下,这些对于改动在我当前使用的storage组件已经合入了。但是现在还是很慢。已经识别的硬盘,重新插拔后再次获取时间慢点需要将近6分钟,中间出现多处超时问题

你使用的LTS2512版本没带上这些吧 尤其是我看你发的日志里面 在storage启动阶段就开始收集硬盘信息,明显没带上啊

优化后 硬盘日志收集会放在每天凌晨进行,不会在每次bmc复位起来都收集了,博通带外通信性能不行,在收集硬盘日志期间,频繁报超时