前言
.NetCore日志,相信大家多少都接触过,博客园有关 ① AspNetCore依赖注入第三方日志组件 ②第三方日志组件Nlog,Serilog 应用方法的博文层出不穷。结合程序的部署结构,本文分单体和微服务聊一聊AspNetCore中追踪日志流的方法。
TraceID
AspNetCore程序基于Pipeline和中间件处理请求, 根据需要记录日志;生产出故障时,在数量庞大的日志记录中追踪某个请求完整的处理链显得很有必要(这个深有体会)。
针对单体程序,AspNetCore贴心的为我们提供HttpContext.TraceIdentifier属性,这个TraceId由{ConnectionId}:{Request Number}组成,理论上这个id标记了位于某Http连接上的某次请求。
① 为什么由 {ConnectionId}:{Request Number}组成?
默认大部分读者知晓Http1.1一个连接上可发起多个Http请求
② TraceId中ConnectionId由Kestrel从{0-9,a-z}中生成,可参考https://github.com/aspnet/KestrelHttpServer/blob/a48222378b8249a26b093b5b835001c7c7b45815/src/Kestrel.Core/Internal/Infrastructure/CorrelationIdGenerator.cs
ok,现在着重聊一下应用方式和衍生知识点
① 启用NLog日志
添加<PackageReference Include="NLog.Web.AspNetCore" Version="4.9.0" />
public class Program
{
public static void Main(string[] args)
{
var webHost = WebHost.CreateDefaultBuilder(args)
.ConfigureAppConfiguration((hostingContext, configureDelagate) =>
{
configureDelagate.AddJsonFile($"appsettings.secrets.json", optional: true, reloadOnChange: true);
})
.ConfigureLogging((hostingContext, loggingBuilder) =>
{
loggingBuilder.AddConsole().AddDebug();
})
.UseNLog() // 默认会找工作目录下nlog.config配置文件
.UseStartup<Startup>()
.Build();
webHost.Run();
}
}
很明显,Nlog要在Pipeline中自由获取HttpContext属性,这里需要注册 IHttpContextAccessor
public class Startup
{
// rest of the code omitted for brevity
public void ConfigureServices(IServiceCollection services)
{
services.AddSingleton<IHttpContextAccessor, HttpContextAccessor>();
}
// rest of the code omitted for brevity
}
② 配置Nlog以支持TraceId
实际上nlog支持记录很多HttpContext信息,详情请关注https://nlog-project.org/config/?tab=layout-renderers
下面的Nlog配置文件呈现了TraceId & User_Id(业务上的UserId能帮助我们在茫茫日志中快速缩小日志)
<?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" throwExceptions="false" internalLogFile="internal-nlog.txt">
<variable name="logDir" value="logs/${date:format=yyyyMMdd}" /> <!-- 日志存储文件夹-->
<variable name="format" value="${date:format=yy/MM/dd HH\:mm\:ss} [${level}].[${logger}].[${aspnet-TraceIdentifier}].[${aspnet-user-identity}]${newline}${message} ${exception:format=tostring}" />
<targets>
<target name="info"
xsi:type="File"
layout="${format}"
fileName="${logDir}/info.log"
encoding="utf-8"/>
</targets>
<rules>
<logger name="*" minlevel="Info" writeTo="info" />
</rules>
</nlog>
结果如下:
以上是在单体程序内根据traceid追踪请求流的方法。
进一步思考,在微服务中,各服务独立形成TraceId,在初始阶段生成 TraceId 并在各微服务中保持该Traceid即可追踪微服务的请求流。
CorrelationId
这里首先假设你的微服务/分布式服务已经部署了ELK等日志集中处理框架。(没有部署ELK也可将多个服务的日志写到同一个物理文件夹)
隆重介绍轮子CorrelationId
CorrelationId是通过自定义Header来标记TraceId概念
X-Correlation-ID
】 的请求头,在本服务Response写入该Header 这样在集中日志中,能通过某TraceID追踪微服务/分布式 全链路请求处理日志。
使用方式也相当简单:
// Install-Package CorrelationId -Version 2.1.0
public void ConfigureServices(IServiceCollection services)
{
services.AddMvc();
services.AddCorrelationId();
}
一般在所有Middleware之前注册CorrelationId,这样在所有请求处理中间件都能获取到TraceId:
public void Configure(IApplicationBuilder app, IHostingEnvironment env)
{
app.UseCorrelationId();
if (env.IsDevelopment())
{
app.UseDeveloperExceptionPage();
}
app.UseMvc();
}
打算应用该TraceId追踪全流程请求日志的服务都需要包含该中间件。
Ok,本文由浅入深 TraceID在单体程序和分布式程序中的应用,希望对大家在日志排障时有所帮助。