Cosminexus V9 アプリケーションサーバ 機能解説 互換編
DABroker Libraryのスプール情報の調査方法について説明します。
DABroker Libraryのスプール情報には,次の種類があります。これらの情報は,<DABroker Libraryの運用ディレクトリ>\spool(Windowsの場合),または<DABroker Libraryの運用ディレクトリ>/spool(UNIXの場合)に出力されています。
表4-19 DABroker Libraryのスプール情報
スプール情報の種類 | 対応するファイル |
---|---|
メッセージログ | dabsv.log dabsv.logold |
拡張データベースアクセストレース | db_accessディレクトリ下のファイル |
エラートレース | dabevttrcerr1.txt(ログ出力用ファイル) dabevttrcerr2.txt(バックアップ用ファイル)※1 |
Exceptionトレースログ | J2EEサーバ名称+MTrc.logおよびJ2EEサーバ名称+MTrcOLD.log |
イベントトレース※2 | dabevttrcXXX1およびdabevttrcXXX2 |
XAトレース | db_xainfo.log |
注※1 これらのほか,ワークファイルが,dabevttrcerr1.txt.lockという名称で作成されます。
注※2 DABroker for C++をインストールしている場合に出力されます。
それぞれの情報について説明します。
また,このほか,DABroker Libraryのログとしては,次のJDBCドライバのトレースが取得できます。これらのトレースは,アプリケーション開発時に設定されている場合だけ出力されます。
DABroker Libraryのメッセージが出力されたファイルです。
データベースへの接続から切断までのアクセス情報を出力したトレースです。データベースへの接続ごとに出力されます。
拡張データベースアクセストレースは,次のように利用できます。
なお,出力するイベントの種類や,トレースファイルの最大容量などは,DABroker Libraryの[環境設定ユティリティ],またはDABroker Library動作環境定義ファイルで定義しておきます。DABroker Libraryの動作環境の設定については,Windowsの場合は「4.3.1(3) DABroker Libraryの動作環境の設定(Windowsの場合)」,UNIXの場合は「4.3.2(4) DABroker Libraryの動作環境の設定(UNIXの場合)」を参照してください。DABroker Library動作環境定義ファイルの詳細については,「4.24 DABroker Library動作環境定義ファイル」を参照してください。
拡張データベースアクセストレースのファイル出力形式を次に示します。斜体は可変の情報です。拡張データベースアクセストレースは,次の2種類の情報で構成されます。
個々のトレース情報は,出力項目を示すタイトル行の下に出力されます。
*-------------------------------------------------------* *- DataBase Access Information (DRV) -* *- Date YYYY/MM/DD hh:mm:ss.nnnnnn -* *-------------------------------------------------------* DABroker Connect ID : AAAAA(BBBBB) Process ID : CCCCC UserID : DDDDD Client Name : EEEEE (DB別出力情報) Lang Mode : GGGGG THREAD-ID CID EVT START-TIME END-TIME RETCODE BLOCKCNT (Windows QueryPerformance Counter) HiRDB_CONNECTION_ID (トレース情報) (SQL)SS…SS (トレース情報) |
*-------------------------------------------------------* *- DataBase Access Information (DRV) -* *- Date YYYY/MM/DD hh:mm:ss.nnnnnn -* *-------------------------------------------------------* DABroker Connect ID : AAAAA(BBBBB) Process ID : CCCCC UserID : DDDDD Client Name : EEEEE (DB別出力情報) Lang Mode : GGGGG THREAD-ID CID EVT START-TIME END-TIME RETCODE BLOCKCNT HiRDB_CONNECTION_ID (トレース情報) (SQL)SS…SS (トレース情報) |
拡張データベースアクセストレースの出力項目について,次の表に示します。斜体は可変の情報です。
項目 | 内容 | |
---|---|---|
ヘッダ情報 | ||
DRV | DABroker Libraryのデータベースアクセスドライバの種別に従い,次の識別子が出力されます。
|
|
Date:YYYY/MM/DD hh:mm:ss.nnnnnn | ファイル作成日時(YYYY/MM/DD hh:mm:ss.nnnnnn)が出力されます。
|
|
DABroker Connect ID:AAAAA(BBBBB) | データベース接続識別子が出力されます。 | |
Process ID:CCCCC | 実行プロセスIDが出力されます。 | |
UserID:DDDDD | 接続ユーザIDが出力されます。 DABroker LibraryでORACLEのOS認証機能を使用した場合は,「OS authority」となります。 |
|
Client Name:EEEEE | J2EEアプリケーション名称が出力されます。名称が設定されていない場合は空白になります。 | |
(DB別出力情報) | 接続データベースによって異なる情報が出力されます。 | |
HiRDBの場合 |
|
|
Oracleの場合 |
|
|
Lang Mode:GGGGG | 実行言語モードが出力されます。 | |
個々のトレース情報 | ||
THREAD-ID | 実行スレッドIDが出力されます。 | |
CID | カーソル番号が出力されます。 | |
EVT | DABroker Libraryがデータベースに要求した処理内容を示す文字列が出力されます。データベースアクセストレースおよび拡張データベースアクセストレースの内容が含まれます。 DABroker Libraryの[環境設定ユティリティ]またはDABroker Library動作環境定義ファイルで設定された内容のイベントが出力されます。なお,すべてのイベントを出力しない設定にしている場合は,ヘッダだけが出力されます。なお,何か一つでもイベントを出力する設定にしている場合は,GET_DIAGイベントは必ず出力されます。 出力されるイベントを次に示します。
|
|
START-TIME | アクセス開始日時(YYYY/MM/DD hh:mm:ss.nnnnnn)が出力されます。
|
|
END-TIME | アクセス終了日時(YYYY/MM/DD hh:mm:ss.nnnnnn)が出力されます。
|
|
RETCODE | データベースから返されるリターンコードが出力されます。 | |
BLOCKCNT | FETCH時の行取得件数が出力されます。 | |
(Windows QueryPerformance Counter) | Windowsの場合に,高分解パフォーマンス情報が表示されます。 | |
HiRDB_CONNECTION_ID | コネクションID(aaaa:bbbb:cccc)が出力されます。
|
|
(SQL)SS…SS | クライアントから要求のあったSQLの内容が出力されます。この項目は,必要に応じて出力されます。 |
拡張データベースアクセストレースのファイルは,次のディレクトリに作成されます。
拡張データベースアクセストレースのファイル名称は,次の規則に従います。斜体は可変の情報です。
spdb_XXXXXXXX_YYYYYYYY_HHHHHHHHHHHHHHHH_<接続データベース名称>ZZZZZ.IIIIII ファイル名称中の文字列について次に示します。
項目 | 意味 |
---|---|
XXXXXXXX | 実行プロセスIDが設定されます。 |
YYYYYYYY | データベース接続識別子が設定されます。 |
HHHHHHHHHHHHHHHH | 実行プロセスごとにユニークな接続識別子が設定されます。 |
<接続データベース名称> | 接続データベース名称です。指定したデータベース種別によって,次のどれかが設定されます。
|
ZZZZZ | 識別順序番号が設定されます。 同じ実行プロセスIDで,かつ同じデータベース接続識別子のファイルがある場合に,00000から32767までの番号を付加します。 |
IIIIII | ファイル拡張子が設定されます。
|
エラートレースは,ログファイルに出力されるDABroker Libraryのエラー情報です。
エラートレースとして出力される情報を次に示します。
エラー事象を示す情報の出力形式および出力項目について説明します。
YYYY/MM/DD hh:mm:ss.sss TID=AAAA SS..SS エラー事象を示す情報の出力例を次に示します。
2004/05/07 13:30:09.555 TID=4040 KFPA11561-E Specified authorization identifier has no connect privilege |
項目 | 意味 |
---|---|
YYYY/MM/DD hh:mm:ss.sss | エラー発生日時が出力されます。 YYYY:西暦年,MM:月,DD:日 hh:時,mm:分,ss:秒,sss:ミリ秒 |
AAAA | エラー発生スレッドID(16進数値)が出力されます。 |
SS...SS | エラーメッセージが出力されます。 |
データベース接続情報の出力形式および出力項目について説明します。
YYYY/MM/DD hh:mm:ss.sss PID=BBBB InitID=CCCC ConID=DDDD CName=EEEE DBID=FFFF CID=GGGG(HHHH,IIII)
2004/05/07 13:30:21.232 PID=1752 InitID=701 ConID=10701 CName=DABLIBAP DBID=1 CID=1(0,0) |
項目 | 意味 |
---|---|
YYYY/MM/DD hh:mm:ss.sss | データベース接続日時が出力されます。 YYYY:西暦年,MM:月,DD:日 hh:時,mm:分,ss:秒,sss:ミリ秒 |
BBBB | プロセスID(10進数値)が出力されます。 |
CCCC | DABroker Library接続ID(16進数値)が出力されます。 |
DDDD | データベース接続識別子(16進数値)が出力されます。 |
EEEE | J2EEアプリケーションの名称が出力されます。ただし,名称なしの場合は空白となります。 |
FFFF | データベースID(10進数値)が出力されます。 1:HiRDB 7:Oracle8i 8:Oracle9i |
GGGG | 実行中カーソルID(10進数値)が出力されます。 |
HHHH | 保守用情報が出力されます。 |
IIII | 保守用情報が出力されます。 |
履歴情報の出力形式および出力項目について説明します。
YYYY/MM/DD hh:mm:ss.sss mmmm:ss.sss JJJJJJJJ KKKKKKKK LLLL MMMM NNNNNNNN OOOOOOOO PP..PP
START-TIME EXEC-TIME TID COUNT REQ-CODE DATA 2004/05/07 15:37:16.733 0:00.030 1712 7 1022 NOW 00000000 00000001 2004/05/07 15:36:18.369 0:00.000 1712 6 1022 OLD 00000001 00000002 2004/05/07 15:35:59.191 0:00.281 1712 2 1021 PRE 00000000 00000002 INSERT INTO "HS 2004/05/07 15:36:18.369 0:00.000 1712 6 1022 EXE 00000001 00000002 |
項目 | 意味 |
---|---|
YYYY/MM/DD hh:mm:ss.sss | 要求開始日時が出力されます。 YYYY:西暦年,MM:月,DD:日 hh:時,mm:分,ss:秒,sss:ミリ秒 |
mmmm:ss.sss | 要求実行時間が出力されます。 mmmm:分,ss:秒,sss:ミリ秒 |
JJJJJJJJ | 要求元スレッドID(16進数値)が出力されます。 |
KKKKKKKK | コネクト要求からの累計要求カウント数(16進数値)が出力されます。FETの場合は,SQL文実行時のFETの要求回数0xFFFFFFFFを超えた場合は,0から循環します。 |
LLLL | 要求コード(10進数値)要求コードの詳細は,「表4-25 要求コード・応答コード一覧」を参照してください。 |
MMMM | 大きくわけて次の3種類に分類されます。
|
NNNNNNNN | 情報1(16進数値) 詳細は,「表4-26 各履歴種別によるDATA内容」を参照してください。 |
OOOOOOOO | 情報2(16進数値) 詳細は,「表4-26 各履歴種別によるDATA内容」を参照してください。 |
PP..PP | 詳細情報(任意文字列) 詳細は,「表4-26 各履歴種別によるDATA内容」を参照してください。 |
データベース接続情報に出力される,要求コードおよび応答コードの一覧を次の表に示します。
表4-25 要求コード・応答コード一覧
要求コード・応答コード (LLLL) |
種別 |
---|---|
1001 | コネクション解放 |
1002 | データベース接続 |
1003 | データベース切り離し |
1004 | Commit |
1005 | Rollback |
1006 | 表一覧取得準備 |
1007 | 表一覧取得 |
1008 | 表一覧取得後処理 |
1009 | 列一覧取得準備 |
1010 | 列一覧取得 |
1011 | 列一覧取得後処理 |
1012 | 索引一覧取得準備 |
1013 | 索引一覧取得 |
1014 | 索引一覧取得後処理 |
1015 | 表権限一覧取得準備 |
1016 | 表権限一覧取得 |
1017 | 表権限一覧取得後処理 |
1018 | 列権限一覧取得準備 |
1019 | 列権限一覧取得 |
1020 | 列権限一覧取得後処理 |
1021 | SQL実行準備 |
1022 | SQL実行 |
1023 | SQL実行結果取得 |
1024 | SQL実行後処理 |
1035 | SQL実行結果取得オプション |
1036 | BLOBファイル削除 |
1037 | プライマリキー一覧取得準備 |
1038 | プライマリキー一覧取得 |
1039 | プライマリキー一覧取得後処理 |
1040 | BLOB,CLOBおよびBFILE分割取得 |
1041 | 自動Commit設定 |
1042 | 自動Commit解除 |
1050 | XAトランザクション制御 |
1501 | ストアドプロシジャ一覧取得準備 |
1502 | ストアドプロシジャ一覧取得 |
1503 | ストアドプロシジャ一覧取得後処理 |
1504 | ストアドプロシジャ列一覧取得準備 |
1505 | ストアドプロシジャ列一覧取得 |
1506 | ストアドプロシジャ列一覧取得後処理 |
1507 | ストアドプロシジャパラメタ定義情報取得 |
1508 | ストアドプロシジャ実行準備 |
1509 | ストアドプロシジャ実行 |
1510 | ストアドプロシジャ拡張実行 |
2001 | 正常応答 |
2002 | 異常応答 |
データベース接続情報に出力される,各履歴種別によるDATA内容の一覧を次の表に示します。
表4-26 各履歴種別によるDATA内容
履歴種別(MMMM) | 情報1(NNNNNNNN) | 情報2(OOOOOOOO) | 詳細情報(PP..PP) |
---|---|---|---|
PRE | 検索カラム数 | ?パラメタ定義数 | SQLの先頭16バイト(マルチバイト文字コードの途中の場合はその文字は出力しません) |
EXE | SQL実行件数※ | ?パラメタ指定数 | − |
FET1 | 要求時検索件数 | 最大検索件数 | − |
FET | 累計検索件数 | 要求時検索件数 | − |
CLS | 0固定 | 0固定 | − |
CMT | − | − | − |
RBK | − | − | − |
NOW | 今回の要求コードで取得した情報 | − | − |
OLD | 前回の要求コードで取得した情報 | − | − |
Exceptionトレースログは,メソッド実行時に障害が発生した場合に障害要因を分析するためのトレース情報です。障害発生時の問題個所の切り分けをするときに有効です。メソッドの呼び出し情報,メソッドの戻り値の情報,および例外(Exception)の情報が,製品名称などが出力されたヘッダと合わせて出力されます。
Exceptionトレースログとして出力される情報を次に示します。
表4-27 Exceptionトレースログとして出力される情報
情報の種類 | 内容 |
---|---|
ヘッダ | 出力情報の通番 |
製品名称 | |
メソッドの呼び出し情報 | ログの取得時間 |
スレッド識別情報 | |
メソッドの呼び出し識別情報 | |
クラス名,オブジェクトID,メソッド名 | |
コネクションハンドル | |
セクションID(カーソルIDと同じことを表現しています) | |
メソッドの引数 | |
メソッドの戻り情報 | ログの取得時間 |
スレッド識別情報 | |
メソッドの戻り識別情報 | |
クラス名,オブジェクトID,メソッド名 | |
コネクションハンドル | |
セクションID(カーソルIDと同じことを表現しています) | |
メソッドの引数 | |
Exceptionの情報 | ログの取得時間 |
スレッド識別情報 | |
Exceptionのスタックトレース |
Exceptionトレースログは,SQLException,BatchUpdateException,またはXAExceptionが発生したときに,環境変数に設定した設定情報を基に,Exceptionがthrowされる前にファイルに出力されます。Exceptionトレースを出力するメソッドと,ログ出力に関連する環境変数については,「4.6.2 DABroker Libraryで取得できるログの種類と出力先」を参照してください。
Exceptionトレースログの出力形式を,トレース取得レベル5の場合の出力例を基に説明します。
出力される内容について次の表で示します。項番は出力例中の番号と対応しています。
項番 | 区分 | 表示 | 意味 |
---|---|---|---|
1 | ヘッダ | [XXXX] | 出力情報の通番を示します。 |
2 | Cosminexus DABroker for Java , DABroker for Java Version 2 XX-XX-XX | DABroker Libraryのログであることを示します。 | |
3 | 共通 | XXXX/XX/XX XX:XX:XX.XXX | ログの取得時間を示します。 |
4 | Thread[XXXX,XXXXX,XXXX]@XXXX | スレッド識別情報を示します。 | |
5 | [JdbcDbpsvXXXX@XXXX.XXXX] | クラス名,オブジェクトID,メソッド名を示します。 | |
6 | HANDLE(XXXX) | ConnectionHandleを示します。 | |
7 | SID(XXX) | セクションID(カーソルIDと同じことを表現しています)を示します。 | |
8 | メソッドの呼び出し情報 | [E] | メソッドの呼び出し識別情報を示します。 |
9 | XXXX=XXXX | メソッドの引数を示します。 | |
10 | メソッドの戻り情報 | [R] | メソッドからの戻り識別情報を示します。 |
11 | Return=XXXX | メソッドの戻り値を示します。 | |
12 | Exception情報 | JP.co.Hitachi.soft.DBPSV_Driver.XXXXException:XXXX | Exceptionのスタックトレースを表示します。 |
ここでは,(1)で示した出力例を使用して,Exceptionトレースログの解析方法について説明します。
Exceptionトレースログは,次の手順で解析します。
時間 | スレッド1 | スレッド2 | スレッド3 | スレッド4 |
---|---|---|---|---|
Thread[main,5,main] @1259414 |
Thread[Thread-0,5,main] @30090737 |
Thread[Thread-1,5,main] @5462872 |
Thread[Thread-2,5,main] @25253977 |
|
2004/07/06 23:07:09.129 | JdbcDbpsvConnection @82c01f.createStatement(1) |
− | − | − |
2004/07/06 23:07:09.160 | JdbcDbpsvStatement @1e4cbc4.execute |
− | − | − |
2004/07/06 23:07:14.285 | JdbcDbpsvConnection @82c01f.commit |
− | − | − |
2004/07/06 23:07:14.301 | JdbcDbpsvConnection @82c01f.prepareStatement(1) |
− | − | − |
2004/07/06 23:07:26.567 | JdbcDbpsvConnection @82c01f.commit |
− | − | − |
2004/07/06 23:07:26.567 | JdbcDbpsvStatement @1e4cbc4.executeQuery |
− | − | − |
2004/07/06 23:07:26.567 | JdbcDbpsvStatement @1e4cbc4.execute |
− | − | − |
2004/07/06 23:07:28.332 | JdbcDbpsvResultSet @3eca90.close |
JdbcDbpsvConnection @82c01f.prepareStatement(1) |
− | − |
2004/07/06 23:07:28.332 | JdbcDbpsvConnection @82c01f.commit |
− | − | − |
2004/07/06 23:07:28.348 | − | − | JdbcDbpsvConnection @82c01f.prepareStatement(1) |
− |
2004/07/06 23:07:30.332 | − | − | − | JdbcDbpsvConnection @82c01f.rollback |
2004/07/06 23:07:42.098 | − | − | − | JdbcDbpsvConnection @82c01f.close |
2004/07/06 23:07:42.535 | − | − | SQLException発生 KFDJ00002-E Statement or Connection is closed. |
− |
トレース取得レベルごとの出力例を次に示します。
トレース取得レベル1の場合の出力例
[1] Cosminexus DABroker for Java , DABroker for Java Version 2 02-11-/D 2004/07/21 17:59:41.001 Thread[main,5,main]@2113601537 [E][JdbcDbpsvXADataSource@59920001.getXAConnection(1)] HANDLE(0) : SID(0) 2004/07/21 17:59:41.020 Thread[main,5,main]@2113601537 [E][JdbcDbpsvXAConnection@8bf8002.getXAResource] HANDLE(0) : SID(0) 2004/07/21 17:59:41.554 Thread[main,5,main]@2113601537 [R][JdbcDbpsvXAConnection@8bf8002.getXAResource] HANDLE(0) : SID(0) Return=JP.co.Hitachi.soft.DBPSV_Driver.JdbcDbpsvXAResource@33690002 2004/07/21 17:59:41.554 Thread[main,5,main]@2113601537 [R][JdbcDbpsvXADataSource@59920001.getXAConnection(1)] HANDLE(0) : SID(0) Return=JP.co.Hitachi.soft.DBPSV_Driver.JdbcDbpsvXAConnection@8bf8002 2004/07/21 17:59:41.557 Thread[main,5,main]@2113601537 [E][JdbcDbpsvXAConnection@8bf8002.getXAResource] HANDLE(0) : SID(0) 2004/07/21 17:59:41.557 Thread[main,5,main]@2113601537 [R][JdbcDbpsvXAConnection@8bf8002.getXAResource] HANDLE(0) : SID(0) Return=JP.co.Hitachi.soft.DBPSV_Driver.JdbcDbpsvXAResource@33690002 2004/07/21 17:59:41.561 Thread[main,5,main]@2113601537 [E][JdbcDbpsvXAConnection@8bf8002.getConnection] HANDLE(0) : SID(0) 2004/07/21 17:59:41.649 Thread[main,5,main]@2113601537 [R][JdbcDbpsvXAConnection@8bf8002.getConnection] HANDLE(883163352) : SID(0) Return=JP.co.Hitachi.soft.DBPSV_Driver.JdbcDbpsvConnection@78688002 2004/07/21 17:59:41.649 Thread[main,5,main]@2113601537 [E][JdbcDbpsvConnection@78688002.prepareStatement(1)] HANDLE(883163352) : SID(0) sql=INSERT INTO TRC_ex VALUES(?) 2004/07/21 17:59:41.819 Thread[main,5,main]@2113601537 [R][JdbcDbpsvConnection@78688002.prepareStatement(1)] HANDLE(883163352) : SID(1) Return=JP.co.Hitachi.soft.DBPSV_Driver.JdbcDbpsvPreparedStatement@d334002 2004/07/21 17:59:41.977 Thread[main,5,main]@2113601537 [E][JdbcDbpsvConnection@78688002.close] HANDLE(883163352) : SID(0) 2004/07/21 17:59:42.886 Thread[main,5,main]@2113601537 [R][JdbcDbpsvConnection@78688002.close] HANDLE(883163352) : SID(0) 2004/07/21 17:59:42.945 Thread[main,5,main]@2113601537 [E][JdbcDbpsvConnection@78688002.createStatement(1)] HANDLE(883163352) : SID(0) 2004/07/21 17:59:42.946 Thread[main,5,main]@2113601537:JP.co.Hitachi.soft.DBPSV_Driver.SQLException: KFDJ00006-E Connection is closed.[JdbcDbpsvConnection.createStatement(1)] at JP.co.Hitachi.soft.DBPSV_Driver.JdbcDbpsvConnection.createStatement(JdbcDbpsvConnection.java:529) at TRC_ex.main(TRC_ex.java:81) |
トレース取得レベル2の場合の出力例
[1] Cosminexus DABroker for Java , DABroker for Java Version 2 02-11-/D 2004/07/21 19:00:56.992 Thread[main,5,main]@2113866091 [E][JdbcDbpsvXADataSource@5996096b.getXAConnection(1)] HANDLE(0) : SID(0) 2004/07/21 19:00:57.012 Thread[main,5,main]@2113866091 [E][JdbcDbpsvXAConnection@8bb8968.getXAResource] HANDLE(0) : SID(0) 2004/07/21 19:00:57.561 Thread[main,5,main]@2113866091 [R][JdbcDbpsvXAConnection@8bb8968.getXAResource] HANDLE(0) : SID(0) Return=JP.co.Hitachi.soft.DBPSV_Driver.JdbcDbpsvXAResource@336d0968 2004/07/21 19:00:57.561 Thread[main,5,main]@2113866091 [R][JdbcDbpsvXADataSource@5996096b.getXAConnection(1)] HANDLE(0) : SID(0) Return=JP.co.Hitachi.soft.DBPSV_Driver.JdbcDbpsvXAConnection@8bb8968 2004/07/21 19:00:57.565 Thread[main,5,main]@2113866091 [E][JdbcDbpsvXAConnection@8bb8968.getXAResource] HANDLE(0) : SID(0) 2004/07/21 19:00:57.565 Thread[main,5,main]@2113866091 [R][JdbcDbpsvXAConnection@8bb8968.getXAResource] HANDLE(0) : SID(0) Return=JP.co.Hitachi.soft.DBPSV_Driver.JdbcDbpsvXAResource@336d0968 2004/07/21 19:00:57.569 Thread[main,5,main]@2113866091 [E][JdbcDbpsvXAConnection@8bb8968.getConnection] HANDLE(0) : SID(0) 2004/07/21 19:00:57.660 Thread[main,5,main]@2113866091 [R][JdbcDbpsvXAConnection@8bb8968.getConnection] HANDLE(883163368) : SID(0) Return=JP.co.Hitachi.soft.DBPSV_Driver.JdbcDbpsvConnection@7862c968 2004/07/21 19:00:57.660 Thread[main,5,main]@2113866091 [E][JdbcDbpsvConnection@7862c968.prepareStatement(1)] HANDLE(883163368) : SID(0) sql=INSERT INTO TRC_ex VALUES(?) 2004/07/21 19:00:57.779 Thread[main,5,main]@2113866091 [R][JdbcDbpsvConnection@7862c968.prepareStatement(1)] HANDLE(883163368) : SID(1) Return=JP.co.Hitachi.soft.DBPSV_Driver.JdbcDbpsvPreparedStatement@d4dc968 2004/07/21 19:00:57.840 Thread[main,5,main]@2113866091 [E][JdbcDbpsvPreparedStatement@d4dc968.executeUpdate(1)] HANDLE(883163368) : SID(1) sql=INSERT INTO TRC_ex VALUES(?) 2004/07/21 19:00:57.854 Thread[main,5,main]@2113866091 [R][JdbcDbpsvPreparedStatement@d4dc968.executeUpdate(1)] HANDLE(883163368) : SID(1) Return=1 2004/07/21 19:00:57.854 Thread[main,5,main]@2113866091 [E][JdbcDbpsvConnection@7862c968.close] HANDLE(883163368) : SID(0) 2004/07/21 19:00:57.886 Thread[main,5,main]@2113866091 [R][JdbcDbpsvConnection@7862c968.close] HANDLE(883163368) : SID(0) 2004/07/21 19:00:57.916 Thread[main,5,main]@2113866091 [E][JdbcDbpsvConnection@7862c968.createStatement(1)] HANDLE(883163368) : SID(0) 2004/07/21 19:00:57.917 Thread[main,5,main]@2113866091:JP.co.Hitachi.soft.DBPSV_Driver.SQLException: KFDJ00006-E Connection is closed.[JdbcDbpsvConnection.createStatement(1)] at JP.co.Hitachi.soft.DBPSV_Driver.JdbcDbpsvConnection.createStatement(JdbcDbpsvConnection.java:529) at TRC_ex.main(TRC_ex.java:81) |
トレースレベル3の場合の出力例
[1] Cosminexus DABroker for Java , DABroker for Java Version 2 02-11-/D 2004/07/21 19:01:28.755 Thread[main,5,main]@2113866075 [E][JdbcDbpsvXADataSource@5996095b.getXAConnection(1)] HANDLE(0) : SID(0) 2004/07/21 19:01:28.774 Thread[main,5,main]@2113866075 [E][JdbcDbpsvXAConnection@8bb8958.getXAResource] HANDLE(0) : SID(0) 2004/07/21 19:01:29.329 Thread[main,5,main]@2113866075 [R][JdbcDbpsvXAConnection@8bb8958.getXAResource] HANDLE(0) : SID(0) Return=JP.co.Hitachi.soft.DBPSV_Driver.JdbcDbpsvXAResource@336d0958 2004/07/21 19:01:29.329 Thread[main,5,main]@2113866075 [R][JdbcDbpsvXADataSource@5996095b.getXAConnection(1)] HANDLE(0) : SID(0) Return=JP.co.Hitachi.soft.DBPSV_Driver.JdbcDbpsvXAConnection@8bb8958 2004/07/21 19:01:29.332 Thread[main,5,main]@2113866075 [E][JdbcDbpsvXAConnection@8bb8958.getXAResource] HANDLE(0) : SID(0) 2004/07/21 19:01:29.332 Thread[main,5,main]@2113866075 [R][JdbcDbpsvXAConnection@8bb8958.getXAResource] HANDLE(0) : SID(0) Return=JP.co.Hitachi.soft.DBPSV_Driver.JdbcDbpsvXAResource@336d0958 2004/07/21 19:01:29.333 Thread[main,5,main]@2113866075 [E][JdbcDbpsvXAResource@336d0958.start] HANDLE(0) : SID(0) xid=MyXid@5ffe4958 flags=0 2004/07/21 19:01:29.372 Thread[main,5,main]@2113866075 [R][JdbcDbpsvXAResource@336d0958.start] HANDLE(0) : SID(0) 2004/07/21 19:01:29.389 Thread[main,5,main]@2113866075 [E][JdbcDbpsvXAConnection@8bb8958.getConnection] HANDLE(0) : SID(0) 2004/07/21 19:01:29.477 Thread[main,5,main]@2113866075 [R][JdbcDbpsvXAConnection@8bb8958.getConnection] HANDLE(883163368) : SID(0) Return=JP.co.Hitachi.soft.DBPSV_Driver.JdbcDbpsvConnection@78b60958 2004/07/21 19:01:29.478 Thread[main,5,main]@2113866075 [E][JdbcDbpsvConnection@78b60958.prepareStatement(1)] HANDLE(883163368) : SID(0) sql=INSERT INTO TRC_ex VALUES(?) 2004/07/21 19:01:29.571 Thread[main,5,main]@2113866075 [R][JdbcDbpsvConnection@78b60958.prepareStatement(1)] HANDLE(883163368) : SID(1) Return=JP.co.Hitachi.soft.DBPSV_Driver.JdbcDbpsvPreparedStatement@13934958 2004/07/21 19:01:29.614 Thread[main,5,main]@2113866075 [E][JdbcDbpsvPreparedStatement@13934958.executeUpdate(1)] HANDLE(883163368) : SID(1) sql=INSERT INTO TRC_ex VALUES(?) 2004/07/21 19:01:29.624 Thread[main,5,main]@2113866075 [R][JdbcDbpsvPreparedStatement@13934958.executeUpdate(1)] HANDLE(883163368) : SID(1) Return=1 2004/07/21 19:01:29.624 Thread[main,5,main]@2113866075 [E][JdbcDbpsvConnection@78b60958.close] HANDLE(883163368) : SID(0) 2004/07/21 19:01:29.656 Thread[main,5,main]@2113866075 [R][JdbcDbpsvConnection@78b60958.close] HANDLE(883163368) : SID(0) 2004/07/21 19:01:29.656 Thread[main,5,main]@2113866075 [E][JdbcDbpsvXAResource@336d0958.end] HANDLE(0) : SID(0) xid=MyXid@5ffe4958 flags=67108864 2004/07/21 19:01:29.658 Thread[main,5,main]@2113866075 [R][JdbcDbpsvXAResource@336d0958.end] HANDLE(0) : SID(0) 2004/07/21 19:01:29.659 Thread[main,5,main]@2113866075 [E][JdbcDbpsvXAResource@336d0958.prepare] HANDLE(0) : SID(0) xid=MyXid@5ffe4958 2004/07/21 19:01:29.675 Thread[main,5,main]@2113866075 [R][JdbcDbpsvXAResource@336d0958.prepare] HANDLE(0) : SID(0) Return=0 2004/07/21 19:01:29.675 Thread[main,5,main]@2113866075 [E][JdbcDbpsvXAResource@336d0958.commit] HANDLE(0) : SID(0) xid=MyXid@5ffe4958 onePhase=false 2004/07/21 19:01:29.681 Thread[main,5,main]@2113866075 [R][JdbcDbpsvXAResource@336d0958.commit] HANDLE(0) : SID(0) 2004/07/21 19:01:29.681 Thread[main,5,main]@2113866075 [E][JdbcDbpsvConnection@78b60958.createStatement(1)] HANDLE(883163368) : SID(0) 2004/07/21 19:01:29.682 Thread[main,5,main]@2113866075:JP.co.Hitachi.soft.DBPSV_Driver.SQLException: KFDJ00006-E Connection is closed.[JdbcDbpsvConnection.createStatement(1)] at JP.co.Hitachi.soft.DBPSV_Driver.JdbcDbpsvConnection.createStatement(JdbcDbpsvConnection.java:529) at TRC_ex.main(TRC_ex.java:81) |
トレース取得レベル5の場合の出力例
[1] Cosminexus DABroker for Java , DABroker for Java Version 2 02-11-/D 2004/07/21 18:58:47.122 Thread[main,5,main]@2113866026 [E][JdbcDbpsvXADataSource@5996092a.getXAConnection(1)] HANDLE(0) : SID(0) 2004/07/21 18:58:47.141 Thread[main,5,main]@2113866026 [E][JdbcDbpsvXAConnection@8bb8929.getXAResource] HANDLE(0) : SID(0) 2004/07/21 18:58:47.705 Thread[main,5,main]@2113866026 [R][JdbcDbpsvXAConnection@8bb8929.getXAResource] HANDLE(0) : SID(0) Return=JP.co.Hitachi.soft.DBPSV_Driver.JdbcDbpsvXAResource@336d0929 2004/07/21 18:58:47.706 Thread[main,5,main]@2113866026 [R][JdbcDbpsvXADataSource@5996092a.getXAConnection(1)] HANDLE(0) : SID(0) Return=JP.co.Hitachi.soft.DBPSV_Driver.JdbcDbpsvXAConnection@8bb8929 2004/07/21 18:58:47.709 Thread[main,5,main]@2113866026 [E][JdbcDbpsvXAConnection@8bb8929.getXAResource] HANDLE(0) : SID(0) 2004/07/21 18:58:47.709 Thread[main,5,main]@2113866026 [R][JdbcDbpsvXAConnection@8bb8929.getXAResource] HANDLE(0) : SID(0) Return=JP.co.Hitachi.soft.DBPSV_Driver.JdbcDbpsvXAResource@336d0929 2004/07/21 18:58:47.710 Thread[main,5,main]@2113866026 [E][JdbcDbpsvXAResource@336d0929.start] HANDLE(0) : SID(0) xid=MyXid@5ffe4929 flags=0 2004/07/21 18:58:47.750 Thread[main,5,main]@2113866026 [R][JdbcDbpsvXAResource@336d0929.start] HANDLE(0) : SID(0) 2004/07/21 18:58:47.770 Thread[main,5,main]@2113866026 [E][JdbcDbpsvXAConnection@8bb8929.getConnection] HANDLE(0) : SID(0) 2004/07/21 18:58:47.858 Thread[main,5,main]@2113866026 [R][JdbcDbpsvXAConnection@8bb8929.getConnection] HANDLE(883163368) : SID(0) Return=JP.co.Hitachi.soft.DBPSV_Driver.JdbcDbpsvConnection@78454929 2004/07/21 18:58:47.858 Thread[main,5,main]@2113866026 [E][JdbcDbpsvConnection@78454929.prepareStatement(1)] HANDLE(883163368) : SID(0) sql=INSERT INTO TRC_ex VALUES(?) 2004/07/21 18:58:47.952 Thread[main,5,main]@2113866026 [R][JdbcDbpsvConnection@78454929.prepareStatement(1)] HANDLE(883163368) : SID(1) Return=JP.co.Hitachi.soft.DBPSV_Driver.JdbcDbpsvPreparedStatement@d2ec929 2004/07/21 18:58:47.994 Thread[main,5,main]@2113866026 [E][JdbcDbpsvPreparedStatement@d2ec929.executeUpdate(1)] HANDLE(883163368) : SID(1) sql=INSERT INTO TRC_ex VALUES(?) 2004/07/21 18:58:47.994 Thread[main,5,main]@2113866026 [E][JdbcDbpsvPreparedStatement@d2ec929.execute(1)] HANDLE(883163368) : SID(1) sql=INSERT INTO TRC_ex VALUES(?) 2004/07/21 18:58:48.004 Thread[main,5,main]@2113866026 [R][JdbcDbpsvPreparedStatement@d2ec929.execute(1)] HANDLE(883163368) : SID(1) Return=false 2004/07/21 18:58:48.004 Thread[main,5,main]@2113866026 [R][JdbcDbpsvPreparedStatement@d2ec929.executeUpdate(1)] HANDLE(883163368) : SID(1) Return=1 2004/07/21 18:58:48.004 Thread[main,5,main]@2113866026 [E][JdbcDbpsvConnection@78454929.close] HANDLE(883163368) : SID(0) 2004/07/21 18:58:48.037 Thread[main,5,main]@2113866026 [R][JdbcDbpsvConnection@78454929.close] HANDLE(883163368) : SID(0) 2004/07/21 18:58:48.037 Thread[main,5,main]@2113866026 [E][JdbcDbpsvXAResource@336d0929.end] HANDLE(0) : SID(0) xid=MyXid@5ffe4929 flags=67108864 2004/07/21 18:58:48.039 Thread[main,5,main]@2113866026 [R][JdbcDbpsvXAResource@336d0929.end] HANDLE(0) : SID(0) 2004/07/21 18:58:48.039 Thread[main,5,main]@2113866026 [E][JdbcDbpsvXAResource@336d0929.prepare] HANDLE(0) : SID(0) xid=MyXid@5ffe4929 2004/07/21 18:58:48.053 Thread[main,5,main]@2113866026 [R][JdbcDbpsvXAResource@336d0929.prepare] HANDLE(0) : SID(0) Return=0 2004/07/21 18:58:48.053 Thread[main,5,main]@2113866026 [E][JdbcDbpsvXAResource@336d0929.commit] HANDLE(0) : SID(0) xid=MyXid@5ffe4929 onePhase=false 2004/07/21 18:58:48.059 Thread[main,5,main]@2113866026 [R][JdbcDbpsvXAResource@336d0929.commit] HANDLE(0) : SID(0) 2004/07/21 18:58:48.059 Thread[main,5,main]@2113866026 [E][JdbcDbpsvConnection@78454929.createStatement(1)] HANDLE(883163368) : SID(0) 2004/07/21 18:58:48.060 Thread[main,5,main]@2113866026:JP.co.Hitachi.soft.DBPSV_Driver.SQLException: KFDJ00006-E Connection is closed.[JdbcDbpsvConnection.createStatement(1)] at JP.co.Hitachi.soft.DBPSV_Driver.JdbcDbpsvConnection.createStatement(JdbcDbpsvConnection.java:529) at TRC_ex.main(TRC_ex.java:81) |
イベントトレースは,DABroker for C++をインストールしている場合に出力されます。
DABroker for C++の機能を使ってデータベースにアクセスする場合のイベントトレースが出力されます。イベントトレースは,次のファイルに取得されます。
なお,イベントトレースファイルが満杯になった場合,ラップアラウンドでトレースが出力されます。この場合は,バックアップファイル(dabevttrccpp2)が作成され,1世代だけ(dabevttrccpp1)が管理されます。
取得するイベントトレースの設定については,「4.7.4 データベース接続の設定」を参照してください。
イベントトレースの出力形式について説明します。
ヘッダ「LEVEL VPID PID TID DATE TIME EVENT」の下に,次に示す形式でトレース情報が出力されます。
レベル 仮想プロセスID プロセスID スレッドID 日付 時刻 動作結果
イベントトレースの出力例を次に示します。
LEVEL VPID PID TID DATE TIME EVENT 40000010 00120000 711a 0001 2004/06/01 11:38:29.300000 イベント1 40000010 00120000 711a 0002 2004/06/01 11:38:30.100000 イベント2 40000010 00120000 711b 0001 2004/06/01 11:38:30.150000 イベント3 40000010 00120000 711b 0002 2004/06/01 11:38:30.250000 イベント4 |
イベントトレースの出力項目について,次の表に示します。
表4-29 DABroker Libraryのイベントトレースの出力項目
ヘッダ | 項目 | 説明 |
---|---|---|
LEVEL | レベル | トレースに出力したレベルが出力されます。 |
VPID | 仮想プロセスID | 仮想プロセスIDが出力されます。 |
PID | プロセスID | プロセスIDが出力されます。 |
TID | スレッドID | スレッドIDが出力されます。 |
DATE | 日付 | 取得した日付が出力されます。 |
TIME | 時刻 | 取得した時刻が出力されます。 |
EVENT | 動作結果 | 実行時の動作結果のログが出力されます。 |
XAインタフェースでのトラブルシュート情報は,XAトレースファイルとして次のファイルに出力されます。
XAトレースファイルの出力形式を次に示します。斜体は可変の情報です。
日付 時刻 プロセスID:スレッドID イベント種別:XA関数名 rmid=rrrr flags=ffff RMName="nnnn" xa_info="iiii" xid=[ffff:gggg:bbbb:dddd] count=cccc return code=rrrr
XAトレースファイルの出力例を次に示します。
XAトレースファイルの出力項目について,次の表に示します。
表4-30 DABroker LibraryのXAトレースの出力項目
項目名 | 説明 |
---|---|
日付 | 出力した年月日(YYYY/MM/DD)が出力されます。
|
時刻 | 出力した時刻(hh:mm:ss:nnnnnn)が表示されます。
|
[プロセスID:スレッドID] | プロセスIDとスレッドIDが出力されます。 |
[イベント種別:XA関数名] | イベント種別と,XA関数の名前が出力されます。
|
rmid=rrrr | RMIDが出力されます。 |
flags=ffff | フラグパラメタが出力されます。 |
RMName="nnnn" | RM名称が出力されます。 |
xa_info="iii " | XA文字列が出力されます。 この項目は,XA関数が,xa_open(),またはxa_close()の場合だけ,出力されます。 |
xid=[ffff:gggg:bbbb:dddd] | XIDが出力されます。 この項目は,XA関数が,xa_open(),またはxa_close()以外の場合だけ,出力されます。 ffff:フォーマットIDが出力されます。 gggg:グローバルトランザクションID長が出力されます。 bbbb:ブランチ修飾子長が出力されます。 dddd:XIDデータが出力されます。 |
count=cccc | リカバリ情報取得カウントが出力されます。 この項目は,XA関数がxa_recover()の場合だけ,出力されます。 |
return code = rrrr | XA関数の戻り値が出力されます。 この項目は,イベント種別が"end"の場合だけ出力されます。 |
J2EEアプリケーションまたはバッチアプリケーション開発時に,DABroker LibraryのAPIを使用して,JDBCドライバのトレースを出力するように設定できます。
ここでは,JDBCドライバのトレースのうち,JDBCインタフェースメソッドのトレースについて説明します。
JDBCインタフェースメソッドのトレースの出力形式を次に示します。斜体は可変の情報です。
[DABroker for Java Version 2] [JDBC Interface メソッド状態][JdbcDbpsvクラス名.メソッド名] 引数または戻り値=値
JDBCインタフェースメソッドのトレースの出力例を次の図に示します。
JDBCインタフェースメソッドのトレースの出力項目について,次の表に示します。
表4-31 JDBCインタフェースメソッドのトレースの出力項目
項目 | 説明 |
---|---|
[DABroker for Java Version 2] | DABroker Libraryのトレースであることを示します。 |
[JDBC Interface メソッド状態] | 使用したJDBCインタフェースメソッドの状態を示します。 Entry:メソッドの呼び出し Return:メソッドの戻り |
[JdbcDbpsvクラス名. メソッド名] | 使用したJDBCインタフェースメソッドの「クラス名.メソッド名」を示します。 |
引数または戻り値=値 | 該当する「クラス名.メソッド名」の引数の値,または戻り値が出力されます。 引数の場合,引数名=値の形式で出力されます。 戻り値の場合,Return=値の形式で出力されます。 |
J2EEアプリケーションまたはバッチアプリケーション開発時に,DABroker LibraryのAPIを使用して,JDBCドライバのトレースを出力するように設定できます。
ここでは,JDBCドライバとDABroker Libraryとのイベントトレースについて説明します。
DABroker Libraryとのイベントトレースの出力形式を次に示します。
[DABroker for Java Version 2] [Server Event イベント] 送信データ種別
DABroker Libraryとのイベントトレースの出力例を次に示します。
DABroker Libraryとのイベントトレースの出力項目について,次の表に示します。
表4-32 DABrokerとのイベントトレースの出力項目
項目 | 説明 | |
---|---|---|
[DABroker for Java Version 2] | DABroker Libraryのトレースであることを示します。 | |
[Server Event イベント] | DABroker Libraryでのイベントを示します。 | |
送信データ種別 | 送受信データ種別が,aa…aa <bb…bb>(cc…cc,dd…dd)SIZE:XXXの形式で出力されます | |
aa…aa | オペレーション種別が出力されます。 表示されるオペレーション種別とその意味は次のとおりです。
|
|
bb…bb | 付加情報が出力されます。 オペレーション種別が,LIST(xxxxx)およびEXT-CMDの場合に表示されます。 |
|
cc…cc | リターンコードが出力されます。 | |
dd…dd | 詳細コードが出力されます。 | |
XXX | DABroker LibraryでのイベントがPutの場合は,送信したデータのサイズが出力されます。 DABroker LibraryでのイベントがGetの場合は,受け取ったデータのサイズが出力されます。 |
All Rights Reserved. Copyright (C) 2012, 2015, Hitachi, Ltd.