【 使用环境 】 测试环境
【 使用版本 】OceanBase_CE-v4.3.5.5
【问题描述】我从一个库A里面做了备份，再这个库里执行恢复就可以；新建了一个实例数据库B，从刚才A个库里面的备份恢复到B库就不行，报错：
【复现路径】查了B库没有lgsettl_new 租户，也没有历史恢复记录
【附件及日志】 ALTER SYSTEM RESTORE lgsettl_new FROM ‘file:///data/archive,file:///data/backup’
WITH ‘pool_list=lgsettl_new_pool’
4200 - hash map/set entry exist
查询时间: 0.021s
不知道有人遇到过没
把报错的这个时间的observer.log RootService.log 发一下
rootservice.log： [2026-05-11 09:53:34.710422] INFO [RS] physical_restore_tenant (ob_root_service.cpp:9422) [60120][DDLQueueTh0][T0][YB42C0A80293-000651806F4F6D07-0-0] [lt=5] [RESTORE] physical restore tenant start(arg={tenant_name:“lgsettl_new”, restore_option:“pool_list=lgsettl_pool”, restore_scn:{val:18446744073709551615, v:3}, passwd_array:"", kms_info:"", table_items:[], with_restore_scn:false, encrypt_key:"", kms_uri:"", kms_encrypt_key:"", restore_timestamp:“2026-05-09 10:00:00”, initiator_job_id:0, initiator_tenant_id:1}, ret=-4018)
[2026-05-11 09:53:34.710489] INFO [SHARE] add_event (ob_event_history_table_operator.h:266) [60120][DDLQueueTh0][T0][YB42C0A80293-000651806F4F6D07-0-0] [lt=12] event table add task(ret=0, event_table_name=“all_rootservice_event_history", sql=INSERT INTO all_rootservice_event_history (gmt_create, module, event, name1, value1, name2, value2, value3, value4, value5, value6, rs_svr_ip, rs_svr_port) VALUES (usec_to_time(1778464414710434), ‘physical_restore’, ‘restore_start’, ‘ret’, -4018, ‘tenant_name’, ‘lgsettl_new’, ‘’, ‘’, ‘’, ‘’, ‘192.168.2.147’, 2882))
observer.log： observer.log.20260511150436987:[2026-05-11 14:34:14.052720] WDIAG [SERVER] do_process (obmp_query.cpp:1226) [2508993][T1_L0_G0][T1][YB42C0A80293-00065184D925D961-0-0] [lt=5][errcode=-5001] query failed(ret=-5001, session={this:0x7f6e53703b68, id:3221489389, client_sid:3221489389, deser:false, tenant:“sys”, tenant_id:1, effective_tenant:“sys”, effective_tenant_id:1, database:“oceanbase”, user:“root@%”, consistency_level:3, session_state:2, autocommit:true, tx:null}, sql=ALTER SYSTEM CREATE LOGSTREAM lgsettl_new IN POOL lgsettl_new_pool, retry_ctrl.need_retry()=0)
observer.log.20260511150436987:[2026-05-11 14:35:01.336305] INFO [SQL.PARSER] parse_sql (ob_parser.cpp:989) [2508993][T1_L0_G0][T1][YB42C0A80293-00065184D925DA20-0-0] [lt=24] failed to parse stmt as sql(stmt_str=ALTER SYSTEM DROP LOGSTREAM lgsettl_new, ret=-5001)
observer.log.20260511150436987:[2026-05-11 14:35:01.336351] WDIAG [SQL.PARSER] parse_sql (ob_parser.cpp:1033) [2508993][T1_L0_G0][T1][YB42C0A80293-00065184D925DA20-0-0] [lt=44][errcode=-5001] failed to parse the statement(stmt_str=ALTER SYSTEM DROP LOGSTREAM lgsettl_new, parse_result.is_fp=0, parse_result.is_multi_query=0, parse_result.yyscan_info=0x7f6e3ee054b8, parse_result.result_tree_=NULL, parse_result.malloc_pool_=0x7f6e5e9d06e0, message=“syntax error, unexpected NAME_OB, expecting DELETE or SHARED_STORAGE_DEST or TABLES”, start_col=19, end_col=27, parse_result.line_=0, parse_result.yycolumn_=28, parse_result.yylineno_=1, parse_result.extra_errno_=0, parse_result.is_for_remap_=0, err_charge_sql_mode=false, sql_mode_=281018368, parse_result.sql_mode_=281018368, parse_result.may_bool_value_=0, ret=-5001)
observer.log.20260511150436987:[2026-05-11 14:35:01.336423] WDIAG parse_sql (ob_parser.cpp:1046) [2508993][T1_L0_G0][T1][YB42C0A80293-00065184D925DA20-0-0] [lt=62][errcode=-5001] You have an error in your SQL syntax; check the manual that corresponds to your OceanBase version for the right syntax to use near ‘LOGSTREAM lgsettl_new’ at line 1
observer.log.20260511150436987:[2026-05-11 14:35:01.336438] WDIAG [SQL.PARSER] parse (ob_parser.cpp:1200) [2508993][T1_L0_G0][T1][YB42C0A80293-00065184D925DA20-0-0] [lt=12][errcode=-5001] failed to parse stmt as sql(stmt=ALTER SYSTEM DROP LOGSTREAM lgsettl_new, parse_mode=0, ret=-5001)
observer.log.20260511150436987:[2026-05-11 14:35:01.336452] WDIAG [SQL] parser_and_check (ob_sql.cpp:4623) [2508993][T1_L0_G0][T1][YB42C0A80293-00065184D925DA20-0-0] [lt=11][errcode=-5001] Generate syntax tree failed(ret=-5001, outlined_stmt=ALTER SYSTEM DROP LOGSTREAM lgsettl_new)
observer.log.20260511150436987:[2026-05-11 14:35:01.336490] WDIAG [SQL] handle_parser (ob_sql.cpp:5572) [2508993][T1_L0_G0][T1][YB42C0A80293-00065184D925DA20-0-0] [lt=36][errcode=-5001] fail to parser normal query(sql=ALTER SYSTEM DROP LOGSTREAM lgsettl_new, ret=-5001)
observer.log.20260511150436987:[2026-05-11 14:35:01.336585] WDIAG [SQL] stmt_query (ob_sql.cpp:175) [2508993][T1_L0_G0][T1][YB42C0A80293-00065184D925DA20-0-0] [lt=12][errcode=-5001] fail to handle text query(stmt=ALTER SYSTEM DROP LOGSTREAM lgsettl_new, ret=-5001)
observer.log.20260511150436987:[2026-05-11 14:35:01.336619] WDIAG [SERVER] do_process (obmp_query.cpp:1094) [2508993][T1_L0_G0][T1][YB42C0A80293-00065184D925DA20-0-0] [lt=21][errcode=-5001] run stmt_query failed, check if need retry(ret=-5001, cli_ret=-5001, retry_ctrl_.need_retry()=0, sql=ALTER SYSTEM DROP LOGSTREAM lgsettl_new)
observer.log.20260511150436987:[2026-05-11 14:35:01.336628] WDIAG [SERVER] do_process (obmp_query.cpp:1226) [2508993][T1_L0_G0][T1][YB42C0A80293-00065184D925DA20-0-0] [lt=7][errcode=-5001] query failed(ret=-5001, session={this:0x7f6e53703b68, id:3221489389, client_sid:3221489389, deser:false, tenant:“sys”, tenant_id:1, effective_tenant:“sys”, effective_tenant_id:1, database:“oceanbase”, user:“root@%”, consistency_level:3, session_state:2, autocommit:true, tx:null}, sql=ALTER SYSTEM DROP LOGSTREAM lgsettl_new, retry_ctrl_.need_retry()=0)observer.log.20260511150436987:[2026-05-11 14:35:01.336628] WDIAG [SERVER] do_process (obmp_query.cpp:1226) [2508993][T1_L0_G0][T1][YB42C0A80293-00065184D925DA20-0-0] [lt=7][errcode=-5001] query failed(ret=-5001, session={this:0x7f6e53703b68, id:3221489389, client_sid:3221489389, deser:false, tenant:“sys”, tenant_id:1, effective_tenant:“sys”, effective_tenant_id:1, database:“oceanbase”, user:“root@%”, consistency_level:3, session_state:2, autocommit:true, tx:null}, sql=ALTER SYSTEM DROP LOGSTREAM lgsettl_new, retry_ctrl_.need_retry()=0)
observer.log.20260511161611560:[2026-05-11 15:59:41.753339] INFO [SHARE.SCHEMA] get_tenant_info (ob_schema_getter_guard.cpp:2190) [2508993][T1_L0_G0][T1][YB42C0A80293-00065184D945DFDC-0-0] [lt=66] tenant not exist(tenant_name=lgsettl_new)
observer.log.20260511161611560:[2026-05-11 15:59:41.753374] WDIAG execute (ob_tenant_executor.cpp:768) [2508993][T1_L0_G0][T1][YB42C0A80293-00065184D945DFDC-0-0] [lt=30][errcode=-5157] Unknown tenant ‘lgsettl_new’
observer.log.20260511161611560:[2026-05-11 15:59:41.756922] WDIAG [SQL.ENG] execute (ob_tenant_executor.cpp:769) [2508993][T1_L0_G0][T1][YB42C0A80293-00065184D945DFDC-0-0] [lt=3542][errcode=-5157] tenant not exist(ret=-5157, ret=“OB_TENANT_NOT_EXIST”, drop_tenant_arg=tenant_name:“lgsettl_new”, if_exist:false, delay_to_drop:false, force_drop:false, object_name:”", open_recyclebin:false, tenant_id:0, drop_only_in_restore:false)
你这个日志找错了吧 建议把你操作的时候报错的时间日志发一下 要不然没有办法分析
SELECT * FROM oceanbase.CDB_OB_RESTORE_PROGRESS;
SELECT * FROM oceanbase.CDB_OB_RESTORE_HISTORY;
SELECT * FROM sys_external_tbs.__all_external_alert_log_info
WHERE message LIKE ‘%RESTORE%’ AND level IN (‘ERROR’, ‘WARN’)
LIMIT 100; 我查了下着三个都为空。
observer.log： 执行恢复后查看的近50 条的[2026-05-11 16:45:20.253033] INFO [LIB] stat (utility.h:1255) [20752][T1_IOWorker][T1][Y0-0000000000000000-0-0] [lt=18] [PALF STAT IO TASK IN QUEUE TIME](cur_stat_count=10, stat_interval=1000000, avg (count/cost)=75, this=0x7fcc7cbf3af0, extra_info="")
[2026-05-11 16:45:20.253080] INFO [LIB] stat (utility.h:1238) [20751][T1_LogIOCb0][T1][Y0-0000000000000000-0-0] [lt=7] [PALF STAT FS CB EXCUTE COST TIME](cur_stat_count=10, stat_interval=1000000, avg (count/cost)=8, this=0x7fcc5339f6a0, extra_info=“palf_id:1”)
[2026-05-11 16:45:20.253094] INFO [LIB] stat (utility.h:1238) [20751][T1_LogIOCb0][T1][Y0-0000000000000000-0-0] [lt=14] [PALF STAT LOG LIFE TIME](cur_stat_count=10, stat_interval=1000000, avg (count/cost)=2136, this=0x7fcc5339f8d0, extra_info=“palf_id:1”)
[2026-05-11 16:45:20.253248] INFO [STORAGE.TRANS] persist_version_if_need_ (ob_tenant_weak_read_cluster_service.cpp:331) [21595][T1_TenantWeakRe][T1][Y0-0000000000000000-0-0] [lt=10] [WRS] [TENANT_WEAK_READ_SERVICE] [CLUSTER_SERVICE] persist CLUSTER version range succ(tenant_id=1, new_min_version={val:1778489120048647000, v:0}, new_max_version={val:1778489120048647000, v:0}, last_min_version={val:1778489119847545000, v:0}, last_max_version={val:1778489119847545000, v:0}, total_time_us=3335, delta_us=204599)
[2026-05-11 16:45:20.253270] INFO [STORAGE.TRANS] update_cluster_version (ob_tenant_weak_read_cluster_service.cpp:690) [21595][T1_TenantWeakRe][T1][Y0-0000000000000000-0-0] [lt=21] [WRS] [TENANT_WEAK_READ_SERVICE] [CLUSTER_SERVICE] update version(tenant_id=1, current_version={val:1778489120048647000, v:0}, min_version={val:1778489120048647000, v:0}, max_version={val:1778489120048647000, v:0}, in_service=true, leader_epoch=10)
[2026-05-11 16:45:20.255726] INFO [STORAGE] runTimerTask (ob_checkpoint_service.cpp:289) [20624][T1_TimerWK3_CKClogDisk][T1][Y0-0000000000000000-0-0] [lt=10] ====== check clog disk timer task ======
[2026-05-11 16:45:20.255742] INFO [PALF] get_disk_usage (palf_env_impl.cpp:902) [20624][T1_TimerWK3_CKClogDisk][T1][Y0-0000000000000000-0-0] [lt=10] get_disk_usage(ret=0, capacity(MB):=2048, used(MB):=277)
[2026-05-11 16:45:20.298497] INFO [STORAGE.TRANS] iterate_tx_ctx (ob_ls_tx_service.cpp:490) [20621][T1_TimerWK1_TntSharedTimer][T1][Y0-0000000000000000-0-0] [lt=18] iter set ready success(ret=0, ls_id={id:1})
[2026-05-11 16:45:20.326016] INFO [COMMON] compute_tenant_wash_size (ob_kvcache_store.cpp:1466) [20340][TimerWK3_KVCacheWash][T0][Y0-0000000000000000-0-0] [lt=25] Wash compute wash size(is_wash_valid=false, sys_total_wash_size=-201207808, global_cache_size=79069184, tenant_max_wash_size=0, tenant_min_wash_size=0, tenant_ids_=[500, 508, 509, 1])
[2026-05-11 16:45:20.326128] INFO [COMMON] wash (ob_kvcache_hazard_domain.h:326) [20340][TimerWK3_KVCacheWash][T0][Y0-0000000000000000-0-0] [lt=27] allocator wash time (wash_time_us=4, freed_blocks_num=0, memory_efficiency=9.526193456105847002e-01)
[2026-05-11 16:45:20.349078] INFO [STORAGE] gc_tables_in_queue (ob_tenant_meta_mem_mgr.cpp:635) [20622][T1_TimerWK2_TenantMetaMemMg][T1][Y0-0000000000000000-0-0] [lt=27] gc tables in queue: recycle 0 table(ret=0, tablet_buffer_pool_={typeid(T).name():“N9oceanbase7storage15ObMetaObjBufferINS0_8ObTabletELl3784EEE”, sizeof(T):3816, used_obj_cnt:1185, free_obj_hold_cnt:2, allocator used:4558080, allocator total:4896000}, large_tablet_buffer_pool_={typeid(T).name():“N9oceanbase7storage15ObMetaObjBufferINS0_8ObTabletELl65448EEE”, sizeof(T):65480, used_obj_cnt:1, free_obj_hold_cnt:0, allocator used:65591, allocator total:65591}, full_tablet_creator_={tiny_allocator_.used():0, tiny_allocator_.total():0, full allocator used:0, full allocator total:0}, tablets_mem=4961591, tablets_mem_limit=429496720, ddl_kv_pool_={typeid(T).name():“N9oceanbase7storage7ObDDLKVE”, sizeof(T):1024, used_obj_cnt:0, free_obj_hold_cnt:0, allocator used:0, allocator total:0}, memtable_pool_={typeid(T).name():“N9oceanbase8memtable10ObMemtableE”, sizeof(T):1984, used_obj_cnt:90, free_obj_hold_cnt:0, allocator used:184320, allocator total:195840}, pending_cnt=0, wait_gc_count=0, tablet count=1186)
[2026-05-11 16:45:20.352014] INFO [STORAGE.TRANS] check_all_readonly_tx_clean_up (ob_ls_tx_service.cpp:356) [21603][T1_TxLoopWorker][T1][Y0-0000000000000000-0-0] [lt=18] wait_all_readonly_tx_cleaned_up cleaned up success(ls_id={id:1})
[2026-05-11 16:45:20.364693] INFO [CLOG.EXTLOG] resize_log_ext_handler_ (ob_cdc_service.cpp:748) [20760][T1_CdcSrv][T1][Y0-0000000000000000-0-0] [lt=5] finish to resize log external storage handler(current_ts=1778489120364685, tenant_max_cpu=2, valid_ls_v1_count=0, valid_ls_v2_count=0, other_ls_count=0, new_concurrency=0)
[2026-05-11 16:45:20.364724] INFO [CLOG.EXTLOG] run1 (ob_cdc_service.cpp:239) [20760][T1_CdcSrv][T1][Y0-0000000000000000-0-0] [lt=30] snapshot_traffic_info once
[2026-05-11 16:45:20.395938] INFO [SQL.EXE] run2 (ob_maintain_dependency_info_task.cpp:228) [20421][MaintainDepInfo][T0][Y0-0000000000000000-0-0] [lt=25] [ASYNC TASK QUEUE](queue_.size()=0, sys_view_consistent_.size()=554)
[2026-05-11 16:45:20.397911] INFO [ARCHIVE] gc_stale_ls_task_ (ob_ls_mgr.cpp:573) [21596][T1_LSArchiveMgr][T1][YB42C0A80293-000651868A375E84-0-0] [lt=35] gc stale ls task succ
[2026-05-11 16:45:20.397973] INFO do_work (ob_rl_mgr.cpp:708) [20396][rl_mgr0][T0][Y0-0000000000000000-0-0] [lt=17] swc wakeup.(stat_period_=1000000, ready=false)
[2026-05-11 16:45:20.407652] INFO [COMMON] replace_map (ob_kv_storecache.cpp:696) [20337][TimerWK0_KVCacheRep][T0][Y0-0000000000000000-0-0] [lt=26] replace map num details(ret=0, replace_node_count=0, map_once_replace_num_=15728, map_replace_skip_count_=6)
[2026-05-11 16:45:20.413460] INFO [SERVER] runTimerTask (ob_eliminate_task.cpp:225) [20620][T1_TimerWK0_ReqMemEvict][T1][Y0-0000000000000000-0-0] [lt=16] sql audit evict task end(request_manager_->get_tenant_id()=1, evict_high_mem_level=32212254, evict_high_size_level=471859, evict_batch_count=0, elapse_time=0, size_used=0, mem_used=24956928)
[2026-05-11 16:45:20.413532] INFO [SERVER] prepare_alloc_queue (ob_dl_queue.cpp:92) [20624][T1_TimerWK3_ReqMemEvict][T1][Y0-0000000000000000-0-0] [lt=7] Construct Queue Num(construct_num=0, get_push_idx()=8, get_cur_idx()=0, get_pop_idx()=0)
[2026-05-11 16:45:20.443769] INFO [STORAGE] diagnose_for_suggestion (ob_compaction_suggestion.cpp:456) [20605][T1_DagScheduler][T1][Y0-0000000000000000-0-0] [lt=6] [COMPACTION DAG STATUS] (start_time=1778489110438824, end_time=1778489120443766, dag_status={})
[2026-05-11 16:45:20.443795] INFO [COMMON] dump_dag_status (ob_tenant_dag_scheduler.cpp:2903) [20605][T1_DagScheduler][T1][Y0-0000000000000000-0-0] [lt=23] dump_dag_status(priority=“PRIO_COMPACTION_HIGH”, limits=6, running_task=0, adaptive_task_limit=6, ready_dag_count=0, waiting_dag_count=0, rank_dag_count=0)
[2026-05-11 16:45:20.443805] INFO [COMMON] dump_dag_status (ob_tenant_dag_scheduler.cpp:2903) [20605][T1_DagScheduler][T1][Y0-0000000000000000-0-0] [lt=11] dump_dag_status(priority=“PRIO_HA_HIGH”, limits=8, running_task=0, adaptive_task_limit=8, ready_dag_count=0, waiting_dag_count=0, rank_dag_count=0)
[2026-05-11 16:45:20.443810] INFO [COMMON] dump_dag_status (ob_tenant_dag_scheduler.cpp:2903) [20605][T1_DagScheduler][T1][Y0-0000000000000000-0-0] [lt=4] dump_dag_status(priority=“PRIO_COMPACTION_MID”, limits=6, running_task=0, adaptive_task_limit=6, ready_dag_count=0, waiting_dag_count=0, rank_dag_count=0)
[2026-05-11 16:45:20.443814] INFO [COMMON] dump_dag_status (ob_tenant_dag_scheduler.cpp:2903) [20605][T1_DagScheduler][T1][Y0-0000000000000000-0-0] [lt=4] dump_dag_status(priority=“PRIO_HA_MID”, limits=5, running_task=0, adaptive_task_limit=5, ready_dag_count=0, waiting_dag_count=0, rank_dag_count=0)
[2026-05-11 16:45:20.443818] INFO [COMMON] dump_dag_status (ob_tenant_dag_scheduler.cpp:2903) [20605][T1_DagScheduler][T1][Y0-0000000000000000-0-0] [lt=4] dump_dag_status(priority=“PRIO_COMPACTION_LOW”, limits=6, running_task=0, adaptive_task_limit=6, ready_dag_count=0, waiting_dag_count=0, rank_dag_count=0)
[2026-05-11 16:45:20.443822] INFO [COMMON] dump_dag_status (ob_tenant_dag_scheduler.cpp:2903) [20605][T1_DagScheduler][T1][Y0-0000000000000000-0-0] [lt=4] dump_dag_status(priority=“PRIO_HA_LOW”, limits=2, running_task=0, adaptive_task_limit=2, ready_dag_count=0, waiting_dag_count=0, rank_dag_count=0)
[2026-05-11 16:45:20.443827] INFO [COMMON] dump_dag_status (ob_tenant_dag_scheduler.cpp:2903) [20605][T1_DagScheduler][T1][Y0-0000000000000000-0-0] [lt=5] dump_dag_status(priority=“PRIO_DDL”, limits=2, running_task=0, adaptive_task_limit=2, ready_dag_count=0, waiting_dag_count=0, rank_dag_count=0)
[2026-05-11 16:45:20.443833] INFO [COMMON] dump_dag_status (ob_tenant_dag_scheduler.cpp:2903) [20605][T1_DagScheduler][T1][Y0-0000000000000000-0-0] [lt=6] dump_dag_status(priority=“PRIO_DDL_HIGH”, limits=6, running_task=0, adaptive_task_limit=6, ready_dag_count=0, waiting_dag_count=0, rank_dag_count=0)
[2026-05-11 16:45:20.443838] INFO [COMMON] dump_dag_status (ob_tenant_dag_scheduler.cpp:2903) [20605][T1_DagScheduler][T1][Y0-0000000000000000-0-0] [lt=5] dump_dag_status(priority=“PRIO_TTL”, limits=2, running_task=0, adaptive_task_limit=2, ready_dag_count=0, waiting_dag_count=0, rank_dag_count=0)
[2026-05-11 16:45:20.443843] INFO [COMMON] dump_dag_status (ob_tenant_dag_scheduler.cpp:3728) [20605][T1_DagScheduler][T1][Y0-0000000000000000-0-0] [lt=3] dump_dag_status[DAG_NET](running_dag_net_map_size=0, blocking_dag_net_list_size=0, running_dag_net_list_size=0)
[2026-05-11 16:45:20.443847] INFO [COMMON] dump_dag_status (ob_tenant_dag_scheduler.cpp:4476) [20605][T1_DagScheduler][T1][Y0-0000000000000000-0-0] [lt=3] dump_dag_status(dag_cnt=0, total_worker_cnt_=0, total_running_task_cnt=0, work_thread_num_=43, scheduled_task_cnt=0)
[2026-05-11 16:45:20.452240] INFO [LIB] stat (utility.h:1238) [21595][T1_TenantWeakRe][T1][Y0-0000000000000000-0-0] [lt=11] [PALF STAT PUSH LOG TO FOLLOWERS RPC POST COST TIME](cur_stat_count=10, stat_interval=1000000, avg (count/cost)=0, this=0x7fcc5339f470, extra_info="")
[2026-05-11 16:45:20.452323] INFO [LIB] stat (utility.h:1238) [21595][T1_TenantWeakRe][T1][Y0-0000000000000000-0-0] [lt=67] [PALF STAT APPEND COST TIME](cur_stat_count=10, stat_interval=1000000, avg (count/cost)=0, this=0x7fcc52dde050, extra_info=“id:1”)
[2026-05-11 16:45:20.452505] INFO [STORAGE.TRANS] check_all_readonly_tx_clean_up (ob_ls_tx_service.cpp:356) [21603][T1_TxLoopWorker][T1][Y0-0000000000000000-0-0] [lt=23] wait_all_readonly_tx_cleaned_up cleaned up success(ls_id={id:1})
[2026-05-11 16:45:20.455149] INFO [PALF] inner_append_log (palf_handle_impl.cpp:2239) [20752][T1_IOWorker][T1][Y0-0000000000000000-0-0] [lt=6] [PALF STAT INNER APPEND LOG SIZE](this={palf_id:1, self:“192.168.2.147:2882”, has_set_deleted:false}, accum_size=3984)
[2026-05-11 16:45:20.455243] INFO [PALF] try_advance_committed_lsn_ (log_sliding_window.cpp:1758) [20751][T1_LogIOCb0][T1][Y0-0000000000000000-0-0] [lt=7] [PALF STAT COMMITTED LOG SIZE](palf_id=1, self=“192.168.2.147:2882”, committed size=3984)
[2026-05-11 16:45:20.455276] INFO [PALF] sliding_cb (log_sliding_window.cpp:2278) [20751][T1_LogIOCb0][T1][Y0-0000000000000000-0-0] [lt=16] [PALF STAT LOG TASK TIME](palf_id=1, self=“192.168.2.147:2882”, total_slide_log_cnt=10, avg_log_gen_to_freeze_time=4, avg_log_gen_to_submit_time=19, avg_log_submit_to_flush_time=2190, avg_log_submit_to_slide_time=2200)
[2026-05-11 16:45:20.455293] INFO [LIB] stat (utility.h:1238) [20751][T1_LogIOCb0][T1][Y0-0000000000000000-0-0] [lt=9] [PALF STAT FLUSH CB COST TIME](cur_stat_count=10, stat_interval=1000000, avg (count/cost)=32, this=0x7fcc533a9fe0, extra_info="")
[2026-05-11 16:45:20.462680] INFO [STORAGE] scheduler_ls_ha_handler_ (ob_storage_ha_service.cpp:195) [21602][T1_HAService][T1][YB42C0A80293-000651868A976255-0-0] [lt=18] start do ls ha handler(ls_id_array_=[{id:1}])
[2026-05-11 16:45:20.497746] INFO [STORAGE.BLKMGR] runTimerTask (ob_block_manager.cpp:1649) [20337][TimerWK0_BlkMgr][T0][Y0-0000000000000000-0-0] [lt=18] skip inspect bad block(last_check_time=1778488139817523, last_macro_idx=-1)
[2026-05-11 16:45:20.514959] INFO [RPC.FRAME] rpc_easy_timer_cb (ob_net_easy.cpp:601) [20447][RpcIO][T0][Y0-0000000000000000-0-0] [lt=15] [RPC EASY STAT](log_str=conn count=0/0, request done=0/0, request doing=0/0)
[2026-05-11 16:45:20.515154] INFO [RPC.FRAME] rpc_easy_timer_cb (ob_net_easy.cpp:601) [20448][RpcIO][T0][Y0-0000000000000000-0-0] [lt=19] [RPC EASY STAT](log_str=conn count=0/0, request done=0/0, request doing=0/0)
[2026-05-11 16:45:20.515172] INFO [RPC.FRAME] rpc_easy_timer_cb (ob_net_easy.cpp:601) [20446][RpcIO][T0][Y0-0000000000000000-0-0] [lt=12] [RPC EASY STAT](log_str=conn count=0/0, request done=0/0, request doing=0/0)
[2026-05-11 16:45:20.526567] INFO [COMMON] compute_tenant_wash_size (ob_kvcache_store.cpp:1466) [20340][TimerWK3_KVCacheWash][T0][Y0-0000000000000000-0-0] [lt=17] Wash compute wash size(is_wash_valid=false, sys_total_wash_size=-201207808, global_cache_size=79069184, tenant_max_wash_size=0, tenant_min_wash_size=0, tenant_ids_=[500, 508, 509, 1])
[2026-05-11 16:45:20.526637] INFO [COMMON] wash (ob_kvcache_hazard_domain.h:326) [20340][TimerWK3_KVCacheWash][T0][Y0-0000000000000000-0-0] [lt=23] allocator wash time (wash_time_us=4, freed_blocks_num=0, memory_efficiency=9.526193456105847002e-01)
[2026-05-11 16:45:20.551207] INFO [PALF] log_loop_ (log_loop_thread.cpp:154) [20756][T1_LogLoop][T1][Y0-0000000000000000-0-0] [lt=79] LogLoopThread round_cost_time(us)(round_cost_time=25)
[2026-05-11 16:45:20.553092] INFO [STORAGE.TRANS] check_all_readonly_tx_clean_up (ob_ls_tx_service.cpp:356) [21603][T1_TxLoopWorker][T1][Y0-0000000000000000-0-0] [lt=29] wait_all_readonly_tx_cleaned_up cleaned up success(ls_id={id:1})
[2026-05-11 16:45:20.609240] INFO [COMMON] replace_map (ob_kv_storecache.cpp:696) [20340][TimerWK3_KVCacheRep][T0][Y0-0000000000000000-0-0] [lt=13] replace map num details(ret=0, replace_node_count=0, map_once_replace_num_=15728, map_replace_skip_count_=5)
[2026-05-11 16:45:20.654051] INFO [STORAGE.TRANS] check_all_readonly_tx_clean_up (ob_ls_tx_service.cpp:346) [21603][T1_TxLoopWorker][T1][Y0-0000000000000000-0-0] [lt=20] readonly requests are active(active_readonly_request_count=1)
[root@www log]#
rootservice.log 近50条的：[2026-05-11 16:46:49.124884] INFO [RS.LB] do_non_tenantgroup_unit_balance_task (ob_server_balancer.cpp:5305) [20417][RootBalance][T0][YB42C0A80293-000651868D675FC5-0-0] [lt=8] start do non-tenantgroup unit balance task(zone=zone1)
[2026-05-11 16:46:49.124892] INFO [RS.LB] calc_global_balance_resource_weights (ob_server_balancer.cpp:5634) [20417][RootBalance][T0][YB42C0A80293-000651868D675FC5-0-0] [lt=5] finish calc global balance resource weights(ret=0, ret=“OB_SUCCESS”, zone=zone1, cpu_weights=2.877697841823023683e-01, mem_weights=4.604316546916838448e-01, log_disk_weights=2.517985611260137868e-01, data_disk_weights=0.000000000000000000e+00, available_servers=[“192.168.2.147:2882”])
[2026-05-11 16:46:49.124909] INFO [RS.LB] divide_complete_server_loads_for_balance (ob_server_balancer.cpp:4541) [20417][RootBalance][T0][YB42C0A80293-000651868D675FC5-0-0] [lt=14] divide complete server loads for balance(ret=0, ret=“OB_SUCCESS”, server_loads=[{server_:“192.168.2.147:2882”, load_sum_:{load_sum_:{unit_config_id:18446744073709551615, name:"", resource:{min_cpu:4, max_cpu:4, memory_size:“4GB”, log_disk_size:“7GB”, data_disk_size:0, min_iops:-9223372036854755809, max_iops:-9223372036854755809, iops_weight:3, max_net_bandwidth:“8.58993459e+09GB”, net_bandwidth_weight:4, }}}, resource_info_:{cpu_capacity:8, cpu_assigned:2, cpu_assigned_max:2, mem_capacity:“5GB”, mem_assigned:“2GB”, mem_in_use:0GB, log_disk_capacity:16GB, log_disk_assigned:2GB, log_disk_in_use:0.3125GB, data_disk_capacity:7.40234375GB, data_disk_assigned:0GB, data_disk_in_use:0.107421875GB}, inter_ttg_load_value_:“6.223920863224726707e-01”}], available_servers=[“192.168.2.147:2882”], wild_server_loads=[], over_server_loads=[], under_server_loads=[{server_:“192.168.2.147:2882”, load_sum_:{load_sum_:{unit_config_id:18446744073709551615, name:"", resource:{min_cpu:4, max_cpu:4, memory_size:“4GB”, log_disk_size:“7GB”, data_disk_size:0, min_iops:-9223372036854755809, max_iops:-9223372036854755809, iops_weight:3, max_net_bandwidth:“8.58993459e+09GB”, net_bandwidth_weight:4, }}}, resource_info_:{cpu_capacity:8, cpu_assigned:2, cpu_assigned_max:2, mem_capacity:“5GB”, mem_assigned:“2GB”, mem_in_use:0GB, log_disk_capacity:16GB, log_disk_assigned:2GB, log_disk_in_use:0.3125GB, data_disk_capacity:7.40234375GB, data_disk_assigned:0GB, data_disk_in_use:0.107421875GB}, inter_ttg_load_value_:“6.223920863224726707e-01”}])
[2026-05-11 16:46:49.124945] INFO [RS.LB] check_all_available_servers_over_disk_waterlevel (ob_server_balancer.cpp:8120) [20417][RootBalance][T0][YB42C0A80293-000651868D675FC5-0-0] [lt=35] check server over disk waterlevel(zone=zone1, disk_statistic={server_:“192.168.2.147:2882”, disk_in_use_:115343360, disk_total_:7948206080, wild_server_:false}, over_disk_waterlevel=false)
[2026-05-11 16:46:49.124952] INFO [RS.LB] check_all_available_servers_over_disk_waterlevel (ob_server_balancer.cpp:8126) [20417][RootBalance][T0][YB42C0A80293-000651868D675FC5-0-0] [lt=7] check all available servers over disk waterlevel(zone=zone1, all_available_servers_over_disk_waterlevel=false, zone_server_over_disk_waterlevel=false, server_disk_statistic_array=[{server_:“192.168.2.147:2882”, disk_in_use_:115343360, disk_total_:7948206080, wild_server_:false}])
[2026-05-11 16:46:49.124961] INFO [RS.LB] make_available_servers_balance (ob_server_balancer.cpp:5287) [20417][RootBalance][T0][YB42C0A80293-000651868D675FC5-0-0] [lt=6] finish zone servers balance(ret=0, ret=“OB_SUCCESS”, disk_waterlevel=8.000000000000000444e-01, balance_task_count=0, balance_reason=“load_balance”, all_available_servers_disk_over=false, zone_over_disk_waterlevel=false, standalone_units.count()=0, not_grant_units.count()=1)
[2026-05-11 16:46:49.124968] INFO [RS.LB] do_non_tenantgroup_unit_balance_task (ob_server_balancer.cpp:5342) [20417][RootBalance][T0][YB42C0A80293-000651868D675FC5-0-0] [lt=7] finish do non-tenantgroup unit balance task(ret=0, ret=“OB_SUCCESS”, zone=zone1, upper_lmt=6.535116906385962654e-01, wild_server_loads.count()=0, over_server_loads.count()=0, under_server_loads.count()=1, standalone_units=[], not_grant_units=[{unit_id:1005, tenant_id:18446744073709551615, resource_pool_id:1005, unit_config:{unit_config_id:1004, name:“lgsettl_new_unit”, resource:{min_cpu:2, max_cpu:2, memory_size:“2GB”, log_disk_size:“5GB”, data_disk_size:0, min_iops:20000, max_iops:20000, iops_weight:2, max_net_bandwidth:INT64_MAX, net_bandwidth_weight:2, }}, unit:0x7fcc3a9e9d18, unit_config:0x7fcc32979d18, pool:0x7fcc32977688}], available_servers=[“192.168.2.147:2882”])
[2026-05-11 16:46:49.456815] INFO [RS] do_work (ob_standby_schema_refresh_trigger.cpp:68) [20581][T1_StandbySchem][T1][YB42C0A80293-000651868A2762AF-0-0] [lt=96] [STANDBY_SCHEMA_REFRESH_TRIGGER] finish one round(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 16:46:49.647120] INFO [RS] do_work (ob_common_ls_service.cpp:125) [20582][T1_COMMONLSSe][T1][YB42C0A80293-000651868C1762A0-0-0] [lt=23] [COMMON_LS_SERVICE] finish one round(ret=0, ret=“OB_SUCCESS”, tmp_ret=0, tmp_ret=“OB_SUCCESS”, idle_time_us=1000000)
[2026-05-11 16:46:49.793494] INFO [RS] send_heartbeat_ (ob_heartbeat_service.cpp:262) [20608][T1_HBService][T1][YB42C0A80293-000651868BE76093-0-0] [lt=14] send_heartbeat_ has finished one round(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 16:46:50.286889] INFO [RS] manage_heartbeat_ (ob_heartbeat_service.cpp:394) [20609][T1_HBService][T1][YB42C0A80293-000651868BD76095-0-0] [lt=23] manage_heartbeat_ has finished one round(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 16:46:50.457533] INFO [RS] do_work (ob_standby_schema_refresh_trigger.cpp:68) [20581][T1_StandbySchem][T1][YB42C0A80293-000651868A2762B0-0-0] [lt=29] [STANDBY_SCHEMA_REFRESH_TRIGGER] finish one round(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 16:46:50.623118] INFO [RS] need_schedule (ob_mview_update_deps_task.cpp:113) [20621][T1_TimerWK1_TntSharedTimer][T1][Y0-0000000000000000-0-0] [lt=26] check mview update deps task need schedule(ret=0, need_sche=false, tenant_id_=1)
[2026-05-11 16:46:50.649405] INFO [RS] do_work (ob_common_ls_service.cpp:125) [20582][T1_COMMONLSSe][T1][YB42C0A80293-000651868C1762A1-0-0] [lt=31] [COMMON_LS_SERVICE] finish one round(ret=0, ret=“OB_SUCCESS”, tmp_ret=0, tmp_ret=“OB_SUCCESS”, idle_time_us=1000000)
[2026-05-11 16:46:51.458656] INFO [RS] do_work (ob_standby_schema_refresh_trigger.cpp:68) [20581][T1_StandbySchem][T1][YB42C0A80293-000651868A2762B1-0-0] [lt=52] [STANDBY_SCHEMA_REFRESH_TRIGGER] finish one round(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 16:46:51.651410] INFO [RS] do_work (ob_common_ls_service.cpp:125) [20582][T1_COMMONLSSe][T1][YB42C0A80293-000651868C1762A2-0-0] [lt=22] [COMMON_LS_SERVICE] finish one round(ret=0, ret=“OB_SUCCESS”, tmp_ret=0, tmp_ret=“OB_SUCCESS”, idle_time_us=1000000)
[2026-05-11 16:46:51.794128] INFO [RS] send_heartbeat_ (ob_heartbeat_service.cpp:262) [20608][T1_HBService][T1][YB42C0A80293-000651868BE76094-0-0] [lt=21] send_heartbeat_ has finished one round(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 16:46:52.208982] INFO [RS] scheduler (ob_dbms_job_master.cpp:318) [20420][DBMS_JOB_MASTER][T0][YB42C0A80293-0006518689D75E86-0-0] [lt=20] dbms job master wait timeout, no entry(ret=-4018)
[2026-05-11 16:46:52.209093] INFO [RS] scheduler (ob_dbms_job_master.cpp:318) [20420][DBMS_JOB_MASTER][T0][YB42C0A80293-0006518689D75E86-0-0] [lt=37] dbms job master wait timeout, no entry(ret=-4018)
[2026-05-11 16:46:52.209130] INFO [RS] scheduler (ob_dbms_job_master.cpp:331) [20420][DBMS_JOB_MASTER][T0][YB42C0A80293-0006518689D75E86-0-0] [lt=17] success to scheduler single dbms job(ret=0, tmp_ret=0, job_key={check_job:false, check_new:false, check_new_tenant:true, execute_at:1778489217209112, delay:5000000, job_id:0, tenant_id:1})
[2026-05-11 16:46:52.291719] INFO [RS] manage_heartbeat_ (ob_heartbeat_service.cpp:394) [20609][T1_HBService][T1][YB42C0A80293-000651868BD76096-0-0] [lt=23] manage_heartbeat_ has finished one round(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 16:46:52.441737] INFO [RS] update_mview_refresh_info_cache (ob_mview_maintenance_service.cpp:330) [20620][T1_TimerWK0_TntSharedTimer][T1][Y0-0000000000000000-0-0] [lt=4] update mview refresh info(ret=0, mview_ids=[], mview_refresh_scns=[], update_cache_cnt=0, del_mview_id=[], cost=2)
[2026-05-11 16:46:52.458949] INFO [RS] do_work (ob_standby_schema_refresh_trigger.cpp:68) [20581][T1_StandbySchem][T1][YB42C0A80293-000651868A2762B2-0-0] [lt=26] [STANDBY_SCHEMA_REFRESH_TRIGGER] finish one round(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 16:46:52.653145] INFO [RS] do_work (ob_common_ls_service.cpp:125) [20582][T1_COMMONLSSe][T1][YB42C0A80293-000651868C1762A3-0-0] [lt=27] [COMMON_LS_SERVICE] finish one round(ret=0, ret=“OB_SUCCESS”, tmp_ret=0, tmp_ret=“OB_SUCCESS”, idle_time_us=1000000)
[2026-05-11 16:46:53.459128] INFO [RS] do_work (ob_standby_schema_refresh_trigger.cpp:68) [20581][T1_StandbySchem][T1][YB42C0A80293-000651868A2762B3-0-0] [lt=64] [STANDBY_SCHEMA_REFRESH_TRIGGER] finish one round(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 16:46:53.655388] INFO [RS] do_work (ob_common_ls_service.cpp:125) [20582][T1_COMMONLSSe][T1][YB42C0A80293-000651868C1762A4-0-0] [lt=22] [COMMON_LS_SERVICE] finish one round(ret=0, ret=“OB_SUCCESS”, tmp_ret=0, tmp_ret=“OB_SUCCESS”, idle_time_us=1000000)
[2026-05-11 16:46:53.795191] INFO [RS] send_heartbeat_ (ob_heartbeat_service.cpp:262) [20608][T1_HBService][T1][YB42C0A80293-000651868BE76095-0-0] [lt=14] send_heartbeat_ has finished one round(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 16:46:54.298815] INFO [RS] manage_heartbeat_ (ob_heartbeat_service.cpp:394) [20609][T1_HBService][T1][YB42C0A80293-000651868BD76097-0-0] [lt=27] manage_heartbeat_ has finished one round(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 16:46:54.459719] INFO [RS] do_work (ob_standby_schema_refresh_trigger.cpp:68) [20581][T1_StandbySchem][T1][YB42C0A80293-000651868A2762B4-0-0] [lt=62] [STANDBY_SCHEMA_REFRESH_TRIGGER] finish one round(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 16:46:54.657130] INFO [RS] do_work (ob_common_ls_service.cpp:125) [20582][T1_COMMONLSSe][T1][YB42C0A80293-000651868C1762A5-0-0] [lt=25] [COMMON_LS_SERVICE] finish one round(ret=0, ret=“OB_SUCCESS”, tmp_ret=0, tmp_ret=“OB_SUCCESS”, idle_time_us=1000000)
[2026-05-11 16:46:55.202989] INFO [RS] gc_mview (ob_mview_maintenance_task.cpp:267) [20624][T1_TimerWK3_TntSharedTimer][T1][Y0-0000000000000000-0-0] [lt=13] mview maintenance task gc mview success(tenant_id_=1, round_=14, gc_mview_cost_us_=1301, fetch_mview_num_=0, gc_mview_num_=0, gc_stats_num_=0)
[2026-05-11 16:46:55.460112] INFO [RS] do_work (ob_standby_schema_refresh_trigger.cpp:68) [20581][T1_StandbySchem][T1][YB42C0A80293-000651868A2762B5-0-0] [lt=64] [STANDBY_SCHEMA_REFRESH_TRIGGER] finish one round(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 16:46:55.625744] INFO [RS] need_schedule (ob_mview_update_deps_task.cpp:113) [20620][T1_TimerWK0_TntSharedTimer][T1][Y0-0000000000000000-0-0] [lt=25] check mview update deps task need schedule(ret=0, need_sche=false, tenant_id_=1)
[2026-05-11 16:46:55.658967] INFO [RS] do_work (ob_common_ls_service.cpp:125) [20582][T1_COMMONLSSe][T1][YB42C0A80293-000651868C1762A6-0-0] [lt=22] [COMMON_LS_SERVICE] finish one round(ret=0, ret=“OB_SUCCESS”, tmp_ret=0, tmp_ret=“OB_SUCCESS”, idle_time_us=1000000)
[2026-05-11 16:46:55.796330] INFO [RS] send_heartbeat_ (ob_heartbeat_service.cpp:262) [20608][T1_HBService][T1][YB42C0A80293-000651868BE76096-0-0] [lt=16] send_heartbeat_ has finished one round(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 16:46:56.303684] INFO [RS] manage_heartbeat_ (ob_heartbeat_service.cpp:394) [20609][T1_HBService][T1][YB42C0A80293-000651868BD76098-0-0] [lt=21] manage_heartbeat_ has finished one round(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 16:46:56.460257] INFO [RS] do_work (ob_standby_schema_refresh_trigger.cpp:68) [20581][T1_StandbySchem][T1][YB42C0A80293-000651868A2762B6-0-0] [lt=66] [STANDBY_SCHEMA_REFRESH_TRIGGER] finish one round(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 16:46:56.586184] WDIAG [SQL] move_to_sqlstat_cache (ob_sql_stat_record.cpp:339) [24818][T1_FrzInfoDet][T1][YB42C0A80293-000651868BC75EEE-0-0] [lt=25][errcode=0] the key is not valid which at plan cache mgr(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 16:46:56.586542] INFO [STORAGE.TRANS] get_number (ob_id_service.cpp:384) [24818][T1_FrzInfoDet][T1][YB42C0A80293-000651868BC75EEE-0-0] [lt=19] get number(ret=0, service_type_=0, range=1, base_id=1778489216586232000, start_id=1778489216586232000, end_id=1778489216586232001)
[2026-05-11 16:46:56.588842] WDIAG [SQL] move_to_sqlstat_cache (ob_sql_stat_record.cpp:339) [24818][T1_FrzInfoDet][T1][YB42C0A80293-000651868BC75EEE-0-0] [lt=17][errcode=0] the key is not valid which at plan cache mgr(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 16:46:56.588984] INFO [RS] renew_snapshot_gc_scn (ob_major_merge_info_manager.cpp:340) [24818][T1_FrzInfoDet][T1][YB42C0A80293-000651868BC75EEE-0-0] [lt=19] renew snapshot_gc_scn(ret=0, new_snapshot_gc_scn={val:1778489216586232000, v:0}, tenant_id=1)
[2026-05-11 16:46:56.591104] WDIAG [SQL] move_to_sqlstat_cache (ob_sql_stat_record.cpp:339) [24818][T1_FrzInfoDet][T1][YB42C0A80293-000651868BC75EEE-0-0] [lt=16][errcode=0] the key is not valid which at plan cache mgr(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 16:46:56.592931] WDIAG [SQL] move_to_sqlstat_cache (ob_sql_stat_record.cpp:339) [24818][T1_FrzInfoDet][T1][YB42C0A80293-000651868BC75EEE-0-0] [lt=20][errcode=0] the key is not valid which at plan cache mgr(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 16:46:56.660490] INFO [RS] do_work (ob_common_ls_service.cpp:125) [20582][T1_COMMONLSSe][T1][YB42C0A80293-000651868C1762A7-0-0] [lt=23] [COMMON_LS_SERVICE] finish one round(ret=0, ret=“OB_SUCCESS”, tmp_ret=0, tmp_ret=“OB_SUCCESS”, idle_time_us=1000000)
[2026-05-11 16:46:57.209248] INFO [RS] scheduler (ob_dbms_job_master.cpp:318) [20420][DBMS_JOB_MASTER][T0][YB42C0A80293-0006518689D75E86-0-0] [lt=22] dbms job master wait timeout, no entry(ret=-4018)
[2026-05-11 16:46:57.212460] INFO [RS] scheduler (ob_dbms_job_master.cpp:318) [20420][DBMS_JOB_MASTER][T0][YB42C0A80293-0006518689D75E86-0-0] [lt=23] dbms job master wait timeout, no entry(ret=-4018)
[2026-05-11 16:46:57.212485] INFO [RS] scheduler (ob_dbms_job_master.cpp:331) [20420][DBMS_JOB_MASTER][T0][YB42C0A80293-0006518689D75E86-0-0] [lt=16] success to scheduler single dbms job(ret=0, tmp_ret=0, job_key={check_job:false, check_new:false, check_new_tenant:true, execute_at:1778489222212477, delay:5000000, job_id:0, tenant_id:1})
[2026-05-11 16:46:57.260944] INFO [RS] check_lost_replicas (ob_lost_replica_checker.cpp:104) [20416][LostRepCheck][T0][Y0-0000000000000000-0-0] [lt=17] start checking lost replicas
[2026-05-11 16:46:57.443979] INFO [RS] update_mview_refresh_info_cache (ob_mview_maintenance_service.cpp:330) [20621][T1_TimerWK1_TntSharedTimer][T1][Y0-0000000000000000-0-0] [lt=15] update mview refresh info(ret=0, mview_ids=[], mview_refresh_scns=[], update_cache_cnt=0, del_mview_id=[], cost=5)
[2026-05-11 16:46:57.461557] INFO [RS] do_work (ob_standby_schema_refresh_trigger.cpp:68) [20581][T1_StandbySchem][T1][YB42C0A80293-000651868A2762B7-0-0] [lt=32] [STANDBY_SCHEMA_REFRESH_TRIGGER] finish one round(ret=0, ret=“OB_SUCCESS”)
[root@www log]#
学习。
重新做一下操作 把整个日志都发一下 日志信息不全
内容大小有限制，截了倒数的，我是先把之前的日志清空了，再执行恢复命令，然后截取的日志 observer.log used:55242}, {obj_id:5958, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:55142}, {obj_id:5959, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:55182}, {obj_id:5960, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:55100}, {obj_id:5961, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:55208}, {obj_id:5962, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:55412}, {obj_id:5963, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:55311}, {obj_id:5964, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:55355}, {obj_id:5965, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:54840}, {obj_id:5966, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:54866}, {obj_id:5967, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:55032}, {obj_id:5968, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:54760}, {obj_id:5969, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:55146}, {obj_id:5970, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:55391}, {obj_id:5971, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:54825}, {obj_id:5972, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:54890}, {obj_id:5973, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:54845}, {obj_id:5974, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:55183}, {obj_id:5975, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:55134}, {obj_id:5976, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:55927}, {obj_id:5977, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:54854}, {obj_id:5979, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:54867}, {obj_id:5981, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:54873}, {obj_id:5982, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:54837}, {obj_id:5983, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:55101}, {obj_id:5984, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:55278}, {obj_id:5985, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:54965}, {obj_id:5986, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:56496}, {obj_id:5989, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:54833}, {obj_id:5990, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:55453}, {obj_id:5991, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:55558}, {obj_id:5992, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:55188}, {obj_id:5993, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:54982}, {obj_id:5994, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:56177}, {obj_id:5995, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:56057}, {obj_id:5996, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:56571}, {obj_id:5997, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:55093}, {obj_id:5998, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:54815}, {obj_id:5999, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:54835}, {obj_id:6000, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:54906}, {obj_id:6001, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:55180}, {obj_id:6002, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:56726}, {obj_id:6003, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:54867}, {obj_id:6004, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:55324}, {obj_id:6005, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:54922}, {obj_id:6006, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:55552}, {obj_id:6007, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:54793}, {obj_id:6008, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:55169}, {obj_id:6010, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:55224}, {obj_id:6012, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:55182}, {obj_id:6013, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:55523}, {obj_id:6014, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:54835}, {obj_id:6015, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:55063}, {obj_id:6016, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:54866}, {obj_id:6017, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:133504}, {obj_id:6018, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:542949}, {obj_id:6019, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:125339}, {obj_id:6021, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:231762}, {obj_id:6023, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:74117}, {obj_id:6024, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:58045}, {obj_id:6027, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:72805}, {obj_id:6028, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:68678}, {obj_id:6036, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:49614}, {obj_id:6037, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:68168}, {obj_id:6039, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:58397}, {obj_id:6042, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:56019}, {obj_id:6043, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:50213}, {obj_id:6044, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:52600}, {obj_id:6045, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:51888}, {obj_id:6048, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:47946}, {obj_id:6059, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:70256}, {obj_id:6106, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:56923}, {obj_id:6111, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:57566}, {obj_id:6131, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:55754}, {obj_id:6219, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:55507}, {obj_id:6385, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:118691}, {obj_id:6386, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:98205}, {obj_id:6387, tenant_id:1, log_del_time:9223372036854775807, real_del_time:9223372036854775807, ref_count:2, added_to_lc:true, mem_used:96203}])
[2026-05-11 17:33:16.838104] INFO [SQL.PC] runTimerTask (ob_plan_cache.cpp:2678) [20621][T1_TimerWK1_PlanCacheEvict][T1][Y0-0000000000000000-0-0] [lt=265] schedule next cache evict task(evict_interval=5000000)
[2026-05-11 17:33:16.854010] INFO [SERVER] runTimerTask (ob_eliminate_task.cpp:225) [20622][T1_TimerWK2_ReqMemEvict][T1][Y0-0000000000000000-0-0] [lt=24] sql audit evict task end(request_manager_->get_tenant_id()=1, evict_high_mem_level=32212254, evict_high_size_level=471859, evict_batch_count=0, elapse_time=0, size_used=0, mem_used=22877184)
[2026-05-11 17:33:16.854103] INFO [SERVER] prepare_alloc_queue (ob_dl_queue.cpp:92) [20621][T1_TimerWK1_ReqMemEvict][T1][Y0-0000000000000000-0-0] [lt=6] Construct Queue Num(construct_num=0, get_push_idx()=9, get_cur_idx()=1, get_pop_idx()=1)
[2026-05-11 17:33:16.857346] INFO [COMMON] compute_tenant_wash_size (ob_kvcache_store.cpp:1466) [20339][TimerWK2_KVCacheWash][T0][Y0-0000000000000000-0-0] [lt=12] Wash compute wash size(is_wash_valid=false, sys_total_wash_size=-136196096, global_cache_size=93634560, tenant_max_wash_size=0, tenant_min_wash_size=0, tenant_ids_=[500, 508, 509, 1])
[2026-05-11 17:33:16.857411] INFO [COMMON] wash (ob_kvcache_hazard_domain.h:326) [20339][TimerWK2_KVCacheWash][T0][Y0-0000000000000000-0-0] [lt=20] allocator wash time (wash_time_us=4, freed_blocks_num=0, memory_efficiency=9.552516041877744390e-01)
[2026-05-11 17:33:16.896990] INFO [SHARE] run_loop_ (ob_bg_thread_monitor.cpp:326) [25093][BGThreadMonitor][T0][Y0-0000000000000000-0-0] [lt=21] current monitor number(seq_=-1)
[2026-05-11 17:33:16.912174] INFO [SQL.PC] need_check_schema_version (ob_plan_cache_value.cpp:2339) [20620][T1_TimerWK0_TntSharedTimer][T1][YB42C0A80293-000651868B07712A-0-0] [lt=21] need check schema(new_schema_version=1778488119118120, cached_tenant_schema_version=1778488119118120, is_contain_synonym()=false, contain_sys_name_table_=true, is_contain_tmp_tbl()=false, is_contain_sys_pl_object()=false, need_check=true, constructed_sql_=SELECT EXISTS (SELECT ? FROM oceanbase.__all_mview_dep t1, oceanbase.__all_mview_dep t2 WHERE t1.mview_id = t2.p_obj AND t1.tenant_id = ?) as exist_nested)
[2026-05-11 17:33:16.921528] INFO [COMMON] replace_map (ob_kv_storecache.cpp:696) [20337][TimerWK0_KVCacheRep][T0][Y0-0000000000000000-0-0] [lt=22] replace map num details(ret=0, replace_node_count=0, map_once_replace_num_=15728, map_replace_skip_count_=2)
[2026-05-11 17:33:16.929275] INFO [LIB] stat (utility.h:1238) [21595][T1_TenantWeakRe][T1][Y0-0000000000000000-0-0] [lt=35] [PALF STAT PUSH LOG TO FOLLOWERS RPC POST COST TIME](cur_stat_count=10, stat_interval=1000000, avg (count/cost)=1, this=0x7fcc5339f470, extra_info="")
[2026-05-11 17:33:16.929305] INFO [PALF] handle_next_submit_log_ (log_sliding_window.cpp:1080) [21595][T1_TenantWeakRe][T1][Y0-0000000000000000-0-0] [lt=21] [PALF STAT GROUP LOG INFO](palf_id=1, self=“192.168.2.147:2882”, role=“LEADER”, total_group_log_cnt=10, avg_log_batch_cnt=1, total_group_log_size=3550, avg_group_log_size=355)
[2026-05-11 17:33:16.929316] INFO [PALF] submit_log (palf_handle_impl.cpp:446) [21595][T1_TenantWeakRe][T1][Y0-0000000000000000-0-0] [lt=9] [PALF STAT APPEND DATA SIZE](this={palf_id:1, self:“192.168.2.147:2882”, has_set_deleted:false}, append size=3549)
[2026-05-11 17:33:16.929344] INFO [LIB] stat (utility.h:1238) [21595][T1_TenantWeakRe][T1][Y0-0000000000000000-0-0] [lt=27] [PALF STAT APPEND COST TIME](cur_stat_count=10, stat_interval=1000000, avg (count/cost)=0, this=0x7fcc52dde050, extra_info=“id:1”)
[2026-05-11 17:33:16.931364] INFO [PALF] inner_append_log (palf_handle_impl.cpp:2239) [20752][T1_IOWorker][T1][Y0-0000000000000000-0-0] [lt=5] [PALF STAT INNER APPEND LOG SIZE](this={palf_id:1, self:“192.168.2.147:2882”, has_set_deleted:false}, accum_size=3550)
[2026-05-11 17:33:16.931522] INFO [PALF] try_advance_committed_lsn_ (log_sliding_window.cpp:1758) [20751][T1_LogIOCb0][T1][Y0-0000000000000000-0-0] [lt=6] [PALF STAT COMMITTED LOG SIZE](palf_id=1, self=“192.168.2.147:2882”, committed size=3550)
[2026-05-11 17:33:16.931966] INFO [STORAGE.TRANS] persist_version_if_need_ (ob_tenant_weak_read_cluster_service.cpp:331) [21595][T1_TenantWeakRe][T1][Y0-0000000000000000-0-0] [lt=5] [WRS] [TENANT_WEAK_READ_SERVICE] [CLUSTER_SERVICE] persist CLUSTER version range succ(tenant_id=1, new_min_version={val:1778491996726481000, v:0}, new_max_version={val:1778491996726481000, v:0}, last_min_version={val:1778491996526909000, v:0}, last_max_version={val:1778491996526909000, v:0}, total_time_us=3989, delta_us=205482)
[2026-05-11 17:33:16.931990] INFO [STORAGE.TRANS] update_cluster_version (ob_tenant_weak_read_cluster_service.cpp:690) [21595][T1_TenantWeakRe][T1][Y0-0000000000000000-0-0] [lt=23] [WRS] [TENANT_WEAK_READ_SERVICE] [CLUSTER_SERVICE] update version(tenant_id=1, current_version={val:1778491996726481000, v:0}, min_version={val:1778491996726481000, v:0}, max_version={val:1778491996726481000, v:0}, in_service=true, leader_epoch=10)
[2026-05-11 17:33:16.932005] INFO [STORAGE.TRANS] self_check (ob_tenant_weak_read_cluster_service.cpp:826) [21595][T1_TenantWeakRe][T1][Y0-0000000000000000-0-0] [lt=9] [WRS] [TENANT_WEAK_READ_SERVICE] [CLUSTER_SERVICE] [SELF_CHECK] done(ret=0, ret=“OB_SUCCESS”, tenant_id=1, need_start_service=false, need_stop_service=false, need_change_leader=false, is_in_service()=true, can_update_version=true, cur_leader_epoch=10, start_service_tstamp_=1778488155878689, error_count_for_change_leader_=0, last_error_tstamp_for_change_leader_=0)
[2026-05-11 17:33:16.933920] INFO [STORAGE.TRANS] check_all_readonly_tx_clean_up (ob_ls_tx_service.cpp:356) [21603][T1_TxLoopWorker][T1][Y0-0000000000000000-0-0] [lt=21] wait_all_readonly_tx_cleaned_up cleaned up success(ls_id={id:1})
[2026-05-11 17:33:16.961518] INFO [SQL.EXE] run2 (ob_maintain_dependency_info_task.cpp:228) [20421][MaintainDepInfo][T0][Y0-0000000000000000-0-0] [lt=27] [ASYNC TASK QUEUE](queue_.size()=0, sys_view_consistent_.size()=554)
[2026-05-11 17:33:16.993342] INFO [SHARE] get_zone_list_ (ob_zone_table_operation.cpp:553) [20337][TimerWK0_ServerGTimer][T0][Y0-0000000000000000-0-0] [lt=26] get inactive zone_list(ret=0, ret=“OB_SUCCESS”, zone_list=[])
[2026-05-11 17:33:17.000979] INFO [ARCHIVE] gc_stale_ls_task_ (ob_ls_mgr.cpp:573) [21596][T1_LSArchiveMgr][T1][YB42C0A80293-000651868A375E84-0-0] [lt=33] gc stale ls task succ
[2026-05-11 17:33:17.028357] INFO [PALF] log_loop_ (log_loop_thread.cpp:154) [20756][T1_LogLoop][T1][Y0-0000000000000000-0-0] [lt=16] LogLoopThread round_cost_time(us)(round_cost_time=13)
[2026-05-11 17:33:17.028367] INFO [MDS] for_each_ls_in_tenant (mds_tenant_service.cpp:225) [20569][T1_Occam][T1][YB42C0A80293-000651868AC76A91-0-0] [lt=49] for each ls(succ_num=1, ret=0, ret=“OB_SUCCESS”)
[2026-05-11 17:33:17.035205] INFO [STORAGE.TRANS] check_all_readonly_tx_clean_up (ob_ls_tx_service.cpp:356) [21603][T1_TxLoopWorker][T1][Y0-0000000000000000-0-0] [lt=17] wait_all_readonly_tx_cleaned_up cleaned up success(ls_id={id:1})
[2026-05-11 17:33:17.057958] INFO [COMMON] compute_tenant_wash_size (ob_kvcache_store.cpp:1466) [20340][TimerWK3_KVCacheWash][T0][Y0-0000000000000000-0-0] [lt=29] Wash compute wash size(is_wash_valid=false, sys_total_wash_size=-136196096, global_cache_size=93634560, tenant_max_wash_size=0, tenant_min_wash_size=0, tenant_ids_=[500, 508, 509, 1])
[2026-05-11 17:33:17.058036] INFO [COMMON] wash (ob_kvcache_hazard_domain.h:326) [20340][TimerWK3_KVCacheWash][T0][Y0-0000000000000000-0-0] [lt=31] allocator wash time (wash_time_us=4, freed_blocks_num=0, memory_efficiency=9.552516041877744390e-01)
[2026-05-11 17:33:17.121878] INFO [COMMON] replace_map (ob_kv_storecache.cpp:696) [20338][TimerWK1_KVCacheRep][T0][Y0-0000000000000000-0-0] [lt=21] replace map num details(ret=0, replace_node_count=0, map_once_replace_num_=15728, map_replace_skip_count_=1)
[2026-05-11 17:33:17.135607] INFO [STORAGE.TRANS] check_all_readonly_tx_clean_up (ob_ls_tx_service.cpp:356) [21603][T1_TxLoopWorker][T1][Y0-0000000000000000-0-0] [lt=48] wait_all_readonly_tx_cleaned_up cleaned up success(ls_id={id:1})
[2026-05-11 17:33:17.137229] INFO do_work (ob_rl_mgr.cpp:708) [20396][rl_mgr0][T0][Y0-0000000000000000-0-0] [lt=22] swc wakeup.(stat_period_=1000000, ready=false)
[2026-05-11 17:33:17.151217] INFO [STORAGE] gc_tables_in_queue (ob_tenant_meta_mem_mgr.cpp:635) [20621][T1_TimerWK1_TenantMetaMemMg][T1][Y0-0000000000000000-0-0] [lt=14] gc tables in queue: recycle 0 table(ret=0, tablet_buffer_pool_={typeid(T).name():“N9oceanbase7storage15ObMetaObjBufferINS0_8ObTabletELl3784EEE”, sizeof(T):3816, used_obj_cnt:1185, free_obj_hold_cnt:2, allocator used:4558080, allocator total:4896000}, large_tablet_buffer_pool_={typeid(T).name():“N9oceanbase7storage15ObMetaObjBufferINS0_8ObTabletELl65448EEE”, sizeof(T):65480, used_obj_cnt:1, free_obj_hold_cnt:0, allocator used:65591, allocator total:65591}, full_tablet_creator_={tiny_allocator_.used():0, tiny_allocator_.total():0, full allocator used:0, full allocator total:0}, tablets_mem=4961591, tablets_mem_limit=429496720, ddl_kv_pool_={typeid(T).name():“N9oceanbase7storage7ObDDLKVE”, sizeof(T):1024, used_obj_cnt:0, free_obj_hold_cnt:0, allocator used:0, allocator total:0}, memtable_pool_={typeid(T).name():“N9oceanbase8memtable10ObMemtableE”, sizeof(T):1984, used_obj_cnt:90, free_obj_hold_cnt:0, allocator used:184320, allocator total:195840}, pending_cnt=0, wait_gc_count=0, tablet count=1186)
[2026-05-11 17:33:17.236105] INFO [STORAGE.TRANS] check_all_readonly_tx_clean_up (ob_ls_tx_service.cpp:356) [21603][T1_TxLoopWorker][T1][Y0-0000000000000000-0-0] [lt=21] wait_all_readonly_tx_cleaned_up cleaned up success(ls_id={id:1})
[2026-05-11 17:33:17.258911] INFO [COMMON] compute_tenant_wash_size (ob_kvcache_store.cpp:1466) [20337][TimerWK0_KVCacheWash][T0][Y0-0000000000000000-0-0] [lt=22] Wash compute wash size(is_wash_valid=false, sys_total_wash_size=-136196096, global_cache_size=93634560, tenant_max_wash_size=0, tenant_min_wash_size=0, tenant_ids_=[500, 508, 509, 1])
[2026-05-11 17:33:17.258986] INFO [COMMON] wash (ob_kvcache_hazard_domain.h:326) [20337][TimerWK0_KVCacheWash][T0][Y0-0000000000000000-0-0] [lt=24] allocator wash time (wash_time_us=6, freed_blocks_num=0, memory_efficiency=9.552516041877744390e-01)
[2026-05-11 17:33:17.322164] INFO [COMMON] replace_map (ob_kv_storecache.cpp:696) [20338][TimerWK1_KVCacheRep][T0][Y0-0000000000000000-0-0] [lt=21] replace map num details(ret=0, replace_node_count=0, map_once_replace_num_=15728, map_replace_skip_count_=0)
[2026-05-11 17:33:17.329563] INFO [STORAGE.TRANS] run1 (ob_xa_trans_heartbeat_worker.cpp:87) [21592][T1_ObXAHbWorker][T1][Y0-0000000000000000-0-0] [lt=22] XA scheduler heartbeat task statistics(avg_time=1)
[2026-05-11 17:33:17.331217] INFO [SHARE] update_decay_factor_ (ob_throttle_unit.ipp:300) [21595][T1_TenantWeakRe][T1][YB42C0A80293-000651868D17A89D-0-0] [lt=10] [Throttle] Update Throttle Unit Config(is_adaptive_update=true, N=1.779375014305114746e+02, this=0x7fcc641982a0, enable_adaptive_limit_=true, Unit Name=TxShare, Config Specify Resource Limit(MB)=1126, Resource Limit(MB)=889, Throttle Trigger(MB)=533, Throttle Percentage=60, Max Duration(us)=7200000000, Decay Factor=2.840892258958227146e+01)
[2026-05-11 17:33:17.336598] INFO [STORAGE.TRANS] check_all_readonly_tx_clean_up (ob_ls_tx_service.cpp:356) [21603][T1_TxLoopWorker][T1][Y0-0000000000000000-0-0] [lt=21] wait_all_readonly_tx_cleaned_up cleaned up success(ls_id={id:1})
[2026-05-11 17:33:17.354476] INFO [SERVER] runTimerTask (ob_eliminate_task.cpp:225) [20622][T1_TimerWK2_ReqMemEvict][T1][Y0-0000000000000000-0-0] [lt=40] sql audit evict task end(request_manager_->get_tenant_id()=1, evict_high_mem_level=32212254, evict_high_size_level=471859, evict_batch_count=0, elapse_time=0, size_used=0, mem_used=22877184)
[2026-05-11 17:33:17.354611] INFO [SERVER] prepare_alloc_queue (ob_dl_queue.cpp:92) [20620][T1_TimerWK0_ReqMemEvict][T1][Y0-0000000000000000-0-0] [lt=91] Construct Queue Num(construct_num=0, get_push_idx()=9, get_cur_idx()=1, get_pop_idx()=1)
[2026-05-11 17:33:17.395373] INFO [SHARE] force_set_master_rs (ob_rs_mgr.cpp:269) [25250][T1_L0_G25][T1][YB42C0A80293-000651868BE76604-0-0] [lt=14] [RS_MGR] force set rs list(master_rs=“192.168.2.147:2882”)
[2026-05-11 17:33:17.395444] INFO [SERVER] handle_heartbeat (ob_service.cpp:3909) [25250][T1_L0_G25][T1][YB42C0A80293-000651868BE76604-0-0] [lt=64] handle_heartbeat(ret=0, ret=“OB_SUCCESS”, hb_request={server:“192.168.2.147:2882”, server_id:1, rs_addr:“192.168.2.147:2882”, rs_server_status:1, epoch_id:10}, hb_response={zone:“zone1”, server:“192.168.2.147:2882”, sql_port:2881, build_version:“4.3.5.5_105000012025111711-c10174c0486c38f64a2222486986bbe15d5da0dc(Nov 17 2025 12:19:35)”, start_service_time:1778488157114927, server_health_status:{data_disk_status_:1, data_disk_status:“NORMAL”}}, time_cost=72)
[2026-05-11 17:33:17.429356] INFO [STORAGE] runTimerTask (ob_checkpoint_service.cpp:289) [20621][T1_TimerWK1_CKClogDisk][T1][Y0-0000000000000000-0-0] [lt=39] ====== check clog disk timer task ======
[2026-05-11 17:33:17.429546] INFO [PALF] get_disk_usage (palf_env_impl.cpp:902) [20621][T1_TimerWK1_CKClogDisk][T1][Y0-0000000000000000-0-0] [lt=180] get_disk_usage(ret=0, capacity(MB):=2048, used(MB):=290)
[2026-05-11 17:33:17.439298] INFO [STORAGE.TRANS] check_all_readonly_tx_clean_up (ob_ls_tx_service.cpp:356) [21603][T1_TxLoopWorker][T1][Y0-0000000000000000-0-0] [lt=17] wait_all_readonly_tx_cleaned_up cleaned up success(ls_id={id:1})
[2026-05-11 17:33:17.439971] WDIAG [SQL.PC] common_free (ob_lib_cache_object_manager.cpp:139) [21643][T1_L0_G0][T1][YB42C0A80293-000651868D976CB3-0-0] [lt=23][errcode=0] set logical del time(cache_obj->get_logical_del_time()=3972728592, cache_obj->added_lc()=false, cache_obj->get_object_id()=6404, cache_obj->get_tenant_id()=1, lbt()=“0x263e9068 0x1a07b67e 0xa45f252 0xa44b12a 0xa43f804 0xa4378a8 0xa42468f 0x1377da79 0x260714d2 0x7fcc877b4b3e 0x7fcc87833d7c”)
[2026-05-11 17:33:17.448279] INFO [STORAGE] scheduler_ls_ha_handler_ (ob_storage_ha_service.cpp:195) [21602][T1_HAService][T1][YB42C0A80293-000651868A976D90-0-0] [lt=23] start do ls ha handler(ls_id_array_=[{id:1}])
[2026-05-11 17:33:17.451453] INFO [STORAGE] print_statistics (ob_tmp_file_thread_job.cpp:178) [21579][T1_TFSwap][T1][Y0-0000000000000000-0-0] [lt=23] tmp file swap statistics(swap_task_cnt=0, avg_swap_response_time=0, max_swap_response_time=-1, min_swap_response_time=-1)
[2026-05-11 17:33:17.451480] INFO [STORAGE] print_block_usage (ob_tmp_file_block_manager.cpp:831) [21579][T1_TFSwap][T1][Y0-0000000000000000-0-0] [lt=21] temporary file module use no blocks
[2026-05-11 17:33:17.451486] INFO [STORAGE] print_statistics (ob_tmp_file_thread_job.cpp:124) [21579][T1_TFSwap][T1][Y0-0000000000000000-0-0] [lt=6] tmp file flush statistics(flush_task_cnt=0, avg_flush_data_len=0, max_flush_data_len=-1, min_flush_data_len=-1, f1_cnt=0, f2_cnt=0, f3_cnt=0, f4_cnt=0, f5_cnt=0)
[2026-05-11 17:33:17.451493] INFO [STORAGE] print_statistics (ob_tmp_file_write_buffer_pool.cpp:1605) [21579][T1_TFSwap][T1][Y0-0000000000000000-0-0] [lt=6] tmp file write buffer pool statistics(dirty_page_percentage=0, max_page_num=2783, fat_actual_size=0, dirty_page_num=0, total_write_back_num=0, meta_page_num=0, dirty_meta_page_num=0, write_back_meta_num=0, data_page_num=0, dirty_data_page_num=0, write_back_data_num=0, data_page_watermark=0, meta_page_watermark=0)
[2026-05-11 17:33:17.451502] INFO [STORAGE] do_work_ (ob_tmp_file_thread_wrapper.cpp:305) [21579][T1_TFSwap][T1][Y0-0000000000000000-0-0] [lt=8] ObTmpFileFlushTG information(this={is_inited_:true, mode_:1, last_flush_timestamp_:3971739889, flush_io_finished_ret_:0, flush_io_finished_round_:3853, flushing_block_num_:0, is_fast_flush_meta_:false, fast_flush_meta_task_cnt_:0, wait_list_size_:0, retry_list_size_:0, finished_list_size_:0, normal_loop_cnt_:2, normal_idle_loop_cnt_:2, fast_loop_cnt_:0, fast_idle_loop_cnt_:0, flush_mgr_:{is_inited_:true, flush_ctx_:{is_inited_:true, fail_too_many_:false, expect_flush_size_:0, actual_flush_size_:0, flush_seq_ctx_:{create_flush_task_cnt_:0, prepare_finished_cnt_:0, flush_sequence_:0}, state_:5, iter_:{is_inited_:false, cur_caching_list_idx_:0, cur_caching_list_is_meta_:false, cur_iter_dir_idx_:-1, cur_iter_file_idx_:-1, cached_file_num_:0, cached_dir_num_:0}, file_ctx_hash_.size():0, flush_failed_array_.size():0}}})
[2026-05-11 17:33:17.457595] INFO [STORAGE] runTimerTask (ob_tablet_gc_service.cpp:147) [20621][T1_TimerWK1_][T1][Y0-0000000000000000-0-0] [lt=34] ====== [tabletchange] timer task ======(GC_CHECK_INTERVAL=5000000)
[2026-05-11 17:33:17.457619] INFO [STORAGE] runTimerTask (ob_tablet_gc_service.cpp:181) [20621][T1_TimerWK1_][T1][Y0-0000000000000000-0-0] [lt=17] [tabletchange] task check ls(ls->get_ls_id()={id:1}, tablet_persist_trigger=0)
[2026-05-11 17:33:17.457631] INFO [STORAGE] runTimerTask (ob_tablet_gc_service.cpp:276) [20621][T1_TimerWK1_][T1][Y0-0000000000000000-0-0] [lt=9] [tabletchange] succeed to gc_tablet(ret=0, ret=“OB_SUCCESS”, ls_cnt=1, times=201)
[2026-05-11 17:33:17.459698] INFO [COMMON] compute_tenant_wash_size (ob_kvcache_store.cpp:1466) [20337][TimerWK0_KVCacheWash][T0][Y0-0000000000000000-0-0] [lt=14] Wash compute wash size(is_wash_valid=false, sys_total_wash_size=-136196096, global_cache_size=93634560, tenant_max_wash_size=0, tenant_min_wash_size=0, tenant_ids_=[500, 508, 509, 1])
[2026-05-11 17:33:17.460785] INFO [COMMON] clean_garbage_node (ob_kvcache_map.cpp:706) [20337][TimerWK0_KVCacheWash][T0][Y0-0000000000000000-0-0] [lt=24] Cache wash clean map node details(ret=0, clean_node_count=0, clean_time=0, clean_start_pos=912253, clean_num=31457)
[2026-05-11 17:33:17.460812] INFO [COMMON] wash (ob_kvcache_hazard_domain.h:326) [20337][TimerWK0_KVCacheWash][T0][Y0-0000000000000000-0-0] [lt=21] allocator wash time (wash_time_us=3, freed_blocks_num=0, memory_efficiency=9.552516041877744390e-01)
[2026-05-11 17:33:17.485019] INFO [STORAGE.TRANS] operator() (ob_ts_mgr.h:180) [20445][TsMgr][T0][Y0-0000000000000000-0-0] [lt=10] refresh gts functor(ret=0, ret=“OB_SUCCESS”, gts_tenant_info={v:1})
[2026-05-11 17:33:17.514497] INFO [RPC.FRAME] rpc_easy_timer_cb (ob_net_easy.cpp:601) [20446][RpcIO][T0][Y0-0000000000000000-0-0] [lt=13] [RPC EASY STAT](log_str=conn count=0/0, request done=0/0, request doing=0/0)
[2026-05-11 17:33:17.514483] INFO [RPC.FRAME] rpc_easy_timer_cb (ob_net_easy.cpp:601) [20448][RpcIO][T0][Y0-0000000000000000-0-0] [lt=25] [RPC EASY STAT](log_str=conn count=0/0, request done=0/0, request doing=0/0)
[2026-05-11 17:33:17.514483] INFO [RPC.FRAME] rpc_easy_timer_cb (ob_net_easy.cpp:601) [20447][RpcIO][T0][Y0-0000000000000000-0-0] [lt=10] [RPC EASY STAT](log_str=conn count=0/0, request done=0/0, request doing=0/0)
[2026-05-11 17:33:17.523475] INFO [COMMON] replace_fragment_node (ob_kvcache_map.cpp:763) [20337][TimerWK0_KVCacheRep][T0][Y0-0000000000000000-0-0] [lt=10] Cache replace map node details(ret=0, replace_node_count=0, replace_time=0, replace_start_pos=471840, replace_num=15728)
[2026-05-11 17:33:17.523538] INFO [COMMON] replace_map (ob_kv_storecache.cpp:696) [20337][TimerWK0_KVCacheRep][T0][Y0-0000000000000000-0-0] [lt=60] replace map num details(ret=0, replace_node_count=0, map_once_replace_num_=15728, map_replace_skip_count_=10)
[2026-05-11 17:33:17.532816] WDIAG [SERVER.OMT] check_cgroup_root_dir (ob_cgroup_ctrl.cpp:221) [20521][MultiTenant][T0][Y0-0000000000000000-0-0] [lt=32][errcode=-4027] dir not exist(OBSERVER_ROOT_CGROUP_DIR=“cgroup”, ret=-4027)
[2026-05-11 17:33:17.536806] INFO [STORAGE.TRANS] generate_weak_read_timestamp_ (ob_ls_wrs_handler.cpp:190) [21595][T1_TenantWeakRe][T1][Y0-0000000000000000-0-0] [lt=28] get wrs ts(ls_id={id:1}, delta=205182, log_service_ts=1778491997331306, min_tx_service_ts=4611686018427387, timestamp={val:1778491997331306000, v:0})
[2026-05-11 17:33:17.536836] INFO [STORAGE.TRANS] print_stat_info (ob_keep_alive_ls_handler.cpp:226) [21595][T1_TenantWeakRe][T1][Y0-0000000000000000-0-0] [lt=26] [Keep Alive Stat] LS Keep Alive Info(tenant_id=1, LS_ID={id:1}, Not_Master_Cnt=0, Near_To_GTS_Cnt=57, Other_Error_Cnt=0, Submit_Succ_Cnt=42, last_scn="{val:1778491994112923001, v:0}", last_lsn={lsn:237129498}, last_gts={val:1778491997331306000, v:0}, min_start_scn="{val:0, v:0}", min_start_status=1, sys_ls_end_scn={val:0, v:0})
[2026-05-11 17:33:17.539520] INFO [STORAGE.TRANS] check_all_readonly_tx_clean_up (ob_ls_tx_service.cpp:356) [21603][T1_TxLoopWorker][T1][Y0-0000000000000000-0-0] [lt=25] wait_all_readonly_tx_cleaned_up cleaned up success(ls_id={id:1})
[2026-05-11 17:33:17.566548] INFO eloop_run (eloop.c:145) [20383][pnio1][T0][Y0-0000000000000000-0-0] [lt=24] PNIO [ratelimit] time: 1778491997566544, bytes: 15194596, bw: 0.004406 MB/s, add_ts: 1002050, add_bytes: 4629
“192.168.2.147:2882”, sql_port:2881, role:1, member_list:[{server:“192.168.2.147:2882”, timestamp:1}], replica_type:0, proposal_id:10, replica_status:“NORMAL”, restore_status:{status:0}, property:{memstore_percent_:100}, unit_id:1, zone:“zone1”, paxos_replica_number:1, data_size:0, required_size:0, in_member_list:true, member_time_us:1, learner_list:{learner_num:0, learner_array:[]}, in_learner_list:false, rebuild:false}]}, ls_status_info_:{tenant_id:1, ls_id:{id:1}, ls_group_id:0, status:“NORMAL”, unit_group_id:0, primary_zone:“zone1”, flag:{flag:0, is_duplicate:false, is_block_tablet_in:false}}, server_stat_array_:[{server:“192.168.2.147:2882”, alive:true, active:true, permanent_offline:false, block:false, stopped:false}], unit_stat_array_:[{unit_id:1, in_pool:true, unit:unit_id:1, resource_pool_id:1, unit_group_id:1, zone:“zone1”, server:“192.168.2.147:2882”, migrate_from_server:“0.0.0.0:0”, is_manual_migrate:false, status:0, replica_type:0, time_stamp:1778313976390762, server_stat:{server:“192.168.2.147:2882”, alive:true, active:true, permanent_offline:false, block:false, stopped:false}}], unit_in_group_stat_array_:[{unit_id:1, in_pool:true, unit:unit_id:1, resource_pool_id:1, unit_group_id:1, zone:“zone1”, server:“192.168.2.147:2882”, migrate_from_server:“0.0.0.0:0”, is_manual_migrate:false, status:0, replica_type:0, time_stamp:1778313976390762, server_stat:{server:“192.168.2.147:2882”, alive:true, active:true, permanent_offline:false, block:false, stopped:false}}], schema_replica_cnt_:1, schema_full_replica_cnt_:1, member_list_cnt_:1, paxos_replica_number_:1, has_leader_:true}, only_for_display=false)
[2026-05-11 17:33:11.750524] INFO [RS.LB] build_locality_stat_map (ob_disaster_recovery_worker.cpp:258) [20593][T1_DRService][T1][YB42C0A80293-000651868C976009-0-0] [lt=219] build ls locality stat map(tenant_id=1, ls_id={id:1})
[2026-05-11 17:33:11.750536] INFO [RS.LB] build_locality_stat_map (ob_disaster_recovery_worker.cpp:363) [20593][T1_DRService][T1][YB42C0A80293-000651868C976009-0-0] [lt=8] ls zone locality map info(zone=zone1, zone_replica_desc={replica_desc_array:[cnt:1, {replica_type_:0, memstore_percent_:100, replica_num_:1}], is_readonly_all_server:false, is_columnstore_all_server:false, readonly_memstore_percent:100})
[2026-05-11 17:33:11.750550] INFO [RS.LB] build_replica_stat_map (ob_disaster_recovery_worker.cpp:406) [20593][T1_DRService][T1][YB42C0A80293-000651868C976009-0-0] [lt=11] ls replica stat(replica_stat_map=[{replica_:{modify_time_us:1778488155998740, create_time_us:0, tenant_id:1, ls_id:{id:1}, server:“192.168.2.147:2882”, sql_port:2881, role:1, member_list:[{server:“192.168.2.147:2882”, timestamp:1}], replica_type:0, proposal_id:10, replica_status:“NORMAL”, restore_status:{status:0}, property:{memstore_percent_:100}, unit_id:1, zone:“zone1”, paxos_replica_number:1, data_size:0, required_size:0, in_member_list:true, member_time_us:1, learner_list:{learner_num:0, learner_array:[]}, in_learner_list:false, rebuild:false}, server_stat_info_:{server:“192.168.2.147:2882”, alive:true, active:true, permanent_offline:false, block:false, stopped:false}, unit_stat_info_:{unit_id:1, in_pool:true, unit:unit_id:1, resource_pool_id:1, unit_group_id:1, zone:“zone1”, server:“192.168.2.147:2882”, migrate_from_server:“0.0.0.0:0”, is_manual_migrate:false, status:0, replica_type:0, time_stamp:1778313976390762, server_stat:{server:“192.168.2.147:2882”, alive:true, active:true, permanent_offline:false, block:false, stopped:false}}, unit_in_group_stat_info_:{unit_id:1, in_pool:true, unit:unit_id:1, resource_pool_id:1, unit_group_id:1, zone:“zone1”, server:“192.168.2.147:2882”, migrate_from_server:“0.0.0.0:0”, is_manual_migrate:false, status:0, replica_type:0, time_stamp:1778313976390762, server_stat:{server:“192.168.2.147:2882”, alive:true, active:true, permanent_offline:false, block:false, stopped:false}}}])
[2026-05-11 17:33:11.750631] INFO [RS.LB] try_locality_alignment (ob_disaster_recovery_worker.cpp:4493) [20593][T1_DRService][T1][YB42C0A80293-000651868C976009-0-0] [lt=71] finish try locality alignment(ret=0, ret=“OB_SUCCESS”, acc_dr_task=0)
[2026-05-11 17:33:11.750650] INFO [RS.LB] try_shrink_resource_pools (ob_disaster_recovery_worker.cpp:4641) [20593][T1_DRService][T1][YB42C0A80293-000651868C976009-0-0] [lt=9] finish try shrink resource pool(ret=0, ret=“OB_SUCCESS”, acc_dr_task=0)
[2026-05-11 17:33:11.750658] INFO [RS.LB] try_cancel_unit_migration (ob_disaster_recovery_worker.cpp:5337) [20593][T1_DRService][T1][YB42C0A80293-000651868C976009-0-0] [lt=6] finish try cancel migrate unit(ret=0, ret=“OB_SUCCESS”, acc_dr_task=0)
[2026-05-11 17:33:11.750665] INFO [RS.LB] try_migrate_to_unit (ob_disaster_recovery_worker.cpp:5525) [20593][T1_DRService][T1][YB42C0A80293-000651868C976009-0-0] [lt=6] finish try migrate to unit(ret=0, ret=“OB_SUCCESS”, acc_dr_task=0)
[2026-05-11 17:33:11.750671] INFO [RS.LB] check_ls_disaster_recovery_tasks_ (ob_disaster_recovery_worker.cpp:2158) [20593][T1_DRService][T1][YB42C0A80293-000651868C976009-0-0] [lt=4] finish check dr tasks(ret=0, ret=“OB_SUCCESS”, cost=2179, tenant_id=1, ls_id={id:1})
[2026-05-11 17:33:11.750680] INFO [RS.LB] try_ls_disaster_recovery (ob_disaster_recovery_worker.cpp:2064) [20593][T1_DRService][T1][YB42C0A80293-000651868C976009-0-0] [lt=8] skip persist dr_task(only_for_display=false, task_count=0)
[2026-05-11 17:33:11.752585] INFO [RS] try_tenant_disaster_recovery_ (ob_disaster_recovery_service.cpp:190) [20593][T1_DRService][T1][YB42C0A80293-000651868C976009-0-0] [lt=5] try check dr tasks over(ret=0, ret=“OB_SUCCESS”, cost=13897, tenant_id=1, acc_dr_task=0)
[2026-05-11 17:33:11.835991] INFO [RS] do_work (ob_common_ls_service.cpp:125) [20582][T1_COMMONLSSe][T1][YB42C0A80293-000651868C176D78-0-0] [lt=34] [COMMON_LS_SERVICE] finish one round(ret=0, ret=“OB_SUCCESS”, tmp_ret=0, tmp_ret=“OB_SUCCESS”, idle_time_us=1000000)
[2026-05-11 17:33:11.909637] INFO [RS] need_schedule (ob_mview_update_deps_task.cpp:113) [20621][T1_TimerWK1_TntSharedTimer][T1][Y0-0000000000000000-0-0] [lt=59] check mview update deps task need schedule(ret=0, need_sche=false, tenant_id_=1)
[2026-05-11 17:33:11.959362] INFO [RS] manage_heartbeat_ (ob_heartbeat_service.cpp:394) [20609][T1_HBService][T1][YB42C0A80293-000651868BD76600-0-0] [lt=26] manage_heartbeat_ has finished one round(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 17:33:12.224880] INFO [RS] do_work (ob_standby_schema_refresh_trigger.cpp:68) [20581][T1_StandbySchem][T1][YB42C0A80293-000651868A276D8C-0-0] [lt=23] [STANDBY_SCHEMA_REFRESH_TRIGGER] finish one round(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 17:33:12.646062] INFO [RS] scheduler (ob_dbms_job_master.cpp:318) [20420][DBMS_JOB_MASTER][T0][YB42C0A80293-0006518689D75E86-0-0] [lt=14] dbms job master wait timeout, no entry(ret=-4018)
[2026-05-11 17:33:12.646099] INFO [RS] scheduler (ob_dbms_job_master.cpp:318) [20420][DBMS_JOB_MASTER][T0][YB42C0A80293-0006518689D75E86-0-0] [lt=17] dbms job master wait timeout, no entry(ret=-4018)
[2026-05-11 17:33:12.646108] INFO [RS] scheduler (ob_dbms_job_master.cpp:331) [20420][DBMS_JOB_MASTER][T0][YB42C0A80293-0006518689D75E86-0-0] [lt=5] success to scheduler single dbms job(ret=0, tmp_ret=0, job_key={check_job:false, check_new:false, check_new_tenant:true, execute_at:1778491997646104, delay:5000000, job_id:0, tenant_id:1})
[2026-05-11 17:33:12.838254] INFO [RS] do_work (ob_common_ls_service.cpp:125) [20582][T1_COMMONLSSe][T1][YB42C0A80293-000651868C176D79-0-0] [lt=18] [COMMON_LS_SERVICE] finish one round(ret=0, ret=“OB_SUCCESS”, tmp_ret=0, tmp_ret=“OB_SUCCESS”, idle_time_us=1000000)
[2026-05-11 17:33:13.225062] INFO [RS] do_work (ob_standby_schema_refresh_trigger.cpp:68) [20581][T1_StandbySchem][T1][YB42C0A80293-000651868A276D8D-0-0] [lt=63] [STANDBY_SCHEMA_REFRESH_TRIGGER] finish one round(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 17:33:13.393420] INFO [RS] send_heartbeat_ (ob_heartbeat_service.cpp:262) [20608][T1_HBService][T1][YB42C0A80293-000651868BE76602-0-0] [lt=11] send_heartbeat_ has finished one round(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 17:33:13.839720] INFO [RS] do_work (ob_common_ls_service.cpp:125) [20582][T1_COMMONLSSe][T1][YB42C0A80293-000651868C176D7A-0-0] [lt=19] [COMMON_LS_SERVICE] finish one round(ret=0, ret=“OB_SUCCESS”, tmp_ret=0, tmp_ret=“OB_SUCCESS”, idle_time_us=1000000)
[2026-05-11 17:33:13.905514] INFO [RS] update_mview_refresh_info_cache (ob_mview_maintenance_service.cpp:330) [20620][T1_TimerWK0_TntSharedTimer][T1][Y0-0000000000000000-0-0] [lt=35] update mview refresh info(ret=0, mview_ids=[], mview_refresh_scns=[], update_cache_cnt=0, del_mview_id=[], cost=3)
[2026-05-11 17:33:13.964275] INFO [RS] manage_heartbeat_ (ob_heartbeat_service.cpp:394) [20609][T1_HBService][T1][YB42C0A80293-000651868BD76601-0-0] [lt=22] manage_heartbeat_ has finished one round(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 17:33:14.225172] INFO [RS] do_work (ob_standby_schema_refresh_trigger.cpp:68) [20581][T1_StandbySchem][T1][YB42C0A80293-000651868A276D8E-0-0] [lt=24] [STANDBY_SCHEMA_REFRESH_TRIGGER] finish one round(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 17:33:14.677412] INFO [RS.LB] idle (ob_root_balancer.cpp:87) [20417][RootBalance][T0][YB42C0A80293-000651868D676304-0-0] [lt=16] root balance idle(idle_time=10000000)
[2026-05-11 17:33:14.677436] INFO [RS] check (ob_migrate_unit_finish_checker.cpp:70) [20417][RootBalance][T0][YB42C0A80293-000651868D676304-0-0] [lt=22] start check unit migrate finish
[2026-05-11 17:33:14.677450] INFO [RS] try_check_migrate_unit_finish_by_tenant (ob_migrate_unit_finish_checker.cpp:163) [20417][RootBalance][T0][YB42C0A80293-000651868D676304-0-0] [lt=6] try check migrate unit finish by tenant(tenant_id=1)
[2026-05-11 17:33:14.684049] INFO [RS] check (ob_alter_locality_finish_checker.cpp:71) [20417][RootBalance][T0][YB42C0A80293-000651868D676304-0-0] [lt=6] start to check alter locality finish
[2026-05-11 17:33:14.685768] WDIAG [RS] find_job (ob_rs_job_table_operator.cpp:337) [20417][RootBalance][T0][YB42C0A80293-000651868D676305-0-0] [lt=29][errcode=-4008] empty result set(ret=-4008)
[2026-05-11 17:33:14.686960] WDIAG [RS] find_job (ob_rs_job_table_operator.cpp:337) [20417][RootBalance][T0][YB42C0A80293-000651868D676305-0-0] [lt=20][errcode=-4008] empty result set(ret=-4008)
[2026-05-11 17:33:14.688197] INFO [RS] check (ob_shrink_expand_resource_pool_checker.cpp:71) [20417][RootBalance][T0][YB42C0A80293-000651868D676305-0-0] [lt=22] start check shrink resource pool
[2026-05-11 17:33:14.688221] INFO [RS] check (ob_shrink_expand_resource_pool_checker.cpp:92) [20417][RootBalance][T0][YB42C0A80293-000651868D676306-0-0] [lt=19] start check shrink resource pool(tenant_id=1)
[2026-05-11 17:33:14.689542] WDIAG [RS] find_job (ob_rs_job_table_operator.cpp:337) [20417][RootBalance][T0][YB42C0A80293-000651868D676306-0-0] [lt=6][errcode=-4008] empty result set(ret=-4008)
[2026-05-11 17:33:14.691256] WDIAG [RS] find_job (ob_rs_job_table_operator.cpp:337) [20417][RootBalance][T0][YB42C0A80293-000651868D676306-0-0] [lt=29][errcode=-4008] empty result set(ret=-4008)
[2026-05-11 17:33:14.691444] INFO [RS] check (ob_shrink_expand_resource_pool_checker.cpp:99) [20417][RootBalance][T0][YB42C0A80293-000651868D676306-0-0] [lt=44] finish check shrink resource pool(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 17:33:14.691465] INFO [RS] check (ob_alter_primary_zone_checker.cpp:49) [20417][RootBalance][T0][YB42C0A80293-000651868D676306-0-0] [lt=19] start check primary zone
[2026-05-11 17:33:14.691476] INFO [RS] check (ob_alter_primary_zone_checker.cpp:75) [20417][RootBalance][T0][YB42C0A80293-000651868D676307-0-0] [lt=7] start check primary zone(tenant_id=1)
[2026-05-11 17:33:14.693011] WDIAG [RS] find_job (ob_rs_job_table_operator.cpp:337) [20417][RootBalance][T0][YB42C0A80293-000651868D676307-0-0] [lt=6][errcode=-4008] empty result set(ret=-4008)
[2026-05-11 17:33:14.693140] INFO [RS.LB] balance_servers (ob_server_balancer.cpp:166) [20417][RootBalance][T0][YB42C0A80293-000651868D676307-0-0] [lt=18] start do unit balance
[2026-05-11 17:33:14.695501] INFO [RS.LB] gather_stat (ob_unit_stat_manager.cpp:105) [20417][RootBalance][T0][YB42C0A80293-000651868D676307-0-0] [lt=18] unit not in unit_stat_map, set required_size as 0(ret=0, ret=“OB_SUCCESS”, unit->unit_id_=1005)
[2026-05-11 17:33:14.695525] INFO [RS.LB] distribute_for_server_status_change (ob_server_balancer.cpp:353) [20417][RootBalance][T0][YB42C0A80293-000651868D676307-0-0] [lt=22] start distribute for server status change
[2026-05-11 17:33:14.695563] INFO [RS.LB] distribute_for_server_status_change (ob_server_balancer.cpp:404) [20417][RootBalance][T0][YB42C0A80293-000651868D676307-0-0] [lt=7] finish distribute for server status change(ret=0)
[2026-05-11 17:33:14.695574] INFO [RS.LB] balance_servers (ob_server_balancer.cpp:200) [20417][RootBalance][T0][YB42C0A80293-000651868D676307-0-0] [lt=11] finish do unit balance(ret=0)
[2026-05-11 17:33:14.698111] INFO [RS.LB] gather_stat (ob_unit_stat_manager.cpp:105) [20417][RootBalance][T0][YB42C0A80293-000651868D676307-0-0] [lt=6] unit not in unit_stat_map, set required_size as 0(ret=0, ret=“OB_SUCCESS”, unit->unit_id_=1005)
[2026-05-11 17:33:14.698144] INFO [RS.LB] tenant_group_balance (ob_server_balancer.cpp:115) [20417][RootBalance][T0][YB42C0A80293-000651868D676307-0-0] [lt=26] start to do tenant group unit balance
[2026-05-11 17:33:14.698174] INFO [RS.LB] rebalance_servers_v2 (ob_server_balancer.cpp:921) [20417][RootBalance][T0][YB42C0A80293-000651868D676307-0-0] [lt=7] start to do tenant group unit balance(zone=zone1)
[2026-05-11 17:33:14.698184] INFO [RS.LB] generate_zone_server_disk_statistic (ob_server_balancer.cpp:7929) [20417][RootBalance][T0][YB42C0A80293-000651868D676307-0-0] [lt=7] build zone disk statistic succeed(ret=0, zone_disk_statistic_={zone_:“zone1”, server_disk_statistic_array_:[{server_:“192.168.2.147:2882”, disk_in_use_:115343360, disk_total_:7960788992, wild_server_:false}], over_disk_waterlevel_:false})
[2026-05-11 17:33:14.698201] INFO [RS.LB] generate_tenant_array (ob_server_balancer.cpp:1075) [20417][RootBalance][T0][YB42C0A80293-000651868D676307-0-0] [lt=12] generate tenant array finish(ret=0, zone=zone1, standalone_tenant_array=[], group_tenant_array=[])
[2026-05-11 17:33:14.698224] INFO [RS.LB] generate_available_servers (ob_server_balancer.cpp:1262) [20417][RootBalance][T0][YB42C0A80293-000651868D676307-0-0] [lt=7] generate available servers finish(ret=0, zone=zone1, available_servers=[“192.168.2.147:2882”])
[2026-05-11 17:33:14.698248] INFO [RS.LB] generate_available_servers (ob_server_balancer.cpp:1262) [20417][RootBalance][T0][YB42C0A80293-000651868D676307-0-0] [lt=14] generate available servers finish(ret=0, zone=zone1, available_servers=[“192.168.2.147:2882”])
[2026-05-11 17:33:14.698255] INFO [RS.LB] do_non_tenantgroup_unit_balance_task (ob_server_balancer.cpp:5305) [20417][RootBalance][T0][YB42C0A80293-000651868D676307-0-0] [lt=5] start do non-tenantgroup unit balance task(zone=zone1)
[2026-05-11 17:33:14.698261] INFO [RS.LB] calc_global_balance_resource_weights (ob_server_balancer.cpp:5634) [20417][RootBalance][T0][YB42C0A80293-000651868D676307-0-0] [lt=3] finish calc global balance resource weights(ret=0, ret=“OB_SUCCESS”, zone=zone1, cpu_weights=2.877697841823023683e-01, mem_weights=4.604316546916838448e-01, log_disk_weights=2.517985611260137868e-01, data_disk_weights=0.000000000000000000e+00, available_servers=[“192.168.2.147:2882”])
[2026-05-11 17:33:14.698277] INFO [RS.LB] divide_complete_server_loads_for_balance (ob_server_balancer.cpp:4541) [20417][RootBalance][T0][YB42C0A80293-000651868D676307-0-0] [lt=12] divide complete server loads for balance(ret=0, ret=“OB_SUCCESS”, server_loads=[{server_:“192.168.2.147:2882”, load_sum_:{load_sum_:{unit_config_id:18446744073709551615, name:"", resource:{min_cpu:4, max_cpu:4, memory_size:“4GB”, log_disk_size:“7GB”, data_disk_size:0, min_iops:-9223372036854755809, max_iops:-9223372036854755809, iops_weight:3, max_net_bandwidth:“8.58993459e+09GB”, net_bandwidth_weight:4, }}}, resource_info_:{cpu_capacity:8, cpu_assigned:2, cpu_assigned_max:2, mem_capacity:“5GB”, mem_assigned:“2GB”, mem_in_use:0GB, log_disk_capacity:16GB, log_disk_assigned:2GB, log_disk_in_use:0.3125GB, data_disk_capacity:7.4140625GB, data_disk_assigned:0GB, data_disk_in_use:0.107421875GB}, inter_ttg_load_value_:“6.223920863224726707e-01”}], available_servers=[“192.168.2.147:2882”], wild_server_loads=[], over_server_loads=[], under_server_loads=[{server_:“192.168.2.147:2882”, load_sum_:{load_sum_:{unit_config_id:18446744073709551615, name:"", resource:{min_cpu:4, max_cpu:4, memory_size:“4GB”, log_disk_size:“7GB”, data_disk_size:0, min_iops:-9223372036854755809, max_iops:-9223372036854755809, iops_weight:3, max_net_bandwidth:“8.58993459e+09GB”, net_bandwidth_weight:4, }}}, resource_info_:{cpu_capacity:8, cpu_assigned:2, cpu_assigned_max:2, mem_capacity:“5GB”, mem_assigned:“2GB”, mem_in_use:0GB, log_disk_capacity:16GB, log_disk_assigned:2GB, log_disk_in_use:0.3125GB, data_disk_capacity:7.4140625GB, data_disk_assigned:0GB, data_disk_in_use:0.107421875GB}, inter_ttg_load_value_:“6.223920863224726707e-01”}])
[2026-05-11 17:33:14.698309] INFO [RS.LB] check_all_available_servers_over_disk_waterlevel (ob_server_balancer.cpp:8120) [20417][RootBalance][T0][YB42C0A80293-000651868D676307-0-0] [lt=31] check server over disk waterlevel(zone=zone1, disk_statistic={server_:“192.168.2.147:2882”, disk_in_use_:115343360, disk_total_:7960788992, wild_server_:false}, over_disk_waterlevel=false)
[2026-05-11 17:33:14.698316] INFO [RS.LB] check_all_available_servers_over_disk_waterlevel (ob_server_balancer.cpp:8126) [20417][RootBalance][T0][YB42C0A80293-000651868D676307-0-0] [lt=7] check all available servers over disk waterlevel(zone=zone1, all_available_servers_over_disk_waterlevel=false, zone_server_over_disk_waterlevel=false, server_disk_statistic_array=[{server_:“192.168.2.147:2882”, disk_in_use_:115343360, disk_total_:7960788992, wild_server_:false}])
[2026-05-11 17:33:14.698325] INFO [RS.LB] make_available_servers_balance (ob_server_balancer.cpp:5287) [20417][RootBalance][T0][YB42C0A80293-000651868D676307-0-0] [lt=6] finish zone servers balance(ret=0, ret=“OB_SUCCESS”, disk_waterlevel=8.000000000000000444e-01, balance_task_count=0, balance_reason=“load_balance”, all_available_servers_disk_over=false, zone_over_disk_waterlevel=false, standalone_units.count()=0, not_grant_units.count()=1)
[2026-05-11 17:33:14.698332] INFO [RS.LB] do_non_tenantgroup_unit_balance_task (ob_server_balancer.cpp:5342) [20417][RootBalance][T0][YB42C0A80293-000651868D676307-0-0] [lt=6] finish do non-tenantgroup unit balance task(ret=0, ret=“OB_SUCCESS”, zone=zone1, upper_lmt=6.535116906385962654e-01, wild_server_loads.count()=0, over_server_loads.count()=0, under_server_loads.count()=1, standalone_units=[], not_grant_units=[{unit_id:1005, tenant_id:18446744073709551615, resource_pool_id:1005, unit_config:{unit_config_id:1004, name:“lgsettl_new_unit”, resource:{min_cpu:2, max_cpu:2, memory_size:“2GB”, log_disk_size:“5GB”, data_disk_size:0, min_iops:20000, max_iops:20000, iops_weight:2, max_net_bandwidth:INT64_MAX, net_bandwidth_weight:2, }}, unit:0x7fcc3a9e9d18, unit_config:0x7fcc32979d18, pool:0x7fcc32977688}], available_servers=[“192.168.2.147:2882”])
[2026-05-11 17:33:14.841074] INFO [RS] do_work (ob_common_ls_service.cpp:125) [20582][T1_COMMONLSSe][T1][YB42C0A80293-000651868C176D7B-0-0] [lt=20] [COMMON_LS_SERVICE] finish one round(ret=0, ret=“OB_SUCCESS”, tmp_ret=0, tmp_ret=“OB_SUCCESS”, idle_time_us=1000000)
[2026-05-11 17:33:15.225370] INFO [RS] do_work (ob_standby_schema_refresh_trigger.cpp:68) [20581][T1_StandbySchem][T1][YB42C0A80293-000651868A276D8F-0-0] [lt=23] [STANDBY_SCHEMA_REFRESH_TRIGGER] finish one round(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 17:33:15.267512] INFO [RS] remove_inactive_ddl_task (ob_ddl_scheduler.cpp:3233) [20622][T1_TimerWK2_HeartBeatCheckT][T1][Y0-0000000000000000-0-0] [lt=41] need remove task(remove_task_ids=[])
[2026-05-11 17:33:15.267533] INFO [RS] remove_inactive_ddl_task (ob_ddl_scheduler.cpp:3252) [20622][T1_TimerWK2_HeartBeatCheckT][T1][Y0-0000000000000000-0-0] [lt=20] remove all timeout ddl task succeed
[2026-05-11 17:33:15.389390] INFO [SHARE] get_jobs (ob_backup_data_table_operator.cpp:712) [20590][T1_BackupDataSr][T1][YB42C0A80293-000651868C075F05-0-0] [lt=20] [DATA_BACKUP]success get jobs(job_attrs=[])
[2026-05-11 17:33:15.390380] INFO [RS.RESTORE] do_work (ob_restore_scheduler.cpp:115) [20587][T1_REST_SER][T1][YB42C0A80293-000651868C575F42-0-0] [lt=14] [RESTORE] restore scheduler quit
[2026-05-11 17:33:15.390448] INFO [RS] publish_scn (ob_replica_safe_check_task.cpp:325) [20621][T1_TimerWK1_TntSharedTimer][T1][Y0-0000000000000000-0-0] [lt=17] publish_scn finish(ret=0, ret=“OB_SUCCESS”, need_publish=false, major_mv_merge_scn={val:18446744073709551615, v:3}, lastest_merge_scn={val:18446744073709551615, v:3}, this={status:0, in_sched:true, is_stop:false, is_inited:true, merge_scn:{val:18446744073709551615, v:3}, max_transfer_task_id:{id:-1}, ls_cache:{arr_.count():0, arr:[]}}, ls_attr_array=[])
[2026-05-11 17:33:15.390480] INFO [RS] switch_status (ob_replica_safe_check_task.cpp:193) [20621][T1_TimerWK1_TntSharedTimer][T1][Y0-0000000000000000-0-0] [lt=25] replica safe check task switch_status(ret=0, ret=“OB_SUCCESS”, new_status=0, delay=30000000, this={status:0, in_sched:true, is_stop:false, is_inited:true, merge_scn:{val:18446744073709551615, v:3}, max_transfer_task_id:{id:-1}, ls_cache:{arr_.count():0, arr:[]}})
[2026-05-11 17:33:15.390490] INFO [RS] runTimerTask (ob_replica_safe_check_task.cpp:173) [20621][T1_TimerWK1_TntSharedTimer][T1][Y0-0000000000000000-0-0] [lt=9] timer task finish(ret=0, ret=“OB_SUCCESS”, this={status:0, in_sched:true, is_stop:false, is_inited:true, merge_scn:{val:18446744073709551615, v:3}, max_transfer_task_id:{id:-1}, ls_cache:{arr_.count():0, arr:[]}})
[2026-05-11 17:33:15.390549] INFO [RS] runTimerTask (ob_collect_mv_merge_info_task.cpp:465) [20624][T1_TimerWK3_TntSharedTimer][T1][Y0-0000000000000000-0-0] [lt=23] collect_mv_merge_info task(ret=0, ret=“OB_SUCCESS”, need_schedule=false, latest_merge_scn={val:18446744073709551615, v:3}, major_mv_merge_scn={val:18446744073709551615, v:3})
[2026-05-11 17:33:15.391253] INFO [SHARE] get_all_recover_table_job (ob_recover_table_persist_helper.cpp:198) [20587][T1_REST_SER][T1][YB42C0A80293-000651868C575F42-0-0] [lt=14] get targets(ret=0, jobs=[], exec_tenant_id=1, sql=select * from all_recover_table_job)
[2026-05-11 17:33:15.391277] WDIAG [SHARE.SCHEMA] revert (ob_schema_mgr_cache.cpp:119) [20587][T1_REST_SER][T1][YB42C0A80293-000651868C575F43-0-0] [lt=17][errcode=0] long time to hold one guard(schema_mgr=0x7fcc37798c30, tenant_id=1, version=1778488119118120, cur_timestamp=1778491995391273, ref_timestamp=1778491935388230, lbt()=“0x263e9068 0x1f4bf99b 0xa7ef0e1 0xa5861f5 0x1131e58a 0x109003aa 0x2606cf34 0x26073c87 0x26073245 0x260714d2 0x7fcc877b4b3e 0x7fcc87833d7c”)
[2026-05-11 17:33:15.391359] INFO [RS.RESTORE] do_work (ob_restore_scheduler.cpp:84) [20587][T1_REST_SER][T1][YB42C0A80293-000651868C575F44-0-0] [lt=12] [RESTORE] restore scheduler start
[2026-05-11 17:33:15.391371] INFO [RS.RESTORE] do_work (ob_restore_scheduler.cpp:91) [20587][T1_REST_SER][T1][YB42C0A80293-000651868C575F45-0-0] [lt=12] [RESTORE] try process restore job
[2026-05-11 17:33:15.392162] INFO [COMMON] get_jobs (ob_physical_restore_table_operator.cpp:412) [20587][T1_REST_SER][T1][YB42C0A80293-000651868C575F45-0-0] [lt=4] [RESTORE] get restore jobs(ret=0, job_cnt=0)
[2026-05-11 17:33:15.394513] INFO [RS] send_heartbeat (ob_heartbeat_service.cpp:262) [20608][T1_HBService][T1][YB42C0A80293-000651868BE76603-0-0] [lt=29] send_heartbeat has finished one round(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 17:33:15.520865] INFO [RS] recover_task (ob_ddl_scheduler.cpp:3156) [20624][T1_TimerWK3_DDLScanTask][T1][Y0-0000000000000000-0-0] [lt=20] start processing ddl recovery(ddl_event_info={addr_:“192.168.2.147:2882”, event_ts_:1778491995520863, sub_id_:0, trace_id_:Y0-0000000000000000-0-0, parent_trace_id_:Y0-0000000000000000-0-0}, task_records=[], primary_tenant_ids=[])
[2026-05-11 17:33:15.842509] INFO [RS] do_work (ob_common_ls_service.cpp:125) [20582][T1_COMMONLSSe][T1][YB42C0A80293-000651868C176D7C-0-0] [lt=22] [COMMON_LS_SERVICE] finish one round(ret=0, ret=“OB_SUCCESS”, tmp_ret=0, tmp_ret=“OB_SUCCESS”, idle_time_us=1000000)
[2026-05-11 17:33:15.970640] INFO [RS] manage_heartbeat_ (ob_heartbeat_service.cpp:394) [20609][T1_HBService][T1][YB42C0A80293-000651868BD76602-0-0] [lt=25] manage_heartbeat_ has finished one round(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 17:33:16.225755] INFO [RS] do_work (ob_standby_schema_refresh_trigger.cpp:68) [20581][T1_StandbySchem][T1][YB42C0A80293-000651868A276D90-0-0] [lt=59] [STANDBY_SCHEMA_REFRESH_TRIGGER] finish one round(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 17:33:16.642649] INFO [RS] receive_hb (ob_server_manager.cpp:653) [20375][LeaseQueueTh0][T0][YB42C0A80293-000651868B576910-0-0] [lt=32] server resource changed(old_resource_info={cpu_capacity:8, cpu_assigned:2, cpu_assigned_max:2, mem_capacity:“5GB”, mem_assigned:“2GB”, mem_in_use:0GB, log_disk_capacity:16GB, log_disk_assigned:2GB, log_disk_in_use:0.3125GB, data_disk_capacity:7.4140625GB, data_disk_assigned:0GB, data_disk_in_use:0.107421875GB}, new_resource_info={cpu_capacity:8, cpu_assigned:2, cpu_assigned_max:2, mem_capacity:“5GB”, mem_assigned:“2GB”, mem_in_use:0GB, log_disk_capacity:16GB, log_disk_assigned:2GB, log_disk_in_use:0.3125GB, data_disk_capacity:7.41210938GB, data_disk_assigned:0GB, data_disk_in_use:0.107421875GB})
[2026-05-11 17:33:16.844667] INFO [RS] do_work (ob_common_ls_service.cpp:125) [20582][T1_COMMONLSSe][T1][YB42C0A80293-000651868C176D7D-0-0] [lt=26] [COMMON_LS_SERVICE] finish one round(ret=0, ret=“OB_SUCCESS”, tmp_ret=0, tmp_ret=“OB_SUCCESS”, idle_time_us=1000000)
[2026-05-11 17:33:16.912528] INFO [RS] need_schedule (ob_mview_update_deps_task.cpp:113) [20620][T1_TimerWK0_TntSharedTimer][T1][Y0-0000000000000000-0-0] [lt=23] check mview update deps task need schedule(ret=0, need_sche=false, tenant_id_=1)
[2026-05-11 17:33:16.957821] INFO [RS] do_dr_service_work_ (ob_disaster_recovery_service.cpp:136) [20594][T1_DRService][T1][YB42C0A80293-000651868C775F09-0-0] [lt=29] [DRTASK_NOTICE] disaster recovery service finish one round(ret=0, ret=“OB_SUCCESS”, idle_time_us=30000000, tenant_id=1, thread_idx=1)
[2026-05-11 17:33:16.961015] INFO [RS] manage_dr_tasks_ (ob_disaster_recovery_service.cpp:218) [20594][T1_DRService][T1][YB42C0A80293-000651868C775F0A-0-0] [lt=74] try manage dr tasks over(ret=0, ret=“OB_SUCCESS”, cost=1976, tenant_id=1, need_clean_task=true, service_epoch_to_check=10)
[2026-05-11 17:33:17.226442] INFO [RS] do_work (ob_standby_schema_refresh_trigger.cpp:68) [20581][T1_StandbySchem][T1][YB42C0A80293-000651868A276D91-0-0] [lt=29] [STANDBY_SCHEMA_REFRESH_TRIGGER] finish one round(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 17:33:17.395573] INFO [RS] send_heartbeat_ (ob_heartbeat_service.cpp:262) [20608][T1_HBService][T1][YB42C0A80293-000651868BE76604-0-0] [lt=13] send_heartbeat_ has finished one round(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 17:33:17.646923] INFO [RS] scheduler (ob_dbms_job_master.cpp:318) [20420][DBMS_JOB_MASTER][T0][YB42C0A80293-0006518689D75E86-0-0] [lt=9] dbms job master wait timeout, no entry(ret=-4018)
[2026-05-11 17:33:17.648121] INFO [RS] scheduler (ob_dbms_job_master.cpp:318) [20420][DBMS_JOB_MASTER][T0][YB42C0A80293-0006518689D75E86-0-0] [lt=32] dbms job master wait timeout, no entry(ret=-4018)
[2026-05-11 17:33:17.648149] INFO [RS] scheduler (ob_dbms_job_master.cpp:331) [20420][DBMS_JOB_MASTER][T0][YB42C0A80293-0006518689D75E86-0-0] [lt=16] success to scheduler single dbms job(ret=0, tmp_ret=0, job_key={check_job:false, check_new:false, check_new_tenant:true, execute_at:1778492002648138, delay:5000000, job_id:0, tenant_id:1})
[2026-05-11 17:33:17.845006] INFO [RS] check_lost_replicas (ob_lost_replica_checker.cpp:104) [20416][LostRepCheck][T0][Y0-0000000000000000-0-0] [lt=12] start checking lost replicas
[2026-05-11 17:33:17.847417] INFO [RS] do_work (ob_common_ls_service.cpp:125) [20582][T1_COMMONLSSe][T1][YB42C0A80293-000651868C176D7E-0-0] [lt=18] [COMMON_LS_SERVICE] finish one round(ret=0, ret=“OB_SUCCESS”, tmp_ret=0, tmp_ret=“OB_SUCCESS”, idle_time_us=1000000)
[2026-05-11 17:33:17.975916] INFO [RS] manage_heartbeat_ (ob_heartbeat_service.cpp:394) [20609][T1_HBService][T1][YB42C0A80293-000651868BD76603-0-0] [lt=26] manage_heartbeat_ has finished one round(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 17:33:18.227556] INFO [RS] do_work (ob_standby_schema_refresh_trigger.cpp:68) [20581][T1_StandbySchem][T1][YB42C0A80293-000651868A276D92-0-0] [lt=48] [STANDBY_SCHEMA_REFRESH_TRIGGER] finish one round(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 17:33:18.640000] INFO [RS] process (ob_root_inspection.cpp:412) [20412][RSInspectTask][T0][Y0-000651868DF75ED5-0-0] [lt=3] purge recyclebin task begin
[2026-05-11 17:33:18.640076] INFO [RS] process (ob_root_inspection.cpp:430) [20412][RSInspectTask][T0][Y0-000651868DF75ED5-0-0] [lt=51] submit purge recyclebin task success(delay=60000000)
[2026-05-11 17:33:18.640087] INFO [RS] process (ob_root_inspection.cpp:432) [20412][RSInspectTask][T0][Y0-000651868DF75ED5-0-0] [lt=11] purge recyclebin task end(delay=60000000)
[2026-05-11 17:33:18.849428] INFO [RS] do_work (ob_common_ls_service.cpp:125) [20582][T1_COMMONLSSe][T1][YB42C0A80293-000651868C176D7F-0-0] [lt=68] [COMMON_LS_SERVICE] finish one round(ret=0, ret=“OB_SUCCESS”, tmp_ret=0, tmp_ret=“OB_SUCCESS”, idle_time_us=1000000)
[2026-05-11 17:33:18.907294] INFO [RS] update_mview_refresh_info_cache (ob_mview_maintenance_service.cpp:330) [20622][T1_TimerWK2_TntSharedTimer][T1][Y0-0000000000000000-0-0] [lt=26] update mview refresh info(ret=0, mview_ids=[], mview_refresh_scns=[], update_cache_cnt=0, del_mview_id=[], cost=2)
[2026-05-11 17:33:19.228037] INFO [RS] do_work (ob_standby_schema_refresh_trigger.cpp:68) [20581][T1_StandbySchem][T1][YB42C0A80293-000651868A276D93-0-0] [lt=58] [STANDBY_SCHEMA_REFRESH_TRIGGER] finish one round(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 17:33:19.327456] WDIAG [SQL] move_to_sqlstat_cache (ob_sql_stat_record.cpp:339) [24818][T1_FrzInfoDet][T1][YB42C0A80293-000651868BC76004-0-0] [lt=32][errcode=0] the key is not valid which at plan cache mgr(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 17:33:19.327904] INFO [STORAGE.TRANS] get_number (ob_id_service.cpp:384) [24818][T1_FrzInfoDet][T1][YB42C0A80293-000651868BC76004-0-0] [lt=20] get number(ret=0, service_type_=0, range=1, base_id=1778491999327673000, start_id=1778491999327673000, end_id=1778491999327673001)
[2026-05-11 17:33:19.330786] WDIAG [SQL] move_to_sqlstat_cache (ob_sql_stat_record.cpp:339) [24818][T1_FrzInfoDet][T1][YB42C0A80293-000651868BC76004-0-0] [lt=17][errcode=0] the key is not valid which at plan cache mgr(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 17:33:19.330891] INFO [RS] renew_snapshot_gc_scn (ob_major_merge_info_manager.cpp:340) [24818][T1_FrzInfoDet][T1][YB42C0A80293-000651868BC76004-0-0] [lt=17] renew snapshot_gc_scn(ret=0, new_snapshot_gc_scn={val:1778491999327673000, v:0}, tenant_id=1)
[2026-05-11 17:33:19.332789] WDIAG [SQL] move_to_sqlstat_cache (ob_sql_stat_record.cpp:339) [24818][T1_FrzInfoDet][T1][YB42C0A80293-000651868BC76004-0-0] [lt=17][errcode=0] the key is not valid which at plan cache mgr(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 17:33:19.334579] WDIAG [SQL] move_to_sqlstat_cache (ob_sql_stat_record.cpp:339) [24818][T1_FrzInfoDet][T1][YB42C0A80293-000651868BC76004-0-0] [lt=17][errcode=0] the key is not valid which at plan cache mgr(ret=0, ret=“OB_SUCCESS”)
[2026-05-11 17:33:19.398221] INFO [RS] send_heartbeat_ (ob_heartbeat_service.cpp:262) [20608][T1_HBService][T1][YB42C0A80293-000651868BE76605-0-0] [lt=16] send_heartbeat_ has finished one round(ret=0, ret=“OB_SUCCESS”)
不能发日志文件么？这个日志看着还不全 没有和你操作有关的日志信息
对啊，为什么不发文件呢，直接粘贴文字，不太好
上传日志附件可能更加方便查看。
好像没遇到过这种问题
应该是等级不够导致的 没有办法发附件 我临时给你调整一下 现在再试一下 新用户记得做一些任务 增加积分就够等级了
是做过以后 立马取的文件么？你这个ob集群 几个副本
我单机版的，没有集群，这个是执行恢复之前，把所有的日志删了。然后执行那个恢复命令，生成的日志。用的obd的图形界面安装的。
/data/backup这个目录树结构 发一下； 问题在归档路径file:///data/archive下，曾尝试读 piece_d1001r1p2/single_piece_info.obarc不存在，说明归档 piece 可能不完整或与元数据不一致，至少存在一次「缺文件」的访问；/data/backup下出现了重复的 backup set 目录。 同一个 backup_set_id被重复加入， 都有问题导致的报错。
