ParallelRefProcEnabled Ref Proc: 229ms+Dubbo

参数优化

-Xmx15G 
-Xms15G 
-XX:MaxDirectMemorySize=5G 
-XX:+UnlockExperimentalVMOptions 
-XX:G1NewSizePercent=5  
-XX:G1RSetUpdatingPauseTimePercent=1 
-XX:+ParallelRefProcEnabled 
-XX:MetaspaceSize=1G 
-XX:+UseG1GC 
-XX:G1MixedGCCountTarget=16 
-XX:StringTableSize=4000000 
-XX:+PrintStringTableStatistics 
-XX:+PrintGCDetails 
-XX:+PrintGCDateStamps 
-Xloggc:/data/logs/intelligent-mr-%p-%t.log 
-XX:+PrintGCApplicationConcurrentTime 
-XX:+PrintGCApplicationStoppedTime 
-XX:+HeapDumpOnOutOfMemoryError 
-XX:HeapDumpPath=/data/logs  
-Djava.net.preferIPv4Stack=true
-XX:G1MaxNewSizePercent=30 
-XX:InitiatingHeapOccupancyPercent=45
-XX:+UnlockDiagnosticVMOptions  
-XX:+PrintHeapAtGC
-XX:+PrintTenuringDistribution
-XX:G1HeapRegionSize=32M
-XX:MaxGCPauseMillis=100 
-XX:GCPauseIntervalMillis=200
-XX:+ParallelRefProcEnabled
-XX:+PrintReferenceGC

XX:ParallelGCThreads

结论

-XX:ParallelGCThreads=32 影响非常大,超时严重,默认效果最优(该场景下)

Region调节对比

结论

32m相对较好

-XX:G1MaxNewSizePercent=30 
-XX:InitiatingHeapOccupancyPercent=45
-XX:G1HeapRegionSize=8M

image
-XX:G1MaxNewSizePercent=30 
-XX:InitiatingHeapOccupancyPercent=45
-XX:G1HeapRegionSize=16M

image
-XX:G1MaxNewSizePercent=30 
-XX:InitiatingHeapOccupancyPercent=45
-XX:G1HeapRegionSize=32M

image

GC日志分析

结论

开启参数ParallelRefProcEnabled ref对象并行化处理

2021-05-28T10:10:38.532+0800: 444.869: [GC pause (G1 Evacuation Pause) (young)
Desired survivor size 402653184 bytes, new threshold 15 (max 15)
- age   1:    3103320 bytes,    3103320 total
- age   2:     178000 bytes,    3281320 total
- age   3:       3920 bytes,    3285240 total
- age   4:      98016 bytes,    3383256 total
- age   5:      70144 bytes,    3453400 total
- age   6:       3464 bytes,    3456864 total
- age   7:      99304 bytes,    3556168 total
- age   8:       4048 bytes,    3560216 total
- age   9:       4712 bytes,    3564928 total
- age  10:       2304 bytes,    3567232 total
- age  11:       4400 bytes,    3571632 total
- age  12:        864 bytes,    3572496 total
- age  13:       1032 bytes,    3573528 total
- age  14:       1304 bytes,    3574832 total
- age  15:        256 bytes,    3575088 total
, 0.2690707 secs]
   [Parallel Time: 34.7 ms, GC Workers: 13]
      [GC Worker Start (ms): Min: 444869.6, Avg: 444892.9, Max: 444903.7, Diff: 34.0]
      [Ext Root Scanning (ms): Min: 0.0, Avg: 3.8, Max: 21.7, Diff: 21.7, Sum: 49.6]
      [Update RS (ms): Min: 0.0, Avg: 0.1, Max: 0.4, Diff: 0.4, Sum: 1.7]
         [Processed Buffers: Min: 0, Avg: 3.4, Max: 21, Diff: 21, Sum: 44]
      [Scan RS (ms): Min: 0.0, Avg: 0.1, Max: 0.2, Diff: 0.2, Sum: 1.2]
      [Code Root Scanning (ms): Min: 0.0, Avg: 0.0, Max: 0.2, Diff: 0.2, Sum: 0.2]
      [Object Copy (ms): Min: 0.0, Avg: 0.8, Max: 2.3, Diff: 2.3, Sum: 10.6]
      [Termination (ms): Min: 0.0, Avg: 6.0, Max: 9.7, Diff: 9.7, Sum: 78.5]
         [Termination Attempts: Min: 1, Avg: 1.0, Max: 1, Diff: 0, Sum: 13]
      [GC Worker Other (ms): Min: 0.0, Avg: 0.1, Max: 0.2, Diff: 0.2, Sum: 0.7]
      [GC Worker Total (ms): Min: 0.2, Avg: 11.0, Max: 34.3, Diff: 34.1, Sum: 142.6]
      [GC Worker End (ms): Min: 444903.8, Avg: 444903.9, Max: 444904.0, Diff: 0.2]
   [Code Root Fixup: 0.1 ms]
   [Code Root Purge: 0.0 ms]
   [Clear CT: 1.9 ms]
   [Other: 232.3 ms]
      [Choose CSet: 0.0 ms]
      [Ref Proc: 229.3 ms]
      [Ref Enq: 0.6 ms]
      [Redirty Cards: 0.6 ms]
      [Humongous Register: 0.2 ms]
      [Humongous Reclaim: 0.0 ms]
      [Free CSet: 0.8 ms]
   [Eden: 6128.0M(6128.0M)->0.0B(752.0M) Survivors: 16.0M->16.0M Heap: 6415.2M(15.0G)->288.8M(15.0G)]
 [Times: user=1.24 sys=0.02, real=0.27 secs] 

2021-06-03T14:41:47.017+0800: 155609.008: 
[SoftReference, 0 refs, 0.0042561 secs]2021-06-03T14:41:47.021+0800: 155609.012: 
[WeakReference, 0 refs, 0.0010238 secs]2021-06-03T14:41:47.022+0800: 155609.014: 
[FinalReference, 5 refs, 0.0021924 secs]2021-06-03T14:41:47.025+0800: 155609.016: 
[PhantomReference, 0 refs, 0 refs, 0.0315034 secs]2021-06-03T14:41:47.056+0800: 155609.047: [JNI Weak Reference, 0.0000365 secs], 0.0575484 secs]

DUMP. 内存分析

结论

线程占用threadLocal 较多,WeakRef较多,减少Dubbo线程数

<dubbo:provider timeout="1000" filter="notice" threadpool="fixed" threads="300" dispatcher="message" retries="0"/>

改为

<dubbo:provider timeout="1000" filter="notice" threadpool="cached" threads="300" dispatcher="message" retries="0"/>

大盘线程数降低

image
image
image

E4

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

推荐阅读更多精彩内容