Curtis Patrick created LOG4J2-2687:
--------------------------------------
Summary: Log4j2 initialize time consuming 5.5s+
Key: LOG4J2-2687
URL: https://issues.apache.org/jira/browse/LOG4J2-2687
Project: Log4j 2
Issue Type: Improvement
Affects Versions: 2.12.1, 2.12.0, 2.11.1, 2.11.0, 2.10.0
Environment: Mac OSX 10.14.4 / Java 1.8.0_172-b11
VSCode 1.37.1
* Debugger for Java 0.21.0
* Java Test Runner 0.19.0
* Java Extension pack 0.8.0
Reporter: Curtis Patrick
Attachments: SlowLog4j2Startup-2019-09-03.gif
I'm just starting to use log4j2 and added it to a new project with a single
test.
Testing time went from practically instantaneous to nearly 6 seconds.
Is this expected?
The log line immediately before the long delay is:
{code:java}
DEBUG StatusLogger Not in a ServletContext environment, thus not loading
WebLookup plugin.
{code}
Debugging the tests In VSCode adds another 9 seconds (15 total) to initialize
the logger.
I've attached is a gif capture of the test run from a terminal window.
app.java
{code:java}
package patrick.curtis;
import org.apache.logging.log4j.LogManager;
import org.apache.logging.log4j.Logger;
public final class App {
private static Logger log = null;
public void initlogger() {
log = LogManager.getLogger();
}
public void foo() {
log.debug("debug");
log.info("info");
log.warn("warn");
log.error("error");
log.fatal("fatal");
}
}
{code}
apptest.java
{code:java}
package patrick.curtis;
import org.junit.Test;
import java.util.Date;
/**
* Unit test for simple App.
*/
public class AppTest {
/**
* Rigorous Test.
*/
@Test
public void appTest() {
long t = new Date().getTime();
System.out.println(String.format("Initializing app (ms): %d", t));
App app = new App();
t = new Date().getTime() - t;
System.out.println(String.format("...app initialization duration (ms):
%d", t));
t = new Date().getTime();
System.out.println(String.format("Initializing logger (ms): %d", t));
app.initlogger();
t = new Date().getTime() - t;
System.out.println(String.format("...logger initialization duration
(ms): %d", t));
t = new Date().getTime();
System.out.println(String.format("Executing foo() (ms): %d", t));
app.foo();
t = new Date().getTime() - t;
System.out.println(String.format("...foo() execution duration (ms):
%d", t));
}
}
{code}
{code:java}
$ mvn -Dlog4j2.debug test
-------------------------------------------------------
T E S T S
-------------------------------------------------------
Running patrick.curtis.AppTest
Initializing app (ms): 1567533450393
...app initialization duration (ms): 2
Initializing logger (ms): 1567533450395
DEBUG StatusLogger Using ShutdownCallbackRegistry class
org.apache.logging.log4j.core.util.DefaultShutdownCallbackRegistry
DEBUG StatusLogger Not in a ServletContext environment, thus not loading
WebLookup plugin.
DEBUG StatusLogger AsyncLogger.ThreadNameStrategy=CACHED
TRACE StatusLogger Using default SystemClock for timestamps.
DEBUG StatusLogger Not in a ServletContext environment, thus not loading
WebLookup plugin.
DEBUG StatusLogger Took 0.059542 seconds to load 202 plugins from
sun.misc.Launcher$AppClassLoader@4aa298b7
DEBUG StatusLogger PluginManager 'Converter' found 42 plugins
DEBUG StatusLogger Starting OutputStreamManager SYSTEM_OUT.false.false-1
DEBUG StatusLogger Starting LoggerContext[name=4aa298b7,
org.apache.logging.log4j.core.LoggerContext@480bdb19]...
DEBUG StatusLogger Reconfiguration started for context[name=4aa298b7] at URI
null (org.apache.logging.log4j.core.LoggerContext@480bdb19) with optional
ClassLoader: null
DEBUG StatusLogger Not in a ServletContext environment, thus not loading
WebLookup plugin.
DEBUG StatusLogger PluginManager 'ConfigurationFactory' found 4 plugins
DEBUG StatusLogger Not in a ServletContext environment, thus not loading
WebLookup plugin.
DEBUG StatusLogger Not in a ServletContext environment, thus not loading
WebLookup plugin.
DEBUG StatusLogger Missing dependencies for Yaml support, ConfigurationFactory
org.apache.logging.log4j.core.config.yaml.YamlConfigurationFactory is inactive
DEBUG StatusLogger Not in a ServletContext environment, thus not loading
WebLookup plugin.
DEBUG StatusLogger Missing dependencies for Json support, ConfigurationFactory
org.apache.logging.log4j.core.config.json.JsonConfigurationFactory is inactive
DEBUG StatusLogger Not in a ServletContext environment, thus not loading
WebLookup plugin.
DEBUG StatusLogger Using configurationFactory
org.apache.logging.log4j.core.config.ConfigurationFactory$Factory@51e2adc7
TRACE StatusLogger Trying to find [log4j2-test4aa298b7.properties] using
context class loader sun.misc.Launcher$AppClassLoader@4aa298b7.
TRACE StatusLogger Trying to find [log4j2-test4aa298b7.properties] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2-test4aa298b7.properties] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2-test4aa298b7.properties] using
ClassLoader.getSystemResource().
TRACE StatusLogger Trying to find [log4j2-test4aa298b7.yml] using context class
loader sun.misc.Launcher$AppClassLoader@4aa298b7.
TRACE StatusLogger Trying to find [log4j2-test4aa298b7.yml] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2-test4aa298b7.yml] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2-test4aa298b7.yml] using
ClassLoader.getSystemResource().
TRACE StatusLogger Trying to find [log4j2-test4aa298b7.yaml] using context
class loader sun.misc.Launcher$AppClassLoader@4aa298b7.
TRACE StatusLogger Trying to find [log4j2-test4aa298b7.yaml] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2-test4aa298b7.yaml] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2-test4aa298b7.yaml] using
ClassLoader.getSystemResource().
TRACE StatusLogger Trying to find [log4j2-test4aa298b7.json] using context
class loader sun.misc.Launcher$AppClassLoader@4aa298b7.
TRACE StatusLogger Trying to find [log4j2-test4aa298b7.json] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2-test4aa298b7.json] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2-test4aa298b7.json] using
ClassLoader.getSystemResource().
TRACE StatusLogger Trying to find [log4j2-test4aa298b7.jsn] using context class
loader sun.misc.Launcher$AppClassLoader@4aa298b7.
TRACE StatusLogger Trying to find [log4j2-test4aa298b7.jsn] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2-test4aa298b7.jsn] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2-test4aa298b7.jsn] using
ClassLoader.getSystemResource().
TRACE StatusLogger Trying to find [log4j2-test4aa298b7.xml] using context class
loader sun.misc.Launcher$AppClassLoader@4aa298b7.
TRACE StatusLogger Trying to find [log4j2-test4aa298b7.xml] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2-test4aa298b7.xml] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2-test4aa298b7.xml] using
ClassLoader.getSystemResource().
TRACE StatusLogger Trying to find [log4j2-test.properties] using context class
loader sun.misc.Launcher$AppClassLoader@4aa298b7.
TRACE StatusLogger Trying to find [log4j2-test.properties] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2-test.properties] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2-test.properties] using
ClassLoader.getSystemResource().
TRACE StatusLogger Trying to find [log4j2-test.yml] using context class loader
sun.misc.Launcher$AppClassLoader@4aa298b7.
TRACE StatusLogger Trying to find [log4j2-test.yml] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2-test.yml] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2-test.yml] using
ClassLoader.getSystemResource().
TRACE StatusLogger Trying to find [log4j2-test.yaml] using context class loader
sun.misc.Launcher$AppClassLoader@4aa298b7.
TRACE StatusLogger Trying to find [log4j2-test.yaml] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2-test.yaml] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2-test.yaml] using
ClassLoader.getSystemResource().
TRACE StatusLogger Trying to find [log4j2-test.json] using context class loader
sun.misc.Launcher$AppClassLoader@4aa298b7.
TRACE StatusLogger Trying to find [log4j2-test.json] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2-test.json] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2-test.json] using
ClassLoader.getSystemResource().
TRACE StatusLogger Trying to find [log4j2-test.jsn] using context class loader
sun.misc.Launcher$AppClassLoader@4aa298b7.
TRACE StatusLogger Trying to find [log4j2-test.jsn] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2-test.jsn] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2-test.jsn] using
ClassLoader.getSystemResource().
TRACE StatusLogger Trying to find [log4j2-test.xml] using context class loader
sun.misc.Launcher$AppClassLoader@4aa298b7.
TRACE StatusLogger Trying to find [log4j2-test.xml] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2-test.xml] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2-test.xml] using
ClassLoader.getSystemResource().
TRACE StatusLogger Trying to find [log4j24aa298b7.properties] using context
class loader sun.misc.Launcher$AppClassLoader@4aa298b7.
TRACE StatusLogger Trying to find [log4j24aa298b7.properties] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j24aa298b7.properties] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j24aa298b7.properties] using
ClassLoader.getSystemResource().
TRACE StatusLogger Trying to find [log4j24aa298b7.yml] using context class
loader sun.misc.Launcher$AppClassLoader@4aa298b7.
TRACE StatusLogger Trying to find [log4j24aa298b7.yml] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j24aa298b7.yml] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j24aa298b7.yml] using
ClassLoader.getSystemResource().
TRACE StatusLogger Trying to find [log4j24aa298b7.yaml] using context class
loader sun.misc.Launcher$AppClassLoader@4aa298b7.
TRACE StatusLogger Trying to find [log4j24aa298b7.yaml] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j24aa298b7.yaml] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j24aa298b7.yaml] using
ClassLoader.getSystemResource().
TRACE StatusLogger Trying to find [log4j24aa298b7.json] using context class
loader sun.misc.Launcher$AppClassLoader@4aa298b7.
TRACE StatusLogger Trying to find [log4j24aa298b7.json] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j24aa298b7.json] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j24aa298b7.json] using
ClassLoader.getSystemResource().
TRACE StatusLogger Trying to find [log4j24aa298b7.jsn] using context class
loader sun.misc.Launcher$AppClassLoader@4aa298b7.
TRACE StatusLogger Trying to find [log4j24aa298b7.jsn] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j24aa298b7.jsn] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j24aa298b7.jsn] using
ClassLoader.getSystemResource().
TRACE StatusLogger Trying to find [log4j24aa298b7.xml] using context class
loader sun.misc.Launcher$AppClassLoader@4aa298b7.
TRACE StatusLogger Trying to find [log4j24aa298b7.xml] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j24aa298b7.xml] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j24aa298b7.xml] using
ClassLoader.getSystemResource().
TRACE StatusLogger Trying to find [log4j2.properties] using context class
loader sun.misc.Launcher$AppClassLoader@4aa298b7.
TRACE StatusLogger Trying to find [log4j2.properties] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2.properties] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2.properties] using
ClassLoader.getSystemResource().
TRACE StatusLogger Trying to find [log4j2.yml] using context class loader
sun.misc.Launcher$AppClassLoader@4aa298b7.
TRACE StatusLogger Trying to find [log4j2.yml] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2.yml] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2.yml] using
ClassLoader.getSystemResource().
TRACE StatusLogger Trying to find [log4j2.yaml] using context class loader
sun.misc.Launcher$AppClassLoader@4aa298b7.
TRACE StatusLogger Trying to find [log4j2.yaml] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2.yaml] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2.yaml] using
ClassLoader.getSystemResource().
TRACE StatusLogger Trying to find [log4j2.json] using context class loader
sun.misc.Launcher$AppClassLoader@4aa298b7.
TRACE StatusLogger Trying to find [log4j2.json] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2.json] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2.json] using
ClassLoader.getSystemResource().
TRACE StatusLogger Trying to find [log4j2.jsn] using context class loader
sun.misc.Launcher$AppClassLoader@4aa298b7.
TRACE StatusLogger Trying to find [log4j2.jsn] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2.jsn] using
sun.misc.Launcher$AppClassLoader@4aa298b7 class loader.
TRACE StatusLogger Trying to find [log4j2.jsn] using
ClassLoader.getSystemResource().
TRACE StatusLogger Trying to find [log4j2.xml] using context class loader
sun.misc.Launcher$AppClassLoader@4aa298b7.
DEBUG StatusLogger Not in a ServletContext environment, thus not loading
WebLookup plugin.
DEBUG StatusLogger Initializing configuration
XmlConfiguration[location=/Users/cpatrick/working/incubation/unidata-independence/phoenix/log4j2-vscode-very-slow/target/classes/log4j2.xml]
DEBUG StatusLogger Installed 1 script engine
DEBUG StatusLogger Oracle Nashorn version: 1.8.0_172, language: ECMAScript,
threading: Not Thread Safe, compile: true, names: [nashorn, Nashorn, js, JS,
JavaScript, javascript, ECMAScript, ecmascript], factory class:
jdk.nashorn.api.scripting.NashornScriptEngineFactory
DEBUG StatusLogger PluginManager 'Core' found 115 plugins
DEBUG StatusLogger PluginManager 'Level' found 0 plugins
DEBUG StatusLogger Building Plugin[name=property,
class=org.apache.logging.log4j.core.config.Property].
TRACE StatusLogger TypeConverterRegistry initializing.
DEBUG StatusLogger PluginManager 'TypeConverter' found 26 plugins
DEBUG StatusLogger createProperty(name="LOG_PATTERN", value="%d{yyyy-MM-dd
HH:mm:ss.SSS} %5p %X{mdcData} --- %-40.40c{1.} : %m%n%ex")
DEBUG StatusLogger Building Plugin[name=properties,
class=org.apache.logging.log4j.core.config.PropertiesPlugin].
DEBUG StatusLogger configureSubstitutor(={LOG_PATTERN=%d{yyyy-MM-dd
HH:mm:ss.SSS} %5p %X{mdcData} --- %-40.40c{1.} : %m%n%ex},
Configuration(/Users/cpatrick/working/incubation/unidata-independence/phoenix/log4j2-vscode-very-slow/target/classes/log4j2.xml))
DEBUG StatusLogger PluginManager 'Lookup' found 13 plugins
DEBUG StatusLogger Building Plugin[name=layout,
class=org.apache.logging.log4j.core.layout.PatternLayout].
DEBUG StatusLogger PatternLayout$Builder(pattern="%d{HH:mm:ss.SSS} [%t]
%-5level %logger{36} - %msg%n", PatternSelector=null,
Configuration(/Users/cpatrick/working/incubation/unidata-independence/phoenix/log4j2-vscode-very-slow/target/classes/log4j2.xml),
Replace=null, charset="null", alwaysWriteExceptions="null",
disableAnsi="null", noConsoleNoAnsi="null", header="null", footer="null")
DEBUG StatusLogger PluginManager 'Converter' found 42 plugins
DEBUG StatusLogger Building Plugin[name=appender,
class=org.apache.logging.log4j.core.appender.ConsoleAppender].
DEBUG StatusLogger ConsoleAppender$Builder(target="SYSTEM_OUT", follow="null",
direct="null", bufferedIo="null", bufferSize="null", immediateFlush="null",
ignoreExceptions="null", PatternLayout(%d{HH:mm:ss.SSS} [%t] %-5level
%logger{36} - %msg%n), name="LogToConsole",
Configuration(/Users/cpatrick/working/incubation/unidata-independence/phoenix/log4j2-vscode-very-slow/target/classes/log4j2.xml),
Filter=null)
DEBUG StatusLogger Starting OutputStreamManager SYSTEM_OUT.false.false
DEBUG StatusLogger Building Plugin[name=appenders,
class=org.apache.logging.log4j.core.config.AppendersPlugin].
DEBUG StatusLogger createAppenders(={LogToConsole})
DEBUG StatusLogger Building Plugin[name=AppenderRef,
class=org.apache.logging.log4j.core.config.AppenderRef].
DEBUG StatusLogger createAppenderRef(ref="LogToConsole", level="null",
Filter=null)
DEBUG StatusLogger Building Plugin[name=root,
class=org.apache.logging.log4j.core.config.LoggerConfig$RootLogger].
DEBUG StatusLogger createLogger(additivity="null", level="TRACE",
includeLocation="null", ={LogToConsole}, ={},
Configuration(/Users/cpatrick/working/incubation/unidata-independence/phoenix/log4j2-vscode-very-slow/target/classes/log4j2.xml),
Filter=null)
DEBUG StatusLogger Building Plugin[name=loggers,
class=org.apache.logging.log4j.core.config.LoggersPlugin].
DEBUG StatusLogger createLoggers(={root})
DEBUG StatusLogger Configuration
XmlConfiguration[location=/Users/cpatrick/working/incubation/unidata-independence/phoenix/log4j2-vscode-very-slow/target/classes/log4j2.xml]
initialized
DEBUG StatusLogger Starting configuration
XmlConfiguration[location=/Users/cpatrick/working/incubation/unidata-independence/phoenix/log4j2-vscode-very-slow/target/classes/log4j2.xml]
DEBUG StatusLogger Started configuration
XmlConfiguration[location=/Users/cpatrick/working/incubation/unidata-independence/phoenix/log4j2-vscode-very-slow/target/classes/log4j2.xml]
OK.
TRACE StatusLogger Stopping
org.apache.logging.log4j.core.config.DefaultConfiguration@2133c8f8...
TRACE StatusLogger DefaultConfiguration notified 1 ReliabilityStrategies that
config will be stopped.
TRACE StatusLogger DefaultConfiguration stopping root LoggerConfig.
TRACE StatusLogger DefaultConfiguration notifying ReliabilityStrategies that
appenders will be stopped.
TRACE StatusLogger DefaultConfiguration stopping remaining Appenders.
DEBUG StatusLogger Shutting down OutputStreamManager SYSTEM_OUT.false.false-1
DEBUG StatusLogger Shut down OutputStreamManager SYSTEM_OUT.false.false-1, all
resources released: true
DEBUG StatusLogger Appender DefaultConsole-1 stopped with status true
TRACE StatusLogger DefaultConfiguration stopped 1 remaining Appenders.
TRACE StatusLogger DefaultConfiguration cleaning Appenders from 1 LoggerConfigs.
DEBUG StatusLogger Stopped
org.apache.logging.log4j.core.config.DefaultConfiguration@2133c8f8 OK
TRACE StatusLogger Reregistering MBeans after reconfigure.
Selector=org.apache.logging.log4j.core.selector.ClassLoaderContextSelector@f79e
TRACE StatusLogger Reregistering context (1/1): '4aa298b7'
org.apache.logging.log4j.core.LoggerContext@480bdb19
TRACE StatusLogger Unregistering but no MBeans found matching
'org.apache.logging.log4j2:type=4aa298b7'
TRACE StatusLogger Unregistering but no MBeans found matching
'org.apache.logging.log4j2:type=4aa298b7,component=StatusLogger'
TRACE StatusLogger Unregistering but no MBeans found matching
'org.apache.logging.log4j2:type=4aa298b7,component=ContextSelector'
TRACE StatusLogger Unregistering but no MBeans found matching
'org.apache.logging.log4j2:type=4aa298b7,component=Loggers,name=*'
TRACE StatusLogger Unregistering but no MBeans found matching
'org.apache.logging.log4j2:type=4aa298b7,component=Appenders,name=*'
TRACE StatusLogger Unregistering but no MBeans found matching
'org.apache.logging.log4j2:type=4aa298b7,component=AsyncAppenders,name=*'
TRACE StatusLogger Unregistering but no MBeans found matching
'org.apache.logging.log4j2:type=4aa298b7,component=AsyncLoggerRingBuffer'
TRACE StatusLogger Unregistering but no MBeans found matching
'org.apache.logging.log4j2:type=4aa298b7,component=Loggers,name=*,subtype=RingBuffer'
DEBUG StatusLogger Registering MBean org.apache.logging.log4j2:type=4aa298b7
DEBUG StatusLogger Registering MBean
org.apache.logging.log4j2:type=4aa298b7,component=StatusLogger
DEBUG StatusLogger Registering MBean
org.apache.logging.log4j2:type=4aa298b7,component=ContextSelector
DEBUG StatusLogger Registering MBean
org.apache.logging.log4j2:type=4aa298b7,component=Loggers,name=
DEBUG StatusLogger Registering MBean
org.apache.logging.log4j2:type=4aa298b7,component=Appenders,name=LogToConsole
TRACE StatusLogger Using default SystemClock for timestamps.
TRACE StatusLogger Using DummyNanoClock for nanosecond timestamps.
DEBUG StatusLogger Reconfiguration complete for context[name=4aa298b7] at URI
/Users/cpatrick/working/incubation/unidata-independence/phoenix/log4j2-vscode-very-slow/target/classes/log4j2.xml
(org.apache.logging.log4j.core.LoggerContext@480bdb19) with optional
ClassLoader: null
DEBUG StatusLogger Shutdown hook enabled. Registering a new one.
DEBUG StatusLogger LoggerContext[name=4aa298b7,
org.apache.logging.log4j.core.LoggerContext@480bdb19] started OK.
...logger initialization duration (ms): 5609
Executing foo() (ms): 1567533456004
12:57:36.005 [main] DEBUG patrick.curtis.App - debug
12:57:36.008 [main] INFO patrick.curtis.App - info
12:57:36.008 [main] WARN patrick.curtis.App - warn
12:57:36.008 [main] ERROR patrick.curtis.App - error
12:57:36.008 [main] FATAL patrick.curtis.App - fatal
...foo() execution duration (ms): 4
Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 5.657 sec
DEBUG StatusLogger Stopping LoggerContext[name=4aa298b7,
org.apache.logging.log4j.core.LoggerContext@480bdb19]
DEBUG StatusLogger Stopping LoggerContext[name=4aa298b7,
org.apache.logging.log4j.core.LoggerContext@480bdb19]...
TRACE StatusLogger Unregistering 1 MBeans:
[org.apache.logging.log4j2:type=4aa298b7]
TRACE StatusLogger Unregistering 1 MBeans:
[org.apache.logging.log4j2:type=4aa298b7,component=StatusLogger]
TRACE StatusLogger Unregistering 1 MBeans:
[org.apache.logging.log4j2:type=4aa298b7,component=ContextSelector]
TRACE StatusLogger Unregistering 1 MBeans:
[org.apache.logging.log4j2:type=4aa298b7,component=Loggers,name=]
TRACE StatusLogger Unregistering 1 MBeans:
[org.apache.logging.log4j2:type=4aa298b7,component=Appenders,name=LogToConsole]
TRACE StatusLogger Unregistering but no MBeans found matching
'org.apache.logging.log4j2:type=4aa298b7,component=AsyncAppenders,name=*'
TRACE StatusLogger Unregistering but no MBeans found matching
'org.apache.logging.log4j2:type=4aa298b7,component=AsyncLoggerRingBuffer'
TRACE StatusLogger Unregistering but no MBeans found matching
'org.apache.logging.log4j2:type=4aa298b7,component=Loggers,name=*,subtype=RingBuffer'
TRACE StatusLogger Stopping
XmlConfiguration[location=/Users/cpatrick/working/incubation/unidata-independence/phoenix/log4j2-vscode-very-slow/target/classes/log4j2.xml]...
TRACE StatusLogger XmlConfiguration notified 2 ReliabilityStrategies that
config will be stopped.
TRACE StatusLogger XmlConfiguration stopping 1 LoggerConfigs.
TRACE StatusLogger XmlConfiguration stopping root LoggerConfig.
TRACE StatusLogger XmlConfiguration notifying ReliabilityStrategies that
appenders will be stopped.
TRACE StatusLogger XmlConfiguration stopping remaining Appenders.
DEBUG StatusLogger Shutting down OutputStreamManager SYSTEM_OUT.false.false
DEBUG StatusLogger Shut down OutputStreamManager SYSTEM_OUT.false.false, all
resources released: true
DEBUG StatusLogger Appender LogToConsole stopped with status true
TRACE StatusLogger XmlConfiguration stopped 1 remaining Appenders.
TRACE StatusLogger XmlConfiguration cleaning Appenders from 2 LoggerConfigs.
DEBUG StatusLogger Stopped
XmlConfiguration[location=/Users/cpatrick/working/incubation/unidata-independence/phoenix/log4j2-vscode-very-slow/target/classes/log4j2.xml]
OK
DEBUG StatusLogger Stopped LoggerContext[name=4aa298b7,
org.apache.logging.log4j.core.LoggerContext@480bdb19] with status trueResults
:Tests run: 1, Failures: 0, Errors: 0, Skipped: 0[INFO]
------------------------------------------------------------------------
[INFO] BUILD SUCCESS
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 6.920 s
[INFO] Finished at: 2019-09-03T12:57:36-05:00
[INFO] ------------------------------------------------------------------------
{code}
--
This message was sent by Atlassian Jira
(v8.3.2#803003)
