Result:
git-log-oneline i915_display_info9 igt_runner9 runtimes9 results9.json results9-i915-load.json guc_logs9.tar i915_display_info_post_exec9 boot9 dmesg9
| Detail | Value |
|---|---|
| Duration | 25.08 seconds |
| Hostname |
shard-dg2-7 |
| Igt-Version |
IGT-Version: 2.3-g23fdc238d (x86_64) (Linux: 7.0.0-rc3-CI_DRM_18143-g45618ec6cfed+ x86_64) |
| Out |
Using IGT_SRANDOM=1773501382 for randomisation Opened device: /dev/dri/card0 Starting subtest: busy-double-start Starting dynamic subtest: rcs0 busy=480837864 idle=0 Dynamic subtest rcs0: SUCCESS (3.622s) Starting dynamic subtest: bcs0 busy=481707604 idle=0 Dynamic subtest bcs0: SUCCESS (3.584s) Starting dynamic subtest: vcs0 busy=469000053 idle=0 Stack trace: #0 ../lib/igt_core.c:2075 __igt_fail_assert() #1 ../tests/intel/perf_pmu.c:481 busy_double_start() #2 ../tests/intel/perf_pmu.c:2429 __igt_unique____real_main2281() #3 ../tests/intel/perf_pmu.c:2281 main() #4 [__libc_init_first+0x8a] #5 [__libc_start_main+0x8b] #6 [_start+0x25] Dynamic subtest vcs0: FAIL (3.570s) Starting dynamic subtest: vcs1 busy=469350677 idle=0 Stack trace: #0 ../lib/igt_core.c:2075 __igt_fail_assert() #1 ../tests/intel/perf_pmu.c:481 busy_double_start() #2 ../tests/intel/perf_pmu.c:2429 __igt_unique____real_main2281() #3 ../tests/intel/perf_pmu.c:2281 main() #4 [__libc_init_first+0x8a] #5 [__libc_start_main+0x8b] #6 [_start+0x25] Dynamic subtest vcs1: FAIL (3.567s) Starting dynamic subtest: vecs0 busy=469339062 idle=0 Stack trace: #0 ../lib/igt_core.c:2075 __igt_fail_assert() #1 ../tests/intel/perf_pmu.c:481 busy_double_start() #2 ../tests/intel/perf_pmu.c:2429 __igt_unique____real_main2281() #3 ../tests/intel/perf_pmu.c:2281 main() #4 [__libc_init_first+0x8a] #5 [__libc_start_main+0x8b] #6 [_start+0x25] Dynamic subtest vecs0: FAIL (3.565s) Starting dynamic subtest: vecs1 busy=469719582 idle=0 Stack trace: #0 ../lib/igt_core.c:2075 __igt_fail_assert() #1 ../tests/intel/perf_pmu.c:481 busy_double_start() #2 ../tests/intel/perf_pmu.c:2429 __igt_unique____real_main2281() #3 ../tests/intel/perf_pmu.c:2281 main() #4 [__libc_init_first+0x8a] #5 [__libc_start_main+0x8b] #6 [_start+0x25] Dynamic subtest vecs1: FAIL (3.565s) Starting dynamic subtest: ccs0 busy=479335313 idle=0 Dynamic subtest ccs0: SUCCESS (3.588s) Subtest busy-double-start: FAIL (25.076s) Opened device: /dev/dri/renderD128 |
| Err |
Starting subtest: busy-double-start Starting dynamic subtest: rcs0 Dynamic subtest rcs0: SUCCESS (3.622s) Starting dynamic subtest: bcs0 Dynamic subtest bcs0: SUCCESS (3.584s) Starting dynamic subtest: vcs0 (perf_pmu:2412) CRITICAL: Test assertion failure function busy_double_start, file ../tests/intel/perf_pmu.c:477: (perf_pmu:2412) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance)) * (double)(ts[1] - ts[0]) && (double)(val) >= (1.0 - (tolerance)) * (double)(ts[1] - ts[0]) (perf_pmu:2412) CRITICAL: 'val' != 'ts[1] - ts[0]' (469000053.000000 not within +5.0%/-5.0% tolerance of 500390288.000000) Dynamic subtest vcs0 failed. **** DEBUG **** (perf_pmu:2412) intel_allocator_reloc-DEBUG: Using reloc allocator (perf_pmu:2412) intel_allocator_reloc-DEBUG: Using reloc allocator (perf_pmu:2412) igt_dummyload-DEBUG: Test requirement passed: nengine (perf_pmu:2412) igt_dummyload-DEBUG: Test requirement passed: nengine (perf_pmu:2412) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV) (perf_pmu:2412) DEBUG: slept=500337000 perf=500390288 (perf_pmu:2412) INFO: busy=469000053 idle=0 (perf_pmu:2412) CRITICAL: Test assertion failure function busy_double_start, file ../tests/intel/perf_pmu.c:477: (perf_pmu:2412) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance)) * (double)(ts[1] - ts[0]) && (double)(val) >= (1.0 - (tolerance)) * (double)(ts[1] - ts[0]) (perf_pmu:2412) CRITICAL: 'val' != 'ts[1] - ts[0]' (469000053.000000 not within +5.0%/-5.0% tolerance of 500390288.000000) (perf_pmu:2412) igt_core-INFO: Stack trace: (perf_pmu:2412) igt_core-INFO: #0 ../lib/igt_core.c:2075 __igt_fail_assert() (perf_pmu:2412) igt_core-INFO: #1 ../tests/intel/perf_pmu.c:481 busy_double_start() (perf_pmu:2412) igt_core-INFO: #2 ../tests/intel/perf_pmu.c:2429 __igt_unique____real_main2281() (perf_pmu:2412) igt_core-INFO: #3 ../tests/intel/perf_pmu.c:2281 main() (perf_pmu:2412) igt_core-INFO: #4 [__libc_init_first+0x8a] (perf_pmu:2412) igt_core-INFO: #5 [__libc_start_main+0x8b] (perf_pmu:2412) igt_core-INFO: #6 [_start+0x25] **** END **** Dynamic subtest vcs0: FAIL (3.570s) Starting dynamic subtest: vcs1 (perf_pmu:2412) CRITICAL: Test assertion failure function busy_double_start, file ../tests/intel/perf_pmu.c:477: (perf_pmu:2412) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance)) * (double)(ts[1] - ts[0]) && (double)(val) >= (1.0 - (tolerance)) * (double)(ts[1] - ts[0]) (perf_pmu:2412) CRITICAL: 'val' != 'ts[1] - ts[0]' (469350677.000000 not within +5.0%/-5.0% tolerance of 500390502.000000) Dynamic subtest vcs1 failed. **** DEBUG **** (perf_pmu:2412) intel_allocator_reloc-DEBUG: Using reloc allocator (perf_pmu:2412) intel_allocator_reloc-DEBUG: Using reloc allocator (perf_pmu:2412) igt_dummyload-DEBUG: Test requirement passed: nengine (perf_pmu:2412) igt_dummyload-DEBUG: Test requirement passed: nengine (perf_pmu:2412) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV) (perf_pmu:2412) DEBUG: slept=500339000 perf=500390502 (perf_pmu:2412) INFO: busy=469350677 idle=0 (perf_pmu:2412) CRITICAL: Test assertion failure function busy_double_start, file ../tests/intel/perf_pmu.c:477: (perf_pmu:2412) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance)) * (double)(ts[1] - ts[0]) && (double)(val) >= (1.0 - (tolerance)) * (double)(ts[1] - ts[0]) (perf_pmu:2412) CRITICAL: 'val' != 'ts[1] - ts[0]' (469350677.000000 not within +5.0%/-5.0% tolerance of 500390502.000000) (perf_pmu:2412) igt_core-INFO: Stack trace: (perf_pmu:2412) igt_core-INFO: #0 ../lib/igt_core.c:2075 __igt_fail_assert() (perf_pmu:2412) igt_core-INFO: #1 ../tests/intel/perf_pmu.c:481 busy_double_start() (perf_pmu:2412) igt_core-INFO: #2 ../tests/intel/perf_pmu.c:2429 __igt_unique____real_main2281() (perf_pmu:2412) igt_core-INFO: #3 ../tests/intel/perf_pmu.c:2281 main() (perf_pmu:2412) igt_core-INFO: #4 [__libc_init_first+0x8a] (perf_pmu:2412) igt_core-INFO: #5 [__libc_start_main+0x8b] (perf_pmu:2412) igt_core-INFO: #6 [_start+0x25] **** END **** Dynamic subtest vcs1: FAIL (3.567s) Starting dynamic subtest: vecs0 (perf_pmu:2412) CRITICAL: Test assertion failure function busy_double_start, file ../tests/intel/perf_pmu.c:477: (perf_pmu:2412) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance)) * (double)(ts[1] - ts[0]) && (double)(val) >= (1.0 - (tolerance)) * (double)(ts[1] - ts[0]) (perf_pmu:2412) CRITICAL: 'val' != 'ts[1] - ts[0]' (469339062.000000 not within +5.0%/-5.0% tolerance of 500394909.000000) Dynamic subtest vecs0 failed. **** DEBUG **** (perf_pmu:2412) intel_allocator_reloc-DEBUG: Using reloc allocator (perf_pmu:2412) intel_allocator_reloc-DEBUG: Using reloc allocator (perf_pmu:2412) igt_dummyload-DEBUG: Test requirement passed: nengine (perf_pmu:2412) igt_dummyload-DEBUG: Test requirement passed: nengine (perf_pmu:2412) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV) (perf_pmu:2412) DEBUG: slept=500341000 perf=500394909 (perf_pmu:2412) INFO: busy=469339062 idle=0 (perf_pmu:2412) CRITICAL: Test assertion failure function busy_double_start, file ../tests/intel/perf_pmu.c:477: (perf_pmu:2412) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance)) * (double)(ts[1] - ts[0]) && (double)(val) >= (1.0 - (tolerance)) * (double)(ts[1] - ts[0]) (perf_pmu:2412) CRITICAL: 'val' != 'ts[1] - ts[0]' (469339062.000000 not within +5.0%/-5.0% tolerance of 500394909.000000) (perf_pmu:2412) igt_core-INFO: Stack trace: (perf_pmu:2412) igt_core-INFO: #0 ../lib/igt_core.c:2075 __igt_fail_assert() (perf_pmu:2412) igt_core-INFO: #1 ../tests/intel/perf_pmu.c:481 busy_double_start() (perf_pmu:2412) igt_core-INFO: #2 ../tests/intel/perf_pmu.c:2429 __igt_unique____real_main2281() (perf_pmu:2412) igt_core-INFO: #3 ../tests/intel/perf_pmu.c:2281 main() (perf_pmu:2412) igt_core-INFO: #4 [__libc_init_first+0x8a] (perf_pmu:2412) igt_core-INFO: #5 [__libc_start_main+0x8b] (perf_pmu:2412) igt_core-INFO: #6 [_start+0x25] **** END **** Dynamic subtest vecs0: FAIL (3.565s) Starting dynamic subtest: vecs1 (perf_pmu:2412) CRITICAL: Test assertion failure function busy_double_start, file ../tests/intel/perf_pmu.c:477: (perf_pmu:2412) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance)) * (double)(ts[1] - ts[0]) && (double)(val) >= (1.0 - (tolerance)) * (double)(ts[1] - ts[0]) (perf_pmu:2412) CRITICAL: 'val' != 'ts[1] - ts[0]' (469719582.000000 not within +5.0%/-5.0% tolerance of 500392221.000000) Dynamic subtest vecs1 failed. **** DEBUG **** (perf_pmu:2412) intel_allocator_reloc-DEBUG: Using reloc allocator (perf_pmu:2412) intel_allocator_reloc-DEBUG: Using reloc allocator (perf_pmu:2412) igt_dummyload-DEBUG: Test requirement passed: nengine (perf_pmu:2412) igt_dummyload-DEBUG: Test requirement passed: nengine (perf_pmu:2412) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV) (perf_pmu:2412) DEBUG: slept=500339000 perf=500392221 (perf_pmu:2412) INFO: busy=469719582 idle=0 (perf_pmu:2412) CRITICAL: Test assertion failure function busy_double_start, file ../tests/intel/perf_pmu.c:477: (perf_pmu:2412) CRITICAL: Failed assertion: (double)(val) <= (1.0 + (tolerance)) * (double)(ts[1] - ts[0]) && (double)(val) >= (1.0 - (tolerance)) * (double)(ts[1] - ts[0]) (perf_pmu:2412) CRITICAL: 'val' != 'ts[1] - ts[0]' (469719582.000000 not within +5.0%/-5.0% tolerance of 500392221.000000) (perf_pmu:2412) igt_core-INFO: Stack trace: (perf_pmu:2412) igt_core-INFO: #0 ../lib/igt_core.c:2075 __igt_fail_assert() (perf_pmu:2412) igt_core-INFO: #1 ../tests/intel/perf_pmu.c:481 busy_double_start() (perf_pmu:2412) igt_core-INFO: #2 ../tests/intel/perf_pmu.c:2429 __igt_unique____real_main2281() (perf_pmu:2412) igt_core-INFO: #3 ../tests/intel/perf_pmu.c:2281 main() (perf_pmu:2412) igt_core-INFO: #4 [__libc_init_first+0x8a] (perf_pmu:2412) igt_core-INFO: #5 [__libc_start_main+0x8b] (perf_pmu:2412) igt_core-INFO: #6 [_start+0x25] **** END **** Dynamic subtest vecs1: FAIL (3.565s) Starting dynamic subtest: ccs0 Dynamic subtest ccs0: SUCCESS (3.588s) Subtest busy-double-start: FAIL (25.076s) |
| Dmesg |
<6> [293.110400] Console: switching to colour dummy device 80x25
<6> [293.110920] [IGT] perf_pmu: executing
<7> [293.127696] i915 0000:03:00.0: [drm:i915_gem_open [i915]]
<7> [293.129432] i915 0000:03:00.0: [drm:i915_gem_open [i915]]
<6> [293.136853] [IGT] perf_pmu: starting subtest busy-double-start
<6> [293.137383] [IGT] perf_pmu: starting dynamic subtest rcs0
<7> [293.137803] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [293.169150] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [296.187037] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [296.726836] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [296.760475] [IGT] perf_pmu: finished subtest rcs0, SUCCESS
<6> [296.761302] [IGT] perf_pmu: starting dynamic subtest bcs0
<7> [296.761737] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [296.762213] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [299.778753] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [300.317571] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [300.347079] [IGT] perf_pmu: finished subtest bcs0, SUCCESS
<6> [300.349848] [IGT] perf_pmu: starting dynamic subtest vcs0
<7> [300.350248] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [300.350670] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [303.365744] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [303.920614] [IGT] perf_pmu: finished subtest vcs0, FAIL
<6> [303.921189] [IGT] perf_pmu: starting dynamic subtest vcs1
<7> [303.921596] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [303.921965] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [306.938924] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [307.488755] [IGT] perf_pmu: finished subtest vcs1, FAIL
<6> [307.489338] [IGT] perf_pmu: starting dynamic subtest vecs0
<7> [307.489496] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [307.489895] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [310.506151] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [311.055032] [IGT] perf_pmu: finished subtest vecs0, FAIL
<6> [311.055692] [IGT] perf_pmu: starting dynamic subtest vecs1
<7> [311.055832] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [311.056167] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [314.071934] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [314.621263] [IGT] perf_pmu: finished subtest vecs1, FAIL
<6> [314.621861] [IGT] perf_pmu: starting dynamic subtest ccs0
<7> [314.622012] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [314.622377] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [317.638827] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [318.178724] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [318.211862] [IGT] perf_pmu: finished subtest ccs0, SUCCESS
<6> [318.214644] [IGT] perf_pmu: finished subtest busy-double-start, FAIL
<7> [318.230403] i915 0000:03:00.0: [drm:i915_gem_open [i915]]
<7> [318.232122] i915 0000:03:00.0: [drm:i915_gem_open [i915]]
<7> [318.234638] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [318.262456] i915 0000:03:00.0: [drm:drm_client_dev_restore] fbdev: ret=0
<6> [318.263112] [IGT] perf_pmu: exiting, ret=98
<6> [318.279314] Console: switching to colour frame buffer device 240x67
|