在MySQL中使用init-connect与binlog来实现用户操作追踪记录

前言:
測试环境莫名其妙有几条关键数据被删除了,因为在binlog里面仅仅看到是公用账号删除的,无法查询是那个谁在那个时间段登录的,就考虑怎么记录每一个MYSQL账号的登录信息。在MYSQL中。每一个连接都会先运行init-connect,进行连接的初始化。我们能够在这里获取用户的登录名称和thread的ID值。然后配合binlog。就能够追踪到每一个操作语句的操作时间,操作人等。

实现审计。


1,在mysql服务器db中建立单独的记录訪问信息的库
set names utf8;
create databaseaccess_log;
CREATE TABLE`access_log` 
(
  `id`int(11) NOT NULL AUTO_INCREMENT,
 `thread_id` int(11) DEFAULT NULL, -- 线程ID,这个值非常重要
  `log_time`timestamp NOT NULL DEF AULT CURRENT_TIMESTAMP ON UPDATE CURRENT_TIMESTAMP, -- 登录时间
 `localname` varchar(30) DEFAULT NULL, -- 登录名称
 `matchname` varchar(30) DEFAULT NULL, -- 登录用户
  PRIMARYKEY (`id`)
) ENGINE=InnoDBAUTO_INCREMENT=1 DEFAULT CHARSET=utf8 comment '录入用户登录信息';



2,在配置文件里配置init-connect參数。登录时插入日志表。

假设这个參数是个错误的SQL语句,登录就会失败。


vim/usr/local/mysql/my.cnf
init-connect='INSERTINTO access_log.access_logVALUES(NULL,CONNECTION_ID(),NOW(),USER(),CURRENT_USER());'
然后重新启动数据库

3。创建普通用户。不能有super权限,并且用户必须有对access_log库的access_log表的insert权限,否则会登录失败。
给登录用户赋予insert权限,可是不赋予access_log的insert、select权限,
GRANTINSERT,DELETE,UPDATE,SELECT ON test.* TO audit_user@'%' IDENTIFIED BY'cacti_user1603';
mysql> GRANTCREATE,DROP,ALTER,INSERT,DELETE,UPDATE,SELECT ON test.* TO audit_user@'%'IDENTIFIED BY 'cacti_user1603';
Query OK, 0 rowsaffected (0.00 sec)
mysql> exit
然后去用新的audit_user登录操作
[root@db_server~]# /usr/local/mysql/bin/mysql  -uaudit_user -p -S/usr/local/mysql/mysql.sock
Enter password: 
Welcome to theMySQL monitor.  Commands end with ; or g.
Your MySQL connectionid is 25
Server version:5.6.12-log

Copyright (c)2000, 2013, Oracle and/or its affiliates. All rights reserved.

Oracle is aregistered trademark of Oracle Corporation and/or its
affiliates. Othernames may be trademarks of their respective
owners.

Type 'help;' or'h' for help. Type 'c' to clear the current input statement.

mysql> lect *from access_log.access_log;
ERROR 2006(HY000): MySQL server has gone away
No connection.Trying to reconnect...
Connection id:   26
Current database:*** NONE ***


ERROR 1184(08S01): Aborted connection 26 to db: 'unconnected' user: 'audit_user' host:'localhost' (init_connect command failed)
mysql> 
看到报错信息 (init_connect command failed),再去错误日志error log验证一下:
tail -fn 5/usr/local/mysql/mysqld.log 
2014-07-28 16:03:3123743 [Warning] Aborted connection 25 to db: 'unconnected' user: 'audit_user'host: 'localhost' (init_connect command failed)
2014-07-2816:03:31 23743 [Warning] INSERT command denied to user ''@'localhost' for table'access_log'
2014-07-2816:04:04 23743 [Warning] Aborted connection 26 to db: 'unconnected' user:'audit_user' host: 'localhost' (init_connect command failed)
2014-07-2816:04:04 23743 [Warning] INSERT command denied to user ''@'localhost' for table'access_log'
看到必需要有对access_log库的access_log表的insert权限才行。


4,赋予用户access_log的insert、select权限,然后又一次赋予权限:
GRANTSELECT,INSERT ON access_log.* TO audit_user@'%';
mysql> 
mysql> GRANTSELECT,INSERT ON access_log.* TO audit_user@'%';
Query OK, 0 rowsaffected (0.00 sec)

mysql> exit
Bye

再登录。报错例如以下:
[root@db_server~]# /usr/local/mysql/bin/mysql  -uaudit_user -p -S/usr/local/mysql/mysql.sock
Enter password: 
ERROR 1045(28000): Access denied for user 'audit_user'@'localhost' (using password: YES)
[root@db_server~]# 

去查看error日志:
2014-07-2816:15:29 23743 [Warning] INSERT command denied to user ''@'localhost' for table'access_log'
2014-07-2816:15:41 23743 [Warning] Aborted connection 37 to db: 'unconnected' user:'audit_user' host: 'localhost' (init_connect command failed)
2014-07-2816:15:41 23743 [Warning] INSERT command denied to user ''@'localhost' for table'access_log'
2014-07-2816:15:50 23743 [Warning] Aborted connection 38 to db: 'unconnected' user:'audit_user' host: 'localhost' (init_connect command failed)
2014-07-2816:15:50 23743 [Warning] INSERT command denied to user ''@'localhost' for table'access_log'

需要用root用户登录进去。清空掉用户为''的用户记录。
 mysql>select user,host,password from mysql.user;
+----------------+-----------+-------------------------------------------+
| user          | host      | password                                |
+----------------+-----------+-------------------------------------------+
| root          | localhost |                                         |
| root          | db_server   |                                         |
| root          | 127.0.0.1 |                                         |
| root          | ::1       |                                         |
|               | localhost |                                         |
|               | db_server   |                                         |
| cacti_user    | %         |*EB9E3195E443D577879101A35EF64A701B35F949 |
| cacti_user    | 1         |*D5FF9B53A78232DA13D3643965A5961449B387DB |
| cacti_user    | 2         | *D5FF9B53A78232DA13D3643965A5961449B387DB|
| test_user     | 192.%     |*8A447777509932F0ED07ADB033562027D95A0F17 |
| test_user     | 1         |*8A447777509932F0ED07ADB033562027D95A0F17 |
| weakpwd_user_1| 10.%      | *6BB4837EB74329105EE4568DDA7DC67ED2CA2AD9 |
| weakpwd_user_2| 10.%      | *B1461C9C68AFA1129A5F968C343636192A084ADB |
| weakpwd_user_3| 10.%      | *DCB7DF5FFC82C441503300FFF165257BC551A598 |
| audit_user    | %         |*AEAB1915B137FAFDE9B949D67A9A42DDB68DD8A2 |
+----------------+-----------+-------------------------------------------+
15 rows in set(0.00 sec)

mysql> dropuser ''@'localhost';
Query OK, 0 rowsaffected (0.00 sec)

mysql> dropuser ''@'db_server';
Query OK, 0 rowsaffected (0.00 sec)

mysql> 

再用已经分配了access_log表的Insert权限的audit_user登录
mysql> select* from access_log.access_log;
+----+-----------+---------------------+---------------------------+--------------+
| id | thread_id| log_time            | localname                | matchname    |
+----+-----------+---------------------+---------------------------+--------------+
|  4 |       41 | 2014-07-28 16:19:37 | audit_user@localhost     | audit_user@% |
|  5 |       42 | 2014-07-28 16:20:32 | audit_user@localhost     | audit_user@% |
|  6 |       45 | 2014-07-28 16:21:11 | audit_user@localhost     | audit_user@% |
+----+-----------+---------------------+---------------------------+--------------+
6 rows in set(0.00 sec)

mysql> showfull processlist;
+----+------------+-----------+------+---------+------+-------+-----------------------+
| Id | User      | Host      | db   | Command | Time |State | Info                  |
+----+------------+-----------+------+---------+------+-------+-----------------------+
| 45 | audit_user| localhost | NULL | Query   |    0 | init  | show fullprocesslist |
+----+------------+-----------+------+---------+------+-------+-----------------------+
1 row in set(0.00 sec)

mysql> 

5,再用另外一个用户登录建表,录入測试数据。
建表录入数据记录
mysql> usetest;
Database changed
mysql> createtable t1 select 1 as a, 'wa' as b;
Query OK, 1 rowaffected (0.01 sec)
Records: 1 Duplicates: 0  Warnings: 0
查看跟踪用户行为记录。
mysql> select* from access_log.access_log;
+----+-----------+---------------------+---------------------------+--------------+
| id | thread_id| log_time            | localname                | matchname    |
+----+-----------+---------------------+---------------------------+--------------+
|  4 |       41 | 2014-07-28 16:19:37 | audit_user@localhost     | audit_user@% |
|  5 |       42 | 2014-07-28 16:20:32 | audit_user@localhost     | audit_user@% |
|  6 |       45 | 2014-07-28 16:21:11 | audit_user@localhost     | audit_user@% |
|  7 |       48 | 2014-07-28 16:30:42 | audit_user@192.168.3.62   | audit_user@% |
|  8 |       50 | 2014-07-28 16:46:11 | audit_user@192.168.3.62   | audit_user@% |
+----+-----------+---------------------+---------------------------+--------------+
8 rows in set(0.00 sec)

mysqldb服务器上查看binlog 内容,解析完后,没有insert语句,怎么回事,去看my.cnf
#binlog-ignore-db=mysql                       # No sync databases
#binlog-ignore-db=test                        # No sync databases
#binlog-ignore-db=information_schema           # No sync databases
#binlog-ignore-db=performance_schema
原来是对test库有binlog过滤设置。所有凝视掉。重新启动mysql库,又一次来一遍,能够在看到binlog
在MySQL客户端上又一次运行。


mysql> usetest;
Database changed
mysql> insertinto test.t1 select 5,'t5';
Query OK, 1 rowaffected (0.00 sec)
Records: 1 Duplicates: 0  Warnings: 0

mysql> select* from access_log.access_log;
+----+-----------+---------------------+---------------------------+--------------+
| id | thread_id| log_time            | localname                | matchname    |
+----+-----------+---------------------+---------------------------+--------------+
|  1 |       17 | 2014-07-28 15:41:04 | cacti_user@192.168.171.71| cacti_user@% |
|  2 |       18 | 2014-07-28 15:41:05 | cacti_user@192.168.171.71| cacti_user@% |
|  3 |       19 | 2014-07-28 15:41:05 | cacti_user@192.168.171.71| cacti_user@% |
|  4 |       41 | 2014-07-28 16:19:37 | audit_user@localhost     | audit_user@% |
|  5 |       42 | 2014-07-28 16:20:32 | audit_user@localhost     | audit_user@% |
|  6 |       45 | 2014-07-28 16:21:11 | audit_user@localhost     | audit_user@% |
|  7 |       48 | 2014-07-28 16:30:42 | audit_user@192.168.3.62   | audit_user@% |
|  8 |       50 | 2014-07-28 16:46:11 | audit_user@192.168.3.62   | audit_user@% |
|  9 |       56 | 2014-07-28 19:32:12 | audit_user@192.168.1.12   | audit_user@% |
| 10 |        1 | 2014-07-28 20:02:56 |audit_user@192.168.3.62    | audit_user@% |
+----+-----------+---------------------+---------------------------+--------------+
10 rows in set(0.00 sec)
看到thread_id为1


6,怎样查看何跟踪用户行为记录。
mysql数据库服务器上查看binlog。应该thread_id=1的binlog记录。


[root@db_serverbinlog]# /usr/local/mysql/bin/mysqlbinlog  --base64-output=DECODE-ROWS mysql-bin.000018 -v>3.log
[root@db_serverbinlog]# vim 3.log
# at 1103
#140728 20:12:48server id 72  end_log_pos 1175 CRC32 0xa323c00e       Query   thread_id=1     exec_time=0    error_code=0
SETTIMESTAMP=1406549568/*!*/;
BEGIN
/*!*/;
# at 1175
#140728 20:12:48server id 72  end_log_pos 1229 CRC32 0xbb8ca914       Table_map: `test`.`t1` mapped to number 72
# at 1229
#140728 20:12:48server id 72  end_log_pos 1272 CRC32 0x8eed1450       Write_rows: table id 72 flags: STMT_END_F
### INSERT INTO `test`.`t1`
### SET
###   @1=5
###   @2='t5'
# at 1272
#140728 20:12:48server id 72  end_log_pos 1303 CRC32 0x72b26336       Xid = 14
COMMIT/*!*/;


看到thread_id=1,然后。就能够依据thread_id=1来推断运行这条insert命令的来源,还能够在mysql服务器上运行show full processlist;来得到MySQL客户端的请求port,
mysql> showfull processlist;
+----+------------+-------------------+------+---------+------+-------+-----------------------+
| Id | User      | Host              |db   | Command | Time | State | Info                 |
+----+------------+-------------------+------+---------+------+-------+-----------------------+
|  1 |audit_user | 192.168.3.62:44657 | test | Sleep   |  162 |      | NULL                 |
|  3 | root      | localhost         | NULL | Query  |    0 | init  | show full processlist |
+----+------------+-------------------+------+---------+------+-------+-----------------------+
2 rows in set(0.00 sec)


mysql> 
看到Id为1的线程。port是44657



我们切换回mysql客户端。去查看port是44657的是什么进程,例如以下所看到的:
[tim@db_client~]$ netstat -antlp |grep 44657
(Not allprocesses could be identified, non-owned process info
 will not beshown, you would have to be root to see it all.)
tcp       0      0 192.168.3.62:44657          192.168.1.12:3307           ESTABLISHED 6335/mysql          
[tim@db_client~]$ 
获取到该进程的PID。再通过ps -eaf得到该进程所运行的命令,例如以下所看到的:
[tim@db_client~]$ ps -eaf|grep 6335
tim   633525497  0 19:59 pts/1    00:00:00 mysql -uaudit_user -p -h192.168.1.12 -P3307
tim   6993 6906  0 20:16 pts/2    00:00:00 grep 6335
[tim@db_client ~]$
最后查到是通过mysql客户端登陆连接的。

增加这个6335是某个webproject的,那么,也能够依据ps-eaf命令查询得到webproject的进程信息。


来自:http://blog.itpub.net/26230597/viewspace-1240386/

參考文章地址:http://blog.chinaunix.net/uid-24086995-id-168445.html


原文地址:https://www.cnblogs.com/yjbjingcha/p/7366594.html