0

将日志记录包装到单独的类中后,我们体验到了性能的提高,这是我们无法完全解释的。

如果有人可以发表评论以帮助我们理解这一点?

这是主线程:

package myapp;

import myapp.logging.Log;

import org.apache.log4j.Logger;

public class ApplicationMain extends Thread {
private static Logger LOG = Logger.getLogger(ApplicationMain.class); 

@Override 
public void run() {
for (int i = 0; i < 50; i++) {
    try {
    Thread.sleep(500);

    //traditional plain log4j
    long startTime = System.nanoTime();
    LOG.info("Hello World Log4j");
    long endTime = System.nanoTime();
    System.out.println(endTime - startTime);

    //logging in wrapper
    long startTime2 = System.nanoTime();
    Log.Info("Hello World Log4J from within wrapper");
    long endTime2 = System.nanoTime();
    System.out.println(endTime2 - startTime2);

    } catch (InterruptedException ex) {
    Log.Info(ex.getMessage());
    }
}
}

}

日志包装类:

package myapp.logging;

import org.apache.log4j.Logger;

public class Log {


private static Logger LOG;

public static synchronized void Info(String LogMessage) {

Throwable throwable = new Throwable();
StackTraceElement[] stackTraceElements = throwable.getStackTrace();
LOG = Logger.getLogger(stackTraceElements[1].getClassName());
LOG.info(LogMessage);
}
}

我们Thread.start()得到以下类型的输出:

2013-01-02 10:42:25,359 INFO   [ApplicationMain] Hello World Log4j

191478

2013-01-02 10:42:25,359 INFO   [ApplicationMain] Hello World Log4J from within wrapper 

163852

2013-01-02 10:42:25,859 INFO   [ApplicationMain] Hello World Log4j 

166165

2013-01-02 10:42:25,859 INFO   [ApplicationMain] Hello World Log4J from within wrapper 

85361

2013-01-02 10:42:26,359 INFO   [ApplicationMain] Hello World Log4j 

188694

2013-01-02 10:42:26,359 INFO   [ApplicationMain] Hello World Log4J from within wrapper

82709

.....

为什么包装器的性能优于直接调用?尽管检索调用者类名称增加了开销?

4

1 回答 1

0

我强烈建议阅读微观基准。这是一个非常有趣的主题,我发现这个问题作为起点很有用:

如何在 Java 中编写正确的微基准测试?

本质上,这不是一个有效的性能衡量标准,因为还有一大堆其他事情需要考虑,主要是围绕编译器优化

于 2013-01-02T08:59:09.957 回答