MySQL死鎖與日志二三事

作者：xrzs 2017-07-28 15:40:01

最近線上 MySQL 接連發生了幾起數據異常，都是在凌晨爆發，由于業務場景屬于典型的數據倉庫型應用，白天壓力較小無法復現。甚至有些異常還比較詭異，最后 root cause 分析頗費周折。那實際業務當中咱們如何能快速的定位線上 MySQL 問題，修復異常呢?下文我會根據兩個實際 case，分享下相關的經驗與方法。

最近線上 MySQL 接連發生了幾起數據異常，都是在凌晨爆發，由于業務場景屬于典型的數據倉庫型應用，白天壓力較小無法復現。甚至有些異常還比較詭異，*** root cause 分析頗費周折。那實際業務當中咱們如何能快速的定位線上 MySQL 問題，修復異常呢?下文我會根據兩個實際 case，分享下相關的經驗與方法。

1、Case1：部分數據更新失敗

某天渠道同學反饋某報表極個別渠道數據為 0，大部分渠道數據正常。這個數據是由一個統計程序每天凌晨例行更新的，按理來說，要么全部正常，要么全部失敗，那會是什么原因導***個別數據異常呢?

首先我們能想到的自然是根據統計任務日志來看了，但是看了統計程序打印的日志沒有發現諸如 SQL update 失敗的異常描述，那當時的數據庫究竟發生了什么呢?在查看 MySQL-server 日志之前，習慣性的看了下數據庫狀態：

SHOW ENGINE INNODB STATUS\G

恰好看到了凌晨這個 update 發生了死鎖：

------------------------ 
LATEST DETECTED DEADLOCK 
------------------------ 
2017-07-17 04:09:01 0x7f6de03c8700 
*** (1) TRANSACTION: 
TRANSACTION 215208479, ACTIVE 0 sec fetching rows 
mysql tables in use 3, locked 3 
LOCK WAIT 5 lock struct(s), heap size 1136, 3 row lock(s) 
MySQL thread id 27844824, OS thread handle 140092183037696, query id 412503674 10.126.95.84 zeye Searching rows for update 
update t_channel_final_datas set nr_register=133,nr_add_goods=29,nr_order_normal=11,nr_pay_normal=8,nr_order_special=0,nr_pay_special=0,n_add_user_num=16 where count_date='2017-07-16' and channel_id='16' and channel_type='10' and terminal='26' 
*** (1) WAITING FOR THIS LOCK TO BE GRANTED: 
RECORD LOCKS space id 464 page no 5459 n bits 392 index index_countdate_type_terminal of table `db_zz_flow`.`t_channel_final_datas` trx id 215208479 lock_mode X locks rec but not gap waiting 
Record lock, heap no 304 PHYSICAL RECORD: n_fields 4; compact format; info bits 0 
 0: len 10; hex 323031372d30372d3136; asc 2017-07-16;; 
 1: len 1; hex 30; asc 0;; 
 2: len 4; hex 80000010; asc     ;; 
 3: len 4; hex 8009055e; asc    ^;; 
 
*** (2) TRANSACTION: 
TRANSACTION 215208474, ACTIVE 0 sec fetching rows 
mysql tables in use 3, locked 3 
6 lock struct(s), heap size 1136, 7 row lock(s) 
MySQL thread id 27844825, OS thread handle 140109890225920, query id 412503669 10.135.6.41 zeye Searching rows for update 
update t_channel_final_datas set nr_register=24,nr_add_goods=32,nr_order_normal=0,nr_pay_normal=0,nr_order_special=0,nr_pay_special=0,n_add_user_num=11 where count_date='2017-07-16' and channel_id='114' and channel_type='10' and terminal='116' 
*** (2) HOLDS THE LOCK(S): 
RECORD LOCKS space id 464 page no 5459 n bits 392 index index_countdate_type_terminal of table `db_zz_flow`.`t_channel_final_datas` trx id 215208474 lock_mode X locks rec but not gap 
Record lock, heap no 304 PHYSICAL RECORD: n_fields 4; compact format; info bits 0 
 0: len 10; hex 323031372d30372d3136; asc 2017-07-16;; 
 1: len 1; hex 30; asc 0;; 
 2: len 4; hex 80000010; asc     ;; 
 3: len 4; hex 8009055e; asc    ^;; 
 
... 
 
*** (2) WAITING FOR THIS LOCK TO BE GRANTED: 
RECORD LOCKS space id 464 page no 4743 n bits 264 index PRIMARY of table `db_zz_flow`.`t_channel_final_datas` trx id 215208474 lock_mode X locks rec but not gap waiting 
Record lock, heap no 168 PHYSICAL RECORD: n_fields 32; compact format; info bits 0 
 0: len 4; hex 80090569; asc    i;; 
 1: len 6; hex 00000cd3b9d0; asc       ;; 
... 
 
*** WE ROLL BACK TRANSACTION (1)

篇幅所限，上下文我這里省略了很多，從這段日志里可以看到，TRANSACTION 1 和 TRANSACTION 2 分別持有一定數量的行鎖，然后又等待對方的鎖，*** MySQL 檢測到 deadlock ，然后選擇回滾了 TRANSACTION 1：Innodb目前處理死鎖的方法是將持有最少行級排他鎖的事務進行回滾。

那這里就有 3 個問題了：

(1)innodb 行鎖不是只鎖一行?

因為這張表是 innodb 引擎的，InnoDB 支持行鎖和表鎖。而InnoDB行鎖是通過給索引上的索引項加鎖來實現的，這一點MySQL與Oracle不同，后者是通過在數據塊中對相應數據行加鎖來實現的。InnoDB這種行鎖實現特點意味著：只有通過索引條件檢索數據，InnoDB才使用行級鎖，否則，InnoDB將使用表鎖，會把所有掃描過的行都鎖定!在實際應用中，要特別注意InnoDB行鎖的這一特性，不然的話，可能導致大量的鎖沖突，從而影響并發性能。由于MySQL的行鎖是針對索引加的鎖，不是針對記錄加的鎖，所以雖然是訪問不同行的記錄，但是如果是使用相同的索引鍵，是會出現鎖沖突的。當我們用范圍條件而不是相等條件檢索數據，并請求共享或排他鎖時，InnoDB會給符合條件的已有數據記錄的索引項加鎖;另外間隙鎖也會鎖多行，InnoDB除了通過范圍條件加鎖時使用間隙鎖外，如果使用相等條件請求給一個不存在的記錄加鎖，InnoDB也會使用間隙鎖!

話都說到這了，那就看下咱們業務表的索引情況：

show INDEX from `db_zz_flow`.`t_channel_final_datas`; 
+-----------------------+--------------+-------------------------------+----------------+-------------+----------+--------+--------------+-----------+-----------------+ 
| Table                 |   Non_unique | Key_name                      |   Seq_in_index | Column_namt |   Packed | Null   | Index_type   | Comment   | Index_comment   | 
|-----------------------+--------------+-------------------------------+----------------+-------------+----------+--------+--------------+-----------+-----------------| 
| t_channel_final_datas |            0 | PRIMARY                       |              1 | id        > |   <null> |        | BTREE        |           |                 | 
| t_channel_final_datas |            1 | index_countdate_type_terminal |              1 | count_date> |   <null> | YES    | BTREE        |           |                 | 
| t_channel_final_datas |            1 | index_countdate_type_terminal |              2 | channel_ty> |   <null> | YES    | BTREE        |           |                 | 
| t_channel_final_datas |            1 | index_countdate_type_terminal |              3 | terminal  > |   <null> | YES    | BTREE        |           |                 | 
| t_channel_final_datas |            1 | index_countdate_channelid     |              1 | count_date> |   <null> | YES    | BTREE        |           |                 | 
| t_channel_final_datas |            1 | index_countdate_channelid     |              2 | channel_id> |   <null> | YES    | BTREE        |           |                 | 
+-----------------------+--------------+-------------------------------+----------------+-------------+----------+--------+--------------+-----------+-----------------+

可以看到這張表的索引極不合理：有3個索引，但是 update 卻沒有完全的用上索引，導致 update 沒有精確的用上索引，需要鎖定多行范圍數據，從而引發死鎖。

知道原理后，咱們再精心構建一個四字段的組合索引即可讓 update 精準的走 innodb 索引，實際上，我們更新索引后，這個死鎖問題即得到了解決。

注：innodb不僅會打印出事務和事務持有和等待的鎖，而且還有記錄本身，不幸的是，它可能超過innodb為輸出結果預留的長度(只能打印1M的內容且只能保留最近一次的死鎖信息)，如果你無法看到完整的輸出，此時可以在任意庫下創建innodb_monitor或innodb_lock_monitor表，這樣innodb status信息會完整且每15s一次被記錄到錯誤日志中。如：create table innodb_monitor(a int)engine=innodb;，不需要記錄到錯誤日志中時就刪掉這個表即可。

(2)回滾的話，為什么只有部分 update 語句失敗，而不是整個事務里的所有 update 都失敗?

這是因為咱們的 innodb 默認是自動提交的：

show variables like 'autocommit'; 
+-----------------+---------+ 
| Variable_name   | Value   | 
|-----------------+---------| 
| autocommit      | ON      | 
+-----------------+---------+

在多個 update 或 insert 語句情況下，每執行完一條 SQL，innodb 就立即 commit 一次以持久化變更，同時釋放鎖，這也正是本例中死鎖回滾事務后只有極個別語句失敗的原因。

需要注意的是，通常還有另外一種情況也可能導致部分語句回滾，需要格外留意。在 innodb 里有個參數叫：innodb_rollback_on_timeout

show VARIABLES LIKE 'innodb_rollback_on_timeout' 
+----------------------------+---------+ 
| Variable_name              | Value   | 
|----------------------------+---------| 
| innodb_rollback_on_timeout | OFF     | 
+----------------------------+---------+

官方手冊里這樣描述：

In MySQL 5.1, InnoDB rolls back only the last statement on a transaction timeout by default. If –innodb_rollback_on_timeout is specified, a transaction timeout causes InnoDB to abort and roll back the entire transaction (the same behavior as in MySQL 4.1). This variable was added in MySQL 5.1.15.

解釋：這個參數關閉或不存在的話遇到超時只回滾事務***一個Query，打開的話事務遇到超時就回滾整個事務。

(3)怎樣降低 innodb 死鎖幾率?

死鎖在行鎖及事務場景下很難完全消除，但可以通過表設計和SQL調整等措施減少鎖沖突和死鎖，包括：

盡量使用較低的隔離級別，比如如果發生了間隙鎖，你可以把會話或者事務的事務隔離級別更改為 RC(read committed)級別來避免，但此時需要把 binlog_format 設置成 row 或者 mixed 格式
精心設計索引，并盡量使用索引訪問數據，使加鎖更精確，從而減少鎖沖突的機會;
選擇合理的事務大小，小事務發生鎖沖突的幾率也更小;
給記錄集顯示加鎖時，***一次性請求足夠級別的鎖。比如要修改數據的話，***直接申請排他鎖，而不是先申請共享鎖，修改時再請求排他鎖，這樣容易產生死鎖;
不同的程序訪問一組表時，應盡量約定以相同的順序訪問各表，對一個表而言，盡可能以固定的順序存取表中的行。這樣可以大大減少死鎖的機會;
盡量用相等條件訪問數據，這樣可以避免間隙鎖對并發插入的影響;
不要申請超過實際需要的鎖級別;除非必須，查詢時不要顯示加鎖;
對于一些特定的事務，可以使用表鎖來提高處理速度或減少死鎖的可能。

2、Case2：詭異的 Lock wait timeout

連續幾天凌晨6點和早上8點都分別有一個任務失敗，load data local infile 的時候報 Lock wait timeout exceeded try restarting transaction innodb 的 Java SQL 異常，和平臺的同學溝通得知，這是我們自己的業務數據庫的 Lock 時間太短或者鎖沖突的問題。但是回頭一想不應該啊?這不一直好好的嗎?而且基本都是單表單任務，不存在多人沖突。

甭管誰的問題，那咱們還是先看自己的數據庫有沒有問題：

show variables like 'innodb_lock_wait_timeout'; 
+--------------------------+---------+ 
| Variable_name            |   Value | 
|--------------------------+---------| 
| innodb_lock_wait_timeout |      50 | 
+--------------------------+---------+

默認 lock 超時時間 50s，這個時間真心不短了，估計調了也沒用，事實上確實死馬當活馬醫的試了下沒用。。。

而且這次 SHOW ENGINE INNODB STATUS\G 也沒出現任何死鎖信息，然后又將目光轉向 MySQL-server 日志，希望能從日志里看一看那個時刻前后數據究竟在做什么操作。這里先簡單的介紹下MySQL日志文件系統的組成：

(a) error 日志：記錄啟動、運行或停止 mysqld 時出現的問題，默認開啟。

(b) general 日志：通用查詢日志，記錄所有語句和指令，開啟數據庫會有 5% 左右性能損失。

(d) slow 日志：記錄所有執行時間超過 long_query_time 秒的查詢或不使用索引的查詢，默認關閉。

(e) Innodb日志：innodb redo log、undo log，用于恢復數據和撤銷操作。

從上面的介紹可以看到，目前這個問題的日志可能在 d 和 b 中，看了下 d 中沒有，那就只能開啟 b 了，但 b 對數據庫的性能有一定損耗，由于是全量日志，量非常巨大，所以開啟一定要謹慎：

-- general_log 日志默認關閉，開啟會影響數據庫 5% 左右性能： 
show variables like 'general%'; 
+------------------+---------------------------------+ 
| Variable_name    | Value                           | 
|------------------+---------------------------------| 
| general_log      | OFF                             | 
| general_log_file | /opt/data/mysql/tjtx-103-26.log | 
+------------------+---------------------------------+ 
 
-- 全局 session 級別開啟： 
set global general_log=1 
 
-- 如果需要對當前 session 生效需要： 
set general_log=1 
 
-- set 指令設置的動態參數在 MySQL 重啟后失效，如果需要***生效需要在 /etc/my.cnf 中配置靜態變量/參數。 
-- 如果不知道 my.cnf 位置，可以根據 mysql -? | grep ".cnf" 查詢 
                      order of preference, my.cnf, $MYSQL_TCP_PORT, 
/etc/my.cnf /etc/mysql/my.cnf /usr/etc/my.cnf ~/.my.cnf

我這里只是每天在出問題的前后半小時開啟下全量日志，結果沒有發現任何 MySQL-client 請求到我們的業務數據庫!該日志格式如下，記錄了所有的連接與命令：

/usr/sbin/mysqld, Version: 5.7.12-log (MySQL Community Server (GPL)). started with: 
Tcp port: 3306  Unix socket: /opt/data/mysql/mysql.sock 
Time                 Id Command    Argument 
2017-07-20T21:45:01.880828Z28556028 Quit 
2017-07-20T21:45:02.708621Z28401469 Query       SELECT 1 
2017-07-20T21:45:02.736734Z28556029 Connect     ooxx@127.0.0.1 on db_zz_system using TCP/IP 
2017-07-20T21:45:02.737242Z28556029 Query       /* mysql-connector-java-5.1.6 ( Revision: ${svn.Revision} ) */SHOW VARIABLES WHERE Variable_name ='language' OR Variable_name = 'net_write_timeout' OR Variable_name = 'interactive_timeout' OR Variable_name = 'wait_timeout' OR Variable_name = 'character_set_client' OR Variable_name = 'character_set_connection' OR Variable_name = 'character_set' OR Variable_name = 'character_set_server' OR Variable_name = 'tx_isolation' OR Variable_name = 'transaction_isolation' OR Variable_name = 'character_set_results' OR Variable_name = 'timezone' OR Variable_name = 'time_zone' OR Variable_name = 'system_time_zone' OR Variable_name = 'lower_case_table_names' OR Variable_name = 'max_allowed_packet' OR Variable_name = 'net_buffer_length' OR Variable_name = 'sql_mode' OR Variable_name = 'query_cache_type' OR Variable_name = 'query_cache_size' OR Variable_name = 'init_connect' 
2017-07-20T21:45:02.738868Z28556029 Query       SHOW COLLATION 
2017-07-20T21:45:02.739941Z28556029 Query       SET character_set_results = NULL 
2017-07-20T21:45:02.740275Z28556029 Query       SET autocommit=1

那問題基本確定了，客戶端請求都沒到我們這邊就拋出了上述的異常，和平臺方再三溝通確認下，***平臺方查證是因為在執行插入前他們需要先從 SQL task 表取出 SQL 和更新 task 狀態，結果這張表由于在整點存在大量 insert 和 update 并發，導致部分 SQL 等待 lock 超時了。。。

[[198411]]

3、MySQL 日志分析腳本

由于凌晨是數據倉庫的業務高峰，很多問題都是在這個時候爆發，一些詭異的問題往往是過了這個村就沒這個店了，白天無法復現。如何能捕獲我們關心的日志，便于快速的定位問題，這個是重中之重，這里我寫了個小腳本，crontab 部署，可以選擇時間范圍開啟，每分鐘采樣一次日志，需要說明的是 general log 沒事別輕易開啟，否則對數據庫性能損耗較大。

# crontab 部署方式： 
# */1 0-10 * * * cd /opt/ooxx/script && bash mysql_perf.sh >> logs/mysql_perf.log.`date -I` 2>&1 
 
date -Iseconds 
 
echo '>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> top -bn1|head' 
top -bn1|head   
echo 
 
echo '>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> SHOW ENGINE INNODB STATUS\G ' 
mysql -uroot -pooxx -h127.0.0.1 -e 'SHOW ENGINE INNODB STATUS\G' 
echo 
 
echo '>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> show open tables where in_use>0;' 
mysql -uroot -pooxx -h127.0.0.1 -e 'show open tables where in_use>0;' 
echo 
 
echo '>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> show full processlist;' 
mysql -uroot -pooxx -h127.0.0.1 -e 'show full processlist;' 
echo 
 
echo '>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> SELECT * FROM `information_schema`.`innodb_trx` ORDER BY `trx_started`; ' 
mysql -uroot -pooxx -h127.0.0.1 -e 'SELECT * FROM `information_schema`.`innodb_trx` ORDER BY `trx_started`;'  
echo 
 
echo '>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> SELECT * FROM `information_schema`.`innodb_locks`;' 
mysql -uroot -pooxx -h127.0.0.1 -e 'SELECT * FROM `information_schema`.`innodb_locks`;' 
echo 
 
echo ">>>>>>>>>>>>>>>>>>>>>>>>>>>>>> show status like '%lock%';" 
mysql -uroot -pooxx -h127.0.0.1 -e "show status like '%lock%';" 
echo 
 
echo '>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> show global status like "table_locks%";' 
mysql -uroot -pooxx -h127.0.0.1 -e 'show global status like "table_locks%";' 
echo 
 
echo ">>>>>>>>>>>>>>>>>>>>>>>>>>>>>> too long omit..." 
mysql -uroot -pooxx -h127.0.0.1 -e "select r.trx_isolation_level, r.trx_id waiting_trx_id, r.trx_mysql_thread_id  waiting_trx_thread, r.trx_state  waiting_trx_state, lr.lock_mode waiting_trx_lock_mode, lr.lock_type  waiting_trx_lock_type, lr.lock_table  waiting_trx_lock_table, lr.lock_index  waiting_trx_lock_index, r.trx_query  waiting_trx_query, b.trx_id  blocking_trx_id, b.trx_mysql_thread_id  blocking_trx_thread, b.trx_state  blocking_trx_state, lb.lock_mode blocking_trx_lock_mode, lb.lock_type  blocking_trx_lock_type, lb.lock_table  blocking_trx_lock_table, lb.lock_index  blocking_trx_lock_index, b.trx_query  blocking_query from  information_schema.innodb_lock_waits  w  inner  join  information_schema.innodb_trx b  on  b.trx_id=w.blocking_trx_id  inner  join  information_schema.innodb_trx  r on  r.trx_id=w.requesting_trx_id  inner  join   information_schema.innodb_locks  lb on  lb.lock_trx_id=w.blocking_trx_id inner  join   information_schema.innodb_locks  lr on  lr.lock_trx_id=w.requesting_trx_id\G" 
echo 
 
echo ">>>>>>>>>>>>>>>>>>>>>>>>>>>>>> too long omit..." 
mysql -uroot -pooxx -h127.0.0.1 -e "SELECT r.trx_id waiting_trx_id,  r.trx_mysql_thread_id waiting_thread, r.trx_query waiting_query, b.trx_id blocking_trx_id,  b.trx_mysql_thread_id blocking_thread, b.trx_query blocking_query FROM information_schema.innodb_lock_waits w INNER JOIN information_schema.innodb_trx b ON  b.trx_id = w.blocking_trx_id INNER JOIN information_schema.innodb_trx r ON  r.trx_id = w.requesting_trx_id\G" 
echo 
 
 
date -Iseconds 
echo '>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>==================================================================================' 
echo 
 
file_name=mysql_perf.log.`date -I` 
if [[ `date +%-H%-M` == 1059 ]] 
then 
    cd /opt/ooxx/script/logs 
    chmod 777 /home/work/ooxx/$file_name 
    find /home/work/ooxx -name 'mysql_perf.log.*' -mtime +7 -delete 
     
    cd /opt/data/mysql 
    cp tjtx-ooxx-slow.log /home/work/ooxx/tjtx-ooxx-slow.log.`date -I` 
    chmod 777 /home/work/ooxx/tjtx-ooxx-slow.log.`date -I` 
    find /home/work/ooxx -name 'tjtx-ooxx-slow.log.*' -mtime +7 -delete 
     
    cp mysqld.log /home/work/ooxx/mysqld.log.`date -I` 
    chmod 777 /home/work/ooxx/mysqld.log.`date -I` 
    find /home/work/ooxx -name 'mysqld.log.*' -mtime +7 -delete 
fi 
 
 
################ 
# 開啟 general_log 全量明細日志會降低數據庫 5% 性能 
#if [[ "`date +%H%M`" == "0545" ]] 
#then 
#   echo "`date +%H%M` ------- set global general_log=1;" 
#   mysql -uroot -pooxx -h127.0.0.1 -e 'set global general_log=1;' 
#elif [[ "`date +%H%M`" == "0630" ]] 
#then 
#   echo "`date +%H%M` ------- set global general_log=0;" 
#   mysql -uroot -pooxx -h127.0.0.1 -e 'set global general_log=0;' 
#elif [[ "`date +%H%M`" == "0745" ]] 
#then 
#   echo "`date +%H%M` ------- set global general_log=1;" 
#   mysql -uroot -pooxx -h127.0.0.1 -e 'set global general_log=1;' 
#elif [[ "`date +%H%M`" == "0830" ]] 
#then 
#   echo "`date +%H%M` ------- set global general_log=0;" 
#   mysql -uroot -pooxx -h127.0.0.1 -e 'set global general_log=0;' 
#elif [[ "`date +%H%M`" == "0001" ]] 
#then 
#   echo "`date +%H%M` ------- set global general_log=1;" 
#   mysql -uroot -pooxx -h127.0.0.1 -e 'set global general_log=1;' 
#elif [[ "`date +%H%M`" == "0002" ]] 
#then 
#   echo "`date +%H%M` ------- set global general_log=0;" 
#   mysql -uroot -pooxx -h127.0.0.1 -e 'set global general_log=0;' 
#fi 
 
 
 
 
 
#[[ 10#`date +%H%M` -lt 10#0550 ||  10#`date +%H%M` -gt 10#0830 ]] && echo "`date +%H%M` ------- set global general_log=0;" && mysql -uroot -pooxx -h127.0.0.1 -e 'set global general_log=0;' 
 
 
# mysql -uroot -pooxx -h127.0.0.1 -e 'show open tables where in_use>0;show full processlist;SELECT * FROM `information_schema`.`innodb_trx` ORDER BY `trx_started`;SELECT * FROM `information_schema`.`innodb_locks`;SHOW ENGINE INNODB STATUS\G' 
 
# --show variables like '%tx_isolation%'; 
# --SELECT @@GLOBAL.tx_isolation, @@tx_isolation, @@session.tx_isolation; 
# --  SET GLOBAL tx_isolation = 'READ-COMMITTED'; 
#  
# --show variables like '%timeout%'; 
# --show variables like 'innodb_lock_wait_timeout'; 
# --  SET GLOBAL innodb_lock_wait_timeout=60 
#  
# --show variables like 'long_query_time'; 
# --  SET global long_query_time=3; 
 
 
# --  show variables like 'innodb_rollback_on_timeout'; 
 
# --  show VARIABLES like '%max_allowed_packet%'; 
# --  set global max_allowed_packet = 100*1024*1024; 
 
# 自動提交 
# -- show variables like 'autocommit'; 
 
# 慢查詢 
# -- show variables  like '%slow_query_log%'; 
# set global 只對當前數據庫生效，如果MySQL重啟后則會失效。如果要***生效，就必須修改配置文件my.cnf（其它系統變量也是如此）。 
# set global slow_query_log=1; 
# -- show variables like 'long_query_time%'; 
# set global long_query_time=4; 
# show global variables like 'long_query_time';  
# select sleep(5); 
# -- show variables like 'log_queries_not_using_indexes'; 
# set global log_queries_not_using_indexes=1; 
# -- show variables like 'log_slow_admin_statements'; 
# -- show global status like '%Slow_queries%'; 
# http://www.cnblogs.com/kerrycode/p/5593204.html 
 
 
 
# -- show variables like "%time_zone%"; 
#set global time_zone = '+8:00'; 
 
#開啟general_log日志 
# -- show variables like 'general%'; 
#可以在my.cnf里添加,1開啟（0關閉）,當然了,這樣要重啟才能生效,有點多余了 
#general-log = 1 
#log = /log/mysql_query.log路徑 
#也可以設置變量那樣更改,1開啟（0關閉）,即時生效,不用重啟,***當然是這樣的了 
#  set global general_log=1 
#這個日志對于操作頻繁的庫,產生的數據量會很快增長,出于對硬盤的保護,可以設置其他存放路徑 
#set global general_log_file=/tmp/general_log.log 
 
#mysql記錄客戶端IP：init_connect，有super權限的用戶是不記錄的， 
# create  table t1 ( cur_user varchar(100), n_user varchar(100),in_time timestamp  default current_timestamp()) ; 
# set global init_connect='insert into test.t1 (cur_user,n_user) values (current_user(),user())';    
# SHOW CREATE TABLE mysql.general_log\G ，開啟general_log日志也行： 
# https://dba.stackexchange.com/questions/33654/mysql-logging-activity-from-specific-user-or-ip               
#SELECT REVERSE(SUBSTRING_INDEX(REVERSE(USER()),'@',1)) as ip; 
#SELECT SUBSTRING(USER(), LOCATE('@', USER())+1) as ip; 
#select SUBSTRING_INDEX(host,':',1) as 'ip' from information_schema.processlist WHERE ID=connection_id();