/*
|| Oracle 11g DataGuard Listing 6
||
|| Illustrates how to:
|| - Activate ...
|| in an Oracle Database 11g primary and standby Data Guard environment.
||
|| Author: Jim Czuprynski
||
|| Usage Notes:
|| These examples are provided to demonstrate various Oracle 11gR1 Data Guard
|| features, and they should be carefully proofread before being executed
|| against any existing Oracle database to avoid potential damage!
*/

/*  
|| Listing 6.1:
|| Performing a manual failover
*/

>> Standby database alert log entries:
Tue Aug 25 19:00:07 2009
ALTER DATABASE RECOVER MANAGED STANDBY DATABASE FINISH FORCE
Terminal Recovery: Stopping real time apply
Tue Aug 25 19:00:07 2009
MRP0: Background Media Recovery cancelled with status 16037
Errors in file /u01/app/oracle/diag/rdbms/orcl_stdby1/orcl_stdby1/trace/orcl_stdby1_mrp0_5709.trc:
ORA-16037: user requested cancel of managed recovery operation
Managed Standby Recovery not using Real Time Apply
Shutting down recovery slaves due to error 16037
Recovery interrupted!
Recovered data files to a consistent state at change 5050217
Waiting for MRP0 pid 5709 to terminate
Errors in file /u01/app/oracle/diag/rdbms/orcl_stdby1/orcl_stdby1/trace/orcl_stdby1_mrp0_5709.trc:
ORA-16037: user requested cancel of managed recovery operation
MRP0: Background Media Recovery process shutdown (orcl_stdby1)
Terminal Recovery: Stopped real time apply
Attempt to do a Terminal Recovery (orcl_stdby1)
Media Recovery Start: Managed Standby Recovery (orcl_stdby1)
Fast Parallel Media Recovery enabled
Managed Standby Recovery not using Real Time Apply
Terminal Recovery timestamp is '08/25/2009 19:00:08'
Terminal Recovery: applying standby redo logs.
Terminal Recovery: thread 1 seq# 24 redo required
Terminal Recovery: 
Recovery of Online Redo Log: Thread 1 Group 5 Seq 24 Reading mem 0
  Mem# 0: /u01/app/oracle/oradata/stdby/srl02.log
Identified End-Of-Redo for thread 1 sequence 24
Incomplete recovery applied all redo ever generated.
Recovery completed through change 5050219 time 08/25/2009 18:54:09
Media Recovery Complete (orcl_stdby1)
Terminal Recovery: successful completion
Resetting standby activation ID 1221597403 (0x48d018db)
Completed: ALTER DATABASE RECOVER MANAGED STANDBY DATABASE FINISH FORCE
ALTER DATABASE COMMIT TO SWITCHOVER TO PRIMARY WAIT WITH SESSION SHUTDOWN
ALTER DATABASE SWITCHOVER TO PRIMARY (orcl_stdby1)
Maximum wait for role transition is 15 minutes.
Backup controlfile written to trace file /u01/app/oracle/diag/rdbms/orcl_stdby1/orcl_stdby1/trace/orcl_stdby1_rsm0_5707.trc
Standby terminal recovery start SCN: 5050217
RESETLOGS after complete recovery through change 5050219
Online log /u01/app/oracle/oradata/stdby/redo01.log: Thread 1 Group 1 was previously cleared
Online log /u01/app/oracle/oradata/stdby/redo02.log: Thread 1 Group 2 was previously cleared
Online log /u01/app/oracle/oradata/stdby/redo03.log: Thread 1 Group 3 was previously cleared
Standby became primary SCN: 5050216
Tue Aug 25 19:00:09 2009
Setting recovery target incarnation to 7
Converting standby mount to primary mount.
Switchover: Complete - Database mounted as primary (orcl_stdby1)
Completed: ALTER DATABASE COMMIT TO SWITCHOVER TO PRIMARY WAIT WITH SESSION SHUTDOWN
Tue Aug 25 19:00:09 2009
ARC2: STARTING ARCH PROCESSES
ARC4: Archival started
ARC2: STARTING ARCH PROCESSES COMPLETE
Tue Aug 25 19:00:09 2009
ARC4 started with pid=26, OS id=5755 
ALTER DATABASE OPEN
Tue Aug 25 19:00:09 2009
Assigning activation ID 1223627885 (0x48ef146d)
Thread 1 opened at log sequence 1
  Current log# 1 seq# 1 mem# 0: /u01/app/oracle/oradata/stdby/redo01.log
Successful open of redo thread 1
MTTR advisory is disabled because FAST_START_MTTR_TARGET is not set
Tue Aug 25 19:00:09 2009
ARC3: Becoming the 'no SRL' ARCH
Tue Aug 25 19:00:09 2009
SMON: enabling cache recovery
Successfully onlined Undo Tablespace 2.
Dictionary check beginning
Dictionary check complete
Verifying file header compatibility for 11g tablespace encryption..
Verifying 11g file header compatibility for tablespace encryption completed
SMON: enabling tx recovery
Database Characterset is AL32UTF8
Opening with internal Resource Manager plan
Starting background process FBDA
Starting background process SMCO
Tue Aug 25 19:00:12 2009
SMCO started with pid=30, OS id=5759 
Tue Aug 25 19:00:12 2009
FBDA started with pid=29, OS id=5757 
replication_dependency_tracking turned off (no async multimaster replication found)
Starting background process QMNC
Tue Aug 25 19:00:13 2009
QMNC started with pid=31, OS id=5761 
LOGSTDBY: Validating controlfile with logical metadata
LOGSTDBY: Validation complete
Tue Aug 25 19:00:25 2009
Deleted Oracle managed file /u01/app/oracle/flash_recovery_area/ORCL_STDBY1/onlinelog/o1_mf_7_579cs7y0_.log
Tue Aug 25 19:00:43 2009
Completed: ALTER DATABASE OPEN
Tue Aug 25 19:00:43 2009
Shutting down archive processes
ALTER SYSTEM SET log_archive_dest_1='location="/u01/app/oracle/flash_recovery_area/STDBY/"','valid_for=(ALL_LOGFILES,ALL_ROLES)' SCOPE=BOTH SID='orcl_stdby1';
ALTER SYSTEM SET log_archive_dest_state_1='ENABLE' SCOPE=BOTH SID='orcl_stdby1';
ALTER SYSTEM SET log_archive_trace=0 SCOPE=BOTH SID='orcl_stdby1';
ALTER SYSTEM SET log_archive_format='log_%s_%t_%r.arc' SCOPE=SPFILE SID='orcl_stdby1';
ALTER SYSTEM SET standby_file_management='AUTO' SCOPE=BOTH SID='*';
ALTER SYSTEM SET archive_lag_target=0 SCOPE=BOTH SID='*';
ARCH shutting down
ARC4: Archival stopped
ALTER SYSTEM SET log_archive_max_processes=4 SCOPE=BOTH SID='*';
ALTER SYSTEM SET log_archive_min_succeed_dest=1 SCOPE=BOTH SID='*';
ALTER SYSTEM SET log_file_name_convert='/u01/app/oracle/oradata/orcl/','/u01/app/oracle/oradata/stdby/' SCOPE=SPFILE;
Tue Aug 25 19:00:48 2009
Failover succeeded. Primary database is now orcl_stdby1.
/* 
|| Listing 6.2:
|| Reinstating a failed primary database
*/

>> Primary database alert log entries:
Tue Aug 25 19:08:48 2009
Starting ORACLE instance (normal)
LICENSE_MAX_SESSION = 0
LICENSE_SESSIONS_WARNING = 0
Picked latch-free SCN scheme 2
Autotune of undo retention is turned on. 
IMODE=BR
ILAT =18
LICENSE_MAX_USERS = 0
SYS auditing is disabled
Starting up ORACLE RDBMS Version: 11.1.0.6.0.
Using parameter settings in server-side spfile /u01/app/oracle/product/11.1.0/db_1/dbs/spfileorcl_primary.ora
System parameters with non-default values:
  processes                = 150
  sga_target               = 400M
  control_files            = "/u01/app/oracle/oradata/orcl/control01.ctl"
  control_files            = "/u01/app/oracle/oradata/orcl/control02.ctl"
  control_files            = "/u01/app/oracle/oradata/orcl/control03.ctl"
  db_block_size            = 8192
  compatible               = "11.1.0.0.0"
  log_archive_config       = "DG_CONFIG=(orcl_primary,orcl_stdby1)"
  log_archive_dest_1       = "location="/u01/app/oracle/flash_recovery_area/ORCL/""
  log_archive_dest_1       = "valid_for=(ALL_LOGFILES,ALL_ROLES)"
  log_archive_dest_2       = "service="orcl_stdby1""
  log_archive_dest_2       = "   LGWR ASYNC NOAFFIRM delay=0 OPTIONAL compression=DISABLE max_failure=0 max_connections=1   reopen=300 db_unique_name="orcl_stdby1" net_timeout=30  valid_for=(online_logfile,primary_role)"
  log_archive_dest_state_1 = "ENABLE"
  log_archive_dest_state_2 = "ENABLE"
  log_archive_max_processes= 4
  log_archive_min_succeed_dest= 1
  log_archive_trace        = 0
  log_archive_format       = "log_%s_%t_%r.arc"
  fal_client               = "orcl_primary"
  fal_server               = "orcl_stdby1"
  archive_lag_target       = 0
  db_recovery_file_dest    = "/u01/app/oracle/flash_recovery_area"
  db_recovery_file_dest_size= 8G
  standby_file_management  = "AUTO"
  undo_tablespace          = "UNDOTBS1"
  sec_case_sensitive_logon = FALSE
  remote_login_passwordfile= "EXCLUSIVE"
  db_domain                = ""
  dispatchers              = "(PROTOCOL=TCP) (SERVICE=orclXDB)"
  audit_file_dest          = "/u01/app/oracle/admin/orcl/adump"
  audit_trail              = "DB"
  db_name                  = "orcl"
  db_unique_name           = "orcl_primary"
  open_cursors             = 300
  pga_aggregate_target     = 150M
  dg_broker_start          = TRUE
  dg_broker_config_file1   = "/u01/app/oracle/product/11.1.0/db_1/dbs/dr1orcl_primary.dat"
  dg_broker_config_file2   = "/u01/app/oracle/product/11.1.0/db_1/dbs/dr2orcl_primary.dat"
  diagnostic_dest          = "/u01/app/oracle"
Tue Aug 25 19:08:51 2009
PMON started with pid=2, OS id=12286 
Tue Aug 25 19:08:51 2009
VKTM started with pid=3, OS id=12299 at elevated priority
VKTM running at (20)ms precision
Tue Aug 25 19:08:51 2009
DIAG started with pid=4, OS id=12303 
Tue Aug 25 19:08:51 2009
DBRM started with pid=5, OS id=12305 
Tue Aug 25 19:08:51 2009
DSKM started with pid=7, OS id=12309 
Tue Aug 25 19:08:51 2009
PSP0 started with pid=6, OS id=12307 
Tue Aug 25 19:08:51 2009
DIA0 started with pid=8, OS id=12311 
Tue Aug 25 19:08:51 2009
MMAN started with pid=7, OS id=12313 
Tue Aug 25 19:08:51 2009
DBW0 started with pid=9, OS id=12315 
Tue Aug 25 19:08:52 2009
CKPT started with pid=11, OS id=12319 
Tue Aug 25 19:08:52 2009
SMON started with pid=12, OS id=12321 
Tue Aug 25 19:08:52 2009
LGWR started with pid=10, OS id=12317 
Tue Aug 25 19:08:52 2009
RECO started with pid=13, OS id=12323 
Tue Aug 25 19:08:52 2009
MMON started with pid=14, OS id=12325 
starting up 1 dispatcher(s) for network address '(ADDRESS=(PARTIAL=YES)(PROTOCOL=TCP))'...
Tue Aug 25 19:08:52 2009
MMNL started with pid=15, OS id=12327 
starting up 1 shared server(s) ...
ORACLE_BASE from environment = /u01/app/oracle
Tue Aug 25 19:08:53 2009
DMON started with pid=18, OS id=12333 
Tue Aug 25 19:08:53 2009
ALTER DATABASE MOUNT
Setting recovery target incarnation to 3
Successful mount of redo thread 1, with mount id 1223620167
Allocated 3981204 bytes in shared pool for flashback generation buffer
Starting background process RVWR
Tue Aug 25 19:09:00 2009
RVWR started with pid=20, OS id=12340 
Database mounted in Exclusive Mode
Lost write protection disabled
Completed: ALTER DATABASE   MOUNT
Starting Data Guard Broker (DMON)
Tue Aug 25 19:09:01 2009
NSV1 started with pid=21, OS id=12343 
Tue Aug 25 19:09:05 2009
INSV started with pid=22, OS id=12345 
Tue Aug 25 19:09:08 2009
ALTER SYSTEM SET log_archive_dest_state_2='RESET' SCOPE=BOTH;
Tue Aug 25 19:09:32 2009
Using STANDBY_ARCHIVE_DEST parameter default value as /u01/app/oracle/flash_recovery_area/ORCL/
Redo Shipping Client Connected as PUBLIC
-- Connected User is Valid
RFS[1]: Assigned to RFS process 12448
RFS[1]: Database mount ID mismatch [0x48ef146d:0x48eef647] (1223627885:1223620167)
RFS[1]: Not using real application clusters
Errors in file /u01/app/oracle/diag/rdbms/orcl_primary/orcl_primary/trace/orcl_primary_rfs_12448.trc:
ORA-16009: remote archive log destination must be a STANDBY database
Tue Aug 25 19:09:50 2009
NSV1 started with pid=23, OS id=12456 
Tue Aug 25 19:09:55 2009
RSM0 started with pid=24, OS id=12561 
FLASHBACK DATABASE TO SCN 5050216
Flashback Restore Start
Flashback Restore Complete
Flashback Media Recovery Start
Fast Parallel Media Recovery NOT enabled
Flashback Media Recovery Log /u01/app/oracle/flash_recovery_area/ORCL/log_18_1_693763762.arc
Flashback Media Recovery Log /u01/app/oracle/flash_recovery_area/ORCL/log_19_1_693763762.arc
Flashback Media Recovery Log /u01/app/oracle/flash_recovery_area/ORCL/log_20_1_693763762.arc
Flashback Media Recovery Log /u01/app/oracle/flash_recovery_area/ORCL/log_21_1_693763762.arc
Recovery of Online Redo Log: Thread 1 Group 1 Seq 22 Reading mem 0
  Mem# 0: /u01/app/oracle/oradata/orcl/redo01.log
Recovery of Online Redo Log: Thread 1 Group 2 Seq 23 Reading mem 0
  Mem# 0: /u01/app/oracle/oradata/orcl/redo02.log
Recovery of Online Redo Log: Thread 1 Group 3 Seq 24 Reading mem 0
  Mem# 0: /u01/app/oracle/oradata/orcl/redo03.log
Incomplete Recovery applied until change 5050217 time 08/25/2009 18:54:06
Flashback Media Recovery Complete
Completed: FLASHBACK DATABASE TO SCN 5050216
alter database convert to physical standby
ALTER DATABASE CONVERT TO PHYSICAL STANDBY (orcl_primary)
Tue Aug 25 19:10:05 2009
Clearing standby activation ID 1221597403 (0x48d018db)
The primary database controlfile was created using the
'MAXLOGFILES 16' clause.
There is space for up to 13 standby redo logfiles
Use the following SQL commands on the standby database to create
standby redo logfiles that match the primary database:
ALTER DATABASE ADD STANDBY LOGFILE 'srl1.f' SIZE 52428800;
ALTER DATABASE ADD STANDBY LOGFILE 'srl2.f' SIZE 52428800;
ALTER DATABASE ADD STANDBY LOGFILE 'srl3.f' SIZE 52428800;
ALTER DATABASE ADD STANDBY LOGFILE 'srl4.f' SIZE 52428800;
Completed: alter database convert to physical standby
Tue Aug 25 19:10:05 2009
Shutting down instance: further logons disabled
Stopping background process MMNL
Stopping background process MMON
Shutting down instance (immediate)
License high water mark = 2
Waiting for shared server 'S000' to die
All dispatchers and shared servers shutdown
alter database CLOSE NORMAL
ORA-1109 signalled during: alter database CLOSE NORMAL...
alter database DISMOUNT
Completed: alter database DISMOUNT
ARCH: Archival disabled due to shutdown: 1089
Shutting down archive processes
Archiving is disabled
Archive process shutdown avoided: 0 active
Shutting down Data Guard Broker processes
Tue Aug 25 19:10:12 2009
Completed: Data Guard Broker shutdown
Tue Aug 25 19:10:13 2009
Stopping background process VKTM: 
ARCH: Archival disabled due to shutdown: 1089
Shutting down archive processes
Archiving is disabled
Archive process shutdown avoided: 0 active
Tue Aug 25 19:10:15 2009
Instance shutdown complete
Tue Aug 25 19:10:38 2009
Starting ORACLE instance (normal)
LICENSE_MAX_SESSION = 0
LICENSE_SESSIONS_WARNING = 0
Picked latch-free SCN scheme 2
Autotune of undo retention is turned on. 
IMODE=BR
ILAT =18
LICENSE_MAX_USERS = 0
SYS auditing is disabled
Starting up ORACLE RDBMS Version: 11.1.0.6.0.
Using parameter settings in server-side spfile /u01/app/oracle/product/11.1.0/db_1/dbs/spfileorcl_primary.ora
System parameters with non-default values:
  processes                = 150
  sga_target               = 400M
  control_files            = "/u01/app/oracle/oradata/orcl/control01.ctl"
  control_files            = "/u01/app/oracle/oradata/orcl/control02.ctl"
  control_files            = "/u01/app/oracle/oradata/orcl/control03.ctl"
  db_block_size            = 8192
  compatible               = "11.1.0.0.0"
  log_archive_config       = "DG_CONFIG=(orcl_primary,orcl_stdby1)"
  log_archive_dest_1       = "location="/u01/app/oracle/flash_recovery_area/ORCL/""
  log_archive_dest_1       = "valid_for=(ALL_LOGFILES,ALL_ROLES)"
  log_archive_dest_2       = "service="orcl_stdby1""
  log_archive_dest_2       = "   LGWR ASYNC NOAFFIRM delay=0 OPTIONAL compression=DISABLE max_failure=0 max_connections=1   reopen=300 db_unique_name="orcl_stdby1" net_timeout=30  valid_for=(online_logfile,primary_role)"
  log_archive_dest_state_1 = "ENABLE"
  log_archive_dest_state_2 = "RESET"
  log_archive_max_processes= 4
  log_archive_min_succeed_dest= 1
  log_archive_trace        = 0
  log_archive_format       = "log_%s_%t_%r.arc"
  fal_client               = "orcl_primary"
  fal_server               = "orcl_stdby1"
  archive_lag_target       = 0
  db_recovery_file_dest    = "/u01/app/oracle/flash_recovery_area"
  db_recovery_file_dest_size= 8G
  standby_file_management  = "AUTO"
  undo_tablespace          = "UNDOTBS1"
  sec_case_sensitive_logon = FALSE
  remote_login_passwordfile= "EXCLUSIVE"
  db_domain                = ""
  dispatchers              = "(PROTOCOL=TCP) (SERVICE=orclXDB)"
  audit_file_dest          = "/u01/app/oracle/admin/orcl/adump"
  audit_trail              = "DB"
  db_name                  = "orcl"
  db_unique_name           = "orcl_primary"
  open_cursors             = 300
  pga_aggregate_target     = 150M
  dg_broker_start          = TRUE
  dg_broker_config_file1   = "/u01/app/oracle/product/11.1.0/db_1/dbs/dr1orcl_primary.dat"
  dg_broker_config_file2   = "/u01/app/oracle/product/11.1.0/db_1/dbs/dr2orcl_primary.dat"
  diagnostic_dest          = "/u01/app/oracle"
Tue Aug 25 19:10:40 2009
PMON started with pid=2, OS id=12668 
Tue Aug 25 19:10:40 2009
VKTM started with pid=3, OS id=12670 at elevated priority
VKTM running at (20)ms precision
Tue Aug 25 19:10:40 2009
DIAG started with pid=4, OS id=12674 
Tue Aug 25 19:10:40 2009
PSP0 started with pid=6, OS id=12678 
Tue Aug 25 19:10:40 2009
DBRM started with pid=5, OS id=12676 
Tue Aug 25 19:10:40 2009
DSKM started with pid=7, OS id=12680 
Tue Aug 25 19:10:40 2009
MMAN started with pid=7, OS id=12684 
Tue Aug 25 19:10:40 2009
DBW0 started with pid=9, OS id=12686 
Tue Aug 25 19:10:40 2009
DIA0 started with pid=8, OS id=12682 
Tue Aug 25 19:10:40 2009
LGWR started with pid=10, OS id=12688 
Tue Aug 25 19:10:40 2009
CKPT started with pid=11, OS id=12690 
Tue Aug 25 19:10:41 2009
SMON started with pid=12, OS id=12692 
Tue Aug 25 19:10:41 2009
MMON started with pid=14, OS id=12696 
starting up 1 dispatcher(s) for network address '(ADDRESS=(PARTIAL=YES)(PROTOCOL=TCP))'...
Tue Aug 25 19:10:41 2009
MMNL started with pid=15, OS id=12698 
Tue Aug 25 19:10:41 2009
RECO started with pid=13, OS id=12694 
starting up 1 shared server(s) ...
ORACLE_BASE from environment = /u01/app/oracle
Tue Aug 25 19:10:42 2009
DMON started with pid=18, OS id=12704 
Tue Aug 25 19:10:42 2009
ALTER DATABASE   MOUNT
Setting recovery target incarnation to 3
ARCH: STARTING ARCH PROCESSES
Tue Aug 25 19:10:48 2009
ARC1 started with pid=21, OS id=12713 
ARC0: Archival started
ARC1: Archival started
ARC2: Archival started
ARC3: Archival started
ARCH: STARTING ARCH PROCESSES COMPLETE
Tue Aug 25 19:10:49 2009
ARC3 started with pid=23, OS id=12717 
ARC3: Becoming the 'no FAL' ARCH
ARC3: Becoming the 'no SRL' ARCH
ARC3: Thread not mounted
Tue Aug 25 19:10:49 2009
ARC2 started with pid=22, OS id=12715 
ARC2: Becoming the heartbeat ARCH
Tue Aug 25 19:10:49 2009
ARC0 started with pid=20, OS id=12711 
ARC0: Thread not mounted
ARC1: Thread not mounted
ARC2: Thread not mounted
Successful mount of redo thread 1, with mount id 1223590068
Allocated 3981204 bytes in shared pool for flashback generation buffer
Starting background process RVWR
Tue Aug 25 19:10:49 2009
RVWR started with pid=24, OS id=12719 
Physical Standby Database mounted.
Lost write protection disabled
Completed: ALTER DATABASE   MOUNT
Starting Data Guard Broker (DMON)
Tue Aug 25 19:10:50 2009
INSV started with pid=25, OS id=12722 
Tue Aug 25 19:11:27 2009
NSV1 started with pid=27, OS id=12901 
Tue Aug 25 19:11:32 2009
RSM0 started with pid=28, OS id=12932 
Using STANDBY_ARCHIVE_DEST parameter default value as /u01/app/oracle/flash_recovery_area/ORCL/
ALTER SYSTEM SET log_archive_dest_1='location="/u01/app/oracle/flash_recovery_area/ORCL/"','valid_for=(ALL_LOGFILES,ALL_ROLES)' 
SCOPE=BOTH SID='orcl_primary';
ALTER SYSTEM SET log_archive_dest_state_1='ENABLE' SCOPE=BOTH SID='orcl_primary';
ALTER SYSTEM SET log_archive_trace=0 SCOPE=BOTH SID='orcl_primary';
ALTER SYSTEM SET log_archive_format='log_%s_%t_%r.arc' SCOPE=SPFILE SID='orcl_primary';
ALTER SYSTEM SET standby_file_management='AUTO' SCOPE=BOTH SID='*';
ALTER SYSTEM SET archive_lag_target=0 SCOPE=BOTH SID='*';
ALTER SYSTEM SET log_archive_max_processes=4 SCOPE=BOTH SID='*';
ALTER SYSTEM SET log_archive_min_succeed_dest=1 SCOPE=BOTH SID='*';
ALTER SYSTEM SET fal_server='orcl_stdby1' SCOPE=BOTH;
ALTER SYSTEM SET fal_client='orcl_primary' SCOPE=BOTH;
ALTER DATABASE RECOVER MANAGED STANDBY DATABASE  THROUGH ALL SWITCHOVER DISCONNECT  USING CURRENT LOGFILE
Attempt to start background Managed Standby Recovery process (orcl_primary)
Tue Aug 25 19:11:38 2009
MRP0 started with pid=29, OS id=12934 
MRP0: Background Managed Standby Recovery process started (orcl_primary)
Fast Parallel Media Recovery enabled
Managed Standby Recovery starting Real Time Apply
 parallel recovery started with 2 processes
Waiting for all non-current ORLs to be archived...
Clearing online redo logfile 1 /u01/app/oracle/oradata/orcl/redo01.log
Clearing online log 1 of thread 1 sequence number 22
Tue Aug 25 19:11:45 2009
Completed: ALTER DATABASE RECOVER MANAGED STANDBY DATABASE  THROUGH ALL SWITCHOVER DISCONNECT  USING CURRENT LOGFILE
Clearing online redo logfile 1 complete
Clearing online redo logfile 2 /u01/app/oracle/oradata/orcl/redo02.log
Clearing online log 2 of thread 1 sequence number 23
Tue Aug 25 19:11:50 2009
Clearing online redo logfile 2 complete
Clearing online redo logfile 3 /u01/app/oracle/oradata/orcl/redo03.log
Clearing online log 3 of thread 1 sequence number 24
Tue Aug 25 19:11:51 2009
Redo Shipping Client Connected as PUBLIC
-- Connected User is Valid
RFS[1]: Assigned to RFS process 12948
RFS[1]: Identified database type as 'physical standby'
Tue Aug 25 19:11:51 2009
Redo Shipping Client Connected as PUBLIC
-- Connected User is Valid
RFS[2]: Assigned to RFS process 12950
RFS[2]: Identified database type as 'physical standby'
Primary database is in MAXIMUM PERFORMANCE mode
RFS LogMiner: Client disabled from further notification
Primary database is in MAXIMUM PERFORMANCE mode
RFS[1]: Successfully opened standby log 5: '/u01/app/oracle/oradata/orcl/srl02.log'
kcrrvslf: active RFS archival for log 5 thread 1 sequence 1
RFS[2]: Successfully opened standby log 4: '/u01/app/oracle/oradata/orcl/srl01.log'
Clearing online redo logfile 3 complete
RFS[1]: Detected missing archivals for Branch(resetlogs_id): 693763762
RFS[1]: Last archived SCN: 0:5050137  Last change SCN: 0:5050219
RFS[1]: New Archival REDO Branch(resetlogs_id): 695847608  Prior: 693763762
RFS[1]: Archival Activation ID: 0x48ef146d Current: 0x0
RFS[1]: Effect of primary database OPEN RESETLOGS
RFS[1]: Managed Standby Recovery process is active
Setting recovery target incarnation to 4
RFS[1]: Incarnation entry added for Branch(resetlogs_id): 695847608 (orcl_primary)
Tue Aug 25 19:11:58 2009
Setting recovery target incarnation to 4
Media Recovery Waiting for thread 1 sequence 24
MRP0: Incarnation has changed! Retry recovery...
Errors in file /u01/app/oracle/diag/rdbms/orcl_primary/orcl_primary/trace/orcl_primary_mrp0_12934.trc:
ORA-19906: recovery target incarnation changed during recovery
Managed Standby Recovery not using Real Time Apply
Shutting down recovery slaves due to error 19906
Recovery interrupted!
Errors in file /u01/app/oracle/diag/rdbms/orcl_primary/orcl_primary/trace/orcl_primary_mrp0_12934.trc:
ORA-19906: recovery target incarnation changed during recovery
Tue Aug 25 19:12:19 2009
Fast Parallel Media Recovery enabled
Managed Standby Recovery starting Real Time Apply
 parallel recovery started with 2 processes
Media Recovery start incarnation depth : 1, target inc# : 4, irscn : 5050219
Waiting for all non-current ORLs to be archived...
Media Recovery Waiting for thread 1 sequence 24 branch(resetlogs_id) 693763762
Tue Aug 25 19:12:44 2009
Redo Shipping Client Connected as PUBLIC
-- Connected User is Valid
RFS[3]: Assigned to RFS process 13154
RFS[3]: Identified database type as 'physical standby'
RFS[3]: Archived Log: '/u01/app/oracle/flash_recovery_area/ORCL/log_24_1_693763762.arc'
Tue Aug 25 19:12:51 2009
Media Recovery Log /u01/app/oracle/flash_recovery_area/ORCL/log_24_1_693763762.arc
Identified End-Of-Redo for thread 1 sequence 24
Resetting standby activation ID 1221597403 (0x48d018db)
Media Recovery End-Of-Redo indicator encountered
Media Recovery Continuing
Media Recovery Log /u01/app/oracle/flash_recovery_area/ORCL/log_1_1_695847608.arc
Media Recovery Waiting for thread 1 sequence 2 (in transit)
Recovery of Online Redo Log: Thread 1 Group 4 Seq 2 Reading mem 0
  Mem# 0: /u01/app/oracle/oradata/orcl/srl01.log
Tue Aug 25 19:14:39 2009
Primary database is in MAXIMUM PERFORMANCE mode
Tue Aug 25 19:14:39 2009
Media Recovery Waiting for thread 1 sequence 3 (in transit)
kcrrvslf: active RFS archival for log 4 thread 1 sequence 2
RFS[2]: Successfully opened standby log 5: '/u01/app/oracle/oradata/orcl/srl02.log'
Recovery of Online Redo Log: Thread 1 Group 5 Seq 3 Reading mem 0
  Mem# 0: /u01/app/oracle/oradata/orcl/srl02.log
Media Recovery Waiting for thread 1 sequence 4
Tue Aug 25 19:14:49 2009
Primary database is in MAXIMUM PERFORMANCE mode