Results for igt@gem_ctx_freq@sysfs

Machine description: shard-dg2-4

Result: Fail

git-log-oneline i915_display_info4 igt_runner4 runtimes4 results4.json results4-i915-load.json i915_display_info_post_exec4 boot4 dmesg4

DetailValue
Duration 3.25 seconds
Hostname 
shard-dg2-4
Igt-Version 
IGT-Version: 2.0-gb00cc8ff9 (x86_64) (Linux: 6.14.0-rc6-CI_DRM_16293-ga958e31a81b3+ x86_64)
Out 
Using IGT_SRANDOM=1742371445 for randomisation
Opened device: /dev/dri/card0
Starting subtest: sysfs
Starting dynamic subtest: gt0
System min freq: 300MHz; max freq: 2100MHz
sysfs: Measured 299.5MHz, expected 300Mhz
sysfs: Measured 489.2MHz, expected 480Mhz
sysfs: Measured 659.2MHz, expected 660Mhz
sysfs: Measured 848.5MHz, expected 840Mhz
sysfs: Measured 1038.5MHz, expected 1020Mhz
sysfs: Measured 1197.8MHz, expected 1200Mhz
sysfs: Measured 1377.8MHz, expected 1380Mhz
sysfs: Measured 1567.8MHz, expected 1560Mhz
sysfs: Measured 1834.7MHz, expected 1740Mhz
sysfs: Measured 1927.3MHz, expected 1920Mhz
sysfs: Measured 2097.4MHz, expected 2100Mhz
sysfs: Measured 2024.2MHz, expected 1920Mhz
Stack trace:
  #0 ../lib/igt_core.c:2055 __igt_fail_assert()
  #1 ../tests/intel/gem_ctx_freq.c:92 __igt_unique____real_main244()
  #2 ../tests/intel/gem_ctx_freq.c:244 main()
  #3 [__libc_init_first+0x8a]
  #4 [__libc_start_main+0x8b]
  #5 [_start+0x25]
Dynamic subtest gt0: FAIL (3.253s)
Subtest sysfs: FAIL (3.255s)
Err 
Starting subtest: sysfs
Starting dynamic subtest: gt0
(gem_ctx_freq:2078) CRITICAL: Test assertion failure function pmu_assert, file ../tests/intel/gem_ctx_freq.c:92:
(gem_ctx_freq:2078) CRITICAL: Failed assertion: __pmu_within_tolerance(actual, target)
(gem_ctx_freq:2078) CRITICAL: Measured frequency 2024.21MHz, is beyond target 1920±100Mhz
Dynamic subtest gt0 failed.
**** DEBUG ****
(gem_ctx_freq:2078) intel_allocator_reloc-DEBUG: Using reloc allocator
(gem_ctx_freq:2078) igt_pm-DEBUG: Test requirement passed: dir
(gem_ctx_freq:2078) igt_pm-DEBUG: Test requirement passed: igt_sysfs_has_attr(gtfd, "slpc_ignore_eff_freq")
(gem_ctx_freq:2078) DEBUG: Test requirement passed: get_sysfs_freq(dirfd, &sys_min, &sys_max)
(gem_ctx_freq:2078) INFO: System min freq: 300MHz; max freq: 2100MHz
(gem_ctx_freq:2078) i915/gem_engine_topology-DEBUG: Test requirement passed: intel_graphics_ver(devid) <= IP_VER(12, 70)
(gem_ctx_freq:2078) i915/gem_engine_topology-DEBUG: Test requirement passed: intel_graphics_ver(devid) <= IP_VER(12, 70)
(gem_ctx_freq:2078) i915/gem_engine_topology-DEBUG: Test requirement passed: intel_graphics_ver(devid) <= IP_VER(12, 70)
(gem_ctx_freq:2078) i915/gem_engine_topology-DEBUG: Test requirement passed: intel_graphics_ver(devid) <= IP_VER(12, 70)
(gem_ctx_freq:2078) i915/gem_engine_topology-DEBUG: Test requirement passed: intel_graphics_ver(devid) <= IP_VER(12, 70)
(gem_ctx_freq:2078) i915/gem_engine_topology-DEBUG: Test requirement passed: intel_graphics_ver(devid) <= IP_VER(12, 70)
(gem_ctx_freq:2078) i915/gem_engine_topology-DEBUG: Test requirement passed: intel_graphics_ver(devid) <= IP_VER(12, 70)
(gem_ctx_freq:2078) DEBUG: Test requirement passed: ci
(gem_ctx_freq:2078) DEBUG: Test requirement passed: pmu >= 0
(gem_ctx_freq:2078) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2078) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 32
Frequency requested 0, actual 300
  min hard:0, soft:0; max soft:0, hard:0
  idle:0, efficient:0, boost:0
Wait boosts: 0
(gem_ctx_freq:2078) INFO: sysfs: Measured 299.5MHz, expected 300Mhz
(gem_ctx_freq:2078) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2078) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 32
Frequency requested 0, actual 500
  min hard:0, soft:0; max soft:0, hard:0
  idle:0, efficient:0, boost:0
Wait boosts: 0
(gem_ctx_freq:2078) INFO: sysfs: Measured 489.2MHz, expected 480Mhz
(gem_ctx_freq:2078) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2078) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 32
Frequency requested 0, actual 700
  min hard:0, soft:0; max soft:0, hard:0
  idle:0, efficient:0, boost:0
Wait boosts: 0
(gem_ctx_freq:2078) INFO: sysfs: Measured 659.2MHz, expected 660Mhz
(gem_ctx_freq:2078) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2078) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 32
Frequency requested 0, actual 850
  min hard:0, soft:0; max soft:0, hard:0
  idle:0, efficient:0, boost:0
Wait boosts: 0
(gem_ctx_freq:2078) INFO: sysfs: Measured 848.5MHz, expected 840Mhz
(gem_ctx_freq:2078) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2078) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 32
Frequency requested 0, actual 1050
  min hard:0, soft:0; max soft:0, hard:0
  idle:0, efficient:0, boost:0
Wait boosts: 0
(gem_ctx_freq:2078) INFO: sysfs: Measured 1038.5MHz, expected 1020Mhz
(gem_ctx_freq:2078) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2078) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 32
Frequency requested 0, actual 1200
  min hard:0, soft:0; max soft:0, hard:0
  idle:0, efficient:0, boost:0
Wait boosts: 0
(gem_ctx_freq:2078) INFO: sysfs: Measured 1197.8MHz, expected 1200Mhz
(gem_ctx_freq:2078) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2078) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 32
Frequency requested 0, actual 1400
  min hard:0, soft:0; max soft:0, hard:0
  idle:0, efficient:0, boost:0
Wait boosts: 0
(gem_ctx_freq:2078) INFO: sysfs: Measured 1377.8MHz, expected 1380Mhz
(gem_ctx_freq:2078) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2078) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 32
Frequency requested 0, actual 1600
  min hard:0, soft:0; max soft:0, hard:0
  idle:0, efficient:0, boost:0
Wait boosts: 0
(gem_ctx_freq:2078) INFO: sysfs: Measured 1567.8MHz, expected 1560Mhz
(gem_ctx_freq:2078) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2078) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 32
Frequency requested 0, actual 1750
  min hard:0, soft:0; max soft:0, hard:0
  idle:0, efficient:0, boost:0
Wait boosts: 0
(gem_ctx_freq:2078) INFO: sysfs: Measured 1834.7MHz, expected 1740Mhz
(gem_ctx_freq:2078) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2078) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 32
Frequency requested 0, actual 1950
  min hard:0, soft:0; max soft:0, hard:0
  idle:0, efficient:0, boost:0
Wait boosts: 0
(gem_ctx_freq:2078) INFO: sysfs: Measured 1927.3MHz, expected 1920Mhz
(gem_ctx_freq:2078) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2078) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 32
Frequency requested 0, actual 2100
  min hard:0, soft:0; max soft:0, hard:0
  idle:0, efficient:0, boost:0
Wait boosts: 0
(gem_ctx_freq:2078) INFO: sysfs: Measured 2097.4MHz, expected 2100Mhz
(gem_ctx_freq:2078) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2078) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 32
Frequency requested 0, actual 1950
  min hard:0, soft:0; max soft:0, hard:0
  idle:0, efficient:0, boost:0
Wait boosts: 0
(gem_ctx_freq:2078) INFO: sysfs: Measured 2024.2MHz, expected 1920Mhz
(gem_ctx_freq:2078) CRITICAL: Test assertion failure function pmu_assert, file ../tests/intel/gem_ctx_freq.c:92:
(gem_ctx_freq:2078) CRITICAL: Failed assertion: __pmu_within_tolerance(actual, target)
(gem_ctx_freq:2078) CRITICAL: Measured frequency 2024.21MHz, is beyond target 1920±100Mhz
(gem_ctx_freq:2078) igt_core-INFO: Stack trace:
(gem_ctx_freq:2078) igt_core-INFO:   #0 ../lib/igt_core.c:2055 __igt_fail_assert()
(gem_ctx_freq:2078) igt_core-INFO:   #1 ../tests/intel/gem_ctx_freq.c:92 __igt_unique____real_main244()
(gem_ctx_freq:2078) igt_core-INFO:   #2 ../tests/intel/gem_ctx_freq.c:244 main()
(gem_ctx_freq:2078) igt_core-INFO:   #3 [__libc_init_first+0x8a]
(gem_ctx_freq:2078) igt_core-INFO:   #4 [__libc_start_main+0x8b]
(gem_ctx_freq:2078) igt_core-INFO:   #5 [_start+0x25]
****  END  ****
Dynamic subtest gt0: FAIL (3.253s)
Subtest sysfs: FAIL (3.255s)
Dmesg
<6> [239.720601] Console: switching to colour dummy device 80x25
<6> [239.721292] [IGT] gem_ctx_freq: executing
<7> [239.747791] i915 0000:03:00.0: [drm:i915_gem_open [i915]]
<7> [239.749794] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [239.761692] i915 0000:03:00.0: [drm:i915_gem_open [i915]]
<7> [239.763328] i915 0000:03:00.0: [drm:i915_gem_open [i915]]
<6> [239.772959] [IGT] gem_ctx_freq: starting subtest sysfs
<6> [239.773707] [IGT] gem_ctx_freq: starting dynamic subtest gt0
<7> [239.774147] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [239.800329] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [240.076207] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [240.340702] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [240.605968] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [240.872362] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [241.139192] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [241.406365] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [241.671291] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [241.936057] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [242.201297] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [242.466084] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [242.731178] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [243.027631] [IGT] gem_ctx_freq: finished subtest gt0, FAIL
<6> [243.029505] [IGT] gem_ctx_freq: finished subtest sysfs, FAIL
<6> [243.031175] [IGT] gem_ctx_freq: exiting, ret=98
<7> [243.031889] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [243.068195] i915 0000:03:00.0: [drm:intel_power_well_enable [i915]] enabling DC_off
<7> [243.068638] i915 0000:03:00.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 01 to 00
<7> [243.085918] i915 0000:03:00.0: [drm:drm_client_dev_restore] fbdev: ret=0
<6> [243.102830] Console: switching to colour frame buffer device 240x67
Created at 2025-03-19 09:21:09