Message Title

Maciej Lizewski created an issue

LOGBACK-1212

Issue Type:	Bug
Affects Versions:	1.1.7
Assignee:	Logback dev list
Components:	logback-classic
Created:	07/Oct/16 1:05 PM
Labels:	socket receiver
Priority:	Major
Reporter:	Maciej Lizewski

With configuration like this:

 
                                                    <?xml version="1.0" encoding="UTF-8"?>
<configuration debug="true">
    <appender name="STDOUT" class="ch.qos.logback.core.ConsoleAppender">
        <encoder>
            <Pattern>%d{ISO8601} %-5level %property{HOSTNAME} %property{APP} [%thread] %logger{36} - %msg%n</Pattern>
        </encoder>
    </appender>
    
    <logger name="_3e.pl.HubApp" level="DEBUG" additivity="false">
        <appender-ref ref="STDOUT" />
    </logger>
    
    <root level="info">
        <appender-ref ref="STDOUT" />
    </root>

    <receiver class="ch.qos.logback.classic.net.SocketReceiver">
        <remoteHost>127.0.0.1</remoteHost>
        <port>8888</port>
        <reconnectionDelay>1000</reconnectionDelay>
    </receiver>

    <receiver class="ch.qos.logback.classic.net.SocketReceiver">
        <remoteHost>127.0.0.1</remoteHost>
        <port>8888</port>
        <reconnectionDelay>1000</reconnectionDelay>
    </receiver>
</configuration>
 
                                                

logback is not showing any logs. When I provide only one <receiver> it works as expected. I am using two connection to same test app producing log every 5sec only for PoC, configuration with two different targets does not work as well. Debug output is:

 
                                                    14:58:44,648 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.groovy]
58:44,648 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
58:44,648 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [file:/C:/project/examplesrv/target/classes/logback.xml]
58:44,894 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender]
58:44,909 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [STDOUT]
58:44,941 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
58:45,003 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [_3e.pl.HubApp] to DEBUG
58:45,003 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting additivity of logger [_3e.pl.HubApp] to false
58:45,003 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [STDOUT] to Logger[_3e.pl.HubApp]
58:45,003 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to INFO
58:45,003 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [STDOUT] to Logger[ROOT]
58:45,003 |-INFO in ch.qos.logback.classic.joran.action.ReceiverAction - About to instantiate receiver of type [ch.qos.logback.classic.net.SocketReceiver]
58:45,019 |-INFO in ch.qos.logback.classic.joran.action.ReceiverAction - About to instantiate receiver of type [ch.qos.logback.classic.net.SocketReceiver]
58:45,019 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration.
58:45,034 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@3439f68d - Registering current configuration as safe fallback point
2016-10-07 14:58:45,034 DEBUG 01-00488-201607 null [main] _3e.pl.HubApp - Starting...
 
                                                

last line is from my app. When I provide only one <receiver> I get:

 
                                                    15:02:51,999 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.groovy]
02:51,999 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
02:51,999 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [file:/C:/project/examplesrv/target/classes/logback.xml]
02:52,264 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender]
02:52,264 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [STDOUT]
02:52,280 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
02:52,342 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [_3e.pl.HubApp] to DEBUG
02:52,342 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting additivity of logger [_3e.pl.HubApp] to false
02:52,342 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [STDOUT] to Logger[_3e.pl.HubApp]
02:52,342 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to INFO
02:52,342 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [STDOUT] to Logger[ROOT]
02:52,342 |-INFO in ch.qos.logback.classic.joran.action.ReceiverAction - About to instantiate receiver of type [ch.qos.logback.classic.net.SocketReceiver]
02:52,358 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration.
02:52,374 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@60438a68 - Registering current configuration as safe fallback point
2016-10-07 15:02:52,374 DEBUG 01-00488-201607 null [main] _3e.pl.HubApp - Starting...
02:52,485 |-INFO in ch.qos.logback.classic.net.SocketReceiver@7e9a5fbe - receiver 127.0.0.1:8888: connection established
 
                                                

and then logs from remote app start to appear (notice "connection established INFO")...

Add Comment

This message was sent by Atlassian JIRA