Results for igt@perf_pmu@most-busy-idle-check-all

Machine description: shard-dg2-10

Result: Fail

git-log-oneline i915_display_info14 igt_runner14 runtimes14 results14.json results14-i915-load.json i915_display_info_post_exec14 boot14 dmesg14

DetailValue
Duration 4.62 seconds
Hostname 
shard-dg2-10
Igt-Version 
IGT-Version: 2.0-g8a358e30c (x86_64) (Linux: 6.14.0-rc7-CI_DRM_16301-ga123616cf3af+ x86_64)
Out 
Using IGT_SRANDOM=1742599866 for randomisation
Opened device: /dev/dri/card0
Starting subtest: most-busy-idle-check-all
Starting dynamic subtest: rcs0
0=0
1=500502396
2=222894892135
3=222865202759
4=222806322865
5=222873929270
6=222470992031
Stack trace:
  #0 ../lib/igt_core.c:2062 __igt_fail_assert()
  #1 ../tests/intel/perf_pmu.c:630 most_busy_check_all()
  #2 ../tests/intel/perf_pmu.c:2382 __igt_unique____real_main2285()
  #3 ../tests/intel/perf_pmu.c:2285 main()
  #4 [__libc_init_first+0x8a]
  #5 [__libc_start_main+0x8b]
  #6 [_start+0x25]
Dynamic subtest rcs0: FAIL (0.682s)
Starting dynamic subtest: bcs0
0=500259687
1=0
2=500147812
3=500141771
4=500140051
5=500133698
6=500185729
Dynamic subtest bcs0: SUCCESS (0.653s)
Starting dynamic subtest: vcs0
0=500359218
1=500362811
2=0
3=500251094
4=500253229
5=500249062
6=500305677
Dynamic subtest vcs0: SUCCESS (0.656s)
Starting dynamic subtest: vcs1
0=500401614
1=500410521
2=500346718
3=0
4=500275208
5=500271822
6=500351301
Dynamic subtest vcs1: SUCCESS (0.649s)
Starting dynamic subtest: vecs0
0=500393958
1=500404322
2=500313385
3=500276822
4=0
5=500289896
6=500349323
Dynamic subtest vecs0: SUCCESS (0.654s)
Starting dynamic subtest: vecs1
0=500528332
1=500431771
2=500434947
3=500430000
4=500438228
5=0
6=500450729
Dynamic subtest vecs1: SUCCESS (0.653s)
Starting dynamic subtest: ccs0
0=500366459
1=500372604
2=500275676
3=500271093
4=500278386
5=500205207
6=0
Dynamic subtest ccs0: SUCCESS (0.650s)
Subtest most-busy-idle-check-all: FAIL (4.617s)
Opened device: /dev/dri/renderD128
Err 
Starting subtest: most-busy-idle-check-all
Starting dynamic subtest: rcs0
(perf_pmu:2764) CRITICAL: Test assertion failure function most_busy_check_all, file ../tests/intel/perf_pmu.c:627:
(perf_pmu:2764) CRITICAL: Failed assertion: (double)(val[i]) <= (1.0 + (tolerance)) * (double)(slept) && (double)(val[i]) >= (1.0 - (tolerance)) * (double)(slept)
(perf_pmu:2764) CRITICAL: 'val[i]' != 'slept' (222894892135.000000 not within +5.0%/-5.0% tolerance of 500192000.000000)

Dynamic subtest rcs0 failed.
**** DEBUG ****
(perf_pmu:2764) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2764) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2764) DEBUG: Test requirement passed: spin
(perf_pmu:2764) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:2764) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:2764) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:2764) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:2764) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:2764) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:2764) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:2764) INFO: 0=0
1=500502396
2=222894892135
3=222865202759
4=222806322865
5=222873929270
6=222470992031
(perf_pmu:2764) CRITICAL: Test assertion failure function most_busy_check_all, file ../tests/intel/perf_pmu.c:627:
(perf_pmu:2764) CRITICAL: Failed assertion: (double)(val[i]) <= (1.0 + (tolerance)) * (double)(slept) && (double)(val[i]) >= (1.0 - (tolerance)) * (double)(slept)
(perf_pmu:2764) CRITICAL: 'val[i]' != 'slept' (222894892135.000000 not within +5.0%/-5.0% tolerance of 500192000.000000)

(perf_pmu:2764) igt_core-INFO: Stack trace:
(perf_pmu:2764) igt_core-INFO:   #0 ../lib/igt_core.c:2062 __igt_fail_assert()
(perf_pmu:2764) igt_core-INFO:   #1 ../tests/intel/perf_pmu.c:630 most_busy_check_all()
(perf_pmu:2764) igt_core-INFO:   #2 ../tests/intel/perf_pmu.c:2382 __igt_unique____real_main2285()
(perf_pmu:2764) igt_core-INFO:   #3 ../tests/intel/perf_pmu.c:2285 main()
(perf_pmu:2764) igt_core-INFO:   #4 [__libc_init_first+0x8a]
(perf_pmu:2764) igt_core-INFO:   #5 [__libc_start_main+0x8b]
(perf_pmu:2764) igt_core-INFO:   #6 [_start+0x25]
****  END  ****
Dynamic subtest rcs0: FAIL (0.682s)
Starting dynamic subtest: bcs0
Dynamic subtest bcs0: SUCCESS (0.653s)
Starting dynamic subtest: vcs0
Dynamic subtest vcs0: SUCCESS (0.656s)
Starting dynamic subtest: vcs1
Dynamic subtest vcs1: SUCCESS (0.649s)
Starting dynamic subtest: vecs0
Dynamic subtest vecs0: SUCCESS (0.654s)
Starting dynamic subtest: vecs1
Dynamic subtest vecs1: SUCCESS (0.653s)
Starting dynamic subtest: ccs0
Dynamic subtest ccs0: SUCCESS (0.650s)
Subtest most-busy-idle-check-all: FAIL (4.617s)
Dmesg
<6> [614.106573] Console: switching to colour dummy device 80x25
<6> [614.107528] [IGT] perf_pmu: executing
<7> [614.123912] i915 0000:03:00.0: [drm:i915_gem_open [i915]]
<7> [614.125197] i915 0000:03:00.0: [drm:i915_gem_open [i915]]
<6> [614.131678] [IGT] perf_pmu: starting subtest most-busy-idle-check-all
<6> [614.132196] [IGT] perf_pmu: starting dynamic subtest rcs0
<7> [614.132568] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<6> [614.815304] [IGT] perf_pmu: finished subtest rcs0, FAIL
<6> [614.816097] [IGT] perf_pmu: starting dynamic subtest bcs0
<7> [614.816268] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [615.427649] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [615.471434] [IGT] perf_pmu: finished subtest bcs0, SUCCESS
<6> [615.473676] [IGT] perf_pmu: starting dynamic subtest vcs0
<7> [615.474524] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [616.088625] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [616.130335] [IGT] perf_pmu: finished subtest vcs0, SUCCESS
<6> [616.130739] [IGT] perf_pmu: starting dynamic subtest vcs1
<7> [616.131008] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [616.738976] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [616.781449] [IGT] perf_pmu: finished subtest vcs1, SUCCESS
<6> [616.783446] [IGT] perf_pmu: starting dynamic subtest vecs0
<7> [616.784246] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [617.396705] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [617.439598] [IGT] perf_pmu: finished subtest vecs0, SUCCESS
<6> [617.441858] [IGT] perf_pmu: starting dynamic subtest vecs1
<7> [617.442678] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [618.053684] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [618.095521] [IGT] perf_pmu: finished subtest vecs1, SUCCESS
<6> [618.095962] [IGT] perf_pmu: starting dynamic subtest ccs0
<7> [618.096182] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [618.704703] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [618.748327] [IGT] perf_pmu: finished subtest ccs0, SUCCESS
<6> [618.750675] [IGT] perf_pmu: finished subtest most-busy-idle-check-all, FAIL
<7> [618.795434] i915 0000:03:00.0: [drm:i915_gem_open [i915]]
<7> [618.797136] i915 0000:03:00.0: [drm:i915_gem_open [i915]]
<7> [618.799989] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [618.814057] i915 0000:03:00.0: [drm:drm_client_dev_restore] fbdev: ret=0
<6> [618.814544] [IGT] perf_pmu: exiting, ret=98
<6> [618.830721] Console: switching to colour frame buffer device 240x67
Created at 2025-03-22 00:33:55