七月 21, 2016 5:51:50 下午 org.apache.tomcat.util.digester.SetPropertiesRule begin
警告: [SetPropertiesRule]{Server/Service/Engine/Host/Context} Setting property 'source' to 'org.eclipse.jst.jee.server:nutz' did not find a matching property.
七月 21, 2016 5:51:50 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: Server version: Apache Tomcat/8.0.30
七月 21, 2016 5:51:50 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: Server built: Dec 1 2015 22:30:46 UTC
七月 21, 2016 5:51:50 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: Server number: 8.0.30.0
七月 21, 2016 5:51:50 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: OS Name: Windows 7
七月 21, 2016 5:51:50 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: OS Version: 6.1
七月 21, 2016 5:51:50 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: Architecture: amd64
七月 21, 2016 5:51:50 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: Java Home: C:\Program Files\Java\jre1.8.0_31
七月 21, 2016 5:51:50 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: JVM Version: 1.8.0_31-b13
七月 21, 2016 5:51:50 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: JVM Vendor: Oracle Corporation
七月 21, 2016 5:51:50 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: CATALINA_BASE: D:\dev-ws.metadata.plugins\org.eclipse.wst.server.core\tmp0
七月 21, 2016 5:51:50 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: CATALINA_HOME: D:\tools\tomcat\apache-tomcat-8.0.30-windows-x64\apache-tomcat-8.0.30
七月 21, 2016 5:51:50 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: Command line argument: -agentlib:jdwp=transport=dt_socket,suspend=y,address=localhost:64474
七月 21, 2016 5:51:50 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: Command line argument: -Dcatalina.base=D:\dev-ws.metadata.plugins\org.eclipse.wst.server.core\tmp0
七月 21, 2016 5:51:50 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: Command line argument: -Dcatalina.home=D:\tools\tomcat\apache-tomcat-8.0.30-windows-x64\apache-tomcat-8.0.30
七月 21, 2016 5:51:50 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: Command line argument: -Dwtp.deploy=D:\dev-ws.metadata.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps
七月 21, 2016 5:51:50 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: Command line argument: -Djava.endorsed.dirs=D:\tools\tomcat\apache-tomcat-8.0.30-windows-x64\apache-tomcat-8.0.30\endorsed
七月 21, 2016 5:51:50 下午 org.apache.catalina.startup.VersionLoggerListener log
信息: Command line argument: -Dfile.encoding=UTF-8
七月 21, 2016 5:51:50 下午 org.apache.catalina.core.AprLifecycleListener lifecycleEvent
信息: The APR based Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: C:\Program Files\Java\jre1.8.0_31\bin;C:\Windows\Sun\Java\bin;C:\Windows\system32;C:\Windows;C:\Windows\system32;C:\Windows;C:\Windows\System32\Wbem;C:\Windows\System32\WindowsPowerShell\v1.0\;D:\tools\svn\bin;D:\tools\EmEditor;D:\tools\maven\maven-3.0.5\bin;C:\Program Files\Java\jdk1.6.0_43\bin;.
七月 21, 2016 5:51:50 下午 org.apache.coyote.AbstractProtocol init
信息: Initializing ProtocolHandler ["http-nio-8080"]
七月 21, 2016 5:51:50 下午 org.apache.tomcat.util.net.NioSelectorPool getSharedSelector
信息: Using a shared selector for servlet write/read
七月 21, 2016 5:51:50 下午 org.apache.coyote.AbstractProtocol init
信息: Initializing ProtocolHandler ["ajp-nio-8009"]
七月 21, 2016 5:51:50 下午 org.apache.tomcat.util.net.NioSelectorPool getSharedSelector
信息: Using a shared selector for servlet write/read
七月 21, 2016 5:51:50 下午 org.apache.catalina.startup.Catalina load
信息: Initialization processed in 944 ms
七月 21, 2016 5:51:50 下午 org.apache.catalina.core.StandardService startInternal
信息: Starting service Catalina
七月 21, 2016 5:51:50 下午 org.apache.catalina.core.StandardEngine startInternal
信息: Starting Servlet Engine: Apache Tomcat/8.0.30
七月 21, 2016 5:51:52 下午 org.apache.jasper.servlet.TldScanner scanJars
信息: At least one JAR was scanned for TLDs yet contained no TLDs. Enable debug logging for this logger for a complete list of JARs that were scanned but no TLDs were found in them. Skipping unneeded JARs during scanning can improve startup time and JSP compilation time.
七月 21, 2016 5:51:52 下午 org.apache.catalina.core.ApplicationContext log
信息: Initializing Shiro environment
2016-07-21 17:51:52,186 org.apache.shiro.web.env.EnvironmentLoader.initEnvironment(EnvironmentLoader.java:128) INFO - Starting Shiro environment initialization.
2016-07-21 17:51:52,201 org.apache.shiro.web.env.IniWebEnvironment.init(IniWebEnvironment.java:76) DEBUG - Checking any specified config locations.
2016-07-21 17:51:52,201 org.apache.shiro.web.env.IniWebEnvironment.init(IniWebEnvironment.java:81) DEBUG - No INI instance or config locations specified. Trying default config locations.
2016-07-21 17:51:52,217 org.apache.shiro.io.ResourceUtils.loadFromClassPath(ResourceUtils.java:159) DEBUG - Opening resource from class path [shiro.ini]
2016-07-21 17:51:52,217 org.apache.shiro.config.Ini.load(Ini.java:342) DEBUG - Parsing [main]
2016-07-21 17:51:52,233 org.apache.shiro.config.Ini.load(Ini.java:342) DEBUG - Parsing [urls]
2016-07-21 17:51:52,233 org.apache.shiro.web.env.IniWebEnvironment.getDefaultIni(IniWebEnvironment.java:136) DEBUG - Discovered non-empty INI configuration at location 'classpath:shiro.ini'. Using for configuration.
2016-07-21 17:51:52,233 org.apache.shiro.config.IniFactorySupport.createInstance(IniFactorySupport.java:122) DEBUG - Creating instance from Ini [sections=urls]
2016-07-21 17:51:52,421 org.apache.shiro.config.IniFactorySupport.createInstance(IniFactorySupport.java:122) DEBUG - Creating instance from Ini [sections=urls]
2016-07-21 17:51:52,421 org.apache.shiro.web.filter.mgt.DefaultFilterChainManager.createChain(DefaultFilterChainManager.java:127) DEBUG - Creating chain [/*] from String definition [anon]
2016-07-21 17:51:52,421 org.apache.shiro.web.filter.mgt.DefaultFilterChainManager.applyChainConfig(DefaultFilterChainManager.java:278) DEBUG - Attempting to apply path [/*] to filter [anon] with config [null]
2016-07-21 17:51:52,421 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]
2016-07-21 17:51:52,421 org.apache.shiro.web.env.EnvironmentLoader.initEnvironment(EnvironmentLoader.java:141) INFO - Shiro environment initialized in 220 ms.
ALL Nutz Log via Log4jLogAdapter
2016-07-21 17:51:52,468 org.nutz.log.Logs.(Logs.java:20) INFO - Nutz is licensed under the Apache License, Version 2.0 .
Report bugs : https://github.com/nutzam/nutz/issues
2016-07-21 17:51:52,468 org.nutz.mvc.NutFilter.init(NutFilter.java:71) INFO - NutFilter[nutz] starting ...
2016-07-21 17:51:52,546 org.nutz.resource.Scans.(Scans.java:487) DEBUG - Locations for Scans:
[JarResourceLocation [jarPath=D:\tools\tomcat\apache-tomcat-8.0.30-windows-x64\apache-tomcat-8.0.30\bin\bootstrap.jar], JarResourceLocation [jarPath=D:\dev-ws.metadata.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\nutz\WEB-INF\lib\nutz-1.b.53.jar], JarResourceLocation [jarPath=D:\tools\tomcat\apache-tomcat-8.0.30-windows-x64\apache-tomcat-8.0.30\bin\tomcat-juli.jar], FileSystemResourceLocation [root=D:\tools\eclipse\eclipse], FileSystemResourceLocation [root=D:\dev-ws.metadata.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\nutz\WEB-INF\classes]]
2016-07-21 17:51:52,811 org.nutz.resource.Scans.init(Scans.java:75) DEBUG - Locations for Scans:
[JarResourceLocation [jarPath=D:\dev-ws.metadata.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\nutz\WEB-INF\lib\commons-beanutils-1.9.2.jar], JarResourceLocation [jarPath=D:\dev-ws.metadata.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\nutz\WEB-INF\lib\log4j-1.2.17.jar], JarResourceLocation [jarPath=D:\dev-ws.metadata.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\nutz\WEB-INF\lib\quartz-2.2.1.jar], JarResourceLocation [jarPath=D:\dev-ws.metadata.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\nutz\WEB-INF\lib\nutz-1.b.53.jar], JarResourceLocation [jarPath=D:\dev-ws.metadata.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\nutz\WEB-INF\lib\mysql-connector-java-5.0.8.jar], JarResourceLocation [jarPath=D:\dev-ws.metadata.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\nutz\WEB-INF\lib\shiro-all-1.2.6.jar], FileSystemResourceLocation [root=D:\tools\eclipse\eclipse], FileSystemResourceLocation [root=D:\dev-ws.metadata.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\nutz\WEB-INF\classes], JarResourceLocation [jarPath=D:\dev-ws.metadata.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\nutz\WEB-INF\lib\c3p0-0.9.1.1.jar], JarResourceLocation [jarPath=D:\dev-ws.metadata.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\nutz\WEB-INF\lib\slf4j-log4j12-1.7.2.jar], JarResourceLocation [jarPath=D:\tools\tomcat\apache-tomcat-8.0.30-windows-x64\apache-tomcat-8.0.30\bin\bootstrap.jar], JarResourceLocation [jarPath=D:\dev-ws.metadata.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\nutz\WEB-INF\lib\druid-1.0.18.jar], JarResourceLocation [jarPath=D:\dev-ws.metadata.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\nutz\WEB-INF\lib\commons-logging-1.2.jar], JarResourceLocation [jarPath=D:\dev-ws.metadata.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\nutz\WEB-INF\lib\nutz-integration-quartz-1.b.53.jar], JarResourceLocation [jarPath=D:\tools\tomcat\apache-tomcat-8.0.30-windows-x64\apache-tomcat-8.0.30\bin\tomcat-juli.jar], JarResourceLocation [jarPath=D:\dev-ws.metadata.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\nutz\WEB-INF\lib\slf4j-api-1.6.6.jar], JarResourceLocation [jarPath=D:\dev-ws.metadata.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\nutz\WEB-INF\lib\nutz-integration-shiro-1.b.53.jar]]
2016-07-21 17:51:52,811 org.nutz.mvc.config.AbstractNutConfig.getMainModule(AbstractNutConfig.java:119) DEBUG - MainModule: <com.hoperun.nutzbook.MainModule>
2016-07-21 17:51:52,842 org.nutz.mvc.config.AbstractNutConfig.createLoading(AbstractNutConfig.java:50) DEBUG - Loading by class org.nutz.mvc.impl.NutLoading
2016-07-21 17:51:52,842 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:55) INFO - Nutz Version : 1.b.53
2016-07-21 17:51:52,842 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:56) INFO - Nutz.Mvc[nutz] is initializing ...
2016-07-21 17:51:52,842 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:60) DEBUG - Web Container Information:
2016-07-21 17:51:52,842 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:61) DEBUG - - Default Charset : UTF-8
2016-07-21 17:51:52,842 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:62) DEBUG - - Current . path : D:\tools\eclipse\eclipse.
2016-07-21 17:51:52,842 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:63) DEBUG - - Java Version : 1.8.0_31
2016-07-21 17:51:52,842 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:64) DEBUG - - File separator : \
2016-07-21 17:51:52,842 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:65) DEBUG - - Timezone : Asia/Shanghai
2016-07-21 17:51:52,842 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:66) DEBUG - - OS : Windows 7 amd64
2016-07-21 17:51:52,842 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:67) DEBUG - - ServerInfo : Apache Tomcat/8.0.30
2016-07-21 17:51:52,842 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:68) DEBUG - - Servlet API : 3.1
2016-07-21 17:51:52,842 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:73) DEBUG - - ContextPath : /nutz
2016-07-21 17:51:52,842 org.nutz.mvc.config.AbstractNutConfig.getMainModule(AbstractNutConfig.java:119) DEBUG - MainModule: <com.hoperun.nutzbook.MainModule>
2016-07-21 17:51:52,842 org.nutz.mvc.impl.NutLoading.createContext(NutLoading.java:231) DEBUG - >> app.root = D:/dev-ws/.metadata/.plugins/org.eclipse.wst.server.core/tmp0/wtpwebapps/nutz
2016-07-21 17:51:52,951 org.nutz.castor.Castors.reload(Castors.java:116) DEBUG - Using 91 castor for Castors
2016-07-21 17:51:52,951 org.nutz.mvc.impl.NutLoading.createIoc(NutLoading.java:368) DEBUG - @IocBy(type=org.nutz.mvc.ioc.provider.ComboIocProvider, args=["*js", "ioc/", "*anno", "com.hoperun.nutzbook", "*tx"],init=[])
2016-07-21 17:51:52,982 org.nutz.resource.Scans.scan(Scans.java:234) DEBUG - Found 1 resource by src( ioc/ ) , regex( ^(.+[.])(js|json)$ )
2016-07-21 17:51:52,982 org.nutz.ioc.loader.json.JsonLoader.(JsonLoader.java:44) DEBUG - loading ioc js config from [dao.js]
2016-07-21 17:51:52,982 org.nutz.ioc.loader.json.JsonLoader.(JsonLoader.java:52) DEBUG - Loaded 3 bean define from path=[ioc/] --> [conf, dao, dataSource]
2016-07-21 17:51:52,982 org.nutz.resource.Scans.scan(Scans.java:234) DEBUG - Found 6 resource by src( com/hoperun/nutzbook/ ) , regex( ^.+[.]class$ )
2016-07-21 17:51:52,998 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:71) DEBUG - Found a Class with Ioc-Annotation : class com.hoperun.nutzbook.module.UserModule
2016-07-21 17:51:53,014 org.nutz.ioc.loader.annotation.AnnotationIocLoader.(AnnotationIocLoader.java:48) INFO - Scan complete ! Found 1 classes in 1 base-packages!
beans = ["userModule"]
2016-07-21 17:51:53,029 org.nutz.ioc.loader.json.JsonLoader.(JsonLoader.java:36) DEBUG - Loaded 5 bean define from reader --
[txREPEATABLE_READ, txSERIALIZABLE, txNONE, txREAD_UNCOMMITTED, txREAD_COMMITTED]
2016-07-21 17:51:53,029 org.nutz.ioc.impl.NutIoc.(NutIoc.java:93) INFO - NutIoc init begin ...
2016-07-21 17:51:53,029 org.nutz.ioc.impl.NutIoc.(NutIoc.java:109) INFO - ... NutIoc init complete
2016-07-21 17:51:53,029 org.nutz.mvc.config.AbstractNutConfig.getMainModule(AbstractNutConfig.java:119) DEBUG - MainModule: <com.hoperun.nutzbook.MainModule>
2016-07-21 17:51:53,029 org.nutz.mvc.impl.NutLoading.evalUrlMapping(NutLoading.java:157) INFO - Build URL mapping by org.nutz.mvc.impl.UrlMappingImpl ...
2016-07-21 17:51:53,045 org.nutz.mvc.impl.NutLoading.createViewMakers(NutLoading.java:358) DEBUG - @Views(DefaultViewMaker)
2016-07-21 17:51:53,045 org.nutz.resource.Scans.scan(Scans.java:234) DEBUG - Found 1 resource by src( mvc/nutzbook-mvc-chain.js ) , regex( ^(.+[.])(js|json)$ )
2016-07-21 17:51:53,060 org.nutz.mvc.impl.chainconfig.JsonActionChainMakerConfiguretion.(JsonActionChainMakerConfiguretion.java:37) DEBUG - ActionChain Config:
{
"default" :{
"ps" :["com.hoperun.nutzbook.mvc.LogTimeProcessor", "org.nutz.mvc.impl.processor.UpdateRequestAttributesProcessor", "org.nutz.mvc.impl.processor.EncodingProcessor", "org.nutz.mvc.impl.processor.ModuleProcessor", "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"
}
}
2016-07-21 17:51:53,060 org.nutz.mvc.impl.NutLoading.createChainMaker(NutLoading.java:259) DEBUG - @ChainBy(org.nutz.mvc.impl.NutActionChainMaker)
2016-07-21 17:51:53,060 org.nutz.mvc.impl.Loadings.scanModules(Loadings.java:139) DEBUG - module class location 'file:/D:/dev-ws/.metadata/.plugins/org.eclipse.wst.server.core/tmp0/wtpwebapps/nutz/WEB-INF/classes/'
2016-07-21 17:51:53,060 org.nutz.mvc.impl.Loadings.scanModuleInPackage(Loadings.java:169) DEBUG - > scan 'com.hoperun.nutzbook'
2016-07-21 17:51:53,076 org.nutz.resource.Scans.scan(Scans.java:234) DEBUG - Found 6 resource by src( com/hoperun/nutzbook/ ) , regex( ^.+[.]class$ )
2016-07-21 17:51:53,076 org.nutz.mvc.impl.Loadings.checkModule(Loadings.java:183) DEBUG - >> add 'com.hoperun.nutzbook.module.UserModule'
2016-07-21 17:51:53,092 org.nutz.mvc.impl.UrlMappingImpl.printActionMapping(UrlMappingImpl.java:130) DEBUG - '/user/' >> UserModule.index(...) : void | @Ok(jsp:jsp.user.list) @Fail(http:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2016-07-21 17:51:53,123 org.nutz.mvc.impl.UrlMappingImpl.printActionMapping(UrlMappingImpl.java:130) DEBUG - '/user/add' >> UserModule.add(...) : Object | @Ok(json:{locked:'password|salt',ignoreNull:true}) @Fail(http:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2016-07-21 17:51:53,123 org.nutz.mvc.impl.UrlMappingImpl.printActionMapping(UrlMappingImpl.java:130) DEBUG - '/user/count' >> UserModule.count(...) : int | @Ok(json:{locked:'password|salt',ignoreNull:true}) @Fail(http:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2016-07-21 17:51:53,123 org.nutz.mvc.impl.UrlMappingImpl.printActionMapping(UrlMappingImpl.java:130) DEBUG - '/user/update' >> UserModule.update(...) : Object | @Ok(json:{locked:'password|salt',ignoreNull:true}) @Fail(http:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2016-07-21 17:51:53,138 org.nutz.mvc.impl.UrlMappingImpl.printActionMapping(UrlMappingImpl.java:130) DEBUG - '/user/delete' >> UserModule.delete(...) : Object | @Ok(json:{locked:'password|salt',ignoreNull:true}) @Fail(http:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2016-07-21 17:51:53,138 org.nutz.mvc.impl.UrlMappingImpl.printActionMapping(UrlMappingImpl.java:130) DEBUG - '/user/query' >> UserModule.query(...) : Object | @Ok(json:{locked:'password|salt',ignoreNull:true}) @Fail(http:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2016-07-21 17:51:53,138 org.nutz.mvc.impl.UrlMappingImpl.printActionMapping(UrlMappingImpl.java:130) DEBUG - '/user/login' >> UserModule.login(...) : Object | @Ok(json:{locked:'password|salt',ignoreNull:true}) @Fail(http:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2016-07-21 17:51:53,138 org.nutz.mvc.impl.UrlMappingImpl.printActionMapping(UrlMappingImpl.java:130) DEBUG - '/user/logout' >> UserModule.logout(...) : void | @Ok(>>:/ ) @Fail(http:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2016-07-21 17:51:53,138 org.nutz.mvc.impl.NutLoading.evalUrlMapping(NutLoading.java:217) INFO - Found 8 module methods
2016-07-21 17:51:53,138 org.nutz.mvc.impl.NutLoading.evalLocalization(NutLoading.java:295) DEBUG - Localization: org.nutz.mvc.impl.NutMessageLoader('msg/') dft
2016-07-21 17:51:53,138 org.nutz.resource.Scans.scan(Scans.java:234) DEBUG - Found 1 resource by src( msg/ ) , regex( ^.+[.]properties$ )
2016-07-21 17:51:53,138 org.nutz.mvc.impl.NutMessageLoader.load(NutMessageLoader.java:29) DEBUG - Load Messages in 1 resource : [[NutResource[zh-CN/user.properties]]]
2016-07-21 17:51:53,154 org.nutz.mvc.impl.NutMessageLoader.load(NutMessageLoader.java:102) DEBUG - Message Loaded, size = 2
2016-07-21 17:51:53,154 org.nutz.mvc.impl.NutLoading.evalSetup(NutLoading.java:267) INFO - Setup application...
2016-07-21 17:51:53,154 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:145) DEBUG - Get 'dao'<interface org.nutz.dao.Dao>
2016-07-21 17:51:53,154 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:165) DEBUG - >> Load definition
2016-07-21 17:51:53,154 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=dao
2016-07-21 17:51:53,154 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:144) DEBUG - Found IocObject(dao) in IocLoader(JsonLoader@1370754550)
2016-07-21 17:51:53,154 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:195) DEBUG - >> Make...'dao'<interface org.nutz.dao.Dao>
2016-07-21 17:51:53,185 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:84) DEBUG - class org.nutz.dao.impl.NutDao without AOP
2016-07-21 17:51:53,185 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:59) DEBUG - Save object 'dao' to [app]
2016-07-21 17:51:53,185 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:145) DEBUG - Get 'dataSource'<>
2016-07-21 17:51:53,185 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:165) DEBUG - >> Load definition
2016-07-21 17:51:53,185 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=dataSource
2016-07-21 17:51:53,185 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:144) DEBUG - Found IocObject(dataSource) in IocLoader(JsonLoader@1370754550)
2016-07-21 17:51:53,185 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:195) DEBUG - >> Make...'dataSource'<>
2016-07-21 17:51:53,216 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:84) DEBUG - class com.alibaba.druid.pool.DruidDataSource without AOP
2016-07-21 17:51:53,216 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:59) DEBUG - Save object 'dataSource' to [app]
2016-07-21 17:51:53,232 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:145) DEBUG - Get 'conf'<>
2016-07-21 17:51:53,232 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:165) DEBUG - >> Load definition
2016-07-21 17:51:53,232 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=conf
2016-07-21 17:51:53,232 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:144) DEBUG - Found IocObject(conf) in IocLoader(JsonLoader@1370754550)
2016-07-21 17:51:53,232 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:195) DEBUG - >> Make...'conf'<>
2016-07-21 17:51:53,232 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:84) DEBUG - class org.nutz.ioc.impl.PropertiesProxy without AOP
2016-07-21 17:51:53,232 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:59) DEBUG - Save object 'conf' to [app]
2016-07-21 17:51:53,249 org.nutz.resource.Scans.scan(Scans.java:234) DEBUG - Found 1 resource by src( custom/db.properties ) , regex( ^.+[.]properties$ )
2016-07-21 17:51:53,249 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:145) DEBUG - Get 'conf'<>
2016-07-21 17:51:53,249 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:145) DEBUG - Get 'conf'<>
2016-07-21 17:51:53,249 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:145) DEBUG - Get 'conf'<>
2016-07-21 17:51:53,249 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:145) DEBUG - Get 'conf'<>
2016-07-21 17:51:53,280 com.alibaba.druid.pool.vendor.MySqlValidConnectionChecker.(MySqlValidConnectionChecker.java:55) WARN - Cannot resolve com.mysq.jdbc.Connection.ping method. Will use 'SELECT 1' instead.
java.lang.NullPointerException
at com.alibaba.druid.pool.vendor.MySqlValidConnectionChecker.(MySqlValidConnectionChecker.java:50)
at com.alibaba.druid.pool.DruidDataSource.initValidConnectionChecker(DruidDataSource.java:944)
at com.alibaba.druid.pool.DruidDataSource.init(DruidDataSource.java:659)
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)
at org.nutz.ioc.weaver.DefaultWeaver.onCreate(DefaultWeaver.java:74)
at org.nutz.ioc.impl.ObjectMakerImpl.make(ObjectMakerImpl.java:135)
at org.nutz.ioc.impl.NutIoc.get(NutIoc.java:196)
at org.nutz.ioc.val.ReferValue.get(ReferValue.java:24)
at org.nutz.ioc.impl.ObjectMakerImpl.make(ObjectMakerImpl.java:73)
at org.nutz.ioc.impl.NutIoc.get(NutIoc.java:196)
at org.nutz.ioc.impl.NutIoc.get(NutIoc.java:221)
at org.nutz.ioc.impl.NutIoc.get(NutIoc.java:140)
at com.hoperun.nutzbook.MainSetUp.init(MainSetUp.java:19)
at org.nutz.mvc.impl.NutLoading.evalSetup(NutLoading.java:270)
at org.nutz.mvc.impl.NutLoading.load(NutLoading.java:119)
at org.nutz.mvc.ActionHandler.(ActionHandler.java:19)
at org.nutz.mvc.NutFilter.init(NutFilter.java:77)
at com.hoperun.nutzbook.mvc.NutzFilter.init(NutzFilter.java:21)
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:4659)
at org.apache.catalina.core.StandardContext.startInternal(StandardContext.java:5281)
at org.apache.catalina.util.LifecycleBase.start(LifecycleBase.java:150)
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)
2016-07-21 17:51:53,295 com.alibaba.druid.pool.DruidDataSource.init(DruidDataSource.java:721) INFO - {dataSource-1} inited
2016-07-21 17:51:53,311 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:145) DEBUG - Get 'dataSource'<>
2016-07-21 17:51:53,311 org.nutz.dao.impl.NutDao.(NutDao.java:105) DEBUG - NutDao[_selfId=0] init ...
2016-07-21 17:51:53,342 org.nutz.filepool.NutFilePool.(NutFilePool.java:23) INFO - Init file-pool by: C:\Users\zhulongxiang/.nutz/tmp/dao/ [200000]
2016-07-21 17:51:53,342 org.nutz.filepool.NutFilePool.(NutFilePool.java:37) DEBUG - file-pool.home: 'C:\Users\zhulongxiang.nutz\tmp\dao'
2016-07-21 17:51:53,342 org.nutz.filepool.NutFilePool.(NutFilePool.java:66) INFO - file-pool.cursor: 0
2016-07-21 17:51:53,342 org.nutz.dao.jdbc.Jdbcs.(Jdbcs.java:85) DEBUG - Jdbcs init complete
2016-07-21 17:51:53,342 org.nutz.dao.jdbc.Jdbcs.getExpert(Jdbcs.java:98) INFO - Get Connection from DataSource for JdbcExpert
2016-07-21 17:51:53,919 org.nutz.dao.impl.DaoSupport$1.invoke(DaoSupport.java:171) DEBUG - JDBC Driver --> mysql-connector-java-5.0.8 ( Revision: ${svn.Revision} )
2016-07-21 17:51:53,919 org.nutz.dao.impl.DaoSupport$1.invoke(DaoSupport.java:172) DEBUG - JDBC Name --> MySQL-AB JDBC Driver
2016-07-21 17:51:53,919 org.nutz.dao.impl.DaoSupport$1.invoke(DaoSupport.java:174) DEBUG - JDBC URL --> jdbc:mysql://127.0.0.1:3306/nutzbook
2016-07-21 17:51:53,935 org.nutz.dao.impl.DaoSupport$1.invoke(DaoSupport.java:183) DEBUG - Mysql : character_set_client=gbk
2016-07-21 17:51:53,935 org.nutz.dao.impl.DaoSupport$1.invoke(DaoSupport.java:183) DEBUG - Mysql : character_set_connection=gbk
2016-07-21 17:51:53,935 org.nutz.dao.impl.DaoSupport$1.invoke(DaoSupport.java:183) DEBUG - Mysql : character_set_database=utf8
2016-07-21 17:51:53,935 org.nutz.dao.impl.DaoSupport$1.invoke(DaoSupport.java:183) DEBUG - Mysql : character_set_filesystem=binary
2016-07-21 17:51:53,935 org.nutz.dao.impl.DaoSupport$1.invoke(DaoSupport.java:183) DEBUG - Mysql : character_set_results=
2016-07-21 17:51:53,935 org.nutz.dao.impl.DaoSupport$1.invoke(DaoSupport.java:183) DEBUG - Mysql : character_set_server=gbk
2016-07-21 17:51:53,935 org.nutz.dao.impl.DaoSupport$1.invoke(DaoSupport.java:183) DEBUG - Mysql : character_set_system=utf8
2016-07-21 17:51:53,935 org.nutz.dao.impl.DaoSupport$1.invoke(DaoSupport.java:183) DEBUG - Mysql : character_sets_dir=D:\tools\mysql\mysql-6.0\share\charsets\
2016-07-21 17:51:53,935 org.nutz.dao.impl.DaoSupport.setDataSource(DaoSupport.java:188) DEBUG - Database info --> MYSQL:[MySQL - 6.0.5-alpha-community]
2016-07-21 17:51:53,935 org.nutz.resource.Scans.scan(Scans.java:234) DEBUG - Found 6 resource by src( com/hoperun/nutzbook/ ) , regex( ^.+[.]class$ )
2016-07-21 17:51:54,029 org.nutz.dao.impl.sql.run.NutDaoExecutor._runSelect(NutDaoExecutor.java:193) DEBUG - SELECT COUNT(*) FROM t_user
2016-07-21 17:51:54,029 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:139) INFO - Nutz.Mvc[nutz] is up in 1187ms
七月 21, 2016 5:51:54 下午 org.apache.coyote.AbstractProtocol start
信息: Starting ProtocolHandler ["http-nio-8080"]
七月 21, 2016 5:51:54 下午 org.apache.coyote.AbstractProtocol start
信息: Starting ProtocolHandler ["ajp-nio-8009"]
七月 21, 2016 5:51:54 下午 org.apache.catalina.startup.Catalina start
信息: Server startup in 3497 ms
大神求告知,为什么会报这个错误。