mysql slow time_mysql使用slow log
1.運行環境:xampp1.7.3,mysql版本為5.1.41
2.開啟slow log:
(1)打開d:/xampp/mysql/bin/my.ini,設置
slow_query_log????? = 1
slow_query_log_file = "d:/xampp/mysql/data/mysql-slow.log"
long_query_time=0//新加
(2)D:\xampp\mysql\data\下新建txt文件mysql-slow.log
(3)重啟或啟動xampp中apache mysql
注:(2)必須后跟(3),看后面的log記錄開頭幾行就會明白
3.測試:運行腳本(注:僅測試log使用,無die等處理錯誤)
$h=mysql_connect("localhost",'root','');
mysql_select_db("test",$h);
mysql_query("flush status");
$res=mysql_query("select t1.id from t1 inner join t2 on t1.id=t2.id");
while($r=mysql_fetch_assoc($res)){
var_dump($r);
}
mysql_close($h);
?>
以下是運行該腳本的log記錄
D:\xampp\mysql\bin\mysqld.exe, Version: 5.1.41-log (Source distribution). started with:
TCP Port: 3306, Named Pipe: MySQL
Time???????????????? Id Command??? Argument
# Time: 111124 15:32:10
# User@Host: root[root] @ localhost [127.0.0.1]
# Query_time: 0.040057? Lock_time: 0.000000 Rows_sent: 4? Rows_examined: 4
use test;
SET timestamp=1322119930;
select t1.id from t1 inner join t2 on t1.id=t2.id;
# Time: 111124 15:33:23
# User@Host: root[root] @ localhost [127.0.0.1]
# Query_time: 0.040058? Lock_time: 0.000000 Rows_sent: 4? Rows_examined: 4
SET timestamp=1322120003;
select t1.id from t1 inner join t2 on t1.id=t2.id;
# Time: 111124 15:33:49
# User@Host: root[root] @ localhost [127.0.0.1]
# Query_time: 0.040058? Lock_time: 0.000000 Rows_sent: 4? Rows_examined: 4
SET timestamp=1322120029;
select t1.id from t1 inner join t2 on t1.id=t2.id;
# Time: 111124 15:34:07
# User@Host: root[root] @ localhost [127.0.0.1]
# Query_time: 0.030044? Lock_time: 0.000000 Rows_sent: 4? Rows_examined: 4
SET timestamp=1322120047;
select t1.id from t1 inner join t2 on t1.id=t2.id;
# Time: 111124 15:34:29
# User@Host: root[root] @ localhost [127.0.0.1]
# Query_time: 0.030043? Lock_time: 0.000000 Rows_sent: 4? Rows_examined: 4
SET timestamp=1322120069;
select t1.id from t1 inner join t2 on t1.id=t2.id;
# Time: 111124 15:34:56
# User@Host: root[root] @ localhost [127.0.0.1]
# Query_time: 0.030044? Lock_time: 0.000000 Rows_sent: 4? Rows_examined: 4
SET timestamp=1322120096;
select t1.id from t1 inner join t2 on t1.id=t2.id;
# Time: 111124 15:34:58
# User@Host: root[root] @ localhost [127.0.0.1]
# Query_time: 0.020029? Lock_time: 0.000000 Rows_sent: 4? Rows_examined: 4
SET timestamp=1322120098;
select t1.id from t1 inner join t2 on t1.id=t2.id;
# User@Host: root[root] @ localhost [127.0.0.1]
# Query_time: 0.040058? Lock_time: 0.000000 Rows_sent: 4? Rows_examined: 4
SET timestamp=1322120098;
select t1.id from t1 inner join t2 on t1.id=t2.id;
4.在my.ini中改long_query_time=0.04,也就是40毫秒,重啟xampp,以下是運行腳本的log結果:
D:\xampp\mysql\bin\mysqld.exe, Version: 5.1.41-log (Source distribution). started with:
TCP Port: 3306, Named Pipe: MySQL
Time???????????????? Id Command??? Argument
# Time: 111124 15:41:40
# User@Host: root[root] @ localhost [127.0.0.1]
# Query_time: 0.040057? Lock_time: 0.000000 Rows_sent: 4? Rows_examined: 4
use test;
SET timestamp=1322120500;
select t1.id from t1 inner join t2 on t1.id=t2.id;
# Time: 111124 15:41:54
# User@Host: root[root] @ localhost [127.0.0.1]
# Query_time: 0.040058? Lock_time: 0.000000 Rows_sent: 4? Rows_examined: 4
SET timestamp=1322120514;
select t1.id from t1 inner join t2 on t1.id=t2.id;
# Time: 111124 15:41:56
# User@Host: root[root] @ localhost [127.0.0.1]
# Query_time: 0.040058? Lock_time: 0.000000 Rows_sent: 4? Rows_examined: 4
SET timestamp=1322120516;
select t1.id from t1 inner join t2 on t1.id=t2.id;
# Time: 111124 15:41:59
# User@Host: root[root] @ localhost [127.0.0.1]
# Query_time: 0.040057? Lock_time: 0.000000 Rows_sent: 4? Rows_examined: 4
SET timestamp=1322120519;
select t1.id from t1 inner join t2 on t1.id=t2.id;
# User@Host: root[root] @ localhost [127.0.0.1]
# Query_time: 0.040057? Lock_time: 0.000000 Rows_sent: 4? Rows_examined: 4
SET timestamp=1322120519;
select t1.id from t1 inner join t2 on t1.id=t2.id;
# User@Host: root[root] @ localhost [127.0.0.1]
# Query_time: 0.040058? Lock_time: 0.000000 Rows_sent: 4? Rows_examined: 4
SET timestamp=1322120519;
select t1.id from t1 inner join t2 on t1.id=t2.id;
# Time: 111124 15:45:41
# User@Host: root[root] @ localhost [127.0.0.1]
# Query_time: 0.070101? Lock_time: 0.000000 Rows_sent: 4? Rows_examined: 4
SET timestamp=1322120741;
select t1.id from t1 inner join t2 on t1.id=t2.id;
# User@Host: root[root] @ localhost [127.0.0.1]
# Query_time: 0.040057? Lock_time: 0.000000 Rows_sent: 4? Rows_examined: 4
SET timestamp=1322120741;
select t1.id from t1 inner join t2 on t1.id=t2.id;
# Time: 111124 15:45:42
# User@Host: root[root] @ localhost [127.0.0.1]
# Query_time: 0.040058? Lock_time: 0.000000 Rows_sent: 4? Rows_examined: 4
SET timestamp=1322120742;
select t1.id from t1 inner join t2 on t1.id=t2.id;
# User@Host: root[root] @ localhost [127.0.0.1]
# Query_time: 0.040058? Lock_time: 0.000000 Rows_sent: 4? Rows_examined: 4
SET timestamp=1322120742;
select t1.id from t1 inner join t2 on t1.id=t2.id;
# Time: 111124 15:45:43
# User@Host: root[root] @ localhost [127.0.0.1]
# Query_time: 0.040058? Lock_time: 0.000000 Rows_sent: 4? Rows_examined: 4
SET timestamp=1322120743;
select t1.id from t1 inner join t2 on t1.id=t2.id;
5. 在my.ini中改long_query_time=0,重啟xampp運行腳本
$h=mysql_connect("localhost",'root','');
mysql_select_db("test",$h);
$res=mysql_query("select t1.id from t1 inner join t2 on t1.id=t2.id");
while($r=mysql_fetch_assoc($res)){
var_dump($r);
}
mysql_close($h);
?>
以下是log結果:
D:\xampp\mysql\bin\mysqld.exe, Version: 5.1.41-log (Source distribution). started with:
TCP Port: 3306, Named Pipe: MySQL
Time???????????????? Id Command??? Argument
# Time: 111124 16:00:05
# User@Host: root[root] @ localhost [127.0.0.1]
# Query_time: 0.030043? Lock_time: 0.000000 Rows_sent: 4? Rows_examined: 4
use test;
SET timestamp=1322121605;
select t1.id from t1 inner join t2 on t1.id=t2.id;
# Time: 111124 16:00:27
# User@Host: root[root] @ localhost [127.0.0.1]
# Query_time: 0.040057? Lock_time: 0.000000 Rows_sent: 4? Rows_examined: 4
SET timestamp=1322121627;
select t1.id from t1 inner join t2 on t1.id=t2.id;
# Time: 111124 16:00:28
# User@Host: root[root] @ localhost [127.0.0.1]
# Query_time: 0.040057? Lock_time: 0.000000 Rows_sent: 4? Rows_examined: 4
SET timestamp=1322121628;
select t1.id from t1 inner join t2 on t1.id=t2.id;
# Time: 111124 16:00:45
# User@Host: root[root] @ localhost [127.0.0.1]
# Query_time: 0.010015? Lock_time: 0.000000 Rows_sent: 4? Rows_examined: 4
SET timestamp=1322121645;
select t1.id from t1 inner join t2 on t1.id=t2.id;
# Time: 111124 16:00:46
# User@Host: root[root] @ localhost [127.0.0.1]
# Query_time: 0.010014? Lock_time: 0.000000 Rows_sent: 4? Rows_examined: 4
SET timestamp=1322121646;
select t1.id from t1 inner join t2 on t1.id=t2.id;
# User@Host: root[root] @ localhost [127.0.0.1]
# Query_time: 0.040058? Lock_time: 0.000000 Rows_sent: 4? Rows_examined: 4
SET timestamp=1322121646;
select t1.id from t1 inner join t2 on t1.id=t2.id;
# Time: 111124 16:00:47
# User@Host: root[root] @ localhost [127.0.0.1]
# Query_time: 0.020029? Lock_time: 0.000000 Rows_sent: 4? Rows_examined: 4
SET timestamp=1322121647;
select t1.id from t1 inner join t2 on t1.id=t2.id;
# Time: 111124 16:00:48
# User@Host: root[root] @ localhost [127.0.0.1]
# Query_time: 0.040058? Lock_time: 0.000000 Rows_sent: 4? Rows_examined: 4
SET timestamp=1322121648;
select t1.id from t1 inner join t2 on t1.id=t2.id;
# User@Host: root[root] @ localhost [127.0.0.1]
# Query_time: 0.040058? Lock_time: 0.000000 Rows_sent: 4? Rows_examined: 4
SET timestamp=1322121648;
select t1.id from t1 inner join t2 on t1.id=t2.id;
# User@Host: root[root] @ localhost [127.0.0.1]
# Query_time: 0.020029? Lock_time: 0.000000 Rows_sent: 4? Rows_examined: 4
SET timestamp=1322121648;
select t1.id from t1 inner join t2 on t1.id=t2.id;
# Time: 111124 16:00:49
# User@Host: root[root] @ localhost [127.0.0.1]
# Query_time: 0.010014? Lock_time: 0.000000 Rows_sent: 4? Rows_examined: 4
SET timestamp=1322121649;
select t1.id from t1 inner join t2 on t1.id=t2.id;
# Time: 111124 16:00:50
# User@Host: root[root] @ localhost [127.0.0.1]
# Query_time: 0.020029? Lock_time: 0.000000 Rows_sent: 4? Rows_examined: 4
SET timestamp=1322121650;
select t1.id from t1 inner join t2 on t1.id=t2.id;
該份腳本比3和4運行的腳本少了mysql_query("flush status");,看log記錄可以看到該份腳本運行有不少0.01和0.02秒的記錄,這也能看出mysql自身的緩存也加快了select的速度!
總結
以上是生活随笔為你收集整理的mysql slow time_mysql使用slow log的全部內容,希望文章能夠幫你解決所遇到的問題。
- 上一篇: mysql checking permi
- 下一篇: mysql安装尝试创建新用户失败_Lin