我导的是：beetl-2.2.27-all.jar
@wendal
日志：
四月 16, 2018 3:06:53 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: Server version: Apache Tomcat/8.5.9
四月 16, 2018 3:06:53 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: Server built: Dec 5 2016 20:18:12 UTC
四月 16, 2018 3:06:53 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: Server number: 8.5.9.0
四月 16, 2018 3:06:53 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: OS Name: Windows 7
四月 16, 2018 3:06:53 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: OS Version: 6.1
四月 16, 2018 3:06:53 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: Architecture: amd64
四月 16, 2018 3:06:53 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: Java Home: D:\MyEclipse2017CI\binary\com.sun.java.jdk8.win32.x86_64_1.8.0.v112\jre
四月 16, 2018 3:06:53 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: JVM Version: 1.8.0_112-b15
四月 16, 2018 3:06:53 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: JVM Vendor: Oracle Corporation
四月 16, 2018 3:06:53 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: CATALINA_BASE: E:\my2017项目\.metadata\.me_tcat85
四月 16, 2018 3:06:53 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: CATALINA_HOME: D:\MyEclipse2017CI\plugins\com.genuitec.eclipse.server.embedded.tomcat.core_13.0.0.me201612211440\tomcat85
四月 16, 2018 3:06:53 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: Command line argument: -Dcatalina.base=E:\my2017项目\.metadata\.me_tcat85
四月 16, 2018 3:06:53 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: Command line argument: -Dcatalina.home=D:\MyEclipse2017CI\plugins\com.genuitec.eclipse.server.embedded.tomcat.core_13.0.0.me201612211440\tomcat85
四月 16, 2018 3:06:53 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: Command line argument: -Dwtp.deploy=E:\my2017项目\.metadata\.me_tcat85\webapps
四月 16, 2018 3:06:53 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: Command line argument: -Djava.endorsed.dirs=D:\MyEclipse2017CI\plugins\com.genuitec.eclipse.server.embedded.tomcat.core_13.0.0.me201612211440\tomcat85\endorsed
四月 16, 2018 3:06:53 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: Command line argument: -Djava.library.path=D:\MyEclipse2017CI\binary\com.sun.java.jdk8.win32.x86_64_1.8.0.v112\bin;D:\MyEclipse2017CI\plugins\com.genuitec.eclipse.server.embedded.tomcat.core_13.0.0.me201612211440\tomcat85\bin
四月 16, 2018 3:06:53 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: Command line argument: -Dfile.encoding=UTF-8
四月 16, 2018 3:06:53 下午 org.apache.catalina.core.AprLifecycleListener lifecycleEvent
信息: The APR based Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: D:\MyEclipse2017CI\binary\com.sun.java.jdk8.win32.x86_64_1.8.0.v112\bin;D:\MyEclipse2017CI\plugins\com.genuitec.eclipse.server.embedded.tomcat.core_13.0.0.me201612211440\tomcat85\bin
四月 16, 2018 3:06:53 下午 org.apache.coyote.AbstractProtocol init
信息: Initializing ProtocolHandler ["http-nio-8080"]
四月 16, 2018 3:06:54 下午 org.apache.tomcat.util.net.NioSelectorPool getSharedSelector
信息: Using a shared selector for servlet write/read
四月 16, 2018 3:06:54 下午 org.apache.coyote.AbstractProtocol init
信息: Initializing ProtocolHandler ["ajp-nio-8009"]
四月 16, 2018 3:06:54 下午 org.apache.tomcat.util.net.NioSelectorPool getSharedSelector
信息: Using a shared selector for servlet write/read
四月 16, 2018 3:06:54 下午 org.apache.catalina.startup.Catalina load
信息: Initialization processed in 1030 ms
四月 16, 2018 3:06:54 下午 org.apache.catalina.core.StandardService startInternal
信息: Starting service Catalina
四月 16, 2018 3:06:54 下午 org.apache.catalina.core.StandardEngine startInternal
信息: Starting Servlet Engine: Apache Tomcat/8.5.9
四月 16, 2018 3:06:54 下午 org.apache.catalina.startup.HostConfig deployDirectory
信息: Deploying web application directory E:\my2017项目\.metadata\.me_tcat85\webapps\docs
四月 16, 2018 3:06:56 下午 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.
四月 16, 2018 3:06:56 下午 org.apache.catalina.startup.HostConfig deployDirectory
信息: Deployment of web application directory E:\my2017项目\.metadata\.me_tcat85\webapps\docs has finished in 2,599 ms
四月 16, 2018 3:06:56 下午 org.apache.catalina.startup.HostConfig deployDirectory
信息: Deploying web application directory E:\my2017项目\.metadata\.me_tcat85\webapps\examples
四月 16, 2018 3:06:59 下午 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.
四月 16, 2018 3:06:59 下午 org.apache.catalina.core.ApplicationContext log
信息: ContextListener: contextInitialized()
四月 16, 2018 3:06:59 下午 org.apache.catalina.core.ApplicationContext log
信息: SessionListener: contextInitialized()
四月 16, 2018 3:06:59 下午 org.apache.catalina.startup.HostConfig deployDirectory
信息: Deployment of web application directory E:\my2017项目\.metadata\.me_tcat85\webapps\examples has finished in 2,638 ms
四月 16, 2018 3:06:59 下午 org.apache.catalina.startup.HostConfig deployDirectory
信息: Deploying web application directory E:\my2017项目\.metadata\.me_tcat85\webapps\host-manager
四月 16, 2018 3:06:59 下午 org.apache.catalina.startup.HostConfig deployDirectory
信息: Deployment of web application directory E:\my2017项目\.metadata\.me_tcat85\webapps\host-manager has finished in 50 ms
四月 16, 2018 3:06:59 下午 org.apache.catalina.startup.HostConfig deployDirectory
信息: Deploying web application directory E:\my2017项目\.metadata\.me_tcat85\webapps\manager
四月 16, 2018 3:06:59 下午 org.apache.catalina.startup.HostConfig deployDirectory
信息: Deployment of web application directory E:\my2017项目\.metadata\.me_tcat85\webapps\manager has finished in 37 ms
四月 16, 2018 3:06:59 下午 org.apache.catalina.startup.HostConfig deployDirectory
信息: Deploying web application directory E:\my2017项目\.metadata\.me_tcat85\webapps\nutzbook
四月 16, 2018 3:07:03 下午 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.
SLF4J: Class path contains multiple SLF4J bindings.
SLF4J: Found binding in [jar:file:/E:/my2017项目/.metadata/.me_tcat85/webapps/nutzbook/WEB-INF/lib/slf4j-jdk14-1.7.7.jar!/org/slf4j/impl/StaticLoggerBinder.class]
SLF4J: Found binding in [jar:file:/E:/my2017项目/.metadata/.me_tcat85/webapps/nutzbook/WEB-INF/lib/slf4j-log4j12-1.7.7.jar!/org/slf4j/impl/StaticLoggerBinder.class]
SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation.
SLF4J: Actual binding is of type [org.slf4j.impl.JDK14LoggerFactory]
四月 16, 2018 3:07:03 下午 org.apache.catalina.core.ApplicationContext log
信息: Initializing Shiro environment
四月 16, 2018 3:07:03 下午 org.apache.shiro.web.env.EnvironmentLoader initEnvironment
信息: Starting Shiro environment initialization.
四月 16, 2018 3:07:04 下午 org.apache.shiro.config.ReflectionBuilder createNewInstance
信息: An instance with name 'authc' already exists. Redefining this object as a new instance of type org.nutz.integration.shiro.SimpleAuthenticationFilter
2018-04-16 15:07:04,315 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: false
2018-04-16 15:07:04,318 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'Boolean' value 'false' to type 'Boolean'
2018-04-16 15:07:04,318 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a Boolean
2018-04-16 15:07:04,321 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: 0
2018-04-16 15:07:04,322 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'Integer' value '0' to type 'Byte'
2018-04-16 15:07:04,322 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:171) DEBUG - Converted to Byte value '0'
2018-04-16 15:07:04,324 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value:
2018-04-16 15:07:04,324 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'Character' value ' ' to type 'Character'
2018-04-16 15:07:04,324 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a Character
2018-04-16 15:07:04,325 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: 0
2018-04-16 15:07:04,326 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'Integer' value '0' to type 'Double'
2018-04-16 15:07:04,327 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:171) DEBUG - Converted to Double value '0.0'
2018-04-16 15:07:04,328 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: 0
2018-04-16 15:07:04,329 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'Integer' value '0' to type 'Float'
2018-04-16 15:07:04,329 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:171) DEBUG - Converted to Float value '0.0'
2018-04-16 15:07:04,330 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: 0
2018-04-16 15:07:04,333 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'Integer' value '0' to type 'Integer'
2018-04-16 15:07:04,333 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a Integer
2018-04-16 15:07:04,334 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: 0
2018-04-16 15:07:04,335 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'Integer' value '0' to type 'Long'
2018-04-16 15:07:04,335 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:171) DEBUG - Converted to Long value '0'
2018-04-16 15:07:04,336 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: 0
2018-04-16 15:07:04,336 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'Integer' value '0' to type 'Short'
2018-04-16 15:07:04,336 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:171) DEBUG - Converted to Short value '0'
2018-04-16 15:07:04,338 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: 0.0
2018-04-16 15:07:04,338 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'BigDecimal' value '0.0' to type 'BigDecimal'
2018-04-16 15:07:04,338 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a BigDecimal
2018-04-16 15:07:04,339 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: 0
2018-04-16 15:07:04,339 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'BigInteger' value '0' to type 'BigInteger'
2018-04-16 15:07:04,339 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a BigInteger
2018-04-16 15:07:04,339 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: false
2018-04-16 15:07:04,340 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'Boolean' value 'false' to type 'Boolean'
2018-04-16 15:07:04,340 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a Boolean
2018-04-16 15:07:04,340 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: 0
2018-04-16 15:07:04,340 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'Integer' value '0' to type 'Byte'
2018-04-16 15:07:04,340 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:171) DEBUG - Converted to Byte value '0'
2018-04-16 15:07:04,340 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value:
2018-04-16 15:07:04,340 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'Character' value ' ' to type 'Character'
2018-04-16 15:07:04,341 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a Character
2018-04-16 15:07:04,341 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: 0
2018-04-16 15:07:04,341 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'Integer' value '0' to type 'Double'
2018-04-16 15:07:04,341 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:171) DEBUG - Converted to Double value '0.0'
2018-04-16 15:07:04,341 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: 0
2018-04-16 15:07:04,342 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'Integer' value '0' to type 'Float'
2018-04-16 15:07:04,342 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:171) DEBUG - Converted to Float value '0.0'
2018-04-16 15:07:04,342 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: 0
2018-04-16 15:07:04,342 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'Integer' value '0' to type 'Integer'
2018-04-16 15:07:04,342 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a Integer
2018-04-16 15:07:04,342 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: 0
2018-04-16 15:07:04,342 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'Integer' value '0' to type 'Long'
2018-04-16 15:07:04,343 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:171) DEBUG - Converted to Long value '0'
2018-04-16 15:07:04,343 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: 0
2018-04-16 15:07:04,343 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'Integer' value '0' to type 'Short'
2018-04-16 15:07:04,343 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:171) DEBUG - Converted to Short value '0'
2018-04-16 15:07:04,345 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value:
2018-04-16 15:07:04,345 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'String' value '' to type 'String'
2018-04-16 15:07:04,355 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: [Z@7c737b20
2018-04-16 15:07:04,355 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'boolean[]' value '[Z@7c737b20' to type 'boolean[]'
2018-04-16 15:07:04,355 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a boolean[]
2018-04-16 15:07:04,356 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: [B@2837735c
2018-04-16 15:07:04,356 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'byte[]' value '[B@2837735c' to type 'byte[]'
2018-04-16 15:07:04,356 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a byte[]
2018-04-16 15:07:04,356 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: [C@31e2e61
2018-04-16 15:07:04,356 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'char[]' value '[C@31e2e61' to type 'char[]'
2018-04-16 15:07:04,357 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a char[]
2018-04-16 15:07:04,357 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: [D@71346998
2018-04-16 15:07:04,357 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'double[]' value '[D@71346998' to type 'double[]'
2018-04-16 15:07:04,357 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a double[]
2018-04-16 15:07:04,358 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: [F@1679a6e5
2018-04-16 15:07:04,358 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'float[]' value '[F@1679a6e5' to type 'float[]'
2018-04-16 15:07:04,358 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a float[]
2018-04-16 15:07:04,358 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: [I@5c79ae5
2018-04-16 15:07:04,358 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'int[]' value '[I@5c79ae5' to type 'int[]'
2018-04-16 15:07:04,359 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a int[]
2018-04-16 15:07:04,359 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: [J@77d8d11a
2018-04-16 15:07:04,359 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'long[]' value '[J@77d8d11a' to type 'long[]'
2018-04-16 15:07:04,359 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a long[]
2018-04-16 15:07:04,359 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: [S@25f20ed0
2018-04-16 15:07:04,360 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'short[]' value '[S@25f20ed0' to type 'short[]'
2018-04-16 15:07:04,360 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a short[]
2018-04-16 15:07:04,360 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: [Ljava.math.BigDecimal;@7e67ca05
2018-04-16 15:07:04,360 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'BigDecimal[]' value '[Ljava.math.BigDecimal;@7e67ca05' to type 'BigDecimal[]'
2018-04-16 15:07:04,360 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a BigDecimal[]
2018-04-16 15:07:04,361 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: [Ljava.math.BigInteger;@76af3e6c
2018-04-16 15:07:04,361 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'BigInteger[]' value '[Ljava.math.BigInteger;@76af3e6c' to type 'BigInteger[]'
2018-04-16 15:07:04,361 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a BigInteger[]
2018-04-16 15:07:04,361 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: [Ljava.lang.Boolean;@369f773
2018-04-16 15:07:04,361 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'Boolean[]' value '[Ljava.lang.Boolean;@369f773' to type 'Boolean[]'
2018-04-16 15:07:04,362 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a Boolean[]
2018-04-16 15:07:04,362 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: [Ljava.lang.Byte;@387c96d0
2018-04-16 15:07:04,362 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'Byte[]' value '[Ljava.lang.Byte;@387c96d0' to type 'Byte[]'
2018-04-16 15:07:04,362 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a Byte[]
2018-04-16 15:07:04,362 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: [Ljava.lang.Character;@46996666
2018-04-16 15:07:04,362 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'Character[]' value '[Ljava.lang.Character;@46996666' to type 'Character[]'
2018-04-16 15:07:04,363 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a Character[]
2018-04-16 15:07:04,363 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: [Ljava.lang.Double;@51fb2663
2018-04-16 15:07:04,363 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'Double[]' value '[Ljava.lang.Double;@51fb2663' to type 'Double[]'
2018-04-16 15:07:04,363 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a Double[]
2018-04-16 15:07:04,363 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: [Ljava.lang.Float;@68be80ef
2018-04-16 15:07:04,363 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'Float[]' value '[Ljava.lang.Float;@68be80ef' to type 'Float[]'
2018-04-16 15:07:04,364 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a Float[]
2018-04-16 15:07:04,364 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: [Ljava.lang.Integer;@229745b
2018-04-16 15:07:04,364 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'Integer[]' value '[Ljava.lang.Integer;@229745b' to type 'Integer[]'
2018-04-16 15:07:04,364 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a Integer[]
2018-04-16 15:07:04,364 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: [Ljava.lang.Long;@30b8aa76
2018-04-16 15:07:04,365 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'Long[]' value '[Ljava.lang.Long;@30b8aa76' to type 'Long[]'
2018-04-16 15:07:04,365 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a Long[]
2018-04-16 15:07:04,365 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: [Ljava.lang.Short;@3f4fadc7
2018-04-16 15:07:04,365 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'Short[]' value '[Ljava.lang.Short;@3f4fadc7' to type 'Short[]'
2018-04-16 15:07:04,365 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a Short[]
2018-04-16 15:07:04,366 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: [Ljava.lang.String;@9f8d0c2
2018-04-16 15:07:04,366 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'String[]' value '[Ljava.lang.String;@9f8d0c2' to type 'String[]'
2018-04-16 15:07:04,366 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a String[]
2018-04-16 15:07:04,366 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: [Ljava.lang.Class;@13487780
2018-04-16 15:07:04,366 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'Class[]' value '[Ljava.lang.Class;@13487780' to type 'Class[]'
2018-04-16 15:07:04,366 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a Class[]
2018-04-16 15:07:04,367 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: [Ljava.util.Date;@51abc1bb
2018-04-16 15:07:04,367 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'Date[]' value '[Ljava.util.Date;@51abc1bb' to type 'Date[]'
2018-04-16 15:07:04,367 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a Date[]
2018-04-16 15:07:04,367 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: [Ljava.util.Calendar;@53405f8e
2018-04-16 15:07:04,368 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'Calendar[]' value '[Ljava.util.Calendar;@53405f8e' to type 'Calendar[]'
2018-04-16 15:07:04,368 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a Calendar[]
2018-04-16 15:07:04,368 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: [Ljava.io.File;@ccd69cf
2018-04-16 15:07:04,368 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'java.io.File[]' value '[Ljava.io.File;@ccd69cf' to type 'java.io.File[]'
2018-04-16 15:07:04,368 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a java.io.File[]
2018-04-16 15:07:04,369 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: [Ljava.sql.Date;@4e52fbf0
2018-04-16 15:07:04,369 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'java.sql.Date[]' value '[Ljava.sql.Date;@4e52fbf0' to type 'java.sql.Date[]'
2018-04-16 15:07:04,369 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a java.sql.Date[]
2018-04-16 15:07:04,369 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: [Ljava.sql.Time;@cc7e7df
2018-04-16 15:07:04,370 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'java.sql.Time[]' value '[Ljava.sql.Time;@cc7e7df' to type 'java.sql.Time[]'
2018-04-16 15:07:04,370 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a java.sql.Time[]
2018-04-16 15:07:04,370 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: [Ljava.sql.Timestamp;@3195b4a9
2018-04-16 15:07:04,370 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'java.sql.Timestamp[]' value '[Ljava.sql.Timestamp;@3195b4a9' to type 'java.sql.Timestamp[]'
2018-04-16 15:07:04,370 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a java.sql.Timestamp[]
2018-04-16 15:07:04,371 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:353) DEBUG - Setting default value: [Ljava.net.URL;@72cfec4e
2018-04-16 15:07:04,371 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'java.net.URL[]' value '[Ljava.net.URL;@72cfec4e' to type 'java.net.URL[]'
2018-04-16 15:07:04,371 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:162) DEBUG - No conversion required, value is already a java.net.URL[]
2018-04-16 15:07:04,383 org.apache.commons.beanutils.ConvertUtilsBean.convert(ConvertUtilsBean.java:481) DEBUG - Convert string 'classpath:ehcache.xml' to class 'java.lang.String'
2018-04-16 15:07:04,383 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'String' value 'classpath:ehcache.xml' to type 'String'
四月 16, 2018 3:07:04 下午 org.apache.shiro.cache.ehcache.EhCacheManager getCache
信息: Cache with name 'nutzdao_realm.authorizationCache' does not yet exist. Creating now.
四月 16, 2018 3:07:04 下午 org.apache.shiro.cache.ehcache.EhCacheManager getCache
信息: Added EhCache named [nutzdao_realm.authorizationCache]
2018-04-16 15:07:04,786 org.apache.commons.beanutils.ConvertUtilsBean.convert(ConvertUtilsBean.java:481) DEBUG - Convert string '/user/login' to class 'java.lang.String'
2018-04-16 15:07:04,786 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'String' value '/user/login' to type 'String'
2018-04-16 15:07:04,789 org.apache.commons.beanutils.ConvertUtilsBean.convert(ConvertUtilsBean.java:481) DEBUG - Convert string '/user/login' to class 'java.lang.String'
2018-04-16 15:07:04,790 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:140) DEBUG - Converting 'String' value '/user/login' to type 'String'
四月 16, 2018 3:07:04 下午 org.apache.shiro.web.env.EnvironmentLoader initEnvironment
信息: Shiro environment initialized in 947 ms.
2018-04-16 15:07:04,851 org.nutz.mvc.NutFilter._init(NutFilter.java:85) INFO - NutFilter[nutz] starting ...
2018-04-16 15:07:04,885 org.nutz.resource.Scans.printLocations(Scans.java:521) DEBUG - Locations count=5 time use 19ms
2018-04-16 15:07:04,942 org.nutz.resource.Scans.printLocations(Scans.java:521) DEBUG - Locations count=43 time use 55ms
2018-04-16 15:07:05,052 org.nutz.castor.Castors.reload(Castors.java:115) DEBUG - Using 95 castor for Castors
2018-04-16 15:07:05,104 org.nutz.mvc.config.AbstractNutConfig.createLoading(AbstractNutConfig.java:59) DEBUG - Loading by class org.nutz.mvc.impl.NutLoading
2018-04-16 15:07:05,108 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:55) INFO - Nutz Version : 1.r.62
2018-04-16 15:07:05,109 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:56) INFO - Nutz.Mvc[nutz] is initializing ...
2018-04-16 15:07:05,109 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:60) DEBUG - Web Container Information:
2018-04-16 15:07:05,110 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:61) DEBUG - - Default Charset : UTF-8
2018-04-16 15:07:05,111 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:62) DEBUG - - Current . path : D:\MyEclipse2017CI\.
2018-04-16 15:07:05,111 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:63) DEBUG - - Java Version : 1.8.0_112
2018-04-16 15:07:05,111 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:64) DEBUG - - File separator : \
2018-04-16 15:07:05,111 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:65) DEBUG - - Timezone : Asia/Shanghai
2018-04-16 15:07:05,113 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:66) DEBUG - - OS : Windows 7 amd64
2018-04-16 15:07:05,113 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:67) DEBUG - - ServerInfo : Apache Tomcat/8.5.9
2018-04-16 15:07:05,113 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:68) DEBUG - - Servlet API : 3.1
2018-04-16 15:07:05,114 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:73) DEBUG - - ContextPath : /nutzbook
2018-04-16 15:07:05,115 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:74) DEBUG - - context.tempdir : E:\my2017项目\.metadata\.me_tcat85\work\Catalina\localhost\nutzbook
2018-04-16 15:07:05,115 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:75) DEBUG - - MainModule : net.wendal.nutzbook.MainModule
2018-04-16 15:07:05,117 org.nutz.mvc.impl.NutLoading.createContext(NutLoading.java:235) DEBUG - >> app.root = E:/my2017项目/.metadata/.me_tcat85/webapps/nutzbook
2018-04-16 15:07:05,127 org.nutz.mvc.impl.NutLoading.createIoc(NutLoading.java:376) DEBUG - @IocBy(type=org.nutz.mvc.ioc.provider.ComboIocProvider, args=["*js", "ioc/", "*anno", "net.wendal.nutzbook", "*tx", "*quartz", "*jedis"],init=[])
2018-04-16 15:07:05,209 org.nutz.resource.Scans.scan(Scans.java:274) DEBUG - Found 3 resource by src( ioc/ ) , regex( ^(.+[.])(js|json)$ )
2018-04-16 15:07:05,210 org.nutz.ioc.loader.json.JsonLoader.<init>(JsonLoader.java:49) DEBUG - loading [dao.js]
2018-04-16 15:07:05,217 org.nutz.ioc.loader.json.JsonLoader.<init>(JsonLoader.java:49) DEBUG - loading [ehcache.js]
2018-04-16 15:07:05,218 org.nutz.ioc.loader.json.JsonLoader.<init>(JsonLoader.java:49) DEBUG - loading [mail.js]
2018-04-16 15:07:05,219 org.nutz.ioc.loader.json.JsonLoader.<init>(JsonLoader.java:57) DEBUG - Loaded 8 bean define from path=[ioc/] --> [dao, cacheProvider, emailAuthenticator, htmlEmail, cacheExecutor, conf, dataSource, cacheManager]
2018-04-16 15:07:05,242 org.nutz.resource.Scans.scan(Scans.java:274) DEBUG - Found 24 resource by src( net/wendal/nutzbook/ ) , regex( ^.+[.]class$ )
2018-04-16 15:07:05,291 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:76) DEBUG - Found @IocBean : class net.wendal.nutzbook.module.AuthorityModule
2018-04-16 15:07:05,324 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:76) DEBUG - Found @IocBean : class net.wendal.nutzbook.module.CaptchaModule
2018-04-16 15:07:05,329 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:76) DEBUG - Found @IocBean : class net.wendal.nutzbook.module.UserModule
2018-04-16 15:07:05,347 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:76) DEBUG - Found @IocBean : class net.wendal.nutzbook.module.UserProfileModule
2018-04-16 15:07:05,354 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:76) DEBUG - Found @IocBean : class net.wendal.nutzbook.quartz.job.CleanNonActiveUserJob
2018-04-16 15:07:05,358 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:76) DEBUG - Found @IocBean : class net.wendal.nutzbook.service.AuthorityServiceImpl
2018-04-16 15:07:05,359 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:76) DEBUG - Found @IocBean : class net.wendal.nutzbook.service.EmailServiceImpl
2018-04-16 15:07:05,361 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:76) DEBUG - Found @IocBean : class net.wendal.nutzbook.service.UserService
2018-04-16 15:07:05,367 org.nutz.ioc.loader.annotation.AnnotationIocLoader.<init>(AnnotationIocLoader.java:52) INFO - Found 8 classes in 1 base-packages!
beans = ["cleanNonActiveUserJob", "authorityService", "userProfileModule", "captchaModule", "authorityModule", "userModule", "emailService", "userService"]
2018-04-16 15:07:05,374 org.nutz.ioc.loader.json.JsonLoader.<init>(JsonLoader.java:40) DEBUG - Loaded 5 bean define from reader --
[txREPEATABLE_READ, txSERIALIZABLE, txNONE, txREAD_UNCOMMITTED, txREAD_COMMITTED]
2018-04-16 15:07:05,377 org.nutz.ioc.loader.combo.ComboIocLoader.createIocLoader(ComboIocLoader.java:110) DEBUG - found quartz -- org.nutz.integration.quartz.QuartzIocLoader
2018-04-16 15:07:05,382 org.nutz.ioc.loader.json.JsonLoader.<init>(JsonLoader.java:57) DEBUG - Loaded 0 bean define from path=[] --> []
2018-04-16 15:07:05,385 org.nutz.ioc.loader.combo.ComboIocLoader.createIocLoader(ComboIocLoader.java:110) DEBUG - found jedis -- org.nutz.integration.jedis.JedisIocLoader
2018-04-16 15:07:05,391 org.nutz.resource.Scans.scan(Scans.java:274) DEBUG - Found 2 resource by src( org/nutz/integration/jedis/jedis.js ) , regex( ^(.+[.])(js|json)$ )
2018-04-16 15:07:05,392 org.nutz.ioc.loader.json.JsonLoader.<init>(JsonLoader.java:49) DEBUG - loading [org/nutz/integration/jedis/jedis.js]
2018-04-16 15:07:05,393 org.nutz.ioc.loader.json.JsonLoader.<init>(JsonLoader.java:49) DEBUG - loading [org/nutz/integration/jedis/jedis.js]
2018-04-16 15:07:05,394 org.nutz.ioc.loader.json.JsonLoader.<init>(JsonLoader.java:57) DEBUG - Loaded 9 bean define from path=[org/nutz/integration/jedis/jedis.js] --> [redisService, jedisCluster, jedisClusterNodes, jedisClusterWrapper, pubSubService, jedisPoolConfig, jedisPool, jedisAgent, redis]
2018-04-16 15:07:05,399 org.nutz.ioc.impl.NutIoc.<init>(NutIoc.java:98) INFO - NutIoc init begin ...
2018-04-16 15:07:05,403 org.nutz.ioc.impl.NutIoc.<init>(NutIoc.java:115) INFO - ... NutIoc init complete
2018-04-16 15:07:05,407 org.nutz.mvc.impl.NutLoading.evalUrlMapping(NutLoading.java:159) INFO - Build URL mapping by org.nutz.mvc.impl.UrlMappingImpl ...
2018-04-16 15:07:05,417 org.beetl.ext.nutz.BeetlViewMaker.init(BeetlViewMaker.java:59) DEBUG - beetl init ....
2018-04-16 15:07:05,422 org.beetl.ext.nutz.BeetlViewMaker.init(BeetlViewMaker.java:64) DEBUG - found beetl.properties, loading ...
2018-04-16 15:07:05,422 org.beetl.ext.nutz.BeetlViewMaker.init(BeetlViewMaker.java:79) DEBUG - no custom DIRECT_BYTE_OUTPUT found , set to true
2018-04-16 15:07:05,537 org.beetl.ext.nutz.BeetlViewMaker.init(BeetlViewMaker.java:92) DEBUG - beetl init complete
2018-04-16 15:07:05,539 org.nutz.mvc.impl.NutLoading.createViewMakers(NutLoading.java:366) DEBUG - @Views(BeetlViewMaker.class,DefaultViewMaker.class)
2018-04-16 15:07:05,552 org.nutz.resource.Scans.scan(Scans.java:274) DEBUG - Found 1 resource by src( mvc/nutzbook-mvc-chain.js ) , regex( ^(.+[.])(js|json)$ )
2018-04-16 15:07:05,558 org.nutz.mvc.impl.chainconfig.JsonActionChainMakerConfiguretion.<init>(JsonActionChainMakerConfiguretion.java:37) DEBUG - ActionChain Config:
{
"default": {
"ps": ["net.wendal.nutzbook.mvc.LogTimeProcessor", "org.nutz.mvc.impl.processor.UpdateRequestAttributesProcessor", "org.nutz.mvc.impl.processor.EncodingProcessor", "org.nutz.mvc.impl.processor.ModuleProcessor", "org.nutz.integration.shiro.NutShiroProcessor", "org.nutz.mvc.impl.processor.ActionFiltersProcessor", "org.nutz.mvc.impl.processor.AdaptorProcessor", "org.nutz.mvc.impl.processor.MethodInvokeProcessor", "org.nutz.mvc.impl.processor.ViewProcessor"],
"error": "org.nutz.mvc.impl.processor.FailProcessor"
}
}
2018-04-16 15:07:05,558 org.nutz.mvc.impl.NutLoading.createChainMaker(NutLoading.java:263) DEBUG - @ChainBy(org.nutz.mvc.impl.NutActionChainMaker)
2018-04-16 15:07:05,562 org.nutz.mvc.impl.Loadings.scanModules(Loadings.java:154) DEBUG - module class location 'file:/E:/my2017项目/.metadata/.me_tcat85/webapps/nutzbook/WEB-INF/classes/'
2018-04-16 15:07:05,562 org.nutz.mvc.impl.Loadings.scanModuleInPackage(Loadings.java:184) DEBUG - > scan 'net.wendal.nutzbook'
2018-04-16 15:07:05,573 org.nutz.resource.Scans.scan(Scans.java:274) DEBUG - Found 24 resource by src( net/wendal/nutzbook/ ) , regex( ^.+[.]class$ )
2018-04-16 15:07:05,575 org.nutz.mvc.impl.Loadings.checkModule(Loadings.java:199) DEBUG - >> add 'net.wendal.nutzbook.module.AuthorityModule'
2018-04-16 15:07:05,575 org.nutz.mvc.impl.Loadings.checkModule(Loadings.java:199) DEBUG - >> add 'net.wendal.nutzbook.module.BeetlTemplateModule'
2018-04-16 15:07:05,576 org.nutz.mvc.impl.Loadings.checkModule(Loadings.java:199) DEBUG - >> add 'net.wendal.nutzbook.module.CaptchaModule'
2018-04-16 15:07:05,576 org.nutz.mvc.impl.Loadings.checkModule(Loadings.java:199) DEBUG - >> add 'net.wendal.nutzbook.module.UserModule'
2018-04-16 15:07:05,576 org.nutz.mvc.impl.Loadings.checkModule(Loadings.java:199) DEBUG - >> add 'net.wendal.nutzbook.module.UserProfileModule'
2018-04-16 15:07:05,704 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/profile/' >> (UserProfileModule.java:148).index : UserProfile | @Ok(jsp:jsp.user.profile) @Fail(jsp:jsp.500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,707 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/profile/get' >> (UserProfileModule.java:58).get : UserProfile | @Ok(json:full) @Fail(jsp:jsp.500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,723 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/profile/update' >> (UserProfileModule.java:73).update : void | @Ok(void ) @Fail(jsp:jsp.500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,746 org.nutz.filepool.NutFilePool.<init>(NutFilePool.java:23) INFO - Init file-pool by: E:/my2017项目/.metadata/.me_tcat85/webapps/nutzbook/WEB-INF/tmp/user_avatar [20000]
2018-04-16 15:07:05,749 org.nutz.filepool.NutFilePool.<init>(NutFilePool.java:37) DEBUG - file-pool.home: 'E:\my2017项目\.metadata\.me_tcat85\webapps\nutzbook\WEB-INF\tmp\user_avatar'
2018-04-16 15:07:05,751 org.nutz.filepool.NutFilePool.<init>(NutFilePool.java:66) INFO - file-pool.cursor: 0
2018-04-16 15:07:05,761 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/profile/avatar' >> (UserProfileModule.java:106).uploadAvatar : void | @Ok(>>:/user/profile) @Fail(jsp:jsp.500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,764 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/profile/avatar' >> (UserProfileModule.java:136).readAvatar : Object | @Ok(raw:jpg) @Fail(jsp:jsp.500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,765 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/profile/active/mail' >> (UserProfileModule.java:157).activeMail : Object | @Ok(json:full) @Fail(jsp:jsp.500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,768 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/profile/active/mail' >> (UserProfileModule.java:184).activeMailCallback : String | @Ok(raw ) @Fail(jsp:jsp.500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,770 org.nutz.mvc.impl.processor.ModuleProcessor.init(ModuleProcessor.java:61) INFO - Create Module obj without Ioc --> class net.wendal.nutzbook.module.BeetlTemplateModule
2018-04-16 15:07:05,777 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/hello' >> (BeetlTemplateModule.java:17).hello : Object | @Ok(beetl:hello.html) @Fail(void ) | by 0 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,785 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/' >> (UserModule.java:124).index : void | @Ok(jsp:jsp.user.login) @Fail(http:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,874 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/add' >> (UserModule.java:76).add : Object | @Ok(json:{locked:'password|salt',ignoreNull:true}) @Fail(http:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,875 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/count' >> (UserModule.java:42).count : int | @Ok(json:{locked:'password|salt',ignoreNull:true}) @Fail(http:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,878 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/update' >> (UserModule.java:88).update : Object | @Ok(json:{locked:'password|salt',ignoreNull:true}) @Fail(http:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,879 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/delete' >> (UserModule.java:99).delete : Object | @Ok(json:{locked:'password|salt',ignoreNull:true}) @Fail(http:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,880 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/list' >> (UserModule.java:130).list : void | @Ok(jsp:jsp.user.list) @Fail(http:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,889 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/query' >> (UserModule.java:111).query : Object | @Ok(json:{locked:'password|salt',ignoreNull:true}) @Fail(http:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,890 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/login' >> (UserModule.java:52).login : Object | @Ok(json:{locked:'password|salt',ignoreNull:true}) @Fail(http:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,891 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/logout' >> (UserModule.java:70).logout : void | @Ok(>>:/user/) @Fail(http:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,893 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/login' >> (UserModule.java:135).loginPage : void | @Ok(jsp:jsp.user.login) @Fail(http:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,895 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/captcha/next' >> (CaptchaModule.java:23).next : BufferedImage | @Ok(raw:png) @Fail(jsp:jsp.500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,898 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/admin/authority/permissions' >> (AuthorityModule.java:72).permissions : Object | @Ok(json ) @Fail(jsp:jsp.500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,900 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/admin/authority/roles' >> (AuthorityModule.java:62).roles : Object | @Ok(json ) @Fail(jsp:jsp.500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,902 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/admin/authority/users' >> (AuthorityModule.java:52).users : Object | @Ok(json:{locked:'password|salt',ignoreNull:true}) @Fail(jsp:jsp.500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,904 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/admin/authority/permission/add' >> (AuthorityModule.java:266).addPermission : void | @Ok(void ) @Fail(jsp:jsp.500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,905 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/admin/authority/role/add' >> (AuthorityModule.java:177).addRole : void | @Ok(void ) @Fail(jsp:jsp.500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,906 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/admin/authority/user/update' >> (AuthorityModule.java:91).updateUser : void | @Ok(void ) @Fail(jsp:jsp.500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,908 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/admin/authority/user/fetch/role' >> (AuthorityModule.java:154).fetchUserRoles : Object | @Ok(json ) @Fail(jsp:jsp.500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,909 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/admin/authority/role/delete' >> (AuthorityModule.java:190).delRole : void | @Ok(void ) @Fail(jsp:jsp.500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,910 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/admin/authority/permission/update' >> (AuthorityModule.java:294).updateRole : void | @Ok(void ) @Fail(jsp:jsp.500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,911 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/admin/authority/role/update' >> (AuthorityModule.java:210).updateRole : void | @Ok(void ) @Fail(jsp:jsp.500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,912 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/admin/authority/permission/delete' >> (AuthorityModule.java:280).delPermission : void | @Ok(void ) @Fail(jsp:jsp.500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,913 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/admin/authority/user/fetch/permission' >> (AuthorityModule.java:135).fetchUserPermissions : Object | @Ok(json ) @Fail(jsp:jsp.500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,915 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/admin/authority/role/fetch' >> (AuthorityModule.java:243).fetchRolePermissions : Object | @Ok(json ) @Fail(jsp:jsp.500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2018-04-16 15:07:05,915 org.nutz.mvc.impl.NutLoading.evalUrlMapping(NutLoading.java:217) INFO - Found 32 module methods
2018-04-16 15:07:05,915 org.nutz.mvc.impl.NutLoading.evalLocalization(NutLoading.java:303) DEBUG - Localization: org.nutz.mvc.impl.NutMessageLoader('msg/') dft<zh-CN>
2018-04-16 15:07:05,922 org.nutz.resource.Scans.scan(Scans.java:274) DEBUG - Found 1 resource by src( msg/ ) , regex( ^.+[.]properties$ )
2018-04-16 15:07:05,923 org.nutz.mvc.impl.NutMessageLoader.load(NutMessageLoader.java:27) DEBUG - Load Messages in 1 resource : [[File[E:\my2017项目\.metadata\.me_tcat85\webapps\nutzbook\WEB-INF\classes\msg\zh-CN\user.properties]]]
2018-04-16 15:07:05,925 org.nutz.mvc.impl.NutMessageLoader.load(NutMessageLoader.java:95) DEBUG - Message Loaded, size = 2
2018-04-16 15:07:05,931 org.nutz.mvc.impl.NutLoading.createSessionProvider(NutLoading.java:410) INFO - SessionBy --> org.nutz.integration.shiro.ShiroSessionProvider@3522d9a4
2018-04-16 15:07:05,931 org.nutz.mvc.impl.NutLoading.evalSetup(NutLoading.java:271) INFO - Setup application...
2018-04-16 15:07:05,943 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'dao'<interface org.nutz.dao.Dao>
2018-04-16 15:07:05,946 org.nutz.ioc.aop.SimpleAopMaker.<init>(SimpleAopMaker.java:79) DEBUG - Load AopConfigure for anno=org.nutz.ioc.aop.Aop by type=org.nutz.ioc.aop.config.impl.AnnotationAopConfigration
2018-04-16 15:07:05,948 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - >> Load definition name=dao
2018-04-16 15:07:05,948 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=dao
2018-04-16 15:07:05,976 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:161) DEBUG - Found IocObject(dao) in JsonLoader(paths=[ioc/])
2018-04-16 15:07:05,977 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - >> Make...'dao'<interface org.nutz.dao.Dao>
2018-04-16 15:07:05,993 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class org.nutz.dao.impl.NutDao without AOP
2018-04-16 15:07:05,994 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'dao' to [app]
2018-04-16 15:07:05,996 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'dataSource'<>
2018-04-16 15:07:05,996 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - >> Load definition name=dataSource
2018-04-16 15:07:05,997 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=dataSource
2018-04-16 15:07:06,015 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:161) DEBUG - Found IocObject(dataSource) in JsonLoader(paths=[ioc/])
2018-04-16 15:07:06,015 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - >> Make...'dataSource'<>
2018-04-16 15:07:06,043 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class com.alibaba.druid.pool.DruidDataSource without AOP
2018-04-16 15:07:06,044 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'dataSource' to [app]
2018-04-16 15:07:06,046 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'conf'<>
2018-04-16 15:07:06,046 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - >> Load definition name=conf
2018-04-16 15:07:06,046 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=conf
2018-04-16 15:07:06,046 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:161) DEBUG - Found IocObject(conf) in JsonLoader(paths=[ioc/])
2018-04-16 15:07:06,047 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - >> Make...'conf'<>
2018-04-16 15:07:06,047 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class org.nutz.ioc.impl.PropertiesProxy without AOP
2018-04-16 15:07:06,048 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'conf' to [app]
2018-04-16 15:07:06,120 org.nutz.resource.Scans.scan(Scans.java:274) DEBUG - Found 3 resource by src( custom/ ) , regex( ^.+[.]properties$ )
2018-04-16 15:07:06,120 org.nutz.ioc.impl.PropertiesProxy.setPaths(PropertiesProxy.java:113) DEBUG - load properties from File[E:\my2017项目\.metadata\.me_tcat85\webapps\nutzbook\WEB-INF\classes\custom\cron.properties]
2018-04-16 15:07:06,121 org.nutz.ioc.impl.PropertiesProxy.setPaths(PropertiesProxy.java:113) DEBUG - load properties from File[E:\my2017项目\.metadata\.me_tcat85\webapps\nutzbook\WEB-INF\classes\custom\db.properties]
2018-04-16 15:07:06,122 org.nutz.ioc.impl.PropertiesProxy.setPaths(PropertiesProxy.java:113) DEBUG - load properties from File[E:\my2017项目\.metadata\.me_tcat85\webapps\nutzbook\WEB-INF\classes\custom\mail.properties]
2018-04-16 15:07:06,527 com.alibaba.druid.pool.DruidDataSource.init(DruidDataSource.java:715) INFO - {dataSource-1} inited
2018-04-16 15:07:06,528 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'dataSource'<>
2018-04-16 15:07:06,795 org.nutz.dao.jdbc.Jdbcs.<clinit>(Jdbcs.java:90) DEBUG - Jdbcs init complete
2018-04-16 15:07:06,795 org.nutz.dao.jdbc.Jdbcs.getExpert(Jdbcs.java:103) INFO - Get Connection from DataSource for JdbcExpert, if you lock at here, check your database server and configure
2018-04-16 15:07:07,156 org.nutz.dao.impl.DaoSupport.setDataSource(DaoSupport.java:188) DEBUG - select expert : org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert
2018-04-16 15:07:07,163 org.nutz.dao.impl.DaoSupport$1.invoke(DaoSupport.java:199) DEBUG - JDBC Driver --> mysql-connector-java-5.1.37 ( Revision: 09940f05b4c98150f352e787a2549f11a2e9da93 )
2018-04-16 15:07:07,163 org.nutz.dao.impl.DaoSupport$1.invoke(DaoSupport.java:200) DEBUG - JDBC Name --> MySQL Connector Java
2018-04-16 15:07:07,164 org.nutz.dao.impl.DaoSupport$1.invoke(DaoSupport.java:202) DEBUG - JDBC URL --> jdbc:mysql://127.0.0.1:3306/nutzbook?useUnicode=true&characterEncoding=UTF-8
2018-04-16 15:07:07,266 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:206) DEBUG - Mysql : character_set_client=utf8
2018-04-16 15:07:07,266 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:206) DEBUG - Mysql : character_set_connection=utf8
2018-04-16 15:07:07,267 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:206) DEBUG - Mysql : character_set_database=utf8
2018-04-16 15:07:07,267 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:206) DEBUG - Mysql : character_set_filesystem=binary
2018-04-16 15:07:07,267 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:206) DEBUG - Mysql : character_set_results=
2018-04-16 15:07:07,267 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:206) DEBUG - Mysql : character_set_server=utf8
2018-04-16 15:07:07,267 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:206) DEBUG - Mysql : character_set_system=utf8
2018-04-16 15:07:07,267 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:206) DEBUG - Mysql : character_sets_dir=D:\mysql\share\charsets\
2018-04-16 15:07:07,270 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:213) DEBUG - Mysql : binlog_format=STATEMENT
2018-04-16 15:07:07,271 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:220) DEBUG - Mysql : database=nutzbook
2018-04-16 15:07:07,273 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:226) DEBUG - Mysql : user=root@localhost
2018-04-16 15:07:07,313 org.nutz.dao.impl.DaoSupport.setDataSource(DaoSupport.java:221) DEBUG - Database info --> MYSQL:[MySQL - 5.5.56]
2018-04-16 15:07:07,316 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'cacheExecutor'<>
2018-04-16 15:07:07,317 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - >> Load definition name=cacheExecutor
2018-04-16 15:07:07,317 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=cacheExecutor
2018-04-16 15:07:07,319 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:161) DEBUG - Found IocObject(cacheExecutor) in JsonLoader(paths=[ioc/])
2018-04-16 15:07:07,319 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - >> Make...'cacheExecutor'<>
2018-04-16 15:07:07,320 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class org.nutz.plugins.cache.dao.DaoCacheInterceptor without AOP
2018-04-16 15:07:07,321 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'cacheExecutor' to [app]
2018-04-16 15:07:07,339 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'cacheProvider'<>
2018-04-16 15:07:07,339 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - >> Load definition name=cacheProvider
2018-04-16 15:07:07,339 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=cacheProvider
2018-04-16 15:07:07,341 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:161) DEBUG - Found IocObject(cacheProvider) in JsonLoader(paths=[ioc/])
2018-04-16 15:07:07,341 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - >> Make...'cacheProvider'<>
2018-04-16 15:07:07,343 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class org.nutz.plugins.cache.dao.impl.provider.EhcacheDaoCacheProvider without AOP
2018-04-16 15:07:07,343 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'cacheProvider' to [app]
2018-04-16 15:07:07,352 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'cacheManager'<>
2018-04-16 15:07:07,352 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - >> Load definition name=cacheManager
2018-04-16 15:07:07,352 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=cacheManager
2018-04-16 15:07:07,352 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:161) DEBUG - Found IocObject(cacheManager) in JsonLoader(paths=[ioc/])
2018-04-16 15:07:07,352 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - >> Make...'cacheManager'<>
2018-04-16 15:07:07,356 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class net.sf.ehcache.CacheManager without AOP
2018-04-16 15:07:07,357 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'cacheManager' to [app]
2018-04-16 15:07:07,441 org.nutz.resource.Scans.scan(Scans.java:274) DEBUG - Found 24 resource by src( net/wendal/nutzbook/ ) , regex( ^.+[.]class$ )
2018-04-16 15:07:07,480 org.nutz.dao.impl.sql.run.NutDaoExecutor.printSQL(NutDaoExecutor.java:388) DEBUG - SELECT COUNT(*) FROM t_user
2018-04-16 15:07:07,484 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'nutQuartzCronJobFactory'<class org.nutz.integration.quartz.NutQuartzCronJobFactory>
2018-04-16 15:07:07,484 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - >> Load definition name=nutQuartzCronJobFactory
2018-04-16 15:07:07,484 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=nutQuartzCronJobFactory
2018-04-16 15:07:07,485 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:161) DEBUG - Found IocObject(nutQuartzCronJobFactory) in QuartzIocLoader@1857283464
2018-04-16 15:07:07,485 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - >> Make...'nutQuartzCronJobFactory'<class org.nutz.integration.quartz.NutQuartzCronJobFactory>
2018-04-16 15:07:07,487 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class org.nutz.integration.quartz.NutQuartzCronJobFactory without AOP
2018-04-16 15:07:07,487 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'nutQuartzCronJobFactory' to [app]
2018-04-16 15:07:07,493 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'scheduler'<>
2018-04-16 15:07:07,493 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - >> Load definition name=scheduler
2018-04-16 15:07:07,493 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=scheduler
2018-04-16 15:07:07,494 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:161) DEBUG - Found IocObject(scheduler) in QuartzIocLoader@1857283464
2018-04-16 15:07:07,494 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - >> Make...'scheduler'<>
2018-04-16 15:07:07,494 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'scheduler' to [app]
四月 16, 2018 3:07:07 下午 org.quartz.impl.StdSchedulerFactory instantiate
信息: Using default implementation for ThreadExecutor
四月 16, 2018 3:07:07 下午 org.quartz.core.SchedulerSignalerImpl <init>
信息: Initialized Scheduler Signaller of type: class org.quartz.core.SchedulerSignalerImpl
四月 16, 2018 3:07:07 下午 org.quartz.core.QuartzScheduler <init>
信息: Quartz Scheduler v.2.2.3 created.
2018-04-16 15:07:07,588 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'jobFactory'<>
2018-04-16 15:07:07,588 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - >> Load definition name=jobFactory
2018-04-16 15:07:07,588 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=jobFactory
2018-04-16 15:07:07,590 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:161) DEBUG - Found IocObject(jobFactory) in QuartzIocLoader@1857283464
2018-04-16 15:07:07,590 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - >> Make...'jobFactory'<>
2018-04-16 15:07:07,591 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class org.nutz.integration.quartz.NutQuartzJobFactory without AOP
2018-04-16 15:07:07,592 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'jobFactory' to [app]
四月 16, 2018 3:07:07 下午 org.quartz.simpl.RAMJobStore initialize
信息: RAMJobStore initialized.
四月 16, 2018 3:07:07 下午 org.quartz.core.QuartzScheduler initialize
信息: Scheduler meta-data: Quartz Scheduler (v2.2.3) 'NutzbookScheduler' with instanceId 'NON_CLUSTERED'
Scheduler class: 'org.quartz.core.QuartzScheduler' - running locally.
NOT STARTED.
Currently in standby mode.
Number of jobs executed: 0
Using thread pool 'org.quartz.simpl.SimpleThreadPool' - with 3 threads.
Using job-store 'org.quartz.simpl.RAMJobStore' - which does not support persistence. and is not clustered.
四月 16, 2018 3:07:07 下午 org.quartz.impl.StdSchedulerFactory instantiate
信息: Quartz scheduler 'NutzbookScheduler' initialized from default resource file in Quartz package: 'quartz.properties'
四月 16, 2018 3:07:07 下午 org.quartz.impl.StdSchedulerFactory instantiate
信息: Quartz scheduler version: 2.2.3
四月 16, 2018 3:07:07 下午 org.quartz.core.QuartzScheduler setJobFactory
信息: JobFactory set to: org.nutz.integration.quartz.NutQuartzJobFactory@20d34bd
四月 16, 2018 3:07:07 下午 org.quartz.core.QuartzScheduler start
信息: Scheduler NutzbookScheduler_$_NON_CLUSTERED started.
2018-04-16 15:07:07,672 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'conf'<>
2018-04-16 15:07:07,673 org.nutz.integration.quartz.NutQuartzCronJobFactory.init(NutQuartzCronJobFactory.java:35) DEBUG - job define name=net.wendal.nutzbook.quartz.job.CleanNonActiveUserJob cron=0 0/2 * * * ?
2018-04-16 15:07:07,692 org.nutz.integration.quartz.NutQuartzCronJobFactory.init(NutQuartzCronJobFactory.java:28) DEBUG - found cron job packages = net.wendal.nutzbook.quartz.job
2018-04-16 15:07:07,695 org.nutz.resource.Scans.scan(Scans.java:274) DEBUG - Found 1 resource by src( net/wendal/nutzbook/quartz/job/ ) , regex( ^.+[.]class$ )
2018-04-16 15:07:07,695 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'authorityService'<interface net.wendal.nutzbook.service.AuthorityService>
2018-04-16 15:07:07,696 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - >> Load definition name=authorityService
2018-04-16 15:07:07,696 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:161) DEBUG - Found IocObject(authorityService) in AnnotationIocLoader(packages=[net.wendal.nutzbook])
2018-04-16 15:07:07,696 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - >> Make...'authorityService'<interface net.wendal.nutzbook.service.AuthorityService>
2018-04-16 15:07:07,696 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class net.wendal.nutzbook.service.AuthorityServiceImpl without AOP
2018-04-16 15:07:07,696 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'authorityService' to [app]
2018-04-16 15:07:07,704 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'dao'<interface org.nutz.dao.Dao>
2018-04-16 15:07:07,715 org.nutz.resource.Scans.scan(Scans.java:274) DEBUG - Found 24 resource by src( net/wendal/nutzbook/ ) , regex( ^.+[.]class$ )
2018-04-16 15:07:07,717 net.wendal.nutzbook.service.AuthorityServiceImpl.initFormPackage(AuthorityServiceImpl.java:59) DEBUG - found 16 permission
2018-04-16 15:07:07,717 net.wendal.nutzbook.service.AuthorityServiceImpl.initFormPackage(AuthorityServiceImpl.java:60) DEBUG - found 0 role
2018-04-16 15:07:07,720 org.nutz.dao.impl.sql.run.NutDaoExecutor.printSQL(NutDaoExecutor.java:388) DEBUG - SELECT * FROM t_permission
2018-04-16 15:07:07,736 org.nutz.dao.impl.sql.run.NutDaoExecutor.printSQL(NutDaoExecutor.java:388) DEBUG - SELECT * FROM t_role
2018-04-16 15:07:07,753 org.nutz.dao.impl.sql.run.NutDaoExecutor.printSQL(NutDaoExecutor.java:388) DEBUG - SELECT * FROM t_user WHERE name=?
| 1 |
|-------|
| admin |
For example:> "SELECT * FROM t_user WHERE name='admin'"
2018-04-16 15:07:07,765 org.nutz.dao.impl.sql.run.NutDaoExecutor.printSQL(NutDaoExecutor.java:388) DEBUG - SELECT * FROM t_role WHERE name=?
| 1 |
|-------|
| admin |
For example:> "SELECT * FROM t_role WHERE name='admin'"
2018-04-16 15:07:07,777 org.nutz.dao.impl.sql.run.NutDaoExecutor.printSQL(NutDaoExecutor.java:388) DEBUG - SELECT COUNT(*) FROM t_user_role WHERE u_id=? AND role_id=?
| 1 | 2 |
|---|---|
| 1 | 1 |
For example:> "SELECT COUNT(*) FROM t_user_role WHERE u_id=1 AND role_id=1"
2018-04-16 15:07:07,780 org.nutz.dao.impl.sql.run.NutDaoExecutor.printSQL(NutDaoExecutor.java:388) DEBUG - SELECT * FROM t_role_permission WHERE role_id=?
| 1 |
|---|
| 1 |
For example:> "SELECT * FROM t_role_permission WHERE role_id=1"
2018-04-16 15:07:07,785 org.nutz.dao.impl.sql.run.NutDaoExecutor.printSQL(NutDaoExecutor.java:388) DEBUG - SELECT * FROM t_permission WHERE name LIKE ? OR name LIKE ? OR name LIKE ?
| 1 | 2 | 3 |
|-------------|--------|---------|
| authority:% | user:% | topic:% |
For example:> "SELECT * FROM t_permission WHERE name LIKE 'authority:%' OR name LIKE 'user:%' OR name LIKE 'topic:%'"
2018-04-16 15:07:07,789 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'cacheManager'<class net.sf.ehcache.CacheManager>
2018-04-16 15:07:07,789 net.wendal.nutzbook.MainSetup.init(MainSetup.java:45) DEBUG - Ehcache CacheManager = nutzbook
2018-04-16 15:07:07,790 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'jedisAgent'<class org.nutz.integration.jedis.JedisAgent>
2018-04-16 15:07:07,790 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - >> Load definition name=jedisAgent
2018-04-16 15:07:07,791 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=jedisAgent
2018-04-16 15:07:07,791 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:161) DEBUG - Found IocObject(jedisAgent) in JedisIocLoader@660964936
2018-04-16 15:07:07,791 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - >> Make...'jedisAgent'<class org.nutz.integration.jedis.JedisAgent>
2018-04-16 15:07:07,802 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class org.nutz.integration.jedis.JedisAgent without AOP
2018-04-16 15:07:07,803 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'jedisAgent' to [app]
2018-04-16 15:07:07,819 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'conf'<>
2018-04-16 15:07:07,819 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'jedisPool'<class redis.clients.util.Pool>
2018-04-16 15:07:07,819 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - >> Load definition name=jedisPool
2018-04-16 15:07:07,819 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=jedisPool
2018-04-16 15:07:07,821 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:161) DEBUG - Found IocObject(jedisPool) in JedisIocLoader@660964936
2018-04-16 15:07:07,821 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - >> Make...'jedisPool'<class redis.clients.util.Pool>
2018-04-16 15:07:07,824 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class redis.clients.jedis.JedisPool without AOP
2018-04-16 15:07:07,824 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'jedisPool' to [app]
2018-04-16 15:07:07,833 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'jedisPoolConfig'<>
2018-04-16 15:07:07,834 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - >> Load definition name=jedisPoolConfig
2018-04-16 15:07:07,834 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=jedisPoolConfig
2018-04-16 15:07:07,835 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:161) DEBUG - Found IocObject(jedisPoolConfig) in JedisIocLoader@660964936
2018-04-16 15:07:07,835 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - >> Make...'jedisPoolConfig'<>
2018-04-16 15:07:07,836 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class redis.clients.jedis.JedisPoolConfig without AOP
2018-04-16 15:07:07,836 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'jedisPoolConfig' to [app]
2018-04-16 15:07:07,877 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'conf'<>
2018-04-16 15:07:07,879 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'conf'<>
2018-04-16 15:07:07,879 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'conf'<>
2018-04-16 15:07:07,880 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'conf'<>
2018-04-16 15:07:07,880 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'conf'<>
2018-04-16 15:07:07,880 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'conf'<>
2018-04-16 15:07:07,880 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'jedisPoolConfig'<>
2018-04-16 15:07:07,880 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'conf'<>
2018-04-16 15:07:07,881 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'conf'<>
2018-04-16 15:07:07,881 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'conf'<>
2018-04-16 15:07:07,881 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'conf'<>
2018-04-16 15:07:07,881 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'conf'<>
2018-04-16 15:07:07,975 net.wendal.nutzbook.MainSetup.init(MainSetup.java:54) DEBUG - redis say : OK
2018-04-16 15:07:07,975 net.wendal.nutzbook.MainSetup.init(MainSetup.java:56) DEBUG - redis say : http://nutzbook.wendal.net
2018-04-16 15:07:07,977 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:141) INFO - Nutz.Mvc[nutz] is up in 2861ms
2018-04-16 15:07:07,977 org.nutz.mvc.NutFilter._init(NutFilter.java:117) INFO - exclusionsPrefix = ^(/rs/|/druid/)
四月 16, 2018 3:07:07 下午 org.apache.catalina.startup.HostConfig deployDirectory
信息: Deployment of web application directory E:\my2017项目\.metadata\.me_tcat85\webapps\nutzbook has finished in 8,372 ms
四月 16, 2018 3:07:07 下午 org.apache.catalina.startup.HostConfig deployDirectory
信息: Deploying web application directory E:\my2017项目\.metadata\.me_tcat85\webapps\ROOT
四月 16, 2018 3:07:09 下午 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.
四月 16, 2018 3:07:09 下午 org.apache.catalina.startup.HostConfig deployDirectory
信息: Deployment of web application directory E:\my2017项目\.metadata\.me_tcat85\webapps\ROOT has finished in 1,829 ms
四月 16, 2018 3:07:09 下午 org.apache.coyote.AbstractProtocol start
信息: Starting ProtocolHandler [http-nio-8080]
四月 16, 2018 3:07:09 下午 org.apache.coyote.AbstractProtocol start
信息: Starting ProtocolHandler [ajp-nio-8009]
四月 16, 2018 3:07:09 下午 org.apache.catalina.startup.Catalina start
信息: Server startup in 15595 ms
2018-04-16 15:07:14,738 org.nutz.mvc.impl.UrlMappingImpl.get(UrlMappingImpl.java:101) DEBUG - Found mapping for [GET] path=/hello : BeetlTemplateModule.hello(BeetlTemplateModule.java:17)
2018-04-16 15:07:14,740 net.wendal.nutzbook.mvc.LogTimeProcessor.process(LogTimeProcessor.java:24) DEBUG - [ GET]URI=/nutzbook/hello 1ms
2018-04-16 15:07:14,742 org.nutz.mvc.impl.processor.FailProcessor.process(FailProcessor.java:28) WARN - Error@/hello :
java.lang.NullPointerException
at net.wendal.nutzbook.module.BeetlTemplateModule.hello(BeetlTemplateModule.java:18)
at net.wendal.nutzbook.module.BeetlTemplateModule$FM$hello$ac4f54c2a1c33e9acd432354e380fa11.invoke(BeetlTemplateModule.java)
at org.nutz.mvc.impl.processor.MethodInvokeProcessor.process(MethodInvokeProcessor.java:31)
at org.nutz.mvc.impl.processor.AbstractProcessor.doNext(AbstractProcessor.java:44)
at org.nutz.mvc.impl.processor.AdaptorProcessor.process(AdaptorProcessor.java:33)
at org.nutz.mvc.impl.processor.AbstractProcessor.doNext(AbstractProcessor.java:44)
at org.nutz.mvc.impl.processor.ActionFiltersProcessor.process(ActionFiltersProcessor.java:58)
at org.nutz.mvc.impl.processor.AbstractProcessor.doNext(AbstractProcessor.java:44)
at org.nutz.integration.shiro.NutShiroProcessor.process(NutShiroProcessor.java:126)
at org.nutz.mvc.impl.processor.AbstractProcessor.doNext(AbstractProcessor.java:44)
at org.nutz.mvc.impl.processor.ModuleProcessor.process(ModuleProcessor.java:123)
at org.nutz.mvc.impl.processor.AbstractProcessor.doNext(AbstractProcessor.java:44)
at org.nutz.mvc.impl.processor.EncodingProcessor.process(EncodingProcessor.java:27)
at org.nutz.mvc.impl.processor.AbstractProcessor.doNext(AbstractProcessor.java:44)
at org.nutz.mvc.impl.processor.UpdateRequestAttributesProcessor.process(UpdateRequestAttributesProcessor.java:15)
at org.nutz.mvc.impl.processor.AbstractProcessor.doNext(AbstractProcessor.java:44)
at net.wendal.nutzbook.mvc.LogTimeProcessor.process(LogTimeProcessor.java:19)
at org.nutz.mvc.impl.NutActionChain.doChain(NutActionChain.java:44)
at org.nutz.mvc.impl.ActionInvoker.invoke(ActionInvoker.java:67)
at org.nutz.mvc.ActionHandler.handle(ActionHandler.java:31)
at org.nutz.mvc.NutFilter.doFilter(NutFilter.java:202)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:192)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:165)
at com.alibaba.druid.support.http.WebStatFilter.doFilter(WebStatFilter.java:123)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:192)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:165)
at org.apache.shiro.web.servlet.AbstractShiroFilter.executeChain(AbstractShiroFilter.java:449)
at org.apache.shiro.web.servlet.AbstractShiroFilter$1.call(AbstractShiroFilter.java:365)
at org.apache.shiro.subject.support.SubjectCallable.doCall(SubjectCallable.java:90)
at org.apache.shiro.subject.support.SubjectCallable.call(SubjectCallable.java:83)
at org.apache.shiro.subject.support.DelegatingSubject.execute(DelegatingSubject.java:383)
at org.apache.shiro.web.servlet.AbstractShiroFilter.doFilterInternal(AbstractShiroFilter.java:362)
at org.apache.shiro.web.servlet.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:125)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:192)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:165)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:198)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:96)
at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:474)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:140)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:79)
at org.apache.catalina.valves.AbstractAccessLogValve.invoke(AbstractAccessLogValve.java:624)
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:87)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:349)
at org.apache.coyote.http11.Http11Processor.service(Http11Processor.java:783)
at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:66)
at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:789)
at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1437)
at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:49)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61)
at java.lang.Thread.run(Thread.java:745)
