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

  • 时间:
  • 浏览:2
  • 来源:幸运快3_快3安卓版_幸运快3安卓版

过后发布过一篇博文 下单快发货慢:一有有一个 JOIN SQL 引起 SqlClient 读取数据慢的奇特什么的什么的问题 ,当时遇到的什么的什么的问题 是从 SQL Server 808 R2 中查询获取 80 条记录竟然耗时 10 多秒,排查中发现什么的什么的问题 与 SQL  查询中中有 INNER JOIN 有关,加在 INNER JOIN 立马查询好快了 了 。当时天真地以为因为着是 JOIN 的那张表数据记录不多以及主表聚集索引不合理,于是采用将 INNER JOIN 要素拆分出来单独查询临时避免了什么的什么的问题 。

这两天大伙儿又在另外一有有一个 ASP.NET Core 2.2 项目中也遇到了查询 80 数据库记录速率单位慢(都要4~6秒)的什么的什么的问题 ,其他所查询的数据库表数据量并都是很大。通过 EF Core 的 日志记录发现耗时位于在 Executed DbCommand 时,耗时位于点与过后的情形不一样,过后是位于在 Executed DbCommand 过后 SqlDataReader 从数据库读取数据时。

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

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

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 的表数据量不大,全版可能性性造成 80 多倍的性能之差。看来上次归罪于 INNER JOIN ,可能性是冤枉它了,得重新思考与排查你你两种什么的什么的问题 。

可能性什么的什么的问题 是在某个时间点过后突然出現,于是采取笨土办法,回退 git 提交历史直至什么的什么的问题 消失。。。

最终发现,竟然是在一次 git commit 中给你你两种查询在 SELECT 时增加了一有有一个字段引起的, 加在你你两种字段,什么的什么的问题 立马消失。进一步测试发现,假使 任意加在 SELECT 中的一有有一个字段,就不会突然出現什么的什么的问题 ,太奇怪了。数了数 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毫秒,相差800多倍!简直是 System.Data.SqlClient 的一有有一个大 bug ,一有有一个潜藏并且(共要从 .NET Core 2.1 到 3.0 Preview 4)的巨坑。

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

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