JVM 分析GC日志

最新推荐文章于 2024-05-27 16:10:53 发布
最新推荐文章于 2024-05-27 16:10:53 发布
阅读量262 收藏
点赞数
分类专栏： JVM Java 文章标签： jvm java
版权声明：本文为博主原创文章，遵循 CC 4.0 BY-SA 版权协议，转载请附上原文出处链接和本声明。
本文链接：https://blog.csdn.net/qq_36942720/article/details/134832818
版权
Java 同时被 2 个专栏收录
64 篇文章 6 订阅
订阅专栏
JVM
12 篇文章 0 订阅
订阅专栏

GC日志参数

-verbose:gc

输出gc日志信息，默认输出到标准输出

-XX:+PrintGC

输出GC日志。类似：-verbose:gc

-XX:+PrintGCDetails

在发生垃圾回收时打印内存回收详细的日志，并在进程退出时输出当前内存各区域分配情况

-XX:+PrintGCTimeStamps

输出GC发生时的时间戳

-XX:+PrintGCDateStamps

输出GC发生时的时间戳（以日期的形式，如2013-05-04T21:53:59.234+0800)

-XX:+PrintHeapAtGC

每一次GC前和GC后，都打印堆信息

-Xloggc:<file>

表示把GC日志写入到一个文件中去，而不是打印到标准输出中

GC日志格式

GC日志分类

MinorGC

        MinorGC(或young GC或YGC)日志：

[GC (Allocation Failure) [PSYoungGen: 31744K->2192K(36864K)] 31744K->2200K(121856K), 0.0139308 secs] [Times: user=0.05 sys=0.01, real=0.01 secs] 

FullGC

        Full GC日志介绍：

[Full GC (Metadata GC Threshold) [PSYoungGen: 5104K->0K(132096K)] [ParOldGen: 416K->5453K(50176K)] 5520K->5453K(182272K), [Metaspace: 20637K->20637K(1067008K)], 0.0245883 secs] [Times: user=0.06 sys=0.00, real=0.02 secs] 

GC日志结构剖析

垃圾收集器

  • 使用Serial收集器在新生代的名字是Default New Generation，因此显示的是"[DefNew"
  • 使用ParNew收集器在新生代的名字会变成"[ParNew",意思是"Parallel New Generation"
  • 使用Parallel Scavenge收集器在新生代的名字是"[PSYoungGen",这里的JDK1.7使用的就是PSYoungGen
  • 使用Parallel Old Generation收集器在老年代的名字是"[ParOldGen"
  • 使用G1收集器的话，会显示为"garbage-first heap"

Allocation Failure：表明本次引起GC的原因是因为在年轻代中没有足够的空间能够存储新的数据了。

GC前后情况

        我们可以发现GC日志格式的规律一般都是：GC前内存占用—>GC后内存占用（该区域内存总大小）

        [PSYoungGen: 5986K->696K(8704K)] 5986K->704K(9216K)

        中括号内：GC回收前年轻代堆大小，回收后大小，（年轻代堆总大小）

        括号外：GC回收前年轻代和老年代大小，回收后大小，（年轻代和老年代总大小）

GC时间

GC日志中有三个时间：user，sys和real

  • user – 进程执行用户态代码（核心之外）所使用的时间。这是执行此进程所使用的实际 CPU 时间，其他进程和此进程阻塞的时间并不包括在内。在垃圾收集的情况下，表示 GC 线程执行所使用的 CPU 总时间。
  • sys – 进程在内核态消耗的 CPU 时间，即在内核执行系统调用或等待系统事件所使用的 CPU 时间。
  • real – 程序从开始到结束所用的时钟时间。这个时间包括其他进程使用的时间片和进程阻塞的时间（比如等待 I/O 完成）。对于并行gc，这个数字应该接近（用户时间+系统时间）除以垃圾收集器使用的线程数。

        由于多核的原因，一般的GC事件中，real time是小于sys + user time的，因为一般是多个线程并发的去做GC，所以real time是要小于sys+user time的。如果real>sys+user的话，则你的应用可能存在下列问题：IO负载非常重或者是CPU不够用。

Minor GC日志解析

2020-11-20T17:19:43.265-0800: 0.822: [GC (ALLOCATION FAILURE) [PSYOUNGGEN: 76800K->8433K(89600K)] 76800K->8449K(294400K), 0.0088371 SECS] [TIMES: USER=0.02 SYS=0.01, REAL=0.01 SECS] 

2020-11-20T17:19:43.265-0800

        日志打印时间日期格式如2013-05-04T21:53:59.234+0800

0.822

        gc发生时，Java虚拟机启动以来经过的秒数

[GC (ALLOCATION FAILURE)

        发生了一次垃圾回收，这是一次Minor GC。它不区分新生代GC还是老年代GC，括号里的内容是gc发生的原因，这里的Allocation Failure的原因是新生代中没有足够区域能够存放需要分配的数层而失败。

[PSYOUNGGEN: 76800K->8433K(89600K)]

PSYoungGen:表示GC发生的区域，区域名称与使用的GC收集器是密切相关的

  1. Serial收集器：Default New Generation显示DefNew
  2. ParNew收集器：ParNew
  3. Parallel Scanvengel收集器：PSYoung
  4. 老年代和新生代同理，也是和收集器名称相关

76800K->8433K(89600K：GC前该内存区域已使用容量·>GC后该区域容量（该区域总容量）

  1. 如果是新生代，总容量则会显示整个新生代内存的9/10，即eden+from/to区
  2. 如果是老年代，总容量则是全部内存大小，无变化

76800K->8449K(294400K)

        在显示完区域容量GC的情况之后，会接着显示整个堆内存区域的GC情况：GC前堆内存已使用容量·>GC堆内存容量（堆内存总容量）

        堆内存总容量=9/10新生代+老年代<初始化的内存大小

0.0088371 SECS

        整个GC所花费的时间，单位是秒

[TIMES: USER=0.02 SYS=0.01, REAL=0.01 SECS] 

        user：指的是CPU工作在用户态所花费的时间

        sys：指的是CPU工作在内核态所花费的时间

        rea：指的是在此次Gc事件中所花费的总时间

Full GC日志解析

2020-11-20T17:19:43.794-0800: 1.351: [FULL GC (METADATA GC THRESHOLD) [PSYOUNGGEN: 10082K->0K(89600K)] [PAROLDGEN: 32K->9638K(204800K)] 10114K->9638K(294400K),[METASPACE: 20158K->20156K(1067008K)], 0.0285388 SECS] [TIMES: USER=0.11 SYS=0.00, REAL=0.03 SECS] 

2020-11-20T17:19:43.794-0800

        日志打印时间日期格式如2013-05-04T21:53:59.234+0800

1.351

        gc发生时，Java虚拟机启动以来经过的秒数

FULL GC (METADATA GC THRESHOLD)

        发生了一次垃圾回收，这是一次FULL GC。它不区分新生代GC还是老年代GC。括号里的内容是gc发生的原因，这里的Metadata GC Threshold的原因是Metaspacel区不够用了。

        Full GC(Ergonomics)：JVM自适应调整导致的GC

        Full GC(System)：调用了System.gc()方法

[PSYOUNGGEN: 10082K->0K(89600K)]

        PSYoungGen:表示GC发生的区域，区域名称与使用的GC收集器是密切相关的

  1. Seriall收集器：Default New Generation显示DefNew
  2. ParNewl收集器：ParNew
  3. Parallel Scanvengel收集器：PSYoung
  4. 老年代和新生代同理，也是和收集器名称相关

        10082K->0K(89600K):GC前该内存区域已使用容量 --> GC后该区域容量（该区域总容量）

  1. 如果是新生代，总容量则会显示整个新生代内存的9/10，即eden+from/to区
  2. 如果是老年代，总容量则是全部内存大小，无变化

[PAROLDGEN: 32K->9638K(204800K)]

        老年代区域没有发生GC，因为本次GC是metaspace起的

10114K->9638K(294400K)

        在显示完区域容量GC的情况之后，会接着显示整个堆内存区域的GC情况：GC前堆内存已使用容量 --> GC堆内存容量（堆内存总容量）堆内存总容量=9/10新生代+老年代<初始化的内存大小

[METASPACE: 20158K->20156K(1067008K)]

        metaspace GC回收2K空间

0.0285388 SECS

        整个GC所花费的时间，单位是秒

[TIMES: USER=0.11 SYS=0.00, REAL=0.03 SECS] 

        user：指的是CPU工作在用户态所花费的时间

        sys：指的是CPU工作在内核态所花费的时间

        rea：指的是在此次Gc事件中所花费的总时间

案例演示

代码

/**
 * 在jdk7 和 jdk8中分别执行
 *  * -verbose:gc -Xms20M -Xmx20M -Xmn10M -XX:+PrintGCDetails -XX:SurvivorRatio=8 -XX:+UseSerialGC
 */
public class GCLogTest1 {
    private static final int _1MB = 1024 * 1024;

    public static void testAllocation() {
        byte[] allocation1, allocation2, allocation3, allocation4;
        allocation1 = new byte[2 * _1MB];
        allocation2 = new byte[2 * _1MB];
        allocation3 = new byte[2 * _1MB];
        allocation4 = new byte[4 * _1MB];
    }

    public static void main(String[] agrs) {
        testAllocation();
    }
}

图解

在JDK7中：与jdk8中有所不同

GC日志分析工具

        上节介绍了GC日志的打印及含义，但是GC日志看起来比较麻烦，本节将会介绍一下GC日志可视化分析工具GCeasy和GCviewer等。通过GC日志可视化分析工具，我们可以很方便的看到JVM各个分代的内存使用情况、垃圾回收次数、垃圾回收的原因、垃圾回收占用的时间、吞吐量等，这些指标在我们进行JVM调优的时候是很有用的。

        如果想把GC日志存到文件的话， 是下面这个参数：-Xloggc:/path/to/gc.log 然后就可以用一些工具去分析这些gc日志。

GCeasy

        GCeasy——一款超好用的在线分析GC日志的网站

        官网地址：https://gceasy.io/，GCeasy是一款在线的GC日志分析器，可以通过GC日志分析进行内存泄漏检测、GC暂停原因分析、JVM配置建议优化等功能，而且是可以免费使用的（有一些服务是收费的）。

GCViewer

        GCViewer是一个免费的、开源的分析小工具，用于可视化查看由SUN/Oracle,IBM,HP和BEA Java虚拟机产生的垃圾收集器的日志。

        GCViewer用于可视化Java VM选项-verbose:gc 和.NET生成的数据-Xloggc:<file>。它还计算与垃圾回收相关的性能指标（吞吐量，累积的暂停，最长的暂停等）。当通过更改世代大小或设置初始堆大小来调整特定应用程序的垃圾回收时，此功能非常有用。

1.下载GCViewer工具

        源码下载：https://github.com/chewiebug/GCViewer

        运行版本下载：https://github.com/chewiebug/GCViewer/wiki/Changelog

2.只需双击gcviewer-1.3x.jar或运行java -jar gcviewer-1.3x.jar（它需要运行java 1.8 vm），即可启动GCViewer（gui）

其他工具

GChisto：GChisto是一款专业分析gc日志的工具，可以通过gc日志来分析：MinorGC、Full GC的次数、频率、持续时间等，通过列表、报表、图表等不同形式来反应gc的情况。

HPjmeter：工具很强大，但只能打开由以下参数生成的GC log，verbose:gc-XIoggc:gc.log。添加其他参数生成的gc.log无法打开。HPjmeter集成了以前的HPjtunel功能，可以分析在HP机器上产生的垃圾回收日志文件

Please Sit Down
关注
  • 0
    点赞
  • 踩
  • 0
    收藏
    觉得还不错? 一键收藏
  • 打赏
    打赏
  • 0
    评论
专栏目录
JVM——GC日志实战分析
庄小焱
12-01 2737
博文将具体示例来演示如何输出 GC 日志，并对输出的日志信息进行解读分析，从中提取有用的信息。
linux jvm gc日志分析,JVM之GC统计以及日志分析
weixin_39634985的博客
05-01 990
环境&准备代码JDK环境openjdk version "1.8.0_191"编写一段代码，循环声明对象，并分配 10MB 堆空间，暴露web接口多次调用。for (int i = 0; i < 100; i++) {byte[] b1 = new byte[1024 * 1024 * 10];byte[] b2 = new byte[1024 * 1024 * 10];byte[]...
JVM分析GC日志
CB_Beginner的博客
09-28 526
在显示完区域容量GC的情况之后，会接着显示整个堆内存区域的GC情况：GC前堆内存已使用容量->GC后堆内存容量（堆内存总容量），并且堆内存总容量 = 9/10 新生代 + 老年代，然后堆内存总容量肯定小于初始化的内存大小。它不区分新生代还是老年代GC，括号里的内容是gc发生的原因，这里的Allocation Failure的原因是新生代中没有足够区域能够存放需要分配的数据而失败。PSYoungGen：表示GC发生的区域，区域名称与使用的GC收集器是密切相关的。如果是老年代，总容量则是全身内存大小，无变化。
JVM-GC日志详细分析
流浪的喵的博客
11-21 1857
JVM-GC日志详细分析 1.打印GC日志参数 1.3 基本JVM参数 参数示例 描述说明 -verbose:gc 控制台打印GC参数 -Xms20M 初始堆大小 20M -Xmx20M 最大堆大小20M 一般情况下-Xms和-Xmx这两个值设为相同大小 -Xmn10M 新生代最大可用值10M -XX:+PrintGC 触发GC时日志打印 -XX:+PrintGCDetails 触发GC时日志打印详细 –XX:UseSerialGC 串行回收 -XX:Surviv
JVM性能调优——GC日志分析
码说芯语的博客
04-13 1732
生成GC日志、Parallel垃圾收集器日志解析、G1垃圾收集器日志解析、CMS垃圾收集器日志解析、日志解析工具
linux jvm gc日志分析,JVM GC 日志详解
weixin_29711471的博客
05-01 1097
本文采用的JDK版本：java version "1.8.0_144"Java(TM) SE Runtime Environment (build 1.8.0_144-b01)Java HotSpot(TM) 64-Bit Server VM (build 25.144-b01, mixed mode)一、GC 日志参数设置JVM GC格式日志的主要参数包括如下8个：-XX:+PrintGC 输出...
JVM-之GC日志
最新发布
tian830937的专栏
05-27 889
在项目中开启GC 日志打印后会查看gc 日志如下gc日志如下在项目中如果需要查看使用的垃圾收集器出了使用GC 日志中去分析还可以使用如下命令。
JVM之GC日志
qq_35597828的博客
04-14 3478
GC日志有什么用 在Java中，GC日志能够帮助我们分析内存动态分配和垃圾回收，让我们有针对的对程序进行优化 如何查看GC日志 先准备一个案例程序 public class GCTest { public static void main(String[] args) { int i = 0; List<User> userList = new ArrayList<>(); while (true) {
JVM 配置GC日志
Coco_chun的博客
09-16 7654
开启GC日志 多种方法都能开启GC的日志功能，其中包括：使用-verbose:gc或-XX:+PrintGC这两个标志中的任意一个能创建基本的GC日志 （这两个日志标志实际上互为别名，默认情况下的GC日志功能是关闭的） 使用-XX:+PrintGCDetails标志会创建更详细的GC日志 推荐使用-XX:+PrintGCDetails标志（这个标志默认情况下也是关闭的）； 通常情况下使用基本的GC日志很难诊断垃圾回收时发生的问题。 开启GC时间提示 除了使用详细的GC日志，我们还推荐使用-XX:+P
JVM查看GC日志
cristianoxm的博客
04-23 4680
一、如何打印出JVM GC日志 需要在系统的JVM参数中加入GC日志的打印选型，jvm参数如下所示： -XX:NewSize=5242880 -XX:MaxNewSize=5242880 -XX:InitialHeapSize=10485760 -XX:MaxHeapSize=10485760 -XX:SurvivorRatio=8 -XX:PretenureSizeThreshold=10485760 -XX:+UseParNewGC -XX:+UseConcMarkSweepGC -XX:+Print
jvmgc日志分析工具
03-20
"jvmgc日志分析工具"专为解析和可视化JVM生成的GC日志而设计，帮助开发者识别内存瓶颈，调整内存设置，以及诊断可能的性能问题。 GC日志是JVM在运行过程中记录的关于垃圾收集活动的详细信息，包括垃圾收集的起始...
JVM 输出 GC 日志导致 JVM 卡住
07-08
JVM 输出 GC 日志导致 JVM 卡住是一个复杂的问题，需要作者通过多方面的分析和监控来定位和解决问题。 知识点： 1. JVM 垃圾回收机制（Garbage Collection，GC） 2. JVM 日志配置，包括 GC 日志、JIT 编译日志和 ...
Java虚拟机GC日志分析
08-28
Java虚拟机GC日志分析 Java虚拟机GC日志分析是Java开发者不可或缺的一项技能，通过对GC日志的分析，可以了解Java虚拟机中的内存使用情况，避免内存溢出和性能问题。本文将对Java虚拟机GC日志分析进行详细的介绍，并...
GChisto GC日志分析工具
10-24
**GChisto GC日志分析工具** 在Java应用程序中，垃圾收集（Garbage Collection, GC）是自动管理内存的关键组成部分。然而，理解GC的工作方式以及它如何影响应用性能可能是一项复杂的任务。这就是GChisto这样的工具...
jvm gc分析工具gcviewer-1.36.jar
12-23
对gc日志进行统计分析，使用命令：java -jar gcviewer-1.3x.jar gc.log summary.csv [chart.png] [-t PLAIN|CSV|CSV_TS|SIMPLE|SUMMARY]
计算两个数的平均值几种方法
一位打工仔的博客
10-29 8439
方法一：直接求平均值（两个数相加再除以二） int average(int x,int y){ return (x + y) / 2; } 这种算法存在着一定的缺陷，当x和y足够大时x和y的和就会存在数据溢出，从而得不到我们想要的结果。（不推荐采用） 方法二：x + y与x的差值除以2的和，可以避免数据溢出 int average(int x,int y){ return x + (y - x) / 2; } 方法三：改进方法二版本（位移） int average(int.
数组下标为什么是从0开始？
一位打工仔的博客
02-25 7839
数组的 4 个基本元素：数组名称、数组元素、元素下标、数据类型 数组（Arrary）是一种线性表数据结构。它用一组连续的内存空间，来存储一组具有相同类型的数据(方便寻址)。 原因一：历史原因 语言出现顺序从早到晚C、Java、JavaScript。C语言数组下标是从0开始->Java也是->JavaScript也是。降低额外的学习和理解成本。 原因二：减少CPU指令运算 ①下标从0开始： 数组寻址：arr[i] = base_addre...
CAS单点登录
一位打工仔的博客
06-01 6831
CAS是Central Authentication Service的缩写，中央认证服务，一种独立开放指令协议。CAS 是 耶鲁大学（Yale University）发起的一个开源项目，旨在为 Web 应用系统提供一种可靠的单点登录方法，CAS 在 2004 年 12 月正式成为 JA-SIG 的一个项目。
SpringBoot3 整合Swagger
一位打工仔的博客
12-26 1830
Swagger 可以快速生成文档，方便前后开发人员进行协调沟通。遵循规范。文档：https://springdoc.org/v2/
深入理解JVM：关键配置参数与GC日志解析
- `-XX:+PrintGCTimeStamps`：添加时间戳到GC日志中，帮助分析GC活动与应用性能的关系。 2. **堆的分配参数**： - 堆内存通常分为新生代（Young Generation）、老年代（Tenured Generation）和永久代（Permanent ...
评论
添加红包

请填写红包祝福语或标题

个

红包个数最小为10个

元

红包金额最低5元

当前余额3.43元 前往充值 >
需支付：10.00元
成就一亿技术人!
领取后你会自动成为博主和红包主的粉丝 规则
hope_wisdom
发出的红包

打赏作者

Please Sit Down

你的鼓励将是我创作的最大动力

¥1 ¥2 ¥4 ¥6 ¥10 ¥20
扫码支付：¥1
获取中
扫码支付

您的余额不足，请更换扫码支付或充值

打赏作者

实付元
使用余额支付
点击重新获取
扫码支付
钱包余额 0

抵扣说明：

1.余额是钱包充值的虚拟货币，按照1:1的比例进行支付金额的抵扣。
2.余额无法直接购买下载，可以购买VIP、付费专栏及课程。

余额充值