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

Result: Fail

integration-manifest git-log-oneline i915_display_info8 igt_runner8 runtimes8 results8.json results8-i915-load.json guc_logs8.tar i915_display_info_post_exec8 boot8 dmesg8

DetailValue
Duration 4.65 seconds
Hostname 
shard-dg2-7
Igt-Version 
IGT-Version: 2.2-g28cc709ad (x86_64) (Linux: 6.18.0-CI_DRM_17665-gd8f645c04dad+ x86_64)
Out 
Using IGT_SRANDOM=1765477538 for randomisation
Opened device: /dev/dri/card0
Starting subtest: most-busy-idle-check-all
Starting dynamic subtest: rcs0
0=0
1=500485886
2=219376055418
3=219398128229
4=219417427448
5=219437581302
6=221622390990
Stack trace:
  #0 ../lib/igt_core.c:2075 __igt_fail_assert()
  #1 ../tests/intel/perf_pmu.c:630 most_busy_check_all()
  #2 ../tests/intel/perf_pmu.c:2378 __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 rcs0: FAIL (0.692s)
Starting dynamic subtest: bcs0
0=500474793
1=0
2=500391511
3=500381719
4=500325677
5=500290990
6=500378490
Dynamic subtest bcs0: SUCCESS (0.674s)
Starting dynamic subtest: vcs0
0=500433751
1=500434011
2=0
3=500315105
4=500317189
5=500312136
6=500367189
Dynamic subtest vcs0: SUCCESS (0.655s)
Starting dynamic subtest: vcs1
0=500483854
1=500386720
2=500389635
3=0
4=500381875
5=500353647
6=500417188
Dynamic subtest vcs1: SUCCESS (0.653s)
Starting dynamic subtest: vecs0
0=500432032
1=500433385
2=500346562
3=500316354
4=0
5=500321823
6=500368178
Dynamic subtest vecs0: SUCCESS (0.655s)
Starting dynamic subtest: vecs1
0=500532136
1=500435782
2=500449064
3=500420053
4=500437188
5=0
6=500457188
Dynamic subtest vecs1: SUCCESS (0.659s)
Starting dynamic subtest: ccs0
0=500548438
1=500433802
2=500449010
3=500419480
4=500447448
5=500417604
6=0
Dynamic subtest ccs0: SUCCESS (0.652s)
Subtest most-busy-idle-check-all: FAIL (4.648s)
Opened device: /dev/dri/renderD128
Err 
Starting subtest: most-busy-idle-check-all
Starting dynamic subtest: rcs0
(perf_pmu:2248) CRITICAL: Test assertion failure function most_busy_check_all, file ../tests/intel/perf_pmu.c:627:
(perf_pmu:2248) CRITICAL: Failed assertion: (double)(val[i]) <= (1.0 + (tolerance)) * (double)(slept) && (double)(val[i]) >= (1.0 - (tolerance)) * (double)(slept)
(perf_pmu:2248) CRITICAL: 'val[i]' != 'slept' (219376055418.000000 not within +5.0%/-5.0% tolerance of 500234000.000000)

Dynamic subtest rcs0 failed.
**** DEBUG ****
(perf_pmu:2248) intel_allocator_reloc-DEBUG: Using reloc allocator
(perf_pmu:2248) igt_dummyload-DEBUG: Test requirement passed: nengine
(perf_pmu:2248) DEBUG: Test requirement passed: spin
(perf_pmu:2248) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:2248) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:2248) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:2248) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:2248) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:2248) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:2248) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:2248) INFO: 0=0
1=500485886
2=219376055418
3=219398128229
4=219417427448
5=219437581302
6=221622390990
(perf_pmu:2248) CRITICAL: Test assertion failure function most_busy_check_all, file ../tests/intel/perf_pmu.c:627:
(perf_pmu:2248) CRITICAL: Failed assertion: (double)(val[i]) <= (1.0 + (tolerance)) * (double)(slept) && (double)(val[i]) >= (1.0 - (tolerance)) * (double)(slept)
(perf_pmu:2248) CRITICAL: 'val[i]' != 'slept' (219376055418.000000 not within +5.0%/-5.0% tolerance of 500234000.000000)

(perf_pmu:2248) igt_core-INFO: Stack trace:
(perf_pmu:2248) igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(perf_pmu:2248) igt_core-INFO:   #1 ../tests/intel/perf_pmu.c:630 most_busy_check_all()
(perf_pmu:2248) igt_core-INFO:   #2 ../tests/intel/perf_pmu.c:2378 __igt_unique____real_main2281()
(perf_pmu:2248) igt_core-INFO:   #3 ../tests/intel/perf_pmu.c:2281 main()
(perf_pmu:2248) igt_core-INFO:   #4 [__libc_init_first+0x8a]
(perf_pmu:2248) igt_core-INFO:   #5 [__libc_start_main+0x8b]
(perf_pmu:2248) igt_core-INFO:   #6 [_start+0x25]
****  END  ****
Dynamic subtest rcs0: FAIL (0.692s)
Starting dynamic subtest: bcs0
Dynamic subtest bcs0: SUCCESS (0.674s)
Starting dynamic subtest: vcs0
Dynamic subtest vcs0: SUCCESS (0.655s)
Starting dynamic subtest: vcs1
Dynamic subtest vcs1: SUCCESS (0.653s)
Starting dynamic subtest: vecs0
Dynamic subtest vecs0: SUCCESS (0.655s)
Starting dynamic subtest: vecs1
Dynamic subtest vecs1: SUCCESS (0.659s)
Starting dynamic subtest: ccs0
Dynamic subtest ccs0: SUCCESS (0.652s)
Subtest most-busy-idle-check-all: FAIL (4.648s)
Dmesg
<6> [242.696583] Console: switching to colour dummy device 80x25
<6> [242.696807] [IGT] perf_pmu: executing
<7> [242.710048] i915 0000:03:00.0: [drm:i915_gem_open [i915]]
<7> [242.712146] i915 0000:03:00.0: [drm:i915_gem_open [i915]]
<6> [242.720034] [IGT] perf_pmu: starting subtest most-busy-idle-check-all
<6> [242.720459] [IGT] perf_pmu: starting dynamic subtest rcs0
<7> [242.720858] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<6> [243.412421] [IGT] perf_pmu: finished subtest rcs0, FAIL
<6> [243.413023] [IGT] perf_pmu: starting dynamic subtest bcs0
<7> [243.413240] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [244.027312] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [244.087509] [IGT] perf_pmu: finished subtest bcs0, SUCCESS
<6> [244.087966] [IGT] perf_pmu: starting dynamic subtest vcs0
<7> [244.088370] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [244.702453] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [244.742923] [IGT] perf_pmu: finished subtest vcs0, SUCCESS
<6> [244.743534] [IGT] perf_pmu: starting dynamic subtest vcs1
<7> [244.743813] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [245.356464] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [245.397387] [IGT] perf_pmu: finished subtest vcs1, SUCCESS
<6> [245.397767] [IGT] perf_pmu: starting dynamic subtest vecs0
<7> [245.397917] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [246.012282] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [246.053855] [IGT] perf_pmu: finished subtest vecs0, SUCCESS
<6> [246.055323] [IGT] perf_pmu: starting dynamic subtest vecs1
<7> [246.055951] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [246.672795] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [246.714375] [IGT] perf_pmu: finished subtest vecs1, SUCCESS
<6> [246.714724] [IGT] perf_pmu: starting dynamic subtest ccs0
<7> [246.714920] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [247.325466] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [247.368004] [IGT] perf_pmu: finished subtest ccs0, SUCCESS
<6> [247.369533] [IGT] perf_pmu: finished subtest most-busy-idle-check-all, FAIL
<7> [247.411671] i915 0000:03:00.0: [drm:i915_gem_open [i915]]
<7> [247.414605] i915 0000:03:00.0: [drm:i915_gem_open [i915]]
<7> [247.418678] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [247.447105] i915 0000:03:00.0: [drm:drm_client_dev_restore] fbdev: ret=0
<6> [247.447361] [IGT] perf_pmu: exiting, ret=98
<6> [247.464013] Console: switching to colour frame buffer device 240x67
Created at 2025-12-11 20:34:51