[jira] [Commented] (LOG4J2-1419) Memory leak on tomcat shutdown

Mickael Marrache (JIRA) Mon, 15 Aug 2016 10:21:54 -0700

    [ 
https://issues.apache.org/jira/browse/LOG4J2-1419?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=15421303#comment-15421303
 ]


Mickael Marrache commented on LOG4J2-1419:
------------------------------------------

Any news with this issue?

> Memory leak on tomcat shutdown
> ------------------------------
>
>                 Key: LOG4J2-1419
>                 URL: https://issues.apache.org/jira/browse/LOG4J2-1419
>             Project: Log4j 2
>          Issue Type: Bug
>          Components: Appenders, Configurators
>    Affects Versions: 2.6
>            Reporter: Vasia
>
> Running log4j2 v2.6 with disruptor 3.3.4. AsyncLoggers configured 
> (-DLog4jContextSelector=org.apache.logging.log4j.core.async.AsyncLoggerContextSelector),
>  log4j-web also included. Web application deployed in Tomcat 7.0.69 with 
> configured servlet 3.0. catalina.properties does not include the log4j*.jar 
> entry.
> Server log:
> {CODE}
> D:\servers\apache-tomcat-7.0.69\bin\catalina.bat run
> [2016-06-08 12:17:40,314] Artifact TestLogging:war exploded: Server is not 
> connected. Deploy is not available.
> Using CATALINA_BASE:   "C:\system\tomcat\Unnamed_TestLogging_2"
> Using CATALINA_HOME:   "D:\servers\apache-tomcat-7.0.69"
> Using CATALINA_TMPDIR: "D:\servers\apache-tomcat-7.0.69\temp"
> Using JRE_HOME:        "C:\Program Files\Java\jdk1.7.0_79"
> Using CLASSPATH:       
> "D:\servers\apache-tomcat-7.0.69\bin\bootstrap.jar;D:\servers\apache-tomcat-7.0.69\bin\tomcat-juli.jar"
> Connected to the target VM, address: '127.0.0.1:50643', transport: 'socket'
> Jun 08, 2016 12:17:41 AM org.apache.catalina.startup.VersionLoggerListener log
> INFO: Server version:        Apache Tomcat/7.0.69
> Jun 08, 2016 12:17:41 AM org.apache.catalina.startup.VersionLoggerListener log
> INFO: Server built:          Apr 11 2016 07:57:09 UTC
> Jun 08, 2016 12:17:41 AM org.apache.catalina.startup.VersionLoggerListener log
> INFO: Server number:         7.0.69.0
> Jun 08, 2016 12:17:41 AM org.apache.catalina.startup.VersionLoggerListener log
> INFO: OS Name:               Windows 8.1
> Jun 08, 2016 12:17:41 AM org.apache.catalina.startup.VersionLoggerListener log
> INFO: OS Version:            6.3
> Jun 08, 2016 12:17:41 AM org.apache.catalina.startup.VersionLoggerListener log
> INFO: Architecture:          amd64
> Jun 08, 2016 12:17:41 AM org.apache.catalina.startup.VersionLoggerListener log
> INFO: Java Home:             C:\Program Files\Java\jdk1.7.0_79\jre
> Jun 08, 2016 12:17:41 AM org.apache.catalina.startup.VersionLoggerListener log
> INFO: JVM Version:           1.7.0_79-b15
> Jun 08, 2016 12:17:41 AM org.apache.catalina.startup.VersionLoggerListener log
> INFO: JVM Vendor:            Oracle Corporation
> Jun 08, 2016 12:17:41 AM org.apache.catalina.startup.VersionLoggerListener log
> INFO: CATALINA_BASE:         C:\system\tomcat\Unnamed_TestLogging_2
> Jun 08, 2016 12:17:41 AM org.apache.catalina.startup.VersionLoggerListener log
> INFO: CATALINA_HOME:         D:\servers\apache-tomcat-7.0.69
> Jun 08, 2016 12:17:41 AM org.apache.catalina.startup.VersionLoggerListener log
> INFO: Command line argument: 
> -agentlib:jdwp=transport=dt_socket,address=127.0.0.1:50643,suspend=y,server=n
> Jun 08, 2016 12:17:41 AM org.apache.catalina.startup.VersionLoggerListener log
> INFO: Command line argument: 
> -DLog4jContextSelector=org.apache.logging.log4j.core.async.AsyncLoggerContextSelector
> Jun 08, 2016 12:17:41 AM org.apache.catalina.startup.VersionLoggerListener log
> INFO: Command line argument: -Dcom.sun.management.jmxremote=
> Jun 08, 2016 12:17:41 AM org.apache.catalina.startup.VersionLoggerListener log
> INFO: Command line argument: -Dcom.sun.management.jmxremote.port=1099
> Jun 08, 2016 12:17:41 AM org.apache.catalina.startup.VersionLoggerListener log
> INFO: Command line argument: -Dcom.sun.management.jmxremote.ssl=false
> Jun 08, 2016 12:17:41 AM org.apache.catalina.startup.VersionLoggerListener log
> INFO: Command line argument: -Dcom.sun.management.jmxremote.authenticate=false
> Jun 08, 2016 12:17:41 AM org.apache.catalina.startup.VersionLoggerListener log
> INFO: Command line argument: -Djava.rmi.server.hostname=127.0.0.1
> Jun 08, 2016 12:17:41 AM org.apache.catalina.startup.VersionLoggerListener log
> INFO: Command line argument: -Djdk.tls.ephemeralDHKeySize=2048
> Jun 08, 2016 12:17:41 AM org.apache.catalina.startup.VersionLoggerListener log
> INFO: Command line argument: 
> -Djava.util.logging.config.file=C:\system\tomcat\Unnamed_TestLogging_2\conf\logging.properties
> Jun 08, 2016 12:17:41 AM org.apache.catalina.startup.VersionLoggerListener log
> INFO: Command line argument: 
> -Djava.util.logging.manager=org.apache.juli.ClassLoaderLogManager
> Jun 08, 2016 12:17:41 AM org.apache.catalina.startup.VersionLoggerListener log
> INFO: Command line argument: 
> -Djava.endorsed.dirs=D:\servers\apache-tomcat-7.0.69\endorsed
> Jun 08, 2016 12:17:41 AM org.apache.catalina.startup.VersionLoggerListener log
> INFO: Command line argument: 
> -Dcatalina.base=C:\system\tomcat\Unnamed_TestLogging_2
> Jun 08, 2016 12:17:41 AM org.apache.catalina.startup.VersionLoggerListener log
> INFO: Command line argument: -Dcatalina.home=D:\servers\apache-tomcat-7.0.69
> Jun 08, 2016 12:17:41 AM org.apache.catalina.startup.VersionLoggerListener log
> INFO: Command line argument: 
> -Djava.io.tmpdir=D:\servers\apache-tomcat-7.0.69\temp
> Jun 08, 2016 12:17:41 AM org.apache.catalina.core.AprLifecycleListener 
> lifecycleEvent
> INFO: Loaded APR based Apache Tomcat Native library 1.1.33 using APR version 
> 1.5.1.
> Jun 08, 2016 12:17:41 AM org.apache.catalina.core.AprLifecycleListener 
> lifecycleEvent
> INFO: APR capabilities: IPv6 [true], sendfile [true], accept filters [false], 
> random [true].
> Jun 08, 2016 12:17:42 AM org.apache.catalina.core.AprLifecycleListener 
> initializeSSL
> INFO: OpenSSL successfully initialized (OpenSSL 1.0.1m 19 Mar 2015)
> Jun 08, 2016 12:17:42 AM org.apache.coyote.AbstractProtocol init
> INFO: Initializing ProtocolHandler ["http-apr-8080"]
> Jun 08, 2016 12:17:42 AM org.apache.coyote.AbstractProtocol init
> INFO: Initializing ProtocolHandler ["ajp-apr-8009"]
> Jun 08, 2016 12:17:42 AM org.apache.catalina.startup.Catalina load
> INFO: Initialization processed in 1496 ms
> Jun 08, 2016 12:17:42 AM org.apache.catalina.core.StandardService 
> startInternal
> INFO: Starting service Catalina
> Jun 08, 2016 12:17:42 AM org.apache.catalina.core.StandardEngine startInternal
> INFO: Starting Servlet Engine: Apache Tomcat/7.0.69
> Jun 08, 2016 12:17:42 AM org.apache.coyote.AbstractProtocol start
> INFO: Starting ProtocolHandler ["http-apr-8080"]
> Jun 08, 2016 12:17:42 AM org.apache.coyote.AbstractProtocol start
> INFO: Starting ProtocolHandler ["ajp-apr-8009"]
> Jun 08, 2016 12:17:42 AM org.apache.catalina.startup.Catalina start
> INFO: Server startup in 43 ms
> Connected to server
> [2016-06-08 12:17:42,400] Artifact TestLogging:war exploded: Artifact is 
> being deployed, please wait...
> Jun 08, 2016 12:17:44 AM org.apache.catalina.startup.TldConfig execute
> INFO: 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.
> 2016-06-08 00:17:44,696 RMI TCP Connection(3)-127.0.0.1 DEBUG Starting 
> LoggerContext[name=AsyncContext[]] from configuration at null
> 2016-06-08 00:17:44,696 RMI TCP Connection(3)-127.0.0.1 TRACE [] 
> AsyncLoggerDisruptor creating new disruptor for this context.
> 2016-06-08 00:17:44,698 RMI TCP Connection(3)-127.0.0.1 TRACE property 
> AsyncLogger.WaitStrategy=TIMEOUT
> 2016-06-08 00:17:44,737 RMI TCP Connection(3)-127.0.0.1 DEBUG [] Starting 
> AsyncLogger disruptor for this context with ringbufferSize=262144, 
> waitStrategy=TimeoutBlockingWaitStrategy, 
> exceptionHandler=org.apache.logging.log4j.core.async.AsyncLoggerDefaultExceptionHandler@3a7e5f1f...
> 2016-06-08 00:17:44,738 RMI TCP Connection(3)-127.0.0.1 TRACE [] AsyncLoggers 
> use a threadlocal translator
> 2016-06-08 00:17:44,738 RMI TCP Connection(3)-127.0.0.1 DEBUG Starting 
> LoggerContext[name=AsyncContext[], 
> org.apache.logging.log4j.core.async.AsyncLoggerContext@1a28371] with 
> configuration 
> XmlConfiguration[location=C:\IdeaProjects\TestLogging\target\test-logging-1.0-SNAPSHOT\WEB-INF\classes\log4j2.xml]...
> 2016-06-08 00:17:44,739 RMI TCP Connection(3)-127.0.0.1 DEBUG Shutdown hook 
> enabled. Registering a new one.
> 2016-06-08 00:17:44,739 RMI TCP Connection(3)-127.0.0.1 DEBUG Initializing 
> configuration 
> XmlConfiguration[location=C:\IdeaProjects\TestLogging\target\test-logging-1.0-SNAPSHOT\WEB-INF\classes\log4j2.xml]
> 2016-06-08 00:17:44,742 RMI TCP Connection(3)-127.0.0.1 DEBUG Installed 
> script engines
> 2016-06-08 00:17:44,752 RMI TCP Connection(3)-127.0.0.1 DEBUG Mozilla Rhino 
> Version: 1.7 release 3 PRERELEASE, Language: ECMAScript, Threading: 
> MULTITHREADED, Compile: true, Names: {js, rhino, JavaScript, javascript, 
> ECMAScript, ecmascript}
> 2016-06-08 00:17:44,752 RMI TCP Connection(3)-127.0.0.1 DEBUG PluginManager 
> 'Core' found 100 plugins
> 2016-06-08 00:17:44,752 RMI TCP Connection(3)-127.0.0.1 DEBUG PluginManager 
> 'Level' found 0 plugins
> 2016-06-08 00:17:44,756 RMI TCP Connection(3)-127.0.0.1 DEBUG Starting 1 
> Log4j2Scheduled threads
> 2016-06-08 00:17:44,757 RMI TCP Connection(3)-127.0.0.1 DEBUG PluginManager 
> 'Lookup' found 14 plugins
> 2016-06-08 00:17:44,758 RMI TCP Connection(3)-127.0.0.1 DEBUG Building 
> Plugin[name=layout, class=org.apache.logging.log4j.core.layout.PatternLayout].
> 2016-06-08 00:17:44,768 RMI TCP Connection(3)-127.0.0.1 TRACE 
> TypeConverterRegistry initializing.
> 2016-06-08 00:17:44,769 RMI TCP Connection(3)-127.0.0.1 DEBUG PluginManager 
> 'TypeConverter' found 23 plugins
> 2016-06-08 00:17:44,780 RMI TCP Connection(3)-127.0.0.1 DEBUG 
> PatternLayout$Builder(pattern="%d [%-5p] [%c]: %m%n", PatternSelector=null, 
> Configuration(C:\IdeaProjects\TestLogging\target\test-logging-1.0-SNAPSHOT\WEB-INF\classes\log4j2.xml),
>  Replace=null, charset="null", alwaysWriteExceptions="null", 
> noConsoleNoAnsi="null", header="null", footer="null")
> 2016-06-08 00:17:44,780 RMI TCP Connection(3)-127.0.0.1 DEBUG PluginManager 
> 'Converter' found 41 plugins
> 2016-06-08 00:17:44,795 RMI TCP Connection(3)-127.0.0.1 DEBUG Building 
> Plugin[name=appender, 
> class=org.apache.logging.log4j.core.appender.ConsoleAppender].
> 2016-06-08 00:17:44,796 RMI TCP Connection(3)-127.0.0.1 DEBUG PluginManager 
> 'Converter' found 41 plugins
> 2016-06-08 00:17:44,798 RMI TCP Connection(3)-127.0.0.1 DEBUG Jansi is not 
> installed, cannot find org.fusesource.jansi.WindowsAnsiOutputStream
> 2016-06-08 00:17:44,798 RMI TCP Connection(3)-127.0.0.1 DEBUG Starting 
> OutputStreamManager SYSTEM_OUT.false-2
> 2016-06-08 00:17:44,803 RMI TCP Connection(3)-127.0.0.1 DEBUG 
> ConsoleAppender$Builder(PatternLayout(%d [%-5p] [%c]: %m%n), Filter=null, 
> target="SYSTEM_OUT", name="Console", follow="null", ignoreExceptions="null")
> 2016-06-08 00:17:44,804 RMI TCP Connection(3)-127.0.0.1 DEBUG Jansi is not 
> installed, cannot find org.fusesource.jansi.WindowsAnsiOutputStream
> 2016-06-08 00:17:44,804 RMI TCP Connection(3)-127.0.0.1 DEBUG Starting 
> OutputStreamManager SYSTEM_OUT.false
> 2016-06-08 00:17:44,805 RMI TCP Connection(3)-127.0.0.1 DEBUG Building 
> Plugin[name=layout, class=org.apache.logging.log4j.core.layout.PatternLayout].
> 2016-06-08 00:17:44,806 RMI TCP Connection(3)-127.0.0.1 DEBUG 
> PatternLayout$Builder(pattern="[%d{dd/MM/yy HH:mm:ss:sss}] [%-5p] [%c]: 
> %m%n", PatternSelector=null, 
> Configuration(C:\IdeaProjects\TestLogging\target\test-logging-1.0-SNAPSHOT\WEB-INF\classes\log4j2.xml),
>  Replace=null, charset="null", alwaysWriteExceptions="null", 
> noConsoleNoAnsi="null", header="null", footer="null")
> 2016-06-08 00:17:44,807 RMI TCP Connection(3)-127.0.0.1 DEBUG Building 
> Plugin[name=SizeBasedTriggeringPolicy, 
> class=org.apache.logging.log4j.core.appender.rolling.SizeBasedTriggeringPolicy].
> 2016-06-08 00:17:44,813 RMI TCP Connection(3)-127.0.0.1 DEBUG 
> createPolicy(size="250 MB")
> 2016-06-08 00:17:44,814 RMI TCP Connection(3)-127.0.0.1 DEBUG Building 
> Plugin[name=Policies, 
> class=org.apache.logging.log4j.core.appender.rolling.CompositeTriggeringPolicy].
> 2016-06-08 00:17:44,815 RMI TCP Connection(3)-127.0.0.1 DEBUG 
> createPolicy(={SizeBasedTriggeringPolicy(size=262144000)})
> 2016-06-08 00:17:44,815 RMI TCP Connection(3)-127.0.0.1 DEBUG Building 
> Plugin[name=appender, 
> class=org.apache.logging.log4j.core.appender.RollingRandomAccessFileAppender].
> 2016-06-08 00:17:44,817 RMI TCP Connection(3)-127.0.0.1 DEBUG 
> createAppender(fileName="C:\system\tomcat\Unnamed_TestLogging_2/logs/oreo.log",
>  
> filePattern="C:\system\tomcat\Unnamed_TestLogging_2/logs/logs/oreo-%d{yyyy-MM-dd_HHmmss-SSS}.log.gz",
>  append="null", name="AppLog", immediateFlush="true", bufferSize="null", 
> Policies(CompositeTriggeringPolicy(policies=[SizeBasedTriggeringPolicy(size=262144000)])),
>  Strategy=null, PatternLayout([%d{dd/MM/yy HH:mm:ss:sss}] [%-5p] [%c]: %m%n), 
> Filter=null, ignoreExceptions="null", advertise="null", advertiseURI="null", 
> Configuration(C:\IdeaProjects\TestLogging\target\test-logging-1.0-SNAPSHOT\WEB-INF\classes\log4j2.xml))
> 2016-06-08 00:17:44,822 RMI TCP Connection(3)-127.0.0.1 TRACE 
> RandomAccessFile C:\system\tomcat\Unnamed_TestLogging_2/logs/oreo.log seek to 
> 22050
> 2016-06-08 00:17:44,823 RMI TCP Connection(3)-127.0.0.1 DEBUG Starting 
> RollingRandomAccessFileManager 
> C:\system\tomcat\Unnamed_TestLogging_2/logs/oreo.log
> 2016-06-08 00:17:44,823 RMI TCP Connection(3)-127.0.0.1 DEBUG PluginManager 
> 'FileConverter' found 2 plugins
> 2016-06-08 00:17:44,825 RMI TCP Connection(3)-127.0.0.1 DEBUG Building 
> Plugin[name=layout, class=org.apache.logging.log4j.core.layout.PatternLayout].
> 2016-06-08 00:17:44,825 RMI TCP Connection(3)-127.0.0.1 DEBUG 
> PatternLayout$Builder(pattern="[%d{dd/MM/yy HH:mm:ss:sss}] [%-5p] [%c]: 
> %m%n", PatternSelector=null, 
> Configuration(C:\IdeaProjects\TestLogging\target\test-logging-1.0-SNAPSHOT\WEB-INF\classes\log4j2.xml),
>  Replace=null, charset="null", alwaysWriteExceptions="null", 
> noConsoleNoAnsi="null", header="null", footer="null")
> 2016-06-08 00:17:44,826 RMI TCP Connection(3)-127.0.0.1 DEBUG Building 
> Plugin[name=SizeBasedTriggeringPolicy, 
> class=org.apache.logging.log4j.core.appender.rolling.SizeBasedTriggeringPolicy].
> 2016-06-08 00:17:44,826 RMI TCP Connection(3)-127.0.0.1 DEBUG 
> createPolicy(size="250 MB")
> 2016-06-08 00:17:44,826 RMI TCP Connection(3)-127.0.0.1 DEBUG Building 
> Plugin[name=Policies, 
> class=org.apache.logging.log4j.core.appender.rolling.CompositeTriggeringPolicy].
> 2016-06-08 00:17:44,827 RMI TCP Connection(3)-127.0.0.1 DEBUG 
> createPolicy(={SizeBasedTriggeringPolicy(size=262144000)})
> 2016-06-08 00:17:44,827 RMI TCP Connection(3)-127.0.0.1 DEBUG Building 
> Plugin[name=appender, 
> class=org.apache.logging.log4j.core.appender.RollingRandomAccessFileAppender].
> 2016-06-08 00:17:44,828 RMI TCP Connection(3)-127.0.0.1 DEBUG 
> createAppender(fileName="C:\system\tomcat\Unnamed_TestLogging_2/logs/oreo-hibernate.log",
>  
> filePattern="C:\system\tomcat\Unnamed_TestLogging_2/logs/logs/oreo-hibernate-%d{yyyy-MM-dd_HHmmss-SSS}.log.gz",
>  append="null", name="HibernateLog", immediateFlush="true", 
> bufferSize="null", 
> Policies(CompositeTriggeringPolicy(policies=[SizeBasedTriggeringPolicy(size=262144000)])),
>  Strategy=null, PatternLayout([%d{dd/MM/yy HH:mm:ss:sss}] [%-5p] [%c]: %m%n), 
> Filter=null, ignoreExceptions="null", advertise="null", advertiseURI="null", 
> Configuration(C:\IdeaProjects\TestLogging\target\test-logging-1.0-SNAPSHOT\WEB-INF\classes\log4j2.xml))
> 2016-06-08 00:17:44,829 RMI TCP Connection(3)-127.0.0.1 TRACE 
> RandomAccessFile 
> C:\system\tomcat\Unnamed_TestLogging_2/logs/oreo-hibernate.log seek to 6237
> 2016-06-08 00:17:44,829 RMI TCP Connection(3)-127.0.0.1 DEBUG Starting 
> RollingRandomAccessFileManager 
> C:\system\tomcat\Unnamed_TestLogging_2/logs/oreo-hibernate.log
> 2016-06-08 00:17:44,830 RMI TCP Connection(3)-127.0.0.1 DEBUG PluginManager 
> 'FileConverter' found 2 plugins
> 2016-06-08 00:17:44,830 RMI TCP Connection(3)-127.0.0.1 DEBUG Building 
> Plugin[name=appenders, 
> class=org.apache.logging.log4j.core.config.AppendersPlugin].
> 2016-06-08 00:17:44,830 RMI TCP Connection(3)-127.0.0.1 DEBUG 
> createAppenders(={Console, AppLog, HibernateLog})
> 2016-06-08 00:17:44,830 RMI TCP Connection(3)-127.0.0.1 DEBUG Building 
> Plugin[name=AppenderRef, 
> class=org.apache.logging.log4j.core.config.AppenderRef].
> 2016-06-08 00:17:44,831 RMI TCP Connection(3)-127.0.0.1 DEBUG 
> createAppenderRef(ref="AppLog", level="null", Filter=null)
> 2016-06-08 00:17:44,831 RMI TCP Connection(3)-127.0.0.1 DEBUG Building 
> Plugin[name=logger, class=org.apache.logging.log4j.core.config.LoggerConfig].
> 2016-06-08 00:17:44,833 RMI TCP Connection(3)-127.0.0.1 DEBUG 
> createLogger(additivity="false", level="DEBUG", name="org.tomcat.logging", 
> includeLocation="null", ={AppLog}, ={}, 
> Configuration(C:\IdeaProjects\TestLogging\target\test-logging-1.0-SNAPSHOT\WEB-INF\classes\log4j2.xml),
>  Filter=null)
> 2016-06-08 00:17:44,834 RMI TCP Connection(3)-127.0.0.1 DEBUG Building 
> Plugin[name=AppenderRef, 
> class=org.apache.logging.log4j.core.config.AppenderRef].
> 2016-06-08 00:17:44,834 RMI TCP Connection(3)-127.0.0.1 DEBUG 
> createAppenderRef(ref="AppLog", level="null", Filter=null)
> 2016-06-08 00:17:44,835 RMI TCP Connection(3)-127.0.0.1 DEBUG Building 
> Plugin[name=logger, class=org.apache.logging.log4j.core.config.LoggerConfig].
> 2016-06-08 00:17:44,835 RMI TCP Connection(3)-127.0.0.1 DEBUG 
> createLogger(additivity="false", level="INFO", name="org.springframework", 
> includeLocation="null", ={AppLog}, ={}, 
> Configuration(C:\IdeaProjects\TestLogging\target\test-logging-1.0-SNAPSHOT\WEB-INF\classes\log4j2.xml),
>  Filter=null)
> 2016-06-08 00:17:44,836 RMI TCP Connection(3)-127.0.0.1 DEBUG Building 
> Plugin[name=AppenderRef, 
> class=org.apache.logging.log4j.core.config.AppenderRef].
> 2016-06-08 00:17:44,836 RMI TCP Connection(3)-127.0.0.1 DEBUG 
> createAppenderRef(ref="HibernateLog", level="null", Filter=null)
> 2016-06-08 00:17:44,836 RMI TCP Connection(3)-127.0.0.1 DEBUG Building 
> Plugin[name=AppenderRef, 
> class=org.apache.logging.log4j.core.config.AppenderRef].
> 2016-06-08 00:17:44,837 RMI TCP Connection(3)-127.0.0.1 DEBUG 
> createAppenderRef(ref="AppLog", level="null", Filter=null)
> 2016-06-08 00:17:44,837 RMI TCP Connection(3)-127.0.0.1 DEBUG Building 
> Plugin[name=logger, class=org.apache.logging.log4j.core.config.LoggerConfig].
> 2016-06-08 00:17:44,838 RMI TCP Connection(3)-127.0.0.1 DEBUG 
> createLogger(additivity="false", level="INFO", name="org.hibernate", 
> includeLocation="null", ={HibernateLog, AppLog}, ={}, 
> Configuration(C:\IdeaProjects\TestLogging\target\test-logging-1.0-SNAPSHOT\WEB-INF\classes\log4j2.xml),
>  Filter=null)
> 2016-06-08 00:17:44,838 RMI TCP Connection(3)-127.0.0.1 DEBUG Building 
> Plugin[name=AppenderRef, 
> class=org.apache.logging.log4j.core.config.AppenderRef].
> 2016-06-08 00:17:44,838 RMI TCP Connection(3)-127.0.0.1 DEBUG 
> createAppenderRef(ref="Console", level="null", Filter=null)
> 2016-06-08 00:17:44,839 RMI TCP Connection(3)-127.0.0.1 DEBUG Building 
> Plugin[name=AppenderRef, 
> class=org.apache.logging.log4j.core.config.AppenderRef].
> 2016-06-08 00:17:44,839 RMI TCP Connection(3)-127.0.0.1 DEBUG 
> createAppenderRef(ref="AppLog", level="null", Filter=null)
> 2016-06-08 00:17:44,839 RMI TCP Connection(3)-127.0.0.1 DEBUG Building 
> Plugin[name=root, 
> class=org.apache.logging.log4j.core.config.LoggerConfig$RootLogger].
> 2016-06-08 00:17:44,840 RMI TCP Connection(3)-127.0.0.1 DEBUG 
> createLogger(additivity="null", level="DEBUG", includeLocation="null", 
> ={Console, AppLog}, ={}, 
> Configuration(C:\IdeaProjects\TestLogging\target\test-logging-1.0-SNAPSHOT\WEB-INF\classes\log4j2.xml),
>  Filter=null)
> 2016-06-08 00:17:44,840 RMI TCP Connection(3)-127.0.0.1 DEBUG Building 
> Plugin[name=loggers, 
> class=org.apache.logging.log4j.core.config.LoggersPlugin].
> 2016-06-08 00:17:44,841 RMI TCP Connection(3)-127.0.0.1 DEBUG 
> createLoggers(={org.tomcat.logging, org.springframework, org.hibernate, root})
> 2016-06-08 00:17:44,842 RMI TCP Connection(3)-127.0.0.1 DEBUG Configuration 
> XmlConfiguration[location=C:\IdeaProjects\TestLogging\target\test-logging-1.0-SNAPSHOT\WEB-INF\classes\log4j2.xml]
>  initialized
> 2016-06-08 00:17:44,843 RMI TCP Connection(3)-127.0.0.1 DEBUG Starting 
> configuration 
> XmlConfiguration[location=C:\IdeaProjects\TestLogging\target\test-logging-1.0-SNAPSHOT\WEB-INF\classes\log4j2.xml]
> 2016-06-08 00:17:44,843 RMI TCP Connection(3)-127.0.0.1 DEBUG Started 
> configuration 
> XmlConfiguration[location=C:\IdeaProjects\TestLogging\target\test-logging-1.0-SNAPSHOT\WEB-INF\classes\log4j2.xml]
>  OK.
> 2016-06-08 00:17:44,844 RMI TCP Connection(3)-127.0.0.1 TRACE Stopping 
> org.apache.logging.log4j.core.config.DefaultConfiguration@47e7cd45...
> 2016-06-08 00:17:44,844 RMI TCP Connection(3)-127.0.0.1 TRACE 
> DefaultConfiguration notified 1 ReliabilityStrategies that config will be 
> stopped.
> 2016-06-08 00:17:44,844 RMI TCP Connection(3)-127.0.0.1 TRACE 
> DefaultConfiguration stopping root LoggerConfig.
> 2016-06-08 00:17:44,844 RMI TCP Connection(3)-127.0.0.1 TRACE 
> DefaultConfiguration notifying ReliabilityStrategies that appenders will be 
> stopped.
> 2016-06-08 00:17:44,845 RMI TCP Connection(3)-127.0.0.1 TRACE 
> DefaultConfiguration stopping remaining Appenders.
> 2016-06-08 00:17:44,845 RMI TCP Connection(3)-127.0.0.1 DEBUG Shutting down 
> OutputStreamManager SYSTEM_OUT.false-1
> 2016-06-08 00:17:44,845 RMI TCP Connection(3)-127.0.0.1 TRACE 
> DefaultConfiguration stopped 1 remaining Appenders.
> 2016-06-08 00:17:44,845 RMI TCP Connection(3)-127.0.0.1 TRACE 
> DefaultConfiguration cleaning Appenders from 1 LoggerConfigs.
> 2016-06-08 00:17:44,845 RMI TCP Connection(3)-127.0.0.1 DEBUG Stopped 
> org.apache.logging.log4j.core.config.DefaultConfiguration@47e7cd45 OK
> 2016-06-08 00:17:44,847 RMI TCP Connection(3)-127.0.0.1 TRACE Reregistering 
> MBeans after reconfigure. 
> Selector=org.apache.logging.log4j.core.async.AsyncLoggerContextSelector@12c1f590
> 2016-06-08 00:17:44,847 RMI TCP Connection(3)-127.0.0.1 TRACE Reregistering 
> context (1/1): 'AsyncContext[]' 
> org.apache.logging.log4j.core.async.AsyncLoggerContext@1a28371
> 2016-06-08 00:17:44,847 RMI TCP Connection(3)-127.0.0.1 TRACE Unregistering 
> but no MBeans found matching 'org.apache.logging.log4j2:type=AsyncContext[]'
> 2016-06-08 00:17:44,847 RMI TCP Connection(3)-127.0.0.1 TRACE Unregistering 
> but no MBeans found matching 
> 'org.apache.logging.log4j2:type=AsyncContext[],component=StatusLogger'
> 2016-06-08 00:17:44,848 RMI TCP Connection(3)-127.0.0.1 TRACE Unregistering 
> but no MBeans found matching 
> 'org.apache.logging.log4j2:type=AsyncContext[],component=ContextSelector'
> 2016-06-08 00:17:44,848 RMI TCP Connection(3)-127.0.0.1 TRACE Unregistering 
> but no MBeans found matching 
> 'org.apache.logging.log4j2:type=AsyncContext[],component=Loggers,name=*'
> 2016-06-08 00:17:44,848 RMI TCP Connection(3)-127.0.0.1 TRACE Unregistering 
> but no MBeans found matching 
> 'org.apache.logging.log4j2:type=AsyncContext[],component=Appenders,name=*'
> 2016-06-08 00:17:44,849 RMI TCP Connection(3)-127.0.0.1 TRACE Unregistering 
> but no MBeans found matching 
> 'org.apache.logging.log4j2:type=AsyncContext[],component=AsyncAppenders,name=*'
> 2016-06-08 00:17:44,849 RMI TCP Connection(3)-127.0.0.1 TRACE Unregistering 
> but no MBeans found matching 
> 'org.apache.logging.log4j2:type=AsyncContext[],component=AsyncLoggerRingBuffer'
> 2016-06-08 00:17:44,849 RMI TCP Connection(3)-127.0.0.1 TRACE Unregistering 
> but no MBeans found matching 
> 'org.apache.logging.log4j2:type=AsyncContext[],component=Loggers,name=*,subtype=RingBuffer'
> 2016-06-08 00:17:44,851 RMI TCP Connection(3)-127.0.0.1 DEBUG Registering 
> MBean org.apache.logging.log4j2:type=AsyncContext[]
> 2016-06-08 00:17:44,853 RMI TCP Connection(3)-127.0.0.1 DEBUG Registering 
> MBean 
> org.apache.logging.log4j2:type=AsyncContext[],component=AsyncLoggerRingBuffer
> 2016-06-08 00:17:44,854 RMI TCP Connection(3)-127.0.0.1 DEBUG Registering 
> MBean org.apache.logging.log4j2:type=AsyncContext[],component=StatusLogger
> 2016-06-08 00:17:44,856 RMI TCP Connection(3)-127.0.0.1 DEBUG Registering 
> MBean org.apache.logging.log4j2:type=AsyncContext[],component=ContextSelector
> 2016-06-08 00:17:44,857 RMI TCP Connection(3)-127.0.0.1 DEBUG Registering 
> MBean 
> org.apache.logging.log4j2:type=AsyncContext[],component=Loggers,name=org.hibernate
> 2016-06-08 00:17:44,858 RMI TCP Connection(3)-127.0.0.1 DEBUG Registering 
> MBean org.apache.logging.log4j2:type=AsyncContext[],component=Loggers,name=
> 2016-06-08 00:17:44,858 RMI TCP Connection(3)-127.0.0.1 DEBUG Registering 
> MBean 
> org.apache.logging.log4j2:type=AsyncContext[],component=Loggers,name=org.tomcat.logging
> 2016-06-08 00:17:44,858 RMI TCP Connection(3)-127.0.0.1 DEBUG Registering 
> MBean 
> org.apache.logging.log4j2:type=AsyncContext[],component=Loggers,name=org.springframework
> 2016-06-08 00:17:44,859 RMI TCP Connection(3)-127.0.0.1 DEBUG Registering 
> MBean 
> org.apache.logging.log4j2:type=AsyncContext[],component=Appenders,name=AppLog
> 2016-06-08 00:17:44,860 RMI TCP Connection(3)-127.0.0.1 DEBUG Registering 
> MBean 
> org.apache.logging.log4j2:type=AsyncContext[],component=Appenders,name=Console
> 2016-06-08 00:17:44,860 RMI TCP Connection(3)-127.0.0.1 DEBUG Registering 
> MBean 
> org.apache.logging.log4j2:type=AsyncContext[],component=Appenders,name=HibernateLog
> 2016-06-08 00:17:44,863 RMI TCP Connection(3)-127.0.0.1 TRACE Using default 
> SystemClock for timestamps.
> 2016-06-08 00:17:44,863 RMI TCP Connection(3)-127.0.0.1 TRACE Using 
> DummyNanoClock for nanosecond timestamps.
> 2016-06-08 00:17:44,864 RMI TCP Connection(3)-127.0.0.1 DEBUG 
> LoggerContext[name=AsyncContext[], 
> org.apache.logging.log4j.core.async.AsyncLoggerContext@1a28371] started OK 
> with configuration 
> XmlConfiguration[location=C:\IdeaProjects\TestLogging\target\test-logging-1.0-SNAPSHOT\WEB-INF\classes\log4j2.xml].
> 2016-06-08 00:17:44,864 RMI TCP Connection(3)-127.0.0.1 TRACE [] AsyncLoggers 
> have been modified to use a vararg translator
> 2016-06-08 00:17:44,893 RMI TCP Connection(3)-127.0.0.1 TRACE Using default 
> SystemClock for timestamps.
> 2016-06-08 00:17:44,894 RMI TCP Connection(3)-127.0.0.1 DEBUG 
> AsyncLogger.ThreadNameStrategy=CACHED
> 2016-06-08 00:17:45,777 [DEBUG] [org.jboss.logging]: Logging Provider: 
> org.jboss.logging.Log4jLoggerProvider
> 2016-06-08 00:17:46,220 RMI TCP Connection(3)-127.0.0.1 DEBUG 
> Log4jServletContextListener ensuring that Log4j starts up properly.
> 2016-06-08 00:17:46,222 RMI TCP Connection(3)-127.0.0.1 DEBUG 
> Log4jServletFilter initialized.
> [2016-06-08 12:17:46,241] Artifact TestLogging:war exploded: Artifact is 
> deployed successfully
> [2016-06-08 12:17:46,241] Artifact TestLogging:war exploded: Deploy took 
> 3,842 milliseconds
> Jun 08, 2016 12:17:52 AM org.apache.catalina.startup.HostConfig 
> deployDirectory
> INFO: Deploying web application directory 
> D:\servers\apache-tomcat-7.0.69\webapps\manager
> Jun 08, 2016 12:17:52 AM org.apache.catalina.startup.HostConfig 
> deployDirectory
> INFO: Deployment of web application directory 
> D:\servers\apache-tomcat-7.0.69\webapps\manager has finished in 63 ms
> D:\servers\apache-tomcat-7.0.69\bin\catalina.bat stop
> Disconnected from the target VM, address: '127.0.0.1:50643', transport: 
> 'socket'
> Using CATALINA_BASE:   "C:\system\tomcat\Unnamed_TestLogging_2"
> Using CATALINA_HOME:   "D:\servers\apache-tomcat-7.0.69"
> Using CATALINA_TMPDIR: "D:\servers\apache-tomcat-7.0.69\temp"
> Using JRE_HOME:        "C:\Program Files\Java\jdk1.7.0_79"
> Using CLASSPATH:       
> "D:\servers\apache-tomcat-7.0.69\bin\bootstrap.jar;D:\servers\apache-tomcat-7.0.69\bin\tomcat-juli.jar"
> Jun 08, 2016 12:18:22 AM org.apache.catalina.core.StandardServer await
> INFO: A valid shutdown command was received via the shutdown port. Stopping 
> the Server instance.
> Jun 08, 2016 12:18:22 AM org.apache.coyote.AbstractProtocol pause
> INFO: Pausing ProtocolHandler ["http-apr-8080"]
> Jun 08, 2016 12:18:22 AM org.apache.coyote.AbstractProtocol pause
> INFO: Pausing ProtocolHandler ["ajp-apr-8009"]
> Jun 08, 2016 12:18:23 AM org.apache.catalina.core.StandardService stopInternal
> INFO: Stopping service Catalina
> 2016-06-08 00:18:23,161 localhost-startStop-2 DEBUG Log4jServletFilter 
> destroyed.
> 2016-06-08 00:18:23,162 localhost-startStop-2 DEBUG 
> Log4jServletContextListener ensuring that Log4j shuts down properly.
> 2016-06-08 00:18:23,163 localhost-startStop-2 DEBUG Removing LoggerContext 
> for [].
> 2016-06-08 00:18:23,163 localhost-startStop-2 DEBUG [] AsyncLoggerDisruptor: 
> shutting down disruptor for this context.
> 2016-06-08 00:18:23,164 localhost-startStop-2 TRACE [] AsyncLoggerDisruptor: 
> shutting down disruptor executor.
> 2016-06-08 00:18:23,185 localhost-startStop-2 DEBUG Stopping 
> LoggerContext[name=AsyncContext[], 
> org.apache.logging.log4j.core.async.AsyncLoggerContext@1a28371]...
> 2016-06-08 00:18:23,186 localhost-startStop-2 TRACE Unregistering 1 MBeans: 
> [org.apache.logging.log4j2:type=AsyncContext[]]
> 2016-06-08 00:18:23,186 localhost-startStop-2 TRACE Unregistering 1 MBeans: 
> [org.apache.logging.log4j2:type=AsyncContext[],component=StatusLogger]
> 2016-06-08 00:18:23,187 localhost-startStop-2 TRACE Unregistering 1 MBeans: 
> [org.apache.logging.log4j2:type=AsyncContext[],component=ContextSelector]
> 2016-06-08 00:18:23,188 localhost-startStop-2 TRACE Unregistering 4 MBeans: 
> [org.apache.logging.log4j2:type=AsyncContext[],component=Loggers,name=, 
> org.apache.logging.log4j2:type=AsyncContext[],component=Loggers,name=org.hibernate,
>  
> org.apache.logging.log4j2:type=AsyncContext[],component=Loggers,name=org.springframework,
>  
> org.apache.logging.log4j2:type=AsyncContext[],component=Loggers,name=org.tomcat.logging]
> 2016-06-08 00:18:23,189 localhost-startStop-2 TRACE Unregistering 3 MBeans: 
> [org.apache.logging.log4j2:type=AsyncContext[],component=Appenders,name=Console,
>  
> org.apache.logging.log4j2:type=AsyncContext[],component=Appenders,name=AppLog,
>  
> org.apache.logging.log4j2:type=AsyncContext[],component=Appenders,name=HibernateLog]
> 2016-06-08 00:18:23,189 localhost-startStop-2 TRACE Unregistering but no 
> MBeans found matching 
> 'org.apache.logging.log4j2:type=AsyncContext[],component=AsyncAppenders,name=*'
> 2016-06-08 00:18:23,190 localhost-startStop-2 TRACE Unregistering 1 MBeans: 
> [org.apache.logging.log4j2:type=AsyncContext[],component=AsyncLoggerRingBuffer]
> 2016-06-08 00:18:23,190 localhost-startStop-2 TRACE Unregistering but no 
> MBeans found matching 
> 'org.apache.logging.log4j2:type=AsyncContext[],component=Loggers,name=*,subtype=RingBuffer'
> 2016-06-08 00:18:23,191 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.ui.context.support.ResourceBundleThemeSource 
> uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,191 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.core.env.MapPropertySource uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,191 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.hibernate.service.jdbc.dialect.internal.AbstractDialectResolver uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,192 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.tomcat.logging.service.impl.ContactServiceImpl uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,192 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.springframework.core.LocalVariableTableParameterNameDiscoverer uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,192 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.web.context.support.XmlWebApplicationContext 
> uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,193 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.hibernate.id.factory.internal.DefaultIdentifierGeneratorFactory uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,193 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.springframework.beans.factory.xml.DefaultBeanDefinitionDocumentReader 
> uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,193 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.jdbc.datasource.SimpleDriverDataSource uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,193 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.jndi.JndiLocatorDelegate uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,193 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.SQL uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,194 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.context.support.DefaultLifecycleProcessor 
> uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,194 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.jdbc.datasource.init.ScriptUtils uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,194 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.cfg.Configuration uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,194 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.core.type.filter.AnnotationTypeFilter uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,194 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.springframework.beans.factory.support.DefaultListableBeanFactory uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,194 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.beans.factory.support.DisposableBeanAdapter 
> uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,195 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.internal.CacheImpl uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,195 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.cfg.beanvalidation.BeanValidationIntegrator uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,195 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.orm.hibernate4.HibernateTransactionManager 
> uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,195 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.springframework.core.io.support.PathMatchingResourcePatternResolver uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,195 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.web.context.ContextLoader uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,196 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.internal.SessionFactoryRegistry uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,196 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.dialect.function.TemplateRenderer uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,196 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.springframework.jdbc.datasource.embedded.H2EmbeddedDatabaseConfigurer 
> uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,196 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.beans.factory.xml.PluggableSchemaResolver 
> uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,196 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.jdbc.config.SortedResourcesFactoryBean uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,197 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.engine.query.spi.QueryPlanCache uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,197 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.ui.context.support.UiApplicationContextUtils 
> uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,197 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.service.internal.AbstractServiceRegistryImpl uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,197 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.springframework.transaction.support.TransactionSynchronizationManager 
> uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,197 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.beans.factory.annotation.InjectionMetadata 
> uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,198 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.springframework.context.annotation.ClassPathBeanDefinitionScanner uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,198 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.core.io.support.ResourceArrayPropertyEditor 
> uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,198 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.engine.jdbc.internal.TypeInfoExtracter uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,198 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.springframework.web.context.support.StandardServletEnvironment uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,198 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.core.SpringProperties uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,198 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.dialect.H2Dialect uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,199 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.beans.ExtendedBeanInfo uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,199 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.MultiTenancyStrategy uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,199 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.cfg.AnnotationBinder uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,199 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.service.config.internal.ConfigurationServiceImpl 
> uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,199 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.hibernate.service.classloading.internal.ClassLoaderServiceImpl uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,199 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.stat.internal.StatisticsInitiator uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,200 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.beans.BeanUtils uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,200 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.tomcat.logging.dao.impl.ContactDaoImpl uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,200 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.springframework.context.annotation.ConfigurationClassPostProcessor uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,200 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.type.BasicTypeRegistry uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,200 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.springframework.context.annotation.CommonAnnotationBeanPostProcessor uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,201 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.springframework.core.env.PropertySource$ComparisonPropertySource uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,201 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.core.env.StandardEnvironment uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,201 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.service.jndi.internal.JndiServiceImpl uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,201 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.service.jdbc.dialect.internal.DialectResolverSet 
> uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,201 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.springframework.core.type.classreading.RecursiveAnnotationArrayVisitor 
> uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,201 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.type.DbTimestampType uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,202 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.hibernate.service.jdbc.connections.internal.ConnectionProviderInitiator 
> uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,202 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.engine.jdbc.spi.SqlExceptionHelper uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,202 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.beans.factory.parsing.FailFastProblemReporter 
> uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,202 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.springframework.transaction.interceptor.TransactionInterceptor uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,202 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.cfg.SettingsFactory uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,203 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.beans.TypeConverterDelegate uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,203 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.beans.factory.xml.DefaultDocumentLoader uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,203 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.jdbc.datasource.DataSourceUtils uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,203 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.jndi.JndiTemplate uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,203 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.springframework.aop.framework.autoproxy.BeanFactoryAdvisorRetrievalHelper 
> uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,203 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.springframework.jdbc.datasource.embedded.EmbeddedDatabaseFactory uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,204 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.dialect.Dialect uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,204 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.Version uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,204 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.context.support.DelegatingMessageSource uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,204 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.springframework.beans.factory.xml.BeanDefinitionParserDelegate uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,204 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.hql.spi.TemporaryTableBulkIdStrategy uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,204 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.id.UUIDGenerator uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,205 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.service.spi.ServiceBinding uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,205 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.beans.factory.xml.XmlBeanDefinitionReader 
> uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,205 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.context.event.EventListenerMethodProcessor 
> uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,205 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.internal.util.xml.DTDEntityResolver uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,205 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.orm.hibernate4.SessionFactoryUtils uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,206 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.springframework.beans.factory.xml.DefaultNamespaceHandlerResolver uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,206 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.hibernate.service.jdbc.connections.internal.MultiTenantConnectionProviderInitiator
>  uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,206 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.core.env.PropertySourcesPropertyResolver uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,206 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.engine.jdbc.internal.LobCreatorBuilder uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,206 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.hibernate.engine.transaction.internal.TransactionFactoryInitiator uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,206 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.beans.factory.xml.BeansDtdResolver uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,207 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.property.BasicPropertyAccessor uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,207 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.context.annotation.ConfigurationClassUtils 
> uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,207 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.springframework.web.context.support.ServletContextPropertySource uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,207 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.beans.factory.config.PropertiesFactoryBean 
> uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,207 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.jboss.logging uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,208 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.springframework.context.annotation.ConfigurationClassBeanDefinitionReader 
> uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,208 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.annotations.common.Version uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,208 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.springframework.context.support.PostProcessorRegistrationDelegate$BeanPostProcessorChecker
>  uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,208 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.beans.factory.xml.ResourceEntityResolver uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,208 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.hql.internal.ast.ASTQueryTranslatorFactory uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,208 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.service.jta.platform.internal.JtaPlatformInitiator 
> uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,209 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.cfg.EJB3DTDEntityResolver uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,209 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.springframework.transaction.annotation.AnnotationTransactionAttributeSource
>  uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,209 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.jndi.JndiPropertySource uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,209 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.bytecode.internal.javassist.BytecodeProviderImpl 
> uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,209 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.beans.AbstractNestablePropertyAccessor uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,210 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.cfg.Environment uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,210 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.internal.SessionFactoryImpl uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,210 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.engine.jdbc.internal.JdbcServicesImpl uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,210 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.core.io.support.SpringFactoriesLoader uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,210 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.aop.framework.JdkDynamicAopProxy uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,210 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.service.ServiceRegistryBuilder uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,211 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.stat.internal.ConcurrentStatisticsImpl uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,211 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.util.PropertyPlaceholderHelper uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,211 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.cfg.annotations.reflection.XMLContext uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,211 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.core.env.SystemEnvironmentPropertySource uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,211 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.type.TypeFactory uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,212 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.springframework.context.support.PostProcessorRegistrationDelegate$ApplicationListenerDetector
>  uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,212 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.jndi.support.SimpleJndiBeanFactory uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,212 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.hibernate.service.jdbc.dialect.internal.StandardDialectResolver uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,212 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.springframework.transaction.interceptor.RuleBasedTransactionAttribute 
> uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,212 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.context.annotation.ConfigurationClassParser 
> uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,212 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.loader.BatchFetchStyle uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,213 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.springframework.transaction.support.TransactionSynchronizationUtils uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,213 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.springframework.core.type.classreading.AnnotationAttributesReadingVisitor 
> uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,213 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.springframework.aop.framework.autoproxy.InfrastructureAdvisorAutoProxyCreator
>  uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,213 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.internal.util.ConfigHelper uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,213 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.springframework.beans.factory.annotation.AutowiredAnnotationBeanPostProcessor
>  uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,214 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.beans.CachedIntrospectionResults uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,214 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.hibernate.integrator.internal.IntegratorServiceImpl uses 
> org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,214 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger org.springframework.core.env.PropertySource$StubPropertySource 
> uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,214 localhost-startStop-2 TRACE [AsyncContext[]] 
> AsyncLogger 
> org.springframework.web.context.support.ServletContextResourcePatternResolver 
> uses org.apache.logging.log4j.core.util.DummyNanoClock@206b5c17.
> 2016-06-08 00:18:23,214 localhost-startStop-2 TRACE Stopping 
> XmlConfiguration[location=C:\IdeaProjects\TestLogging\target\test-logging-1.0-SNAPSHOT\WEB-INF\classes\log4j2.xml]...
> 2016-06-08 00:18:23,215 localhost-startStop-2 TRACE XmlConfiguration notified 
> 5 ReliabilityStrategies that config will be stopped.
> 2016-06-08 00:18:23,215 localhost-startStop-2 TRACE XmlConfiguration stopping 
> 4 LoggerConfigs.
> 2016-06-08 00:18:23,215 localhost-startStop-2 TRACE XmlConfiguration stopping 
> root LoggerConfig.
> 2016-06-08 00:18:23,215 localhost-startStop-2 TRACE XmlConfiguration 
> notifying ReliabilityStrategies that appenders will be stopped.
> 2016-06-08 00:18:23,215 localhost-startStop-2 TRACE XmlConfiguration stopping 
> remaining Appenders.
> 2016-06-08 00:18:23,215 localhost-startStop-2 DEBUG Shutting down 
> RollingRandomAccessFileManager 
> C:\system\tomcat\Unnamed_TestLogging_2/logs/oreo-hibernate.log
> 2016-06-08 00:18:23,237 localhost-startStop-2 DEBUG Shutting down 
> OutputStreamManager SYSTEM_OUT.false
> 2016-06-08 00:18:23,237 localhost-startStop-2 DEBUG Shutting down 
> RollingRandomAccessFileManager 
> C:\system\tomcat\Unnamed_TestLogging_2/logs/oreo.log
> 2016-06-08 00:18:23,256 localhost-startStop-2 TRACE XmlConfiguration stopped 
> 3 remaining Appenders.
> 2016-06-08 00:18:23,257 localhost-startStop-2 TRACE XmlConfiguration cleaning 
> Appenders from 5 LoggerConfigs.
> 2016-06-08 00:18:23,257 localhost-startStop-2 DEBUG Stopping Log4j2Scheduled 
> threads.
> 2016-06-08 00:18:23,258 localhost-startStop-2 DEBUG Stopped 
> XmlConfiguration[location=C:\IdeaProjects\TestLogging\target\test-logging-1.0-SNAPSHOT\WEB-INF\classes\log4j2.xml]
>  OK
> 2016-06-08 00:18:23,260 localhost-startStop-2 DEBUG Stopped 
> LoggerContext[name=AsyncContext[], 
> org.apache.logging.log4j.core.async.AsyncLoggerContext@1a28371]...
> 2016-06-08 00:18:23,278 localhost-startStop-2 DEBUG PluginManager 'Converter' 
> found 41 plugins
> 2016-06-08 00:18:23,282 localhost-startStop-2 DEBUG Jansi is not installed, 
> cannot find org.fusesource.jansi.WindowsAnsiOutputStream
> 2016-06-08 00:18:23,282 localhost-startStop-2 DEBUG Starting 
> OutputStreamManager SYSTEM_OUT.false-3
> 2016-06-08 00:18:23,283 localhost-startStop-2 TRACE [AsyncContext@35d61702] 
> AsyncLoggerDisruptor creating new disruptor for this context.
> 2016-06-08 00:18:23,283 localhost-startStop-2 TRACE property 
> AsyncLogger.WaitStrategy=TIMEOUT
> 2016-06-08 00:18:23,294 localhost-startStop-2 DEBUG [AsyncContext@35d61702] 
> Starting AsyncLogger disruptor for this context with ringbufferSize=262144, 
> waitStrategy=TimeoutBlockingWaitStrategy, 
> exceptionHandler=org.apache.logging.log4j.core.async.AsyncLoggerDefaultExceptionHandler@32302995...
> 2016-06-08 00:18:23,294 localhost-startStop-2 TRACE [AsyncContext@35d61702] 
> AsyncLoggers use a threadlocal translator
> 2016-06-08 00:18:23,294 localhost-startStop-2 DEBUG Starting 
> LoggerContext[name=AsyncContext@35d61702, 
> org.apache.logging.log4j.core.async.AsyncLoggerContext@77fa0ef0]...
> 2016-06-08 00:18:23,295 localhost-startStop-2 DEBUG Reconfiguration started 
> for context[name=AsyncContext@35d61702] at URI null 
> (org.apache.logging.log4j.core.async.AsyncLoggerContext@77fa0ef0) with 
> optional ClassLoader: null
> 2016-06-08 00:18:23,295 localhost-startStop-2 DEBUG Using 
> configurationFactory 
> org.apache.logging.log4j.core.config.ConfigurationFactory$Factory@41eaec19
> 2016-06-08 00:18:23,296 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using context class loader 
> WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
> .
> 2016-06-08 00:18:23,297 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,298 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,299 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using 
> ClassLoader.getSystemResource().
> 2016-06-08 00:18:23,299 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using context class loader 
> WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
> .
> 2016-06-08 00:18:23,300 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,300 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,301 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using ClassLoader.getSystemResource().
> 2016-06-08 00:18:23,301 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using context class loader 
> WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
> .
> 2016-06-08 00:18:23,302 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,302 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,303 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using ClassLoader.getSystemResource().
> 2016-06-08 00:18:23,303 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using context class loader 
> WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
> .
> 2016-06-08 00:18:23,304 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,304 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,305 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using ClassLoader.getSystemResource().
> 2016-06-08 00:18:23,305 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using context class loader 
> WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
> .
> 2016-06-08 00:18:23,306 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,306 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,307 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using ClassLoader.getSystemResource().
> 2016-06-08 00:18:23,307 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using context class loader 
> WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
> .
> 2016-06-08 00:18:23,308 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,308 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,309 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using ClassLoader.getSystemResource().
> 2016-06-08 00:18:23,309 localhost-startStop-2 TRACE Trying to find 
> [log4j2-test.properties] using context class loader WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
> .
> 2016-06-08 00:18:23,310 localhost-startStop-2 TRACE Trying to find 
> [log4j2-test.properties] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,310 localhost-startStop-2 TRACE Trying to find 
> [log4j2-test.properties] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,311 localhost-startStop-2 TRACE Trying to find 
> [log4j2-test.properties] using ClassLoader.getSystemResource().
> 2016-06-08 00:18:23,311 localhost-startStop-2 TRACE Trying to find 
> [log4j2-test.yml] using context class loader WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
> .
> 2016-06-08 00:18:23,312 localhost-startStop-2 TRACE Trying to find 
> [log4j2-test.yml] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,312 localhost-startStop-2 TRACE Trying to find 
> [log4j2-test.yml] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,313 localhost-startStop-2 TRACE Trying to find 
> [log4j2-test.yml] using ClassLoader.getSystemResource().
> 2016-06-08 00:18:23,313 localhost-startStop-2 TRACE Trying to find 
> [log4j2-test.yaml] using context class loader WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
> .
> 2016-06-08 00:18:23,313 localhost-startStop-2 TRACE Trying to find 
> [log4j2-test.yaml] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,313 localhost-startStop-2 TRACE Trying to find 
> [log4j2-test.yaml] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,314 localhost-startStop-2 TRACE Trying to find 
> [log4j2-test.yaml] using ClassLoader.getSystemResource().
> 2016-06-08 00:18:23,314 localhost-startStop-2 TRACE Trying to find 
> [log4j2-test.json] using context class loader WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
> .
> 2016-06-08 00:18:23,314 localhost-startStop-2 TRACE Trying to find 
> [log4j2-test.json] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,315 localhost-startStop-2 TRACE Trying to find 
> [log4j2-test.json] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,315 localhost-startStop-2 TRACE Trying to find 
> [log4j2-test.json] using ClassLoader.getSystemResource().
> 2016-06-08 00:18:23,315 localhost-startStop-2 TRACE Trying to find 
> [log4j2-test.jsn] using context class loader WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
> .
> 2016-06-08 00:18:23,316 localhost-startStop-2 TRACE Trying to find 
> [log4j2-test.jsn] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,316 localhost-startStop-2 TRACE Trying to find 
> [log4j2-test.jsn] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,316 localhost-startStop-2 TRACE Trying to find 
> [log4j2-test.jsn] using ClassLoader.getSystemResource().
> 2016-06-08 00:18:23,317 localhost-startStop-2 TRACE Trying to find 
> [log4j2-test.xml] using context class loader WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
> .
> 2016-06-08 00:18:23,317 localhost-startStop-2 TRACE Trying to find 
> [log4j2-test.xml] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,317 localhost-startStop-2 TRACE Trying to find 
> [log4j2-test.xml] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,318 localhost-startStop-2 TRACE Trying to find 
> [log4j2-test.xml] using ClassLoader.getSystemResource().
> 2016-06-08 00:18:23,318 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using context class loader 
> WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
> .
> 2016-06-08 00:18:23,318 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,319 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,319 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using 
> ClassLoader.getSystemResource().
> 2016-06-08 00:18:23,319 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using context class loader WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
> .
> 2016-06-08 00:18:23,319 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,320 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,320 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using ClassLoader.getSystemResource().
> 2016-06-08 00:18:23,320 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using context class loader 
> WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
> .
> 2016-06-08 00:18:23,320 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,321 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,321 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using ClassLoader.getSystemResource().
> 2016-06-08 00:18:23,321 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using context class loader 
> WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
> .
> 2016-06-08 00:18:23,321 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,322 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,322 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using ClassLoader.getSystemResource().
> 2016-06-08 00:18:23,322 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using context class loader WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
> .
> 2016-06-08 00:18:23,323 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,323 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,323 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using ClassLoader.getSystemResource().
> 2016-06-08 00:18:23,323 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using context class loader WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
> .
> 2016-06-08 00:18:23,324 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,324 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,324 localhost-startStop-2 TRACE Trying to find 
> [[email protected]] using ClassLoader.getSystemResource().
> 2016-06-08 00:18:23,325 localhost-startStop-2 TRACE Trying to find 
> [log4j2.properties] using context class loader WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
> .
> 2016-06-08 00:18:23,325 localhost-startStop-2 TRACE Trying to find 
> [log4j2.properties] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,325 localhost-startStop-2 TRACE Trying to find 
> [log4j2.properties] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,325 localhost-startStop-2 TRACE Trying to find 
> [log4j2.properties] using ClassLoader.getSystemResource().
> 2016-06-08 00:18:23,326 localhost-startStop-2 TRACE Trying to find 
> [log4j2.yml] using context class loader WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
> .
> 2016-06-08 00:18:23,326 localhost-startStop-2 TRACE Trying to find 
> [log4j2.yml] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,326 localhost-startStop-2 TRACE Trying to find 
> [log4j2.yml] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,326 localhost-startStop-2 TRACE Trying to find 
> [log4j2.yml] using ClassLoader.getSystemResource().
> 2016-06-08 00:18:23,327 localhost-startStop-2 TRACE Trying to find 
> [log4j2.yaml] using context class loader WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
> .
> 2016-06-08 00:18:23,327 localhost-startStop-2 TRACE Trying to find 
> [log4j2.yaml] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,327 localhost-startStop-2 TRACE Trying to find 
> [log4j2.yaml] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,327 localhost-startStop-2 TRACE Trying to find 
> [log4j2.yaml] using ClassLoader.getSystemResource().
> 2016-06-08 00:18:23,328 localhost-startStop-2 TRACE Trying to find 
> [log4j2.json] using context class loader WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
> .
> 2016-06-08 00:18:23,328 localhost-startStop-2 TRACE Trying to find 
> [log4j2.json] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,328 localhost-startStop-2 TRACE Trying to find 
> [log4j2.json] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,328 localhost-startStop-2 TRACE Trying to find 
> [log4j2.json] using ClassLoader.getSystemResource().
> 2016-06-08 00:18:23,329 localhost-startStop-2 TRACE Trying to find 
> [log4j2.jsn] using context class loader WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
> .
> 2016-06-08 00:18:23,329 localhost-startStop-2 TRACE Trying to find 
> [log4j2.jsn] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,329 localhost-startStop-2 TRACE Trying to find 
> [log4j2.jsn] using WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
>  class loader.
> 2016-06-08 00:18:23,329 localhost-startStop-2 TRACE Trying to find 
> [log4j2.jsn] using ClassLoader.getSystemResource().
> 2016-06-08 00:18:23,330 localhost-startStop-2 TRACE Trying to find 
> [log4j2.xml] using context class loader WebappClassLoader
>   context: 
>   delegate: false
>   repositories:
>     /WEB-INF/classes/
> ----------> Parent Classloader:
> java.net.URLClassLoader@26e35d06
> .
> 2016-06-08 00:18:23,333 localhost-startStop-2 DEBUG Initializing 
> configuration 
> XmlConfiguration[location=C:\IdeaProjects\TestLogging\target\test-logging-1.0-SNAPSHOT\WEB-INF\classes\log4j2.xml]
> 2016-06-08 00:18:23,334 localhost-startStop-2 DEBUG Installed script engines
> 2016-06-08 00:18:23,335 localhost-startStop-2 DEBUG Mozilla Rhino Version: 
> 1.7 release 3 PRERELEASE, Language: ECMAScript, Threading: MULTITHREADED, 
> Compile: true, Names: {js, rhino, JavaScript, javascript, ECMAScript, 
> ecmascript}
> 2016-06-08 00:18:23,335 localhost-startStop-2 DEBUG PluginManager 'Core' 
> found 100 plugins
> 2016-06-08 00:18:23,335 localhost-startStop-2 DEBUG PluginManager 'Level' 
> found 0 plugins
> 2016-06-08 00:18:23,336 localhost-startStop-2 DEBUG Starting 1 
> Log4j2Scheduled threads
> 2016-06-08 00:18:23,336 localhost-startStop-2 DEBUG PluginManager 'Lookup' 
> found 14 plugins
> 2016-06-08 00:18:23,336 localhost-startStop-2 DEBUG Building 
> Plugin[name=layout, class=org.apache.logging.log4j.core.layout.PatternLayout].
> 2016-06-08 00:18:23,337 localhost-startStop-2 DEBUG 
> PatternLayout$Builder(pattern="%d [%-5p] [%c]: %m%n", PatternSelector=null, 
> Configuration(C:\IdeaProjects\TestLogging\target\test-logging-1.0-SNAPSHOT\WEB-INF\classes\log4j2.xml),
>  Replace=null, charset="null", alwaysWriteExceptions="null", 
> noConsoleNoAnsi="null", header="null", footer="null")
> 2016-06-08 00:18:23,337 localhost-startStop-2 DEBUG PluginManager 'Converter' 
> found 41 plugins
> 2016-06-08 00:18:23,338 localhost-startStop-2 DEBUG Building 
> Plugin[name=appender, 
> class=org.apache.logging.log4j.core.appender.ConsoleAppender].
> 2016-06-08 00:18:23,338 localhost-startStop-2 DEBUG PluginManager 'Converter' 
> found 41 plugins
> 2016-06-08 00:18:23,339 localhost-startStop-2 DEBUG Jansi is not installed, 
> cannot find org.fusesource.jansi.WindowsAnsiOutputStream
> 2016-06-08 00:18:23,340 localhost-startStop-2 DEBUG Starting 
> OutputStreamManager SYSTEM_OUT.false-4
> 2016-06-08 00:18:23,340 localhost-startStop-2 DEBUG 
> ConsoleAppender$Builder(PatternLayout(%d [%-5p] [%c]: %m%n), Filter=null, 
> target="SYSTEM_OUT", name="Console", follow="null", ignoreExceptions="null")
> 2016-06-08 00:18:23,341 localhost-startStop-2 DEBUG Jansi is not installed, 
> cannot find org.fusesource.jansi.WindowsAnsiOutputStream
> 2016-06-08 00:18:23,341 localhost-startStop-2 DEBUG Starting 
> OutputStreamManager SYSTEM_OUT.false
> 2016-06-08 00:18:23,341 localhost-startStop-2 DEBUG Building 
> Plugin[name=layout, class=org.apache.logging.log4j.core.layout.PatternLayout].
> 2016-06-08 00:18:23,342 localhost-startStop-2 DEBUG 
> PatternLayout$Builder(pattern="[%d{dd/MM/yy HH:mm:ss:sss}] [%-5p] [%c]: 
> %m%n", PatternSelector=null, 
> Configuration(C:\IdeaProjects\TestLogging\target\test-logging-1.0-SNAPSHOT\WEB-INF\classes\log4j2.xml),
>  Replace=null, charset="null", alwaysWriteExceptions="null", 
> noConsoleNoAnsi="null", header="null", footer="null")
> 2016-06-08 00:18:23,342 localhost-startStop-2 DEBUG Building 
> Plugin[name=SizeBasedTriggeringPolicy, 
> class=org.apache.logging.log4j.core.appender.rolling.SizeBasedTriggeringPolicy].
> 2016-06-08 00:18:23,343 localhost-startStop-2 DEBUG createPolicy(size="250 
> MB")
> 2016-06-08 00:18:23,343 localhost-startStop-2 DEBUG Building 
> Plugin[name=Policies, 
> class=org.apache.logging.log4j.core.appender.rolling.CompositeTriggeringPolicy].
> 2016-06-08 00:18:23,343 localhost-startStop-2 DEBUG 
> createPolicy(={SizeBasedTriggeringPolicy(size=262144000)})
> 2016-06-08 00:18:23,343 localhost-startStop-2 DEBUG Building 
> Plugin[name=appender, 
> class=org.apache.logging.log4j.core.appender.RollingRandomAccessFileAppender].
> 2016-06-08 00:18:23,344 localhost-startStop-2 DEBUG 
> createAppender(fileName="C:\system\tomcat\Unnamed_TestLogging_2/logs/oreo.log",
>  
> filePattern="C:\system\tomcat\Unnamed_TestLogging_2/logs/logs/oreo-%d{yyyy-MM-dd_HHmmss-SSS}.log.gz",
>  append="null", name="AppLog", immediateFlush="true", bufferSize="null", 
> Policies(CompositeTriggeringPolicy(policies=[SizeBasedTriggeringPolicy(size=262144000)])),
>  Strategy=null, PatternLayout([%d{dd/MM/yy HH:mm:ss:sss}] [%-5p] [%c]: %m%n), 
> Filter=null, ignoreExceptions="null", advertise="null", advertiseURI="null", 
> Configuration(C:\IdeaProjects\TestLogging\target\test-logging-1.0-SNAPSHOT\WEB-INF\classes\log4j2.xml))
> 2016-06-08 00:18:23,345 localhost-startStop-2 TRACE RandomAccessFile 
> C:\system\tomcat\Unnamed_TestLogging_2/logs/oreo.log seek to 25081
> 2016-06-08 00:18:23,345 localhost-startStop-2 DEBUG Starting 
> RollingRandomAccessFileManager 
> C:\system\tomcat\Unnamed_TestLogging_2/logs/oreo.log
> 2016-06-08 00:18:23,345 localhost-startStop-2 DEBUG PluginManager 
> 'FileConverter' found 2 plugins
> 2016-06-08 00:18:23,346 localhost-startStop-2 DEBUG Building 
> Plugin[name=layout, class=org.apache.logging.log4j.core.layout.PatternLayout].
> 2016-06-08 00:18:23,346 localhost-startStop-2 DEBUG 
> PatternLayout$Builder(pattern="[%d{dd/MM/yy HH:mm:ss:sss}] [%-5p] [%c]: 
> %m%n", PatternSelector=null, 
> Configuration(C:\IdeaProjects\TestLogging\target\test-logging-1.0-SNAPSHOT\WEB-INF\classes\log4j2.xml),
>  Replace=null, charset="null", alwaysWriteExceptions="null", 
> noConsoleNoAnsi="null", header="null", footer="null")
> 2016-06-08 00:18:23,347 localhost-startStop-2 DEBUG Building 
> Plugin[name=SizeBasedTriggeringPolicy, 
> class=org.apache.logging.log4j.core.appender.rolling.SizeBasedTriggeringPolicy].
> 2016-06-08 00:18:23,347 localhost-startStop-2 DEBUG createPolicy(size="250 
> MB")
> 2016-06-08 00:18:23,347 localhost-startStop-2 DEBUG Building 
> Plugin[name=Policies, 
> class=org.apache.logging.log4j.core.appender.rolling.CompositeTriggeringPolicy].
> 2016-06-08 00:18:23,347 localhost-startStop-2 DEBUG 
> createPolicy(={SizeBasedTriggeringPolicy(size=262144000)})
> 2016-06-08 00:18:23,348 localhost-startStop-2 DEBUG Building 
> Plugin[name=appender, 
> class=org.apache.logging.log4j.core.appender.RollingRandomAccessFileAppender].
> 2016-06-08 00:18:23,349 localhost-startStop-2 DEBUG 
> createAppender(fileName="C:\system\tomcat\Unnamed_TestLogging_2/logs/oreo-hibernate.log",
>  
> filePattern="C:\system\tomcat\Unnamed_TestLogging_2/logs/logs/oreo-hibernate-%d{yyyy-MM-dd_HHmmss-SSS}.log.gz",
>  append="null", name="HibernateLog", immediateFlush="true", 
> bufferSize="null", 
> Policies(CompositeTriggeringPolicy(policies=[SizeBasedTriggeringPolicy(size=262144000)])),
>  Strategy=null, PatternLayout([%d{dd/MM/yy HH:mm:ss:sss}] [%-5p] [%c]: %m%n), 
> Filter=null, ignoreExceptions="null", advertise="null", advertiseURI="null", 
> Configuration(C:\IdeaProjects\TestLogging\target\test-logging-1.0-SNAPSHOT\WEB-INF\classes\log4j2.xml))
> 2016-06-08 00:18:23,349 localhost-startStop-2 TRACE RandomAccessFile 
> C:\system\tomcat\Unnamed_TestLogging_2/logs/oreo-hibernate.log seek to 7128
> 2016-06-08 00:18:23,349 localhost-startStop-2 DEBUG Starting 
> RollingRandomAccessFileManager 
> C:\system\tomcat\Unnamed_TestLogging_2/logs/oreo-hibernate.log
> 2016-06-08 00:18:23,350 localhost-startStop-2 DEBUG PluginManager 
> 'FileConverter' found 2 plugins
> 2016-06-08 00:18:23,350 localhost-startStop-2 DEBUG Building 
> Plugin[name=appenders, 
> class=org.apache.logging.log4j.core.config.AppendersPlugin].
> 2016-06-08 00:18:23,350 localhost-startStop-2 DEBUG 
> createAppenders(={Console, AppLog, HibernateLog})
> 2016-06-08 00:18:23,350 localhost-startStop-2 DEBUG Building 
> Plugin[name=AppenderRef, 
> class=org.apache.logging.log4j.core.config.AppenderRef].
> 2016-06-08 00:18:23,351 localhost-startStop-2 DEBUG 
> createAppenderRef(ref="AppLog", level="null", Filter=null)
> 2016-06-08 00:18:23,351 localhost-startStop-2 DEBUG Building 
> Plugin[name=logger, class=org.apache.logging.log4j.core.config.LoggerConfig].
> 2016-06-08 00:18:23,352 localhost-startStop-2 DEBUG 
> createLogger(additivity="false", level="DEBUG", name="org.tomcat.logging", 
> includeLocation="null", ={AppLog}, ={}, 
> Configuration(C:\IdeaProjects\TestLogging\target\test-logging-1.0-SNAPSHOT\WEB-INF\classes\log4j2.xml),
>  Filter=null)
> 2016-06-08 00:18:23,352 localhost-startStop-2 DEBUG Building 
> Plugin[name=AppenderRef, 
> class=org.apache.logging.log4j.core.config.AppenderRef].
> 2016-06-08 00:18:23,352 localhost-startStop-2 DEBUG 
> createAppenderRef(ref="AppLog", level="null", Filter=null)
> 2016-06-08 00:18:23,353 localhost-startStop-2 DEBUG Building 
> Plugin[name=logger, class=org.apache.logging.log4j.core.config.LoggerConfig].
> 2016-06-08 00:18:23,354 localhost-startStop-2 DEBUG 
> createLogger(additivity="false", level="INFO", name="org.springframework", 
> includeLocation="null", ={AppLog}, ={}, 
> Configuration(C:\IdeaProjects\TestLogging\target\test-logging-1.0-SNAPSHOT\WEB-INF\classes\log4j2.xml),
>  Filter=null)
> 2016-06-08 00:18:23,354 localhost-startStop-2 DEBUG Building 
> Plugin[name=AppenderRef, 
> class=org.apache.logging.log4j.core.config.AppenderRef].
> 2016-06-08 00:18:23,354 localhost-startStop-2 DEBUG 
> createAppenderRef(ref="HibernateLog", level="null", Filter=null)
> 2016-06-08 00:18:23,354 localhost-startStop-2 DEBUG Building 
> Plugin[name=AppenderRef, 
> class=org.apache.logging.log4j.core.config.AppenderRef].
> 2016-06-08 00:18:23,355 localhost-startStop-2 DEBUG 
> createAppenderRef(ref="AppLog", level="null", Filter=null)
> 2016-06-08 00:18:23,355 localhost-startStop-2 DEBUG Building 
> Plugin[name=logger, class=org.apache.logging.log4j.core.config.LoggerConfig].
> 2016-06-08 00:18:23,356 localhost-startStop-2 DEBUG 
> createLogger(additivity="false", level="INFO", name="org.hibernate", 
> includeLocation="null", ={HibernateLog, AppLog}, ={}, 
> Configuration(C:\IdeaProjects\TestLogging\target\test-logging-1.0-SNAPSHOT\WEB-INF\classes\log4j2.xml),
>  Filter=null)
> 2016-06-08 00:18:23,356 localhost-startStop-2 DEBUG Building 
> Plugin[name=AppenderRef, 
> class=org.apache.logging.log4j.core.config.AppenderRef].
> 2016-06-08 00:18:23,356 localhost-startStop-2 DEBUG 
> createAppenderRef(ref="Console", level="null", Filter=null)
> 2016-06-08 00:18:23,356 localhost-startStop-2 DEBUG Building 
> Plugin[name=AppenderRef, 
> class=org.apache.logging.log4j.core.config.AppenderRef].
> 2016-06-08 00:18:23,357 localhost-startStop-2 DEBUG 
> createAppenderRef(ref="AppLog", level="null", Filter=null)
> 2016-06-08 00:18:23,357 localhost-startStop-2 DEBUG Building 
> Plugin[name=root, 
> class=org.apache.logging.log4j.core.config.LoggerConfig$RootLogger].
> 2016-06-08 00:18:23,358 localhost-startStop-2 DEBUG 
> createLogger(additivity="null", level="DEBUG", includeLocation="null", 
> ={Console, AppLog}, ={}, 
> Configuration(C:\IdeaProjects\TestLogging\target\test-logging-1.0-SNAPSHOT\WEB-INF\classes\log4j2.xml),
>  Filter=null)
> 2016-06-08 00:18:23,358 localhost-startStop-2 DEBUG Building 
> Plugin[name=loggers, 
> class=org.apache.logging.log4j.core.config.LoggersPlugin].
> 2016-06-08 00:18:23,358 localhost-startStop-2 DEBUG 
> createLoggers(={org.tomcat.logging, org.springframework, org.hibernate, root})
> 2016-06-08 00:18:23,358 localhost-startStop-2 DEBUG Configuration 
> XmlConfiguration[location=C:\IdeaProjects\TestLogging\target\test-logging-1.0-SNAPSHOT\WEB-INF\classes\log4j2.xml]
>  initialized
> 2016-06-08 00:18:23,359 localhost-startStop-2 DEBUG Starting configuration 
> XmlConfiguration[location=C:\IdeaProjects\TestLogging\target\test-logging-1.0-SNAPSHOT\WEB-INF\classes\log4j2.xml]
> 2016-06-08 00:18:23,359 localhost-startStop-2 DEBUG Started configuration 
> XmlConfiguration[location=C:\IdeaProjects\TestLogging\target\test-logging-1.0-SNAPSHOT\WEB-INF\classes\log4j2.xml]
>  OK.
> 2016-06-08 00:18:23,359 localhost-startStop-2 TRACE Stopping 
> org.apache.logging.log4j.core.config.DefaultConfiguration@7a25d5eb...
> 2016-06-08 00:18:23,359 localhost-startStop-2 TRACE DefaultConfiguration 
> notified 1 ReliabilityStrategies that config will be stopped.
> 2016-06-08 00:18:23,359 localhost-startStop-2 TRACE DefaultConfiguration 
> stopping root LoggerConfig.
> 2016-06-08 00:18:23,360 localhost-startStop-2 TRACE DefaultConfiguration 
> notifying ReliabilityStrategies that appenders will be stopped.
> 2016-06-08 00:18:23,360 localhost-startStop-2 TRACE DefaultConfiguration 
> stopping remaining Appenders.
> 2016-06-08 00:18:23,360 localhost-startStop-2 DEBUG Shutting down 
> OutputStreamManager SYSTEM_OUT.false-3
> 2016-06-08 00:18:23,360 localhost-startStop-2 TRACE DefaultConfiguration 
> stopped 1 remaining Appenders.
> 2016-06-08 00:18:23,360 localhost-startStop-2 TRACE DefaultConfiguration 
> cleaning Appenders from 1 LoggerConfigs.
> 2016-06-08 00:18:23,360 localhost-startStop-2 DEBUG Stopped 
> org.apache.logging.log4j.core.config.DefaultConfiguration@7a25d5eb OK
> 2016-06-08 00:18:23,360 localhost-startStop-2 TRACE Reregistering MBeans 
> after reconfigure. 
> Selector=org.apache.logging.log4j.core.async.AsyncLoggerContextSelector@12c1f590
> 2016-06-08 00:18:23,361 localhost-startStop-2 TRACE Reregistering context 
> (1/1): 'AsyncContext@35d61702' 
> org.apache.logging.log4j.core.async.AsyncLoggerContext@77fa0ef0
> 2016-06-08 00:18:23,361 localhost-startStop-2 TRACE Unregistering but no 
> MBeans found matching 'org.apache.logging.log4j2:type=AsyncContext@35d61702'
> 2016-06-08 00:18:23,361 localhost-startStop-2 TRACE Unregistering but no 
> MBeans found matching 
> 'org.apache.logging.log4j2:type=AsyncContext@35d61702,component=StatusLogger'
> 2016-06-08 00:18:23,361 localhost-startStop-2 TRACE Unregistering but no 
> MBeans found matching 
> 'org.apache.logging.log4j2:type=AsyncContext@35d61702,component=ContextSelector'
> 2016-06-08 00:18:23,362 localhost-startStop-2 TRACE Unregistering but no 
> MBeans found matching 
> 'org.apache.logging.log4j2:type=AsyncContext@35d61702,component=Loggers,name=*'
> 2016-06-08 00:18:23,362 localhost-startStop-2 TRACE Unregistering but no 
> MBeans found matching 
> 'org.apache.logging.log4j2:type=AsyncContext@35d61702,component=Appenders,name=*'
> 2016-06-08 00:18:23,362 localhost-startStop-2 TRACE Unregistering but no 
> MBeans found matching 
> 'org.apache.logging.log4j2:type=AsyncContext@35d61702,component=AsyncAppenders,name=*'
> 2016-06-08 00:18:23,362 localhost-startStop-2 TRACE Unregistering but no 
> MBeans found matching 
> 'org.apache.logging.log4j2:type=AsyncContext@35d61702,component=AsyncLoggerRingBuffer'
> 2016-06-08 00:18:23,362 localhost-startStop-2 TRACE Unregistering but no 
> MBeans found matching 
> 'org.apache.logging.log4j2:type=AsyncContext@35d61702,component=Loggers,name=*,subtype=RingBuffer'
> 2016-06-08 00:18:23,363 localhost-startStop-2 DEBUG Registering MBean 
> org.apache.logging.log4j2:type=AsyncContext@35d61702
> 2016-06-08 00:18:23,363 localhost-startStop-2 DEBUG Registering MBean 
> org.apache.logging.log4j2:type=AsyncContext@35d61702,component=AsyncLoggerRingBuffer
> 2016-06-08 00:18:23,364 localhost-startStop-2 DEBUG Registering MBean 
> org.apache.logging.log4j2:type=AsyncContext@35d61702,component=StatusLogger
> 2016-06-08 00:18:23,364 localhost-startStop-2 DEBUG Registering MBean 
> org.apache.logging.log4j2:type=AsyncContext@35d61702,component=ContextSelector
> 2016-06-08 00:18:23,364 localhost-startStop-2 DEBUG Registering MBean 
> org.apache.logging.log4j2:type=AsyncContext@35d61702,component=Loggers,name=org.hibernate
> 2016-06-08 00:18:23,364 localhost-startStop-2 DEBUG Registering MBean 
> org.apache.logging.log4j2:type=AsyncContext@35d61702,component=Loggers,name=
> 2016-06-08 00:18:23,365 localhost-startStop-2 DEBUG Registering MBean 
> org.apache.logging.log4j2:type=AsyncContext@35d61702,component=Loggers,name=org.tomcat.logging
> 2016-06-08 00:18:23,365 localhost-startStop-2 DEBUG Registering MBean 
> org.apache.logging.log4j2:type=AsyncContext@35d61702,component=Loggers,name=org.springframework
> 2016-06-08 00:18:23,365 localhost-startStop-2 DEBUG Registering MBean 
> org.apache.logging.log4j2:type=AsyncContext@35d61702,component=Appenders,name=AppLog
> 2016-06-08 00:18:23,366 localhost-startStop-2 DEBUG Registering MBean 
> org.apache.logging.log4j2:type=AsyncContext@35d61702,component=Appenders,name=Console
> 2016-06-08 00:18:23,366 localhost-startStop-2 DEBUG Registering MBean 
> org.apache.logging.log4j2:type=AsyncContext@35d61702,component=Appenders,name=HibernateLog
> 2016-06-08 00:18:23,366 localhost-startStop-2 TRACE Using DummyNanoClock for 
> nanosecond timestamps.
> 2016-06-08 00:18:23,366 localhost-startStop-2 DEBUG Reconfiguration complete 
> for context[name=AsyncContext@35d61702] at URI 
> C:\IdeaProjects\TestLogging\target\test-logging-1.0-SNAPSHOT\WEB-INF\classes\log4j2.xml
>  (org.apache.logging.log4j.core.async.AsyncLoggerContext@77fa0ef0) with 
> optional ClassLoader: null
> 2016-06-08 00:18:23,366 localhost-startStop-2 DEBUG Shutdown hook enabled. 
> Registering a new one.
> 2016-06-08 00:18:23,367 localhost-startStop-2 DEBUG 
> LoggerContext[name=AsyncContext@35d61702, 
> org.apache.logging.log4j.core.async.AsyncLoggerContext@77fa0ef0] started OK.
> Jun 08, 2016 12:18:23 AM org.apache.catalina.loader.WebappClassLoaderBase 
> clearReferencesJdbc
> SEVERE: The web application [] registered the JDBC driver [org.h2.Driver] but 
> failed to unregister it when the web application was stopped. To prevent a 
> memory leak, the JDBC Driver has been forcibly unregistered.
> Jun 08, 2016 12:18:23 AM org.apache.catalina.loader.WebappClassLoaderBase 
> clearReferencesThreads
> SEVERE: The web application [] appears to have started a thread named 
> [Log4j2-AsyncLogger[AsyncContext@35d61702]3] but has failed to stop it. This 
> is very likely to create a memory leak.
> Jun 08, 2016 12:18:23 AM org.apache.catalina.loader.WebappClassLoaderBase 
> clearReferencesThreads
> SEVERE: The web application [] appears to have started a thread named 
> [Log4j2-Log4j2Scheduled-4] but has failed to stop it. This is very likely to 
> create a memory leak.
> Jun 08, 2016 12:18:23 AM org.apache.coyote.AbstractProtocol stop
> INFO: Stopping ProtocolHandler ["http-apr-8080"]
> Jun 08, 2016 12:18:23 AM org.apache.coyote.AbstractProtocol stop
> INFO: Stopping ProtocolHandler ["ajp-apr-8009"]
> Jun 08, 2016 12:18:23 AM org.apache.coyote.AbstractProtocol destroy
> INFO: Destroying ProtocolHandler ["http-apr-8080"]
> Jun 08, 2016 12:18:23 AM org.apache.coyote.AbstractProtocol destroy
> INFO: Destroying ProtocolHandler ["ajp-apr-8009"]
> Disconnected from server
> {CODE}
> As you can see in line with timestamp 2016-06-08 00:18:23,260 LoggerContext 
> was stopped. Next step what Log4j2 doing is initialize new LoggerContext 
> (2016-06-08 00:18:23,294) and when it done (2016-06-08 00:18:23,367) we have 
> memory leak...
> My log4j2.xml:
> {CODE}
> <?xml version="1.0" encoding="UTF-8" ?>
> <Configuration status="TRACE" monitorInterval="60">
>     <Appenders>
>         <Console name="Console" target="SYSTEM_OUT">
>             <PatternLayout pattern="%d [%-5p] [%c]: %m%n" />
>         </Console>
>         <RollingRandomAccessFile name="AppLog"
>                 fileName="${sys:catalina.base}/logs/test.log"
>                 immediateFlush="true"
>                 
> filePattern="${sys:catalina.base}/logs/logs/test-%d{yyyy-MM-dd_HHmmss-SSS}.log.gz">
>             <PatternLayout pattern="[%d{dd/MM/yy HH:mm:ss:sss}] [%-5p] [%c]: 
> %m%n" />
>             <Policies>
>                 <SizeBasedTriggeringPolicy size="250 MB" />
>             </Policies>
>         </RollingRandomAccessFile>
>         <RollingRandomAccessFile name="HibernateLog"
>                                  
> fileName="${sys:catalina.base}/logs/test-hibernate.log"
>                                  immediateFlush="true"
>                                  
> filePattern="${sys:catalina.base}/logs/logs/test-hibernate-%d{yyyy-MM-dd_HHmmss-SSS}.log.gz">
>             <PatternLayout pattern="[%d{dd/MM/yy HH:mm:ss:sss}] [%-5p] [%c]: 
> %m%n" />
>             <Policies>
>                 <SizeBasedTriggeringPolicy size="250 MB" />
>             </Policies>
>         </RollingRandomAccessFile>
>     </Appenders>
>     <Loggers>
>         <Logger name="org.simple.logging" level="DEBUG" additivity="false">
>             <AppenderRef ref="AppLog"/>
>         </Logger>
>         <Logger name="org.springframework" level="INFO" additivity="false">
>             <AppenderRef ref="AppLog"/>
>         </Logger>
>         <Logger name="org.hibernate" level="INFO" additivity="false">
>             <AppenderRef ref="HibernateLog"/>
>             <AppenderRef ref="AppLog"/>
>         </Logger>
>         <Root level="DEBUG">
>             <AppenderRef ref="Console" />
>             <AppenderRef ref="AppLog"/>
>         </Root>
>     </Loggers>
> </Configuration>
> {CODE}



--
This message was sent by Atlassian JIRA
(v6.3.4#6332)

---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

[jira] [Commented] (LOG4J2-1419) Memory leak on tomcat shutdown

Reply via email to