D:\java\tomcat\apache-tomcat-8.5.29\bin\catalina.bat run
[2019-10-16 10:10:48,562] Artifact nutzbook:war exploded: Waiting for server connection to start artifact deployment...
Using CATALINA_BASE: "C:\Users\Administrator.IntelliJIdea2017.3\system\tomcat\Unnamed_nutzbook_2"
Using CATALINA_HOME: "D:\java\tomcat\apache-tomcat-8.5.29"
Using CATALINA_TMPDIR: "D:\java\tomcat\apache-tomcat-8.5.29\temp"
Using JRE_HOME: "C:\Program Files\Java\jdk1.8.0_172"
Using CLASSPATH: "D:\java\tomcat\apache-tomcat-8.5.29\bin\bootstrap.jar;D:\java\tomcat\apache-tomcat-8.5.29\bin\tomcat-juli.jar"
16-Oct-2019 10:10:56.105 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Server version: Apache Tomcat/8.5.29
16-Oct-2019 10:10:56.124 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Server built: Mar 5 2018 13:11:12 UTC
16-Oct-2019 10:10:56.124 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Server number: 8.5.29.0
16-Oct-2019 10:10:56.125 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log OS Name: Windows 7
16-Oct-2019 10:10:56.125 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log OS Version: 6.1
16-Oct-2019 10:10:56.125 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Architecture: amd64
16-Oct-2019 10:10:56.126 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Java Home: C:\Program Files\Java\jdk1.8.0_172\jre
16-Oct-2019 10:10:56.126 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log JVM Version: 1.8.0_172-b11
16-Oct-2019 10:10:56.127 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log JVM Vendor: Oracle Corporation
16-Oct-2019 10:10:56.127 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log CATALINA_BASE: C:\Users\Administrator.IntelliJIdea2017.3\system\tomcat\Unnamed_nutzbook_2
16-Oct-2019 10:10:56.128 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log CATALINA_HOME: D:\java\tomcat\apache-tomcat-8.5.29
16-Oct-2019 10:10:56.129 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.util.logging.config.file=C:\Users\Administrator.IntelliJIdea2017.3\system\tomcat\Unnamed_nutzbook_2\conf\logging.properties
16-Oct-2019 10:10:56.130 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.util.logging.manager=org.apache.juli.ClassLoaderLogManager
16-Oct-2019 10:10:56.130 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcom.sun.management.jmxremote=
16-Oct-2019 10:10:56.131 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcom.sun.management.jmxremote.port=1099
16-Oct-2019 10:10:56.132 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcom.sun.management.jmxremote.ssl=false
16-Oct-2019 10:10:56.132 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcom.sun.management.jmxremote.authenticate=false
16-Oct-2019 10:10:56.132 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.rmi.server.hostname=127.0.0.1
16-Oct-2019 10:10:56.133 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djdk.tls.ephemeralDHKeySize=2048
16-Oct-2019 10:10:56.133 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.protocol.handler.pkgs=org.apache.catalina.webresources
16-Oct-2019 10:10:56.133 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dignore.endorsed.dirs=
16-Oct-2019 10:10:56.134 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcatalina.base=C:\Users\Administrator.IntelliJIdea2017.3\system\tomcat\Unnamed_nutzbook_2
16-Oct-2019 10:10:56.134 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcatalina.home=D:\java\tomcat\apache-tomcat-8.5.29
16-Oct-2019 10:10:56.135 信息 [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.io.tmpdir=D:\java\tomcat\apache-tomcat-8.5.29\temp
16-Oct-2019 10:10:56.136 信息 [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent Loaded APR based Apache Tomcat Native library [1.2.16] using APR version [1.6.3].
16-Oct-2019 10:10:56.136 信息 [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true].
16-Oct-2019 10:10:56.136 信息 [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent APR/OpenSSL configuration: useAprConnector [false], useOpenSSL [true]
16-Oct-2019 10:10:57.297 信息 [main] org.apache.catalina.core.AprLifecycleListener.initializeSSL OpenSSL successfully initialized [OpenSSL 1.0.2m 2 Nov 2017]
16-Oct-2019 10:10:58.309 信息 [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-8082"]
16-Oct-2019 10:10:58.368 信息 [main] org.apache.tomcat.util.net.NioSelectorPool.getSharedSelector Using a shared selector for servlet write/read
16-Oct-2019 10:10:58.425 信息 [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["ajp-nio-8009"]
16-Oct-2019 10:10:58.435 信息 [main] org.apache.tomcat.util.net.NioSelectorPool.getSharedSelector Using a shared selector for servlet write/read
16-Oct-2019 10:10:58.440 信息 [main] org.apache.catalina.startup.Catalina.load Initialization processed in 4298 ms
16-Oct-2019 10:10:58.629 信息 [main] org.apache.catalina.core.StandardService.startInternal Starting service [Catalina]
16-Oct-2019 10:10:58.629 信息 [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet Engine: Apache Tomcat/8.5.29
16-Oct-2019 10:10:58.680 信息 [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-8082"]
16-Oct-2019 10:10:58.717 信息 [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["ajp-nio-8009"]
16-Oct-2019 10:10:58.728 信息 [main] org.apache.catalina.startup.Catalina.start Server startup in 287 ms
Connected to server
[2019-10-16 10:10:59,137] Artifact nutzbook:war exploded: Artifact is being deployed, please wait...
16-Oct-2019 10:11:06.963 信息 [RMI TCP Connection(3)-127.0.0.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.
2019-10-16 10:11:07,525 org.apache.shiro.web.env.EnvironmentLoader.initEnvironment(EnvironmentLoader.java:128) INFO - Starting Shiro environment initialization.
2019-10-16 10:11:07,592 org.apache.shiro.web.env.IniWebEnvironment.init(IniWebEnvironment.java:76) DEBUG - Checking any specified config locations.
2019-10-16 10:11:07,593 org.apache.shiro.web.env.IniWebEnvironment.init(IniWebEnvironment.java:81) DEBUG - No INI instance or config locations specified. Trying default config locations.
2019-10-16 10:11:07,611 org.apache.shiro.io.ResourceUtils.loadFromClassPath(ResourceUtils.java:159) DEBUG - Opening resource from class path [shiro.ini]
2019-10-16 10:11:07,707 org.apache.shiro.config.Ini.load(Ini.java:342) DEBUG - Parsing [main]
2019-10-16 10:11:07,708 org.apache.shiro.config.Ini.load(Ini.java:342) DEBUG - Parsing [urls]
2019-10-16 10:11:07,714 org.apache.shiro.web.env.IniWebEnvironment.getDefaultIni(IniWebEnvironment.java:136) DEBUG - Discovered non-empty INI configuration at location 'classpath:shiro.ini'. Using for configuration.
2019-10-16 10:11:07,729 org.apache.shiro.config.IniFactorySupport.createInstance(IniFactorySupport.java:122) DEBUG - Creating instance from Ini [sections=urls]
2019-10-16 10:11:08,167 org.apache.shiro.config.IniFactorySupport.createInstance(IniFactorySupport.java:122) DEBUG - Creating instance from Ini [sections=urls]
2019-10-16 10:11:08,194 org.apache.shiro.web.filter.mgt.DefaultFilterChainManager.createChain(DefaultFilterChainManager.java:127) DEBUG - Creating chain [/*] from String definition [anon]
2019-10-16 10:11:08,195 org.apache.shiro.web.filter.mgt.DefaultFilterChainManager.applyChainConfig(DefaultFilterChainManager.java:278) DEBUG - Attempting to apply path [/*] to filter [anon] with config [null]
2019-10-16 10:11:08,203 org.apache.shiro.web.env.EnvironmentLoader.initEnvironment(EnvironmentLoader.java:136) DEBUG - Published WebEnvironment as ServletContext attribute with name [org.apache.shiro.web.env.EnvironmentLoader.ENVIRONMENT_ATTRIBUTE_KEY]
2019-10-16 10:11:08,204 org.apache.shiro.web.env.EnvironmentLoader.initEnvironment(EnvironmentLoader.java:141) INFO - Shiro environment initialized in 664 ms.
2019-10-16 10:11:08,388 org.nutz.mvc.NutFilter._init(NutFilter.java:81) INFO - NutFilter[nutz] starting ...
2019-10-16 10:11:08,671 org.nutz.resource.Scans.(Scans.java:509) DEBUG - Locations for Scans:
[Dir[path=D:\java\tomcat\apache-tomcat-8.5.29\bin], Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\nutz-1.r.60.jar], Dir[path=D:\nutzbook\target\nutzbook\WEB-INF\classes], Jar[path=D:\java\tomcat\apache-tomcat-8.5.29\bin\bootstrap.jar], Jar[path=D:\java\tomcat\apache-tomcat-8.5.29\bin\tomcat-juli.jar]]
16-Oct-2019 10:11:08.733 信息 [localhost-startStop-1] org.apache.catalina.startup.HostConfig.deployDirectory Deploying web application directory [D:\java\tomcat\apache-tomcat-8.5.29\webapps\manager]
16-Oct-2019 10:11:09.261 信息 [localhost-startStop-1] org.apache.catalina.startup.HostConfig.deployDirectory Deployment of web application directory [D:\java\tomcat\apache-tomcat-8.5.29\webapps\manager] has finished in [526] ms
2019-10-16 10:11:10,149 org.nutz.resource.Scans.init(Scans.java:105) DEBUG - Locations for Scans:
{D:\java\tomcat\apache-tomcat-8.5.29\bin=Dir[path=D:\java\tomcat\apache-tomcat-8.5.29\bin], D:\nutzbook\target\nutzbook\WEB-INF\lib\nutz-1.r.60.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\nutz-1.r.60.jar], D:\nutzbook\target\nutzbook\WEB-INF\classes=Dir[path=D:\nutzbook\target\nutzbook\WEB-INF\classes], D:\java\tomcat\apache-tomcat-8.5.29\bin\bootstrap.jar=Jar[path=D:\java\tomcat\apache-tomcat-8.5.29\bin\bootstrap.jar], D:\java\tomcat\apache-tomcat-8.5.29\bin\tomcat-juli.jar=Jar[path=D:\java\tomcat\apache-tomcat-8.5.29\bin\tomcat-juli.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\shiro-guice-1.2.3.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\shiro-guice-1.2.3.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\mchange-commons-java-0.2.15.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\mchange-commons-java-0.2.15.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\taglibs-standard-compat-1.2.5.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\taglibs-standard-compat-1.2.5.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\javax.servlet-api-3.1.0.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\javax.servlet-api-3.1.0.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\guice-multibindings-3.0.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\guice-multibindings-3.0.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\commons-email-1.3.2.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\commons-email-1.3.2.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\taglibs-standard-spec-1.2.5.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\taglibs-standard-spec-1.2.5.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\aopalliance-1.0.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\aopalliance-1.0.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\nutz-integration-quartz-1.r.60.r2.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\nutz-integration-quartz-1.r.60.r2.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\quartz-2.3.1.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\quartz-2.3.1.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\commons-collections-3.2.1.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\commons-collections-3.2.1.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\druid-1.0.26.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\druid-1.0.26.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\mysql-connector-java-5.1.40.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\mysql-connector-java-5.1.40.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\nutz-plugins-cache-1.r.60.r2.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\nutz-plugins-cache-1.r.60.r2.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\javax.mail-api-1.5.2.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\javax.mail-api-1.5.2.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\servlet-api-2.4.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\servlet-api-2.4.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\nutz-integration-jedis-1.r.60.r2.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\nutz-integration-jedis-1.r.60.r2.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\taglibs-standard-impl-1.2.5.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\taglibs-standard-impl-1.2.5.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\guice-3.0.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\guice-3.0.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\guava-r09.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\guava-r09.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\javax.inject-1.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\javax.inject-1.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\c3p0-0.9.5.3.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\c3p0-0.9.5.3.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\commons-beanutils-1.9.2.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\commons-beanutils-1.9.2.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\shiro-web-1.3.2.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\shiro-web-1.3.2.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\commons-logging-1.1.2.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\commons-logging-1.1.2.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\log4j-1.2.17.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\log4j-1.2.17.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\taglibs-standard-jstlel-1.2.5.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\taglibs-standard-jstlel-1.2.5.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\mail-1.4.5.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\mail-1.4.5.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\shiro-all-1.2.3.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\shiro-all-1.2.3.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\activation-1.1.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\activation-1.1.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\shiro-core-1.2.3.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\shiro-core-1.2.3.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\HikariCP-java7-2.4.13.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\HikariCP-java7-2.4.13.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\nutz-integration-shiro-1.r.60.r2.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\nutz-integration-shiro-1.r.60.r2.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\slf4j-api-1.7.7.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\slf4j-api-1.7.7.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\jsp-api-2.0.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\jsp-api-2.0.jar], D:\nutzbook\target\nutzbook\WEB-INF\lib\slf4j-log4j12-1.7.7.jar=Jar[path=D:\nutzbook\target\nutzbook\WEB-INF\lib\slf4j-log4j12-1.7.7.jar]}
2019-10-16 10:11:10,688 org.nutz.castor.Castors.reload(Castors.java:115) DEBUG - Using 95 castor for Castors
2019-10-16 10:11:10,764 org.nutz.mvc.config.AbstractNutConfig.createLoading(AbstractNutConfig.java:59) DEBUG - Loading by class org.nutz.mvc.impl.NutLoading
2019-10-16 10:11:10,772 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:55) INFO - Nutz Version : 1.r.60
2019-10-16 10:11:10,774 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:56) INFO - Nutz.Mvc[nutz] is initializing ...
2019-10-16 10:11:10,774 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:60) DEBUG - Web Container Information:
2019-10-16 10:11:10,780 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:61) DEBUG - - Default Charset : GBK
2019-10-16 10:11:10,781 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:62) DEBUG - - Current . path : D:\java\tomcat\apache-tomcat-8.5.29\bin.
2019-10-16 10:11:10,783 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:63) DEBUG - - Java Version : 1.8.0_172
2019-10-16 10:11:10,784 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:64) DEBUG - - File separator : \
2019-10-16 10:11:10,785 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:65) DEBUG - - Timezone : Asia/Shanghai
2019-10-16 10:11:10,787 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:66) DEBUG - - OS : Windows 7 amd64
2019-10-16 10:11:10,788 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:67) DEBUG - - ServerInfo : Apache Tomcat/8.5.29
2019-10-16 10:11:10,790 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:68) DEBUG - - Servlet API : 3.1
2019-10-16 10:11:10,791 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:73) DEBUG - - ContextPath :
2019-10-16 10:11:10,792 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:74) DEBUG - - context.tempdir : C:\Users\Administrator.IntelliJIdea2017.3\system\tomcat\Unnamed_nutzbook_2\work\Catalina\localhost\ROOT
2019-10-16 10:11:10,795 org.nutz.mvc.impl.NutLoading.load(NutLoading.java:75) DEBUG - - MainModule : net.wendal.nutzbook.MainModlue
2019-10-16 10:11:10,810 org.nutz.mvc.impl.NutLoading.createContext(NutLoading.java:238) DEBUG - >> app.root = D:/nutzbook/target/nutzbook
2019-10-16 10:11:10,830 org.nutz.mvc.impl.NutLoading.createIoc(NutLoading.java:379) DEBUG - @IocBy(type=org.nutz.mvc.ioc.provider.ComboIocProvider, args=["*js", "ioc/", "*anno", "net.wendal.nutzbook", "*tx", "*quartz"],init=[])
2019-10-16 10:11:10,950 org.nutz.resource.Scans.scan(Scans.java:274) DEBUG - Found 2 resource by src( ioc/ ) , regex( ^(.+[.])(js|json)$ )
2019-10-16 10:11:10,955 org.nutz.ioc.loader.json.JsonLoader.(JsonLoader.java:48) DEBUG - loading ioc js config from [dao.js]
2019-10-16 10:11:10,982 org.nutz.ioc.loader.json.JsonLoader.(JsonLoader.java:48) DEBUG - loading ioc js config from [mail.js]
2019-10-16 10:11:10,986 org.nutz.ioc.loader.json.JsonLoader.(JsonLoader.java:56) DEBUG - Loaded 5 bean define from path=[ioc/] --> [conf, dao, emailAuthenticator, dataSource, htmlEmail]
2019-10-16 10:11:11,031 org.nutz.resource.Scans.scan(Scans.java:274) DEBUG - Found 10 resource by src( net/wendal/nutzbook/ ) , regex( ^.+[.]class$ )
2019-10-16 10:11:11,153 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:74) DEBUG - Found @IocBean : class net.wendal.nutzbook.module.UserModule
2019-10-16 10:11:11,202 org.nutz.ioc.loader.annotation.AnnotationIocLoader.addClass(AnnotationIocLoader.java:74) DEBUG - Found @IocBean : class net.wendal.nutzbook.module.UserProfileModule
2019-10-16 10:11:11,254 org.nutz.ioc.loader.annotation.AnnotationIocLoader.(AnnotationIocLoader.java:50) INFO - Found 2 classes in 1 base-packages!
beans = ["userProfileModule", "userModule"]
2019-10-16 10:11:11,268 org.nutz.ioc.loader.json.JsonLoader.(JsonLoader.java:40) DEBUG - Loaded 5 bean define from reader --
[txREPEATABLE_READ, txSERIALIZABLE, txNONE, txREAD_UNCOMMITTED, txREAD_COMMITTED]
2019-10-16 10:11:11,287 org.nutz.ioc.loader.combo.ComboIocLoader.createIocLoader(ComboIocLoader.java:118) DEBUG - found org.nutz.integration.quartz.QuartzIocLoader -- org.nutz.integration.quartz.QuartzIocLoader
2019-10-16 10:11:11,289 org.nutz.ioc.loader.json.JsonLoader.(JsonLoader.java:56) DEBUG - Loaded 0 bean define from path=[] --> []
2019-10-16 10:11:11,313 org.nutz.ioc.impl.NutIoc.(NutIoc.java:98) INFO - NutIoc init begin ...
2019-10-16 10:11:11,326 org.nutz.ioc.impl.NutIoc.(NutIoc.java:115) INFO - ... NutIoc init complete
2019-10-16 10:11:11,342 org.nutz.mvc.impl.NutLoading.evalUrlMapping(NutLoading.java:159) INFO - Build URL mapping by org.nutz.mvc.impl.UrlMappingImpl ...
2019-10-16 10:11:11,358 org.nutz.mvc.impl.NutLoading.createViewMakers(NutLoading.java:369) DEBUG - @Views(DefaultViewMaker.class)
2019-10-16 10:11:11,402 org.nutz.resource.Scans.scan(Scans.java:274) DEBUG - Found 1 resource by src( mvc/nutzbook-mvc-chain.js ) , regex( ^(.+[.])(js|json)$ )
2019-10-16 10:11:11,441 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"
}
}
2019-10-16 10:11:11,442 org.nutz.mvc.impl.NutLoading.createChainMaker(NutLoading.java:266) DEBUG - @ChainBy(org.nutz.mvc.impl.NutActionChainMaker)
2019-10-16 10:11:11,466 org.nutz.mvc.impl.Loadings.scanModules(Loadings.java:154) DEBUG - module class location 'file:/D:/nutzbook/target/nutzbook/WEB-INF/classes/'
2019-10-16 10:11:11,468 org.nutz.mvc.impl.Loadings.scanModuleInPackage(Loadings.java:184) DEBUG - > scan 'net.wendal.nutzbook'
2019-10-16 10:11:11,502 org.nutz.resource.Scans.scan(Scans.java:274) DEBUG - Found 10 resource by src( net/wendal/nutzbook/ ) , regex( ^.+[.]class$ )
2019-10-16 10:11:11,509 org.nutz.mvc.impl.Loadings.checkModule(Loadings.java:198) DEBUG - >> add 'net.wendal.nutzbook.module.UserModule'
2019-10-16 10:11:11,510 org.nutz.mvc.impl.Loadings.checkModule(Loadings.java:198) DEBUG - >> add 'net.wendal.nutzbook.module.UserProfileModule'
2019-10-16 10:11:11,756 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/profile/' >> (UserProfileModule.java:119).index : UserProfile | @Ok(jsp:jsp.user.profile) @Fail(jsp:jsp.500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2019-10-16 10:11:11,766 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/profile/get' >> (UserProfileModule.java:34).get : UserProfile | @Ok(json:full) @Fail(jsp:jsp.500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2019-10-16 10:11:11,782 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/profile/update' >> (UserProfileModule.java:49).update : void | @Ok(void ) @Fail(jsp:jsp.500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2019-10-16 10:11:11,808 org.nutz.filepool.NutFilePool.(NutFilePool.java:23) INFO - Init file-pool by: D:/nutzbook/target/nutzbook/WEB-INF/tmp/user_avatar [20000]
2019-10-16 10:11:11,821 org.nutz.filepool.NutFilePool.(NutFilePool.java:37) DEBUG - file-pool.home: 'D:\nutzbook\target\nutzbook\WEB-INF\tmp\user_avatar'
2019-10-16 10:11:11,824 org.nutz.filepool.NutFilePool.(NutFilePool.java:66) INFO - file-pool.cursor: 0
2019-10-16 10:11:11,851 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/profile/avatar' >> (UserProfileModule.java:79).uploadAvatar : void | @Ok(>>:/user/profile) @Fail(jsp:jsp.500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2019-10-16 10:11:11,869 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/profile/avatar' >> (UserProfileModule.java:109).readAvatar : Object | @Ok(raw:jpg) @Fail(jsp:jsp.500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2019-10-16 10:11:11,888 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/' >> (UserModule.java:100).index : void | @Ok(jsp:jsp.user.list) @Fail(http:500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2019-10-16 10:11:11,940 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/add' >> (UserModule.java:51).add : Object | @Ok(json:{locked:'password|salt',ignoreNull:true}) @Fail(http:500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2019-10-16 10:11:11,946 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/count' >> (UserModule.java:30).count : int | @Ok(json:{locked:'password|salt',ignoreNull:true}) @Fail(http:500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2019-10-16 10:11:11,955 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/update' >> (UserModule.java:64).update : Object | @Ok(json:{locked:'password|salt',ignoreNull:true}) @Fail(http:500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2019-10-16 10:11:11,989 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/delete' >> (UserModule.java:79).delete : Object | @Ok(json:{locked:'password|salt',ignoreNull:true}) @Fail(http:500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2019-10-16 10:11:12,007 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/query' >> (UserModule.java:89).query : Object | @Ok(json:{locked:'password|salt',ignoreNull:true}) @Fail(http:500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2019-10-16 10:11:12,016 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/login' >> (UserModule.java:35).login : Object | @Ok(json:{locked:'password|salt',ignoreNull:true}) @Fail(http:500) | by 0 Filters | (I:UTF-8/O:UTF-8)
2019-10-16 10:11:12,024 org.nutz.mvc.impl.UrlMappingImpl.print(UrlMappingImpl.java:146) DEBUG - '/user/logout' >> (UserModule.java:46).logout : void | @Ok(>>:/ ) @Fail(http:500) | by 1 Filters | (I:UTF-8/O:UTF-8)
2019-10-16 10:11:12,025 org.nutz.mvc.impl.NutLoading.evalUrlMapping(NutLoading.java:220) INFO - Found 13 module methods
2019-10-16 10:11:12,027 org.nutz.mvc.impl.NutLoading.evalLocalization(NutLoading.java:306) DEBUG - Localization: org.nutz.mvc.impl.NutMessageLoader('msg/') dft
2019-10-16 10:11:12,040 org.nutz.resource.Scans.scan(Scans.java:274) DEBUG - Found 1 resource by src( msg/ ) , regex( ^.+[.]properties$ )
2019-10-16 10:11:12,042 org.nutz.mvc.impl.NutMessageLoader.load(NutMessageLoader.java:27) DEBUG - Load Messages in 1 resource : [[NutResource[zh-CN/user.properties]]]
2019-10-16 10:11:12,058 org.nutz.mvc.impl.NutMessageLoader.load(NutMessageLoader.java:95) DEBUG - Message Loaded, size = 2
2019-10-16 10:11:12,067 org.nutz.mvc.impl.NutLoading.evalSetup(NutLoading.java:274) INFO - Setup application...
2019-10-16 10:11:12,071 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'dao'<interface org.nutz.dao.Dao>
2019-10-16 10:11:12,080 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
2019-10-16 10:11:12,083 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - >> Load definition name=dao
2019-10-16 10:11:12,089 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=dao
2019-10-16 10:11:12,113 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:169) DEBUG - Found IocObject(dao) in JsonLoader(paths=[ioc/])
2019-10-16 10:11:12,114 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - >> Make...'dao'<interface org.nutz.dao.Dao>
2019-10-16 10:11:12,167 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class org.nutz.dao.impl.NutDao without AOP
2019-10-16 10:11:12,174 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'dao' to [app]
2019-10-16 10:11:12,189 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'dataSource'<>
2019-10-16 10:11:12,190 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - >> Load definition name=dataSource
2019-10-16 10:11:12,191 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=dataSource
2019-10-16 10:11:12,222 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:169) DEBUG - Found IocObject(dataSource) in JsonLoader(paths=[ioc/])
2019-10-16 10:11:12,223 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - >> Make...'dataSource'<>
2019-10-16 10:11:12,305 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class com.alibaba.druid.pool.DruidDataSource without AOP
2019-10-16 10:11:12,306 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'dataSource' to [app]
2019-10-16 10:11:12,317 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'conf'<>
2019-10-16 10:11:12,318 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - >> Load definition name=conf
2019-10-16 10:11:12,320 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=conf
2019-10-16 10:11:12,323 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:169) DEBUG - Found IocObject(conf) in JsonLoader(paths=[ioc/])
2019-10-16 10:11:12,325 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - >> Make...'conf'<>
2019-10-16 10:11:12,332 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class org.nutz.ioc.impl.PropertiesProxy without AOP
2019-10-16 10:11:12,333 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'conf' to [app]
2019-10-16 10:11:12,353 org.nutz.resource.Scans.scan(Scans.java:274) DEBUG - Found 2 resource by src( custom/ ) , regex( ^.+[.]properties$ )
2019-10-16 10:11:12,773 com.alibaba.druid.pool.DruidDataSource.init(DruidDataSource.java:715) INFO - {dataSource-1} inited
2019-10-16 10:11:12,776 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'dataSource'<>
2019-10-16 10:11:12,880 org.nutz.filepool.NutFilePool.(NutFilePool.java:23) INFO - Init file-pool by: C:\Users\Administrator/.nutz/tmp/dao/ [200000]
2019-10-16 10:11:12,885 org.nutz.filepool.NutFilePool.(NutFilePool.java:37) DEBUG - file-pool.home: 'C:\Users\Administrator.nutz\tmp\dao'
2019-10-16 10:11:12,887 org.nutz.filepool.NutFilePool.(NutFilePool.java:66) INFO - file-pool.cursor: 0
2019-10-16 10:11:12,931 org.nutz.dao.jdbc.Jdbcs.(Jdbcs.java:90) DEBUG - Jdbcs init complete
2019-10-16 10:11:12,932 org.nutz.dao.jdbc.Jdbcs.getExpert(Jdbcs.java:103) INFO - Get Connection from DataSource for JdbcExpert, if you lock at here, check your database server and configure
2019-10-16 10:11:14,014 org.nutz.dao.impl.DaoSupport.setDataSource(DaoSupport.java:188) DEBUG - select expert : org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert
2019-10-16 10:11:14,039 org.nutz.dao.impl.DaoSupport$1.invoke(DaoSupport.java:199) DEBUG - JDBC Driver --> mysql-connector-java-5.1.40 ( Revision: 402933ef52cad9aa82624e80acbea46e3a701ce6 )
2019-10-16 10:11:14,039 org.nutz.dao.impl.DaoSupport$1.invoke(DaoSupport.java:200) DEBUG - JDBC Name --> MySQL Connector Java
2019-10-16 10:11:14,040 org.nutz.dao.impl.DaoSupport$1.invoke(DaoSupport.java:202) DEBUG - JDBC URL --> jdbc:mysql://127.0.0.1:3306/nutzbook
2019-10-16 10:11:14,419 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) DEBUG - Mysql : character_set_client=utf8
2019-10-16 10:11:14,420 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) DEBUG - Mysql : character_set_connection=utf8
2019-10-16 10:11:14,421 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) DEBUG - Mysql : character_set_database=utf8
2019-10-16 10:11:14,421 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) DEBUG - Mysql : character_set_filesystem=binary
2019-10-16 10:11:14,422 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) DEBUG - Mysql : character_set_results=
2019-10-16 10:11:14,423 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) DEBUG - Mysql : character_set_server=utf8
2019-10-16 10:11:14,424 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) DEBUG - Mysql : character_set_system=utf8
2019-10-16 10:11:14,425 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:212) DEBUG - Mysql : character_sets_dir=C:\Program Files\MySQL\MySQL Server 5.5\share\charsets\
2019-10-16 10:11:14,430 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:219) DEBUG - Mysql : binlog_format=STATEMENT
2019-10-16 10:11:14,432 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:226) DEBUG - Mysql : database=nutzbook
2019-10-16 10:11:14,435 org.nutz.dao.impl.jdbc.mysql.MysqlJdbcExpert.checkDataSource(MysqlJdbcExpert.java:232) DEBUG - Mysql : user=root@localhost
2019-10-16 10:11:14,561 org.nutz.dao.impl.DaoSupport.setDataSource(DaoSupport.java:221) DEBUG - Database info --> MYSQL:[MySQL - 5.5.57]
2019-10-16 10:11:14,587 org.nutz.resource.Scans.scan(Scans.java:274) DEBUG - Found 10 resource by src( net/wendal/nutzbook/ ) , regex( ^.+[.]class$ )
2019-10-16 10:11:14,918 org.nutz.dao.impl.sql.run.NutDaoExecutor.printSQL(NutDaoExecutor.java:388) DEBUG - SELECT COUNT(*) FROM t_user
2019-10-16 10:11:14,932 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'nutQuartzCronJobFactory'<class org.nutz.integration.quartz.NutQuartzCronJobFactory>
2019-10-16 10:11:14,941 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - >> Load definition name=nutQuartzCronJobFactory
2019-10-16 10:11:14,943 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=nutQuartzCronJobFactory
2019-10-16 10:11:14,952 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:169) DEBUG - Found IocObject(nutQuartzCronJobFactory) in QuartzIocLoader@39558005
2019-10-16 10:11:14,953 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - >> Make...'nutQuartzCronJobFactory'<class org.nutz.integration.quartz.NutQuartzCronJobFactory>
2019-10-16 10:11:14,959 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class org.nutz.integration.quartz.NutQuartzCronJobFactory without AOP
2019-10-16 10:11:14,960 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'nutQuartzCronJobFactory' to [app]
2019-10-16 10:11:14,966 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'scheduler'<>
2019-10-16 10:11:14,967 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - >> Load definition name=scheduler
2019-10-16 10:11:14,968 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=scheduler
2019-10-16 10:11:14,970 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:169) DEBUG - Found IocObject(scheduler) in QuartzIocLoader@39558005
2019-10-16 10:11:14,971 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - >> Make...'scheduler'<>
2019-10-16 10:11:14,972 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'scheduler' to [app]
2019-10-16 10:11:15,161 org.quartz.impl.StdSchedulerFactory.instantiate(StdSchedulerFactory.java:1208) INFO - Using default implementation for ThreadExecutor
2019-10-16 10:11:15,239 org.quartz.core.SchedulerSignalerImpl.(SchedulerSignalerImpl.java:61) INFO - Initialized Scheduler Signaller of type: class org.quartz.core.SchedulerSignalerImpl
2019-10-16 10:11:15,240 org.quartz.core.QuartzScheduler.(QuartzScheduler.java:229) INFO - Quartz Scheduler v.2.3.1 created.
2019-10-16 10:11:15,245 org.quartz.simpl.RAMJobStore.initialize(RAMJobStore.java:155) INFO - RAMJobStore initialized.
2019-10-16 10:11:15,247 org.quartz.core.QuartzScheduler.initialize(QuartzScheduler.java:294) INFO - Scheduler meta-data: Quartz Scheduler (v2.3.1) 'NutzbookScheduler' with instanceId 'NON_CLUSTERED'
Scheduler class: 'org.quartz.core.QuartzScheduler' - running locally.
NOT STARTED.
Currently in standby mode.
Number of jobs executed: 0
Using thread pool 'org.quartz.simpl.SimpleThreadPool' - with 3 threads.
Using job-store 'org.quartz.simpl.RAMJobStore' - which does not support persistence. and is not clustered.
2019-10-16 10:11:15,248 org.quartz.impl.StdSchedulerFactory.instantiate(StdSchedulerFactory.java:1362) INFO - Quartz scheduler 'NutzbookScheduler' initialized from default resource file in Quartz package: 'quartz.properties'
2019-10-16 10:11:15,249 org.quartz.impl.StdSchedulerFactory.instantiate(StdSchedulerFactory.java:1366) INFO - Quartz scheduler version: 2.3.1
2019-10-16 10:11:15,251 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'jobFactory'<>
2019-10-16 10:11:15,253 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - >> Load definition name=jobFactory
2019-10-16 10:11:15,254 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=jobFactory
2019-10-16 10:11:15,258 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:169) DEBUG - Found IocObject(jobFactory) in QuartzIocLoader@39558005
2019-10-16 10:11:15,259 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - >> Make...'jobFactory'<>
2019-10-16 10:11:15,280 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class org.nutz.integration.quartz.NutQuartzJobFactory without AOP
2019-10-16 10:11:15,281 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'jobFactory' to [app]
2019-10-16 10:11:15,285 org.quartz.core.QuartzScheduler.setJobFactory(QuartzScheduler.java:2293) INFO - JobFactory set to: org.nutz.integration.quartz.NutQuartzJobFactory@1e0bfbf6
2019-10-16 10:11:15,286 org.quartz.core.QuartzScheduler.start(QuartzScheduler.java:547) INFO - Scheduler NutzbookScheduler_$_NON_CLUSTERED started.
2019-10-16 10:11:15,287 org.quartz.core.QuartzSchedulerThread.run(QuartzSchedulerThread.java:291) DEBUG - batch acquisition of 0 triggers
2019-10-16 10:11:15,289 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'conf'<>
2019-10-16 10:11:15,302 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'htmlEmail'<class org.apache.commons.mail.HtmlEmail>
2019-10-16 10:11:15,302 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - >> Load definition name=htmlEmail
2019-10-16 10:11:15,304 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=htmlEmail
2019-10-16 10:11:15,308 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:169) DEBUG - Found IocObject(htmlEmail) in JsonLoader(paths=[ioc/])
2019-10-16 10:11:15,309 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - >> Make...'htmlEmail'<class org.apache.commons.mail.HtmlEmail>
2019-10-16 10:11:15,357 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class org.apache.commons.mail.ImageHtmlEmail without AOP
2019-10-16 10:11:15,408 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'conf'<>
2019-10-16 10:11:15,409 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'conf'<>
2019-10-16 10:11:15,412 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'emailAuthenticator'<>
2019-10-16 10:11:15,415 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:177) DEBUG - >> Load definition name=emailAuthenticator
2019-10-16 10:11:15,423 org.nutz.ioc.loader.map.MapLoader.load(MapLoader.java:67) DEBUG - Loading define for name=emailAuthenticator
2019-10-16 10:11:15,436 org.nutz.ioc.loader.combo.ComboIocLoader.load(ComboIocLoader.java:169) DEBUG - Found IocObject(emailAuthenticator) in JsonLoader(paths=[ioc/])
2019-10-16 10:11:15,438 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:209) DEBUG - >> Make...'emailAuthenticator'<>
2019-10-16 10:11:15,444 org.nutz.ioc.aop.impl.DefaultMirrorFactory.getMirror(DefaultMirrorFactory.java:70) DEBUG - Load class org.apache.commons.mail.DefaultAuthenticator without AOP
2019-10-16 10:11:15,447 org.nutz.ioc.impl.ScopeContext.save(ScopeContext.java:64) DEBUG - Save object 'emailAuthenticator' to [app]
2019-10-16 10:11:15,454 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'conf'<>
2019-10-16 10:11:15,458 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'conf'<>
2019-10-16 10:11:15,465 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'conf'<>
2019-10-16 10:11:15,467 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'conf'<>
2019-10-16 10:11:15,469 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'conf'<>
2019-10-16 10:11:15,474 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'conf'<>
2019-10-16 10:11:15,491 org.nutz.ioc.impl.NutIoc.get(NutIoc.java:151) DEBUG - Get 'conf'<>
16-Oct-2019 10:11:15.633 严重 [RMI TCP Connection(3)-127.0.0.1] org.apache.catalina.core.StandardContext.startInternal One or more Filters failed to start. Full details will be found in the appropriate container log file
16-Oct-2019 10:11:15.637 严重 [RMI TCP Connection(3)-127.0.0.1] org.apache.catalina.core.StandardContext.startInternal Context [] startup failed due to previous errors
16-Oct-2019 10:11:15.662 警告 [RMI TCP Connection(3)-127.0.0.1] org.apache.catalina.loader.WebappClassLoaderBase.clearReferencesJdbc The web application [ROOT] registered the JDBC driver [com.alibaba.druid.proxy.DruidDriver] but failed to unregister it when the web application was stopped. To prevent a memory leak, the JDBC Driver has been forcibly unregistered.
16-Oct-2019 10:11:15.663 警告 [RMI TCP Connection(3)-127.0.0.1] org.apache.catalina.loader.WebappClassLoaderBase.clearReferencesJdbc The web application [ROOT] registered the JDBC driver [com.mysql.jdbc.Driver] but failed to unregister it when the web application was stopped. To prevent a memory leak, the JDBC Driver has been forcibly unregistered.
16-Oct-2019 10:11:15.667 警告 [RMI TCP Connection(3)-127.0.0.1] org.apache.catalina.loader.WebappClassLoaderBase.clearReferencesThreads The web application [ROOT] appears to have started a thread named [NutzbookScheduler_QuartzSchedulerThread] but has failed to stop it. This is very likely to create a memory leak. Stack trace of thread:
java.lang.Object.wait(Native Method)
org.quartz.core.QuartzSchedulerThread.run(QuartzSchedulerThread.java:427)
[2019-10-16 10:11:15,736] Artifact nutzbook:war exploded: Error during artifact deployment. See server log for details.