log4j 与 logback 性能对比

于 2011-08-02 10:49:00 发布 · 111 阅读 · 0
文章标签：

#java #数据库

本文通过实验对比分析了 Log4j、Logback 在不同并发模式下的日志记录性能，包括直接调用、测试调用和参数化调用，以及使用 JDBC C3P0、Socket 和 Jdbc 测试等场景。同时，通过 Java 代码实现了日志性能测试，并提供了详细的数据分析。
代码来自 : logback performance clarification
机器配置
Win XP SP3
双核 Intel(R) Core(TM)2 Duo CPU E7400 @ 2.80GHz
2GB内存
结果:
引用

###################### loop 10w #########################
Log4j direct debug call: 250
Log4j direct warn call: 44381
Log4j tested (isDebugEnabled) debug call: 17
###############################################
###################### loop 100w # perfiles 500KB 2000files#########################
Log4j direct debug call: 250
Log4j direct warn call: 45664
Log4j tested (isDebugEnabled) debug call: 13
###############################################
######################## loop 100w # perfiles 500KB 2000files#######################
Log4j direct debug call: 239
Log4j direct warn call: 62462
Log4j tested (isDebugEnabled) debug call: 13
###############################################
################### loop 1000000 # perfiles 10MB 2000files############################
Log4j direct debug call: 236
Log4j direct warn call: 44482
Log4j tested (isDebugEnabled) debug call: 13
###############################################
################### loop 1000000 # perfiles 100MB 2000files############################
Log4j direct debug call: 240
Log4j direct warn call: 44305
Log4j tested (isDebugEnabled) debug call: 13
###############################################
################### loop 1000000 # perfiles 200MB 2000files############################
Log4j direct debug call: 236
Log4j direct warn call: 45445
Log4j tested (isDebugEnabled) debug call: 13
###############################################

########################### 异步模式 ########################################
################### loop 100000 #ASYNC 10线程 500KB 2000files############################
Log4j direct debug call: 938
Log4j direct warn call: 623017
Log4j tested (isDebugEnabled) debug call: 12
###############################################
################### loop 100000 #ASYNC 10线程 500KB 2000files############################
Log4j direct debug call: 989
Log4j direct warn call: 636342
Log4j tested (isDebugEnabled) debug call: 12
###############################################
################### loop 100000 #ASYNC 10线程 10MB 2000files############################
Log4j direct debug call: 954
Log4j direct warn call: 498409
Log4j tested (isDebugEnabled) debug call: 12
###############################################
################### loop 100000 #ASYNC 10线程 100MB 2000files############################
Log4j direct debug call: 961
Log4j direct warn call: 517658
Log4j tested (isDebugEnabled) debug call: 12
###############################################
################### loop 100000 #ASYNC 10线程 200MB 2000files############################
Log4j direct debug call: 994
Log4j direct warn call: 521485
Log4j tested (isDebugEnabled) debug call: 11
###############################################



##################### loop 10w ##########################
Logback direct debug call: 224
Logback direct warn call: 10649
Logback tested (isDebugEnabled) debug call: 16
Logback tested (isWarnEnabled) warn call: 10754
Logback parametrized debug call: 25
Logback parametrized warn call: 11544
###############################################
###############################################
Logback direct debug call: 205
Logback direct warn call: 10634
Logback tested (isDebugEnabled) debug call: 12
Logback tested (isWarnEnabled) warn call: 10886
Logback parametrized debug call: 20
Logback parametrized warn call: 11521
###############################################
################## loop 1000000 # perfiles 500KB and zip#############################
Logback direct debug call: 214
Logback direct warn call: 22342
Logback tested (isDebugEnabled) debug call: 11
Logback tested (isWarnEnabled) warn call: 11079
Logback parametrized debug call: 22
Logback parametrized warn call: 11959
###############################################
################## loop 1000000 # perfiles 500KB and zip#############################
Logback direct debug call: 203
Logback direct warn call: 10297
Logback tested (isDebugEnabled) debug call: 11
Logback tested (isWarnEnabled) warn call: 10585
Logback parametrized debug call: 20
Logback parametrized warn call: 10884
###############################################
################## loop 1000000 # perfiles 200MB and zip#############################
Logback direct debug call: 206
Logback direct warn call: 8472
Logback tested (isDebugEnabled) debug call: 12
Logback tested (isWarnEnabled) warn call: 8600
Logback parametrized debug call: 21
Logback parametrized warn call: 8707
###############################################
################## loop 1000000 # perfiles 100MB and zip#############################
Logback direct debug call: 395
Logback direct warn call: 40629
Logback tested (isDebugEnabled) debug call: 11
Logback tested (isWarnEnabled) warn call: 40417
Logback parametrized debug call: 20
Logback parametrized warn call: 40687
Count Times(ms) : 122156
###############################################
################## loop 1000000 # perfiles 100MB and zip#############################
Logback direct debug call: 236
Logback direct warn call: 8489
Logback tested (isDebugEnabled) debug call: 11
Logback tested (isWarnEnabled) warn call: 8535
Logback parametrized debug call: 21
Logback parametrized warn call: 9042
###############################################
################## loop 1000000 # perfiles 50MB and zip#############################
Logback direct debug call: 217
Logback direct warn call: 8508
Logback tested (isDebugEnabled) debug call: 11
Logback tested (isWarnEnabled) warn call: 8695
Logback parametrized debug call: 20
Logback parametrized warn call: 8757
###############################################
################## loop 1000000 # perfiles 10MB and zip#############################
Logback direct debug call: 208
Logback direct warn call: 8499
Logback tested (isDebugEnabled) debug call: 12
Logback tested (isWarnEnabled) warn call: 8578
Logback parametrized debug call: 22
Logback parametrized warn call: 8741
###############################################
################## loop 100000 # jdbc(c3p0) #############################
Logback direct debug call: 355
Logback direct warn call: 3937399
Logback tested (isDebugEnabled) debug call: 27
Logback tested (isWarnEnabled) warn call: 4040561
Logback parametrized debug call: 40
Logback parametrized warn call: 4004411
###############################################
################## loop 2000000 # 1 Main Thread 100MB #per LogSize 286 Byte#############################
Logback direct debug call: 406
Logback direct warn call: 40168
Logback tested (isDebugEnabled) debug call: 11
Logback tested (isWarnEnabled) warn call: 40212
Logback parametrized debug call: 20
Logback parametrized warn call: 40562
Count Times(ms) : 242765
###############################################
################## loop 1000000 # 1 Main Thread 100MB #per LogSize 286 Byte#############################
Logback direct debug call: 389
Logback direct warn call: 39958
Logback tested (isDebugEnabled) debug call: 11
Logback tested (isWarnEnabled) warn call: 40440
Logback parametrized debug call: 20
Logback parametrized warn call: 40335
Count Times(ms) : 121156
###############################################
################## loop 1000000 # socket 1 client 1 Main Thread 100MB #per LogSize 286 Byte#############################
Logback direct debug call: 401
Logback direct warn call: 117924
Logback tested (isDebugEnabled) debug call: 11
Logback tested (isWarnEnabled) warn call: 118562
Logback parametrized debug call: 19
Logback parametrized warn call: 128202
Count Times(ms) : 365110
###############################################
################## loop 100000 # socket 1 client 1 Main Thread 100MB #per LogSize 286 Byte#############################
Logback direct debug call: 148301
Logback direct warn call: 152806
Logback tested (isDebugEnabled) debug call: 150971
Logback tested (isWarnEnabled) warn call: 141062
Logback parametrized debug call: 158658
Logback parametrized warn call: 153140
Count Times(ms) : 90500
###############################################
################## loop 1000000 # socket 1 client 1 Main Thread 100MB #per LogSize 286 Byte#############################
Logback direct debug call: 388
Logback direct warn call: 144331
Logback tested (isDebugEnabled) debug call: 10
Logback tested (isWarnEnabled) warn call: 96334
Logback parametrized debug call: 20
Logback parametrized warn call: 92826
Count Times(ms) : 333907
###############################################
################## loop 1000000 # socket 1 client 1 Main Thread 100MB #per LogSize 286 Byte#############################
Logback direct debug call: 392
Logback direct warn call: 166776
Logback tested (isDebugEnabled) debug call: 11
Logback tested (isWarnEnabled) warn call: 216869
Logback parametrized debug call: 141
Logback parametrized warn call: 156749
Count Times(ms) : 540969
###############################################


################## loop 100000 # 10thread 20queueSize 500KB and zip #per LogSize 286 Byte#############################
Logback direct debug call: 885
Logback direct warn call: 451863
Logback tested (isDebugEnabled) debug call: 9
Logback tested (isWarnEnabled) warn call: 451750
Logback parametrized debug call: 21
Logback parametrized warn call: 449805
###############################################
################## loop 100000 # 10 Thread 20 QueueSize 10MB and zip #per LogSize 286 Byte#############################
Logback direct debug call: 918
Logback direct warn call: 450027
Logback tested (isDebugEnabled) debug call: 9
Logback tested (isWarnEnabled) warn call: 452299
Logback parametrized debug call: 22
Logback parametrized warn call: 437268
###############################################
################## loop 100000 # 10 Thread 20 QueueSize 100MB and zip #per LogSize 286 Byte#############################
Logback direct debug call: 808
Logback direct warn call: 445219
Logback tested (isDebugEnabled) debug call: 10
Logback tested (isWarnEnabled) warn call: 449316
Logback parametrized debug call: 20
Logback parametrized warn call: 431124
###############################################
################## loop 100000 # 10 Thread 20 QueueSize 200MB and zip #per LogSize 286 Byte#############################
Logback direct debug call: 851
Logback direct warn call: 445867
Logback tested (isDebugEnabled) debug call: 10
Logback tested (isWarnEnabled) warn call: 450838
Logback parametrized debug call: 21
Logback parametrized warn call: 440028
###############################################
################## loop 100000 # 50 Thread 50 QueueSize 100MB and zip #per LogSize 286 Byte#############################
Logback direct debug call: 8719
Logback direct warn call: 2358846
Logback tested (isDebugEnabled) debug call: 10
Logback tested (isWarnEnabled) warn call: 2346821
Logback parametrized debug call: 20
Logback parametrized warn call: 2329942
###############################################
################## loop 100000 # 4 Thread 20 QueueSize 100MB and zip #per LogSize 286 Byte#############################
Logback direct debug call: 1299
Logback direct warn call: 195412
Logback tested (isDebugEnabled) debug call: 14
Logback tested (isWarnEnabled) warn call: 194969
Logback parametrized debug call: 24
Logback parametrized warn call: 192029
###############################################
################## loop 100000 # 3 Thread 20 QueueSize 100MB and zip #per LogSize 286 Byte#############################
Logback direct debug call: 915
Logback direct warn call: 145027
Logback tested (isDebugEnabled) debug call: 11
Logback tested (isWarnEnabled) warn call: 140793
Logback parametrized debug call: 21
Logback parametrized warn call: 143145
###############################################
################## loop 100000 # 2 Thread 20 QueueSize 100MB and zip #per LogSize 286 Byte#############################
Logback direct debug call: 961
Logback direct warn call: 95941
Logback tested (isDebugEnabled) debug call: 10
Logback tested (isWarnEnabled) warn call: 96473
Logback parametrized debug call: 20
Logback parametrized warn call: 96345
###############################################
################## loop 100000 # 1 Thread 20 QueueSize 100MB and zip #per LogSize 286 Byte#############################
Logback direct debug call: 414
Logback direct warn call: 44408
Logback tested (isDebugEnabled) debug call: 9
Logback tested (isWarnEnabled) warn call: 44709
Logback parametrized debug call: 18
Logback parametrized warn call: 45287
###############################################
################## loop 100000 # 1 Thread 20 QueueSize 100MB #per LogSize 286 Byte#############################
Logback direct debug call: 403
Logback direct warn call: 43233
Logback tested (isDebugEnabled) debug call: 10
Logback tested (isWarnEnabled) warn call: 43490
Logback parametrized debug call: 19
Logback parametrized warn call: 43935
Count Times(ms) : 270000
###############################################
################## loop 100000 # 1 Thread 20 QueueSize 100MB #per LogSize 286 Byte#############################
Logback direct debug call: 410
Logback direct warn call: 43172
Logback tested (isDebugEnabled) debug call: 9
Logback tested (isWarnEnabled) warn call: 43314
Logback parametrized debug call: 19
Logback parametrized warn call: 43751
Count Times(ms) : 283812
###############################################
################## loop 100000 # 2 Thread 20 QueueSize 100MB #per LogSize 286 Byte#############################
Logback direct debug call: 511
Logback direct warn call: 92970
Logback tested (isDebugEnabled) debug call: 12
Logback tested (isWarnEnabled) warn call: 90352
Logback parametrized debug call: 20
Logback parametrized warn call: 92044
Count Times(ms) : 304656
###############################################
################## loop 100000 # 3 Thread 20 QueueSize 100MB #per LogSize 286 Byte#############################
Logback direct debug call: 619
Logback direct warn call: 136300
Logback tested (isDebugEnabled) debug call: 10
Logback tested (isWarnEnabled) warn call: 146003
Logback parametrized debug call: 20
Logback parametrized warn call: 109449
Count Times(ms) : 294078
###############################################
################## loop 100000 # 4 Thread 20 QueueSize 100MB #per LogSize 286 Byte#############################
Logback direct debug call: 702
Logback direct warn call: 171259
Logback tested (isDebugEnabled) debug call: 11
Logback tested (isWarnEnabled) warn call: 178437
Logback parametrized debug call: 21
Logback parametrized warn call: 187121
Count Times(ms) : 293609
###############################################


log4j测试代码
Java代码 复制代码 收藏代码
  1. /**
  2. *$Id$
  3. */
  4. packageperfTest.ch.qos.logback;
  6. importorg.apache.log4j.Logger;
  7. importorg.apache.log4j.xml.DOMConfigurator;
  9. /**
  10. *@authorLastchangedby:$Author$
  11. *@version$Revision$$Date$
  12. */
  13. publicclassPerformanceLog4j{
  14. staticLoggerlog4jlogger=Logger.getLogger(PerformanceLog4j.class);
  16. //Howmanytimesshouldwetrytolog:
  17. staticintloop=1000000;
  19. publicstaticvoidmain(String[]args)throwsInterruptedException{
  20. initConfig();
  22. //Let'srunonceforJustInTimecompiler
  23. log4jDirectDebugCall();
  24. log4jDirectWarnCall();
  25. log4jTestedDebugCall();
  27. //let'srunthetestsanddisplaytheresults:
  28. longresult1=log4jDirectDebugCall();
  29. longresult2=log4jDirectWarnCall();
  30. longresult3=log4jTestedDebugCall();
  32. System.out.println("###################loop"+loop+"############################");
  33. System.out.println("Log4jdirectdebugcall:"+result1);
  34. System.out.println("Log4jdirectwarncall:"+result2);
  35. System.out.println("Log4jtested(isDebugEnabled)debugcall:"+result3);
  36. System.out.println("###############################################");
  37. }
  39. privatestaticlonglog4jDirectDebugCall(){
  40. Integerj=newInteger(1);
  41. longstart=System.nanoTime();
  42. for(inti=0;i<loop;i++){
  43. log4jlogger.debug("SEEIFTHISISLOGGEDlog4jDirectDebugCall()"+j+".");
  44. }
  45. return(System.nanoTime()-start)/loop;
  46. }
  48. privatestaticlonglog4jDirectWarnCall(){
  49. Integerj=newInteger(2);
  50. longstart=System.nanoTime();
  51. for(inti=0;i<loop;i++){
  52. log4jlogger.warn("SEEIFTHISISLOGGEDlog4jDirectWarnCall()"+j+".");
  53. }
  54. return(System.nanoTime()-start)/loop;
  55. }
  57. privatestaticlonglog4jTestedDebugCall(){
  58. Integerj=newInteger(3);
  59. longstart=System.nanoTime();
  60. for(inti=0;i<loop;i++){
  61. if(log4jlogger.isDebugEnabled()){
  62. log4jlogger.debug("SEEIFTHISISLOGGEDlog4jTestedDebugCall()"+j+".");
  63. }
  64. }
  65. return(System.nanoTime()-start)/loop;
  66. }
  68. privatestaticvoidinitConfig(){
  69. DOMConfigurator.configure("src/main/resource/log4j.xml");
  71. //createtheloggers
  72. org.apache.log4j.Logger.getLogger("perfTest");
  73. org.apache.log4j.Logger.getLogger("perfTest.ch");
  74. org.apache.log4j.Logger.getLogger("perfTest.ch.qos");
  75. org.apache.log4j.Logger.getLogger("perfTest.ch.qos.logback");
  76. }
  77. }
/** * $Id$ */ package perfTest.ch.qos.logback; import org.apache.log4j.Logger; import org.apache.log4j.xml.DOMConfigurator; /** * @author Last changed by: $Author$ * @version $Revision$ $Date$ */ public class PerformanceLog4j { static Logger log4jlogger = Logger.getLogger(PerformanceLog4j.class); // How many times should we try to log: static int loop = 1000000; public static void main(String[] args) throws InterruptedException { initConfig(); // Let's run once for Just In Time compiler log4jDirectDebugCall(); log4jDirectWarnCall(); log4jTestedDebugCall(); // let's run the tests and display the results: long result1 = log4jDirectDebugCall(); long result2 = log4jDirectWarnCall(); long result3 = log4jTestedDebugCall(); System.out.println("################### loop " + loop + " ############################"); System.out.println("Log4j direct debug call: " + result1); System.out.println("Log4j direct warn call: " + result2); System.out.println("Log4j tested (isDebugEnabled) debug call: " + result3); System.out.println("###############################################"); } private static long log4jDirectDebugCall() { Integer j = new Integer(1); long start = System.nanoTime(); for (int i = 0; i < loop; i++) { log4jlogger.debug("SEE IF THIS IS LOGGED log4jDirectDebugCall() " + j + "."); } return (System.nanoTime() - start) / loop; } private static long log4jDirectWarnCall() { Integer j = new Integer(2); long start = System.nanoTime(); for (int i = 0; i < loop; i++) { log4jlogger.warn("SEE IF THIS IS LOGGED log4jDirectWarnCall()" + j + "."); } return (System.nanoTime() - start) / loop; } private static long log4jTestedDebugCall() { Integer j = new Integer(3); long start = System.nanoTime(); for (int i = 0; i < loop; i++) { if (log4jlogger.isDebugEnabled()) { log4jlogger.debug("SEE IF THIS IS LOGGED log4jTestedDebugCall() " + j + "."); } } return (System.nanoTime() - start) / loop; } private static void initConfig() { DOMConfigurator.configure("src/main/resource/log4j.xml"); // create the loggers org.apache.log4j.Logger.getLogger("perfTest"); org.apache.log4j.Logger.getLogger("perfTest.ch"); org.apache.log4j.Logger.getLogger("perfTest.ch.qos"); org.apache.log4j.Logger.getLogger("perfTest.ch.qos.logback"); } }
Xml代码 复制代码 收藏代码
  1. <?xmlversion="1.0"encoding="UTF-8"?>
  2. <!DOCTYPElog4j:configurationSYSTEM"log4j.dtd">
  4. <log4j:configurationxmlns:log4j='http://jakarta.apache.org/log4j/'>
  6. <!--<appendername="ASYNC"class="org.apache.log4j.AsyncAppender">-->
  7. <!--<appender-refref="STDOUT"/>-->
  8. <!--</appender>-->
  10. <appendername="STDOUT"class="org.apache.log4j.ConsoleAppender">
  11. <layoutclass="org.apache.log4j.PatternLayout">
  12. <paramname="ConversionPattern"value="%d(%t)[%24F:%-3L:%-5p]%x%m%n"/>
  13. </layout>
  14. </appender>
  16. <appendername="FILE"class="org.apache.log4j.RollingFileAppender">
  17. <paramname="File"value="logs/log4j-test.log"/>
  18. <paramname="BufferSize"value="8129"/>
  19. <paramname="Append"value="true"/>
  20. <paramname="MaxFileSize"value="200MB"/>
  21. <paramname="MaxBackupIndex"value="2000"/>
  22. <layoutclass="org.apache.log4j.PatternLayout">
  23. <paramname="ConversionPattern"value="%d(%t)[%24F:%-3L:%-5p]%x%m%n"/>
  24. </layout>
  25. </appender>
  28. <root>
  29. <priorityvalue="INFO"/>
  30. <!--<appender-refref="STDOUT"/>-->
  31. <appender-refref="FILE"/>
  32. </root>
  34. </log4j:configuration>
<?xml version="1.0" encoding="UTF-8"?> <!DOCTYPE log4j:configuration SYSTEM "log4j.dtd"> <log4j:configuration xmlns:log4j='http://jakarta.apache.org/log4j/'> <!-- <appender name="ASYNC" class="org.apache.log4j.AsyncAppender">--> <!-- <appender-ref ref="STDOUT" />--> <!-- </appender>--> <appender name="STDOUT" class="org.apache.log4j.ConsoleAppender"> <layout class="org.apache.log4j.PatternLayout"> <param name="ConversionPattern" value="%d (%t) [%24F:%-3L:%-5p]%x %m%n" /> </layout> </appender> <appender name="FILE" class="org.apache.log4j.RollingFileAppender"> <param name="File" value="logs/log4j-test.log" /> <param name="BufferSize" value="8129" /> <param name="Append" value="true" /> <param name="MaxFileSize" value="200MB"/> <param name="MaxBackupIndex" value="2000"/> <layout class="org.apache.log4j.PatternLayout"> <param name="ConversionPattern" value="%d (%t) [%24F:%-3L:%-5p]%x %m%n" /> </layout> </appender> <root> <priority value="INFO" /> <!-- <appender-ref ref="STDOUT" />--> <appender-ref ref="FILE"/> </root> </log4j:configuration>

logback测试代码
Java代码 复制代码 收藏代码
  1. /**
  2. *$Id$
  3. */
  4. packageperfTest.ch.qos.logback;
  6. importorg.slf4j.Logger;
  7. importorg.slf4j.LoggerFactory;
  9. importch.qos.logback.classic.LoggerContext;
  10. importch.qos.logback.classic.joran.JoranConfigurator;
  11. importch.qos.logback.core.joran.spi.JoranException;
  12. importch.qos.logback.core.util.StatusPrinter;
  14. /**
  15. *@authorLastchangedby:$Author$
  16. *@version$Revision$$Date$
  17. */
  18. publicclassPerformanceLogback{
  19. staticLoggerlogbacklogger=LoggerFactory.getLogger(PerformanceLogback.class);
  21. //Howmanytimesshouldwetrytolog:
  22. staticintloop=1000000;
  24. publicstaticvoidmain(String[]args)throwsInterruptedException{
  25. //initConfig();
  27. //Let'srunonceforJustInTimecompiler
  28. logbackDirectDebugCall();
  29. logbackDirectWarnCall();
  30. logbackTestedDebugCall();
  31. logbackTestedWarnCall();
  32. logbackParametrizedDebugCall();
  33. logbackParametrizedWarnCall();
  35. //let'srunthetestsanddisplaytheresults:
  36. longresult4=logbackDirectDebugCall();
  37. longresult5=logbackDirectWarnCall();
  38. longresult6=logbackTestedDebugCall();
  39. longresult7=logbackTestedWarnCall();
  40. longresult8=logbackParametrizedDebugCall();
  41. longresult9=logbackParametrizedWarnCall();
  43. System.out.println("##################loop"+loop+"#############################");
  44. System.out.println("Logbackdirectdebugcall:"+result4);
  45. System.out.println("Logbackdirectwarncall:"+result5);
  46. System.out.println("Logbacktested(isDebugEnabled)debugcall:"+result6);
  47. System.out.println("Logbacktested(isWarnEnabled)warncall:"+result7);
  48. System.out.println("Logbackparametrizeddebugcall:"+result8);
  49. System.out.println("Logbackparametrizedwarncall:"+result9);
  50. System.out.println("###############################################");
  51. }
  53. privatestaticlonglogbackDirectDebugCall(){
  54. Integerj=newInteger(5);
  55. longstart=System.nanoTime();
  56. for(inti=0;i<loop;i++){
  57. logbacklogger.debug("SEEIFTHISISLOGGED"+j+".");
  58. }
  59. return(System.nanoTime()-start)/loop;
  60. }
  62. privatestaticlonglogbackDirectWarnCall(){
  63. Integerj=newInteger(6);
  64. longstart=System.nanoTime();
  65. for(inti=0;i<loop;i++){
  66. logbacklogger.warn("SEEIFTHISISLOGGEDlogbackDirectWarnCall()"+j+".");
  67. }
  68. return(System.nanoTime()-start)/loop;
  69. }
  71. privatestaticlonglogbackTestedDebugCall(){
  72. Integerj=newInteger(7);
  73. longstart=System.nanoTime();
  74. for(inti=0;i<loop;i++){
  75. if(logbacklogger.isDebugEnabled())
  76. logbacklogger.debug("SEEIFTHISISLOGGED"+j+".");
  77. }
  78. return(System.nanoTime()-start)/loop;
  79. }
  81. privatestaticlonglogbackTestedWarnCall(){
  82. Integerj=newInteger(8);
  83. longstart=System.nanoTime();
  84. for(inti=0;i<loop;i++){
  85. if(logbacklogger.isWarnEnabled())
  86. logbacklogger.warn("SEEIFTHISISLOGGEDlogbackTestedWarnCall()"+j+".");
  87. }
  88. longend=System.nanoTime();
  89. longresult=(end-start)/loop;
  90. System.out.println("start="+start+"end="+end+"result="+result);
  91. returnresult;
  92. }
  94. privatestaticlonglogbackParametrizedDebugCall(){
  95. Integerj=newInteger(9);
  96. longstart=System.nanoTime();
  97. for(inti=0;i<loop;i++){
  98. logbacklogger.debug("SEEIFTHISISLOGGED{}.",j);
  99. }
  100. return(System.nanoTime()-start)/loop;
  101. }
  103. privatestaticlonglogbackParametrizedWarnCall(){
  104. Integerj=newInteger(10);
  105. longstart=System.nanoTime();
  106. for(inti=0;i<loop;i++){
  107. logbacklogger.warn("SEEIFTHISISLOGGEDlogbackParametrizedWarnCall(){}.",j);
  108. }
  109. longend=System.nanoTime();
  110. longresult=(end-start)/loop;
  111. System.out.println("start="+start+"end="+end+"result="+result);
  112. returnresult;
  113. }
  115. privatestaticvoidinitConfig(){
  116. //assumeSLF4Jisboundtologbackinthecurrentenvironment
  117. LoggerContextlc=(LoggerContext)LoggerFactory.getILoggerFactory();
  119. try{
  120. JoranConfiguratorconfigurator=newJoranConfigurator();
  121. configurator.setContext(lc);
  122. //thecontextwasprobablyalreadyconfiguredbydefaultconfiguration
  123. //rules
  124. lc.reset();
  125. configurator.doConfigure("src/main/resource/logback.xml");
  126. }catch(JoranExceptionje){
  127. //StatusPrinterwillhandlethis
  128. }
  129. StatusPrinter.printInCaseOfErrorsOrWarnings(lc);
  131. //createtheloggers
  132. LoggerFactory.getLogger("perfTest");
  133. LoggerFactory.getLogger("perfTest.ch");
  134. LoggerFactory.getLogger("perfTest.ch.qos");
  135. LoggerFactory.getLogger("perfTest.ch.qos.logback");
  136. }
  137. }
/** * $Id$ */ package perfTest.ch.qos.logback; import org.slf4j.Logger; import org.slf4j.LoggerFactory; import ch.qos.logback.classic.LoggerContext; import ch.qos.logback.classic.joran.JoranConfigurator; import ch.qos.logback.core.joran.spi.JoranException; import ch.qos.logback.core.util.StatusPrinter; /** * @author Last changed by: $Author$ * @version $Revision$ $Date$ */ public class PerformanceLogback { static Logger logbacklogger = LoggerFactory.getLogger(PerformanceLogback.class); // How many times should we try to log: static int loop = 1000000; public static void main(String[] args) throws InterruptedException { // initConfig(); // Let's run once for Just In Time compiler logbackDirectDebugCall(); logbackDirectWarnCall(); logbackTestedDebugCall(); logbackTestedWarnCall(); logbackParametrizedDebugCall(); logbackParametrizedWarnCall(); // let's run the tests and display the results: long result4 = logbackDirectDebugCall(); long result5 = logbackDirectWarnCall(); long result6 = logbackTestedDebugCall(); long result7 = logbackTestedWarnCall(); long result8 = logbackParametrizedDebugCall(); long result9 = logbackParametrizedWarnCall(); System.out.println("################## loop " + loop + " #############################"); System.out.println("Logback direct debug call: " + result4); System.out.println("Logback direct warn call: " + result5); System.out.println("Logback tested (isDebugEnabled) debug call: " + result6); System.out.println("Logback tested (isWarnEnabled) warn call: " + result7); System.out.println("Logback parametrized debug call: " + result8); System.out.println("Logback parametrized warn call: " + result9); System.out.println("###############################################"); } private static long logbackDirectDebugCall() { Integer j = new Integer(5); long start = System.nanoTime(); for (int i = 0; i < loop; i++) { logbacklogger.debug("SEE IF THIS IS LOGGED " + j + "."); } return (System.nanoTime() - start) / loop; } private static long logbackDirectWarnCall() { Integer j = new Integer(6); long start = System.nanoTime(); for (int i = 0; i < loop; i++) { logbacklogger.warn("SEE IF THIS IS LOGGED logbackDirectWarnCall()" + j + "."); } return (System.nanoTime() - start) / loop; } private static long logbackTestedDebugCall() { Integer j = new Integer(7); long start = System.nanoTime(); for (int i = 0; i < loop; i++) { if (logbacklogger.isDebugEnabled()) logbacklogger.debug("SEE IF THIS IS LOGGED " + j + "."); } return (System.nanoTime() - start) / loop; } private static long logbackTestedWarnCall() { Integer j = new Integer(8); long start = System.nanoTime(); for (int i = 0; i < loop; i++) { if (logbacklogger.isWarnEnabled()) logbacklogger.warn("SEE IF THIS IS LOGGED logbackTestedWarnCall()" + j + "."); } long end = System.nanoTime(); long result = (end - start) / loop; System.out.println("start = " + start + "end = " + end + "result = " + result); return result; } private static long logbackParametrizedDebugCall() { Integer j = new Integer(9); long start = System.nanoTime(); for (int i = 0; i < loop; i++) { logbacklogger.debug("SEE IF THIS IS LOGGED {}.", j); } return (System.nanoTime() - start) / loop; } private static long logbackParametrizedWarnCall() { Integer j = new Integer(10); long start = System.nanoTime(); for (int i = 0; i < loop; i++) { logbacklogger.warn("SEE IF THIS IS LOGGED logbackParametrizedWarnCall() {}.", j); } long end = System.nanoTime(); long result = (end - start) / loop; System.out.println("start = " + start + "end = " + end + "result = " + result); return result; } private static void initConfig() { // assume SLF4J is bound to logback in the current environment LoggerContext lc = (LoggerContext) LoggerFactory.getILoggerFactory(); try { JoranConfigurator configurator = new JoranConfigurator(); configurator.setContext(lc); // the context was probably already configured by default configuration // rules lc.reset(); configurator.doConfigure("src/main/resource/logback.xml"); } catch (JoranException je) { // StatusPrinter will handle this } StatusPrinter.printInCaseOfErrorsOrWarnings(lc); // create the loggers LoggerFactory.getLogger("perfTest"); LoggerFactory.getLogger("perfTest.ch"); LoggerFactory.getLogger("perfTest.ch.qos"); LoggerFactory.getLogger("perfTest.ch.qos.logback"); } }
Xml代码 复制代码 收藏代码
  1. <?xmlversion="1.0"encoding="UTF-8"?>
  2. <configuration>
  3. <propertyfile="src/main/resource/jdbc.properties"/>
  5. <appendername="DB"class="ch.qos.logback.classic.db.DBAppender">
  6. <connectionSourceclass="ch.qos.logback.core.db.DataSourceConnectionSource">
  7. <dataSourceclass="com.mchange.v2.c3p0.ComboPooledDataSource">
  8. <driverClass>${jdbc.driver.class}</driverClass>
  9. <jdbcUrl>${jdbc.url}</jdbcUrl>
  10. <!--<serverName>${serverName}</serverName>-->
  11. <!--<databaseName>${databaseName}</databaseName>-->
  12. <user>${jdbc.username}</user>
  13. <password>${jdbc.password}</password>
  14. <paramname="minPoolSize"value="30"/>
  15. <paramname="maxPoolSize"value="60"/>
  16. <paramname="initialPoolSize"value="30"/>
  17. <paramname="acquireIncrement"value="3"/>
  18. <paramname="acquireRetryAttempts"value="30"/>
  19. <paramname="acquireRetryDelay"value="1000"/>
  20. <paramname="autoCommitOnClose"value="false"/>
  21. <paramname="breakAfterAcquireFailure"value="false"/>
  22. <paramname="checkoutTimeout"value="0"/>
  23. <paramname="maxIdleTime"value="60"/>
  24. <paramname="maxStatements"value="100"/>
  25. </dataSource>
  27. </connectionSource>
  28. </appender>
  29. <appendername="FILE"class="ch.qos.logback.core.rolling.RollingFileAppender">
  30. <file>logs/logback-test.log</file>
  31. <rollingPolicyclass="ch.qos.logback.core.rolling.TimeBasedRollingPolicy">
  32. <!--rolloverdaily-->
  33. <fileNamePattern>logs/logback-%d{yyyy-MM-dd}.%i.zip</fileNamePattern>
  34. <timeBasedFileNamingAndTriggeringPolicyclass="ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP">
  35. <!--orwheneverthefilesizereaches100MB-->
  36. <maxFileSize>10MB</maxFileSize>
  37. </timeBasedFileNamingAndTriggeringPolicy>
  38. </rollingPolicy>
  39. <encoder>
  40. <pattern>%date{ISO8601}[%thread][%24file:%M:%-3line:%-5level]-%msg%n</pattern>
  41. </encoder>
  42. </appender>
  44. <rootlevel="INFO">
  45. <!--<appender-refref="DB"/>-->
  46. <appender-refref="FILE"/>
  47. </root>
  48. </configuration>
<?xml version="1.0" encoding="UTF-8" ?> <configuration> <property file="src/main/resource/jdbc.properties" /> <appender name="DB" class="ch.qos.logback.classic.db.DBAppender"> <connectionSource class="ch.qos.logback.core.db.DataSourceConnectionSource"> <dataSource class="com.mchange.v2.c3p0.ComboPooledDataSource"> <driverClass>${jdbc.driver.class}</driverClass> <jdbcUrl>${jdbc.url}</jdbcUrl> <!-- <serverName>${serverName}</serverName>--> <!-- <databaseName>${databaseName}</databaseName>--> <user>${jdbc.username}</user> <password>${jdbc.password}</password> <param name="minPoolSize" value="30" /> <param name="maxPoolSize" value="60" /> <param name="initialPoolSize" value="30" /> <param name="acquireIncrement" value="3" /> <param name="acquireRetryAttempts" value="30" /> <param name="acquireRetryDelay" value="1000" /> <param name="autoCommitOnClose" value="false" /> <param name="breakAfterAcquireFailure" value="false" /> <param name="checkoutTimeout" value="0" /> <param name="maxIdleTime" value="60" /> <param name="maxStatements" value="100" /> </dataSource> </connectionSource> </appender> <appender name="FILE" class="ch.qos.logback.core.rolling.RollingFileAppender"> <file>logs/logback-test.log</file> <rollingPolicy class="ch.qos.logback.core.rolling.TimeBasedRollingPolicy"> <!-- rollover daily --> <fileNamePattern>logs/logback-%d{yyyy-MM-dd}.%i.zip</fileNamePattern> <timeBasedFileNamingAndTriggeringPolicy class="ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP"> <!-- or whenever the file size reaches 100MB --> <maxFileSize>10MB</maxFileSize> </timeBasedFileNamingAndTriggeringPolicy> </rollingPolicy> <encoder> <pattern>%date{ISO8601} [%thread] [%24file:%M:%-3line:%-5level] - %msg%n</pattern> </encoder> </appender> <root level="INFO"> <!-- <appender-ref ref="DB" />--> <appender-ref ref="FILE" /> </root> </configuration>
jdbc.properties
Properties代码 复制代码 收藏代码
  1. #mysqlconfig
  2. jdbc.driver.class=com.mysql.jdbc.Driver
  3. jdbc.url=jdbc:mysql://localhost/logs?autoReconnect=true&useUnicode=true&characterEncoding=utf8
  4. jdbc.username=root
  5. jdbc.password=root
# mysql config jdbc.driver.class=com.mysql.jdbc.Driver jdbc.url=jdbc:mysql://localhost/logs?autoReconnect=true&useUnicode=true&characterEncoding=utf8 jdbc.username=root jdbc.password=root

10线程模式
Java代码 复制代码 收藏代码
  1. /**
  2. *$Id$
  3. */
  4. packageperfTest.ch.qos.logback;
  6. importjava.util.concurrent.ConcurrentHashMap;
  7. importjava.util.concurrent.ConcurrentMap;
  8. importjava.util.concurrent.ExecutorService;
  9. importjava.util.concurrent.Executors;
  11. importorg.apache.log4j.Logger;
  12. importorg.apache.log4j.xml.DOMConfigurator;
  14. /**
  15. *@authorLastchangedby:$Author$
  16. *@version$Revision$$Date$
  17. */
  18. publicclassPerformanceLog4j{
  20. //Howmanytimesshouldwetrytolog:
  21. staticintloop=100000;
  23. staticConcurrentMap<Integer,Long>result=newConcurrentHashMap<Integer,Long>();
  25. staticintRESULT_1=1;
  26. staticintRESULT_2=2;
  27. staticintRESULT_3=3;
  28. staticintcountThread=20;
  30. publicPerformanceLog4j(){
  32. }
  34. publicvoidstart(){
  35. initConfig();
  36. result.put(RESULT_1,0L);
  37. result.put(RESULT_2,0L);
  38. result.put(RESULT_3,0L);
  39. intcountT=countThread;
  40. ExecutorServiceexecutor=Executors.newFixedThreadPool(10);
  42. for(inti=0;i<countThread;i++){
  43. executor.execute(newLog4jRun());
  44. }
  46. while(countThread>0){
  47. try{
  48. Thread.sleep(10000);
  49. }catch(InterruptedExceptione){
  50. e.printStackTrace();
  51. }
  52. }
  53. executor.shutdown();
  55. System.out.println("###################loop"+loop+"#ASYNC############################");
  56. System.out.println("Log4jdirectdebugcall:"+result.get(RESULT_1)/countT);
  57. System.out.println("Log4jdirectwarncall:"+result.get(RESULT_2)/countT);
  58. System.out.println("Log4jtested(isDebugEnabled)debugcall:"+result.get(RESULT_3)/countT);
  59. System.out.println("###############################################");
  61. }
  63. publicstaticvoidmain(String[]args)throwsInterruptedException{
  64. newPerformanceLog4j().start();
  65. }
  67. privatestaticvoidinitConfig(){
  68. DOMConfigurator.configure("src/main/resource/log4j.xml");
  70. //createtheloggers
  71. org.apache.log4j.Logger.getLogger("perfTest");
  72. org.apache.log4j.Logger.getLogger("perfTest.ch");
  73. org.apache.log4j.Logger.getLogger("perfTest.ch.qos");
  74. org.apache.log4j.Logger.getLogger("perfTest.ch.qos.logback");
  75. }
  77. staticclassLog4jRunimplementsRunnable{
  78. staticLoggerlog4jlogger=Logger.getLogger(Log4jRun.class);
  80. static{
  81. //Let'srunonceforJustInTimecompiler
  82. log4jDirectDebugCall();
  83. log4jDirectWarnCall();
  84. log4jTestedDebugCall();
  85. }
  87. publicLog4jRun(){
  89. }
  91. /*
  92. *(non-Javadoc)
  93. *@seejava.lang.Runnable#run()
  94. */
  95. @Override
  96. publicvoidrun(){
  97. System.out.println("start"+Thread.currentThread());
  98. //let'srunthetestsanddisplaytheresults:
  99. longresult1=log4jDirectDebugCall();
  100. longresult2=log4jDirectWarnCall();
  101. longresult3=log4jTestedDebugCall();
  102. synchronized(result){
  103. result.put(RESULT_1,result.get(RESULT_1)+result1);
  104. result.put(RESULT_2,result.get(RESULT_2)+result2);
  105. result.put(RESULT_3,result.get(RESULT_3)+result3);
  106. }
  107. countThread--;
  108. System.out.println("count"+countThread+"end"+Thread.currentThread());
  109. }
  111. privatestaticlonglog4jDirectDebugCall(){
  112. Integerj=newInteger(1);
  113. longstart=System.nanoTime();
  114. for(inti=0;i<loop;i++){
  115. log4jlogger.debug("SEEIFTHISISLOGGEDlog4jDirectDebugCall()"+j+".");
  116. }
  117. return(System.nanoTime()-start)/loop;
  118. }
  120. privatestaticlonglog4jDirectWarnCall(){
  121. Integerj=newInteger(2);
  122. longstart=System.nanoTime();
  123. for(inti=0;i<loop;i++){
  124. log4jlogger.warn("SEEIFTHISISLOGGEDlog4jDirectWarnCall()"+j+".");
  125. }
  126. return(System.nanoTime()-start)/loop;
  127. }
  129. privatestaticlonglog4jTestedDebugCall(){
  130. Integerj=newInteger(3);
  131. longstart=System.nanoTime();
  132. for(inti=0;i<loop;i++){
  133. if(log4jlogger.isDebugEnabled()){
  134. log4jlogger.debug("SEEIFTHISISLOGGEDlog4jTestedDebugCall()"+j+".");
  135. }
  136. }
  137. return(System.nanoTime()-start)/loop;
  138. }
  140. }
  141. }
/** * $Id$ */ package perfTest.ch.qos.logback; import java.util.concurrent.ConcurrentHashMap; import java.util.concurrent.ConcurrentMap; import java.util.concurrent.ExecutorService; import java.util.concurrent.Executors; import org.apache.log4j.Logger; import org.apache.log4j.xml.DOMConfigurator; /** * @author Last changed by: $Author$ * @version $Revision$ $Date$ */ public class PerformanceLog4j { // How many times should we try to log: static int loop = 100000; static ConcurrentMap<Integer, Long> result = new ConcurrentHashMap<Integer, Long>(); static int RESULT_1 = 1; static int RESULT_2 = 2; static int RESULT_3 = 3; static int countThread = 20; public PerformanceLog4j() { } public void start() { initConfig(); result.put(RESULT_1, 0L); result.put(RESULT_2, 0L); result.put(RESULT_3, 0L); int countT = countThread; ExecutorService executor = Executors.newFixedThreadPool(10); for (int i = 0; i < countThread; i++) { executor.execute(new Log4jRun()); } while (countThread > 0) { try { Thread.sleep(10000); } catch (InterruptedException e) { e.printStackTrace(); } } executor.shutdown(); System.out.println("################### loop " + loop + " #ASYNC ############################"); System.out.println("Log4j direct debug call: " + result.get(RESULT_1) / countT); System.out.println("Log4j direct warn call: " + result.get(RESULT_2) / countT); System.out.println("Log4j tested (isDebugEnabled) debug call: " + result.get(RESULT_3) / countT); System.out.println("###############################################"); } public static void main(String[] args) throws InterruptedException { new PerformanceLog4j().start(); } private static void initConfig() { DOMConfigurator.configure("src/main/resource/log4j.xml"); // create the loggers org.apache.log4j.Logger.getLogger("perfTest"); org.apache.log4j.Logger.getLogger("perfTest.ch"); org.apache.log4j.Logger.getLogger("perfTest.ch.qos"); org.apache.log4j.Logger.getLogger("perfTest.ch.qos.logback"); } static class Log4jRun implements Runnable { static Logger log4jlogger = Logger.getLogger(Log4jRun.class); static { // Let's run once for Just In Time compiler log4jDirectDebugCall(); log4jDirectWarnCall(); log4jTestedDebugCall(); } public Log4jRun() { } /* * (non-Javadoc) * @see java.lang.Runnable#run() */ @Override public void run() { System.out.println("start " + Thread.currentThread()); // let's run the tests and display the results: long result1 = log4jDirectDebugCall(); long result2 = log4jDirectWarnCall(); long result3 = log4jTestedDebugCall(); synchronized (result) { result.put(RESULT_1, result.get(RESULT_1) + result1); result.put(RESULT_2, result.get(RESULT_2) + result2); result.put(RESULT_3, result.get(RESULT_3) + result3); } countThread--; System.out.println("count " + countThread + " end " + Thread.currentThread()); } private static long log4jDirectDebugCall() { Integer j = new Integer(1); long start = System.nanoTime(); for (int i = 0; i < loop; i++) { log4jlogger.debug("SEE IF THIS IS LOGGED log4jDirectDebugCall() " + j + "."); } return (System.nanoTime() - start) / loop; } private static long log4jDirectWarnCall() { Integer j = new Integer(2); long start = System.nanoTime(); for (int i = 0; i < loop; i++) { log4jlogger.warn("SEE IF THIS IS LOGGED log4jDirectWarnCall()" + j + "."); } return (System.nanoTime() - start) / loop; } private static long log4jTestedDebugCall() { Integer j = new Integer(3); long start = System.nanoTime(); for (int i = 0; i < loop; i++) { if (log4jlogger.isDebugEnabled()) { log4jlogger.debug("SEE IF THIS IS LOGGED log4jTestedDebugCall() " + j + "."); } } return (System.nanoTime() - start) / loop; } } }
Java代码 复制代码 收藏代码
  1. /**
  2. *$Id$
  3. */
  4. packageperfTest.ch.qos.logback;
  6. importjava.util.concurrent.ConcurrentHashMap;
  7. importjava.util.concurrent.ConcurrentMap;
  8. importjava.util.concurrent.ExecutorService;
  9. importjava.util.concurrent.Executors;
  11. importorg.slf4j.Logger;
  12. importorg.slf4j.LoggerFactory;
  14. /**
  15. *@authorLastchangedby:$Author$
  16. *@version$Revision$$Date$
  17. */
  18. publicclassPerformanceLogback{
  20. //Howmanytimesshouldwetrytolog:
  21. staticintloop=100000;
  23. staticConcurrentMap<Integer,Long>result=newConcurrentHashMap<Integer,Long>();
  25. staticintRESULT_4=1;
  26. staticintRESULT_5=2;
  27. staticintRESULT_6=3;
  28. staticintRESULT_7=4;
  29. staticintRESULT_8=5;
  30. staticintRESULT_9=6;
  31. staticintcountThread=20;
  33. publicPerformanceLogback(){
  35. }
  37. publicvoidstart(){
  38. result.put(RESULT_4,0L);
  39. result.put(RESULT_5,0L);
  40. result.put(RESULT_6,0L);
  41. result.put(RESULT_7,0L);
  42. result.put(RESULT_8,0L);
  43. result.put(RESULT_9,0L);
  45. intcountT=countThread;
  46. ExecutorServiceexecutor=Executors.newFixedThreadPool(10);
  48. for(inti=0;i<countThread;i++){
  49. executor.execute(newLogbackRun());
  50. }
  52. while(countThread>0){
  53. try{
  54. Thread.sleep(10000);
  55. }catch(InterruptedExceptione){
  56. e.printStackTrace();
  57. }
  58. }
  59. executor.shutdown();
  61. System.out.println("##################loop"+loop+"#############################");
  62. System.out.println("Logbackdirectdebugcall:"+result.get(RESULT_4)/countT);
  63. System.out.println("Logbackdirectwarncall:"+result.get(RESULT_5)/countT);
  64. System.out.println("Logbacktested(isDebugEnabled)debugcall:"+result.get(RESULT_6)/countT);
  65. System.out.println("Logbacktested(isWarnEnabled)warncall:"+result.get(RESULT_7)/countT);
  66. System.out.println("Logbackparametrizeddebugcall:"+result.get(RESULT_8)/countT);
  67. System.out.println("Logbackparametrizedwarncall:"+result.get(RESULT_9)/countT);
  68. System.out.println("###############################################");
  69. }
  71. publicstaticvoidmain(String[]args)throwsInterruptedException{
  72. newPerformanceLogback().start();
  73. }
  75. staticclassLogbackRunimplementsRunnable{
  76. staticLoggerlogbacklogger=LoggerFactory.getLogger(LogbackRun.class);
  78. static{
  79. //Let'srunonceforJustInTimecompiler
  80. logbackDirectDebugCall();
  81. logbackDirectWarnCall();
  82. logbackTestedDebugCall();
  83. logbackTestedWarnCall();
  84. logbackParametrizedDebugCall();
  85. logbackParametrizedWarnCall();
  86. }
  87. /*
  88. *(non-Javadoc)
  89. *@seejava.lang.Runnable#run()
  90. */
  91. @Override
  92. publicvoidrun(){
  93. System.out.println("start"+Thread.currentThread());
  94. //let'srunthetestsanddisplaytheresults:
  95. longresult4=logbackDirectDebugCall();
  96. longresult5=logbackDirectWarnCall();
  97. longresult6=logbackTestedDebugCall();
  98. longresult7=logbackTestedWarnCall();
  99. longresult8=logbackParametrizedDebugCall();
  100. longresult9=logbackParametrizedWarnCall();
  101. synchronized(result){
  102. result.put(RESULT_4,result.get(RESULT_4)+result4);
  103. result.put(RESULT_5,result.get(RESULT_5)+result5);
  104. result.put(RESULT_6,result.get(RESULT_6)+result6);
  105. result.put(RESULT_7,result.get(RESULT_7)+result7);
  106. result.put(RESULT_8,result.get(RESULT_8)+result8);
  107. result.put(RESULT_9,result.get(RESULT_9)+result9);
  108. }
  109. countThread--;
  110. System.out.println("count"+countThread+"end"+Thread.currentThread());
  112. }
  114. privatestaticlonglogbackDirectDebugCall(){
  115. Integerj=newInteger(5);
  116. longstart=System.nanoTime();
  117. for(inti=0;i<loop;i++){
  118. logbacklogger.debug("SEEIFTHISISLOGGED"+j+".");
  119. }
  120. return(System.nanoTime()-start)/loop;
  121. }
  123. privatestaticlonglogbackDirectWarnCall(){
  124. Integerj=newInteger(6);
  125. longstart=System.nanoTime();
  126. for(inti=0;i<loop;i++){
  127. logbacklogger.warn("SEEIFTHISISLOGGEDlogbackDirectWarnCall()"+j+".");
  128. }
  129. return(System.nanoTime()-start)/loop;
  130. }
  132. privatestaticlonglogbackTestedDebugCall(){
  133. Integerj=newInteger(7);
  134. longstart=System.nanoTime();
  135. for(inti=0;i<loop;i++){
  136. if(logbacklogger.isDebugEnabled())
  137. logbacklogger.debug("SEEIFTHISISLOGGED"+j+".");
  138. }
  139. return(System.nanoTime()-start)/loop;
  140. }
  142. privatestaticlonglogbackTestedWarnCall(){
  143. Integerj=newInteger(8);
  144. longstart=System.nanoTime();
  145. for(inti=0;i<loop;i++){
  146. if(logbacklogger.isWarnEnabled())
  147. logbacklogger.warn("SEEIFTHISISLOGGEDlogbackTestedWarnCall()"+j+".");
  148. }
  149. longend=System.nanoTime();
  150. longresult=(end-start)/loop;
  151. //System.out.println("start="+start+"end="+end+"result="+result);
  152. returnresult;
  153. }
  155. privatestaticlonglogbackParametrizedDebugCall(){
  156. Integerj=newInteger(9);
  157. longstart=System.nanoTime();
  158. for(inti=0;i<loop;i++){
  159. logbacklogger.debug("SEEIFTHISISLOGGED{}.",j);
  160. }
  161. return(System.nanoTime()-start)/loop;
  162. }
  164. privatestaticlonglogbackParametrizedWarnCall(){
  165. Integerj=newInteger(10);
  166. longstart=System.nanoTime();
  167. for(inti=0;i<loop;i++){
  168. logbacklogger.warn("SEEIFTHISISLOGGEDlogbackParametrizedWarnCall(){}.",j);
  169. }
  170. longend=System.nanoTime();
  171. longresult=(end-start)/loop;
  172. //System.out.println("start="+start+"end="+end+"result="+result);
  173. returnresult;
  174. }
  175. }
  176. }
iteye_956
关注
评论
成就一亿技术人!
拼手气红包6.0元
还能输入1000个字符
 
红包 添加红包
表情包 插入表情
表情包 代码片
 条评论被折叠 查看
添加红包

请填写红包祝福语或标题

个

红包个数最小为10个

元

红包金额最低5元

当前余额3.43元 前往充值 >
需支付：10.00元
成就一亿技术人!
领取后你会自动成为博主和红包主的粉丝 规则
hope_wisdom
发出的红包
实付元
使用余额支付
点击重新获取
扫码支付
钱包余额 0

抵扣说明：

1.余额是钱包充值的虚拟货币，按照1:1的比例进行支付金额的抵扣。
2.余额无法直接购买下载，可以购买VIP、付费专栏及课程。

余额充值