引入 SkyWalking 后对 ES 运行机器的影响

在 dev 环境引入 SkyWalking 之后,ES CPU 长期飙到 200%。我们需要定位一下到底是内存不足导致的疯狂 GC 引致 CPU飙高,还是因为 CPU 不足运算性能太低导致的。

性能问题分析

具体情况如下图,可见 ES 的 CPU 消耗极高


image.png

首先我们判断是否是因为GC原因导致CPU飙高

jstat -gcutil {processID} 1000 30 #间隔1s执行20次
image.png

年轻代的内存分分钟就满了,每秒差不多都要执行 3 次 Young GC。老年代内存每次到 70+% 的时候就要执行 FULL GC 了,差不多每10s执行一次 FULL GC 可以说太频繁了。

这个时候我们大概能确定是 GC 导致 CPU 太高,但是我们还需要更多的证据。

sudo -u elasticsearch jstack {processID} > /tmp/es-thread-stack.txt #导出线程堆栈信息
top -n 1 -H {processID} #查看指定进程的线程CPU使用情况

这里我们执行三次此命令,多次采样取平均值。


![image.png](https://upload-images.jianshu.io/upload_images/625996-da52e57ba5983249.png?imageMogr2/auto-orient/strip%7CimageView2/2/w/1240)

图中PID即为线程ID,将其转换为16进制在 es-thread-stack.txt 文件中进行查询。

cat es-thread-stack.txt | grep $(printf %x {threadId})
21375-20.0%: "elasticsearch[C92gS_3][refresh][T#1]"
21385-20.0%: "elasticsearch[C92gS_3][http_server_worker][T#2]"
21096-13.3%: "Gang worker#2 (Parallel GC Threads)"
21098-13.3%: "Gang worker#3 (Parallel GC Threads)"
21376-13.3%: "elasticsearch[C92gS_3][refresh][T#2]"
21495-13.3%: "elasticsearch[C92gS_3][write][T#2]"
21560-13.3%: "elasticsearch[C92gS_3][write][T#4]"
21094-6.70%: "Gang worker#0 (Parallel GC Threads)"
21095-6.70%: "Gang worker#1 (Parallel GC Threads)"
21494-6.70%: "elasticsearch[C92gS_3][write][T#1]"
21559-6.70%: "elasticsearch[C92gS_3][write][T#3]"
22420-6.70%: "elasticsearch[C92gS_3][search][T#2]"
22423-6.70%: "elasticsearch[C92gS_3][search][T#1]"
22424-6.70%: "elasticsearch[C92gS_3][search][T#4]"
22446-6.70%: "elasticsearch[C92gS_3][search][T#6]"
22458-6.70%: "elasticsearch[C92gS_3][search][T#7]"

total CPU: 166.8% , elasticsearch CPU: 126.8% , GC CPU: 40.0%
image.png
21375-46.7%: "elasticsearch[C92gS_3][refresh][T#1]" 
21376-40.0%: "elasticsearch[C92gS_3][refresh][T#2]"
21397-26.7%: "elasticsearch[C92gS_3][http_server_worker][T#5]"
21396-13.3%: "elasticsearch[C92gS_3][http_server_worker][T#4]"
21495-13.3%: "elasticsearch[C92gS_3][write][T#2]"
21494-6.7%:  "elasticsearch[C92gS_3][write][T#1]"
21559-6.7%:  "elasticsearch[C92gS_3][write][T#3]"
21560-6.7%:  "elasticsearch[C92gS_3][write][T#4]"
22420-6.7%:  "elasticsearch[C92gS_3][search][T#2]"
22422-6.7%:  "elasticsearch[C92gS_3][search][T#3]"
22423-6.7%:  "elasticsearch[C92gS_3][search][T#1]"
22436-6.7%:  "elasticsearch[C92gS_3][search][T#5]"
22446-6.7%:  "elasticsearch[C92gS_3][search][T#6]"
22458-6.7%:  "elasticsearch[C92gS_3][search][T#7]"

total CPU: 200.3% , elasticsearch CPU: 200.3% , GC CPU: 0.0%
image.png
21376-25.0%: "elasticsearch[C92gS_3][refresh][T#2]"
21094-18.8%: "Gang worker#0 (Parallel GC Threads)"
21095-18.8%: "Gang worker#1 (Parallel GC Threads)"
21098-18.8%: "Gang worker#3 (Parallel GC Threads)"
21375-18.8%: "elasticsearch[C92gS_3][refresh][T#1]"
21096-12.5%: "Gang worker#2 (Parallel GC Threads)"
21494-12.5%: "elasticsearch[C92gS_3][write][T#1]"
22458-12.5%: "elasticsearch[C92gS_3][search][T#7]"
21116-6.2%:  "VM Thread"
21446-6.2%:  "elasticsearch[C92gS_3][http_server_worker][T#7]"
21495-6.2%:  "elasticsearch[C92gS_3][write][T#2]"
21560-6.2%:  "elasticsearch[C92gS_3][write][T#4]"
22370-6.2%:  "elasticsearch[C92gS_3][http_server_worker][T#8]"
22424-6.2%:  "elasticsearch[C92gS_3][search][T#4]"
22446-6.2%:  "elasticsearch[C92gS_3][search][T#6]"

total CPU: 181.1% , elasticsearch CPU: 106.0% , GC CPU: 75.1%

取三次的平均值

total CPU: 182.7 , elasticsearch CPU: 144.4% , GC CPU: 38.3%

根据该部分数据分析,ES 当前运行的机器不仅内存不足,CPU性能也不够。

关闭 SkyWalking 的性能情况

image.png

CPU 基本都在 100% 以下

image.png

可以看到 Young GC 和 FULL GC 大大降低,不过看这个情况内存还是不太够。

总结

目前 dev 环境仅接入了 1/3 的节点,但是对 ES 的影响就已经如此巨大。为了测试和开发的完整性,目前的方案是降低 SkyWalking 应用端的采样率,ES 服务单独部署在高配机器上。

SkyWalking 对于应用端的性能影响及其的低,但是针对存储端的影响是非常大的。在上线之前除了针对 SkyWalking 本身对应用端性能的测试外,还要根据测试环境 ES 的运行情况评估线上 ES 是否要增加集群节点。

©著作权归作者所有,转载或内容合作请联系作者
  • 序言:七十年代末,一起剥皮案震惊了整个滨河市,随后出现的几起案子,更是在滨河造成了极大的恐慌,老刑警刘岩,带你破解...
    沈念sama阅读 200,176评论 5 469
  • 序言:滨河连续发生了三起死亡事件,死亡现场离奇诡异,居然都是意外死亡,警方通过查阅死者的电脑和手机,发现死者居然都...
    沈念sama阅读 84,190评论 2 377
  • 文/潘晓璐 我一进店门,熙熙楼的掌柜王于贵愁眉苦脸地迎上来,“玉大人,你说我怎么就摊上这事。” “怎么了?”我有些...
    开封第一讲书人阅读 147,232评论 0 332
  • 文/不坏的土叔 我叫张陵,是天一观的道长。 经常有香客问我,道长,这世上最难降的妖魔是什么? 我笑而不...
    开封第一讲书人阅读 53,953评论 1 272
  • 正文 为了忘掉前任,我火速办了婚礼,结果婚礼上,老公的妹妹穿的比我还像新娘。我一直安慰自己,他们只是感情好,可当我...
    茶点故事阅读 62,879评论 5 360
  • 文/花漫 我一把揭开白布。 她就那样静静地躺着,像睡着了一般。 火红的嫁衣衬着肌肤如雪。 梳的纹丝不乱的头发上,一...
    开封第一讲书人阅读 48,177评论 1 277
  • 那天,我揣着相机与录音,去河边找鬼。 笑死,一个胖子当着我的面吹牛,可吹牛的内容都是我干的。 我是一名探鬼主播,决...
    沈念sama阅读 37,626评论 3 390
  • 文/苍兰香墨 我猛地睁开眼,长吁一口气:“原来是场噩梦啊……” “哼!你这毒妇竟也来了?” 一声冷哼从身侧响起,我...
    开封第一讲书人阅读 36,295评论 0 254
  • 序言:老挝万荣一对情侣失踪,失踪者是张志新(化名)和其女友刘颖,没想到半个月后,有当地人在树林里发现了一具尸体,经...
    沈念sama阅读 40,436评论 1 294
  • 正文 独居荒郊野岭守林人离奇死亡,尸身上长有42处带血的脓包…… 初始之章·张勋 以下内容为张勋视角 年9月15日...
    茶点故事阅读 35,365评论 2 317
  • 正文 我和宋清朗相恋三年,在试婚纱的时候发现自己被绿了。 大学时的朋友给我发了我未婚夫和他白月光在一起吃饭的照片。...
    茶点故事阅读 37,414评论 1 329
  • 序言:一个原本活蹦乱跳的男人离奇死亡,死状恐怖,灵堂内的尸体忽然破棺而出,到底是诈尸还是另有隐情,我是刑警宁泽,带...
    沈念sama阅读 33,096评论 3 315
  • 正文 年R本政府宣布,位于F岛的核电站,受9级特大地震影响,放射性物质发生泄漏。R本人自食恶果不足惜,却给世界环境...
    茶点故事阅读 38,685评论 3 303
  • 文/蒙蒙 一、第九天 我趴在偏房一处隐蔽的房顶上张望。 院中可真热闹,春花似锦、人声如沸。这庄子的主人今日做“春日...
    开封第一讲书人阅读 29,771评论 0 19
  • 文/苍兰香墨 我抬头看了看天上的太阳。三九已至,却和暖如春,着一层夹袄步出监牢的瞬间,已是汗流浃背。 一阵脚步声响...
    开封第一讲书人阅读 30,987评论 1 255
  • 我被黑心中介骗来泰国打工, 没想到刚下飞机就差点儿被人妖公主榨干…… 1. 我叫王不留,地道东北人。 一个月前我还...
    沈念sama阅读 42,438评论 2 346
  • 正文 我出身青楼,却偏偏与公主长得像,于是被迫代替她去往敌国和亲。 传闻我的和亲对象是个残疾皇子,可洞房花烛夜当晚...
    茶点故事阅读 42,032评论 2 341

推荐阅读更多精彩内容