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 "Anders Kreinøe (JIRA)" <ji...@apache.org> on 2015/06/15 14:07:00 UTC
[jira] [Resolved] (LOG4J2-1054) PatternLayout in Socket appender
writes the stacktrace of an exception to the socket, after it has written
the pattern.
[ https://issues.apache.org/jira/browse/LOG4J2-1054?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel ]
Anders Kreinøe resolved LOG4J2-1054.
------------------------------------
Resolution: Cannot Reproduce
Going to the code, to see if I could create a patch, made me aware of the alwaysWriteExceptions setting of PatternLayout. I do not now how i could overlook that in the documentation. Sorry about that.
> PatternLayout in Socket appender writes the stacktrace of an exception to the socket, after it has written the pattern.
> -----------------------------------------------------------------------------------------------------------------------
>
> Key: LOG4J2-1054
> URL: https://issues.apache.org/jira/browse/LOG4J2-1054
> Project: Log4j 2
> Issue Type: Bug
> Components: Appenders
> Affects Versions: 2.3
> Reporter: Anders Kreinøe
>
> I have the following configuration:
> {code:xml}
> <?xml version="1.0" encoding="UTF-8"?>
> <Configuration status="WARN" monitorInterval="30">
> <Appenders>
> <Console name="Console" target="SYSTEM_OUT">
> <PatternLayout>
> <Pattern>%d %p [%X{userName} - %X{userId} - %X{requestId} - %X{requestName} - %c{2.}] %m%n</Pattern>
> </PatternLayout>
> </Console>
> <Socket name="logstash" host="localhost" protocol="tcp" port="5000" ignoreExceptions="false" connectTimeoutMillis="5000" reconnectionDelayMillis="1000">
> <PatternLayout>
> <Pattern>{"@timestamp":"%d{yyyy-MM-dd'T'HH:mm:ss.SSSZZ}","logger":"%c{1.}","level":"%p","message":"%enc{%m}","exception":"%enc{%ex}","logger_full_name":"%c","mdc_map":"%mdc","uuid":"%u{ramdom}","thread":"%t","application":"logstash-log4j-test","type":"java","sub_type":"log4j"}%n</Pattern>
> </PatternLayout>
> </Socket>
> </Appenders>
> <Loggers>
> <Root level="TRACE">
> <AppenderRef ref="Console"/>
> <AppenderRef ref="logstash"/>
> </Root>
> </Loggers>
> </Configuration>
> {code}
> when i run the following code:
> {code:java}
> package dk.cirque.tmp.logstashLog4jTest;
> import org.slf4j.Logger;
> import org.slf4j.LoggerFactory;
> public class JavaMain {
> public static void main(String[] args) {
> final Logger log = LoggerFactory.getLogger(JavaMain.class);
> log.info("Info log from log4j, 1 - med exception", new RuntimeException("Message of runtime exception for loggin."));
> log.info("Info log from log4j, 2 with newline" + System.lineSeparator() + "this is on a new line.");
> }
> }
> {code}
> i get the following writting to the console:
> {noformat}
> ~/ nc -l 5000
> {"@timestamp":"2015-06-15T12:50:04.370+0200","logger":"d.c.t.l.JavaMain","level":"INFO","message":"Info log from log4j, 1 - med exception","exception":"java.lang.RuntimeException: Message of runtime exception for loggin.\n at dk.cirque.tmp.logstashLog4jTest.JavaMain.main(JavaMain.java:13)\n at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)\n at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)\n at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)\n at java.lang.reflect.Method.invoke(Method.java:606)\n at sbt.Run.invokeMain(Run.scala:67)\n at sbt.Run.run0(Run.scala:61)\n at sbt.Run.sbt$Run$$execute$1(Run.scala:51)\n at sbt.Run$$anonfun$run$1.apply$mcV$sp(Run.scala:55)\n at sbt.Run$$anonfun$run$1.apply(Run.scala:55)\n at sbt.Run$$anonfun$run$1.apply(Run.scala:55)\n at sbt.Logger$$anon$4.apply(Logger.scala:85)\n at sbt.TrapExit$App.run(TrapExit.scala:248)\n at java.lang.Thread.run(Thread.java:745)\n","logger_full_name":"dk.cirque.tmp.logstashLog4jTest.JavaMain","mdc_map":"{}","uuid":"47907581-134c-11e5-b741-5c514f566c15","thread":"run-main-4a","application":"logstash-log4j-test","type":"java","sub_type":"log4j"}
> java.lang.RuntimeException: Message of runtime exception for loggin.
> at dk.cirque.tmp.logstashLog4jTest.JavaMain.main(JavaMain.java:13) [classes/:?]
> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[?:1.7.0_55]
> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) ~[?:1.7.0_55]
> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) ~[?:1.7.0_55]
> at java.lang.reflect.Method.invoke(Method.java:606) ~[?:1.7.0_55]
> at sbt.Run.invokeMain(Run.scala:67) [run-0.13.8.jar:0.13.8]
> at sbt.Run.run0(Run.scala:61) [run-0.13.8.jar:0.13.8]
> at sbt.Run.sbt$Run$$execute$1(Run.scala:51) [run-0.13.8.jar:0.13.8]
> at sbt.Run$$anonfun$run$1.apply$mcV$sp(Run.scala:55) [run-0.13.8.jar:0.13.8]
> at sbt.Run$$anonfun$run$1.apply(Run.scala:55) [run-0.13.8.jar:0.13.8]
> at sbt.Run$$anonfun$run$1.apply(Run.scala:55) [run-0.13.8.jar:0.13.8]
> at sbt.Logger$$anon$4.apply(Logger.scala:85) [logging-0.13.8.jar:0.13.8]
> at sbt.TrapExit$App.run(TrapExit.scala:248) [run-0.13.8.jar:0.13.8]
> at java.lang.Thread.run(Thread.java:745) [?:1.7.0_55]
> {"@timestamp":"2015-06-15T12:50:04.376+0200","logger":"d.c.t.l.JavaMain","level":"INFO","message":"Info log from log4j, 2 with newline\nthis is on a new line.","exception":"","logger_full_name":"dk.cirque.tmp.logstashLog4jTest.JavaMain","mdc_map":"{}","uuid":"47907582-134c-11e5-b741-5c514f566c15","thread":"run-main-4a","application":"logstash-log4j-test","type":"java","sub_type":"log4j"}
> {noformat}
> It has written the following (where only number 1 and 3 was expected):
> # The result of the pattern for the first exception
> # The output of printStacktrace() for the cause exception of the first log statesment.
> # The result of the pattern for the second exception.
--
This message was sent by Atlassian JIRA
(v6.3.4#6332)
---------------------------------------------------------------------
To unsubscribe, e-mail: log4j-dev-unsubscribe@logging.apache.org
For additional commands, e-mail: log4j-dev-help@logging.apache.org