[:00000002] LAUNCH snlua bootstrap
[:00000003] LAUNCH snlua launcher
[:00000004] LAUNCH snlua cdummy
[:00000005] LAUNCH harbor 0 4
[:00000006] LAUNCH snlua datacenterd
[:00000007] LAUNCH snlua service_mgr
[:00000008] LAUNCH snlua test_account
2026-03-19 14:57:33.182122 unknown_service NOTICE: app_preloader.lua(51): luacov module is not found
2026-03-19 14:57:34.128586 account_IT NOTICE: test_account.lua(41): == prepare test data
2026-03-19 14:57:37.587088 account_IT ERROR: utils.lua(253): copy file open src file failed
2026-03-19 14:57:37.587297 account_IT ERROR: utils.lua(253): copy file open src file failed
2026-03-19 14:57:39.286580 account_IT NOTICE: utils.lua(71): dbus-launch > /home/workspace/950_BX/account/test/.dbus
2026-03-19 14:57:39.561430 account_IT NOTICE: utils.lua(38): set env: DBUS_SESSION_BUS_ADDRESS=unix:path=/tmp/dbus-YbbI5GhOHH,guid=ea081aab9d446fbd4dd43a3669bb9e63
2026-03-19 14:57:39.561613 account_IT NOTICE: utils.lua(38): set env: DBUS_SESSION_BUS_PID=3246745
[:00000009] LAUNCH snlua sd_bus
[:0000000a] LAUNCH snlua harbor
2026-03-19 14:57:40.111378 account_IT INFO: tasks.lua(86): task [poll_tasktable: 0x720de49842d0] start
[:0000000b] LAUNCH snlua persistence/service/main
2026-03-19 14:57:40.419489 test_account SUBSCRIBE NOTICE: harbor.lua(300): get telemetry status failed, interface: bmc.kepler.Dashboard.Observability, info: org.freedesktop.DBus.Error.UnknownObject: Unknown object path /bmc/kepler/Dashboard
2026-03-19 14:57:40.420639 test_account SUBSCRIBE NOTICE: harbor.lua(300): get telemetry status failed, interface: bmc.kepler.Dashboard.Observability.Traces, info: org.freedesktop.DBus.Error.UnknownObject: Unknown object path /bmc/kepler/Dashboard
2026-03-19 14:57:40.421588 test_account SUBSCRIBE NOTICE: harbor.lua(300): get telemetry status failed, interface: bmc.kepler.Dashboard.Observability.Metrics, info: org.freedesktop.DBus.Error.UnknownObject: Unknown object path /bmc/kepler/Dashboard
2026-03-19 14:57:40.422520 test_account SUBSCRIBE NOTICE: harbor.lua(300): get telemetry status failed, interface: bmc.kepler.Dashboard.Observability.Logs, info: org.freedesktop.DBus.Error.UnknownObject: Unknown object path /bmc/kepler/Dashboard
2026-03-19 14:57:40.432098 persistence NOTICE: micro_component.lua(164): Startup status has changed,  ==> Starting, uptime:906804s, cost 0ms
2026-03-19 14:57:40.477175 persistence WARNING: persistence_db_intf.lua(74): database file in the primary partition does not exist, copy it from the backup partition
2026-03-19 14:57:40.477360 persistence WARNING: persistence_db_intf.lua(89): failed to recover from backup database
2026-03-19 14:57:40.614660 persistence NOTICE: service_app_base.lua(377): start persistence service
2026-03-19 14:57:40.619051 persistence NOTICE: micro_component.lua(164): Startup status has changed, Starting ==> InitCompleted, uptime:906805s, cost 187ms
[:0000000c] LAUNCH snlua key_mgmt/service/main
2026-03-19 14:57:40.674239 key_mgmt NOTICE: micro_component.lua(164): Startup status has changed,  ==> Starting, uptime:906805s, cost 0ms
2026-03-19 14:57:40.687618 key_mgmt NOTICE: persist_client_lib.lua(60): persist client init completed, time taken: 3 ms
2026-03-19 14:57:40.701048 key_mgmt NOTICE: persist_client_lib.lua(60): persist client init completed, time taken: 4 ms
2026-03-19 14:57:40.701405 key_mgmt NOTICE: service_app_base.lua(377): start key_mgmt service
2026-03-19 14:57:40.714606 key_mgmt NOTICE: key_service.lua(97): Before init KMC ksf: /home/workspace/950_BX/account/test/integration/account.test_temp_data/datatocheck.dat, ksf_bak: /home/workspace/950_BX/account/test/integration/account.test_temp_data/datatocheck_bak.dat, default: /home/workspace/950_BX/account/test/integration/account.test_temp_data/datatocheck_default.dat
2026-03-19 14:57:40.882361 key_mgmt ERROR: key_service.lua(154): [init] copy datatocheck_bak failed. err: -2
2026-03-19 14:57:40.882577 key_mgmt NOTICE: kmc_kit.lua(28): Domain count : 2; mk count: 2
2026-03-19 14:57:40.886325 key_mgmt NOTICE: key_mgmt_app.lua(173): Return to main coroutine.
2026-03-19 14:57:40.886773 key_mgmt NOTICE: micro_component.lua(164): Startup status has changed, Starting ==> InitCompleted, uptime:906805s, cost 212ms
[:0000000d] LAUNCH snlua maca/service/main
2026-03-19 14:57:41.019363 unknown_service NOTICE: base.lua(86): component[capability_proxy] is detected in the environment
2026-03-19 14:57:41.294687 unknown_service NOTICE: base.lua(86): component[account] is detected in the environment
2026-03-19 14:57:41.539082 unknown_service NOTICE: base.lua(86): component[ipmi_core] is detected in the environment
2026-03-19 14:57:41.803504 unknown_service NOTICE: mc_admin.lua(86): no service json info
2026-03-19 14:57:41.803925 unknown_service NOTICE: base.lua(86): component[hwdiscovery] is detected in the environment
2026-03-19 14:57:42.080192 unknown_service NOTICE: base.lua(86): component[persistence] is detected in the environment
2026-03-19 14:57:42.363248 unknown_service NOTICE: base.lua(86): component[file_transfer] is detected in the environment
2026-03-19 14:57:42.630708 unknown_service NOTICE: base.lua(86): component[rmcpd] is detected in the environment
2026-03-19 14:57:42.891093 unknown_service NOTICE: base.lua(86): component[frudata] is detected in the environment
2026-03-19 14:57:43.166470 unknown_service NOTICE: base.lua(86): component[event] is detected in the environment
2026-03-19 14:57:43.435545 unknown_service NOTICE: base.lua(86): component[certificate] is detected in the environment
2026-03-19 14:57:43.687458 unknown_service NOTICE: base.lua(86): component[hwproxy] is detected in the environment
2026-03-19 14:57:43.951680 unknown_service NOTICE: base.lua(86): component[bmc_network] is detected in the environment
2026-03-19 14:57:44.242718 unknown_service NOTICE: base.lua(86): component[key_mgmt] is detected in the environment
2026-03-19 14:57:44.525390 maca NOTICE: micro_component.lua(164): Startup status has changed,  ==> Starting, uptime:906808s, cost 0ms
2026-03-19 14:57:44.560071 maca NOTICE: service_app_base.lua(377): start maca service
2026-03-19 14:57:44.560236 maca NOTICE: maca_app.lua(283): maca init: bus = table: 0x720de4cbe350
2026-03-19 14:57:44.621404 maca NOTICE: performance_db.lua(59): call init_mdb_interval succ.
2026-03-19 14:57:44.644769 maca NOTICE: starter_without_listening.lua(35): startor_without_listening init interval:1440
2026-03-19 14:57:44.645038 maca NOTICE: performance_db.lua(75): call mdb_changed_register succ.
2026-03-19 14:57:44.645675 maca NOTICE: micro_component.lua(164): Startup status has changed, Starting ==> InitCompleted, uptime:906809s, cost 120ms
2026-03-19 14:57:44.646501 test_account SUBSCRIBE NOTICE: harbor.lua(453): subscribe dbus name owner changed signal
[:0000000e] LAUNCH snlua hwproxy/service/main
2026-03-19 14:57:44.663558 maca NOTICE: base.lua(462): monitor component key_mgmt added, service: bmc.kepler.key_mgmt
2026-03-19 14:57:44.802044 hwproxy NOTICE: micro_component.lua(164): Startup status has changed,  ==> Starting, uptime:906809s, cost 0ms
2026-03-19 14:57:44.820104 hwproxy NOTICE: persist_client_lib.lua(60): persist client init completed, time taken: 6 ms
2026-03-19 14:57:44.832571 hwproxy NOTICE: service_app_base.lua(377): start hwproxy service
2026-03-19 14:57:44.840196 hwproxy NOTICE: hwproxy_app.lua(46): Start to clear interface(bmc.kepler.Scanner) shm data.
2026-03-19 14:57:44.849421 hwproxy NOTICE: micro_component.lua(164): Startup status has changed, Starting ==> InitCompleted, uptime:906809s, cost 48ms
[:0000000f] LAUNCH snlua hwproxy/service/monitor
2026-03-19 14:57:44.864304 hwproxy NOTICE: object_manage.lua(674): start to fetch hwdiscovery objects
[:00000010] LAUNCH snlua hwdiscovery/service/main
2026-03-19 14:57:44.868242 hwproxy NOTICE: object_manage.lua(679): fetch hwdiscovery objects failed, err=org.freedesktop.DBus.Error.ServiceUnknown: The name bmc.kepler.hwdiscovery was not provided by any .service files
[:00000011] LAUNCH snlua hwdiscovery/service/parser_service
2026-03-19 14:57:44.972987 maca NOTICE: base.lua(462): monitor component persistence added, service: bmc.kepler.persistence
2026-03-19 14:57:44.994000 hwdiscovery NOTICE: micro_component.lua(164): Startup status has changed,  ==> Starting, uptime:906809s, cost 0ms
2026-03-19 14:57:45.017220 hwdiscovery NOTICE: persist_client_lib.lua(60): persist client init completed, time taken: 5 ms
2026-03-19 14:57:45.042734 hwdiscovery NOTICE: persist_client_lib.lua(60): persist client init completed, time taken: 6 ms
2026-03-19 14:57:45.042888 hwdiscovery NOTICE: hwdiscovery_app.lua(101): app start to initialize modules
2026-03-19 14:57:45.043077 hwdiscovery NOTICE: service_app_base.lua(377): start hwdiscovery service
2026-03-19 14:57:45.050365 hwdiscovery NOTICE: micro_component.lua(164): Startup status has changed, Starting ==> InitCompleted, uptime:906809s, cost 57ms
2026-03-19 14:57:45.050629 hwdiscovery NOTICE: hwdiscovery_app.lua(128): app start to hardware self-discovery
2026-03-19 14:57:45.051096 hwdiscovery NOTICE: micro_component.lua(164): Startup status has changed, InitCompleted ==> HardwareInit, uptime:906809s, cost 1ms
2026-03-19 14:57:45.051700 hwdiscovery NOTICE: discovery.lua(113): read product info from sdk error: ./opt/bmc/apps/hwdiscovery/lualib/discovery.lua:99: open device failed: No such file or directory
2026-03-19 14:57:45.051785 hwdiscovery NOTICE: discovery.lua(156): position: 00, discover platform component start
2026-03-19 14:57:45.052090 hwdiscovery WARNING: discovery.lua(168): position: 00, get platform sr failed, error: Local file not found, open file failed: /home/workspace/950_BX/account/test/integration/account.test_temp_data/sr/platform.sr, status: 4
2026-03-19 14:57:45.052226 hwdiscovery NOTICE: discovery.lua(202): position: 01, discover root component start
2026-03-19 14:57:45.054787 hwdiscovery NOTICE: micro_component.lua(164): Startup status has changed, HardwareInit ==> HardwareCompleted, uptime:906809s, cost 3ms
2026-03-19 14:57:45.092096 hwdiscovery NOTICE: sdr.lua(76): position: 01, get objects, count: 2
2026-03-19 14:57:45.093967 hwdiscovery NOTICE: parser_work.lua(76): position: 01, process sr data successfully, uptime: 906809 s, cost: 3ms
2026-03-19 14:57:45.304110 maca NOTICE: base.lua(393): monitor component hwproxy added, service: bmc.kepler.hwproxy
2026-03-19 14:57:45.391248 hwdiscovery NOTICE: object_manage.lua(312): start to add objects, path: /bmc/kepler/ObjectGroup/01, life cycle id: 1, count: 1, uptime: 906809 s
2026-03-19 14:57:45.413253 hwdiscovery NOTICE: object_manage.lua(332): add objects callback, path: /bmc/kepler/ObjectGroup/01, life cycle id: 1, count: 1, took 22ms, uptime: 906809 s
2026-03-19 14:57:45.413386 hwdiscovery NOTICE: object_manage.lua(342): add objects completely, path: /bmc/kepler/ObjectGroup/01, life cycle id: 1, took 0ms, uptime: 906809 s
2026-03-19 14:57:45.422657 hwdiscovery NOTICE: component.lua(271): position: 01, setup resource tree successfully, uptime: 906809 s
2026-03-19 14:57:45.424857 hwdiscovery NOTICE: hwcomponent.lua(313): [self-discovery] name: Connector_Event_01, position: 0100, current: 1, previous: 0,uptime: 906809 s
2026-03-19 14:57:45.595184 maca NOTICE: base.lua(393): monitor component hwdiscovery added, service: bmc.kepler.hwdiscovery
2026-03-19 14:57:45.701156 hwdiscovery NOTICE: init.lua(201): position: 0100, get csr data from /home/workspace/950_BX/account/test/integration/account.test_temp_data/sr/14100513_Event_0.sr, format version: 1.00, data version: 1.00
2026-03-19 14:57:45.701832 hwdiscovery NOTICE: hwcomponent.lua(209): position: 0100, load sr data successfully, uptime: 906810 s, cost: 1ms
2026-03-19 14:57:45.702743 hwdiscovery NOTICE: hwcomponent.lua(230): position: 0100, start to process sr data, source: /home/workspace/950_BX/account/test/integration/account.test_temp_data/sr/14100513_Event_0.sr, format version: 1.00, data version: 1.00, uptime: 906810 s
2026-03-19 14:57:45.709034 hwdiscovery NOTICE: sdr.lua(76): position: 0100, get objects, count: 2
2026-03-19 14:57:45.711019 hwdiscovery NOTICE: parser_work.lua(76): position: 0100, process sr data successfully, uptime: 906810 s, cost: 3ms
2026-03-19 14:57:45.864194 hwproxy NOTICE: object_manage.lua(674): start to fetch hwdiscovery objects
2026-03-19 14:57:45.872280 hwproxy NOTICE: object_manage.lua(712): fetch hwdiscovery objects completely, took 0 ms, uptime: 906810 s
2026-03-19 14:57:45.993957 hwdiscovery NOTICE: component.lua(271): position: 0100, setup resource tree successfully, uptime: 906810 s
[:00000012] LAUNCH snlua ipmi_core/service/main
2026-03-19 14:57:47.124626 unknown_service WARNING: init.lua(97): nil:31 > require.lua:-1 > ipmi_command_define.lua:18: Node busy
2026-03-19 14:57:47.124786 unknown_service WARNING: init.lua(97): nil:31 > require.lua:-1 > ipmi_command_define.lua:19: Invalid command
2026-03-19 14:57:47.124965 unknown_service WARNING: init.lua(97): nil:31 > require.lua:-1 > ipmi_command_define.lua:20: Invalid command on LUN
2026-03-19 14:57:47.125108 unknown_service WARNING: init.lua(97): nil:31 > require.lua:-1 > ipmi_command_define.lua:21: Timeout
2026-03-19 14:57:47.125222 unknown_service WARNING: init.lua(97): nil:31 > require.lua:-1 > ipmi_command_define.lua:22: Out of space
2026-03-19 14:57:47.125335 unknown_service WARNING: init.lua(97): nil:31 > require.lua:-1 > ipmi_command_define.lua:23: Reservation cancelled or invalid
2026-03-19 14:57:47.125445 unknown_service WARNING: init.lua(97): nil:31 > require.lua:-1 > ipmi_command_define.lua:24: Request data truncated
2026-03-19 14:57:47.125547 unknown_service WARNING: init.lua(97): nil:31 > require.lua:-1 > ipmi_command_define.lua:25: Request data length invalid
2026-03-19 14:57:47.125655 unknown_service WARNING: init.lua(97): nil:31 > require.lua:-1 > ipmi_command_define.lua:26: Request data field length limit exceeded
2026-03-19 14:57:47.125778 unknown_service WARNING: init.lua(97): nil:31 > require.lua:-1 > ipmi_command_define.lua:27: Parameter out of range
2026-03-19 14:57:47.125921 unknown_service WARNING: init.lua(97): nil:31 > require.lua:-1 > ipmi_command_define.lua:28: Cannot return number of requested data bytes
2026-03-19 14:57:47.126053 unknown_service WARNING: init.lua(97): nil:31 > require.lua:-1 > ipmi_command_define.lua:29: Requested sensor, data, or record not found
2026-03-19 14:57:47.126209 unknown_service WARNING: init.lua(97): nil:31 > require.lua:-1 > ipmi_command_define.lua:30: Invalid data field in request
2026-03-19 14:57:47.126343 unknown_service WARNING: init.lua(97): nil:31 > require.lua:-1 > ipmi_command_define.lua:31: Command illegal for specified sensor or record type
2026-03-19 14:57:47.126462 unknown_service WARNING: init.lua(97): nil:31 > require.lua:-1 > ipmi_command_define.lua:32: Command response could not be provided
2026-03-19 14:57:47.126578 unknown_service WARNING: init.lua(97): nil:31 > require.lua:-1 > ipmi_command_define.lua:33: Cannot execute duplicated request
2026-03-19 14:57:47.126689 unknown_service WARNING: init.lua(97): nil:31 > require.lua:-1 > ipmi_command_define.lua:34: SDR Repository in update mode
2026-03-19 14:57:47.126799 unknown_service WARNING: init.lua(97): nil:31 > require.lua:-1 > ipmi_command_define.lua:35: Device firmeware in update mode
2026-03-19 14:57:47.126910 unknown_service WARNING: init.lua(97): nil:31 > require.lua:-1 > ipmi_command_define.lua:36: BMC initialization in progress
2026-03-19 14:57:47.127036 unknown_service WARNING: init.lua(97): nil:31 > require.lua:-1 > ipmi_command_define.lua:37: Destination unavailable
2026-03-19 14:57:47.127167 unknown_service WARNING: init.lua(97): nil:31 > require.lua:-1 > ipmi_command_define.lua:38: Insufficient privilege level
2026-03-19 14:57:47.127283 unknown_service WARNING: init.lua(97): nil:31 > require.lua:-1 > ipmi_command_define.lua:39: Cannot excute command
2026-03-19 14:57:47.127413 unknown_service WARNING: init.lua(97): nil:31 > require.lua:-1 > ipmi_command_define.lua:40: Cannot execute command, command disabled
2026-03-19 14:57:47.127542 unknown_service WARNING: init.lua(97): nil:31 > require.lua:-1 > ipmi_command_define.lua:41: Cannot execute command, parameter not supported.
2026-03-19 14:57:47.203736 ipmi_core NOTICE: micro_component.lua(167): Startup status has changed,  ==> Starting, uptime:906811s, cost 0ms
2026-03-19 14:57:47.212871 maca NOTICE: base.lua(393): monitor component ipmi_core added, service: bmc.kepler.ipmi_core
2026-03-19 14:57:47.246281 ipmi_core NOTICE: persist_client_lib.lua(60): persist client init completed, time taken: 24 ms
2026-03-19 14:57:47.270035 ipmi_core NOTICE: persist_client_lib.lua(60): persist client init completed, time taken: 11 ms
2026-03-19 14:57:47.270229 ipmi_core NOTICE: ipmi_core_app.lua(537): ipmi core app initializing
2026-03-19 14:57:47.270426 ipmi_core NOTICE: chip_info.lua(36): get chip name successfully, chip name: 1712
2026-03-19 14:58:15.207683 ipmi_core ERROR: ipmi_core_app.lua(490): get PowerOnLock obj[/bmc/kepler/Systems/0/FruCtrl/FruCtrl_1_01] failed, cannot set poweron lock
2026-03-19 14:58:15.207837 ipmi_core NOTICE: ipmi_core_app.lua(511): Start to clear interface(bmc.kepler.CmdInfo) shm data.
2026-03-19 14:58:15.217669 ipmi_core NOTICE: service_app_base.lua(377): start ipmi_core service
2026-03-19 14:58:15.218259 ipmi_core NOTICE: ipmi_core_app.lua(595): ipmi core app initializing finished
2026-03-19 14:58:15.218780 ipmi_core NOTICE: micro_component.lua(167): Startup status has changed, Starting ==> InitCompleted, uptime:906839s, cost 28015ms
2026-03-19 14:58:15.221670 ipmi_core NOTICE: object_manage.lua(674): start to fetch hwdiscovery objects
2026-03-19 14:58:15.222812 ipmi_core NOTICE: dft_mode_info.lua(29): current dft mode is false
[:00000013] LAUNCH snlua rmcpd/service/main
2026-03-19 14:58:15.228928 ipmi_core NOTICE: object_manage.lua(712): fetch hwdiscovery objects completely, took 0 ms, uptime: 906839 s
2026-03-19 14:58:15.232662 ipmi_core NOTICE: object_manage.lua(312): start to add objects, path: /bmc/kepler/ObjectGroup/01, life cycle id: 1, count: 1, uptime: 906839 s
2026-03-19 14:58:15.241797 ipmi_core NOTICE: ipmi_core_app.lua(117): [IpmiCore] Add object callback, class_name: IpmiCore, object name: IpmiCore_1_01, position: 01
2026-03-19 14:58:15.245122 ipmi_core NOTICE: object_manage.lua(332): add objects callback, path: /bmc/kepler/ObjectGroup/01, life cycle id: 1, count: 1, took 13ms, uptime: 906839 s
2026-03-19 14:58:15.245316 ipmi_core NOTICE: ipmi_core_app.lua(219): [IpmiCore] Add object complete callback start, position: 01
2026-03-19 14:58:15.245397 ipmi_core NOTICE: object_manage.lua(342): add objects completely, path: /bmc/kepler/ObjectGroup/01, life cycle id: 1, took 0ms, uptime: 906839 s
2026-03-19 14:58:15.324996 rmcpd NOTICE: micro_component.lua(167): Startup status has changed,  ==> Starting, uptime:906839s, cost 0ms
2026-03-19 14:58:15.346174 maca NOTICE: base.lua(393): monitor component rmcpd added, service: bmc.kepler.rmcpd
2026-03-19 14:58:15.365051 rmcpd NOTICE: persist_client_lib.lua(60): persist client init completed, time taken: 19 ms
2026-03-19 14:58:15.381590 rmcpd NOTICE: persist_client_lib.lua(60): persist client init completed, time taken: 6 ms
2026-03-19 14:58:15.382074 rmcpd NOTICE: service_app_base.lua(377): start rmcpd service
2026-03-19 14:58:15.412317 rmcpd NOTICE: micro_component.lua(167): Startup status has changed, Starting ==> InitCompleted, uptime:906839s, cost 88ms
2026-03-19 14:58:15.834019 rmcpd ERROR: app_preloader.lua(215): ./opt/bmc/apps/rmcpd/lualib/app.lua:358: app(rmcpd/service/main) count(1) pcall failed(./opt/bmc/apps/rmcpd/lualib/app.lua:210: attempt to call a nil value (field 'set_manufacture_id'))
2026-03-19 14:58:15.837054 rmcpd NOTICE: object_manage.lua(674): start to fetch hwdiscovery objects
2026-03-19 14:58:15.870971 rmcpd NOTICE: object_manage.lua(712): fetch hwdiscovery objects completely, took 0 ms, uptime: 906840 s
2026-03-19 14:58:16.620449 ipmi_core NOTICE: ipmi_core_app.lua(829): ipmi_core app started completed
2026-03-19 14:58:20.369356 rmcpd NOTICE: channel_mapping.lua(42): Failed to get channel number mappings objects.
2026-03-19 14:58:20.380151 rmcpd ERROR: app_preloader.lua(215): ./opt/bmc/apps/rmcpd/lualib/app.lua:357: app(rmcpd/service/main) count(1) pcall failed(...0_BX/account/temp/opt/bmc/skynet/lualib/skynet/queue.lua:20: ./opt/bmc/apps/rmcpd/lualib/uart/uart_mgmt.lua:74: open device failed: No such file or directory stack traceback:  [C]: in function 'libsoc_adapter.uart.new'  ./opt/bmc/apps/rmcpd/lualib/uart/uart_mgmt.lua:74: in field 'ctor'  ./opt/bmc/libmc/lualib/mc/class.lua:21: in function <./opt/bmc/libmc/lualib/mc/class.lua:16>  (
[:00000014] LAUNCH snlua event/service/main
2026-03-19 14:58:20.914006 unknown_service NOTICE: main.lua(63): [event] local db check ok.
2026-03-19 14:58:20.914434 unknown_service NOTICE: main.lua(98): start to init event defs
2026-03-19 14:58:20.914749 unknown_service ERROR: event_common.lua(1006): all event def file invalid error:[test/integration/account.test_temp_data/event_def.json: No such file or directory][test/integration/account.test_temp_data/backup_event_def.json: No such file or directory]
2026-03-19 14:58:20.914933 unknown_service ERROR: init.lua(97): nil:113 > main.lua:-1 > event_common.lua:1007: The request failed due to an internal service error.  The service is still operational.
2026-03-19 14:58:20.915082 unknown_service ERROR: main.lua(120): load event def file, and will use empty config, because InternalError: The request failed due to an internal service error.  The service is still operational.
2026-03-19 14:58:20.915219 unknown_service NOTICE: main.lua(132): init event defs end
2026-03-19 14:58:21.217379 event NOTICE: micro_component.lua(167): Startup status has changed,  ==> Starting, uptime:906845s, cost 0ms
2026-03-19 14:58:21.230555 maca NOTICE: base.lua(393): monitor component event added, service: bmc.kepler.event
2026-03-19 14:58:21.246307 event NOTICE: persist_client_lib.lua(60): persist client init completed, time taken: 9 ms
2026-03-19 14:58:21.285655 event NOTICE: persist_client_lib.lua(60): persist client init completed, time taken: 24 ms
2026-03-19 14:58:21.286600 event NOTICE: micro_component.lua(167): Startup status has changed, Starting ==> InitCompleted, uptime:906845s, cost 69ms
2026-03-19 14:58:21.287072 event NOTICE: event_app.lua(61): event service initializing
2026-03-19 14:58:21.288345 event NOTICE: service_app_base.lua(377): start event service
[:00000015] LAUNCH snlua frudata/service/main
2026-03-19 14:58:21.330588 event NOTICE: event_app.lua(76): initialize metrics finished
2026-03-19 14:58:21.332913 event NOTICE: event_app.lua(80): initialize event database finished
2026-03-19 14:58:21.335083 event NOTICE: event_management.lua(175): current alarm name is iBMC
2026-03-19 14:58:21.335251 event NOTICE: event_management.lua(176): event definitions and maps had been generated
2026-03-19 14:58:21.352088 event NOTICE: event_app.lua(85): initialize event manager finished
2026-03-19 14:58:21.353008 event NOTICE: event_app.lua(89): start orm object finishedd
2026-03-19 14:58:21.419740 event NOTICE: starter.lua(46): init interval:1440
2026-03-19 14:58:21.435433 event NOTICE: event_app.lua(98): initialize external interfaces finished
2026-03-19 14:58:21.436030 event NOTICE: event_app.lua(119): delete persistence with PersistencePrimarykey failed, err: ./opt/bmc/libmc/lualib/database/init.lua:152: no such column: PersistencePrimarykey
2026-03-19 14:58:21.436260 event NOTICE: event_app.lua(103): event service initialized
2026-03-19 14:58:21.437866 event NOTICE: object_manage.lua(674): start to fetch hwdiscovery objects
2026-03-19 14:58:21.440749 frudata NOTICE: micro_component.lua(167): Startup status has changed,  ==> Starting, uptime:906845s, cost 0ms
2026-03-19 14:58:21.443563 event NOTICE: object_manage.lua(712): fetch hwdiscovery objects completely, took 0 ms, uptime: 906845 s
2026-03-19 14:58:21.459708 frudata NOTICE: persist_client_lib.lua(60): persist client init completed, time taken: 5 ms
2026-03-19 14:58:21.460697 event NOTICE: object_manage.lua(312): start to add objects, path: /bmc/kepler/ObjectGroup/0100, life cycle id: 1, count: 1, uptime: 906845 s
2026-03-19 14:58:21.484125 event NOTICE: object_manage.lua(332): add objects callback, path: /bmc/kepler/ObjectGroup/0100, life cycle id: 1, count: 1, took 24ms, uptime: 906845 s
2026-03-19 14:58:21.484306 event NOTICE: object_manage.lua(342): add objects completely, path: /bmc/kepler/ObjectGroup/0100, life cycle id: 1, took 0ms, uptime: 906845 s
2026-03-19 14:58:21.484445 event NOTICE: event_management.lua(280): start to register events
2026-03-19 14:58:21.484703 frudata NOTICE: persist_client_lib.lua(60): persist client init completed, time taken: 4 ms
2026-03-19 14:58:21.484798 frudata NOTICE: frudata_app.lua(229): ===== frudata service init =======
2026-03-19 14:58:21.484974 event NOTICE: event_management.lua(287): initial dump record [0]
2026-03-19 14:58:21.485034 frudata NOTICE: service_app_base.lua(377): start frudata service
2026-03-19 14:58:21.486378 event NOTICE: events.lua(57): System alarm count changed, minor: 0, major: 0, critical: 0
2026-03-19 14:58:21.486591 event NOTICE: event_handler.lua(141): init insert method [linear], record mode [0]
2026-03-19 14:58:21.507346 frudata NOTICE: frudata_app.lua(438): register default system 1 RPC resources.
2026-03-19 14:58:21.508594 frudata NOTICE: micro_component.lua(167): Startup status has changed, Starting ==> InitCompleted, uptime:906845s, cost 68ms
[:00000016] LAUNCH snlua bmc_network/service/main
2026-03-19 14:58:21.573511 maca NOTICE: base.lua(393): monitor component frudata added, service: bmc.kepler.frudata
2026-03-19 14:58:21.761930 unknown_service NOTICE: main.lua(46): bmc_network start proc.
2026-03-19 14:58:21.798468 bmc_network NOTICE: micro_component.lua(167): Startup status has changed,  ==> Starting, uptime:906846s, cost 9ms
2026-03-19 14:58:21.826364 bmc_network NOTICE: persist_client_lib.lua(60): persist client init completed, time taken: 6 ms
2026-03-19 14:58:21.856087 bmc_network NOTICE: persist_client_lib.lua(60): persist client init completed, time taken: 15 ms
2026-03-19 14:58:21.856254 bmc_network NOTICE: bmc_network_app.lua(364): ===== network service init =======
2026-03-19 14:58:21.856484 bmc_network NOTICE: service_app_base.lua(377): start bmc_network service
2026-03-19 14:58:21.859544 bmc_network NOTICE: chip_info.lua(33): get chip name successfully, chip name: 1712
2026-03-19 14:58:21.930419 frudata NOTICE: object_manage.lua(674): start to fetch hwdiscovery objects
2026-03-19 14:58:21.939835 frudata NOTICE: object_manage.lua(712): fetch hwdiscovery objects completely, took 0 ms, uptime: 906846 s
2026-03-19 14:58:21.943881 frudata NOTICE: object_manage.lua(312): start to add objects, path: /bmc/kepler/ObjectGroup/0100, life cycle id: 1, count: 1, uptime: 906846 s
2026-03-19 14:58:21.945879 maca NOTICE: base.lua(393): monitor component bmc_network added, service: bmc.kepler.bmc_network
2026-03-19 14:58:21.972074 frudata NOTICE: object_manage.lua(332): add objects callback, path: /bmc/kepler/ObjectGroup/0100, life cycle id: 1, count: 1, took 28ms, uptime: 906846 s
2026-03-19 14:58:21.972362 frudata NOTICE: object_manage.lua(342): add objects completely, path: /bmc/kepler/ObjectGroup/0100, life cycle id: 1, took 1ms, uptime: 906846 s
2026-03-19 14:58:22.178786 bmc_network WARNING: ipv4.lua(243): [ip route] flush table 100 failed
2026-03-19 14:58:22.741912 bmc_network WARNING: ipv4.lua(243): [ip route] flush table 101 failed
2026-03-19 14:58:23.449328 bmc_network WARNING: ipv4.lua(243): [ip route] flush table 102 failed
2026-03-19 14:58:23.946628 bmc_network WARNING: ipv4.lua(243): [ip route] flush table 103 failed
2026-03-19 14:58:24.433139 bmc_network WARNING: ipv6.lua(128): [ip -6 route] flush table 300 failed
2026-03-19 14:58:24.933177 bmc_network WARNING: ipv6.lua(128): [ip -6 route] flush table 301 failed
2026-03-19 14:58:25.417545 bmc_network WARNING: ipv6.lua(128): [ip -6 route] flush table 302 failed
2026-03-19 14:58:25.931107 bmc_network WARNING: ipv6.lua(128): [ip -6 route] flush table 303 failed
2026-03-19 14:58:26.179970 bmc_network NOTICE: network_resource_tree.lua(574): start init resource tree
2026-03-19 14:58:26.189138 bmc_network NOTICE: network_resource_tree.lua(141): generate ipv4 resource tree completed
2026-03-19 14:58:26.189272 bmc_network NOTICE: network_resource_tree.lua(183): start push ipv6 to resource tree
2026-03-19 14:58:26.196409 bmc_network NOTICE: network_resource_tree.lua(193): generate ipv6 resource tree completed
2026-03-19 14:58:26.229069 bmc_network NOTICE: network_resource_tree.lua(417): generate eth [eth2] resource tree completed true
2026-03-19 14:58:26.229342 bmc_network NOTICE: network_resource_tree.lua(418): generate eth [eth2] init status: true channel:1
2026-03-19 14:58:26.238168 bmc_network NOTICE: network_resource_tree.lua(548): generate manager [iBMC] resource tree completed
2026-03-19 14:58:26.243380 bmc_network NOTICE: network_resource_tree.lua(563): generate nat config resource tree completed
2026-03-19 14:58:26.248180 bmc_network NOTICE: network_resource_tree.lua(570): generate eth config resource tree completed
2026-03-19 14:58:26.253914 bmc_network NOTICE: micro_component.lua(167): Startup status has changed, Starting ==> InitCompleted, uptime:906850s, cost 4455ms
2026-03-19 14:58:26.254027 bmc_network NOTICE: main.lua(62): bmc_network new finish.
2026-03-19 14:58:26.255035 bmc_network NOTICE: main.lua(69): bmc_network start finish.
2026-03-19 14:58:26.255736 bmc_network NOTICE: manager.lua(59): [multi_ethernet_intf_mgmt] start multi ethernet auto proc
[:00000017] LAUNCH snlua bmc_network/service/fusionpod
2026-03-19 14:58:26.850576 ipmi_core NOTICE: ipmi_core_app.lua(687): An unregistered ipmi command is found.(bmc.kepler.bmc_network:/bmc/kepler/IpmiCmds/0C/02/GetDefGatewayMac)
2026-03-19 14:58:27.397341 bmc_network NOTICE: object_manage.lua(674): start to fetch hwdiscovery objects
2026-03-19 14:58:27.402770 bmc_network NOTICE: object_manage.lua(712): fetch hwdiscovery objects completely, took 0 ms, uptime: 906851 s
2026-03-19 14:58:29.404364 persistence NOTICE: debug.lua(498): Set debug log level to info successfully, will set back to default level (notice) in 0 hour
2026-03-19 14:58:29.405558 account_IT NOTICE: testcase_utils.lua(68): Set app [persistence] log level [info] successfully.
2026-03-19 14:58:29.406976 key_mgmt NOTICE: debug.lua(498): Set debug log level to info successfully, will set back to default level (notice) in 0 hour
2026-03-19 14:58:29.407289 key_mgmt INFO: persist_client_lib.lua(173): persist saving, op: update, table: _t_mc_properties_key_mgmt, primary_key: [["Id",1]], data_size: 70
2026-03-19 14:58:29.407823 account_IT NOTICE: testcase_utils.lua(68): Set app [key_mgmt] log level [info] successfully.
2026-03-19 14:58:29.409637 account_IT ERROR: testcase_utils.lua(66): Set app [trust] log level [info] failed, error: org.freedesktop.DBus.Error.ServiceUnknown: The name bmc.kepler.trust was not provided by any .service files
[:00000002] KILL self
[:00000018] LAUNCH snlua main
2026-03-19 14:58:29.576734 unknown_service NOTICE: main.lua(27): account app uniqueservice
2026-03-19 14:58:29.577048 unknown_service NOTICE: main.lua(29): account app register service
2026-03-19 14:58:29.577129 unknown_service NOTICE: main.lua(31): new account app start
2026-03-19 14:58:29.612087 account NOTICE: mc_admin.lua(86): no service json info
2026-03-19 14:58:29.612508 account NOTICE: micro_component.lua(167): Startup status has changed,  ==> Starting, uptime:906853s, cost 0ms
2026-03-19 14:58:29.625408 account NOTICE: persist_client_lib.lua(60): persist client init completed, time taken: 4 ms
2026-03-19 14:58:29.644196 account NOTICE: persist_client_lib.lua(60): persist client init completed, time taken: 11 ms
2026-03-19 14:58:29.644513 account NOTICE: account_app.lua(189): account class init start
2026-03-19 14:58:29.644775 account NOTICE: service_app_base.lua(377): start account service
2026-03-19 14:58:29.666799 account NOTICE: account_app.lua(205): account class init end
2026-03-19 14:58:29.667584 account NOTICE: micro_component.lua(167): Startup status has changed, Starting ==> InitCompleted, uptime:906853s, cost 55ms
2026-03-19 14:58:29.667909 account NOTICE: main.lua(36): new account app success
2026-03-19 14:58:29.668039 account NOTICE: main.lua(41): account app dispatch
2026-03-19 14:58:29.966641 account NOTICE: debug.lua(498): Set debug log level to info successfully, will set back to default level (notice) in 0 hour
2026-03-19 14:58:29.966984 account INFO: persist_client_lib.lua(173): persist saving, op: update, table: _t_mc_properties_account, primary_key: [["Id",1]], data_size: 70
2026-03-19 14:58:29.967205 account_IT NOTICE: testcase_utils.lua(68): Set app [account] log level [info] successfully.
2026-03-19 14:58:29.967308 account_IT NOTICE: test_account.lua(95): ==== main server start, server id: 24 ====
2026-03-19 14:58:29.967391 account_IT NOTICE: test_common_suit.lua(26): ================ test CommonSuit setupClass ================
2026-03-19 14:58:30.173225 key_mgmt NOTICE: key_service.lua(320): domain 2 first register, desc: Login credentials, ksf_name: datatocheck_account.dat, time: 1773903510
2026-03-19 14:58:30.182523 key_mgmt INFO: [C](-1): [WSEC_CBB][][638] (UTC) 2026-03-19 06:58:30 New Domain (ID=2 keysfrom=0 domainType=0) added.
2026-03-19 14:58:30.182695 key_mgmt INFO: [C](-1): [WSEC_CBB][][811] (UTC) 2026-03-19 06:58:30 Domain keytype (domainID=2, keytype=3) added.
2026-03-19 14:58:30.182906 key_mgmt INFO: [C](-1): [WSEC_CBB][][982] (UTC) 2026-03-19 06:58:30 Master Key (DomainId=2, KeyId= 1, KeyType=3) generated
2026-03-19 14:58:30.210082 key_mgmt INFO: [C](-1): [WSEC_CBB][][1970] (UTC) 2026-03-19 06:58:30 MemBatchCreateMkEx write ksf at 47d14aa508eae722 with updateCount 4
2026-03-19 14:58:30.210703 key_mgmt INFO: [C](-1): [WSEC_CBB][][832] (UTC) 2026-03-19 06:58:30 Kmc Create Mks success.
2026-03-19 14:58:30.242189 key_mgmt INFO: [C](-1): [WSEC_CBB][][1970] (UTC) 2026-03-19 06:58:30 MemBatchActivateMk write ksf at a49c1345e018c488 with updateCount 5
2026-03-19 14:58:30.243007 key_mgmt INFO: [C](-1): [WSEC_CBB][][673] (UTC) 2026-03-19 06:58:30 The MK (DomainId=2, KeyId=1) is activated, other keys of this domain is deactivated.
2026-03-19 14:58:30.272659 key_mgmt INFO: [C](-1): [WSEC_CBB][][1970] (UTC) 2026-03-19 06:58:30 MemGenerateKsfAll write ksf at 69d6bfcc53b4be5d with updateCount 5
2026-03-19 14:58:30.272791 key_mgmt INFO: [C](-1): [WSEC_CBB][][2097] (UTC) 2026-03-19 06:58:30 Generate Ksf Success
2026-03-19 14:58:30.273417 key_mgmt INFO: persist_client_lib.lua(173): persist saving, op: insert, table: t_master_key, primary_key: [["DomainId",2]], data_size: 982
2026-03-19 14:58:30.277414 account NOTICE: key_client_lib.lua(188): start listen on change of keyid from path: /bmc/kepler/KeyService/Kmc/Keys/2
2026-03-19 14:58:30.277606 account NOTICE: key_client_lib.lua(107): Start Refresh MK Mask.
2026-03-19 14:58:30.278294 account INFO: harbor_client.lua(259): local signal subscribe: rule=[type='signal',path_namespace='/bmc/kepler/KeyService/Kmc/Keys/2',member='PropertiesChanged'], subscribe_id=1
2026-03-19 14:58:30.279399 account NOTICE: account_app.lua(218): infrastructure init start
2026-03-19 14:58:30.279723 account NOTICE: account_app.lua(225): infrastructure init end, login rule init start
2026-03-19 14:58:30.307888 account NOTICE: account_app.lua(231): login rule init end, role privilege init start
2026-03-19 14:58:30.362608 account NOTICE: account_app.lua(237): role privilege init end, account config init start
2026-03-19 14:58:30.363419 account ERROR: global_account_config.lua(53): The init weakpwddictionary is null
2026-03-19 14:58:30.364006 account NOTICE: account_app.lua(242): account config init end, account manager init start
2026-03-19 14:58:30.365740 account INFO: tasks.lua(86): task [poll_tasktable: 0x720dd137c0a0] start
2026-03-19 14:58:30.366984 account INFO: account_app.lua(152): service is not ready
2026-03-19 14:58:30.367100 account ERROR: key_client_lib.lua(177): Domain 2 update ciphertext failed.
2026-03-19 14:58:30.972763 account_IT NOTICE: test_account.lua(142): error: ./opt/bmc/libmc/lualib/mc/mdb/init.lua:790: service not exists, path:/bmc/kepler/AccountService/Accounts/2, interface:bmc.kepler.AccountService.ManagerAccount
2026-03-19 14:58:30.972876 account_IT ERROR: app_preloader.lua(215): ...rkspace/950_BX/account/test/integration/test_account.lua:135: app(test_account) count(1) pcall failed(...rkspace/950_BX/account/test/integration/test_account.lua:143: === test failed ===)
[:00000013] KILL self
2026-03-19 14:58:31.174853 account_IT NOTICE: test_account.lua(85): - clear test data
2026-03-19 14:58:31.831695 account INFO: harbor_client.lua(268): dbus unsubscribe local dispatch: rule=[type='signal',path_namespace='/bmc/kepler/KeyService/Kmc/Keys/2',member='PropertiesChanged'], subscribe_id=1