使用 StopWatch 优雅打印执行耗时

 

0x01：背景

有时在做开发的使用时候需要记录每个任务执行时间，或者记录一段代码执行时间，优雅打印执最简单的行耗方法就是打印当前时间与执行完时间的差值，然后这样如果执行大量测试的使用话就很麻烦，并且不直观，优雅打印执如果想对执行的行耗时间做进一步控制，云服务器提供商则需要在程序中很多地方修改，使用目前spring-framework提供了一个StopWatch类可以做类似任务执行时间控制，优雅打印执也就是行耗封装了一个对开始时间，结束时间记录工具

示例

先来看几个示例

 统计输出总耗时  import org.springframework.util.StopWatch;    public class SpringStopWatchExample {      public static void main (String[] args) throws InterruptedException {           StopWatch sw = new StopWatch();            sw.start();            //long task simulation           Thread.sleep(1000);            sw.stop();            System.out.println(sw.getTotalTimeMillis());        }    } 

输出 

1013   输出最后一个任务的使用耗时  public class SpringStopWatchExample2 {           public static void main (String[] args) throws InterruptedException {             StopWatch sw = new StopWatch();            sw.start("A");//setting a task name            //long task simulation            Thread.sleep(1000);            sw.stop();            System.out.println(sw.getLastTaskTimeMillis());        }    } 

输出 

1009   以优雅的格式打出所有任务的耗时以及占比  import org.springframework.util.StopWatch;     public class SpringStopWatchExample3 {           public static void main (String[] args) throws InterruptedException {            StopWatch sw = new StopWatch();            sw.start("A");            Thread.sleep(500);            sw.stop();            sw.start("B");            Thread.sleep(300);          sw.stop();            sw.start("C");           Thread.sleep(200);            sw.stop();            System.out.println(sw.prettyPrint());        }    } 

输出 

StopWatch : running time (millis) = 1031    -----------------------------------------    ms     %     Task name    -----------------------------------------    00514  050%  A    00302  029%  B    00215  021%  C:   序列服务输出耗时信息  @Override    public long nextSeq(String name) {         StopWatch watch = new StopWatch();       watch.start("单序列获取总消耗");        long sequence = generator.generateId(name);     watch.stop();        logger.info(watch.prettyPrint());        return sequence;    } 

0x02：更多用法

不同的打印结果

 getTotalTimeSeconds() 获取总耗时秒，同时也有获取毫秒的优雅打印执方法  prettyPrint() 优雅的香港云服务器格式打印结果，表格形式  shortSummary() 返回简短的行耗总耗时描述  getTaskCount() 返回统计时间任务的数量  getLastTaskInfo().getTaskName() 返回最后一个任务TaskInfo对象的名称

更多查看文档

https://docs.spring.io/spring-framework/docs/current/javadoc-api/org/springframework/util/StopWatch.html

0x03：总结

以后统计代码执行效率建议大家都使用这个工具来进行输出，不需要在starttime、使用endtime再相减计算，优雅打印执用优雅的行耗方式来完成这件事情。