分析MYSQL错误日志

160626  3:04:05 [Note] Plugin 'FEDERATED' is disabled.
160626  3:04:05 [Note] Plugin 'InnoDB' is disabled.
160626  3:04:06 [Note] Event Scheduler: Loaded 0 events
160626  3:04:06 [Note] D:\Program Files\WebPhp5.2\MySQL Server 5.5\bin\mysqld.exe: ready for connections.
Version: '5.5.19'  socket: ''  port: 3306  MySQL Community Server (GPL)
160626  3:11:33 [Note] D:\Program Files\WebPhp5.2\MySQL Server 5.5\bin\mysqld.exe: Normal shutdown160626  3:11:33 [Note] Event Scheduler: Purging the queue. 0 events
160626  3:11:35 [Note] D:\Program Files\WebPhp5.2\MySQL Server 5.5\bin\mysqld.exe: Shutdown complete160626  3:11:38 [Note] Plugin 'FEDERATED' is disabled.
160626  3:11:38 InnoDB: The InnoDB memory heap is disabled
160626  3:11:38 InnoDB: Mutexes and rw_locks use Windows interlocked functions
160626  3:11:38 InnoDB: Compressed tables use zlib 1.2.3
160626  3:11:38 InnoDB: Initializing buffer pool, size = 64.0M
160626  3:11:38 InnoDB: Completed initialization of buffer pool
InnoDB: The first specified data file .\ibdata1 did not exist:
InnoDB: a new database to be created!
160626  3:11:38  InnoDB: Setting file .\ibdata1 size to 10 MB
InnoDB: Database physically writes the file full: wait...
160626  3:11:38  InnoDB: Log file .\ib_logfile0 did not exist: new to be created
InnoDB: Setting log file .\ib_logfile0 size to 16 MB
InnoDB: Database physically writes the file full: wait...
160626  3:11:39  InnoDB: Log file .\ib_logfile1 did not exist: new to be created
InnoDB: Setting log file .\ib_logfile1 size to 16 MB
InnoDB: Database physically writes the file full: wait...
InnoDB: Doublewrite buffer not found: creating new
InnoDB: Doublewrite buffer created
InnoDB: 127 rollback segment(s) active.
InnoDB: Creating foreign key constraint system tables
InnoDB: Foreign key constraint system tables created
160626  3:11:41  InnoDB: Waiting for the background threads to start
160626  3:11:42 InnoDB: 1.1.8 started; log sequence number 0
160626  3:11:42 [Note] Event Scheduler: Loaded 0 events
160626  3:11:42 [Note] D:\Program Files\WebPhp5.2\MySQL Server 5.5\bin\mysqld.exe: ready for connections.
Version: '5.5.19'  socket: ''  port: 3306  MySQL Community Server (GPL)
160626  3:13:17 [Note] D:\Program Files\WebPhp5.2\MySQL Server 5.5\bin\mysqld.exe: Normal shutdown160626  3:13:17 [Note] Event Scheduler: Purging the queue. 0 events
160626  3:13:19  InnoDB: Starting shutdown...
160626  3:13:20  InnoDB: Shutdown completed; log sequence number 1595675
160626  3:13:20 [Note] D:\Program Files\WebPhp5.2\MySQL Server 5.5\bin\mysqld.exe: Shutdown complete160626  3:13:22 [Note] Plugin 'FEDERATED' is disabled.
160626  3:13:22 InnoDB: The InnoDB memory heap is disabled
160626  3:13:22 InnoDB: Mutexes and rw_locks use Windows interlocked functions
160626  3:13:22 InnoDB: Compressed tables use zlib 1.2.3
160626  3:13:22 InnoDB: Initializing buffer pool, size = 64.0M
160626  3:13:22 InnoDB: Completed initialization of buffer pool
160626  3:13:22 InnoDB: highest supported file format is Barracuda.
160626  3:13:24  InnoDB: Waiting for the background threads to start
160626  3:13:25 InnoDB: 1.1.8 started; log sequence number 1595675
160626  3:13:25 [Note] Event Scheduler: Loaded 0 events
160626  3:13:25 [Note] D:\Program Files\WebPhp5.2\MySQL Server 5.5\bin\mysqld.exe: ready for connections.
Version: '5.5.19'  socket: ''  port: 3306  MySQL Community Server (GPL)
160626  3:14:30 [Note] D:\Program Files\WebPhp5.2\MySQL Server 5.5\bin\mysqld.exe: Normal shutdown160626  3:14:30 [Note] Event Scheduler: Purging the queue. 0 events
160626  3:14:31 [ERROR] D:\Program Files\WebPhp5.2\MySQL Server 5.5\bin\mysqld.exe: Sort aborted: Server shutdown in progress
160626  3:14:32  InnoDB: Starting shutdown...
160626  3:14:33  InnoDB: Shutdown completed; log sequence number 1595675
160626  3:14:33 [Note] D:\Program Files\WebPhp5.2\MySQL Server 5.5\bin\mysqld.exe: Shutdown complete160626  3:14:36 [Note] Plugin 'FEDERATED' is disabled.
160626  3:14:36 InnoDB: The InnoDB memory heap is disabled
160626  3:14:36 InnoDB: Mutexes and rw_locks use Windows interlocked functions
160626  3:14:36 InnoDB: Compressed tables use zlib 1.2.3
160626  3:14:36 InnoDB: Initializing buffer pool, size = 64.0M
160626  3:14:36 InnoDB: Completed initialization of buffer pool
160626  3:14:36 InnoDB: highest supported file format is Barracuda.
160626  3:14:38  InnoDB: Waiting for the background threads to start
160626  3:14:39 InnoDB: 1.1.8 started; log sequence number 1595675
160626  3:14:39 [Note] Event Scheduler: Loaded 0 events
160626  3:14:39 [Note] D:\Program Files\WebPhp5.2\MySQL Server 5.5\bin\mysqld.exe: ready for connections.
Version: '5.5.19'  socket: ''  port: 3306  MySQL Community Server (GPL)
160626  3:15:44 [Note] D:\Program Files\WebPhp5.2\MySQL Server 5.5\bin\mysqld.exe: Normal shutdown160626  3:15:44 [Note] Event Scheduler: Purging the queue. 0 events
160626  3:15:44  InnoDB: Starting shutdown...
160626  3:15:45  InnoDB: Shutdown completed; log sequence number 1595675
160626  3:15:45 [Note] D:\Program Files\WebPhp5.2\MySQL Server 5.5\bin\mysqld.exe: Shutdown complete160626  3:15:47 [Note] Plugin 'FEDERATED' is disabled.
160626  3:15:47 [Note] Plugin 'InnoDB' is disabled.
160626  3:15:47 [Note] Event Scheduler: Loaded 0 events
160626  3:15:47 [Note] D:\Program Files\WebPhp5.2\MySQL Server 5.5\bin\mysqld.exe: ready for connections.
Version: '5.5.19'  socket: ''  port: 3306  MySQL Community Server (GPL)
160626  3:27:14 [Note] D:\Program Files\WebPhp5.2\MySQL Server 5.5\bin\mysqld.exe: Normal shutdown160626  3:27:14 [Note] Event Scheduler: Purging the queue. 0 events
160626  3:27:14 [ERROR] D:\Program Files\WebPhp5.2\MySQL Server 5.5\bin\mysqld.exe: Sort aborted: Server shutdown in progress
160626  3:27:16 [Note] D:\Program Files\WebPhp5.2\MySQL Server 5.5\bin\mysqld.exe: Shutdown complete160626  3:27:18 [Note] Plugin 'FEDERATED' is disabled.
160626  3:27:18 [Note] Plugin 'InnoDB' is disabled.
160626  3:27:18 [Note] Event Scheduler: Loaded 0 events
160626  3:27:18 [Note] D:\Program Files\WebPhp5.2\MySQL Server 5.5\bin\mysqld.exe: ready for connections.
Version: '5.5.19'  socket: ''  port: 3306  MySQL Community Server (GPL)
160626  4:07:48 [Note] D:\Program Files\WebPhp5.2\MySQL Server 5.5\bin\mysqld.exe: Normal shutdown160626  4:07:48 [Note] Event Scheduler: Purging the queue. 0 events
160626  4:07:50 [Warning] D:\Program Files\WebPhp5.2\MySQL Server 5.5\bin\mysqld.exe: Forcing close of thread 855  user: 'root'160626  4:07:50 [Warning] D:\Program Files\WebPhp5.2\MySQL Server 5.5\bin\mysqld.exe: Forcing close of thread 819  user: 'root'160626  4:07:50 [Warning] D:\Program Files\WebPhp5.2\MySQL Server 5.5\bin\mysqld.exe: Forcing close of thread 818  user: 'root'160626  4:07:50 [Warning] D:\Program Files\WebPhp5.2\MySQL Server 5.5\bin\mysqld.exe: Forcing close of thread 810  user: 'root'160626  4:07:50 [Warning] D:\Program Files\WebPhp5.2\MySQL Server 5.5\bin\mysqld.exe: Forcing close of thread 803  user: 'root'160626  4:07:50 [Warning] D:\Program Files\WebPhp5.2\MySQL Server 5.5\bin\mysqld.exe: Forcing close of thread 789  user: 'root'160626  4:07:50 [Warning] D:\Program Files\WebPhp5.2\MySQL Server 5.5\bin\mysqld.exe: Forcing close of thread 752  user: 'root'160626  4:07:50 [Warning] D:\Program Files\WebPhp5.2\MySQL Server 5.5\bin\mysqld.exe: Forcing close of thread 680  user: 'root'160626  4:07:50 [Note] D:\Program Files\WebPhp5.2\MySQL Server 5.5\bin\mysqld.exe: Shutdown complete160626  4:07:52 [Note] Plugin 'FEDERATED' is disabled.
160626  4:07:52 InnoDB: The InnoDB memory heap is disabled
160626  4:07:52 InnoDB: Mutexes and rw_locks use Windows interlocked functions
160626  4:07:52 InnoDB: Compressed tables use zlib 1.2.3
160626  4:07:52 InnoDB: Initializing buffer pool, size = 64.0M
160626  4:07:52 InnoDB: Completed initialization of buffer pool
160626  4:07:52 InnoDB: highest supported file format is Barracuda.
160626  4:07:55  InnoDB: Waiting for the background threads to start
160626  4:07:56 InnoDB: 1.1.8 started; log sequence number 1595675
160626  4:07:56 [Note] Event Scheduler: Loaded 0 events
160626  4:07:56 [Note] D:\Program Files\WebPhp5.2\MySQL Server 5.5\bin\mysqld.exe: ready for connections.
Version: '5.5.19'  socket: ''  port: 3306  MySQL Community Server (GPL)

解决方案 »

  1.   

     [ERROR] D:\Program Files\WebPhp5.2\MySQL Server 5.5\bin\mysqld.exe: Sort aborted: Server shutdown in progress主要是这个报错。搜了一下，说是这个可能是由于bug引起的
      

  2.   

    就是 当你明确的用kill一个查询的时候，而这个查询本身又用到了 sort buffer，会出现类似 mysql server 重启的情况，这个bug已经子啊5.6以后解决
      

  3.   

    问题描述：
    1、问题只要出在有一张超大的表，因为更新需要频繁读、写、替换，并且这张表的内容在前台都是动态调用的，运行一段时间后，前台访问这张表的内容页会卡住，浏览一直处在加载状态好长时间，最后打不开返回一个好像是返回一个504的错误吧！包括后台也无法对这些表的内容进行维护及更新，同样是卡住没反应，大概隔间几分钟甚至更长时间后，即又能自动恢复正常。
    2、这张表的大小为3G左右，1千万+记录；
    3、顺便把 my.ini 贴出来，求各位大神帮忙分析看看
    [client]
    port=3306[mysql]
    default-character-set=utf8[mysqld]
    port=3306
    server_id=1
    character-set-server=utf8
    default-storage-engine=MYISAM
    sql-mode="NO_AUTO_CREATE_USER,NO_ENGINE_SUBSTITUTION"
    slow_query_log=0
    long_query_time=2
    local-infile=0
    skip-external-locking
    #skip-innodb
    #log-bin=mysql-bin
    #binlog_format=mixedmax_connections=1000
    query_cache_size=0
    key_buffer_size=64M
    sort_buffer_size=256kb
    read_buffer_size=512kb
    join_buffer_size=2M
    read_rnd_buffer_size=2M
    max_allowed_packet=16M
    table_open_cache=256
    tmp_table_size=64M
    max_heap_table_size=64Mmyisam_max_sort_file_size=64G
    myisam_sort_buffer_size=32M
    myisam_repair_threads=1innodb_autoextend_increment=128M
    innodb_buffer_pool_size=256M
    innodb_log_file_size=128M
    innodb_log_buffer_size=16M
    innodb_file_per_table=1
    innodb_flush_log_at_trx_commit=0
    innodb_lock_wait_timeout=50[mysqldump]
    quick
    max_allowed_packet=16M[mysql]
    no-auto-rehash[myisamchk]
    key_buffer_size=20M
    sort_buffer_size=20M
    read_buffer=2M
    write_buffer=2M[mysqlhotcopy]
    interactive-timeout[mysqld_safe]
    open-files-limit=8192
      

  4.   

    问题补充：大概隔间几分钟甚至更长时间后，前台调用这张超大表数据的页面能自动恢复正常（包括后台也能对这张超大表进行维护与更新）  或  重启mysql服务也可以。
      

  5.   

     my.ini 中的  innodb_autoextend_increment=128M 是刚加上的，并且出问题时 innodb_flush_log_at_trx_commit 是的值是 1