使用10046事件查看数据库OPEN时从root dba到bootstrap$的详细引导过程
2013-11-29 15:36
423 查看
数据库版本11.2.0.4
ORACLE instance started.
Total System Global Area 150654976 bytes
Fixed Size 1363216 bytes
Variable Size 96469744 bytes
Database Buffers 50331648 bytes
Redo Buffers 2490368 bytes
Database mounted.
SYS@ bys3>alter session set events='10046 trace name context forever,level 12';
Session altered.
SYS@ bys3>alter database open;
Database altered.
SYS@ bys3>select value from v$diag_info where name like 'Default%';
其它查看TRACE文件位置方法是:oradebug setmypid; oradebug tracefile_name 或者直接在user_dump_dest目录中使用 ls -alt 找最近生成的文件
VALUE
-------------------------------------------------------------------------------------------------
/u01/app/oracle/product/11.2.0/dbhome_1/log/diag/rdbms/bys3/bys3/trace/bys3_ora_13020.trc
####################################
引导过程: 关于root dba及 bootstrap$,详见:http://blog.csdn.net/q947817003/article/details/17025955
1.ORACLE首先读取控制文件获取数据文件,b file sequential read 单块读方式读取每个数据文件第一个block 数据文件头的信息,
2.然后用db file sequential read方式读取了file 1 block#520的内容(这一步应该有从file 1 blcok 1找到root dba来定位到file#1 block#520,不知道怎么从TRACE文件中看???)
WAIT #3064435524: nam='db file sequential read' ela= 264 file#=1 block#=520 blocks=1 obj#=-1 tim=1385703907158975
3.ORACLE找到了file#=1 block#=520后,读取其内容,在内存中创建:
PARSING IN CURSOR #3064429824 len=188 dep=1 uid=0 oct=1 lid=0 tim=1385703907172599 hv=4006182593 ad='257ea26c' sqlid='32r4f1brckzq1'
create table bootstrap$ (
END OF STMT
4.此后ORACLE通过递归查询,从bootstrap$中获取创建对象的语句:
PARSING IN CURSOR #3064429824 len=55 dep=1 uid=0 oct=3 lid=0 tim=1385703907195679 hv=2111436465 ad='257e8e88' sqlid='6apq2rjyxmxpj'
select line#, sql_text from bootstrap$ where obj# != :1
END OF STMT
5.然后,根据查出语句,创建这些对象:如下: 这些创建对象语句在数据库中也通过select * from bootstrap$ 可以查到
=====================
PARSING IN CURSOR #3064429824 len=129 dep=1 uid=0 oct=36 lid=0 tim=1385703907299714 hv=1119914026 ad='b6a51d5c' sqlid='864bmh11c121a'
CREATE ROLLBACK SEGMENT SYSTEM STORAGE ( INITIAL 112K NEXT 56K MINEXTENTS 1 MAXEXTENTS 32765 OBJNO 0 EXTENTS (FILE 1 BLOCK 128))
END OF STMT
PARSE #3064429824:c=999,e=31611,p=0,cr=0,cu=0,mis=1,r=0,dep=1,og=4,plh=0,tim=1385703907299710
EXEC #3064429824:c=1000,e=18763,p=0,cr=0,cu=0,mis=0,r=0,dep=1,og=4,plh=0,tim=1385703907318789
CLOSE #3064429824:c=0,e=7,dep=1,type=0,tim=1385703907318912
=====================
6.再然后,创建完这些对象后,就正常打开数据库。
########################################
This event is used to wait for disk file operations (for example, open, close, seek, and resize). It is also used for miscellaneous I/O operations such as block dumps and password file accesses.
control file sequential read
控制文件连续读
rdbms ipc reply
这个事件说明等待一个后台进程的响应。
db file sequential read
等待时间是由于执行对索引,回滚(undo)段,和表(当借助rowid来访问),控制文件和数据文件头的单块读操作SQL语句(用户和递归)引起的。
control file parallel write-控制文件并行写
当server 进程更新所有控制文件时,这个事件可能出现。如果等待很短,可以不用考虑。如果等待时间较长,检查存放控制文件的物理磁盘I/O 是否存在瓶颈
########################################
Oracle Database 11g Enterprise Edition Release 11.2.0.4.0 - Production
With the Partitioning, OLAP, Data Mining and Real Application Testing options
ORACLE_HOME = /u01/app/oracle/product/11.2.0/dbhome_1
System name: Linux
Node name: bys3.bys.com
Release: 2.6.32-200.13.1.el5uek
Version: #1 SMP Wed Jul 27 20:21:26 EDT 2011
Machine: i686
Instance name: bys3
Redo thread mounted by this instance: 1
Oracle process number: 17
Unix process pid: 13020, image: oracle@bys3.bys.com (TNS V1-V3)
*** 2013-11-29 13:44:59.723
*** SESSION ID:(1.5) 2013-11-29 13:44:59.723
*** CLIENT ID:() 2013-11-29 13:44:59.723
*** SERVICE NAME:() 2013-11-29 13:44:59.723
*** MODULE NAME:(sqlplus@bys3.bys.com (TNS V1-V3)) 2013-11-29 13:44:59.723
*** ACTION NAME:() 2013-11-29 13:44:59.723
WAIT #3064440660: nam='SQL*Net message to client' ela= 10 driver id=1650815232 #bytes=1 p3=0 obj#=-1 tim=1385703899721694
*** 2013-11-29 13:45:05.589
WAIT #3064440660: nam='SQL*Net message from client' ela= 5865444 driver id=1650815232 #bytes=1 p3=0 obj#=-1 tim=1385703905589082
CLOSE #3064440660:c=0,e=28,dep=0,type=1,tim=1385703905590081
XCTEND rlbk=0, rd_only=1, tim=1385703905595227
=====================
PARSING IN CURSOR #3064435524 len=19 dep=0 uid=0 oct=35 lid=0 tim=1385703905623330 hv=1907384048 ad='25eddd7c' sqlid='a01hp0psv0rrh'
alter database open
END OF STMT
PARSE #3064435524:c=12999,e=33127,p=0,cr=0,cu=0,mis=1,r=0,dep=0,og=1,plh=0,tim=1385703905623322
WAIT #3064435524: nam='Disk file operations I/O' ela= 550 FileOperation=2 fileno=0 filetype=1 obj#=-1 tim=1385703905629002
WAIT #3064435524: nam='Disk file operations I/O'
ela= 33 FileOperation=2 fileno=1 filetype=1 obj#=-1 tim=1385703905629484
WAIT #3064435524: nam='control file sequential read' ela= 188 file#=0 block#=1 blocks=1 obj#=-1 tim=1385703905629831
WAIT #3064435524: nam='control file sequential read' ela= 47 file#=1 block#=1 blocks=1 obj#=-1
tim=1385703905630128 ---读取数据文件1的第1个块
WAIT #3064435524: nam='control file sequential read' ela= 23 file#=0 block#=8 blocks=1 obj#=-1 tim=1385703905630278
WAIT #3064435524: nam='control file sequential read' ela= 41 file#=0 block#=10 blocks=1 obj#=-1 tim=1385703905630632
WAIT #3064435524: nam='control file sequential read' ela= 39 file#=0 block#=1 blocks=1 obj#=-1 tim=1385703905633356
WAIT #3064435524: nam='control file sequential read' ela= 41 file#=0 block#=8 blocks=1 obj#=-1 tim=1385703905633910
WAIT #3064435524: nam='control file sequential read' ela= 38 file#=0 block#=10 blocks=1 obj#=-1 tim=1385703905634005
WAIT #3064435524: nam='rdbms ipc reply' ela= 60 from_process=10 timeout=910 p3=0 obj#=-1 tim=1385703905637300
WAIT #3064435524: nam='rdbms ipc reply' ela= 127477 from_process=10 timeout=910 p3=0 obj#=-1 tim=1385703905764875
WAIT #3064435524: nam='control file sequential read' ela= 52 file#=0 block#=1 blocks=1 obj#=-1 tim=1385703905765507
WAIT #3064435524: nam='control file sequential read' ela= 43 file#=0 block#=8 blocks=1 obj#=-1 tim=1385703905765632
WAIT #3064435524: nam='control file sequential read' ela= 42 file#=0 block#=10 blocks=1 obj#=-1 tim=1385703905765734
WAIT #3064435524: nam='control file sequential read' ela= 68 file#=0 block#=291 blocks=1 obj#=-1 tim=1385703905765869
WAIT #3064435524: nam='control file sequential read' ela= 40 file#=0 block#=1 blocks=1 obj#=-1 tim=1385703905766297
WAIT #3064435524: nam='control file sequential read' ela= 47 file#=1 block#=1 blocks=1 obj#=-1 tim=1385703905766543
WAIT #3064435524: nam='control file sequential read' ela= 40 file#=0 block#=8 blocks=1 obj#=-1 tim=1385703905766642
WAIT #3064435524: nam='control file sequential read' ela= 40 file#=0 block#=10 blocks=1 obj#=-1 tim=1385703905766731
WAIT #3064435524: nam='control file sequential read' ela= 43 file#=0 block#=291 blocks=1 obj#=-1 tim=1385703905766860
WAIT #3064435524: nam='Disk file operations I/O' ela= 69 FileOperation=2 fileno=1 filetype=2 obj#=-1 tim=1385703905767279
WAIT #3064435524: nam='Disk file operations I/O' ela= 23 FileOperation=2 fileno=2 filetype=2 obj#=-1 tim=1385703905767380
WAIT #3064435524: nam='Disk file operations I/O' ela= 54 FileOperation=2 fileno=3 filetype=2 obj#=-1 tim=1385703905767824
WAIT #3064435524: nam='Disk file operations I/O' ela= 51 FileOperation=2 fileno=4 filetype=2 obj#=-1 tim=1385703905767914
WAIT #3064435524: nam='Disk file operations I/O' ela= 20 FileOperation=2 fileno=201 filetype=2 obj#=-1 tim=1385703905767972
WAIT #3064435524: nam='control file sequential read' ela= 44 file#=0 block#=16 blocks=1 obj#=-1 tim=1385703905768068
WAIT #3064435524: nam='db file sequential read'
ela= 68 file#=1 block#=1 blocks=1 obj#=-1 tim=1385703905768369
WAIT #3064435524: nam='db file sequential read'
ela= 26 file#=2 block#=1 blocks=1 obj#=-1 tim=1385703905768933
WAIT #3064435524: nam='db file sequential read'
ela= 28 file#=3 block#=1 blocks=1 obj#=-1 tim=1385703905769117
WAIT #3064435524: nam='db file sequential read'
ela= 27 file#=4 block#=1 blocks=1 obj#=-1 tim=1385703905769223
WAIT #3064435524: nam='control file parallel write' ela= 744 files=2 block#=9 requests=2 obj#=-1 tim=1385703905770129
WAIT #3064435524: nam='control file parallel write' ela= 1244 files=2 block#=7 requests=2 obj#=-1 tim=1385703905771569
WAIT #3064435524: nam='control file parallel write' ela= 534 files=2 block#=1 requests=2 obj#=-1 tim=1385703905772171
WAIT #3064435524: nam='control file sequential read' ela= 41 file#=0 block#=1 blocks=1 obj#=-1 tim=1385703905772336
WAIT #3064435524: nam='control file sequential read' ela= 65 file#=1 block#=1 blocks=1 obj#=-1 tim=1385703905772461
WAIT #3064435524: nam='control file sequential read' ela= 42 file#=0 block#=7 blocks=1 obj#=-1 tim=1385703905772672
WAIT #3064435524: nam='control file sequential read' ela= 40 file#=0 block#=9 blocks=1 obj#=-1 tim=1385703905772771
WAIT #3064435524: nam='control file sequential read' ela= 41 file#=0 block#=291 blocks=1 obj#=-1 tim=1385703905772901
WAIT #3064435524: nam='control file sequential read' ela= 41 file#=0 block#=1 blocks=1 obj#=-1 tim=1385703905773134
WAIT #3064435524: nam='control file sequential read' ela= 44 file#=1 block#=1 blocks=1 obj#=-1 tim=1385703905773236
WAIT #3064435524: nam='control file sequential read' ela= 39 file#=0 block#=7 blocks=1 obj#=-1 tim=1385703905773317
WAIT #3064435524: nam='control file sequential read' ela= 44 file#=0 block#=9 blocks=1 obj#=-1 tim=1385703905773400
WAIT #3064435524: nam='control file sequential read' ela= 40 file#=0 block#=291 blocks=1 obj#=-1 tim=1385703905773549
WAIT #3064435524: nam='control file parallel write' ela= 607 files=2 block#=292 requests=2 obj#=-1 tim=1385703905774316
WAIT #3064435524: nam='control file parallel write' ela= 709 files=2 block#=10 requests=2 obj#=-1 tim=1385703905775097
WAIT #3064435524: nam='control file parallel write' ela= 610 files=2 block#=8 requests=2 obj#=-1 tim=1385703905775773
WAIT #3064435524: nam='control file parallel write' ela= 594 files=2 block#=1 requests=2 obj#=-1 tim=1385703905776514
WAIT #3064435524: nam='control file sequential read' ela= 42 file#=0 block#=1 blocks=1 obj#=-1 tim=1385703905779031
WAIT #3064435524: nam='control file sequential read' ela= 41 file#=1 block#=1 blocks=1 obj#=-1 tim=1385703905779254
WAIT #3064435524: nam='control file sequential read' ela= 48 file#=0 block#=8 blocks=1 obj#=-1 tim=1385703905779358
WAIT #3064435524: nam='control file sequential read' ela= 64 file#=0 block#=10 blocks=1 obj#=-1 tim=1385703905779464
WAIT #3064435524: nam='control file sequential read' ela= 48 file#=0 block#=331 blocks=1 obj#=-1 tim=1385703905779621
WAIT #3064435524: nam='control file parallel write' ela= 38493 files=2 block#=332 requests=2 obj#=-1 tim=1385703905818160
WAIT #3064435524: nam='control file parallel write' ela= 606 files=2 block#=9 requests=2 obj#=-1 tim=1385703905818848
WAIT #3064435524: nam='control file parallel write' ela= 934 files=2 block#=7 requests=2 obj#=-1 tim=1385703905819850
WAIT #3064435524: nam='control file parallel write' ela= 596 files=2 block#=1 requests=2 obj#=-1 tim=1385703905820754
WAIT #3064435524: nam='control file sequential read' ela= 42 file#=0 block#=1 blocks=1 obj#=-1 tim=1385703905821083
WAIT #3064435524: nam='control file sequential read' ela= 39 file#=1 block#=1 blocks=1 obj#=-1 tim=1385703905821240
WAIT #3064435524: nam='control file sequential read' ela= 43 file#=0 block#=7 blocks=1 obj#=-1 tim=1385703905821325
WAIT #3064435524: nam='control file sequential read' ela= 68 file#=0 block#=9 blocks=1 obj#=-1 tim=1385703905821441
WAIT #3064435524: nam='control file sequential read' ela= 47 file#=0 block#=1 blocks=1 obj#=-1 tim=1385703905821631
WAIT #3064435524: nam='control file sequential read' ela= 39 file#=1 block#=1 blocks=1 obj#=-1 tim=1385703905821729
WAIT #3064435524: nam='control file sequential read' ela= 44 file#=0 block#=7 blocks=1 obj#=-1 tim=1385703905821813
WAIT #3064435524: nam='control file sequential read' ela= 42 file#=0 block#=9 blocks=1 obj#=-1 tim=1385703905822220
WAIT #3064435524: nam='control file sequential read' ela= 45 file#=0 block#=11 blocks=1 obj#=-1 tim=1385703905822329
WAIT #3064435524: nam='control file sequential read' ela= 43 file#=0 block#=1 blocks=1 obj#=-1 tim=1385703905822488
WAIT #3064435524: nam='control file sequential read' ela= 43 file#=0 block#=7 blocks=1 obj#=-1 tim=1385703905822575
WAIT #3064435524: nam='control file sequential read' ela= 40 file#=0 block#=9 blocks=1 obj#=-1 tim=1385703905822659
WAIT #3064435524: nam='rdbms ipc reply' ela= 23 from_process=11 timeout=1800 p3=0 obj#=-1 tim=1385703905826080
*** 2013-11-29 13:45:07.141
WAIT #3064435524: nam='rdbms ipc reply' ela= 1314812 from_process=11 timeout=1800 p3=0 obj#=-1 tim=1385703907140989
WAIT #3064435524: nam='control file sequential read' ela= 101 file#=0 block#=1 blocks=1 obj#=-1 tim=1385703907142993
WAIT #3064435524: nam='control file sequential read' ela= 42 file#=0 block#=8 blocks=1 obj#=-1 tim=1385703907143128
WAIT #3064435524: nam='control file sequential read' ela= 43 file#=0 block#=10 blocks=1 obj#=-1 tim=1385703907143343
WAIT #3064435524: nam='control file sequential read' ela= 58 file#=0 block#=292 blocks=1 obj#=-1 tim=1385703907143462
WAIT #3064435524: nam='control file sequential read' ela= 41 file#=0 block#=1 blocks=1 obj#=-1 tim=1385703907143570
WAIT #3064435524: nam='control file sequential read' ela= 39 file#=0 block#=8 blocks=1 obj#=-1 tim=1385703907143651
WAIT #3064435524: nam='control file sequential read' ela= 43 file#=0 block#=10 blocks=1 obj#=-1 tim=1385703907143739
WAIT #3064435524: nam='control file sequential read' ela= 40 file#=0 block#=292 blocks=1 obj#=-1 tim=1385703907143821
WAIT #3064435524: nam='control file sequential read' ela= 41 file#=0 block#=1 blocks=1 obj#=-1 tim=1385703907143944
WAIT #3064435524: nam='control file sequential read' ela= 40 file#=0 block#=8 blocks=1 obj#=-1 tim=1385703907144025
WAIT #3064435524: nam='control file sequential read' ela= 42 file#=0 block#=10 blocks=1 obj#=-1 tim=1385703907144110
WAIT #3064435524: nam='control file sequential read' ela= 40 file#=0 block#=292 blocks=1 obj#=-1 tim=1385703907144192
WAIT #3064435524: nam='control file sequential read' ela= 44 file#=0 block#=1 blocks=1 obj#=-1 tim=1385703907148808
WAIT #3064435524: nam='control file sequential read' ela= 49 file#=0 block#=8 blocks=1 obj#=-1 tim=1385703907148929
WAIT #3064435524: nam='control file sequential read' ela= 40 file#=0 block#=10 blocks=1 obj#=-1 tim=1385703907149011
WAIT #3064435524: nam='control file sequential read' ela= 43 file#=0 block#=292 blocks=1 obj#=-1 tim=1385703907149094
WAIT #3064435524: nam='db file sequential read' ela= 264 file#=1 block#=520blocks=1 obj#=-1 tim=1385703907158975
=====================
PARSING IN CURSOR #3064429824 len=188 dep=1 uid=0 oct=1 lid=0 tim=1385703907172599 hv=4006182593 ad='257ea26c' sqlid='32r4f1brckzq1'
create table bootstrap$ (
END OF STMT
PARSE #3064429824:c=5999,e=11363,p=0,cr=0,cu=0,mis=1,r=0,dep=1,og=4,plh=0,tim=1385703907172594
EXEC #3064429824:c=2000,e=16397,p=0,cr=0,cu=0,mis=0,r=0,dep=1,og=4,plh=0,tim=1385703907191131
CLOSE #3064429824:c=1000,e=36,dep=1,type=0,tim=1385703907191434
=====================
PARSING IN CURSOR #3064429824 len=55 dep=1 uid=0 oct=3 lid=0 tim=1385703907195679 hv=2111436465 ad='257e8e88' sqlid='6apq2rjyxmxpj'
select line#, sql_text from bootstrap$ where obj# != :1
END OF STMT
PARSE #3064429824:c=2999,e=4055,p=0,cr=0,cu=0,mis=1,r=0,dep=1,og=4,plh=0,tim=1385703907195675
BINDS #3064429824:
Bind#0
oacdty=02 mxl=22(22) mxlc=00 mal=00 scl=00 pre=00
oacflg=08 fl2=0001 frm=00 csi=00 siz=24 off=0
kxsbbbfp=b6a778d0 bln=22 avl=02 flg=05
value=59
EXEC #3064429824:c=7999,e=47324,p=0,cr=0,cu=0,mis=1,r=0,dep=1,og=4,plh=867914364,tim=1385703907244586
WAIT #3064429824: nam='db file sequential read' ela= 246 file#=1 block#=520 blocks=1 obj#=59 tim=1385703907245408
WAIT #3064429824: nam='db file scattered read' ela= 470 file#=1 block#=521 blocks=3 obj#=59 tim=1385703907248639
FETCH #3064429824:c=3999,e=7831,p=4,cr=3,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907252714
FETCH #3064429824:c=0,e=45,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907252920
FETCH #3064429824:c=0,e=10,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907252978
FETCH #3064429824:c=0,e=10,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907253032
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907253089
FETCH #3064429824:c=0,e=10,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907253148
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907253201
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907253254
FETCH #3064429824:c=0,e=10,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907253307
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907253359
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907253412
FETCH #3064429824:c=0,e=10,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907253486
FETCH #3064429824:c=0,e=11,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907254729
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907254803
FETCH #3064429824:c=0,e=10,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907254856
FETCH #3064429824:c=0,e=10,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907254908
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907254959
FETCH #3064429824:c=0,e=10,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907255011
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907255072
FETCH #3064429824:c=0,e=10,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907255125
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907255176
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907255228
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907255280
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907255331
FETCH #3064429824:c=0,e=10,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907255386
FETCH #3064429824:c=0,e=13,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907255457
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907255512
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907255564
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907255615
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907255666
FETCH #3064429824:c=0,e=12,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907256923
FETCH #3064429824:c=0,e=10,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907256977
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907257028
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907257080
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907257131
FETCH #3064429824:c=0,e=10,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907257232
FETCH #3064429824:c=0,e=13,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907257453
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907257508
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907257560
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907257611
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907257661
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907257716
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907257773
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907257825
FETCH #3064429824:c=0,e=11,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907259036
FETCH #3064429824:c=0,e=10,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907259110
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907259162
FETCH #3064429824:c=0,e=11,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907259215
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907259271
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907259322
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907259383
FETCH #3064429824:c=0,e=12,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907259452
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907259507
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907259559
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907259610
FETCH #3064429824:c=0,e=8,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907259661
FETCH #3064429824:c=0,e=10,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907259717
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907259773
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907259824
FETCH #3064429824:c=0,e=8,p=0,cr=0,cu=0,mis=0,r=0,dep=1,og=4,plh=867914364,tim=1385703907259875
STAT #3064429824 id=1 cnt=59 pid=0 pos=1 obj=59 op='TABLE ACCESS FULL BOOTSTRAP$ (cr=61 pr=4 pw=0 time=7811 us)'
CLOSE #3064429824:c=0,e=10,dep=1,type=0,tim=1385703907267895
=====================
PARSING IN CURSOR #3064429824 len=129 dep=1 uid=0 oct=36 lid=0 tim=1385703907299714 hv=1119914026 ad='b6a51d5c' sqlid='864bmh11c121a'
CREATE ROLLBACK SEGMENT SYSTEM STORAGE ( INITIAL 112K NEXT 56K MINEXTENTS 1 MAXEXTENTS 32765 OBJNO 0 EXTENTS (FILE 1 BLOCK 128)) ----这些创建对象语句在数据库中通过select * from bootstrap$ 可以查到
END OF STMT
PARSE #3064429824:c=999,e=31611,p=0,cr=0,cu=0,mis=1,r=0,dep=1,og=4,plh=0,tim=1385703907299710
EXEC #3064429824:c=1000,e=18763,p=0,cr=0,cu=0,mis=0,r=0,dep=1,og=4,plh=0,tim=1385703907318789
CLOSE #3064429824:c=0,e=7,dep=1,type=0,tim=1385703907318912
=====================
PARSING IN CURSOR #3064429824 len=209 dep=1 uid=0 oct=4 lid=0 tim=1385703907324096 hv=1323908363 ad='b6a51d0c' sqlid='7j058yj7fkg8b'
CREATE CLUSTER C_OBJ#("OBJ#" NUMBER) PCTFREE 5 PCTUSED 40 INITRANS 2 MAXTRANS 255 STORAGE ( INITIAL 136K NEXT 200K MINEXTENTS 1 MAXEXTENTS 2147483645 PCTINCREASE 0 OBJNO 2 EXTENTS (FILE 1 BLOCK 144)) SIZE 800
END OF STMT
PARSE #3064429824:c=0,e=5135,p=0,cr=0,cu=0,mis=1,r=0,dep=1,og=4,plh=0,tim=1385703907324091
EXEC #3064429824:c=2000,e=420,p=0,cr=0,cu=0,mis=0,r=0,dep=1,og=4,plh=0,tim=1385703907324715
CLOSE #3064429824:c=0,e=7,dep=1,type=0,tim=1385703907324827
=====================
PARSING IN CURSOR #3064429824 len=191 dep=1 uid=0 oct=9 lid=0 tim=1385703907361450 hv=2739073813 ad='257d8b18' sqlid='0cmnx32jn5wsp'
CREATE INDEX I_OBJ# ON CLUSTER C_OBJ# PCTFREE 10 INITRANS 2 MAXTRANS 255 STORAGE ( INITIAL 64K NEXT 1024K MINEXTENTS 1 MAXEXTENTS 2147483645 PCTINCREASE 0 OBJNO 3 EXTENTS (FILE 1 BLOCK 168))
END OF STMT
1.使用10046事件查看数据库OPEN时的TRACE文件:
SYS@ bys3>startup mount;ORACLE instance started.
Total System Global Area 150654976 bytes
Fixed Size 1363216 bytes
Variable Size 96469744 bytes
Database Buffers 50331648 bytes
Redo Buffers 2490368 bytes
Database mounted.
SYS@ bys3>alter session set events='10046 trace name context forever,level 12';
Session altered.
SYS@ bys3>alter database open;
Database altered.
SYS@ bys3>select value from v$diag_info where name like 'Default%';
其它查看TRACE文件位置方法是:oradebug setmypid; oradebug tracefile_name 或者直接在user_dump_dest目录中使用 ls -alt 找最近生成的文件
VALUE
-------------------------------------------------------------------------------------------------
/u01/app/oracle/product/11.2.0/dbhome_1/log/diag/rdbms/bys3/bys3/trace/bys3_ora_13020.trc
####################################
引导过程: 关于root dba及 bootstrap$,详见:http://blog.csdn.net/q947817003/article/details/17025955
1.ORACLE首先读取控制文件获取数据文件,b file sequential read 单块读方式读取每个数据文件第一个block 数据文件头的信息,
2.然后用db file sequential read方式读取了file 1 block#520的内容(这一步应该有从file 1 blcok 1找到root dba来定位到file#1 block#520,不知道怎么从TRACE文件中看???)
WAIT #3064435524: nam='db file sequential read' ela= 264 file#=1 block#=520 blocks=1 obj#=-1 tim=1385703907158975
3.ORACLE找到了file#=1 block#=520后,读取其内容,在内存中创建:
PARSING IN CURSOR #3064429824 len=188 dep=1 uid=0 oct=1 lid=0 tim=1385703907172599 hv=4006182593 ad='257ea26c' sqlid='32r4f1brckzq1'
create table bootstrap$ (
END OF STMT
4.此后ORACLE通过递归查询,从bootstrap$中获取创建对象的语句:
PARSING IN CURSOR #3064429824 len=55 dep=1 uid=0 oct=3 lid=0 tim=1385703907195679 hv=2111436465 ad='257e8e88' sqlid='6apq2rjyxmxpj'
select line#, sql_text from bootstrap$ where obj# != :1
END OF STMT
5.然后,根据查出语句,创建这些对象:如下: 这些创建对象语句在数据库中也通过select * from bootstrap$ 可以查到
=====================
PARSING IN CURSOR #3064429824 len=129 dep=1 uid=0 oct=36 lid=0 tim=1385703907299714 hv=1119914026 ad='b6a51d5c' sqlid='864bmh11c121a'
CREATE ROLLBACK SEGMENT SYSTEM STORAGE ( INITIAL 112K NEXT 56K MINEXTENTS 1 MAXEXTENTS 32765 OBJNO 0 EXTENTS (FILE 1 BLOCK 128))
END OF STMT
PARSE #3064429824:c=999,e=31611,p=0,cr=0,cu=0,mis=1,r=0,dep=1,og=4,plh=0,tim=1385703907299710
EXEC #3064429824:c=1000,e=18763,p=0,cr=0,cu=0,mis=0,r=0,dep=1,og=4,plh=0,tim=1385703907318789
CLOSE #3064429824:c=0,e=7,dep=1,type=0,tim=1385703907318912
=====================
6.再然后,创建完这些对象后,就正常打开数据库。
########################################
2.关于转储文件中的几个等待事件简单说明:
Disk file operations I/OThis event is used to wait for disk file operations (for example, open, close, seek, and resize). It is also used for miscellaneous I/O operations such as block dumps and password file accesses.
control file sequential read
控制文件连续读
rdbms ipc reply
这个事件说明等待一个后台进程的响应。
db file sequential read
等待时间是由于执行对索引,回滚(undo)段,和表(当借助rowid来访问),控制文件和数据文件头的单块读操作SQL语句(用户和递归)引起的。
control file parallel write-控制文件并行写
当server 进程更新所有控制文件时,这个事件可能出现。如果等待很短,可以不用考虑。如果等待时间较长,检查存放控制文件的物理磁盘I/O 是否存在瓶颈
########################################
3.TRACE文件内容---截取部分
Trace file /u01/app/oracle/product/11.2.0/dbhome_1/log/diag/rdbms/bys3/bys3/trace/bys3_ora_13020.trcOracle Database 11g Enterprise Edition Release 11.2.0.4.0 - Production
With the Partitioning, OLAP, Data Mining and Real Application Testing options
ORACLE_HOME = /u01/app/oracle/product/11.2.0/dbhome_1
System name: Linux
Node name: bys3.bys.com
Release: 2.6.32-200.13.1.el5uek
Version: #1 SMP Wed Jul 27 20:21:26 EDT 2011
Machine: i686
Instance name: bys3
Redo thread mounted by this instance: 1
Oracle process number: 17
Unix process pid: 13020, image: oracle@bys3.bys.com (TNS V1-V3)
*** 2013-11-29 13:44:59.723
*** SESSION ID:(1.5) 2013-11-29 13:44:59.723
*** CLIENT ID:() 2013-11-29 13:44:59.723
*** SERVICE NAME:() 2013-11-29 13:44:59.723
*** MODULE NAME:(sqlplus@bys3.bys.com (TNS V1-V3)) 2013-11-29 13:44:59.723
*** ACTION NAME:() 2013-11-29 13:44:59.723
WAIT #3064440660: nam='SQL*Net message to client' ela= 10 driver id=1650815232 #bytes=1 p3=0 obj#=-1 tim=1385703899721694
*** 2013-11-29 13:45:05.589
WAIT #3064440660: nam='SQL*Net message from client' ela= 5865444 driver id=1650815232 #bytes=1 p3=0 obj#=-1 tim=1385703905589082
CLOSE #3064440660:c=0,e=28,dep=0,type=1,tim=1385703905590081
XCTEND rlbk=0, rd_only=1, tim=1385703905595227
=====================
PARSING IN CURSOR #3064435524 len=19 dep=0 uid=0 oct=35 lid=0 tim=1385703905623330 hv=1907384048 ad='25eddd7c' sqlid='a01hp0psv0rrh'
alter database open
END OF STMT
PARSE #3064435524:c=12999,e=33127,p=0,cr=0,cu=0,mis=1,r=0,dep=0,og=1,plh=0,tim=1385703905623322
WAIT #3064435524: nam='Disk file operations I/O' ela= 550 FileOperation=2 fileno=0 filetype=1 obj#=-1 tim=1385703905629002
WAIT #3064435524: nam='Disk file operations I/O'
ela= 33 FileOperation=2 fileno=1 filetype=1 obj#=-1 tim=1385703905629484
WAIT #3064435524: nam='control file sequential read' ela= 188 file#=0 block#=1 blocks=1 obj#=-1 tim=1385703905629831
WAIT #3064435524: nam='control file sequential read' ela= 47 file#=1 block#=1 blocks=1 obj#=-1
tim=1385703905630128 ---读取数据文件1的第1个块
WAIT #3064435524: nam='control file sequential read' ela= 23 file#=0 block#=8 blocks=1 obj#=-1 tim=1385703905630278
WAIT #3064435524: nam='control file sequential read' ela= 41 file#=0 block#=10 blocks=1 obj#=-1 tim=1385703905630632
WAIT #3064435524: nam='control file sequential read' ela= 39 file#=0 block#=1 blocks=1 obj#=-1 tim=1385703905633356
WAIT #3064435524: nam='control file sequential read' ela= 41 file#=0 block#=8 blocks=1 obj#=-1 tim=1385703905633910
WAIT #3064435524: nam='control file sequential read' ela= 38 file#=0 block#=10 blocks=1 obj#=-1 tim=1385703905634005
WAIT #3064435524: nam='rdbms ipc reply' ela= 60 from_process=10 timeout=910 p3=0 obj#=-1 tim=1385703905637300
WAIT #3064435524: nam='rdbms ipc reply' ela= 127477 from_process=10 timeout=910 p3=0 obj#=-1 tim=1385703905764875
WAIT #3064435524: nam='control file sequential read' ela= 52 file#=0 block#=1 blocks=1 obj#=-1 tim=1385703905765507
WAIT #3064435524: nam='control file sequential read' ela= 43 file#=0 block#=8 blocks=1 obj#=-1 tim=1385703905765632
WAIT #3064435524: nam='control file sequential read' ela= 42 file#=0 block#=10 blocks=1 obj#=-1 tim=1385703905765734
WAIT #3064435524: nam='control file sequential read' ela= 68 file#=0 block#=291 blocks=1 obj#=-1 tim=1385703905765869
WAIT #3064435524: nam='control file sequential read' ela= 40 file#=0 block#=1 blocks=1 obj#=-1 tim=1385703905766297
WAIT #3064435524: nam='control file sequential read' ela= 47 file#=1 block#=1 blocks=1 obj#=-1 tim=1385703905766543
WAIT #3064435524: nam='control file sequential read' ela= 40 file#=0 block#=8 blocks=1 obj#=-1 tim=1385703905766642
WAIT #3064435524: nam='control file sequential read' ela= 40 file#=0 block#=10 blocks=1 obj#=-1 tim=1385703905766731
WAIT #3064435524: nam='control file sequential read' ela= 43 file#=0 block#=291 blocks=1 obj#=-1 tim=1385703905766860
WAIT #3064435524: nam='Disk file operations I/O' ela= 69 FileOperation=2 fileno=1 filetype=2 obj#=-1 tim=1385703905767279
WAIT #3064435524: nam='Disk file operations I/O' ela= 23 FileOperation=2 fileno=2 filetype=2 obj#=-1 tim=1385703905767380
WAIT #3064435524: nam='Disk file operations I/O' ela= 54 FileOperation=2 fileno=3 filetype=2 obj#=-1 tim=1385703905767824
WAIT #3064435524: nam='Disk file operations I/O' ela= 51 FileOperation=2 fileno=4 filetype=2 obj#=-1 tim=1385703905767914
WAIT #3064435524: nam='Disk file operations I/O' ela= 20 FileOperation=2 fileno=201 filetype=2 obj#=-1 tim=1385703905767972
WAIT #3064435524: nam='control file sequential read' ela= 44 file#=0 block#=16 blocks=1 obj#=-1 tim=1385703905768068
WAIT #3064435524: nam='db file sequential read'
ela= 68 file#=1 block#=1 blocks=1 obj#=-1 tim=1385703905768369
WAIT #3064435524: nam='db file sequential read'
ela= 26 file#=2 block#=1 blocks=1 obj#=-1 tim=1385703905768933
WAIT #3064435524: nam='db file sequential read'
ela= 28 file#=3 block#=1 blocks=1 obj#=-1 tim=1385703905769117
WAIT #3064435524: nam='db file sequential read'
ela= 27 file#=4 block#=1 blocks=1 obj#=-1 tim=1385703905769223
WAIT #3064435524: nam='control file parallel write' ela= 744 files=2 block#=9 requests=2 obj#=-1 tim=1385703905770129
WAIT #3064435524: nam='control file parallel write' ela= 1244 files=2 block#=7 requests=2 obj#=-1 tim=1385703905771569
WAIT #3064435524: nam='control file parallel write' ela= 534 files=2 block#=1 requests=2 obj#=-1 tim=1385703905772171
WAIT #3064435524: nam='control file sequential read' ela= 41 file#=0 block#=1 blocks=1 obj#=-1 tim=1385703905772336
WAIT #3064435524: nam='control file sequential read' ela= 65 file#=1 block#=1 blocks=1 obj#=-1 tim=1385703905772461
WAIT #3064435524: nam='control file sequential read' ela= 42 file#=0 block#=7 blocks=1 obj#=-1 tim=1385703905772672
WAIT #3064435524: nam='control file sequential read' ela= 40 file#=0 block#=9 blocks=1 obj#=-1 tim=1385703905772771
WAIT #3064435524: nam='control file sequential read' ela= 41 file#=0 block#=291 blocks=1 obj#=-1 tim=1385703905772901
WAIT #3064435524: nam='control file sequential read' ela= 41 file#=0 block#=1 blocks=1 obj#=-1 tim=1385703905773134
WAIT #3064435524: nam='control file sequential read' ela= 44 file#=1 block#=1 blocks=1 obj#=-1 tim=1385703905773236
WAIT #3064435524: nam='control file sequential read' ela= 39 file#=0 block#=7 blocks=1 obj#=-1 tim=1385703905773317
WAIT #3064435524: nam='control file sequential read' ela= 44 file#=0 block#=9 blocks=1 obj#=-1 tim=1385703905773400
WAIT #3064435524: nam='control file sequential read' ela= 40 file#=0 block#=291 blocks=1 obj#=-1 tim=1385703905773549
WAIT #3064435524: nam='control file parallel write' ela= 607 files=2 block#=292 requests=2 obj#=-1 tim=1385703905774316
WAIT #3064435524: nam='control file parallel write' ela= 709 files=2 block#=10 requests=2 obj#=-1 tim=1385703905775097
WAIT #3064435524: nam='control file parallel write' ela= 610 files=2 block#=8 requests=2 obj#=-1 tim=1385703905775773
WAIT #3064435524: nam='control file parallel write' ela= 594 files=2 block#=1 requests=2 obj#=-1 tim=1385703905776514
WAIT #3064435524: nam='control file sequential read' ela= 42 file#=0 block#=1 blocks=1 obj#=-1 tim=1385703905779031
WAIT #3064435524: nam='control file sequential read' ela= 41 file#=1 block#=1 blocks=1 obj#=-1 tim=1385703905779254
WAIT #3064435524: nam='control file sequential read' ela= 48 file#=0 block#=8 blocks=1 obj#=-1 tim=1385703905779358
WAIT #3064435524: nam='control file sequential read' ela= 64 file#=0 block#=10 blocks=1 obj#=-1 tim=1385703905779464
WAIT #3064435524: nam='control file sequential read' ela= 48 file#=0 block#=331 blocks=1 obj#=-1 tim=1385703905779621
WAIT #3064435524: nam='control file parallel write' ela= 38493 files=2 block#=332 requests=2 obj#=-1 tim=1385703905818160
WAIT #3064435524: nam='control file parallel write' ela= 606 files=2 block#=9 requests=2 obj#=-1 tim=1385703905818848
WAIT #3064435524: nam='control file parallel write' ela= 934 files=2 block#=7 requests=2 obj#=-1 tim=1385703905819850
WAIT #3064435524: nam='control file parallel write' ela= 596 files=2 block#=1 requests=2 obj#=-1 tim=1385703905820754
WAIT #3064435524: nam='control file sequential read' ela= 42 file#=0 block#=1 blocks=1 obj#=-1 tim=1385703905821083
WAIT #3064435524: nam='control file sequential read' ela= 39 file#=1 block#=1 blocks=1 obj#=-1 tim=1385703905821240
WAIT #3064435524: nam='control file sequential read' ela= 43 file#=0 block#=7 blocks=1 obj#=-1 tim=1385703905821325
WAIT #3064435524: nam='control file sequential read' ela= 68 file#=0 block#=9 blocks=1 obj#=-1 tim=1385703905821441
WAIT #3064435524: nam='control file sequential read' ela= 47 file#=0 block#=1 blocks=1 obj#=-1 tim=1385703905821631
WAIT #3064435524: nam='control file sequential read' ela= 39 file#=1 block#=1 blocks=1 obj#=-1 tim=1385703905821729
WAIT #3064435524: nam='control file sequential read' ela= 44 file#=0 block#=7 blocks=1 obj#=-1 tim=1385703905821813
WAIT #3064435524: nam='control file sequential read' ela= 42 file#=0 block#=9 blocks=1 obj#=-1 tim=1385703905822220
WAIT #3064435524: nam='control file sequential read' ela= 45 file#=0 block#=11 blocks=1 obj#=-1 tim=1385703905822329
WAIT #3064435524: nam='control file sequential read' ela= 43 file#=0 block#=1 blocks=1 obj#=-1 tim=1385703905822488
WAIT #3064435524: nam='control file sequential read' ela= 43 file#=0 block#=7 blocks=1 obj#=-1 tim=1385703905822575
WAIT #3064435524: nam='control file sequential read' ela= 40 file#=0 block#=9 blocks=1 obj#=-1 tim=1385703905822659
WAIT #3064435524: nam='rdbms ipc reply' ela= 23 from_process=11 timeout=1800 p3=0 obj#=-1 tim=1385703905826080
*** 2013-11-29 13:45:07.141
WAIT #3064435524: nam='rdbms ipc reply' ela= 1314812 from_process=11 timeout=1800 p3=0 obj#=-1 tim=1385703907140989
WAIT #3064435524: nam='control file sequential read' ela= 101 file#=0 block#=1 blocks=1 obj#=-1 tim=1385703907142993
WAIT #3064435524: nam='control file sequential read' ela= 42 file#=0 block#=8 blocks=1 obj#=-1 tim=1385703907143128
WAIT #3064435524: nam='control file sequential read' ela= 43 file#=0 block#=10 blocks=1 obj#=-1 tim=1385703907143343
WAIT #3064435524: nam='control file sequential read' ela= 58 file#=0 block#=292 blocks=1 obj#=-1 tim=1385703907143462
WAIT #3064435524: nam='control file sequential read' ela= 41 file#=0 block#=1 blocks=1 obj#=-1 tim=1385703907143570
WAIT #3064435524: nam='control file sequential read' ela= 39 file#=0 block#=8 blocks=1 obj#=-1 tim=1385703907143651
WAIT #3064435524: nam='control file sequential read' ela= 43 file#=0 block#=10 blocks=1 obj#=-1 tim=1385703907143739
WAIT #3064435524: nam='control file sequential read' ela= 40 file#=0 block#=292 blocks=1 obj#=-1 tim=1385703907143821
WAIT #3064435524: nam='control file sequential read' ela= 41 file#=0 block#=1 blocks=1 obj#=-1 tim=1385703907143944
WAIT #3064435524: nam='control file sequential read' ela= 40 file#=0 block#=8 blocks=1 obj#=-1 tim=1385703907144025
WAIT #3064435524: nam='control file sequential read' ela= 42 file#=0 block#=10 blocks=1 obj#=-1 tim=1385703907144110
WAIT #3064435524: nam='control file sequential read' ela= 40 file#=0 block#=292 blocks=1 obj#=-1 tim=1385703907144192
WAIT #3064435524: nam='control file sequential read' ela= 44 file#=0 block#=1 blocks=1 obj#=-1 tim=1385703907148808
WAIT #3064435524: nam='control file sequential read' ela= 49 file#=0 block#=8 blocks=1 obj#=-1 tim=1385703907148929
WAIT #3064435524: nam='control file sequential read' ela= 40 file#=0 block#=10 blocks=1 obj#=-1 tim=1385703907149011
WAIT #3064435524: nam='control file sequential read' ela= 43 file#=0 block#=292 blocks=1 obj#=-1 tim=1385703907149094
WAIT #3064435524: nam='db file sequential read' ela= 264 file#=1 block#=520blocks=1 obj#=-1 tim=1385703907158975
=====================
PARSING IN CURSOR #3064429824 len=188 dep=1 uid=0 oct=1 lid=0 tim=1385703907172599 hv=4006182593 ad='257ea26c' sqlid='32r4f1brckzq1'
create table bootstrap$ (
END OF STMT
PARSE #3064429824:c=5999,e=11363,p=0,cr=0,cu=0,mis=1,r=0,dep=1,og=4,plh=0,tim=1385703907172594
EXEC #3064429824:c=2000,e=16397,p=0,cr=0,cu=0,mis=0,r=0,dep=1,og=4,plh=0,tim=1385703907191131
CLOSE #3064429824:c=1000,e=36,dep=1,type=0,tim=1385703907191434
=====================
PARSING IN CURSOR #3064429824 len=55 dep=1 uid=0 oct=3 lid=0 tim=1385703907195679 hv=2111436465 ad='257e8e88' sqlid='6apq2rjyxmxpj'
select line#, sql_text from bootstrap$ where obj# != :1
END OF STMT
PARSE #3064429824:c=2999,e=4055,p=0,cr=0,cu=0,mis=1,r=0,dep=1,og=4,plh=0,tim=1385703907195675
BINDS #3064429824:
Bind#0
oacdty=02 mxl=22(22) mxlc=00 mal=00 scl=00 pre=00
oacflg=08 fl2=0001 frm=00 csi=00 siz=24 off=0
kxsbbbfp=b6a778d0 bln=22 avl=02 flg=05
value=59
EXEC #3064429824:c=7999,e=47324,p=0,cr=0,cu=0,mis=1,r=0,dep=1,og=4,plh=867914364,tim=1385703907244586
WAIT #3064429824: nam='db file sequential read' ela= 246 file#=1 block#=520 blocks=1 obj#=59 tim=1385703907245408
WAIT #3064429824: nam='db file scattered read' ela= 470 file#=1 block#=521 blocks=3 obj#=59 tim=1385703907248639
FETCH #3064429824:c=3999,e=7831,p=4,cr=3,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907252714
FETCH #3064429824:c=0,e=45,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907252920
FETCH #3064429824:c=0,e=10,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907252978
FETCH #3064429824:c=0,e=10,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907253032
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907253089
FETCH #3064429824:c=0,e=10,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907253148
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907253201
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907253254
FETCH #3064429824:c=0,e=10,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907253307
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907253359
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907253412
FETCH #3064429824:c=0,e=10,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907253486
FETCH #3064429824:c=0,e=11,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907254729
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907254803
FETCH #3064429824:c=0,e=10,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907254856
FETCH #3064429824:c=0,e=10,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907254908
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907254959
FETCH #3064429824:c=0,e=10,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907255011
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907255072
FETCH #3064429824:c=0,e=10,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907255125
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907255176
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907255228
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907255280
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907255331
FETCH #3064429824:c=0,e=10,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907255386
FETCH #3064429824:c=0,e=13,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907255457
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907255512
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907255564
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907255615
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907255666
FETCH #3064429824:c=0,e=12,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907256923
FETCH #3064429824:c=0,e=10,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907256977
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907257028
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907257080
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907257131
FETCH #3064429824:c=0,e=10,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907257232
FETCH #3064429824:c=0,e=13,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907257453
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907257508
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907257560
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907257611
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907257661
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907257716
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907257773
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907257825
FETCH #3064429824:c=0,e=11,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907259036
FETCH #3064429824:c=0,e=10,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907259110
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907259162
FETCH #3064429824:c=0,e=11,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907259215
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907259271
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907259322
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907259383
FETCH #3064429824:c=0,e=12,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907259452
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907259507
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907259559
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907259610
FETCH #3064429824:c=0,e=8,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907259661
FETCH #3064429824:c=0,e=10,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907259717
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907259773
FETCH #3064429824:c=0,e=9,p=0,cr=1,cu=0,mis=0,r=1,dep=1,og=4,plh=867914364,tim=1385703907259824
FETCH #3064429824:c=0,e=8,p=0,cr=0,cu=0,mis=0,r=0,dep=1,og=4,plh=867914364,tim=1385703907259875
STAT #3064429824 id=1 cnt=59 pid=0 pos=1 obj=59 op='TABLE ACCESS FULL BOOTSTRAP$ (cr=61 pr=4 pw=0 time=7811 us)'
CLOSE #3064429824:c=0,e=10,dep=1,type=0,tim=1385703907267895
=====================
PARSING IN CURSOR #3064429824 len=129 dep=1 uid=0 oct=36 lid=0 tim=1385703907299714 hv=1119914026 ad='b6a51d5c' sqlid='864bmh11c121a'
CREATE ROLLBACK SEGMENT SYSTEM STORAGE ( INITIAL 112K NEXT 56K MINEXTENTS 1 MAXEXTENTS 32765 OBJNO 0 EXTENTS (FILE 1 BLOCK 128)) ----这些创建对象语句在数据库中通过select * from bootstrap$ 可以查到
END OF STMT
PARSE #3064429824:c=999,e=31611,p=0,cr=0,cu=0,mis=1,r=0,dep=1,og=4,plh=0,tim=1385703907299710
EXEC #3064429824:c=1000,e=18763,p=0,cr=0,cu=0,mis=0,r=0,dep=1,og=4,plh=0,tim=1385703907318789
CLOSE #3064429824:c=0,e=7,dep=1,type=0,tim=1385703907318912
=====================
PARSING IN CURSOR #3064429824 len=209 dep=1 uid=0 oct=4 lid=0 tim=1385703907324096 hv=1323908363 ad='b6a51d0c' sqlid='7j058yj7fkg8b'
CREATE CLUSTER C_OBJ#("OBJ#" NUMBER) PCTFREE 5 PCTUSED 40 INITRANS 2 MAXTRANS 255 STORAGE ( INITIAL 136K NEXT 200K MINEXTENTS 1 MAXEXTENTS 2147483645 PCTINCREASE 0 OBJNO 2 EXTENTS (FILE 1 BLOCK 144)) SIZE 800
END OF STMT
PARSE #3064429824:c=0,e=5135,p=0,cr=0,cu=0,mis=1,r=0,dep=1,og=4,plh=0,tim=1385703907324091
EXEC #3064429824:c=2000,e=420,p=0,cr=0,cu=0,mis=0,r=0,dep=1,og=4,plh=0,tim=1385703907324715
CLOSE #3064429824:c=0,e=7,dep=1,type=0,tim=1385703907324827
=====================
PARSING IN CURSOR #3064429824 len=191 dep=1 uid=0 oct=9 lid=0 tim=1385703907361450 hv=2739073813 ad='257d8b18' sqlid='0cmnx32jn5wsp'
CREATE INDEX I_OBJ# ON CLUSTER C_OBJ# PCTFREE 10 INITRANS 2 MAXTRANS 255 STORAGE ( INITIAL 64K NEXT 1024K MINEXTENTS 1 MAXEXTENTS 2147483645 PCTINCREASE 0 OBJNO 3 EXTENTS (FILE 1 BLOCK 168))
END OF STMT
相关文章推荐
- 一个查看MSSQLServer数据库空间使用情况的存储过程 SpaceUsed
- 使用BBED查看SYSTEM文件头的root dba及bootstrap$
- eclipse openRunDialog 查看详细加载过程
- 将Oracle数据库改为归档模式并启用RMAN备份 如下Linux环境下对Oracle单节点数据库采用文件系统情况的配置归档模式过程。首先查看数据库归档模式和磁盘使用情况,确定归档文件放到什么位置。
- 一个查看MSSQLServer数据库空间使用情况的存储过程 SpaceUsed
- 在系统启动时至少有一个服务或驱动程序产生错误,详细信息,请使用事件查看器查看事件日志
- C#使用 SQLite 数据库 开发的配置过程及基本操作类,实例程序:工商银行贵金属行情查看小工具
- 弹出应用程序: 服务控制管理器 : 在系统启动时至少有一个服务或驱动程序产生错误。详细信息,请使用事件查看器查看事件日志
- 在系统启动时至少有一个服务或驱动程序产生错误。详细信息,请使用事件查看器查看事件日志
- 在系统启动时至少有一个服务或驱动程序产生错误。详细信息,请使用时间查看器查看事件日志
- WCF 寄宿于Windows服务 ,可能会报的错:在系统启动时至少有一个服务或驱动程序产生错误。详细信息,请使用事件查看器查看事件日志。
- 程序打包,"错误:应用程序无法启动,因为应用程序的并行配置不正确。有关详细信息,请参阅应用程序事件日志,或使用命令行sxstrace.exe"工具解决办法
- Zstack协议栈OSAL中添加任务事件消息、发送数据详细过程
- Android--创建和使用数据库详细指南
- vc使用ADO连接数据库 ADODB中的RecordSet.Open打开记录的两个参数adOpenKeyset、adLockBatchOptimistic的说明:
- 使用通有事件过程,如何查找事件产生的控件
- 使用 10046 查看执行计划并读懂 trace 文件
- android 最新 NDK r8 在window下开发环境搭建 安装配置与使用 详细图文讲解,完整实际配置过程记录
- VMware Tools (ubuntu系统)安装详细过程与使用
- mysql查看当前使用的数据库