MySQL SQL SQL Tuning:Profile位置決め単一QUERY性能ボトルネック


病気になったqueryが診察を受けに来たとき、医者である私たちが「胡庸医が虎狼薬を乱用した」としたら
何の役にも立たないだけでなく、多くの人件費と時間のコストを浪費し、サーバを台無しにすることもあります.
だから、私たちはSQLの最適化を受けています.最初のことはquery病がどこにあるかを理解することです.
IOですか?CPUですか?ボトルネックがどこにあるかを知ってこそ,病状に応じて薬を処方することができ,病気を治すことができる.
MySQL QUERY Profilerは、非常に便利なQUERY診断ツールであり、5.0に導入されています.5.1 GA版埋め込み
このツールは、Oracleオープン1046イベントと同様に、SQLのライフサイクル全体の各アクションを詳細に示しています.
SQLがデータ・アクセスに費やされているか、演算(ソートやパケットなど)に費やされているかを明確に理解できます.
order byがtuning sort bufferに行ってsorting result時間がこんなに少ないのを盲目的に見ることはありません
Profile構文:
SHOW PROFILE [type [, type] ... ]
    [FOR QUERY n]
    [LIMIT row_count [OFFSET offset]]

type:
    ALL
  | BLOCK IO
  | CONTEXT SWITCHES
  | CPU
  | IPC
  | MEMORY
  | PAGE FAULTS
  | SOURCE
  | SWAPS

注記:
デフォルトの出力結果はStatusとDurationのみを示し、typeを指定して出力を拡張できます.
私がよく使うのはCPUとBLOCK IOを追加してCPUとIOの負荷を出力することですが、実はこれらはもう十分です.
デフォルトのprofileは閉じられており、profilingパラメータによって制御され、sessionレベルです.
オン:SET profiling=1
オフ:set profiling=0
クエリー:select@@profiling
show profilesが保存するqueryエントリ数はパラメータprofiling_history_size制御、デフォルトは15で、超えたら前のを取り除くことができます
mysql> set profiling=1;

mysql> select @@profiling;
+-------------+
| @@profiling |
+-------------+
|           1 |
+-------------+

mysql> select * from employees.t order by first_name;

mysql> show profiles;
+----------+------------+-----------------------------------------------+
| Query_ID | Duration   | Query                                         |
+----------+------------+-----------------------------------------------+
|        1 | 0.21138800 | show create table employees.t                 |
|        2 | 8.21691600 | select * from employees.t order by first_name |
+----------+------------+-----------------------------------------------+
2 rows in set (0.00 sec)

mysql> show profile cpu,block io for query 2;
+----------------------+----------+----------+------------+--------------+---------------+
| Status               | Duration | CPU_user | CPU_system | Block_ops_in | Block_ops_out |
+----------------------+----------+----------+------------+--------------+---------------+
| starting             | 0.000160 | 0.000000 |   0.000000 |            0 |             0 |
| checking permissions | 0.000026 | 0.000000 |   0.000000 |            0 |             0 |
| Opening tables       | 0.000055 | 0.000000 |   0.000000 |            0 |             0 |
| System lock          | 0.000033 | 0.000000 |   0.000000 |            0 |             0 |
| init                 | 0.000050 | 0.000000 |   0.000000 |            0 |             0 |
| optimizing           | 0.000026 | 0.000000 |   0.000000 |            0 |             0 |
| statistics           | 0.000145 | 0.000000 |   0.000000 |            0 |             0 |
| preparing            | 0.000118 | 0.000000 |   0.000000 |            0 |             0 |
| executing            | 0.000011 | 0.000000 |   0.000000 |            0 |             0 |
| Sorting result       | 2.838465 | 1.396087 |   1.140071 |            0 |             0 |
| Sending data         | 0.928078 | 0.544034 |   0.056003 |            0 |             0 |
| end                  | 0.000026 | 0.000000 |   0.000000 |            0 |             0 |
| query end            | 0.000011 | 0.000000 |   0.000000 |            0 |             0 |
| closing tables       | 0.000021 | 0.000000 |   0.000000 |            0 |             0 |
| freeing items        | 4.449672 | 0.000000 |   0.000000 |            0 |             0 |
| logging slow query   | 0.000014 | 0.000000 |   0.000000 |            0 |             0 |
| cleaning up          | 0.000005 | 0.000000 |   0.000000 |            0 |             0 |
+----------------------+----------+----------+------------+--------------+---------------+
17 rows in set (0.00 sec)

同じ情報をinformationからschemaに出力され、時間をソートすることもできます.
Profileのデフォルトは実行順にソートされているため、実際にはどのくらいの時間がかかっているのか、どのようなオーバーヘッドが大きいかを簡単に知ることができます.
mysql> SELECT STATE, FORMAT(DURATION, 6) AS DURATION
    -> FROM INFORMATION_SCHEMA.PROFILING
    -> WHERE QUERY_ID = 2 ORDER BY DURATION DESC;
+----------------------+----------+
| STATE                | DURATION |
+----------------------+----------+
| freeing items        | 4.449672 |
| Sorting result       | 2.838465 |
| Sending data         | 0.928078 |
| starting             | 0.000160 |
| statistics           | 0.000145 |
| preparing            | 0.000118 |
| Opening tables       | 0.000055 |
| init                 | 0.000050 |
| System lock          | 0.000033 |
| end                  | 0.000026 |
| optimizing           | 0.000026 |
| checking permissions | 0.000026 |
| closing tables       | 0.000021 |
| logging slow query   | 0.000014 |
| query end            | 0.000011 |
| executing            | 0.000011 |
| cleaning up          | 0.000005 |
+----------------------+----------+
17 rows in set (0.00 sec)

参考記事:
http://dev.mysql.com/doc/refman/5.5/en/show-profile.html
By迦夜
2013-10-3
Good Luck
作者:linwaterbin发表于2013-10-3 2:01:48原文链接
読書:227コメント:3コメントの表示