学步园

java-监测方法运行时间

方式1：

    public void doTest() {  
        long time = System.currentTimeMillis();  
        //...
        time = System.currentTimeMillis() - time;  
        System.out.println("process time: " + time + " ms");         
    } 

方式2：

链接:http://jinnianshilongnian.iteye.com/blog/1670856
//如果采用springmvc的拦截器拦截记录处理时间，由于拦截器是单例的。
//不管用户请求多少次都只有一个拦截器实现，即线程不安全。那我们应该怎么记录时间呢？
//我们可以使用ThreadLocal，它是线程绑定的变量，提供线程局部变量
（一个线程一个ThreadLocal，A线程的ThreadLocal只能看到A线程的ThreadLocal，不能看到B线程的ThreadLocal）

public class StopWatchHandlerInterceptor extends HandlerInterceptorAdapter {  
    private NamedThreadLocal<Long>  startTimeThreadLocal =  new NamedThreadLocal<Long>("StopWatch-StartTime");//Spring提供的一个命名的ThreadLocal实现。
    @Override  
    public boolean preHandle(HttpServletRequest request, HttpServletResponse response, Object handler) throws Exception {  
        long beginTime = System.currentTimeMillis();//1、开始时间  
        startTimeThreadLocal.set(beginTime);//线程绑定变量（该数据只有当前请求的线程可见）  
        return true;//继续流程  
    }        
    @Override  
    public void afterCompletion(HttpServletRequest request, HttpServletResponse response, Object handler, Exception ex) throws Exception {  
        long endTime = System.currentTimeMillis();//2、结束时间  
        long beginTime = startTimeThreadLocal.get();//得到线程绑定的局部变量（开始时间）  
        long consumeTime = endTime - beginTime;//3、消耗的时间  
        if(consumeTime > 500) {//此处认为处理时间超过500毫秒的请求为慢请求  
            //TODO 记录到日志文件  
            System.out.println(String.format("%s consume %d millis", request.getRequestURI(), consumeTime));  
        }          
    }  
}