Oracle, The World's Largest Enterprise Software Company
  |  WorldwideChange Country, Oracle Worldwide Web SitesSitefinder
Secure Search
PRODUCTS AND SERVICES INDUSTRIES SUPPORT PARTNERS COMMUNITIES ABOUT

AWR Report

WORKLOAD REPOSITORY report for

DB NameDB IdInstanceInst numReleaseRACHost
VIS192418558VISA110.2.0.3.0YESoracle16.engr.sgi.com

Snap IdSnap TimeSessionsCursors/Session
Begin Snap:103-Jan-08 19:33:111233 139.6
End Snap:303-Jan-08 20:38:19201 221.8
Elapsed:  65.15 (mins)  
DB Time:  500.54 (mins)  

Report Summary

Cache Sizes

BeginEnd
Buffer Cache: 8,000M 8,000MStd Block Size: 8K
Shared Pool Size: 3,008M 3,008MLog Buffer: 30,736K

Load Profile

Per SecondPer Transaction
Redo size: 7,080,994.31 54,518.07
Logical reads: 288,951.39 2,224.70
Block changes: 42,712.56 328.85
Physical reads: 187.49 1.44
Physical writes: 1,122.36 8.64
User calls: 2,631.77 20.26
Parses: 1,256.73 9.68
Hard parses: 1.11 0.01
Sorts: 1,563.32 12.04
Logons: 2.08 0.02
Executes: 13,845.63 106.60
Transactions: 129.88 

% Blocks changed per Read: 14.78Recursive Call %: 89.86
Rollback per transaction %: 4.36Rows per Sort: 9.98

Instance Efficiency Percentages (Target 100%)

Buffer Nowait %: 99.92Redo NoWait %: 100.00
Buffer Hit %: 99.96In-memory Sort %: 100.00
Library Hit %: 100.03Soft Parse %: 99.91
Execute to Parse %: 90.92Latch Hit %: 98.49
Parse CPU to Parse Elapsd %: 79.64% Non-Parse CPU: 97.10

Shared Pool Statistics

BeginEnd
Memory Usage %: 47.65 64.31
% SQL with executions>1: 56.68 81.59
% Memory for SQL w/exec>1: 34.81 53.66

Top 5 Timed Events

EventWaitsTime(s)Avg Wait(ms)% Total Call TimeWait Class
CPU time  25,138  83.7 
gc buffer busy 92,633 938 10 3.1Cluster
latch: cache buffers chains 2,796,918 619 0 2.1Concurrency
enq: HW - contention 89,720 359 4 1.2Configuration
log file sync 136,786 309 2 1.0Commit

RAC Statistics

BeginEnd
Number of Instances: 2 2

Global Cache Load Profile

Per SecondPer Transaction
Global Cache blocks received: 144.91 1.12
Global Cache blocks served: 94.25 0.73
GCS/GES messages received: 761.14 5.86
GCS/GES messages sent: 788.94 6.07
DBWR Fusion writes: 9.90 0.08
Estd Interconnect traffic (KB) 2,216.02 

Global Cache Efficiency Percentages (Target local+remote 100%)

Buffer access - local cache %: 99.91
Buffer access - remote cache %: 0.05
Buffer access - disk %: 0.04

Global Cache and Enqueue Services - Workload Characteristics

Avg global enqueue get time (ms): 0.2
Avg global cache cr block receive time (ms): 1.2
Avg global cache current block receive time (ms): 1.2
Avg global cache cr block build time (ms): 0.2
Avg global cache cr block send time (ms): 0.1
Global cache log flushes for cr blocks served %: 23.2
Avg global cache cr block flush time (ms): 2.5
Avg global cache current block pin time (ms): 0.3
Avg global cache current block send time (ms): 0.1
Global cache log flushes for current blocks served %: 2.1
Avg global cache current block flush time (ms): 3.5

Global Cache and Enqueue Services - Messaging Statistics

Avg message sent queue time (ms): 0.1
Avg message sent queue time on ksxp (ms): 0.5
Avg message received queue time (ms): 0.0
Avg GCS message process time (ms): 0.0
Avg GES message process time (ms): 0.0
% of direct sent messages: 41.33
% of indirect sent messages: 26.98
% of flow controlled messages: 31.68


Main Report

More RAC Statistics


Back to Top

Wait Events Statistics

Back to Top

Time Model Statistics

  • Total time in database user-calls (DB Time): 30032.2s
  • Statistics including the word "background" measure background process time, and so do not contribute to the DB time statistic
  • Ordered by % or DB time desc, Statistic name
Statistic NameTime (s)% of DB Time
sql execute elapsed time 27,900.48 92.90
DB CPU 25,137.94 83.70
PL/SQL execution elapsed time 3,882.11 12.93
Java execution elapsed time 2,979.57 9.92
inbound PL/SQL rpc elapsed time 2,593.16 8.63
parse time elapsed 948.32 3.16
hard parse elapsed time 663.34 2.21
sequence load elapsed time 107.11 0.36
connection management call elapsed time 25.58 0.09
repeated bind elapsed time 24.14 0.08
hard parse (sharing criteria) elapsed time 5.95 0.02
PL/SQL compilation elapsed time 4.69 0.02
hard parse (bind mismatch) elapsed time 1.45 0.00
DB time 30,032.23  
background elapsed time 1,758.16  
background cpu time 1,088.35  

Back to Wait Events Statistics
Back to Top

Wait Class

  • s - second
  • cs - centisecond - 100th of a second
  • ms - millisecond - 1000th of a second
  • us - microsecond - 1000000th of a second
  • ordered by wait time desc, waits desc
Wait ClassWaits%Time -outsTotal Wait Time (s)Avg wait (ms)Waits /txn
Cluster 1,077,391 0.07 1,917 2 2.12
Concurrency 3,682,944 0.37 1,234 0 7.25
Other 1,135,556 26.85 669 1 2.24
Configuration 253,849 53.57 407 2 0.50
System I/O 789,021 0.00 370 0 1.55
User I/O 238,860 0.00 343 1 0.47
Application 45,362 0.80 318 7 0.09
Commit 136,786 0.00 309 2 0.27
Network 12,102,905 0.00 76 0 23.84

Back to Wait Events Statistics
Back to Top

Wait Events

  • s - second
  • cs - centisecond - 100th of a second
  • ms - millisecond - 1000th of a second
  • us - microsecond - 1000000th of a second
  • ordered by wait time desc, waits desc (idle events last)
EventWaits%Time -outsTotal Wait Time (s)Avg wait (ms)Waits /txn
gc buffer busy 92,633 0.83 938 10 0.18
latch: cache buffers chains 2,796,918 0.00 619 0 5.51
enq: HW - contention 89,720 0.02 359 4 0.18
log file sync 136,786 0.00 309 2 0.27
gc cr block busy 161,921 0.00 301 2 0.32
db file sequential read 160,654 0.00 269 2 0.32
enq: UL - contention 34,930 0.78 257 7 0.07
gc cr multi block request 60,444 0.00 213 4 0.12
log file parallel write 503,400 0.00 211 0 0.99
enq: TX - index contention 36,168 0.27 188 5 0.07
gc cr block 2-way 254,518 0.00 167 1 0.50
db file parallel write 274,164 0.00 154 1 0.54
cursor: pin S wait on X 14,615 92.98 146 10 0.03
buffer busy waits 698,811 0.00 132 0 1.38
DFS lock handle 93,113 0.00 124 1 0.18
gcs log flush sync 98,716 19.20 122 1 0.19
wait for scn ack 370,830 0.00 122 0 0.73
gc current block 2-way 115,866 0.00 81 1 0.23
row cache lock 118,981 0.00 75 1 0.23
enq: FB - contention 28,390 0.00 70 2 0.06
read by other session 64,575 0.00 58 1 0.13
gc current grant busy 40,571 0.00 57 1 0.08
cr request retry 68 91.18 57 834 0.00
gc current multi block request 217,053 0.00 54 0 0.43
latch: undo global data 11,304 0.00 49 4 0.02
gc current block busy 2,454 0.00 48 20 0.00
enq: SQ - contention 26,650 0.00 42 2 0.05
SQL*Net more data to client 982,271 0.00 38 0 1.93
library cache lock 2,288 0.13 34 15 0.00
enq: TX - contention 5,742 0.07 27 5 0.01
SQL*Net more data from client 306,183 0.00 27 0 0.60
gc current grant 2-way 69,452 0.00 23 0 0.14
enq: KO - fast object checkpoint 116 36.21 22 193 0.00
enq: TX - row lock contention 2,051 1.22 22 11 0.00
gc cr grant 2-way 58,575 0.00 21 0 0.12
library cache load lock 912 0.00 21 23 0.00
db file scattered read 8,599 0.00 14 2 0.02
buffer deadlock 51,961 98.40 13 0 0.10
enq: RO - fast object reuse 92 22.83 13 136 0.00
SQL*Net message to client 10,814,451 0.00 11 0 21.30
global enqueue expand wait 1,235 76.92 10 8 0.00
latch: redo allocation 15,283 0.00 10 1 0.03
latch: library cache 6,969 0.00 9 1 0.01
enq: US - contention 9,769 0.00 7 1 0.02
latch free 8,594 0.00 7 1 0.02
latch: cache buffers lru chain 5,184 0.00 6 1 0.01
kksfbc child completion 159 71.70 6 36 0.00
enq: TX - allocate ITL entry 1,277 0.00 5 4 0.00
gc cr block congested 1,789 0.00 5 3 0.00
reliable message 424 0.24 5 11 0.00
LGWR wait for redo copy 25,276 0.14 4 0 0.05
SQL*Net break/reset to client 8,012 0.00 4 1 0.02
gc recovery quiesce 14 28.57 4 279 0.00
library cache pin 2,292 0.00 4 2 0.00
enq: DV - contention 376 0.00 4 9 0.00
wait list latch free 1,625 0.00 3 2 0.00
gcs drm freeze in enter server mode 18 0.00 3 171 0.00
latch: library cache pin 3,004 0.00 3 1 0.01
name-service call wait 44 0.00 3 66 0.00
control file sequential read 9,639 0.00 3 0 0.02
ksxr poll remote instances 255,040 50.33 2 0 0.50
control file parallel write 1,818 0.00 2 1 0.00
cursor: pin S 19,400 0.00 2 0 0.04
db file parallel read 173 0.00 2 12 0.00
gc current block congested 807 0.00 2 3 0.00
os thread startup 14 0.00 2 142 0.00
latch: ges resource hash list 7,922 0.00 2 0 0.02
latch: object queue header operation 5,737 0.00 1 0 0.01
rdbms ipc reply 1,346 0.00 1 1 0.00
PX Deq Credit: send blkd 1,648 30.70 1 1 0.00
latch: cache buffer handles 1,432 0.00 1 1 0.00
latch: gcs resource hash 1,238 0.00 1 1 0.00
lock deadlock retry 25 96.00 1 39 0.00
latch: row cache objects 1,315 0.00 1 1 0.00
gc current retry 50 0.00 1 17 0.00
gc cr grant congested 402 0.00 1 2 0.00
gc current grant congested 375 0.00 1 2 0.00
latch: session allocation 1,437 0.00 1 0 0.00
undo segment extension 136,025 99.96 1 0 0.27
PX Deq: reap credit 20,499 81.36 0 0 0.04
CGS wait for IPC msg 55,629 99.91 0 0 0.11
enq: CF - contention 164 0.00 0 3 0.00
enq: TM - contention 159 0.00 0 3 0.00
enq: PS - contention 185 0.00 0 2 0.00
local write wait 29 0.00 0 13 0.00
latch: library cache lock 243 0.00 0 1 0.00
latch: redo writing 172 0.00 0 2 0.00
gc current block unknown 373 0.00 0 1 0.00
latch: KCL gc element parent latch 1,051 0.00 0 0 0.00
latch: messages 1,096 0.00 0 0 0.00
latch: shared pool 219 0.00 0 1 0.00
PX Deq: Signal ACK 111 31.53 0 2 0.00
enq: TO - contention 47 0.00 0 4 0.00
PX qref latch 32,352 99.83 0 0 0.06
enq: TT - contention 93 0.00 0 2 0.00
KJC: Wait for msg sends to complete 310 0.00 0 0 0.00
latch: checkpoint queue latch 214 0.00 0 1 0.00
enq: TA - contention 89 0.00 0 2 0.00
latch: enqueue hash chains 185 0.00 0 1 0.00
gc current split 20 0.00 0 5 0.00
IPC send completion sync 56 91.07 0 2 0.00
L1 validation 10 70.00 0 9 0.00
write complete waits 5 0.00 0 12 0.00
gc cr failure 69 0.00 0 1 0.00
enq: KM - contention 6 0.00 0 7 0.00
enq: JQ - contention 8 0.00 0 4 0.00
cursor: mutex S 151 0.00 0 0 0.00
lock escalate retry 47 89.36 0 1 0.00
latch: object queue header heap 42 0.00 0 0 0.00
direct path read 4,685 0.00 0 0 0.01
enq: MD - contention 9 0.00 0 1 0.00
enq: WF - contention 8 0.00 0 1 0.00
cursor: mutex X 44 0.00 0 0 0.00
gc cr disk read 4 0.00 0 0 0.00
enq: TQ - TM contention 1 0.00 0 1 0.00
enq: CU - contention 1 0.00 0 1 0.00
direct path write 107 0.00 0 0 0.00
enq: MW - contention 2 0.00 0 0 0.00
kkdlgon 1 0.00 0 0 0.00
direct path write temp 32 0.00 0 0 0.00
enq: DL - contention 1 0.00 0 0 0.00
enq: PW - flush prewarm buffers 2 0.00 0 0 0.00
gc quiesce wait 1 0.00 0 0 0.00
latch: parallel query alloc buffer 1 0.00 0 0 0.00
ges2 LMON to wake up LMD - mrcvr 2 0.00 0 0 0.00
direct path read temp 6 0.00 0 0 0.00
SQL*Net message from client 10,814,965 0.00 2,330,594 215 21.30
pipe get 46,046 46.65 63,838 1386 0.09
gcs remote message 2,421,228 77.13 14,875 6 4.77
Streams AQ: waiting for messages in the queue 1,712 98.54 10,139 5922 0.00
PX Idle Wait 2,447 95.10 5,790 2366 0.00
DIAG idle wait 19,318 0.00 3,814 197 0.04
jobq slave wait 1,614 46.84 3,807 2359 0.00
Streams AQ: qmn slave idle wait 138 0.00 3,792 27480 0.00
Streams AQ: qmn coordinator idle wait 275 50.18 3,792 13790 0.00
ges remote message 635,207 63.18 3,760 6 1.25
Streams AQ: waiting for time management or cleanup tasks 54 25.93 3,759 69615 0.00
PL/SQL lock timer 271 96.31 2,979 10993 0.00
PX Deq: Execution Msg 1,258 4.85 48 38 0.00
PX Deq: Execute Reply 3,642 26.11 9 3 0.01
PX Deq: Parse Reply 149 20.81 7 50 0.00
PX Deq: Msg Fragment 810 0.74 2 2 0.00
PX Deq: Join ACK 200 38.50 0 2 0.00
PX Deq Credit: need buffer 1,021 4.80 0 0 0.00
PX Deq: Table Q Normal 334 17.07 0 1 0.00
Streams AQ: RAC qmn coordinator idle wait 276 100.00 0 0 0.00

Back to Wait Events Statistics
Back to Top

Background Wait Events

  • ordered by wait time desc, waits desc (idle events last)
EventWaits%Time -outsTotal Wait Time (s)Avg wait (ms)Waits /txn
events in waitclass Other 849,803 23.90 289 0 1.67
log file parallel write 503,387 0.00 211 0 0.99
db file parallel write 274,161 0.00 154 1 0.54
latch: cache buffers chains 6,620 0.00 14 2 0.01
db file scattered read 895 0.00 4 5 0.00
control file sequential read 7,828 0.00 2 0 0.02
control file parallel write 1,818 0.00 2 1 0.00
gc cr multi block request 3,551 0.00 1 0 0.01
db file parallel read 43 0.00 1 12 0.00
row cache lock 260 0.00 0 2 0.00
db file sequential read 155 0.00 0 3 0.00
latch: redo writing 172 0.00 0 2 0.00
gc current block 2-way 497 0.00 0 0 0.00
gc cr block 2-way 182 0.00 0 1 0.00
buffer busy waits 508 0.59 0 0 0.00
enq: KO - fast object checkpoint 24 0.00 0 2 0.00
library cache lock 30 0.00 0 1 0.00
enq: TM - contention 14 0.00 0 3 0.00
enq: RO - fast object reuse 19 0.00 0 2 0.00
gc current grant 2-way 56 0.00 0 0 0.00
gc current grant busy 28 0.00 0 1 0.00
gc cr block congested 3 0.00 0 3 0.00
gc cr grant 2-way 26 0.00 0 0 0.00
latch: row cache objects 23 0.00 0 0 0.00
library cache pin 1 0.00 0 1 0.00
log file sync 1 0.00 0 0 0.00
latch: shared pool 3 0.00 0 0 0.00
latch: library cache 1 0.00 0 0 0.00
rdbms ipc message 1,611,012 3.93 40,716 25 3.17
gcs remote message 2,420,990 77.13 14,875 6 4.77
DIAG idle wait 19,318 0.00 3,814 197 0.04
pmon timer 3,316 95.69 3,798 1145 0.01
Streams AQ: qmn slave idle wait 138 0.00 3,792 27480 0.00
Streams AQ: qmn coordinator idle wait 275 50.18 3,792 13790 0.00
ges remote message 635,054 63.18 3,760 6 1.25
Streams AQ: waiting for time management or cleanup tasks 54 25.93 3,759 69615 0.00
smon timer 158,694 0.00 3,750 24 0.31
PX Deq: Join ACK 28 42.86 0 2 0.00
PX Deq: Parse Reply 30 40.00 0 1 0.00
PX Deq: Execute Reply 23 26.09 0 1 0.00
Streams AQ: RAC qmn coordinator idle wait 276 100.00 0 0 0.00

Back to Wait Events Statistics
Back to Top

Operating System Statistics

StatisticTotal
BUSY_TIME 30,258,744
IDLE_TIME 33,727,765
IOWAIT_TIME 406,624
NICE_TIME 0
SYS_TIME 2,887,480
USER_TIME 25,469,156
LOAD 1
RSRC_MGR_CPU_WAIT_TIME 0
PHYSICAL_MEMORY_BYTES 10,977,888
NUM_CPUS 16
NUM_CPU_SOCKETS 8

Back to Wait Events Statistics
Back to Top

Service Statistics

  • ordered by DB Time
Service NameDB Time (s)DB CPU (s)Physical ReadsLogical Reads
VIS 29,870.80 25,000.00 613,450 1,119,625,711
SYS$USERS 179.50 147.10 99,618 8,109,028
SYS$BACKGROUND 0.00 0.00 19,839 1,860,682

Back to Wait Events Statistics
Back to Top

Service Wait Class Stats

  • Wait Class info for services in the Service Statistics section.
  • Total Waits and Time Waited displayed for the following wait classes: User I/O, Concurrency, Administrative, Network
  • Time Waited (Wt Time) in centisecond (100th of a second)
Service NameUser I/O Total WtsUser I/O Wt TimeConcurcy Total WtsConcurcy Wt TimeAdmin Total WtsAdmin Wt TimeNetwork Total WtsNetwork Wt Time
VIS 227739 32285 3664587 121490 0 0 12081554 7619
SYS$USERS 10027 1496 10930 488 0 0 6363 2
SYS$BACKGROUND 1093 528 7457 1455 0 0 0 0

Back to Wait Events Statistics
Back to Top

SQL Statistics

Back to Top

SQL ordered by Elapsed Time

  • Resources reported for PL/SQL code includes the resources used by all SQL statements called by the code.
  • % Total DB Time is the Elapsed Time of the SQL statement divided into the Total Database Time multiplied by 100
Elapsed Time (s)CPU Time (s)Executions Elap per Exec (s) % Total DB Time SQL IdSQL ModuleSQL Text
3,795 3,673 8 474.39 12.64 ghw9svn8x4vzu WSHPSRS BEGIN WSH_PICK_LIST.RELEASE_BA...
2,477 2,304 294 8.43 8.25 0z318y6g3uagc INCTCW declare l_retstat varchar2 ( 3...
1,816 1,705 10 181.62 6.05 bkxrrs52m7d8p WSHINTERFACE BEGIN WSH_SHIP_CONFIRM_ACTIONS...
1,645 1,096 14 117.54 5.48 8c30hkqv9n7cr OEHVIMP BEGIN OE_BULK_ORDER_IMPORT_PVT...
1,610 1,559 69,421 0.02 5.36 60t2tt1564j0k   SELECT SUBSTRB(MACHINE, 1, 60)...
1,049 628 1,526 0.69 3.49 bt0w082dfrm8v WSHINTERFACE BEGIN WSH_SHIP_CONFIRM_ACTIONS...
974 925 8 121.72 3.24 7g05xfvc5vp74 ARTERRPW BEGIN arp_run.revenue_recognit...
814 544 57,598 0.01 2.71 gksvm8wmzk8w0 WSHINTERFACE begin OE_INVOICE_WF.INVOICE_IN...
811 724 1,285 0.63 2.70 3cb7xm8ykx1qh icx.por.req.server.RequisitionAM begin :1 := POR_UTIL_PKG.subm...
698 623 16 43.61 2.32 5qyckzm5v1qmj RAXTRX begin :return_value:i_return_v...
668 644 19,458 0.03 2.23 8h16w67202y4g   begin fnd_global.initialize(:s...
626 610 11 56.91 2.08 1du9v021t8m46 ARGLTP insert into gl_interface(creat...
554 523 5,000 0.11 1.85 2fjd6cndjby9p ARTERRPW INSERT INTO RA_CUST_TRX_LINE_G...
523 477 8 65.42 1.74 8vmj377jqyqwq WSHASCSRS BEGIN WSH_BATCH_PROCESS.CONFIR...
516 373 96 5.37 1.72 37f1qguwxw0sk RAXTRX begin IF ( :v_msg_level:i_msg_...
445 377 57,605 0.01 1.48 9wdrypwkpf607 WSHINTERFACE begin OE_FULFILL_WF.START_FULF...
442 126 63 7.01 1.47 3a7mfaapst783 RAXTRX update RA_CUSTOMER_TRX T set ...
434 415 57,639 0.01 1.44 4yak7x2zqz0dh WSHFRREL BEGIN inv_transfer_order_pvt.f...
378 331 8,886 0.04 1.26 6h2tpcxpymqu7 JDBC Thin Client BEGIN :1 := FND_AOLJ_UTIL.is_V...
338 331 11 30.77 1.13 bp8crdjba8zgt ARGLTP update ra_cust_trx_line_gl_dis...
335 280 10,000 0.03 1.12 64qc329wgjv39 PYUSLV select /*+ ORDERED INDEX(ASS...
335 27 16 20.91 1.11 cz148dcrzr2rw RAXTRX UPDATE RA_INTERFACE_LINES SET ...
331 328 984 0.34 1.10 0qcpgw43yqj5r WSHPSRS ( SELECT DISTINCT WDD.SOURCE_L...
325 177 70,145 0.00 1.08 3vy5h9xkfv1s5   INSERT INTO WF_ITEM_ATTRIBUTE_...
303 218 806,909 0.00 1.01 gnhmcahkmrnzs   INSERT INTO WF_ITEM_ACTIVITY_S...

Back to SQL Statistics
Back to Top

SQL ordered by CPU Time

  • Resources reported for PL/SQL code includes the resources used by all SQL statements called by the code.
  • % Total DB Time is the Elapsed Time of the SQL statement divided into the Total Database Time multiplied by 100
CPU Time (s)Elapsed Time (s)Executions CPU per Exec (s)% Total DB Time SQL IdSQL ModuleSQL Text
3,673 3,795 8 459.15 12.64 ghw9svn8x4vzu WSHPSRS BEGIN WSH_PICK_LIST.RELEASE_BA...
2,304 2,477 294 7.84 8.25 0z318y6g3uagc INCTCW declare l_retstat varchar2 ( 3...
1,705 1,816 10 170.54 6.05 bkxrrs52m7d8p WSHINTERFACE BEGIN WSH_SHIP_CONFIRM_ACTIONS...
1,559 1,610 69,421 0.02 5.36 60t2tt1564j0k   SELECT SUBSTRB(MACHINE, 1, 60)...
1,096 1,645 14 78.27 5.48 8c30hkqv9n7cr OEHVIMP BEGIN OE_BULK_ORDER_IMPORT_PVT...
925 974 8 115.62 3.24 7g05xfvc5vp74 ARTERRPW BEGIN arp_run.revenue_recognit...
724 811 1,285