Just something I noticed today. Happens on both AMD and Intel, kvm/queue.
Likely the test needs lower tolerancies.
I'll investigate this later
This is on my AMD machine (3970X):
[mlevitsk@starship ~/Kernel/master/src/tools/testing/selftests/kvm]$while true ; do ./x86_64/hyperv_clock ; done
==== Test Assertion Failure ====
x86_64/hyperv_clock.c:199: delta_ns * 100 < (t2 - t1) * 100
pid=66218 tid=66218 errno=0 - Success
1 0x000000000040255d: host_check_tsc_msr_rdtsc at hyperv_clock.c:199
2 (inlined by) main at hyperv_clock.c:223
3 0x00007f0f2822d55f: ?? ??:0
4 0x00007f0f2822d60b: ?? ??:0
5 0x0000000000402744: _start at ??:?
Elapsed time does not match (MSR=471600, TSC=461024)
==== Test Assertion Failure ====
x86_64/hyperv_clock.c:199: delta_ns * 100 < (t2 - t1) * 100
pid=66269 tid=66269 errno=0 - Success
1 0x000000000040255d: host_check_tsc_msr_rdtsc at hyperv_clock.c:199
2 (inlined by) main at hyperv_clock.c:223
3 0x00007f296522d55f: ?? ??:0
4 0x00007f296522d60b: ?? ??:0
5 0x0000000000402744: _start at ??:?
Elapsed time does not match (MSR=460700, TSC=475361)
==== Test Assertion Failure ====
x86_64/hyperv_clock.c:234: false
pid=66652 tid=66652 errno=4 - Interrupted system call
1 0x00000000004026e7: main at hyperv_clock.c:234
2 0x00007fdab782d55f: ?? ??:0
3 0x00007fdab782d60b: ?? ??:0
4 0x0000000000402744: _start at ??:?
Failed guest assert: delta_ns * 100 < (t2 - t1) * 100 at x86_64/hyperv_clock.c:74
==== Test Assertion Failure ====
x86_64/hyperv_clock.c:199: delta_ns * 100 < (t2 - t1) * 100
pid=67112 tid=67112 errno=0 - Success
1 0x000000000040255d: host_check_tsc_msr_rdtsc at hyperv_clock.c:199
2 (inlined by) main at hyperv_clock.c:223
3 0x00007f3095c2d55f: ?? ??:0
4 0x00007f3095c2d60b: ?? ??:0
5 0x0000000000402744: _start at ??:?
Elapsed time does not match (MSR=469600, TSC=484418)
==== Test Assertion Failure ====
x86_64/hyperv_clock.c:234: false
pid=67146 tid=67146 errno=4 - Interrupted system call
1 0x00000000004026e7: main at hyperv_clock.c:234
2 0x00007f81b802d55f: ?? ??:0
3 0x00007f81b802d60b: ?? ??:0
4 0x0000000000402744: _start at ??:?
Failed guest assert: delta_ns * 100 < (t2 - t1) * 100 at x86_64/hyperv_clock.c:74
==== Test Assertion Failure ====
x86_64/hyperv_clock.c:199: delta_ns * 100 < (t2 - t1) * 100
pid=67179 tid=67179 errno=0 - Success
1 0x000000000040255d: host_check_tsc_msr_rdtsc at hyperv_clock.c:199
2 (inlined by) main at hyperv_clock.c:223
3 0x00007f1fb522d55f: ?? ??:0
4 0x00007f1fb522d60b: ?? ??:0
5 0x0000000000402744: _start at ??:?
Elapsed time does not match (MSR=470300, TSC=461134)
==== Test Assertion Failure ====
x86_64/hyperv_clock.c:234: false
pid=67459 tid=67459 errno=4 - Interrupted system call
1 0x00000000004026e7: main at hyperv_clock.c:234
2 0x00007f330dc2d55f: ?? ??:0
3 0x00007f330dc2d60b: ?? ??:0
4 0x0000000000402744: _start at ??:?
Failed guest assert: delta_ns * 100 < (t2 - t1) * 100 at x86_64/hyperv_clock.c:74
==== Test Assertion Failure ====
x86_64/hyperv_clock.c:234: false
pid=67622 tid=67622 errno=4 - Interrupted system call
1 0x00000000004026e7: main at hyperv_clock.c:234
2 0x00007f9da422d55f: ?? ??:0
3 0x00007f9da422d60b: ?? ??:0
4 0x0000000000402744: _start at ??:?
Failed guest assert: delta_ns * 100 < (t2 - t1) * 100 at x86_64/hyperv_clock.c:74
==== Test Assertion Failure ====
x86_64/hyperv_clock.c:199: delta_ns * 100 < (t2 - t1) * 100
pid=68043 tid=68043 errno=0 - Success
1 0x000000000040255d: host_check_tsc_msr_rdtsc at hyperv_clock.c:199
2 (inlined by) main at hyperv_clock.c:223
3 0x00007f3ba2c2d55f: ?? ??:0
4 0x00007f3ba2c2d60b: ?? ??:0
5 0x0000000000402744: _start at ??:?
Elapsed time does not match (MSR=482900, TSC=468989)
==== Test Assertion Failure ====
x86_64/hyperv_clock.c:199: delta_ns * 100 < (t2 - t1) * 100
pid=68118 tid=68118 errno=0 - Success
1 0x000000000040255d: host_check_tsc_msr_rdtsc at hyperv_clock.c:199
2 (inlined by) main at hyperv_clock.c:223
3 0x00007f25ef62d55f: ?? ??:0
4 0x00007f25ef62d60b: ?? ??:0
5 0x0000000000402744: _start at ??:?
Elapsed time does not match (MSR=362300, TSC=379772)
==== Test Assertion Failure ====
x86_64/hyperv_clock.c:234: false
pid=68233 tid=68233 errno=4 - Interrupted system call
1 0x00000000004026e7: main at hyperv_clock.c:234
2 0x00007f7e94c2d55f: ?? ??:0
3 0x00007f7e94c2d60b: ?? ??:0
4 0x0000000000402744: _start at ??:?
Failed guest assert: delta_ns * 100 < (t2 - t1) * 100 at x86_64/hyperv_clock.c:74
==== Test Assertion Failure ====
x86_64/hyperv_clock.c:199: delta_ns * 100 < (t2 - t1) * 100
pid=68609 tid=68609 errno=0 - Success
1 0x000000000040255d: host_check_tsc_msr_rdtsc at hyperv_clock.c:199
2 (inlined by) main at hyperv_clock.c:223
3 0x00007f69a3a2d55f: ?? ??:0
4 0x00007f69a3a2d60b: ?? ??:0
5 0x0000000000402744: _start at ??:?
Elapsed time does not match (MSR=475800, TSC=466334)
This is on my Intel machine:
[mlevitsk@worklaptop ~/Kernel/master/src/tools/testing/selftests/kvm]$while true ; do ./x86_64/hyperv_clock ; done
==== Test Assertion Failure ====
x86_64/hyperv_clock.c:234: false
pid=52204 tid=52204 errno=4 - Interrupted system call
1 0x00000000004026e7: main at hyperv_clock.c:234
2 0x00007fd2baa2d55f: ?? ??:0
3 0x00007fd2baa2d60b: ?? ??:0
4 0x0000000000402744: _start at ??:?
Failed guest assert: delta_ns * 100 < (t2 - t1) * 100 at x86_64/hyperv_clock.c:74
==== Test Assertion Failure ====
x86_64/hyperv_clock.c:234: false
pid=52517 tid=52517 errno=4 - Interrupted system call
1 0x00000000004026e7: main at hyperv_clock.c:234
2 0x00007f832a02d55f: ?? ??:0
3 0x00007f832a02d60b: ?? ??:0
4 0x0000000000402744: _start at ??:?
Failed guest assert: delta_ns * 100 < (t2 - t1) * 100 at x86_64/hyperv_clock.c:74
==== Test Assertion Failure ====
x86_64/hyperv_clock.c:199: delta_ns * 100 < (t2 - t1) * 100
pid=52598 tid=52598 errno=0 - Success
1 0x000000000040255d: host_check_tsc_msr_rdtsc at hyperv_clock.c:199
2 (inlined by) main at hyperv_clock.c:223
3 0x00007f52bd02d55f: ?? ??:0
4 0x00007f52bd02d60b: ?? ??:0
5 0x0000000000402744: _start at ??:?
Elapsed time does not match (MSR=263000, TSC=269964)
==== Test Assertion Failure ====
x86_64/hyperv_clock.c:199: delta_ns * 100 < (t2 - t1) * 100
pid=52645 tid=52645 errno=0 - Success
1 0x000000000040255d: host_check_tsc_msr_rdtsc at hyperv_clock.c:199
2 (inlined by) main at hyperv_clock.c:223
3 0x00007f398d22d55f: ?? ??:0
4 0x00007f398d22d60b: ?? ??:0
5 0x0000000000402744: _start at ??:?
Elapsed time does not match (MSR=530300, TSC=521275)
==== Test Assertion Failure ====
x86_64/hyperv_clock.c:199: delta_ns * 100 < (t2 - t1) * 100
pid=52762 tid=52762 errno=0 - Success
1 0x000000000040255d: host_check_tsc_msr_rdtsc at hyperv_clock.c:199
2 (inlined by) main at hyperv_clock.c:223
3 0x00007fdaac62d55f: ?? ??:0
4 0x00007fdaac62d60b: ?? ??:0
5 0x0000000000402744: _start at ??:?
Elapsed time does not match (MSR=263800, TSC=267716)
==== Test Assertion Failure ====
x86_64/hyperv_clock.c:199: delta_ns * 100 < (t2 - t1) * 100
pid=52787 tid=52787 errno=0 - Success
1 0x000000000040255d: host_check_tsc_msr_rdtsc at hyperv_clock.c:199
2 (inlined by) main at hyperv_clock.c:223
3 0x00007f029322d55f: ?? ??:0
4 0x00007f029322d60b: ?? ??:0
5 0x0000000000402744: _start at ??:?
Elapsed time does not match (MSR=342200, TSC=332493)
==== Test Assertion Failure ====
x86_64/hyperv_clock.c:234: false
pid=52968 tid=52968 errno=4 - Interrupted system call
1 0x00000000004026e7: main at hyperv_clock.c:234
2 0x00007f133202d55f: ?? ??:0
3 0x00007f133202d60b: ?? ??:0
4 0x0000000000402744: _start at ??:?
Failed guest assert: delta_ns * 100 < (t2 - t1) * 100 at x86_64/hyperv_clock.c:74
==== Test Assertion Failure ====
x86_64/hyperv_clock.c:199: delta_ns * 100 < (t2 - t1) * 100
pid=53349 tid=53349 errno=0 - Success
1 0x000000000040255d: host_check_tsc_msr_rdtsc at hyperv_clock.c:199
2 (inlined by) main at hyperv_clock.c:223
3 0x00007f28fbc2d55f: ?? ??:0
4 0x00007f28fbc2d60b: ?? ??:0
5 0x0000000000402744: _start at ??:?
Elapsed time does not match (MSR=265300, TSC=257886)
==== Test Assertion Failure ====
x86_64/hyperv_clock.c:234: false
pid=53460 tid=53460 errno=4 - Interrupted system call
1 0x00000000004026e7: main at hyperv_clock.c:234
2 0x00007f7a0542d55f: ?? ??:0
3 0x00007f7a0542d60b: ?? ??:0
4 0x0000000000402744: _start at ??:?
Failed guest assert: delta_ns * 100 < (t2 - t1) * 100 at x86_64/hyperv_clock.c:74
==== Test Assertion Failure ====
x86_64/hyperv_clock.c:199: delta_ns * 100 < (t2 - t1) * 100
pid=53847 tid=53847 errno=0 - Success
1 0x000000000040255d: host_check_tsc_msr_rdtsc at hyperv_clock.c:199
2 (inlined by) main at hyperv_clock.c:223
3 0x00007f7d53c2d55f: ?? ??:0
4 0x00007f7d53c2d60b: ?? ??:0
5 0x0000000000402744: _start at ??:?
Elapsed time does not match (MSR=578800, TSC=527827)
Best regards,
Maxim Levitsky
