@
-
背景
-
问题
-
Arthas
-
github地址
-
官网文档地址:
-
说明
-
安装
-
运行Arthas
-
trace命令的使用
-
总结
背景
有时候我们在对线上接口作性能优化的时候需要找出一个方法的代码调用栈具体是那个方法或者哪行代码比较慢
最简单的方式就加log
// 使用spring提供的计时工具类
StopWatch sw = new StopWatch();
sw.start("调用数据库1");
TimeUnit.SECONDS.sleep(1);
sw.stop();
sw.start("调用数据库2");
TimeUnit.SECONDS.sleep(2);
sw.stop();
sw.start("调用数据库3");
TimeUnit.SECONDS.sleep(1);
sw.stop();
log.info("方法总耗时 {}", sw.getTotalTimeMillis());
log.info("总任务数 {}", sw.getTaskCount());
log.info(sw.prettyPrint());
打印结果如下
可以看到最耗时的就是任务二，耗时50%，接着我们就可以对任务二中间的代码作优化
问题
但是如果我们是线上接口呢？线上接口加log我们需要上线。然后部署合分支，发版。想想都很麻烦。有没有不需要加log就能知道各个方法的调用者的调用时间呢？答案是有的就是阿里开源的Arthas
Arthas
github地址
https://github.com/alibaba/arthas
官网文档地址:
https://arthas.aliyun.com/doc/
说明
这里的说明引用官方文档，有不懂的可以自己去看官方文档，这不是本文今天要介绍的重点
安装
wget https://alibaba.github.io/arthas/arthas-boot.jar && java -jar arthas-boot.jar
运行Arthas
java -jar arthas-boot.jar
运行完会显示我们运行的java进程的pid然后我们直接输入我们的pid然后就进入到Arthas里面了
trace命令的使用
接下来我们就介绍如何使用trace命令分析方法的耗时
使用起来很简单
比如我要分析类OrderApplicationQueryService中的listPackage方法的耗时
我们使用如下命令
trace com.test.query.OrderApplicationQueryService listPackage -n 1
格式就是：trace + 类所在包 + 类全称 + 空格 + 方法名
如果方法调用的次数很多，那么可以用-n参数指定捕捉结果的次数。比如上面的例子里，捕捉到一次调用就退出命令
然后我们执行上面的命令
到这里就是等待方法被调用。然后我们调用接口，让接口调用该方法，之后Arthas就会自动记录所有方法的调用时间了
可以看到listPackageByCondition()这个方法是比较耗时的
默认情况下，trace不会包含jdk里的函数调用，如果希望trace jdk里的函数，需要显式设置--skipJDKMethod false
上面的命令就变成如下方式了
trace --skipJDKMethod false com.test.query.OrderApplicationQueryService listPackage -n 1
执行上面命令，就可以看到jdk自带的函数调用耗时也打出来了，不过一般没啥必要。难道我们还能指望是jdk方法的耗时吗
其次也可以使用时间筛选命令，比如我们只展示方法调用耗时为>10ms的，则上面的命令变成如下方式
trace com.test.query.OrderApplicationQueryService listPackage '#cost > 10' -n 1
使用#cost > 10'即可
总结
本文只是介绍了Arthas中耗时分析的命令，更多好用的命令请参考官网，对线上定位问题还是比较有帮助的
原文始发于微信公众号（小奏技术）：Java线上接口耗时分析神器 Arthas
版权声明：本文内容由互联网用户自发贡献，该文观点仅代表作者本人。本站仅提供信息存储空间服务，不拥有所有权，不承担相关法律责任。如发现本站有涉嫌侵权/违法违规的内容， 请发送邮件至 举报，一经查实，本站将立刻删除。
文章由极客之音整理，本文链接：https://www.bmabk.com/index.php/post/30270.html
