为什么使用System.nanoTime()得到负的运行时间?

Question

我试图使用以下代码与System.nanoTime()来测量代码的运行时间。

public static void main(String[] args) throws Exception {
    while (true) {
        long start = System.nanoTime();
        for (int i = 0; i < 10000; i++)
            ;
        long end = System.nanoTime();
        long cost = end - start;
        if (cost < 0) {
            System.out.println("start: " + start + ", end: " + end + ", cost: " + cost);
        }
    }
}

，我得到这样的结果:

start: 34571588742886, end: 34571585695366, cost: -3047520
start: 34571590239323, end: 34571586847711, cost: -3391612
start: 34571651240343, end: 34571648928369, cost: -2311974
start: 34571684937094, end: 34571681543134, cost: -3393960
start: 34571791867954, end: 34571788878081, cost: -2989873
start: 34571838733068, end: 34571835464021, cost: -3269047
start: 34571869993665, end: 34571866950949, cost: -3042716
start: 34571963747021, end: 34571960656216, cost: -3090805
start: 34571965020545, end: 34571961637608, cost: -3382937
start: 34572010616580, end: 34572007613257, cost: -3003323

为什么我得到负值?

(OS: windows xp sp3, java: jdk1.6u27)

Answer 1

可以取CPU时钟周期计数器的nanoTime。由于不同的cpu可以在略有不同的时间启动，因此不同cpu上的时钟计数器可能不同。Linux可以纠正这个问题，但是旧版本的Windows不能。(我假设你有两个cpu相隔3毫秒启动)

偶尔也会看到超过2.5 ms的正跳变。

试

if (cost < 0 || cost > 2000000) {

当进程在cpu之间切换时，你应该看到一些向前跳，一些向后跳。