Open github-actions[bot] opened 10 months ago
COUNT | 1XX | 2XX | 3XX | 4XX | 5XX | METHOD | URI | MIN | MAX | SUM | AVG | P90 | P95 | P99 | STDDEV | MIN(BODY) | MAX(BODY) | SUM(BODY) | AVG(BODY) |
---|
Reading from STDIN ...
# 23.6s user time, 110ms system time, 35.83M rss, 42.23M vsz
# Current date: Sat Nov 25 08:27:54 2023
# Hostname: ip-192-168-0-12
# Files: STDIN
# Overall: 398.37k total, 76 unique, 5.04k QPS, 0.91x concurrency ________
# Time range: 2023-11-25T08:25:22 to 2023-11-25T08:26:41
# Attribute total min max avg 95% stddev median
# ============ ======= ======= ======= ======= ======= ======= =======
# Exec time 72s 1us 374ms 179us 214us 1ms 42us
# Lock time 144ms 0 3ms 0 1us 7us 0
# Rows sent 286.48k 0 7.58k 0.74 0.99 32.37 0
# Rows examine 40.92M 0 19.52k 107.71 0.99 880.12 0
# Query size 17.98M 6 1.94M 47.33 59.77 3.27k 31.70
# Profile
# Rank Query ID Response time Calls R/Call V/M
# ==== ================================== ============= ====== ====== ====
# 1 0xFFFCA4D67EA0A788813031B8BBC3B329 17.2678 24.1% 11136 0.0016 0.00 COMMIT
# 2 0x59F1B6DD8D9FEC059E55B3BFD624E8C3 10.0970 14.1% 2821 0.0036 0.00 SELECT reservation_slots
# 3 0x9EAD6C0CE525E3693EE27FFC9AAF05A3 6.8703 9.6% 710 0.0097 0.00 SELECT livestreams
# 4 0xDA556F9115773A1A99AA0165670CE848 6.8492 9.6% 124112 0.0001 0.00 ADMIN PREPARE
# 5 0xDFFCC1D78939C4D781C7C58349101F50 3.7566 5.2% 1000 0.0038 0.00 INSERT users
# 6 0xD2A0864774622BA36F6557496405CF75 3.6591 5.1% 1386 0.0026 0.00 INSERT themes
# 7 0x38BC86A45F31C6B1EE324671506C898A 2.7014 3.8% 27259 0.0001 0.00 SELECT themes
# 8 0xA3401CA3ABCC04C3AB221DB8AD5CBF26 2.6240 3.7% 288 0.0091 0.00 UPDATE reservation_slots
# 9 0x7F9C0C0BA9473953B723EE16C08655F1 2.3866 3.3% 290 0.0082 0.00 SELECT reservation_slots
# 10 0xD6032FE08E1FE706A928B8B7CBA06B85 2.1983 3.1% 29699 0.0001 0.00 SELECT livestreams
# 11 0xEA1E6309EEEFF9A6831AD2FB940FC23C 1.9724 2.8% 26861 0.0001 0.00 SELECT users
# 12 0xB78E63D0D9C72DDDAB7A3E53517FA04C 1.4451 2.0% 1169 0.0012 0.00 SELECT livecomments
# 13 0x9FE1EB375E9ADFD57E719AA0C2924155 1.3062 1.8% 1338 0.0010 0.00 SELECT livecomments
# 14 0xAD0C28443E1E5CFAFF1569DBB4F7E63A 1.1929 1.7% 1201 0.0010 0.00 SELECT reactions
# 15 0x3F155F5E71EFF856F0CF7B8430DE8C23 1.0819 1.5% 12365 0.0001 0.00 SELECT users
# 16 0x07890000813C4CC7111FD2D3F3B3B4EB 0.5803 0.8% 124106 0.0000 0.00 ADMIN CLOSE STMT
# 17 0x02B6A87E51A5A1B7646675DB67C57DE3 0.3742 0.5% 1 0.3742 0.00 INSERT ng_words
# 18 0x98F959E03B684A5538FD8402A0EE94AD 0.3735 0.5% 103 0.0036 0.00 INSERT tags
# 19 0x9E2DA589A20EC24C34E11DDE0FBF5564 0.3456 0.5% 11209 0.0000 0.00 START
# 20 0x611999F76068C4DC4F90E0A389918E63 0.3433 0.5% 16 0.0215 0.01 SELECT users livestreams reactions livestreams livecomments
# 21 0x0C1FCBB4E25B178AA3A46D4FECBA9BDC 0.2997 0.4% 22 0.0136 0.00 INSERT livestream_tags
# 22 0x80E10371CE74ED05E09C79C72C73F8E1 0.2676 0.4% 289 0.0009 0.18 INSERT livestreams
# 23 0xF7144185D9A142A426A36DC55C1D2623 0.2500 0.3% 2783 0.0001 0.00 SELECT livestream_tags
# 24 0x4B6FA79E206C6CED71D433A2FC998D69 0.2425 0.3% 3228 0.0001 0.00 SELECT
# 25 0x5D469B53C536D19CD15E40763ACC23C7 0.2211 0.3% 1362 0.0002 0.01 INSERT livestream_tags
# 26 0x64CC8A4E8E4B390203375597CE4D611F 0.2067 0.3% 1581 0.0001 0.00 SELECT ng_words
# 27 0x55C45664C0A27CA4AF92DD1D2D0ABDAA 0.1946 0.3% 2750 0.0001 0.00 SELECT tags
# 28 0xF3A502CCF34F7DA288CC1B75AD5AFA37 0.1921 0.3% 1580 0.0001 0.00 INSERT livecomments
# 29 0xE4555A2709C09FD9BFF6688D80B0AA49 0.1832 0.3% 7 0.0262 0.01 SELECT livestreams reactions livecomments
# 30 0x24C44C3518CE12293EF12410AEDA2393 0.1813 0.3% 881 0.0002 0.00 SELECT livestreams
# 31 0xEE4C51AE2BF74414C4892CBE11E894AA 0.1346 0.2% 114 0.0012 0.00 SELECT livecomments
# 32 0x5AEB6E4A781A3854CF642125E293FEE0 0.1282 0.2% 1183 0.0001 0.00 INSERT reactions
# 33 0xDF0AAE38E2AAFC85E6F50569CEF2285D 0.1256 0.2% 1 0.1256 0.00 INSERT reservation_slots
# 34 0xE64D50F7AFC1AD5F465809A92DF4935E 0.1225 0.2% 113 0.0011 0.00 SELECT reactions
# 35 0x651E3772B8767A368CB47EE7389EEB33 0.1103 0.2% 26 0.0042 0.00 SELECT livestream_tags
# 36 0x466EE4C87B17CAD4E692DE1D44EAD84D 0.1071 0.1% 1190 0.0001 0.00 SELECT livecomment_reports
# 37 0xEDE18C1523658A19E07525EAFCBA6BFE 0.1056 0.1% 862 0.0001 0.00 SELECT ng_words
# 38 0x64052B1C32B30DF53AB3292208B783B4 0.0782 0.1% 387 0.0002 0.00 INSERT users
# 39 0x2B760561C10B5D133155AA306D0F407C 0.0769 0.1% 64 0.0012 0.00 SELECT livecomments
# 40 0x722BF793949484884D382A709285091D 0.0736 0.1% 20 0.0037 0.00 DELETE livecomments
# 41 0xF985E5835B84E84C7A721801818E98CE 0.0667 0.1% 16 0.0042 0.00 SELECT users livestreams reactions
# 42 0x49F80FBE1AC70F23A3DD076174FF1AA9 0.0652 0.1% 16 0.0041 0.00 SELECT users livestreams reactions
# 43 0x0C655718656DD9DDA39A0D11554A0C64 0.0585 0.1% 516 0.0001 0.00 INSERT ng_words
# 44 0xB08B7B7486D2DFE2F2FE9CE78689FD79 0.0555 0.1% 516 0.0001 0.00 SELECT ng_words
# 45 0x544239977D2094F805A7B062DE95673A 0.0450 0.1% 283 0.0002 0.00 SELECT tags
# 46 0x1FB70DBF74628C9F2E9F0C3478771936 0.0406 0.1% 1 0.0406 0.00 TRUNCATE TABLE ng_words
# 47 0xB871CC5B0472067402F5739D108B2C1C 0.0404 0.1% 516 0.0001 0.00 SELECT livestreams
# 48 0x08A6ACD83D579DD8A808134B32AD376B 0.0357 0.0% 1 0.0357 0.00 TRUNCATE TABLE livestream_tags
# 49 0xD2978B45C67B47B5D73AC532EB40A95E 0.0356 0.0% 1 0.0356 0.00 TRUNCATE TABLE themes
# 50 0xDBB1C17D6ABA0156D8ABCE105DDDA1B2 0.0328 0.0% 1 0.0328 0.00 TRUNCATE TABLE users
# 51 0xBB7F4DC4E67BF30E0588D296FFAF009F 0.0316 0.0% 1 0.0316 0.00 TRUNCATE TABLE tags
# 52 0xAFFDC331C1D4BA089978A0B8DD00BFC8 0.0300 0.0% 1 0.0300 0.00 TRUNCATE TABLE livestreams
# 53 0xFB296F703ACC41C3F94A9B7D75044F3C 0.0296 0.0% 1 0.0296 0.00 TRUNCATE TABLE reactions
# 54 0x07F6C3FF39ADD79FC63923A7EE938953 0.0283 0.0% 1 0.0283 0.00 INSERT livecomments
# 55 0x9C697B3F0446BBF7602663588252F020 0.0263 0.0% 1 0.0263 0.00 TRUNCATE TABLE livestream_viewers_history
# 56 0x253CA101A906B3D56A95D1B8DCEE28EF 0.0256 0.0% 1 0.0256 0.00 TRUNCATE TABLE icons
# 57 0x2AAED5867123C749367FD8E4BBD796D2 0.0255 0.0% 1 0.0255 0.00 TRUNCATE TABLE livecomments
# 58 0x93A42F50BF286ACA749DF5F342FAC07B 0.0252 0.0% 1 0.0252 0.00 TRUNCATE TABLE livecomment_reports
# 59 0xA7C2E59AEF14D03CB65B227F3E3BA469 0.0250 0.0% 1 0.0250 0.00 TRUNCATE TABLE reservation_slots
# 60 0x2C17BCA1E1077820CDC2EC6106F4D93E 0.0207 0.0% 64 0.0003 0.01 SELECT livestream_viewers_history
# 61 0xA0D956F292B7FEA0DCE68A5DD5F529E1 0.0194 0.0% 107 0.0002 0.00 DELETE livestream_viewers_history
# 62 0x74232BDFFB94C567F0340DBE3285E458 0.0180 0.0% 1 0.0180 0.00 INSERT reactions
# 63 0x81E419F4B58AEB9B280B03DE44DD8B94 0.0158 0.0% 202 0.0001 0.00 SELECT livecomments
# 64 0xFFF66E9B3D962FA319C8068B5C1997CD 0.0110 0.0% 66 0.0002 0.00 ROLLBACK
# 65 0xBF3194A2446AC20FC99B6CC7FA476A57 0.0100 0.0% 115 0.0001 0.00 INSERT livestream_viewers_history
# 66 0xEBE4AF9F935DE1D48BB5BB3558C7FCC4 0.0053 0.0% 7 0.0008 0.00 SELECT livestreams livecomments
# 67 0x827F41D30F8E37F04D8BDCD46C556FB3 0.0047 0.0% 51 0.0001 0.00 INSERT livecomment_reports
# 68 0x8F885091E23CB955C051B1204EE7D91D 0.0042 0.0% 7 0.0006 0.00 SELECT livestreams reactions
# 69 0x20CD15DC47AF2F861B8F3C25D195ABE9 0.0017 0.0% 26 0.0001 0.00 SELECT tags
# 70 0x8B2044ADAE690405979131C33185F22A 0.0013 0.0% 15 0.0001 0.00 SELECT users
# 71 0x394E66DDE2823A903078D4C0F235B948 0.0009 0.0% 7 0.0001 0.00 SELECT livestreams livecomment_reports
# 72 0xF085F31DC1964EA538732B713E4B4108 0.0008 0.0% 7 0.0001 0.00 SELECT livestreams livestream_viewers_history
# 73 0x0E7680C04FF2596BE3A3649C5FAC418D 0.0006 0.0% 9 0.0001 0.00 SELECT
# 74 0xEDBC971AEC392917AA353644DE4C4CB4 0.0005 0.0% 296 0.0000 0.00 ADMIN QUIT
# 75 0xC4625761E0CFD817F41B4802F152A489 0.0004 0.0% 1 0.0004 0.00 SELECT livecomments
# 76 0xE84E602C0D0858D5661956B70D72A215 0.0002 0.0% 1 0.0002 0.00 SELECT icons
# Query 1: 161.39 QPS, 0.25x concurrency, ID 0xFFFCA4D67EA0A788813031B8BBC3B329 at byte 87363321
# This item is included in the report because it matches --limit.
# Scores: V/M = 0.00
# Time range: 2023-11-25T08:25:32 to 2023-11-25T08:26:41
# Attribute pct total min max avg 95% stddev median
# ============ === ======= ======= ======= ======= ======= ======= =======
# Count 2 11136
# Exec time 24 17s 16us 49ms 2ms 5ms 2ms 36us
# 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
# Query size 0 65.25k 6 6 6 6 0 6
# String:
# Hosts ip-192-168-0-11.ap-northeast-1.compute.inter...
# Users isucon
# Query_time distribution
# 1us
# 10us ################################################################
# 100us #
# 1ms #######################################
# 10ms #
# 100ms
# 1s
# 10s+
COMMIT\G
# Query 2: 40.88 QPS, 0.15x concurrency, ID 0x59F1B6DD8D9FEC059E55B3BFD624E8C3 at byte 112716558
# This item is included in the report because it matches --limit.
# Scores: V/M = 0.00
# Time range: 2023-11-25T08:25:32 to 2023-11-25T08:26:41
# Attribute pct total min max avg 95% stddev median
# ============ === ======= ======= ======= ======= ======= ======= =======
# Count 0 2821
# Exec time 14 10s 2ms 44ms 4ms 7ms 2ms 3ms
# Lock time 2 3ms 0 198us 1us 1us 6us 1us
# Rows sent 0 2.75k 1 1 1 1 0 1
# Rows examine 57 23.56M 8.55k 8.55k 8.55k 8.55k 0 8.55k
# Query size 1 236.92k 86 86 86 86 0 86
# String:
# Hosts ip-192-168-0-11.ap-northeast-1.compute.inter...
# Users isucon
# Query_time distribution
# 1us
# 10us
# 100us
# 1ms ################################################################
# 10ms #
# 100ms
# 1s
# 10s+
# Tables
# SHOW TABLE STATUS LIKE 'reservation_slots'\G
# SHOW CREATE TABLE `reservation_slots`\G
# EXPLAIN /*!50100 PARTITIONS*/
SELECT slot FROM reservation_slots WHERE start_at = 1702897200 AND end_at = 1702900800\G
# Query 3: 10.29 QPS, 0.10x concurrency, ID 0x9EAD6C0CE525E3693EE27FFC9AAF05A3 at byte 112731461
# This item is included in the report because it matches --limit.
# Scores: V/M = 0.00
# Time range: 2023-11-25T08:25:32 to 2023-11-25T08:26:41
# Attribute pct total min max avg 95% stddev median
# ============ === ======= ======= ======= ======= ======= ======= =======
# Count 0 710
# Exec time 9 7s 4ms 50ms 10ms 19ms 5ms 8ms
# Lock time 0 716us 0 12us 1us 1us 0 1us
# Rows sent 0 1.16k 0 21 1.68 4.96 2.10 0.99
# Rows examine 12 5.18M 7.32k 7.60k 7.47k 7.31k 0 7.31k
# Query size 0 31.88k 43 46 45.99 44.60 0.16 44.60
# String:
# Hosts ip-192-168-0-11.ap-northeast-1.compute.inter...
# Users isucon
# Query_time distribution
# 1us
# 10us
# 100us
# 1ms ################################################################
# 10ms ################################
# 100ms
# 1s
# 10s+
# Tables
# SHOW TABLE STATUS LIKE 'livestreams'\G
# SHOW CREATE TABLE `livestreams`\G
# EXPLAIN /*!50100 PARTITIONS*/
SELECT * FROM livestreams WHERE user_id = 1114\G
# Query 4: 1.80k QPS, 0.10x concurrency, ID 0xDA556F9115773A1A99AA0165670CE848 at byte 101576356
# This item is included in the report because it matches --limit.
# Scores: V/M = 0.00
# Time range: 2023-11-25T08:25:32 to 2023-11-25T08:26:41
# Attribute pct total min max avg 95% stddev median
# ============ === ======= ======= ======= ======= ======= ======= =======
# Count 31 124112
# Exec time 9 7s 22us 8ms 55us 89us 80us 44us
# 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
# Query size 19 3.55M 30 30 30 30 0 30
# String:
# Hosts ip-192-168-0-11.ap-northeast-1.compute.inter...
# Users isucon
# Query_time distribution
# 1us
# 10us ################################################################
# 100us ##
# 1ms #
# 10ms
# 100ms
# 1s
# 10s+
administrator command: Prepare\G
# Query 5: 125 QPS, 0.47x concurrency, ID 0xDFFCC1D78939C4D781C7C58349101F50 at byte 620049
# This item is included in the report because it matches --limit.
# Scores: V/M = 0.00
# Time range: 2023-11-25T08:25:22 to 2023-11-25T08:25:30
# Attribute pct total min max avg 95% stddev median
# ============ === ======= ======= ======= ======= ======= ======= =======
# Count 0 1000
# Exec time 5 4s 2ms 10ms 4ms 5ms 703us 4ms
# Lock time 0 1ms 0 34us 1us 1us 1us 1us
# Rows sent 0 0 0 0 0 0 0 0
# Rows examine 0 0 0 0 0 0 0 0
# Query size 2 401.18k 192 463 410.81 420.77 16.87 400.73
# String:
# Hosts ip-192-168-0-11.ap-northeast-1.compute.inter...
# Users isucon
# Query_time distribution
# 1us
# 10us
# 100us
# 1ms ################################################################
# 10ms #
# 100ms
# 1s
# 10s+
# Tables
# SHOW TABLE STATUS LIKE 'users'\G
# SHOW CREATE TABLE `users`\G
INSERT INTO users (id, name, display_name, description, password) VALUES (646, 'hiroshiendo0', '感慨', '普段営業をしています。\nよろしくおねがいします!\n\n連絡は以下からお願いします。\n\nウェブサイト: http://hiroshiendo.example.com/\nメールアドレス: hiroshiendo@example.com\n', '$2a$04$UwZb6IFm4tgS1pLvujdaV.sK3Gq9zN2IJyIuGjqtMyuSL/dZXfqjK')\G
2023-11-25T08:25:22.064Z info isupipe-benchmarker SSL接続が有効になっています
2023-11-25T08:25:22.065Z info isupipe-benchmarker 静的ファイルチェックを行います
2023-11-25T08:25:22.065Z info isupipe-benchmarker 静的ファイルチェックが完了しました
2023-11-25T08:25:22.065Z info isupipe-benchmarker webappの初期化を行います
2023-11-25T08:25:32.455Z info isupipe-benchmarker ベンチマーク走行前のデータ整合性チェックを行います
2023-11-25T08:25:41.537Z info isupipe-benchmarker 整合性チェックが成功しました
2023-11-25T08:25:41.537Z info isupipe-benchmarker ベンチマーク走行を開始します
2023-11-25T08:26:17.544Z info isupipe-benchmarker DNS水責め負荷が上昇します {"parallelis": 3}
2023-11-25T08:26:41.538Z info isupipe-benchmarker ベンチマーク走行を停止します
2023-11-25T08:26:41.539Z warn isupipe-benchmarker ライブコメントを配信に投稿できないため、視聴者が離脱します {"viewer": "inakamura2", "livestream_id": 7701, "error": "Post \"https://ahayashi0.u.isucon.dev:443/api/livestream/7701/livecomment\": context canceled: ベンチマーク走行が継続できないエラーが発生しました"}
2023-11-25T08:26:41.541Z warn isupipe-benchmarker ライブコメントを配信に投稿できないため、視聴者が離脱します {"viewer": "yasuhiro540", "livestream_id": 7526, "error": "Post \"https://kazuya580.u.isucon.dev:443/api/livestream/7526/livecomment\": context canceled: ベンチマーク走行が継続できないエラーが発生しました"}
2023-11-25T08:26:41.541Z warn isupipe-benchmarker ライブコメントを配信に投稿できないため、視聴者が離脱します {"viewer": "isuzuki0", "livestream_id": 7531, "error": "Post \"https://satomigoto0.u.isucon.dev:443/api/livestream/7531/livecomment\": context canceled: ベンチマーク走行が継続できないエラーが発生しました"}
2023-11-25T08:26:41.541Z warn isupipe-benchmarker ライブコメントを配信に投稿できないため、視聴者が離脱します {"viewer": "ysato0", "livestream_id": 7577, "error": "Post \"https://yasuhiro280.u.isucon.dev:443/api/livestream/7577/livecomment\": context canceled: ベンチマーク走行が継続できないエラーが発生しました"}
2023-11-25T08:26:42.132Z info isupipe-benchmarker ベンチマーク走行終了
2023-11-25T08:26:42.132Z info isupipe-benchmarker 最終チェックを実施します
2023-11-25T08:26:42.132Z info isupipe-benchmarker 最終チェックが成功しました
2023-11-25T08:26:42.133Z info isupipe-benchmarker 重複排除したログを以下に出力します
2023-11-25T08:26:42.133Z info isupipe-benchmarker 配信を最後まで視聴できた視聴者数 {"viewers": 106}
[一般エラー] GET /api/livestream/7528/report へのリクエストに対して、期待されたHTTPステータスコードが確認できませんでした (expected:200, actual:500)
[一般エラー] GET /api/livestream/7523/report へのリクエストに対して、期待されたHTTPステータスコードが確認できませんでした (expected:200, actual:500)
[一般エラー] POST /api/livestream/7579/livecomment へのリクエストに対して、期待されたHTTPステータスコードが確認できませんでした (expected:400, actual:201)
[一般エラー] GET /api/livestream/7532/report へのリクエストに対して、期待されたHTTPステータスコードが確認できませんでした (expected:200, actual:500)
[一般エラー] GET /api/livestream/7529/report へのリクエストに対して、期待されたHTTPステータスコードが確認できませんでした (expected:200, actual:500)
[一般エラー] POST /api/livestream/7523/livecomment/1015/report へのリクエストに対して、期待されたHTTPステータスコードが確認できませんでした (expected:201, actual:404)
[一般エラー] GET /api/livestream/7527/report へのリクエストに対して、期待されたHTTPステータスコードが確認できませんでした (expected:200, actual:500)
[一般エラー] POST /api/livestream/7528/livecomment/1053/report へのリクエストに対して、期待されたHTTPステータスコードが確認できませんでした (expected:201, actual:404)
[一般エラー] GET /api/livestream/7522/report へのリクエストに対して、期待されたHTTPステータスコードが確認できませんでした (expected:200, actual:500)
[一般エラー] GET /api/livestream/7534/report へのリクエストに対して、期待されたHTTPステータスコードが確認できませんでした (expected:200, actual:500)
[一般エラー] POST /api/livestream/7529/livecomment/1054/report へのリクエストに対して、期待されたHTTPステータスコードが確認できませんでした (expected:201, actual:404)
[一般エラー] POST /api/livestream/7605/livecomment へのリクエストに対して、期待されたHTTPステータスコードが確認できませんでした (expected:400, actual:201)
[一般エラー] POST /api/livestream/7523/livecomment/1014/report へのリクエストに対して、期待されたHTTPステータスコードが確認できませんでした (expected:201, actual:404)
[一般エラー] POST /api/livestream/7531/livecomment/1061/report へのリクエストに対して、期待されたHTTPステータスコードが確認できませんでした (expected:201, actual:404)
[一般エラー] POST /api/livestream/7695/livecomment へのリクエストに対して、期待されたHTTPステータスコードが確認できませんでした (expected:400, actual:201)
[一般エラー] GET /api/livestream/7539/report へのリクエストに対して、期待されたHTTPステータスコードが確認できませんでした (expected:200, actual:500)
[リクエストタイムアウト] GET /api/livestream/7743/ngwords: Get "https://yutasato0.u.isucon.dev:443/api/livestream/7743/ngwords": read udp 10.0.26.226:39489->54.178.145.213:53: i/o timeout: タイムアウトによりリクエスト失敗
名前解決成功数 5606
売上: 21743