OGG-01031

2014-05-21 19:54:17  ERROR   OGG-01031  There is a problem in network communication, a remote file problem, encryption keys for target and source do not match (if using ENCRYPT) or an unknown
 error. (Reply received is Unable to open file "/u01/ogg/app/ogg/rl/re000023" (error 11, Resource temporarily unavailable)).

错误：远程文件被加锁,pump进程终止

在remote端可以看到相关的日志信息

2014-05-21 19:54:19  INFO    OGG-01677  Oracle GoldenGate Collector for Oracle:  Waiting for connection (started dynamically).
2014-05-21 19:54:19  INFO    OGG-00963  Oracle GoldenGate Manager for Oracle, mgr.prm:  Command received from SERVER on host [127.0.0.1]:16590 (REPORT 31899 7820).
2014-05-21 19:54:19  INFO    OGG-00974  Oracle GoldenGate Manager for Oracle, mgr.prm:  Manager started collector process (Port 7820).
2014-05-21 19:54:19  INFO    OGG-01228  Oracle GoldenGate Collector for Oracle:  Timeout in 300 seconds.
2014-05-21 19:54:24  INFO    OGG-01229  Oracle GoldenGate Collector for Oracle:  Connected to localhost:55542.
2014-05-21 19:54:24  INFO    OGG-01669  Oracle GoldenGate Collector for Oracle:  Opening /u01/ogg/app/ogg/rl/re000023 (byte -1, current EOF 1482).
2014-05-21 19:54:34  WARNING OGG-01223  Oracle GoldenGate Collector for Oracle:  Unable to lock file " (error 11, Resource temporarily unavailable).  Lock currently held by process id (PID) 28944.

解决方法：

  1 非RAC环境下，解决办法

    

a. 在remote端，stop replicat 进程
b. mv /u01/ogg/app/ogg/rl/re000023 /u01/ogg/app/ogg/rl/re000023bak
c. cp /u01/ogg/app/ogg/rl/re000023bak 
/u01/ogg/app/ogg/rl/re000023
d start replcat 进程
e start pump进程

   2.在RAC环境下

  

a. 模拟掉电   装其中正在跑goldengate工具的一端强制关机
b.可以观察到

GGSCI (rac2) 36> info all

Program     Status      Group       Lag at Chkpt  Time Since Chkpt

MANAGER     RUNNING                                           
EXTRACT     RUNNING     EXT1        00:00:00      00:00:01    
EXTRACT     ABENDED     PUMP1       00:00:00      00:06:43    
REPLICAT    RUNNING     REPL1       00:00:00      00:00:02    

c.重新启动刚掉的机器，等集群启动好 大概过二分钟左右的时间

GGSCI (rac2) 37> info all

MANAGER     RUNNING                                           
EXTRACT     RUNNING     EXT1        00:00:00      00:00:03    
EXTRACT     RUNNING     PUMP1       00:00:00      00:06:45    
REPLICAT    RUNNING     REPL1       00:00:00      00:00:04 <pre name="code" class="html">可以观察到进程通过 
观察远程和本地的日志

2014-05-21 20:05:43  INFO    OGG-01229  Oracle GoldenGate Collector for Oracle:  Connected to localhost:46156.
2014-05-21 20:05:43  INFO    OGG-01669  Oracle GoldenGate Collector for Oracle:  Opening /u01/ogg/app/ogg/rl/re000025 (byte -1, current EOF 1482).
2014-05-21 20:05:53  WARNING OGG-01223  Oracle GoldenGate Collector for Oracle:  Unable to lock file "/u01/ogg/app/ogg/rl/re000025" (error 11, Resource temporarily unavailable).  Lock currently held by process id (PID) 32464.
2014-05-21 20:05:53  WARNING OGG-01223  Oracle GoldenGate Collector for Oracle:  Unable to open file "/u01/ogg/app/ogg/rl/re000025" (error 11, Resource temporarily unavailable).
2014-05-21 20:05:53  INFO    OGG-01676  Oracle GoldenGate Collector for Oracle:  Terminating after client disconnect.
2014-05-21 20:07:01  INFO    OGG-01670  Oracle GoldenGate Collector for Oracle:  Closing /u01/ogg/app/ogg/rl/re000025.
2014-05-21 20:07:01  INFO    OGG-01676  Oracle GoldenGate Collector for Oracle:  Terminating after client disconnect.
2014-05-21 20:08:38  INFO    OGG-00963  Oracle GoldenGate Manager for Oracle, mgr.prm:  Command received from EXTRACT on host [192.168.0.112]:16843 (START SERVER CPU -1 PRI -1  TIMEOUT 300 PARAMS ).
2014-05-21 20:08:38  INFO    OGG-01677  Oracle GoldenGate Collector for Oracle:  Waiting for connection (started dynamically).
2014-05-21 20:08:38  INFO    OGG-00963  Oracle GoldenGate Manager for Oracle, mgr.prm:  Command received from SERVER on host [127.0.0.1]:16610 (REPORT 804 7819).
2014-05-21 20:08:38  INFO    OGG-00974  Oracle GoldenGate Manager for Oracle, mgr.prm:  Manager started collector process (Port 7819).
2014-05-21 20:08:38  INFO    OGG-01228  Oracle GoldenGate Collector for Oracle:  Timeout in 300 seconds.
2014-05-21 20:08:43  INFO    OGG-01229  Oracle GoldenGate Collector for Oracle:  Connected to localhost:15125.
2014-05-21 20:08:43  INFO    OGG-01669  Oracle GoldenGate Collector for Oracle:  Opening /u01/ogg/app/ogg/rl/re000025 (byte -1, current EOF 1482).
2014-05-21 20:08:43  INFO    OGG-01670  Oracle GoldenGate Collector for Oracle:  Closing /u01/ogg/app/ogg/rl/re000025.
2014-05-21 20:08:43  INFO    OGG-01669  Oracle GoldenGate Collector for Oracle:  Opening /u01/ogg/app/ogg/rl/re000025 (byte 1482, current EOF 1482).
2014-05-21 20:08:43  INFO    OGG-01735  Oracle GoldenGate Collector for Oracle:  Synchronizing /u01/ogg/app/ogg/rl/re000025 to disk.
2014-05-21 20:08:43  INFO    OGG-01971  Oracle GoldenGate Collector for Oracle:  The previous message, 'INFO OGG-01735', repeated 1 times.
2014-05-21 20:08:43  INFO    OGG-01670  Oracle GoldenGate Collector for Oracle:  Closing /u01/ogg/app/ogg/rl/re000025.
2014-05-21 20:08:43  INFO    OGG-01669  Oracle GoldenGate Collector for Oracle:  Opening /u01/ogg/app/ogg/rl/re000026 (byte -1, current EOF 0).
2014-05-21 20:08:43  INFO    OGG-01735  Oracle GoldenGate Collector for Oracle:  Synchronizing /u01/ogg/app/ogg/rl/re000026 to disk.
2014-05-21 20:08:43  INFO    OGG-01971  Oracle GoldenGate Collector for Oracle:  The previous message, 'INFO OGG-01735', repeated 1 times.
2014-05-21 20:08:43  INFO    OGG-01670  Oracle GoldenGate Collector for Oracle:  Closing /u01/ogg/app/ogg/rl/re000026.
2014-05-21 20:08:43  INFO    OGG-01669  Oracle GoldenGate Collector for Oracle:  Opening /u01/ogg/app/ogg/rl/re000027 (byte -1, current EOF 0).

本地日志

2014-05-21 20:05:21  INFO    OGG-00993  Oracle GoldenGate Capture for Oracle, pump1.prm:  EXTRACT PUMP1 started.
2014-05-21 20:05:26  INFO    OGG-01226  Oracle GoldenGate Capture for Oracle, pump1.prm:  Socket buffer size set to 27985 (flush size 27985).
2014-05-21 20:05:36  ERROR   OGG-01031  Oracle GoldenGate Capture for Oracle, pump1.prm:  There is a problem in network communication, a remote file problem, encryption keys for target and source do not match (if using ENCRYPT) or an unknown error. (Reply received is Unable to open file "/u01/ogg/app/ogg/rl/re000025" (error 11, Resource temporarily unavailable)).
2014-05-21 20:05:36  ERROR   OGG-01668  Oracle GoldenGate Capture for Oracle, pump1.prm:  PROCESS ABENDING.
2014-05-21 20:06:31  INFO    OGG-00987  Oracle GoldenGate Command Interpreter for Oracle:  GGSCI command (oracle): info all.
2014-05-21 20:06:33  INFO    OGG-00987  Oracle GoldenGate Command Interpreter for Oracle:  GGSCI command (oracle): info all.
2014-05-21 20:06:41  INFO    OGG-00987  Oracle GoldenGate Command Interpreter for Oracle:  GGSCI command (oracle): info all.
2014-05-21 20:06:43  INFO    OGG-00987  Oracle GoldenGate Command Interpreter for Oracle:  GGSCI command (oracle): info all.
2014-05-21 20:06:44  INFO    OGG-00987  Oracle GoldenGate Command Interpreter for Oracle:  GGSCI command (oracle): info all.
2014-05-21 20:06:58  INFO    OGG-00987  Oracle GoldenGate Command Interpreter for Oracle:  GGSCI command (oracle): info all.
2014-05-21 20:07:00  INFO    OGG-00987  Oracle GoldenGate Command Interpreter for Oracle:  GGSCI command (oracle): info all.
2014-05-21 20:07:10  INFO    OGG-00987  Oracle GoldenGate Command Interpreter for Oracle:  GGSCI command (oracle): info all.
2014-05-21 20:07:29  INFO    OGG-00987  Oracle GoldenGate Command Interpreter for Oracle:  GGSCI command (oracle): info all.
2014-05-21 20:07:41  INFO    OGG-00987  Oracle GoldenGate Command Interpreter for Oracle:  GGSCI command (oracle): info all.
2014-05-21 20:08:20  INFO    OGG-00987  Oracle GoldenGate Command Interpreter for Oracle:  GGSCI command (oracle): info all.
2014-05-21 20:08:21  INFO    OGG-00975  Oracle GoldenGate Manager for Oracle, mgr.prm:  EXTRACT PUMP1 starting.
2014-05-21 20:08:21  INFO    OGG-00965  Oracle GoldenGate Manager for Oracle, mgr.prm:  EXTRACT PUMP1 restarted automatically.
2014-05-21 20:08:21  INFO    OGG-00992  Oracle GoldenGate Capture for Oracle, pump1.prm:  EXTRACT PUMP1 starting.
2014-05-21 20:08:21  INFO    OGG-03059  Oracle GoldenGate Capture for Oracle, pump1.prm:  Operating system character set identified as UTF-8.
2014-05-21 20:08:21  INFO    OGG-02695  Oracle GoldenGate Capture for Oracle, pump1.prm:  ANSI SQL parameter syntax is used for parameter parsing.
2014-05-21 20:08:21  INFO    OGG-01851  Oracle GoldenGate Capture for Oracle, pump1.prm:  filecaching started: thread ID: 47144693426496.
2014-05-21 20:08:21  INFO    OGG-01815  Oracle GoldenGate Capture for Oracle, pump1.prm:  Virtual Memory Facilities for: COM
    anon alloc: mmap(MAP_ANON)  anon free: munmap
    file alloc: mmap(MAP_SHARED)  file free: munmap
    target directories:
2014-05-21 20:08:21  INFO    OGG-00993  Oracle GoldenGate Capture for Oracle, pump1.prm:  EXTRACT PUMP1 started.
2014-05-21 20:08:23  INFO    OGG-00987  Oracle GoldenGate Command Interpreter for Oracle:  GGSCI command (oracle): info all.
2014-05-21 20:08:26  INFO    OGG-01226  Oracle GoldenGate Capture for Oracle, pump1.prm:  Socket buffer size set to 27985 (flush size 27985).
2014-05-21 20:08:26  INFO    OGG-01055  Oracle GoldenGate Capture for Oracle, pump1.prm:  Recovery initialization completed for target file /u01/ogg/app/ogg/rl/re000025, at RBA 1482.
2014-05-21 20:08:26  INFO    OGG-01478  Oracle GoldenGate Capture for Oracle, pump1.prm:  Output file /u01/ogg/app/ogg/rl/re is using format RELEASE 12.1.
2014-05-21 20:08:26  INFO    OGG-01026  Oracle GoldenGate Capture for Oracle, pump1.prm:  Rolling over remote file /u01/ogg/app/ogg/rl/re000026.
2014-05-21 20:08:26  INFO    OGG-01053  Oracle GoldenGate Capture for Oracle, pump1.prm:  Recovery completed for target file /u01/ogg/app/ogg/rl/re000026, at RBA 805.
2014-05-21 20:08:26  INFO    OGG-01057  Oracle GoldenGate Capture for Oracle, pump1.prm:  Recovery completed for all targets.
2014-05-21 20:08:26  INFO    OGG-01026  Oracle GoldenGate Capture for Oracle, pump1.prm:  Rolling over remote file /u01/ogg/app/ogg/rl/re000027.

看日志可以看出，经过多次错误之后，进行了remote file的切换