【发布时间】：2016-12-15 20:44:04
【问题描述】：
我需要在迭代中捕获某些代码的执行时间。我决定使用Map<Integer,Long> 来捕获这些数据，其中 Integer(key) 是迭代次数，Long(value) 是该迭代所消耗的时间毫秒。
我编写了下面的 java 代码来计算每次迭代所花费的时间。我想确保在调用实际代码之前所有迭代所花费的时间为零。令人惊讶的是，以下代码在每次执行时表现不同。
有时，我会得到所需的输出（所有迭代为零毫秒），但有时我会得到一些随机迭代的正值甚至负值。
我尝试用以下代码替换System.currentTimeMillis();：
new java.util.Date().getTime();
System.nanoTime();
org.apache.commons.lang.time.StopWatch
但仍然没有运气。
关于为什么某些迭代需要额外时间以及如何消除它的任何建议？
package com.stackoverflow.programmer;
import java.util.HashMap;
import java.util.Map;
public class TestTimeConsumption {
public static void main(String[] args) {
Integer totalIterations = 100000;
Integer nonZeroMilliSecondsCounter = 0;
Map<Integer, Long> timeTakenMap = new HashMap<>();
for (Integer iteration = 1; iteration <= totalIterations; iteration++) {
timeTakenMap.put(iteration, getTimeConsumed(iteration));
if (timeTakenMap.get(iteration) != 0) {
nonZeroMilliSecondsCounter++;
System.out.format("Iteration %6d has taken %d millisecond(s).\n", iteration,
timeTakenMap.get(iteration));
}
}
System.out.format("Total non zero entries : %d", nonZeroMilliSecondsCounter);
}
private static Long getTimeConsumed(Integer iteration) {
long startTime = System.currentTimeMillis();
// Execute code for which execution time needs to be captured
long endTime = System.currentTimeMillis();
return (endTime - startTime);
}
}
这是同一代码的 5 次不同执行的示例输出：
执行 #1（不正常）
Iteration 42970 has taken 1 millisecond(s).
Total non zero entries : 1
执行 #2（正常）
Total non zero entries : 0
执行 #3（正常）
Total non zero entries : 0
执行 #4（不正常）
Iteration 65769 has taken -1 millisecond(s).
Total non zero entries : 1
执行 #5（不正常）
Iteration 424 has taken 1 millisecond(s).
Iteration 33053 has taken 1 millisecond(s).
Iteration 76755 has taken -1 millisecond(s).
Total non zero entries : 3
我正在寻找一种基于 Java 的解决方案，以确保所有 迭代持续消耗零毫秒。我更喜欢 使用纯 Java 代码完成此操作，而无需使用分析器。
注意：我也可以通过 C 代码完成此操作。
【问题讨论】：
-
如果你必须使用并行集合，那么你做错了什么......
-
是的，我同意。我将消除并行集合。不过，我需要所有迭代的执行时间一致。
-
正如您在这里所看到的，Java 中的微基准测试并不像它们第一次出现那样简单。请参阅 stackoverflow.com/questions/504103/…