log.debug与e.printStackTrace()多线程下输出顺序异常问题

核心原因 #

这是因为Logback日志和e.printStackTrace()使用了不同的标准输出流，且两者的缓冲区刷新时机不一致：

• Logback的ConsoleAppender默认将日志输出到System.out（标准输出流），且默认配置immediateFlush=true（即时刷新缓冲区）。
• e.printStackTrace()默认将异常堆栈输出到System.err（标准错误流），这是一个独立于System.out的输出流，它的缓冲区刷新策略和System.out不同。

在多线程场景下，第一个log.debug("running...")执行时会触发Logback的初始化流程，此时System.out的缓冲区被即时刷新；后续e.printStackTrace()写入System.err时，System.err的缓冲区可能还未触发自动刷新，而log.debug("continue")又立即写入System.out并刷新，导致控制台中System.out的内容先被显示，System.err的堆栈信息后出现，和代码执行顺序相反。

另外两个无异常场景的本质：

1. 主线程执行：单线程下代码按顺序执行，e.printStackTrace()先写入System.err，再执行log.debug写入System.out，即使是不同流，单线程的写入顺序也保证了控制台显示顺序符合预期。
2. 移除首个log：Logback的初始化被延迟到log.debug("continue")执行时，此时e.printStackTrace()已经完成System.err的写入（甚至触发了缓冲区刷新），所以显示顺序正常。

解决方案 #

方案1：统一输出流（推荐） #

修改Logback配置文件，让ConsoleAppender输出到System.err，和printStackTrace()使用同一个流：

<configuration>
    <appender name="CONSOLE" class="ch.qos.logback.core.ConsoleAppender">
        <!-- 指定输出到System.err -->
        <target>System.err</target>
        <encoder>
            <pattern>%d{HH:mm:ss} [%thread] [%level] %logger - %msg%n</pattern>
        </encoder>
    </appender>
    <root level="debug">
        <appender-ref ref="CONSOLE"/>
    </root>
</configuration>

所有输出走同一个流后，顺序完全由代码执行顺序决定。

方案2：用Logback打印异常（更规范） #

直接替换e.printStackTrace()为Logback的日志方法，让异常信息也通过Logback输出，彻底避免流不一致的问题：

@Slf4j
public class SleepTest {
    public static void main(String[] args) {
        Thread t0 = new Thread(()->{
            log.debug("running...");
            try {
                Thread.sleep(1000);
            } catch (InterruptedException e) {
                // 用Logback打印异常，保留完整堆栈信息
                log.error("线程休眠被中断", e);
            }
            log.debug("continue");
        },"t0");
        t0.start();
        t0.interrupt();
    }
}

这种方式不仅能保证输出顺序，还能统一日志格式，便于后续日志收集和分析。

方案3：手动刷新错误流 #

如果一定要保留e.printStackTrace()，可以在调用后手动刷新System.err的缓冲区：

catch (InterruptedException e) {
    e.printStackTrace();
    // 手动刷新错误流，强制输出缓冲区内容
    System.err.flush();
}

不过这只是临时 workaround，不如前两种方案规范。

内容的提问来源于stack exchange，提问作者CodingCube