6、虚拟机性能监控与故障处理工具(1)(JVM笔记)

一、JDK的命令行工具

所有的命令行工具都在bin目录中。Sun JDK监控和故障处理工具如下:

名称 主要作用
jps JVM Process Status Tool,显示指定系统内所有的HotSpot虚拟机进程
jstat JVM Statistics Monitoring Tool,用于收集HotSpot虚拟机各方面的运行数据
jinfo Configuration Info for Java,显示虚拟机配置信息
jmap Memory Map for Java,生成虚拟机的内存转储快照(headdump文件)
jhat JVM Heap Dump Browser,用于分析headdump文件,它会建立一个HTTP/HTML服务器,让用户可以在浏览器上查看分析结果
jstack Stack Trace for Java,显示虚拟机的线程快照

1.1 jps:虚拟机进程状况工具

此工具可以列出正在运行的虚拟机进程,并显示虚拟机执行主类(Main Class, main()函数所在的类)名称以及这些进程的本地虚拟机唯一ID(Local Virtual Machine Identifier,LVMID)。其他的JDK工具大多需要输入它查询到的LVMID来确定要监控的是哪一个虚拟机进程。对于本地虚拟机进程来说,LVMID与操作系统的进程ID(Process Identifier,PID)是一致的,使用windows的任务管理器或UNIXps命令也可以查询到虚拟机进程的LVMID,但如果同时启动了多个虚拟机进程,无法根据进程名称定位时,那就只能依赖此命令显示主类的功能才能区分了。命令格式如下:

jps [ options ] [ hostid ]

其主要选项如下:

选项 作用
-q 只输出LVMID,省略主类的名称
-m 输出虚拟机进程启动时传递给主类main()函数的参数
-l 输出主类的全名,如果进程执行的是Jar包,输出Jar路径
-v 输出虚拟机进程启动时JVM参数

1.2 jstat:虚拟机统计信息监视工具

此工具用于监视虚拟机各种运行状态信息的命令行工具。它可以显示本地或者远程虚拟机进程中的类装载、内存、垃圾收集、JIT编译等运行数据。其命令格式为:

jstat [ option  vmid [ interval [ s|ms ] [ count ] ] ]

说明:如果是本地虚拟机进程,VMIDLVMID是一致的,如果是远程虚拟机进程,那VMID的格式应当是:

[ protocol: ][ // ] lvmid [ @hostname [ :port ] / servername ]

其中intervalcount代表查询间隔和次数,如果省略这两个参数,说明只查询一次。假设需要250ms查询一次进程2764垃圾收集状况,一共查询20次,那命令应该是:

jstat -gc 2764 250 20

选项option代表着用户希望查询的虚拟机信息,主要分为三类:类装载、垃圾收集、运行期编译状况,具体选项及作用如下:

选项 作用
-class 监视类装载、卸载数量、总空间以及类装载所耗费的时间
-gc 监视Java堆状况,包括Eden区、两个survivor区、老年代、永久代等的容量、已用空间、GC时间合计等信息
-gccapacity 监视内容与-gc基本相同,但输出主要关注Java堆各个区域使用到的最大、最小空间
-gcutil 监视内容与-gc基本相同,但输出主要关注已使用空间占总空间的百分比
-gccause -gcutil功能一样,但是会额外输出导致上一次GC产生的原因
-gcnew 监视新生代GC状况
-gcnewcapacity 监视内容与-gcnew基本相同,输出主要关注使用到的最大、最小空间
-gcold 监视老年代GC状况
-gcoldcapactiy 监视内容与-gcold基本相同,输出主要关注使用到的最大、最小空间
-gcpermcapacity 输出永久代使用到的最大、最小空间
-compiler 输出JIT编译器编译过的方法、耗时等信息
-printcompilation 输出已经被JIT编译的方法

下面通过一个例子简单了解一下:

1

说明:这台服务器的新生代Eden区(E,表示Eden)使用了6.2%的空间,两个survivor区(S0、S1,表示survivor0、survivor1)里面都是空的,老年代(O,表示Old)和永久代(P,表示Permanent)则分别使用了41.42%47.20%的空间。程序运行以来共发生Minor GCYGC,表示Young GC16次,总耗时0.105s,发生Full GCFGC,表示Full GC)三次,Full GC总耗时(FGCT,表示Full GC Time)为0.472s,所有GC总耗时(GCT,表示GC Time)为0.577s

1.3 jinfo:Java配置信息工具

此工具是实时地查看和调整虚拟机各项参数。使用jps命令的-v参数可以查看虚拟机启动时显式指定的参数列表,但如果想知道未被显式指定的参数的系统默认值,除了去找资料外,就只能使用jinfo-flag选项进行查询了(如果只限于JDK1.6或以上版本,则使用java -XX:+PrintFlagsFinal查看参数默认值也是一个很好的选择),jinfo还可以使用-sysprops选项把虚拟机进程的Sytem.getProperties()的内容打印出来,还有在运行期修改参数的能力,可以使用-flag[+|-] name-flag name=value修改一部分运行期可写的虚拟机参数值。在windows中有较大限制,只提供了最基本的-flag选项。其命令格式如下:

jinfo [ option ] pid

1.4 jmap:Java内存映像工具

此命令用于生成堆转储快照(一般称为headdumpdump文件)。如果不实用此命令,要想获取Java堆转储快照,可以使用之前提到的暴力手段,即使用-XX:+HeadDumpOnOutOfMemoryError参数,可以让虚拟机在OOM异常出现之后自动生成dump文件,通过-XX:+HeadDumpOnCtrlBreak参数则可以使用[Ctrl]+[Break]键让虚拟机生成dump文件,又或者在Linux中使用Kill -3命令拿到dump文件。当然,此命令的作用不仅仅是为了获取dump文件,它还可以查询finalize执行队列、Java堆和永久代的详细信息,如空间使用率、当前用的是哪种收集器等。其功能在windows中受限,除了生成dump文件的-dump选项和用于查看每个类的实例、空间占用统计的-histo选项在所有操作系统都提供之外,其余选项都智能在Linux/Solaris下使用。其命令格式:

jmap [ option ] vmid

主要选项如下:

选项 作用
-dump 生成Java堆转储快照。格式为:-dump:[live, ]format=b, file=<filename>, 其中live子参数说明是否只dump出存活的对象
-finalizerinfo 显示在F-Queue中等待Finalizer线程执行finalizer方法的对象。只在Linux/Solaris平台有效
-heap 显示Java堆详细信息,如使用哪种回收期、参数配置、分代状况等。只在Linux/Solaris平台有效
-histo 显示堆中对象统计信息,包括类、实例数量、合计容量
-permstat ClassLoader为统计口径显示永久代内存状态。只在Linux/Solaris平台有效
-F 当虚拟机进程对-dump选项没有响应时,可使用这个选项强制生成dump快照。只在Linux/Solaris平台有效

例如:(3500LVMID

2

1.5 jhat:虚拟机堆转储快照分析工具

此命令和jmap搭配使用,来分析jmap生成的堆转储快照。其内置一个微型的HTTP/HTML服务器,生成dump文件的分析结果后,可以在浏览器中查看。一般不会使用此命令来分析dump文件,因为一是一般不会在部署应用的服务器上直接分析dump文件(太耗资源),而是此工具功能相对较为简陋,可以使用后面讲到的VisualVM工具替代。

1.6 jstack:Java堆栈跟踪工具

此命令用于生成虚拟机当前时刻的线程快照(一般称为threaddump或者javacore文件)。线程快照就是当前虚拟机内每一条线程正在执行的方法堆栈的集合,生成线程快照的主要目的是定位线程出现长时间停顿的原因,如线程间死锁、死循环、请求外部资源导致的长时间等待等都是导致线程长时间停顿的常见原因。线程出现停顿的时候通过此命令来查看各个线程的调用堆栈,就可以知道没有响应的线程到底在后台做什么,或等待什么资源。其格式为:

jstack [ option ] vmid

主要选项如下:

选项 作用
-F 当正常输出的请求不被响应时,强制输出线程堆栈
-l 除堆栈外,显示关于锁的附加信息
-m 如果调用到本地方法的话,可以显示C/C++的堆栈

在JDK1.5中,java.lang.Thread类新增了一个getAllStackTraces()方法用于获取虚拟机中所有线程的StackTraceElement对象。使用此方法通过几行简单的代码就可以完成jstack的大部分功能,在实际项目中不妨调用此方法做个管理员页面,随时查看线程堆栈。


3

1.7 HSDIS:JIT生成代码反汇编

随着技术的发展,高性能虚拟机真正的细节实现方式逐渐成了虚拟机实现的“概念模型”——即实现智能保证规范描述等效。基于此原因,在分析程序的执行语义问题(虚拟机做了什么)时,在字节码层面上分析完全可行,但分析程序的执行行为问题(虚拟机是怎样做的、性能如何)时,在字节码层面上分析居没有什么意义了,需要通过其他方式解决。

HSDIS是官方对剑的HotSpot虚拟机JIT编译代码的反汇编插件,它包含在HotSpot虚拟机的源码之中,但没有提供编译后的程序。其作用是让HotSpot-XX:+PrintAssembly指令调用它来把动态生成的本地代码还原为汇编输出,同时还生成大量非常有价值的注释,这样我们就可以通过输出的代码来分析问题。注意,如果使用的DebugFastDebug版的HotSpot,那可以直接通过-XX:+PrintAssembly指令使用插件;如果使用的是Product版的HotSpot,那还要额外加入一个-XX:+UnlockDiagnosticVMOptions参数。

例如:测试代码

public class Bar{
  int a = 1;
  static int b = 2;
  
  public int sum(int c ){
    return a + b + c;
  }

  public static void main(String[] args){
    new Bar().sum(3);
  }
}

编译:

java -XX+:PrintAssembly -Xcomp -XX:CompileCommand=dontinline, *Bar.sum -XX:CompileCommand=Compileonly, *Bar.sum test.Bar

其中-Xcomp是让虚拟机以编译模式执行代码,这样就不需要执行足够次数来预热就能触发JIT编译(-Xcomp在新版本HotSpot已被移除)。两个-XX:CompileCommand是让编译器不要内联sum()并且只编译sum()-XX+:PrintAssembly就是输出反汇编内容。如果一切顺利会得到如下代码:

[Disassembling for mach='i386']
[Entry Point]
[Constants]
  # {method} 'sum' '(I)I' in 'test/Bar'
  # this:     ecx       = 'test/Bar'
  # parm0:    edx       = int
  #           [sp+0x20]  (sp of caller)
  ……
  0x01cac407: cmp    0x4(%ecx),%eax
  0x01cac40a: jne    0x01c6b050         ;   {runtime_call}
[Verified Entry Point]
  0x01cac410: mov    %eax,-0x8000(%esp)
  0x01cac417: push   %ebp
  0x01cac418: sub    $0x18,%esp         ;*aload_0
                                        ; - test.Bar::sum@0 (line  8)
  ;;  block B0 [0, 10]

  0x01cac41b: mov    0x8(%ecx),%eax     ;*getfield a
                                        ; - test.Bar::sum@1 (line 8)
  0x01cac41e: mov    $0x3d2fad8,%esi    ;   {oop(a 
'java/lang/Class' = 'test/Bar')}
  0x01cac423: mov    0x68(%esi),%esi    ;*getstatic b
                                        ; - test.Bar::sum@4 (line 8)
  0x01cac426: add    %esi,%eax
  0x01cac428: add    %edx,%eax
  0x01cac42a: add    $0x18,%esp
  0x01cac42d: pop    %ebp
  0x01cac42e: test   %eax,0x2b0100      ;   {poll_return}
  0x01cac434: ret  

说明:

  • 1、mov %eax,-0x8000(%esp):检查栈溢。
  • 2、push %ebp:保存上一栈帧基址。
  • 3、sub $0x18,%esp:给新帧分配空间。
  • 4、mov 0x8(%ecx),%eax:取实例变量a,这里0x8(%ecx)就是ecx+0x8的意思,前面“[Constants]”节中提示了“this:ecx = 'test/Bar'”,即ecx寄存器中放的就是this对象的地址。偏移0x8是越过this对象的对象头,之后就是实例变量a的内存位置。这次是访问“Java堆”中的数据。
  • 5、mov $0x3d2fad8,%esi:取test.Bar在方法区的指针。
  • 6、mov 0x68(%esi),%esi:取类变量b,这次是访问“方法区”中的数据。
  • 7、add %esi,%eax 、add %edx,%eax:做2次加法,求a+b+c的值,前面的代码把a放在eax中,把b放在esi中,而c[Constants]中提示了,“parm0:edx = int”,说明cedx中。
  • 8、add $0x18,%esp:撤销栈帧。
  • 9、pop %ebp:恢复上一栈帧。
  • 10、test %eax,0x2b0100:轮询方法返回处的SafePoint
  • 11、ret:方法返回。
最后编辑于
©著作权归作者所有,转载或内容合作请联系作者
  • 序言:七十年代末,一起剥皮案震惊了整个滨河市,随后出现的几起案子,更是在滨河造成了极大的恐慌,老刑警刘岩,带你破解...
    沈念sama阅读 203,547评论 6 477
  • 序言:滨河连续发生了三起死亡事件,死亡现场离奇诡异,居然都是意外死亡,警方通过查阅死者的电脑和手机,发现死者居然都...
    沈念sama阅读 85,399评论 2 381
  • 文/潘晓璐 我一进店门,熙熙楼的掌柜王于贵愁眉苦脸地迎上来,“玉大人,你说我怎么就摊上这事。” “怎么了?”我有些...
    开封第一讲书人阅读 150,428评论 0 337
  • 文/不坏的土叔 我叫张陵,是天一观的道长。 经常有香客问我,道长,这世上最难降的妖魔是什么? 我笑而不...
    开封第一讲书人阅读 54,599评论 1 274
  • 正文 为了忘掉前任,我火速办了婚礼,结果婚礼上,老公的妹妹穿的比我还像新娘。我一直安慰自己,他们只是感情好,可当我...
    茶点故事阅读 63,612评论 5 365
  • 文/花漫 我一把揭开白布。 她就那样静静地躺着,像睡着了一般。 火红的嫁衣衬着肌肤如雪。 梳的纹丝不乱的头发上,一...
    开封第一讲书人阅读 48,577评论 1 281
  • 那天,我揣着相机与录音,去河边找鬼。 笑死,一个胖子当着我的面吹牛,可吹牛的内容都是我干的。 我是一名探鬼主播,决...
    沈念sama阅读 37,941评论 3 395
  • 文/苍兰香墨 我猛地睁开眼,长吁一口气:“原来是场噩梦啊……” “哼!你这毒妇竟也来了?” 一声冷哼从身侧响起,我...
    开封第一讲书人阅读 36,603评论 0 258
  • 序言:老挝万荣一对情侣失踪,失踪者是张志新(化名)和其女友刘颖,没想到半个月后,有当地人在树林里发现了一具尸体,经...
    沈念sama阅读 40,852评论 1 297
  • 正文 独居荒郊野岭守林人离奇死亡,尸身上长有42处带血的脓包…… 初始之章·张勋 以下内容为张勋视角 年9月15日...
    茶点故事阅读 35,605评论 2 321
  • 正文 我和宋清朗相恋三年,在试婚纱的时候发现自己被绿了。 大学时的朋友给我发了我未婚夫和他白月光在一起吃饭的照片。...
    茶点故事阅读 37,693评论 1 329
  • 序言:一个原本活蹦乱跳的男人离奇死亡,死状恐怖,灵堂内的尸体忽然破棺而出,到底是诈尸还是另有隐情,我是刑警宁泽,带...
    沈念sama阅读 33,375评论 4 318
  • 正文 年R本政府宣布,位于F岛的核电站,受9级特大地震影响,放射性物质发生泄漏。R本人自食恶果不足惜,却给世界环境...
    茶点故事阅读 38,955评论 3 307
  • 文/蒙蒙 一、第九天 我趴在偏房一处隐蔽的房顶上张望。 院中可真热闹,春花似锦、人声如沸。这庄子的主人今日做“春日...
    开封第一讲书人阅读 29,936评论 0 19
  • 文/苍兰香墨 我抬头看了看天上的太阳。三九已至,却和暖如春,着一层夹袄步出监牢的瞬间,已是汗流浃背。 一阵脚步声响...
    开封第一讲书人阅读 31,172评论 1 259
  • 我被黑心中介骗来泰国打工, 没想到刚下飞机就差点儿被人妖公主榨干…… 1. 我叫王不留,地道东北人。 一个月前我还...
    沈念sama阅读 43,970评论 2 349
  • 正文 我出身青楼,却偏偏与公主长得像,于是被迫代替她去往敌国和亲。 传闻我的和亲对象是个残疾皇子,可洞房花烛夜当晚...
    茶点故事阅读 42,414评论 2 342

推荐阅读更多精彩内容