0

我在我的代码中设置了一些秒表调用来测量一些代码块，所有消息都进入我的主日志而不是计时日志。perfStats.log 文件创建得很好，但所有消息都进入根日志，根据我阅读的文档，我认为这不应该发生。我在这里有什么明显的遗漏吗？

perf4j 教程链接

示例代码

import org.apache.log4j.Logger;
import org.perf4j.LoggingStopWatch;
import org.perf4j.StopWatch;

public class PerfLogger {

    /**
     * @param args
     */
    public static void main(String[] args) 
    {
        Logger  logger = Logger.getLogger(PerfLogger.class.getName());

        logger.info("Starting perf log test");

        StopWatch stopWatch = new LoggingStopWatch("test time");

        try {
            Thread.sleep(1000);
        } catch (InterruptedException e) {
            // TODO Auto-generated catch block
            e.printStackTrace();
        }
        stopWatch.stop();

    }

}

示例 log4j.xml 

<log4j:configuration xmlns:log4j='http://jakarta.apache.org/log4j/'>    

    <appender name="STDOUT-DEBUG" class="org.apache.log4j.ConsoleAppender">
        <layout class="org.apache.log4j.PatternLayout">
            <param name="ConversionPattern" value="%d %-5p [%t]%x %M (%F:%L) - %m%n"/>
        </layout>
    </appender>


   <!-- Perf4J appenders -->
    <!--
       This AsyncCoalescingStatisticsAppender groups StopWatch log messages
       into GroupedTimingStatistics messages which it sends on the
       file appender defined below
    -->
    <appender name="CoalescingStatistics"
              class="org.perf4j.log4j.AsyncCoalescingStatisticsAppender">
        <!--
          The TimeSlice option is used to determine the time window for which
          all received StopWatch logs are aggregated to create a single
          GroupedTimingStatistics log. Here we set it to 10 seconds, overriding
          the default of 30000 ms
        -->
        <param name="TimeSlice" value="10000"/>
        <appender-ref ref="fileAppender"/>
    </appender>


    <!-- This file appender is used to output aggregated performance statistics -->
    <appender name="fileAppender" class="org.apache.log4j.FileAppender">
        <param name="File" value="perfStats.log"/>
        <layout class="org.apache.log4j.PatternLayout">
            <param name="ConversionPattern" value="%m%n"/>
        </layout>
    </appender>

    <!-- Loggers -->
    <!--
      The Perf4J logger. Note that org.perf4j.TimingLogger is the value of the
      org.perf4j.StopWatch.DEFAULT_LOGGER_NAME constant. Also, note that
      additivity is set to false, which is usually what is desired - this means
      that timing statements will only be sent to this logger and NOT to
      upstream loggers.
    -->
    <logger name="org.perf4j.TimingLogger" additivity="false">
        <level value="INFO"/>
        <appender-ref ref="CoalescingStatistics"/>
    </logger>

    <root>
        <priority value="info"/>
        <appender-ref ref="STDOUT-DEBUG"/>
    </root>

</log4j:configuration>
4

3 回答 3

1

我检查了 jar 并且 perf4j jar 中没有名为TimingLogger的类，这也可以通过搜索他们的代码存储库在这里看到，这将解释消息不会进入您期望的文件。如果您使用他们在示例中显示的默认LoggingStopWatch类，它看起来唯一会做的就是打印到您可以在此处看到的 std err 。我尝试将代码中的记录器更改为使用他们的 Log4JStopWatch 类，并将 xml 文件中的记录器更改为org.perf4j.log4j.Log4JStopWatch但是消息是标准输出而不是文件，这可能是因为它没有使用我猜的 log4j.xml 中指定的配置。我将尝试跟进维护项目的团队，看看他们是否有更新的示例或错误修复。

于 2010-04-15T15:53:07.567 回答
0

问题是您使用的是 LoggingStopWatch，默认情况下它将所有输出发送到 stderr。您想使用 Log4JStopWatch。LoggingStopWatch 的每个直接子类都是为不同的框架设计的（请参阅http://perf4j.codehaus.org/apidocs/org/perf4j/LoggingStopWatch.html）。

于 2010-04-15T17:25:58.550 回答
0

org.log4j.TimingLogger不是类名，而是 Perf4j 使用的默认记录器名称。如果您使用 Log4j，您应该使用org.perf4j.log4j.Log4JStopWatch类，并且在创建它时不要忘记使用正确的标签，因为统计信息将按此分组。

按照你的例子：

import org.apache.log4j.Logger;
import org.perf4j.LoggingStopWatch;
import org.perf4j.StopWatch;

public class PerfLogger {

    /**
     * @param args
     */
    public static void main(String[] args) 
    {

        StopWatch stopWatch = new LoggingStopWatch("main(..)");

        try {
            Thread.sleep(1000);
        } catch (InterruptedException e) {
            // TODO Auto-generated catch block
            e.printStackTrace();
        }
        stopWatch.stop();

    }
}

使用该实现和相同的配置文件，您将获得如下输出：

Performance Statistics   2012-07-03 22:13:20 - 2012-07-03 22:13:30
Tag                        Avg(ms)         Min         Max   Std Dev       Count
main(..)                   999.0           999         999       0.0           1

希望这能澄清这个问题。

于 2012-07-03T21:19:22.730 回答