Redisの調査についてとrmlp

by Konboi

Slide 1

Slide 1 text

Redisͷௐࠪʹ͍ͭͯͱ rmlp shibuya.go#2 3/22

Slide 2

Slide 2 text

ࣗݾ঺հ • @Konboi • ໘ന๏ਓΧϠοΫ • ϞόΠϧήʔϜͷ։ൃͱӡ༻

Slide 3

Slide 3 text

ࠓ೔࿩͢ࣄ • Redisͷௐࠪ • CPU͕ • ϝϞϦ͕ • 1୆Ͱ͸ • rmlpʹ͍ͭͯ

Slide 4

Slide 4 text

ࠓ೔࿩͞ͳ͍ࣄ • Redisʹ͍ͭͯͷ࿩ • Redisͷνϡʔχϯά • GoΛ࢖ͬͯͷRedisͷૢ࡞

Slide 5

Slide 5 text

RedisΛۀ຿Ͱ࢖ͬͯΔ ͱ͍͏ํ ✋

Slide 6

Slide 6 text

Redisͷௐࠪʹ͍ͭͯ

Slide 7

Slide 7 text

ͷલʹ

Slide 8

Slide 8 text

ӡ༻͍ͯ͠ΔҊ݅Ͱ RedisͷCPU͕͜ͷ༷ʹ ͳͬͨܦݧ͸͋Γ·͔͢

Slide 9

Slide 9 text

ಥൃతʹ͕͋ΔCPUෛՙ

Slide 10

Slide 10 text

No content

Slide 11

Slide 11 text

Slide 12

Slide 12 text

໷ʹͳΔʹͭΕ͕ͯ͋Δ CPUෛՙ

Slide 13

Slide 13 text

No content

Slide 14

Slide 14 text

Slide 15

Slide 15 text

೔ʹ೔ʹߴ͘ͳΔCPUෛՙ

Slide 16

Slide 16 text

No content

Slide 17

Slide 17 text

!!!

Slide 18

Slide 18 text

ා͍Ͱ͢Ͷ

Slide 19

Slide 19 text

ͱ͍͏͜ͱͰຊ୊

Slide 20

Slide 20 text

CPUͷෛՙ͕ߴ͍࣌

Slide 21

Slide 21 text

CPUͷෛՙ͕ߴ͍࣌ • ͳʹ͔ॏ͍ॲཧ͕ߦΘΕ͍ͯΔ֬཰͕ߴ͍Ͱ͢ • Redis͸γϯάϧεϨουͳͷͰॏ͍ॲཧ͕͋ΔͱͦΕ͕ऴΘ Δ·Ͱଞͷॲཧ͸଴ͨ͞ΕͯͭΒ͍ • ॏ͍ͱ͍ͬͯ਺ϛϦඵͰॲཧ͸ऴΘΔͷͰؾ͖ͮʹ͍͘ • devͩͱΞΫηε͕গͳ͍ͷͰ࿐ఄ͠ʹ͍͘

Slide 22

Slide 22 text

Ͳ͏͢Δ...

Slide 23

Slide 23 text

slow logΛݟ·͠ΐ͏

Slide 24

Slide 24 text

# ࠓճ͸ݕূͷͨΊ slowlogͷ৚݅Λ10microඵʹ͍ͯ͠·͢ $ redis-cli -h slowlog get 1) 1) (integer) 34990 2) (integer) 1457071463 3) (integer) 11 4) 1) "slowlog" 2) "get" 3) "1" ... 3) 1) (integer) 34988 2) (integer) 1457071448 3) (integer) 51 4) 1) "slowlog" 2) "get" 3) "5"

Slide 25

Slide 25 text

ݟํ 1) 1) (integer) 34990 2) (integer) 1457071463 3) (integer) 11 4) 1) "slowlog" 2) "get" 3) "1" 1) 1) slowlogͷID 2) ࣮ߦऴྃ࣌ͷtimestamp(UNIXඵ) 3) ࣮ߦ࣌ؒ(microඵ) 4) ࣮ߦίϚϯυͱΦϓγϣϯ

Slide 26

Slide 26 text

CPUͷෛՙ͕ߴ͍࣌ • ͍͍ͩͨ͜ΕͰ஗͍(ෛՙͷߴ͍)ίϚϯυ͕෼͔Δ͸ͣͰ͢ • ޙ͸֘౰ͷιʔείʔυΛ௚͠·͠ΐ͏ • ܦݧ্ keys * ΍େྔͷσʔλಉ࢜ͰͷUNION ΍ DIFF Λ͢Δ ͱCPUͷෛՙ͕άϯάϯ্͕Γ·͢

Slide 27

Slide 27 text

ϝϞϦ

Slide 28

Slide 28 text

No content

Slide 29

Slide 29 text

೔ʹ೔ʹ૿͑Δσʔλྔ

Slide 30

Slide 30 text

͜ΕͰ͸͋ͱX೔Ͱ༰ྔ ͷݶքΛܴ͑ͯ͠·͏

Slide 31

Slide 31 text

!!!

Slide 32

Slide 32 text

dumpΛऔΓ rdb tool Λ࢖ͬͯௐࠪ͠·͠ΐ͏

Slide 33

Slide 33 text

rdb tool ͱ͸ • sripathikrishnan/redis-rdb-tools • Rdbtools is a parser for Redis' dump.rdb ﬁles. • python੡ • rdbϑΝΠϧ͔Βσʔλͷ༷ʑͳ৘ใΛग़ྗͰ͖Δπʔϧ

Slide 34

Slide 34 text

αϯϓϧ dump͸slaveͳͲ͔ΒऔΓ·͠ΐ͏ # αʔόʔ͔Βdump $ redis-cli -h --rdb dump.rdb # memoryͱkeyΛग़ྗ $ rdb -c memory dump.rdb > dump_memory.csv # memoryͷେ͖͞ॱʹsort $ cat dump_memory.csv | awk -F "," '{print $4 "\t" $3'} | sort -n

Slide 35

Slide 35 text

ϝϞϦ • ༰ྔॱʹstore͞Ε͍ͯΔσʔλ͕Θ͔ΔͷͰ֘౰ͷσʔλΛ ফ͢ • ඞཁແ͘ͳͬͨσʔλΛ࡟আ͢Δ • ܦݧ্ temporary తͳσʔλ͕࢒͍ͬͯΔࣄ͕ଟ͍ • SET "EX" • ͳͲexpire͢Δ࣌ؒΛ͜·Ίʹࢦఆ • ফ͜͠Έॲཧ͕࣮૷͞Ε͍ͯΔ͔֬ೝ

Slide 36

Slide 36 text

͖ͪΜͱফ͜͠ΈΛߦ͏ Α͏ʹͨ݁͠Ռ

Slide 37

Slide 37 text

No content

Slide 38

Slide 38 text

! ! !

Slide 39

Slide 39 text

ͦΕͰ΋1୆Ͱ͸ݶք͕...

Slide 40

Slide 40 text

໾ׂ͝ͱʹෳ਺୆ʹ͠Α͏ʂ

Slide 41

Slide 41 text

໾ׂ͝ͱʹෳ਺୆ʹ͠Α͏ • session༻ • cache༻ • ϥϯΩϯά࡞੒༻ • ͳͲͳͲ

Slide 42

Slide 42 text

Ͱ΋ͪΐͬͱ଴ͬͯ ✋

Slide 43

Slide 43 text

ͦͷ෼ׂຊ౰ʹޮ͘...?

Slide 44

Slide 44 text

ͦͷ෼ׂຊ౰ʹޮ͘...? • $ redis-cli slowlog get Ͱ͸஗͍ίϚϯυ͕Θ͔Δ • rdb tool Ͱ৭ʑղੳͰ͖Δ • ͜Ε͚ͩͰ͸Ŋ֤keyͷར༻ස౓·Ͱ͸෼͔Βͳ͍ • ಛఆͷΠϕϯτͷ͚࣌ͩଟ͍͔΋͠Εͳ͍ • ͋Δkeyͷ࣮ߦ͕΄͔ͷkeyͷ10ഒҎ্͔΋͠Εͳ͍ • ͳͲ

Slide 45

Slide 45 text

redis-cli monitor

Slide 46

Slide 46 text

redis-cli monitor $ redis-cli monitor 1457077479.354522 [0 127.0.0.1:59247] "INCR" "counter:__rand_int__" 1457077479.354621 [0 127.0.0.1:59247] "INCR" 1457077479.352548 [0 127.0.0.1:59245] "SET" "key:__rand_int__" "xxx""counter:__rand_int__" 1457077479.354852 [0 127.0.0.1:59248] "LPUSH" "mylist" "xxx" 1457077479.352812 [0 127.0.0.1:59245] "SET" "key:__rand_int__" "xxx" 1457077479.354522 [0 127.0.0.1:59247] "INCR" "counter:__rand_int__" 1457077479.354621 [0 127.0.0.1:59247] "INCR" "counter:__rand_int__" 1457077479.354852 [0 127.0.0.1:59248] "LPUSH" "mylist" "xxx" 1457077479.353138 [0 127.0.0.1:59245] "SET" "key:__rand_int__" "xxx" ݱࡏ࣮ߦ͞Ε͍ͯΔίϚϯυ਺͕෼͔Δ एׯෛՙ͕͕͋ΔͷͰؾΛ͚࣮ͭͯߦ͍ͯͩ͘͠͞

Slide 47

Slide 47 text

1457077479.354852 [0 127.0.0.1:59248] "LPUSH" "mylist" "xxx" 1457077479.354956 [0 127.0.0.1:59248] "LPUSH" "mylist" "xxx" [ ] ͳͷͰ2ߦ໨͔Β1ߦͷtimestampΛҾ͚͹1ߦ໨ͷ࣮ߦ࣌ؒ ͕Θ͔Δ (ݫີͰ͸ͳ͍)

Slide 48

Slide 48 text

ίϚϯυϥΠϯͰ΍Δͱ $ awk 'function fetchcommand() { c =""; for (i = 4; i < NF; i++) { c = c " " $i }; c = c " " $NF; return c } NR==1 { time=$1; command=fetchcommand() } NR!=1 { print command, $1-time; time=$1; command=fetch_command(); }' /tmp/redis.log surported by @tkuchiki

Slide 49

Slide 49 text

ίϚϯυʹ͠·ͨ͠

Slide 50

Slide 50 text

΍ͬͱGoͷ࿩Λ ͪΐΖͬͱ͠·͢

Slide 51

Slide 51 text

rmlp

Slide 52

Slide 52 text

rmlp • Konboi/rmlp • Redis Monitor Log Proﬁler • Go੡ • ઌ΄ͲͷlogΛݟ΍͍͢ܗʹ੔ܗ • ίϚϯυͷ ฏۉॱ ࣮ߦॱ ࣮ߦճ਺ॱ ͰιʔτՄೳ

Slide 53

Slide 53 text

$ redis-cli monitor > redis-monitor.log $ rmlp -f redis-monitor.log Overall Stats ================================== LineCount 15000 Commands Rate ================================== LRANGE 4000 PING 2000 ... Heavy Commands ================================== Command Sum(msec) LRANGE 0.803558 PING 0.106445 ... Slowest Calls ================================== KEY Count Max(msec) Avg(msec) PING 2000 0.001511 0.000053 LRANGE mylist 4000 0.001358 0.000201

Slide 54

Slide 54 text

rmlp • खݩ(Mac)Ͱσόοάͯ͠Ϗϧυ͢Ε͹ຊ൪(EC2)Ͱಈ͘࠷ߴ • Ͳͷkey͕Ͳͷఔ౓ͷස౓Ͱൃߦ͞Ε͍ͯΔͷ͔೺ѲͰ͖Δ • ࿈ଓతʹredis͕ར༻͞Ε͍ͯͳ͍ͱਖ਼֬ͳܭଌ͕Ͱ͖ͳ͍ • ࣍ͷίϚϯυͷ։࢝࣌ؒΛݩʹ࣮ߦ࣌ؒΛग़͍ͯ͠ΔͨΊ • ෼͚Δඞཁੑ͕͋Δͷ͔ͷ൑அࡐྉʹ͸Ͱ͖Δ͔ͳͱ

Slide 55

Slide 55 text

rmlp • facebookarchive/redis-faina • python੡ • hirose31/redis-trafﬁc-stats • tcpdump࣮ͯ͠ߦ࣌ؒͱස౓Λܭଌ͢Δπʔϧ΋͋Δ

Slide 56

Slide 56 text

஫ҙࣄ߲ • ࠓճग़ͨ͠ௐࠪͷྫ͸͋͘·ͰҰྫͰ͢ͷͰଞʹ΋ௐࠪํ๏ ͸͋Δͱࢥ͍·͢ • dumpͱ͔͸ෛՙͰ࣮αʔϏε͕Өڹͳ͍ঢ়گͰͦ͏ͧ !