NLog - StackOverflow exception/NLog.NLogRuntimeException 发生在 MySQL 数据库目标上

NLog - StackOverflow exception/NLog.NLogRuntimeException occurred with MySQL database target

我已将 NLog 配置为将 errors/logs 记录到两个 MySQL/Database 目标:

<nlog autoReload="false" internalLogFile="omg.txt" throwExceptions="true" xmlns="http://www.nlog-project.org/schemas/NLog.xsd" xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance">
  <!--<nlog autoReload="false" xmlns="http://www.nlog-project.org/schemas/NLog.xsd" xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance">-->
  <variable name="DefaultLayout" value="${longdate} | ${uppercase:${level}} | ${logger} | ${message}&#xD;&#xA;     ${exception:innerFormat=ToString:maxInnerExceptionLevel=6:innerExceptionSeparator=InnerException:format=ToString}" />
  <targets>
    <target xsi:type="ColoredConsole" name="console" layout="${DefaultLayout}" />
    <target xsi:type="Null" name="nulltarget" formatMessage="false" layout="${DefaultLayout}" />
    <target xsi:type="Database"
          name="MySqlErrorTarget"
          dbProvider="MySql.Data.MySqlClient" connectionString="x"
          keepConnection="true">
      <commandText>
        CALL Error_Insert(@Message)
      </commandText>
      <parameter name="@Message" layout="${message}" />
      (...)
    </target>
    <target xsi:type="Database"
          name="MySqlLogTarget"
          dbProvider="MySql.Data.MySqlClient" connectionString="x"
          keepConnection="true">
      <commandText>
        CALL Log_Insert(@Message)
      </commandText>
      <parameter name="@Message" layout="${message}" />
      (...)
    </target>
  </targets>
  <rules>
    <logger name="*" levels="TRACE, DEBUG, INFO" writeTo="MySqlLogTarget"/>
    <logger name="*" levels="WARN, ERROR, FATAL" writeTo="MySqlErrorTarget"/>
    <logger name="*" minlevel="INFO" writeTo="console" />
  </rules>
</nlog>

当 MySQL 数据库可用时一切正常,但是当 MySQL 出现故障时,NLog 会抛出 Whosebug 异常。内部日志文件如下所示:

2016-03-21 15:36:33.0487 Error Error when writing to database MySql.Data.MySqlClient.MySqlException (0x80004005): Unable to connect to any of the specified MySQL hosts. ---> System.Net.Sockets.SocketException (0x80004005): No such host is known
   at System.Net.Dns.GetAddrInfo(String name)
   at System.Net.Dns.InternalGetHostByName(String hostName, Boolean includeIPv6)
   at System.Net.Dns.GetHostEntry(String hostNameOrAddress)
   at MySql.Data.Common.MyNetworkStream.CreateStream(MySqlConnectionStringBuilder settings, Boolean unix)
   at MySql.Data.Common.StreamCreator.GetStream(MySqlConnectionStringBuilder settings)
   at MySql.Data.MySqlClient.NativeDriver.Open()
   at MySql.Data.MySqlClient.NativeDriver.Open()
   at MySql.Data.MySqlClient.Driver.Open()
   at MySql.Data.MySqlClient.Driver.Create(MySqlConnectionStringBuilder settings)
   at MySql.Data.MySqlClient.MySqlPool.GetPooledConnection()
   at MySql.Data.MySqlClient.MySqlPool.TryToGetDriver()
   at MySql.Data.MySqlClient.MySqlPool.GetConnection()
   at MySql.Data.MySqlClient.MySqlConnection.Open()
   at NLog.Targets.DatabaseTarget.OpenConnection(String connectionString)
   at NLog.Targets.DatabaseTarget.EnsureConnectionOpen(String connectionString)
   at NLog.Targets.DatabaseTarget.WriteEventToDatabase(LogEventInfo logEvent)
   at NLog.Targets.DatabaseTarget.Write(LogEventInfo logEvent)
2016-03-21 15:37:00.1794 Error Error when writing to database MySql.Data.MySqlClient.MySqlException (0x80004005): Unable to connect to any of the specified MySQL hosts. ---> System.Net.Sockets.SocketException (0x80004005): No such host is known
   at System.Net.Dns.GetAddrInfo(String name)
   at System.Net.Dns.InternalGetHostByName(String hostName, Boolean includeIPv6)
   at System.Net.Dns.GetHostEntry(String hostNameOrAddress)
   at MySql.Data.Common.MyNetworkStream.CreateStream(MySqlConnectionStringBuilder settings, Boolean unix)
   at MySql.Data.Common.StreamCreator.GetStream(MySqlConnectionStringBuilder settings)
   at MySql.Data.MySqlClient.NativeDriver.Open()
   at MySql.Data.MySqlClient.NativeDriver.Open()
   at MySql.Data.MySqlClient.Driver.Open()
   at MySql.Data.MySqlClient.Driver.Create(MySqlConnectionStringBuilder settings)
   at MySql.Data.MySqlClient.MySqlPool.GetPooledConnection()
   at MySql.Data.MySqlClient.MySqlPool.TryToGetDriver()
   at MySql.Data.MySqlClient.MySqlPool.GetConnection()
   at MySql.Data.MySqlClient.MySqlConnection.Open()
   at NLog.Targets.DatabaseTarget.OpenConnection(String connectionString)
   at NLog.Targets.DatabaseTarget.EnsureConnectionOpen(String connectionString)
   at NLog.Targets.DatabaseTarget.WriteEventToDatabase(LogEventInfo logEvent)
   at NLog.Targets.DatabaseTarget.Write(LogEventInfo logEvent)

如此循环往复,最后发生 Whosebug。 Visual Studio 中报告的异常如下所示:

NLog.NLogRuntimeException occurred
  HResult=-2146233088
  Message=Exception occurred in NLog
  Source=NLog
  StackTrace:
       at NLog.LoggerImpl.<>c__DisplayClass1.<Write>b__0(Exception ex)
       at NLog.Internal.SingleCallContinuation.Function(Exception exception)
       at NLog.Targets.Target.Write(AsyncLogEventInfo logEvent)
       at NLog.Targets.Target.WriteAsyncLogEvent(AsyncLogEventInfo logEvent)
       at NLog.LoggerImpl.WriteToTargetWithFilterChain(TargetWithFilterChain targetListHead, LogEventInfo logEvent, AsyncContinuation onException)
       at NLog.LoggerImpl.Write(Type loggerType, TargetWithFilterChain targets, LogEventInfo logEvent, LogFactory factory)
       at NLog.Logger.Debug(String message)
       at Runner.Main(String[] args) in C:\Repos\x\src\Runner.cs:line 36
  InnerException: 
       ErrorCode=-2147467259
       HResult=-2147467259
       Message=Unable to connect to any of the specified MySQL hosts.
       Number=1042
       Source=MySql.Data
       StackTrace:
            at MySql.Data.MySqlClient.NativeDriver.Open()
            at MySql.Data.MySqlClient.Driver.Open()
            at MySql.Data.MySqlClient.Driver.Create(MySqlConnectionStringBuilder settings)
            at MySql.Data.MySqlClient.MySqlPool.GetPooledConnection()
            at MySql.Data.MySqlClient.MySqlPool.TryToGetDriver()
            at MySql.Data.MySqlClient.MySqlPool.GetConnection()
            at MySql.Data.MySqlClient.MySqlConnection.Open()
            at NLog.Targets.DatabaseTarget.OpenConnection(String connectionString)
            at NLog.Targets.DatabaseTarget.EnsureConnectionOpen(String connectionString)
            at NLog.Targets.DatabaseTarget.WriteEventToDatabase(LogEventInfo logEvent)
            at NLog.Targets.DatabaseTarget.Write(LogEventInfo logEvent)
            at NLog.Targets.Target.Write(AsyncLogEventInfo logEvent)
       InnerException: 
            ErrorCode=11001
            HResult=-2147467259
            Message=No such host is known
            NativeErrorCode=11001
            Source=System
            StackTrace:
                 at System.Net.Dns.GetAddrInfo(String name)
                 at System.Net.Dns.InternalGetHostByName(String hostName, Boolean includeIPv6)
                 at System.Net.Dns.GetHostEntry(String hostNameOrAddress)
                 at MySql.Data.Common.MyNetworkStream.CreateStream(MySqlConnectionStringBuilder settings, Boolean unix)
                 at MySql.Data.Common.StreamCreator.GetStream(MySqlConnectionStringBuilder settings)
                 at MySql.Data.MySqlClient.NativeDriver.Open()
            InnerException: 

我尝试将规则更改为:

  <rules>
    <logger name="NLog.*" minlevel="TRACE" writeTo="nulltarget" final="true"/>
    <logger name="MySql.*" minlevel="TRACE" writeTo="nulltarget" final="true"/>
    <logger name="System.*" minlevel="TRACE" writeTo="nulltarget" final="true"/>
    <logger name="*" levels="TRACE, DEBUG, INFO" writeTo="MySqlLogTarget"/>
    <logger name="*" levels="WARN, ERROR, FATAL" writeTo="MySqlErrorTarget"/>
    <logger name="*" minlevel="INFO" writeTo="console" />
  </rules>

然而,这并没有帮助。有什么想法可以避免 WhosebugException 吗?

<nlog 上的 throwExceptions 设置为 false。 NLog 将忽略连接异常,并且 NLog 不会尝试将其记录到数据库中。

事实证明,我的代码库中某处调用了这一行:

Trace.Listeners.Add(new NLogTraceListener());

导致 MySql 的错误日志被重定向到 Trace,感谢 NLogTraceListener,NLog 使用 MySql 目标记录了它,失败并被重定向到 Trace,感谢到 NLogTraceListener,它是由 NLog 使用 MySql 目标记录的,这......你知道这是怎么回事。

我没有想出一个好的解决方案,因为没有足够的信息来过滤 TraceListener 中的日志(只是一个字符串形式的消息)。因此我暂时关闭了 NLogTraceListener,因为打开它并不重要。