数据库crash, "Mem# 0 errs 0" 请高人帮忙瞅一瞅

[复制链接]
查看11 | 回复7 | 2013-3-27 11:17:11 | 显示全部楼层 |阅读模式
各位高人:
最近遇到一个问题,比较郁闷,查了半天也没查出什么原因,特请各位大虾一起分析分析。
症状:数据库刚开始是ORA-3113的错误,最后干脆就挂掉了。
OS:Window2003
DB: Oracle 8.1.7.4.1
解决办法:recovery database
以下是出错期间的log摘要:
Completed checkpoint up to RBA [0x19847.2.10], SCN: 0x0000.39f92683
Dump file I:\oracle\WSP\saptrace\background\wspALRT.LOGWed Feb 03 09:33:54 2010
ORACLE V8.1.7.4.1 - Production vsnsta=0
vsnsql=f vsnxtr=3
Windows 2000 Version 5.2 Service Pack 2, CPU type 586
Starting up ORACLE RDBMS Version: 8.1.7.4.1.
System parameters with non-default values:
processes
= 160
sessions
= 181
timed_statistics = TRUE
shared_pool_size = 379332853
shared_pool_reserved_size= 37933285
control_files
= I:\oracle\WSP\sapdata1\cntrl\cntrlWSP.dbf, I:\oracle\WSP\sapdata2\cntrl\cntrlWSP.dbf, I:\oracle\WSP\sapdata3\cntrl\cntrlWSP.dbf
db_block_buffers = 116000
db_block_size
= 8192
db_block_lru_latches = 4
compatible
= 8.1.6
log_archive_start= TRUE
log_archive_dest = I:\oracle\WSP\saparch\WSParch
log_archive_format = ARC%s.%T
log_buffer
= 1048576
log_checkpoint_interval= 300000
db_files
= 254
db_file_multiblock_read_count= 8
fast_start_io_target = 0
log_checkpoints_to_alert = TRUE
control_file_record_keep_time= 30
row_locking
= always
max_rollback_segments= 400
rollback_segments= PRS_0, PRS_1, PRS_2, PRS_3, PRS_4, PRS_5, PRS_6, PRS_7, PRS_8, PRS_9, PRS_10, PRS_11, PRS_12, PRS_13, PRS_14, PRS_15, PRS_16, PRS_17, PRS_18, PRS_19
transaction_auditing = FALSE
remote_login_passwordfile= EXCLUSIVE
distributed_transactions = 0
sort_area_size = 2097152
sort_area_retained_size= 0
db_name
= WSP
open_cursors
= 1800
optimizer_mode = choose
always_anti_join = hash
parallel_broadcast_enabled= TRUE
optimizer_index_cost_adj = 10
cursor_space_for_time= FALSE
create_bitmap_area_size= 33554432
bitmap_merge_area_size = 33554432
parallel_max_servers = 4
parallel_execution_message_size= 8192
hash_join_enabled= FALSE
hash_area_size = 4194304
hash_multiblock_io_count = 8
background_dump_dest = I:\oracle\WSP\saptrace\background
user_dump_dest = I:\oracle\WSP\saptrace\usertrace
max_dump_file_size = 20000
PMON started with pid=2
DBW0 started with pid=3
LGWR started with pid=4
CKPT started with pid=5
SMON started with pid=6
Wed Feb 03 09:33:56 2010
ARCH: STARTING ARCH PROCESSES
ARC0 started with pid=7
Wed Feb 03 09:33:56 2010
ARCH: STARTING ARCH PROCESSES COMPLETE
Wed Feb 03 09:33:56 2010
alter database WSP mount exclusive
Wed Feb 03 09:33:57 2010
ARC0: Archival started
Wed Feb 03 09:34:02 2010
Successful mount of redo thread 1, with mount id 3713430154.
Wed Feb 03 09:34:02 2010
Database mounted in Exclusive Mode.Completed: alter database WSP mount exclusive
Wed Feb 03 09:34:02 2010
alter database open
Beginning crash recovery of 1 threadsWed Feb 03 09:34:02 2010
Thread recovery: start rolling forward thread 1
Recovery of Online Redo Log: Thread 1 Group 14 Seq 104519 Reading mem 0
Mem# 0 errs 0: I:\ORACLE\WSP\ORIGLOGB\LOG_G14M1.DBF
Mem# 1 errs 0: I:\ORACLE\WSP\MIRRLOGB\LOG_G14M2.DBFWed Feb 03 09:34:03 2010
Thread recovery: finish rolling forward thread 1
Thread recovery: 723 data blocks read, 394 data blocks written, 7241 redo blocks read
Crash recovery completed successfullyWed Feb 03 09:34:03 2010
Thread 1 advanced to log sequence 104520
Thread 1 opened at log sequence 104520
Current log# 13 seq# 104520 mem# 0: I:\ORACLE\WSP\ORIGLOGA\LOG_G13M1.DBF
Current log# 13 seq# 104520 mem# 1: I:\ORACLE\WSP\MIRRLOGA\LOG_G13M2.DBF
Successful open of redo thread 1.
Wed Feb 03 09:34:04 2010
SMON: enabling cache recovery
Wed Feb 03 09:34:04 2010
ARC0: Beginning to archive log# 14 seq# 104519
Wed Feb 03 09:34:04 2010
SMON: enabling tx recovery
Wed Feb 03 09:34:04 2010
ARC0: Completed archiving log# 14 seq# 104519
Wed Feb 03 09:34:04 2010
Completed: alter database open
Wed Feb 03 09:37:34 2010
Beginning log switch checkpoint up to RBA [0x19849.2.10], SCN: 0x0000.39f98831
Thread 1 advanced to log sequence 104521
Wed Feb 03 09:37:34 2010
ARC0: Beginning to archive log# 13 seq# 104520
Wed Feb 03 09:37:34 2010
ARC0: Completed archiving log# 13 seq# 104520
Wed Feb 03 09:37:35 2010
Current log# 11 seq# 104521 mem# 0: I:\ORACLE\WSP\ORIGLOGA\LOG_G11M1.DBF
Wed Feb 03 09:37:35 2010
Current log# 11 seq# 104521 mem# 1: I:\ORACLE\WSP\MIRRLOGA\LOG_G11M2.DBF
Wed Feb 03 09:37:45 2010
Beginning log switch checkpoint up to RBA [0x1984a.2.10], SCN: 0x0000.39f988bf
Thread 1 advanced to log sequence 104522
Wed Feb 03 09:37:45 2010
ARC0: Beginning to archive log# 11 seq# 104521
Wed Feb 03 09:37:45 2010
Current log# 12 seq# 104522 mem# 0: I:\ORACLE\WSP\ORIGLOGB\LOG_G12M1.DBF
Current log# 12 seq# 104522 mem# 1: I:\ORACLE\WSP\MIRRLOGB\LOG_G12M2.DBF
Wed Feb 03 09:37:47 2010
ARC0: Completed archiving log# 11 seq# 104521
Wed Feb 03 09:37:50 2010
Completed checkpoint up to RBA [0x19849.2.10], SCN: 0x0000.39f98831
Completed checkpoint up to RBA [0x1984a.2.10], SCN: 0x0000.39f988bf
Dump file I:\oracle\WSP\saptrace\background\wspALRT.LOG
Wed Feb 03 09:46:23 2010
ORACLE V8.1.7.4.1 - Production vsnsta=0
vsnsql=f vsnxtr=3
Windows 2000 Version 5.2 Service Pack 2, CPU type 586
Starting up ORACLE RDBMS Version: 8.1.7.4.1.
System parameters with non-default values:

......重复信息,略
PMON started with pid=2
DBW0 started with pid=3
LGWR started with pid=4
CKPT started with pid=5
SMON started with pid=6
Wed Feb 03 09:46:25 2010
ARCH: STARTING ARCH PROCESSES
ARC0 started with pid=7
Wed Feb 03 09:46:25 2010
ARCH: STARTING ARCH PROCESSES COMPLETE
Wed Feb 03 09:46:25 2010
alter database WSP mount exclusive
Wed Feb 03 09:46:26 2010
ARC0: Archival started
Wed Feb 03 09:46:30 2010
Successful mount of redo thread 1, with mount id 3713461366.
Wed Feb 03 09:46:30 2010
Database mounted in Exclusive Mode.
Completed: alter database WSP mount exclusive
Wed Feb 03 09:46:30 2010
alter database open
Beginning crash recovery of 1 threadsWed Feb 03 09:46:31 2010
Thread recovery: start rolling forward thread 1
Recovery of Online Redo Log: Thread 1 Group 12 Seq 104522 Reading mem 0
Mem# 0 errs 0: I:\ORACLE\WSP\ORIGLOGB\LOG_G12M1.DBF
Mem# 1 errs 0: I:\ORACLE\WSP\MIRRLOGB\LOG_G12M2.DBFWed Feb 03 09:46:34 2010
Thread recovery: finish rolling forward thread 1
Thread recovery: 6270 data blocks read, 6260 data blocks written, 36862 redo blocks read
Crash recovery completed successfullyWed Feb 03 09:46:36 2010
Thread 1 advanced to log sequence 104523
Thread 1 opened at log sequence 104523
Current log# 14 seq# 104523 mem# 0: I:\ORACLE\WSP\ORIGLOGB\LOG_G14M1.DBF
Current log# 14 seq# 104523 mem# 1: I:\ORACLE\WSP\MIRRLOGB\LOG_G14M2.DBF
Successful open of redo thread 1.
Wed Feb 03 09:46:36 2010
ARC0: Beginning to archive log# 12 seq# 104522
Wed Feb 03 09:46:36 2010
SMON: enabling cache recovery
SMON: enabling tx recovery
Wed Feb 03 09:46:37 2010
ARC0: Completed archiving log# 12 seq# 104522
Wed Feb 03 09:46:37 2010
Completed: alter database open
Dump file I:\oracle\WSP\saptrace\background\wspALRT.LOG
Wed Feb 03 10:36:12 2010
ORACLE V8.1.7.4.1 - Production vsnsta=0
vsnsql=f vsnxtr=3
Windows 2000 Version 5.2 Service Pack 2, CPU type 586
Starting up ORACLE RDBMS Version: 8.1.7.4.1.
System parameters with non-default values:
重复信息,略
PMON started with pid=2
DBW0 started with pid=3
LGWR started with pid=4
CKPT started with pid=5
SMON started with pid=6
Wed Feb 03 10:36:13 2010
ARCH: STARTING ARCH PROCESSES
ARC0 started with pid=7
Wed Feb 03 10:36:14 2010
ARCH: STARTING ARCH PROCESSES COMPLETE
Wed Feb 03 10:36:14 2010
alter database WSP mount exclusive
Wed Feb 03 10:36:15 2010
ARC0: Archival started
Wed Feb 03 10:36:19 2010
Successful mount of redo thread 1, with mount id 3713438499.
Wed Feb 03 10:36:19 2010
Database mounted in Exclusive Mode.
Completed: alter database WSP mount exclusive
Wed Feb 03 10:36:19 2010
alter database open
Beginning crash recovery of 1 threads
Wed Feb 03 10:36:20 2010
Thread recovery: start rolling forward thread 1
Recovery of Online Redo Log: Thread 1 Group 14 Seq 104523 Reading mem 0
Mem# 0 errs 0: I:\ORACLE\WSP\ORIGLOGB\LOG_G14M1.DBF
Mem# 1 errs 0: I:\ORACLE\WSP\MIRRLOGB\LOG_G14M2.DBFWed Feb 03 10:36:21 2010
Thread recovery: finish rolling forward thread 1
Thread recovery: 1413 data blocks read, 717 data blocks written, 15865 redo blocks read
Crash recovery completed successfully
Wed Feb 03 10:36:21 2010
Thread 1 advanced to log sequence 104524
Thread 1 opened at log sequence 104524
Current log# 13 seq# 104524 mem# 0: I:\ORACLE\WSP\ORIGLOGA\LOG_G13M1.DBF
Current log# 13 seq# 104524 mem# 1: I:\ORACLE\WSP\MIRRLOGA\LOG_G13M2.DBF
Successful open of redo thread 1.
Wed Feb 03 10:36:21 2010
SMON: enabling cache recovery
Wed Feb 03 10:36:21 2010
ARC0: Beginning to archive log# 14 seq# 104523
Wed Feb 03 10:36:21 2010
SMON: enabling tx recovery
Wed Feb 03 10:36:22 2010
ARC0: Completed archiving log# 14 seq# 104523
Wed Feb 03 10:36:22 2010
Completed: alter database open
Dump file I:\oracle\WSP\saptrace\background\wspALRT.LOG
Wed Feb 03 10:48:41 2010
ORACLE V8.1.7.4.1 - Production vsnsta=0
vsnsql=f vsnxtr=3
Windows 2000 Version 5.2 Service Pack 2, CPU type 586
Starting up ORACLE RDBMS Version: 8.1.7.4.1.
System parameters with non-default values:
重复信息,略
PMON started with pid=2
DBW0 started with pid=3
LGWR started with pid=4
CKPT started with pid=5
SMON started with pid=6
Wed Feb 03 10:48:42 2010
ARCH: STARTING ARCH PROCESSES
ARC0 started with pid=7
Wed Feb 03 10:48:43 2010
ARCH: STARTING ARCH PROCESSES COMPLETE
Wed Feb 03 10:48:43 2010
alter database WSP mount exclusive
Wed Feb 03 10:48:44 2010
ARC0: Archival started
Wed Feb 03 10:48:48 2010
Successful mount of redo thread 1, with mount id 3713406736.
Wed Feb 03 10:48:48 2010
Database mounted in Exclusive Mode.
Completed: alter database WSP mount exclusive
Wed Feb 03 10:48:48 2010
alter database open
Beginning crash recovery of 1 threadsWed Feb 03 10:48:50 2010
Thread recovery: start rolling forward thread 1
Recovery of Online Redo Log: Thread 1 Group 13 Seq 104524 Reading mem 0
Mem# 0 errs 0: I:\ORACLE\WSP\ORIGLOGA\LOG_G13M1.DBF
Mem# 1 errs 0: I:\ORACLE\WSP\MIRRLOGA\LOG_G13M2.DBFWed Feb 03 10:48:51 2010Thread recovery: finish rolling forward thread 1
Thread recovery: 1670 data blocks read, 1668 data blocks written, 18942 redo blocks read
Crash recovery completed successfully
Wed Feb 03 10:48:51 2010
Thread 1 advanced to log sequence 104525
Thread 1 opened at log sequence 104525
Current log# 11 seq# 104525 mem# 0: I:\ORACLE\WSP\ORIGLOGA\LOG_G11M1.DBF
Current log# 11 seq# 104525 mem# 1: I:\ORACLE\WSP\MIRRLOGA\LOG_G11M2.DBF
Successful open of redo thread 1.
Wed Feb 03 10:48:51 2010
SMON: enabling cache recovery
Wed Feb 03 10:48:51 2010
ARC0: Beginning to archive log# 13 seq# 104524
Wed Feb 03 10:48:51 2010
SMON: enabling tx recovery
Wed Feb 03 10:48:52 2010
ARC0: Completed archiving log# 13 seq# 104524
Wed Feb 03 10:48:52 2010
Completed: alter database open
Wed Feb 03 11:31:28 2010
Beginning log switch checkpoint up to RBA [0x1984e.2.10], SCN: 0x0000.39fa91fd
Thread 1 advanced to log sequence 104526
Wed Feb 03 11:31:28 2010
ARC0: Beginning to archive log# 11 seq# 104525
Wed Feb 03 11:31:28 2010
Current log# 12 seq# 104526 mem# 0: I:\ORACLE\WSP\ORIGLOGB\LOG_G12M1.DBF
Current log# 12 seq# 104526 mem# 1: I:\ORACLE\WSP\MIRRLOGB\LOG_G12M2.DBF
Wed Feb 03 11:31:28 2010
ARC0: Completed archiving log# 11 seq# 104525
Wed Feb 03 11:32:03 2010
Completed checkpoint up to RBA [0x1984e.2.10], SCN: 0x0000.39fa91fd
Wed Feb 03 11:32:07 2010
Beginning log switch checkpoint up to RBA [0x1984f.2.10], SCN: 0x0000.39fa9fc6
Thread 1 advanced to log sequence 104527
Wed Feb 03 11:32:07 2010
ARC0: Beginning to archive log# 12 seq# 104526
Wed Feb 03 11:32:07 2010
Current log# 14 seq# 104527 mem# 0: I:\ORACLE\WSP\ORIGLOGB\LOG_G14M1.DBF
Current log# 14 seq# 104527 mem# 1: I:\ORACLE\WSP\MIRRLOGB\LOG_G14M2.DBF
Wed Feb 03 11:32:07 2010
ARC0: Completed archiving log# 12 seq# 104526
Wed Feb 03 11:32:46 2010
Completed checkpoint up to RBA [0x1984f.2.10], SCN: 0x0000.39fa9fc6
Wed Feb 03 11:32:48 2010
Beginning log switch checkpoint up to RBA [0x19850.2.10], SCN: 0x0000.39faad84
Thread 1 advanced to log sequence 104528
Wed Feb 03 11:32:48 2010
ARC0: Beginning to archive log# 14 seq# 104527
Wed Feb 03 11:32:48 2010
Current log# 13 seq# 104528 mem# 0: I:\ORACLE\WSP\ORIGLOGA\LOG_G13M1.DBF
Current log# 13 seq# 104528 mem# 1: I:\ORACLE\WSP\MIRRLOGA\LOG_G13M2.DBF
Wed Feb 03 11:32:48 2010
ARC0: Completed archiving log# 14 seq# 104527
Dump file I:\oracle\WSP\saptrace\background\wspALRT.LOG
Wed Feb 03 11:38:33 2010
ORACLE V8.1.7.4.1 - Production vsnsta=0
vsnsql=f vsnxtr=3
Windows 2000 Version 5.2 Service Pack 2, CPU type 586
Starting up ORACLE RDBMS Version: 8.1.7.4.1.
System parameters with non-default values:

重复信息,略
PMON started with pid=2
DBW0 started with pid=3
LGWR started with pid=4
CKPT started with pid=5
SMON started with pid=6
Wed Feb 03 11:38:35 2010
ARCH: STARTING ARCH PROCESSES
ARC0 started with pid=7
Wed Feb 03 11:38:35 2010
ARC0: Archival started
Wed Feb 03 11:38:36 2010
ARCH: STARTING ARCH PROCESSES COMPLETE
Wed Feb 03 11:38:36 2010
alter database WSP mount exclusiveWed Feb 03 11:38:40 2010
Successful mount of redo thread 1, with mount id 3713463744.
Wed Feb 03 11:38:40 2010
Database mounted in Exclusive Mode.
Completed: alter database WSP mount exclusive
Wed Feb 03 11:38:40 2010
alter database open
Beginning crash recovery of 1 threadsWed Feb 03 11:38:41 2010
Thread recovery: start rolling forward thread 1
Recovery of Online Redo Log: Thread 1 Group 14 Seq 104527 Reading mem 0
Mem# 0 errs 0: I:\ORACLE\WSP\ORIGLOGB\LOG_G14M1.DBF
Mem# 1 errs 0: I:\ORACLE\WSP\MIRRLOGB\LOG_G14M2.DBF
Recovery of Online Redo Log: Thread 1 Group 13 Seq 104528 Reading mem 0
Mem# 0 errs 0: I:\ORACLE\WSP\ORIGLOGA\LOG_G13M1.DBF
Mem# 1 errs 0: I:\ORACLE\WSP\MIRRLOGA\LOG_G13M2.DBF

--------------------------------------------------------------------------------------------
一直这样反复出现。最后只能recovery database 才使数据库恢复正常使用。
不知道大家有没有遇到过这样的问题?其中的"Mem# 0 errs 0"是不是内存出什么问题了?

谢谢先啦。
回复

使用道具 举报

千问 | 2013-3-27 11:17:11 | 显示全部楼层


这么快就沉下去了阿。
各位大虾请帮忙看看吧。。
回复

使用道具 举报

千问 | 2013-3-27 11:17:11 | 显示全部楼层
Mem# 0 errs 0: I:\ORACLE\WSP\ORIGLOGA\LOG_G13M1.DBF
This alert log message, though rare, is a report of a perfectly normal Oracle
recovery mechanism to ensure that partial block updates do not occur as a
result of a server process dying during a block update.No action is required.
这个估计不是原因,
回复

使用道具 举报

千问 | 2013-3-27 11:17:11 | 显示全部楼层
终于有高人回复啦


那实在是太奇怪了,运行得好好的,突然就不行了。。。。
对了,我们是用MS-Cluster做HA, Cluster 本身没什么告警。
回复

使用道具 举报

千问 | 2013-3-27 11:17:11 | 显示全部楼层
我看了你的ALTER LOG 都没有出现ORA错误,,所以我也不知道为啥。。
回复

使用道具 举报

千问 | 2013-3-27 11:17:11 | 显示全部楼层
是啊,真是郁闷。。。。。。。
回复

使用道具 举报

千问 | 2013-3-27 11:17:11 | 显示全部楼层
顶上去!
回复

使用道具 举报

千问 | 2013-3-27 11:17:11 | 显示全部楼层
这里没有错误的信息 呀。而且最后是open的,也没有crash的shutdown的信息。
是不是HA的问题,把系统日志贴出来看看。
回复

使用道具 举报

您需要登录后才可以回帖 登录 | 立即注册

本版积分规则

主题

0

回帖

4882万

积分

论坛元老

Rank: 8Rank: 8

积分
48824836
热门排行