为什么（在某些情况下）logback调用toString（）即使日志级别被禁用？

Question

我们最近在系统中遇到了一个性能问题，Logback调用了toString（），尽管指定的日志级别（DEBUG）没有为该特定的日志记录程序启用。当然，现在还有一个额外的问题是我们的toString（）方法非常占用CPU，但logback的行为非常出乎意料。给定以下简单的测试案例，日志级别为mypkg。LogTest2未指定（默认），我看到toString（）调用了两次，但没有打印日志消息（注意：针对logback-经典-0.9.29和logback-核心-0.9.29的链接）。

package mypkg;
import org.slf4j.Logger;
import org.slf4j.LoggerFactory;

public class LogTest2 {
   private static Logger ROOT_LOGGER = LoggerFactory.getLogger(Logger.ROOT_LOGGER_NAME);
   private static Logger CLASS_LOGGER = LoggerFactory.getLogger(LogTest2.class);

   public static void main(String[] args){
      LogTest2 obj = new LogTest2();
   }
   public LogTest2() {
      if (CLASS_LOGGER.isDebugEnabled()) {
         ROOT_LOGGER.info("A CLASS_LOGGER debug guarded ROOT_LOGGER info message: {}", this);
         CLASS_LOGGER.debug("A class logger debug message: {}", this);
      }
   }
   public String toString() {
      System.out.println("================= LogTest2 toString invoked.");
      return "{LogTest2}";
   }
}

上述程序的输出：

================= LogTest2 toString invoked.
================= LogTest2 toString invoked.

为了完整起见，这里是回溯。我正在使用的xml文件：

<?xml version="1.0" encoding="UTF-8"?>
<configuration  scan="true" debug="true">
  <appender name="stdout" class="ch.qos.logback.core.ConsoleAppender">
    <encoder><pattern>%c -> %msg%n</pattern></encoder>
  </appender>

  <!--  
  <logger name="mypkg" level="debug">  <appender-ref ref="stdout" />  </logger>
  -->
</configuration>

如果我更新了上面的日志。要取消对“mypkg”记录器的注释，输出会发生更改，但仍会额外调用toString（）

================= LogTest2 toString invoked.
================= LogTest2 toString invoked.
mypkg.LogTest2 -> A class logger debug message: {LogTest2}

这与我对slf4j和logback日志应该如何工作的理解背道而驰。有人能帮我理解吗？这是错误还是预期的行为（为什么）？

Answer 1

根记录器是在调试级别下创建的。创建子记录器时，其有效日志记录级别设置为其父记录器的有效日志记录级别。另外，isDebugEnabled（）检查记录器（一个int值）的有效记录级别是否为

在没有声明记录器的示例中，它也没有任何附加器。消息已被构造，但没有登录的位置。因此，虽然调试级别确实得到了满足，但它不会记录任何地方。

在较新版本的logback中，日志消息的构造似乎是在检查appender之后完成的。