Results for igt@perf_pmu@busy-accuracy-98

Machine description: shard-tglu-4

Result: Fail

git-log-oneline i915_display_info3 igt_runner3 runtimes3 results3.json results3-i915-load.json i915_display_info_post_exec3 boot3 dmesg3

DetailValue
Duration 15.34 seconds
Hostname
shard-tglu-4
Igt-Version
IGT-Version: 1.30-gb4da30722 (x86_64) (Linux: 6.14.0-rc4-CI_DRM_16205-gca9d01b66c70+ x86_64)
Out
Using IGT_SRANDOM=1740822415 for randomisation
Opened device: /dev/dri/card0
Starting subtest: busy-accuracy-98
Starting dynamic subtest: rcs0
calibration=1000ms, test=2000ms, cycle=200ms; ratio=98.00% (196000us/4000us)
0: 5 cycles, busy 980488us, idle 22161us -> 97.79% (target: 98%; average=97.82±0.049%)
1: 10 cycles, busy 1979814us, idle 44215us -> 97.82% (target: 98%; average=97.79±0.010%)
error=-0.80% (97.01% vs 97.82%)
Dynamic subtest rcs0: SUCCESS (3.044s)
Starting dynamic subtest: bcs0
calibration=1000ms, test=2000ms, cycle=200ms; ratio=98.00% (196000us/4000us)
0: 5 cycles, busy 1009461us, idle 22710us -> 97.80% (target: 98%; average=97.82±0.021%)
1: 10 cycles, busy 2008324us, idle 44819us -> 97.82% (target: 98%; average=97.81±0.005%)
error=-2.19% (95.63% vs 97.82%)
Stack trace:
  #0 ../lib/igt_core.c:2055 __igt_fail_assert()
  #1 ../tests/intel/perf_pmu.c:2303 __igt_unique____real_main2285()
  #2 ../tests/intel/perf_pmu.c:2285 main()
  #3 [__libc_init_first+0x8a]
  #4 [__libc_start_main+0x8b]
  #5 [_start+0x25]
Dynamic subtest bcs0: FAIL (3.118s)
Starting dynamic subtest: vcs0
calibration=1000ms, test=2000ms, cycle=200ms; ratio=98.00% (196000us/4000us)
0: 5 cycles, busy 999571us, idle 22474us -> 97.80% (target: 98%; average=97.83±0.032%)
1: 10 cycles, busy 1992259us, idle 44565us -> 97.81% (target: 98%; average=97.80±0.006%)
error=-1.40% (96.41% vs 97.81%)
Dynamic subtest vcs0: SUCCESS (3.075s)
Starting dynamic subtest: vcs1
calibration=1000ms, test=2000ms, cycle=200ms; ratio=98.00% (196000us/4000us)
0: 5 cycles, busy 993208us, idle 21991us -> 97.83% (target: 98%; average=97.84±0.022%)
1: 10 cycles, busy 1981706us, idle 44296us -> 97.81% (target: 98%; average=97.82±0.004%)
error=-0.90% (96.92% vs 97.81%)
Dynamic subtest vcs1: SUCCESS (3.056s)
Starting dynamic subtest: vecs0
calibration=1000ms, test=2000ms, cycle=200ms; ratio=98.00% (196000us/4000us)
0: 5 cycles, busy 988870us, idle 21836us -> 97.84% (target: 98%; average=97.85±0.010%)
1: 10 cycles, busy 1974946us, idle 44312us -> 97.81% (target: 98%; average=97.82±0.003%)
error=-0.55% (97.25% vs 97.81%)
Dynamic subtest vecs0: SUCCESS (3.047s)
Subtest busy-accuracy-98: FAIL (15.341s)
Opened device: /dev/dri/renderD128
Err
Starting subtest: busy-accuracy-98
Starting dynamic subtest: rcs0
Dynamic subtest rcs0: SUCCESS (3.044s)
Starting dynamic subtest: bcs0
(perf_pmu:2009) CRITICAL: Test assertion failure function accuracy, file ../tests/intel/perf_pmu.c:2073:
(perf_pmu:2009) CRITICAL: Failed assertion: (double)(100.0 * busy_r) <= ((double)(100.0 * expected) + (2)) && (double)(100.0 * busy_r) >= ((double)(100.0 * expected) - (2))
(perf_pmu:2009) CRITICAL: 95.631103 not within +2.000000/-2.000000 of 97.817027! ('100.0 * busy_r' vs '100.0 * expected')
Dynamic subtest bcs0 failed.
**** DEBUG ****
(perf_pmu:2009) DEBUG: Test requirement passed: gem_scheduler_has_engine_busy_stats(gem_fd)
(perf_pmu:2009) INFO: calibration=1000ms, test=2000ms, cycle=200ms; ratio=98.00% (196000us/4000us)
(perf_pmu:2009) DEBUG: Test requirement passed: !(fd < 0 && errno == ENODEV)
(perf_pmu:2009) INFO: error=-2.19% (95.63% vs 97.82%)
(perf_pmu:2009) CRITICAL: Test assertion failure function accuracy, file ../tests/intel/perf_pmu.c:2073:
(perf_pmu:2009) CRITICAL: Failed assertion: (double)(100.0 * busy_r) <= ((double)(100.0 * expected) + (2)) && (double)(100.0 * busy_r) >= ((double)(100.0 * expected) - (2))
(perf_pmu:2009) CRITICAL: 95.631103 not within +2.000000/-2.000000 of 97.817027! ('100.0 * busy_r' vs '100.0 * expected')
(perf_pmu:2009) igt_core-INFO: Stack trace:
(perf_pmu:2009) igt_core-INFO:   #0 ../lib/igt_core.c:2055 __igt_fail_assert()
(perf_pmu:2009) igt_core-INFO:   #1 ../tests/intel/perf_pmu.c:2303 __igt_unique____real_main2285()
(perf_pmu:2009) igt_core-INFO:   #2 ../tests/intel/perf_pmu.c:2285 main()
(perf_pmu:2009) igt_core-INFO:   #3 [__libc_init_first+0x8a]
(perf_pmu:2009) igt_core-INFO:   #4 [__libc_start_main+0x8b]
(perf_pmu:2009) igt_core-INFO:   #5 [_start+0x25]
****  END  ****
Dynamic subtest bcs0: FAIL (3.118s)
Starting dynamic subtest: vcs0
Dynamic subtest vcs0: SUCCESS (3.075s)
Starting dynamic subtest: vcs1
Dynamic subtest vcs1: SUCCESS (3.056s)
Starting dynamic subtest: vecs0
Dynamic subtest vecs0: SUCCESS (3.047s)
Subtest busy-accuracy-98: FAIL (15.341s)
Dmesg
<6> [49.442704] Console: switching to colour dummy device 80x25
<6> [49.442761] [IGT] perf_pmu: executing
<7> [49.445045] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [49.445567] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<6> [49.449947] [IGT] perf_pmu: starting subtest busy-accuracy-98
<6> [49.450035] [IGT] perf_pmu: starting dynamic subtest rcs0
<7> [50.318922] i915 0000:00:02.0: [drm:intel_tc_port_reset_mode [i915]] Port G/TC#4: TC port mode reset (tbt-alt -> disconnected)
<7> [50.318971] i915 0000:00:02.0: [drm:intel_tc_port_reset_mode [i915]] Port F/TC#3: TC port mode reset (tbt-alt -> disconnected)
<7> [50.319031] i915 0000:00:02.0: [drm:intel_tc_port_reset_mode [i915]] Port E/TC#2: TC port mode reset (tbt-alt -> disconnected)
<7> [50.319036] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling TC_cold_off
<7> [50.319510] i915 0000:00:02.0: [drm:tgl_tc_cold_request.isra.0 [i915]] TC cold unblock succeeded
<7> [50.319861] i915 0000:00:02.0: [drm:intel_tc_port_reset_mode [i915]] Port D/TC#1: TC port mode reset (legacy -> disconnected)
<6> [52.493640] [IGT] perf_pmu: finished subtest rcs0, SUCCESS
<6> [52.493729] [IGT] perf_pmu: starting dynamic subtest bcs0
<6> [55.611989] [IGT] perf_pmu: finished subtest bcs0, FAIL
<6> [55.612073] [IGT] perf_pmu: starting dynamic subtest vcs0
<6> [58.687319] [IGT] perf_pmu: finished subtest vcs0, SUCCESS
<6> [58.687405] [IGT] perf_pmu: starting dynamic subtest vcs1
<6> [61.743889] [IGT] perf_pmu: finished subtest vcs1, SUCCESS
<6> [61.743984] [IGT] perf_pmu: starting dynamic subtest vecs0
<6> [64.790576] [IGT] perf_pmu: finished subtest vecs0, SUCCESS
<6> [64.790691] [IGT] perf_pmu: finished subtest busy-accuracy-98, FAIL
<7> [64.790763] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [64.791236] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [64.793270] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [64.825146] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0
<6> [64.825322] [IGT] perf_pmu: exiting, ret=98
<6> [64.834251] Console: switching to colour frame buffer device 240x67
Created at 2025-03-01 11:09:16