[oracle@db2 log]$ cat 20120814.lst ASH Report - From 14-Aug-12 11:40:00 To 14-Aug-12 12:10:00

ASH Report For G1DB/G1db2

DB Name DB Id Instance Inst num Release RAC Host

G1DB 2583992970 G1db2 2 10.2.0.4.0 YES db2

DB Name	DB Id	Instance	Inst num	Release	RAC	Host
G1DB	2583992970	G1db2	2	10.2.0.4.0	YES	db2

CPUs SGA Size Buffer Cache Shared Pool ASH Buffer Size

24 6,144M (100%) 2,432M (39.6%) 3,455M (56.2%) 40.5M (0.7%)

CPUs	SGA Size	Buffer Cache	Shared Pool	ASH Buffer Size
24	6,144M (100%)	2,432M (39.6%)	3,455M (56.2%)	40.5M (0.7%)

Sample Time Data Source

Analysis Begin Time: 14-Aug-12 11:40:00 DBA_HIST_ACTIVE_SESS_HISTORY
in AWR snapshot 6501

Analysis End Time: 14-Aug-12 12:10:00 DBA_HIST_ACTIVE_SESS_HISTORY
in AWR snapshot 6502

Elapsed Time: 30.0 (mins)

Sample Count: 5,568

Average Active Sessions: 30.93

Avg. Active Session per CPU: 1.29

Report Target: None specified

	Sample Time	Data Source
Analysis Begin Time:	14-Aug-12 11:40:00	DBA_HIST_ACTIVE_SESS_HISTORY in AWR snapshot 6501
Analysis End Time:	14-Aug-12 12:10:00	DBA_HIST_ACTIVE_SESS_HISTORY in AWR snapshot 6502
Elapsed Time:	30.0 (mins)
Sample Count:	5,568
Average Active Sessions:	30.93
Avg. Active Session per CPU:	1.29
Report Target:	None specified

Top Events

Top User Events
Top Background Events
Top Event P1/P2/P3 Values

Top User Events

Event	Event Class	% Activity	Avg Active Sessions
enq: TX - row lock contention	Application	74.35	23.00
gc buffer busy	Cluster	11.12	3.44
row cache lock	Concurrency	5.85	1.81
log file sync	Commit	2.73	0.84
gc current block busy	Cluster	1.62	0.50

Top Background Events

Event	Event Class	% Activity	Avg Active Sessions
gcs log flush sync	Other	1.33	0.41
enq: CF - contention	Other	1.31	0.41

Top Event P1/P2/P3 Values

Event	% Event	P1 Value, P2 Value, P3 Value	% Activity	Parameter 1	Parameter 2	Parameter 3
enq: TX - row lock contention	74.35	"1415053318","196626","23962"	74.35	name\|mode	usn<<16 \| slot	sequence
gc buffer busy	11.12	"24","313263","65537"	4.69	file#	block#	id#
		"6","1140579","65537"	2.57
		"6","25911","65537"	1.90
row cache lock	5.85	"3","0","3"	5.85	cache id	mode	request
log file sync	2.73	"5350","0","0"	2.73	buffer#	NOT DEFINED	NOT DEFINED
gcs log flush sync	1.33	"24","0","109"	1.33	waittime	poll	event

Load Profile

Top Service/Module
Top Client IDs
Top SQL Command Types

Top Service/Module

Service	Module	% Activity	Action	% Action
G1db	UNNAMED	96.23	UNNAMED	96.23
SYS$BACKGROUND	UNNAMED	2.73	UNNAMED	2.73

Back to Load Profile
Back to Top

Top Client IDs

No data exists for this section of the report.

Back to Load Profile
Back to Top

Top SQL Command Types

'Distinct SQLIDs' is the count of the distinct number of SQLIDs with the given SQL Command Type found over all the ASH samples in the analysis period

SQL Command Type	Distinct SQLIDs	% Activity	Avg Active Sessions
UPDATE	19	83.10	25.71
INSERT	7	9.66	2.99
SELECT	10	1.47	0.46

Back to Load Profile
Back to Top

Top SQL

Top SQL Statements
Top SQL using literals
Complete List of SQL Text

Top SQL Statements

SQL ID	Planhash	% Activity	Event	% Event	SQL Text
gzt34x6x7p8r0	3683798013	54.96	enq: TX - row lock contention	54.96	UPDATE TMSTPOS SET TM_SMP=:1, ...
gtpuh24u3cr3d	3683798013	19.40	enq: TX - row lock contention	19.40	UPDATE TMSTPOS Set ...
72zqywap3utzv		3.57	row cache lock	1.80	INSERT INTO HPSTSJNL (AC_DT, T...
		3.57	gc buffer busy	1.78	INSERT INTO HPSTSJNL (AC_DT, T...
8cryq35k225g0	563338888	3.56	gc buffer busy	3.56	UPDATE HPSTJNL SET TM_S...
0hpnx35mqhhpg		2.48	row cache lock	1.19	INSERT INTO HPSTSJNL (AC_DT, T...

Top SQL using literals

Plan Hash	% Activity	# of Sampled SQL Versions	Example SQL 1	Example SQL TEXT 1	Example SQL 2	Example SQL TEXT 2
803511549	4.02	224	0018m8my0sbxk	UPDATE PUBSEQREC SET TM_SMP='2...	gzz5nkd8zkqb1	UPDATE PUBSEQREC SET TM_SMP='2...

Complete List of SQL Text

SQL Id SQL Text

0018m8my0sbxk UPDATE PUBSEQREC SET TM_SMP='20120814120303', SEL_VAL = SEL_VAL WHERE BR_NO='1021' AND SEQ_NM='CUP' AND SEQ_CND='CUP'

0hpnx35mqhhpg INSERT INTO HPSTSJNL (AC_DT, TM_SMP, LOG_NO, TXN_TM, APP_VER, CSEQ_NO, TRM_OPERAT, TRM_SN, APP_NUM) VALUES (:1, :2, :3, :4, :5, :6, :7, :8, :9)

72zqywap3utzv INSERT INTO HPSTSJNL (AC_DT, TM_SMP, LOG_NO, TXN_TM, APP_VER, CSEQ_NO, TRM_SN, APP_NUM) VALUES (:1, :2, :3, :4, :5, :6, :7, :8)

8cryq35k225g0 UPDATE HPSTJNL SET TM_SMP=:1, CPS_CD=:2 WHERE LOG_NO=:3

gtpuh24u3cr3d UPDATE TMSTPOS Set TM_SMP=:1, SATTLE_SMP=:2, BAT_NO=:3 WHERE MERC_ID=:4 AND TRM_NO=:5

gzt34x6x7p8r0 UPDATE TMSTPOS SET TM_SMP=:1, PIN_KEY=:2, MAC_KEY=:3, BAT_NO=:4, SIG_DT=:5, DATA_KEY=:6, SGN_STS='1', DATA_KEY_TS=:7 WHERE MERC_ID=:8 AND TRM_NO=:9

gzz5nkd8zkqb1 UPDATE PUBSEQREC SET TM_SMP='20120814093046', SEL_VAL = SEL_VAL WHERE BR_NO='1021' AND SEQ_NM='BOC' AND SEQ_CND='BOC'

SQL Id	SQL Text
0018m8my0sbxk	UPDATE PUBSEQREC SET TM_SMP='20120814120303', SEL_VAL = SEL_VAL WHERE BR_NO='1021' AND SEQ_NM='CUP' AND SEQ_CND='CUP'
0hpnx35mqhhpg	INSERT INTO HPSTSJNL (AC_DT, TM_SMP, LOG_NO, TXN_TM, APP_VER, CSEQ_NO, TRM_OPERAT, TRM_SN, APP_NUM) VALUES (:1, :2, :3, :4, :5, :6, :7, :8, :9)
72zqywap3utzv	INSERT INTO HPSTSJNL (AC_DT, TM_SMP, LOG_NO, TXN_TM, APP_VER, CSEQ_NO, TRM_SN, APP_NUM) VALUES (:1, :2, :3, :4, :5, :6, :7, :8)
8cryq35k225g0	UPDATE HPSTJNL SET TM_SMP=:1, CPS_CD=:2 WHERE LOG_NO=:3
gtpuh24u3cr3d	UPDATE TMSTPOS Set TM_SMP=:1, SATTLE_SMP=:2, BAT_NO=:3 WHERE MERC_ID=:4 AND TRM_NO=:5
gzt34x6x7p8r0	UPDATE TMSTPOS SET TM_SMP=:1, PIN_KEY=:2, MAC_KEY=:3, BAT_NO=:4, SIG_DT=:5, DATA_KEY=:6, SGN_STS='1', DATA_KEY_TS=:7 WHERE MERC_ID=:8 AND TRM_NO=:9
gzz5nkd8zkqb1	UPDATE PUBSEQREC SET TM_SMP='20120814093046', SEL_VAL = SEL_VAL WHERE BR_NO='1021' AND SEQ_NM='BOC' AND SEQ_CND='BOC'

Top PL/SQL Procedures

No data exists for this section of the report.

Top Sessions

Top Sessions
Top Blocking Sessions
Top Sessions running PQs

Top Sessions

'# Samples Active' shows the number of ASH samples in which the session was found waiting for that particular event. The percentage shown in this column is calculated with respect to wall clock time and not total database activity.
'XIDs' shows the number of distinct transaction IDs sampled in ASH when the session was waiting for that particular event
For sessions running Parallel Queries, this section will NOT aggregate the PQ slave activity into the session issuing the PQ. Refer to the 'Top Sessions running PQs' section for such statistics.

Sid, Serial#	% Activity	Event	% Event	User	# Samples Active
902, 4436	3.23	enq: TX - row lock contention	3.23	POSP	180/180 [100%]
904,16855	3.23	enq: TX - row lock contention	3.23	POSP	180/180 [100%]
905,32356	3.23	enq: TX - row lock contention	3.23	POSP	180/180 [100%]
906,60921	3.23	enq: TX - row lock contention	3.23	POSP	180/180 [100%]
910,57264	3.23	enq: TX - row lock contention	3.23	POSP	180/180 [100%]

Top Blocking Sessions

Blocking session activity percentages are calculated with respect to waits on enqueues, latches and "buffer busy" only
'% Activity' represents the load on the database caused by a particular blocking session
'# Samples Active' shows the number of ASH samples in which the blocking session was found active.
'XIDs' shows the number of distinct transaction IDs sampled in ASH when the blocking session was found active.

Blocking Sid	% Activity	Event Caused	% Event	User	Program	# Samples Active	XIDs
1090, 1	4.83	log file sync	2.73	SYS	oracle@db2 (LGWR)	31/180 [ 17%]	0
		gcs log flush sync	1.33

Top Sessions running PQs

No data exists for this section of the report.

Top Objects/Files/Latches

Top DB Objects
Top DB Files
Top Latches

Top DB Objects

With respect to Application, Cluster, User I/O and buffer busy waits only.

Object ID	% Activity	Event	% Event	Object Name (Type)	Tablespace
12801	74.64	enq: TX - row lock contention	74.35	POSP.TMSTPOS (TABLE)	TBS_POSP
53813	5.12	gc buffer busy	4.69	POSP.HPSTJNL_PK_INT (INDEX)	TBS_POSP_IDX_2
13436	4.02	gc buffer busy	3.30	POSP.PUBSEQREC (TABLE)	TBS_POSP
47390	3.07	gc buffer busy	2.57	POSP.PK_HPSTSJNLN (INDEX)	TBS_POSP

Top DB Files

With respect to Cluster and User I/O events only.

File ID	% Activity	Event	% Event	File Name	Tablespace
6	7.72	gc buffer busy	5.87	+ORADATA/g1db/datafile/tbs_posp.277.736909545	TBS_POSP
		gc current block busy	1.19
24	6.03	gc buffer busy	5.24	+ORADATA/g1db/datafile/tbs_posp_idx_2.dbf	TBS_POSP_IDX_2

Top Latches

No data exists for this section of the report.

Activity Over Time

Analysis period is divided into smaller time slots
Top 3 events are reported in each of those slots
'Slot Count' shows the number of ASH samples in that slot
'Event Count' shows the number of ASH samples waiting for that event in that slot
'% Event' is 'Event Count' over all ASH samples in the analysis period

Slot Time (Duration)	Slot Count	Event	Event Count	% Event
11:40:00 (5.0 min)	698	enq: TX - row lock contention	690	12.39
		gc current block 2-way	4	0.07
		gc cr multi block request	3	0.05
11:45:00 (5.0 min)	694	enq: TX - row lock contention	690	12.39
		CPU + Wait for CPU	2	0.04
		gc cr multi block request	1	0.02
11:50:00 (5.0 min)	693	enq: TX - row lock contention	690	12.39
		CPU + Wait for CPU	1	0.02
		gc cr multi block request	1	0.02
11:55:00 (5.0 min)	980	enq: TX - row lock contention	690	12.39
		gc buffer busy	127	2.28
		log file sync	56	1.01
12:00:00 (5.0 min)	1,808	enq: TX - row lock contention	690	12.39
		gc buffer busy	492	8.84
		row cache lock	311	5.59
12:05:00 (5.0 min)	695	enq: TX - row lock contention	690	12.39
		CPU + Wait for CPU	3	0.05
		db file sequential read	1	0.02

End of Report