我正在使用捆绑的 Windows 服务运行器在 Windows 下运行 Tomcat 6。我似乎有以下行为:
- 如果我的一个 Web 应用程序写入标准输出(例如,通过 System.out.println),则此输出会逐字显示在标题为 stdout_xxx.log 的日志中。
- 如果 jvm 本身写入标准输出(就像启用 -XX:+PrintCompilation 一样),则此输出会显示在标题为 jakarta_service_xxx.log 的日志中。
此外, jakarta_service_xxx.log 不是标准输出的直接转储;相反,似乎有些东西正在拦截标准输出并通过 java 日志记录重定向。因此,没有 Tomcat 的 JVM 通常会打印
283 s java.lang.StringBuffer::length (5 bytes)
jakarta_service_xxx.log 中显示的是:
[2010-01-15 17:07:15] [info] 283
[2010-01-15 17:07:15] [info] s
[2010-01-15 17:07:15] [info] java.lang.StringBuffer::
[2010-01-15 17:07:15] [info] l
[2010-01-15 17:07:15] [info] e
[2010-01-15 17:07:15] [info] n
[2010-01-15 17:07:15] [info] g
[2010-01-15 17:07:15] [info] t
[2010-01-15 17:07:15] [info] h
[2010-01-15 17:07:15] [info] (5 bytes)
你能解释一下为什么 stdout 在这两种情况下会受到不同的对待吗?或者,关于如何从 -XX:+PrintCompilation 获取 JVM 输出以显示在 stdout.log 中的任何提示,而不是上述疯狂?
确定没有深入研究 Tomcat 的内容,我认为序列将是这样的。
启动 JVM 的新进程,传递“stdin”、“stdout”和“stderr”文件描述符。这些通常由调用 shell 设置,并通过 fork/exec 系统调用传递给 JVM。(或任何 Windows 等价物......)但在这种情况下,有一些包装脚本或本机应用程序在 JVM 启动之前将“stdout”重定向到“jakarta_service_xxx.log”。
JVM 创建了一些内部日志系统(在本机代码中实现),GC 和其他 JVM 服务将使用这些系统进行 JVM 日志记录。这将使用“stdout”或“stderr”文件描述符。
JVM 创建 PrintStream(OutputStream) 对象,这些对象包装“stdout”和“stderr”文件描述符,并分别设置
java.lang.System.out
和java.lang.System.err
设置这些对象。JVM调用Tomcat
main
方法来启动Tomcat。Tomcat 向“stdout_xxx.log”打开一个新的 FileOutputStream 并用于
java.lang.System.setOut()
更新java.lang.System.out
. 如果每个 webapp 有不同的“stdout_xxx.log”文件,那么很可能 Tomcat 已经实现了一个聪明的输出流代理,它根据线程组或其他东西将输出解复用到不同的日志文件......我怀疑 JVM 日志记录根本没有使用 java.util.Logging ...或任何 Java 代码。看起来就是这样。我这样说是因为我认为如果 JVM 试图在某些时候调用 Java 代码,它会陷入困境;例如在 GC 的关键点。但我可能错了……
至于为什么会发生这种情况,我认为它正在发生,因为将来自 webapps 和 jvm / tomcat 核心的“System.out/err”输出分开通常是一个好主意。可能有配置文件等允许您更改它...如果您愿意。
您通常希望通过 webapp 将日志输出与容器内部消息(例如 JVM 诊断消息)分开。
除了支持各种日志框架外,Tomcat 还捕获 System.out 和 System.err 并将它们重定向到适当的日志文件。
您应该能够在 Tomcat 的配置文件中配置确切的行为和格式(更多关于 Serverfault 的内容......)