还在用 System.currentTimeMillis() 统计代码耗时？太 Low 啦

爱吃糖的靓仔

已于 2024-03-27 13:25:50 修改

阅读量348

点赞数 10

分类专栏： # 功能代码文章标签： java 前端数据库

于 2024-03-03 18:18:14 首次发布

本文链接：https://blog.csdn.net/qq_42292373/article/details/136435482

版权

功能代码专栏收录该内容

5 篇文章 0 订阅

订阅专栏

本文介绍了如何在SpringFramework中使用StopWatch类来记录和分析任务执行时间，包括统计总耗时、输出最后一个任务耗时、以优雅格式显示耗时占比，以及在序列服务中的应用示例。

摘要由CSDN通过智能技术生成

1. 背景

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

2. 统计总耗时

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());
    }
}

输出

3. 输出最后一个任务的耗时

    public static void main(String[] args) throws InterruptedException {
        StopWatch stopWatch = new StopWatch();

        // 开始计时
        stopWatch.start();

        // 模拟第一次任务执行
        try {
            Thread.sleep(1000);
        } catch (InterruptedException e) {
            e.printStackTrace();
        }

        // 停止第一个任务
        stopWatch.stop();

        // 输出最后一次任务执行的时间
        System.out.println("First Task Time: " + stopWatch.getLastTaskTimeMillis() + " ms");

        // 开始另一个任务
        stopWatch.start();

        // 模拟第二次任务执行
        try {
            Thread.sleep(500);
        } catch (InterruptedException e) {
            e.printStackTrace();
        }

        // 停止第二个任务
        stopWatch.stop();

        // 输出最后一次任务执行的时间
        System.out.println("Second Task Time: " + stopWatch.getLastTaskTimeMillis() + " ms");

        // 输出所有任务的总时间
        System.out.println("Total Time: " + stopWatch.getTotalTimeMillis() + " ms");
            }
        }

输出

Second Task Time: 513 ms
Total Time: 1527 ms

4. 以优雅的格式打出所有任务的耗时以及占比

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

5. 序列服务输出耗时信息

@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;
}