2017-08-31 15:34:44,889 [INFO ][main] total resouces of dataHost demo is :2 (io.mycat.backend.datasource.PhysicalDBPool:PhysicalDBPool.java:101)
2017-08-31 15:34:45,056 [INFO ][main] create layer cache pool TableID2DataNodeCache of type encache ,default cache size 10000 ,default expire seconds18000 (io.mycat.cache.CacheService:CacheService.java:125)
2017-08-31 15:34:45,082 [INFO ][main] create child Cache: TESTDB_ORDERS for layered cache TableID2DataNodeCache, size 50000, expire seconds 18000 (io.mycat.cache.DefaultLayedCachePool:DefaultLayedCachePool.java:80)
2017-08-31 15:34:45,118 [DEBUG][main] Configuring ehcache from ehcache.xml found in the classpath: file:/C:/Users/Administrator/IdeaProjects/Mycat-Server/target/classes/ehcache.xml (net.sf.ehcache.config.ConfigurationFactory:ConfigurationFactory.java:132)
2017-08-31 15:34:45,120 [DEBUG][main] Configuring ehcache from URL: file:/C:/Users/Administrator/IdeaProjects/Mycat-Server/target/classes/ehcache.xml (net.sf.ehcache.config.ConfigurationFactory:ConfigurationFactory.java:98)
2017-08-31 15:34:45,129 [DEBUG][main] Configuring ehcache from InputStream (net.sf.ehcache.config.ConfigurationFactory:ConfigurationFactory.java:150)
2017-08-31 15:34:45,192 [DEBUG][main] Ignoring ehcache attribute xmlns:xsi (net.sf.ehcache.config.BeanHandler:BeanHandler.java:271)
2017-08-31 15:34:45,193 [DEBUG][main] Ignoring ehcache attribute xsi:noNamespaceSchemaLocation (net.sf.ehcache.config.BeanHandler:BeanHandler.java:271)
2017-08-31 15:34:45,193 [DEBUG][main] Ignoring ehcache attribute maxEntriesLocalHeap (net.sf.ehcache.config.BeanHandler:BeanHandler.java:271)
2017-08-31 15:34:45,228 [DEBUG][main] Creating new CacheManager with default config (net.sf.ehcache.CacheManager:CacheManager.java:1036)
2017-08-31 15:34:45,239 [DEBUG][main] propertiesString is null. (net.sf.ehcache.util.PropertyUtil:PropertyUtil.java:88)
2017-08-31 15:34:45,317 [DEBUG][main] No CacheManagerEventListenerFactory class specified. Skipping... (net.sf.ehcache.config.ConfigurationHelper:ConfigurationHelper.java:185)
2017-08-31 15:34:46,141 [DEBUG][main] No BootstrapCacheLoaderFactory class specified. Skipping... (net.sf.ehcache.Cache:Cache.java:955)
2017-08-31 15:34:46,141 [DEBUG][main] CacheWriter factory not configured. Skipping... (net.sf.ehcache.Cache:Cache.java:929)
2017-08-31 15:34:46,144 [DEBUG][main] No CacheExceptionHandlerFactory class specified. Skipping... (net.sf.ehcache.config.ConfigurationHelper:ConfigurationHelper.java:96)
2017-08-31 15:34:46,163 [DEBUG][main] No BootstrapCacheLoaderFactory class specified. Skipping... (net.sf.ehcache.Cache:Cache.java:955)
2017-08-31 15:34:46,163 [DEBUG][main] CacheWriter factory not configured. Skipping... (net.sf.ehcache.Cache:Cache.java:929)
2017-08-31 15:34:46,190 [DEBUG][main] Initialized net.sf.ehcache.store.NotifyingMemoryStore for TableID2DataNodeCache.TESTDB_ORDERS (net.sf.ehcache.store.MemoryStore:MemoryStore.java:153)
2017-08-31 15:34:46,209 [DEBUG][main] Initialised cache: TableID2DataNodeCache.TESTDB_ORDERS (net.sf.ehcache.Cache:Cache.java:1165)
2017-08-31 15:34:46,225 [DEBUG][main] Attempting to create an existing singleton. Existing singleton returned. (net.sf.ehcache.CacheManager:CacheManager.java:794)
2017-08-31 15:34:46,226 [DEBUG][main] No BootstrapCacheLoaderFactory class specified. Skipping... (net.sf.ehcache.Cache:Cache.java:955)
2017-08-31 15:34:46,226 [DEBUG][main] CacheWriter factory not configured. Skipping... (net.sf.ehcache.Cache:Cache.java:929)
2017-08-31 15:34:46,226 [DEBUG][main] Initialized net.sf.ehcache.store.NotifyingMemoryStore for ER_SQL2PARENTID (net.sf.ehcache.store.MemoryStore:MemoryStore.java:153)
2017-08-31 15:34:46,226 [DEBUG][main] Initialised cache: ER_SQL2PARENTID (net.sf.ehcache.Cache:Cache.java:1165)
2017-08-31 15:34:46,226 [DEBUG][main] Attempting to create an existing singleton. Existing singleton returned. (net.sf.ehcache.CacheManager:CacheManager.java:794)
2017-08-31 15:34:46,227 [DEBUG][main] No BootstrapCacheLoaderFactory class specified. Skipping... (net.sf.ehcache.Cache:Cache.java:955)
2017-08-31 15:34:46,227 [DEBUG][main] CacheWriter factory not configured. Skipping... (net.sf.ehcache.Cache:Cache.java:929)
2017-08-31 15:34:46,227 [DEBUG][main] Initialized net.sf.ehcache.store.NotifyingMemoryStore for SQLRouteCache (net.sf.ehcache.store.MemoryStore:MemoryStore.java:153)
2017-08-31 15:34:46,227 [DEBUG][main] Initialised cache: SQLRouteCache (net.sf.ehcache.Cache:Cache.java:1165)
2017-08-31 15:34:46,291 [INFO ][main] dyna class load from C:/Users/Administrator/IdeaProjects/Mycat-Server\catlet,and auto check for class file modified every 60 seconds (io.mycat.config.classloader.DynaClassLoader:DynaClassLoader.java:34)
2017-08-31 15:34:46,454 [DEBUG][main] baseDir C:/Users/Administrator/IdeaProjects/Mycat-Server/tmlogs/ (io.mycat.backend.mysql.xa.recovery.impl.FileSystemRepository:FileSystemRepository.java:43)
2017-08-31 15:34:46,455 [DEBUG][main] baseName tmlog (io.mycat.backend.mysql.xa.recovery.impl.FileSystemRepository:FileSystemRepository.java:44)
2017-08-31 15:34:47,163 [INFO ][main] MyCat is ready to startup ... (io.mycat.MycatServer:MycatServer.java:316)
2017-08-31 15:34:47,163 [INFO ][main] Startup processors ...,total processors:4,aio thread pool size:8
each process allocated socket buffer pool bytes ,a page size:2097152 a page's chunk number(PageSize/ChunkSize) is:512 buffer page's number is:80 (io.mycat.MycatServer:MycatServer.java:328)
2017-08-31 15:34:47,163 [INFO ][main] sysconfig params:SystemConfig [processorBufferLocalPercent=100, frontSocketSoRcvbuf=1048576, frontSocketSoSndbuf=4194304, backSocketSoRcvbuf=4194304, backSocketSoSndbuf=1048576, frontSocketNoDelay=1, backSocketNoDelay=1, maxStringLiteralLength=65535, frontWriteQueueSize=2048, bindIp=0.0.0.0, serverPort=8066, managerPort=9066, charset=utf8, processors=4, processorExecutor=8, timerExecutor=2, managerExecutor=2, idleTimeout=1800000, catletClassCheckSeconds=60, sqlExecuteTimeout=300, processorCheckPeriod=1000, dataNodeIdleCheckPeriod=300000, dataNodeHeartbeatPeriod=10000, clusterHeartbeatUser=_HEARTBEAT_USER_, clusterHeartbeatPass=_HEARTBEAT_PASS_, clusterHeartbeatPeriod=5000, clusterHeartbeatTimeout=10000, clusterHeartbeatRetry=10, txIsolation=3, parserCommentVersion=50148, sqlRecordCount=10, bufferPoolPageSize=2097152, bufferPoolChunkSize=4096, bufferPoolPageNumber=80, maxResultSet=524288, bigResultSizeSqlCount=10, bufferUsagePercent=80, flowControlRejectStrategy=0, clearBigSqLResultSetMapMs=600000, defaultMaxLimit=100, sequnceHandlerType=2, sqlInterceptor=io.mycat.server.interceptor.impl.DefaultSqlInterceptor, sqlInterceptorType=select, sqlInterceptorFile=C:\Users\Administrator\IdeaProjects\Mycat-Server/logs/sql.txt, mutiNodeLimitType=0, mutiNodePatchSize=100, defaultSqlParser=druidparser, usingAIO=0, packetHeaderSize=4, maxPacketSize=16777216, mycatNodeId=1] (io.mycat.MycatServer:MycatServer.java:329)
2017-08-31 15:34:47,426 [INFO ][main] useOffHeapForMerge = 1 (io.mycat.memory.MyCatMemory:MyCatMemory.java:53)
2017-08-31 15:34:47,426 [INFO ][main] memoryPageSize = 64k (io.mycat.memory.MyCatMemory:MyCatMemory.java:54)
2017-08-31 15:34:47,426 [INFO ][main] spillsFileBufferSize = 1k (io.mycat.memory.MyCatMemory:MyCatMemory.java:55)
2017-08-31 15:34:47,426 [INFO ][main] useStreamOutput = 0 (io.mycat.memory.MyCatMemory:MyCatMemory.java:56)
2017-08-31 15:34:47,426 [INFO ][main] systemReserveMemorySize = 384m (io.mycat.memory.MyCatMemory:MyCatMemory.java:57)
2017-08-31 15:34:47,481 [INFO ][main] totalNetWorkBufferSize = 160MB (io.mycat.memory.MyCatMemory:MyCatMemory.java:58)
2017-08-31 15:34:47,481 [INFO ][main] dataNodeSortedTempDir = C:\Users\Administrator\IdeaProjects\Mycat-Server (io.mycat.memory.MyCatMemory:MyCatMemory.java:59)
2017-08-31 15:34:47,507 [INFO ][main] mycat.memory.offHeap.size: 1007MB (io.mycat.memory.MyCatMemory:MyCatMemory.java:122)
2017-08-31 15:34:48,155 [INFO ][main] using nio network handler (io.mycat.MycatServer:MycatServer.java:435)
2017-08-31 15:34:48,251 [INFO ][main] $_MyCatManager is started and listening on 9066 (io.mycat.MycatServer:MycatServer.java:451)
2017-08-31 15:34:48,251 [INFO ][main] $_MyCatServer is started and listening on 8066 (io.mycat.MycatServer:MycatServer.java:455)
2017-08-31 15:34:48,251 [INFO ][main] =============================================== (io.mycat.MycatServer:MycatServer.java:457)
2017-08-31 15:34:48,252 [INFO ][main] Initialize dataHost ... (io.mycat.MycatServer:MycatServer.java:461)
2017-08-31 15:34:48,252 [INFO ][main] init backend myqsl source ,create connections total 10 for hostM1 index :0 (io.mycat.backend.datasource.PhysicalDBPool:PhysicalDBPool.java:303)
2017-08-31 15:34:48,265 [INFO ][main] no ilde connection in pool,create new connection for hostM1 of schema db2 (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:506)
2017-08-31 15:34:48,277 [INFO ][main] no ilde connection in pool,create new connection for hostM1 of schema db1 (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:506)
2017-08-31 15:34:48,277 [INFO ][main] no ilde connection in pool,create new connection for hostM1 of schema db2 (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:506)
2017-08-31 15:34:48,277 [INFO ][main] no ilde connection in pool,create new connection for hostM1 of schema db1 (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:506)
2017-08-31 15:34:48,278 [INFO ][main] no ilde connection in pool,create new connection for hostM1 of schema db2 (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:506)
2017-08-31 15:34:48,278 [INFO ][main] no ilde connection in pool,create new connection for hostM1 of schema db1 (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:506)
2017-08-31 15:34:48,278 [INFO ][main] no ilde connection in pool,create new connection for hostM1 of schema db2 (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:506)
2017-08-31 15:34:48,278 [INFO ][main] no ilde connection in pool,create new connection for hostM1 of schema db1 (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:506)
2017-08-31 15:34:48,278 [INFO ][main] no ilde connection in pool,create new connection for hostM1 of schema db2 (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:506)
2017-08-31 15:34:48,278 [INFO ][main] no ilde connection in pool,create new connection for hostM1 of schema db1 (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:506)
2017-08-31 15:34:48,351 [DEBUG][$_NIOConnector] 连接后台真正完成 (io.mycat.net.AbstractConnection:AbstractConnection.java:606)
2017-08-31 15:34:48,372 [DEBUG][$_NIOConnector] 连接后台真正完成 (io.mycat.net.AbstractConnection:AbstractConnection.java:606)
2017-08-31 15:34:48,378 [DEBUG][$_NIOConnector] 连接后台真正完成 (io.mycat.net.AbstractConnection:AbstractConnection.java:606)
2017-08-31 15:34:48,379 [DEBUG][$_NIOConnector] 连接后台真正完成 (io.mycat.net.AbstractConnection:AbstractConnection.java:606)
2017-08-31 15:34:48,379 [DEBUG][$_NIOConnector] 连接后台真正完成 (io.mycat.net.AbstractConnection:AbstractConnection.java:606)
2017-08-31 15:34:48,380 [DEBUG][$_NIOConnector] 连接后台真正完成 (io.mycat.net.AbstractConnection:AbstractConnection.java:606)
2017-08-31 15:34:48,380 [DEBUG][$_NIOConnector] 连接后台真正完成 (io.mycat.net.AbstractConnection:AbstractConnection.java:606)
2017-08-31 15:34:48,382 [DEBUG][$_NIOConnector] 连接后台真正完成 (io.mycat.net.AbstractConnection:AbstractConnection.java:606)
2017-08-31 15:34:48,382 [DEBUG][$_NIOConnector] 连接后台真正完成 (io.mycat.net.AbstractConnection:AbstractConnection.java:606)
2017-08-31 15:34:48,382 [DEBUG][$_NIOConnector] 连接后台真正完成 (io.mycat.net.AbstractConnection:AbstractConnection.java:606)
2017-08-31 15:34:48,418 [INFO ][$_NIOREACTOR-2-RW] connected successfuly MySQLConnection [id=2, lastTime=1504164888418, user=root, schema=db1, old shema=db1, borrowed=true, fromSlaveDB=false, threadId=2166, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.mysql.nio.handler.GetConnectionHandler:GetConnectionHandler.java:67)
2017-08-31 15:34:48,418 [INFO ][$_NIOREACTOR-1-RW] connected successfuly MySQLConnection [id=5, lastTime=1504164888418, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2169, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.mysql.nio.handler.GetConnectionHandler:GetConnectionHandler.java:67)
2017-08-31 15:34:48,418 [INFO ][$_NIOREACTOR-3-RW] connected successfuly MySQLConnection [id=3, lastTime=1504164888418, user=root, schema=db1, old shema=db1, borrowed=true, fromSlaveDB=false, threadId=2170, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.mysql.nio.handler.GetConnectionHandler:GetConnectionHandler.java:67)
2017-08-31 15:34:48,419 [INFO ][$_NIOREACTOR-0-RW] connected successfuly MySQLConnection [id=8, lastTime=1504164888418, user=root, schema=db1, old shema=db1, borrowed=true, fromSlaveDB=false, threadId=2171, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.mysql.nio.handler.GetConnectionHandler:GetConnectionHandler.java:67)
2017-08-31 15:34:48,419 [DEBUG][$_NIOREACTOR-1-RW] release channel MySQLConnection [id=5, lastTime=1504164888418, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2169, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:34:48,419 [DEBUG][$_NIOREACTOR-2-RW] release channel MySQLConnection [id=2, lastTime=1504164888418, user=root, schema=db1, old shema=db1, borrowed=true, fromSlaveDB=false, threadId=2166, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:34:48,419 [DEBUG][$_NIOREACTOR-0-RW] release channel MySQLConnection [id=8, lastTime=1504164888418, user=root, schema=db1, old shema=db1, borrowed=true, fromSlaveDB=false, threadId=2171, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:34:48,419 [DEBUG][$_NIOREACTOR-3-RW] release channel MySQLConnection [id=3, lastTime=1504164888418, user=root, schema=db1, old shema=db1, borrowed=true, fromSlaveDB=false, threadId=2170, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:34:48,419 [INFO ][$_NIOREACTOR-0-RW] connected successfuly MySQLConnection [id=4, lastTime=1504164888419, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2167, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.mysql.nio.handler.GetConnectionHandler:GetConnectionHandler.java:67)
2017-08-31 15:34:48,419 [INFO ][$_NIOREACTOR-1-RW] connected successfuly MySQLConnection [id=9, lastTime=1504164888419, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2172, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.mysql.nio.handler.GetConnectionHandler:GetConnectionHandler.java:67)
2017-08-31 15:34:48,419 [INFO ][$_NIOREACTOR-3-RW] connected successfuly MySQLConnection [id=7, lastTime=1504164888419, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2165, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.mysql.nio.handler.GetConnectionHandler:GetConnectionHandler.java:67)
2017-08-31 15:34:48,419 [DEBUG][$_NIOREACTOR-0-RW] release channel MySQLConnection [id=4, lastTime=1504164888419, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2167, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:34:48,419 [DEBUG][$_NIOREACTOR-3-RW] release channel MySQLConnection [id=7, lastTime=1504164888419, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2165, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:34:48,419 [DEBUG][$_NIOREACTOR-1-RW] release channel MySQLConnection [id=9, lastTime=1504164888419, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2172, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:34:48,419 [INFO ][$_NIOREACTOR-1-RW] connected successfuly MySQLConnection [id=1, lastTime=1504164888419, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2168, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.mysql.nio.handler.GetConnectionHandler:GetConnectionHandler.java:67)
2017-08-31 15:34:48,419 [INFO ][$_NIOREACTOR-2-RW] connected successfuly MySQLConnection [id=6, lastTime=1504164888419, user=root, schema=db1, old shema=db1, borrowed=true, fromSlaveDB=false, threadId=2164, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.mysql.nio.handler.GetConnectionHandler:GetConnectionHandler.java:67)
2017-08-31 15:34:48,419 [DEBUG][$_NIOREACTOR-1-RW] release channel MySQLConnection [id=1, lastTime=1504164888419, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2168, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:34:48,419 [DEBUG][$_NIOREACTOR-2-RW] release channel MySQLConnection [id=6, lastTime=1504164888419, user=root, schema=db1, old shema=db1, borrowed=true, fromSlaveDB=false, threadId=2164, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:34:48,419 [INFO ][$_NIOREACTOR-2-RW] connected successfuly MySQLConnection [id=10, lastTime=1504164888419, user=root, schema=db1, old shema=db1, borrowed=true, fromSlaveDB=false, threadId=2173, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.mysql.nio.handler.GetConnectionHandler:GetConnectionHandler.java:67)
2017-08-31 15:34:48,419 [DEBUG][$_NIOREACTOR-2-RW] release channel MySQLConnection [id=10, lastTime=1504164888419, user=root, schema=db1, old shema=db1, borrowed=true, fromSlaveDB=false, threadId=2173, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:34:48,483 [INFO ][main] init result :finished 10 success 10 target count:10 (io.mycat.backend.datasource.PhysicalDBPool:PhysicalDBPool.java:328)
2017-08-31 15:34:48,483 [INFO ][main] demo index:0 init success (io.mycat.backend.datasource.PhysicalDBPool:PhysicalDBPool.java:274)
2017-08-31 15:34:48,556 [INFO ][Timer0] create connections ,because idle connection not enough ,cur is 0, minCon is 10 for hostS2 (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:371)
2017-08-31 15:34:48,567 [INFO ][main] =============================================== (io.mycat.MycatServer:MycatServer.java:499)
2017-08-31 15:34:48,567 [INFO ][main] Perform XA recovery log ... (io.mycat.MycatServer:MycatServer.java:500)
2017-08-31 15:34:48,569 [INFO ][Timer0] no ilde connection in pool,create new connection for hostS2 of schema db2 (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:392)
2017-08-31 15:34:48,570 [DEBUG][$_NIOConnector] 连接后台真正完成 (io.mycat.net.AbstractConnection:AbstractConnection.java:606)
2017-08-31 15:34:48,572 [DEBUG][$_NIOREACTOR-3-RW] release channel MySQLConnection [id=11, lastTime=1504164888572, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=true, threadId=2097, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3308, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:34:48,572 [INFO ][$_NIOREACTOR-3-RW] connectionAcquired MySQLConnection [id=11, lastTime=1504164888568, user=root, schema=db2, old shema=db2, borrowed=false, fromSlaveDB=true, threadId=2097, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3308, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.mysql.nio.handler.NewConnectionRespHandler:NewConnectionRespHandler.java:45)
2017-08-31 15:34:48,601 [DEBUG][main] baseDir C:/Users/Administrator/IdeaProjects/Mycat-Server/tmlogs/ (io.mycat.backend.mysql.xa.recovery.impl.FileSystemRepository:FileSystemRepository.java:43)
2017-08-31 15:34:48,601 [DEBUG][main] baseName tmlog (io.mycat.backend.mysql.xa.recovery.impl.FileSystemRepository:FileSystemRepository.java:44)
MyCAT Server startup successfully. see logs in logs/mycat.log
2017-08-31 15:34:48,629 [DEBUG][Timer0] con query sql:select user() to con:MySQLConnection [id=5, lastTime=1504164888629, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2169, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.sqlengine.SQLJob:SQLJob.java:88)
2017-08-31 15:34:48,632 [DEBUG][Timer0] con query sql:select user() to con:MySQLConnection [id=11, lastTime=1504164888632, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=true, threadId=2097, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3308, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.sqlengine.SQLJob:SQLJob.java:88)
2017-08-31 15:34:48,645 [DEBUG][$_NIOREACTOR-3-RW] release channel MySQLConnection [id=11, lastTime=1504164888615, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=true, threadId=2097, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3308, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:34:48,645 [DEBUG][$_NIOREACTOR-1-RW] release channel MySQLConnection [id=5, lastTime=1504164888615, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2169, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:34:58,534 [DEBUG][Timer1] con query sql:select user() to con:MySQLConnection [id=4, lastTime=1504164898534, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2167, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.sqlengine.SQLJob:SQLJob.java:88)
2017-08-31 15:34:58,534 [DEBUG][Timer1] con query sql:select user() to con:MySQLConnection [id=11, lastTime=1504164898534, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=true, threadId=2097, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3308, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.sqlengine.SQLJob:SQLJob.java:88)
2017-08-31 15:34:58,535 [DEBUG][$_NIOREACTOR-0-RW] release channel MySQLConnection [id=4, lastTime=1504164898534, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2167, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:34:58,535 [DEBUG][$_NIOREACTOR-3-RW] release channel MySQLConnection [id=11, lastTime=1504164898534, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=true, threadId=2097, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3308, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:35:08,533 [DEBUG][Timer0] con query sql:select user() to con:MySQLConnection [id=7, lastTime=1504164908533, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2165, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.sqlengine.SQLJob:SQLJob.java:88)
2017-08-31 15:35:08,534 [DEBUG][$_NIOREACTOR-3-RW] release channel MySQLConnection [id=7, lastTime=1504164908515, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2165, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:35:08,534 [DEBUG][Timer0] con query sql:select user() to con:MySQLConnection [id=11, lastTime=1504164908534, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=true, threadId=2097, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3308, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.sqlengine.SQLJob:SQLJob.java:88)
2017-08-31 15:35:08,536 [DEBUG][$_NIOREACTOR-3-RW] release channel MySQLConnection [id=11, lastTime=1504164908515, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=true, threadId=2097, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3308, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:35:18,534 [DEBUG][Timer1] con query sql:select user() to con:MySQLConnection [id=9, lastTime=1504164918534, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2172, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.sqlengine.SQLJob:SQLJob.java:88)
2017-08-31 15:35:18,534 [DEBUG][Timer1] con query sql:select user() to con:MySQLConnection [id=11, lastTime=1504164918534, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=true, threadId=2097, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3308, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.sqlengine.SQLJob:SQLJob.java:88)
2017-08-31 15:35:18,535 [DEBUG][$_NIOREACTOR-1-RW] release channel MySQLConnection [id=9, lastTime=1504164918515, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2172, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:35:18,535 [DEBUG][$_NIOREACTOR-3-RW] release channel MySQLConnection [id=11, lastTime=1504164918515, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=true, threadId=2097, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3308, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:35:28,535 [DEBUG][Timer0] con query sql:select user() to con:MySQLConnection [id=1, lastTime=1504164928535, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2168, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.sqlengine.SQLJob:SQLJob.java:88)
2017-08-31 15:35:28,536 [DEBUG][Timer0] con query sql:select user() to con:MySQLConnection [id=11, lastTime=1504164928536, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=true, threadId=2097, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3308, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.sqlengine.SQLJob:SQLJob.java:88)
2017-08-31 15:35:28,537 [DEBUG][$_NIOREACTOR-3-RW] release channel MySQLConnection [id=11, lastTime=1504164928535, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=true, threadId=2097, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3308, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:35:28,541 [DEBUG][$_NIOREACTOR-1-RW] release channel MySQLConnection [id=1, lastTime=1504164928535, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2168, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:35:38,534 [DEBUG][Timer1] con query sql:select user() to con:MySQLConnection [id=5, lastTime=1504164938534, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2169, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.sqlengine.SQLJob:SQLJob.java:88)
2017-08-31 15:35:38,534 [DEBUG][$_NIOREACTOR-1-RW] release channel MySQLConnection [id=5, lastTime=1504164938516, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2169, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:35:38,534 [DEBUG][Timer1] con query sql:select user() to con:MySQLConnection [id=11, lastTime=1504164938534, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=true, threadId=2097, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3308, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.sqlengine.SQLJob:SQLJob.java:88)
2017-08-31 15:35:38,535 [DEBUG][$_NIOREACTOR-3-RW] release channel MySQLConnection [id=11, lastTime=1504164938516, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=true, threadId=2097, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3308, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:35:48,533 [DEBUG][Timer1] con query sql:select user() to con:MySQLConnection [id=4, lastTime=1504164948533, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2167, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.sqlengine.SQLJob:SQLJob.java:88)
2017-08-31 15:35:48,534 [DEBUG][$_NIOREACTOR-0-RW] release channel MySQLConnection [id=4, lastTime=1504164948515, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2167, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:35:48,534 [DEBUG][Timer1] con query sql:select user() to con:MySQLConnection [id=11, lastTime=1504164948534, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=true, threadId=2097, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3308, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.sqlengine.SQLJob:SQLJob.java:88)
2017-08-31 15:35:48,534 [DEBUG][$_NIOREACTOR-3-RW] release channel MySQLConnection [id=11, lastTime=1504164948515, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=true, threadId=2097, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3308, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:35:58,534 [DEBUG][Timer1] con query sql:select user() to con:MySQLConnection [id=7, lastTime=1504164958534, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2165, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.sqlengine.SQLJob:SQLJob.java:88)
2017-08-31 15:35:58,534 [DEBUG][Timer1] con query sql:select user() to con:MySQLConnection [id=11, lastTime=1504164958534, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=true, threadId=2097, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3308, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.sqlengine.SQLJob:SQLJob.java:88)
2017-08-31 15:35:58,534 [DEBUG][$_NIOREACTOR-3-RW] release channel MySQLConnection [id=7, lastTime=1504164958515, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2165, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:35:58,535 [DEBUG][$_NIOREACTOR-3-RW] release channel MySQLConnection [id=11, lastTime=1504164958515, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=true, threadId=2097, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3308, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:36:08,534 [DEBUG][Timer0] con query sql:select user() to con:MySQLConnection [id=9, lastTime=1504164968534, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2172, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.sqlengine.SQLJob:SQLJob.java:88)
2017-08-31 15:36:08,534 [DEBUG][Timer0] con query sql:select user() to con:MySQLConnection [id=11, lastTime=1504164968534, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=true, threadId=2097, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3308, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.sqlengine.SQLJob:SQLJob.java:88)
2017-08-31 15:36:08,534 [DEBUG][$_NIOREACTOR-1-RW] release channel MySQLConnection [id=9, lastTime=1504164968515, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2172, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:36:08,534 [DEBUG][$_NIOREACTOR-3-RW] release channel MySQLConnection [id=11, lastTime=1504164968515, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=true, threadId=2097, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3308, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:36:18,535 [DEBUG][Timer0] con query sql:select user() to con:MySQLConnection [id=1, lastTime=1504164978535, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2168, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.sqlengine.SQLJob:SQLJob.java:88)
2017-08-31 15:36:18,536 [DEBUG][$_NIOREACTOR-1-RW] release channel MySQLConnection [id=1, lastTime=1504164978535, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2168, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:36:18,536 [DEBUG][Timer0] con query sql:select user() to con:MySQLConnection [id=11, lastTime=1504164978536, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=true, threadId=2097, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3308, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.sqlengine.SQLJob:SQLJob.java:88)
2017-08-31 15:36:18,537 [DEBUG][$_NIOREACTOR-3-RW] release channel MySQLConnection [id=11, lastTime=1504164978535, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=true, threadId=2097, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3308, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:36:28,534 [DEBUG][Timer0] con query sql:select user() to con:MySQLConnection [id=5, lastTime=1504164988534, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2169, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.sqlengine.SQLJob:SQLJob.java:88)
2017-08-31 15:36:28,535 [DEBUG][$_NIOREACTOR-1-RW] release channel MySQLConnection [id=5, lastTime=1504164988515, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2169, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:36:28,535 [DEBUG][Timer0] con query sql:select user() to con:MySQLConnection [id=11, lastTime=1504164988535, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=true, threadId=2097, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3308, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.sqlengine.SQLJob:SQLJob.java:88)
2017-08-31 15:36:28,536 [DEBUG][$_NIOREACTOR-3-RW] release channel MySQLConnection [id=11, lastTime=1504164988515, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=true, threadId=2097, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3308, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
2017-08-31 15:36:38,534 [DEBUG][Timer1] con query sql:select user() to con:MySQLConnection [id=4, lastTime=1504164998534, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2167, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.sqlengine.SQLJob:SQLJob.java:88)
2017-08-31 15:36:38,536 [DEBUG][Timer1] con query sql:select user() to con:MySQLConnection [id=11, lastTime=1504164998536, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=true, threadId=2097, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3308, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.sqlengine.SQLJob:SQLJob.java:88)
no ilde connection in pool,create new connection for hostM1 of schema db1 队列没有可用的连接的时候会异步的创建一个连接
连接后台真正完成 (io.mycat.net.AbstractConnection:AbstractConnection.java:606) 这是nio 第一次连接mysql之后会打印
我配置datahost的时候最小空闲连接数是10，在PhysicalDBPool #initSource方法会初始化，注意这里的handler是GetConnectionHandler，
这个handler成功创建连接connectionAcquired之后会打印logger.info("connected successfuly " + conn);
从connectionAcquired方法可以看到，直接conn.release了，会放到队列中，下次直接拿来用，达到了初始化的效果
然后mycatserver有个定时任务dataNodeConHeartBeatCheck会使用createByIdleLitte方法，定时的补偿连接数。
补偿的时候handler是NewConnectionRespHandler，
然后有很多的
release channel MySQLConnection [id=1, lastTime=1504164978535, user=root, schema=db2, old shema=db2, borrowed=true, fromSlaveDB=false, threadId=2168, charset=latin1, txIsolation=3, autocommit=true, attachment=null, respHandler=null, host=localhost, port=3307, statusSync=null, writeQueue=0, modifiedSQLExecuted=false] (io.mycat.backend.datasource.PhysicalDatasource:PhysicalDatasource.java:590)
这里就是调用了PhysicalDatasource#releaseChannel方法，这里并非真的释放，上面说过了，是放到队列中，如果队列满了，才会真正的回收，
因为使用连接玩之后都会放到队列，比如初始化的时候会放队列，比如心跳检测完之后也会放队列，所以这句话非常多，
只能说国产的质量真的。。。
什么都没干，应用都没连到mycat就打印一大堆日志，还有中英文。。。
然后只看到生产连接数，回收的呢。。连接数的id一直变大，但是这么少的呢，没日志。。。。