Results for igt@gem_exec_fair@basic-pace-solo

Machine description: shard-rkl-7

Result: Fail

integration-manifest git-log-oneline i915_display_info7 igt_runner7 run7 runtimes7 results7.json i915_display_info_post_exec7 boot7 dmesg7

DetailValue
Duration 5.48 seconds
Hostname 
shard-rkl-7
Igt-Version 
IGT-Version: 1.29-NO-GIT (x86_64) (Linux: 6.12.0-rc6-CI_DRM_15651-gfce38995f74a+ x86_64)
Out 
Using IGT_SRANDOM=1731000136 for randomisation
Opened device: /dev/dri/card0
Running on rocketlake
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: 12000000
Starting subtest: basic-pace-solo
Starting dynamic subtest: rcs0
Interval 16.73ms, range 0.00ms
  3 clients, range: [17.6, 17.6], iqr: [17.6, 17.6], median: 17.6 [0.0, 0.7], mean: 17.6 ± 0.00 ms, cpu: 8%
  7 clients, range: [14.4, 14.4], iqr: [14.4, 14.4], median: 14.4 [7.9, 9.9], mean: 14.4 ± 0.00 ms, cpu: 18%
 15 clients, range: [16.2, 26.6], iqr: [20.1, 25.6], median: 21.0 [17.3, 25.2], mean: 21.9 ± 3.25 ms, cpu: 38%
 31 clients, range: [1.2, 35.6], iqr: [3.0, 6.0], median: 5.3 [26.5, 32.5], mean: 6.0 ± 6.03 ms, cpu: 68%
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.478s)
Subtest basic-pace-solo: FAIL (5.479s)
Err 
Starting subtest: basic-pace-solo
Starting dynamic subtest: rcs0
(gem_exec_fair:1632) CRITICAL: Test assertion failure function fairness, file ../tests/intel/gem_exec_fair.c:958:
(gem_exec_fair:1632) CRITICAL: Failed assertion: iqr[nchild / 2] < result[nchild / 2]
(gem_exec_fair:1632) CRITICAL: Child frame IQR 28.91ms exceeded median threshold 5.32ms
Dynamic subtest rcs0 failed.
**** DEBUG ****
(gem_exec_fair:1632) DEBUG: Test requirement passed: has_ctx_timestamp(i915, cfg, e)
(gem_exec_fair:1632) DEBUG: Test requirement passed: gem_class_has_mutable_submission(i915, e->class)
(gem_exec_fair:1632) DEBUG: CPU usage: 3%
(gem_exec_fair:1632) INFO: Interval 16.73ms, range 0.00ms
(gem_exec_fair:1632) DEBUG: CPU usage: 8%
(gem_exec_fair:1632) INFO:   3 clients, range: [17.6, 17.6], iqr: [17.6, 17.6], median: 17.6 [0.0, 0.7], mean: 17.6 ± 0.00 ms, cpu: 8%
(gem_exec_fair:1632) DEBUG: CPU usage: 18%
(gem_exec_fair:1632) INFO:   7 clients, range: [14.4, 14.4], iqr: [14.4, 14.4], median: 14.4 [7.9, 9.9], mean: 14.4 ± 0.00 ms, cpu: 18%
(gem_exec_fair:1632) DEBUG: CPU usage: 38%
(gem_exec_fair:1632) INFO:  15 clients, range: [16.2, 26.6], iqr: [20.1, 25.6], median: 21.0 [17.3, 25.2], mean: 21.9 ± 3.25 ms, cpu: 38%
(gem_exec_fair:1632) DEBUG: CPU usage: 68%
(gem_exec_fair:1632) INFO:  31 clients, range: [1.2, 35.6], iqr: [3.0, 6.0], median: 5.3 [26.5, 32.5], mean: 6.0 ± 6.03 ms, cpu: 68%
(gem_exec_fair:1632) CRITICAL: Test assertion failure function fairness, file ../tests/intel/gem_exec_fair.c:958:
(gem_exec_fair:1632) CRITICAL: Failed assertion: iqr[nchild / 2] < result[nchild / 2]
(gem_exec_fair:1632) CRITICAL: Child frame IQR 28.91ms exceeded median threshold 5.32ms
(gem_exec_fair:1632) igt_core-INFO: Stack trace:
(gem_exec_fair:1632) igt_core-INFO:   #0 ../lib/igt_core.c:2051 __igt_fail_assert()
(gem_exec_fair:1632) igt_core-INFO:   #1 ../tests/intel/gem_exec_fair.c:963 fairness()
(gem_exec_fair:1632) igt_core-INFO:   #2 ../tests/intel/gem_exec_fair.c:1423 __igt_unique____real_main1292()
(gem_exec_fair:1632) igt_core-INFO:   #3 ../tests/intel/gem_exec_fair.c:1292 main()
(gem_exec_fair:1632) igt_core-INFO:   #4 [__libc_init_first+0x8a]
(gem_exec_fair:1632) igt_core-INFO:   #5 [__libc_start_main+0x8b]
(gem_exec_fair:1632) igt_core-INFO:   #6 [_start+0x25]
****  END  ****
Dynamic subtest rcs0: FAIL (5.478s)
Subtest basic-pace-solo: FAIL (5.479s)
Dmesg
<6> [178.813981] Console: switching to colour dummy device 80x25
<6> [178.814235] [IGT] gem_exec_fair: executing
<7> [178.818082] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [178.818649] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [178.818838] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [178.819358] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<6> [178.823939] [IGT] gem_exec_fair: starting subtest basic-pace-solo
<6> [178.824074] [IGT] gem_exec_fair: starting dynamic subtest rcs0
<7> [178.824564] [drm:i915_gem_do_execbuffer [i915]] EINVAL at eb_validate_vma:509
<6> [181.079464] pcieport 0000:00:1b.0: AER: Correctable error message received from 0000:01:00.0
<4> [181.079514] nvme 0000:01:00.0: PCIe Bus Error: severity=Correctable, type=Physical Layer, (Receiver ID)
<4> [181.079520] nvme 0000:01:00.0: device [15b7:5006] error status/mask=00000001/0000e000
<4> [181.079527] nvme 0000:01:00.0: [ 0] RxErr
<6> [184.302548] [IGT] gem_exec_fair: finished subtest rcs0, FAIL
<6> [184.302751] [IGT] gem_exec_fair: finished subtest basic-pace-solo, FAIL
<6> [184.411197] [IGT] gem_exec_fair: exiting, ret=98
<7> [184.411677] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [184.413330] i915 0000:00:02.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [184.413899] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 02 to 00
<7> [184.432775] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0
<6> [184.452028] Console: switching to colour frame buffer device 240x67
Created at 2024-11-07 18:12:06