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

Result: Fail

git-log-oneline i915_display_info23 igt_runner23 runtimes23 results23.json results23-i915-load.json guc_logs23.tar i915_display_info_post_exec23 boot23 dmesg23

DetailValue
Duration 9.47 seconds
Hostname 
shard-mtlp-6
Igt-Version 
IGT-Version: 2.4-g9b94cb28a (x86_64) (Linux: 7.1.0-rc3-CI_DRM_18479-g8fbb3d48e61c+ x86_64)
Out 
Using IGT_SRANDOM=1778703337 for randomisation
Opened device: /dev/dri/card0
Starting subtest: most-busy-idle-check-all
Starting dynamic subtest: rcs0
0=0
1=223315409479
2=223407947865
3=223382022604
4=223411279740
5=223113313386
Stack trace:
  #0 ../lib/igt_core.c:2074 __igt_fail_assert()
  #1 ../tests/intel/perf_pmu.c:630 most_busy_check_all()
  #2 ../tests/intel/perf_pmu.c:2383 __igt_unique____real_main2286()
  #3 ../tests/intel/perf_pmu.c:2286 main()
  #4 [__libc_init_first+0x8a]
  #5 [__libc_start_main+0x8b]
  #6 [_start+0x25]
Dynamic subtest rcs0: FAIL (0.645s)
Starting dynamic subtest: bcs0
0=500063281
1=0
2=500100261
3=500076095
4=500110469
5=500000834
Dynamic subtest bcs0: SUCCESS (0.832s)
Starting dynamic subtest: vcs0
0=500170313
1=500065470
2=0
3=499988177
4=500007500
5=500102709
Dynamic subtest vcs0: SUCCESS (1.978s)
Starting dynamic subtest: vcs1
0=500075260
1=500046198
2=499964741
3=0
4=499971043
5=500037970
Dynamic subtest vcs1: SUCCESS (1.978s)
Starting dynamic subtest: vecs0
0=500192658
1=500092240
2=499973386
3=499981719
4=0
5=500118333
Dynamic subtest vecs0: SUCCESS (1.980s)
Starting dynamic subtest: ccs0
0=500196771
1=500142917
2=500082448
3=500056615
4=500096145
5=0
Dynamic subtest ccs0: SUCCESS (2.044s)
Subtest most-busy-idle-check-all: FAIL (9.472s)
Opened device: /dev/dri/renderD128
Err 
Starting subtest: most-busy-idle-check-all
Starting dynamic subtest: rcs0
[357.887257] (perf_pmu:9015) CRITICAL: Test assertion failure function most_busy_check_all, file ../tests/intel/perf_pmu.c:627:
[357.887282] (perf_pmu:9015) CRITICAL: Failed assertion: (double)(val[i]) <= (1.0 + (tolerance)) * (double)(slept) && (double)(val[i]) >= (1.0 - (tolerance)) * (double)(slept)
[357.887316] (perf_pmu:9015) CRITICAL: 'val[i]' != 'slept' (223315409479.000000 not within +5.0%/-5.0% tolerance of 500185000.000000)

Dynamic subtest rcs0 failed.
**** DEBUG ****
[357.274743] (perf_pmu:9015) intel_allocator_reloc-DEBUG: Using reloc allocator
[357.274755] (perf_pmu:9015) igt_dummyload-DEBUG: Test requirement passed: nengine
[357.280918] (perf_pmu:9015) DEBUG: Test requirement passed: spin
[357.281118] (perf_pmu:9015) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
[357.281319] (perf_pmu:9015) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
[357.281988] (perf_pmu:9015) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
[357.282248] (perf_pmu:9015) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
[357.282580] (perf_pmu:9015) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
[357.282942] (perf_pmu:9015) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
[357.887208] (perf_pmu:9015) INFO: 0=0
1=223315409479
2=223407947865
3=223382022604
4=223411279740
5=223113313386
[357.887257] (perf_pmu:9015) CRITICAL: Test assertion failure function most_busy_check_all, file ../tests/intel/perf_pmu.c:627:
[357.887282] (perf_pmu:9015) CRITICAL: Failed assertion: (double)(val[i]) <= (1.0 + (tolerance)) * (double)(slept) && (double)(val[i]) >= (1.0 - (tolerance)) * (double)(slept)
[357.887316] (perf_pmu:9015) CRITICAL: 'val[i]' != 'slept' (223315409479.000000 not within +5.0%/-5.0% tolerance of 500185000.000000)

[357.892303] (perf_pmu:9015) igt_core-INFO: Stack trace:
[357.907770] (perf_pmu:9015) igt_core-INFO:   #0 ../lib/igt_core.c:2074 __igt_fail_assert()
[357.910178] (perf_pmu:9015) igt_core-INFO:   #1 ../tests/intel/perf_pmu.c:630 most_busy_check_all()
[357.910208] (perf_pmu:9015) igt_core-INFO:   #2 ../tests/intel/perf_pmu.c:2383 __igt_unique____real_main2286()
[357.910223] (perf_pmu:9015) igt_core-INFO:   #3 ../tests/intel/perf_pmu.c:2286 main()
[357.915457] (perf_pmu:9015) igt_core-INFO:   #4 [__libc_init_first+0x8a]
[357.916006] (perf_pmu:9015) igt_core-INFO:   #5 [__libc_start_main+0x8b]
[357.916131] (perf_pmu:9015) igt_core-INFO:   #6 [_start+0x25]
****  END  ****
Dynamic subtest rcs0: FAIL (0.645s)
Starting dynamic subtest: bcs0
Dynamic subtest bcs0: SUCCESS (0.832s)
Starting dynamic subtest: vcs0
Dynamic subtest vcs0: SUCCESS (1.978s)
Starting dynamic subtest: vcs1
Dynamic subtest vcs1: SUCCESS (1.978s)
Starting dynamic subtest: vecs0
Dynamic subtest vecs0: SUCCESS (1.980s)
Starting dynamic subtest: ccs0
Dynamic subtest ccs0: SUCCESS (2.044s)
Subtest most-busy-idle-check-all: FAIL (9.472s)
Dmesg
<6> [402.821454] Console: switching to colour dummy device 80x25
<6> [402.821877] [IGT] perf_pmu: executing
<7> [402.832662] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [402.833788] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<6> [402.837786] [IGT] perf_pmu: starting subtest most-busy-idle-check-all
<6> [402.838179] [IGT] perf_pmu: starting dynamic subtest rcs0
<7> [402.838602] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<6> [403.483509] [IGT] perf_pmu: finished subtest rcs0, FAIL
<6> [403.484033] [IGT] perf_pmu: starting dynamic subtest bcs0
<7> [403.484119] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [403.576266] i915 0000:00:02.0: [drm:intel_tc_port_reset_mode [i915]] Port D/TC#1: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [403.640268] i915 0000:00:02.0: [drm:intel_tc_port_reset_mode [i915]] Port G/TC#4: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [403.640325] i915 0000:00:02.0: [drm:intel_tc_port_reset_mode [i915]] Port F/TC#3: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [403.641288] i915 0000:00:02.0: [drm:intel_tc_port_reset_mode [i915]] Port E/TC#2: TC port mode reset (legacy -> disconnected) pin assignment: - max lanes: 4
<7> [404.093060] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [404.317266] [IGT] perf_pmu: finished subtest bcs0, SUCCESS
<6> [404.319020] [IGT] perf_pmu: starting dynamic subtest vcs0
<7> [404.319646] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [404.927463] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [405.110390] i915 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [i915]] [ENCODER:507:DDI A/PHY A] PPS 0 turning VDD off
<7> [405.111449] i915 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [i915]] [ENCODER:507:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067
<7> [405.112117] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [405.112497] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [405.112795] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<6> [406.298764] [IGT] perf_pmu: finished subtest vcs0, SUCCESS
<6> [406.300485] [IGT] perf_pmu: starting dynamic subtest vcs1
<7> [406.301044] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [406.911440] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [408.279930] [IGT] perf_pmu: finished subtest vcs1, SUCCESS
<6> [408.281825] [IGT] perf_pmu: starting dynamic subtest vecs0
<7> [408.282439] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [408.894394] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [410.263021] [IGT] perf_pmu: finished subtest vecs0, SUCCESS
<6> [410.264743] [IGT] perf_pmu: starting dynamic subtest ccs0
<7> [410.265265] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [410.874163] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [412.309728] [IGT] perf_pmu: finished subtest ccs0, SUCCESS
<6> [412.311395] [IGT] perf_pmu: finished subtest most-busy-idle-check-all, FAIL
<7> [412.312202] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [412.313720] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [412.316054] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [412.346284] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [412.347232] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [412.359308] i915 0000:00:02.0: [drm:drm_client_dev_restore] fbdev: ret=0
<6> [412.359710] [IGT] perf_pmu: exiting, ret=98
<6> [412.370377] Console: switching to colour frame buffer device 180x56
Created at 2026-05-14 01:48:07