NLog mappeddiagnosticlogicalcontext在async/await和ConfigureAwa

本文关键字:await ConfigureAwa async mappeddiagnosticlogicalcontext NLog | 更新日期: 2023-09-27 18:03:04

我使用的是NLog 4.3.5和。net framework 4.6.1

当我开始一个服务器端操作时,我调用:

NLog.MappedDiagnosticsLogicalContext.Set("OperationId", Guid.NewGuid());

这被映射并出现在我的日志文件中。一切都好....是吗?当检查我的日志文件时,我注意到这个操作id值似乎没有像我期望的那样工作。

的例子:

  1. 在线程19中开始一个操作并设置上下文。

  2. 在所有await调用中使用.ConfigureAwait(false)

  3. 执行

    var tasks = items.Select(item => Task.Run( () => { /* do stuff */}
    await Task.WhenAll(tasks).ConfigureAwait(false)
    
  4. 其中一个用于这些任务的线程是线程31(记住以后)同时,在线程36中,一个不同的服务器方法被调用并开始一个新的操作。几个日志消息写入它的唯一操作id
  5. 此操作使用ConfigureAwait(false)执行2个不同的await调用
  6. 下一条日志语句发生在线程31上。从那时起,它记录为线程19上开始的操作创建的操作id !

我没想到会发生这种事,也不确定它是怎么发生的。但是,当我查看我的日志历史记录时,我发现这种事情以前发生过。

我认为逻辑调用上下文应该延续下去。是我使用ConfigureAwait(false)导致这种行为吗?这是我唯一能想到的....

NLog mappeddiagnosticlogicalcontext在async/await和ConfigureAwa

找到了我认为的问题所在。https://github.com/NLog/NLog/issues/934

你可以这样做:

public static class LogicalThreadContext  
{ 
    private const string KeyPrefix = "NLog.LogicalThreadContext"; 
    private static string GetCallContextKey(string key)
    {
        return string.Format("{0}.{1}", KeyPrefix, key);
    }
    private static string GetCallContextValue(string key)
    {
        return CallContext.LogicalGetData(GetCallContextKey(key)) as string ?? string.Empty;
    }
    private static void SetCallContextValue(string key, string value)
    {
        CallContext.LogicalSetData(GetCallContextKey(key), value);         
    }
    public static string Get(string item)
    {
        return GetCallContextValue(item);
    }
    public static string Get(string item, IFormatProvider formatProvider)
    {
        if ((formatProvider == null) && (LogManager.Configuration != null))
        {
            formatProvider = LogManager.Configuration.DefaultCultureInfo;
        }
        return string.Format(formatProvider, "{0}", GetCallContextValue(item));
    }
    public static void Set(string item, string value)
    {
        SetCallContextValue(item, value);
    }
}
[LayoutRenderer("mdlc2")]
public class LogicalThreadContextLayoutRenderer : LayoutRenderer
{
   [DefaultParameter]
   public bool Name {get;set;}
    protected override void Append(StringBuilder builder, LogEventInfo logEvent)
    {
        builder.Append(LogicalThreadContext.Get(Name, null));
    }
}
//or application_start for ASP.NET 4
static void Main(string[] args) 
{ 
    //layout renderer
    ConfigurationItemFactory.Default.LayoutRenderers
          .RegisterDefinition("mdlc2", typeof(LogicalThreadContextLayoutRenderer ));
}

配置文件中的用法:

${mdlc2:OperationId}