记一次 OB 自证清白之旅

SELECT usec_to_time(request_time) req_time, svr_ip, client_ip, user_client_ip, plan_id, ret_code,sql_id, query_sql, elapsed_time,execute_time,event
FROM oceanbase.gv$ob_sql_audit
WHERE query_sql LIKE '%bmsql_oorder%'
  AND request_time BETWEEN time_to_usec('2024-07-04 12:15:00') AND time_to_usec('2024-07-04 13:00:00')
ORDER BY request_time DESC LIMIT 100;
复制

[admin@server062 log]$ cat obproxy.log |grep cs_id |grep 1572971
[2024-07-05 06:31:49.365515] INFO  [PROXY.CS] ob_mysql_client_session.cpp:370 [36465][Y0-00007F2336567360] [lt=16] [dc=0] client session born(cs_id=1572971, proxy_sessid=0, is_local_connection=false, client_vc=0x7f233655fa80, client_fd=80, client_addr="10.0.0.65:21858")
[2024-07-05 06:31:49.365538] INFO  [PROXY.CS] ob_mysql_client_session.cpp:241 [36465][Y0-00007F2336567360] [lt=10] [dc=0] Starting new transaction using sm(cs_id=1572971, get_transact_count()=0, sm_id=296)
[2024-07-05 06:31:49.366539] INFO  [PROXY.SS] ob_mysql_server_session.cpp:106 [36465][Y0-00007F2336567360] [lt=6] [dc=0] server session born(ss_id=41, server_ip={10.0.0.62:2881}, cs_id=1572971, proxy_sessid=0, server_type=1)
[2024-07-05 06:31:49.366598] INFO  [PROXY.TXN] ob_mysql_transact.cpp:4736 [36465][Y0-00007F2336567360] [lt=13] [dc=0] succ to set proxy_sessid(cs_id=1572971, proxy_sessid=720576206856192010, server_ip={10.0.0.62:2881}, ss_id=41, server_sessid=3221697167, is_proxy_mysql_client=false, ss_fd=83, client_addr="10.0.0.65:21858")
[2024-07-05 06:33:21.121272] INFO  [PROXY.TXN] ob_mysql_transact.cpp:364 [36465][Y0-00007F2336567360] [lt=4] [dc=0] user first dml got(cs_id=1572971, sql=select * from bmsql_warehouse where w_name='O35Ysg8I5T')
[2024-07-05 06:33:23.704394] INFO  [PROXY.SS] ob_mysql_server_session.cpp:153 [36465][Y0-00007F2336567360] [lt=30] [dc=0] server session do_io_close((*this={ss_id:41, server_sessid:3221697167, server_ip:{10.0.0.62:2881}, is_inited:true, magic:19136237, state:1, server_vc:0x7f2332acdbd0, client_session:{this:0x7f2336f511c0, is_proxy_mysql_client:false, is_waiting_trans_first_request:false, need_delete_cluster:false, is_first_dml_sql_got:true, vc_ready_killed:false, active:true, magic:19132429, conn_decrease:true, current_tid:36465, cs_id:1572971, proxy_sessid:720576206856192010, session_info:{is_inited:true, priv_info:{has_all_privilege:false, cs_id:1572971, user_priv_set:133009965054, cluster_name:"OB4216", tenant_name:"obmysql", user_name:"root"}, version:{common_hot_sys_var_version:0, common_sys_var_version:0, mysql_hot_sys_var_version:0, mysql_sys_var_version:0, hot_sys_var_version:1, sys_var_version:9, user_var_version:1, db_name_version:1, last_insert_id_version:0, sess_info_version:2}, hash_version:{common_hot_sys_var_version:0, common_sys_var_version:0, mysql_hot_sys_var_version:0, mysql_sys_var_version:0, hot_sys_var_version:0, sys_var_version:0, user_var_version:0, db_name_version:0, last_insert_id_version:0, sess_info_version:0}, val_hash:{common_hot_sys_var_hash:0, common_cold_sys_var_hash:0, mysql_hot_sys_var_hash:0, mysql_cold_sys_var_hash:0, hot_sys_var_hash:0, cold_sys_var_hash:0, user_var_hash:0}, global_vars_version:0, is_global_vars_changed:false, is_trans_specified:false, is_user_idc_name_set:false, is_read_consistency_set:false, idc_name:"", cluster_id:0, real_meta_cluster_name:"", safe_read_snapshot:1, syncing_safe_read_snapshot:0, route_policy:1, proxy_route_policy:3, user_identity:0, global_vars_version:0, is_read_only_user:false, is_request_follower_user:false, obproxy_force_parallel_query_dop:1, ob20_request:{remain_payload_len:0, ob20_request_received_done:false, ob20_header:{ob 20 protocol header:{compressed_len:0, seq:0, non_compressed_len:0}, magic_num:0, header_checksum:0, connection_id:0, request_id:0, pkt_seq:0, payload_len:0, version:0, flag_.flags:0, reserved:0}}, client_cap:0, server_cap:916303, last_server_addr:{*Not IP address [0]*:0}, last_server_sess_id:0, init_sql:""}, dummy_ldc:{use_ldc:false, idc_name:"", item_count:2, site_start_index_array:[[0]0, [1]2, [2]2, [3]2], item_array:[[0]{idc_type:"SAME_IDC", zone_type:"ReadWrite", replica:{server:"10.0.0.63:2881", is_dup_replica:false, role:"FOLLOWER", type:"FULL"}, is_merging:false, is_partition_server:false, is_force_congested:false, is_used:true}, [1]{idc_type:"SAME_IDC", zone_type:"ReadWrite", replica:{server:"10.0.0.62:2881", is_dup_replica:false, role:"FOLLOWER", type:"FULL"}, is_merging:false, is_partition_server:false, is_force_congested:false, is_used:true}], pl:null, ts:0x7f23357a6d00, readonly_exist_status:"READONLY_ZONE_NOT_EXIST"}, dummy_entry:0x7f23391258b0, server_state_version:2, cur_ss:0x7f2332670d70, bound_ss:null, lii_ss:null, cluster_resource:{this:0x7f2335949080, ref_count:26, is_inited:true, cluster_info_key:{cluster_name:{config_string:"OB4216"}, cluster_id:0}, cr_state:"CR_AVAIL", version:2, last_access_time_ns:1720132403703664351, deleting_completed_thread_num:0, fetch_rslist_task_count:0, fetch_idc_list_task_count:0, last_idc_list_refresh_time_ns:1720132157657606744, last_rslist_refresh_time_ns:1720132157638986140, server_state_version:2}, client_vc:0x7f233655fa80, using_ldg:false, trace_stats:NULL}, transact_count:5, server_trans_stat:1, session_info:{cap:916303, ob_server:, version:{common_hot_sys_var_version:0, common_sys_var_version:0, mysql_hot_sys_var_version:0, mysql_sys_var_version:0, hot_sys_var_version:1, sys_var_version:9, user_var_version:1, db_name_version:1, last_insert_id_version:0, sess_info_version:2}, val_hash:{common_hot_sys_var_hash:0, common_cold_sys_var_hash:0, mysql_hot_sys_var_hash:0, mysql_cold_sys_var_hash:0, hot_sys_var_hash:0, cold_sys_var_hash:0, user_var_hash:0}, checksum_switch:1, server_type:1}}, server_vc_=0x7f2332acdbd0, this=0x7f2332670d70)
[2024-07-05 06:33:23.704600] INFO  [PROXY.SS] ob_mysql_server_session.cpp:190 [36465][Y0-00007F2336567360] [lt=200] [dc=0] server session is closing(ss_id=41, server_sessid=3221697167, server_ip={10.0.0.62:2881}, cs_id=1572971, proxy_sessid=720576206856192010)
[2024-07-05 06:33:23.704622] INFO  [PROXY.TXN] ob_mysql_transact.cpp:5781 [36465][Y0-00007F2336567360] [lt=6] [dc=0] [ObMysqlTransact::handle_server_connection_break](client_ip={10.0.0.65:21858}, server_ip={10.0.0.62:2881}, cs_id=1572971, proxy_sessid=720576206856192010, ss_id=0, server_sessid=0, sm_id=296, proxy_user_name=root@obmysql#OB4216, database_name=tpccdb, server_state="INTERNAL_ERROR", request_cmd="Quit", sql_cmd="Quit", sql=)
[2024-07-05 06:33:23.704642] INFO  [PROXY.SS] ob_mysql_client_session.cpp:652 [36465][Y0-00007F2336567360] [lt=4] [dc=0] client session do_io_close((*this={this:0x7f2336f511c0, is_proxy_mysql_client:false, is_waiting_trans_first_request:false, need_delete_cluster:false, is_first_dml_sql_got:true, vc_ready_killed:false, active:true, magic:19132429, conn_decrease:true, current_tid:36465, cs_id:1572971, proxy_sessid:720576206856192010, session_info:{is_inited:true, priv_info:{has_all_privilege:false, cs_id:1572971, user_priv_set:133009965054, cluster_name:"OB4216", tenant_name:"obmysql", user_name:"root"}, version:{common_hot_sys_var_version:0, common_sys_var_version:0, mysql_hot_sys_var_version:0, mysql_sys_var_version:0, hot_sys_var_version:1, sys_var_version:9, user_var_version:1, db_name_version:1, last_insert_id_version:0, sess_info_version:2}, hash_version:{common_hot_sys_var_version:0, common_sys_var_version:0, mysql_hot_sys_var_version:0, mysql_sys_var_version:0, hot_sys_var_version:0, sys_var_version:0, user_var_version:0, db_name_version:0, last_insert_id_version:0, sess_info_version:0}, val_hash:{common_hot_sys_var_hash:0, common_cold_sys_var_hash:0, mysql_hot_sys_var_hash:0, mysql_cold_sys_var_hash:0, hot_sys_var_hash:0, cold_sys_var_hash:0, user_var_hash:0}, global_vars_version:0, is_global_vars_changed:false, is_trans_specified:false, is_user_idc_name_set:false, is_read_consistency_set:false, idc_name:"", cluster_id:0, real_meta_cluster_name:"", safe_read_snapshot:1, syncing_safe_read_snapshot:0, route_policy:1, proxy_route_policy:3, user_identity:0, global_vars_version:0, is_read_only_user:false, is_request_follower_user:false, obproxy_force_parallel_query_dop:1, ob20_request:{remain_payload_len:0, ob20_request_received_done:false, ob20_header:{ob 20 protocol header:{compressed_len:0, seq:0, non_compressed_len:0}, magic_num:0, header_checksum:0, connection_id:0, request_id:0, pkt_seq:0, payload_len:0, version:0, flag_.flags:0, reserved:0}}, client_cap:0, server_cap:916303, last_server_addr:{*Not IP address [0]*:0}, last_server_sess_id:0, init_sql:""}, dummy_ldc:{use_ldc:false, idc_name:"", item_count:2, site_start_index_array:[[0]0, [1]2, [2]2, [3]2], item_array:[[0]{idc_type:"SAME_IDC", zone_type:"ReadWrite", replica:{server:"10.0.0.63:2881", is_dup_replica:false, role:"FOLLOWER", type:"FULL"}, is_merging:false, is_partition_server:false, is_force_congested:false, is_used:true}, [1]{idc_type:"SAME_IDC", zone_type:"ReadWrite", replica:{server:"10.0.0.62:2881", is_dup_replica:false, role:"FOLLOWER", type:"FULL"}, is_merging:false, is_partition_server:false, is_force_congested:false, is_used:true}], pl:null, ts:0x7f23357a6d00, readonly_exist_status:"READONLY_ZONE_NOT_EXIST"}, dummy_entry:0x7f23391258b0, server_state_version:2, cur_ss:null, bound_ss:null, lii_ss:null, cluster_resource:{this:0x7f2335949080, ref_count:26, is_inited:true, cluster_info_key:{cluster_name:{config_string:"OB4216"}, cluster_id:0}, cr_state:"CR_AVAIL", version:2, last_access_time_ns:1720132403703664351, deleting_completed_thread_num:0, fetch_rslist_task_count:0, fetch_idc_list_task_count:0, last_idc_list_refresh_time_ns:1720132157657606744, last_rslist_refresh_time_ns:1720132157638986140, server_state_version:2}, client_vc:0x7f233655fa80, using_ldg:false, trace_stats:NULL}, client_vc_=0x7f233655fa80, this=0x7f2336f511c0)
[2024-07-05 06:33:23.704742] INFO  [PROXY.CS] ob_mysql_client_session.cpp:94 [36465][Y0-00007F2336567360] [lt=56] [dc=0] client session destroy(cs_id=1572971, proxy_sessid=720576206856192010, client_vc=NULL)
复制