2017-08-01 14:14:14,160 org.apache.shiro.web.env.EnvironmentLoader.initEnvironment(EnvironmentLoader.java:128) INFO - Starting Shiro environment initialization.
2017-08-01 14:14:14,194 org.apache.shiro.web.env.IniWebEnvironment.init(IniWebEnvironment.java:76) DEBUG - Checking any specified config locations.
2017-08-01 14:14:14,195 org.apache.shiro.web.env.IniWebEnvironment.init(IniWebEnvironment.java:81) DEBUG - No INI instance or config locations specified. Trying default config locations.
2017-08-01 14:14:14,204 org.apache.shiro.io.ResourceUtils.loadFromClassPath(ResourceUtils.java:159) DEBUG - Opening resource from class path [shiro.ini]
2017-08-01 14:14:14,211 org.apache.shiro.config.Ini.load(Ini.java:351) DEBUG - Parsing [main]
2017-08-01 14:14:14,211 org.apache.shiro.config.Ini.load(Ini.java:351) DEBUG - Parsing [urls]
2017-08-01 14:14:14,214 org.apache.shiro.web.env.IniWebEnvironment.getDefaultIni(IniWebEnvironment.java:136) DEBUG - Discovered non-empty INI configuration at location 'classpath:shiro.ini'. Using for configuration.
2017-08-01 14:14:14,222 org.apache.shiro.config.IniFactorySupport.createInstance(IniFactorySupport.java:122) DEBUG - Creating instance from Ini [sections=urls]
2017-08-01 14:14:14,638 org.apache.shiro.config.IniFactorySupport.createInstance(IniFactorySupport.java:122) DEBUG - Creating instance from Ini [sections=urls]
2017-08-01 14:14:14,644 org.apache.shiro.web.filter.mgt.DefaultFilterChainManager.createChain(DefaultFilterChainManager.java:127) DEBUG - Creating chain [/*] from String definition [anon]
2017-08-01 14:14:14,645 org.apache.shiro.web.filter.mgt.DefaultFilterChainManager.applyChainConfig(DefaultFilterChainManager.java:278) DEBUG - Attempting to apply path [/*] to filter [anon] with config [null]
2017-08-01 14:14:14,646 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]
2017-08-01 14:14:14,646 org.apache.shiro.web.env.EnvironmentLoader.initEnvironment(EnvironmentLoader.java:141) INFO - Shiro environment initialized in 479 ms.
2017-08-01 14:14:14,703 org.nutz.mvc.NutFilter._init(NutFilter.java:81) INFO - NutFilter[nutz] starting ...
2017-08-01 14:14:14,804 org.nutz.resource.Scans.(Scans.java:509) DEBUG - Locations for Scans:
[Dir[path=D:\eclipse], Jar[path=D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\nutz-1.r.60.jar], Dir[path=D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\classes], Jar[path=D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\bin\bootstrap.jar], Jar[path=D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\bin\tomcat-juli.jar]]
2017-08-01 14:14:15,033 org.nutz.resource.Scans.init(Scans.java:105) DEBUG - Locations for Scans:
{D:\eclipse=Dir[path=D:\eclipse], D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\nutz-1.r.60.jar=Jar[path=D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\nutz-1.r.60.jar], D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\classes=Dir[path=D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\classes], D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\bin\bootstrap.jar=Jar[path=D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\bin\bootstrap.jar], D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\bin\tomcat-juli.jar=Jar[path=D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\bin\tomcat-juli.jar], D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\taglibs-standard-impl-1.2.5.jar=Jar[path=D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\taglibs-standard-impl-1.2.5.jar], D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\commons-beanutils-1.9.3.jar=Jar[path=D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\commons-beanutils-1.9.3.jar], D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\javax.servlet.jsp.jstl-api-1.2.1.jar=Jar[path=D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\javax.servlet.jsp.jstl-api-1.2.1.jar], D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\slf4j-log4j12-1.7.25.jar=Jar[path=D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\slf4j-log4j12-1.7.25.jar], D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\javax.mail-1.5.2.jar=Jar[path=D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\javax.mail-1.5.2.jar], D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\commons-logging-1.2.jar=Jar[path=D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\commons-logging-1.2.jar], D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\taglibs-standard-spec-1.2.5.jar=Jar[path=D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\taglibs-standard-spec-1.2.5.jar], D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\log4j-1.2.17.jar=Jar[path=D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\log4j-1.2.17.jar], D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\quartz-2.1.7.jar=Jar[path=D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\quartz-2.1.7.jar], D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\taglibs-standard-jstlel-1.2.5.jar=Jar[path=D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\taglibs-standard-jstlel-1.2.5.jar], D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\nutz-integration-quartz-1.r.60.r2.jar=Jar[path=D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\nutz-integration-quartz-1.r.60.r2.jar], D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\slf4j-api-1.7.25.jar=Jar[path=D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\slf4j-api-1.7.25.jar], D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\nutz-integration-shiro-1.r.60.r2.jar=Jar[path=D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\nutz-integration-shiro-1.r.60.r2.jar], D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\druid-1.0.26.jar=Jar[path=D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\druid-1.0.26.jar], D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\mysql-connector-java-5.1.40.jar=Jar[path=D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\mysql-connector-java-5.1.40.jar], D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\commons-email-1.3.3.jar=Jar[path=D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\commons-email-1.3.3.jar], D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\shiro-all-1.3.2.jar=Jar[path=D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\lib\shiro-all-1.3.2.jar]}
2017-08-01 14:14:15,194 org.nutz.castor.Castors.reload(Castors.java:115) DEBUG - Using 95 castor for Castors
2017-08-01 14:14:15,229 org.nutz.mvc.config.AbstractNutConfig.createLoading(AbstractNutConfig.java:59) DEBUG - Loading by class org.nutz.mvc.impl.NutLoading
2017-08-01 14:14:15,233 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:55) INFO - Nutz Version : 1.r.60
2017-08-01 14:14:15,233 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:56) INFO - Nutz.Mvc[nutz] is initializing ...
2017-08-01 14:14:15,233 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:60) DEBUG - Web Container Information:
2017-08-01 14:14:15,234 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:61) DEBUG - - Default Charset : UTF-8
2017-08-01 14:14:15,234 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:62) DEBUG - - Current . path : D:\eclipse.
2017-08-01 14:14:15,234 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:63) DEBUG - - Java Version : 1.8.0_144
2017-08-01 14:14:15,234 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:64) DEBUG - - File separator : \
2017-08-01 14:14:15,235 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:65) DEBUG - - Timezone : Asia/Shanghai
2017-08-01 14:14:15,235 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:66) DEBUG - - OS : Windows 10 amd64
2017-08-01 14:14:15,235 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:67) DEBUG - - ServerInfo : Apache Tomcat/8.0.45
2017-08-01 14:14:15,235 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:68) DEBUG - - Servlet API : 3.1
2017-08-01 14:14:15,235 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:73) DEBUG - - ContextPath : /nutzbook
2017-08-01 14:14:15,236 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:74) DEBUG - - context.tempdir : D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\work\Catalina\localhost\nutzbook
2017-08-01 14:14:15,236 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:75) DEBUG - - MainModule : net.wendal.nutzbook.MainModule
2017-08-01 14:14:15,238 org.nutz.mvc.impl.NutLoading.createContext(NutLoading.java:238) DEBUG - >> app.root = D:/java/apache-tomcat-8.0.45/apache-tomcat-8.0.45/wtpwebapps/nutzbook
2017-08-01 14:14:15,241 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=[])
2017-08-01 14:14:15,278 org.nutz.resource.Scans.scan(Scans.java:274) DEBUG - Found 2 resource by src( ioc/ ) , regex( ^(.+[.])(js|json)$ )
2017-08-01 14:14:15,278 org.nutz.ioc.loader.json.JsonLoader.(JsonLoader.java:48) DEBUG - loading ioc js config from [dao.js]
2017-08-01 14:14:15,290 org.nutz.ioc.loader.json.JsonLoader.(JsonLoader.java:48) DEBUG - loading ioc js config from [mail.js]
2017-08-01 14:14:15,292 org.nutz.ioc.loader.json.JsonLoader.(JsonLoader.java:56) DEBUG - Loaded 5 bean define from path=[ioc/] --> [conf, dao, emailAuthenticator, dataSource, htmlEmail]
2017-08-01 14:14:15,304 org.nutz.resource.Scans.scan(Scans.java:274) DEBUG - Found 13 resource by src( net/wendal/nutzbook/ ) , regex( ^.+[.]class$ )
2017-08-01 14:14:15,360 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:74) DEBUG - Found @IocBean : class net.wendal.nutzbook.module.UserModule
2017-08-01 14:14:15,392 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:74) DEBUG - Found @IocBean : class net.wendal.nutzbook.module.UserProfileModule
2017-08-01 14:14:15,483 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:74) DEBUG - Found @IocBean : class net.wendal.nutzbook.quartz.jop.CleanNonActiveUserJob
2017-08-01 14:14:15,489 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:74) DEBUG - Found @IocBean : class net.wendal.nutzbook.server.EmailServiceImpl
2017-08-01 14:14:15,492 org.nutz.ioc.loader.annotation.AnnotationIocLoader.(AnnotationIocLoader.java:50) INFO - Found 4 classes in 1 base-packages!
beans = ["cleanNonActiveUserJob", "userProfileModule", "userModule", "emailService"]
2017-08-01 14:14:15,498 org.nutz.ioc.loader.json.JsonLoader.(JsonLoader.java:40) DEBUG - Loaded 5 bean define from reader --
[txREPEATABLE_READ, txSERIALIZABLE, txNONE, txREAD_UNCOMMITTED, txREAD_COMMITTED]
2017-08-01 14:14:15,503 org.nutz.ioc.loader.combo.ComboIocLoader.createIocLoader(ComboIocLoader.java:118) DEBUG - found org.nutz.integration.quartz.QuartzIocLoader -- org.nutz.integration.quartz.QuartzIocLoader
2017-08-01 14:14:15,503 org.nutz.ioc.loader.json.JsonLoader.(JsonLoader.java:56) DEBUG - Loaded 0 bean define from path=[] --> []
2017-08-01 14:14:15,525 org.nutz.ioc.impl.NutIoc.(NutIoc.java:98) INFO - NutIoc init begin ...
2017-08-01 14:14:15,533 org.nutz.ioc.impl.NutIoc.(NutIoc.java:115) INFO - ... NutIoc init complete
2017-08-01 14:14:15,538 org.nutz.mvc.impl.NutLoading.evalUrlMapping(NutLoading.java:159) INFO - Build URL mapping by org.nutz.mvc.impl.UrlMappingImpl ...
2017-08-01 14:14:15,543 org.nutz.mvc.impl.NutLoading.createViewMakers(NutLoading.java:369) DEBUG - @Views(DefaultViewMaker.class)
2017-08-01 14:14:15,559 org.nutz.resource.Scans.scan(Scans.java:274) DEBUG - Found 1 resource by src( mvc/nutzbook-mvc-chain.js ) , regex( ^(.+[.])(js|json)$ )
2017-08-01 14:14:15,571 org.nutz.mvc.impl.chainconfig.JsonActionChainMakerConfiguretion.(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"
}
}
2017-08-01 14:14:15,571 org.nutz.mvc.impl.NutLoading.createChainMaker(NutLoading.java:266) DEBUG - @ChainBy(org.nutz.mvc.impl.NutActionChainMaker)
2017-08-01 14:14:15,586 org.nutz.mvc.impl.Loadings.scanModules(Loadings.java:154) DEBUG - module class location 'file:/D:/java/apache-tomcat-8.0.45/apache-tomcat-8.0.45/wtpwebapps/nutzbook/WEB-INF/classes/'
2017-08-01 14:14:15,587 org.nutz.mvc.impl.Loadings.scanModuleInPackage(Loadings.java:184) DEBUG - > scan 'net.wendal.nutzbook'
2017-08-01 14:14:15,594 org.nutz.resource.Scans.scan(Scans.java:274) DEBUG - Found 13 resource by src( net/wendal/nutzbook/ ) , regex( ^.+[.]class$ )
2017-08-01 14:14:15,596 org.nutz.mvc.impl.Loadings.checkModule(Loadings.java:198) DEBUG - >> add 'net.wendal.nutzbook.module.UserModule'
2017-08-01 14:14:15,596 org.nutz.mvc.impl.Loadings.checkModule(Loadings.java:198) DEBUG - >> add 'net.wendal.nutzbook.module.UserProfileModule'
2017-08-01 14:14:15,712 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/add' >> (UserModule.java:105).add : Object | @Ok(json ) @Fail(http:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2017-08-01 14:14:15,714 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/count' >> (UserModule.java:38).count : int | @Ok(json ) @Fail(http:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2017-08-01 14:14:15,716 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/update' >> (UserModule.java:123).update : Object | @Ok(json ) @Fail(http:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2017-08-01 14:14:15,725 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/delete' >> (UserModule.java:144).delete : Object | @Ok(json ) @Fail(http:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2017-08-01 14:14:15,734 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/query' >> (UserModule.java:89).query : Object | @Ok(json ) @Fail(http:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2017-08-01 14:14:15,736 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/logout' >> (UserModule.java:67).logout : Object | @Ok(json ) @Fail(http:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2017-08-01 14:14:15,740 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/login' >> (UserModule.java:49).login : Object | @Ok(json ) @Fail(http:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2017-08-01 14:14:15,744 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/tolist' >> (UserModule.java:80).tolist : void | @Ok(jsp:jsp.user.list) @Fail(http:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2017-08-01 14:14:15,753 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/profile/' >> (UserProfileModule.java:165).index : UserProfile | @Ok(jsp:jsp.user.profile) @Fail(jsp:jsp.500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2017-08-01 14:14:15,754 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/profile/get' >> (UserProfileModule.java:53).get : UserProfile | @Ok(json:full) @Fail(jsp:jsp.500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2017-08-01 14:14:15,759 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/profile/update' >> (UserProfileModule.java:72).update : void | @Ok(void ) @Fail(jsp:jsp.500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2017-08-01 14:14:15,762 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/profile/avatar' >> (UserProfileModule.java:149).readAvatar : Object | @Ok(raw:jpg) @Fail(jsp:jsp.500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2017-08-01 14:14:15,765 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/profile/active/mail' >> (UserProfileModule.java:172).activeMail : Object | @Ok(json:full) @Fail(jsp:jsp.500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2017-08-01 14:14:15,773 org.nutz.filepool.NutFilePool.(NutFilePool.java:23) INFO - Init file-pool by: D:/java/apache-tomcat-8.0.45/apache-tomcat-8.0.45/wtpwebapps/nutzbook/WEB-INF/tmp/user_avatar [20000]
2017-08-01 14:14:15,776 org.nutz.filepool.NutFilePool.(NutFilePool.java:37) DEBUG - file-pool.home: 'D:\java\apache-tomcat-8.0.45\apache-tomcat-8.0.45\wtpwebapps\nutzbook\WEB-INF\tmp\user_avatar'
2017-08-01 14:14:15,777 org.nutz.filepool.NutFilePool.(NutFilePool.java:66) INFO - file-pool.cursor: 0
2017-08-01 14:14:15,794 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/profile/avatar' >> (UserProfileModule.java:113).uploadAvatar : void | @Ok(>>:/user/profile) @Fail(jsp:jsp.500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2017-08-01 14:14:15,795 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/profile/active/mail' >> (UserProfileModule.java:209).activeMailCallback : String | @Ok(raw ) @Fail(jsp:jsp.500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2017-08-01 14:14:15,795 org.nutz.mvc.impl.NutLoading.evalUrlMapping(NutLoading.java:220) INFO - Found 15 module methods
2017-08-01 14:14:15,796 org.nutz.mvc.impl.NutLoading.evalLocalization(NutLoading.java:306) DEBUG - Localization: org.nutz.mvc.impl.NutMessageLoader('msg/') dft
2017-08-01 14:14:15,801 org.nutz.resource.Scans.scan(Scans.java:274) DEBUG - Found 1 resource by src( msg/ ) , regex( ^.+[.]properties$ )
2017-08-01 14:14:15,801 org.nutz.mvc.impl.NutMessageLoader.load(NutMessageLoader.java:27) DEBUG - Load Messages in 1 resource : [[NutResource[zh-CN/user.properties]]]
2017-08-01 14:14:15,803 org.nutz.mvc.impl.NutMessageLoader.load(NutMessageLoader.java:95) DEBUG - Message Loaded, size = 2
2017-08-01 14:14:15,804 org.nutz.mvc.impl.NutLoading.evalSetup(NutLoading.java:274) INFO - Setup application...
2017-08-01 14:14:15,804 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'dao'<interface org.nutz.dao.Dao>
2017-08-01 14:14:15,807 org.nutz.ioc.aop.SimpleAopMaker.(SimpleAopMaker.java:79) DEBUG - Load AopConfigure for anno=org.nutz.ioc.aop.Aop by type=org.nutz.ioc.aop.config.impl.AnnotationAopConfigration
2017-08-01 14:14:15,808 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - >> Load definition name=dao
2017-08-01 14:14:15,809 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=dao
2017-08-01 14:14:15,815 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:169) DEBUG - Found IocObject(dao) in JsonLoader(paths=[ioc/])
2017-08-01 14:14:15,815 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - >> Make...'dao'<interface org.nutz.dao.Dao>
2017-08-01 14:14:15,984 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class org.nutz.dao.impl.NutDao without AOP
2017-08-01 14:14:15,986 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'dao' to [app]
2017-08-01 14:14:15,989 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'dataSource'<>
2017-08-01 14:14:15,990 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - >> Load definition name=dataSource
2017-08-01 14:14:15,990 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=dataSource
2017-08-01 14:14:16,003 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:169) DEBUG - Found IocObject(dataSource) in JsonLoader(paths=[ioc/])
2017-08-01 14:14:16,004 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - >> Make...'dataSource'<>
2017-08-01 14:14:16,030 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class com.alibaba.druid.pool.DruidDataSource without AOP
2017-08-01 14:14:16,030 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'dataSource' to [app]
2017-08-01 14:14:16,033 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'conf'<>
2017-08-01 14:14:16,033 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - >> Load definition name=conf
2017-08-01 14:14:16,033 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=conf
2017-08-01 14:14:16,034 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:169) DEBUG - Found IocObject(conf) in JsonLoader(paths=[ioc/])
2017-08-01 14:14:16,035 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - >> Make...'conf'<>
2017-08-01 14:14:16,035 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class org.nutz.ioc.impl.PropertiesProxy without AOP
2017-08-01 14:14:16,035 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'conf' to [app]
2017-08-01 14:14:16,040 org.nutz.resource.Scans.scan(Scans.java:274) DEBUG - Found 3 resource by src( custom/ ) , regex( ^.+[.]properties$ )
2017-08-01 14:14:16,148 com.alibaba.druid.pool.DruidDataSource.init(DruidDataSource.java:715) INFO - {dataSource-1} inited
2017-08-01 14:14:16,154 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'dataSource'<>
2017-08-01 14:14:16,300 org.nutz.filepool.NutFilePool.(NutFilePool.java:23) INFO - Init file-pool by: C:\Users\editor5/.nutz/tmp/dao/ [200000]
2017-08-01 14:14:16,301 org.nutz.filepool.NutFilePool.(NutFilePool.java:37) DEBUG - file-pool.home: 'C:\Users\editor5.nutz\tmp\dao'
2017-08-01 14:14:16,301 org.nutz.filepool.NutFilePool.(NutFilePool.java:66) INFO - file-pool.cursor: 0
2017-08-01 14:14:16,311 org.nutz.dao.jdbc.Jdbcs.(Jdbcs.java:90) DEBUG - Jdbcs init complete
2017-08-01 14:14:16,311 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
2017-08-01 14:14:17,249 org.nutz.dao.impl.DaoSupport.setDataSource(DaoSupport.java:188) DEBUG - select expert : org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert
2017-08-01 14:14:17,265 org.nutz.dao.impl.DaoSupport$1.invoke(DaoSupport.java:199) DEBUG - JDBC Driver --> mysql-connector-java-5.1.40 ( Revision: 402933ef52cad9aa82624e80acbea46e3a701ce6 )
2017-08-01 14:14:17,265 org.nutz.dao.impl.DaoSupport$1.invoke(DaoSupport.java:200) DEBUG - JDBC Name --> MySQL Connector Java
2017-08-01 14:14:17,265 org.nutz.dao.impl.DaoSupport$1.invoke(DaoSupport.java:202) DEBUG - JDBC URL --> jdbc:mysql://bdm281033109.my3w.com/bdm281033109_db
2017-08-01 14:14:17,459 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) DEBUG - Mysql : character_set_client=gbk
2017-08-01 14:14:17,460 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) DEBUG - Mysql : character_set_connection=gbk
2017-08-01 14:14:17,461 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) DEBUG - Mysql : character_set_database=gbk
2017-08-01 14:14:17,461 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) DEBUG - Mysql : character_set_filesystem=binary
2017-08-01 14:14:17,461 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) DEBUG - Mysql : character_set_results=
2017-08-01 14:14:17,461 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) DEBUG - Mysql : character_set_server=gbk
2017-08-01 14:14:17,462 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) DEBUG - Mysql : character_set_system=utf8
2017-08-01 14:14:17,462 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) DEBUG - Mysql : character_sets_dir=/usr/local/mysql/share/mysql/charsets/
2017-08-01 14:14:17,514 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:219) DEBUG - Mysql : binlog_format=STATEMENT
2017-08-01 14:14:17,566 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:226) DEBUG - Mysql : database=bdm281033109_db
2017-08-01 14:14:17,627 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:232) DEBUG - Mysql : user=bdm281033109@36.248.244.58
2017-08-01 14:14:17,749 org.nutz.dao.impl.DaoSupport.setDataSource(DaoSupport.java:221) DEBUG - Database info --> MYSQL:[MySQL - 5.1.73]
2017-08-01 14:14:17,762 org.nutz.resource.Scans.scan(Scans.java:274) DEBUG - Found 13 resource by src( net/wendal/nutzbook/ ) , regex( ^.+[.]class$ )
2017-08-01 14:14:18,102 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'nutQuartzCronJobFactory'<class org.nutz.integration.quartz.NutQuartzCronJobFactory>
2017-08-01 14:14:18,102 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - >> Load definition name=nutQuartzCronJobFactory
2017-08-01 14:14:18,102 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=nutQuartzCronJobFactory
2017-08-01 14:14:18,103 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:169) DEBUG - Found IocObject(nutQuartzCronJobFactory) in QuartzIocLoader@547521231
2017-08-01 14:14:18,103 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - >> Make...'nutQuartzCronJobFactory'<class org.nutz.integration.quartz.NutQuartzCronJobFactory>
2017-08-01 14:14:18,105 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class org.nutz.integration.quartz.NutQuartzCronJobFactory without AOP
2017-08-01 14:14:18,106 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'nutQuartzCronJobFactory' to [app]
2017-08-01 14:14:18,108 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'scheduler'<>
2017-08-01 14:14:18,109 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - >> Load definition name=scheduler
2017-08-01 14:14:18,109 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=scheduler
2017-08-01 14:14:18,109 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:169) DEBUG - Found IocObject(scheduler) in QuartzIocLoader@547521231
2017-08-01 14:14:18,110 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - >> Make...'scheduler'<>
2017-08-01 14:14:18,110 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'scheduler' to [app]
2017-08-01 14:14:18,200 org.quartz.impl.StdSchedulerFactory.instantiate(StdSchedulerFactory.java:1175) INFO - Using default implementation for ThreadExecutor
2017-08-01 14:14:18,231 org.quartz.core.SchedulerSignalerImpl.(SchedulerSignalerImpl.java:61) INFO - Initialized Scheduler Signaller of type: class org.quartz.core.SchedulerSignalerImpl
2017-08-01 14:14:18,231 org.quartz.core.QuartzScheduler.(QuartzScheduler.java:243) INFO - Quartz Scheduler v.2.1.7 created.
2017-08-01 14:14:18,233 org.quartz.simpl.RAMJobStore.initialize(RAMJobStore.java:154) INFO - RAMJobStore initialized.
2017-08-01 14:14:18,234 org.quartz.core.QuartzScheduler.initialize(QuartzScheduler.java:268) INFO - Scheduler meta-data: Quartz Scheduler (v2.1.7) '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.

2017-08-01 14:14:18,234 org.quartz.impl.StdSchedulerFactory.instantiate(StdSchedulerFactory.java:1324) INFO - Quartz scheduler 'NutzbookScheduler' initialized from default resource file in Quartz package: 'quartz.properties'
2017-08-01 14:14:18,234 org.quartz.impl.StdSchedulerFactory.instantiate(StdSchedulerFactory.java:1328) INFO - Quartz scheduler version: 2.1.7
2017-08-01 14:14:18,234 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'jobFactory'<>
2017-08-01 14:14:18,234 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - >> Load definition name=jobFactory
2017-08-01 14:14:18,235 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=jobFactory
2017-08-01 14:14:18,236 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:169) DEBUG - Found IocObject(jobFactory) in QuartzIocLoader@547521231
2017-08-01 14:14:18,236 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - >> Make...'jobFactory'<>
2017-08-01 14:14:18,237 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class org.nutz.integration.quartz.NutQuartzJobFactory without AOP
2017-08-01 14:14:18,238 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'jobFactory' to [app]
2017-08-01 14:14:18,239 org.quartz.core.QuartzScheduler.setJobFactory(QuartzScheduler.java:2247) INFO - JobFactory set to: org.nutz.integration.quartz.NutQuartzJobFactory@2b2f15db
2017-08-01 14:14:18,239 org.quartz.core.QuartzScheduler.start(QuartzScheduler.java:534) INFO - Scheduler NutzbookScheduler_$_NON_CLUSTERED started.
2017-08-01 14:14:18,239 org.quartz.core.QuartzSchedulerThread.run(QuartzSchedulerThread.java:268) DEBUG - batch acquisition of 0 triggers
2017-08-01 14:14:18,240 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'conf'<>
2017-08-01 14:14:18,240 org.nutz.integration.quartz.NutQuartzCronJobFactory.init(NutQuartzCronJobFactory.java:35) DEBUG - job define name=net.wendal.nutzbook.quartz.job.CleanNonActiveUserJob cron=0 0/2 * * * ?
2017-08-01 14:14:18,241 org.nutz.ioc.impl.ScopeContext.remove(ScopeContext.java:84) DEBUG - Remove object 'nutQuartzCronJobFactory' from [app]
2017-08-01 14:14:18,243 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:125) ERROR - Error happend during start serivce!
org.nutz.ioc.IocException: [nutQuartzCronJobFactory] # FAIL to create Ioc Bean name=[nutQuartzCronJobFactory]
at org.nutz.ioc.impl.ObjectMakerImpl.make(ObjectMakerImpl.java:149)
at org.nutz.ioc.impl.NutIoc.get(NutIoc.java:210)
at org.nutz.ioc.impl.NutIoc.get(NutIoc.java:239)
at org.nutz.ioc.impl.NutIoc.get(NutIoc.java:146)
at net.wendal.nutzbook.MainSetup.init(MainSetup.java:25)
at org.nutz.mvc.impl.NutLoading.evalSetup(NutLoading.java:277)
at org.nutz.mvc.impl.NutLoading.load(NutLoading.java:121)
at org.nutz.mvc.ActionHandler.(ActionHandler.java:19)
at org.nutz.mvc.NutFilter._init(NutFilter.java:87)
at org.nutz.mvc.NutFilter.init(NutFilter.java:65)
at org.apache.catalina.core.ApplicationFilterConfig.initFilter(ApplicationFilterConfig.java:279)
at org.apache.catalina.core.ApplicationFilterConfig.getFilter(ApplicationFilterConfig.java:260)
at org.apache.catalina.core.ApplicationFilterConfig.(ApplicationFilterConfig.java:105)
at org.apache.catalina.core.StandardContext.filterStart(StandardContext.java:4700)
at org.apache.catalina.core.StandardContext.startInternal(StandardContext.java:5340)
at org.apache.catalina.util.LifecycleBase.start(LifecycleBase.java:145)
at org.apache.catalina.core.ContainerBase$StartChild.call(ContainerBase.java:1408)
at org.apache.catalina.core.ContainerBase$StartChild.call(ContainerBase.java:1398)
at java.util.concurrent.FutureTask.run(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
at java.lang.Thread.run(Unknown Source)
Caused by: java.lang.RuntimeException: java.lang.ClassNotFoundException: net.wendal.nutzbook.quartz.job.CleanNonActiveUserJob
at org.nutz.lang.Lang.wrapThrow(Lang.java:181)
at org.nutz.lang.Lang.wrapThrow(Lang.java:180)
at org.nutz.ioc.trigger.MethodEventTrigger.trigger(MethodEventTrigger.java:21)
at org.nutz.ioc.weaver.DefaultWeaver.onCreate(DefaultWeaver.java:72)
at org.nutz.ioc.impl.ObjectMakerImpl.make(ObjectMakerImpl.java:138)
... 21 more
Caused by: java.lang.ClassNotFoundException: net.wendal.nutzbook.quartz.job.CleanNonActiveUserJob
at org.apache.catalina.loader.WebappClassLoaderBase.loadClass(WebappClassLoaderBase.java:1333)
at org.apache.catalina.loader.WebappClassLoaderBase.loadClass(WebappClassLoaderBase.java:1167)
at java.lang.Class.forName0(Native Method)
at java.lang.Class.forName(Unknown Source)
at org.nutz.lang.Lang.loadClass(Lang.java:2022)
at org.nutz.integration.quartz.NutQuartzCronJobFactory.init(NutQuartzCronJobFactory.java:38)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
at java.lang.reflect.Method.invoke(Unknown Source)
at org.nutz.ioc.trigger.MethodEventTrigger.trigger(MethodEventTrigger.java:18)
... 23 more
2017-08-01 14:14:18,248 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:127) ERROR - try to depose ioc
2017-08-01 14:14:18,251 org.nutz.ioc.impl.NutIoc.depose(NutIoc.java:255) INFO - org.nutz.ioc.impl.NutIoc@1803352604 is closing. startup date [17-08-01 14:14:15.525]
2017-08-01 14:14:18,251 org.nutz.ioc.impl.ScopeContext.clear(ScopeContext.java:108) DEBUG - Depose object 'jobFactory' ...
2017-08-01 14:14:18,251 org.nutz.ioc.impl.ScopeContext.clear(ScopeContext.java:108) DEBUG - Depose object 'scheduler' ...
2017-08-01 14:14:18,252 org.quartz.core.QuartzScheduler.shutdown(QuartzScheduler.java:653) INFO - Scheduler NutzbookScheduler_$_NON_CLUSTERED shutting down.
2017-08-01 14:14:18,252 org.quartz.core.QuartzScheduler.standby(QuartzScheduler.java:572) INFO - Scheduler NutzbookScheduler_$_NON_CLUSTERED paused.
2017-08-01 14:14:18,252 org.quartz.simpl.SimpleThreadPool.shutdown(SimpleThreadPool.java:327) DEBUG - Shutting down threadpool...
2017-08-01 14:14:18,252 org.quartz.simpl.SimpleThreadPool.shutdown(SimpleThreadPool.java:381) DEBUG - Shutdown of threadpool complete.
2017-08-01 14:14:18,253 org.quartz.core.QuartzScheduler.shutdown(QuartzScheduler.java:725) INFO - Scheduler NutzbookScheduler_$_NON_CLUSTERED shutdown complete.
2017-08-01 14:14:18,253 org.nutz.ioc.impl.ScopeContext.clear(ScopeContext.java:108) DEBUG - Depose object 'conf' ...
2017-08-01 14:14:18,253 org.nutz.ioc.impl.ScopeContext.clear(ScopeContext.java:108) DEBUG - Depose object 'dao' ...
2017-08-01 14:14:18,253 org.nutz.ioc.impl.ScopeContext.clear(ScopeContext.java:113) DEBUG - Depose object 'dataSource' ...
2017-08-01 14:14:18,258 com.alibaba.druid.pool.DruidDataSource.close(DruidDataSource.java:1444) INFO - {dataSource-1} closed
2017-08-01 14:14:18,259 org.nutz.ioc.impl.NutIoc.depose(NutIoc.java:262) INFO - org.nutz.ioc.impl.NutIoc@1803352604 is deposed. startup date [17-08-01 14:14:15.525]