環境說明
root@ubuntu:/home/tb# cat /etc/issue Ubuntu 16.04.2 LTS \n \l root@ubuntu:/home/tb# php -v PHP 7.0.15-0ubuntu0.16.04.4 (cli) ( NTS ) Copyright (c) 1997-2017 The PHP Group Zend Engine v3.0.0, Copyright (c) 1998-2017 Zend Technologies with Zend OPcache v7.0.15-0ubuntu0.16.04.4, Copyright (c) 1999-2017, by Zend Technologies
查看php-fpm配置路徑
root@ubuntu:/home/tb# ps -ef |grep fpm root 1642 1 0 10:17 ? 00:00:01 php-fpm: master process (/etc/php/7.0/fpm/php-fpm.conf) www-data 3685 1642 0 17:14 ? 00:00:04 php-fpm: pool www www-data 3686 1642 0 17:14 ? 00:00:03 php-fpm: pool www www-data 3808 1642 0 17:43 ? 00:00:03 php-fpm: pool www root 3930 2208 0 18:10 pts/0 00:00:00 grep --color=auto fpm root@ubuntu:/home/tb#
php-fpm.conf
的最後一行為
include=/etc/php/7.0/fpm/pool.d/*.conf
那我們去那裡改www.conf
,查看關於慢查詢的介紹
314 ; The log file for slow requests 315 ; Default Value: not set 316 ; Note: slowlog is mandatory if request_slowlog_timeout is set 317 ;slowlog = log/$pool.log.slow 318 319 ; The timeout for serving a single request after which a PHP backtrace will be 320 ; dumped to the 'slowlog' file. A value of '0s' means 'off'. 321 ; Available units: s(econds)(default), m(inutes), h(ours), or d(ays) 322 ; Default Value: 0 323 ;request_slowlog_timeout = 0
添加兩行配置
slowlog=/var/log/php7.0/fpm/slow.log request_slowlog_timeout=1s
重啟fpm,同時注意目錄權限等一般問題
service php7.0-fpm reload
查看log回顯結果
[03-Jan-2018 18:48:53] [pool www] pid 4934 script_filename = /usr/share/nginx/ testapp/index.php [0x00007fb626213520] session_start() /usr/share/nginx/ testapp/app/models/user_model.php:11 [0x00007fb6262134a0] __construct() /usr/share/nginx/ci_2.2.0/core/Loader.php:303 [0x00007fb626213390] model() /usr/share/nginx/ testapp/app/core/my_Controller.php:39 [0x00007fb6262132e0] __construct() /usr/share/nginx/ testapp/app/controllers/home.php:8 [0x00007fb626213270] __construct() /usr/share/nginx/ci_2.2.0/core/CodeIgniter.php:308 [0x00007fb6262130e0] [INCLUDE_OR_EVAL]() /usr/share/nginx/ testapp/index.php:325 [03-Jan-2018 18:48:53] [pool www] pid 4931 script_filename = /usr/share/nginx/ testapp/index.php [0x00007fb626213520] session_start() /usr/share/nginx/ testapp/app/models/user_model.php:11 [0x00007fb6262134a0] __construct() /usr/share/nginx/ci_2.2.0/core/Loader.php:303 [0x00007fb626213390] model() /usr/share/nginx/ testapp/app/core/my_Controller.php:39 [0x00007fb6262132e0] __construct() /usr/share/nginx/ testapp/app/controllers/home.php:8 [0x00007fb626213270] __construct() /usr/share/nginx/ci_2.2.0/core/CodeIgniter.php:308 [0x00007fb6262130e0] [INCLUDE_OR_EVAL]() /usr/share/nginx/ testapp/index.php:325
關於log的說明
[03-Jan-2018 18:48:53] [pool www] pid 4931
這個沒啥解釋,時間進程id
script_filename = /usr/share/nginx/ testapp/index.php
執行腳本名稱,php web應用程式都為單入口
[0x00007fb626213520] session_start() /usr/share/nginx/ testapp/app/models/user_model.php:11
這個第三行比較重要:是堆疊頂部資訊(is the top of the stack trace),他說明指出了超出了閾值的當前執行的方法的函數呼叫是哪個,以及具體的檔案及程式碼行數
剩下的其他部分就是呼叫的順序(從下往上,最終導致變慢超時的結果)
其他說明
#如果發現第三行是以類似curl_exec()
,例如:這一般是網路io佔用了時間,如果是必須請求第三方,那麼。 。忍吧。
[0x00007fb6262136f0] curl_exec() /usr/share/nginx/
同樣,如果有mysql_query
之類的,也是由於sql
慢查詢導致的
參考連結
#php-fpm設定:https://www.php.net/manual/zh/install.fpm.configuration.php
how-to-read-the-php-slow-request-log: https://serverpilot.io/docs/how-to-read-the-php-slow-request-log/