ushmz / isucon-utils

0 stars 1 forks source link

pt-query-digest@15:00 #50

Closed ushmz closed 1 year ago

ushmz commented 2 years ago


# A software update is available:

# 400ms user time, 190ms system time, 41.57M rss, 33.14G vsz
# Current date: Sat Jul  9 15:00:29 2022
# Hostname: kahma
# Files: log/150017/slow.log
# Overall: 822 total, 8 unique, 12.45 QPS, 1.82x concurrency _____________
# Time range: 2022-07-09 14:50:10 to 14:51:16
# Attribute          total     min     max     avg     95%  stddev  median
# ============     ======= ======= ======= ======= ======= ======= =======
# Exec time           120s   100ms   345ms   146ms   219ms    42ms   128ms
# Lock time           91ms       0    13ms   110us   301us   595us    19us
# Rows sent        381.71k       0   1.49k  475.51   1.20k  448.12  400.73
# Rows examine      40.91M       0  72.22k  50.97k  68.96k  15.47k  51.46k
# Rows affecte          32       0      28    0.04       0    0.96       0
# Bytes sent        58.31M      11 242.86k  72.63k 182.98k  67.82k  62.55k
# Query size       893.82k       6 790.36k   1.09k  151.03  26.25k  124.25

# Profile
# Rank Query ID                            Response time Calls R/Call V/M 
# ==== =================================== ============= ===== ====== ====
#    1 0x931A992E852C61FC6D46141A39DEF4FE  38.8012 32.3%   285 0.1361  0.01 SELECT isu_condition
#    2 0x9C6C682008AE0D08F3E2A0049B030C70  38.5163 32.1%   264 0.1459  0.01 SELECT isu_condition
#    3 0x8155B89FFD74A9D523D19AC409FD97AF  27.7962 23.1%   183 0.1519  0.01 SELECT isu_condition
#    4 0x5F580A12ADA1633C9634298BE5BD9422   8.3271  6.9%    61 0.1365  0.01 SELECT isu_condition
#    5 0xFFFCA4D67EA0A788813031B8BBC3B329   5.0997  4.2%    21 0.2428  0.02 COMMIT
# MISC 0xMISC                               1.6315  1.4%     8 0.2039   0.0 <3 ITEMS>

# Query 1: 6.06 QPS, 0.83x concurrency, ID 0x931A992E852C61FC6D46141A39DEF4FE at byte 926451
# Scores: V/M = 0.01
# Time range: 2022-07-09 14:50:29 to 14:51:16
# Attribute    pct   total     min     max     avg     95%  stddev  median
# ============ === ======= ======= ======= ======= ======= ======= =======
# Count         34     285
# Exec time     32     39s   100ms   255ms   136ms   208ms    34ms   122ms
# Lock time     38    35ms    12us    13ms   124us   273us   796us    19us
# Rows sent     47 182.67k       6   1.49k  656.32   1.26k  470.13  719.66
# Rows examine  32  13.44M  15.19k  72.22k  48.27k  65.68k  13.72k  46.68k
# Rows affecte   0       0       0       0       0       0       0       0
# Bytes sent    47  27.89M   1.45k 242.86k 100.22k 201.74k  71.42k 112.33k
# Query size     3  32.01k     115     115     115     115       0     115
# String:
# Databases    isucondition
# Hosts        localhost
# Users        isucon
# Query_time distribution
#   1us
#  10us
# 100us
#   1ms
#  10ms
# 100ms  ################################################################
#    1s
#  10s+
# Tables
#    SHOW TABLE STATUS FROM `isucondition` LIKE 'isu_condition'\G
#    SHOW CREATE TABLE `isucondition`.`isu_condition`\G
# EXPLAIN /*!50100 PARTITIONS*/
SELECT * FROM `isu_condition` WHERE `jia_isu_uuid` = '6d69647a-b816-4540-9e60-1d43c774df94' ORDER BY timestamp DESC\G

# Query 2: 6.14 QPS, 0.90x concurrency, ID 0x9C6C682008AE0D08F3E2A0049B030C70 at byte 1021437
# Scores: V/M = 0.01
# Time range: 2022-07-09 14:50:33 to 14:51:16
# Attribute    pct   total     min     max     avg     95%  stddev  median
# ============ === ======= ======= ======= ======= ======= ======= =======
# Count         32     264
# Exec time     32     39s   100ms   313ms   146ms   208ms    37ms   134ms
# Lock time     25    23ms    12us     2ms    88us   287us   270us    20us
# Rows sent     36 139.67k      18   1.41k  541.77   1.04k  321.86  511.45
# Rows examine  34  14.24M  19.39k  72.05k  55.23k  65.68k  10.36k  56.74k
# Rows affecte   0       0       0       0       0       0       0       0
# Bytes sent    37  21.61M   3.19k 205.34k  83.83k 165.97k  50.40k  79.83k
# Query size     4  40.48k     157     157     157     157       0     157
# String:
# Databases    isucondition
# Hosts        localhost
# Users        isucon
# Query_time distribution
#   1us
#  10us
# 100us
#   1ms
#  10ms
# 100ms  ################################################################
#    1s
#  10s+
# Tables
#    SHOW TABLE STATUS FROM `isucondition` LIKE 'isu_condition'\G
#    SHOW CREATE TABLE `isucondition`.`isu_condition`\G
# EXPLAIN /*!50100 PARTITIONS*/
SELECT * FROM `isu_condition` WHERE `jia_isu_uuid` = '6f6330a5-a0f8-4962-a92b-99e0137dc045' AND `timestamp` < '2021-08-16 00:52:53' ORDER BY `timestamp` DESC\G

# Query 3: 4.95 QPS, 0.75x concurrency, ID 0x8155B89FFD74A9D523D19AC409FD97AF at byte 1100886
# Scores: V/M = 0.01
# Time range: 2022-07-09 14:50:39 to 14:51:16
# Attribute    pct   total     min     max     avg     95%  stddev  median
# ============ === ======= ======= ======= ======= ======= ======= =======
# Count         22     183
# Exec time     23     28s   100ms   345ms   152ms   208ms    39ms   141ms
# Lock time     32    30ms    10us     9ms   161us   467us   703us    20us
# Rows sent      0     183       1       1       1       1       0       1
# Rows examine  24  10.05M  25.85k  70.52k  56.24k  68.96k  12.51k  59.57k
# Rows affecte   0       0       0       0       0       0       0       0
# Bytes sent     0 132.98k     720     789  744.09  755.64   12.76  719.66
# Query size     2  22.34k     125     125     125     125       0     125
# String:
# Databases    isucondition
# Hosts        localhost
# Users        isucon
# Query_time distribution
#   1us
#  10us
# 100us
#   1ms
#  10ms
# 100ms  ################################################################
#    1s
#  10s+
# Tables
#    SHOW TABLE STATUS FROM `isucondition` LIKE 'isu_condition'\G
#    SHOW CREATE TABLE `isucondition`.`isu_condition`\G
# EXPLAIN /*!50100 PARTITIONS*/
SELECT * FROM `isu_condition` WHERE `jia_isu_uuid` = 'e4137943-f223-4aca-bbe2-5cae0afba2a0' ORDER BY `timestamp` DESC LIMIT 1\G

# Query 4: 1.11 QPS, 0.15x concurrency, ID 0x5F580A12ADA1633C9634298BE5BD9422 at byte 811043
# Scores: V/M = 0.01
# Time range: 2022-07-09 14:50:19 to 14:51:14
# Attribute    pct   total     min     max     avg     95%  stddev  median
# ============ === ======= ======= ======= ======= ======= ======= =======
# Count          7      61
# Exec time      6      8s   100ms   288ms   137ms   189ms    35ms   122ms
# Lock time      2     3ms    12us   313us    42us   113us    48us    19us
# Rows sent     15  59.18k      50   1.25k  993.49   1.20k  247.87   1.09k
# Rows examine   7   3.01M   2.65k  68.65k  50.57k  65.68k  12.48k  51.46k
# Rows affecte   0       0       0       0       0       0       0       0
# Bytes sent    14   8.67M   8.00k 184.29k 145.51k 174.27k  33.59k 158.07k
# Query size     0   6.91k     116     116     116     116       0     116
# String:
# Databases    isucondition
# Hosts        localhost
# Users        isucon
# Query_time distribution
#   1us
#  10us
# 100us
#   1ms
#  10ms
# 100ms  ################################################################
#    1s
#  10s+
# Tables
#    SHOW TABLE STATUS FROM `isucondition` LIKE 'isu_condition'\G
#    SHOW CREATE TABLE `isucondition`.`isu_condition`\G
# EXPLAIN /*!50100 PARTITIONS*/
SELECT * FROM `isu_condition` WHERE `jia_isu_uuid` = '13df7ba1-1273-409d-aa8f-755c70f9e52f' ORDER BY `timestamp` ASC\G

# Query 5: 0.58 QPS, 0.14x concurrency, ID 0xFFFCA4D67EA0A788813031B8BBC3B329 at byte 814936
# Scores: V/M = 0.02
# Time range: 2022-07-09 14:50:19 to 14:50:55
# Attribute    pct   total     min     max     avg     95%  stddev  median
# ============ === ======= ======= ======= ======= ======= ======= =======
# Count          2      21
# Exec time      4      5s   100ms   319ms   243ms   308ms    77ms   279ms
# Lock time      0       0       0       0       0       0       0       0
# Rows sent      0       0       0       0       0       0       0       0
# Rows examine   0       0       0       0       0       0       0       0
# Rows affecte   0       0       0       0       0       0       0       0
# Bytes sent     0     231      11      11      11      11       0      11
# Query size     0     126       6       6       6       6       0       6
# String:
# Databases    isucondition
# Hosts        localhost
# Users        isucon
# Query_time distribution
#   1us
#  10us
# 100us
#   1ms
#  10ms
# 100ms  ################################################################
#    1s
#  10s+
COMMIT\G
\n```
ushmz commented 1 year ago

issue整理