Results for igt@sysfs_heartbeat_interval@precise@vcs0

Result: Fail

integration-manifest git-log-oneline i915_display_info6 igt_runner6 runtimes6 results6.json results6-i915-load.json i915_display_info_post_exec6 boot6 dmesg6

DetailValue
Duration 0.77 seconds
Hostname
shard-rkl-3
Igt-Version
IGT-Version: 2.1-g93979491e (x86_64) (Linux: 6.17.0-rc7-CI_DRM_17276-g3008c5c8e2fa+ x86_64)
Out
Starting dynamic subtest: vcs0
heartbeat_interval_ms:1, elapsed=11.875ms[11]
heartbeat_interval_ms:50, elapsed=109.879ms[109]
heartbeat_interval_ms:100, elapsed=452.661ms[452]
Stack trace:
  #0 ../lib/igt_core.c:2075 __igt_fail_assert()
  #1 ../tests/intel/sysfs_heartbeat_interval.c:241 test_precise()
  #2 ../lib/i915/gem_engine_topology.c:714 dyn_sysfs_engines()
  #3 ../tests/intel/sysfs_heartbeat_interval.c:525 __igt_unique____real_main490()
  #4 ../tests/intel/sysfs_heartbeat_interval.c:490 main()
  #5 [__libc_init_first+0x8a]
  #6 [__libc_start_main+0x8b]
  #7 [_start+0x25]
Dynamic subtest vcs0: FAIL (0.770s)
Err
Starting dynamic subtest: vcs0
(sysfs_heartbeat_interval:2280) CRITICAL: Test assertion failure function test_precise, file ../tests/intel/sysfs_heartbeat_interval.c:259:
(sysfs_heartbeat_interval:2280) CRITICAL: Failed assertion: elapsed / 1000 / 1000 < 3 * delays[i] + 150
(sysfs_heartbeat_interval:2280) CRITICAL: Heartbeat interval (and CPR) exceeded request!
Dynamic subtest vcs0 failed.
**** DEBUG ****
(sysfs_heartbeat_interval:2280) i915/gem_engine_topology-DEBUG: Test requirement passed: fstatat(engine, file, &st, 0) == 0
(sysfs_heartbeat_interval:2280) DEBUG: set preempt_timeout_ms:1
(sysfs_heartbeat_interval:2280) DEBUG: Test requirement passed: igt_sysfs_printf(engine, attr, "%u", value) > 0
(sysfs_heartbeat_interval:2280) DEBUG: Initial heartbeat_interval_ms:2500
(sysfs_heartbeat_interval:2280) DEBUG: set heartbeat_interval_ms:1
(sysfs_heartbeat_interval:2280) DEBUG: Test requirement passed: igt_sysfs_printf(engine, attr, "%u", value) > 0
(sysfs_heartbeat_interval:2280) intel_allocator_reloc-DEBUG: Using reloc allocator
(sysfs_heartbeat_interval:2280) igt_dummyload-DEBUG: Test requirement passed: gem_class_can_store_dword(fd, class)
(sysfs_heartbeat_interval:2280) igt_dummyload-DEBUG: Test requirement passed: nengine
(sysfs_heartbeat_interval:2280) intel_allocator_reloc-DEBUG: Using reloc allocator
(sysfs_heartbeat_interval:2280) igt_dummyload-DEBUG: Test requirement passed: gem_class_can_store_dword(fd, class)
(sysfs_heartbeat_interval:2280) igt_dummyload-DEBUG: Test requirement passed: nengine
(sysfs_heartbeat_interval:2280) INFO: heartbeat_interval_ms:1, elapsed=11.875ms[11]
(sysfs_heartbeat_interval:2280) DEBUG: set heartbeat_interval_ms:50
(sysfs_heartbeat_interval:2280) DEBUG: Test requirement passed: igt_sysfs_printf(engine, attr, "%u", value) > 0
(sysfs_heartbeat_interval:2280) intel_allocator_reloc-DEBUG: Using reloc allocator
(sysfs_heartbeat_interval:2280) igt_dummyload-DEBUG: Test requirement passed: gem_class_can_store_dword(fd, class)
(sysfs_heartbeat_interval:2280) igt_dummyload-DEBUG: Test requirement passed: nengine
(sysfs_heartbeat_interval:2280) intel_allocator_reloc-DEBUG: Using reloc allocator
(sysfs_heartbeat_interval:2280) igt_dummyload-DEBUG: Test requirement passed: gem_class_can_store_dword(fd, class)
(sysfs_heartbeat_interval:2280) igt_dummyload-DEBUG: Test requirement passed: nengine
(sysfs_heartbeat_interval:2280) INFO: heartbeat_interval_ms:50, elapsed=109.879ms[109]
(sysfs_heartbeat_interval:2280) DEBUG: set heartbeat_interval_ms:100
(sysfs_heartbeat_interval:2280) DEBUG: Test requirement passed: igt_sysfs_printf(engine, attr, "%u", value) > 0
(sysfs_heartbeat_interval:2280) intel_allocator_reloc-DEBUG: Using reloc allocator
(sysfs_heartbeat_interval:2280) igt_dummyload-DEBUG: Test requirement passed: gem_class_can_store_dword(fd, class)
(sysfs_heartbeat_interval:2280) igt_dummyload-DEBUG: Test requirement passed: nengine
(sysfs_heartbeat_interval:2280) intel_allocator_reloc-DEBUG: Using reloc allocator
(sysfs_heartbeat_interval:2280) igt_dummyload-DEBUG: Test requirement passed: gem_class_can_store_dword(fd, class)
(sysfs_heartbeat_interval:2280) igt_dummyload-DEBUG: Test requirement passed: nengine
(sysfs_heartbeat_interval:2280) INFO: heartbeat_interval_ms:100, elapsed=452.661ms[452]
(sysfs_heartbeat_interval:2280) CRITICAL: Test assertion failure function test_precise, file ../tests/intel/sysfs_heartbeat_interval.c:259:
(sysfs_heartbeat_interval:2280) CRITICAL: Failed assertion: elapsed / 1000 / 1000 < 3 * delays[i] + 150
(sysfs_heartbeat_interval:2280) CRITICAL: Heartbeat interval (and CPR) exceeded request!
(sysfs_heartbeat_interval:2280) igt_core-INFO: Stack trace:
(sysfs_heartbeat_interval:2280) igt_core-INFO:   #0 ../lib/igt_core.c:2075 __igt_fail_assert()
(sysfs_heartbeat_interval:2280) igt_core-INFO:   #1 ../tests/intel/sysfs_heartbeat_interval.c:241 test_precise()
(sysfs_heartbeat_interval:2280) igt_core-INFO:   #2 ../lib/i915/gem_engine_topology.c:714 dyn_sysfs_engines()
(sysfs_heartbeat_interval:2280) igt_core-INFO:   #3 ../tests/intel/sysfs_heartbeat_interval.c:525 __igt_unique____real_main490()
(sysfs_heartbeat_interval:2280) igt_core-INFO:   #4 ../tests/intel/sysfs_heartbeat_interval.c:490 main()
(sysfs_heartbeat_interval:2280) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(sysfs_heartbeat_interval:2280) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(sysfs_heartbeat_interval:2280) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest vcs0: FAIL (0.770s)
Dmesg
<6> [238.238452] [IGT] sysfs_heartbeat_interval: starting dynamic subtest vcs0
<7> [238.239348] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<5> [238.240426] i915 0000:00:02.0: [drm] vcs0 heartbeat interval adjusted to a non-default value which may cause engine resets to target innocent contexts!
<7> [238.241471] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508
<7> [238.243688] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508
<5> [238.255478] i915 0000:00:02.0: [drm] Resetting vcs0 for preemption time out
<6> [238.256294] i915 0000:00:02.0: [drm] GPU HANG: ecode 12:4:277ffefe, in sysfs_heartbeat [2280]
<7> [238.256554] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [238.309961] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508
<7> [238.314017] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508
<5> [238.423906] i915 0000:00:02.0: [drm] Resetting vcs0 for preemption time out
<6> [238.424625] i915 0000:00:02.0: [drm] GPU HANG: ecode 12:4:277ffefe, in sysfs_heartbeat [2280]
<7> [238.424889] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [238.474767] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508
<7> [238.480823] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:508
<5> [238.933997] i915 0000:00:02.0: [drm] Resetting vcs0 for preemption time out
<6> [238.936116] i915 0000:00:02.0: [drm] GPU HANG: ecode 12:4:277ffefe, in sysfs_heartbeat [2280]
<7> [238.936459] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [239.009096] [IGT] sysfs_heartbeat_interval: finished subtest vcs0, FAIL
Created at 2025-09-26 18:55:29