坑暗花明:又遇 .NET Core 中 System.Data.SqlClient 查询缓慢的问题

  • 时间:
  • 浏览:3
  • 来源:大发时时彩_时时彩在线稳定计划_大发时时彩在线稳定计划

前一天发布过一篇博文 下单快发货慢:1个多 JOIN SQL 引起 SqlClient 读取数据慢的奇特疑问,当时遇到的疑问是从 SQL Server 4008 R2 中查询获取 400 条记录竟然耗时 10 多秒,排查中发现疑问与 SQL  查询中蕴藏 INNER JOIN 有关,加进去 INNER JOIN 立马查询很慢。当时天真地以为原困是 JOIN 的那张表数据记录不多以及主表聚集索引不合理,于是采用将 INNER JOIN 偏离 拆分出来单独查询临时处里了疑问。

这三三十天 他们都都都 又在另外1个多 ASP.NET Core 2.2 项目中也遇到了查询 400 数据库记录效率慢(须要4~6秒)的疑问,何如让所查询的数据库表数据量并有的是很大。通过 EF Core 的 日志记录发现耗时地处在 Executed DbCommand 时,耗时地处点与前一天的情况报告不一样,前一天是地处在 Executed DbCommand 前一天 SqlDataReader 从数据库读取数据时。

2019-05-11T14:21:38.1015229+08:00 [INFORMATION] Executed DbCommand ("5,8400"ms)

而通过 SQL Server Management Studio 执行同样的 SQL 句子只须要 20 毫秒左右,相差400多倍。

Executed DbCommand 日志记录的是 dbCommand.ExecuteReaderAsync 执行的时间(详见 EF Core 的源码)

result = new RelationalDataReader(
    connection,
    dbCommand,
    await dbCommand.ExecuteReaderAsync(cancellationToken),
    commandId,
    Logger);

dbCommand.ExecuteReaderAsync 的实现代码在 corefx 的 System.Data.SqlClient 中,不可能 是 .net core 的疑问,那疑问就出在 System.Data.SqlClient 。

在上次排查 SqlDataReader 读取数据效率慢疑问,就曾怀疑 System.Data.SqlClient ,花了好多好多 时间在 System.Data.SqlClient 的源码中打点排查,最终这么找到线索,这次不敢轻易怀疑它。

随便说说这次的耗时地处点与上次不一样,但这次的 SQL 查询句子蕴藏个地方和上次是一样的,也蕴藏 INNER JOIN 查询,于是试着加进去 INNER JOIN ,Executed DbCommand 只需2毫秒。

[INFORMATION] Executed DbCommand ("2"ms)

啊,何如在么在也与 INNER JOIN 有关,没道理啊,这次 JOIN 的表数据量不大,完整无需可能 造成 400 多倍的性能之差。看来上次归罪于 INNER JOIN ,不可能 是冤枉它了,得重新思考与排查一种生活 疑问。

不可能 疑问是在某个时间点前一天出显,于是采取笨妙招,回退 git 提交历史直至疑问消失。。。

最终发现,竟然是在一次 git commit 中给一种生活 查询在 SELECT 时增加了1个多字段引起的, 加进去一种生活 字段,疑问立马消失。进一步测试发现,倘若任意加进去 SELECT 中的1个多字段,就无需出显显象,太奇怪了。数了数 SELECT 蕴藏20个字段,难道与 SELECT 字段的数量有关?前一天的项目会无需也与 SELECT 字段的数量有关?

于是回到前一天的项目,恢复 INNER JOIN 查询,这时惊讶地发现 SqlDataReader 读取数据效率慢的疑问竟然消失了。回想当时处里疑问后到现在所做的变更,唯一的变更好多好多 从 .NET Core 3.0 Preivew 4 升级到 .NET Core 3.0 Preivew 5 ,难道 3.0 Preivew 5 把一种生活 疑问给修复了?难道真的是 System.Data.SqlClient 的 bug ?

答案很容易验证,将当前遇到 Executed DbCommand 执行慢的项目升级到 .NET Core 3.0 Preivew 5 ,昨天晚上完成升级后

Executed DbCommand ("3"ms)

飞流直下三千尺,从4秒骤降到3毫秒,相差4000多倍!你以为是 System.Data.SqlClient 的1个多大 bug ,1个多潜藏你要(离米 从 .NET Core 2.1 到 3.0 Preview 4)的巨坑。

一种生活 诡异疑问的谜底在偶然间终于被解开了,这时又产生了新的疑问 —— corefx 中是何如修复一种生活 巨坑 bug 的?

查看 corefx 中与 System.Data.SqlClient 相关的 git commits ,目测发现下面的 commit (对应的 PR ),跟我说是一种生活 commit 修复的,接下来找时间验证一下。