NutzCN Logo
问答 为何打印不出tio的日志
发布于 8天前 作者 蛋蛋的忧伤 65 次浏览 复制 上一个帖子 下一个帖子
标签:

log4j.properties

log4j.rootLogger=debug,Console,file

log4j.logger.org.nutz.dao = debug
log4j.logger.org.nutz.ioc = debug
log4j.logger.freemarker = debug
log4j.logger.org.apache.commons = debug
log4j.logger.me.zouooh.mvc.quartz.QuartzIocLoader = debug
log4j.logger.org.nutz.mvc.impl.Loadings = debug
log4j.logger.org.tio.server = debug


log4j.appender.Console=org.apache.log4j.ConsoleAppender
log4j.appender.Console.layout=org.apache.log4j.PatternLayout
log4j.appender.Console.layout.ConversionPattern=[%-5p] %d{HH:mm:ss.SSS} %l - %m%n


log4j.appender.file=org.apache.log4j.DailyRollingFileAppender
log4j.appender.file.DatePattern='-'yyyy-MM-dd-HH'.log'
log4j.appender.file.File= ${catalina.home}/logs/water-server/out
log4j.appender.file.Append=true
log4j.appender.file.Encoding=UTF8
log4j.appender.file.layout=org.apache.log4j.PatternLayout
log4j.appender.file.layout.ConversionPattern=[%-5p] %d{yyyy-MM-dd HH:mm:ss.SSS} %l - %m%n

启动tio,调试跟到这里,正常应该打印warn日志,但是没有打印....

package org.tio.server;

import java.io.IOException;
import java.net.InetSocketAddress;
import java.net.StandardSocketOptions;
import java.nio.channels.AsynchronousChannelGroup;
import java.nio.channels.AsynchronousServerSocketChannel;
import java.util.concurrent.ExecutorService;
import java.util.concurrent.TimeUnit;

import org.apache.commons.lang3.StringUtils;
import org.slf4j.Logger;
import org.slf4j.LoggerFactory;
import org.tio.core.Node;

/**
 *
 * @author tanyaowu
 *
 */
public class AioServer {
	......省略
          private static Logger log = LoggerFactory.getLogger(AioServer.class);


	public void start(String serverIp, int serverPort) throws IOException {
		.....省略
		log.warn("{} started, listen on {}", serverGroupContext.getName(), this.serverNode);
	}

.....省略
}

我看t-io源代码里用的 slf4j-logback好像,配置文件是xml的...

8 回复
[INFO ] 14:30:26.046 org.nutz.mvc.NutFilter._init(NutFilter.java:85) - NutFilter[nutz] starting ...
[DEBUG] 14:30:26.091 org.nutz.resource.Scans.printLocations(Scans.java:527) - Locations count=5 time use 13ms
[DEBUG] 14:30:26.185 org.nutz.resource.Scans.printLocations(Scans.java:527) - Locations count=46 time use 93ms
[DEBUG] 14:30:26.244 org.nutz.mvc.config.AbstractNutConfig.createLoading(AbstractNutConfig.java:61) - Loading by class org.nutz.mvc.impl.NutLoading
[INFO ] 14:30:26.251 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:55) - Nutz Version : 1.r.63-SNAPSHOT 
[INFO ] 14:30:26.251 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:56) - Nutz.Mvc[nutz] is initializing ...
[DEBUG] 14:30:26.252 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:60) - Web Container Information:
[DEBUG] 14:30:26.254 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:61) -  - Default Charset : UTF-8
[DEBUG] 14:30:26.257 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:62) -  - Current . path  : E:\dev\apache-tomcat-8.0.48\bin\.
[DEBUG] 14:30:26.258 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:63) -  - Java Version    : 1.8.0_151
[DEBUG] 14:30:26.259 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:64) -  - File separator  : \
[DEBUG] 14:30:26.260 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:65) -  - Timezone        : Asia/Shanghai
[DEBUG] 14:30:26.261 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:66) -  - OS              : Windows 10 amd64
[DEBUG] 14:30:26.262 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:67) -  - ServerInfo      : Apache Tomcat/8.0.48
[DEBUG] 14:30:26.263 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:68) -  - Servlet API     : 3.1
[DEBUG] 14:30:26.264 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:73) -  - ContextPath     : /server
[DEBUG] 14:30:26.267 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:74) -  - context.tempdir : C:\Users\Administrator\.IntelliJIdea2017.3\system\tomcat\Unnamed_water\work\Catalina\localhost\server
[DEBUG] 14:30:26.268 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:75) -  - MainModule      : com.yixin.water.MainModule
[DEBUG] 14:30:26.275 org.nutz.mvc.impl.NutLoading.createContext(NutLoading.java:239) - >> app.root = E:/idea_workspace/water/water-server/target/water-server
[DEBUG] 14:30:26.434 org.nutz.castor.Castors.reload(Castors.java:115) - Using 95 castor for Castors
[DEBUG] 14:30:26.436 org.nutz.mvc.impl.NutLoading.createIoc(NutLoading.java:380) - @IocBy(type=org.nutz.mvc.ioc.provider.ComboIocProvider, args=["*js", "ioc/", "*anno", "com.yixin.water", "com.wangzc", "*tx"],init=[])
11-Jan-2018 14:30:26.436 信息 [localhost-startStop-1] org.apache.catalina.startup.HostConfig.deployDirectory Deploying web application directory E:\dev\apache-tomcat-8.0.48\webapps\manager
11-Jan-2018 14:30:26.634 信息 [localhost-startStop-1] org.apache.jasper.servlet.TldScanner.scanJars At least one JAR was scanned for TLDs yet contained no TLDs. Enable debug logging for this logger for a complete list of JARs that were scanned but no TLDs were found in them. Skipping unneeded JARs during scanning can improve startup time and JSP compilation time.
[DEBUG] 14:30:26.660 org.nutz.resource.Scans.scan(Scans.java:280) - Found 4 resource by src( ioc/ ) , regex( ^(.+[.])(js|json)$ )
[DEBUG] 14:30:26.661 org.nutz.ioc.loader.json.JsonLoader.<init>(JsonLoader.java:49) - loading [conf.js]
[DEBUG] 14:30:26.666 org.nutz.ioc.loader.json.JsonLoader.<init>(JsonLoader.java:49) - loading [dao.js]
[DEBUG] 14:30:26.668 org.nutz.ioc.loader.json.JsonLoader.<init>(JsonLoader.java:49) - loading [ehcache.js]
[DEBUG] 14:30:26.670 org.nutz.ioc.loader.json.JsonLoader.<init>(JsonLoader.java:49) - loading [upload.js]
[DEBUG] 14:30:26.675 org.nutz.ioc.loader.json.JsonLoader.<init>(JsonLoader.java:57) - Loaded 9 bean define from path=[ioc/] --> [dao, cacheProvider, uploadFileContext, cacheExecutor, tmpFilePool, conf, imageUpload, dataSource, cacheManager]
11-Jan-2018 14:30:26.690 信息 [localhost-startStop-1] org.apache.catalina.startup.HostConfig.deployDirectory Deployment of web application directory E:\dev\apache-tomcat-8.0.48\webapps\manager has finished in 253 ms
[DEBUG] 14:30:26.723 org.nutz.resource.Scans.scan(Scans.java:280) - Found 33 resource by src( com/yixin/water/ ) , regex( ^.+[.]class$ )
[DEBUG] 14:30:26.785 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:80) - Found @IocBean : class com.yixin.water.controllers.TestController
[DEBUG] 14:30:26.795 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:80) - Found @IocBean : class com.yixin.water.socket.context.WaterSessionContext
[DEBUG] 14:30:26.797 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:80) - Found @IocBean : class com.yixin.water.socket.handler.BindReqHandler
[DEBUG] 14:30:26.809 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:80) - Found @IocBean : class com.yixin.water.socket.listener.WaterServerAioListener
[DEBUG] 14:30:26.811 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:80) - Found @IocBean : class com.yixin.water.socket.WaterAioHandler
[DEBUG] 14:30:26.816 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:80) - Found @IocBean : class com.yixin.water.socket.WaterAioServer
[DEBUG] 14:30:26.849 org.nutz.resource.Scans.scan(Scans.java:280) - Found 103 resource by src( com/wangzc/ ) , regex( ^.+[.]class$ )
[DEBUG] 14:30:26.982 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:80) - Found @IocBean : class com.wangzc.mvc.controller.HomeController
[DEBUG] 14:30:26.983 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:80) - Found @IocBean : class com.wangzc.mvc.controller.sys.SysLogController
[DEBUG] 14:30:26.995 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:80) - Found @IocBean : class com.wangzc.mvc.controller.sys.SysLoginController
[DEBUG] 14:30:27.000 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:80) - Found @IocBean : class com.wangzc.mvc.controller.sys.SysMenuController
[DEBUG] 14:30:27.003 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:80) - Found @IocBean : class com.wangzc.mvc.controller.sys.SysMsgController
[DEBUG] 14:30:27.007 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:80) - Found @IocBean : class com.wangzc.mvc.controller.sys.SysPermissionController
[DEBUG] 14:30:27.009 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:80) - Found @IocBean : class com.wangzc.mvc.controller.sys.SysRoleController
[DEBUG] 14:30:27.014 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:80) - Found @IocBean : class com.wangzc.mvc.controller.sys.SysRolePermissionController
[DEBUG] 14:30:27.015 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:80) - Found @IocBean : class com.wangzc.mvc.controller.sys.SysUserController
[DEBUG] 14:30:27.018 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:80) - Found @IocBean : class com.wangzc.mvc.controller.sys.SysUserRoleController
[DEBUG] 14:30:27.021 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:80) - Found @IocBean : class com.wangzc.mvc.controller.UploadController
[DEBUG] 14:30:27.037 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:80) - Found @IocBean : class com.wangzc.mvc.service.impl.SysLogServiceImpl
[DEBUG] 14:30:27.039 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:80) - Found @IocBean : class com.wangzc.mvc.service.impl.SysMenuServiceImpl
[DEBUG] 14:30:27.042 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:80) - Found @IocBean : class com.wangzc.mvc.service.impl.SysMsgServiceImpl
[DEBUG] 14:30:27.044 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:80) - Found @IocBean : class com.wangzc.mvc.service.impl.SysRolePermissionServiceImpl
[DEBUG] 14:30:27.045 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:80) - Found @IocBean : class com.wangzc.mvc.service.impl.SysUserRolePermissionServciceImpl
[DEBUG] 14:30:27.047 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:80) - Found @IocBean : class com.wangzc.mvc.service.impl.SysUserServiceImpl
[INFO ] 14:30:27.051 org.nutz.ioc.loader.annotation.AnnotationIocLoader.<init>(AnnotationIocLoader.java:56) - Found 23 classes in 2 base-packages!
beans = ["sysLogService", "testController", "sysRolePermissionController", "uploadController", "waterSessionContext", "sysMenuService", "sysRolePermissionService", "waterAioHandler", "sysLoginController", "sysMenuController", "homeController", "sysLogController", "sysPermissionController", "waterAioServer", "sysUserService", "waterServerAioListener", "bindReqHandler", "sysMsgController", "sysRoleController", "sysMsgService", "sysUserController", "sysUserRolePermissionService", "sysUserRoleController"]
[DEBUG] 14:30:27.064 org.nutz.ioc.loader.json.JsonLoader.<init>(JsonLoader.java:40) - Loaded 5 bean define from reader --
[txREPEATABLE_READ, txSERIALIZABLE, txNONE, txREAD_UNCOMMITTED, txREAD_COMMITTED]
[INFO ] 14:30:27.071 org.nutz.ioc.impl.NutIoc.<init>(NutIoc.java:98) - NutIoc init begin ...
[INFO ] 14:30:27.077 org.nutz.ioc.impl.NutIoc.<init>(NutIoc.java:121) - ... NutIoc init complete
[INFO ] 14:30:27.086 org.nutz.mvc.impl.NutLoading.evalUrlMapping(NutLoading.java:159) - Build URL mapping by org.nutz.mvc.impl.UrlMappingImpl ...
[DEBUG] 14:30:27.093 org.nutz.mvc.impl.NutLoading.createViewMakers(NutLoading.java:370) - @Views(HtmlViewMaker.class,DefaultViewMaker.class)
[DEBUG] 14:30:27.122 org.nutz.resource.Scans.scan(Scans.java:280) - Found 1 resource by src( mvc/chain.js ) , regex( ^(.+[.])(js|json)$ )
[DEBUG] 14:30:27.128 org.nutz.mvc.impl.chainconfig.JsonActionChainMakerConfiguretion.<init>(JsonActionChainMakerConfiguretion.java:37) - ActionChain Config:
{
   "default": {
      "ps": ["com.wangzc.mvc.processor.LogTimeProcessor", "org.nutz.mvc.impl.processor.UpdateRequestAttributesProcessor", "org.nutz.mvc.impl.processor.EncodingProcessor", "org.nutz.mvc.impl.processor.ModuleProcessor", "com.wangzc.mvc.processor.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"
   }
}
[DEBUG] 14:30:27.128 org.nutz.mvc.impl.NutLoading.createChainMaker(NutLoading.java:267) - @ChainBy(org.nutz.mvc.impl.NutActionChainMaker)
[DEBUG] 14:30:27.154 org.nutz.mvc.impl.Loadings.scanModuleInPackage(Loadings.java:188) -  > scan 'com.wangzc'
[DEBUG] 14:30:27.163 org.nutz.resource.Scans.scan(Scans.java:280) - Found 103 resource by src( com/wangzc/ ) , regex( ^.+[.]class$ )
[DEBUG] 14:30:27.254 org.nutz.mvc.impl.Loadings.checkModule(Loadings.java:203) -    >> add 'com.wangzc.mvc.controller.HomeController'
[DEBUG] 14:30:27.255 org.nutz.mvc.impl.Loadings.checkModule(Loadings.java:203) -    >> add 'com.wangzc.mvc.controller.sys.SysLogController'
[DEBUG] 14:30:27.255 org.nutz.mvc.impl.Loadings.checkModule(Loadings.java:203) -    >> add 'com.wangzc.mvc.controller.sys.SysLoginController'
[DEBUG] 14:30:27.256 org.nutz.mvc.impl.Loadings.checkModule(Loadings.java:203) -    >> add 'com.wangzc.mvc.controller.sys.SysMenuController'
[DEBUG] 14:30:27.257 org.nutz.mvc.impl.Loadings.checkModule(Loadings.java:203) -    >> add 'com.wangzc.mvc.controller.sys.SysMsgController'
[DEBUG] 14:30:27.258 org.nutz.mvc.impl.Loadings.checkModule(Loadings.java:203) -    >> add 'com.wangzc.mvc.controller.sys.SysPermissionController'
[DEBUG] 14:30:27.260 org.nutz.mvc.impl.Loadings.checkModule(Loadings.java:203) -    >> add 'com.wangzc.mvc.controller.sys.SysRoleController'
[DEBUG] 14:30:27.262 org.nutz.mvc.impl.Loadings.checkModule(Loadings.java:203) -    >> add 'com.wangzc.mvc.controller.sys.SysRolePermissionController'
[DEBUG] 14:30:27.263 org.nutz.mvc.impl.Loadings.checkModule(Loadings.java:203) -    >> add 'com.wangzc.mvc.controller.sys.SysUserController'
[DEBUG] 14:30:27.264 org.nutz.mvc.impl.Loadings.checkModule(Loadings.java:203) -    >> add 'com.wangzc.mvc.controller.sys.SysUserRoleController'
[DEBUG] 14:30:27.267 org.nutz.mvc.impl.Loadings.checkModule(Loadings.java:203) -    >> add 'com.wangzc.mvc.controller.UploadController'
[DEBUG] 14:30:27.395 org.nutz.mvc.impl.Loadings.scanModules(Loadings.java:158) - module class location 'file:/E:/idea_workspace/water/water-server/target/water-server/WEB-INF/classes/'
[DEBUG] 14:30:27.396 org.nutz.mvc.impl.Loadings.scanModuleInPackage(Loadings.java:188) -  > scan 'com.yixin.water'
[DEBUG] 14:30:27.417 org.nutz.resource.Scans.scan(Scans.java:280) - Found 33 resource by src( com/yixin/water/ ) , regex( ^.+[.]class$ )
[DEBUG] 14:30:27.558 org.nutz.mvc.impl.Loadings.checkModule(Loadings.java:203) -    >> add 'com.yixin.water.controllers.TestController'
[DEBUG] 14:30:27.580 org.nutz.mvc.impl.NutLoading.evalUrlMapping(NutLoading.java:196) - Use org.nutz.mvc.impl.NutEntryDeterminer as EntryMethodDeterminer
[DEBUG] 14:30:27.833 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/sys/permission/add'       >> (SysPermissionController.java:91).add : Object     | @Ok(json ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[DEBUG] 14:30:27.837 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/sys/permission/delete'    >> (SysPermissionController.java:72).delete : Object     | @Ok(json ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[DEBUG] 14:30:27.839 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/sys/permission/list'      >> (SysPermissionController.java:42).list : Object     | @Ok(html ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[DEBUG] 14:30:27.842 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/sys/permission/select'    >> (SysPermissionController.java:33).select : Object     | @Ok(json ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[DEBUG] 14:30:27.845 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/test/stopSocket'          >> (TestController.java:18).stopSocket   : Object     | @Ok(json ) @Fail(json ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[DEBUG] 14:30:27.855 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/sys/log/list'             >> (SysLogController.java:30).list       : Object     | @Ok(html ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[DEBUG] 14:30:27.857 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/login/register'           >> (SysLoginController.java:40).register : Object     | @Ok(json ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[DEBUG] 14:30:27.861 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/sys/role/add'             >> (SysRoleController.java:37).add       : Object     | @Ok(json ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[DEBUG] 14:30:27.863 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/sys/role/delete'          >> (SysRoleController.java:52).delete    : Object     | @Ok(json ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[DEBUG] 14:30:27.866 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/sys/role/list'            >> (SysRoleController.java:65).list      : Object     | @Ok(html ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[DEBUG] 14:30:27.868 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/sys/role/select'          >> (SysRoleController.java:28).select    : Object     | @Ok(json ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[DEBUG] 14:30:27.889 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/sys/user/add'             >> (SysUserController.java:61).add       : Object     | @Ok(json ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[DEBUG] 14:30:27.891 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/sys/user/lock'            >> (SysUserController.java:75).lock      : Object     | @Ok(json ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[DEBUG] 14:30:27.892 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/sys/user/list'            >> (SysUserController.java:40).list      : Object     | @Ok(html ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[DEBUG] 14:30:27.897 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/sys/user/reset'           >> (SysUserController.java:121).reset    : Object     | @Ok(json ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[DEBUG] 14:30:27.899 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/sys/user/chpwd'           >> (SysUserController.java:98).chpwd     : Object     | @Ok(json ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[DEBUG] 14:30:27.902 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/sys/user/role/add'        >> (SysUserRoleController.java:38).add   : Object     | @Ok(json ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[DEBUG] 14:30:27.904 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/sys/user/role/delete'     >> (SysUserRoleController.java:48).delete : Object     | @Ok(json ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[DEBUG] 14:30:27.909 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/sys/menu/add'             >> (SysMenuController.java:79).add       : Object     | @Ok(json ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[DEBUG] 14:30:27.911 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/sys/menu/delete'          >> (SysMenuController.java:118).delete   : Object     | @Ok(json ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[DEBUG] 14:30:27.915 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/sys/menu/list'            >> (SysMenuController.java:36).list      : Object     | @Ok(html ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[DEBUG] 14:30:27.917 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/sys/menu/save'            >> (SysMenuController.java:103).save     : Object     | @Ok(json ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[DEBUG] 14:30:27.918 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/sys/menu/select'          >> (SysMenuController.java:127).select   : Object     | @Ok(json ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[DEBUG] 14:30:27.920 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/sys/menu/edit'            >> (SysMenuController.java:94).edit      : Object     | @Ok(html ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[DEBUG] 14:30:27.923 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/sys/role/permission/list' >> (SysRolePermissionController.java:41).list : Object     | @Ok(html ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[DEBUG] 14:30:27.925 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/sys/role/permission/edit' >> (SysRolePermissionController.java:83).edit : Object     | @Ok(json ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[DEBUG] 14:30:27.928 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/sys/msg/read'             >> (SysMsgController.java:42).read       : Object     | @Ok(html ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[DEBUG] 14:30:27.929 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/sys/msg/list'             >> (SysMsgController.java:28).list       : Object     | @Ok(html ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[DEBUG] 14:30:27.932 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/sys/msg/upload'           >> (SysMsgController.java:69).upload     : Object     | @Ok(json ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[DEBUG] 14:30:27.933 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/sys/msg/nums'             >> (SysMsgController.java:52).nums       : Object     | @Ok(json ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[DEBUG] 14:30:27.936 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/home'                     >> (HomeController.java:21).home         : Object     | @Ok(html ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[INFO ] 14:30:27.987 org.nutz.filepool.NutFilePool.<init>(NutFilePool.java:25) - Init file-pool by: E:\dev\apache-tomcat-8.0.48\temp [2000]
[DEBUG] 14:30:27.995 org.nutz.filepool.NutFilePool.<init>(NutFilePool.java:39) - file-pool.home: 'E:\dev\apache-tomcat-8.0.48\temp'
[INFO ] 14:30:28.001 org.nutz.filepool.NutFilePool.<init>(NutFilePool.java:68) - file-pool.cursor: 0
[DEBUG] 14:30:28.012 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/upload/file'              >> (UploadController.java:54).file       : Object     | @Ok(json ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[DEBUG] 14:30:28.014 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'imageUpload'<class org.nutz.mvc.upload.UploadAdaptor>
[DEBUG] 14:30:28.018 org.nutz.ioc.aop.SimpleAopMaker.<init>(SimpleAopMaker.java:79) - Load AopConfigure for anno=org.nutz.ioc.aop.Aop by type=org.nutz.ioc.aop.config.impl.AnnotationAopConfigration
[DEBUG] 14:30:28.020 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:183) - 	 >> Load definition name=imageUpload
[DEBUG] 14:30:28.022 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) - Loading define for name=imageUpload
[DEBUG] 14:30:28.027 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:163) - Found IocObject(imageUpload) in JsonLoader(paths=[ioc/])
[DEBUG] 14:30:28.027 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:215) - 	 >> Make...'imageUpload'<class org.nutz.mvc.upload.UploadAdaptor>
[DEBUG] 14:30:28.045 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'uploadFileContext'<>
[DEBUG] 14:30:28.053 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:183) - 	 >> Load definition name=uploadFileContext
[DEBUG] 14:30:28.054 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) - Loading define for name=uploadFileContext
[DEBUG] 14:30:28.055 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:163) - Found IocObject(uploadFileContext) in JsonLoader(paths=[ioc/])
[DEBUG] 14:30:28.056 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:215) - 	 >> Make...'uploadFileContext'<>
[DEBUG] 14:30:28.056 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'tmpFilePool'<>
[DEBUG] 14:30:28.057 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:183) - 	 >> Load definition name=tmpFilePool
[DEBUG] 14:30:28.058 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) - Loading define for name=tmpFilePool
[DEBUG] 14:30:28.064 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:163) - Found IocObject(tmpFilePool) in JsonLoader(paths=[ioc/])
[DEBUG] 14:30:28.064 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:215) - 	 >> Make...'tmpFilePool'<>
[DEBUG] 14:30:28.067 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) - Save object 'tmpFilePool' to [app] 
[DEBUG] 14:30:28.071 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) - Load class org.nutz.filepool.NutFilePool without AOP
[INFO ] 14:30:28.160 org.nutz.filepool.NutFilePool.<init>(NutFilePool.java:25) - Init file-pool by: ~/nutz/blog/upload/tmps [1000]
[DEBUG] 14:30:28.172 org.nutz.filepool.NutFilePool.<init>(NutFilePool.java:39) - file-pool.home: 'C:\Users\Administrator\nutz\blog\upload\tmps'
[INFO ] 14:30:28.174 org.nutz.filepool.NutFilePool.<init>(NutFilePool.java:68) - file-pool.cursor: 0
[DEBUG] 14:30:28.180 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) - Load class org.nutz.mvc.upload.UploadingContext without AOP
[DEBUG] 14:30:28.191 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'tmpFilePool'<>
[DEBUG] 14:30:28.268 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) - Load class org.nutz.mvc.upload.UploadAdaptor without AOP
[DEBUG] 14:30:28.269 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'uploadFileContext'<>
[DEBUG] 14:30:28.270 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:183) - 	 >> Load definition name=uploadFileContext
[DEBUG] 14:30:28.271 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) - Loading define for name=uploadFileContext
[DEBUG] 14:30:28.277 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:163) - Found IocObject(uploadFileContext) in JsonLoader(paths=[ioc/])
[DEBUG] 14:30:28.281 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:215) - 	 >> Make...'uploadFileContext'<>
[DEBUG] 14:30:28.291 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'tmpFilePool'<>
[DEBUG] 14:30:28.298 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) - Load class org.nutz.mvc.upload.UploadingContext without AOP
[DEBUG] 14:30:28.302 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'tmpFilePool'<>
[DEBUG] 14:30:28.306 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) -    '/upload/image'             >> (UploadController.java:35).image      : Object     | @Ok(json ) @Fail(fail ) | by 0 Filters | (I:UTF-8/O:UTF-8)
[INFO ] 14:30:28.309 org.nutz.mvc.impl.NutLoading.evalUrlMapping(NutLoading.java:221) - Found 33 module methods
[DEBUG] 14:30:28.314 org.nutz.mvc.impl.NutLoading.evalLocalization(NutLoading.java:335) - @Localization not define
[INFO ] 14:30:28.330 org.nutz.mvc.impl.NutLoading.createSessionProvider(NutLoading.java:414) - SessionBy --> org.nutz.integration.shiro.ShiroSessionProvider@748d9178
[INFO ] 14:30:28.331 org.nutz.mvc.impl.NutLoading.evalSetup(NutLoading.java:275) - Setup application...
[INFO ] 14:30:28.341 com.wangzc.mvc.setup.AbstractSetup.init(AbstractSetup.java:36) - You shall set up environment variable [ehcache.disk.store.dir], which using at ehcache.xml =>>  -Dehcache.disk.store.dir=/tmp
[DEBUG] 14:30:28.342 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'cacheManager'<class net.sf.ehcache.CacheManager>
[DEBUG] 14:30:28.342 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:183) - 	 >> Load definition name=cacheManager
[DEBUG] 14:30:28.343 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) - Loading define for name=cacheManager
[DEBUG] 14:30:28.344 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:163) - Found IocObject(cacheManager) in JsonLoader(paths=[ioc/])
[DEBUG] 14:30:28.345 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:215) - 	 >> Make...'cacheManager'<class net.sf.ehcache.CacheManager>
[DEBUG] 14:30:28.346 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) - Save object 'cacheManager' to [app] 
[DEBUG] 14:30:28.354 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) - Load class net.sf.ehcache.CacheManager without AOP
[DEBUG] 14:30:28.355 com.wangzc.mvc.setup.AbstractSetup.init(AbstractSetup.java:45) - Ehcache CacheManager = admin
[DEBUG] 14:30:28.356 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'dao'<interface org.nutz.dao.Dao>
[DEBUG] 14:30:28.357 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:183) - 	 >> Load definition name=dao
[DEBUG] 14:30:28.359 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) - Loading define for name=dao
[DEBUG] 14:30:28.366 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:163) - Found IocObject(dao) in JsonLoader(paths=[ioc/])
[DEBUG] 14:30:28.367 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:215) - 	 >> Make...'dao'<interface org.nutz.dao.Dao>
[DEBUG] 14:30:28.368 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) - Save object 'dao' to [app] 
[DEBUG] 14:30:28.368 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'dataSource'<>
[DEBUG] 14:30:28.369 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:183) - 	 >> Load definition name=dataSource
[DEBUG] 14:30:28.370 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) - Loading define for name=dataSource
[DEBUG] 14:30:28.411 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:163) - Found IocObject(dataSource) in JsonLoader(paths=[ioc/])
[DEBUG] 14:30:28.412 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:215) - 	 >> Make...'dataSource'<>
[DEBUG] 14:30:28.413 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) - Save object 'dataSource' to [app] 
[DEBUG] 14:30:28.465 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) - Load class com.alibaba.druid.pool.DruidDataSource without AOP
[DEBUG] 14:30:29.417 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'conf'<>
[DEBUG] 14:30:29.418 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:183) - 	 >> Load definition name=conf
[DEBUG] 14:30:29.419 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) - Loading define for name=conf
[DEBUG] 14:30:29.440 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:163) - Found IocObject(conf) in JsonLoader(paths=[ioc/])
[DEBUG] 14:30:29.441 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:215) - 	 >> Make...'conf'<>
[DEBUG] 14:30:29.441 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) - Save object 'conf' to [app] 
[DEBUG] 14:30:29.443 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) - Load class org.nutz.ioc.impl.PropertiesProxy without AOP
[DEBUG] 14:30:29.584 org.nutz.resource.Scans.scan(Scans.java:280) - Found 5 resource by src( config/ ) , regex( ^.+[.]properties$ )
[DEBUG] 14:30:29.651 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'conf'<>
[DEBUG] 14:30:29.652 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'conf'<>
[DEBUG] 14:30:29.657 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'conf'<>
[DEBUG] 14:30:29.657 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'conf'<>
[INFO ] 14:30:29.762 com.alibaba.druid.pool.DruidDataSource.init(DruidDataSource.java:722) - {dataSource-1} inited
[DEBUG] 14:30:29.787 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) - Load class org.nutz.dao.impl.NutDao without AOP
[DEBUG] 14:30:29.788 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'dataSource'<>
[DEBUG] 14:30:30.404 org.nutz.dao.jdbc.Jdbcs.<clinit>(Jdbcs.java:90) - Jdbcs init complete
[INFO ] 14:30:30.405 org.nutz.dao.jdbc.Jdbcs.getExpert(Jdbcs.java:103) - Get Connection from DataSource for JdbcExpert, if you lock at here, check your database server and configure
[DEBUG] 14:30:31.165 org.nutz.dao.impl.DaoSupport.setDataSource(DaoSupport.java:188) - select expert : org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert
[DEBUG] 14:30:31.181 org.nutz.dao.impl.DaoSupport$1.invoke(DaoSupport.java:199) - JDBC Driver --> mysql-connector-java-5.1.39 ( Revision: 3289a357af6d09ecc1a10fd3c26e95183e5790ad )
[DEBUG] 14:30:31.182 org.nutz.dao.impl.DaoSupport$1.invoke(DaoSupport.java:200) - JDBC Name   --> MySQL Connector Java
[DEBUG] 14:30:31.182 org.nutz.dao.impl.DaoSupport$1.invoke(DaoSupport.java:202) - JDBC URL    --> jdbc:mysql://pos.xvo2o.com:3306/waterfountain?useOldAliasMetadataBehavior=true&useUnicode=true&characterEncoding=utf8
[DEBUG] 14:30:31.211 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) - Mysql : character_set_client=utf8
[DEBUG] 14:30:31.212 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) - Mysql : character_set_connection=utf8
[DEBUG] 14:30:31.213 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) - Mysql : character_set_database=utf8
[DEBUG] 14:30:31.214 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) - Mysql : character_set_filesystem=binary
[DEBUG] 14:30:31.214 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) - Mysql : character_set_results=
[DEBUG] 14:30:31.215 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) - Mysql : character_set_server=latin1
[DEBUG] 14:30:31.215 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) - Mysql : character_set_system=utf8
[DEBUG] 14:30:31.216 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) - Mysql : character_sets_dir=/usr/share/mysql/charsets/
[DEBUG] 14:30:31.232 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:219) - Mysql : binlog_format=STATEMENT
[DEBUG] 14:30:31.247 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:226) - Mysql : database=waterfountain
[DEBUG] 14:30:31.263 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:232) - Mysql : user=root@219.146.132.30
[DEBUG] 14:30:31.310 org.nutz.dao.impl.DaoSupport.setDataSource(DaoSupport.java:221) - Database info --> MYSQL:[MySQL - 5.5.58-0ubuntu0.14.04.1]
[DEBUG] 14:30:31.316 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'cacheExecutor'<>
[DEBUG] 14:30:31.316 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:183) - 	 >> Load definition name=cacheExecutor
[DEBUG] 14:30:31.316 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) - Loading define for name=cacheExecutor
[DEBUG] 14:30:31.318 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:163) - Found IocObject(cacheExecutor) in JsonLoader(paths=[ioc/])
[DEBUG] 14:30:31.319 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:215) - 	 >> Make...'cacheExecutor'<>
[DEBUG] 14:30:31.319 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) - Save object 'cacheExecutor' to [app] 
[DEBUG] 14:30:31.322 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) - Load class org.nutz.plugins.cache.dao.CachedNutDaoExecutor without AOP
[DEBUG] 14:30:31.349 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'cacheProvider'<>
[DEBUG] 14:30:31.350 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:183) - 	 >> Load definition name=cacheProvider
[DEBUG] 14:30:31.351 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) - Loading define for name=cacheProvider
[DEBUG] 14:30:31.354 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:163) - Found IocObject(cacheProvider) in JsonLoader(paths=[ioc/])
[DEBUG] 14:30:31.355 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:215) - 	 >> Make...'cacheProvider'<>
[DEBUG] 14:30:31.356 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) - Save object 'cacheProvider' to [app] 
[DEBUG] 14:30:31.358 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) - Load class org.nutz.plugins.cache.dao.impl.provider.EhcacheDaoCacheProvider without AOP
[DEBUG] 14:30:31.383 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'cacheManager'<>
[DEBUG] 14:30:31.394 com.wangzc.mvc.setup.AbstractSetup$1.invoke(AbstractSetup.java:57) - Source Connection Class=com.mysql.jdbc.JDBC4Connection
[DEBUG] 14:30:31.395 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'waterAioServer'<class com.yixin.water.socket.WaterAioServer>
[DEBUG] 14:30:31.396 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:183) - 	 >> Load definition name=waterAioServer
[DEBUG] 14:30:31.397 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:163) - Found IocObject(waterAioServer) in AnnotationIocLoader(packages=[com.yixin.water, com.wangzc])
[DEBUG] 14:30:31.398 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:215) - 	 >> Make...'waterAioServer'<class com.yixin.water.socket.WaterAioServer>
[DEBUG] 14:30:31.398 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) - Save object 'waterAioServer' to [app] 
[DEBUG] 14:30:31.400 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) - Load class com.yixin.water.socket.WaterAioServer without AOP
[DEBUG] 14:30:31.446 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'waterAioHandler'<class com.yixin.water.socket.WaterAioHandler>
[DEBUG] 14:30:31.446 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:183) - 	 >> Load definition name=waterAioHandler
[DEBUG] 14:30:31.447 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:163) - Found IocObject(waterAioHandler) in AnnotationIocLoader(packages=[com.yixin.water, com.wangzc])
[DEBUG] 14:30:31.448 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:215) - 	 >> Make...'waterAioHandler'<class com.yixin.water.socket.WaterAioHandler>
[DEBUG] 14:30:31.449 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) - Save object 'waterAioHandler' to [app] 
[DEBUG] 14:30:31.449 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) - Load class com.yixin.water.socket.WaterAioHandler without AOP
[DEBUG] 14:30:31.461 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'bindReqHandler'<class com.yixin.water.socket.handler.BindReqHandler>
[DEBUG] 14:30:31.462 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:183) - 	 >> Load definition name=bindReqHandler
[DEBUG] 14:30:31.463 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:163) - Found IocObject(bindReqHandler) in AnnotationIocLoader(packages=[com.yixin.water, com.wangzc])
[DEBUG] 14:30:31.464 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:215) - 	 >> Make...'bindReqHandler'<class com.yixin.water.socket.handler.BindReqHandler>
[DEBUG] 14:30:31.465 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) - Save object 'bindReqHandler' to [app] 
[DEBUG] 14:30:31.466 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) - Load class com.yixin.water.socket.handler.BindReqHandler without AOP
[DEBUG] 14:30:31.478 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'dao'<interface org.nutz.dao.Dao>
[DEBUG] 14:30:31.479 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'sysMsgService'<interface com.wangzc.mvc.service.SysMsgService>
[DEBUG] 14:30:31.483 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:183) - 	 >> Load definition name=sysMsgService
[DEBUG] 14:30:31.484 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:163) - Found IocObject(sysMsgService) in AnnotationIocLoader(packages=[com.yixin.water, com.wangzc])
[DEBUG] 14:30:31.485 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:215) - 	 >> Make...'sysMsgService'<interface com.wangzc.mvc.service.SysMsgService>
[DEBUG] 14:30:31.486 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) - Save object 'sysMsgService' to [app] 
[DEBUG] 14:30:31.486 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) - Load class com.wangzc.mvc.service.impl.SysMsgServiceImpl without AOP
[DEBUG] 14:30:31.503 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'dao'<interface org.nutz.dao.Dao>
[DEBUG] 14:30:31.504 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'conf'<class org.nutz.ioc.impl.PropertiesProxy>
[DEBUG] 14:30:31.504 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'sysMsgService'<interface com.wangzc.mvc.service.SysMsgService>
[DEBUG] 14:30:31.504 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'waterServerAioListener'<>
[DEBUG] 14:30:31.505 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:183) - 	 >> Load definition name=waterServerAioListener
[DEBUG] 14:30:31.505 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:163) - Found IocObject(waterServerAioListener) in AnnotationIocLoader(packages=[com.yixin.water, com.wangzc])
[DEBUG] 14:30:31.506 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:215) - 	 >> Make...'waterServerAioListener'<>
[DEBUG] 14:30:31.506 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) - Save object 'waterServerAioListener' to [app] 
[DEBUG] 14:30:31.507 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) - Load class com.yixin.water.socket.listener.WaterServerAioListener without AOP
[DEBUG] 14:30:31.519 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'conf'<class org.nutz.ioc.impl.PropertiesProxy>
[DEBUG] 14:30:34.385 com.yixin.water.socket.WaterAioServer.start(WaterAioServer.java:63) - 启动成功
[DEBUG] 14:30:34.386 com.yixin.water.MainSetup.init(MainSetup.java:37) - Socket启动成功...
[DEBUG] 14:30:34.386 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'conf'<class org.nutz.ioc.impl.PropertiesProxy>
[DEBUG] 14:30:34.387 com.wangzc.mvc.setup.init.Init.execute(Init.java:51) - water-admin init : com.wangzc.mvc.setup.init.InitProperties
[DEBUG] 14:30:34.387 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'conf'<class org.nutz.ioc.impl.PropertiesProxy>
[DEBUG] 14:30:34.388 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'conf'<class org.nutz.ioc.impl.PropertiesProxy>
[DEBUG] 14:30:34.388 com.wangzc.mvc.setup.init.Init.execute(Init.java:51) - water-admin init : com.wangzc.mvc.setup.init.InitTable @ { package: com.wangzc }
[DEBUG] 14:30:34.389 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'dao'<interface org.nutz.dao.Dao>
[DEBUG] 14:30:34.393 org.nutz.resource.Scans.scan(Scans.java:280) - Found 103 resource by src( com/wangzc/ ) , regex( ^.+[.]class$ )
[DEBUG] 14:30:34.635 org.nutz.resource.Scans.scan(Scans.java:280) - Found 103 resource by src( com/wangzc/ ) , regex( ^.+[.]class$ )
[DEBUG] 14:30:34.897 com.wangzc.mvc.setup.init.Init.execute(Init.java:51) - water-admin init : com.wangzc.mvc.setup.init.InitRoleAndPermission @ { package: com.wangzc }
[DEBUG] 14:30:34.901 org.nutz.resource.Scans.scan(Scans.java:280) - Found 103 resource by src( com/wangzc/ ) , regex( ^.+[.]class$ )
[DEBUG] 14:30:34.905 com.wangzc.mvc.setup.init.Init.execute(Init.java:51) - water-admin init : com.wangzc.mvc.setup.init.InitUser
[DEBUG] 14:30:34.906 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'sysUserRolePermissionService'<interface com.wangzc.mvc.service.SysUserRolePermissionService>
[DEBUG] 14:30:34.906 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:183) - 	 >> Load definition name=sysUserRolePermissionService
[DEBUG] 14:30:34.908 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:163) - Found IocObject(sysUserRolePermissionService) in AnnotationIocLoader(packages=[com.yixin.water, com.wangzc])
[DEBUG] 14:30:34.910 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:215) - 	 >> Make...'sysUserRolePermissionService'<interface com.wangzc.mvc.service.SysUserRolePermissionService>
[DEBUG] 14:30:34.912 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) - Save object 'sysUserRolePermissionService' to [app] 
[DEBUG] 14:30:34.912 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) - Load class com.wangzc.mvc.service.impl.SysUserRolePermissionServciceImpl without AOP
[DEBUG] 14:30:34.928 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'dao'<interface org.nutz.dao.Dao>
[DEBUG] 14:30:34.929 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'sysRolePermissionService'<interface com.wangzc.mvc.service.SysRolePermissionService>
[DEBUG] 14:30:34.930 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:183) - 	 >> Load definition name=sysRolePermissionService
[DEBUG] 14:30:34.930 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:163) - Found IocObject(sysRolePermissionService) in AnnotationIocLoader(packages=[com.yixin.water, com.wangzc])
[DEBUG] 14:30:34.931 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:215) - 	 >> Make...'sysRolePermissionService'<interface com.wangzc.mvc.service.SysRolePermissionService>
[DEBUG] 14:30:34.931 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) - Save object 'sysRolePermissionService' to [app] 
[DEBUG] 14:30:34.932 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) - Load class com.wangzc.mvc.service.impl.SysRolePermissionServiceImpl without AOP
[DEBUG] 14:30:34.958 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'dao'<interface org.nutz.dao.Dao>
[DEBUG] 14:30:34.961 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'sysUserService'<interface com.wangzc.mvc.service.SysUserService>
[DEBUG] 14:30:34.961 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:183) - 	 >> Load definition name=sysUserService
[DEBUG] 14:30:34.963 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:163) - Found IocObject(sysUserService) in AnnotationIocLoader(packages=[com.yixin.water, com.wangzc])
[DEBUG] 14:30:34.966 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:215) - 	 >> Make...'sysUserService'<interface com.wangzc.mvc.service.SysUserService>
[DEBUG] 14:30:34.967 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) - Save object 'sysUserService' to [app] 
[DEBUG] 14:30:34.968 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) - Load class com.wangzc.mvc.service.impl.SysUserServiceImpl without AOP
[DEBUG] 14:30:34.995 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'dao'<interface org.nutz.dao.Dao>
[DEBUG] 14:30:34.996 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'sysRolePermissionService'<interface com.wangzc.mvc.service.SysRolePermissionService>
[DEBUG] 14:30:34.997 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'dao'<interface org.nutz.dao.Dao>
[DEBUG] 14:30:35.037 org.nutz.dao.impl.sql.run.NutDaoExecutor.printSQL(NutDaoExecutor.java:388) - SELECT * FROM sys_role  WHERE role_id=?
    |     1 |
    |-------|
    | admin |
  For example:> "SELECT * FROM sys_role  WHERE role_id='admin'"
[DEBUG] 14:30:35.101 org.nutz.dao.impl.sql.run.NutDaoExecutor.printSQL(NutDaoExecutor.java:388) - SELECT * FROM sys_user  WHERE account=? LIMIT 0, 1 
    |     1 |
    |-------|
    | admin |
  For example:> "SELECT * FROM sys_user  WHERE account='admin' LIMIT 0, 1 "
[DEBUG] 14:30:35.172 org.nutz.dao.impl.sql.run.NutDaoExecutor.printSQL(NutDaoExecutor.java:388) - SELECT COUNT(*) FROM sys_user_role  WHERE user_id=? AND role_id=?
    | 1 |     2 |
    |---|-------|
    | 1 | admin |
  For example:> "SELECT COUNT(*) FROM sys_user_role  WHERE user_id=1 AND role_id='admin'"
[DEBUG] 14:30:35.194 com.wangzc.mvc.setup.init.Init.execute(Init.java:51) - water-admin init : com.wangzc.mvc.setup.init.InitMenu
[DEBUG] 14:30:35.194 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'dao'<interface org.nutz.dao.Dao>
[DEBUG] 14:30:35.195 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'sysRolePermissionService'<interface com.wangzc.mvc.service.SysRolePermissionService>
[DEBUG] 14:30:35.196 org.nutz.dao.impl.sql.run.NutDaoExecutor.printSQL(NutDaoExecutor.java:388) - SELECT * FROM sys_permission  WHERE permission_id=?
    |        1 |
    |----------|
    | menu.sys |
  For example:> "SELECT * FROM sys_permission  WHERE permission_id='menu.sys'"
[DEBUG] 14:30:35.235 org.nutz.dao.impl.sql.run.NutDaoExecutor.printSQL(NutDaoExecutor.java:388) - SELECT * FROM sys_permission  WHERE permission_id=?
    |            1 |
    |--------------|
    | static.druid |
  For example:> "SELECT * FROM sys_permission  WHERE permission_id='static.druid'"
[DEBUG] 14:30:35.255 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'sysMenuService'<interface com.wangzc.mvc.service.SysMenuService>
[DEBUG] 14:30:35.255 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:183) - 	 >> Load definition name=sysMenuService
[DEBUG] 14:30:35.256 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:163) - Found IocObject(sysMenuService) in AnnotationIocLoader(packages=[com.yixin.water, com.wangzc])
[DEBUG] 14:30:35.257 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:215) - 	 >> Make...'sysMenuService'<interface com.wangzc.mvc.service.SysMenuService>
[DEBUG] 14:30:35.257 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) - Save object 'sysMenuService' to [app] 
[DEBUG] 14:30:35.258 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) - Load class com.wangzc.mvc.service.impl.SysMenuServiceImpl without AOP
[DEBUG] 14:30:35.280 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:157) - Get 'dao'<interface org.nutz.dao.Dao>
[DEBUG] 14:30:38.402 org.nutz.dao.impl.sql.run.NutDaoExecutor.printSQL(NutDaoExecutor.java:388) - SELECT * FROM sys_permission  WHERE permission_id=?
    |                  1 |
    |--------------------|
    | sys.permission.add |
  For example:> "SELECT * FROM sys_permission  WHERE permission_id='sys.permission.add'"
[DEBUG] 14:30:38.419 org.nutz.dao.impl.sql.run.NutDaoExecutor.printSQL(NutDaoExecutor.java:388) - UPDATE sys_permission SET permission_name=?,create_time=?  WHERE permission_id=?
    |       1 |                   2 |                  3 |
    |---------|---------------------|--------------------|
    | 系统权限.添加 | 2017-12-22 15:48:29 | sys.permission.add |
  For example:> "UPDATE sys_permission SET permission_name='系统权限.添加',create_time='2017-12-22 15:48:29'  WHERE permission_id='sys.permission.add'"
[DEBUG] 14:30:38.439 org.nutz.dao.impl.sql.run.NutDaoExecutor.printSQL(NutDaoExecutor.java:388) - SELECT * FROM sys_role 
[DEBUG] 14:30:38.455 org.nutz.dao.impl.sql.run.NutDaoExecutor.printSQL(NutDaoExecutor.java:388) - SELECT * FROM sys_permission 
[DEBUG] 14:30:38.473 org.nutz.dao.impl.sql.run.NutDaoExecutor.printSQL(NutDaoExecutor.java:388) - SELECT * FROM sys_role_permission 
[INFO ] 14:30:38.490 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:141) - Nutz.Mvc[nutz] is up in 12221ms
[DEBUG] 14:30:38.663 freemarker.log._Log4JLoggerFactory$Log4JLogger.debug(_Log4JLoggerFactory.java:83) - Using object wrapper of class freemarker.template.DefaultObjectWrapper
[2018-01-11 02:30:38,687] Artifact water-server:war exploded: Artifact is deployed successfully
[2018-01-11 02:30:38,687] Artifact water-server:war exploded: Deploy took 21,741 milliseconds

start方法没被调用过吧

我怎么可能会有这个弱智的错误....我断点跟到里面亲自看的,调用肯定没问题

问题解决了,缺包了.....
缺了个:slf4j-log4j12-1.7.21.jar
好坑,为啥缺这个包其他的日志都能打印....
整理一下,大概都需要加这几个包:
commons-logging-1.2.jar
log4j-1.2.17.jar
slf4j-log4j12-1.7.21.jar
slf4j-api-1.6.4.jar

csdn看的人不多了吧

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