RAC網路中斷後自動恢復過程日誌ORA-16198: ORA-16198:

還不算暈發表於2013-10-10
在備庫dg2上停掉網路。此時主庫日誌中有出錯提示。將備庫網路恢復正常,過幾分鐘,ORACLE自動恢復歸檔的傳遞。

[oracle@dg1 ~]$ sqlplus / as sysdba                  
SYS@dg1>alter system switch logfile;
System altered.
SYS@dg1>alter system switch logfile;
System altered.
SYS@dg1>exit
日誌:
[oracle@dg1 ~]$ cat alert_dg.log
Sun Aug 04 19:19:21 2013
ORA-16198: LGWR received timedout error from KSR
LGWR: Attempting destination LOG_ARCHIVE_DEST_2 network reconnect (16198)
LGWR: Destination LOG_ARCHIVE_DEST_2 network reconnect abandoned
Errors in file /u01/diag/rdbms/dg1/dg/trace/dg_lgwr_2852.trc:
ORA-16198: Timeout incurred on internal channel during remote archival
Error 16198 for archive log file 1 to 'dg2'
Destination LOG_ARCHIVE_DEST_2 is UNSYNCHRONIZED
LGWR: Failed to archive log 1 thread 1 sequence 127 (16198)
Thread 1 advanced to log sequence 128 (LGWR switch)
  Current log# 2 seq# 128 mem# 0: /u01/oradata/dg/redo02.log
Sun Aug 04 19:19:26 2013
Archived Log entry 245 added for thread 1 sequence 127 ID 0x6776473b dest 1:
Thread 1 advanced to log sequence 129 (LGWR switch)
  Current log# 3 seq# 129 mem# 0: /u01/oradata/dg/redo03.log
Sun Aug 04 19:19:30 2013
Archived Log entry 246 added for thread 1 sequence 128 ID 0x6776473b dest 1:

備庫網路恢復後:
SYS@dg1>select sequence#,status,thread#,block# from v$managed_standby;
 SEQUENCE# STATUS          THREAD#     BLOCK#
---------- ------------ ---------- ----------
       129 CLOSING               1          1
       128 CLOSING               1          1
         0 CONNECTED             0          0
       130 CLOSING               1          1
       131 WRITING               1        140
SYS@dg2>select sequence#,status,thread#,block# from v$managed_standby;
 SEQUENCE# STATUS          THREAD#     BLOCK#
---------- ------------ ---------- ----------
       130 CLOSING               1          1
       126 CLOSING               1          1
         0 CONNECTED             0          0
       129 CLOSING               1          1
         0 IDLE                  0          0
         0 IDLE                  0          0
         0 IDLE                  0          0
       131 IDLE                  1         14
       131 APPLYING_LOG          1         14

主庫日誌:
[oracle@dg1 ~]$ cat alert_dg.log
Sun Aug 04 19:25:04 2013
ARC3: Standby redo logfile selected for thread 1 sequence 127 for destination LOG_ARCHIVE_DEST_2
Sun Aug 04 19:25:05 2013
NSS2 started with pid=29, OS id=3373
Sun Aug 04 19:25:08 2013
LGWR: Standby redo logfile selected to archive thread 1 sequence 130
LGWR: Standby redo logfile selected for thread 1 sequence 130 for destination LOG_ARCHIVE_DEST_2
Thread 1 advanced to log sequence 130 (LGWR switch)
  Current log# 1 seq# 130 mem# 0: /u01/oradata/dg/redo01.log
Archived Log entry 249 added for thread 1 sequence 129 ID 0x6776473b dest 1:
Sun Aug 04 19:25:08 2013
ARC0: Standby redo logfile selected for thread 1 sequence 129 for destination LOG_ARCHIVE_DEST_2
Destination LOG_ARCHIVE_DEST_2 is SYNCHRONIZED
LGWR: Standby redo logfile selected to archive thread 1 sequence 131
LGWR: Standby redo logfile selected for thread 1 sequence 131 for destination LOG_ARCHIVE_DEST_2
Thread 1 advanced to log sequence 131 (LGWR switch)
  Current log# 2 seq# 131 mem# 0: /u01/oradata/dg/redo02.log
Archived Log entry 252 added for thread 1 sequence 130 ID 0x6776473b dest 1:


備庫日誌:
[oracle@dg2 ~]$ cat alert_dg.log
Sun Aug 04 19:22:20 2013
db_recovery_file_dest_size of 3852 MB is 3.07% used. This is a
user-specified limit on the amount of space that will be used by this
database for recovery-related files, and does not reflect the amount of
space available in the underlying filesystem or ASM diskgroup.
Sun Aug 04 19:25:02 2013
RFS[5]: Assigned to RFS process 3584
RFS[5]: Identified database type as 'physical standby': Client is ARCH pid 2936
krsv_proc_kill: Killing 1 processes (idle RFS by thread/sequence)
Sun Aug 04 19:25:04 2013
RFS[6]: Assigned to RFS process 3588
RFS[6]: Identified database type as 'physical standby': Client is ARCH pid 2928
Sun Aug 04 19:25:04 2013
RFS[7]: Assigned to RFS process 3590
RFS[7]: Identified database type as 'physical standby': Client is ARCH pid 2940
RFS[6]: Opened log for thread 1 sequence 128 dbid 1735160627 branch 821829622
Archived Log entry 134 added for thread 1 sequence 128 rlc 821829622 ID 0x6776473b dest 2:
RFS[7]: Selected log 4 for thread 1 sequence 127 dbid 1735160627 branch 821829622
Sun Aug 04 19:25:04 2013
Media Recovery Log /u01/archivelog/arc_1_128_821829622.arc
Media Recovery Waiting for thread 1 sequence 129
Sun Aug 04 19:25:04 2013
Archived Log entry 135 added for thread 1 sequence 127 ID 0x6776473b dest 1:
Sun Aug 04 19:25:08 2013
RFS[8]: Assigned to RFS process 3597
RFS[8]: Identified database type as 'physical standby': Client is LGWR SYNC pid 2852
Primary database is in MAXIMUM AVAILABILITY mode
Changing standby controlfile to RESYNCHRONIZATION level
Standby controlfile consistent with primary
RFS[8]: Selected log 4 for thread 1 sequence 130 dbid 1735160627 branch 821829622
RFS[6]: Selected log 5 for thread 1 sequence 129 dbid 1735160627 branch 821829622
Sun Aug 04 19:25:08 2013
Archived Log entry 136 added for thread 1 sequence 129 ID 0x6776473b dest 1:
Media Recovery Log /u01/archivelog/arc_1_129_821829622.arc
Media Recovery Waiting for thread 1 sequence 130 (in transit)
Recovery of Online Redo Log: Thread 1 Group 4 Seq 130 Reading mem 0
  Mem# 0: /u01/oradata/dg/standbyredo04.log
Archived Log entry 137 added for thread 1 sequence 130 ID 0x6776473b dest 1:
Changing standby controlfile to MAXIMUM AVAILABILITY level
Media Recovery Waiting for thread 1 sequence 131 (in transit)
RFS[8]: Selected log 4 for thread 1 sequence 131 dbid 1735160627 branch 821829622
Recovery of Online Redo Log: Thread 1 Group 4 Seq 131 Reading mem 0
  Mem# 0: /u01/oradata/dg/standbyredo04.log

相關文章