ERROR OGG-00524 DDL trace log file [\ggs_ddl_trace.log], error code -20782 error message ORA-207

来源：互联网发布：阿里域名隐私保护编辑：程序博客网时间：2024/05/17 20:00

2014-11-20 21:48:55 ERROR OGG-00524 Oracle GoldenGate Capture for Oracle, esource.prm: Error in DDL trigger has been detected: ERROR: DDL se
quence [], marker sequence [43519], DDL trace log file [\ggs_ddl_trace.log], error code -20782 error message ORA-20782: GoldenGate DDL Replicatio
n Error: Code :ORA-01423: error encountered while checking for extra rows in exact fetch ORA-01013: user requested cancel of current operation, e
rror stack: Error stack is avalaible only on Oracle 10.1 and above. Please investigate trace log file or contact Oracle Support.
2014-11-20 21:48:55 ERROR OGG-01668 Oracle GoldenGate Capture for Oracle, esource.prm: PROCESS ABENDING.

GGSCI (zydb) 12> info all

Program Status Group Lag Time SinceChkpt

MANAGER    RUNNING
EXTRACT     ABENDED    ESOURCE     14:14:06     00:02:43
EXTRACT     RUNNING    PSOURCE     00:00:00     00:00:06
检查view report esource;info ESOURCE;moreggserr.log/dump/ggs_ddl_trace.log
2014-11-20 21:50:56 INFO    OGG-01055 OracleGoldenGate Capture for Oracle, esource.prm: Recovery initializationcompleted for target file ./d
irdat/es000124,at RBA 48040000.
2014-11-20 21:50:56 INFO    OGG-01478 OracleGoldenGate Capture for Oracle, esource.prm: Output file ./dirdat/es isusing format RELEASE 10.4/
11.1.
2014-11-20 21:50:57 INFO    OGG-01644 OracleGoldenGate Capture for Oracle, esource.prm: BOUNDED RECOVERY: COMPLETE:for object pool 1: p14053
28_Redo Thread 1 at SeqNo: 6895, RBA: 313687176, SCN: 3273.2359121579

查看select * from V$log; SeqNo: 6895, RBA: 313687176

2014-11-20 21:50:57 INFO    OGG-01026 OracleGoldenGate Capture for Oracle, esource.prm: Rolling over remote file ./dirdat/es000124.
2014-11-20 21:50:57 INFO    OGG-01053 OracleGoldenGate Capture for Oracle, esource.prm: Recovery completed for targetfile ./dirdat/es000125,
at RBA 975.
2014-11-20 21:50:57 INFO    OGG-01057 OracleGoldenGate Capture for Oracle, esource.prm: Recovery completed for alltargets.
2014-11-2021:50:59 ERROR   OGG-00524 Oracle GoldenGate Capture forOracle, esource.prm: Error in DDL trigger has been detected: ERROR: DDLse
quence [], marker sequence [43519], DDL trace log file [\ggs_ddl_trace.log],error code -20782 error message ORA-20782: GoldenGate DDL Replicatio
n Error: Code :ORA-01423: error encountered while checking for extrarows in exact fetch ORA-01013: user requested cancel of current operation, e
rror stack: Error stack is avalaible only on Oracle 10.1 and above. Pleaseinvestigate trace log file or contact Oracle Support.

2014-11-21 02:25:57 INFO   OGG-01057 Oracle GoldenGate Capture for Oracle, esource.prm: Recovery completed for all targets.
2014-11-21 02:25:57 INFO    OGG-01644 OracleGoldenGate Capture for Oracle, esource.prm: BOUNDED RECOVERY: COMPLETE:for object pool 1: p14053
28_Redo Thread 1 at SeqNo: 6895, RBA: 313687176, SCN: 3273.2359121579(14059787081387).
2014-11-21 02:25:59 ERROR   OGG-00524 Oracle GoldenGateCapture for Oracle, esource.prm: Error in DDL trigger has been detected:ERROR: DDL se
quence [], marker sequence [43519], DDL trace log file [\ggs_ddl_trace.log],error code -20782 error message ORA-20782: GoldenGate DDL Replicatio
n Error: Code :ORA-01423: error encountered while checking for extra rows inexact fetch ORA-01013: user requested cancel of current operation, e
rror stack: Error stack is avalaible only on Oracle 10.1 and above. Pleaseinvestigate trace log file or contact Oracle Support.
2014-11-21 02:25:59 ERROR   OGG-01668 Oracle GoldenGateCapture for Oracle, esource.prm: PROCESS ABENDING.

2014-11-21 09:41:58 INFO OGG-01644 BOUNDEDRECOVERY: COMPLETE: for object pool 1: p1405328_Redo Thread 1 at SeqNo: 6895,RBA: 313687176, SCN
: 3273.2359121579 (14059787081387).
TABLE resolved (entry OGGADM.GGS_MARKER):
TABLE OGGADM.GGS_MARKER;

Using the following key columns for source tableOGGADM.GGS_MARKER: SEQNO, FRAGMENTNO, OPTIME.

Source Context :
SourceModule           : [ggapp.ddl]
SourceID               :[/scratch/aime2/adestore/views/aime2_staxk11/oggcore/OpenSys/src/gglib/ggapp/ddlext.c]
SourceFunction          :[checkInputData(char *, extractDDL_t *)]
SourceLine             : [942]

2014-11-21 09:42:00 ERROR OGG-00524 Error in DDL trigger has been detected: ERROR: DDL sequence [], marker sequence[43519], DDL trace log fi
le [\ggs_ddl_trace.log], error code -20782 error message ORA-20782: GoldenGateDDL Replication Error: Code :ORA-01423: error encountered while ch
ecking for extra rows in exact fetch
ORA-01013: user requested cancel of current operation, error stack: Error stackis avalaible only on Oracle 10.1 and above. Please investigate tr
ace log file or contact Oracle Support.

尝试：（源端报错）

target file ./dirdat/es000124,at RBA 48040000.

查看select * from V$log; SeqNo: 6895, RBA: 313687176
alter extractESOURCE, extseqno 6895, extrba 313687176, thread 1
start esource
检查view report esource报同样错：
Source Context :
SourceModule           : [ggapp.ddl]
SourceID               :[/scratch/aime2/adestore/views/aime2_staxk11/oggcore/OpenSys/src/gglib/ggapp/ddlext.c]
SourceFunction          :[checkInputData(char *, extractDDL_t *)]
SourceLine             : [942]

2014-11-21 09:48:35 ERROR OGG-00524 Error in DDL trigger has been detected: ERROR: DDL sequence [], marker sequence[43519], DDL trace log fi
le [\ggs_ddl_trace.log], error code -20782 error message ORA-20782: GoldenGateDDL Replication Error: Code :ORA-01423: error encountered while ch
ecking for extra rows in exact fetch
ORA-01013: user requested cancel of current operation, error stack: Error stackis avalaible only on Oracle 10.1 and above. Please investigate tr
ace log file or contact Oracle Support.

然后继续尝试加1，这个和dirdat/esxxx中的rba不是一回事：
alter extractESOURCE, extseqno 6895, extrba 313687177, thread 1
start esource
检查view report esource报新错误：
2014-11-21 09:52:28 INFO OGG-01513 Positioning to(Thread 1) Sequence 6895, RBA 313687177, SCN 0.0.

2014-11-21 09:52:28 INFO OGG-01516 Positioned to (Thread 1) Sequence 6895, RBA 313687177, SCN 0.0,Nov 20, 2014 7:34:25 PM.

2014-11-21 09:52:28 INFO OGG-01517 Position of first record processed for Thread 1, Sequence 6895,RBA 313687177, SCN 51596.2639702789, Nov
20, 2014 7:34:56 PM.

2014-11-21 09:52:28 INFO OGG-01056 Recovery initialization completed for target file./dirdat/es000161, at RBA 268929, CSN 14059789688731.

2014-11-21 09:52:28 INFO OGG-01478 Output file ./dirdat/es is using format RELEASE 10.4/11.1.

2014-11-21 09:52:28 WARNING OGG-01438 Checkpointmarked as from graceful shutdown, but records found after checkpoint in trail ./dirdat/es. Ex
pected EOF Seqno 161, RBA 1186. Found Seqno 161, RBA 268929.

2014-11-21 09:52:28 INFO OGG-01026 Rolling over remote file ./dirdat/es000161.

***********************************************************************
** Run TimeMessages **
***********************************************************************

Source Context :
SourceModule           : [er.redo.ora.rtc]
SourceID               : [/scratch/aime2/adestore/views/aime2_staxk11/oggcore/OpenSys/src/app/er/redo/oracle/rtc.c]
SourceFunction          :[RTC_producer(void *)]
SourceLine             : [1907]

2014-11-2109:52:29 ERROR OGG-01028 Out of order SCN3273.2361822192 (14059789782000) in record for sequence 6896 (last SCN51596.2639702789
(221605772307205)).

尝试使用下一个日志组开始捕捉：可能丢失一些事物。
alter EXTRACTESOURCE, extseqno 6896, extrba 0, thread 1
start esource
info all
全部正常。

最正确的操作应该参考如下：
http://www.tuicool.com/articles/jQfAJn

target file ./dirdat/es000124,at RBA 48040000.

$ ./logdump

Oracle GoldenGate Log File Dump Utility
Version 11.1.1.1.2 OGGCORE_11.1.1.1.2_PLATFORMS_111004.2100

Logdump 1 >open dirdat/es000124
Current LogTrail is /zyhome/oracle/ogg/dirdat/es000124
Logdump 2 >pos 48040000
Reading forward from RBA 48040000
Logdump 3 >n /next
Logdump 4 >n
Logdump 5 >n
Logdump 6 >n
Logdump 7 >exit
根据上面的dump查看表名没有后续事物。所以本次采用redo的方式跳过。

参考检查info esource,detail

GGSCI (zydb) 7> info esource,detail

EXTRACT    ESOURCE   Last Started2014-11-21 09:53   Status RUNNING
Checkpoint Lag       00:00:00 (updated 00:00:06ago)
Log Read Checkpoint Oracle Redo Logs
                    2014-11-21 10:26:26 Thread 1, Seqno 6898, RBA137989996

Target Extract Trails:

Remote TrailName Seqno RBA MaxMB

./dirdat/es 163 8654184 100

ExtractSource Begin End

/zyredo/redo04.log                     2014-11-20 19:34 2014-11-21 10:26
/zyredo/redo05.log                     * Initialized *   2014-11-20 19:34
/zyredo/redo05.log                     2014-11-20 19:34 2014-11-20 19:34
NotAvailable                          * Initialized *   2014-11-20 19:34
NotAvailable                          2014-11-20 21:48 2014-11-20 19:34
/zyredo/redo05.log                     * Initialized *   2014-11-20 21:48
/zyredo/redo05.log                     2014-08-26 19:28 2014-11-20 21:48
/zyredo/redo05.log                     2014-08-26 19:28 2014-11-20 21:48
/zyredo/redo05.log                     2014-08-26 19:28 2014-11-20 21:48
/zyredo/redo05.log                     2014-08-26 19:28 2014-11-20 21:48

XXXXXXXXXXXXXXXXXXXXXXXXX

$ ./logdump

Oracle GoldenGate Log File Dump Utility

Version 11.1.1.1.2OGGCORE_11.1.1.1.2_PLATFORMS_111004.2100

Logdump 1 >open dirdat/es000124

Current LogTrail is/zyhome/oracle/ogg/dirdat/es000124

Logdump 2 >pos 48040000

Reading forward from RBA 48040000

Logdump 3 >n

Logdump 4 >n

Logdump 5 >n

Logdump 15 >sfh forward

Scan reached EOF

Logdump 16 >sfh back

2014/11/20 21:32:42.000.000 FieldComp Len 139 RBA 48039759

Name: GISTAR.JR_COVER_ADDRESS

After Image: Partition 4 G e

0000000a 0000 0006 3333 3939 3936 0006 000c 0000 | ........339996......

0008d4b6 d1f3 d2bb b7bd 000a 0008 0000 0004 5c2d | ..................\-

2d5c0013 0048 0000 0044 b1b1 bea9 b1b1 bea9 cad0 | -\...H...D..........

b3afd1f4 c7f8 5cb9 dcd7 afcb fed3 aab1 b1bd d631 | ......\............1

bac5d4ba d4b6 d1f3 d2bb b7bd 31ba c5c2 a531 b5a5 | ............1....1..

d4aa5c2d 2d5c 3134 3032 28b7 bdc8 f3d4 b229 0014 | ..\--\1402(......)..

00080000 0004 b7bf bce4 001d 0005 0000 0001 59 | ..................Y

Column 0 (x0000), Len 10 (x000a)

Column 6 (x0006), Len 12 (x000c)

Column 10 (x000a), Len 8 (x0008)

Column 19 (x0013), Len 72 (x0048)

Column 20 (x0014), Len 8 (x0008)

Column 29 (x001d), Len 5 (x0005)

Logdump 17 >sfh back

2014/11/20 21:32:42.000.000 FieldComp Len 57 RBA 48039564

Name: GISTAR.JR_CUSTOMER_RECORD

After Image: Partition 4 G b

0000000c 0000 0008 3730 3431 3034 3035 0024 000c | ........70410405.$..

00000008 b1be b5d8 cda8 bbb0 0025 0015 0000 0011 | .............%......

b1beb5d8 cda8 bbb0 2cc0 b4b5 e7cf d4ca be | ........,........

Column 0 (x0000), Len 12 (x000c)

Column 36 (x0024), Len 12 (x000c)

Column 37 (x0025), Len 21 (x0015)

Logdump 18 >exit

0 0