如何解决NLog记日志性能慢的问题

最近写了一个模拟器程序，由于模拟器中要在日志中记录对象实时变化时的完整状态，导致日志数量猛增，跑了一分钟程序就有3000多条日志。

日志多没关系，但是我发现在增加日志内容后程序在很多运行周期中常常超时。难道这个.Net Core程序用的NLog还要占用主线程的CPU资源去记录日志吗？仔细研读了NLog的文档后，发现NLog在默认状态下确实是使用记录日志时所用的线程来保存日志的。

但是你可以打开异步开关来实现在日志自己的线程中保存日志，具体做法是在配置文件的 targets 增加 async = “true” 属性。下面是示例配置：

<?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="Info"
      internalLogFile="${basedir}/logs/internal-nlog.txt">

  <!-- 在这里把 async="true" 就可以实现异步保存日志了 -->
  <targets async="true">
    <!-- write logs to file  -->
    <target xsi:type="File" name="allfile" fileName="${basedir}/logs/nlog-all-${shortdate}.log"
            keepFileOpen="true"
            archiveFileName="${basedir}/logs/archives/nlog-all-${longdate}.log"
            archiveAboveSize="4096000"
            archiveEvery="Day"
            maxArchiveFiles="35"
            layout="${longdate}|${event-properties:item=EventId_Id}|${uppercase:${level}}|${logger}|${message} ${exception:format=tostring}" />

    <target name="logconsole" xsi:type="Console" />
  </targets>

  <!-- rules to map from logger name to target -->
  <rules>
    <logger name="*" minlevel="Info" writeTo="logconsole" />
    <!--All logs, including from Microsoft-->
    <logger name="*" minlevel="Info" writeTo="allfile" />
    <!--Skip non-critical Microsoft logs and so log only own logs-->
    <!--logger name="Microsoft.*" maxlevel="Info" final="true" /-->
  </rules>
</nlog>

实际运行以后，即使是在压力极大的情况下也没有再出现过运行周期超时的问题，成功地解决了写日志耗时过高的问题。

由于是异步写日志，NLog默认设置了一个缓存值，这个值默认是10000条日志，如果 10000 条以上了待写入的时候又来了其他日志，NLog 会直接忽略。当然你可以选择扩大缓存，或者让发起记日志的线程等待缓存被清空。

最后，记得在程序运行结束时执行以下语句，这样才能保证日志被完整保存。

// Flush logs
NLog.LogManager.Shutdown();

参考资料：
https://github.com/NLog/NLog/wiki/AsyncWrapper-target