使用DropWizard计时器查找代码块的执行时间

Question

我讨论了这个问题DropWizard Metrics Meters vs Timer，并理解了定时器的概念。但是，有没有一种方法可以记录每次调用代码块时代码块的执行时间？我不想要这个计时器的平均速率和内容，因为这个方法调用频率不高，但调用时需要相当长的时间。那么，有没有一种方法可以打印每个调用的执行时间？此外，我如何获得以下问题的答案

1. 如何调查值出现尖峰的原因？
2. 我如何知道Max time事件何时发生，以便查看日志并查看可能的原因？

任何帮助都将不胜感激。

Answer 1

不知道有没有办法获取定时器上下文对象，但是我有另外一个想法。你说这个方法不经常被调用。为什么不使用DynamicFeature并打印容器的执行时间？

下面我将向您展示如何实现这一点。我不确定这是否有效，我只是在没有任何测试的情况下对其进行了编码，因此请尝试一下，并在需要时进行更改。如果由于已实现的接口，执行时间筛选器需要拆分为两个单独的类，请相应地进行更改。

第1步：创建过滤器

@Provider
public class ExecutionTimeFilter implements ContainerRequestFilter, ContainerResponseFilter {
    public static final String EXECUTION_TIME_HEADER = "X-Execution-Time";

    @Override
    public void filter(ContainerRequestContext requestContext) throws IOException {
        requestContext.getHeaders().add(EXECUTION_TIME_HEADER, ZonedDateTime.now().toString());
    }

        @Override
    public void filter(ContainerRequestContext requestContext, ContainerResponseContext responseContext) throws IOException {
        ZonedDateTime executionStartHeader = ZonedDateTime.parse(requestContext.getHeaderString(EXECUTION_TIME_HEADER));
        Duration executionTime = Duration.between(executionStartHeader, ZonedDateTime.now());
        //you can also print some url informations or whatever you need; check out the informations from both mehtod params
        System.out.println("The execution time was:" + executionTime);
    }
}

步骤 2：创建动态功能

@Provider
public class ExecutionTimeFeature implements DynamicFeature {
    @Override
    public void configure(ResourceInfo resourceInfo, FeatureContext context) {
        if (resourceInfo.getResourceMethod().getAnnotation(ExecutionTime.class) != null) {
            context.register(ExecutionTimeFilter.class);
        }
    }
}

第3步：创建注释

@Target({ ElementType.METHOD })
@Retention(RetentionPolicy.RUNTIME)
public @interface ExecutionTime {
}

步骤4:注释您的资源

@GET
@ExecutionTime
public String getExcpensiveCalculation(@QueryParam("number") @DefaultValue("1") IntegerParam number) {
    return getCalculation(number);
}

步骤 5：注册功能

environment.jersey().register(ExecutionTimeFeature.class);

参考:带有过滤器的Dropwizard动态功能

Answer 2

为了报告准确的代码块执行时间，可以使用计数器。

它可以保持累积时间值，该值可以通过导数转换为图上的尖峰。以石墨的导数（..）函数为例（注意，这不是“真”导数，只是值差）。

这种方法不适合频繁的事件，不太容易扩展。在高负载的情况下，计时器更适合。

简单的java助手：

    timed(String metricName, Runnable body) {
        Counter counter = metricsRegistry.counter(metricName);
        long t = System.currentTimeMillis();
        try {
            body.run();
        finally {
            counter.inc(System.currentTimeMillis() - t);
        }
    }