点击上方蓝字关注“汪宇杰博客”
导语
昨天刚发了一篇《
生产大爆炸
发生问题的是已经被删除的博客文章，正常情况下，这些不存在的文章会直接显示自定义的404页面，但实际上产生了500异常。日志如下：
2019-09-26 00:11:50.8405|RD00155DB89A5B|WARN|Moonglade.Web.Controllers.PostController|Post not found, parameter '2014/7/23/my-surface-pro-3-review-system-software'.,GET https://edi.wang/post/2014/7/23/my-surface-pro-3-review-system-software,Slug,66.249.71.135
2019-09-26 00:11:51.1174|RD00155DB89A5B|WARN|Moonglade.Web.Controllers.PostController|Post not found, parameter '2014/7/23/my-surface-pro-3-review-system-software'.,GET https://edi.wang/error,Slug,66.249.71.135
2019-09-26 00:11:51.1174|RD00155DB89A5B|ERROR|Microsoft.AspNetCore.Diagnostics.ExceptionHandlerMiddleware|An unhandled exception has occurred while executing the request.,System.ArgumentException: An item with the same key has already been added. Key: x-pingback
at System.Collections.Generic.Dictionary`2.TryInsert(TKey key, TValue value, InsertionBehavior behavior)
at System.Collections.Generic.Dictionary`2.Add(TKey key, TValue value)
at Microsoft.AspNetCore.HttpSys.Internal.HeaderCollection.Add(String key, StringValues value)
看上去像是个Pingback HTTP头被重复添加的问题。但实际上这个头被添加产生异常的本质原因是请求博客文章的Slug这个Action被执行了两次。
重现故障
这个问题在开发时并没有发现，staging环境可以重现，但由于偷懒，没测过exception path，happy path过了就发布了。之所以开发环境 works on my machine 是因为这样一个设定，大部分 ASP.NET Core 程序都会这么做，毕竟是默认模板里的实践：
if (env.IsDevelopment())
{
ListAllRegisteredServices(app);
app.UseDeveloperExceptionPage();
}
else
{
app.UseExceptionHandler("/error");
app.UseStatusCodePagesWithReExecute("/error", "?statusCode={0}");
}
出问题的是 UseStatusCodePagesWithReExecute() 这个中间件。
最终在 GitHub 上找到了一个已知问题：
https://github.com/aspnet/AspNetCore/issues/13715
我用 VS2019 16.3.1 + .NET Core 3.0 正式版建了个测试工程，重现了这个问题。
public IActionResult Index(int id = 0)
{
if (id == 1)
{
return NotFound();
}
return View();
}
[Route("/error")]
[ResponseCache(Duration = 0, Location = ResponseCacheLocation.None, NoStore = true)]
public IActionResult Error(int? statusCode = null)
{
return Content($"Test Error Action: {statusCode}");
}
public void Configure(IApplicationBuilder app, IWebHostEnvironment env)
{
//app.UseStatusCodePages();
//app.UseExceptionHandler("/error");
app.UseStatusCodePagesWithReExecute("/error", "?statusCode={0}");
app.UseHttpsRedirection();
app.UseStaticFiles();
app.UseRouting();
app.UseAuthorization();
app.UseEndpoints(endpoints =>
{
endpoints.MapControllerRoute(
name: "default",
pattern: "{controller=Home}/{action=Index}/{id?}");
});
}
访问 /Home/Index?id=1
id=1的请求成功执行到 NotFound(); 正常情况应该立即执行 /error?statusCode=404，当实际上 Error 这个 Action 根本没有跑进去，而是马上再次执行了 Index，id=0
而因为执行的逻辑是ReExecute，也就是把action的执行结果放到“父”action里输出，所以会触发两次pingback头的添加，导致我博客大爆炸。
复制粘贴 能跑就行
微软并不打算在 3.0 的补丁更新中修复这个问题，而是直接放到了 3.1。好在微软提供了 workaround，所以我们只能先忍几个月。
在 UseRouting() 和 UseStatusCodePagesWithReExecute() 之间加入一段神奇的代码，即可结束福爆。
app.UseStatusCodePagesWithReExecute("/error", "?statusCode={0}");
// Workaround .NET Core 3.0 known bug
// https://github.com/aspnet/AspNetCore/issues/13715
app.Use((context, next) => {
context.SetEndpoint(null);
return next();
});
实在不行 删库跑路 也挺省心
目前 .NET Core 3.0 升级问题多多，资料少少，一不小心就容易领取福报。如果追求刺激和拥抱开源的乐趣，可以像我或者博客园一样直接踩坑。如果追求稳定，不想被公司开除，建议等 3.1 再更新吧~ 毕竟微软拥抱开源以后的产品，.1 才是能用的（早上更新的 VS2019 16.3.1笑而不语）。
