D:\SoftWares\apache-tomcat-8.0.44\bin\catalina.bat run
[2017-11-07 05:32:55,105] Artifact shugui:war exploded: Server is not connected. Deploy is not available.
Using CATALINA_BASE:   "C:\Users\Administrator\.IntelliJIdea2017.1\system\tomcat\Unnamed_shugui"
Using CATALINA_HOME:   "D:\SoftWares\apache-tomcat-8.0.44"
Using CATALINA_TMPDIR: "D:\SoftWares\apache-tomcat-8.0.44\temp"
Using JRE_HOME:        "C:\Java\jdk1.8.0_121"
Using CLASSPATH:       "D:\SoftWares\apache-tomcat-8.0.44\bin\bootstrap.jar;D:\SoftWares\apache-tomcat-8.0.44\bin\tomcat-juli.jar"
07-Nov-2017 17:32:56.038 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Server version:        Apache Tomcat/8.0.44
07-Nov-2017 17:32:56.038 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Server built:          May 10 2017 17:21:09 UTC
07-Nov-2017 17:32:56.038 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Server number:         8.0.44.0
07-Nov-2017 17:32:56.038 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log OS Name:               Windows 10
07-Nov-2017 17:32:56.038 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log OS Version:            10.0
07-Nov-2017 17:32:56.038 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Architecture:          amd64
07-Nov-2017 17:32:56.038 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Java Home:             C:\Java\jdk1.8.0_121\jre
07-Nov-2017 17:32:56.053 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log JVM Version:           1.8.0_121-b13
07-Nov-2017 17:32:56.053 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log JVM Vendor:            Oracle Corporation
07-Nov-2017 17:32:56.053 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log CATALINA_BASE:         C:\Users\Administrator\.IntelliJIdea2017.1\system\tomcat\Unnamed_shugui
07-Nov-2017 17:32:56.053 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log CATALINA_HOME:         D:\SoftWares\apache-tomcat-8.0.44
07-Nov-2017 17:32:56.053 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.util.logging.config.file=C:\Users\Administrator\.IntelliJIdea2017.1\system\tomcat\Unnamed_shugui\conf\logging.properties
07-Nov-2017 17:32:56.053 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.util.logging.manager=org.apache.juli.ClassLoaderLogManager
07-Nov-2017 17:32:56.053 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcom.sun.management.jmxremote=
07-Nov-2017 17:32:56.053 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcom.sun.management.jmxremote.port=1099
07-Nov-2017 17:32:56.053 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcom.sun.management.jmxremote.ssl=false
07-Nov-2017 17:32:56.053 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcom.sun.management.jmxremote.authenticate=false
07-Nov-2017 17:32:56.053 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.rmi.server.hostname=127.0.0.1
07-Nov-2017 17:32:56.053 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djdk.tls.ephemeralDHKeySize=2048
07-Nov-2017 17:32:56.053 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.protocol.handler.pkgs=org.apache.catalina.webresources
07-Nov-2017 17:32:56.053 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.endorsed.dirs=D:\SoftWares\apache-tomcat-8.0.44\endorsed
07-Nov-2017 17:32:56.053 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcatalina.base=C:\Users\Administrator\.IntelliJIdea2017.1\system\tomcat\Unnamed_shugui
07-Nov-2017 17:32:56.053 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcatalina.home=D:\SoftWares\apache-tomcat-8.0.44
07-Nov-2017 17:32:56.053 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.io.tmpdir=D:\SoftWares\apache-tomcat-8.0.44\temp
07-Nov-2017 17:32:56.053 信息 [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent Loaded APR based Apache Tomcat Native library 1.2.12 using APR version 1.5.2.
07-Nov-2017 17:32:56.053 信息 [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true].
07-Nov-2017 17:32:56.799 信息 [main] org.apache.catalina.core.AprLifecycleListener.initializeSSL OpenSSL successfully initialized (OpenSSL 1.0.2k  26 Jan 2017)
07-Nov-2017 17:32:56.924 信息 [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-apr-8080"]
07-Nov-2017 17:32:56.924 信息 [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["ajp-apr-8009"]
07-Nov-2017 17:32:56.924 信息 [main] org.apache.catalina.startup.Catalina.load Initialization processed in 1287 ms
07-Nov-2017 17:32:56.971 信息 [main] org.apache.catalina.core.StandardService.startInternal Starting service Catalina
07-Nov-2017 17:32:56.971 信息 [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet Engine: Apache Tomcat/8.0.44
07-Nov-2017 17:32:56.971 信息 [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-apr-8080"]
07-Nov-2017 17:32:56.987 信息 [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["ajp-apr-8009"]
07-Nov-2017 17:32:56.987 信息 [main] org.apache.catalina.startup.Catalina.start Server startup in 56 ms
Connected to server
[2017-11-07 05:32:57,369] Artifact shugui:war exploded: Artifact is being deployed, please wait...
07-Nov-2017 17:32:58.276 信息 [RMI TCP Connection(3)-127.0.0.1] org.apache.jasper.servlet.TldScanner.scanJars At least one JAR was scanned for TLDs yet contained no TLDs. Enable debug logging for this logger for a complete list of JARs that were scanned but no TLDs were found in them. Skipping unneeded JARs during scanning can improve startup time and JSP compilation time.
17-11-07 17:32:58.322 INFO [RMI TCP Connection(3)-127.0.0.1] Select SystemLog as Nutz.Log implement
17-11-07 17:32:58.329 INFO [RMI TCP Connection(3)-127.0.0.1] NutFilter[nutz] starting ...
17-11-07 17:32:58.343 DEBUG [RMI TCP Connection(3)-127.0.0.1] Locations count=3 time use 5ms
17-11-07 17:32:58.347 DEBUG [RMI TCP Connection(3)-127.0.0.1] Locations count=7 time use 4ms
17-11-07 17:32:58.423 DEBUG [RMI TCP Connection(3)-127.0.0.1] Using 95 castor for Castors
17-11-07 17:32:58.438 DEBUG [RMI TCP Connection(3)-127.0.0.1] Loading by class org.nutz.mvc.impl.NutLoading
17-11-07 17:32:58.440 INFO [RMI TCP Connection(3)-127.0.0.1] Nutz Version : 1.r.62 
17-11-07 17:32:58.442 INFO [RMI TCP Connection(3)-127.0.0.1] Nutz.Mvc[nutz] is initializing ...
17-11-07 17:32:58.442 DEBUG [RMI TCP Connection(3)-127.0.0.1] Web Container Information:
17-11-07 17:32:58.444 DEBUG [RMI TCP Connection(3)-127.0.0.1]  - Default Charset : GBK
17-11-07 17:32:58.444 DEBUG [RMI TCP Connection(3)-127.0.0.1]  - Current . path  : D:\SoftWares\apache-tomcat-8.0.44\bin\.
17-11-07 17:32:58.445 DEBUG [RMI TCP Connection(3)-127.0.0.1]  - Java Version    : 1.8.0_121
17-11-07 17:32:58.446 DEBUG [RMI TCP Connection(3)-127.0.0.1]  - File separator  : \
17-11-07 17:32:58.446 DEBUG [RMI TCP Connection(3)-127.0.0.1]  - Timezone        : Asia/Shanghai
17-11-07 17:32:58.446 DEBUG [RMI TCP Connection(3)-127.0.0.1]  - OS              : Windows 10 amd64
17-11-07 17:32:58.447 DEBUG [RMI TCP Connection(3)-127.0.0.1]  - ServerInfo      : Apache Tomcat/8.0.44
17-11-07 17:32:58.447 DEBUG [RMI TCP Connection(3)-127.0.0.1]  - Servlet API     : 3.1
17-11-07 17:32:58.447 DEBUG [RMI TCP Connection(3)-127.0.0.1]  - ContextPath     : 
17-11-07 17:32:58.447 DEBUG [RMI TCP Connection(3)-127.0.0.1]  - context.tempdir : C:\Users\Administrator\.IntelliJIdea2017.1\system\tomcat\Unnamed_shugui\work\Catalina\localhost\ROOT
17-11-07 17:32:58.448 DEBUG [RMI TCP Connection(3)-127.0.0.1]  - MainModule      : net.wendal.nutzbook.MainModule
17-11-07 17:32:58.449 DEBUG [RMI TCP Connection(3)-127.0.0.1] >> app.root = D:/Practices/shugui/target/shugui-1.0-SNAPSHOT
17-11-07 17:32:58.452 DEBUG [RMI TCP Connection(3)-127.0.0.1] @IocBy(type=org.nutz.mvc.ioc.provider.ComboIocProvider, args=["*js", "ioc/", "*anno", "net.wendal.nutzbook", "*tx", "*async"],init=[])
17-11-07 17:32:58.565 DEBUG [RMI TCP Connection(3)-127.0.0.1] Found 1 resource by src( ioc/ ) , regex( ^(.+[.])(js|json)$ )
17-11-07 17:32:58.565 DEBUG [RMI TCP Connection(3)-127.0.0.1] loading [dao.js]
17-11-07 17:32:58.578 DEBUG [RMI TCP Connection(3)-127.0.0.1] Loaded 2 bean define from path=[ioc/] --> [dataSource, dao]
17-11-07 17:32:58.591 DEBUG [RMI TCP Connection(3)-127.0.0.1] Found 4 resource by src( net/wendal/nutzbook/ ) , regex( ^.+[.]class$ )
17-11-07 17:32:58.603 DEBUG [RMI TCP Connection(3)-127.0.0.1] Found @IocBean : class net.wendal.nutzbook.module.UserModule
17-11-07 17:32:58.609 INFO [RMI TCP Connection(3)-127.0.0.1] Found 1 classes in 1 base-packages!
beans = ["userModule"]
17-11-07 17:32:58.613 DEBUG [RMI TCP Connection(3)-127.0.0.1] Loaded 5 bean define from reader --
[txREPEATABLE_READ, txSERIALIZABLE, txNONE, txREAD_UNCOMMITTED, txREAD_COMMITTED]
17-11-07 17:32:58.630 DEBUG [RMI TCP Connection(3)-127.0.0.1] Load AopConfigure for anno=org.nutz.aop.interceptor.async.Async by type=org.nutz.aop.interceptor.async.AsyncAopIocLoader
17-11-07 17:32:58.633 INFO [RMI TCP Connection(3)-127.0.0.1] NutIoc init begin ...
17-11-07 17:32:58.635 INFO [RMI TCP Connection(3)-127.0.0.1] ... NutIoc init complete
17-11-07 17:32:58.638 INFO [RMI TCP Connection(3)-127.0.0.1] Build URL mapping by org.nutz.mvc.impl.UrlMappingImpl ...
17-11-07 17:32:58.641 DEBUG [RMI TCP Connection(3)-127.0.0.1] @Views(DefaultViewMaker.class)
17-11-07 17:32:58.648 DEBUG [RMI TCP Connection(3)-127.0.0.1] @ChainBy(org.nutz.mvc.impl.NutActionChainMaker)
17-11-07 17:32:58.654 DEBUG [RMI TCP Connection(3)-127.0.0.1] module class location 'file:/D:/Practices/shugui/target/shugui-1.0-SNAPSHOT/WEB-INF/classes/'
17-11-07 17:32:58.655 DEBUG [RMI TCP Connection(3)-127.0.0.1]  > scan 'net.wendal.nutzbook'
17-11-07 17:32:58.656 DEBUG [RMI TCP Connection(3)-127.0.0.1] Found 4 resource by src( net/wendal/nutzbook/ ) , regex( ^.+[.]class$ )
17-11-07 17:32:58.657 DEBUG [RMI TCP Connection(3)-127.0.0.1]    >> add 'net.wendal.nutzbook.module.UserModule'
17-11-07 17:32:58.676 INFO [RMI TCP Connection(3)-127.0.0.1] Optional processor class not found, disabled : org.nutz.integration.shiro.NutShiroProcessor
17-11-07 17:32:58.687 INFO [RMI TCP Connection(3)-127.0.0.1] Optional processor class not found, disabled : org.nutz.plugins.validation.ValidationProcessor
17-11-07 17:32:58.705 DEBUG [RMI TCP Connection(3)-127.0.0.1]    '/user/count'               >> (UserModule.java:23).count            : int        | @Ok(json ) @Fail(http:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
17-11-07 17:32:58.705 INFO [RMI TCP Connection(3)-127.0.0.1] Found 1 module methods
17-11-07 17:32:58.705 DEBUG [RMI TCP Connection(3)-127.0.0.1] @Localization not define
17-11-07 17:32:58.706 INFO [RMI TCP Connection(3)-127.0.0.1] Setup application...
17-11-07 17:32:58.708 DEBUG [RMI TCP Connection(3)-127.0.0.1] Get 'dao'<interface org.nutz.dao.Dao>
17-11-07 17:32:58.709 DEBUG [RMI TCP Connection(3)-127.0.0.1] Get '$aop_async'<interface org.nutz.ioc.aop.config.AopConfigration>
17-11-07 17:32:58.709 DEBUG [RMI TCP Connection(3)-127.0.0.1] 	 >> Load definition name=$aop_async
17-11-07 17:32:58.711 DEBUG [RMI TCP Connection(3)-127.0.0.1] Found IocObject($aop_async) in AsyncAopIocLoader@1675970382
17-11-07 17:32:58.712 DEBUG [RMI TCP Connection(3)-127.0.0.1] 	 >> Make...'$aop_async'<interface org.nutz.ioc.aop.config.AopConfigration>
17-11-07 17:32:58.713 DEBUG [RMI TCP Connection(3)-127.0.0.1] Save object '$aop_async' to [app] 
17-11-07 17:32:58.717 DEBUG [RMI TCP Connection(3)-127.0.0.1] Load AopConfigure for anno=org.nutz.ioc.aop.Aop by type=org.nutz.ioc.aop.config.impl.AnnotationAopConfigration
17-11-07 17:32:58.718 DEBUG [RMI TCP Connection(3)-127.0.0.1] 	 >> Load definition name=dao
17-11-07 17:32:58.718 DEBUG [RMI TCP Connection(3)-127.0.0.1] Loading define for name=dao
17-11-07 17:32:58.721 DEBUG [RMI TCP Connection(3)-127.0.0.1] Found IocObject(dao) in JsonLoader(paths=[ioc/])
17-11-07 17:32:58.721 DEBUG [RMI TCP Connection(3)-127.0.0.1] 	 >> Make...'dao'<interface org.nutz.dao.Dao>
17-11-07 17:32:58.737 DEBUG [RMI TCP Connection(3)-127.0.0.1] Load class org.nutz.dao.impl.NutDao without AOP
17-11-07 17:32:58.738 DEBUG [RMI TCP Connection(3)-127.0.0.1] Save object 'dao' to [app] 
17-11-07 17:32:58.738 DEBUG [RMI TCP Connection(3)-127.0.0.1] Get 'dataSource'<>
17-11-07 17:32:58.738 DEBUG [RMI TCP Connection(3)-127.0.0.1] 	 >> Load definition name=dataSource
17-11-07 17:32:58.739 DEBUG [RMI TCP Connection(3)-127.0.0.1] Loading define for name=dataSource
17-11-07 17:32:58.752 DEBUG [RMI TCP Connection(3)-127.0.0.1] Found IocObject(dataSource) in JsonLoader(paths=[ioc/])
17-11-07 17:32:58.752 DEBUG [RMI TCP Connection(3)-127.0.0.1] 	 >> Make...'dataSource'<>
17-11-07 17:32:58.771 DEBUG [RMI TCP Connection(3)-127.0.0.1] Load class com.alibaba.druid.pool.DruidDataSource without AOP
17-11-07 17:32:58.772 DEBUG [RMI TCP Connection(3)-127.0.0.1] Save object 'dataSource' to [app] 
17-11-07 17:32:59.162 DEBUG [RMI TCP Connection(3)-127.0.0.1] Get 'dataSource'<>
07-Nov-2017 17:32:59.161 信息 [RMI TCP Connection(3)-127.0.0.1] com.alibaba.druid.pool.DruidDataSource.info {dataSource-1} inited
17-11-07 17:32:59.373 DEBUG [RMI TCP Connection(3)-127.0.0.1] Jdbcs init complete
17-11-07 17:32:59.373 INFO [RMI TCP Connection(3)-127.0.0.1] Get Connection from DataSource for JdbcExpert, if you lock at here, check your database server and configure
17-11-07 17:32:59.607 DEBUG [RMI TCP Connection(3)-127.0.0.1] select expert : org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert
17-11-07 17:32:59.612 DEBUG [RMI TCP Connection(3)-127.0.0.1] JDBC Driver --> mysql-connector-java-5.1.33 ( Revision: alexander.soklakov@oracle.com-20140908134200-8ukofe1izi0r2b63 )
17-11-07 17:32:59.613 DEBUG [RMI TCP Connection(3)-127.0.0.1] JDBC Name   --> MySQL Connector Java
17-11-07 17:32:59.613 DEBUG [RMI TCP Connection(3)-127.0.0.1] JDBC URL    --> jdbc:mysql://127.0.0.1:3306/nutzbook
17-11-07 17:32:59.619 DEBUG [RMI TCP Connection(3)-127.0.0.1] Mysql : character_set_client=utf8
17-11-07 17:32:59.619 DEBUG [RMI TCP Connection(3)-127.0.0.1] Mysql : character_set_connection=utf8
17-11-07 17:32:59.619 DEBUG [RMI TCP Connection(3)-127.0.0.1] Mysql : character_set_database=utf8
17-11-07 17:32:59.619 DEBUG [RMI TCP Connection(3)-127.0.0.1] Mysql : character_set_filesystem=binary
17-11-07 17:32:59.619 DEBUG [RMI TCP Connection(3)-127.0.0.1] Mysql : character_set_results=
17-11-07 17:32:59.619 DEBUG [RMI TCP Connection(3)-127.0.0.1] Mysql : character_set_server=utf8
17-11-07 17:32:59.620 DEBUG [RMI TCP Connection(3)-127.0.0.1] Mysql : character_set_system=utf8
17-11-07 17:32:59.620 DEBUG [RMI TCP Connection(3)-127.0.0.1] Mysql : character_sets_dir=C:\Program Files\MySQL\MySQL Server 5.6\share\charsets\
17-11-07 17:32:59.621 DEBUG [RMI TCP Connection(3)-127.0.0.1] Mysql : binlog_format=STATEMENT
17-11-07 17:32:59.621 DEBUG [RMI TCP Connection(3)-127.0.0.1] Mysql : database=nutzbook
17-11-07 17:32:59.622 DEBUG [RMI TCP Connection(3)-127.0.0.1] Mysql : user=root@localhost
17-11-07 17:32:59.635 DEBUG [RMI TCP Connection(3)-127.0.0.1] Database info --> MYSQL:[MySQL - 5.6.21-log]
17-11-07 17:32:59.639 DEBUG [RMI TCP Connection(3)-127.0.0.1] Found 4 resource by src( net/wendal/nutzbook/ ) , regex( ^.+[.]class$ )
17-11-07 17:32:59.684 DEBUG [RMI TCP Connection(3)-127.0.0.1] SELECT COUNT(*) FROM t_user 
17-11-07 17:32:59.686 INFO [RMI TCP Connection(3)-127.0.0.1] Nutz.Mvc[nutz] is up in 1238ms
[2017-11-07 05:32:59,705] Artifact shugui:war exploded: Artifact is deployed successfully
[2017-11-07 05:32:59,705] Artifact shugui:war exploded: Deploy took 2,336 milliseconds
07-Nov-2017 17:33:06.974 信息 [localhost-startStop-1] org.apache.catalina.startup.HostConfig.deployDirectory Deploying web application directory D:\SoftWares\apache-tomcat-8.0.44\webapps\manager
07-Nov-2017 17:33:07.021 信息 [localhost-startStop-1] org.apache.catalina.startup.HostConfig.deployDirectory Deployment of web application directory D:\SoftWares\apache-tomcat-8.0.44\webapps\manager has finished in 47 ms
17-11-07 17:33:26.987 DEBUG [http-apr-8080-exec-1] Search mapping for [GET] path=/nutzbook/user/count : NOT Action match