OOW Tokyo 2012 Unconference つまらない STATSPACK をさらにややこしく盾hしてみよう
- 1. つまらない STATSPACK を さらにややこしく盾hしてみよう さらにややこしく盾hしてみよう Copyright ? 2012 Insight Technology, Inc. All Rights Reserved. 1
- 2. まず、、、、 STATSPACKレポ`トの r狼双を嚠襪靴討だ さい。 Copyright ? 2012 Insight Technology, Inc. All Rights Reserved. 2
- 3. ヒント SNAPSHOT１ \喘として協械議に STATSPACK のデ`タは函 誼している。 Copyright ? 2012 Insight Technology, Inc. All Rights Reserved. 3
- 4. ヒント SNAPSHOT2 ある晩のメンテナンス瘁に OLTP 狼のI尖でタイムアウ トがlkした。 {砲里燭瓩 STATSPACK レポ`トを函誼してみた。 Copyright ? 2012 Insight Technology, Inc. All Rights Reserved. 4
- 5. ヒント SNAPSHOT3 鮦瓠畺普疱r_Jの ために STATSPACK レポ` トを函誼してみた。 Copyright ? 2012 Insight Technology, Inc. All Rights Reserved. 5
- 6. 基えは3kで、、、、 １ A★B★C ２ B★C★A ３ C★B★A Copyright ? 2012 Insight Technology, Inc. All Rights Reserved. 6
- 7. 基えは3kで、、、、 １ A★B★C ２ B★C★A ３ C★B★A Copyright ? 2012 Insight Technology, Inc. All Rights Reserved. 7
- 8. 基えは3kで、、、、 C才┳\喘r B坤瓮鵐謄淵鵐香 A詐o識鮦 ３ C★B★A Copyright ? 2012 Insight Technology, Inc. All Rights Reserved. 8
- 9. h廠秤鵤┐燭世掘編^h廠ね HW CPU : 4core Mem 8GB OS RHEL 5 64bit DB Oracle Database 11.2.0.2 Enterprise Edition Copyright ? 2012 Insight Technology, Inc. All Rights Reserved. 9
- 10. 撹 B亊サ`バ WEB?APサ`バ デ`タベ`スサ`バ Copyright ? 2012 Insight Technology, Inc. All Rights Reserved. 10
- 11. OLTPI尖SQL┘リジナル彜B OLTPI尖SQLのy秤 SQL Statistics ~~~~~~~~~~~~~~ % Snap Statement Total Per Execute Total --------------- --------------- ------ Buffer Gets: 1,052,361 116,929.0 13.72 Disk Reads: 0 0.0 .00 Rows processed: 3,600 400.0 CPU Time(s/ms): 5 558.8 Elapsed Time(s/ms): 6 674.6 : Executions: 9 Copyright ? 2012 Insight Technology, Inc. All Rights Reserved. 11
- 12. OLTPI尖SQL┘瓮鵐謄淵鵐香瓧 OLTPI尖SQLのy秤 SQL Statistics ~~~~~~~~~~~~~~ % Snap Statement Total Per Execute Total --------------- --------------- ------ Buffer Gets: 1,870,864 116,929.0 2.08 Disk Reads: 0 0.0 .00 Rows processed: 6,400 400.0 CPU Time(s/ms): 8 479.2 Elapsed Time(s/ms): 26 1,655.3 : Executions: 16 Copyright ? 2012 Insight Technology, Inc. All Rights Reserved. 12
- 13. REPORT C嬾墾k伏念のレポ`ト Top 5 Timed Events Avg %Total ~~~~~~~~~~~~~~~~~~ wait Call Event Waits Time (s) (ms) Time ----------------------------------------- ------------ ----------- ------ ------ db file scattered read 1,846,915 735 0 55.9 CPU time 152 11.5 PL/SQL lock timer 1 120 ###### 9.1 db file parallel read 31 73 2358 5.6 db file sequential read 152,969 65 0 5.0 ----------------------------------------- ------------ ----------- ------ ------ .。oO(仝db file scatterd read々 がTOPだね) Copyright ? 2012 Insight Technology, Inc. All Rights Reserved. 13
- 14. REPORT B嬾墾k伏rのレポ`ト Top 5 Timed Events Avg %Total ~~~~~~~~~~~~~~~~~~ wait Call Event Waits Time (s) (ms) Time ----------------------------------------- ------------ ----------- ------ ------ CPU time 311 47.0 latch: cache buffers chains 2,635 207 78 31.2 PL/SQL lock timer 1 120 ###### 18.1 control file parallel write 42 6 152 1.0 db file async I/O submit 69 5 67 .7 ----------------------------------------- ------------ ----------- ------ ------ .。oO( I/O狼の棋Cイベントがなくなっている。嬾墾どころか むしろこちらのほうが措挫では) Copyright ? 2012 Insight Technology, Inc. All Rights Reserved. 14
- 15. バッチI尖SQL┘リジナル バッチI尖SQLのy秤 SQL Statistics ~~~~~~~~~~~~~~ % Snap Statement Total Per Execute Total --------------- --------------- ------ Buffer Gets: 7,546,904 104,818.1 98.40 Disk Reads: 6,803,691 94,495.7 114.53 Rows processed: 28,800 400.0 CPU Time(s/ms): 175 2,429.0 Elapsed Time(s/ms): 954 13,252.2 : Executions: 72 Copyright ? 2012 Insight Technology, Inc. All Rights Reserved. 15
- 16. バッチI尖SQL┘瓮鵐謄淵鵐香瓧 バッチI尖SQLのy秤 SQL Statistics ~~~~~~~~~~~~~~ % Snap Statement Total Per Execute Total --------------- --------------- ------ Buffer Gets: 88,412,056 116,947.2 98.09 Disk Reads: 0 0.0 .00 Rows processed: 302,400 400.0 CPU Time(s/ms): 302 399.0 Elapsed Time(s/ms): 728 962.7 : Executions: 756 Copyright ? 2012 Insight Technology, Inc. All Rights Reserved. 16
- 17. REPORT B嬾墾k伏rのレポ`ト犀戮咤 Top 5 Timed Events Avg %Total ~~~~~~~~~~~~~~~~~~ wait Call Event Waits Time (s) (ms) Time ----------------------------------------- ------------ ----------- ------ ------ CPU time 311 47.0 latch: cache buffers chains 2,635 207 78 31.2 PL/SQL lock timer 1 120 ###### 18.1 control file parallel write 42 6 152 1.0 db file async I/O submit 69 5 67 .7 ----------------------------------------- ------------ ----------- ------ ------ .。oO(もしかして、みんな￣CPU聞い￣になってないか) Copyright ? 2012 Insight Technology, Inc. All Rights Reserved. 17
- 18. CPUリソ`スの旋喘彜r CPUリソ`スの旋喘彜rを STATSPACKレポ`ト の秤鵑ら牢いなおしてみると、、、 <REPORT C> 8.6(AAS)x11.5%(CPU time)= 0.989core <REPORT B> 6.5(AAS)x47.0%(CPU time)= 3.055core .。oO(峠譲してこのぐらいはCPU聞ってるな`) Copyright ? 2012 Insight Technology, Inc. All Rights Reserved. 18
- 19. OLTPI尖SQLがタイムアウトした圻咀は STATSPACKレポ`トをながめてると、、、 1. CPUバウンドなOLTPI尖がス ロ`ダウンしている。 2. 棋Cイベントの恷貧了がCPU timeになっている。 3. Core方Q麻で1core蛍の腎きが ない。 Copyright ? 2012 Insight Technology, Inc. All Rights Reserved. 19
- 20. I圭隈 アイディア 椗 Copyright ? 2012 Insight Technology, Inc. All Rights Reserved. 20
- 21. I圭隈 バッチI尖のK双業雙崙 - バッチI尖SQLg悶のI尖rgは書指のチュ`ニン グで玉sしている。 - バッチI尖のK双業を和げても、ト`タルのI尖堀 業は鯢呂靴討い襦 - 書指はバッチI尖のK双業を雙えて、CPUリソ`ス を盾慧する圭で鬉垢襦 Copyright ? 2012 Insight Technology, Inc. All Rights Reserved. 21
- 22. CPUリソ`スの旋喘彜r鮦瓧 CPUリソ`スの旋喘彜rをもう匯業 STATSPACK レポ`トの秤鵑ら棟亢してみた、、、 <REPORT C> 8.6(AAS)x11.5%(CPU time)= 0.989core <REPORT B> 6.5(AAS)x47.0%(CPU time)= 3.055core <REPORT A> 4.2(AAS)x48.2%(CPU time)= 2.024core .。oO(おっ。CPUリ ソ`ス腎いた。) Copyright ? 2012 Insight Technology, Inc. All Rights Reserved. 22
- 23. OLTPI尖SQL鮦瓧 OLTPI尖SQLのy秤 SQL Statistics ~~~~~~~~~~~~~~ % Snap Statement Total Per Execute Total --------------- --------------- ------ Buffer Gets: 1,169,290 116,929.0 2.14 Disk Reads: 0 0.0 .00 Rows processed: 4,000 400.0 CPU Time(s/ms): 5 482.0 Elapsed Time(s/ms): 11 1,081.9 : 1,655.3 Executions: 10 Copyright ? 2012 Insight Technology, Inc. All Rights Reserved. 23
- 24. ちょっと篠り祇9iなあなたへ￣なんちゃってAAS￣ REPORT C Top 5 Timed Events Avg %Total ~~~~~~~~~~~~~~~~~~ wait Call Event Waits Time (s) (ms) Time ----------------------------------------- ------------ ----------- ------ ------ db file scattered read 1,846,915 735 0 55.9 CPU time 152 11.5 PL/SQL lock timer 1 120 ###### 9.1 db file parallel read 31 73 2358 5.6 db file sequential read 152,969 65 0 5.0 ---------- ------ ------ 栽 = 1145 87.1 100%Q麻栽 = 1315 100.0 Elapsed: 2.15min*60sec = 129sec 1315/129 = 10.19 (NAAS) Copyright ? 2012 Insight Technology, Inc. All Rights Reserved. 24
- 25. まとめ - STATSPACKはDB畠悶を県遨した 秤鵑誼られる。 - よって匯何のI尖の咾和颪 れがち。 - CPU timeが貧了にいる栽は、 AASをMみ栽わせてCPUリソ`ス の旋喘彜rを委燐すべし。 Copyright ? 2012 Insight Technology, Inc. All Rights Reserved. 25
- 26. まとめ - STATSPACKレポ`トでAASが燕幣 されなくても＾なんちゃって AAS￣が森議。 朿藤NAAS┘仏`ス Copyright ? 2012 Insight Technology, Inc. All Rights Reserved. 26
- 27. Any Question ? 幄塀氏芙インサイトテクノロジ` 表和 屎 Copyright ? 2012 Insight Technology, Inc. All Rights Reserved. 27
- 28. o僅dを鋤ず この猟はあくまでも歌深Y創であり、dされている秤鵑腕荼罎覆靴筝されることがあります。 幄塀氏芙インサイトテクノロジ`は云の坪否にvしていかなる隠^もしません。また、云の坪否にvBしたいかなる p墾についても販をいかねます。 云で聞喘しているu瞳やサ`ビス兆の兆各は、光芙の斌砲泙燭狼賠h斌砲任后 Copyright ? 2012 Insight Technology, Inc. All Rights Reserved. 28