[LOG4J2-319] Double stack trace logging when using %throwable in %style and %highlight

• Type: Bug
• Status: Closed
• Priority: Major
• Resolution: Fixed
• Affects Version/s: 2.0-beta8
• Component/s: Layouts

Environment

Apache Maven 3.0.5 (r01de14724cdef164cd33c7c8c2fe155faf9602da; 2013-02-19 08:51:28-0500)
Maven home: C:\Java\apache-maven-3.0.5\bin\..
Java version: 1.7.0_25, vendor: Oracle Corporation
Java home: C:\Program Files\Java\jdk1.7.0_25\jre
Default locale: en_US, platform encoding: Cp1252
OS name: "windows 7", version: "6.1", arch: "amd64", family: "windows"

• Assignee: Gary D. Gregory
• Reporter: Gary D. Gregory
• Created: 20/Jul/13 12:37
• Updated: 28/Aug/14 03:59
• Resolved: 09/Sep/13 16:24

Description

I'm seeing something odd in trunk:

When I run org.apache.logging.log4j.core.appender.ConsoleAppenderAnsiStyleLayoutMain

I see double stack traces:

[30m2013-07-07 02:27:09,904 [m [34m[main] [m [33mFATAL: [m [32mFatal message.
[m [30m2013-07-07 02:27:09,906 [m [34m[main] [m [33mERROR: [m [32mError message.
[m [30m2013-07-07 02:27:09,907 [m [34m[main] [m [33mWARN : [m [32mWarning message.
[m [30m2013-07-07 02:27:09,907 [m [34m[main] [m [33mINFO : [m [32mInformation message.
[m [30m2013-07-07 02:27:09,907 [m [34m[main] [m [33mDEBUG: [m [32mDebug message.
[m [30m2013-07-07 02:27:09,907 [m [34m[main] [m [33mTRACE: [m [32mTrace message.
[m [30m2013-07-07 02:27:09,907 [m [34m[main] [m [33mERROR: [m [32mError message.
java.io.IOException: test
at org.apache.logging.log4j.core.appender.ConsoleAppenderAnsiStyleLayoutMain.main(ConsoleAppenderAnsiStyleLayoutMain.java:44)
[m java.io.IOException: test
at org.apache.logging.log4j.core.appender.ConsoleAppenderAnsiStyleLayoutMain.main(ConsoleAppenderAnsiStyleLayoutMain.java:44) [test-classes/:?]

Note that the last one includes jar provenance.

The patter in /log4j-core/src/test/resources/log4j2-console-style-ansi.xml is:

%style{%d{ISO8601}}

{black}

%style

{[%t]} {blue}

%style

{%-5level:} {yellow}

%style

{%msg%n%throwable} {green}

When I switch the test to use

/log4j-core/src/test/resources/log4j2-console.xml, the output contains a single track trace without jar provenance. The patter there is:

%d

{ISO8601}

[%t] %-5level: %msg%n%throwable

Looks like a bug in pattern/layout parsing?

Issue Links

• is related to: LOG4J2-180 style & highlight patterns altering content behaviour