ODPのパフォーマンスボトルネック

[2022-07-11 14:32:51.758195] WARN  [PROXY.SM] update_cmd_stats (ob_mysql_sm.cpp:8425) [74744][Y0-7F4B1CEA13A0] [lt=7] [dc=0] Slow Query: ((
client_ip={127.0.0.1:50422},   // SQLを送信するクライアントのアドレス
server_ip={xx.xx.xx.xx:33041}, // SQLがルーティングされるターゲットOBServer
obproxy_client_port={xx.xx.xx.xx:52052},  // OBServerに接続するローカルアドレス
server_trace_id=Y81100B7C0535-0005E3460FBBE3CD-0-0, // ターゲットOBServer内での実行プロセス中のtrace id
route_type=ROUTE_TYPE_NONPARTITION_UNMERGE_LOCAL, // SQLが使用するルーティングポリシー
user_name=root,         // ユーザー名
tenant_name=sys,        // テナント名
cluster_name=ob9988.zhixin.lm.100.xx.xx.xx,  // クラスタ名
logic_database_name=,  // ロジックデータベース名
logic_tenant_name=,    // ロジックテナント名
ob_proxy_protocol=0,   // プロトコルタイプ
cs_id=14,         // client login時に表示されるconnection id、proxyが割り当てる
proxy_sessid=7230691598940700681, // clientがOBServerにアクセスする際の内部記録connection id
ss_id=21,
server_sessid=3221588238, // SQLがターゲットOBServer内のconnection id、OBServerが割り当てる
sm_id=14,
cmd_size_stats={
    client_request_bytes:20,  // clientがproxyに送信するリクエストパケットのサイズ
    server_request_bytes:38,  // ODPがターゲットOBServerに送信するリクエストパケットのサイズ
    server_response_bytes:0, // ターゲットOBServerがproxyに送信する応答パケットのサイズ
    client_response_bytes:71}, // ODPがclientに送信する応答パケットのサイズ
cmd_time_stats={
    client_transaction_idle_time_us=0, // トランザクション内でこのSQLと前のSQLの実行終了間の間隔時間、すなわちclientトランザクション間隔時間
    client_request_read_time_us=97, // ODPがclientソケットからリクエストパケットを読み取る時間消費
    client_request_analyze_time_us=95, // ODPがclientのSQLを分析する時間消費
    cluster_resource_create_time_us=0, // ODPがクラスタリソースを作成する時間消費（クラスタへの初回アクセス時のみ必要）
    pl_lookup_time_us=0, // SQLに基づいてルーティングテーブルに関連する時間消費
    pl_process_time_us=0, // ルーティングテーブルに関連するものをフィルタリング・ソートする時間消費
    congestion_control_time_us=21, // SQLに基づいてブラックリスト情報に関連する時間消費
    congestion_process_time_us=3, // ブラックリストに関連するものをチェック・フィルタリングする時間消費
    do_observer_open_time_us=55, // ターゲットOBServerから利用可能な接続を取得する時間消費、connect_timeを含む
        server_connect_time_us=0,  // ターゲットOBServerで接続を作成する時間消費
    server_sync_session_variable_time_us=0, // 選択したターゲット接続を初期化する時間消費、saved_login、db同期、システム変数同期、last_insert_id同期、start_trans同期を含む
        server_send_saved_login_time_us=0, // 選択したターゲット接続でsaved loginにかかる時間消費
        server_send_use_database_time_us=0, // 選択したターゲット接続でdb同期にかかる時間消費
        server_send_session_variable_time_us=0, // 選択したターゲット接続で変更されたシステム変数を同期する時間消費
        server_send_all_session_variable_time_us=0, // 選択したターゲット接続ですべてのシステムを同期する時間消費
        server_send_last_insert_id_time_us=0, // 選択したターゲット接続でlast_insert_idを同期する時間消費
        server_send_start_trans_time_us=0,   // 選択したターゲット接続でstart_trans/beginを同期する時間消費
    build_server_request_time_us=23,  // ターゲットserverに対するリクエストパケットを構築する時間消費
    plugin_compress_request_time_us=0,   // リクエストパケットを圧縮する時間消費
    prepare_send_request_to_server_time_us=409,  // ODPがクライアントリクエストを受信してからOBServerに転送して実行するまでの合計時間、通常は前述のすべての時間の合計であるはず
    server_request_write_time_us=32,  // ODPがターゲットserverソケットにリクエストパケットを送信する時間消費
    server_process_request_time_us=3039883,   // ターゲットserverがこのSQLを実行する時間消費
    server_response_read_time_us=67,   // ODPがターゲットserverソケットから応答パケットを読み取る時間消費
    plugin_decompress_response_time_us=59, // 応答パケットを解凍する時間消費
    server_response_analyze_time_us=70, // 応答パケットを分析する時間消費
    ok_packet_trim_time_us=0, // 応答パケットから最後のokパケットをトリムする時間消費
    client_response_write_time_us=185,  // ODPがclientソケットに応答パケットを送信する時間消費
    request_total_time_us=3041116},  // ODPがこのリクエストを処理する合計時間、前述のすべての時間消費の合計に等しい
sql=select sleep(3)   //clientのリクエストSQL
)