GGSCI (node1.localdomain as ggadmin@ggsrc) 4> start extract exhr01
Sending START request to MANAGER ...
EXTRACT EXHR01 starting
GGSCI (node1.localdomain as ggadmin@ggsrc) 5> info all
Program Status Group Lag at Chkpt Time Since Chkpt
MANAGER RUNNING
EXTRACT ABENDED EXHR01 00:28:25 00:00:03
GGSCI (node1.localdomain as ggadmin@ggsrc) 6> view report exhr01
***********************************************************************
Oracle GoldenGate Capture for Oracle
Version 12.1.2.1.0 OGGCORE_12.1.2.1.0_PLATFORMS_140727.2135.1_FBO
Linux, x64, 64bit (optimized), Oracle 12c on Aug 7 2014 10:40:21
Copyright (C) 1995, 2014, Oracle and/or its affiliates. All rights reserved.
Starting at 2015-09-20 12:26:29
***********************************************************************
Operating System Version:
Linux
Version #1 SMP Fri Feb 22 18:16:18 PST 2013, Release 2.6.39-400.17.1.el6uek.x86_64
Node: node1.localdomain
Machine: x86_64
soft limit hard limit
Address Space Size : unlimited unlimited
Heap Size : unlimited unlimited
File Size : unlimited unlimited
CPU Time : unlimited unlimited
Process id: 5706
Description:
***********************************************************************
** Running with the following parameters **
***********************************************************************
2015-09-20 12:26:29 INFO OGG-03059 Operating system character set identified as UTF-8.
2015-09-20 12:26:29 INFO OGG-02695 ANSI SQL parameter syntax is used for parameter parsing.
EXTRACT EXHR01
SETENV (ORACLE_SID=ggsrc)
2015-09-20 12:26:29 INFO OGG-02095 Successfully set environment variable ORACLE_SID=ggsrc.
USERID ggadmin , PASSWORD *******
2015-09-20 12:26:30 INFO OGG-03522 Setting session time zone to source database time zone 'GMT'.
EXTTRAIL ./dirdat/hr
TABLE HR.* ;
2015-09-20 12:26:30 INFO OGG-01815 Virtual Memory Facilities for: BR
anon alloc: mmap(MAP_ANON) anon free: munmap
file alloc: mmap(MAP_SHARED) file free: munmap
target directories:
/data01/oracle/ggs/BR/EXHR01.
Bounded Recovery Parameter:
BRINTERVAL = 4HOURS
BRDIR = /data01/oracle/ggs
2015-09-20 12:26:30 INFO OGG-01851 filecaching started: thread ID: 140605740996352.
2015-09-20 12:26:30 INFO OGG-01815 Virtual Memory Facilities for: COM
anon alloc: mmap(MAP_ANON) anon free: munmap
file alloc: mmap(MAP_SHARED) file free: munmap
target directories:
/data01/oracle/ggs/dirtmp.
CACHEMGR virtual memory values (may have been adjusted)
CACHESIZE: 64G
CACHEPAGEOUTSIZE (default): 8M
PROCESS VM AVAIL FROM OS (min): 128G
CACHESIZEMAX (strict force to disk): 96G
Database Version:
Oracle Database 12c Enterprise Edition Release 12.1.0.1.0 - 64bit Production
PL/SQL Release 12.1.0.1.0 - Production
CORE 12.1.0.1.0 Production
TNS for Linux: Version 12.1.0.1.0 - Production
NLSRTL Version 12.1.0.1.0 - Production
Database Language and Character Set:
NLS_LANGUAGE = "AMERICAN"
NLS_TERRITORY = "AMERICA"
NLS_CHARACTERSET = "WE8MSWIN1252"
2015-09-20 12:26:30 INFO OGG-01513 Positioning to Sequence 9, RBA 5464080, SCN 0.0.
2015-09-20 12:26:30 INFO OGG-01516 Positioned to Sequence 9, RBA 5464080, SCN 0.0, Sep 20, 2015 11:58:05 AM.
2015-09-20 12:26:30 INFO OGG-01055 Recovery initialization completed for target file ./dirdat/hr000001, at RBA 1474.
2015-09-20 12:26:30 INFO OGG-01478 Output file ./dirdat/hr is using format RELEASE 12.1.
2015-09-20 12:26:30 INFO OGG-01026 Rolling over remote file ./dirdat/hr000001.
2015-09-20 12:26:30 INFO OGG-01053 Recovery completed for target file ./dirdat/hr000002, at RBA 1474.
2015-09-20 12:26:30 INFO OGG-01057 Recovery completed for all targets.
***********************************************************************
** Run Time Messages **
***********************************************************************
2015-09-20 12:26:30 INFO OGG-01517 Position of first record processed Sequence 9, RBA 5464080, SCN 0.1863330, Sep 20, 20
15 11:59:57 AM.
Source Context :
SourceModule : [er.redo.ora.rdr]
SourceID : [/scratch/aime1/adestore/views/aime1_adc4150384/oggcore/OpenSys/src/app/er/redo/oracle/redoorardr
.c]
SourceFunction : [REDOORARDR_get_next_record]
SourceLine : [6988]
ThreadBacktrace : [14] elements
: [/data01/oracle/ggs/libgglog.so(CMessageContext::AddThreadContext()+0x1e) [0x7fe160262dae]]
: [/data01/oracle/ggs/libgglog.so(CMessageFactory::CreateMessage(CSourceContext*, unsigned int, ...
)+0x340) [0x7fe16025dac0]]
: [/data01/oracle/ggs/libgglog.so(_MSG_ERR_ORACLE_IN_MEMORY_UNDO_UNHANDLED(CSourceContext*, unsigne
d int, long, char const*, CMessageFactory::MessageDisposition)+0x41) [0x7fe160245c85]]
: [/data01/oracle/ggs/extract(REDOORARDR_get_next_record(log_context_t*, log_cursor_t*, unsigned in
t, int, char*, unsigned int*, unsigned int*, long*, rec_position_t*, char (&) [2048])+0x1bba) [0x7ae66a]]
: [/data01/oracle/ggs/extract(REDO_read(char*, int*, long*, char*, short*, int, char (&) [2048])+0x
50e) [0x7586ee]]
: [/data01/oracle/ggs/extract(READ_EXTRACT_RECORD(chkpt_context_t*, short, char*, unsigned long, __
std_rec_hdr*, int*, int*, long*, short, char*, short*, char*, short*, long*, char (&) [2048])+0xe9) [0x53ed19]]
: [/data01/oracle/ggs/extract(process_extract_loop()+0x7f6) [0x5c1c96]]
: [/data01/oracle/ggs/extract(extract_main(int, char**)+0x418) [0x5c0098]]
: [/data01/oracle/ggs/extract(ggs::gglib::MultiThreading::MainThread::ExecMain()+0x4f) [0x6ab4df]]
: [/data01/oracle/ggs/extract(ggs::gglib::MultiThreading::Thread::RunThread(ggs::gglib::MultiThread
ing::Thread::ThreadArgs*)+0x104) [0x6ab9e4]]
: [/data01/oracle/ggs/extract(ggs::gglib::MultiThreading::MainThread::Run(int, char**)+0x8b) [0x6ab
dab]]
: [/data01/oracle/ggs/extract(main+0x3f) [0x5bfa2f]]
: [/lib64/libc.so.6(__libc_start_main+0xfd) [0x34a3e1ecdd]]
: [/data01/oracle/ggs/extract() [0x534319]]
2015-09-20 12:26:30 ERROR OGG-00717 Found unsupported in-memory undo record in sequence 9, at RBA 5474956, with SCN 0.186
3343 (1863343) ... Minimum supplemental logging must be enabled to prevent data loss.
***********************************************************************
* ** Run Time Statistics ** *
***********************************************************************
Report at 2015-09-20 12:26:30 (activity since 2015-09-20 12:26:29)
Output to ./dirdat/hr:
No records extracted.
2015-09-20 12:26:30 ERROR OGG-01668 PROCESS ABENDING.
CACHE OBJECT MANAGER statistics
CACHE MANAGER VM USAGE
vm current = 0 vm anon queues = 0
vm anon in use = 0 vm file = 0
vm used max = 0 ==> CACHE BALANCED
CACHE CONFIGURATION
cache size = 64G cache force paging = 96G
buffer min = 64K buffer max (soft) = 8M
pageout eligible size = 8M
================================================================================
RUNTIME STATS FOR SUPERPOOL
CACHE Transaction Stats
trans active = 0 max concurrent = 1
Solution :
=======
Alter the extract to start to position when supplemental log has been enabled :
GGSCI (node1.localdomain as ggadmin@ggsrc) 7> alter extract, exhr01 begin now
EXTRACT altered.
GGSCI (node1.localdomain as ggadmin@ggsrc) 8> start extract exhr01
Sending START request to MANAGER ...
EXTRACT EXHR01 starting
GGSCI (node1.localdomain as ggadmin@ggsrc) 9> info all
Program Status Group Lag at Chkpt Time Since Chkpt
MANAGER RUNNING
EXTRACT RUNNING EXHR01 00:00:00 00:00:01
Sending START request to MANAGER ...
EXTRACT EXHR01 starting
GGSCI (node1.localdomain as ggadmin@ggsrc) 5> info all
Program Status Group Lag at Chkpt Time Since Chkpt
MANAGER RUNNING
EXTRACT ABENDED EXHR01 00:28:25 00:00:03
GGSCI (node1.localdomain as ggadmin@ggsrc) 6> view report exhr01
***********************************************************************
Oracle GoldenGate Capture for Oracle
Version 12.1.2.1.0 OGGCORE_12.1.2.1.0_PLATFORMS_140727.2135.1_FBO
Linux, x64, 64bit (optimized), Oracle 12c on Aug 7 2014 10:40:21
Copyright (C) 1995, 2014, Oracle and/or its affiliates. All rights reserved.
Starting at 2015-09-20 12:26:29
***********************************************************************
Operating System Version:
Linux
Version #1 SMP Fri Feb 22 18:16:18 PST 2013, Release 2.6.39-400.17.1.el6uek.x86_64
Node: node1.localdomain
Machine: x86_64
soft limit hard limit
Address Space Size : unlimited unlimited
Heap Size : unlimited unlimited
File Size : unlimited unlimited
CPU Time : unlimited unlimited
Process id: 5706
Description:
***********************************************************************
** Running with the following parameters **
***********************************************************************
2015-09-20 12:26:29 INFO OGG-03059 Operating system character set identified as UTF-8.
2015-09-20 12:26:29 INFO OGG-02695 ANSI SQL parameter syntax is used for parameter parsing.
EXTRACT EXHR01
SETENV (ORACLE_SID=ggsrc)
2015-09-20 12:26:29 INFO OGG-02095 Successfully set environment variable ORACLE_SID=ggsrc.
USERID ggadmin , PASSWORD *******
2015-09-20 12:26:30 INFO OGG-03522 Setting session time zone to source database time zone 'GMT'.
EXTTRAIL ./dirdat/hr
TABLE HR.* ;
2015-09-20 12:26:30 INFO OGG-01815 Virtual Memory Facilities for: BR
anon alloc: mmap(MAP_ANON) anon free: munmap
file alloc: mmap(MAP_SHARED) file free: munmap
target directories:
/data01/oracle/ggs/BR/EXHR01.
Bounded Recovery Parameter:
BRINTERVAL = 4HOURS
BRDIR = /data01/oracle/ggs
2015-09-20 12:26:30 INFO OGG-01851 filecaching started: thread ID: 140605740996352.
2015-09-20 12:26:30 INFO OGG-01815 Virtual Memory Facilities for: COM
anon alloc: mmap(MAP_ANON) anon free: munmap
file alloc: mmap(MAP_SHARED) file free: munmap
target directories:
/data01/oracle/ggs/dirtmp.
CACHEMGR virtual memory values (may have been adjusted)
CACHESIZE: 64G
CACHEPAGEOUTSIZE (default): 8M
PROCESS VM AVAIL FROM OS (min): 128G
CACHESIZEMAX (strict force to disk): 96G
Database Version:
Oracle Database 12c Enterprise Edition Release 12.1.0.1.0 - 64bit Production
PL/SQL Release 12.1.0.1.0 - Production
CORE 12.1.0.1.0 Production
TNS for Linux: Version 12.1.0.1.0 - Production
NLSRTL Version 12.1.0.1.0 - Production
Database Language and Character Set:
NLS_LANGUAGE = "AMERICAN"
NLS_TERRITORY = "AMERICA"
NLS_CHARACTERSET = "WE8MSWIN1252"
2015-09-20 12:26:30 INFO OGG-01513 Positioning to Sequence 9, RBA 5464080, SCN 0.0.
2015-09-20 12:26:30 INFO OGG-01516 Positioned to Sequence 9, RBA 5464080, SCN 0.0, Sep 20, 2015 11:58:05 AM.
2015-09-20 12:26:30 INFO OGG-01055 Recovery initialization completed for target file ./dirdat/hr000001, at RBA 1474.
2015-09-20 12:26:30 INFO OGG-01478 Output file ./dirdat/hr is using format RELEASE 12.1.
2015-09-20 12:26:30 INFO OGG-01026 Rolling over remote file ./dirdat/hr000001.
2015-09-20 12:26:30 INFO OGG-01053 Recovery completed for target file ./dirdat/hr000002, at RBA 1474.
2015-09-20 12:26:30 INFO OGG-01057 Recovery completed for all targets.
***********************************************************************
** Run Time Messages **
***********************************************************************
2015-09-20 12:26:30 INFO OGG-01517 Position of first record processed Sequence 9, RBA 5464080, SCN 0.1863330, Sep 20, 20
15 11:59:57 AM.
Source Context :
SourceModule : [er.redo.ora.rdr]
SourceID : [/scratch/aime1/adestore/views/aime1_adc4150384/oggcore/OpenSys/src/app/er/redo/oracle/redoorardr
.c]
SourceFunction : [REDOORARDR_get_next_record]
SourceLine : [6988]
ThreadBacktrace : [14] elements
: [/data01/oracle/ggs/libgglog.so(CMessageContext::AddThreadContext()+0x1e) [0x7fe160262dae]]
: [/data01/oracle/ggs/libgglog.so(CMessageFactory::CreateMessage(CSourceContext*, unsigned int, ...
)+0x340) [0x7fe16025dac0]]
: [/data01/oracle/ggs/libgglog.so(_MSG_ERR_ORACLE_IN_MEMORY_UNDO_UNHANDLED(CSourceContext*, unsigne
d int, long, char const*, CMessageFactory::MessageDisposition)+0x41) [0x7fe160245c85]]
: [/data01/oracle/ggs/extract(REDOORARDR_get_next_record(log_context_t*, log_cursor_t*, unsigned in
t, int, char*, unsigned int*, unsigned int*, long*, rec_position_t*, char (&) [2048])+0x1bba) [0x7ae66a]]
: [/data01/oracle/ggs/extract(REDO_read(char*, int*, long*, char*, short*, int, char (&) [2048])+0x
50e) [0x7586ee]]
: [/data01/oracle/ggs/extract(READ_EXTRACT_RECORD(chkpt_context_t*, short, char*, unsigned long, __
std_rec_hdr*, int*, int*, long*, short, char*, short*, char*, short*, long*, char (&) [2048])+0xe9) [0x53ed19]]
: [/data01/oracle/ggs/extract(process_extract_loop()+0x7f6) [0x5c1c96]]
: [/data01/oracle/ggs/extract(extract_main(int, char**)+0x418) [0x5c0098]]
: [/data01/oracle/ggs/extract(ggs::gglib::MultiThreading::MainThread::ExecMain()+0x4f) [0x6ab4df]]
: [/data01/oracle/ggs/extract(ggs::gglib::MultiThreading::Thread::RunThread(ggs::gglib::MultiThread
ing::Thread::ThreadArgs*)+0x104) [0x6ab9e4]]
: [/data01/oracle/ggs/extract(ggs::gglib::MultiThreading::MainThread::Run(int, char**)+0x8b) [0x6ab
dab]]
: [/data01/oracle/ggs/extract(main+0x3f) [0x5bfa2f]]
: [/lib64/libc.so.6(__libc_start_main+0xfd) [0x34a3e1ecdd]]
: [/data01/oracle/ggs/extract() [0x534319]]
2015-09-20 12:26:30 ERROR OGG-00717 Found unsupported in-memory undo record in sequence 9, at RBA 5474956, with SCN 0.186
3343 (1863343) ... Minimum supplemental logging must be enabled to prevent data loss.
***********************************************************************
* ** Run Time Statistics ** *
***********************************************************************
Report at 2015-09-20 12:26:30 (activity since 2015-09-20 12:26:29)
Output to ./dirdat/hr:
No records extracted.
2015-09-20 12:26:30 ERROR OGG-01668 PROCESS ABENDING.
CACHE OBJECT MANAGER statistics
CACHE MANAGER VM USAGE
vm current = 0 vm anon queues = 0
vm anon in use = 0 vm file = 0
vm used max = 0 ==> CACHE BALANCED
CACHE CONFIGURATION
cache size = 64G cache force paging = 96G
buffer min = 64K buffer max (soft) = 8M
pageout eligible size = 8M
================================================================================
RUNTIME STATS FOR SUPERPOOL
CACHE Transaction Stats
trans active = 0 max concurrent = 1
Solution :
=======
SQL> alter database add supplemental log data ;
Enable schema level supplemental loging using ggsci
Enable schema level supplemental loging using ggsci
GGSCI> add schematrandata HR
Alter the extract to start to position when supplemental log has been enabled :
GGSCI (node1.localdomain as ggadmin@ggsrc) 7> alter extract, exhr01 begin now
EXTRACT altered.
GGSCI (node1.localdomain as ggadmin@ggsrc) 8> start extract exhr01
Sending START request to MANAGER ...
EXTRACT EXHR01 starting
GGSCI (node1.localdomain as ggadmin@ggsrc) 9> info all
Program Status Group Lag at Chkpt Time Since Chkpt
MANAGER RUNNING
EXTRACT RUNNING EXHR01 00:00:00 00:00:01
GGSCI (node1.localdomain as ggadmin@ggsrc) 11> info extract exhr01
EXTRACT EXHR01 Last Started 2015-09-20 12:28 Status RUNNING
Checkpoint Lag 00:00:00 (updated 00:00:02 ago)
Process ID 5735
Log Read Checkpoint Oracle Redo Logs
2015-09-20 12:46:51 Seqno 10, RBA 802304
SCN 0.1867251 (1867251)
GGSCI (node1.localdomain as ggadmin@ggsrc) 12> info extract exhr01 , detail
EXTRACT EXHR01 Last Started 2015-09-20 12:28 Status RUNNING
Checkpoint Lag 00:00:00 (updated 00:00:06 ago)
Process ID 5735
Log Read Checkpoint Oracle Redo Logs
2015-09-20 12:46:51 Seqno 10, RBA 802304
SCN 0.1867251 (1867251)
Target Extract Trails:
Trail Name Seqno RBA Max MB Trail Type
./dirdat/hr 3 1474 100 EXTTRAIL
Extract Source Begin End
/data01/app/oracle/oradata/ggsrc/redo01.log 2015-09-20 12:28 2015-09-20 12:46
/data01/app/oracle/oradata/ggsrc/redo03.log * Initialized * 2015-09-20 12:28
/data01/app/oracle/oradata/ggsrc/redo03.log 2015-09-20 11:58 2015-09-20 11:58
/data01/app/oracle/oradata/ggsrc/redo03.log 2015-09-20 11:58 2015-09-20 11:58
/data01/app/oracle/oradata/ggsrc/redo03.log 2015-09-20 11:58 2015-09-20 11:58
Not Available * Initialized * 2015-09-20 11:58
Not Available * Initialized * 2015-09-20 11:58
Current directory /data01/oracle/ggs
Report file /data01/oracle/ggs/dirrpt/EXHR01.rpt
Parameter file /data01/oracle/ggs/dirprm/exhr01.prm
Checkpoint file /data01/oracle/ggs/dirchk/EXHR01.cpe
Process file /data01/oracle/ggs/dirpcs/EXHR01.pce
Error log /data01/oracle/ggs/ggserr.log
GGSCI (node1.localdomain as ggadmin@ggsrc) 13>
EXTRACT EXHR01 Last Started 2015-09-20 12:28 Status RUNNING
Checkpoint Lag 00:00:00 (updated 00:00:02 ago)
Process ID 5735
Log Read Checkpoint Oracle Redo Logs
2015-09-20 12:46:51 Seqno 10, RBA 802304
SCN 0.1867251 (1867251)
GGSCI (node1.localdomain as ggadmin@ggsrc) 12> info extract exhr01 , detail
EXTRACT EXHR01 Last Started 2015-09-20 12:28 Status RUNNING
Checkpoint Lag 00:00:00 (updated 00:00:06 ago)
Process ID 5735
Log Read Checkpoint Oracle Redo Logs
2015-09-20 12:46:51 Seqno 10, RBA 802304
SCN 0.1867251 (1867251)
Target Extract Trails:
Trail Name Seqno RBA Max MB Trail Type
./dirdat/hr 3 1474 100 EXTTRAIL
Extract Source Begin End
/data01/app/oracle/oradata/ggsrc/redo01.log 2015-09-20 12:28 2015-09-20 12:46
/data01/app/oracle/oradata/ggsrc/redo03.log * Initialized * 2015-09-20 12:28
/data01/app/oracle/oradata/ggsrc/redo03.log 2015-09-20 11:58 2015-09-20 11:58
/data01/app/oracle/oradata/ggsrc/redo03.log 2015-09-20 11:58 2015-09-20 11:58
/data01/app/oracle/oradata/ggsrc/redo03.log 2015-09-20 11:58 2015-09-20 11:58
Not Available * Initialized * 2015-09-20 11:58
Not Available * Initialized * 2015-09-20 11:58
Current directory /data01/oracle/ggs
Report file /data01/oracle/ggs/dirrpt/EXHR01.rpt
Parameter file /data01/oracle/ggs/dirprm/exhr01.prm
Checkpoint file /data01/oracle/ggs/dirchk/EXHR01.cpe
Process file /data01/oracle/ggs/dirpcs/EXHR01.pce
Error log /data01/oracle/ggs/ggserr.log
GGSCI (node1.localdomain as ggadmin@ggsrc) 13>
No comments:
Post a Comment