升级Micronaut 3.8.0后Logback配置与日志级别配置冲突问题

现象描述 #

将Micronaut从3.7.5升级至3.8.0后，Logback的日志配置会在应用启动过程中自动切换：

• 生产环境通过JVM参数-Dlogback.configurationFile=logback-docker.xml指定JSON格式日志，启动初期Hibernate相关日志为JSON格式，但后续日志自动切换为纯文本格式（对应默认的logback.xml配置）
• 切回Micronaut 3.7.5版本后，日志全程保持JSON格式，符合预期

背景信息 #

我们维护两个Logback配置文件：

• logback.xml：配置纯文本日志，用于本地开发
• logback-docker.xml：配置JSON格式日志，用于生产环境，通过JVM参数指定加载

关键触发条件 #

排查确认，仅当application.yml中存在日志级别配置时，才会触发日志配置切换问题：

logger:
  levels:
    org.zalando.logbook: TRACE

移除这段配置后，Micronaut 3.8.0的日志输出恢复正常，且Setting log level 'TRACE' for logger: 'org.zalando.logbook'这条日志也会消失。

问题根源 #

Micronaut 3.8.0新增了通过application.yaml配置Logback文件的功能，现在存在两种配置Logback的方式，两者存在冲突：

1. JVM系统参数方式：java -Dlogback.configurationFile=MY-LOGBACK.XML，该配置在Micronaut的ApplicationContext创建前就生效
2. Micronaut配置方式：在application.yaml中配置：

   logger:
     config: MY-LOGBACK.XML
   

当两种方式配置的Logback文件不一致时，ApplicationContext初始化过程中，Micronaut配置会接管JVM参数的配置，导致日志格式切换。且仅当配置了日志级别时，这个接管逻辑才会被触发。

验证过程 #

复现验证 #

在应用main方法中添加ApplicationContext创建前后的日志：

fun main(args: Array<String>) {
    LOG.info { "BEFORE start of ApplicationContext" }
    val applicationContext = build()
        .args(*args)
        .banner(false)
        .start()
    LOG.info { "AFTER start of ApplicationContext" }
}

application.yaml配置：

logger:
  config: logback.xml
  levels:
    foo: TRACE

用冲突的JVM参数启动应用：

$ java -Dlogback.configurationFile=logback-timestamp-last.xml -jar build/libs/json-logging-0.1-all.jar 
json.logging.Application - BEFORE start of ApplicationContext | at 13:56:51.422
13:56:51.769 i.m.l.PropertiesLoggingLevelsConfigurer - Setting log level 'TRACE' for logger: 'foo'
13:56:51.936 io.micronaut.runtime.Micronaut - Startup completed in 500ms. Server Running: http://localhost:8080
13:56:51.938 json.logging.Application - AFTER start of ApplicationContext

可见在ApplicationContext初始化过程中，日志格式从JVM参数指定的"时间戳后置"切换为application.yaml配置的"时间戳前置"。

反向验证 #

将application.yaml配置改为：

logger:
  config: logback-timestamp-last.xml
  levels:
    foo: TRACE

无JVM参数启动应用，日志格式从默认的"时间戳前置"切换为"时间戳后置"；即使添加JVM参数-Dlogback.configurationFile=logback.xml启动，结果一致。

若注释掉日志级别配置：

logger:
  config: logback-timestamp-last.xml
#  levels:
#    foo: TRACE

则日志格式切换现象完全消失。

解决方案 #

优先方案 #

建议直接通过Micronaut的application.yaml配置Logback文件，不再使用JVM系统参数：

logger:
  config: logback-docker.xml

但此方式不会影响ApplicationContext初始化前的日志输出（如Hibernate的启动日志），会出现启动初期日志格式与后续不一致的情况。

优化建议 #

如果必须使用多个Logback配置文件，需要确保JVM系统参数与对应环境的application.yml中logger.config配置完全一致，避免两者冲突导致日志格式切换。

结论 #

Micronaut 3.8.0新增的通过application.yml配置Logback文件的功能，有以下特点：

• 不会覆盖ApplicationContext初始化前的日志配置（如ORM框架的启动日志）
• 与JVM CLI参数配置存在冲突，必须同步两种配置才能保证日志格式全程一致

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