详解.Net core2.0日志组件Log4net、Nlog简单性能测试

啊,小雪,小雪,来了,来了。从微微的凉风中,从傍晚的喧闹中来了!像春风抖落万树梨花,像天女撒下漫天白絮……你不飘飘悠悠,因为那是骄傲的象征;你不轻轻起舞,因为那是胆小的缩影,听,沙沙沙沙、沙沙沙沙……我好像坐在屋里听那春雨的歌声。

.Net core之Log4net、Nlog简单性能测试

比较log4net、nlog的文件写入性能(.netcore环境),涉及代码和配置如有不正确的地方,还请批评指正。

测试环境

开发工具: Vsual Studio 2017 15.3

框架版本: .net core 2.0

操作系统:window10 Enterprise 1703

硬件配置:CPU I3-4170 3.7GHz,内存 8G,固态硬盘

日志组件

log4net 2.0.8

nlog 5.0.0-beta10

测试用例

1.不启用Buffer,连续插入20万行字符串到文件,单文件最大1MB。

2.启用Buffer为100,连续插入20万行字符串到文件,单文件最大1MB。

测试方法

xunit单元测试。

测试代码

using System;
using System.Diagnostics;
using System.IO;
using Xunit;
using Xunit.Abstractions;
namespace Demo.Logging.Tests
{
  /// <summary>
  /// Log4net、Nlog日志文件写入对比
  /// </summary>
  public class BigDataTest
  {
    private readonly ITestOutputHelper output;
    public BigDataTest(ITestOutputHelper outputHelper)
    {
      output = outputHelper;
    }

    /// <summary>
    /// 使用Log4net连续插入20W行字符串
    /// </summary>
    [Fact]
    public void Log4netTest()
    {
      log4net.Repository.ILoggerRepository repository = log4net.LogManager.CreateRepository("NETCoreRepository");
      var fileInfo = new FileInfo("config/log4net.config");
      log4net.Config.XmlConfigurator.Configure(repository, fileInfo);
      log4net.Config.BasicConfigurator.Configure(repository);
      log4net.ILog log = log4net.LogManager.GetLogger(repository.Name, "NETCorelog4net");

      var total = 200000;
      var sw = new Stopwatch();
      sw.Start();
      for (int i = 0; i < total; i++)
      {
        log.Info("log4 bigdata test: " + i);
      }
      sw.Stop();
      log.Info($"total: {total}, Elapsed:{sw.ElapsedMilliseconds}");
      output.WriteLine($"Log4net测试 total: {total}, Elapsed:{sw.ElapsedMilliseconds}");
    }

    /// <summary>
    /// 使用Nlog连续插入20W行字符串
    /// </summary>
    [Fact]
    public void NlogTest()
    {

      NLog.Logger log = NLog.LogManager.GetCurrentClassLogger();
      var total = 200000;
      var sw = new Stopwatch();
      sw.Start();
      for (int i = 0; i < total; i++)
      {
        log.Info("nlog bigdata test: " + i);
      }
      sw.Stop();
      log.Info($"total: {total}, Elapsed:{sw.ElapsedMilliseconds}");
      output.WriteLine($"NLog测试 total: {total}, Elapsed:{sw.ElapsedMilliseconds}");
    }

  }
}

测试用例一:不启用缓存,连续插入20W行

1.Log4net

配置

log4net.config

<?xml version="1.0" encoding="utf-8" ?>
<configuration>
 <!-- This section contains the log4net configuration settings -->
 <log4net>
  
  <appender name="RollingLogFileAppender" type="log4net.Appender.RollingFileAppender">
   <file value="logfile/" />
   <appendToFile value="true" />
   <rollingStyle value="Composite" />
   <staticLogFileName value="false" />
   <datePattern value="yyyyMMdd'.log'" />
   <maxSizeRollBackups value="10" />
   <maximumFileSize value="1MB" />
   <layout type="log4net.Layout.PatternLayout">
    <conversionPattern value="%date | %message%newline" />
   </layout>
  </appender>

  <!-- Setup the root category, add the appenders and set the default level -->
  <root>
   <level value="ALL" />
   <appender-ref ref="RollingLogFileAppender" />
  </root>

 </log4net>
</configuration>

测试结果

输出日志内容:

2017-09-11 19:38:02,276 | log4 bigdata test: 0

2017-09-11 19:38:02,279 | log4 bigdata test: 1

... ...

... ...

2017-09-11 19:38:02,279 | log4 bigdata test: 199998

2017-09-11 19:38:02,279 | log4 bigdata test: 199999

Log4net耗时:

写入行数:200000, 毫秒数:7749

2.Nlog

配置

nlog.config

<?xml version="1.0" encoding="utf-8" ?>
<nlog xmlns="http://www.nlog-project.org/schemas/NLog.xsd"
   xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
   autoReload="true"
   internalLogLevel="Warn"
   internalLogFile="internal-nlog.txt">

 <!-- define various log targets -->
 <targets>
  <!-- write logs to file -->
  <target xsi:type="File" name="ownFile-web" fileName="logs/nlog-own-${shortdate}.log"
       layout="${longdate} | ${message}" 
      archiveAboveSize="1048576"/>
 </targets>

 <rules>
  <logger name="*" minlevel="Trace" writeTo="ownFile-web" />
 </rules>
</nlog>

测试结果

输出日志内容:

2017-09-11 19:38:02,276 | nlog bigdata test: 0

2017-09-11 19:38:02,279 | nlog bigdata test: 1

......

......

2017-09-11 19:38:02,279 | nlog bigdata test: 199998

2017-09-11 19:38:02,279 | nlog bigdata test: 199999

Nlog耗时:

写入行数:200000, 毫秒数:104468

测试用例二:启用Buffer,连续插入20W行

1.Log4net

配置 log4net.config

......

 <log4net>
  <appender name="RollingLogFileAppender" type="log4net.Appender.RollingFileAppender">
   <bufferSize value="100" />

......

耗时:Log4net写入行数:200000, 毫秒数:4672

2.Nlog

配置

nlog.config

......

 <targets>
  <!-- write logs to file -->
  <default-wrapper xsi:type="BufferingWrapper" bufferSize="100"/>
  <target xsi:type="File" name="ownFile-web" fileName="logs/nlog-own-${shortdate}.log"
       layout="${longdate} | ${message}" 
      archiveAboveSize="1048576"/>
 </targets>

......

Nlog耗时:写入行数:200000, 毫秒数:1605

总结

日志组件 版本 环境 用例 (启用Buffer=100)毫秒数 (不启用Buffer)毫秒数
log4net 2.0.8 .netcore 2.0 20W行文件写入 4672 7749
nlog 5.0.0-beta10 .netcore 2.0 20W行文件写入 1605 104468

代码和配置文件都在上边了,不知道不同配置的机器结果如何。

大家又会倾向于nlog还是log4net? log4net无论是否启用buffer,耗时都比较稳定,10秒以内,前后差距1.66倍;nlog在启用buffer前后,耗时差距65倍 ,未启用buffer竟然需要100多秒,虽然在启用buffer后仅1.605秒。

本文详解.Net core2.0日志组件Log4net、Nlog简单性能测试到此结束。时不时给自我一个能够沉默的理由来淡定人生。小编再次感谢大家对我们的支持!

标签: 性能测试 Net