次に、'DEBUG TRACE LOAD'をTPumpスクリプト内に指定したときのサンプル出力を示します。
======================================================================== = = = Teradata Parallel Data Pump Utility Release 17.00.00.00 = = Platform WIN 64-bit = = PID 10948 = = = ======================================================================== = = = Copyright 1997-2019 Teradata Corporation. ALL RIGHTS RESERVED. = = = ======================================================================== **** 17:38:25 UTY2411 Processing start date: WED APR 24, 2019 ======================================================================== = = = Logon/Connection = = = ======================================================================== 0001 .DEBUG TRACE LOAD; 0002 .LOGTABLE TESTPSALOGS; 0003 .LOGON NODEID/FLUSER,; **** 17:38:30 UTY8400 Teradata Database Release: 17.00.00.00 **** 17:38:30 UTY8400 Teradata Database Version: 17.00.00.00 **** 17:38:30 UTY8400 Default character set: ASCII **** 17:38:30 UTY8400 Current RDBMS has UDT support **** 17:38:30 UTY8400 Current RDBMS has Large Decimal support **** 17:38:30 UTY8400 Current RDBMS has Statement Info Parcel support **** 17:38:30 UTY8400 Maximum supported buffer size: 1M **** 17:38:30 UTY8400 Upsert supported by RDBMS server **** 17:38:30 UTY8400 Data Encryption supported by RDBMS server **** 17:38:30 UTY8400 Array Support supported by RDBMS server **** 17:38:30 UTY8400 Statement Independence supported by RDBMS server **** 17:38:32 UTY6211 A successful connect was made to the RDBMS. **** 17:38:32 UTY6217 Logtable 'FLUSER.TESTPSALOGS' has been created. ======================================================================== = = = Processing Control Statements = = = ======================================================================== 0004 delete from TESTSA01; **** 17:38:33 UTY1016 'DELETE' request successful. 0005 .SET WEDDT TO '2019-05-02'; 0006 .DISPLAY '&WEDDT' TO FILE *; **** 17:38:33 UTY2402 Previous statement modified to: 0007 .DISPLAY '2019-05-02' TO FILE *; 2019-05-02 0008 .DISPLAY '2019-05-02' TO FILE *; 2019-05-02 0009 .BEGIN CHECKPOINT 15 SESSIONS 4 1 TENACITY 2 ERRORTABLE TPERRTESTSA01 ROBUST OFF; ======================================================================== = = = Processing TPump Statements = = = ======================================================================== 0010 .LAYOUT LAY0012; 0011 .FIELD FF1 * INTEGER KEY; 0012 .FIELD FF2 * CHAR(10); 0013 .FIELD FF3 * CHAR(10); 0014 .DML LABEL LABEL0012; 0015 INSERT INTO TESTSA01 VALUES ( :FF1, :FF2, :FF3 ); 0016 .IMPORT INFILE FEXPDATA LAYOUT LAY0012 APPLY LABEL0012; 0017 .END LOAD; **** 17:38:33 UTY6609 Starting to log on sessions... StartConn: connect DBCHCL status: 0 StartConn: connect DBCHCL status: 0 StartConn: connect DBCHCL status: 0 StartConn: connect DBCHCL status: 0 WaitForResponse: Calling dbchwat WaitForResponse: Returned from dbchwat DBCAreaPtr->fet_parcel_flavor is 8 DBCAreaPtr->fet_parcel_flavor is 12 Logged on session[0] 16 TDPSess = 274323 WaitForResponse: Calling dbchwat WaitForResponse: Returned from dbchwat DBCAreaPtr->fet_parcel_flavor is 8 DBCAreaPtr->fet_parcel_flavor is 12 Logged on session[1] 17 TDPSess = 274324 WaitForResponse: Calling dbchwat WaitForResponse: Returned from dbchwat DBCAreaPtr->fet_parcel_flavor is 8 DBCAreaPtr->fet_parcel_flavor is 12 Logged on session[2] 18 TDPSess = 274325 WaitForResponse: Calling dbchwat WaitForResponse: Returned from dbchwat DBCAreaPtr->fet_parcel_flavor is 8 DBCAreaPtr->fet_parcel_flavor is 12 Logged on session[3] 19 TDPSess = 274326 **** 17:38:37 UTY6610 Logged on 4 sessions. ======================================================================== = = = TPump Import(s) Beginning = = = ======================================================================== **** 17:38:37 UTY6630 Options in effect for following TPump Import(s): . Tenacity: 2 hour limit to successfully connect load sessions. . Max Sessions: 4 session(s). . Min Sessions: 1 session(s). . Checkpoint: 15 minute(s). . Errlimit: No limit in effect. . Restart Mode: SIMPLE. . Serialization: OFF. . Packing: 20 Statements per Request. . StartUp Rate: UNLIMITED Statements per Minute. StmtGenTest buffer len: 96 StmtGenTest request len: 95 Preparing SQL: 'USING(FF1 INTEGER,FF2 CHAR(10),FF3 CHAR(10)) INSERT INTO TESTSA01 VALUES ( :FF1, :FF2, :FF3 ); ' StmtGenMacro buffer len: 1520 StmtGenMacro request len: 186 macro: CREATE MACRO FLUSER.M20190502_173839_76635_001_001(FF1 INTEGER,FF2 CHAR(10) CHARACTER SET LATIN,FF3 CHAR(10) CHARACTER SET LATIN) AS (INSERT INTO TESTSA01 VALUES ( :FF1, :FF2, :FF3 ); ); Testing pack factor 20 StmtGenTemplate nOneStmtUBytes: 38 StmtGenTemplate nUsingBytes: 767 StmtGenTemplate nStmtBytes: 59 StmtGenTemplate buffer len: 1954 StmtGenTemplate request len: 1953 Sqllen: 1953, Datalen: 480, Maxlen: 1048472 TESTPACKFACTOR: extra_cli_overhead: 0 Partition DEFAULT PARTITION using request template token = 0, i_sess_id = Ctx->Id = 16 Sending 57 byte request: 'exec TPumpMacro.ImportCreate('FLUSER', 'TESTPSALOGS', 1);' Using 0 byte(s) of data: '' Ctx->ReqId updated to o_req_id = 2 DBCAreaPtr->fet_parcel_flavor is 9 **** 17:38:41 UTY8802 WARNING: Rate Monitoring turned off - database TPumpMacro does not exist. **** 17:38:41 UTY6608 Import 1 begins. DEFAULT PARTITION session 0 Buckets: 1 Total Buckets: 1 Hit End of file calling SessCheckT w/ timeout = 60 Flushing backlog Sending Bucket on DEFAULT PARTITION session 0 token = 0, i_sess_id = Ctx->Id = 16 Sending 498 byte request: 'USING(AA1 INTEGER,AA2 CHAR(10),AA3 CHAR(10),AB1 INTEGER,AB2 CHAR(10),AB3 CHAR(10),AC1 INTEGER,AC2 CHAR(10),AC3 CHAR(10),AD1 INTEGER,AD2 CHAR(10),AD3 CHAR(10),AE1 INTEGER,AE2 CHAR(10),AE3 CHAR(10)) BT;EXEC FLUSER.M20190502_173839_76635_001_001(:AA1,:AA2,:AA3);EXEC FLUSER.M20190502_173839_76635_001_001(:AB1,:AB2,:AB3);EXEC FLUSER.M20190502_173839_76635_001_001(:AC1,:AC2,:AC3);EXEC FLUSER.M20190502_173839_76635_001_001(:AD1,:AD2,:AD3);EXEC FLUSER.M20190502_173839_76635_001_001(:AE1,:AE2,:AE3);ET;' Using 120 byte(s) of data: '01000000412020202020202020204141202020202020202002000000422020202020202020 204141202020202020202003000000432020202020202020204141202020202020202004000 000442020202020202020204141202020202020202005000000452020202020202020204141 2020202020202020' Ctx->ReqId updated to o_req_id = 3 calling SessCheckT w/ timeout = 60 WaitForResponse: Calling dbchwat WaitForResponse: Returned from dbchwat WaitForResponse returned token 0 Corresponding session has status = 1, Ctx->Id = 16, Ctx->ReqId = 3 DBCAreaPtr->fet_parcel_flavor is 205 DBCAreaPtr->fet_parcel_flavor is 11 DBCAreaPtr->fet_parcel_flavor is 205 DBCAreaPtr->fet_parcel_flavor is 11 DBCAreaPtr->fet_parcel_flavor is 205 DBCAreaPtr->fet_parcel_flavor is 11 DBCAreaPtr->fet_parcel_flavor is 205 DBCAreaPtr->fet_parcel_flavor is 11 DBCAreaPtr->fet_parcel_flavor is 205 DBCAreaPtr->fet_parcel_flavor is 11 DBCAreaPtr->fet_parcel_flavor is 205 DBCAreaPtr->fet_parcel_flavor is 11 DBCAreaPtr->fet_parcel_flavor is 205 DBCAreaPtr->fet_parcel_flavor is 11 DBCAreaPtr->fet_parcel_flavor is 12 done on DEFAULT PARTITION session 0 Flushing backlog **** 17:38:42 UTY6641 Since last chkpt., 5 recs. in, 5 stmts., 1 reqs **** 17:38:42 UTY6647 Since last chkpt., avg. DBS wait time: 546.00 **** 17:38:42 UTY6612 Beginning final checkpoint... **** 17:38:42 UTY6641 Since last chkpt., 5 recs. in, 5 stmts., 1 reqs **** 17:38:42 UTY6647 Since last chkpt., avg. DBS wait time: 546.00 **** 17:38:42 UTY6607 Checkpoint Completes with 5 rows sent. **** 17:38:42 UTY6642 Import 1 statements: 5, requests: 1 **** 17:38:42 UTY6643 Import 1 average statements per request: 5.00 **** 17:38:42 UTY6644 Import 1 average statements per record: 1.00 **** 17:38:42 UTY6645 Import 1 statements/session: avg. 1.25, min. 0.00, max. 5.00 **** 17:38:42 UTY6646 Import 1 requests/session: average 0.25, minimum 0.00, maximum 1.00 **** 17:38:42 UTY6648 Import 1 DBS wait time/session: avg. 136.50, min. 0.00, max. 546.00 **** 17:38:42 UTY6649 Import 1 DBS wait time/request: avg. 136.50, min. 0.00, max. 546.00 **** 17:38:42 UTY1823 Import processing statistics . IMPORT 1 Total thus far . ========= ============== Candidate records considered:.... 5 5 Apply conditions satisfied:...... 5 5 Records logable to error table:.. 0 0 Candidate records rejected:...... 0 0 **** Statistics for Apply Label : LABEL0012 Type: I Database: FLUSER Table or Macro Name: TESTSA01 Activity: 5 **** 17:38:42 UTY6677 Loading phase statistics Elapsed time: 00:00:00:01(dd:hh:mm:ss) CPU time: 0 Seconds MB/sec: 0.00012 MB/cpusec: N/A **** 17:38:44 UTY0821 Error table FLUSER.TPERRTESTSA01 is EMPTY, dropping table. token = 0, i_sess_id = Ctx->Id = 16 Sending 57 byte request: 'exec TPumpMacro.DeleteImport('FLUSER', 'TESTPSALOGS', 1);' Using 0 byte(s) of data: '' Ctx->ReqId updated to o_req_id = 4 DBCAreaPtr->fet_parcel_flavor is 9 ======================================================================== = = = Logoff/Disconnect = = = ======================================================================== **** 17:38:46 UTY6216 The restart log table has been dropped. **** 17:38:46 UTY6212 A successful disconnect was made from the RDBMS. **** 17:38:46 UTY2410 Total processor time used = '0.405603 Seconds' . Start : 17:38:24 - WED APR 24, 2019 . End : 17:38:46 - WED APR 24, 2019 . Highest return code encountered = '0'. getting out w/rc 0