April 2012 - logback-user - mailman3.qos.ch

Re: [logback-user] Logback suddenly stopped logging
by Andreas Dejung 19 Jun '14

19 Jun '14

I had the same problem and I think I know why J Solaris does interrupt IO blocked thread which then causes the OutputStreamAppender to catch the IOException in line 218 (version 0.9.24). I actually run version 0.9.18 but this part has not change so I guess it will behave the same way. If we look at http://bugs.sun.com/bugdatabase/view_bug.do?bug_id=4385444 InterruptedIOException should not be required by platform specification (sol) And log4j https://issues.apache.org/bugzilla/show_bug.cgi?id=44157 InterruptedIOException ignored by log4j I think it should be solved the same why } catch (InterruptedIOException iioe){ //give the thread a changes to act on interruption and then carry on Thread.currentThread().interrupt(); } catch (IOException ioe) { // as soon as an exception occurs, move to non-started state // and add a single ErrorStatus to the SM. this.started = false; addStatus(new ErrorStatus("IO failure in appender", this, ioe)); } I could not find the jira entry mentioned in this thread therefore I write it here J BTY the jvm option -XX:-UseVMInterruptibleIO does prevent the interruption by solaris but that's only a workaround and not solving the problem ;) Cheers Andy

8 16

(Important) Dynamically change the scan period
by Yihya Hugirat 08 Apr '13

08 Apr '13

hi all, i have migrated to logback to be able to change the log levels dynamically. i'm testing it now with calssfish 3.01 and somehow it is not working when i change the levels in logback.xml there nothing happens. by deploying from netbeans i get the following: |-INFO in ch.qos.logback.classic.turbo.ReconfigureOnChangeFilter@11bfee0 - Will scan for changes in [[C:\Dokumente und Einstellungen\user_Home\Eigene Dateien\NetBeansProjects\WS-LDAP\build\web\WEB-INF\classes\logback.xml]] every 15 seconds. but when i change the levels in this file nothing happens Any help will be appreciated Hugirat -- إِنَّ الَّذِينَ يُحِبُّونَ أَنْ تَشِيعَ الْفَاحِشَةُ فِي الَّذِينَ آمَنُوا لَهُمْ عَذَابٌ أَلِيمٌ فِي الدُّنْيَا وَالآخِرَةِ وَاللَّهُ يَعْلَمُ وَأَنْتُمْ لا تَعْلَمُونَ My public key please use it when you contact me: هذا مفتاحي العام الرجاء أستخدامه عند الإتصال بي: 09BA B710 4B98 ECDA 8C0A 6CB1 2E1E CF88 6A12 F2C3

3 4

Websphere specific JMX configuration?
by Sumanth Donthi 12 Jun '12

12 Jun '12

How can we enable JMX for logback in WebSphere ? Currently do not see ch.qos.logback.classic.jmx.Configurator in jconsole though <jmxConfigurator/> tag exist in logback configuration file. logback 0.9.27 WebSphere 7.0 This is similar to one posted earlier -- http://www.qos.ch/pipermail/logback-user/2010-November/001886.html -Sumanth

4 6

Replacing JUL with logback with Tomcat
by Alex Glass 31 May '12

31 May '12

I have setup logback-access according to the documentation with a LogbackValve and my Tomcat instance is logging requests. However it seems Tomcat is still writing messages to the console using JUL. What is the best way to route these messages to logback? Do I configure Tomcat to use log4j and then try and bridge those messages into logback-classic or is there a less complicated way? In the past I followed these instructions [1] to get Tomcat logging with log4j but would rather just use logback going forward. Thanks, Alex http://mrhaki.blogspot.com/2011/02/configure-log4j-on-tomcat.html

4 9

SyslogAppender stacktrace logging prefix
by Jiri Sitina 30 May '12

30 May '12

Hi, we have recently switched from Log4J to Logback. Logging seems to work well except stack traces in SyslogAppender. They are prefixed just like remaining log messages. Is there any way how to disable this prefix and ensure they will be printed in the same manner like with Log4J SyslogAppender? Current behavior: Apr 02 12:31:08 host.name 2012-04-02T12:31:08.418+0200 ajp-bio-8009-exec-7 com.gooddata.exception.servlet.HttpExceptionTranslator ERROR: Processing client_request=/gdcwebapp/gdc/projects/FoodMartDemo/groups/everyone status=FAILED errorCode=gdc.usergroups.default_group_modification errorDescription="Attempt to modify default group (everyone)" exceptionId=abc37cf0-9c56-4e68-a4a7-2111ca823fd4 component=webapp request_id=cAWvICOaKVFF1VvI userId=1 projectId=FoodMartDemo nodeId=nodeOne nodeId=nodeOne, requestId=cAWvICOaKVFF1VvI, userId=1, projectId=FoodMartDemo Apr 02 12:31:08 host.name #011at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) Apr 02 12:31:08 host.name #011at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) Apr 02 12:31:08 host.name #011at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) Apr 02 12:31:08 host.name #011at java.lang.reflect.Method.invoke(Method.java:601) Apr 02 12:31:08 host.name #011at org.springframework.web.method.support.InvocableHandlerMethod.invoke(InvocableHandlerMethod.java:212) Apr 02 12:31:08 host.name #011at org.springframework.web.method.support.InvocableHandlerMethod.invokeForRequest(InvocableHandlerMethod.java:126) Apr 02 12:31:08 host.name #011at org.springframework.web.servlet.mvc.method.annotation.ServletInvocableHandlerMethod.invokeAndHandle(ServletInvocableHandlerMethod.java:96) Apr 02 12:31:08 host.name #011at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.invokeHandlerMethod(RequestMappingHandlerAdapter.java:617) Apr 02 12:31:08 host.name #011at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.handleInternal(RequestMappingHandlerAdapter.java:578) Apr 02 12:31:08 host.name #011at org.springframework.web.servlet.mvc.method.AbstractHandlerMethodAdapter.handle(AbstractHandlerMethodAdapter.java:80) Apr 02 12:31:08 host.name #011at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:900) Desired behavior: Apr 02 12:31:08 host.name 2012-04-02T12:31:08.418+0200 ajp-bio-8009-exec-7 com.gooddata.exception.servlet.HttpExceptionTranslator ERROR: Processing client_request=/gdcwebapp/gdc/projects/FoodMartDemo/groups/everyone status=FAILED errorCode=gdc.usergroups.default_group_modification errorDescription="Attempt to modify default group (everyone)" exceptionId=abc37cf0-9c56-4e68-a4a7-2111ca823fd4 component=webapp request_id=cAWvICOaKVFF1VvI userId=1 projectId=FoodMartDemo nodeId=nodeOne nodeId=nodeOne, requestId=cAWvICOaKVFF1VvI, userId=1, projectId=FoodMartDemo at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:601) at org.springframework.web.method.support.InvocableHandlerMethod.invoke(InvocableHandlerMethod.java:212) at org.springframework.web.method.support.InvocableHandlerMethod.invokeForRequest(InvocableHandlerMethod.java:126) at org.springframework.web.servlet.mvc.method.annotation.ServletInvocableHandlerMethod.invokeAndHandle(ServletInvocableHandlerMethod.java:96) at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.invokeHandlerMethod(RequestMappingHandlerAdapter.java:617) at org.springframework.web.servlet.mvc.method.annotation.RequestMappingHandlerAdapter.handleInternal(RequestMappingHandlerAdapter.java:578) at org.springframework.web.servlet.mvc.method.AbstractHandlerMethodAdapter.handle(AbstractHandlerMethodAdapter.java:80) at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:900) Current logback.xml for SyslogAppender: <appender name="SYSLOG" class="ch.qos.logback.classic.net.SyslogAppender"> <facility>local2</facility> <syslogHost>localhost</syslogHost> <suffixPattern>%d{yyyy-MM-dd'T'HH:mm:ss.SSSZ} %t %c %p: %m component=webapp request_id=%X{requestId} userId=%X{userId} projectId=%X{projectId} nodeId=%X{nodeId} %X%n</suffixPattern> </appender> Thanks in advance for any advice. Best regards Jiri Sitina -- View this message in context: http://old.nabble.com/SyslogAppender-stacktrace-logging-prefix-tp33555063p3… Sent from the Logback User mailing list archive at Nabble.com.

2 4

Re: [logback-user] syslogappender stacktraces get cut
by Ingebrigt Berg 15 May '12

15 May '12

Hi ! We have looked more into this issue. >From a TCPdump for the traffic between the app (using logback) and the syslog-server we learn that each line in the stacktrace is actually sent as a separate message to syslog (sensitive info replaced with xx/yy/zz): 11:28:37.911604 IP xx localhost.localdomain.55934 > localhost.localdomain.syslog: [bad udp cksum af4f!] SYSLOG, length: 101 Facility local3 (19), Severity error (3) Msg: Mar 30 11:28:37 yy2-31 zz-mce-test 30.03.2012 11:28:37.910 [ERROR] [LogbackTester] []: Fjas\0x0a 11:28:37.912028 IP xx localhost.localdomain.55934 > localhost.localdomain.syslog: [bad udp cksum 6076!] SYSLOG, length: 104 Facility local3 (19), Severity error (3) Msg: Mar 30 11:28:37 yy2-31 \0x09at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) The first packet is a regular log statement, the second one is a line in a stack trace. Notice how 'zz-mce-test 30.03.2012 11:28:37.910 [ERROR] [LogbackTester] []:' is replaced with: '\0x09at' If we interpret this correctly, SyslogAppender will log the error message and each StackTraceElement separately. But for the StackTraceElements it will ignore what we configure in the <SuffixPattern> property: ( <SuffixPattern>%contextName %d{dd.MM.yyyy HH:mm:ss.SSS} [%p] [%c{1}] [%X{ThreadId}]: %m%n</SuffixPattern> ) Instead the stackline messages simply get a '\0x09at' (a TAB) appended in place of the SuffixPattern. This happens in line 89 in ch.qos.logback.classic.net.SyslogAppender: sb.append(prefix).append(CoreConstants.TAB).append(step); Contrast that to line 59 in ch.qos.logback.classic.net.SyslogAppender (normal messages), where the SuffixPattern gets added: fullLayout.setPattern(prefixPattern + suffixPattern); We see two viable solutions: EITHER: when a message is split into a main message and StackTraceElements, the StackTraceElement messages must also get the content of the <SuffixPattern> appended OR: an optional property <StackTraceSuffixPattern> could be added to SyslogAppender, allowing control of what goes into StackTraceElement messages. cheers, Ingebrigt Berg + Marius Eikenes Den 11:40 20. mars 2012 skrev Ingebrigt Berg <ingebrigt(a)jpro.no> følgende: > Hi ! > > We've recently made the switch from Log4j to Logback. We use Syslog to > send logfiles to our logserver, and things generally work. > > But when there are stacktraces in the logs we get in trouble. > SyslogAppender will replace lineshifts with '#011' to make the logentry a > single line. Then it will cut each line that is to long according to the > syslog limit of 2K/line. Only the fist segment will arrive in the correct > log. The remaining segments are not prefixed with everything in the > suffixPattern, and our regexp will not have anything to match. The segment > will end up in a 'trash' log for unmatchable loglines. > > My config for the SyslogAppender looks like this: > > <contextName>company-${CONTEXT_PATH}-${environment}</contextName> > <appender name="LOGSERVER_FILE" > class="ch.qos.logback.classic.net.SyslogAppender"> > <syslogHost>localhost</syslogHost> > <facility>local3</facility> > <SuffixPattern>%contextName %d{dd.MM.yyyy HH:mm:ss.SSS} [%p] > [%c{1}] [%X{ThreadId}]: %m%n</SuffixPattern> > </appender> > > We use the contextName property to control the logfilename. On the > receiving end we read the contextName parameter (using a regexp) for each > log line, and write the line to a file with a corresponding name. > > We had a similar problem when we used Log4J (Where the Tag element was > used in the same manner), and fixed it back then by writing a custom log4j > SyslogAppender. But the main purpose of moving to Logback is to loose all > our home brew logging stuff, we don't want to go down that path again. If > we can't make Logback work out of the box with Syslog we'll probably end up > going back to Log4J. (Another alternative is to replace Syslog with Gelf, > but that's further down the road). > > However, I imagine Logback and Syslog being a common combination, and > surely someone must have this working out of the box. Any advice will be > appreciated. My requirements are simple: > -must work with no custom logging code, only config (preferably xml) > -stacktraces in logs must work > -must be able to fully control the filename on the recieving end. > > cheers, > Ingebrigt Berg >

2 7

SMTPAppender mail not sent (logback 1.0.0, JDK 1.5)
by Louis-Félix 03 May '12

03 May '12

Hi, I upgraded to logback 1.0.0 in a web application (tomcat 5, JDK 1.5), and the ERROR email are not sent anymore from the SMTPAppender. When I rollback my logback-core and logback-classic JARs to version 0.9.30, it's working again. I have a simple config: <appender name="courriel" class="ch.qos.logback.classic.net.SMTPAppender"> <smtpHost>smtp.xxx.xx.xx</smtpHost> <to>xxx(a)xxx.xx.xx</to> <from>no-reply.ti(a)xxx.xx.xx</from> <subject>Test</subject> <cyclicBufferTracker class="ch.qos.logback.core.spi.CyclicBufferTrackerImpl"> <bufferSize>25</bufferSize> </cyclicBufferTracker> <layout class="ch.qos.logback.classic.html.HTMLLayout"> <pattern>%date%level%thread%logger%line%message</pattern> </layout> </appender> I am using logback 1.0.0 with no problem in an other project (with JDK 1.6). Is there any known compatibility problem between logback 1.0.0 and JDK 1.5? Thanks, Louis-Félix

6 10

Release of logback version 1.0.2
by ceki 26 Apr '12

26 Apr '12

Hello all, I am happy to announce the release of logback version 1.0.2. It should hit the Maven central repository within the next 24 hours. Please refer to the news page for precise details of this release. http://logback.qos.ch/news.html You can download logback, including full source code, class files and documentation on our download page, shown below. http://logback.qos.ch/download.html You can receive logback related announcements by subscribing to the QOS.ch announce mailing list. To subscribe to QOS.ch announce list, please visit the following URL. http://www.qos.ch/mailman/listinfo/announce Enjoy, -- Ceki http://twitter.com/#!/ceki

1 0

Force FileAppender embedded in SiftingAppender to stop
by Dario Campagna 24 Apr '12

24 Apr '12

Hi, In an application I am developing I am using a SiftingAppender embedding a FileAppender, defined within a logback configuration file. Each FileAppender manages the logging events generated by a particular process. Each process knows nothing (and should know nothing) about the appenders managing its logging event. I read in the documentation that an appender created by SiftingAppender is automatically closed and discarded if unused for 30 minutes. I would like to stop the FileAppender associated to a process as soon as the process ends its executions, this in order to close the associated file and to avoid having a lot of opened streams. The solution I came up with consists in defining a custom FileAppender (to be embedded in the SiftingAppender) that stops itself upon receiving a logging event with a particular marker, e.g., STOP. What do you think of this solutions? Are there any other (maybe better) possible solutions I should consider? Cheers, Dario

1 0

Is 5 minute file rollover possible?
by Andreas Kruthoff 24 Apr '12

24 Apr '12

Is it possible to configure logback to rollover every 5 minutes, or every 15 minutes? How would I configure this? thanks for any suggestions -andreas This email and any attachment may contain confidential information which is intended for use only by the addressee(s) named above. If you received this email by mistake, please notify the sender immediately, and delete the email from your system. You are prohibited from copying, disseminating or otherwise using the email or any attachment.

1 1