You are viewing a plain text version of this content. The canonical link for it is here.
Posted to log4j-dev@logging.apache.org by "Veit Guna (JIRA)" <ji...@apache.org> on 2017/03/03 20:21:46 UTC
[jira] [Commented] (LOG4J2-1259) Log4j threads are leaking on
Tomcat shutdown
[ https://issues.apache.org/jira/browse/LOG4J2-1259?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=15894974#comment-15894974 ]
Veit Guna commented on LOG4J2-1259:
-----------------------------------
I just ran into the same problem using 2.8.1.
I've added the log4j-web.jar, switched to servlet spec 3.0 in my web.xml and I'm using Spring in my web application.
I've added an AsyncAppender in front of my SmtpAppender. Starting the webapp and directly stopping it leads to:
{code}
Mär 03, 2017 9:17:56 PM org.apache.catalina.loader.WebappClassLoaderBase clearReferencesThreads
WARNUNG: The web application [acme-backend] appears to have started a thread named [AsyncAppender-asyncSmtpAppender] but has failed to stop it. This is very likely to create a memory leak. Stack trace of thread:
sun.misc.Unsafe.park(Native Method)
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
java.util.concurrent.ArrayBlockingQueue.take(ArrayBlockingQueue.java:403)
org.apache.logging.log4j.core.appender.AsyncAppender$AsyncThread.run(AsyncAppender.java:403)
{code}
Here's the output of status=trace
{code}
2017-03-03 21:09:58,741 localhost-startStop-1 DEBUG Starting LoggerContext[name=Acme Backend] from configuration at null
2017-03-03 21:09:58,745 localhost-startStop-1 DEBUG Starting LoggerContext[name=Acme Backend, org.apache.logging.log4j.core.LoggerContext@554ad7a7] with configuration XmlConfiguration[location=E:\Coding\workspace\.metadata\.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\acme-web-impl\WEB-INF\classes\log4j2.xml]...
2017-03-03 21:09:58,746 localhost-startStop-1 DEBUG Shutdown hook enabled. Registering a new one.
2017-03-03 21:09:58,748 localhost-startStop-1 DEBUG Initializing configuration XmlConfiguration[location=E:\Coding\workspace\.metadata\.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\acme-web-impl\WEB-INF\classes\log4j2.xml]
2017-03-03 21:09:58,755 localhost-startStop-1 DEBUG Installed script engines
2017-03-03 21:09:59,396 localhost-startStop-1 DEBUG Oracle Nashorn Version: 1.8.0_66, Language: ECMAScript, Threading: Not Thread Safe, Compile: true, Names: {nashorn, Nashorn, js, JS, JavaScript, javascript, ECMAScript, ecmascript}
2017-03-03 21:09:59,407 localhost-startStop-1 DEBUG Took 0,009540 seconds to load 4 plugins from package com.acme.backend.service.rest.logging.log4j2
2017-03-03 21:09:59,407 localhost-startStop-1 DEBUG PluginManager 'Core' found 117 plugins
2017-03-03 21:09:59,407 localhost-startStop-1 DEBUG PluginManager 'Level' found 0 plugins
2017-03-03 21:09:59,425 localhost-startStop-1 DEBUG Building Plugin[name=property, class=org.apache.logging.log4j.core.config.Property].
2017-03-03 21:09:59,443 localhost-startStop-1 TRACE TypeConverterRegistry initializing.
2017-03-03 21:09:59,444 localhost-startStop-1 DEBUG PluginManager 'TypeConverter' found 26 plugins
2017-03-03 21:09:59,458 localhost-startStop-1 DEBUG createProperty(name="logsPath", value="logs")
2017-03-03 21:09:59,458 localhost-startStop-1 DEBUG Building Plugin[name=properties, class=org.apache.logging.log4j.core.config.PropertiesPlugin].
2017-03-03 21:09:59,466 localhost-startStop-1 DEBUG configureSubstitutor(={logsPath=logs}, Configuration(E:\Coding\workspace\.metadata\.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\acme-web-impl\WEB-INF\classes\log4j2.xml))
2017-03-03 21:09:59,467 localhost-startStop-1 DEBUG PluginManager 'Lookup' found 14 plugins
2017-03-03 21:09:59,467 localhost-startStop-1 DEBUG Building Plugin[name=layout, class=org.apache.logging.log4j.core.layout.PatternLayout].
2017-03-03 21:09:59,477 localhost-startStop-1 DEBUG PatternLayout$Builder(pattern="%d %-5p [%mdc{RQID}] [%c{1}] - %m%n", PatternSelector=null, Configuration(E:\Coding\workspace\.metadata\.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\acme-web-impl\WEB-INF\classes\log4j2.xml), Replace=null, charset="null", alwaysWriteExceptions="null", disableAnsi="null", noConsoleNoAnsi="null", header="null", footer="null")
2017-03-03 21:09:59,478 localhost-startStop-1 DEBUG PluginManager 'Converter' found 41 plugins
2017-03-03 21:09:59,507 localhost-startStop-1 DEBUG Building Plugin[name=SizeBasedTriggeringPolicy, class=org.apache.logging.log4j.core.appender.rolling.SizeBasedTriggeringPolicy].
2017-03-03 21:09:59,510 localhost-startStop-1 DEBUG createPolicy(size="10 MB")
2017-03-03 21:09:59,512 localhost-startStop-1 DEBUG Building Plugin[name=Policies, class=org.apache.logging.log4j.core.appender.rolling.CompositeTriggeringPolicy].
2017-03-03 21:09:59,513 localhost-startStop-1 DEBUG createPolicy(={SizeBasedTriggeringPolicy(size=10485760)})
2017-03-03 21:09:59,513 localhost-startStop-1 DEBUG Building Plugin[name=DefaultRolloverStrategy, class=org.apache.logging.log4j.core.appender.rolling.DefaultRolloverStrategy].
2017-03-03 21:09:59,515 localhost-startStop-1 DEBUG createStrategy(max="5", min="null", fileIndex="null", compressionLevel="null", ={}, stopCustomActionsOnError="true", Configuration(E:\Coding\workspace\.metadata\.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\acme-web-impl\WEB-INF\classes\log4j2.xml))
2017-03-03 21:09:59,516 localhost-startStop-1 DEBUG Building Plugin[name=appender, class=org.apache.logging.log4j.core.appender.RollingRandomAccessFileAppender].
2017-03-03 21:09:59,528 localhost-startStop-1 DEBUG RollingRandomAccessFileAppender$Builder(fileName="logs/acme-backend.log", filePattern="logs/acme-backend-%d{yyyy-MM-dd}-%i.log", append="null", Policies(CompositeTriggeringPolicy(policies=[SizeBasedTriggeringPolicy(size=10485760)])), DefaultRolloverStrategy(DefaultRolloverStrategy(min=1, max=5, useMax=true)), advertise="null", advertiseURI="null", bufferedIo="null", bufferSize="null", immediateFlush="true", ignoreExceptions="null", PatternLayout(%d %-5p [%mdc{RQID}] [%c{1}] - %m%n), name="rollingFileAppender", Configuration(E:\Coding\workspace\.metadata\.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\acme-web-impl\WEB-INF\classes\log4j2.xml), Filter=null)
2017-03-03 21:09:59,539 localhost-startStop-1 TRACE RandomAccessFile logs/acme-backend.log seek to 9220221
2017-03-03 21:09:59,539 localhost-startStop-1 DEBUG Starting RollingRandomAccessFileManager logs/acme-backend.log
2017-03-03 21:09:59,542 localhost-startStop-1 DEBUG PluginManager 'FileConverter' found 2 plugins
2017-03-03 21:09:59,544 localhost-startStop-1 DEBUG Setting prev file time to 2017-03-03T21:01:57.387+0100
2017-03-03 21:09:59,550 localhost-startStop-1 DEBUG Initializing triggering policy CompositeTriggeringPolicy(policies=[SizeBasedTriggeringPolicy(size=10485760)])
2017-03-03 21:09:59,550 localhost-startStop-1 DEBUG Building Plugin[name=layout, class=org.apache.logging.log4j.core.layout.PatternLayout].
2017-03-03 21:09:59,550 localhost-startStop-1 DEBUG PatternLayout$Builder(pattern="%d{HH:mm:ss,SSS} %-5p [%mdc{RQID}] [%c{1}] - %m%n", PatternSelector=null, Configuration(E:\Coding\workspace\.metadata\.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\acme-web-impl\WEB-INF\classes\log4j2.xml), Replace=null, charset="null", alwaysWriteExceptions="null", disableAnsi="null", noConsoleNoAnsi="null", header="null", footer="null")
2017-03-03 21:09:59,551 localhost-startStop-1 DEBUG Building Plugin[name=appender, class=org.apache.logging.log4j.core.appender.ConsoleAppender].
2017-03-03 21:09:59,554 localhost-startStop-1 DEBUG ConsoleAppender$Builder(target="SYSTEM_OUT", follow="null", direct="null", bufferedIo="null", bufferSize="null", immediateFlush="null", ignoreExceptions="null", PatternLayout(%d{HH:mm:ss,SSS} %-5p [%mdc{RQID}] [%c{1}] - %m%n), name="consoleAppender", Configuration(E:\Coding\workspace\.metadata\.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\acme-web-impl\WEB-INF\classes\log4j2.xml), Filter=null)
2017-03-03 21:09:59,556 localhost-startStop-1 DEBUG Jansi is not installed, cannot find org.fusesource.jansi.WindowsAnsiOutputStream
2017-03-03 21:09:59,557 localhost-startStop-1 DEBUG Starting OutputStreamManager SYSTEM_OUT.false.false
2017-03-03 21:09:59,557 localhost-startStop-1 DEBUG Building Plugin[name=filter, class=com.acme.backend.service.rest.logging.log4j2.RegExFileFilter].
2017-03-03 21:09:59,559 localhost-startStop-1 DEBUG createFilter(filePath="log4j2-regex-filters.txt", checkModificationIntervalSecs="60", acceptOnMatch="false")
2017-03-03 21:09:59,563 localhost-startStop-1 INFO loading regexs from 'E:\Coding\workspace\.metadata\.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\acme-web-impl\WEB-INF\classes\log4j2-regex-filters.txt'...
2017-03-03 21:09:59,564 localhost-startStop-1 DEBUG Building Plugin[name=filter, class=com.acme.backend.service.rest.logging.log4j2.DeduplicateExceptionFilter].
2017-03-03 21:09:59,566 localhost-startStop-1 DEBUG createFilter(level="ERROR", expirationIntervalMillis="60000", releaseBlockAfterSilenceOfSecs="3600", releaseBlockAfterSecs="21600", dupsHighlightCount="10")
2017-03-03 21:09:59,593 localhost-startStop-1 DEBUG Building Plugin[name=filters, class=org.apache.logging.log4j.core.filter.CompositeFilter].
2017-03-03 21:09:59,595 localhost-startStop-1 DEBUG createFilters(={RegExFileFilter, DeduplicateExceptionFilter})
2017-03-03 21:09:59,595 localhost-startStop-1 DEBUG Building Plugin[name=layout, class=org.apache.logging.log4j.core.layout.PatternLayout].
2017-03-03 21:09:59,596 localhost-startStop-1 DEBUG PatternLayout$Builder(pattern="%d %-5p [%mdc{RQID}] [%c{1}] - %m%n", PatternSelector=null, Configuration(E:\Coding\workspace\.metadata\.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\acme-web-impl\WEB-INF\classes\log4j2.xml), Replace=null, charset="null", alwaysWriteExceptions="null", disableAnsi="null", noConsoleNoAnsi="null", header="null", footer="null")
2017-03-03 21:09:59,597 localhost-startStop-1 DEBUG Building Plugin[name=appender, class=com.acme.backend.service.rest.logging.log4j2.DeduplicateExceptionSmtpAppender].
2017-03-03 21:09:59,604 localhost-startStop-1 DEBUG createAppender(Configuration(E:\Coding\workspace\.metadata\.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\acme-web-impl\WEB-INF\classes\log4j2.xml), name="smtpAppender", PatternLayout(%d %-5p [%mdc{RQID}] [%c{1}] - %m%n), Filters({RegExFileFilter, DeduplicateExceptionFilter}), ignoreExceptions="null")
2017-03-03 21:09:59,634 localhost-startStop-1 DEBUG Starting SmtpManager SMTP:bc180b2b3c83b892f0c5ade1df40cd47
2017-03-03 21:09:59,635 localhost-startStop-1 DEBUG Building Plugin[name=AppenderRef, class=org.apache.logging.log4j.core.config.AppenderRef].
2017-03-03 21:09:59,636 localhost-startStop-1 DEBUG createAppenderRef(ref="smtpAppender", level="null", Filter=null)
2017-03-03 21:09:59,636 localhost-startStop-1 DEBUG Building Plugin[name=appender, class=org.apache.logging.log4j.core.appender.AsyncAppender].
2017-03-03 21:09:59,640 localhost-startStop-1 DEBUG AsyncAppender$Builder(={smtpAppender}, errorRef="null", blocking="null", shutdownTimeout="null", bufferSize="null", name="asyncSmtpAppender", includeLocation="null", Filter=null, Configuration(E:\Coding\workspace\.metadata\.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\acme-web-impl\WEB-INF\classes\log4j2.xml), ignoreExceptions="null", BlockingQueueFactory=null)
2017-03-03 21:09:59,641 localhost-startStop-1 DEBUG Building Plugin[name=appenders, class=org.apache.logging.log4j.core.config.AppendersPlugin].
2017-03-03 21:09:59,641 localhost-startStop-1 DEBUG createAppenders(={rollingFileAppender, consoleAppender, smtpAppender, asyncSmtpAppender})
2017-03-03 21:09:59,641 localhost-startStop-1 DEBUG Building Plugin[name=logger, class=org.apache.logging.log4j.core.config.LoggerConfig].
2017-03-03 21:09:59,642 localhost-startStop-1 DEBUG createLogger(additivity="true", level="DEBUG", name="com.acme.backend", includeLocation="null", ={}, ={}, Configuration(E:\Coding\workspace\.metadata\.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\acme-web-impl\WEB-INF\classes\log4j2.xml), Filter=null)
2017-03-03 21:09:59,646 localhost-startStop-1 DEBUG Building Plugin[name=logger, class=org.apache.logging.log4j.core.config.LoggerConfig].
2017-03-03 21:09:59,647 localhost-startStop-1 DEBUG createLogger(additivity="true", level="INFO", name="org.springframework.security", includeLocation="null", ={}, ={}, Configuration(E:\Coding\workspace\.metadata\.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\acme-web-impl\WEB-INF\classes\log4j2.xml), Filter=null)
2017-03-03 21:09:59,647 localhost-startStop-1 DEBUG Building Plugin[name=logger, class=org.apache.logging.log4j.core.config.LoggerConfig].
2017-03-03 21:09:59,648 localhost-startStop-1 DEBUG createLogger(additivity="true", level="INFO", name="org.springframework.transaction", includeLocation="null", ={}, ={}, Configuration(E:\Coding\workspace\.metadata\.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\acme-web-impl\WEB-INF\classes\log4j2.xml), Filter=null)
2017-03-03 21:09:59,648 localhost-startStop-1 DEBUG Building Plugin[name=logger, class=org.apache.logging.log4j.core.config.LoggerConfig].
2017-03-03 21:09:59,648 localhost-startStop-1 DEBUG createLogger(additivity="true", level="INFO", name="org.springframework.orm.jpa", includeLocation="null", ={}, ={}, Configuration(E:\Coding\workspace\.metadata\.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\acme-web-impl\WEB-INF\classes\log4j2.xml), Filter=null)
2017-03-03 21:09:59,649 localhost-startStop-1 DEBUG Building Plugin[name=logger, class=org.apache.logging.log4j.core.config.LoggerConfig].
2017-03-03 21:09:59,649 localhost-startStop-1 DEBUG createLogger(additivity="true", level="ERROR", name="org.hibernate.SQL", includeLocation="null", ={}, ={}, Configuration(E:\Coding\workspace\.metadata\.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\acme-web-impl\WEB-INF\classes\log4j2.xml), Filter=null)
2017-03-03 21:09:59,649 localhost-startStop-1 DEBUG Building Plugin[name=logger, class=org.apache.logging.log4j.core.config.LoggerConfig].
2017-03-03 21:09:59,650 localhost-startStop-1 DEBUG createLogger(additivity="true", level="ERROR", name="org.hibernate.type", includeLocation="null", ={}, ={}, Configuration(E:\Coding\workspace\.metadata\.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\acme-web-impl\WEB-INF\classes\log4j2.xml), Filter=null)
2017-03-03 21:09:59,650 localhost-startStop-1 DEBUG Building Plugin[name=AppenderRef, class=org.apache.logging.log4j.core.config.AppenderRef].
2017-03-03 21:09:59,651 localhost-startStop-1 DEBUG createAppenderRef(ref="consoleAppender", level="null", Filter=null)
2017-03-03 21:09:59,651 localhost-startStop-1 DEBUG Building Plugin[name=AppenderRef, class=org.apache.logging.log4j.core.config.AppenderRef].
2017-03-03 21:09:59,651 localhost-startStop-1 DEBUG createAppenderRef(ref="rollingFileAppender", level="null", Filter=null)
2017-03-03 21:09:59,651 localhost-startStop-1 DEBUG Building Plugin[name=filter, class=com.acme.backend.service.rest.logging.log4j2.IsPropertySetFilter].
2017-03-03 21:09:59,652 localhost-startStop-1 DEBUG createFilter(sysProperty="pgb.env", envProperty="PGB_ENV", value="null", onMatch="ACCEPT", onMismatch="DENY")
2017-03-03 21:09:59,652 localhost-startStop-1 DEBUG Building Plugin[name=AppenderRef, class=org.apache.logging.log4j.core.config.AppenderRef].
2017-03-03 21:09:59,653 localhost-startStop-1 DEBUG createAppenderRef(ref="asyncSmtpAppender", level="null", IsPropertySetFilter(IsPropertySetFilter))
2017-03-03 21:09:59,653 localhost-startStop-1 DEBUG Building Plugin[name=root, class=org.apache.logging.log4j.core.config.LoggerConfig$RootLogger].
2017-03-03 21:09:59,654 localhost-startStop-1 DEBUG createLogger(additivity="null", level="INFO", includeLocation="null", ={consoleAppender, rollingFileAppender, asyncSmtpAppender}, ={}, Configuration(E:\Coding\workspace\.metadata\.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\acme-web-impl\WEB-INF\classes\log4j2.xml), Filter=null)
2017-03-03 21:09:59,654 localhost-startStop-1 DEBUG Building Plugin[name=loggers, class=org.apache.logging.log4j.core.config.LoggersPlugin].
2017-03-03 21:09:59,656 localhost-startStop-1 DEBUG createLoggers(={com.acme.backend, org.springframework.security, org.springframework.transaction, org.springframework.orm.jpa, org.hibernate.SQL, org.hibernate.type, root})
2017-03-03 21:09:59,656 localhost-startStop-1 DEBUG Configuration XmlConfiguration[location=E:\Coding\workspace\.metadata\.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\acme-web-impl\WEB-INF\classes\log4j2.xml] initialized
2017-03-03 21:09:59,657 localhost-startStop-1 DEBUG Starting configuration XmlConfiguration[location=E:\Coding\workspace\.metadata\.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\acme-web-impl\WEB-INF\classes\log4j2.xml]
2017-03-03 21:09:59,661 localhost-startStop-1 DEBUG Started configuration XmlConfiguration[location=E:\Coding\workspace\.metadata\.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\acme-web-impl\WEB-INF\classes\log4j2.xml] OK.
2017-03-03 21:09:59,662 localhost-startStop-1 TRACE Stopping org.apache.logging.log4j.core.config.DefaultConfiguration@373492e5...
2017-03-03 21:09:59,662 localhost-startStop-1 TRACE DefaultConfiguration notified 1 ReliabilityStrategies that config will be stopped.
2017-03-03 21:09:59,662 localhost-startStop-1 TRACE DefaultConfiguration stopping root LoggerConfig.
2017-03-03 21:09:59,662 localhost-startStop-1 TRACE DefaultConfiguration notifying ReliabilityStrategies that appenders will be stopped.
2017-03-03 21:09:59,663 localhost-startStop-1 TRACE DefaultConfiguration stopping remaining Appenders.
2017-03-03 21:09:59,663 localhost-startStop-1 DEBUG Shutting down OutputStreamManager SYSTEM_OUT.false.false-1
2017-03-03 21:09:59,663 localhost-startStop-1 DEBUG Shut down OutputStreamManager SYSTEM_OUT.false.false-1, all resources released: true
2017-03-03 21:09:59,663 localhost-startStop-1 DEBUG Appender DefaultConsole-1 stopped with status true
2017-03-03 21:09:59,664 localhost-startStop-1 TRACE DefaultConfiguration stopped 1 remaining Appenders.
2017-03-03 21:09:59,664 localhost-startStop-1 TRACE DefaultConfiguration cleaning Appenders from 1 LoggerConfigs.
2017-03-03 21:09:59,664 localhost-startStop-1 DEBUG Stopped org.apache.logging.log4j.core.config.DefaultConfiguration@373492e5 OK
2017-03-03 21:09:59,666 localhost-startStop-1 TRACE Reregistering MBeans after reconfigure. Selector=org.apache.logging.log4j.core.selector.ClassLoaderContextSelector@33d1ef79
2017-03-03 21:09:59,667 localhost-startStop-1 TRACE Reregistering context (1/1): 'Acme Backend' org.apache.logging.log4j.core.LoggerContext@554ad7a7
2017-03-03 21:09:59,667 localhost-startStop-1 TRACE Unregistering but no MBeans found matching 'org.apache.logging.log4j2:type=Acme Backend'
2017-03-03 21:09:59,667 localhost-startStop-1 TRACE Unregistering but no MBeans found matching 'org.apache.logging.log4j2:type=Acme Backend,component=StatusLogger'
2017-03-03 21:09:59,668 localhost-startStop-1 TRACE Unregistering but no MBeans found matching 'org.apache.logging.log4j2:type=Acme Backend,component=ContextSelector'
2017-03-03 21:09:59,668 localhost-startStop-1 TRACE Unregistering but no MBeans found matching 'org.apache.logging.log4j2:type=Acme Backend,component=Loggers,name=*'
2017-03-03 21:09:59,668 localhost-startStop-1 TRACE Unregistering but no MBeans found matching 'org.apache.logging.log4j2:type=Acme Backend,component=Appenders,name=*'
2017-03-03 21:09:59,669 localhost-startStop-1 TRACE Unregistering but no MBeans found matching 'org.apache.logging.log4j2:type=Acme Backend,component=AsyncAppenders,name=*'
2017-03-03 21:09:59,669 localhost-startStop-1 TRACE Unregistering but no MBeans found matching 'org.apache.logging.log4j2:type=Acme Backend,component=AsyncLoggerRingBuffer'
2017-03-03 21:09:59,669 localhost-startStop-1 TRACE Unregistering but no MBeans found matching 'org.apache.logging.log4j2:type=Acme Backend,component=Loggers,name=*,subtype=RingBuffer'
2017-03-03 21:09:59,672 localhost-startStop-1 DEBUG Registering MBean org.apache.logging.log4j2:type=Acme Backend
2017-03-03 21:09:59,675 localhost-startStop-1 DEBUG Registering MBean org.apache.logging.log4j2:type=Acme Backend,component=StatusLogger
2017-03-03 21:09:59,677 localhost-startStop-1 DEBUG Registering MBean org.apache.logging.log4j2:type=Acme Backend,component=ContextSelector
2017-03-03 21:09:59,679 localhost-startStop-1 DEBUG Registering MBean org.apache.logging.log4j2:type=Acme Backend,component=Loggers,name=
2017-03-03 21:09:59,680 localhost-startStop-1 DEBUG Registering MBean org.apache.logging.log4j2:type=Acme Backend,component=Loggers,name=org.hibernate.SQL
2017-03-03 21:09:59,680 localhost-startStop-1 DEBUG Registering MBean org.apache.logging.log4j2:type=Acme Backend,component=Loggers,name=org.springframework.transaction
2017-03-03 21:09:59,681 localhost-startStop-1 DEBUG Registering MBean org.apache.logging.log4j2:type=Acme Backend,component=Loggers,name=org.springframework.security
2017-03-03 21:09:59,681 localhost-startStop-1 DEBUG Registering MBean org.apache.logging.log4j2:type=Acme Backend,component=Loggers,name=com.acme.backend
2017-03-03 21:09:59,681 localhost-startStop-1 DEBUG Registering MBean org.apache.logging.log4j2:type=Acme Backend,component=Loggers,name=org.springframework.orm.jpa
2017-03-03 21:09:59,681 localhost-startStop-1 DEBUG Registering MBean org.apache.logging.log4j2:type=Acme Backend,component=Loggers,name=org.hibernate.type
2017-03-03 21:09:59,684 localhost-startStop-1 DEBUG Registering MBean org.apache.logging.log4j2:type=Acme Backend,component=Appenders,name=smtpAppender
2017-03-03 21:09:59,686 localhost-startStop-1 DEBUG Registering MBean org.apache.logging.log4j2:type=Acme Backend,component=AsyncAppenders,name=asyncSmtpAppender
2017-03-03 21:09:59,686 localhost-startStop-1 DEBUG Registering MBean org.apache.logging.log4j2:type=Acme Backend,component=Appenders,name=rollingFileAppender
2017-03-03 21:09:59,687 localhost-startStop-1 DEBUG Registering MBean org.apache.logging.log4j2:type=Acme Backend,component=Appenders,name=consoleAppender
2017-03-03 21:09:59,690 localhost-startStop-1 TRACE Using default SystemClock for timestamps.
2017-03-03 21:09:59,692 localhost-startStop-1 TRACE Using DummyNanoClock for nanosecond timestamps.
2017-03-03 21:09:59,692 localhost-startStop-1 DEBUG LoggerContext[name=Acme Backend, org.apache.logging.log4j.core.LoggerContext@554ad7a7] started OK with configuration XmlConfiguration[location=E:\Coding\workspace\.metadata\.plugins\org.eclipse.wst.server.core\tmp0\wtpwebapps\acme-web-impl\WEB-INF\classes\log4j2.xml].
...
2017-03-03 21:09:59,746 localhost-startStop-1 DEBUG AsyncLogger.ThreadNameStrategy=CACHED
2017-03-03 21:09:59,746 localhost-startStop-1 TRACE Using default SystemClock for timestamps.
...
2017-03-03 21:10:18,759 localhost-startStop-1 DEBUG Log4jServletContextListener ensuring that Log4j starts up properly.
2017-03-03 21:10:18,762 localhost-startStop-1 DEBUG Log4jServletFilter initialized.
{code}
> Log4j threads are leaking on Tomcat shutdown
> --------------------------------------------
>
> Key: LOG4J2-1259
> URL: https://issues.apache.org/jira/browse/LOG4J2-1259
> Project: Log4j 2
> Issue Type: Bug
> Components: Appenders
> Affects Versions: 2.5
> Reporter: Misagh Moayyed
>
> Running log4j2 v2.5 with disruptor 3.3.x. AsyncLoggers configured. log4j-web also included in the web application deployed in Tomcat 8. The context listener is correctly starting up and shutting down, catalina.properties does not include the log4j*.jar entry. Yet I see:
> {code}
> 20-Jan-2016 14:59:26.322 WARNING [localhost-startStop-2] org.apache.catalina.loader.WebappClassLoaderBase.clearReferencesThreads The web application [cas-server-webapp-4.3.0-SNAPSHOT] appears to have started a thread named [Log4j2-Log4j2Scheduled-5] but has failed to stop it. This is very likely to create a memory leak. Stack trace of thread:
> sun.misc.Unsafe.park(Native Method)
> java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
> java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
> java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
> java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
> java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
> java.lang.Thread.run(Thread.java:745)
> 20-Jan-2016 14:59:26.336 WARNING [localhost-startStop-2] org.apache.catalina.loader.WebappClassLoaderBase.clearReferencesThreads The web application [cas-server-webapp-4.3.0-SNAPSHOT] appears to have started a thread named [Log4j2-AsyncLoggerConfig-6] but has failed to stop it. This is very likely to create a memory leak. Stack trace of thread:
> sun.misc.Unsafe.park(Native Method)
> java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
> java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
> com.lmax.disruptor.BlockingWaitStrategy.waitFor(BlockingWaitStrategy.java:45)
> com.lmax.disruptor.ProcessingSequenceBarrier.waitFor(ProcessingSequenceBarrier.java:56)
> com.lmax.disruptor.BatchEventProcessor.run(BatchEventProcessor.java:124)
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
> java.lang.Thread.run(Thread.java:745)
> {code}
--
This message was sent by Atlassian JIRA
(v6.3.15#6346)
---------------------------------------------------------------------
To unsubscribe, e-mail: log4j-dev-unsubscribe@logging.apache.org
For additional commands, e-mail: log4j-dev-help@logging.apache.org