java - Jboss EAP 6.3 线程与 log4j ConsoleAppender 发生死锁

Question

从 Jboss 5 升级到 Jboss EAP 6.3.0 后，我们发现一个应用程序在运行一段时间后失败。看了一下，接受 HTTP 请求但无法为其提供服务的线程数量开始增加。之后，ThreadDump 向我们展示了 log4j 的死锁:

Found one Java-level deadlock:
=============================
"http-/0.0.0.0:39002-109":
  waiting to lock monitor 0x0000000013d2a218 (object 0x00000000c1cc7aa8, a org.apache.log4j.ConsoleAppender),
  which is held by "http-/0.0.0.0:39002-12"
"http-/0.0.0.0:39002-12":
  waiting to lock monitor 0x000000001456c128 (object 0x00000000c1cca400, a java.io.PrintStream),
  which is held by "http-/0.0.0.0:39002-74"
"http-/0.0.0.0:39002-74":
  waiting to lock monitor 0x0000000013d2a218 (object 0x00000000c1cc7aa8, a org.apache.log4j.ConsoleAppender),
  which is held by "http-/0.0.0.0:39002-12"

与开发团队交谈，应用程序内删除了所有对 log4j 的引用，仅保留standalone.xml 上的配置，以便将某些类记录到某些特定文件，这是有关日志记录的相关配置:

    <periodic-rotating-file-handler name="FILE" autoflush="true">
        <formatter>
            <named-formatter name="PATTERN"/>
        </formatter>
        <file relative-to="jboss.server.log.dir" path="server.log"/>
        <suffix value=".yyyy-MM-dd"/>
        <append value="true"/>
    </periodic-rotating-file-handler>
    <size-rotating-file-handler name="DocumentalServices">
        <file relative-to="jboss.server.log.dir" path="DocumentalServices.log"/>
        <rotate-size value="10m"/>
        <max-backup-index value="5"/>
    </size-rotating-file-handler>
    <size-rotating-file-handler name="DataServices">
        <file relative-to="jboss.server.log.dir" path="DataServices.log"/>
        <rotate-size value="10m"/>
        <max-backup-index value="5"/>
    </size-rotating-file-handler>
    <size-rotating-file-handler name="Audit">
        <file relative-to="jboss.server.log.dir" path="audit.log"/>
        <rotate-size value="10m"/>
        <max-backup-index value="5"/>
    </size-rotating-file-handler>
    <logger category="com.documentation.framework.ws" use-parent-handlers="false">
        <level name="DEBUG"/>
        <handlers>
            <handler name="DocumentalServices"/>
        </handlers>
    </logger>
    <logger category="com.documentation.framework.data" use-parent-handlers="false">
        <level name="DEBUG"/>
        <handlers>
            <handler name="DataServices"/>
        </handlers>
    </logger>
    <logger category="com.documentation.framework.core.audit" use-parent-handlers="false">
        <level name="DEBUG"/>
        <handlers>
            <handler name="Audit"/>
        </handlers>
    </logger>
    <root-logger>
        <level name="INFO"/>
        <handlers>
            <handler name="FILE"/>
        </handlers>
    </root-logger>

ConsoleAppender 上的死锁似乎有点奇怪，考虑到我们没有记录到根记录器内的控制台，只是记录到文件(server.log)。

Answer 1

必须添加 log4j ConsoleAppender。这可能是 Spring ，因为我知道他们做了一些伐木伎俩。在启动过程中，您可以尝试传递 -Dorg.jboss.as.logging.per-deployment=false 如果发现 log4j.xml 或 log4j.properties 文件，这应该会禁用 JBoss EAP 配置 log4j 的尝试.

另一个选项可能是在日志子系统中将 add-logging-api-dependencies 设置为 false。您需要在部署中包含 log4j 库，因为它似乎依赖于它。以下是 CLI 更改默认值的样子。

/subsystem=logging:write-attribute(name=add-logging-api-dependencies,value=false)

请注意，禁用此功能会影响所有部署。

这就是说问题是 log4j ConsoleAppender 的工作方式。它总是直接记录到System.xxx。 JBoss EAP 将 stdout 和 stderr 包装在记录器中，这就是导致死锁的原因。

有一个修复应该以 6.4 结尾在某个时候发布。