dble
dble copied to clipboard
Published
20 hours ago •
actiontech
actiontech
Spend too much time on INFO log
Raised by: helingyun Steps:
- Prepare: 2 data-nodes, 2 tables on each node, 50000000 rows in each table
- Sysbench 2048 threads:
select ... id between a and a+100 order by money - log level is INFO, found many logs like:
2017-05-15 15:18:04.146 INFO [BusinessExecutor51] (io.mycat.backend.mysql.nio.handler.query.impl.MultiNodeMergeHandler.rowEofResponse(MultiNodeMergeHandler.java:177)) - MySQLConnection [id=1384, lastTime=1494832683860, user=action, schema=test_hly, old shema=test_hly, borrowed=true, fromSlaveDB=false, threadId=4284, charset=latin1, txIsolation=3, autocommit=true, attachment=dn1{select `user_creditcard_info`.`id`,`user_creditcard_info`.`my_creditcard`,`user_creditcard_info`.`my_comsume_money`,`user_creditcard_info`.`my_date`,`user_creditcard_info`.`my_credit_state`,`user_creditcard_info`.`my_max_money` from `user_creditcard_info` where id BETWEEN 31299641 AND 31299741 ORDER BY `user_creditcard_info`.`id` ASC LIMIT 50}.0, respHandler=io.mycat.backend.mysql.nio.handler.query.impl.BaseSelectHandler@25e79cfe, host=10.186.17.101, port=3309, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] 's rowEof is reached.
2017-05-15 15:18:04.146 INFO [BusinessExecutor19] (io.mycat.backend.mysql.nio.handler.query.impl.OutputHandler.rowEofResponse(OutputHandler.java:163)) - --------sql execute end!
