странное поведение ARC при старте БД на Муркоде

Sleepy_PIP

Дата: 04.03.2007 14:11:53

Если можно - поясните что происходит.
вот лог:
ORACLE V9.2.0.8.0 - Production vsnsta=0
vsnsql=12 vsnxtr=3
Windows 2000 Version 5.1 Service Pack 2, CPU type 586
Sun Mar 04 13:58:37 2007
Starting ORACLE instance (normal)
LICENSE_MAX_SESSION = 0
LICENSE_SESSIONS_WARNING = 0
SCN scheme 2
Using log_archive_dest parameter default value
LICENSE_MAX_USERS = 0
SYS auditing is disabled
Starting up ORACLE RDBMS Version: 9.2.0.8.0.
System parameters with non-default values:
processes = 150
timed_statistics = TRUE
shared_pool_size = 159383552
sga_max_size = 1301358584
large_pool_size = 8388608
java_pool_size = 159383552
control_files = h:\ora92\oradata\PIPDBH92\control01.ctl, h:\ora92\oradata\PIPDBH92\control02.ctl, h:\ora92\oradata\PIPDBH92\control03.ctl
db_block_size = 8192
db_cache_size = 947912704
compatible = 9.2.0.0.0
log_archive_start = TRUE
log_archive_dest_1 = LOCATION=H:\ora92\oradata\PIPDBH92\arc MANDATORY REOPEN
log_archive_format = ARC_%S.%T
db_file_multiblock_read_count= 16
fast_start_mttr_target = 900
undo_management = AUTO
undo_tablespace = UNDOTBS1
undo_retention = 1800
remote_login_passwordfile= EXCLUSIVE
db_domain =
instance_name = PIPDBH92
dispatchers = (PROTOCOL=TCP) (SERVICE=PIPDBH92XDB)
job_queue_processes = 10
hash_join_enabled = TRUE
background_dump_dest = h:\ora92\admin\PIPDBH92\bdump
user_dump_dest = h:\ora92\admin\PIPDBH92\udump
core_dump_dest = h:\ora92\admin\PIPDBH92\cdump
sort_area_size = 524288
db_name = PIPDBH92
open_cursors = 300
star_transformation_enabled= FALSE
query_rewrite_enabled = FALSE
pga_aggregate_target = 25165824
aq_tm_processes = 1
PMON started with pid=2, OS id=2272
DBW0 started with pid=3, OS id=2296
LGWR started with pid=4, OS id=2320
CKPT started with pid=5, OS id=2344
SMON started with pid=6, OS id=2368
RECO started with pid=7, OS id=2400
CJQ0 started with pid=8, OS id=2428
QMN0 started with pid=9, OS id=2456
Sun Mar 04 13:58:42 2007
starting up 1 shared server(s) ...
starting up 1 dispatcher(s) for network address '(ADDRESS=(PARTIAL=YES)(PROTOCOL=TCP))'...
ARCH: STARTING ARCH PROCESSES
ARC0 started with pid=12, OS id=2876
ARC1 started with pid=13, OS id=2884
Sun Mar 04 13:58:43 2007
ARC0: Archival started
Sun Mar 04 13:58:44 2007
ARCH: STARTING ARCH PROCESSES COMPLETE
Sun Mar 04 13:58:44 2007
ARC0: Becoming the 'no FAL' ARCH
Sun Mar 04 13:58:45 2007
alter database mount exclusive
Sun Mar 04 13:58:45 2007
ARC1: Archival started
Sun Mar 04 13:58:45 2007
ARC1: Becoming the heartbeat ARCH
Sun Mar 04 13:58:45 2007
ARC0: Becoming the 'no FAL' ARCHARC0: Thread not mounted
Sun Mar 04 13:58:45 2007
ARC1: Becoming the heartbeat ARCHARC1: Thread not mounted
Sun Mar 04 13:58:52 2007
Successful mount of redo thread 1, with mount id 2479450390
Sun Mar 04 13:58:52 2007
Database mounted in Exclusive Mode.
Completed: alter database mount exclusive
Sun Mar 04 13:58:52 2007
alter database open
Sun Mar 04 13:58:55 2007
Beginning crash recovery of 1 threads
Sun Mar 04 13:58:56 2007
Started redo scan
Sun Mar 04 13:58:59 2007
Completed redo scan
135995 redo blocks read, 8531 data blocks need recovery
Sun Mar 04 13:59:08 2007
Started recovery at
Thread 1: logseq 1249, block 304808, scn 0.0
Sun Mar 04 13:59:08 2007
Recovery of Online Redo Log: Thread 1 Group 1 Seq 1249 Reading mem 0
Mem# 0 errs 0: H:\ORA92\ORADATA\PIPDBH92\REDOLOG1.ORA
Sun Mar 04 13:59:27 2007
Completed redo application
Sun Mar 04 13:59:27 2007
Ended recovery at
Thread 1: logseq 1249, block 440803, scn 0.117618753
8531 data blocks read, 8531 data blocks written, 135995 redo blocks read
Crash recovery completed successfully
Sun Mar 04 13:59:28 2007
LGWR: Primary database is in CLUSTER CONSISTENT mode
Thread 1 advanced to log sequence 1250
Thread 1 opened at log sequence 1250
Current log# 2 seq# 1250 mem# 0: H:\ORA92\ORADATA\PIPDBH92\REDOLOG2.ORA
Successful open of redo thread 1
Sun Mar 04 13:59:34 2007
SMON: enabling cache recovery
Sun Mar 04 13:59:35 2007
ARC1: Evaluating archive log 1 thread 1 sequence 1249
ARC1: Beginning to archive log 1 thread 1 sequence 1249
Creating archive destination LOG_ARCHIVE_DEST_1: 'H:\ORA92\ORADATA\PIPDBH92\ARC\ARC_01249.001'
Sun Mar 04 13:59:36 2007
ARC0: Evaluating archive log 1 thread 1 sequence 1249
ARC0: Unable to archive log 1 thread 1 sequence 1249
Log actively being archived by another process
Sun Mar 04 13:59:43 2007
Successfully onlined Undo Tablespace 1.
Sun Mar 04 13:59:43 2007
SMON: enabling tx recovery
Sun Mar 04 13:59:43 2007
Database Characterset is CL8MSWIN1251
Sun Mar 04 13:59:55 2007
replication_dependency_tracking turned off (no async multimaster replication found)
Sun Mar 04 14:00:00 2007
ARC1: Completed archiving log 1 thread 1 sequence 1249
Sun Mar 04 14:00:04 2007
Completed: alter database open

что интересно - куски
ARC0 started with pid=12, OS id=2876
ARC1 started with pid=13, OS id=2884

ARC0: Archival started
Sun Mar 04 13:58:44 2007
ARCH: STARTING ARCH PROCESSES COMPLETE
Sun Mar 04 13:58:44 2007
ARC0: Becoming the 'no FAL' ARCH
Sun Mar 04 13:58:45 2007
alter database mount exclusive
Sun Mar 04 13:58:45 2007
ARC1: Archival started
Sun Mar 04 13:58:45 2007
ARC1: Becoming the heartbeat ARCH
Sun Mar 04 13:58:45 2007
ARC0: Becoming the 'no FAL' ARCHARC0: Thread not mounted
Sun Mar 04 13:58:45 2007
ARC1: Becoming the heartbeat ARCHARC1: Thread not mounted

а вот затем самое интересное:
ARC1: Evaluating archive log 1 thread 1 sequence 1249
ARC1: Beginning to archive log 1 thread 1 sequence 1249
Creating archive destination LOG_ARCHIVE_DEST_1: 'H:\ORA92\ORADATA\PIPDBH92\ARC\ARC_01249.001'
Sun Mar 04 13:59:36 2007
ARC0: Evaluating archive log 1 thread 1 sequence 1249
ARC0: Unable to archive log 1 thread 1 sequence 1249
Log actively being archived by another process

ARC1 не дал ARC0 архивить уже открыв архивлог? я правильно понимаю?
А чего они договориться не смогли?

Спасибо!!!