【性能优化】记录一次YounGC峰值优化
服务环境
- CPU 24核
- 服务内存 16G
问题复盘
youngGC时延增大直到触发mixedGC后恢复正常
如下
具体GC日志如下
Before MixedGC
2020-01-12T19:37:30.333+0800: 192703.245: [SoftReference, 0 refs, 0.0000815 secs]2020-01-12T19:37:30.333+0800: 192703.245: [WeakReference, 2 refs, 0.0000126 secs]2020-01-12T19:37:30.334+0800: 192703.245: [FinalReference, 28 refs, 0.0000426 secs]2020-01-12T19:37:30.334+0800: 192703.245: [PhantomReference, 0 refs, 58 refs, 0.0000277 secs]2020-01-12T19:37:30.334+0800: 192703.245: [JNI Weak Reference, 0.0000331 secs], 0.2385635 secs][Parallel Time: 232.4 ms, GC Workers: 18][GC Worker Start (ms): Min: 192703012.3, Avg: 192703012.5, Max: 192703012.8, Diff: 0.5][Ext Root Scanning (ms): Min: 155.8, Avg: 159.7, Max: 164.0, Diff: 8.2, Sum: 2874.1][Update RS (ms): Min: 24.9, Avg: 26.0, Max: 26.5, Diff: 1.6, Sum: 467.4][Processed Buffers: Min: 25, Avg: 38.4, Max: 66, Diff: 41, Sum: 691][Scan RS (ms): Min: 0.0, Avg: 0.1, Max: 0.2, Diff: 0.2, Sum: 1.6][Code Root Scanning (ms): Min: 0.0, Avg: 0.0, Max: 0.0, Diff: 0.0, Sum: 0.0][Object Copy (ms): Min: 41.6, Avg: 45.9, Max: 49.6, Diff: 8.0, Sum: 826.5][Termination (ms): Min: 0.0, Avg: 0.0, Max: 0.0, Diff: 0.0, Sum: 0.3][Termination Attempts: Min: 1, Avg: 8.3, Max: 13, Diff: 12, Sum: 150][GC Worker Other (ms): Min: 0.0, Avg: 0.1, Max: 0.2, Diff: 0.1, Sum: 1.6][GC Worker Total (ms): Min: 231.5, Avg: 231.8, Max: 232.0, Diff: 0.5, Sum: 4171.6][GC Worker End (ms): Min: 192703244.2, Avg: 192703244.3, Max: 192703244.3, Diff: 0.1][Code Root Fixup: 0.0 ms][Code Root Purge: 0.0 ms][Clear CT: 0.4 ms][Other: 5.7 ms][Choose CSet: 0.0 ms][Ref Proc: 0.5 ms][Ref Enq: 0.0 ms][Redirty Cards: 0.2 ms][Humongous Register: 0.0 ms][Humongous Reclaim: 0.0 ms][Free CSet: 1.1 ms][Eden: 3192.0M(3192.0M)->0.0B(3192.0M) Survivors: 80.0M->80.0M Heap: 10.4G(16.0G)->7494.1M(16.0G)]
Heap after GC invocations=10527 (full 0):garbage-first heap total 16777216K, used 7673982K [0x00000003c0000000, 0x00000003c0804000, 0x00000007c0000000)region size 8192K, 10 young (81920K), 10 survivors (81920K)Metaspace used 113051K, capacity 114336K, committed 114816K, reserved 1150976Kclass space used 13294K, capacity 13594K, committed 13696K, reserved 1048576K
}[Times: user=4.15 sys=0.00, real=0.24 secs]After MixedGC
2020-01-12T19:37:51.074+0800: 192723.985: [SoftReference, 0 refs, 0.0000829 secs]2020-01-12T19:37:51.074+0800: 192723.985: [WeakReference, 3 refs, 0.0000134 secs]2020-01-12T19:37:51.074+0800: 192723.985: [FinalReference, 28 refs, 0.0000514 secs]2020-01-12T19:37:51.074+0800: 192723.985: [PhantomReference, 0 refs, 64 refs, 0.0000221 secs]2020-01-12T19:37:51.074+0800: 192723.985: [JNI Weak Reference, 0.0000299 secs], 0.0240489 secs][Parallel Time: 18.6 ms, GC Workers: 18][GC Worker Start (ms): Min: 192723966.5, Avg: 192723966.7, Max: 192723966.9, Diff: 0.4][Ext Root Scanning (ms): Min: 2.3, Avg: 2.6, Max: 3.0, Diff: 0.7, Sum: 46.1][Update RS (ms): Min: 3.2, Avg: 3.5, Max: 3.9, Diff: 0.7, Sum: 63.3][Processed Buffers: Min: 8, Avg: 20.9, Max: 61, Diff: 53, Sum: 377][Scan RS (ms): Min: 0.0, Avg: 0.1, Max: 0.1, Diff: 0.1, Sum: 1.4][Code Root Scanning (ms): Min: 0.0, Avg: 0.0, Max: 0.0, Diff: 0.0, Sum: 0.0][Object Copy (ms): Min: 11.5, Avg: 11.8, Max: 12.0, Diff: 0.5, Sum: 213.0][Termination (ms): Min: 0.0, Avg: 0.0, Max: 0.0, Diff: 0.0, Sum: 0.2][Termination Attempts: Min: 1, Avg: 1.0, Max: 1, Diff: 0, Sum: 18][GC Worker Other (ms): Min: 0.0, Avg: 0.1, Max: 0.3, Diff: 0.3, Sum: 2.2][GC Worker Total (ms): Min: 17.9, Avg: 18.1, Max: 18.3, Diff: 0.5, Sum: 326.1][GC Worker End (ms): Min: 192723984.7, Avg: 192723984.8, Max: 192723984.8, Diff: 0.1][Code Root Fixup: 0.0 ms][Code Root Purge: 0.0 ms][Clear CT: 0.4 ms][Other: 5.0 ms][Choose CSet: 0.0 ms][Ref Proc: 0.4 ms][Ref Enq: 0.0 ms][Redirty Cards: 0.2 ms][Humongous Register: 2.0 ms][Humongous Reclaim: 0.0 ms][Free CSet: 1.1 ms][Eden: 3200.0M(3200.0M)->0.0B(3192.0M) Survivors: 72.0M->80.0M Heap: 4205.6M(16.0G)->1011.7M(16.0G)]
Heap after GC invocations=10533 (full 0):garbage-first heap total 16777216K, used 1035991K [0x00000003c0000000, 0x00000003c0804000, 0x00000007c0000000)region size 8192K, 10 young (81920K), 10 survivors (81920K)Metaspace used 113051K, capacity 114336K, committed 114816K, reserved 1150976Kclass space used 13294K, capacity 13594K, committed 13696K, reserved 1048576K
}[Times: user=0.22 sys=0.10, real=0.02 secs]
问题分析
- 为何mixedGC可以使YoungGC恢复正常 ？
- 如何使优化使服务稳定?
问题1 为何mixedGC可以使YoungGC恢复正常
RootSet：包括寄存器，调用栈，全局变量
RememberSet：记录OldRegion到YoungRegion的引用
YoungGC包括如下几个步骤
- 初始标记：遍历RootSet 和 RememberSet 标记存活实例 （STW）
- 并发标记：遍历Eden及Survivors，标记存活实例加入CSet
- 重复标记：SATB（Snapshot-at-the-beginning)增量回收 步骤2期间发生变化的实例 （STW）， 标记存活实例加入CSet
- 最终回收：部分STW，并发
从整体情况来看，步骤一及步骤三是STW主要花费时间的阶段。
步骤一主要花费时间取决于两个变量 RootSet.size 与 RememberSet.size。
步骤三主要花费时间取决于SATB队列.size，由于并发标记速度较快。该时间可忽略。
步骤四主要花费时间取决于CSet大小及SurvivorsRegion.size
因此，从BeforeMixGC 和 AfterMixGC情况来看，其主要变更的是RememberSet大小。
从年代回收算法来看：
- Young： 临时，短期内存占用
- Eden：中期内存占用
- Old: 长期及永久内存占用
对于当前服务来说，服务理想情况内存占用分布情况应该为：
- Young：临时变量，生命周期极短
- Eden：连接相关所有Event请求，生命中期中
- Old：PlayFramework组件、服务相关组件、配置信息等，生命周期与服务周期近乎相等
服务线上运行之后第一次MixedGC之后内存记录，做为真实old区应该占用空间大小。
[Eden: 3200.0M(3200.0M)->0.0B(3200.0M) Survivors: 72.0M->72.0M Heap: 5480.9M(16.0G)->1005.6M(16.0G)]
实际当服务运行至MixedGC临界时，实际内存表现为
[Eden: 3192.0M(3192.0M)->0.0B(3192.0M) Survivors: 80.0M->80.0M Heap: 10.4G(16.0G)->7494.1M(16.0G)]
可以看到服务在整体运行期间，实际上年代回收机制实际上并没有很好的执行。
目前年老代晋升的最大临界值 -XX:MaxTenuringThreshold=15
对象存活时间超过 T = 15 * YongGC间隔时间 即能进入Old区。
统计高峰期间隔时间： Min= 1s Ava=3s
2020-01-12 一天服务数据session存活时间数量
100s = 259
60s = 290
30s =576
15s =9463
问题2 如何使优化使服务稳定?
从问题1的分析来看，解决该问题可以从以下几方面着手
年代回收机制，业务请求生命周期维持在Young和Survivors
MixedGC触发机制，尽早的触发MixedGC避免RememberSet过大
业务层面优化，减少连接保持时间
年代回收机制
根据Mixed后容量预估，Min(Old.size) = 1.5G左右 ，跟进分析情况给出建议配置为
-XX:G1NewSizePercent=25 -XX:G1MaxNewSizePercent=75 -XX:MaxTenuringThreshold=25MixedGC触发机制
在RememberSet还未增长过大时，即触发MixedGC
-XX:InitiatingHeapOccupancyPercent=35
落地后续
整体峰值从80ms > 30ms，服务稳定性提高
【性能优化】记录一次YounGC峰值优化相关推荐
- Zabbix服务器性能优化记录
Zabbix服务器性能优化记录 一.检查服务器当前负载 二.检查CPU和内存占比 1.CPU占用率情况 2.内存使用情况 三.处理解决 1.临时关闭图形界面 2.systemd启动目标介绍 3.永久设 ...
- React性能优化记录（不定期更新）
React性能优化记录(不定期更新) 1. 使用PureComponent代替Component 在新建组件的时候需要继承Component会用到以下代码 import React,{Componen ...
- Android开发之Android性能优化记录
Android 性能优化 Android 中的性能优化在我看来分为以下几个方面:内存优化.布局优化.网络优化.安装包优化: 内存优化: 下一个问题就是: 布局优化: 布局优化的本质就是减少 View ...
- 拉勾课程--性能优化记录
性能 所谓性能,就是使用有限的资源在有限的时间内完成工作.最主要的衡量因素就是时间,所以很多衡量指标,都可以把时间作为横轴. 加载缓慢的网站,会受到搜索排名算法的惩罚,从而导致网站排名下降. 因此加载 ...
- （2020.12.7）初次web前端性能优化记录
(转载公司内部论坛本人文章2020.12.7) 导语: 作为客户端开发,由于项目的需要,最近一年陆续做了很多web前端的需求开发.但过去做的大部分都是单页面的运营H5,上线时间短,一般保证能稳定运行就 ...
- 提高C++性能的编程技术笔记：设计优化/可扩展性/系统体系结构相关+测试代码
1. 设计优化 我们可以粗略地将性能优化分为两种类型:编码优化和设计优化.编码优化定义为不需要完整理解要解决的问题或者应用程序的执行流程就能实施的优化.通过定义看出,编码优化用于局部代码,同时该过程不 ...
- html个人主页_前端性能优化实践 之 百度App个人主页优化
作者:潘铭 @祝余 前言 性能是每个前端工程师都应该关注的话题,通用的优化手段已有许多文章和实践,就不再赘述,本篇以百度App个人主页为例,聊聊针对业务特点进行的一些性能优化实践. 适用于:传统意义的 ...
- MySQL02--高级(BTreeB+Tree、聚簇索引非聚簇索引、性能分析(Explain)、索引、sql优化)
1.MySQL架构 2.sql 执行顺序: FROM <LEFT_TABLE> ON <JOIN_CONDITION> <JOIN_TYPR> JOIN <R ...
- Android性能优化(5)：APK瘦身优化
文章目录 1. APK文件结构 2. APK瘦身优化 2.1 优化dex文件大小 2.1.1 Proguard 2.1.2 AndResGuard 2.2 优化资源文件大小 2.2.1 Android ...
- Android 网络性能优化（4）弱网优化
系列文章目录 1. Android 网络性能优化(1)概述 2. Android 网络性能优化(2)DNS优化 3. Android 网络性能优化(3)复用连接池 4. Android 网络性能优化( ...
最新文章
- MyBatis架构分层
- 自定义动画 animate || 案例：王者荣耀手风琴效果分析
- 在Spring 框架中如何更有效的使用JDBC？
- cocos2dx3.0五种屏幕适配模式,及FIXED_WIDTH、FIXED_HEIGHT使用
- 8 种有趣的用于 Web 品牌的动物
- 【思维】Iranian ChamPions Cup
- 零基础自学html5要多久？Web前端学习路线的6点建议
- APP移动购物界面设计灵感
- mysql的事务隔离级别
- Windows2003四大必知版本
- linux/mac下一键删除下载失败的maven jar包
- 华为 oj java题库_华为OJ 201301 JAVA题目0-1级
- 玩转Redis-生产环境如何导入、导出及删除大量数据
- 量子计算机原理 纠缠,白话量子计算机原理【前面的那个有错误，重新理清了一下思路】...
- android模拟器超级root,android模拟器root,avd root,emulator root教程
- webrtc QOS方法四（Sender Side BWE）
- 利用快速傅里叶计算多项式相乘
- 解决双击excel文件打开多个excel.exe进程的问题
- 《视觉SLAM十四讲》详细笔记
- 大学如何学习——我的五年失败经验总结