MySQL学习笔记之SQL语句执行过程查看

已于 2023-07-29 09:42:20 修改
阅读量2k 收藏 3
点赞数 1
分类专栏： 数据库 文章标签： mysql
于 2023-07-29 09:41:25 首次发布
版权声明：本文为博主原创文章，遵循 CC 4.0 BY-SA 版权协议，转载请附上原文出处链接和本声明。
本文链接：https://blog.csdn.net/qq_37475168/article/details/131991350
版权

文章目录

参数使能

以select语句为例，首先打开profile参数：

mysql> set profiling = 1;
Query OK, 0 rows affected, 1 warning (0.00 sec)

然后执行两边下面的语句：

mysql> select * from employees;

查看最近一条SQL执行过程

可以通过show profile语句查看最近一条SQL的执行过程：

mysql> show profile;
+----------------------+----------+
| Status               | Duration |
+----------------------+----------+
| starting             | 0.000039 |
| checking permissions | 0.000004 |
| Opening tables       | 0.000012 |
| init                 | 0.000014 |
| System lock          | 0.000006 |
| optimizing           | 0.000002 |
| statistics           | 0.000008 |
| preparing            | 0.000010 |
| executing            | 0.000003 |
| Sending data         | 0.000188 |
| end                  | 0.000004 |
| query end            | 0.000006 |
| closing tables       | 0.000008 |
| freeing items        | 0.000104 |
| cleaning up          | 0.000013 |
+----------------------+----------+
15 rows in set, 1 warning (0.00 sec)

可以看到一条SQL语句要经历上述15步。如果开启了SQL缓存且命中缓存的话，步骤会减少，但SQL缓存要求两条SQL必须完全一样才能命中，任何字符的更改(包括注释、空格等)都会导致缓存没命中，因此MySQL的缓存相当鸡肋，命中率很低。

查看profiling打开开后，所有SQL语句执行耗时

可以通过show profiles开启profiling后所有SQL语句的耗时：

mysql> show profiles;
+----------+------------+-------------------------+
| Query_ID | Duration   | Query                   |
+----------+------------+-------------------------+
|        1 | 0.00070175 | select * from employees |
|        2 | 0.00041950 | select * from employees |
+----------+------------+-------------------------+
2 rows in set, 1 warning (0.00 sec)

查看某一条SQL的执行过程

可以通过show profile for query Query_ID查看：

mysql> show profile for query 1;
+----------------------+----------+
| Status               | Duration |
+----------------------+----------+
| starting             | 0.000036 |
| checking permissions | 0.000004 |
| Opening tables       | 0.000012 |
| init                 | 0.000013 |
| System lock          | 0.000006 |
| optimizing           | 0.000002 |
| statistics           | 0.000008 |
| preparing            | 0.000355 |
| executing            | 0.000006 |
| Sending data         | 0.000169 |
| end                  | 0.000003 |
| query end            | 0.000005 |
| closing tables       | 0.000006 |
| freeing items        | 0.000070 |
| cleaning up          | 0.000007 |
+----------------------+----------+
15 rows in set, 1 warning (0.00 sec)

mysql> show profile for query 2;
+----------------------+----------+
| Status               | Duration |
+----------------------+----------+
| starting             | 0.000039 |
| checking permissions | 0.000004 |
| Opening tables       | 0.000012 |
| init                 | 0.000014 |
| System lock          | 0.000006 |
| optimizing           | 0.000002 |
| statistics           | 0.000008 |
| preparing            | 0.000010 |
| executing            | 0.000003 |
| Sending data         | 0.000188 |
| end                  | 0.000004 |
| query end            | 0.000006 |
| closing tables       | 0.000008 |
| freeing items        | 0.000104 |
| cleaning up          | 0.000013 |
+----------------------+----------+
15 rows in set, 1 warning (0.00 sec)

指定要查看的性能选项

mysql> show profile CPU, block io;
+---------------+----------+----------+------------+--------------+---------------+
| Status        | Duration | CPU_user | CPU_system | Block_ops_in | Block_ops_out |
+---------------+----------+----------+------------+--------------+---------------+
| starting      | 0.000066 | 0.000000 |   0.000000 |         NULL |          NULL |
| freeing items | 0.000058 | 0.000000 |   0.000000 |         NULL |          NULL |
| cleaning up   | 0.000004 | 0.000000 |   0.000000 |         NULL |          NULL |
+---------------+----------+----------+------------+--------------+---------------+
3 rows in set, 1 warning (0.00 sec)

查看所有性能选项

mysql> show profile all for query 1\G
*************************** 1. row ***************************
             Status: starting
           Duration: 0.000036
           CPU_user: 0.000000
         CPU_system: 0.000000
  Context_voluntary: NULL
Context_involuntary: NULL
       Block_ops_in: NULL
      Block_ops_out: NULL
      Messages_sent: NULL
  Messages_received: NULL
  Page_faults_major: NULL
  Page_faults_minor: NULL
              Swaps: NULL
    Source_function: NULL
        Source_file: NULL
        Source_line: NULL
*************************** 2. row ***************************
             Status: checking permissions
           Duration: 0.000004
           CPU_user: 0.000000
         CPU_system: 0.000000
  Context_voluntary: NULL
Context_involuntary: NULL
       Block_ops_in: NULL
      Block_ops_out: NULL
      Messages_sent: NULL
  Messages_received: NULL
  Page_faults_major: NULL
  Page_faults_minor: NULL
              Swaps: NULL
    Source_function: check_access
        Source_file: sql_authorization.cc
        Source_line: 802
*************************** 3. row ***************************
             Status: Opening tables
           Duration: 0.000012
           CPU_user: 0.000000
         CPU_system: 0.000000
  Context_voluntary: NULL
Context_involuntary: NULL
       Block_ops_in: NULL
      Block_ops_out: NULL
      Messages_sent: NULL
  Messages_received: NULL
  Page_faults_major: NULL
  Page_faults_minor: NULL
              Swaps: NULL
    Source_function: open_tables
        Source_file: sql_base.cc
        Source_line: 5714
*************************** 4. row ***************************
             Status: init
           Duration: 0.000013
           CPU_user: 0.000000
         CPU_system: 0.000000
  Context_voluntary: NULL
Context_involuntary: NULL
       Block_ops_in: NULL
      Block_ops_out: NULL
      Messages_sent: NULL
  Messages_received: NULL
  Page_faults_major: NULL
  Page_faults_minor: NULL
              Swaps: NULL
    Source_function: handle_query
        Source_file: sql_select.cc
        Source_line: 121
*************************** 5. row ***************************
             Status: System lock
           Duration: 0.000006
           CPU_user: 0.000000
         CPU_system: 0.000000
  Context_voluntary: NULL
Context_involuntary: NULL
       Block_ops_in: NULL
      Block_ops_out: NULL
      Messages_sent: NULL
  Messages_received: NULL
  Page_faults_major: NULL
  Page_faults_minor: NULL
              Swaps: NULL
    Source_function: mysql_lock_tables
        Source_file: lock.cc
        Source_line: 323
*************************** 6. row ***************************
             Status: optimizing
           Duration: 0.000002
           CPU_user: 0.000000
         CPU_system: 0.000000
  Context_voluntary: NULL
Context_involuntary: NULL
       Block_ops_in: NULL
      Block_ops_out: NULL
      Messages_sent: NULL
  Messages_received: NULL
  Page_faults_major: NULL
  Page_faults_minor: NULL
              Swaps: NULL
    Source_function: JOIN::optimize
        Source_file: sql_optimizer.cc
        Source_line: 151
*************************** 7. row ***************************
             Status: statistics
           Duration: 0.000008
           CPU_user: 0.000000
         CPU_system: 0.000000
  Context_voluntary: NULL
Context_involuntary: NULL
       Block_ops_in: NULL
      Block_ops_out: NULL
      Messages_sent: NULL
  Messages_received: NULL
  Page_faults_major: NULL
  Page_faults_minor: NULL
              Swaps: NULL
    Source_function: JOIN::optimize
        Source_file: sql_optimizer.cc
        Source_line: 367
*************************** 8. row ***************************
             Status: preparing
           Duration: 0.000355
           CPU_user: 0.000000
         CPU_system: 0.000000
  Context_voluntary: NULL
Context_involuntary: NULL
       Block_ops_in: NULL
      Block_ops_out: NULL
      Messages_sent: NULL
  Messages_received: NULL
  Page_faults_major: NULL
  Page_faults_minor: NULL
              Swaps: NULL
    Source_function: JOIN::optimize
        Source_file: sql_optimizer.cc
        Source_line: 475
*************************** 9. row ***************************
             Status: executing
           Duration: 0.000006
           CPU_user: 0.000000
         CPU_system: 0.000000
  Context_voluntary: NULL
Context_involuntary: NULL
       Block_ops_in: NULL
      Block_ops_out: NULL
      Messages_sent: NULL
  Messages_received: NULL
  Page_faults_major: NULL
  Page_faults_minor: NULL
              Swaps: NULL
    Source_function: JOIN::exec
        Source_file: sql_executor.cc
        Source_line: 119
*************************** 10. row ***************************
             Status: Sending data
           Duration: 0.000169
           CPU_user: 0.000000
         CPU_system: 0.000000
  Context_voluntary: NULL
Context_involuntary: NULL
       Block_ops_in: NULL
      Block_ops_out: NULL
      Messages_sent: NULL
  Messages_received: NULL
  Page_faults_major: NULL
  Page_faults_minor: NULL
              Swaps: NULL
    Source_function: JOIN::exec
        Source_file: sql_executor.cc
        Source_line: 195
*************************** 11. row ***************************
             Status: end
           Duration: 0.000003
           CPU_user: 0.000000
         CPU_system: 0.000000
  Context_voluntary: NULL
Context_involuntary: NULL
       Block_ops_in: NULL
      Block_ops_out: NULL
      Messages_sent: NULL
  Messages_received: NULL
  Page_faults_major: NULL
  Page_faults_minor: NULL
              Swaps: NULL
    Source_function: handle_query
        Source_file: sql_select.cc
        Source_line: 199
*************************** 12. row ***************************
             Status: query end
           Duration: 0.000005
           CPU_user: 0.000000
         CPU_system: 0.000000
  Context_voluntary: NULL
Context_involuntary: NULL
       Block_ops_in: NULL
      Block_ops_out: NULL
      Messages_sent: NULL
  Messages_received: NULL
  Page_faults_major: NULL
  Page_faults_minor: NULL
              Swaps: NULL
    Source_function: mysql_execute_command
        Source_file: sql_parse.cc
        Source_line: 4946
*************************** 13. row ***************************
             Status: closing tables
           Duration: 0.000006
           CPU_user: 0.000000
         CPU_system: 0.000000
  Context_voluntary: NULL
Context_involuntary: NULL
       Block_ops_in: NULL
      Block_ops_out: NULL
      Messages_sent: NULL
  Messages_received: NULL
  Page_faults_major: NULL
  Page_faults_minor: NULL
              Swaps: NULL
    Source_function: mysql_execute_command
        Source_file: sql_parse.cc
        Source_line: 4998
*************************** 14. row ***************************
             Status: freeing items
           Duration: 0.000070
           CPU_user: 0.000000
         CPU_system: 0.000000
  Context_voluntary: NULL
Context_involuntary: NULL
       Block_ops_in: NULL
      Block_ops_out: NULL
      Messages_sent: NULL
  Messages_received: NULL
  Page_faults_major: NULL
  Page_faults_minor: NULL
              Swaps: NULL
    Source_function: mysql_parse
        Source_file: sql_parse.cc
        Source_line: 5610
*************************** 15. row ***************************
             Status: cleaning up
           Duration: 0.000007
           CPU_user: 0.000000
         CPU_system: 0.000000
  Context_voluntary: NULL
Context_involuntary: NULL
       Block_ops_in: NULL
      Block_ops_out: NULL
      Messages_sent: NULL
  Messages_received: NULL
  Page_faults_major: NULL
  Page_faults_minor: NULL
              Swaps: NULL
    Source_function: dispatch_command
        Source_file: sql_parse.cc
        Source_line: 1924
15 rows in set, 1 warning (0.00 sec)
举其中的一行为例：

*************************** 10. row ***************************
             Status: Sending data
           Duration: 0.000169
           CPU_user: 0.000000
         CPU_system: 0.000000
  Context_voluntary: NULL
Context_involuntary: NULL
       Block_ops_in: NULL
      Block_ops_out: NULL
      Messages_sent: NULL
  Messages_received: NULL
  Page_faults_major: NULL
  Page_faults_minor: NULL
              Swaps: NULL
    Source_function: JOIN::exec
        Source_file: sql_executor.cc
        Source_line: 195

每一行数据就显示该步骤下的各个阶段的耗时，甚至源文件等信息。

coder_szc
关注
  • 1
    点赞
  • 踩
  • 3
    收藏
    觉得还不错? 一键收藏
  • 0
    评论
专栏目录
SQL教程 之查看 SQL 的执行顺序
iCloudEnd的博客
08-17 801
在编写了大量 SQL 脚本之后，您可能会在性能方面达到某种形式的平台期。您使用相同的策略提取见解并遇到相同类型的错误。幸运的是，您可以通过花时间了解如何评估 SQL 中的子句来改善编写查询的体验。在这里，我们讨论 SQL 中的执行顺序并解释它的重要性。......
Mysql——Sql查询语句的执行过程
zekser的博客
03-27 1003
从上层视角解释了SQL查询语句的执行过程，解释了会经过mysql的哪些组件，以及各个组件起到的作用和目的
mysql 拼接sql批量执行_MySQL的sql执行步骤及优化
weixin_39739846的博客
11-28 507
简单来说MySQL的sql执行过程如下:客户端发送一条查询给服务器；服务器先检查查询缓存，如果命中了缓存，则立刻返回存储在缓存中的结果。否则进入下一阶段。服务器段进行SQL解析、预处理，在优化器生成对应的执行计划；MySQL根据优化器生成的执行计划，调用存储引擎的API来执行查询。将结果返回给客户端。1、MySQL客户端和服务器通讯 MySQL客户端和服务器之间的通讯协议是“半双工”的，这意...
MySQL事件event的定义和查看SQL示例
最新发布
学亮编程手记
05-13 473
假设我们要创建一个事件，该事件每天凌晨1点自动删除表logs中的旧记录，假设我们认为30天前的记录为“旧记录”。ON SCHEDULE EVERY 1 DAY STARTS '2023-04-01 01:00:00' -- 从2023年4月1日开始，每天1点执行DOBEGINEND$$DELIMITER;和DELIMITER;是用来改变语句结束的标记，因为在事件定义中可能需要使用分号，所以先改变DELIMITER避免冲突。创建了一个名为的事件。
mysql查询历史执行sql记录
qq_35048277的博客
10-17 7775
- 如果 log_output 不是 TABLE，则设置为 TABLE 输出。-- 如果 general_log = OFF，执行脚本关闭日志。-- 1、查看 general_log 是否开启。mysql查询历史执行sql记录。-- 2、查看输出方式。
查看MySQL记录执行过的SQL
热门推荐
KEN的专栏
05-26 3万+
第一种:查Slow query的SQL语法: log_slow_queries = /var/log/mysql/mysql-slow.loglong_query_time = 2 (超过2秒的SQL语法记录起来,设短一点来记录除错也是一种方法.)  第二种:设MySQL Replication用binlog: log_bin = /var/log/my
[MySQL]SQL语句查询执行流程
qq_39535439的博客
12-14 320
JHT2212-day01 查询一条SQL的流程
mysql如何查看正在执行的sql_MySQL中如何查看正在执行的SQL语句？
weixin_39562327的博客
01-19 1万+
【此为"一森咖记"公众号——第126篇文章】读完需要10分钟速读仅需5分钟【引言】如何在MySQL中查看正在执行的SQL语句有哪些，今天念叨下这件事。大家都知道，linux环境中很容易通过操作系统top看到执行时间长的进程pid号，根据pid号，再通过oracle的视图v$session，v$process，v$sqltext追到到执行sid，从而查到具体的sql语句。示例如下：SQL语句SELE...
读书-高性能MySQL 第三章
小谷的博客
02-01 951
服务器性能剖析 : 最经常碰到的三个性能相关的服务请求是：如何确认服务器是否达到了性能最佳的状态，找出某条语句为什么执行不够快，以及诊断被用户描述成“停顿”、“堆积”或者“卡死”的某些间歇性阴暗故障。核心方法是专注于服务器的时间花费在哪里，使用的 技术则是性能剖析工具（profiling）。本章，将展示如何测量系统并生成剖析报告，以及如何分析系统的整个对渣（stack），包括从应用程序到数据库...
怎么看mysql执行计划
zs_lin的博客
03-23 8769
前言 mysql是关系型数据库中比较流行的一款数据库。在工作中使用mysql，难免会遇到sql执行缓慢的情况。这时候，我们就需要查看sql的执行计划，以此来分析sql执行缓慢的问题所在。 如何查看mysql执行计划 方法一：使用explain（推荐） explain select * from t_user; 方法二：使用Navicat解释执行 执行计划结果 下面，我们依次解析每个字段的含义。 id（重要） 表示表的读取顺序，分为两种情况： id相同，读表顺序...
数据库系列1：SQL查询语句的执行过程
纵横千里 捭阖四方 的专栏
04-08 593
当我们通过终端或者其他方式连接到数据库进行SQL操作时，整个过程是怎么样的呢？理解该过程有利于了解Mysql的架构和优化方法，我们就来看一下。 1.执行过程 执行整体过程如下所示： 具体来说有以下步骤： 1.1.建立连接 Mysql服务监听的默认端口是3306，客户端可以采用多种方式连接服务端。可以是同步的，也可以是异步的，可以是长连接也可以是短连接，可以是TCP也可以是Socket。如果想看当前Mysql有多少个连接，可以使用如下的命令： show status like 'Thread%'; 例如我
java学习笔记之sql常用语句
12-14
DDL(Data Definition Language)：数据库定义语句； 　DML(Data Manipulation Language)：用于增删改查数据库中数据； 　DCL(Data Control Language)用来向用户赋予/取消对数据...”，但执行mysql语句则需要加“;”
mysql学习笔记之完整的select语句用法实例详解
12-14
本文实例讲述了mysql学习笔记之完整的select语句用法。分享给大家供大家参考，具体如下： 本文内容： 完整语法 去重选项 字段别名 数据源 where group by having order by limit 首发日期：2018-04-11 ...
Mysql学习笔记（基础）基础sql语句详细记录
12-14
数据库学习（基础） // 个人网课学习记录，如果有违规等问题，请联系我删除~ mysql下载安装（ 解压版安装配置 下载版安装配置 ） 需求分析：使用cmd命令来创建一个数据库，并对数据库中得一张分类表进行增删改查得...
MySQL中的基本查询语句学习笔记
12-15
1.基本查询语句 select 属性列表 from 表名和视图列表 [where 条件表达式1] [group by 属性名1 [having 条件表达式2]] [order by 属性名2 [asc|desc]] 2.单表查询 1）使用*查询所有字段 select * from 表名； 2）...
MySQL学习笔记之DQL(六)
01-20
查询语句(DQL)的使用 我们在演示之前先建一个表，如下： CREATE TABLE student02( id INT, NAME VARCHAR(32), age INT, sex VARCHAR(16), address VARCHAR(16), math INT, english INT ); 然后插入一些数据...
MySQL(二)查询执行流程
weixin_44149903的博客
02-07 313
下图是MySQL查询路径 半双工，a向b发送，等到b接收完成后才能响应，然后才可以发下一条指令 比方对讲机，你说完，另一个人才能说 select * from user where username=‘123’; 连接时间可以修改，这些参数都可以在官网上查找到的，不用记 查询缓存，先去查询缓存，直接返回结果（sql语句和之前的一样） 默认关闭，打开/etc/my.cnf文件进行配置que...
mysql监控sql执行情况
weixin_42274846的博客
12-03 486
mysql如何监控sql执行情况
MySQL查询的执行流程
骑个小蜗牛的博客
09-28 4307
MySQL分层 1. Server层 2. 存储引擎层 查询的执行流程 1. 建立连接 MySQL通信 2. 发送SQL 3. 查询缓存 4. 解析器 5. 预处理器 6. 查询优化器 7. 查询执行引擎
MySQL架构学习笔记
06-13
MySQL是一种关系型数据库管理系统，其架构主要由以下几个组件构成： 1. 连接器（Connection Manager）：负责与客户端建立连接、进行身份认证、维护连接池等。 2. 查询缓存（Query Cache）：缓存查询结果，避免重复查询相同的结果集。 3. 分析器（Parser）：对SQL语句进行解析，并创建相应的内部数据结构，以便执行器能够更好地理解SQL语句。 4. 优化器（Optimizer）：对查询执行计划进行优化，选择最优的执行计划来提高查询效率。 5. 执行器（Execution Engine）：执行SQL语句，获取数据，并返回给客户端。 6. 存储引擎（Storage Engine）：负责表的存储和读写，MySQL支持多种存储引擎，如InnoDB、MyISAM等。 其中，连接器、查询缓存、分析器和优化器组成了MySQL的“前端”，执行器和存储引擎组成了MySQL的“后端”。MySQL的架构设计非常灵活，允许用户根据实际需求选择不同的组件来构建自己的数据库系统。

“相关推荐”对你有帮助么？

  • 非常没帮助
  • 没帮助
  • 一般
  • 有帮助
  • 非常有帮助
提交
评论
添加红包

请填写红包祝福语或标题

个

红包个数最小为10个

元

红包金额最低5元

当前余额3.43元 前往充值 >
需支付：10.00元
成就一亿技术人!
领取后你会自动成为博主和红包主的粉丝 规则
hope_wisdom
发出的红包
实付元
使用余额支付
点击重新获取
扫码支付
钱包余额 0

抵扣说明：

1.余额是钱包充值的虚拟货币，按照1:1的比例进行支付金额的抵扣。
2.余额无法直接购买下载，可以购买VIP、付费专栏及课程。

余额充值