INFORMATION_SCHEMA.PROFILING
發(fā)表時間：2023-09-02 來源：明輝站整理相關(guān)軟件相關(guān)文章人氣：
[摘要]INFORMATION_SCHEMA PROFILING TablePROFILING表提供了語句分析信息。 其內(nèi)容對應(yīng)于SHOW PROFILES和SHOW PROFILE語句生成的信息.INFORMATION_SCHEMA NameSHOW NameNotesQUERY_IDQuery_ID標...
INFORMATION_SCHEMA PROFILING Table
PROFILING表提供了語句分析信息。 其內(nèi)容對應(yīng)于SHOW PROFILES和SHOW PROFILE語句生成的信息.
| QUERY_ID | Query_ID | 標識 |
| SEQ |
| 具有相同QUERY_ID值的行的顯示順序的序列號 |
| STATE | Status | 行測量適用的分析狀態(tài) |
| DURATION | Duration | 在給定狀態(tài)下，多長時間的語句執(zhí)行保持在幾秒鐘內(nèi) |
| CPU_USER | CPU_user | 用戶CPU使用，以秒為單位 |
| CPU_SYSTEM | CPU_system | 系統(tǒng)CPU使用，以秒為單位 |
| CONTEXT_VOLUNTARY | Context_voluntary | 自愿上下文切換發(fā)生 |
| CONTEXT_INVOLUNTARY | Context_involuntary | 非自愿上下文切換發(fā)生 |
| BLOCK_OPS_IN | Block_ops_in | 輸入塊操作的數(shù)量 |
| BLOCK_OPS_OUT | Block_ops_out | 輸出塊操作的數(shù)量 |
| MESSAGES_SENT | Messages_sent | 發(fā)送的通信消息的數(shù)量 |
| MESSAGES_RECEIVED | Messages_received | 接收的通信消息的數(shù)量 |
| PAGE_FAULTS_MAJOR | Page_faults_major | 主頁面錯誤的數(shù)量 |
| PAGE_FAULTS_MINOR | Page_faults_minor | 次頁面錯誤的數(shù)量 |
| SWAPS | Swaps | 發(fā)生了多少次交換 |
| SOURCE_FUNCTION | Source_function | 源代碼執(zhí)行分析狀態(tài)的位置的信息 |
| SOURCE_FILE | Source_file | 源代碼執(zhí)行分析狀態(tài)的位置的信息 |
| SOURCE_LINE | Source_line | 源代碼執(zhí)行分析狀態(tài)的位置的信息 |
13.7.5.31 SHOW PROFILES Syntax
SHOW PROFILES
SHOW PROFILES語句與SHOW PROFILE一起顯示分析信息，指示在當前會話過程中執(zhí)行的語句的資源使用情況。
13.7.5.30 SHOW PROFILE Syntax
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可以指定可選類型值以顯示特定的其他類型的信息（對應(yīng)PROFILING中字段）：
| ALL | 顯示所有信息 |
| BLOCK IO | 顯示塊輸入和輸出操作的計數(shù) |
| CONTEXT SWITCHES | 顯示自愿和非自愿上下文切換的計數(shù) |
| CPU | 顯示用戶和系統(tǒng)CPU使用時間 |
| IPC | 顯示發(fā)送和接收消息的計數(shù) |
| MEMORY | 目前尚未實施 |
| PAGE FAULTS | 顯示主頁和次頁錯誤的計數(shù) |
| SOURCE | 顯示來自源代碼的函數(shù)的名稱以及該函數(shù)發(fā)生的文件的名稱和行號 |
| SWAPS | 顯示交換計數(shù) |
SHOW PROFILE和SHOW PROFILES語句顯示分析信息，指示在當前會話過程中執(zhí)行的語句的資源使用情況。
Profiling由Profiling會話變量控制，默認值為0（OFF）。 通過將Profiling設(shè)置為1或ON可啟用分析：
mysql> SET profiling = 1;
SHOW PROFILES顯示發(fā)送到服務(wù)器的最新語句的列表。 列表的大小由profiling_history_size會話變量控制，該變量的默認值為15.最大值為100.將值設(shè)置為0具有禁用性能分析的實際效果。
除SHOW PROFILE和SHOW PROFILES之外，所有語句都進行了概要分析，因此您將不會在配置文件列表中找到這些語句。 對于格式錯誤的執(zhí)行語句，例如SHOW PROFILING是一個非法語句，如果您嘗試執(zhí)行該語句，則會出現(xiàn)語法錯誤，但會顯示在概要分析列表中。
SHOW PROFILE顯示有關(guān)單個語句的詳細信息，如果沒有追加FOR QUERY n子句，輸出與最近執(zhí)行的語句相關(guān)；否則展示特定語句的信息。 n的值對應(yīng)于SHOW PROFILES顯示的Query_ID值。
可以給出LIMIT row_count子句以將輸出限制為row_count行。如果給定了LIMIT，則可以添加OFFSET偏移以將輸出偏移行開始到整組行。
默認情況下，SHOW PROFILE顯示狀態(tài)和持續(xù)時間列。
每個會話啟用分析。會話結(jié)束時，其分析信息丟失。
說了那么多，上面這些已經(jīng)被廢棄啦�。。�！
Note:
這些語句已被逐漸棄用，將在未來的MySQL版本中被刪除。
也就是說新版本包括以后的版本對于性能的監(jiān)控逐漸使用PERFORMANCE_SCHEM代替INFORMATION_SCHEMA -->詳見Chapter 25 MySQL Performance Schema
Action
已知：
mysql root@127.0.0.1:nt> SELECT * FROM student
+------+--------+-------+-------+ id name age sex
------+--------+-------+------- 1 s1 12 m
2 s2 12 w
3 s3 11 w
+------+--------+-------+-------+3 rows in setTime: 0.004s
mysql root@127.0.0.1:nt> SELECT * FROM teacher
+------+--------+ id name
------+-------- 1 Han
2 Gou
3 Eric
+------+--------+3 rows in setTime: 0.002s
mysql root@127.0.0.1:nt> SELECT * FROM course
+------+--------------+----------------+ id teacher_id name
------+--------------+---------------- 1 1 Advanced Maths
2 2 English
3 3 Arts
4 1 Physics
5 3 Programming
+------+--------------+----------------+5 rows in setTime: 0.003s
mysql root@127.0.0.1:nt> SELECT * FROM score
+--------------+-------------+---------+ student_id course_id score
--------------+-------------+--------- 1 1 78
1 2 56
1 3 89
1 4 60
1 5 92
2 1 92
2 2 60
2 3 78
2 4 77
2 5 95
3 1 66
3 2 50
3 3 78
3 4 67
3 5 86
+--------------+-------------+---------+15 rows in setTime: 0.003s解：高數(shù)比美術(shù)分數(shù)高的學生信息
SELECT S.*
FROM (SELECT SC1.STUDENT_ID,SC1.COURSE_ID,SC1.SCORE FROM score SC1) A,
(SELECT SC2.STUDENT_ID,SC2.COURSE_ID,SC2.SCORE FROM score SC2) B,
student S
WHERE A.STUDENT_ID=B.STUDENT_ID
AND A.COURSE_ID=1
AND B.COURSE_ID=3
AND A.SCORE>B.SCORE
AND A.STUDENT_ID=S.ID;mysql root@127.0.0.1:nt> SELECT @@profiling
+---------------+
@@profiling
---------------
0
+---------------+
1 row in set
Time: 0.002s
mysql root@127.0.0.1:nt> SET profiling = 1
Query OK, 0 rows affected
Time: 0.001s
mysql root@127.0.0.1:nt> SELECT S.*
-> FROM (SELECT SC1.STUDENT_ID,SC1.COURSE_ID,SC1.SCORE FROM score SC1) A,
-> (SELECT SC2.STUDENT_ID,SC2.COURSE_ID,SC2.SCORE FROM score SC2) B,
-> student S
-> WHERE A.STUDENT_ID=B.STUDENT_ID
-> AND A.COURSE_ID=1
-> AND B.COURSE_ID=3
-> AND A.SCORE>B.SCORE
-> AND A.STUDENT_ID=S.ID;
+------+--------+-------+-------+
id name age sex
------+--------+-------+-------
2 s2 12 w
+------+--------+-------+-------+
1 row in set
Time: 0.007s
mysql root@127.0.0.1:nt> SHOW PROFILES
+------------+------------+---------------+
Query_ID Duration Query
------------+------------+---------------
1 4.5e-05 SHOW WARNINGS
2 0.000603 SELECT S.*
FROM (SELECT SC1.STUDENT_ID,SC1.COURSE_ID,SC1.SCORE FROM score SC1) A,
(SELECT SC2.STUDENT_ID,SC2.COURSE_ID,SC2.SCORE FROM score SC2) B,
student S
WHERE A.STUDENT_ID=B.STUDENT_ID
AND A.COURSE_ID=1
AND B.COURSE_ID=3
AND A.SCORE>B.SCORE
AND A.STUDENT_ID=S.ID
+------------+------------+---------------+
2 rows in set
Time: 0.002s
mysql root@127.0.0.1:nt> SHOW PROFILE FOR QUERY 2
+----------------------+------------+
Status Duration
----------------------+------------
starting 0.000134
checking permissions 1.1e-05
checking permissions 4e-06
checking permissions 7e-06
Opening tables 2.4e-05
init 5.2e-05
System lock 1.1e-05
optimizing 1.5e-05
statistics 0.000161
preparing 2.7e-05
executing 4e-06
Sending data 6.4e-05
end 6e-06
query end 7e-06
closing tables 8e-06
freeing items 5.4e-05
cleaning up 1.4e-05
+----------------------+------------+
17 rows in set
Time: 0.005s上面的結(jié)果太丑
mysql root@127.0.0.1:nt> set @query_id=2
Query OK, 0 rows affected
Time: 0.001s
使用下面的SQL：
SELECT STATE, SUM(DURATION) AS TOTAL_R,
ROUND(100 * SUM(DURATION)/(SELECT SUM(DURATION)
FROM information_schema.PROFILING
WHERE QUERY_ID=@query_id),
2
) AS PCT_R,
COUNT(*) CALLS,
SUM(DURATION)/COUNT(*) AS "R/CALL"
FROM information_schema.PROFILING
WHERE QUERY_ID=@query_id
GROUP BY STATE
ORDER BY TOTAL_R DESC;mycli執(zhí)行上面的sql：
+----------------------+-----------+---------+---------+------------+
STATE TOTAL_R PCT_R CALLS R/CALL
----------------------+-----------+---------+---------+------------
statistics 0.000161 26.7 1 0.000161
starting 0.000134 22.22 1 0.000134
Sending data 6.4e-05 10.61 1 6.4e-05
freeing items 5.4e-05 8.96 1 5.4e-05
init 5.2e-05 8.62 1 5.2e-05
preparing 2.7e-05 4.48 1 2.7e-05
Opening tables 2.4e-05 3.98 1 2.4e-05
checking permissions 2.2e-05 3.65 3 7.3333e-06
optimizing 1.5e-05 2.49 1 1.5e-05
cleaning up 1.4e-05 2.32 1 1.4e-05
System lock 1.1e-05 1.82 1 1.1e-05
closing tables 8e-06 1.33 1 8e-06
query end 7e-06 1.16 1 7e-06
end 6e-06 1 1 6e-06
executing 4e-06 0.66 1 4e-06
+----------------------+-----------+---------+---------+------------+
15 rows in set
Time: 0.018s
可以看出來，時間消耗占比最高依次：
statistics：服務(wù)器正在計算統(tǒng)計信息以開發(fā)查詢執(zhí)行計劃。如果一個線程長時間處于這種狀態(tài)，服務(wù)器可能是磁盤綁定的，執(zhí)行其他工作
starting
Sending data：線程正在讀取和處理SELECT語句的行，并向客戶端發(fā)送數(shù)據(jù)。由于在此狀態(tài)期間發(fā)生的操作往往執(zhí)行大量的磁盤訪問（讀�。�，所以在給定查詢的整個生命周期內(nèi)通常是最長的運行狀態(tài)
freeing items：線程已經(jīng)執(zhí)行了一個命令。在這種狀態(tài)下完成的項目的一些釋放涉及查詢緩存。這種狀態(tài)通常是清理
init：這發(fā)生在ALTER TABLE，DELETE，INSERT，SELECT或UPDATE語句的初始化之前。處于此狀態(tài)的服務(wù)器采取的操作包括刷新二進制日志，InnoDB日志和一些查詢緩存清理操作。
對于最終狀態(tài)，可能會發(fā)生以下操作：
下面看看記錄2對應(yīng)的CPU信息
mysql root@127.0.0.1:nt> SHOW PROFILE CPU FOR QUERY 2
+----------------------+------------+------------+--------------+
Status Duration CPU_user CPU_system
----------------------+------------+------------+--------------
starting 0.000134 0.000126 8e-06
checking permissions 1.1e-05 4e-06 6e-06
checking permissions 4e-06 2e-06 3e-06
checking permissions 7e-06 4e-06 2e-06
Opening tables 2.4e-05 2.3e-05 2e-06
init 5.2e-05 4.8e-05 3e-06
System lock 1.1e-05 8e-06 2e-06
optimizing 1.5e-05 1.4e-05 2e-06
statistics 0.000161 0.000113 5.3e-05
preparing 2.7e-05 1.9e-05 3e-06
executing 4e-06 2e-06 3e-06
Sending data 6.4e-05 6.3e-05 1e-06
end 6e-06 3e-06 3e-06
query end 7e-06 5e-06 1e-06
closing tables 8e-06 7e-06 1e-06
freeing items 5.4e-05 1.3e-05 4.2e-05
cleaning up 1.4e-05 1.2e-05 2e-06
+----------------------+------------+------------+--------------+
17 rows in set
Time: 0.009s
Qs:為什么show profiles結(jié)果中的duration和直接執(zhí)行的時間差距那么大？
以上就是INFORMATION_SCHEMA.PROFILING的詳細內(nèi)容，更多請關(guān)注php中文網(wǎng)其它相關(guān)文章！
學習教程快速掌握從入門到精通的SQL知識。
