Results for igt@gem_exec_fair@basic-pace@rcs0

Machine description: shard-tglu-9

Result: Fail

git-log-oneline i915_display_info9 igt_runner9 run9 runtimes9 results9.json i915_display_info_post_exec9 boot9 dmesg9

DetailValue
Duration 5.54 seconds
Hostname 
shard-tglu-9
Igt-Version 
IGT-Version: 1.29-NO-GIT (x86_64) (Linux: 6.12.0-rc3-CI_DRM_15540-g12e4970af1ec+ x86_64)
Out 
Using IGT_SRANDOM=1729082284 for randomisation
Opened device: /dev/dri/card0
Running on tigerlake
Using Execlists submission
Has kernel scheduler
 - With priority sorting
 - With preemption enabled
 - With HW semaphores enabled
 - With engine busy statistics
 - With timeslicing enabled
CS timestamp frequency: 19200000
Starting subtest: basic-pace
Starting dynamic subtest: rcs0
Interval 16.77ms, range 0.01ms
  3 clients, range: [17.6, 17.6], iqr: [17.6, 17.6], median: 17.6 [1.9, 2.0], mean: 17.6 ± 0.01 ms, cpu: 10%
  7 clients, range: [14.4, 20.4], iqr: [14.5, 18.4], median: 14.5 [9.9, 10.1], mean: 15.9 ± 2.29 ms, cpu: 25%
 15 clients, range: [7.1, 29.9], iqr: [19.8, 28.4], median: 23.6 [13.6, 28.2], mean: 23.0 ± 6.65 ms, cpu: 37%
 31 clients, range: [1.3, 34.2], iqr: [3.5, 7.9], median: 4.5 [28.3, 33.2], mean: 8.0 ± 9.23 ms, cpu: 56%
Stack trace:
  #0 ../lib/igt_core.c:2051 __igt_fail_assert()
  #1 ../tests/intel/gem_exec_fair.c:963 fairness()
  #2 ../tests/intel/gem_exec_fair.c:1423 __igt_unique____real_main1292()
  #3 ../tests/intel/gem_exec_fair.c:1292 main()
  #4 [__libc_init_first+0x8a]
  #5 [__libc_start_main+0x8b]
  #6 [_start+0x25]
Dynamic subtest rcs0: FAIL (5.540s)
Err 
Starting subtest: basic-pace
Starting dynamic subtest: rcs0
(gem_exec_fair:1458) CRITICAL: Test assertion failure function fairness, file ../tests/intel/gem_exec_fair.c:958:
(gem_exec_fair:1458) CRITICAL: Failed assertion: iqr[nchild / 2] < result[nchild / 2]
(gem_exec_fair:1458) CRITICAL: Child frame IQR 30.69ms exceeded median threshold 4.51ms
Dynamic subtest rcs0 failed.
**** DEBUG ****
(gem_exec_fair:1458) DEBUG: Test requirement passed: has_ctx_timestamp(i915, cfg, e)
(gem_exec_fair:1458) DEBUG: Test requirement passed: gem_class_has_mutable_submission(i915, e->class)
(gem_exec_fair:1458) DEBUG: CPU usage: 4%
(gem_exec_fair:1458) INFO: Interval 16.77ms, range 0.01ms
(gem_exec_fair:1458) DEBUG: CPU usage: 10%
(gem_exec_fair:1458) INFO:   3 clients, range: [17.6, 17.6], iqr: [17.6, 17.6], median: 17.6 [1.9, 2.0], mean: 17.6 ± 0.01 ms, cpu: 10%
(gem_exec_fair:1458) DEBUG: CPU usage: 25%
(gem_exec_fair:1458) INFO:   7 clients, range: [14.4, 20.4], iqr: [14.5, 18.4], median: 14.5 [9.9, 10.1], mean: 15.9 ± 2.29 ms, cpu: 25%
(gem_exec_fair:1458) DEBUG: CPU usage: 37%
(gem_exec_fair:1458) INFO:  15 clients, range: [7.1, 29.9], iqr: [19.8, 28.4], median: 23.6 [13.6, 28.2], mean: 23.0 ± 6.65 ms, cpu: 37%
(gem_exec_fair:1458) DEBUG: CPU usage: 56%
(gem_exec_fair:1458) INFO:  31 clients, range: [1.3, 34.2], iqr: [3.5, 7.9], median: 4.5 [28.3, 33.2], mean: 8.0 ± 9.23 ms, cpu: 56%
(gem_exec_fair:1458) CRITICAL: Test assertion failure function fairness, file ../tests/intel/gem_exec_fair.c:958:
(gem_exec_fair:1458) CRITICAL: Failed assertion: iqr[nchild / 2] < result[nchild / 2]
(gem_exec_fair:1458) CRITICAL: Child frame IQR 30.69ms exceeded median threshold 4.51ms
(gem_exec_fair:1458) igt_core-INFO: Stack trace:
(gem_exec_fair:1458) igt_core-INFO:   #0 ../lib/igt_core.c:2051 __igt_fail_assert()
(gem_exec_fair:1458) igt_core-INFO:   #1 ../tests/intel/gem_exec_fair.c:963 fairness()
(gem_exec_fair:1458) igt_core-INFO:   #2 ../tests/intel/gem_exec_fair.c:1423 __igt_unique____real_main1292()
(gem_exec_fair:1458) igt_core-INFO:   #3 ../tests/intel/gem_exec_fair.c:1292 main()
(gem_exec_fair:1458) igt_core-INFO:   #4 [__libc_init_first+0x8a]
(gem_exec_fair:1458) igt_core-INFO:   #5 [__libc_start_main+0x8b]
(gem_exec_fair:1458) igt_core-INFO:   #6 [_start+0x25]
****  END  ****
Dynamic subtest rcs0: FAIL (5.540s)
Dmesg
<6> [229.992437] Console: switching to colour dummy device 80x25
<6> [229.992675] [IGT] gem_exec_fair: executing
<7> [229.995353] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [229.995939] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [229.996111] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [229.996650] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<6> [230.001979] [IGT] gem_exec_fair: starting subtest basic-pace
<6> [230.002269] [IGT] gem_exec_fair: starting dynamic subtest rcs0
<7> [230.855287] i915 0000:00:02.0: [drm:intel_tc_port_update_mode [i915]] Port G/TC#4: TC port mode reset (tbt-alt -> disconnected)
<7> [230.855348] i915 0000:00:02.0: [drm:intel_tc_port_update_mode [i915]] Port F/TC#3: TC port mode reset (tbt-alt -> disconnected)
<7> [230.855403] i915 0000:00:02.0: [drm:intel_tc_port_update_mode [i915]] Port E/TC#2: TC port mode reset (tbt-alt -> disconnected)
<7> [230.855423] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling TC_cold_off
<7> [230.855896] i915 0000:00:02.0: [drm:__intel_display_power_put_domain [i915]] TC cold unblock succeeded
<7> [230.856262] i915 0000:00:02.0: [drm:intel_tc_port_update_mode [i915]] Port D/TC#1: TC port mode reset (legacy -> disconnected)
<6> [235.542862] [IGT] gem_exec_fair: finished subtest rcs0, FAIL
Created at 2024-10-16 14:16:44