root@oceanbase-70:~# cat /home/admin/ysdb/oceanbase/log/observer.log | grep check_daily [2026-01-08 20:29:04.720643] INFO [PL] compile (ob_pl_compile.cpp:438) [1912731][T1042_L0_G0][T1042][YB42AC100C46-000647DFE6A76713-0-0] [lt=15] >>>>>>>>Init AST Time: (routine.get_routine_id()=500328, routine.get_routine_name()=check_daily, init_end - init_start=1) [2026-01-08 20:29:04.721125] INFO [PL] compile (ob_pl_compile.cpp:451) [1912731][T1042_L0_G0][T1042][YB42AC100C46-000647DFE6A76713-0-0] [lt=32] >>>>>>>>Parse Time: (routine.get_routine_id()=500328, routine.get_routine_name()=check_daily, parse_end - init_end=483) [2026-01-08 20:29:04.732432] INFO [PL] compile (ob_pl_compile.cpp:483) [1912731][T1042_L0_G0][T1042][YB42AC100C46-000647DFE6A76713-0-0] [lt=39] >>>>>>>>Resolve Time: (routine.get_routine_id()=500328, routine.get_routine_name()=check_daily, resolve_end - parse_end=11306) [2026-01-08 20:29:04.758320] INFO [PL] compile (ob_pl_compile.cpp:541) [1912731][T1042_L0_G0][T1042][YB42AC100C46-000647DFE6A76713-0-0] [lt=37] >>>>>>>>CG Time: (routine.get_routine_id()=500328, routine.get_routine_name()=check_daily, cg_end - resolve_end=25888) [2026-01-08 20:29:04.758345] INFO [PL] compile (ob_pl_compile.cpp:544) [1912731][T1042_L0_G0][T1042][YB42AC100C46-000647DFE6A76713-0-0] [lt=32] >>>>>>>>Final Compile Routine Time: (routine.get_routine_id()=500328, routine.get_routine_name()=check_daily, final_end - init_start=37703) [2026-01-08 20:29:04.761386] INFO [PL] generate_pl_function (ob_pl.cpp:2844) [1912731][T1042_L0_G0][T1042][YB42AC100C46-000647DFE6A76713-0-0] [lt=14] >>>>>>>>>>Compile Routine Time: (ret=0, proc_id=500328, compile_end - compile_start=41256, routine={ns:2, ref_count:1, tenant_schema_version:1766911209616144, sys_schema_version:1767836179527672, object_id:185, dependency_tables:[cnt:1, {table_id:500328, schema_version:1766844358787584, object_type:4, is_db_explicit:false, is_existed:true}], params_info:[], variables:[cnt:3, {type:0, type_from:0, not_null:false, pls_type:0, type_info_id:18446744073709551615, obj_type:{meta:{type:"INT", collation:"binary", coercibility:"NUMERIC"}, accuracy:{length:-1, precision:11, scale:0}, charset:2, is_binary_collation:false, is_zero_fill:false}, {type:0, type_from:0, not_null:false, pls_type:0, type_info_id:18446744073709551615, obj_type:{meta:{type:"VARCHAR", collation:"utf8mb4_general_ci", coercibility:"IMPLICIT"}, accuracy:{length:255, precision:-1, scale:-1}, charset:2, is_binary_collation:false, is_zero_fill:false}, {type:5, type_from:0, not_null:false, pls_type:0, type_info_id:18446744073709551615, user_type_id:18446744073708503040], default_idxs:[cnt:3, 1, 3, -1], function_name:"check_daily", priv_user:"root@%"}) CRASH ERROR!!! IP=7f801b7e09ea, RBP=7f8e2d7c5a90, sig=4, sig_code=2, sig_addr=0x7f801b7e09ea, RLIMIT_CORE=unlimited, timestamp=1767875344841373, tid=1912731, tname=T1042_L0_G0, trace_id=YB42AC100C46-000647DFE6A76713-0-0, lbt=0x1f96b218 0x1f1b698d 0x7f900a3e741f 0x7f801b7e09ea 0xea882f7 0xea74cea 0x14a77faa 0x11bba464 0x7c4fe26 0x7923e9c 0x792151d 0x7cc475e 0x78c853e 0x78b88e3 0x78b1adf 0x78aefec 0x789e118 0xfc77118 0x1f95655d 0x7f900a3db608 0x7f900a2fe352, SQL_ID=, SQL_STRING=call check_daily root@oceanbase-70:~# grep -C 20 check_daily /home/admin/ysdb/oceanbase/log/observer.log [2026-01-08 20:29:04.711652] INFO [PALF] next (palf_iterator.h:183) [1913451][T1044_ReplaySrv][T1044][Y0-0000000000000000-0-0] [lt=7] [PALF STAT ITERATOR INFO](io_ctx={user:"REPLAY", palf_id:1002, iterator_info:{allow_filling_cache:true, hot_cache_stat:{hit_cnt:4267, miss_cnt:29, cache_read_size:1253681, hit_ratio:"9.932495344506517831e-01"}, cold_cache_stat:{hit_cnt:0, miss_cnt:29, cache_read_size:0, hit_ratio:"0.000000000000000000e+00"}, read_io_cnt:55, read_io_size:104804352, read_disk_cost_ts:12135905, start_lsn:{lsn:139846336512}}}) [2026-01-08 20:29:04.711841] WDIAG [STORAGE.TRANS] run1 (ob_standby_timestamp_service.cpp:147) [1915577][T1052_STSWorker][T1052][Y0-0000000000000000-0-0] [lt=37][errcode=-4076] query and update last id fail(ret=-4076, ret="OB_NEED_WAIT") [2026-01-08 20:29:04.713776] INFO [SHARE] load_can_execute_task (ob_balance_task_table_operator.cpp:842) [1909210][T1030_BalanceEx][T1030][YB42AC100C46-000647DFC426E944-0-0] [lt=31] load can-execute balance task(ret=0, ret="OB_SUCCESS", task_array=[], sql=select * from __all_balance_task where parent_list is null or parent_list = '') [2026-01-08 20:29:04.713811] INFO [BALANCE] do_work (ob_balance_task_execute_service.cpp:172) [1909210][T1030_BalanceEx][T1030][YB42AC100C46-000647DFC426E944-0-0] [lt=44] [BALANCE_EXECUTE] finish one round(ret=0, ret="OB_SUCCESS", task_array_=[], idle_time_us=1000000, task_comment_=) [2026-01-08 20:29:04.715157] INFO [COORDINATOR] refresh (ob_leader_coordinator.cpp:146) [1923086][T1093_Occam][T1093][Y0-0000000000000000-0-0] [lt=44] refresh __all_ls_election_reference_info success(ret=0, ret="OB_SUCCESS", *new_all_ls_election_reference_info=[{1,1,False,{False,},False,False,True}]) [2026-01-08 20:29:04.715949] WDIAG [STORAGE.TRANS] run1 (ob_standby_timestamp_service.cpp:147) [1926335][T1098_STSWorker][T1098][Y0-0000000000000000-0-0] [lt=39][errcode=-4076] query and update last id fail(ret=-4076, ret="OB_NEED_WAIT") [2026-01-08 20:29:04.716068] WDIAG [SQL.PC] common_free (ob_lib_cache_object_manager.cpp:141) [1912731][T1042_L0_G0][T1042][YB42AC100C46-000647DFE6A76712-0-0] [lt=41][errcode=0] set logical del time(cache_obj->get_logical_del_time()=4010312652361, cache_obj->added_lc()=false, cache_obj->get_object_id()=183, cache_obj->get_tenant_id()=1042, lbt()="0x810107f 0x10bac60e 0x78d12ff 0x78c2d42 0x78b88e4 0x78b1ae0 0x78aefed 0x789e119 0xfc77119 0x1f95655e 0x7f900a3db609 0x7f900a2fe353") [2026-01-08 20:29:04.716082] INFO [PALF] handle_next_submit_log_ (log_sliding_window.cpp:1093) [1921670][T1088_TxLoopWor][T1088][Y0-0000000000000000-0-0] [lt=29] [PALF STAT GROUP LOG INFO](palf_id=1, self="172.16.12.70:2882", role="LEADER", total_group_log_cnt=10, avg_log_batch_cnt=1, total_group_log_size=1226, avg_group_log_size=122) [2026-01-08 20:29:04.716128] INFO [PALF] submit_log (palf_handle_impl.cpp:458) [1921670][T1088_TxLoopWor][T1088][Y0-0000000000000000-0-0] [lt=58] [PALF STAT APPEND DATA SIZE](this={palf_id:1, self:"172.16.12.70:2882", has_set_deleted:false}, append size=1226) [2026-01-08 20:29:04.716180] INFO [PALF] handle_next_submit_log_ (log_sliding_window.cpp:1093) [1921670][T1088_TxLoopWor][T1088][Y0-0000000000000000-0-0] [lt=30] [PALF STAT GROUP LOG INFO](palf_id=1001, self="172.16.12.70:2882", role="LEADER", total_group_log_cnt=10, avg_log_batch_cnt=1, total_group_log_size=1220, avg_group_log_size=122) [2026-01-08 20:29:04.716191] INFO [PALF] inner_append_log (palf_handle_impl.cpp:2231) [1924760][T1094_IOWorker][T1094][Y0-0000000000000000-0-0] [lt=25] [PALF STAT INNER APPEND LOG SIZE](this={palf_id:1, self:"172.16.12.70:2882", has_set_deleted:false}, accum_size=2192) [2026-01-08 20:29:04.718110] INFO [CLOG] run1 (ob_garbage_collector.cpp:1466) [1912865][T1043_GCCollect][T1043][Y0-0000000000000000-0-0] [lt=17] Garbage Collector is running(seq_=41, gc_interval=10000000) [2026-01-08 20:29:04.719299] INFO [STORAGE.TRANS] run1 (ob_tx_loop_worker.cpp:106) [1927553][T1101_TxLoopWor][T1101][Y0-0000000000000000-0-0] [lt=48] tx gc loop thread is running(MTL_ID()=1101) [2026-01-08 20:29:04.719328] INFO [STORAGE.TRANS] run1 (ob_tx_loop_worker.cpp:113) [1927553][T1101_TxLoopWor][T1101][Y0-0000000000000000-0-0] [lt=37] try gc retain ctx [2026-01-08 20:29:04.719337] INFO [STORAGE.TRANS] run1 (ob_tx_loop_worker.cpp:120) [1927553][T1101_TxLoopWor][T1101][Y0-0000000000000000-0-0] [lt=11] try to retry start_working [2026-01-08 20:29:04.719373] INFO [STORAGE] update_min_start_scn_info (ob_tx_table.cpp:1053) [1927553][T1101_TxLoopWor][T1101][Y0-0000000000000000-0-0] [lt=21] finish update min start scn(max_decided_scn={val:1767875344692978000, v:0}, ctx_min_start_scn_info_={min_start_scn_in_ctx_:{val:1767875334597334003, v:0}, keep_alive_scn_:{val:1767875339689158002, v:0}, update_ts_:1767875344718417}) [2026-01-08 20:29:04.720018] INFO [STORAGE.TRANS] do_tx_gc_ (ob_tx_loop_worker.cpp:271) [1927553][T1101_TxLoopWor][T1101][Y0-0000000000000000-0-0] [lt=28] [Tx Loop Worker] check tx scheduler success(MTL_ID()=1101, *ls_ptr={running_state:{state:1}, ls_meta:{tenant_id:1101, ls_id:{id:1}, ls_persistent_state:{state:1}, clog_checkpoint_scn:{val:1767836161513099002, v:0}, clog_base_lsn:{lsn:0}, rebuild_seq:0, migration_status:0, gc_state_:1, offline_scn_:{val:18446744073709551615, v:3}, restore_status:{status:0}, replayable_point:{val:18446744073709551615, v:3}, tablet_change_checkpoint_scn:{val:1767836161513099001, v:0}, all_id_meta:{id_meta:[{limited_id:1767875354170778000, latest_log_ts:{val:1767875337588009001, v:0}}, {limited_id:3000001, latest_log_ts:{val:1767875141565840004, v:0}}, {limited_id:30000001, latest_log_ts:{val:1767874994170778003, v:0}}]}, transfer_scn:{val:0, v:0}, rebuild_info:{status:{status:0}, type:{type:0}, tablet_id_array:{id_array:[]}, src:[type = 0], [address = ]}, transfer_meta_info:{src_ls:{id:0}, src_scn:{val:1, v:0}, trans_status:0, tablet_id_array:{id_array:[]}, data_version:1(0, 0, 1)}, store_format:{store_type:1, store_type_str:"NORMAL"}}, switch_epoch:1, log_handler:{role:1, proposal_id:2, palf_env_:0x7f8ac95e0030, is_in_stop_state_:false, is_inited_:true, id_:1}, restore_handler:{is_inited:true, is_in_stop_state:false, id:1, proposal_id:9223372036854775807, role:2, parent:null, context:{issue_task_num:0, issue_version:-1, last_fetch_ts:-1, max_submit_lsn:{lsn:18446744073709551615}, max_fetch_lsn:{lsn:18446744073709551615}, max_fetch_scn:{val:18446744073709551615, v:3}, error_context:{ret_code:0, trace_id:Y0-0000000000000000-0-0, error_type:0, err_lsn:{lsn:18446744073709551615}}, task_count:0}, restore_context:{seek_done:false, lsn:{lsn:18446744073709551615}}}, is_inited:true, tablet_gc_handler:{tablet_persist_trigger:0, is_inited:true}, startup_transfer_info:{ls_id:{id:0}, transfer_start_scn:{val:18446744073709551615, v:3}}, need_delay_resource_recycle:false}) [2026-01-08 20:29:04.720088] INFO [PL] get_pl_function (ob_pl.cpp:2628) [1912731][T1042_L0_G0][T1042][YB42AC100C46-000647DFE6A76713-0-0] [lt=42] get pl function from plan cache failed(ret=-5138, pc_ctx.key_={db_id:500005, key_id:500328, namespace:2, name:""}, package_id=-1, routine_id=500328) [2026-01-08 20:29:04.720118] INFO [PL] get_pl_function (ob_pl.cpp:2646) [1912731][T1042_L0_G0][T1042][YB42AC100C46-000647DFE6A76713-0-0] [lt=37] get pl function from plan cache failed(ret=-5138, pc_ctx.key_={db_id:500005, key_id:500328, namespace:2, name:""}, package_id=-1, routine_id=500328) [2026-01-08 20:29:04.720176] WDIAG [PALF] sliding_cb (log_sliding_window.cpp:2302) [1979676][T1042_L0_G1][T1042][YB42AC100C7A-000636E4395EF96E-0-0] [lt=34][errcode=-4389] log_task life cost too much time(palf_id=1002, self="172.16.12.70:2882", log_id=156682105, log_task={header:{begin_lsn:{lsn:84043482963}, end_lsn:{lsn:84043483085}, log_id:156682105, min_scn:{val:1767875344201653004, v:0}, max_scn:{val:1767875344201653004, v:0}, data_len:66, proposal_id:5, prev_lsn:{lsn:84043482841}, prev_proposal_id:5, committed_end_lsn:{lsn:84043482963}, data_checksum:1715074492, accum_checksum:2475495472, is_padding_log:false, is_raw_write:false}, state_map:{val:58}, ref_cnt:0, gen_ts:1767875344620021, freeze_ts:1767875344620021, submit_ts:1767875344620027, flushed_ts:1767875344620927, gen_to_freeze cost time:0, gen_to_submit cost time:6, submit_to_flush cost time:900}, fs_cb_begin_ts=1767875344720162, log_life_time=100141) [2026-01-08 20:29:04.720643] INFO [PL] compile (ob_pl_compile.cpp:438) [1912731][T1042_L0_G0][T1042][YB42AC100C46-000647DFE6A76713-0-0] [lt=15] >>>>>>>>Init AST Time: (routine.get_routine_id()=500328, routine.get_routine_name()=check_daily, init_end - init_start=1) [2026-01-08 20:29:04.721125] INFO [PL] compile (ob_pl_compile.cpp:451) [1912731][T1042_L0_G0][T1042][YB42AC100C46-000647DFE6A76713-0-0] [lt=32] >>>>>>>>Parse Time: (routine.get_routine_id()=500328, routine.get_routine_name()=check_daily, parse_end - init_end=483) [2026-01-08 20:29:04.721767] INFO [STORAGE] scheduler_ls_ha_handler_ (ob_storage_ha_service.cpp:196) [1920635][T1085_HAService][T1085][Y0-0000000000000000-0-0] [lt=42] start do ls ha handler(ls_id_array_=[{id:1}]) [2026-01-08 20:29:04.721788] INFO [STORAGE] scheduler_ls_ha_handler_ (ob_storage_ha_service.cpp:196) [1927322][T1100_HAService][T1100][Y0-0000000000000000-0-0] [lt=39] start do ls ha handler(ls_id_array_=[{id:1}, {id:1001}]) [2026-01-08 20:29:04.722020] INFO [PALF] try_advance_committed_lsn_ (log_sliding_window.cpp:1771) [1969730][T1055_L0_G1][T1055][YB42AC100C79-000642AC124DD5F4-0-0] [lt=31] [PALF STAT COMMITTED LOG SIZE](palf_id=1, self="172.16.12.70:2882", committed size=8462) [2026-01-08 20:29:04.722269] INFO [LIB] stat (utility.h:1210) [1924892][T1094_ReplaySrv][T1094][Y0-0000000000000000-0-0] [lt=41] [REPLAY STAT REPLAY TASK IN QUEUE TIME](cur_stat_count=56, stat_interval=1000000, avg (count/cost)=82, this=0x7f8b87e8a8f8, extra_info="") [2026-01-08 20:29:04.722305] INFO [LIB] stat (utility.h:1210) [1924892][T1094_ReplaySrv][T1094][Y0-0000000000000000-0-0] [lt=47] [REPLAY STAT REPLAY TASK EXECUTE COST TIME](cur_stat_count=56, stat_interval=1000000, avg (count/cost)=18, this=0x7f8b87e8ab28, extra_info="") [2026-01-08 20:29:04.722924] WDIAG [SQL.SESSION] get_user_variable (ob_basic_session_info.cpp:4020) [1912731][T1042_L0_G0][T1042][YB42AC100C46-000647DFE6A76713-0-0] [lt=26][errcode=-5112] unknown user variable(var=dyn_sql, ret=-5112) [2026-01-08 20:29:04.722946] WDIAG [SQL.ENG] calc_result_type1 (ob_expr_get_user_var.cpp:49) [1912731][T1042_L0_G0][T1042][YB42AC100C46-000647DFE6A76713-0-0] [lt=29][errcode=-5112] fail to exec type_ctx.get_session()->get_user_variable(key, session_var)(ret=-5112, key=dyn_sql, session_var={meta:{type:"NULL", collation:"invalid_type", coercibility:"INVALID"}, value:{"NULL":"NULL"}}) [2026-01-08 20:29:04.724259] INFO [CLOG] handle_rpc_response_ (ob_garbage_collector.cpp:274) [1912865][T1043_GCCollect][T1043][Y0-0000000000000000-0-0] [lt=29] GC check ls in member list, skip it(id={id:1}, leader="172.16.12.121:2882") [2026-01-08 20:29:04.724279] INFO [CLOG] gc_check_member_list_ (ob_garbage_collector.cpp:1559) [1912865][T1043_GCCollect][T1043][Y0-0000000000000000-0-0] [lt=23] gc_check_member_list_ cost time(ret=0, time_us=6146) [2026-01-08 20:29:04.724290] INFO [CLOG] execute_gc_ (ob_garbage_collector.cpp:1833) [1912865][T1043_GCCollect][T1043][Y0-0000000000000000-0-0] [lt=9] execute_gc cost time(ret=0, time_us=1) [2026-01-08 20:29:04.724710] INFO [ARCHIVE] gc_stale_ls_task_ (ob_ls_mgr.cpp:586) [1927976][T1102_LSArchive][T1102][YB42AC100C46-000647DFA446E7D9-0-0] [lt=41] gc stale ls task succ [2026-01-08 20:29:04.726543] INFO [LIB] stat (utility.h:1210) [1926347][T1098_TxLoopWor][T1098][Y0-0000000000000000-0-0] [lt=44] [PALF STAT PUSH LOG TO FOLLOWERS RPC POST COST TIME](cur_stat_count=10, stat_interval=1000000, avg (count/cost)=1, this=0x7f8b055e5470, extra_info="") [2026-01-08 20:29:04.726589] INFO [PALF] handle_next_submit_log_ (log_sliding_window.cpp:1093) [1926347][T1098_TxLoopWor][T1098][Y0-0000000000000000-0-0] [lt=46] [PALF STAT GROUP LOG INFO](palf_id=1, self="172.16.12.70:2882", role="LEADER", total_group_log_cnt=10, avg_log_batch_cnt=1, total_group_log_size=1220, avg_group_log_size=122) [2026-01-08 20:29:04.726651] INFO [PALF] submit_log (palf_handle_impl.cpp:458) [1926347][T1098_TxLoopWor][T1098][Y0-0000000000000000-0-0] [lt=79] [PALF STAT APPEND DATA SIZE](this={palf_id:1, self:"172.16.12.70:2882", has_set_deleted:false}, append size=1220) [2026-01-08 20:29:04.727337] INFO [STORAGE.TRANS] print_stat_ (ob_tenant_weak_read_service.cpp:541) [1910670][T1037_TenantWea][T1037][Y0-0000000000000000-0-0] [lt=42] [WRS] [TENANT_WEAK_READ_SERVICE] [STAT](tenant_id=1037, server_version={version:{val:1767875344428850000, v:0}, total_part_count:1, valid_inner_part_count:1, valid_user_part_count:0}, server_version_delta=298477, in_cluster_service=true, cluster_version={val:1767875344027844001, v:0}, min_cluster_version={val:1767875344027844001, v:0}, max_cluster_version={val:1767875344027844001, v:0}, get_cluster_version_err=0, cluster_version_delta=699483, cluster_service_master="172.16.12.70:2882", cluster_service_tablet_id={id:226}, post_cluster_heartbeat_count=3904, succ_cluster_heartbeat_count=784, cluster_heartbeat_interval=50000, local_cluster_version={val:1767875041066475989, v:0}, local_cluster_delta=303660852, force_self_check=false, weak_read_refresh_interval=100000) [2026-01-08 20:29:04.728013] INFO [LIB] stat (utility.h:1210) [1975340][T1093_L0_G1][T1093][YB42AC100C79-000642AC0C1F7799-0-0] [lt=52] [PALF STAT PUSH LOG TO FOLLOWERS RPC POST COST TIME](cur_stat_count=13, stat_interval=1000000, avg (count/cost)=0, this=0x7f8b947d3470, extra_info="") [2026-01-08 20:29:04.728210] INFO [PALF] handle_next_submit_log_ (log_sliding_window.cpp:1093) [1979871][T1056_L0_G1][T1056][YB42AC100C79-000642AC261E91B7-0-0] [lt=32] [PALF STAT GROUP LOG INFO](palf_id=1001, self="172.16.12.70:2882", role="FOLLOWER", total_group_log_cnt=10, avg_log_batch_cnt=0, total_group_log_size=1220, avg_group_log_size=122) [2026-01-08 20:29:04.729194] INFO [CLOG] gc_check_ls_status_ (ob_garbage_collector.cpp:1755) [1912865][T1043_GCCollect][T1043][Y0-0000000000000000-0-0] [lt=8] gc_candidates push_back success(ret=0, candidate={ls_id_:{id:1}, ls_status_:1, gc_reason_:0}) [2026-01-08 20:29:04.729232] INFO [CLOG] execute_gc_ (ob_garbage_collector.cpp:1777) [1912865][T1043_GCCollect][T1043][Y0-0000000000000000-0-0] [lt=42] ls status is normal, skip(id={id:1}, gc_candidates=[{ls_id_:{id:1}, ls_status_:1, gc_reason_:0}]) [2026-01-08 20:29:04.729252] INFO [CLOG] execute_gc_ (ob_garbage_collector.cpp:1833) [1912865][T1043_GCCollect][T1043][Y0-0000000000000000-0-0] [lt=24] execute_gc cost time(ret=0, time_us=21) [2026-01-08 20:29:04.729261] INFO [SERVER] handle (ob_safe_destroy_handler.cpp:240) [1912865][T1043_GCCollect][T1043][Y0-0000000000000000-0-0] [lt=10] ObSafeDestroyHandler start process [2026-01-08 20:29:04.729337] INFO [STORAGE] check_read_snapshot_for_normal_or_split_dst (ob_tablet_create_delete_helper.cpp:344) [1912731][T1042_L0_G0][T1042][YB42AC100C46-000647DFE6A76713-0-0] [lt=81] tablet create transaction is committed, currently in finish transfer in transacation(ret=0, ls_id={id:1}, tablet_id={id:272}, snapshot_version=1767875344340064000, trans_state=3, user_data={tablet_status:{val:1, str:"NORMAL"}, transfer_scn:{val:18446744073709551615, v:3}, transfer_ls_id:{id:-1}, data_type:1, create_commit_scn:{val:1752478639255575000, v:0}, create_commit_version:1752478639255575000, delete_commit_scn:{val:18446744073709551615, v:3}, delete_commit_version:-1, start_transfer_commit_version:-1, start_split_commit_version:-1}) [2026-01-08 20:29:04.729317] INFO [STORAGE.TRANS] get_number (ob_id_service.cpp:393) [1920628][T1085_TenantWea][T1085][Y0-0000000000000000-0-0] [lt=29] get number(ret=0, service_type_=0, range=1, base_id=1767875344729079000, start_id=1767875344729079000, end_id=1767875344729079001) [2026-01-08 20:29:04.729382] INFO [STORAGE] check_status_for_new_mds (ob_tablet_create_delete_helper.cpp:264) [1912731][T1042_L0_G0][T1042][YB42AC100C46-000647DFE6A76713-0-0] [lt=60] refresh tablet status cache(ret=0, ls_id={id:1}, tablet_id={id:272}, tablet_status_cache={tablet_status:{val:1, str:"NORMAL"}, create_commit_version:1752478639255575000, delete_commit_version:-1}, snapshot_version=1767875344340064000) [2026-01-08 20:29:04.729825] INFO [DATA_DICT] get_data_dict_meta_info_ (ob_data_dict_meta_info.cpp:482) [1913438][T1044_ArcTimer][T1044][YB42AC100C46-000647DF78A6E7D9-0-0] [lt=36] get_data_dict_meta_info(tenant_id_=1044, base_scn={val:1753776758298854000, v:0}, record_count=177, valid_record_count=167) [2026-01-08 20:29:04.730093] INFO [STORAGE] scheduler_transfer_handler_ (ob_transfer_service.cpp:202) [1912620][T1042_TransferS][T1042][YB42AC100C46-000647DFF886E7E7-0-0] [lt=1] start do transfer handler(ls_id_array_=[{id:1}, {id:1001}, {id:1002}, {id:1003}]) [2026-01-08 20:29:04.730139] WDIAG begin (ob_hashtable.h:954) [1912731][T1042_L0_G0][T1042][YB42AC100C46-000647DFE6A76713-0-0] [lt=35][errcode=-4006] hashtable not init, backtrace=0x810107f 0x130a017a 0x813a11b 0x813681c 0x13895b38 0x7f48d99 0x7f37287 0x7a7a203 0x7a767e0 0x78e6cb7 0x7c4d02d 0x7c4cc93 0x7c482ef 0x7cf5031 0x7cf492a 0x1f20bc74 0x19105e68 0x19109009 0xec0e9d4 0xeaa3654 0xea77651 0x14a77fab 0x11bba465 0x7c4fe27 0x7923e9d 0x792151e 0x7cc475f 0x78c853f 0x78b88e4 0x78b1ae0 0x78aefed 0x789e119 0xfc77119 0x1f95655e 0x7f900a3db609 0x7f900a2fe353 [2026-01-08 20:29:04.730175] WDIAG begin (ob_hashtable.h:954) [1912731][T1042_L0_G0][T1042][YB42AC100C46-000647DFE6A76713-0-0] [lt=32][errcode=-4006] hashtable not init, backtrace=0x810107f 0x130a017a 0x813a11b 0x813684a 0x13895b38 0x7f48d99 0x7f37287 0x7a7a203 0x7a767e0 0x78e6cb7 0x7c4d02d 0x7c4cc93 0x7c482ef 0x7cf5031 0x7cf492a 0x1f20bc74 0x19105e68 0x19109009 0xec0e9d4 0xeaa3654 0xea77651 0x14a77fab 0x11bba465 0x7c4fe27 0x7923e9d 0x792151e 0x7cc475f 0x78c853f 0x78b88e4 0x78b1ae0 0x78aefed 0x789e119 0xfc77119 0x1f95655e 0x7f900a3db609 0x7f900a2fe353 [2026-01-08 20:29:04.730542] INFO [LIB] stat (utility.h:1210) [1979676][T1042_L0_G1][T1042][YB42AC100C79-000642AC392DF336-0-0] [lt=88] [PALF STAT PUSH LOG TO FOLLOWERS RPC POST COST TIME](cur_stat_count=10, stat_interval=1000000, avg (count/cost)=0, this=0x7f8e463ed470, extra_info="") [2026-01-08 20:29:04.730585] INFO [PALF] handle_next_submit_log_ (log_sliding_window.cpp:1093) [1979676][T1042_L0_G1][T1042][YB42AC100C79-000642AC392DF336-0-0] [lt=42] [PALF STAT GROUP LOG INFO](palf_id=1001, self="172.16.12.70:2882", role="FOLLOWER", total_group_log_cnt=10, avg_log_batch_cnt=0, total_group_log_size=1220, avg_group_log_size=122) [2026-01-08 20:29:04.731491] INFO [STORAGE] runTimerTask (ob_checkpoint_service.cpp:133) [1915176][T1051_TimerWK2][T1051][Y0-0000000000000000-0-0] [lt=28] ====== checkpoint timer task ====== [2026-01-08 20:29:04.732176] INFO [STORAGE.TRANS] get_rec_scn (ob_trans_ctx_mgr_v4.cpp:1430) [1915176][T1051_TimerWK2][T1051][Y0-0000000000000000-0-0] [lt=39] succ to get rec scn(*this={this:0x7f8da6a04030, ls_id:{id:1}, tenant_id:1051, tx_ls_state_mgr:{ls_id_:{id:1}, cur_state_.state_val_:{state_:"L_WORKING", offline_flag_:0, block_start_tx_flag_:0, block_start_normal_tx_flag_:0, block_start_readonly_flag_:0}, prev_state_.state_val_:{state_:"L_WORKING", offline_flag_:0, block_start_tx_flag_:0, block_start_normal_tx_flag_:0, block_start_readonly_flag_:0}, max_applying_start_working_ts_:{val:1767875062955831001, v:0}, max_applied_start_working_ts_:{val:1767875062955831001, v:0}}, total_tx_ctx_count:0, active_tx_count:0, ls_retain_ctx_mgr:{retain_ctx_list_.get_size():0, max_wait_ckpt_ts_:{val:18446744073709551615, v:3}, last_push_gc_task_ts_:1767874771762392, skip_remove_cnt_:0}, aggre_rec_scn:{val:18446744073709551615, v:3}, prev_aggre_rec_scn:{val:18446744073709551615, v:3}, uref:990}, aggre_rec_scn={val:4611686018427387903, v:0}) [2026-01-08 20:29:04.732228] INFO [STORAGE.TRANS] get_rec_scn (ob_tx_ctx_memtable.cpp:182) [1915176][T1051_TimerWK2][T1051][Y0-0000000000000000-0-0] [lt=69] tx ctx memtable get rec scn(this={ObITable:{this:0x7f8d8a8f0080, key:{tablet_id:{id:49401}, column_group_idx:0, table_type:"TX_CTX_MEMTABLE", scn_range:{start_scn:{val:1, v:0}, end_scn:{val:2, v:0}}}, ref_cnt:2, upper_trans_version:-4007, timestamp:0}, this:0x7f8d8a8f0080, snapshot_version:{val:4611686018427387903, v:0}, ls_id:{id:1}, is_frozen:false}, rec_scn={val:4611686018427387903, v:0}) [2026-01-08 20:29:04.732343] INFO [SQL] get_cache_obj (ob_sql_stat_record.cpp:621) [1912731][T1042_L0_G0][T1042][YB42AC100C46-000647DFE6A76713-0-0] [lt=20] sql stat record not found(ret=-5138, key={sql_id:"1D0BA376E273B9D622641124D8C59264", plan_hash:11346785040401645945, source_addr:"0.0.0.0:0"}) [2026-01-08 20:29:04.732432] INFO [PL] compile (ob_pl_compile.cpp:483) [1912731][T1042_L0_G0][T1042][YB42AC100C46-000647DFE6A76713-0-0] [lt=39] >>>>>>>>Resolve Time: (routine.get_routine_id()=500328, routine.get_routine_name()=check_daily, resolve_end - parse_end=11306) [2026-01-08 20:29:04.732513] INFO [MDS] get_rec_scn (mds_table_mgr.cpp:265) [1915176][T1051_TimerWK2][T1051][Y0-0000000000000000-0-0] [lt=47] [FREEZE]get rec_scn from MdsTableMgr(ret=0, ret="OB_SUCCESS", min_rec_scn={val:1767808865474041002, v:0}, order_flusher_for_one={high_priority_flusher:size:1, ordered_tablets:{{tablet_id:{id:60476}, rec_scn:{val:1767808865474041002, v:0}}, }, *this={this:0x7f8da6ddd150, is_inited:true, freezing_scn:{val:0, v:0}, ls:{running_state:{state:1}, ls_meta:{tenant_id:1051, ls_id:{id:1}, ls_persistent_state:{state:1}, clog_checkpoint_scn:{val:1767808865474041002, v:0}, clog_base_lsn:{lsn:122734620672}, rebuild_seq:1, migration_status:0, gc_state_:1, offline_scn_:{val:18446744073709551615, v:3}, restore_status:{status:0}, replayable_point:{val:18446744073709551615, v:3}, tablet_change_checkpoint_scn:{val:1767808865474041001, v:0}, all_id_meta:{id_meta:[{limited_id:1767875361348735000, latest_log_ts:{val:1767875344691919001, v:0}}, {limited_id:211000001, latest_log_ts:{val:1767875071348735002, v:0}}, {limited_id:5000000001, latest_log_ts:{val:1767875071742257319, v:0}}]}, transfer_scn:{val:0, v:0}, rebuild_info:{status:{status:0}, type:{type:0}, tablet_id_array:{id_array:[]}, src:[type = 0], [address = ]}, transfer_meta_info:{src_ls:{id:0}, src_scn:{val:1, v:0}, trans_status:0, tablet_id_array:{id_array:[]}, data_version:1(0, 0, 1)}, store_format:{store_type:1, store_type_str:"NORMAL"}}, switch_epoch:1, log_handler:{role:1, proposal_id:97, palf_env_:0x7f8db3ff8030, is_in_stop_state_:false, is_inited_:true, id_:1}, restore_handler:{is_inited:true, is_in_stop_state:false, id:1, proposal_id:9223372036854775807, role:2, parent:null, context:{issue_task_num:0, issue_version:-1, last_fetch_ts:-1, max_submit_lsn:{lsn:18446744073709551615}, max_fetch_lsn:{lsn:18446744073709551615}, max_fetch_scn:{val:18446744073709551615, v:3}, error_context:{ret_code:0, trace_id:Y0-0000000000000000-0-0, error_type:0, err_lsn:{lsn:18446744073709551615}}, task_count:0}, restore_context:{seek_done:false, lsn:{lsn:18446744073709551615}}}, is_inited:true, tablet_gc_handler:{tablet_persist_trigger:0, is_inited:true}, startup_transfer_info:{ls_id:{id:0}, transfer_start_scn:{val:18446744073709551615, v:3}}, need_delay_resource_recycle:false}}) [2026-01-08 20:29:04.732620] INFO [STORAGE.TRANS] get_rec_scn (ob_ls_tx_service.cpp:637) [1915176][T1051_TimerWK2][T1051][Y0-0000000000000000-0-0] [lt=138] [CHECKPOINT] ObLSTxService::get_rec_scn(common_checkpoint_type="MDS_TABLE_TYPE", common_checkpoints_[min_rec_scn_common_checkpoint_type_index]={this:0x7f8da6ddd150, is_inited:true, freezing_scn:{val:0, v:0}, ls:{running_state:{state:1}, ls_meta:{tenant_id:1051, ls_id:{id:1}, ls_persistent_state:{state:1}, clog_checkpoint_scn:{val:1767808865474041002, v:0}, clog_base_lsn:{lsn:122734620672}, rebuild_seq:1, migration_status:0, gc_state_:1, offline_scn_:{val:18446744073709551615, v:3}, restore_status:{status:0}, replayable_point:{val:18446744073709551615, v:3}, tablet_change_checkpoint_scn:{val:1767808865474041001, v:0}, all_id_meta:{id_meta:[{limited_id:1767875361348735000, latest_log_ts:{val:1767875344691919001, v:0}}, {limited_id:211000001, latest_log_ts:{val:1767875071348735002, v:0}}, {limited_id:5000000001, latest_log_ts:{val:1767875071742257319, v:0}}]}, transfer_scn:{val:0, v:0}, rebuild_info:{status:{status:0}, type:{type:0}, tablet_id_array:{id_array:[]}, src:[type = 0], [address = ]}, transfer_meta_info:{src_ls:{id:0}, src_scn:{val:1, v:0}, trans_status:0, tablet_id_array:{id_array:[]}, data_version:1(0, 0, 1)}, store_format:{store_type:1, store_type_str:"NORMAL"}}, switch_epoch:1, log_handler:{role:1, proposal_id:97, palf_env_:0x7f8db3ff8030, is_in_stop_state_:false, is_inited_:true, id_:1}, restore_handler:{is_inited:true, is_in_stop_state:false, id:1, proposal_id:9223372036854775807, role:2, parent:null, context:{issue_task_num:0, issue_version:-1, last_fetch_ts:-1, max_submit_lsn:{lsn:18446744073709551615}, max_fetch_lsn:{lsn:18446744073709551615}, max_fetch_scn:{val:18446744073709551615, v:3}, error_context:{ret_code:0, trace_id:Y0-0000000000000000-0-0, error_type:0, err_lsn:{lsn:18446744073709551615}}, task_count:0}, restore_context:{seek_done:false, lsn:{lsn:18446744073709551615}}}, is_inited:true, tablet_gc_handler:{tablet_persist_trigger:0, is_inited:true}, startup_transfer_info:{ls_id:{id:0}, transfer_start_scn:{val:18446744073709551615, v:3}}, need_delay_resource_recycle:false}}, min_rec_scn={val:1767808865474041002, v:0}, ls_id_={id:1}) [2026-01-08 20:29:04.732694] INFO [STORAGE] get_rec_scn (ob_ls_ddl_log_handler.cpp:501) [1915176][T1051_TimerWK2][T1051][Y0-0000000000000000-0-0] [lt=85] [CHECKPOINT] ObLSDDLLogHandler::get_rec_scn(ret=0, ls_id={id:1}, barrier_tablet_id={id:0}, rec_scn={val:4611686018427387903, v:0}, last_rec_scn={val:1766944801572637000, v:0}) [2026-01-08 20:29:04.732716] INFO [STORAGE.TRANS] get_rec_scn (ob_id_service.cpp:308) [1915176][T1051_TimerWK2][T1051][Y0-0000000000000000-0-0] [lt=24] get rec log scn(service_type_=0, rec_log_ts={val:1767875344691919001, v:0}) [2026-01-08 20:29:04.732732] INFO [STORAGE.TRANS] get_rec_scn (ob_id_service.cpp:308) [1915176][T1051_TimerWK2][T1051][Y0-0000000000000000-0-0] [lt=19] get rec log scn(service_type_=1, rec_log_ts={val:1767875071348735002, v:0}) [2026-01-08 20:29:04.732741] INFO [STORAGE.TRANS] get_rec_scn (ob_id_service.cpp:308) [1915176][T1051_TimerWK2][T1051][Y0-0000000000000000-0-0] [lt=8] get rec log scn(service_type_=2, rec_log_ts={val:1767875071742257319, v:0}) [2026-01-08 20:29:04.732760] INFO [STORAGE.TABLELOCK] get_rec_scn (ob_lock_memtable.cpp:1220) [1915176][T1051_TimerWK2][T1051][Y0-0000000000000000-0-0] [lt=17] rec_scn of ObLockMemtable is (rec_scn_={val:4611686018427387903, v:0}, flushed_scn_={val:0, v:0}, pre_rec_scn_={val:4611686018427387903, v:0}, freeze_scn_={val:0, v:0}, max_committed_scn_={val:18446744073709551615, v:3}, is_frozen_=false, ls_id_={id:1}) [2026-01-08 20:29:04.732787] INFO [STORAGE.TABLELOCK] get_rec_scn (ob_lock_memtable.cpp:1220) [1915176][T1051_TimerWK2][T1051][Y0-0000000000000000-0-0] [lt=28] rec_scn of ObLockMemtable is (rec_scn_={val:4611686018427387903, v:0}, flushed_scn_={val:0, v:0}, pre_rec_scn_={val:4611686018427387903, v:0}, freeze_scn_={val:0, v:0}, max_committed_scn_={val:18446744073709551615, v:3}, is_frozen_=false, ls_id_={id:1}) [2026-01-08 20:29:04.732806] INFO [STORAGE] update_clog_checkpoint (ob_checkpoint_executor.cpp:189) [1915176][T1051_TimerWK2][T1051][Y0-0000000000000000-0-0] [lt=23] [CHECKPOINT] clog checkpoint no change(checkpoint_scn={val:1767808865474041002, v:0}, checkpoint_scn_in_ls_meta={val:1767808865474041002, v:0}, ls_id={id:1}, service_type="TRANS_SERVICE") [2026-01-08 20:29:04.732833] WDIAG [PALF] set_base_lsn (palf_handle_impl.cpp:1664) [1915176][T1051_TimerWK2][T1051][Y0-0000000000000000-0-0] [lt=22][errcode=0] no need to set new base lsn, curr base lsn is greater than or equal to new base lsn(this={palf_id:1, self:"172.16.12.70:2882", has_set_deleted:false}, log_snapshot_meta={version:2, base_lsn:{lsn:122734620672}, prev_log_info:{log_id:129530024, lsn:{lsn:84820422474}, scn:{val:1763831167739836000, v:0}, log_proposal_id:37, accum_checksum:1909038043}, prev_log_tail_lsn:{lsn:84820426752}}, new_base_lsn={lsn:122734620672}, lsn={lsn:122734620672}) [2026-01-08 20:29:04.732862] INFO [STORAGE] runTimerTask (ob_checkpoint_service.cpp:190) [1915176][T1051_TimerWK2][T1051][Y0-0000000000000000-0-0] [lt=38] [CHECKPOINT] advance palf base lsn successfully(checkpoint_lsn={lsn:122734620672}, ls->get_ls_id()={id:1}) [2026-01-08 20:29:04.732880] INFO [STORAGE] runTimerTask (ob_checkpoint_service.cpp:197) [1915176][T1051_TimerWK2][T1051][Y0-0000000000000000-0-0] [lt=20] succeed to update_clog_checkpoint(ret=0, ls_cnt=1) [2026-01-08 20:29:04.734203] INFO [SERVER] runTimerTask (ob_eliminate_task.cpp:225) [1923402][T1094_TimerWK2][T1094][Y0-0000000000000000-0-0] [lt=46] sql audit evict task end(request_manager_->get_tenant_id()=1094, evict_high_mem_level=278313880, evict_high_size_level=471859, evict_batch_count=0, elapse_time=0, size_used=0, mem_used=41594880) [2026-01-08 20:29:04.734263] INFO [SERVER] prepare_alloc_queue (ob_dl_queue.cpp:52) [1923403][T1094_TimerWK3][T1094][Y0-0000000000000000-0-0] [lt=21] Construct Queue Num(construct_num=0, get_push_idx()=8, get_cur_idx()=0, get_pop_idx()=0) [2026-01-08 20:29:04.734422] INFO [SERVER] runTimerTask (ob_eliminate_task.cpp:225) [1923124][T1093_TimerWK0][T1093][Y0-0000000000000000-0-0] [lt=134] sql audit evict task end(request_manager_->get_tenant_id()=1093, evict_high_mem_level=19327352, evict_high_size_level=471859, evict_batch_count=0, elapse_time=0, size_used=0, mem_used=4159488) [2026-01-08 20:29:04.734582] WDIAG [STORAGE.TRANS] run1 (ob_standby_timestamp_service.cpp:147) [1913432][T1044_STSWorker][T1044][Y0-0000000000000000-0-0] [lt=44][errcode=-4076] query and update last id fail(ret=-4076, ret="OB_NEED_WAIT") [2026-01-08 20:29:04.735061] WDIAG [SQL.ENG] get_next_left_row (ob_nested_loop_join_vec_op.cpp:167) [1927382][T1101_COMMONLSS][T1101][YB42AC100C46-000647DFE1F6E8A1-0-0] [lt=54][errcode=-4008] failed to get next left row from friver iterator(ret=-4008) [2026-01-08 20:29:04.735081] INFO [STORAGE] gc_tables_in_queue (ob_tenant_meta_mem_mgr.cpp:612) [1914742][T1050_TimerWK3][T1050][Y0-0000000000000000-0-0] [lt=47] gc tables in queue: recycle 0 table(ret=0, tablet_buffer_pool_={typeid(T).name():"N9oceanbase7storage15ObMetaObjBufferINS0_8ObTabletELl3788EEE", sizeof(T):3824, used_obj_cnt:1358, free_obj_hold_cnt:12, allocator used:5271760, allocator total:5614080}, large_tablet_buffer_pool_={typeid(T).name():"N9oceanbase7storage15ObMetaObjBufferINS0_8ObTabletELl65448EEE", sizeof(T):65480, used_obj_cnt:12, free_obj_hold_cnt:0, allocator used:787092, allocator total:787092}, full_tablet_creator_={tiny_allocator_.used():0, tiny_allocator_.total():0, full allocator used:0, full allocator total:0}, tablets_mem=6401172, tablets_mem_limit=2319282340, 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:42, free_obj_hold_cnt:0, allocator used:86016, allocator total:130560}, pending_cnt=0, wait_gc_count=0, tablet count=1370) [2026-01-08 20:29:04.735121] INFO [LIB] stat (utility.h:1210) [1912387][T1042_IOWorker][T1042][Y0-0000000000000000-0-0] [lt=29] [PALF STAT WRITE LOG COST TIME](cur_stat_count=11, stat_interval=1000000, avg (count/cost)=1594, this=0x7f8e43611c30, extra_info="") [2026-01-08 20:29:04.735157] INFO [LIB] stat (utility.h:1227) [1912387][T1042_IOWorker][T1042][Y0-0000000000000000-0-0] [lt=38] [PALF STAT IO TASK IN QUEUE TIME](cur_stat_count=11, stat_interval=1000000, avg (count/cost)=20, this=0x7f8e5a1ffaf0, extra_info="") -- [2026-01-08 20:29:04.750826] INFO [PALF] next (palf_iterator.h:183) [1977907][T1042_L0_G13][T1042][Y8639AC100C46-0000000032A80C1C-0-0] [lt=38] [PALF STAT ITERATOR INFO](io_ctx={user:"CDC", palf_id:1003, iterator_info:{allow_filling_cache:true, hot_cache_stat:{hit_cnt:1, miss_cnt:0, cache_read_size:122, hit_ratio:"1.000000000000000000e+00"}, cold_cache_stat:{hit_cnt:0, miss_cnt:0, cache_read_size:0, hit_ratio:"0.000000000000000000e+00"}, read_io_cnt:0, read_io_size:0, read_disk_cost_ts:0, start_lsn:{lsn:120171395307}}}) [2026-01-08 20:29:04.750888] INFO [CLOG.EXTLOG] fetch_log (ob_cdc_fetcher.cpp:136) [1977907][T1042_L0_G13][T1042][Y8639AC100C46-0000000032A80C1C-0-0] [lt=70] fetch_log done(req={rpc_ver:1, ls_id:{id:1003}, start_lsn:{lsn:120171395307}, upper_limit_ts:1767875374340064002, client_pid:820793, client_id:{client_addr:"172.16.12.70:820793", client_pid:820793}, progress:1767875344340064002, flag:0, compressor_type:0, tenant_id:0}, resp={rpc_ver:1, err:0, debug_err:0, ls_id:{id:1003}, feedback_type:-1, fetch_status:{is_reach_max_lsn:true, is_reach_upper_limit_ts:false, scan_round_count:2, l2s_net_time:0, svr_queue_time:0, log_fetch_time:0, ext_process_time:0}, next_req_lsn:{lsn:120171395429}, log_num:1, pos:122}, fetch_log_time_stat={fetch_total_time:87, fetch_log_time:83, fetch_palf_time:78, fetch_archive_time:0, fetch_log_post_process_time:1, prefill_resp_time:1}) [2026-01-08 20:29:04.751297] WDIAG [PALF] next (log_iterator_impl.h:707) [1977907][T1042_L0_G13][T1042][Y8639AC100C46-00000000325816BE-0-0] [lt=59][errcode=-4008] there is no readable log, set next_min_scn to OB_INVALID_TIMESTAMP(ret=-4008, this={buf_:null, next_round_pread_size:3678208, curr_read_pos:0, curr_read_buf_start_pos:0, curr_read_buf_end_pos:0, log_storage_:{start_lsn:{lsn:120171395429}, end_lsn:{lsn:120171395429}, read_buf:{buf_len_:0, buf_:null}, block_size:67104768, log_storage_:0x7f8e4360da70, log_storage_:{log_tail:{lsn:120171395429}, readable_log_tail:{lsn:120171395429}, log_block_header:{magic:18754, version:1, min_lsn:{lsn:18446744073709551615}, min_scn:{val:18446744073709551615, v:3}, curr_block_id:1790, palf_id:1003}, block_mgr:{log_dir:"/home/admin/ysdb/oceanbase/store/clog/tenant_1042/1003/log", dir_fd:993, min_block_id:1332, max_block_id:1791, curr_writable_block_id:1790}, logical_block_size_:67104768, curr_block_writable_size_:13244059, block_header_serialize_buf_:0x7f8e4360e738, flashback_version:0}, storage_type:"DISK_STORAGE"}, curr_entry_is_raw_write:false, curr_entry_size:0, prev_entry_scn:{val:18446744073709551615, v:3}, curr_entry:{LogGroupEntryHeader:{magic:0, version:0, group_size:0, proposal_id:9223372036854775807, committed_lsn:{lsn:18446744073709551615}, max_scn:{val:18446744073709551615, v:3}, accumulated_checksum:0, log_id:0, flag:0}}, init_mode_version:0, accumulate_checksum:-1, curr_entry_is_padding:0, padding_entry_size:0, padding_entry_scn:{val:18446744073709551615, v:3}}, info={reason:2, log_scn:{val:18446744073709551615, v:3}}, replayable_point_scn={val:1767875342081604002, v:0}) [2026-01-08 20:29:04.751366] INFO [PALF] next (palf_iterator.h:183) [1977907][T1042_L0_G13][T1042][Y8639AC100C46-00000000325816BE-0-0] [lt=90] [PALF STAT ITERATOR INFO](io_ctx={user:"CDC", palf_id:1003, iterator_info:{allow_filling_cache:true, hot_cache_stat:{hit_cnt:0, miss_cnt:0, cache_read_size:0, hit_ratio:"0.000000000000000000e+00"}, cold_cache_stat:{hit_cnt:0, miss_cnt:0, cache_read_size:0, hit_ratio:"0.000000000000000000e+00"}, read_io_cnt:0, read_io_size:0, read_disk_cost_ts:0, start_lsn:{lsn:120171395429}}}) [2026-01-08 20:29:04.751405] INFO [CLOG.EXTLOG] fetch_log (ob_cdc_fetcher.cpp:136) [1977907][T1042_L0_G13][T1042][Y8639AC100C46-00000000325816BE-0-0] [lt=48] fetch_log done(req={rpc_ver:1, ls_id:{id:1003}, start_lsn:{lsn:120171395429}, upper_limit_ts:1767875374696273000, client_pid:820793, client_id:{client_addr:"172.16.12.70:820793", client_pid:820793}, progress:1767875344730094000, flag:0, compressor_type:0, tenant_id:0}, resp={rpc_ver:1, err:0, debug_err:0, ls_id:{id:1003}, feedback_type:-1, fetch_status:{is_reach_max_lsn:true, is_reach_upper_limit_ts:false, scan_round_count:1, l2s_net_time:0, svr_queue_time:0, log_fetch_time:0, ext_process_time:0}, next_req_lsn:{lsn:120171395429}, log_num:0, pos:0}, fetch_log_time_stat={fetch_total_time:110, fetch_log_time:109, fetch_palf_time:107, fetch_archive_time:0, fetch_log_post_process_time:0, prefill_resp_time:0}) [2026-01-08 20:29:04.751924] WDIAG [STORAGE.TRANS] run1 (ob_standby_timestamp_service.cpp:147) [1922372][T1090_STSWorker][T1090][Y0-0000000000000000-0-0] [lt=51][errcode=-4076] query and update last id fail(ret=-4076, ret="OB_NEED_WAIT") [2026-01-08 20:29:04.754394] WDIAG [SHARE] get_by_ls_id_ (ob_transfer_task_operator.cpp:754) [1912620][T1042_TransferS][T1042][YB42AC100C46-000647DFF886E7EF-0-0] [lt=30][errcode=-4018] dest ls transfer task not found(ret=-4018, ret="OB_ENTRY_NOT_EXIST", tenant_id=1042, ls_id={id:1003}) [2026-01-08 20:29:04.754467] WDIAG [SHARE] get_by_src_ls (ob_transfer_task_operator.cpp:189) [1912620][T1042_TransferS][T1042][YB42AC100C46-000647DFF886E7EF-0-0] [lt=37][errcode=-4018] failed to get by ls id(ret=-4018, tenant_id=1042, src_ls={id:1003}) [2026-01-08 20:29:04.754487] WDIAG [STORAGE] fetch_transfer_task_from_inner_table_by_src_ls_ (ob_transfer_handler.cpp:246) [1912620][T1042_TransferS][T1042][YB42AC100C46-000647DFF886E7EF-0-0] [lt=25][errcode=-4018] failed to get transfer task(ret=-4018, tenant_id=1042, src_ls_id={id:1003}) [2026-01-08 20:29:04.754685] WDIAG begin (ob_hashtable.h:954) [1912731][T1042_L0_G0][T1042][YB42AC100C46-000647DFE6A76713-0-0] [lt=24][errcode=-4006] hashtable not init, backtrace=0x810107f 0x130a017a 0x813a11b 0x813681c 0x13895b38 0x7f48d99 0x7f37287 0x7a7a203 0x7a767e0 0x78e6cb7 0x7c4d02d 0x7c4cc93 0x7c482ef 0x7bf7412 0x7bf6cb0 0x7bf6baa 0x7bf69b6 0xec0c532 0xec0be34 0xec0ee85 0xeaa3654 0xea77651 0x14a77fab 0x11bba465 0x7c4fe27 0x7923e9d 0x792151e 0x7cc475f 0x78c853f 0x78b88e4 0x78b1ae0 0x78aefed 0x789e119 0xfc77119 0x1f95655e 0x7f900a3db609 0x7f900a2fe353 [2026-01-08 20:29:04.754722] WDIAG begin (ob_hashtable.h:954) [1912731][T1042_L0_G0][T1042][YB42AC100C46-000647DFE6A76713-0-0] [lt=33][errcode=-4006] hashtable not init, backtrace=0x810107f 0x130a017a 0x813a11b 0x813684a 0x13895b38 0x7f48d99 0x7f37287 0x7a7a203 0x7a767e0 0x78e6cb7 0x7c4d02d 0x7c4cc93 0x7c482ef 0x7bf7412 0x7bf6cb0 0x7bf6baa 0x7bf69b6 0xec0c532 0xec0be34 0xec0ee85 0xeaa3654 0xea77651 0x14a77fab 0x11bba465 0x7c4fe27 0x7923e9d 0x792151e 0x7cc475f 0x78c853f 0x78b88e4 0x78b1ae0 0x78aefed 0x789e119 0xfc77119 0x1f95655e 0x7f900a3db609 0x7f900a2fe353 [2026-01-08 20:29:04.754988] INFO [STORAGE] runTimerTask (ob_checkpoint_service.cpp:300) [1925911][T1097_TimerWK3][T1097][Y0-0000000000000000-0-0] [lt=26] ====== check clog disk timer task ====== [2026-01-08 20:29:04.755028] INFO [PALF] get_disk_usage (palf_env_impl.cpp:920) [1925911][T1097_TimerWK3][T1097][Y0-0000000000000000-0-0] [lt=47] get_disk_usage(ret=0, capacity(MB):=3686, used(MB):=2888) [2026-01-08 20:29:04.755131] WDIAG [STORAGE.TRANS] run1 (ob_standby_timestamp_service.cpp:147) [1916381][T1056_STSWorker][T1056][Y0-0000000000000000-0-0] [lt=47][errcode=-4076] query and update last id fail(ret=-4076, ret="OB_NEED_WAIT") [2026-01-08 20:29:04.757101] WDIAG [SHARE] get_by_ls_id_ (ob_transfer_task_operator.cpp:754) [1912620][T1042_TransferS][T1042][YB42AC100C46-000647DFF886E7EF-0-0] [lt=13][errcode=-4018] dest ls transfer task not found(ret=-4018, ret="OB_ENTRY_NOT_EXIST", tenant_id=1042, ls_id={id:1003}) [2026-01-08 20:29:04.757169] WDIAG [SHARE] get_by_dest_ls (ob_transfer_task_operator.cpp:207) [1912620][T1042_TransferS][T1042][YB42AC100C46-000647DFF886E7EF-0-0] [lt=33][errcode=-4018] failed to get by ls id(ret=-4018, tenant_id=1042, dest_ls={id:1003}) [2026-01-08 20:29:04.757188] WDIAG [STORAGE] fetch_transfer_task_from_inner_table_by_dest_ls_ (ob_transfer_handler.cpp:272) [1912620][T1042_TransferS][T1042][YB42AC100C46-000647DFF886E7EF-0-0] [lt=24][errcode=-4018] failed to get transfer task by dest ls(ret=-4018, tenant_id=1042, dest_ls_id={id:1003}) [2026-01-08 20:29:04.757323] INFO [STORAGE] get_need_backfill_tx_tablets_ (ob_transfer_backfill_tx.cpp:239) [1912620][T1042_TransferS][T1042][YB42AC100C46-000647DFF886E7EF-0-0] [lt=12] statistics the time that get needed to backfill tablets(ls id={id:1003}, cost_time=122) [2026-01-08 20:29:04.757339] INFO [STORAGE] do_worker_transfer_ (ob_transfer_handler.cpp:2386) [1912620][T1042_TransferS][T1042][YB42AC100C46-000647DFF886E7EF-0-0] [lt=19] do worker transfer(ls_={running_state:{state:1}, ls_meta:{tenant_id:1042, ls_id:{id:1003}, ls_persistent_state:{state:1}, clog_checkpoint_scn:{val:1767834065807102000, v:0}, clog_base_lsn:{lsn:120117534720}, rebuild_seq:1, migration_status:0, gc_state_:1, offline_scn_:{val:18446744073709551615, v:3}, restore_status:{status:0}, replayable_point:{val:1767875342081604002, v:0}, tablet_change_checkpoint_scn:{val:1767859989078011003, v:0}, all_id_meta:{id_meta:[{limited_id:1, latest_log_ts:{val:18446744073709551615, v:3}}, {limited_id:1, latest_log_ts:{val:18446744073709551615, v:3}}, {limited_id:1, latest_log_ts:{val:18446744073709551615, v:3}}]}, transfer_scn:{val:1765438522982657002, v:0}, rebuild_info:{status:{status:0}, type:{type:0}, tablet_id_array:{id_array:[]}, src:[type = 0], [address = ]}, transfer_meta_info:{src_ls:{id:0}, src_scn:{val:1, v:0}, trans_status:0, tablet_id_array:{id_array:[]}, data_version:17180067072(4, 3, 5, 0)}, store_format:{store_type:1, store_type_str:"NORMAL"}}, switch_epoch:1, log_handler:{role:1, proposal_id:108, palf_env_:0x7f8e5a1f8030, is_in_stop_state_:false, is_inited_:true, id_:1003}, restore_handler:{is_inited:true, is_in_stop_state:false, id:1003, proposal_id:9223372036854775807, role:2, parent:null, context:{issue_task_num:0, issue_version:-1, last_fetch_ts:-1, max_submit_lsn:{lsn:18446744073709551615}, max_fetch_lsn:{lsn:18446744073709551615}, max_fetch_scn:{val:18446744073709551615, v:3}, error_context:{ret_code:0, trace_id:Y0-0000000000000000-0-0, error_type:0, err_lsn:{lsn:18446744073709551615}}, task_count:0}, restore_context:{seek_done:false, lsn:{lsn:18446744073709551615}}}, is_inited:true, tablet_gc_handler:{tablet_persist_trigger:0, is_inited:true}, startup_transfer_info:{ls_id:{id:0}, transfer_start_scn:{val:18446744073709551615, v:3}}, need_delay_resource_recycle:false}) [2026-01-08 20:29:04.758039] INFO [PL.STORAGEROUTINE] read_dll_from_disk (ob_pl_persistent.cpp:601) [1912731][T1042_L0_G0][T1042][YB42AC100C46-000647DFE6A76713-0-0] [lt=20] succ decode dll from disk(ret=0, key_id_=500328, merge_version=1766844358795752) [2026-01-08 20:29:04.758320] INFO [PL] compile (ob_pl_compile.cpp:541) [1912731][T1042_L0_G0][T1042][YB42AC100C46-000647DFE6A76713-0-0] [lt=37] >>>>>>>>CG Time: (routine.get_routine_id()=500328, routine.get_routine_name()=check_daily, cg_end - resolve_end=25888) [2026-01-08 20:29:04.758345] INFO [PL] compile (ob_pl_compile.cpp:544) [1912731][T1042_L0_G0][T1042][YB42AC100C46-000647DFE6A76713-0-0] [lt=32] >>>>>>>>Final Compile Routine Time: (routine.get_routine_id()=500328, routine.get_routine_name()=check_daily, final_end - init_start=37703) [2026-01-08 20:29:04.759479] INFO [STORAGE] do_transfer_handler_ (ob_transfer_service.cpp:237) [1912620][T1042_TransferS][T1042][YB42AC100C46-000647DFF886E7EF-0-0] [lt=86] [TRANSFER] transfer handler process(ret=0, ls_id={id:1003}) [2026-01-08 20:29:04.761386] INFO [PL] generate_pl_function (ob_pl.cpp:2844) [1912731][T1042_L0_G0][T1042][YB42AC100C46-000647DFE6A76713-0-0] [lt=14] >>>>>>>>>>Compile Routine Time: (ret=0, proc_id=500328, compile_end - compile_start=41256, routine={ns:2, ref_count:1, tenant_schema_version:1766911209616144, sys_schema_version:1767836179527672, object_id:185, dependency_tables:[cnt:1, {table_id:500328, schema_version:1766844358787584, object_type:4, is_db_explicit:false, is_existed:true}], params_info:[], variables:[cnt:3, {type:0, type_from:0, not_null:false, pls_type:0, type_info_id:18446744073709551615, obj_type:{meta:{type:"INT", collation:"binary", coercibility:"NUMERIC"}, accuracy:{length:-1, precision:11, scale:0}, charset:2, is_binary_collation:false, is_zero_fill:false}, {type:0, type_from:0, not_null:false, pls_type:0, type_info_id:18446744073709551615, obj_type:{meta:{type:"VARCHAR", collation:"utf8mb4_general_ci", coercibility:"IMPLICIT"}, accuracy:{length:255, precision:-1, scale:-1}, charset:2, is_binary_collation:false, is_zero_fill:false}, {type:5, type_from:0, not_null:false, pls_type:0, type_info_id:18446744073709551615, user_type_id:18446744073708503040], default_idxs:[cnt:3, 1, 3, -1], function_name:"check_daily", priv_user:"root@%"}) [2026-01-08 20:29:04.762440] WDIAG [STORAGE.TRANS] run1 (ob_standby_timestamp_service.cpp:147) [1923028][T1092_STSWorker][T1092][Y0-0000000000000000-0-0] [lt=43][errcode=-4076] query and update last id fail(ret=-4076, ret="OB_NEED_WAIT") [2026-01-08 20:29:04.762669] WDIAG [RPC.OBMYSQL] serialize (ob_mysql_row.cpp:56) [1909717][T1_L0_G10000][T1][YB42AC100C46-000647DFC7070160-0-0] [lt=22][errcode=-4019] failed to encode cell(ret=-4019, cell_idx=82, len=6910, pos=3829) [2026-01-08 20:29:04.762747] WDIAG [RPC.OBMYSQL] serialize (ob_mysql_row.cpp:56) [1909717][T1_L0_G10000][T1][YB42AC100C46-000647DFC7070160-0-0] [lt=45][errcode=-4019] failed to encode cell(ret=-4019, cell_idx=82, len=13312, pos=3829) [2026-01-08 20:29:04.763159] WDIAG [STORAGE.TRANS] run1 (ob_standby_timestamp_service.cpp:147) [1921661][T1088_STSWorker][T1088][Y0-0000000000000000-0-0] [lt=33][errcode=-4076] query and update last id fail(ret=-4076, ret="OB_NEED_WAIT") [2026-01-08 20:29:04.765292] INFO [STORAGE] operator() (ob_tenant_freezer.cpp:129) [1916104][T1056_Occam][T1056][Y0-0000000000000000-0-0] [lt=31] ====== tenant freeze timer task ====== [2026-01-08 20:29:04.766563] INFO [SQL] get_cache_obj (ob_sql_stat_record.cpp:621) [1912731][T1042_L0_G0][T1042][YB42AC100C46-000647DFE6A76713-0-0] [lt=92] sql stat record not found(ret=-5138, key={sql_id:"B7A6FA97FEC98C06F9586D23935AC4C6", plan_hash:0, source_addr:"0.0.0.0:0"}) [2026-01-08 20:29:04.767095] INFO [PALF] next (palf_iterator.h:183) [1977907][T1042_L0_G13][T1042][YF5BAAC100C46-0000000041FD77DC-0-0] [lt=60] [PALF STAT ITERATOR INFO](io_ctx={user:"CDC", palf_id:1003, iterator_info:{allow_filling_cache:true, hot_cache_stat:{hit_cnt:1, miss_cnt:0, cache_read_size:122, hit_ratio:"1.000000000000000000e+00"}, cold_cache_stat:{hit_cnt:0, miss_cnt:0, cache_read_size:0, hit_ratio:"0.000000000000000000e+00"}, read_io_cnt:0, read_io_size:0, read_disk_cost_ts:0, start_lsn:{lsn:120171395307}}}) [2026-01-08 20:29:04.767135] INFO [CLOG.EXTLOG] fetch_log (ob_cdc_fetcher.cpp:136) [1977907][T1042_L0_G13][T1042][YF5BAAC100C46-0000000041FD77DC-0-0] [lt=44] fetch_log done(req={rpc_ver:1, ls_id:{id:1003}, start_lsn:{lsn:120171395307}, upper_limit_ts:1767875374201653004, client_pid:2225594, client_id:{client_addr:"172.16.12.70:2225594", client_pid:2225594}, progress:1767875344340064002, flag:0, compressor_type:0, tenant_id:0}, resp={rpc_ver:1, err:0, debug_err:0, ls_id:{id:1003}, feedback_type:-1, fetch_status:{is_reach_max_lsn:true, is_reach_upper_limit_ts:false, scan_round_count:2, l2s_net_time:0, svr_queue_time:0, log_fetch_time:0, ext_process_time:0}, next_req_lsn:{lsn:120171395429}, log_num:1, pos:122}, fetch_log_time_stat={fetch_total_time:55, fetch_log_time:52, fetch_palf_time:48, fetch_archive_time:0, fetch_log_post_process_time:1, prefill_resp_time:1}) [2026-01-08 20:29:04.767565] INFO [LIB] stat (utility.h:1210) [1923037][T1092_TxLoopWor][T1092][Y0-0000000000000000-0-0] [lt=28] [PALF STAT PUSH LOG TO FOLLOWERS RPC POST COST TIME](cur_stat_count=7, stat_interval=1000000, avg (count/cost)=27, this=0x7f8bb49cd470, extra_info="") [2026-01-08 20:29:04.767610] INFO [LIB] stat (utility.h:1210) [1923037][T1092_TxLoopWor][T1092][Y0-0000000000000000-0-0] [lt=39] [PALF STAT APPEND COST TIME](cur_stat_count=7, stat_interval=1000000, avg (count/cost)=0, this=0x7f8c3b95e050, extra_info="id:1002") [2026-01-08 20:29:04.767648] WDIAG [PALF] next (log_iterator_impl.h:707) [1977907][T1042_L0_G13][T1042][YF5BAAC100C46-0000000041DD7B17-0-0] [lt=91][errcode=-4008] there is no readable log, set next_min_scn to OB_INVALID_TIMESTAMP(ret=-4008, this={buf_:null, next_round_pread_size:3678208, curr_read_pos:0, curr_read_buf_start_pos:0, curr_read_buf_end_pos:0, log_storage_:{start_lsn:{lsn:120171395429}, end_lsn:{lsn:120171395429}, read_buf:{buf_len_:0, buf_:null}, block_size:67104768, log_storage_:0x7f8e4360da70, log_storage_:{log_tail:{lsn:120171395429}, readable_log_tail:{lsn:120171395429}, log_block_header:{magic:18754, version:1, min_lsn:{lsn:18446744073709551615}, min_scn:{val:18446744073709551615, v:3}, curr_block_id:1790, palf_id:1003}, block_mgr:{log_dir:"/home/admin/ysdb/oceanbase/store/clog/tenant_1042/1003/log", dir_fd:993, min_block_id:1332, max_block_id:1791, curr_writable_block_id:1790}, logical_block_size_:67104768, curr_block_writable_size_:13244059, block_header_serialize_buf_:0x7f8e4360e738, flashback_version:0}, storage_type:"DISK_STORAGE"}, curr_entry_is_raw_write:false, curr_entry_size:0, prev_entry_scn:{val:18446744073709551615, v:3}, curr_entry:{LogGroupEntryHeader:{magic:0, version:0, group_size:0, proposal_id:9223372036854775807, committed_lsn:{lsn:18446744073709551615}, max_scn:{val:18446744073709551615, v:3}, accumulated_checksum:0, log_id:0, flag:0}}, init_mode_version:0, accumulate_checksum:-1, curr_entry_is_padding:0, padding_entry_size:0, padding_entry_scn:{val:18446744073709551615, v:3}}, info={reason:2, log_scn:{val:18446744073709551615, v:3}}, replayable_point_scn={val:1767875342081604002, v:0}) [2026-01-08 20:29:04.767731] INFO [PALF] next (palf_iterator.h:183) [1977907][T1042_L0_G13][T1042][YF5BAAC100C46-0000000041DD7B17-0-0] [lt=109] [PALF STAT ITERATOR INFO](io_ctx={user:"CDC", palf_id:1003, iterator_info:{allow_filling_cache:true, hot_cache_stat:{hit_cnt:0, miss_cnt:0, cache_read_size:0, hit_ratio:"0.000000000000000000e+00"}, cold_cache_stat:{hit_cnt:0, miss_cnt:0, cache_read_size:0, hit_ratio:"0.000000000000000000e+00"}, read_io_cnt:0, read_io_size:0, read_disk_cost_ts:0, start_lsn:{lsn:120171395429}}}) [2026-01-08 20:29:04.767740] INFO [STORAGE.TRANS] run1 (ob_tx_loop_worker.cpp:113) [1921435][T1087_TxLoopWor][T1087][Y0-0000000000000000-0-0] [lt=105] try gc retain ctx [2026-01-08 20:29:04.767751] INFO [CLOG.EXTLOG] fetch_log (ob_cdc_fetcher.cpp:136) [1977907][T1042_L0_G13][T1042][YF5BAAC100C46-0000000041DD7B17-0-0] [lt=24] fetch_log done(req={rpc_ver:1, ls_id:{id:1003}, start_lsn:{lsn:120171395429}, upper_limit_ts:1767875374201653004, client_pid:2225594, client_id:{client_addr:"172.16.12.70:2225594", client_pid:2225594}, progress:1767875344730094000, flag:0, compressor_type:0, tenant_id:0}, resp={rpc_ver:1, err:0, debug_err:0, ls_id:{id:1003}, feedback_type:-1, fetch_status:{is_reach_max_lsn:true, is_reach_upper_limit_ts:false, scan_round_count:1, l2s_net_time:0, svr_queue_time:0, log_fetch_time:0, ext_process_time:0}, next_req_lsn:{lsn:120171395429}, log_num:0, pos:0}, fetch_log_time_stat={fetch_total_time:106, fetch_log_time:105, fetch_palf_time:103, fetch_archive_time:0, fetch_log_post_process_time:0, prefill_resp_time:0}) [2026-01-08 20:29:04.767772] INFO [STORAGE.TRANS] run1 (ob_tx_loop_worker.cpp:120) [1921435][T1087_TxLoopWor][T1087][Y0-0000000000000000-0-0] [lt=43] try to retry start_working [2026-01-08 20:29:04.768687] INFO [PALF] runTimerTask (block_gc_timer_task.cpp:101) [1920520][T1085_TimerWK3][T1085][Y0-0000000000000000-0-0] [lt=53] BlockGCTimerTask success(ret=0, cost_time_us=6, palf_env_impl_={IPalfEnvImpl:{IPalfEnvImpl:"Dummy"}, self:"172.16.12.70:2882", log_dir:"/home/admin/ysdb/oceanbase/store/clog/tenant_1085", disk_options_wrapper:{disk_opts_for_stopping_writing:{log_disk_size(MB):12288, log_disk_utilization_threshold(%):80, log_disk_utilization_limit_threshold(%):95, log_disk_throttling_percentage(%):60, log_disk_throttling_maximum_duration(s):7200, log_writer_parallelism:3}, disk_opts_for_recycling_blocks:{log_disk_size(MB):12288, log_disk_utilization_threshold(%):80, log_disk_utilization_limit_threshold(%):95, log_disk_throttling_percentage(%):60, log_disk_throttling_maximum_duration(s):7200, log_writer_parallelism:3}, status:1, cur_unrecyclable_log_disk_size(MB):649, sequence:1}, log_alloc_mgr_:{flying_log_task:0, flying_meta_task:0}}) [2026-01-08 20:29:04.768582] INFO [PALF] check_and_switch_state (palf_handle_impl.cpp:2747) [1912858][T1043_LogLoop][T1043][Y0-0000000000000000-0-0] [lt=15] [PALF_DUMP](palf_id=1, self="172.16.12.70:2882", [SlidingWindow]={palf_id:1, self:"172.16.12.70:2882", lsn_allocator:{max_log_id:249221737, max_lsn:165987707330, max_scn:{val:1767875344711085000, v:0}}, group_buffer:{log_group_buffer: start_lsn:{lsn:165975771336}, reuse_lsn:{lsn:165987707330}, reserved_buffer_size:41943040, available_buffer_size:41943040, readable_begin_lsn:{lsn:165975771929}}, last_submit_lsn:{lsn:165987706576}, last_submit_end_lsn:{lsn:165987707330}, last_submit_log_id:249221737, last_submit_log_pid:19, max_flushed_lsn:{lsn:165987706576}, max_flushed_end_lsn:{lsn:165987707330}, max_flushed_log_pid:19, committed_end_lsn:{lsn:165987707330}, last_slide_log_id:249221737, last_slide_scn:{val:1767875344711085000, v:0}, last_slide_lsn:{lsn:165987706576}, last_slide_end_lsn:{lsn:165987707330}, last_slide_log_pid:19, last_slide_log_accum_checksum:1922307738, last_fetch_end_lsn:{lsn:18446744073709551615}, last_fetch_max_log_id:-1, last_fetch_committed_end_lsn:{lsn:18446744073709551615}, last_truncate_lsn:{lsn:18446744073709551615}, last_fetch_req_time:0, is_truncating:false, is_rebuilding:false, last_rebuild_lsn:{lsn:18446744073709551615}, freeze_mode:"FEEDBACK_FREEZE_MODE", has_pending_handle_submit_task:false, last_fetch_trigger_type:"LOG_LOOP_TH", this:0x7f8e21940530}, [StateMgr]={this:0x7f8e21944830, self:"172.16.12.70:2882", palf_id:1, role:"FOLLOWER", replica_type:"NORMAL_REPLICA", state:"ACTIVE", prepare_meta:{version:1, voted_for:"0.0.0.0:0", log_proposal_id:19}, leader:"172.16.12.121:2882", leader_epoch:464, is_sync_enabled:true, allow_vote:true, allow_vote_persisted:true, pending_end_lsn:{lsn:18446744073709551615}, scan_disk_log_finished:true, last_check_start_id:249221738, is_changing_config_with_arb:false, reconfirm_start_time_us:-1, palf_role_change_cb:0x7f8e2194b2f0, allow_vote:true}, [ConfigMgr]={palf_id:1, self:"172.16.12.70:2882", alive_paxos_memberlist:3{server:"172.16.12.70:2882", timestamp:1763865493137324, flag:0}{server:"172.16.12.121:2882", timestamp:1, flag:0}{server:"172.16.12.122:2882", timestamp:1, flag:0}, alive_paxos_replica_num:3, log_ms_meta:{version:3, proposal_id:19, prev:{version:1, config:{config_version:{proposal_id:18, config_seq:20}, log_sync_memberlist:3{server:"172.16.12.70:2882", timestamp:1763865493137324, flag:0}{server:"172.16.12.121:2882", timestamp:1, flag:0}{server:"172.16.12.122:2882", timestamp:1, flag:0}, log_sync_replica_num:3, arbitration_member:{server:"0.0.0.0:0", timestamp:-1, flag:0}, learnerlist:{learner_num:0, learner_array:[]}, degraded_learnerlist:{learner_num:0, learner_array:[]}}, lock_meta:{version:1, lock_type:0, lock_owner:-1, lock_time:-1}}, curr:{version:1, config:{config_version:{proposal_id:19, config_seq:21}, log_sync_memberlist:3{server:"172.16.12.70:2882", timestamp:1763865493137324, flag:0}{server:"172.16.12.121:2882", timestamp:1, flag:0}{server:"172.16.12.122:2882", timestamp:1, flag:0}, log_sync_replica_num:3, arbitration_member:{server:"0.0.0.0:0", timestamp:-1, flag:0}, learnerlist:{learner_num:0, learner_array:[]}, degraded_learnerlist:{learner_num:0, learner_array:[]}}, lock_meta:{version:1, lock_type:0, lock_owner:-1, lock_time:-1}}, prev_log_proposal_id:18, prev_lsn:{lsn:126862483138}, prev_mode_pid:19}, running_args:{server:{server:"0.0.0.0:0", timestamp:-1, flag:0}, curr_member_list:0, curr_replica_num:0, new_replica_num:0, config_version:{proposal_id:9223372036854775807, config_seq:-1}, ref_scn:{val:18446744073709551615, v:3}, lock_owner:-1, lock_type:0, added_list:0, removed_list:0, type:"Invalid"}, state:0, checking_barrier:{prev_log_proposal_id:9223372036854775807, prev_lsn:{lsn:0}, prev_end_lsn:{lsn:0}, prev_mode_pid:9223372036854775807}, reconfig_barrier:{prev_log_proposal_id:9223372036854775807, prev_lsn:{lsn:0}, prev_end_lsn:{lsn:0}, prev_mode_pid:9223372036854775807}, persistent_config_version:{proposal_id:19, config_seq:21}, ms_ack_list:0, resend_config_version:{proposal_id:9223372036854775807, config_seq:-1}, resend_log_list:{learner_num:0, learner_array:[]}, last_submit_config_log_time_us:-1, need_change_config_bkgd:false, bkgd_config_version:{proposal_id:9223372036854775807, config_seq:-1}, region:"OCP_META_REGION", register_time_us:1767875343667947, parent:"0.0.0.0:0", parent_keepalive_time_us:-1, last_submit_register_req_time_us:1767875343667947, children:{learner_num:0, learner_array:[]}, last_submit_keepalive_time_us:-1, this:0x7f8e21941c70}, [ModeMgr]={palf_id:1, self:"172.16.12.70:2882", applied_mode_meta:{version:1, proposal_id:19, mode_version:0, access_mode:1, ref_scn:{val:1, v:0}}, accepted_mode_meta:{version:1, proposal_id:19, mode_version:0, access_mode:1, ref_scn:{val:1, v:0}}, last_submit_mode_meta:{version:1, proposal_id:19, mode_version:0, access_mode:1, ref_scn:{val:1, v:0}}, state:"MODE_INIT", new_proposal_id:9223372036854775807, local_max_lsn:{lsn:18446744073709551615}, local_max_log_pid:9223372036854775807, max_majority_accepted_pid:9223372036854775807, max_majority_lsn:{lsn:18446744073709551615}, max_majority_accepted_mode_meta:{version:-1, proposal_id:9223372036854775807, mode_version:9223372036854775807, access_mode:0, ref_scn:{val:18446744073709551615, v:3}}, follower_list:0, ack_list:0, majority_cnt:9223372036854775807, last_submit_req_ts:-1, resend_mode_meta_list:{learner_num:0, learner_array:[]}}, [LogEngine]={palf_id:1, is_inited:true, min_block_max_scn:{val:18446744073709551615, v:3}, min_block_id:2452, min_block_min_scn:{val:1767744469409842001, v:0}, base_lsn_for_block_gc:{lsn:165815881728}, log_meta:{version:1, log_prepare_meta:{version:1, voted_for:"0.0.0.0:0", log_proposal_id:19}, log_config_meta:{version:3, proposal_id:19, prev:{version:1, config:{config_version:{proposal_id:18, config_seq:20}, log_sync_memberlist:3{server:"172.16.12.70:2882", timestamp:1763865493137324, flag:0}{server:"172.16.12.121:2882", timestamp:1, flag:0}{server:"172.16.12.122:2882", timestamp:1, flag:0}, log_sync_replica_num:3, arbitration_member:{server:"0.0.0.0:0", timestamp:-1, flag:0}, learnerlist:{learner_num:0, learner_array:[]}, degraded_learnerlist:{learner_num:0, learner_array:[]}}, lock_meta:{version:1, lock_type:0, lock_owner:-1, lock_time:-1}}, curr:{version:1, config:{config_version:{proposal_id:19, config_seq:21}, log_sync_memberlist:3{server:"172.16.12.70:2882", timestamp:1763865493137324, flag:0}{server:"172.16.12.121:2882", timestamp:1, flag:0}{server:"172.16.12.122:2882", timestamp:1, flag:0}, log_sync_replica_num:3, arbitration_member:{server:"0.0.0.0:0", timestamp:-1, flag:0}, learnerlist:{learner_num:0, learner_array:[]}, degraded_learnerlist:{learner_num:0, learner_array:[]}}, lock_meta:{version:1, lock_type:0, lock_owner:-1, lock_time:-1}}, prev_log_proposal_id:18, prev_lsn:{lsn:126862483138}, prev_mode_pid:19}, log_snapshot_meta:{version:2, base_lsn:{lsn:165815881728}, prev_log_info:{log_id:181509129, lsn:{lsn:120721473006}, scn:{val:1763833962285185000, v:0}, log_proposal_id:4, accum_checksum:3838643870}, prev_log_tail_lsn:{lsn:120721477632}}, log_replica_property_meta:{allow_vote:true, replica_type:"NORMAL_REPLICA"}, log_mode_meta:{version:1, proposal_id:19, mode_version:0, access_mode:1, ref_scn:{val:1, v:0}}}, log_meta_storage:{log_tail:{lsn:798720}, readable_log_tail:{lsn:798720}, log_block_header:{magic:18754, version:1, min_lsn:{lsn:166017196032}, min_scn:{val:0, v:0}, curr_block_id:0, palf_id:1}, block_mgr:{log_dir:"/home/admin/ysdb/oceanbase/store/clog/tenant_1043/1/meta", dir_fd:1164, min_block_id:0, max_block_id:1, curr_writable_block_id:0}, logical_block_size_:67104768, curr_block_writable_size_:66306048, block_header_serialize_buf_:0x7f8e21946a38, flashback_version:0}, log_storage:{log_tail:{lsn:165987707330}, readable_log_tail:{lsn:165987707330}, log_block_header:{magic:18754, version:1, min_lsn:{lsn:18446744073709551615}, min_scn:{val:18446744073709551615, v:3}, curr_block_id:2473, palf_id:1}, block_mgr:{log_dir:"/home/admin/ysdb/oceanbase/store/clog/tenant_1043/1/log", dir_fd:1200, min_block_id:2452, max_block_id:2474, curr_writable_block_id:2473}, logical_block_size_:67104768, curr_block_writable_size_:29488702, block_header_serialize_buf_:0x7f8e21948738, flashback_version:0}, palf_epoch:1, last_purge_throttling_ts:-1, this:0x7f8e21944f70}, [Reconfirm]={palf_id:1, self:"172.16.12.70:2882", state:"INITED", new_proposal_id:9223372036854775807, prepare_log_ack_list:0, curr_paxos_follower_list:0, majority_cnt:0, majority_max_log_server:"0.0.0.0:0", majority_max_accept_pid:9223372036854775807, majority_max_lsn:{lsn:18446744073709551615}, saved_end_lsn:{lsn:18446744073709551615}, last_submit_prepare_req_time_us:-1, last_fetch_log_time_us:-1, last_record_sw_start_id:-1, last_notify_fetch_time_us:-1, last_purge_throttling_time_us:-1, this:0x7f8e219449b0}) [2026-01-08 20:29:04.768885] WDIAG [PALF] get_ack_info_array (log_sliding_window.cpp:2773) [1912858][T1043_LogLoop][T1043][Y0-0000000000000000-0-0] [lt=401][errcode=-4018] match_lsn_map_ get failed(ret=-4018, palf_id=1, self="172.16.12.70:2882", tmp_server={server:"172.16.12.70:2882", timestamp:1763865493137324, flag:0}) [2026-01-08 20:29:04.768912] INFO [PALF] check_and_switch_state (palf_handle_impl.cpp:2751) [1912858][T1043_LogLoop][T1043][Y0-0000000000000000-0-0] [lt=33] [PALF_DUMP](palf_id=1, self="172.16.12.70:2882", ack_info_list=[]) [2026-01-08 20:29:04.768931] WDIAG [PALF] get_ack_info_array (log_sliding_window.cpp:2773) [1912858][T1043_LogLoop][T1043][Y0-0000000000000000-0-0] [lt=23][errcode=-4018] match_lsn_map_ get failed(ret=-4018, palf_id=1, self="172.16.12.70:2882", tmp_server={server:"172.16.12.70:2882", timestamp:1763865493137324, flag:0}) -- [2026-01-08 20:29:04.846898] INFO pktc_sk_flush (handle_io.t.h:36) [1907435][pnio1][T0][Y0-0000000000000000-0-0] [lt=2] PNIO do_flush fail: 9 [2026-01-08 20:29:04.846909] INFO pktc_sk_delete (pktc_sk_factory.h:85) [1907430][pnio1][T0][Y0-0000000000000000-0-0] [lt=0] PNIO sk_destroy: s=0x7f8ec77fca98 io=0x7f8f6c784688 [2026-01-08 20:29:04.846916] INFO pktc_resp_cb_on_sk_destroy (pktc_resp.h:43) [1907430][pnio1][T0][Y0-0000000000000000-0-0] [lt=8] PNIO resp_cb on sk_destroy: packet_id=850689 s=0x7f8ec77fca98 [2026-01-08 20:29:04.846908] WDIAG [SQL.EXE] task_execute_v2 (ob_executor_rpc_impl.cpp:143) [1907592][MetaLocAsyncUp0][T1][YB42AC100C46-000647DF6A27401A-0-0] [lt=33][errcode=-4121] rpc task_execute fail(ret=-4121, tenant_id=1, svr="172.16.12.121:2882", timeout=992911, timeout_timestamp=1767875345839604) [2026-01-08 20:29:04.846919] INFO eloop_handle_sock_event (eloop.c:112) [1907435][pnio1][T0][Y0-0000000000000000-0-0] [lt=19] PNIO sock destroy: sock=0x7f8ec77fd4e8, connection=fd:1042:local:"0.0.0.0:0":remote:"0.0.0.0:0", err=9 [2026-01-08 20:29:04.846929] WDIAG [SQL.EXE] execute_with_sql (ob_remote_scheduler.cpp:253) [1907592][MetaLocAsyncUp0][T1][YB42AC100C46-000647DF6A27401A-0-0] [lt=26][errcode=-4121] task execute failed(ret=-4121) [2026-01-08 20:29:04.846866] INFO [SHARE.LOCATION] batch_update_caches_ (ob_ls_location_service.cpp:962) [1907591][SysLocAsyncUp0][T0][YB42AC100C46-000647DF6946E999-0-0] [lt=21] [LS_LOCATION]ls location cache has changed(ret=0, ret="OB_SUCCESS", old_location={cache_key:{tenant_id:1, ls_id:{id:1}, cluster_id:1743060883}, renew_time:1767875343586029, replica_locations:[{server:"172.16.12.121:2882", role:1, sql_port:2881, replica_type:0, property:{memstore_percent_:100}, restore_status:{status:0}, proposal_id:2}]}, new_location={cache_key:{tenant_id:1, ls_id:{id:1}, cluster_id:1743060883}, renew_time:1767875344846866, replica_locations:[]}) [2026-01-08 20:29:04.846935] INFO pktc_sk_delete (pktc_sk_factory.h:85) [1907435][pnio1][T0][Y0-0000000000000000-0-0] [lt=0] PNIO sk_destroy: s=0x7f8ec77fd4e8 io=0x7f8f6bd84688 [2026-01-08 20:29:04.846938] WDIAG [SQL.EXE] schedule (ob_remote_scheduler.cpp:53) [1907592][MetaLocAsyncUp0][T1][YB42AC100C46-000647DF6A27401A-0-0] [lt=11][errcode=-4121] execute with sql failed(ret=-4121) [2026-01-08 20:29:04.846947] INFO pktc_resp_cb_on_sk_destroy (pktc_resp.h:43) [1907435][pnio1][T0][Y0-0000000000000000-0-0] [lt=15] PNIO resp_cb on sk_destroy: packet_id=850691 s=0x7f8ec77fd4e8 [2026-01-08 20:29:04.846950] WDIAG [SQL] do_open_plan (ob_result_set.cpp:640) [1907592][MetaLocAsyncUp0][T1][YB42AC100C46-000647DF6A27401A-0-0] [lt=15][errcode=-4121] fail execute plan(ret=-4121) [2026-01-08 20:29:04.846945] WDIAG [SHARE.LOCATION] renew_location_ (ob_ls_location_service.cpp:1026) [1907591][SysLocAsyncUp0][T0][YB42AC100C46-000647DF6946E999-0-0] [lt=101][errcode=-4721] get empty location from meta table(ret=-4721, ret="OB_LS_LOCATION_NOT_EXIST", location={cache_key:{tenant_id:0, ls_id:{id:-1}, cluster_id:-1}, renew_time:0, replica_locations:[]}) [2026-01-08 20:29:04.846959] WDIAG [SQL] open (ob_result_set.cpp:164) [1907592][MetaLocAsyncUp0][T1][YB42AC100C46-000647DF6A27401A-0-0] [lt=11][errcode=-4121] execute plan failed(ret=-4121) [2026-01-08 20:29:04.846966] WDIAG [SHARE.LOCATION] batch_process_tasks (ob_ls_location_service.cpp:562) [1907591][SysLocAsyncUp0][T0][YB42AC100C46-000647DF6946E999-0-0] [lt=26][errcode=-4721] fail to renew location(ret=-4721, ret="OB_LS_LOCATION_NOT_EXIST", task={cluster_id:1743060883, tenant_id:1, ls_id:{id:1}, renew_for_tenant:false, add_timestamp:1767875344842002}) [2026-01-08 20:29:04.846974] INFO [SHARE.LOCATION] batch_renew_tablet_locations (ob_location_service.cpp:442) [1907592][MetaLocAsyncUp0][T1][YB42AC100C46-000647DF6A27401A-0-0] [lt=10] [TABLET_LOCATION] batch renew tablet locations finished(ret=0, ret="OB_SUCCESS", tenant_id=1, renew_type=0, is_nonblock=true, tablet_list=[{id:342}], ls_ids=[], error_code=-4121) [2026-01-08 20:29:04.846985] WDIAG [SERVER] batch_process_tasks (ob_uniq_task_queue.h:601) [1907591][SysLocAsyncUp0][T0][YB42AC100C46-000647DF6946E999-0-0] [lt=24][errcode=-4721] fail to batch process task(ret=-4721) [2026-01-08 20:29:04.846994] WDIAG [SERVER] open (ob_inner_sql_result.cpp:155) [1907592][MetaLocAsyncUp0][T1][YB42AC100C46-000647DF6A27401A-0-0] [lt=23][errcode=-4121] open result set failed(ret=-4121) [2026-01-08 20:29:04.846996] WDIAG [SERVER] run1 (ob_uniq_task_queue.h:501) [1907591][SysLocAsyncUp0][T0][YB42AC100C46-000647DF6946E999-0-0] [lt=14][errcode=-4721] fail to batch execute task(ret=-4721, tasks.count()=1) [2026-01-08 20:29:04.847003] WDIAG [SERVER] do_query (ob_inner_sql_connection.cpp:799) [1907592][MetaLocAsyncUp0][T1][YB42AC100C46-000647DF6A27401A-0-0] [lt=10][errcode=-4121] result set open failed(ret=-4121, executor={ObIExecutor:, sql:"SELECT * FROM __all_ls_meta_table WHERE tenant_id = 1041 ORDER BY tenant_id, ls_id, svr_ip, svr_port"}) [2026-01-08 20:29:04.847015] WDIAG [SERVER] query (ob_inner_sql_connection.cpp:944) [1907592][MetaLocAsyncUp0][T1][YB42AC100C46-000647DF6A27401A-0-0] [lt=15][errcode=-4121] execute failed(ret=-4121, tenant_id=1, executor={ObIExecutor:, sql:"SELECT * FROM __all_ls_meta_table WHERE tenant_id = 1041 ORDER BY tenant_id, ls_id, svr_ip, svr_port"}, retry_cnt=0, local_sys_schema_version=1767836179527672, local_tenant_schema_version=1767836179527672) CRASH ERROR!!! IP=7f801b7e09ea, RBP=7f8e2d7c5a90, sig=4, sig_code=2, sig_addr=0x7f801b7e09ea, RLIMIT_CORE=unlimited, timestamp=1767875344841373, tid=1912731, tname=T1042_L0_G0, trace_id=YB42AC100C46-000647DFE6A76713-0-0, lbt=0x1f96b218 0x1f1b698d 0x7f900a3e741f 0x7f801b7e09ea 0xea882f7 0xea74cea 0x14a77faa 0x11bba464 0x7c4fe26 0x7923e9c 0x792151d 0x7cc475e 0x78c853e 0x78b88e3 0x78b1adf 0x78aefec 0x789e118 0xfc77118 0x1f95655d 0x7f900a3db608 0x7f900a2fe352, SQL_ID=, SQL_STRING=call check_daily [2026-01-08 20:29:04.847021] WDIAG [STORAGE] get_ls (ob_ls_service.cpp:977) [1907591][SysLocAsyncUp0][T1][YB42AC100C46-000647DF6946E99A-0-0] [lt=13][errcode=-4719] get log stream fail(ret=-4719, ls_id={id:1}) [2026-01-08 20:29:04.847029] WDIAG [SERVER] after_func (ob_query_retry_ctrl.cpp:1066) [1907592][MetaLocAsyncUp0][T1][YB42AC100C46-000647DF6A27401A-0-0] [lt=18][errcode=-4121] [RETRY] check if need retry(v={force_local_retry:true, stmt_retry_times:0, local_retry_times:0, err_:-4121, err_:"OB_RPC_SEND_ERROR", retry_type:0, client_ret:-4121}, need_retry=false) [2026-01-08 20:29:04.847056] WDIAG [SERVER] inner_close (ob_inner_sql_result.cpp:220) [1907592][MetaLocAsyncUp0][T1][YB42AC100C46-000647DF6A27401A-0-0] [lt=30][errcode=-4121] result set close failed(ret=-4121) [2026-01-08 20:29:04.847068] WDIAG [SERVER] force_close (ob_inner_sql_result.cpp:200) [1907592][MetaLocAsyncUp0][T1][YB42AC100C46-000647DF6A27401A-0-0] [lt=14][errcode=-4121] result set close failed(ret=-4121) [2026-01-08 20:29:04.847077] WDIAG [SERVER] query (ob_inner_sql_connection.cpp:949) [1907592][MetaLocAsyncUp0][T1][YB42AC100C46-000647DF6A27401A-0-0] [lt=13][errcode=-4121] failed to close result(close_ret=-4121, ret=-4121) [2026-01-08 20:29:04.847099] WDIAG [SERVER] query (ob_inner_sql_connection.cpp:979) [1907592][MetaLocAsyncUp0][T1][YB42AC100C46-000647DF6A27401A-0-0] [lt=20][errcode=-4121] failed to process record(executor={ObIExecutor:, sql:"SELECT * FROM __all_ls_meta_table WHERE tenant_id = 1041 ORDER BY tenant_id, ls_id, svr_ip, svr_port"}, record_ret=-4121, ret=-4121) [2026-01-08 20:29:04.847091] WDIAG pktc_sk_consume (handle_io.t.h:57) [1907450][pnio1][T0][Y0-0000000000000000-0-0] [lt=7][errcode=0] REACH SYSLOG RATE LIMIT [bandwidth] [2026-01-08 20:29:04.847120] INFO pktc_sk_flush (handle_io.t.h:36) [1907450][pnio1][T0][Y0-0000000000000000-0-0] [lt=37] PNIO do_flush fail: 9 [2026-01-08 20:29:04.847120] WDIAG [SERVER] query (ob_inner_sql_connection.cpp:1016) [1907592][MetaLocAsyncUp0][T0][YB42AC100C46-000647DF6A27401A-0-0] [lt=26][errcode=-4121] failed to process final(executor={ObIExecutor:, sql:"SELECT * FROM __all_ls_meta_table WHERE tenant_id = 1041 ORDER BY tenant_id, ls_id, svr_ip, svr_port"}, aret=-4121, ret=-4121) [2026-01-08 20:29:04.847134] INFO eloop_handle_sock_event (eloop.c:112) [1907450][pnio1][T0][Y0-0000000000000000-0-0] [lt=13] PNIO sock destroy: sock=0x7f8efbf18a98, connection=fd:952:local:"0.0.0.0:0":remote:"0.0.0.0:0", err=9