golang使用defer计算函数耗时无法计算正确的时间

今天想计算程序的耗时时间,为了方便使用defer来计算函数的总的执行时间。但是很少。后来经过如下实验发下了问题:

    logsParam := "[test]"
    startTime := time.Now()
    defer logs.Warning("%s end-cost Seconds:%vs ", logsParam, time.Since(startTime).Seconds())
    time.Sleep(2 * time.Second)

    logs.Warning("%s end-cost-2 Seconds:%vs ", logsParam, time.Since(startTime).Seconds())

输出:

2020/08/21 14:55:45.888 [W] [proc.go:203]  [test] end-cost-2 Seconds:2.000612215s 
2020/08/21 14:55:45.888 [W] [proc.go:203]  [test] end-cost Seconds:1.45e-07s 

使用以上的defer形式来计算耗时确实有问题。
后来找到原因了:defer 调用的函数参数的值 defer 被定义时就确定了。所以耗时参数在defer定义的那块就确定了,所以耗时就很少了。
计算耗时的方法可以改成这样:

    logsParam := "[test]"
    startTime := time.Now()
    defer func(time1 time.Time) {
        logs.Warning("%s end-cost Seconds:%v\n", logsParam, time.Since(time1))
    }(startTime)
    time.Sleep(2 * time.Second)

    logs.Warning("%s end-cost-2 Seconds:%vs ", logsParam, time.Since(startTime).Seconds())

输出:

2020/08/21 15:27:31.594 [W] [proc.go:203]  [test] end-cost-2 Seconds:2.000604603s 
2020/08/21 15:27:31.594 [W] [main.go:58]  [test] end-cost Seconds:2.000729234s

圆满完成~~~

©著作权归作者所有,转载或内容合作请联系作者
【社区内容提示】社区部分内容疑似由AI辅助生成,浏览时请结合常识与多方信息审慎甄别。
平台声明:文章内容(如有图片或视频亦包括在内)由作者上传并发布,文章内容仅代表作者本人观点,简书系信息发布平台,仅提供信息存储服务。

友情链接更多精彩内容