AUTOREFRESHトレース

ttTraceMon ユーティリティを使用して、AUTOREFRESHキャッシュ・グループ属性を持つキャッシュ・グループの自動リフレッシュ操作の処理状況に関する情報を取得します。

『Oracle TimesTen In-Memory Databaseキャッシュ・ガイド』の「AUTOREFRESHキャッシュ・グループ属性の概要」を参照してください。

表2-7に、AUTOREFRESHトレース・レベルを示します。「+」サインの付いた各レベルには、該当するレベルで説明されているトレース情報に加え、該当レベルより上のすべてのレベルの情報も含まれます。

表2-7 AUTOREFRESHトレース・レベル

レベル 説明

1

その時間隔の自動リフレッシュのサマリー:

  • 自動リフレッシュが開始された時間

  • その時間隔で自動リフレッシュされた行数

  • その時間隔で自動リフレッシュされたルート表の行数

  • キャッシュ・エージェントの起動後に自動リフレッシュされた行の総数

  • キャッシュ・エージェントの起動後に自動リフレッシュされたルート表の行の総数

  • 自動リフレッシュが終了した時間

ノート: 時間およびルート表の行に関する情報は、完全自動リフレッシュの場合にレポートされます。

2

+ キャッシュ・グループ・レベルでの自動リフレッシュのサマリー:

  • 各キャッシュ・グループで自動リフレッシュが開始された時間

  • 各キャッシュ・グループで自動リフレッシュされた行数

  • 各キャッシュ・グループで自動リフレッシュされたルート表の行数

  • キャッシュ・エージェントの起動後に各キャッシュ・グループで自動リフレッシュされた行の総数

  • キャッシュ・エージェントの起動後に各キャッシュ・グループで自動リフレッシュされたルート表の行の総数

  • 各キャッシュ・グループで自動リフレッシュが終了した時間

ノート: 時間およびルート表の行に関する情報は、完全自動リフレッシュの場合にレポートされます。

3

+ 表レベルでの自動リフレッシュのサマリー:

  • 自動リフレッシュが開始された時間

  • 自動リフレッシュされた行数

  • キャッシュ・エージェントの起動後に自動リフレッシュされた行の総数

  • 自動リフレッシュが終了した時間

4

+ 各表の自動リフレッシュの詳細:

  • 各表で自動リフレッシュが開始された時間

  • 自動リフレッシュ問合せ

  • Oracle Databaseで問合せの実行にかかった時間(ミリ秒)

  • Oracle Databaseの問合せでフェッチにかかった時間(ミリ秒)

  • TimesTenで問合せの適用にかかった時間(ミリ秒)

  • Oracle Databaseで子表に対する問合せの実行にかかった時間(ミリ秒)

  • Oracle Databaseで子表に対する問合せでフェッチにかかった時間(ミリ秒)

  • TimesTenで子表に対する問合せの適用にかかった時間(ミリ秒)

  • 各表で自動リフレッシュが終了した時間

  • 自動リフレッシュの完了位置を示す自動リフレッシュ・ブックマーク(logseq)

この例では、ttTraceMonユーティリティを使用して、cgDSNデータベースの自動リフレッシュ操作をトレースします。トレース・レベルを1に設定すると、ttCacheAutorefreshStatsGet組込みプロシージャの出力に似た情報が表示されます。 

% tttracemon cgDSN
Trace monitor; empty line to exit
Trace> level autorefresh 1
Trace> dump

08:56:57.445 19398 AUTOREFRESH 1L 5C 32246P Autorefresh number 1415 started 
for interval 60000
08:56:57.883 19419 AUTOREFRESH 1L 5C 32246P Duration For Interval 60000ms: 420
08:56:57.883 19420 AUTOREFRESH 1L 5C 32246P Num Rows For Interval 60000ms: 0
08:56:57.883 19421 AUTOREFRESH 1L 5C 32246P Num Root Rows For Interval 
60000ms: 0
08:56:57.883 19422 AUTOREFRESH 1L 5C 32246P Cumulative Rows for Interval 
60000ms: 11587
08:56:57.883 19423 AUTOREFRESH 1L 5C 32246P Cumulative Root Rows for Interval 60000ms: 1697
08:56:57.883 19424 AUTOREFRESH 1L 5C 32246P Autorefresh number 1415 ended for 
interval 60000ms successfully.
7 records dumped

レベル4でトレースすると、自動リフレッシュ操作1415に関する追加情報が生成されます。testuser.readcacheキャッシュ・グループ、testuser.readtabルート表および自動リフレッシュ間隔に関する自動リフレッシュ情報が提供されます。 

Trace> level autorefresh 4
Trace> dump

08:56:57.445 19398 AUTOREFRESH 1L 5C 32246P Autorefresh number 1415 started for 
interval 60000
08:56:57.471 19399 AUTOREFRESH 2L 5C 32246P Autorefresh started for cachegroup 
TESTUSER.READCACHE
08:56:57.471 19400 AUTOREFRESH 3L 5C 32246P Incremental autorefresh started for 
table TESTUSER.READTAB
08:56:57.471 19401 AUTOREFRESH 4L 5C 32246P Autorefresh Query: SELECT L."COL_10", 
X."COL_20", X.ft$NotDelete, Z.rowid FROM (SELECT DISTINCT "COL_10" FROM 
"TESTUSER"."TT_06_454854_L" WHERE logseq >:logseq AND ft_cacheGroup <> 
100000000000*1844259679+-299200618) L,(SELECT "TESTUSER"."READTAB"."COL_10", 
"TESTUSER"."READTAB"."COL_20", 1 AS ft$NotDelete  FROM "TESTUSER"."READTAB", 
"TESTUSER"."T1" WHERE "TESTUSER"."READTAB"."COL_10" = "TESTUSER"."T1"."COL_10") 
X, "TESTUSER"."READTAB" Z WHERE L ."COL_10" = X."COL_10" (+) AND X."COL_10" = 
Z."COL_10" (+), logseq: 7
08:56:57.870 19402 AUTOREFRESH 3L 5C 32246P Duration for table 
TESTUSER.READTAB: 70
08:56:57.870 19403 AUTOREFRESH 3L 5C 32246P Num Rows for table 
TESTUSER.READTAB: 1
08:56:57.870 19404 AUTOREFRESH 3L 5C 32246P Cumulative rows for table 
TESTUSER.READTAB: 1559
08:56:57.870 19405 AUTOREFRESH 4L 5C 32246P Autorefresh Query Execute duration 
for table TESTUSER.READTAB: 60
08:56:57.870 19406 AUTOREFRESH 4L 5C 32246P Autorefresh Query Fetch duration for 
table TESTUSER.READTAB: 0
08:56:57.870 19407 AUTOREFRESH 4L 5C 32246P Autorefresh Query Apply duration for 
table TESTUSER.READTAB: 0
08:56:57.870 19408 AUTOREFRESH 4L 5C 32246P Max logseq applied for table 
TESTUSER.READTAB: 8
08:56:57.870 19409 AUTOREFRESH 4L 5C 32246P Autorefresh Query Execute duration 
for 7 child(ren) table(s): 32
08:56:57.870 19410 AUTOREFRESH 4L 5C 32246P Autorefresh Query Fetch duration for 
7 child(ren) table(s): 0
08:56:57.870 19411 AUTOREFRESH 4L 5C 32246P Autorefresh Query Apply duration for 
7 child(ren) table(s): 0
08:56:57.870 19412 AUTOREFRESH 3L 5C  32246P Incremental autorefresh ended for 
table TESTUSER.READTAB
08:56:57.872 19413 AUTOREFRESH 2L 5C 32246P Duration For Cache Group 
TESTUSER.READCACHE: 1020
08:56:57.872 19414 AUTOREFRESH 2L 5C 32246P Num Rows For Cache Group 
TESTUSER.READCACHE: 1
08:56:57.872 19415 AUTOREFRESH 2L 5C 32246P Num Root Rows For Cache Group 
TESTUSER.READCACHE: 0
08:56:57.872 19416 AUTOREFRESH 2L 5C 32246P Cumulative Rows for Cache Group 
TESTUSER.READCACHE: 11776
08:56:57.872 19417 AUTOREFRESH 2L 5C 32246P Cumulative Root Rows for Cache Group 
TESTUSER.READCACHE: 1697
08:56:57.872 19418 AUTOREFRESH 2L 5C 32246P Autorefresh ended for cache group 
TESTUSER.READCACHE
08:56:57.883 19419 AUTOREFRESH 1L 5C 32246P Duration For Interval 60000ms: 420
08:56:57.883 19420 AUTOREFRESH 1L 5C 32246P Num Rows For Interval 60000ms: 0
08:56:57.883 19421 AUTOREFRESH 1L 5C 32246P Num Root Rows For Interval 
60000ms: 0
08:56:57.883 19422 AUTOREFRESH 1L 5C 32246P Cumulative Rows for Interval 
60000ms: 11587
08:56:57.883 19423 AUTOREFRESH 1L 5C 32246P Cumulative Root Rows for Interval 
60000ms: 1697
08:56:57.883 19424 AUTOREFRESH 1L 5C 32246P Autorefresh number 1415 ended for 
interval 60000ms successfully.
27 records dumped

AUTOREFRESHトレースをデフォルトの設定(0)に戻し、ttTraceMonを終了します。 

Trace > level autorefresh 0
Trace > {press ENTER – blank line}