[oracle@rac2 trace]$ tail -f alert_orcl2.log
open_cursors = 300
pga_aggregate_target = 500M
deferred_segment_creation= FALSE
enable_ddl_logging = TRUE
diagnostic_dest = "/u02/app/oracle"
max_dump_file_size = "25M"
Cluster communication is configured to use the following interface(s) for this instance
169.254.51.139
cluster interconnect IPC version:Oracle UDP/IP (generic)
IPC Vendor 1 proto 2
Fri Nov 03 10:28:22 2017
PMON started with pid=2, OS id=3067
Fri Nov 03 10:28:22 2017
PSP0 started with pid=3, OS id=3069
Fri Nov 03 10:28:23 2017
VKTM started with pid=4, OS id=3071 at elevated priority
Fri Nov 03 10:28:23 2017
VKTM running at (1)millisec precision with DBRM quantum (100)ms
GEN0 started with pid=5, OS id=3075
Fri Nov 03 10:28:23 2017
DIAG started with pid=6, OS id=3077
Fri Nov 03 10:28:23 2017
DBRM started with pid=7, OS id=3079
Fri Nov 03 10:28:23 2017
PING started with pid=8, OS id=3081
Fri Nov 03 10:28:23 2017
ACMS started with pid=9, OS id=3083
Fri Nov 03 10:28:23 2017
DIA0 started with pid=10, OS id=3085
Fri Nov 03 10:28:23 2017
LMON started with pid=11, OS id=3087
Fri Nov 03 10:28:23 2017
LMD0 started with pid=12, OS id=3089
Fri Nov 03 10:28:23 2017
Fri Nov 03 10:28:23 2017
LMS0 started with pid=13, OS id=3091 at elevated priority
LMS1 started with pid=14, OS id=3095 at elevated priority
* Load Monitor used for high load check
* New Low - High Load Threshold Range = [3840 - 5120]
Fri Nov 03 10:28:23 2017
RMS0 started with pid=15, OS id=3099
Fri Nov 03 10:28:23 2017
LMHB started with pid=16, OS id=3101
Fri Nov 03 10:28:23 2017
MMAN started with pid=17, OS id=3103
Fri Nov 03 10:28:23 2017
DBW0 started with pid=18, OS id=3105
Fri Nov 03 10:28:24 2017
LGWR started with pid=19, OS id=3107
Fri Nov 03 10:28:24 2017
CKPT started with pid=20, OS id=3109
Fri Nov 03 10:28:24 2017
SMON started with pid=21, OS id=3111
Fri Nov 03 10:28:24 2017
RECO started with pid=22, OS id=3113
Fri Nov 03 10:28:24 2017
RBAL started with pid=23, OS id=3115
Fri Nov 03 10:28:24 2017
ASMB started with pid=24, OS id=3117
Fri Nov 03 10:28:24 2017
MMON started with pid=25, OS id=3119
Fri Nov 03 10:28:24 2017
MMNL started with pid=26, OS id=3123
Fri Nov 03 10:28:24 2017
starting up 1 dispatcher(s) for network address '(ADDRESS=(PARTIAL=YES)(PROTOCOL=TCP))'...
NOTE: initiating MARK startup
starting up 1 shared server(s) ...
Starting background process MARK
Fri Nov 03 10:28:24 2017
MARK started with pid=28, OS id=3127
NOTE: MARK has subscribed
lmon registered with NM - instance number 2 (internal mem no 1)
Reconfiguration started (old inc 0, new inc 8)
List of instances:
1 2 (myinst: 2)
Global Resource Directory frozen
* allocate domain 0, invalid = TRUE
Communication channels reestablished
* domain 0 valid = 1 according to instance 1
Master broadcasted resource hash value bitmaps
Non-local Process blocks cleaned out
LMS 0: 0 GCS shadows cancelled, 0 closed, 0 Xw survived
LMS 1: 0 GCS shadows cancelled, 0 closed, 0 Xw survived
Set master node info
Fri Nov 03 10:28:35 2017
Submitted all remote-enqueue requests
Fri Nov 03 10:28:52 2017
Dwn-cvts replayed, VALBLKs dubious
All grantable enqueues granted
Submitted all GCS remote-cache requests
Fri Nov 03 10:29:23 2017
Fix write in gcs resources
Reconfiguration complete
Fri Nov 03 10:29:23 2017
LCK0 started with pid=31, OS id=3158
Fri Nov 03 10:29:30 2017
Starting background process RSMN
Fri Nov 03 10:29:30 2017
RSMN started with pid=32, OS id=3160
Fri Nov 03 10:29:44 2017
ORACLE_BASE not set in environment. It is recommended
that ORACLE_BASE be set in the environment
Reusing ORACLE_BASE from an earlier startup = /u02/app/oracle
Fri Nov 03 10:29:46 2017
NOTE: Loaded library: System
Fri Nov 03 10:29:46 2017
SUCCESS: diskgroup DATA was mounted
Fri Nov 03 10:29:46 2017
NOTE: dependency between database orcl and diskgroup resource ora.DATA.dg is established
Fri Nov 03 10:29:47 2017
ALTER DATABASE MOUNT /* db agent *//* {2:27864:2} */
Fri Nov 03 10:29:47 2017
SUCCESS: diskgroup FRA was mounted
NOTE: dependency between database orcl and diskgroup resource ora.FRA.dg is established
Fri Nov 03 10:29:59 2017
Successful mount of redo thread 2, with mount id 1486853127
Fri Nov 03 10:30:00 2017
Database mounted in Shared Mode (CLUSTER_DATABASE=TRUE)
Lost write protection disabled
Fri Nov 03 10:30:17 2017
Completed: ALTER DATABASE MOUNT /* db agent *//* {2:27864:2} */
ALTER DATABASE OPEN /* db agent *//* {2:27864:2} */
Picked broadcast on commit scheme to generate SCNs
ARCH: STARTING ARCH PROCESSES
Fri Nov 03 10:30:18 2017
ARC0 started with pid=37, OS id=3221
ARC0: Archival started
ARCH: STARTING ARCH PROCESSES COMPLETE
ARC0: STARTING ARCH PROCESSES
Fri Nov 03 10:30:18 2017
ARC1 started with pid=38, OS id=3228
Fri Nov 03 10:30:18 2017
ARC2 started with pid=39, OS id=3234
Fri Nov 03 10:30:18 2017
ARC3 started with pid=40, OS id=3244
ARC1: Archival started
ARC2: Archival started
ARC2: Becoming the 'no FAL' ARCH
ARC2: Becoming the 'no SRL' ARCH
ARC1: Becoming the heartbeat ARCH
ARC3: Archival started
ARC0: STARTING ARCH PROCESSES COMPLETE
ARC2: Archiving disabled thread 2 sequence 72
Archived Log entry 138 added for thread 2 sequence 72 ID 0x588c3e5c dest 1:
Archived Log entry 139 added for thread 2 sequence 71 ID 0x588c3e5c dest 1:
Fri Nov 03 10:30:28 2017
Thread 2 opened at log sequence 73
Current log# 3 seq# 73 mem# 0: +DATA/orcl/onlinelog/group_3.273.957784959
Current log# 3 seq# 73 mem# 1: +FRA/orcl/onlinelog/group_3.262.957784963
Successful open of redo thread 2
Fri Nov 03 10:30:28 2017
MTTR advisory is disabled because FAST_START_MTTR_TARGET is not set
Fri Nov 03 10:30:28 2017
SMON: enabling cache recovery
Fri Nov 03 10:30:32 2017
minact-scn: Inst 2 is a slave inc#:8 mmon proc-id:3119 status:0x2
minact-scn status: grec-scn:0x0000.00000000 gmin-scn:0x0000.00000000 gcalc-scn:0x0000.00000000
[3176] Successfully onlined Undo Tablespace 5.
Undo initialization finished serial:0 start:325454 end:327564 diff:2110 (21 seconds)
Verifying file header compatibility for 11g tablespace encryption..
Verifying 11g file header compatibility for tablespace encryption completed
SMON: enabling tx recovery
Database Characterset is ZHS16GBK
No Resource Manager plan active
Starting background process GTX0
Fri Nov 03 10:30:37 2017
GTX0 started with pid=44, OS id=3292
Starting background process RCBG
Fri Nov 03 10:30:37 2017
RCBG started with pid=45, OS id=3294
replication_dependency_tracking turned off (no async multimaster replication found)
Fri Nov 03 10:30:40 2017
Starting background process QMNC
Fri Nov 03 10:30:40 2017
QMNC started with pid=46, OS id=3331
Fri Nov 03 10:30:56 2017
Completed: ALTER DATABASE OPEN /* db agent *//* {2:27864:2} */
Fri Nov 03 10:31:01 2017
Starting background process CJQ0
Fri Nov 03 10:31:01 2017
CJQ0 started with pid=50, OS id=3362
open_cursors = 300
pga_aggregate_target = 500M
deferred_segment_creation= FALSE
enable_ddl_logging = TRUE
diagnostic_dest = "/u02/app/oracle"
max_dump_file_size = "25M"
Cluster communication is configured to use the following interface(s) for this instance
169.254.51.139
cluster interconnect IPC version:Oracle UDP/IP (generic)
IPC Vendor 1 proto 2
Fri Nov 03 10:28:22 2017
PMON started with pid=2, OS id=3067
Fri Nov 03 10:28:22 2017
PSP0 started with pid=3, OS id=3069
Fri Nov 03 10:28:23 2017
VKTM started with pid=4, OS id=3071 at elevated priority
Fri Nov 03 10:28:23 2017
VKTM running at (1)millisec precision with DBRM quantum (100)ms
GEN0 started with pid=5, OS id=3075
Fri Nov 03 10:28:23 2017
DIAG started with pid=6, OS id=3077
Fri Nov 03 10:28:23 2017
DBRM started with pid=7, OS id=3079
Fri Nov 03 10:28:23 2017
PING started with pid=8, OS id=3081
Fri Nov 03 10:28:23 2017
ACMS started with pid=9, OS id=3083
Fri Nov 03 10:28:23 2017
DIA0 started with pid=10, OS id=3085
Fri Nov 03 10:28:23 2017
LMON started with pid=11, OS id=3087
Fri Nov 03 10:28:23 2017
LMD0 started with pid=12, OS id=3089
Fri Nov 03 10:28:23 2017
Fri Nov 03 10:28:23 2017
LMS0 started with pid=13, OS id=3091 at elevated priority
LMS1 started with pid=14, OS id=3095 at elevated priority
* Load Monitor used for high load check
* New Low - High Load Threshold Range = [3840 - 5120]
Fri Nov 03 10:28:23 2017
RMS0 started with pid=15, OS id=3099
Fri Nov 03 10:28:23 2017
LMHB started with pid=16, OS id=3101
Fri Nov 03 10:28:23 2017
MMAN started with pid=17, OS id=3103
Fri Nov 03 10:28:23 2017
DBW0 started with pid=18, OS id=3105
Fri Nov 03 10:28:24 2017
LGWR started with pid=19, OS id=3107
Fri Nov 03 10:28:24 2017
CKPT started with pid=20, OS id=3109
Fri Nov 03 10:28:24 2017
SMON started with pid=21, OS id=3111
Fri Nov 03 10:28:24 2017
RECO started with pid=22, OS id=3113
Fri Nov 03 10:28:24 2017
RBAL started with pid=23, OS id=3115
Fri Nov 03 10:28:24 2017
ASMB started with pid=24, OS id=3117
Fri Nov 03 10:28:24 2017
MMON started with pid=25, OS id=3119
Fri Nov 03 10:28:24 2017
MMNL started with pid=26, OS id=3123
Fri Nov 03 10:28:24 2017
starting up 1 dispatcher(s) for network address '(ADDRESS=(PARTIAL=YES)(PROTOCOL=TCP))'...
NOTE: initiating MARK startup
starting up 1 shared server(s) ...
Starting background process MARK
Fri Nov 03 10:28:24 2017
MARK started with pid=28, OS id=3127
NOTE: MARK has subscribed
lmon registered with NM - instance number 2 (internal mem no 1)
Reconfiguration started (old inc 0, new inc 8)
List of instances:
1 2 (myinst: 2)
Global Resource Directory frozen
* allocate domain 0, invalid = TRUE
Communication channels reestablished
* domain 0 valid = 1 according to instance 1
Master broadcasted resource hash value bitmaps
Non-local Process blocks cleaned out
LMS 0: 0 GCS shadows cancelled, 0 closed, 0 Xw survived
LMS 1: 0 GCS shadows cancelled, 0 closed, 0 Xw survived
Set master node info
Fri Nov 03 10:28:35 2017
Submitted all remote-enqueue requests
Fri Nov 03 10:28:52 2017
Dwn-cvts replayed, VALBLKs dubious
All grantable enqueues granted
Submitted all GCS remote-cache requests
Fri Nov 03 10:29:23 2017
Fix write in gcs resources
Reconfiguration complete
Fri Nov 03 10:29:23 2017
LCK0 started with pid=31, OS id=3158
Fri Nov 03 10:29:30 2017
Starting background process RSMN
Fri Nov 03 10:29:30 2017
RSMN started with pid=32, OS id=3160
Fri Nov 03 10:29:44 2017
ORACLE_BASE not set in environment. It is recommended
that ORACLE_BASE be set in the environment
Reusing ORACLE_BASE from an earlier startup = /u02/app/oracle
Fri Nov 03 10:29:46 2017
NOTE: Loaded library: System
Fri Nov 03 10:29:46 2017
SUCCESS: diskgroup DATA was mounted
Fri Nov 03 10:29:46 2017
NOTE: dependency between database orcl and diskgroup resource ora.DATA.dg is established
Fri Nov 03 10:29:47 2017
ALTER DATABASE MOUNT /* db agent *//* {2:27864:2} */
Fri Nov 03 10:29:47 2017
SUCCESS: diskgroup FRA was mounted
NOTE: dependency between database orcl and diskgroup resource ora.FRA.dg is established
Fri Nov 03 10:29:59 2017
Successful mount of redo thread 2, with mount id 1486853127
Fri Nov 03 10:30:00 2017
Database mounted in Shared Mode (CLUSTER_DATABASE=TRUE)
Lost write protection disabled
Fri Nov 03 10:30:17 2017
Completed: ALTER DATABASE MOUNT /* db agent *//* {2:27864:2} */
ALTER DATABASE OPEN /* db agent *//* {2:27864:2} */
Picked broadcast on commit scheme to generate SCNs
ARCH: STARTING ARCH PROCESSES
Fri Nov 03 10:30:18 2017
ARC0 started with pid=37, OS id=3221
ARC0: Archival started
ARCH: STARTING ARCH PROCESSES COMPLETE
ARC0: STARTING ARCH PROCESSES
Fri Nov 03 10:30:18 2017
ARC1 started with pid=38, OS id=3228
Fri Nov 03 10:30:18 2017
ARC2 started with pid=39, OS id=3234
Fri Nov 03 10:30:18 2017
ARC3 started with pid=40, OS id=3244
ARC1: Archival started
ARC2: Archival started
ARC2: Becoming the 'no FAL' ARCH
ARC2: Becoming the 'no SRL' ARCH
ARC1: Becoming the heartbeat ARCH
ARC3: Archival started
ARC0: STARTING ARCH PROCESSES COMPLETE
ARC2: Archiving disabled thread 2 sequence 72
Archived Log entry 138 added for thread 2 sequence 72 ID 0x588c3e5c dest 1:
Archived Log entry 139 added for thread 2 sequence 71 ID 0x588c3e5c dest 1:
Fri Nov 03 10:30:28 2017
Thread 2 opened at log sequence 73
Current log# 3 seq# 73 mem# 0: +DATA/orcl/onlinelog/group_3.273.957784959
Current log# 3 seq# 73 mem# 1: +FRA/orcl/onlinelog/group_3.262.957784963
Successful open of redo thread 2
Fri Nov 03 10:30:28 2017
MTTR advisory is disabled because FAST_START_MTTR_TARGET is not set
Fri Nov 03 10:30:28 2017
SMON: enabling cache recovery
Fri Nov 03 10:30:32 2017
minact-scn: Inst 2 is a slave inc#:8 mmon proc-id:3119 status:0x2
minact-scn status: grec-scn:0x0000.00000000 gmin-scn:0x0000.00000000 gcalc-scn:0x0000.00000000
[3176] Successfully onlined Undo Tablespace 5.
Undo initialization finished serial:0 start:325454 end:327564 diff:2110 (21 seconds)
Verifying file header compatibility for 11g tablespace encryption..
Verifying 11g file header compatibility for tablespace encryption completed
SMON: enabling tx recovery
Database Characterset is ZHS16GBK
No Resource Manager plan active
Starting background process GTX0
Fri Nov 03 10:30:37 2017
GTX0 started with pid=44, OS id=3292
Starting background process RCBG
Fri Nov 03 10:30:37 2017
RCBG started with pid=45, OS id=3294
replication_dependency_tracking turned off (no async multimaster replication found)
Fri Nov 03 10:30:40 2017
Starting background process QMNC
Fri Nov 03 10:30:40 2017
QMNC started with pid=46, OS id=3331
Fri Nov 03 10:30:56 2017
Completed: ALTER DATABASE OPEN /* db agent *//* {2:27864:2} */
Fri Nov 03 10:31:01 2017
Starting background process CJQ0
Fri Nov 03 10:31:01 2017
CJQ0 started with pid=50, OS id=3362