定位消耗系统资源多的查询

    注意,expensive query 日志和慢查询日志的区别是,慢查询日志是在语句执行完后才打印,expensive query 日志可以将正在执行的语句的相关信息打印出来。当一条语句在执行过程中达到资源使用阈值时(执行时间/使用内存量),TiDB 会即时将这条语句的相关信息写入日志。

    字段含义说明

    • :日志打印时语句已经花费的执行时间。
    • stats:语句涉及到的表或索引使用的统计信息版本。值为 pseudo 时表示无可用统计信息,需要对表或索引进行 analyze。
    • table_ids:语句涉及到的表的 ID。
    • txn_start_ts:事务的开始时间戳,也是事务的唯一 ID,可以用这个值在 TiDB 日志中查找事务相关的其他日志。
    • sql:SQL 语句。

    和内存使用相关的字段:

    • user:执行语句的用户名。
    • :用户的连接 ID,可以用类似 con:60026 的关键字在 TiDB 日志中查找该连接相关的其他日志。
    • database:执行语句时使用的 database。

    和 TiKV Coprocessor Task 相关的字段:

    • wait_time:该语句在 TiKV 的等待时间之和,因为 TiKV 的 Coprocessor 线程数是有限的,当所有的 Coprocessor 线程都在工作的时候,请求会排队;当队列中有某些请求耗时很长的时候,后面的请求的等待时间都会增加。
    • request_count:该语句发送的 Coprocessor 请求的数量。
    • total_keys:Coprocessor 扫过的 key 的数量。
    • processed_keys:Coprocessor 处理的 key 的数量。与 total_keys 相比,processed_keys 不包含 MVCC 的旧版本。如果 processed_keys 和 total_keys 相差很大,说明旧版本比较多。
    • :Coprocessor 执行 task 的平均执行时间。
    • process_p90_time:Coprocessor 执行 task 的 P90 分位执行时间。
    • process_max_time:Coprocessor 执行 task 的最长执行时间。
    • process_max_addr:task 执行时间最长的 Coprocessor 所在地址。
    • wait_avg_time:Coprocessor 上 task 的等待时间。
    • wait_p90_time:Coprocessor 上 task 的 P90 分位等待时间。
    • wait_max_time:Coprocessor 上 task 的最长等待时间。