[prev in list] [next in list] [prev in thread] [next in thread] 

List:       logback-dev
Subject:    [logback-dev] [JIRA] (LOGBACK-1394) TimeBasedRollingPolicy LogbackLock deadlock at 23:59:59
From:       "QOS.CH (JIRA)" <noreply-jira () qos ! ch>
Date:       2018-03-30 9:19:00
Message-ID: JIRA.15221.1522401539000.1455.1522401540293 () Atlassian ! JIRA
[Download RAW message or body]

calonlan created LOGBACK-1394:
---------------------------------

             Summary: TimeBasedRollingPolicy LogbackLock deadlock at 23:59:59
                 Key: LOGBACK-1394
                 URL: https://jira.qos.ch/browse/LOGBACK-1394
             Project: logback
          Issue Type: Bug
    Affects Versions: 1.1.2
         Environment: *JDK:*
java version "1.8.0_162"
Java(TM) SE Runtime Environment (build 1.8.0_162-b12)
Java HotSpot(TM) 64-Bit Server VM (build 25.162-b12, mixed mode)

*logback.xml:*

<configuration scan="true" scanPeriod="180 seconds" debug="true">
    

<appender name="FILE" class="ch.qos.logback.core.rolling.RollingFileAppender">
 <file>../log/test.log</file>
 <rollingPolicy class="ch.qos.logback.core.rolling.TimeBasedRollingPolicy">
 <fileNamePattern>../log/test.%d\{yyyy-MM-dd}.log.zip</fileNamePattern>
 </rollingPolicy>

 <encoder>
 <pattern>%d\{HH:mm:ss.SSS} [%thread] %-5level %logger - %msg%n</pattern>
 </encoder>
</appender>

</configuration>
            Reporter: calonlan
            Assignee: Logback dev list
            Priority: Blocker


*threaddump :*
Found one Java-level deadlock:
=============================

"async-task-thread-pool-1-tid-59197-huoqiu-685270909":
 waiting to lock Monitor@0x00007f140c0282f8 (Object@0x00000000e802a3b0, a \
ch/qos/logback/core/rolling/TimeBasedRollingPolicy),  which is held by \
"async-task-thread-pool-1-tid-59195-huoqiu-685270900" \
"async-task-thread-pool-1-tid-59195-huoqiu-685270900":  waiting to lock \
Monitor@0x00007f13fc061b08 (Object@0x00000000e8035950, a \
ch/qos/logback/core/spi/LogbackLock),  which is held by \
"async-task-thread-pool-1-tid-59197-huoqiu-685270909"

Found a total of 1 deadlock.

Thread 20382: (state = BLOCKED)
 - ch.qos.logback.core.rolling.RollingFileAppender.subAppend(java.lang.Object) \
                @bci=6, line=176 (Compiled frame)
 - ch.qos.logback.core.OutputStreamAppender.append(java.lang.Object) @bci=10, \
                line=103 (Compiled frame)
 - ch.qos.logback.core.UnsynchronizedAppenderBase.doAppend(java.lang.Object) \
                @bci=123, line=88 (Compiled frame)
 - ch.qos.logback.core.spi.AppenderAttachableImpl.appendLoopOnAppenders(java.lang.Object) \
                @bci=33, line=48 (Compiled frame)
 - ch.qos.logback.classic.Logger.appendLoopOnAppenders(ch.qos.logback.classic.spi.ILoggingEvent) \
                @bci=12, line=273 (Compiled frame)
 - ch.qos.logback.classic.Logger.callAppenders(ch.qos.logback.classic.spi.ILoggingEvent) \
                @bci=11, line=260 (Compiled frame)
 - ch.qos.logback.classic.Logger.buildLoggingEventAndAppend(java.lang.String, \
org.slf4j.Marker, ch.qos.logback.classic.Level, java.lang.String, java.lang.Object[], \
                java.lang.Throwable) @bci=27, line=442 (Compiled frame)
 - ch.qos.logback.classic.Logger.filterAndLog_0_Or3Plus(java.lang.String, \
org.slf4j.Marker, ch.qos.logback.classic.Level, java.lang.String, java.lang.Object[], \
                java.lang.Throwable) @bci=57, line=396 (Compiled frame)
 - ch.qos.logback.classic.Logger.info(java.lang.String) @bci=11, line=600 (Compiled \
                frame)
 - com.bj58.spat.gaea.server.contract.log.LogbackLogger.info(java.lang.String) \
                @bci=9, line=101 (Compiled frame)
 - com.bj58.spat.gaea.server.filter.ExecuteTimeFilter.filter(com.bj58.spat.gaea.server.contract.context.GaeaContext) \
                @bci=121, line=72 (Compiled frame)
 - com.bj58.spat.gaea.server.core.proxy.AsyncInvokerHandle$1.run() @bci=203, line=99 \
                (Compiled frame)
 - com.bj58.spat.gaea.server.util.async.AsyncWorker$1.run() @bci=84, line=157 \
                (Compiled frame)
 - java.util.concurrent.ThreadPoolExecutor.runWorker(java.util.concurrent.ThreadPoolExecutor$Worker) \
                @bci=95, line=1149 (Compiled frame)
 - java.util.concurrent.ThreadPoolExecutor$Worker.run() @bci=5, line=624 (Compiled \
                frame)
 - java.lang.Thread.run() @bci=11, line=748 (Compiled frame)


Thread 20380: (state = BLOCKED)
 - ch.qos.logback.core.rolling.RollingFileAppender.subAppend(java.lang.Object) \
                @bci=6, line=176 (Compiled frame)
 - ch.qos.logback.core.OutputStreamAppender.append(java.lang.Object) @bci=10, \
                line=103 (Compiled frame)
 - ch.qos.logback.core.UnsynchronizedAppenderBase.doAppend(java.lang.Object) \
                @bci=123, line=88 (Compiled frame)
 - ch.qos.logback.core.spi.AppenderAttachableImpl.appendLoopOnAppenders(java.lang.Object) \
                @bci=33, line=48 (Compiled frame)
 - ch.qos.logback.classic.Logger.appendLoopOnAppenders(ch.qos.logback.classic.spi.ILoggingEvent) \
                @bci=12, line=273 (Compiled frame)
 - ch.qos.logback.classic.Logger.callAppenders(ch.qos.logback.classic.spi.ILoggingEvent) \
                @bci=11, line=260 (Compiled frame)
 - ch.qos.logback.classic.Logger.buildLoggingEventAndAppend(java.lang.String, \
org.slf4j.Marker, ch.qos.logback.classic.Level, java.lang.String, java.lang.Object[], \
                java.lang.Throwable) @bci=27, line=442 (Compiled frame)
 - ch.qos.logback.classic.Logger.filterAndLog_0_Or3Plus(java.lang.String, \
org.slf4j.Marker, ch.qos.logback.classic.Level, java.lang.String, java.lang.Object[], \
                java.lang.Throwable) @bci=57, line=396 (Compiled frame)
 - ch.qos.logback.classic.Logger.info(java.lang.String) @bci=11, line=600 (Compiled \
                frame)
 - com.bj58.spat.gaea.server.contract.log.LogbackLogger.info(java.lang.String) \
                @bci=9, line=101 (Compiled frame)
 - com.bj58.spat.gaea.server.filter.ExecuteTimeFilter.filter(com.bj58.spat.gaea.server.contract.context.GaeaContext) \
                @bci=121, line=72 (Compiled frame)
 - com.bj58.spat.gaea.server.core.proxy.AsyncInvokerHandle$1.run() @bci=203, line=99 \
                (Compiled frame)
 - com.bj58.spat.gaea.server.util.async.AsyncWorker$1.run() @bci=84, line=157 \
                (Compiled frame)
 - java.util.concurrent.ThreadPoolExecutor.runWorker(java.util.concurrent.ThreadPoolExecutor$Worker) \
                @bci=95, line=1149 (Compiled frame)
 - java.util.concurrent.ThreadPoolExecutor$Worker.run() @bci=5, line=624 (Compiled \
                frame)
 - java.lang.Thread.run() @bci=11, line=748 (Compiled frame)


Thread 20378: (state = BLOCKED)
 - ch.qos.logback.core.rolling.RollingFileAppender.subAppend(java.lang.Object) \
                @bci=6, line=176 (Compiled frame)
 - ch.qos.logback.core.OutputStreamAppender.append(java.lang.Object) @bci=10, \
                line=103 (Compiled frame)
 - ch.qos.logback.core.UnsynchronizedAppenderBase.doAppend(java.lang.Object) \
                @bci=123, line=88 (Compiled frame)
 - ch.qos.logback.core.spi.AppenderAttachableImpl.appendLoopOnAppenders(java.lang.Object) \
                @bci=33, line=48 (Compiled frame)
 - ch.qos.logback.classic.Logger.appendLoopOnAppenders(ch.qos.logback.classic.spi.ILoggingEvent) \
                @bci=12, line=273 (Compiled frame)
 - ch.qos.logback.classic.Logger.callAppenders(ch.qos.logback.classic.spi.ILoggingEvent) \
                @bci=11, line=260 (Compiled frame)
 - ch.qos.logback.classic.Logger.buildLoggingEventAndAppend(java.lang.String, \
org.slf4j.Marker, ch.qos.logback.classic.Level, java.lang.String, java.lang.Object[], \
                java.lang.Throwable) @bci=27, line=442 (Compiled frame)
 - ch.qos.logback.classic.Logger.filterAndLog_0_Or3Plus(java.lang.String, \
org.slf4j.Marker, ch.qos.logback.classic.Level, java.lang.String, java.lang.Object[], \
                java.lang.Throwable) @bci=57, line=396 (Compiled frame)
 - ch.qos.logback.classic.Logger.info(java.lang.String) @bci=11, line=600 (Compiled \
                frame)
 - com.bj58.spat.gaea.server.contract.log.LogbackLogger.info(java.lang.String) \
                @bci=9, line=101 (Compiled frame)
 - com.bj58.spat.gaea.server.filter.ExecuteTimeFilter.filter(com.bj58.spat.gaea.server.contract.context.GaeaContext) \
                @bci=121, line=72 (Compiled frame)
 - com.bj58.spat.gaea.server.core.proxy.AsyncInvokerHandle$1.run() @bci=203, line=99 \
                (Compiled frame)
 - com.bj58.spat.gaea.server.util.async.AsyncWorker$1.run() @bci=84, line=157 \
                (Compiled frame)
 - java.util.concurrent.ThreadPoolExecutor.runWorker(java.util.concurrent.ThreadPoolExecutor$Worker) \
                @bci=95, line=1149 (Compiled frame)
 - java.util.concurrent.ThreadPoolExecutor$Worker.run() @bci=5, line=624 (Compiled \
                frame)
 - java.lang.Thread.run() @bci=11, line=748 (Compiled frame)


Thread 20377: (state = BLOCKED)
 - ch.qos.logback.core.rolling.RollingFileAppender.subAppend(java.lang.Object) \
                @bci=6, line=176 (Compiled frame)
 - ch.qos.logback.core.OutputStreamAppender.append(java.lang.Object) @bci=10, \
                line=103 (Compiled frame)
 - ch.qos.logback.core.UnsynchronizedAppenderBase.doAppend(java.lang.Object) \
                @bci=123, line=88 (Compiled frame)
 - ch.qos.logback.core.spi.AppenderAttachableImpl.appendLoopOnAppenders(java.lang.Object) \
                @bci=33, line=48 (Compiled frame)
 - ch.qos.logback.classic.Logger.appendLoopOnAppenders(ch.qos.logback.classic.spi.ILoggingEvent) \
                @bci=12, line=273 (Compiled frame)
 - ch.qos.logback.classic.Logger.callAppenders(ch.qos.logback.classic.spi.ILoggingEvent) \
                @bci=11, line=260 (Compiled frame)
 - ch.qos.logback.classic.Logger.buildLoggingEventAndAppend(java.lang.String, \
org.slf4j.Marker, ch.qos.logback.classic.Level, java.lang.String, java.lang.Object[], \
                java.lang.Throwable) @bci=27, line=442 (Compiled frame)
 - ch.qos.logback.classic.Logger.filterAndLog_0_Or3Plus(java.lang.String, \
org.slf4j.Marker, ch.qos.logback.classic.Level, java.lang.String, java.lang.Object[], \
                java.lang.Throwable) @bci=57, line=396 (Compiled frame)
 - ch.qos.logback.classic.Logger.info(java.lang.String) @bci=11, line=600 (Compiled \
                frame)
 - com.bj58.spat.gaea.server.contract.log.LogbackLogger.info(java.lang.String) \
                @bci=9, line=101 (Compiled frame)
 - com.bj58.spat.gaea.server.filter.ExecuteTimeFilter.filter(com.bj58.spat.gaea.server.contract.context.GaeaContext) \
                @bci=121, line=72 (Compiled frame)
 - com.bj58.spat.gaea.server.core.proxy.AsyncInvokerHandle$1.run() @bci=203, line=99 \
                (Compiled frame)
 - com.bj58.spat.gaea.server.util.async.AsyncWorker$1.run() @bci=84, line=157 \
                (Compiled frame)
 - java.util.concurrent.ThreadPoolExecutor.runWorker(java.util.concurrent.ThreadPoolExecutor$Worker) \
                @bci=95, line=1149 (Compiled frame)
 - java.util.concurrent.ThreadPoolExecutor$Worker.run() @bci=5, line=624 (Compiled \
                frame)
 - java.lang.Thread.run() @bci=11, line=748 (Compiled frame)



--
This message was sent by Atlassian JIRA
(v7.3.1#73012)
_______________________________________________
logback-dev mailing list
logback-dev@qos.ch
http://mailman.qos.ch/mailman/listinfo/logback-dev


[prev in list] [next in list] [prev in thread] [next in thread] 

Configure | About | News | Add a list | Sponsored by KoreLogic