Nutz
  1. 主页/
  2. 问答
NutzCN Logo
问答 发送邮件时报错，htmlEmail找不到，mail.js未被加载到ioc
发布于 1890天前 作者 菜鸟上路 1264 次浏览 复制 上一个帖子 下一个帖子
标签: 无 
2019-02-22 17:12:50,912 org.apache.shiro.web.env.EnvironmentLoader.initEnvironment(EnvironmentLoader.java:128) INFO  - Starting Shiro environment initialization.
2019-02-22 17:12:50,926 org.apache.shiro.web.env.IniWebEnvironment.init(IniWebEnvironment.java:76) DEBUG - Checking any specified config locations.
2019-02-22 17:12:50,927 org.apache.shiro.web.env.IniWebEnvironment.init(IniWebEnvironment.java:81) DEBUG - No INI instance or config locations specified.  Trying default config locations.
2019-02-22 17:12:50,936 org.apache.shiro.io.ResourceUtils.loadFromClassPath(ResourceUtils.java:159) DEBUG - Opening resource from class path [shiro.ini]
2019-02-22 17:12:50,943 org.apache.shiro.config.Ini.load(Ini.java:351) DEBUG - Parsing [main]
2019-02-22 17:12:50,949 org.apache.shiro.config.Ini.load(Ini.java:351) DEBUG - Parsing [urls]
2019-02-22 17:12:50,953 org.apache.shiro.web.env.IniWebEnvironment.getDefaultIni(IniWebEnvironment.java:136) DEBUG - Discovered non-empty INI configuration at location 'classpath:shiro.ini'.  Using for configuration.
2019-02-22 17:12:50,963 org.apache.shiro.config.IniFactorySupport.createInstance(IniFactorySupport.java:122) DEBUG - Creating instance from Ini [sections=main,urls]
2019-02-22 17:12:51,278 org.apache.shiro.realm.AuthorizingRealm.getAuthorizationCacheLazy(AuthorizingRealm.java:234) DEBUG - No authorizationCache instance set.  Checking for a cacheManager...
2019-02-22 17:12:51,278 org.apache.shiro.realm.AuthorizingRealm.getAuthorizationCacheLazy(AuthorizingRealm.java:248) DEBUG - No cache or cacheManager properties have been set.  Authorization cache cannot be obtained.
2019-02-22 17:12:51,278 org.apache.shiro.config.ReflectionBuilder.createNewInstance(ReflectionBuilder.java:296) INFO  - An instance with name 'authc' already exists.  Redefining this object as a new instance of type org.nutz.integration.shiro.SimpleAuthenticationFilter
2019-02-22 17:12:51,300 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: false
2019-02-22 17:12:51,300 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'Boolean' value 'false' to type 'Boolean'
2019-02-22 17:12:51,300 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a Boolean
2019-02-22 17:12:51,302 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: 0
2019-02-22 17:12:51,302 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'Integer' value '0' to type 'Byte'
2019-02-22 17:12:51,304 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:158) DEBUG -     Converted to Byte value '0'
2019-02-22 17:12:51,305 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value:  
2019-02-22 17:12:51,305 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'Character' value ' ' to type 'Character'
2019-02-22 17:12:51,306 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a Character
2019-02-22 17:12:51,306 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: 0
2019-02-22 17:12:51,307 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'Integer' value '0' to type 'Double'
2019-02-22 17:12:51,307 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:158) DEBUG -     Converted to Double value '0.0'
2019-02-22 17:12:51,308 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: 0
2019-02-22 17:12:51,308 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'Integer' value '0' to type 'Float'
2019-02-22 17:12:51,308 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:158) DEBUG -     Converted to Float value '0.0'
2019-02-22 17:12:51,310 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: 0
2019-02-22 17:12:51,310 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'Integer' value '0' to type 'Integer'
2019-02-22 17:12:51,310 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a Integer
2019-02-22 17:12:51,311 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: 0
2019-02-22 17:12:51,311 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'Integer' value '0' to type 'Long'
2019-02-22 17:12:51,312 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:158) DEBUG -     Converted to Long value '0'
2019-02-22 17:12:51,312 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: 0
2019-02-22 17:12:51,313 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'Integer' value '0' to type 'Short'
2019-02-22 17:12:51,313 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:158) DEBUG -     Converted to Short value '0'
2019-02-22 17:12:51,315 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: 0.0
2019-02-22 17:12:51,316 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'BigDecimal' value '0.0' to type 'BigDecimal'
2019-02-22 17:12:51,317 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a BigDecimal
2019-02-22 17:12:51,318 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: 0
2019-02-22 17:12:51,318 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'BigInteger' value '0' to type 'BigInteger'
2019-02-22 17:12:51,319 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a BigInteger
2019-02-22 17:12:51,320 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: false
2019-02-22 17:12:51,320 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'Boolean' value 'false' to type 'Boolean'
2019-02-22 17:12:51,320 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a Boolean
2019-02-22 17:12:51,320 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: 0
2019-02-22 17:12:51,320 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'Integer' value '0' to type 'Byte'
2019-02-22 17:12:51,320 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:158) DEBUG -     Converted to Byte value '0'
2019-02-22 17:12:51,321 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value:  
2019-02-22 17:12:51,321 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'Character' value ' ' to type 'Character'
2019-02-22 17:12:51,321 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a Character
2019-02-22 17:12:51,322 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: 0
2019-02-22 17:12:51,322 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'Integer' value '0' to type 'Double'
2019-02-22 17:12:51,322 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:158) DEBUG -     Converted to Double value '0.0'
2019-02-22 17:12:51,322 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: 0
2019-02-22 17:12:51,322 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'Integer' value '0' to type 'Float'
2019-02-22 17:12:51,322 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:158) DEBUG -     Converted to Float value '0.0'
2019-02-22 17:12:51,323 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: 0
2019-02-22 17:12:51,323 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'Integer' value '0' to type 'Integer'
2019-02-22 17:12:51,323 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a Integer
2019-02-22 17:12:51,323 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: 0
2019-02-22 17:12:51,323 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'Integer' value '0' to type 'Long'
2019-02-22 17:12:51,323 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:158) DEBUG -     Converted to Long value '0'
2019-02-22 17:12:51,323 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: 0
2019-02-22 17:12:51,323 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'Integer' value '0' to type 'Short'
2019-02-22 17:12:51,323 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:158) DEBUG -     Converted to Short value '0'
2019-02-22 17:12:51,324 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: 
2019-02-22 17:12:51,324 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'String' value '' to type 'String'
2019-02-22 17:12:51,330 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: [Z@20c36577
2019-02-22 17:12:51,331 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'boolean[]' value '[Z@20c36577' to type 'boolean[]'
2019-02-22 17:12:51,331 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a boolean[]
2019-02-22 17:12:51,331 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: [B@531a04b8
2019-02-22 17:12:51,331 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'byte[]' value '[B@531a04b8' to type 'byte[]'
2019-02-22 17:12:51,331 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a byte[]
2019-02-22 17:12:51,331 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: [C@19b94e8d
2019-02-22 17:12:51,332 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'char[]' value '[C@19b94e8d' to type 'char[]'
2019-02-22 17:12:51,332 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a char[]
2019-02-22 17:12:51,332 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: [D@d433fb6
2019-02-22 17:12:51,332 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'double[]' value '[D@d433fb6' to type 'double[]'
2019-02-22 17:12:51,332 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a double[]
2019-02-22 17:12:51,332 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: [F@36900bb4
2019-02-22 17:12:51,332 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'float[]' value '[F@36900bb4' to type 'float[]'
2019-02-22 17:12:51,333 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a float[]
2019-02-22 17:12:51,333 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: [I@352cf61a
2019-02-22 17:12:51,333 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'int[]' value '[I@352cf61a' to type 'int[]'
2019-02-22 17:12:51,333 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a int[]
2019-02-22 17:12:51,333 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: [J@66b20b14
2019-02-22 17:12:51,333 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'long[]' value '[J@66b20b14' to type 'long[]'
2019-02-22 17:12:51,333 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a long[]
2019-02-22 17:12:51,333 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: [S@721826fb
2019-02-22 17:12:51,333 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'short[]' value '[S@721826fb' to type 'short[]'
2019-02-22 17:12:51,333 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a short[]
2019-02-22 17:12:51,334 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: [Ljava.math.BigDecimal;@44635ea7
2019-02-22 17:12:51,334 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'BigDecimal[]' value '[Ljava.math.BigDecimal;@44635ea7' to type 'BigDecimal[]'
2019-02-22 17:12:51,334 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a BigDecimal[]
2019-02-22 17:12:51,334 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: [Ljava.math.BigInteger;@60b1bf6d
2019-02-22 17:12:51,334 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'BigInteger[]' value '[Ljava.math.BigInteger;@60b1bf6d' to type 'BigInteger[]'
2019-02-22 17:12:51,334 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a BigInteger[]
2019-02-22 17:12:51,334 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: [Ljava.lang.Boolean;@d6598ca
2019-02-22 17:12:51,334 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'Boolean[]' value '[Ljava.lang.Boolean;@d6598ca' to type 'Boolean[]'
2019-02-22 17:12:51,335 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a Boolean[]
2019-02-22 17:12:51,335 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: [Ljava.lang.Byte;@19f60305
2019-02-22 17:12:51,335 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'Byte[]' value '[Ljava.lang.Byte;@19f60305' to type 'Byte[]'
2019-02-22 17:12:51,335 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a Byte[]
2019-02-22 17:12:51,335 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: [Ljava.lang.Character;@72c3eb
2019-02-22 17:12:51,336 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'Character[]' value '[Ljava.lang.Character;@72c3eb' to type 'Character[]'
2019-02-22 17:12:51,336 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a Character[]
2019-02-22 17:12:51,336 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: [Ljava.lang.Double;@519df14d
2019-02-22 17:12:51,336 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'Double[]' value '[Ljava.lang.Double;@519df14d' to type 'Double[]'
2019-02-22 17:12:51,336 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a Double[]
2019-02-22 17:12:51,336 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: [Ljava.lang.Float;@63d411e8
2019-02-22 17:12:51,336 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'Float[]' value '[Ljava.lang.Float;@63d411e8' to type 'Float[]'
2019-02-22 17:12:51,336 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a Float[]
2019-02-22 17:12:51,336 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: [Ljava.lang.Integer;@74d5f09a
2019-02-22 17:12:51,337 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'Integer[]' value '[Ljava.lang.Integer;@74d5f09a' to type 'Integer[]'
2019-02-22 17:12:51,337 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a Integer[]
2019-02-22 17:12:51,337 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: [Ljava.lang.Long;@3da19c52
2019-02-22 17:12:51,337 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'Long[]' value '[Ljava.lang.Long;@3da19c52' to type 'Long[]'
2019-02-22 17:12:51,338 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a Long[]
2019-02-22 17:12:51,338 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: [Ljava.lang.Short;@4f46c3ab
2019-02-22 17:12:51,338 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'Short[]' value '[Ljava.lang.Short;@4f46c3ab' to type 'Short[]'
2019-02-22 17:12:51,338 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a Short[]
2019-02-22 17:12:51,338 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: [Ljava.lang.String;@4cf693e8
2019-02-22 17:12:51,338 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'String[]' value '[Ljava.lang.String;@4cf693e8' to type 'String[]'
2019-02-22 17:12:51,338 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a String[]
2019-02-22 17:12:51,338 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: [Ljava.lang.Class;@3dcf220e
2019-02-22 17:12:51,339 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'Class[]' value '[Ljava.lang.Class;@3dcf220e' to type 'Class[]'
2019-02-22 17:12:51,339 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a Class[]
2019-02-22 17:12:51,339 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: [Ljava.util.Date;@446de587
2019-02-22 17:12:51,340 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'Date[]' value '[Ljava.util.Date;@446de587' to type 'Date[]'
2019-02-22 17:12:51,340 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a Date[]
2019-02-22 17:12:51,340 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: [Ljava.util.Calendar;@67bbab31
2019-02-22 17:12:51,340 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'Calendar[]' value '[Ljava.util.Calendar;@67bbab31' to type 'Calendar[]'
2019-02-22 17:12:51,340 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a Calendar[]
2019-02-22 17:12:51,340 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: [Ljava.io.File;@8cab2a4
2019-02-22 17:12:51,340 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'java.io.File[]' value '[Ljava.io.File;@8cab2a4' to type 'java.io.File[]'
2019-02-22 17:12:51,341 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a java.io.File[]
2019-02-22 17:12:51,341 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: [Ljava.sql.Date;@7d602ddd
2019-02-22 17:12:51,341 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'java.sql.Date[]' value '[Ljava.sql.Date;@7d602ddd' to type 'java.sql.Date[]'
2019-02-22 17:12:51,341 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a java.sql.Date[]
2019-02-22 17:12:51,341 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: [Ljava.sql.Time;@2b46ac1
2019-02-22 17:12:51,341 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'java.sql.Time[]' value '[Ljava.sql.Time;@2b46ac1' to type 'java.sql.Time[]'
2019-02-22 17:12:51,341 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a java.sql.Time[]
2019-02-22 17:12:51,341 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: [Ljava.sql.Timestamp;@7edf0c46
2019-02-22 17:12:51,342 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'java.sql.Timestamp[]' value '[Ljava.sql.Timestamp;@7edf0c46' to type 'java.sql.Timestamp[]'
2019-02-22 17:12:51,342 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a java.sql.Timestamp[]
2019-02-22 17:12:51,342 org.apache.commons.beanutils.converters.AbstractConverter.setDefaultValue(AbstractConverter.java:336) DEBUG - Setting default value: [Ljava.net.URL;@35206397
2019-02-22 17:12:51,342 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'java.net.URL[]' value '[Ljava.net.URL;@35206397' to type 'java.net.URL[]'
2019-02-22 17:12:51,342 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:149) DEBUG -     No conversion required, value is already a java.net.URL[]
2019-02-22 17:12:51,355 org.apache.commons.beanutils.ConvertUtilsBean.convert(ConvertUtilsBean.java:460) DEBUG - Convert string '/user/login' to class 'java.lang.String'
2019-02-22 17:12:51,356 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'String' value '/user/login' to type 'String'
2019-02-22 17:12:51,359 org.apache.commons.beanutils.ConvertUtilsBean.convert(ConvertUtilsBean.java:460) DEBUG - Convert string '/user/login' to class 'java.lang.String'
2019-02-22 17:12:51,359 org.apache.commons.beanutils.converters.AbstractConverter.convert(AbstractConverter.java:127) DEBUG - Converting 'String' value '/user/login' to type 'String'
2019-02-22 17:12:51,360 org.apache.shiro.realm.AuthorizingRealm.getAuthorizationCacheLazy(AuthorizingRealm.java:234) DEBUG - No authorizationCache instance set.  Checking for a cacheManager...
2019-02-22 17:12:51,360 org.apache.shiro.realm.AuthorizingRealm.getAuthorizationCacheLazy(AuthorizingRealm.java:248) DEBUG - No cache or cacheManager properties have been set.  Authorization cache cannot be obtained.
2019-02-22 17:12:51,363 org.apache.shiro.config.IniFactorySupport.createInstance(IniFactorySupport.java:122) DEBUG - Creating instance from Ini [sections=main,urls]
2019-02-22 17:12:51,367 org.apache.shiro.web.filter.mgt.DefaultFilterChainManager.createChain(DefaultFilterChainManager.java:127) DEBUG - Creating chain [/rs/*] from String definition [anon]
2019-02-22 17:12:51,368 org.apache.shiro.web.filter.mgt.DefaultFilterChainManager.applyChainConfig(DefaultFilterChainManager.java:278) DEBUG - Attempting to apply path [/rs/*] to filter [anon] with config [null]
2019-02-22 17:12:51,369 org.apache.shiro.web.filter.mgt.DefaultFilterChainManager.createChain(DefaultFilterChainManager.java:127) DEBUG - Creating chain [/user/logout] from String definition [logout]
2019-02-22 17:12:51,370 org.apache.shiro.web.filter.mgt.DefaultFilterChainManager.applyChainConfig(DefaultFilterChainManager.java:278) DEBUG - Attempting to apply path [/user/logout] to filter [logout] with config [null]
2019-02-22 17:12:51,370 org.apache.shiro.web.filter.mgt.DefaultFilterChainManager.createChain(DefaultFilterChainManager.java:127) DEBUG - Creating chain [/user/error] from String definition [anon]
2019-02-22 17:12:51,370 org.apache.shiro.web.filter.mgt.DefaultFilterChainManager.applyChainConfig(DefaultFilterChainManager.java:278) DEBUG - Attempting to apply path [/user/error] to filter [anon] with config [null]
2019-02-22 17:12:51,370 org.apache.shiro.web.filter.mgt.DefaultFilterChainManager.createChain(DefaultFilterChainManager.java:127) DEBUG - Creating chain [/user/login] from String definition [anon]
2019-02-22 17:12:51,371 org.apache.shiro.web.filter.mgt.DefaultFilterChainManager.applyChainConfig(DefaultFilterChainManager.java:278) DEBUG - Attempting to apply path [/user/login] to filter [anon] with config [null]
2019-02-22 17:12:51,371 org.apache.shiro.web.filter.mgt.DefaultFilterChainManager.createChain(DefaultFilterChainManager.java:127) DEBUG - Creating chain [/user/profile/active/mail] from String definition [anon]
2019-02-22 17:12:51,371 org.apache.shiro.web.filter.mgt.DefaultFilterChainManager.applyChainConfig(DefaultFilterChainManager.java:278) DEBUG - Attempting to apply path [/user/profile/active/mail] to filter [anon] with config [null]
2019-02-22 17:12:51,371 org.apache.shiro.web.env.EnvironmentLoader.initEnvironment(EnvironmentLoader.java:136) DEBUG - Published WebEnvironment as ServletContext attribute with name [org.apache.shiro.web.env.EnvironmentLoader.ENVIRONMENT_ATTRIBUTE_KEY]
2019-02-22 17:12:51,372 org.apache.shiro.web.env.EnvironmentLoader.initEnvironment(EnvironmentLoader.java:141) INFO  - Shiro environment initialized in 457 ms.
2019-02-22 17:12:51,409 org.nutz.mvc.NutFilter._init(NutFilter.java:81) INFO  - NutFilter[nutz] starting ...
2019-02-22 17:12:51,548 org.nutz.resource.Scans.<init>(Scans.java:509) DEBUG - Locations for Scans:
[Dir[path=E:\develop\eclipse], Jar[path=E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\nutz-1.r.60.jar], Dir[path=E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\classes], Jar[path=E:\develop\apache-tomcat_nutz\bin\bootstrap.jar], Jar[path=E:\develop\apache-tomcat_nutz\bin\tomcat-juli.jar], Jar[path=E:\develop\jdk1.8.0_66\lib\tools.jar]]
2019-02-22 17:12:51,702 org.nutz.resource.Scans.init(Scans.java:105) DEBUG - Locations for Scans:
{E:\develop\eclipse=Dir[path=E:\develop\eclipse], E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\nutz-1.r.60.jar=Jar[path=E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\nutz-1.r.60.jar], E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\classes=Dir[path=E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\classes], E:\develop\apache-tomcat_nutz\bin\bootstrap.jar=Jar[path=E:\develop\apache-tomcat_nutz\bin\bootstrap.jar], E:\develop\apache-tomcat_nutz\bin\tomcat-juli.jar=Jar[path=E:\develop\apache-tomcat_nutz\bin\tomcat-juli.jar], E:\develop\jdk1.8.0_66\lib\tools.jar=Jar[path=E:\develop\jdk1.8.0_66\lib\tools.jar], E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\taglibs-standard-impl-1.2.5.jar=Jar[path=E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\taglibs-standard-impl-1.2.5.jar], E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\slf4j-api-1.6.1.jar=Jar[path=E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\slf4j-api-1.6.1.jar], E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\mysql-connector-java-5.1.20-bin.jar=Jar[path=E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\mysql-connector-java-5.1.20-bin.jar], E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\commons-beanutils-1.8.3.jar=Jar[path=E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\commons-beanutils-1.8.3.jar], E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\javax.mail-1.5.2.jar=Jar[path=E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\javax.mail-1.5.2.jar], E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\taglibs-standard-spec-1.2.5.jar=Jar[path=E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\taglibs-standard-spec-1.2.5.jar], E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\log4j-1.2.17.jar=Jar[path=E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\log4j-1.2.17.jar], E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\taglibs-standard-jstlel-1.2.5.jar=Jar[path=E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\taglibs-standard-jstlel-1.2.5.jar], E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\quartz-2.0.0.jar=Jar[path=E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\quartz-2.0.0.jar], E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\nutz-integration-quartz-1.r.60.r2.jar=Jar[path=E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\nutz-integration-quartz-1.r.60.r2.jar], E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\nutz-integration-shiro-1.r.60.r2.jar=Jar[path=E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\nutz-integration-shiro-1.r.60.r2.jar], E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\druid-1.0.26.jar=Jar[path=E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\druid-1.0.26.jar], E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\simplecaptcha-1.2.2.jar=Jar[path=E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\simplecaptcha-1.2.2.jar], E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\commons-email-1.3.3.jar=Jar[path=E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\commons-email-1.3.3.jar], E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\shiro-all-1.3.2.jar=Jar[path=E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\shiro-all-1.3.2.jar], E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\slf4j-log4j12-1.6.1.jar=Jar[path=E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\slf4j-log4j12-1.6.1.jar], E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\commons-logging-1.1.1.jar=Jar[path=E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\lib\commons-logging-1.1.1.jar]}
2019-02-22 17:12:51,771 org.nutz.castor.Castors.reload(Castors.java:115) DEBUG - Using 95 castor for Castors
2019-02-22 17:12:51,792 org.nutz.mvc.config.AbstractNutConfig.createLoading(AbstractNutConfig.java:59) DEBUG - Loading by class org.nutz.mvc.impl.NutLoading
2019-02-22 17:12:51,794 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:55) INFO  - Nutz Version : 1.r.60 
2019-02-22 17:12:51,794 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:56) INFO  - Nutz.Mvc[nutz] is initializing ...
2019-02-22 17:12:51,795 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:60) DEBUG - Web Container Information:
2019-02-22 17:12:51,796 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:61) DEBUG -  - Default Charset : UTF-8
2019-02-22 17:12:51,796 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:62) DEBUG -  - Current . path  : E:\develop\eclipse\.
2019-02-22 17:12:51,796 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:63) DEBUG -  - Java Version    : 1.8.0_66
2019-02-22 17:12:51,797 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:64) DEBUG -  - File separator  : \
2019-02-22 17:12:51,797 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:65) DEBUG -  - Timezone        : Asia/Shanghai
2019-02-22 17:12:51,797 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:66) DEBUG -  - OS              : Windows 10 amd64
2019-02-22 17:12:51,797 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:67) DEBUG -  - ServerInfo      : Apache Tomcat/7.0.42
2019-02-22 17:12:51,798 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:68) DEBUG -  - Servlet API     : 3.0
2019-02-22 17:12:51,799 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:73) DEBUG -  - ContextPath     : /nutzbook
2019-02-22 17:12:51,800 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:74) DEBUG -  - context.tempdir : E:\develop\apache-tomcat_nutz\work\Catalina\localhost\nutzbook
2019-02-22 17:12:51,800 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:75) DEBUG -  - MainModule      : net.wendal.nutzbook.MainModule
2019-02-22 17:12:51,801 org.nutz.mvc.impl.NutLoading.createContext(NutLoading.java:238) DEBUG - >> app.root = E:/develop/apache-tomcat_nutz/webapps/nutzbook
2019-02-22 17:12:51,804 org.nutz.mvc.impl.NutLoading.createIoc(NutLoading.java:379) DEBUG - @IocBy(type=org.nutz.mvc.ioc.provider.ComboIocProvider, args=["*js", "ioc/", "*anno", "net.wendal.nutzbook", "*tx", "*quartz"],init=[])
2019-02-22 17:12:51,828 org.nutz.resource.Scans.scan(Scans.java:274) DEBUG - Found 1 resource by src( ioc/ ) , regex( ^(.+[.])(js|json)$ )
2019-02-22 17:12:51,828 org.nutz.ioc.loader.json.JsonLoader.<init>(JsonLoader.java:48) DEBUG - loading ioc js config from [dao.js]
2019-02-22 17:12:51,832 org.nutz.ioc.loader.json.JsonLoader.<init>(JsonLoader.java:56) DEBUG - Loaded 3 bean define from path=[ioc/] --> [conf, dao, dataSource]
2019-02-22 17:12:51,841 org.nutz.resource.Scans.scan(Scans.java:274) DEBUG - Found 19 resource by src( net/wendal/nutzbook/ ) , regex( ^.+[.]class$ )
2019-02-22 17:12:51,871 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:230) WARN  - class(net.wendal.nutzbook.module.BaseModule) don't has @IocBean, but field(dao) has @Inject! Miss @IocBean ??
2019-02-22 17:12:51,875 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:74) DEBUG - Found @IocBean : class net.wendal.nutzbook.module.CaptchaModule
2019-02-22 17:12:51,883 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:74) DEBUG - Found @IocBean : class net.wendal.nutzbook.module.UserModule
2019-02-22 17:12:51,897 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:74) DEBUG - Found @IocBean : class net.wendal.nutzbook.module.UserProfileModule
2019-02-22 17:12:51,909 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:74) DEBUG - Found @IocBean : class net.wendal.nutzbook.service.EmailServiceImpl
2019-02-22 17:12:51,914 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:74) DEBUG - Found @IocBean : class net.wendal.nutzbook.service.UserService
2019-02-22 17:12:51,922 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:74) DEBUG - Found @IocBean : class net.wendal.nutzbook.test.Test1
2019-02-22 17:12:51,924 org.nutz.ioc.loader.annotation.AnnotationIocLoader.<init>(AnnotationIocLoader.java:50) INFO  - Found 6 classes in 1 base-packages!
beans = ["userProfileModule", "captchaModule", "userModule", "test1", "emailService", "userService"]
2019-02-22 17:12:51,927 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]
2019-02-22 17:12:51,936 org.nutz.ioc.loader.combo.ComboIocLoader.createIocLoader(ComboIocLoader.java:118) DEBUG - found org.nutz.integration.quartz.QuartzIocLoader -- org.nutz.integration.quartz.QuartzIocLoader
2019-02-22 17:12:51,937 org.nutz.ioc.loader.json.JsonLoader.<init>(JsonLoader.java:56) DEBUG - Loaded 0 bean define from path=[] --> []
2019-02-22 17:12:51,942 org.nutz.ioc.impl.NutIoc.<init>(NutIoc.java:98) INFO  - NutIoc init begin ...
2019-02-22 17:12:51,945 org.nutz.ioc.impl.NutIoc.<init>(NutIoc.java:115) INFO  - ... NutIoc init complete
2019-02-22 17:12:51,951 org.nutz.mvc.impl.NutLoading.evalUrlMapping(NutLoading.java:159) INFO  - Build URL mapping by org.nutz.mvc.impl.UrlMappingImpl ...
2019-02-22 17:12:51,954 org.nutz.mvc.impl.NutLoading.createViewMakers(NutLoading.java:369) DEBUG - @Views(DefaultViewMaker.class)
2019-02-22 17:12:51,966 org.nutz.resource.Scans.scan(Scans.java:274) DEBUG - Found 1 resource by src( mvc/nutzbook-mvc-chain.js ) , regex( ^(.+[.])(js|json)$ )
2019-02-22 17:12:51,974 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.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"
   }
}
2019-02-22 17:12:51,974 org.nutz.mvc.impl.NutLoading.createChainMaker(NutLoading.java:266) DEBUG - @ChainBy(org.nutz.mvc.impl.NutActionChainMaker)
2019-02-22 17:12:51,980 org.nutz.mvc.impl.Loadings.scanModules(Loadings.java:154) DEBUG - module class location 'file:/E:/develop/apache-tomcat_nutz/webapps/nutzbook/WEB-INF/classes/net/wendal/nutzbook/MainModule.class'
2019-02-22 17:12:51,981 org.nutz.mvc.impl.Loadings.scanModuleInPackage(Loadings.java:184) DEBUG -  > scan 'net.wendal.nutzbook'
2019-02-22 17:12:51,989 org.nutz.resource.Scans.scan(Scans.java:274) DEBUG - Found 19 resource by src( net/wendal/nutzbook/ ) , regex( ^.+[.]class$ )
2019-02-22 17:12:51,991 org.nutz.mvc.impl.Loadings.checkModule(Loadings.java:198) DEBUG -    >> add 'net.wendal.nutzbook.module.CaptchaModule'
2019-02-22 17:12:51,991 org.nutz.mvc.impl.Loadings.checkModule(Loadings.java:198) DEBUG -    >> add 'net.wendal.nutzbook.module.UserModule'
2019-02-22 17:12:51,991 org.nutz.mvc.impl.Loadings.checkModule(Loadings.java:198) DEBUG -    >> add 'net.wendal.nutzbook.module.UserProfileModule'
2019-02-22 17:12:51,996 org.nutz.mvc.impl.Loadings.checkModule(Loadings.java:198) DEBUG -    >> add 'net.wendal.nutzbook.test.Test1'
2019-02-22 17:12:52,031 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG -    '/captcha/next'             >> (CaptchaModule.java:24).next          : BufferedImage | @Ok(raw:png) @Fail(jsp:jsp:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2019-02-22 17:12:52,042 org.nutz.mvc.impl.processor.ViewProcessor.init(ViewProcessor.java:29) WARN  - Not a good idea : Return String ,and using JsonView!! (Using @Ok("raw") or return map/list/pojo)--> Test1.test(...)
2019-02-22 17:12:52,044 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG -    '/test1/test'               >> (Test1.java:17).test                  : String     | @Ok(json ) @Fail(jsp:jsp:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2019-02-22 17:12:52,053 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG -    '/user/'                    >> (UserModule.java:48).index            : void       | @Ok(jsp:jsp/user/list) @Fail(http:500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2019-02-22 17:12:52,061 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG -    '/user/add'                 >> (UserModule.java:113).add             : Object     | @Ok(json:{locked:'password|salt',ignoreNull:true}) @Fail(http:500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2019-02-22 17:12:52,062 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG -    '/user/count'               >> (UserModule.java:40).count            : int        | @Ok(json:{locked:'password|salt',ignoreNull:true}) @Fail(http:500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2019-02-22 17:12:52,066 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG -    '/user/update'              >> (UserModule.java:102).update          : Object     | @Ok(json:{locked:'password|salt',ignoreNull:true}) @Fail(http:500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2019-02-22 17:12:52,068 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG -    '/user/delete'              >> (UserModule.java:90).delete           : Object     | @Ok(json:{locked:'password|salt',ignoreNull:true}) @Fail(http:500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2019-02-22 17:12:52,070 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG -    '/user/query'               >> (UserModule.java:76).query            : Object     | @Ok(json:{locked:'password|salt',ignoreNull:true}) @Fail(http:500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2019-02-22 17:12:52,071 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG -    '/user/login'               >> (UserModule.java:65).loginPage        : void       | @Ok(jsp:jsp.user.login) @Fail(http:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2019-02-22 17:12:52,072 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG -    '/user/logout'              >> (UserModule.java:70).logout           : void       | @Ok(>>:/ ) @Fail(http:500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2019-02-22 17:12:52,073 org.nutz.mvc.impl.UrlMappingImpl.add(UrlMappingImpl.java:68) WARN  - Duplicate @At mapping ? path=/user/login
2019-02-22 17:12:52,075 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG -    '/user/login'               >> (UserModule.java:53).login            : Object     | @Ok(json:{locked:'password|salt',ignoreNull:true}) @Fail(http:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2019-02-22 17:12:52,077 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG -    '/user/profile/'            >> (UserProfileModule.java:145).index    : UserProfile | @Ok(jsp:jsp.user.profile) @Fail(jsp:jsp:500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2019-02-22 17:12:52,078 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG -    '/user/profile/get'         >> (UserProfileModule.java:52).get       : UserProfile | @Ok(json:full) @Fail(jsp:jsp:500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2019-02-22 17:12:52,080 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG -    '/user/profile/update'      >> (UserProfileModule.java:67).update    : void       | @Ok(json:full) @Fail(jsp:jsp:500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2019-02-22 17:12:52,082 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG -    '/user/profile/active/mail' >> (UserProfileModule.java:181).activeMailCallback : String     | @Ok(raw  ) @Fail(jsp:jsp:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2019-02-22 17:12:52,090 org.nutz.filepool.NutFilePool.<init>(NutFilePool.java:23) INFO  - Init file-pool by: E:/develop/apache-tomcat_nutz/webapps/nutzbook/WEB-INF/tmp/user_avatar [20000]
2019-02-22 17:12:52,093 org.nutz.filepool.NutFilePool.<init>(NutFilePool.java:37) DEBUG - file-pool.home: 'E:\develop\apache-tomcat_nutz\webapps\nutzbook\WEB-INF\tmp\user_avatar'
2019-02-22 17:12:52,094 org.nutz.filepool.NutFilePool.<init>(NutFilePool.java:66) INFO  - file-pool.cursor: 0
2019-02-22 17:12:52,102 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG -    '/user/profile/avatar'      >> (UserProfileModule.java:101).uploadAvatar : void       | @Ok(>>:/user/profile) @Fail(jsp:jsp:500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2019-02-22 17:12:52,104 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG -    '/user/profile/avatar'      >> (UserProfileModule.java:133).readAvatar : Object     | @Ok(raw:jpg) @Fail(jsp:jsp:500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2019-02-22 17:12:52,105 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG -    '/user/profile/active/mail' >> (UserProfileModule.java:153).activeMail : Object     | @Ok(json:full) @Fail(jsp:jsp:500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2019-02-22 17:12:52,105 org.nutz.mvc.impl.NutLoading.evalUrlMapping(NutLoading.java:220) INFO  - Found 18 module methods
2019-02-22 17:12:52,105 org.nutz.mvc.impl.NutLoading.evalLocalization(NutLoading.java:306) DEBUG - Localization: org.nutz.mvc.impl.NutMessageLoader('msg/')  dft<zh-CN>
2019-02-22 17:12:52,108 org.nutz.resource.Scans.scan(Scans.java:274) DEBUG - Found 1 resource by src( msg/ ) , regex( ^.+[.]properties$ )
2019-02-22 17:12:52,108 org.nutz.mvc.impl.NutMessageLoader.load(NutMessageLoader.java:27) DEBUG - Load Messages in 1 resource : [[NutResource[zh-CN/user.properties]]]
2019-02-22 17:12:52,109 org.nutz.mvc.impl.NutMessageLoader.load(NutMessageLoader.java:95) DEBUG - Message Loaded, size = 2
2019-02-22 17:12:52,110 org.nutz.mvc.impl.NutLoading.evalSetup(NutLoading.java:274) INFO  - Setup application...
2019-02-22 17:12:52,110 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'dao'<interface org.nutz.dao.Dao>
2019-02-22 17:12:52,112 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
2019-02-22 17:12:52,113 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - 	 >> Load definition name=dao
2019-02-22 17:12:52,114 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=dao
2019-02-22 17:12:52,118 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:169) DEBUG - Found IocObject(dao) in JsonLoader(paths=[ioc/])
2019-02-22 17:12:52,118 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - 	 >> Make...'dao'<interface org.nutz.dao.Dao>
2019-02-22 17:12:52,125 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class org.nutz.dao.impl.NutDao without AOP
2019-02-22 17:12:52,126 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'dao' to [app] 
2019-02-22 17:12:52,129 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'dataSource'<>
2019-02-22 17:12:52,130 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - 	 >> Load definition name=dataSource
2019-02-22 17:12:52,132 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=dataSource
2019-02-22 17:12:52,141 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:169) DEBUG - Found IocObject(dataSource) in JsonLoader(paths=[ioc/])
2019-02-22 17:12:52,141 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - 	 >> Make...'dataSource'<>
2019-02-22 17:12:52,157 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class com.alibaba.druid.pool.DruidDataSource without AOP
2019-02-22 17:12:52,157 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'dataSource' to [app] 
2019-02-22 17:12:52,162 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'conf'<>
2019-02-22 17:12:52,163 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - 	 >> Load definition name=conf
2019-02-22 17:12:52,163 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=conf
2019-02-22 17:12:52,164 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:169) DEBUG - Found IocObject(conf) in JsonLoader(paths=[ioc/])
2019-02-22 17:12:52,164 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - 	 >> Make...'conf'<>
2019-02-22 17:12:52,165 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class org.nutz.ioc.impl.PropertiesProxy without AOP
2019-02-22 17:12:52,165 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'conf' to [app] 
2019-02-22 17:12:52,173 org.nutz.resource.Scans.scan(Scans.java:274) DEBUG - Found 2 resource by src( custom/ ) , regex( ^.+[.]properties$ )
2019-02-22 17:12:52,297 com.alibaba.druid.pool.DruidDataSource.init(DruidDataSource.java:715) INFO  - {dataSource-1} inited
2019-02-22 17:12:52,299 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'dataSource'<>
2019-02-22 17:12:52,318 org.nutz.filepool.NutFilePool.<init>(NutFilePool.java:23) INFO  - Init file-pool by: C:\Users\Administrator/.nutz/tmp/dao/ [200000]
2019-02-22 17:12:52,319 org.nutz.filepool.NutFilePool.<init>(NutFilePool.java:37) DEBUG - file-pool.home: 'C:\Users\Administrator\.nutz\tmp\dao'
2019-02-22 17:12:52,319 org.nutz.filepool.NutFilePool.<init>(NutFilePool.java:66) INFO  - file-pool.cursor: 0
2019-02-22 17:12:52,325 org.nutz.dao.jdbc.Jdbcs.<clinit>(Jdbcs.java:90) DEBUG - Jdbcs init complete
2019-02-22 17:12:52,325 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
2019-02-22 17:12:52,504 org.nutz.dao.impl.DaoSupport.setDataSource(DaoSupport.java:188) DEBUG - select expert : org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert
2019-02-22 17:12:52,510 org.nutz.dao.impl.DaoSupport$1.invoke(DaoSupport.java:199) DEBUG - JDBC Driver --> mysql-connector-java-5.1.20 ( Revision: tonci.grgin@oracle.com-20111003110438-qfydx066wsbydkbw )
2019-02-22 17:12:52,510 org.nutz.dao.impl.DaoSupport$1.invoke(DaoSupport.java:200) DEBUG - JDBC Name   --> MySQL-AB JDBC Driver
2019-02-22 17:12:52,510 org.nutz.dao.impl.DaoSupport$1.invoke(DaoSupport.java:202) DEBUG - JDBC URL    --> jdbc:mysql://127.0.0.1:3306/test
2019-02-22 17:12:52,605 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) DEBUG - Mysql : character_set_client=utf8mb4
2019-02-22 17:12:52,605 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) DEBUG - Mysql : character_set_connection=utf8mb4
2019-02-22 17:12:52,605 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) DEBUG - Mysql : character_set_database=utf8
2019-02-22 17:12:52,605 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) DEBUG - Mysql : character_set_filesystem=binary
2019-02-22 17:12:52,606 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) DEBUG - Mysql : character_set_results=
2019-02-22 17:12:52,606 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) DEBUG - Mysql : character_set_server=utf8
2019-02-22 17:12:52,606 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) DEBUG - Mysql : character_set_system=utf8
2019-02-22 17:12:52,606 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) DEBUG - Mysql : character_sets_dir=C:\Program Files (x86)\MySQL\MySQL Server 5.5\share\charsets\
2019-02-22 17:12:52,607 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:219) DEBUG - Mysql : binlog_format=STATEMENT
2019-02-22 17:12:52,608 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:226) DEBUG - Mysql : database=test
2019-02-22 17:12:52,609 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:232) DEBUG - Mysql : user=root@localhost
2019-02-22 17:12:52,635 org.nutz.dao.impl.DaoSupport.setDataSource(DaoSupport.java:221) DEBUG - Database info --> MYSQL:[MySQL - 5.5.49]
2019-02-22 17:12:52,642 org.nutz.resource.Scans.scan(Scans.java:274) DEBUG - Found 19 resource by src( net/wendal/nutzbook/ ) , regex( ^.+[.]class$ )
2019-02-22 17:12:52,692 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'nutQuartzCronJobFactory'<class org.nutz.integration.quartz.NutQuartzCronJobFactory>
2019-02-22 17:12:52,692 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - 	 >> Load definition name=nutQuartzCronJobFactory
2019-02-22 17:12:52,692 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=nutQuartzCronJobFactory
2019-02-22 17:12:52,692 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:169) DEBUG - Found IocObject(nutQuartzCronJobFactory) in QuartzIocLoader@1075978339
2019-02-22 17:12:52,693 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - 	 >> Make...'nutQuartzCronJobFactory'<class org.nutz.integration.quartz.NutQuartzCronJobFactory>
2019-02-22 17:12:52,694 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class org.nutz.integration.quartz.NutQuartzCronJobFactory without AOP
2019-02-22 17:12:52,694 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'nutQuartzCronJobFactory' to [app] 
2019-02-22 17:12:52,695 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'scheduler'<>
2019-02-22 17:12:52,695 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - 	 >> Load definition name=scheduler
2019-02-22 17:12:52,695 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=scheduler
2019-02-22 17:12:52,696 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:169) DEBUG - Found IocObject(scheduler) in QuartzIocLoader@1075978339
2019-02-22 17:12:52,696 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - 	 >> Make...'scheduler'<>
2019-02-22 17:12:52,696 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'scheduler' to [app] 
2019-02-22 17:12:52,748 org.quartz.core.SchedulerSignalerImpl.<init>(SchedulerSignalerImpl.java:61) INFO  - Initialized Scheduler Signaller of type: class org.quartz.core.SchedulerSignalerImpl
2019-02-22 17:12:52,748 org.quartz.core.QuartzScheduler.<init>(QuartzScheduler.java:234) INFO  - Quartz Scheduler v.2.0.0 created.
2019-02-22 17:12:52,751 org.quartz.simpl.RAMJobStore.initialize(RAMJobStore.java:154) INFO  - RAMJobStore initialized.
2019-02-22 17:12:52,752 org.quartz.core.QuartzScheduler.initialize(QuartzScheduler.java:257) INFO  - Scheduler meta-data: Quartz Scheduler (v2.0.0) '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.

2019-02-22 17:12:52,753 org.quartz.impl.StdSchedulerFactory.instantiate(StdSchedulerFactory.java:1254) INFO  - Quartz scheduler 'NutzbookScheduler' initialized from default resource file in Quartz package: 'quartz.properties'
2019-02-22 17:12:52,753 org.quartz.impl.StdSchedulerFactory.instantiate(StdSchedulerFactory.java:1258) INFO  - Quartz scheduler version: 2.0.0
2019-02-22 17:12:52,753 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'jobFactory'<>
2019-02-22 17:12:52,753 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - 	 >> Load definition name=jobFactory
2019-02-22 17:12:52,753 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=jobFactory
2019-02-22 17:12:52,755 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:169) DEBUG - Found IocObject(jobFactory) in QuartzIocLoader@1075978339
2019-02-22 17:12:52,755 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - 	 >> Make...'jobFactory'<>
2019-02-22 17:12:52,756 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class org.nutz.integration.quartz.NutQuartzJobFactory without AOP
2019-02-22 17:12:52,757 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'jobFactory' to [app] 
2019-02-22 17:12:52,758 org.quartz.core.QuartzScheduler.setJobFactory(QuartzScheduler.java:2223) INFO  - JobFactory set to: org.nutz.integration.quartz.NutQuartzJobFactory@4be724f4
2019-02-22 17:12:52,759 org.quartz.core.QuartzSchedulerThread.run(QuartzSchedulerThread.java:268) DEBUG - batch acquisition of 0 triggers
2019-02-22 17:12:52,759 org.quartz.core.QuartzScheduler.start(QuartzScheduler.java:513) INFO  - Scheduler NutzbookScheduler_$_NON_CLUSTERED started.
2019-02-22 17:12:52,759 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'conf'<>
2019-02-22 17:12:52,760 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:141) INFO  - Nutz.Mvc[nutz] is up in 959ms
2019-02-22 17:12:52,760 org.nutz.mvc.NutFilter._init(NutFilter.java:113) INFO  - exclusionsPrefix  = ^(/rs/|/druid/)
二月 22, 2019 5:12:52 下午 org.apache.catalina.startup.HostConfig deployDirectory
信息: Deploying web application directory E:\develop\apache-tomcat_nutz\webapps\ROOT
二月 22, 2019 5:12:52 下午 org.apache.coyote.AbstractProtocol start
信息: Starting ProtocolHandler ["http-bio-8080"]
二月 22, 2019 5:12:52 下午 org.apache.coyote.AbstractProtocol start
信息: Starting ProtocolHandler ["ajp-bio-8009"]
二月 22, 2019 5:12:52 下午 org.apache.catalina.startup.Catalina start
信息: Server startup in 2771 ms
2019-02-22 17:13:00,268 org.nutz.mvc.impl.UrlMappingImpl.get(UrlMappingImpl.java:101) DEBUG - Found mapping for [GET] path=/user/profile/ : UserProfileModule.index(UserProfileModule.java:145)
2019-02-22 17:13:00,270 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'userProfileModule'<class net.wendal.nutzbook.module.UserProfileModule>
2019-02-22 17:13:00,270 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - 	 >> Load definition name=userProfileModule
2019-02-22 17:13:00,270 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:169) DEBUG - Found IocObject(userProfileModule) in AnnotationIocLoader(packages=[net.wendal.nutzbook])
2019-02-22 17:13:00,270 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - 	 >> Make...'userProfileModule'<class net.wendal.nutzbook.module.UserProfileModule>
2019-02-22 17:13:00,271 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class net.wendal.nutzbook.module.UserProfileModule without AOP
2019-02-22 17:13:00,271 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'userProfileModule' to [app] 
2019-02-22 17:13:00,276 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'dao'<interface org.nutz.dao.Dao>
2019-02-22 17:13:00,278 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'emailService'<interface net.wendal.nutzbook.service.EmailService>
2019-02-22 17:13:00,278 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - 	 >> Load definition name=emailService
2019-02-22 17:13:00,279 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:169) DEBUG - Found IocObject(emailService) in AnnotationIocLoader(packages=[net.wendal.nutzbook])
2019-02-22 17:13:00,279 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - 	 >> Make...'emailService'<interface net.wendal.nutzbook.service.EmailService>
2019-02-22 17:13:00,279 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class net.wendal.nutzbook.service.EmailServiceImpl without AOP
2019-02-22 17:13:00,280 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'emailService' to [app] 
2019-02-22 17:13:00,281 net.wendal.nutzbook.mvc.LogTimeProcessor.process(LogTimeProcessor.java:24) DEBUG - [ GET]URI=/nutzbook/user/profile/ 13ms
2019-02-22 17:13:01,611 org.nutz.mvc.impl.UrlMappingImpl.get(UrlMappingImpl.java:101) DEBUG - Found mapping for [POST] path=/user/login : UserModule.login(UserModule.java:53)
2019-02-22 17:13:01,611 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'userModule'<class net.wendal.nutzbook.module.UserModule>
2019-02-22 17:13:01,611 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - 	 >> Load definition name=userModule
2019-02-22 17:13:01,611 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:169) DEBUG - Found IocObject(userModule) in AnnotationIocLoader(packages=[net.wendal.nutzbook])
2019-02-22 17:13:01,612 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - 	 >> Make...'userModule'<class net.wendal.nutzbook.module.UserModule>
2019-02-22 17:13:01,612 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'txREAD_COMMITTED'<interface org.nutz.aop.MethodInterceptor>
2019-02-22 17:13:01,612 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - 	 >> Load definition name=txREAD_COMMITTED
2019-02-22 17:13:01,612 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=txREAD_COMMITTED
2019-02-22 17:13:01,614 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:169) DEBUG - Found IocObject(txREAD_COMMITTED) in TransIocLoader@574792579
2019-02-22 17:13:01,614 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - 	 >> Make...'txREAD_COMMITTED'<interface org.nutz.aop.MethodInterceptor>
2019-02-22 17:13:01,614 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'txREAD_COMMITTED' to [app] 
2019-02-22 17:13:01,619 org.nutz.aop.asm.AsmClassAgent.<clinit>(AsmClassAgent.java:29) DEBUG - AsmClassAgent will define class in Version 50
2019-02-22 17:13:01,627 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'userModule' to [app] 
2019-02-22 17:13:01,628 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'userService'<class net.wendal.nutzbook.service.UserService>
2019-02-22 17:13:01,628 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - 	 >> Load definition name=userService
2019-02-22 17:13:01,628 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:169) DEBUG - Found IocObject(userService) in AnnotationIocLoader(packages=[net.wendal.nutzbook])
2019-02-22 17:13:01,628 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - 	 >> Make...'userService'<class net.wendal.nutzbook.service.UserService>
2019-02-22 17:13:01,628 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class net.wendal.nutzbook.service.UserService without AOP
2019-02-22 17:13:01,629 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'userService' to [app] 
2019-02-22 17:13:01,629 org.nutz.service.EntityService.<init>(EntityService.java:41) DEBUG - Get TypeParams for self : net.wendal.nutzbook.bean.User
2019-02-22 17:13:01,629 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'dao'<>
2019-02-22 17:13:01,629 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'dao'<interface org.nutz.dao.Dao>
2019-02-22 17:13:01,630 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'emailService'<interface net.wendal.nutzbook.service.EmailService>
2019-02-22 17:13:01,644 org.nutz.dao.impl.sql.run.NutDaoExecutor.printSQL(NutDaoExecutor.java:388) DEBUG - SELECT * FROM t_user  WHERE name=? AND passwd=? LIMIT 0, 1 
    |     1 |      2 |
    |-------|--------|
    | admin | 123456 |
  For example:> "SELECT * FROM t_user  WHERE name='admin' AND passwd='123456' LIMIT 0, 1 "
2019-02-22 17:13:01,651 net.wendal.nutzbook.mvc.LogTimeProcessor.process(LogTimeProcessor.java:24) DEBUG - [POST]URI=/nutzbook/user/login 40ms
2019-02-22 17:13:09,720 org.nutz.mvc.impl.UrlMappingImpl.get(UrlMappingImpl.java:101) DEBUG - Found mapping for [GET] path=/user/profile/ : UserProfileModule.index(UserProfileModule.java:145)
2019-02-22 17:13:09,720 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'userProfileModule'<class net.wendal.nutzbook.module.UserProfileModule>
2019-02-22 17:13:09,733 org.nutz.dao.impl.sql.run.NutDaoExecutor.printSQL(NutDaoExecutor.java:388) DEBUG - SELECT uid,nickname,email,email_checked,gender,dt,loc,ct,ut FROM t_user_profile  WHERE uid=?
    | 1 |
    |---|
    | 1 |
  For example:> "SELECT uid,nickname,email,email_checked,gender,dt,loc,ct,ut FROM t_user_profile  WHERE uid=1"
2019-02-22 17:13:09,758 net.wendal.nutzbook.mvc.LogTimeProcessor.process(LogTimeProcessor.java:24) DEBUG - [ GET]URI=/nutzbook/user/profile/ 38ms
2019-02-22 17:13:09,773 org.nutz.mvc.impl.UrlMappingImpl.get(UrlMappingImpl.java:101) DEBUG - Found mapping for [GET] path=/user/profile/avatar : UserProfileModule.readAvatar(UserProfileModule.java:133)
2019-02-22 17:13:09,773 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'userProfileModule'<class net.wendal.nutzbook.module.UserProfileModule>
2019-02-22 17:13:09,774 org.nutz.dao.impl.sql.run.NutDaoExecutor.printSQL(NutDaoExecutor.java:388) DEBUG - SELECT avatar FROM t_user_profile  WHERE uid=?
    | 1 |
    |---|
    | 1 |
  For example:> "SELECT avatar FROM t_user_profile  WHERE uid=1"
2019-02-22 17:13:09,777 net.wendal.nutzbook.mvc.LogTimeProcessor.process(LogTimeProcessor.java:24) DEBUG - [ GET]URI=/nutzbook/user/profile/avatar 4ms
2019-02-22 17:13:12,150 org.nutz.mvc.impl.UrlMappingImpl.get(UrlMappingImpl.java:101) DEBUG - Found mapping for [POST] path=/user/profile/active/mail : UserProfileModule.activeMail(UserProfileModule.java:153)
2019-02-22 17:13:12,151 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'userProfileModule'<class net.wendal.nutzbook.module.UserProfileModule>
2019-02-22 17:13:12,152 org.nutz.dao.impl.sql.run.NutDaoExecutor.printSQL(NutDaoExecutor.java:388) DEBUG - SELECT uid,nickname,email,email_checked,gender,dt,loc,ct,ut FROM t_user_profile  WHERE uid=?
    | 1 |
    |---|
    | 1 |
  For example:> "SELECT uid,nickname,email,email_checked,gender,dt,loc,ct,ut FROM t_user_profile  WHERE uid=1"
2019-02-22 17:13:12,162 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'htmlEmail'<class org.apache.commons.mail.HtmlEmail>
2019-02-22 17:13:12,163 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - 	 >> Load definition name=htmlEmail
2019-02-22 17:13:12,164 net.wendal.nutzbook.module.UserProfileModule.activeMail(UserProfileModule.java:169) DEBUG - 发送邮件失败
org.nutz.ioc.IocException: [htmlEmail] # For object [htmlEmail] - type:[class org.apache.commons.mail.HtmlEmail]
	at org.nutz.ioc.impl.NutIoc.get(NutIoc.java:218)
	at org.nutz.ioc.impl.NutIoc.get(NutIoc.java:239)
	at org.nutz.ioc.impl.NutIoc.get(NutIoc.java:146)
	at net.wendal.nutzbook.service.EmailServiceImpl.send(EmailServiceImpl.java:21)
	at net.wendal.nutzbook.module.UserProfileModule.activeMail(UserProfileModule.java:164)
	at net.wendal.nutzbook.module.UserProfileModule$$FASTCLASS._invoke(UserProfileModule.java:1)
	at org.nutz.lang.reflect.AbstractFastClass.invoke(AbstractFastClass.java:143)
	at org.nutz.lang.reflect.FastClassFactory.invoke(FastClassFactory.java:67)
	at org.nutz.mvc.impl.processor.MethodInvokeProcessor.process(MethodInvokeProcessor.java:27)
	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.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:198)
	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:243)
	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:210)
	at com.alibaba.druid.support.http.WebStatFilter.doFilter(WebStatFilter.java:123)
	at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:243)
	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:210)
	at org.apache.shiro.web.servlet.ProxiedFilterChain.doFilter(ProxiedFilterChain.java:61)
	at org.apache.shiro.web.servlet.AdviceFilter.executeChain(AdviceFilter.java:108)
	at org.apache.shiro.web.servlet.AdviceFilter.doFilterInternal(AdviceFilter.java:137)
	at org.apache.shiro.web.servlet.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:125)
	at org.apache.shiro.web.servlet.ProxiedFilterChain.doFilter(ProxiedFilterChain.java:66)
	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:243)
	at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:210)
	at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:222)
	at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:123)
	at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:502)
	at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:171)
	at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:99)
	at org.apache.catalina.valves.AccessLogValve.invoke(AccessLogValve.java:953)
	at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:118)
	at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:408)
	at org.apache.coyote.http11.AbstractHttp11Processor.process(AbstractHttp11Processor.java:1023)
	at org.apache.coyote.AbstractProtocol$AbstractConnectionHandler.process(AbstractProtocol.java:589)
	at org.apache.tomcat.util.net.JIoEndpoint$SocketProcessor.run(JIoEndpoint.java:312)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
	at java.lang.Thread.run(Thread.java:745)
Caused by: org.nutz.ioc.ObjectLoadException: Object 'htmlEmail' without define!
	at org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:174)
	at org.nutz.ioc.impl.NutIoc.get(NutIoc.java:180)
	... 61 more
2019-02-22 17:13:12,166 net.wendal.nutzbook.mvc.LogTimeProcessor.process(LogTimeProcessor.java:24) DEBUG - [POST]URI=/nutzbook/user/profile/active/mail 15ms
2019-02-22 17:13:16,113 org.quartz.core.QuartzSchedulerThread.run(QuartzSchedulerThread.java:268) DEBUG - batch acquisition of 0 triggers

mail.js配置  存放路径：conf/ioc/
var ioc={
    emailAuthenticator : {
        type : "org.apache.commons.mail.DefaultAuthenticator",
        args : [{java:"$conf.get('mail.UserName')"}, {java:"$conf.get('mail.Password')"}]
    },
    htmlEmail : {
        type : "org.apache.commons.mail.ImageHtmlEmail",
        singleton : false,
        fields : {
            hostName : {java:"$conf.get('mail.HostName')"},
            smtpPort : {java:"$conf.get('mail.SmtpPort')"},
            authenticator : {refer:"emailAuthenticator"},
            SSLOnConnect : {java:"$conf.get('mail.SSLOnConnect')"},
            from : {java:"$conf.get('mail.From')"},
            charset : {java:"$conf.get('mail.charset', 'UTF-8')"}
        }
    }

mail.properties配置       存放路径：conf/custom/
mail.HostName=smtp.163.com
mail.SmtpPort=25
mail.UserName=15313285216@163.com
mail.Password=YU5211314chao
mail.SSLOnConnect=false
mail.From=15313285216@163.com
mail.charset=UTF-8
7 回复

没放在dao.js同一目录下？

2019-02-22 17:12:51,832 org.nutz.ioc.loader.json.JsonLoader.<init>(JsonLoader.java:56) DEBUG - Loaded 3 bean define from path=[ioc/] --> [conf, dao, dataSource]

和dao.js是在同一目录下的

dao.js 配置     存放路径：conf/ioc/dao.js

var ioc = {
        conf : {
            type : "org.nutz.ioc.impl.PropertiesProxy",
            fields : {
                paths : ["custom/"]
            }
        },
        dataSource : {
                factory : "$conf#make",
                args : ["com.alibaba.druid.pool.DruidDataSource", "db."],
                type : "com.alibaba.druid.pool.DruidDataSource",
                events : {
                    create : "init",
                        depose : 'close'
                }
        },
      dao : {
          type : "org.nutz.dao.impl.NutDao",
            args : [{refer:"dataSource"}]
      }
};

跟mail.json同一目录？

嗯呢，mail.js 存放路径：conf/ioc/mail.js

clean project，也许是编译问题

嗯嗯，好像别人没出现这种问题

添加回复
请先登陆
回到顶部