TiDBダッシュボードメトリクス関係グラフ

TiDB ダッシュボードメトリック関係グラフは、v4.0.7 で導入された機能です。この機能は、TiDB クラスター内の各内部プロセスの期間の監視データの関係グラフを表示します。目的は、各プロセスの期間とそれらの関係をすばやく理解できるようにすることです。

アクセスグラフ

TiDB ダッシュボードにログイン後、左側のナビゲーションメニューで[クラスタ診断]をクリックすると、メトリック関係グラフを生成するページが表示されます。

Metrics relation graph homepage

範囲開始時間と範囲期間を設定した後、 「メトリック関係の生成」をクリックすると、メトリック関係グラフのページが表示されます。

グラフを理解する

次の画像は、メトリック関係グラフの例です。このグラフは、2020-07-29 16:36:00 から 5 分以内の TiDB クラスターでの各監視メトリックの期間と合計クエリ期間の割合を示しています。グラフには、各監視メトリックの関係も示されています。

Metrics relation graph example

たとえば、監視メトリックtidb_executeのノードの意味は次のとおりです。

tidb_execute監視メトリックの合計期間は 19306.46 秒で、これはクエリの合計期間の 89.4% を占めます。
tidb_executeノード自体の継続時間は 9070.18 秒で、これはクエリ全体の継続時間の 42% を占めます。
ボックス領域の上にマウスを置くと、合計期間、平均期間、平均 P99 (99 パーセンタイル) 期間など、メトリックの詳細情報が表示されます。

tidb_execute node example

ノード情報

各ボックス領域は監視メトリックを表し、次の情報を提供します。

監視メトリックの名前
監視メトリックの合計期間
メトリックの合計期間とクエリの合計期間の割合

メトリックノードの合計期間=メトリックノード自体の期間+その子ノードの期間。したがって、一部のノードのメトリックグラフには、 tidb_executeのグラフのように、ノード自体の期間と合計期間の比率が表示されます。

tidb_execute node example1

tidb_execute監視メトリックの名前であり、TiDB 実行エンジンでの SQL クエリの実行期間を表します。
19306.46s 、メトリックtidb_executeの合計実行時間が 19306.46 秒であることを表します。 89.40% 、19306.46 秒がすべての SQL クエリ (ユーザー SQL クエリと TiDB の内部 SQL クエリを含む) に費やされた合計時間の 89.40% を占めることを表します。クエリの合計実行時間は、 tidb_queryの合計実行時間です。
9070.18s 、 tidb_executeノード自体の合計実行時間が 9070.18 秒であり、残りがその子ノードによって消費された時間であることを表します。4 42.00% 9070.18 秒がすべてのクエリの合計クエリ時間の 42.00% を占めることを表します。

ボックス領域の上にマウスを置くと、 tidb_executeメトリックノードの詳細が表示されます。

tidb_execute node example2

上記の画像に表示されているテキスト情報は、メトリックノードの説明であり、合計期間、合計時間、平均期間、平均期間 P99、P90、P80 が含まれます。

ノード間の親子関係

このセクションでは、 tidb_executeメトリックノードを例に、メトリックの子ノードについて説明します。

tidb_execute node relation example1

上のグラフから、 tidb_executeの 2 つの子ノードがわかります。

pd_start_tso_wait : トランザクションのstart_tsoを待機する合計時間、つまり 300.66 秒。
tidb_txn_cmd : TiDB が関連するトランザクションコマンドを実行する合計時間。9935.62 秒です。

さらに、 tidb_executeはtidb_copボックス領域を指す点線の矢印もあり、次のことを示しています。

tidb_executeにはtidb_copメトリックの期間が含まれますが、 copリクエストが同時に実行される可能性があります。たとえば、2 つのテーブルでcop joinクエリを実行するexecute期間は 60 秒で、その間に結合した 2 つのテーブルでテーブルスキャンリクエストが同時に実行されます。10 リクエストの実行期間がそれぞれ 40 秒と 30 秒の場合、 copリクエストの合計期間は 70 秒です。ただし、 execute期間は 60 秒のみです。したがって、親ノードの期間に子ノードの期間が完全に含まれていない場合は、点線の矢印を使用して子ノードを指します。

注記：
ノードに子ノードを指す点線の矢印がある場合、このノード自体の継続時間は不正確です。たとえば、 tidb_executeノードでは、ノード自体の継続時間は 9070.18 秒 ( 9070.18 = 19306.46 - 300.66 - 9935.62 ) です。この式では、 tidb_cop子ノードの継続時間はtidb_executeの子ノードの継続時間に計算されません。しかし、実際にはそうではありませんtidb_execute自体の継続時間である 9070.18 秒には、 tidb_cop継続時間の一部が含まれており、この部分の継続時間は決定できません。

`tidb_kv_request`とその親ノード

tidb_execute node relation example2

tidb_kv_requestの親ノードであるtidb_copとtidb_txn_cmd.getは、どちらもtidb_kv_requestを指す点線の矢印があり、次のことを示しています。

tidb_copの持続時間にはtidb_kv_requestの持続時間の一部が含まれます。
tidb_txn_cmd.getの持続時間にはtidb_kv_requestの持続時間の一部も含まれます。

しかし、 tidb_kv_requestの持続時間がtidb_copにどれだけ含まれているかを判断するのは困難です。

tidb_kv_request.Get : TiDB がGet種類のキー値要求を送信する期間。
tidb_kv_request.Cop : TiDB がCop種類のキー値要求を送信する期間。

tidb_kv_request tidb_kv_request.Getとtidb_kv_request.Copノードを子ノードとして含みませんが、後者の 2 つのノードで構成されます。子ノードの名前プレフィックスは親ノードの名前に.xxxを加えたもので、子ノードが親ノードのサブクラスであることを意味します。このケースは次のように理解できます。

TiDB がキー値要求を送信する合計時間は 14745.07 秒で、そのうちGetおよびCopタイプのキー値要求にはそれぞれ 9798.02 秒と 4946.46 秒かかります。