oracle10gu与oracle 11gR2启动流程及日志

1：概述

通常所说的oracle server服务器，主要是由两部分组成：Instance和Databae .Instance 是指一组后台线程和一块共享内存区域；Database是指存储在磁盘中的一组物理数据文件。

启动Oracle server服务，在windows下只需要在管理服务内启动相应的监听程序及实例服务即可，两个双击即可启动；在linux /unix 下只要以sysdba/sysoper身份登录，执行startup命令即可启动服务。在以上两个操作都很简单，但对于数据库确在此经历了很多复杂过程。为以后快速解决启动相关内部，在此了解一下oracle启动服务的详细过程。主要启动过程包括如下：

启动数据库到nomount状态；

启动数据库到mount状态；

启动数据库到open状态。

2：oracle 10g启动过程日志

2.1、启动到nomount状态

SQL> select * from v$version;

BANNER

------------------------------------------------------

Oracle Database 10g Enterprise Edition Release 10.2.0.1.0 - Prod

PL/SQL Release 10.2.0.1.0 - Production

CORE 10.2.0.1.0 Production

TNS for Linux: Version 10.2.0.1.0 - Production

NLSRTL Version 10.2.0.1.0 – Production

2.2、启动到nomount状态

SQL> select * from v$version;

ORACLE instance started.

Total System Global Area 167772160 bytes

Fixed Size 1218316 bytes

Variable Size 71305460 bytes

Database Buffers 92274688 bytes

Redo Buffers 2973696 bytes

2.3、启动到nomount状态

/u01/app/oracle/admin/orcl10g/bdump/alert_orcl10g.log

Sun Aug 16 09:07:38 2009

Starting ORACLE instance (normal)

Cannot determine all dependent dynamic libraries for /proc/self/exe

Unable to find dynamic library libocr10.so in search paths

RPATH = /ade/aime1_build2101/oracle/has/lib/:/ade/aime1_build2101/oracle/lib/:/ade/aime1_build2101/oracle/has/lib/:

LD_LIBRARY_PATH is not set!

The default library directories are /lib and /usr/lib

Unable to find dynamic library libocrb10.so in search paths

Unable to find dynamic library libocrutl10.so in search paths

Unable to find dynamic library libocrutl10.so in search paths

LICENSE_MAX_SESSION = 0

LICENSE_SESSIONS_WARNING = 0

Picked latch-free SCN scheme 2

Using LOG_ARCHIVE_DEST_10 parameter default value as USE_DB_RECOVERY_FILE_DEST

Autotune of undo retention is turned on.

IMODE=BR

ILAT =18

LICENSE_MAX_USERS = 0

SYS auditing is disabled

ksdpec: called for event 13740 prior to event group initialization

Starting up ORACLE RDBMS Version: 10.2.0.1.0.

System parameters with non-default values:

processes = 150

__shared_pool_size = 62914560

__large_pool_size = 4194304

__java_pool_size = 4194304

__streams_pool_size = 0

sga_target = 167772160

control_files=/u02/oradata/orcl10g/control01.ctl, /u02/oradata/orcl10g/control02.ctl, /u02/oradata/orcl10g/control03.ctl

db_block_size = 8192

__db_cache_size = 92274688

compatible = 10.2.0.1.0

db_file_multiblock_read_count= 16

db_recovery_file_dest = /u02/flash_recovery_area

db_recovery_file_dest_size= 2147483648

undo_management = AUTO

undo_tablespace = UNDOTBS1

remote_login_passwordfile= EXCLUSIVE

db_domain =

dispatchers = (PROTOCOL=TCP) (SERVICE=orcl10gXDB)

job_queue_processes = 10

background_dump_dest = /u01/app/oracle/admin/orcl10g/bdump

user_dump_dest = /u01/app/oracle/admin/orcl10g/udump

core_dump_dest = /u01/app/oracle/admin/orcl10g/cdump

audit_file_dest = /u01/app/oracle/admin/orcl10g/adump

db_name = orcl10g

open_cursors = 300

pga_aggregate_target = 16777216

PMON started with pid=2, OS id=17981

PSP0 started with pid=3, OS id=17983

MMAN started with pid=4, OS id=17985

DBW0 started with pid=5, OS id=17987

LGWR started with pid=6, OS id=17989

CKPT started with pid=7, OS id=17991

SMON started with pid=8, OS id=17993

RECO started with pid=9, OS id=17995

CJQ0 started with pid=10, OS id=17997

MMON started with pid=11, OS id=17999

MMNL started with pid=12, OS id=18001

Sun Aug 16 09:07:40 2009

starting up 1 dispatcher(s) for network address '(ADDRESS=(PARTIAL=YES)(PROTOCOL=TCP))'...

starting up 1 shared server(s) ...

2.4、启动到mount状态

SQL> alter database mount;

Database altered.

2.5、启动到mount状态日志信息

Sun Aug 16 09:08:04 2009

alter database mount

Sun Aug 16 09:08:08 2009

Setting recovery target incarnation to 2

Sun Aug 16 09:08:08 2009

Successful mount of redo thread 1, with mount id 879453876

Sun Aug 16 09:08:08 2009

Database mounted in Exclusive Mode

Completed: alter database mount

2.6、启动到open状态

SQL> alter database open;

Database altered.

2.7、启动到open状态日志信息

Sun Aug 16 09:08:27 2009

alter database open

Sun Aug 16 09:08:27 2009

Thread 1 opened at log sequence 2

Current log# 1 seq# 2 mem# 0: /u02/oradata/orcl10g/redo01.log

Successful open of redo thread 1

Sun Aug 16 09:08:27 2009

MTTR advisory is disabled because FAST_START_MTTR_TARGET is not set

Successfully onlined Undo Tablespace 1.

Sun Aug 16 09:08:28 2009

SMON: enabling cache recovery

SMON: enabling tx recovery

Sun Aug 16 09:08:28 2009

Database Characterset is WE8ISO8859P1

replication_dependency_tracking turned off (no async multimaster replication found)

Starting background process QMNC

QMNC started with pid=16, OS id=18015

Sun Aug 16 09:08:31 2009

db_recovery_file_dest_size of 2048 MB is 0.00% 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 16 09:08:34 2009

Completed: alter database open

2.8．停止服务

SQL> shutdown immediate;

Database closed.

Database dismounted.

ORACLE instance shut down

2.9、停止服务日志信息

Sun Aug 16 09:08:53 2009

Starting background process EMN0

EMN0 started with pid=20, OS id=18030

Sun Aug 16 09:08:53 2009

Shutting down instance: further logons disabled

Sun Aug 16 09:08:53 2009

Stopping background process CJQ0

Sun Aug 16 09:08:53 2009

Stopping background process QMNC

Sun Aug 16 09:08:54 2009

Stopping background process MMNL

Sun Aug 16 09:08:55 2009

Stopping background process MMON

Sun Aug 16 09:08:56 2009

Shutting down instance (immediate)

License high water mark = 2

Sun Aug 16 09:08:56 2009

Stopping Job queue slave processes

Sun Aug 16 09:09:01 2009

Process OS id : 18021 alive after kill

Errors in file /u01/app/oracle/admin/orcl10g/udump/orcl10g_ora_18006.trc

Sun Aug 16 09:09:01 2009

Job queue slave processes stopped

All dispatchers and shared servers shutdown

Sun Aug 16 09:09:03 2009

ALTER DATABASE CLOSE NORMAL

Sun Aug 16 09:09:03 2009

SMON: disabling tx recovery

SMON: disabling cache recovery

Sun Aug 16 09:09:04 2009

Shutting down archive processes

Archiving is disabled

Archive process shutdown avoided: 0 active

Thread 1 closed at log sequence 2

Successful close of redo thread 1

Sun Aug 16 09:09:04 2009

Completed: ALTER DATABASE CLOSE NORMAL

Sun Aug 16 09:09:04 2009

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

ARCH: Archival disabled due to shutdown: 1089

Shutting down archive processes

Archiving is disabled

Archive process shutdown avoided: 0 active

3：oracle 11gR2启动过程日志

3.1数据库版本

SQL> select * from v$version;

BANNER

Oracle Database 11g Enterprise Edition Release 11.2.0.1.0 - Production

PL/SQL Release 11.2.0.1.0 - Production

CORE 11.2.0.1.0 Production

TNS for Linux: Version 11.2.0.1.0 - Production

NLSRTL Version 11.2.0.1.0 – Production

3.2、启动到nomount状态

SQL> startup nomount;

ORACLE instance started.

Total System Global Area 167772160 bytes

Fixed Size 1218316 bytes

Variable Size 71305460 bytes

Database Buffers 92274688 bytes

Redo Buffers 2973696 bytes

3.3、启动到nomount状态日志信息

/u01/app/oracle/diag/rdbms/orcl11gr2/orcl11gR2/trace/alert_orcl10g.log

Mon Sep 14 01:15:53 2009

Starting ORACLE instance (normal)

LICENSE_MAX_SESSION = 0

LICENSE_SESSIONS_WARNING = 0

Picked latch-free SCN scheme 2

Using LOG_ARCHIVE_DEST_1 parameter default value as USE_DB_RECOVERY_FILE_DEST

Autotune of undo retention is turned on.

IMODE=BR

ILAT =27

LICENSE_MAX_USERS = 0

SYS auditing is disabled

Starting up:

Oracle Database 11g Enterprise Edition Release 11.2.0.1.0 - Production

With the Partitioning, OLAP, Data Mining and Real Application Testing options.

Using parameter settings in server-side spfile /u01/app/oracle/product/11.2.0/db_1/dbs/spfileorcl11gR2.ora

System parameters with non-default values:

processes = 150

sga_target = 240M

control_files = "/u02/orcl11gR2/control01.ctl"

control_files = "/u02/flash_recovery_area/orcl11gR2/control02.ctl"

db_block_size = 8192

compatible = "11.2.0.0.0"

log_archive_format = "%t_%s_%r.dbf"

db_recovery_file_dest = "/u02/flash_recovery_area"

db_recovery_file_dest_size= 4977M

undo_tablespace = "UNDOTBS1"

remote_login_passwordfile= "EXCLUSIVE"

db_domain = ""

dispatchers = "(PROTOCOL=TCP) (SERVICE=orcl11gR2XDB)"

audit_file_dest = "/u01/app/oracle/admin/orcl11gR2/adump"

audit_trail = "DB"

db_name = "orcl11gR"

db_unique_name = "orcl11gR2"

open_cursors = 300

pga_aggregate_target = 79M

diagnostic_dest = "/u01/app/oracle"

Mon Sep 14 01:15:55 2009

PMON started with pid=2, OS id=11488

Mon Sep 14 01:15:55 2009

VKTM started with pid=3, OS id=11490 at elevated priority

VKTM running at (10)millisec precision with DBRM quantum (100)ms

Mon Sep 14 01:15:55 2009

GEN0 started with pid=4, OS id=11494

Mon Sep 14 01:15:55 2009

DIAG started with pid=5, OS id=11496

Mon Sep 14 01:15:55 2009

DBRM started with pid=6, OS id=11498

Mon Sep 14 01:15:55 2009

PSP0 started with pid=7, OS id=11501

Mon Sep 14 01:15:56 2009

DIA0 started with pid=8, OS id=11503

Mon Sep 14 01:15:56 2009

MMAN started with pid=9, OS id=11505

Mon Sep 14 01:15:56 2009

DBW0 started with pid=10, OS id=11507

Mon Sep 14 01:15:56 2009

LGWR started with pid=11, OS id=11509

Mon Sep 14 01:15:56 2009

CKPT started with pid=12, OS id=11511

Mon Sep 14 01:15:56 2009

SMON started with pid=13, OS id=11513

Mon Sep 14 01:15:56 2009

RECO started with pid=14, OS id=11515

Mon Sep 14 01:15:56 2009

MMON started with pid=15, OS id=11517

starting up 1 dispatcher(s) for network address '(ADDRESS=(PARTIAL=YES)(PROTOCOL=TCP))'...

Mon Sep 14 01:15:56 2009

MMNL started with pid=16, OS id=11519

starting up 1 shared server(s) ...

ORACLE_BASE from environment = /u01/app/oracle

3.4、启动到mount状态

SQL> alter database mount;

Database altered.

3.5、启动到nount状态日志信息

Mon Sep 14 01:16:41 2009

alter database mount

Mon Sep 14 01:16:45 2009

Successful mount of redo thread 1, with mount id 672871289

Database mounted in Exclusive Mode

Lost write protection disabled

Completed: alter database mount

3.6、启动到open状态

SQL> alter database open;

Database altered.

3.7启动到open状态日志信息

Mon Sep 14 01:17:42 2009

alter database open

Mon Sep 14 01:17:42 2009

LGWR: STARTING ARCH PROCESSES

Mon Sep 14 01:17:42 2009

ARC0 started with pid=20, OS id=11719

ARC0: Archival started

LGWR: STARTING ARCH PROCESSES COMPLETE

ARC0: STARTING ARCH PROCESSES

Mon Sep 14 01:17:43 2009

ARC1 started with pid=21, OS id=11721

Mon Sep 14 01:17:43 2009

ARC2 started with pid=22, OS id=11723

Thread 1 opened at log sequence 67

Current log# 1 seq# 67 mem# 0: /u02/orcl11gR2/redo01.log

Successful open of redo thread 1

MTTR advisory is disabled because FAST_START_MTTR_TARGET is not set

Mon Sep 14 01:17:43 2009

SMON: enabling cache recovery

ARC1: Archival started

ARC2: Archival started

ARC1: Becoming the 'no FAL' ARCH

ARC1: Becoming the 'no SRL' ARCH

ARC2: Becoming the heartbeat ARCH

Mon Sep 14 01:17:43 2009

ARC3 started with pid=23, OS id=11725

Successfully onlined Undo Tablespace 2.

Verifying file header compatibility for 11g tablespace encryption..

Verifying 11g file header compatibility for tablespace encryption completed

SMON: enabling tx recovery

Database Characterset is WE8MSWIN1252

No Resource Manager plan active

replication_dependency_tracking turned off (no async multimaster replication found)

ARC3: Archival started

ARC0: STARTING ARCH PROCESSES COMPLETE

Starting background process QMNC

Mon Sep 14 01:17:47 2009

QMNC started with pid=24, OS id=11782

Completed: alter database open

Mon Sep 14 01:17:51 2009

Starting background process CJQ0

Mon Sep 14 01:17:51 2009

CJQ0 started with pid=26, OS id=11800

Mon Sep 14 01:17:52 2009

db_recovery_file_dest_size of 4977 MB is 1.75% 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.

3.8、停止服务

SQL> shutdown immediate;

Database closed.

Database dismounted.

ORACLE instance shut down.

3.9、停止服务日志信息

Mon Sep 14 01:14:48 2009

Shutting down instance (immediate)

Shutting down instance: further logons disabled

Mon Sep 14 01:14:48 2009

Stopping background process CJQ0

Stopping background process QMNC

Stopping background process MMNL

Stopping background process MMON

License high water mark = 6

All dispatchers and shared servers shutdown

ALTER DATABASE CLOSE NORMAL

Mon Sep 14 01:14:52 2009

SMON: disabling tx recovery

SMON: disabling cache recovery

Mon Sep 14 01:14:52 2009

Shutting down archive processes

Archiving is disabled

Mon Sep 14 01:14:52 2009

ARCH shutting down

ARC3: Archival stopped

Mon Sep 14 01:14:52 2009

ARCH shutting down

ARC2: Archival stopped

Mon Sep 14 01:14:52 2009

ARCH shutting down

ARC1: Archival stopped

Mon Sep 14 01:14:52 2009

ARCH shutting down

ARC0: Archival stopped

Thread 1 closed at log sequence 67

Successful close of redo thread 1

Completed: 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

Mon Sep 14 01:14:54 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

Mon Sep 14 01:14:57 2009

Instance shutdown complete

[@more@]