Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
(perf_pmu:2657) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2657) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2657) CRITICAL: 'val' != 'ts[1] - ts[0]' (473702240.000000 not withi...

Dynamic subtest rcs0 failed.
**** DEBUG ****
(perf_pmu:2657) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2657) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2657) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2657) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2657) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:2657) DEBUG: slept=500304000 perf=500639892
(perf_pmu:2657) INFO: busy=473702240 idle=0
(perf_pmu:2657) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2657) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
(perf_pmu:2628) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2628) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2628) CRITICAL: 'val' != 'ts[1] - ts[0]' (473812656.000000 not withi...

Dynamic subtest rcs0 failed.
**** DEBUG ****
(perf_pmu:2628) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2628) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2628) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2628) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2628) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:2628) DEBUG: slept=500386000 perf=500719020
(perf_pmu:2628) INFO: busy=473812656 idle=0
(perf_pmu:2628) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2628) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
(perf_pmu:3021) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:3021) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:3021) CRITICAL: 'val' != 'ts[1] - ts[0]' (474708541.000000 not withi...

Dynamic subtest rcs0 failed.
**** DEBUG ****
(perf_pmu:3021) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:3021) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:3021) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:3021) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:3021) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:3021) DEBUG: slept=500101000 perf=500551060
(perf_pmu:3021) INFO: busy=474708541 idle=0
(perf_pmu:3021) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:3021) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
(perf_pmu:3031) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:3031) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:3031) CRITICAL: 'val' != 'ts[1] - ts[0]' (473919792.000000 not withi...

Dynamic subtest rcs0 failed.
**** DEBUG ****
(perf_pmu:3031) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:3031) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:3031) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:3031) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:3031) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:3031) DEBUG: slept=500062000 perf=500521193
(perf_pmu:3031) INFO: busy=473919792 idle=0
(perf_pmu:3031) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:3031) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
(perf_pmu:3000) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:3000) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:3000) CRITICAL: 'val' != 'ts[1] - ts[0]' (473180209.000000 not withi...

Dynamic subtest rcs0 failed.
**** DEBUG ****
(perf_pmu:3000) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:3000) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:3000) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:3000) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:3000) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:3000) DEBUG: slept=500071000 perf=500523775
(perf_pmu:3000) INFO: busy=473180209 idle=0
(perf_pmu:3000) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:3000) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
(perf_pmu:2986) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2986) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2986) CRITICAL: 'val' != 'ts[1] - ts[0]' (473554167.000000 not withi...

Dynamic subtest rcs0 failed.
**** DEBUG ****
(perf_pmu:2986) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2986) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2986) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2986) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2986) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:2986) DEBUG: slept=500326000 perf=500821853
(perf_pmu:2986) INFO: busy=473554167 idle=0
(perf_pmu:2986) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2986) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
(perf_pmu:3147) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:3147) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:3147) CRITICAL: 'val' != 'ts[1] - ts[0]' (473729739.000000 not withi...

Dynamic subtest rcs0 failed.
**** DEBUG ****
(perf_pmu:3147) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:3147) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:3147) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:3147) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:3147) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:3147) DEBUG: slept=500263000 perf=500716382
(perf_pmu:3147) INFO: busy=473729739 idle=0
(perf_pmu:3147) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:3147) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
(perf_pmu:3023) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:3023) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:3023) CRITICAL: 'val' != 'ts[1] - ts[0]' (474725155.000000 not withi...

Dynamic subtest rcs0 failed.
**** DEBUG ****
(perf_pmu:3023) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:3023) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:3023) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:3023) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:3023) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:3023) DEBUG: slept=500704000 perf=501165208
(perf_pmu:3023) INFO: busy=474725155 idle=0
(perf_pmu:3023) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:3023) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
(perf_pmu:3027) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:3027) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:3027) CRITICAL: 'val' != 'ts[1] - ts[0]' (473958177.000000 not withi...

Dynamic subtest rcs0 failed.
**** DEBUG ****
(perf_pmu:3027) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:3027) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:3027) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:3027) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:3027) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:3027) DEBUG: slept=500334000 perf=500661086
(perf_pmu:3027) INFO: busy=473958177 idle=0
(perf_pmu:3027) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:3027) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
(perf_pmu:3038) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:3038) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:3038) CRITICAL: 'val' != 'ts[1] - ts[0]' (474030209.000000 not withi...

Dynamic subtest rcs0 failed.
**** DEBUG ****
(perf_pmu:3038) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:3038) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:3038) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:3038) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:3038) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:3038) DEBUG: slept=500069000 perf=500491837
(perf_pmu:3038) INFO: busy=474030209 idle=0
(perf_pmu:3038) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:3038) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
(perf_pmu:3060) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:3060) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:3060) CRITICAL: 'val' != 'ts[1] - ts[0]' (474423333.000000 not withi...

Dynamic subtest rcs0 failed.
**** DEBUG ****
(perf_pmu:3060) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:3060) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:3060) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:3060) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:3060) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:3060) DEBUG: slept=501330000 perf=501845982
(perf_pmu:3060) INFO: busy=474423333 idle=0
(perf_pmu:3060) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:3060) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
(perf_pmu:2989) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2989) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2989) CRITICAL: 'val' != 'ts[1] - ts[0]' (474497605.000000 not withi...

Dynamic subtest rcs0 failed.
**** DEBUG ****
(perf_pmu:2989) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2989) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2989) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2989) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2989) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:2989) DEBUG: slept=500191000 perf=500634273
(perf_pmu:2989) INFO: busy=474497605 idle=0
(perf_pmu:2989) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2989) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
(perf_pmu:3015) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:3015) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:3015) CRITICAL: 'val' != 'ts[1] - ts[0]' (473918230.000000 not withi...

Dynamic subtest rcs0 failed.
**** DEBUG ****
(perf_pmu:3015) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:3015) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:3015) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:3015) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:3015) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:3015) DEBUG: slept=500471000 perf=500955359
(perf_pmu:3015) INFO: busy=473918230 idle=0
(perf_pmu:3015) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:3015) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
(perf_pmu:3062) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:3062) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:3062) CRITICAL: 'val' != 'ts[1] - ts[0]' (473471978.000000 not withi...

Dynamic subtest rcs0 failed.
**** DEBUG ****
(perf_pmu:3062) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:3062) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:3062) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:3062) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:3062) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:3062) DEBUG: slept=500090000 perf=500540127
(perf_pmu:3062) INFO: busy=473471978 idle=0
(perf_pmu:3062) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:3062) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
(perf_pmu:3030) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:3030) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:3030) CRITICAL: 'val' != 'ts[1] - ts[0]' (473633959.000000 not withi...

Dynamic subtest rcs0 failed.
**** DEBUG ****
(perf_pmu:3030) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:3030) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:3030) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:3030) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:3030) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:3030) DEBUG: slept=500192000 perf=500716302
(perf_pmu:3030) INFO: busy=473633959 idle=0
(perf_pmu:3030) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:3030) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
(perf_pmu:2999) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2999) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2999) CRITICAL: 'val' != 'ts[1] - ts[0]' (475206562.000000 not withi...

Dynamic subtest rcs0 failed.
**** DEBUG ****
(perf_pmu:2999) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2999) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2999) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2999) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2999) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:2999) DEBUG: slept=500944000 perf=501368707
(perf_pmu:2999) INFO: busy=475206562 idle=0
(perf_pmu:2999) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2999) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
(perf_pmu:3013) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:3013) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:3013) CRITICAL: 'val' != 'ts[1] - ts[0]' (474975313.000000 not withi...

Dynamic subtest rcs0 failed.
**** DEBUG ****
(perf_pmu:3013) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:3013) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:3013) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:3013) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:3013) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:3013) DEBUG: slept=500930000 perf=501550738
(perf_pmu:3013) INFO: busy=474975313 idle=0
(perf_pmu:3013) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:3013) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
(perf_pmu:3004) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:3004) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:3004) CRITICAL: 'val' != 'ts[1] - ts[0]' (474298646.000000 not withi...

Dynamic subtest rcs0 failed.
**** DEBUG ****
(perf_pmu:3004) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:3004) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:3004) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:3004) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:3004) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:3004) DEBUG: slept=500249000 perf=500715247
(perf_pmu:3004) INFO: busy=474298646 idle=0
(perf_pmu:3004) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:3004) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
(perf_pmu:3049) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:3049) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:3049) CRITICAL: 'val' != 'ts[1] - ts[0]' (474627396.000000 not withi...

Dynamic subtest rcs0 failed.
**** DEBUG ****
(perf_pmu:3049) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:3049) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:3049) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:3049) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:3049) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:3049) DEBUG: slept=500959000 perf=501447874
(perf_pmu:3049) INFO: busy=474627396 idle=0
(perf_pmu:3049) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:3049) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
(perf_pmu:2994) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2994) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2994) CRITICAL: 'val' != 'ts[1] - ts[0]' (473635417.000000 not withi...

Dynamic subtest rcs0 failed.
**** DEBUG ****
(perf_pmu:2994) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2994) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2994) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2994) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2994) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:2994) DEBUG: slept=500498000 perf=500942783
(perf_pmu:2994) INFO: busy=473635417 idle=0
(perf_pmu:2994) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2994) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
(perf_pmu:2411) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2411) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2411) CRITICAL: 'val' != 'ts[1] - ts[0]' (474747864.000000 not withi...

Dynamic subtest rcs0 failed.
**** DEBUG ****
(perf_pmu:2411) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2411) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2411) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2411) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2411) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:2411) DEBUG: slept=500330000 perf=500705798
(perf_pmu:2411) INFO: busy=474747864 idle=0
(perf_pmu:2411) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2411) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
(perf_pmu:2647) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2647) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2647) CRITICAL: 'val' != 'ts[1] - ts[0]' (474322500.000000 not withi...

Dynamic subtest rcs0 failed.
**** DEBUG ****
(perf_pmu:2647) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2647) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2647) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2647) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2647) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:2647) DEBUG: slept=500376000 perf=500875074
(perf_pmu:2647) INFO: busy=474322500 idle=0
(perf_pmu:2647) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2647) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
Dynamic subtest rcs0: SUCCESS (3.626s)
Starting dynamic subtest: bcs0
Dynamic subtest bcs0: SUCCESS (3.604s)
Starting dynamic subtest: vcs0
Dynamic subtest vcs0: SUCCESS (3.610s)
Starting dynamic subtest: vcs1
Dynamic subtest vcs1: SUCCESS (3.594s)
Starting dynamic subtest: vecs0
Dynamic subtest vecs0: SUCCESS (3.593s)
Starting dynamic subtest: vecs1
Dynamic subtest vecs1: SUCCESS (3.581s)
Starting dynamic subtest: ccs0
(perf_pmu:2907) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2907) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2907) CRITICAL: 'val' != 'ts[1] - ts[0]' (222655673489.000000 not wi...
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
Dynamic subtest rcs0: SUCCESS (3.630s)
Starting dynamic subtest: bcs0
Dynamic subtest bcs0: SUCCESS (3.580s)
Starting dynamic subtest: vcs0
(perf_pmu:2957) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2957) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2957) CRITICAL: 'val' != 'ts[1] - ts[0]' (470594427.000000 not withi...

Dynamic subtest vcs0 failed.
**** DEBUG ****
(perf_pmu:2957) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2957) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2957) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2957) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2957) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
Dynamic subtest rcs0: SUCCESS (3.589s)
Starting dynamic subtest: bcs0
Dynamic subtest bcs0: SUCCESS (3.585s)
Starting dynamic subtest: vcs0
(perf_pmu:2932) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2932) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2932) CRITICAL: 'val' != 'ts[1] - ts[0]' (470491822.000000 not withi...

Dynamic subtest vcs0 failed.
**** DEBUG ****
(perf_pmu:2932) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2932) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2932) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2932) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2932) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
Dynamic subtest rcs0: SUCCESS (3.623s)
Starting dynamic subtest: bcs0
Dynamic subtest bcs0: SUCCESS (3.583s)
Starting dynamic subtest: vcs0
(perf_pmu:2914) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2914) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2914) CRITICAL: 'val' != 'ts[1] - ts[0]' (470516250.000000 not withi...

Dynamic subtest vcs0 failed.
**** DEBUG ****
(perf_pmu:2914) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2914) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2914) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2914) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2914) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
Dynamic subtest rcs0: SUCCESS (3.605s)
Starting dynamic subtest: bcs0
Dynamic subtest bcs0: SUCCESS (3.594s)
Starting dynamic subtest: vcs0
(perf_pmu:4930) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:4930) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:4930) CRITICAL: 'val' != 'ts[1] - ts[0]' (470452916.000000 not withi...

Dynamic subtest vcs0 failed.
**** DEBUG ****
(perf_pmu:4930) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:4930) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:4930) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:4930) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:4930) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
Dynamic subtest rcs0: SUCCESS (3.618s)
Starting dynamic subtest: bcs0
Dynamic subtest bcs0: SUCCESS (3.586s)
Starting dynamic subtest: vcs0
(perf_pmu:2932) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2932) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2932) CRITICAL: 'val' != 'ts[1] - ts[0]' (470328437.000000 not withi...

Dynamic subtest vcs0 failed.
**** DEBUG ****
(perf_pmu:2932) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2932) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2932) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2932) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2932) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
Dynamic subtest rcs0: SUCCESS (3.620s)
Starting dynamic subtest: bcs0
Dynamic subtest bcs0: SUCCESS (3.588s)
Starting dynamic subtest: vcs0
Dynamic subtest vcs0: SUCCESS (3.611s)
Starting dynamic subtest: vcs1
Dynamic subtest vcs1: SUCCESS (3.595s)
Starting dynamic subtest: vecs0
Dynamic subtest vecs0: SUCCESS (3.590s)
Starting dynamic subtest: vecs1
Dynamic subtest vecs1: SUCCESS (3.601s)
Starting dynamic subtest: ccs0
(perf_pmu:2953) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2953) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2953) CRITICAL: 'val' != 'ts[1] - ts[0]' (222479785469.000000 not wi...
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
Dynamic subtest rcs0: SUCCESS (3.633s)
Starting dynamic subtest: bcs0
Dynamic subtest bcs0: SUCCESS (3.583s)
Starting dynamic subtest: vcs0
(perf_pmu:2930) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2930) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2930) CRITICAL: 'val' != 'ts[1] - ts[0]' (470668125.000000 not withi...

Dynamic subtest vcs0 failed.
**** DEBUG ****
(perf_pmu:2930) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2930) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2930) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2930) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2930) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
Dynamic subtest rcs0: SUCCESS (3.626s)
Starting dynamic subtest: bcs0
Dynamic subtest bcs0: SUCCESS (3.600s)
Starting dynamic subtest: vcs0
(perf_pmu:2931) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2931) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2931) CRITICAL: 'val' != 'ts[1] - ts[0]' (470500938.000000 not withi...

Dynamic subtest vcs0 failed.
**** DEBUG ****
(perf_pmu:2931) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2931) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2931) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2931) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2931) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
Dynamic subtest rcs0: SUCCESS (3.646s)
Starting dynamic subtest: bcs0
Dynamic subtest bcs0: SUCCESS (3.575s)
Starting dynamic subtest: vcs0
(perf_pmu:2950) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2950) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2950) CRITICAL: 'val' != 'ts[1] - ts[0]' (470883750.000000 not withi...

Dynamic subtest vcs0 failed.
**** DEBUG ****
(perf_pmu:2950) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2950) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2950) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2950) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2950) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
Dynamic subtest rcs0: SUCCESS (3.616s)
Starting dynamic subtest: bcs0
Dynamic subtest bcs0: SUCCESS (3.594s)
Starting dynamic subtest: vcs0
(perf_pmu:2917) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2917) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2917) CRITICAL: 'val' != 'ts[1] - ts[0]' (470505833.000000 not withi...

Dynamic subtest vcs0 failed.
**** DEBUG ****
(perf_pmu:2917) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2917) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2917) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2917) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2917) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
Dynamic subtest rcs0: SUCCESS (3.629s)
Starting dynamic subtest: bcs0
Dynamic subtest bcs0: SUCCESS (3.609s)
Starting dynamic subtest: vcs0
(perf_pmu:2943) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2943) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2943) CRITICAL: 'val' != 'ts[1] - ts[0]' (470733751.000000 not withi...

Dynamic subtest vcs0 failed.
**** DEBUG ****
(perf_pmu:2943) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2943) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2943) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2943) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2943) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
Dynamic subtest rcs0: SUCCESS (3.619s)
Starting dynamic subtest: bcs0
Dynamic subtest bcs0: SUCCESS (3.612s)
Starting dynamic subtest: vcs0
(perf_pmu:2952) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2952) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2952) CRITICAL: 'val' != 'ts[1] - ts[0]' (470398334.000000 not withi...

Dynamic subtest vcs0 failed.
**** DEBUG ****
(perf_pmu:2952) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2952) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2952) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2952) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2952) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
Dynamic subtest rcs0: SUCCESS (3.636s)
Starting dynamic subtest: bcs0
Dynamic subtest bcs0: SUCCESS (3.600s)
Starting dynamic subtest: vcs0
(perf_pmu:2920) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2920) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2920) CRITICAL: 'val' != 'ts[1] - ts[0]' (470812239.000000 not withi...

Dynamic subtest vcs0 failed.
**** DEBUG ****
(perf_pmu:2920) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2920) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2920) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2920) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2920) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
Dynamic subtest rcs0: SUCCESS (3.626s)
Starting dynamic subtest: bcs0
Dynamic subtest bcs0: SUCCESS (3.597s)
Starting dynamic subtest: vcs0
(perf_pmu:2097) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2097) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2097) CRITICAL: 'val' != 'ts[1] - ts[0]' (470049428.000000 not withi...

Dynamic subtest vcs0 failed.
**** DEBUG ****
(perf_pmu:2097) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2097) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2097) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2097) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2097) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
Dynamic subtest rcs0: SUCCESS (3.621s)
Starting dynamic subtest: bcs0
Dynamic subtest bcs0: SUCCESS (3.587s)
Starting dynamic subtest: vcs0
(perf_pmu:2240) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2240) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2240) CRITICAL: 'val' != 'ts[1] - ts[0]' (470414583.000000 not withi...

Dynamic subtest vcs0 failed.
**** DEBUG ****
(perf_pmu:2240) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2240) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2240) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2240) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2240) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
Dynamic subtest rcs0: SUCCESS (3.591s)
Starting dynamic subtest: bcs0
Dynamic subtest bcs0: SUCCESS (3.584s)
Starting dynamic subtest: vcs0
Dynamic subtest vcs0: SUCCESS (3.590s)
Starting dynamic subtest: vcs1
Dynamic subtest vcs1: SUCCESS (3.589s)
Starting dynamic subtest: vecs0
(perf_pmu:2822) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2822) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2822) CRITICAL: 'val' != 'ts[1] - ts[0]' (222681084896.000000 not wi...

Dynamic subtest vecs0 failed.
**** DEBUG ****
(perf_pmu:2822) intel_allocator_reloc-DEBUG: Using reloc allocator
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
Dynamic subtest rcs0: SUCCESS (3.618s)
Starting dynamic subtest: bcs0
Dynamic subtest bcs0: SUCCESS (3.595s)
Starting dynamic subtest: vcs0
Dynamic subtest vcs0: SUCCESS (3.601s)
Starting dynamic subtest: vcs1
Dynamic subtest vcs1: SUCCESS (3.576s)
Starting dynamic subtest: vecs0
(perf_pmu:2860) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2860) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2860) CRITICAL: 'val' != 'ts[1] - ts[0]' (222662587709.000000 not wi...

Dynamic subtest vecs0 failed.
**** DEBUG ****
(perf_pmu:2860) intel_allocator_reloc-DEBUG: Using reloc allocator
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
Dynamic subtest rcs0: SUCCESS (3.601s)
Starting dynamic subtest: bcs0
Dynamic subtest bcs0: SUCCESS (3.561s)
Starting dynamic subtest: vcs0
Dynamic subtest vcs0: SUCCESS (3.586s)
Starting dynamic subtest: vcs1
Dynamic subtest vcs1: SUCCESS (3.592s)
Starting dynamic subtest: vecs0
(perf_pmu:2807) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2807) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2807) CRITICAL: 'val' != 'ts[1] - ts[0]' (222700864531.000000 not wi...

Dynamic subtest vecs0 failed.
**** DEBUG ****
(perf_pmu:2807) intel_allocator_reloc-DEBUG: Using reloc allocator
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
Dynamic subtest rcs0: SUCCESS (3.615s)
Starting dynamic subtest: bcs0
Dynamic subtest bcs0: SUCCESS (3.607s)
Starting dynamic subtest: vcs0
Dynamic subtest vcs0: SUCCESS (3.608s)
Starting dynamic subtest: vcs1
Dynamic subtest vcs1: SUCCESS (3.612s)
Starting dynamic subtest: vecs0
(perf_pmu:2816) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2816) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2816) CRITICAL: 'val' != 'ts[1] - ts[0]' (222801495470.000000 not wi...

Dynamic subtest vecs0 failed.
**** DEBUG ****
(perf_pmu:2816) intel_allocator_reloc-DEBUG: Using reloc allocator
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
Dynamic subtest rcs0: SUCCESS (3.628s)
Starting dynamic subtest: bcs0
Dynamic subtest bcs0: SUCCESS (3.606s)
Starting dynamic subtest: vcs0
Dynamic subtest vcs0: SUCCESS (3.585s)
Starting dynamic subtest: vcs1
Dynamic subtest vcs1: SUCCESS (3.596s)
Starting dynamic subtest: vecs0
(perf_pmu:2841) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2841) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2841) CRITICAL: 'val' != 'ts[1] - ts[0]' (222727273177.000000 not wi...

Dynamic subtest vecs0 failed.
**** DEBUG ****
(perf_pmu:2841) intel_allocator_reloc-DEBUG: Using reloc allocator
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
Dynamic subtest rcs0: SUCCESS (3.613s)
Starting dynamic subtest: bcs0
Dynamic subtest bcs0: SUCCESS (3.597s)
Starting dynamic subtest: vcs0
Dynamic subtest vcs0: SUCCESS (3.571s)
Starting dynamic subtest: vcs1
Dynamic subtest vcs1: SUCCESS (3.605s)
Starting dynamic subtest: vecs0
(perf_pmu:2780) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2780) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2780) CRITICAL: 'val' != 'ts[1] - ts[0]' (222664179843.000000 not wi...

Dynamic subtest vecs0 failed.
**** DEBUG ****
(perf_pmu:2780) intel_allocator_reloc-DEBUG: Using reloc allocator
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
Dynamic subtest rcs0: SUCCESS (3.600s)
Starting dynamic subtest: bcs0
Dynamic subtest bcs0: SUCCESS (3.590s)
Starting dynamic subtest: vcs0
Dynamic subtest vcs0: SUCCESS (3.600s)
Starting dynamic subtest: vcs1
Dynamic subtest vcs1: SUCCESS (3.587s)
Starting dynamic subtest: vecs0
(perf_pmu:2812) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2812) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2812) CRITICAL: 'val' != 'ts[1] - ts[0]' (222710871875.000000 not wi...

Dynamic subtest vecs0 failed.
**** DEBUG ****
(perf_pmu:2812) intel_allocator_reloc-DEBUG: Using reloc allocator
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
Dynamic subtest rcs0: SUCCESS (3.610s)
Starting dynamic subtest: bcs0
Dynamic subtest bcs0: SUCCESS (3.597s)
Starting dynamic subtest: vcs0
Dynamic subtest vcs0: SUCCESS (3.613s)
Starting dynamic subtest: vcs1
Dynamic subtest vcs1: SUCCESS (3.596s)
Starting dynamic subtest: vecs0
(perf_pmu:2863) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2863) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2863) CRITICAL: 'val' != 'ts[1] - ts[0]' (222671863282.000000 not wi...

Dynamic subtest vecs0 failed.
**** DEBUG ****
(perf_pmu:2863) intel_allocator_reloc-DEBUG: Using reloc allocator
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
Dynamic subtest rcs0: SUCCESS (3.606s)
Starting dynamic subtest: bcs0
Dynamic subtest bcs0: SUCCESS (3.591s)
Starting dynamic subtest: vcs0
Dynamic subtest vcs0: SUCCESS (3.601s)
Starting dynamic subtest: vcs1
Dynamic subtest vcs1: SUCCESS (3.601s)
Starting dynamic subtest: vecs0
(perf_pmu:2806) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2806) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2806) CRITICAL: 'val' != 'ts[1] - ts[0]' (222708379064.000000 not wi...

Dynamic subtest vecs0 failed.
**** DEBUG ****
(perf_pmu:2806) intel_allocator_reloc-DEBUG: Using reloc allocator
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
Dynamic subtest rcs0: SUCCESS (3.618s)
Starting dynamic subtest: bcs0
Dynamic subtest bcs0: SUCCESS (3.580s)
Starting dynamic subtest: vcs0
Dynamic subtest vcs0: SUCCESS (3.602s)
Starting dynamic subtest: vcs1
Dynamic subtest vcs1: SUCCESS (3.578s)
Starting dynamic subtest: vecs0
(perf_pmu:2792) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2792) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2792) CRITICAL: 'val' != 'ts[1] - ts[0]' (222791201458.000000 not wi...

Dynamic subtest vecs0 failed.
**** DEBUG ****
(perf_pmu:2792) intel_allocator_reloc-DEBUG: Using reloc allocator
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
Dynamic subtest rcs0: SUCCESS (3.575s)
Starting dynamic subtest: bcs0
Dynamic subtest bcs0: SUCCESS (3.594s)
Starting dynamic subtest: vcs0
Dynamic subtest vcs0: SUCCESS (3.588s)
Starting dynamic subtest: vcs1
Dynamic subtest vcs1: SUCCESS (3.593s)
Starting dynamic subtest: vecs0
(perf_pmu:2819) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2819) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2819) CRITICAL: 'val' != 'ts[1] - ts[0]' (222798321250.000000 not wi...

Dynamic subtest vecs0 failed.
**** DEBUG ****
(perf_pmu:2819) intel_allocator_reloc-DEBUG: Using reloc allocator
...

Starting subtest: busy-double-start
Starting dynamic subtest: rcs0
Dynamic subtest rcs0: SUCCESS (3.615s)
Starting dynamic subtest: bcs0
Dynamic subtest bcs0: SUCCESS (3.598s)
Starting dynamic subtest: vcs0
Dynamic subtest vcs0: SUCCESS (3.584s)
Starting dynamic subtest: vcs1
Dynamic subtest vcs1: SUCCESS (3.607s)
Starting dynamic subtest: vecs0
(perf_pmu:2809) CRITICAL: Test assertion failure function busy_double_start, f...
(perf_pmu:2809) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance...
(perf_pmu:2809) CRITICAL: 'val' != 'ts[1] - ts[0]' (222714009323.000000 not wi...

Dynamic subtest vecs0 failed.
**** DEBUG ****
(perf_pmu:2809) intel_allocator_reloc-DEBUG: Using reloc allocator
...