Results for igt@gem_ctx_freq@sysfs

Machine description: shard-dg2-9

Result: Fail

git-log-oneline i915_display_info20 igt_runner20 runtimes20 results20.json results20-i915-load.json i915_display_info_post_exec20 boot20 dmesg20

DetailValue
Duration 2.73 seconds
Hostname 
shard-dg2-9
Igt-Version 
IGT-Version: 1.30-g1595d0371 (x86_64) (Linux: 6.14.0-rc5-CI_DRM_16231-g3ccfd8016ad8+ x86_64)
Out 
Using IGT_SRANDOM=1741249338 for randomisation
Opened device: /dev/dri/card0
Starting subtest: sysfs
Starting dynamic subtest: gt0
System min freq: 300MHz; max freq: 2100MHz
sysfs: Measured 299.4MHz, expected 300Mhz
sysfs: Measured 489.2MHz, expected 480Mhz
sysfs: Measured 668.9MHz, expected 660Mhz
sysfs: Measured 848.5MHz, expected 840Mhz
sysfs: Measured 1038.1MHz, expected 1020Mhz
sysfs: Measured 1197.8MHz, expected 1200Mhz
sysfs: Measured 1377.3MHz, expected 1380Mhz
sysfs: Measured 1557.2MHz, expected 1560Mhz
sysfs: Measured 1834.9MHz, expected 1740Mhz
sysfs: Measured 2024.4MHz, 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 (2.728s)
Subtest sysfs: FAIL (2.730s)
Err 
Starting subtest: sysfs
Starting dynamic subtest: gt0
(gem_ctx_freq:2675) CRITICAL: Test assertion failure function pmu_assert, file ../tests/intel/gem_ctx_freq.c:92:
(gem_ctx_freq:2675) CRITICAL: Failed assertion: __pmu_within_tolerance(actual, target)
(gem_ctx_freq:2675) CRITICAL: Measured frequency 2024.35MHz, is beyond target 1920±100Mhz
Dynamic subtest gt0 failed.
**** DEBUG ****
(gem_ctx_freq:2675) intel_allocator_reloc-DEBUG: Using reloc allocator
(gem_ctx_freq:2675) igt_pm-DEBUG: Test requirement passed: dir
(gem_ctx_freq:2675) igt_pm-DEBUG: Test requirement passed: igt_sysfs_has_attr(gtfd, "slpc_ignore_eff_freq")
(gem_ctx_freq:2675) DEBUG: Test requirement passed: get_sysfs_freq(dirfd, &sys_min, &sys_max)
(gem_ctx_freq:2675) INFO: System min freq: 300MHz; max freq: 2100MHz
(gem_ctx_freq:2675) i915/gem_engine_topology-DEBUG: Test requirement passed: intel_graphics_ver(devid) <= IP_VER(12, 70)
(gem_ctx_freq:2675) i915/gem_engine_topology-DEBUG: Test requirement passed: intel_graphics_ver(devid) <= IP_VER(12, 70)
(gem_ctx_freq:2675) i915/gem_engine_topology-DEBUG: Test requirement passed: intel_graphics_ver(devid) <= IP_VER(12, 70)
(gem_ctx_freq:2675) i915/gem_engine_topology-DEBUG: Test requirement passed: intel_graphics_ver(devid) <= IP_VER(12, 70)
(gem_ctx_freq:2675) i915/gem_engine_topology-DEBUG: Test requirement passed: intel_graphics_ver(devid) <= IP_VER(12, 70)
(gem_ctx_freq:2675) i915/gem_engine_topology-DEBUG: Test requirement passed: intel_graphics_ver(devid) <= IP_VER(12, 70)
(gem_ctx_freq:2675) i915/gem_engine_topology-DEBUG: Test requirement passed: intel_graphics_ver(devid) <= IP_VER(12, 70)
(gem_ctx_freq:2675) DEBUG: Test requirement passed: ci
(gem_ctx_freq:2675) DEBUG: Test requirement passed: pmu >= 0
(gem_ctx_freq:2675) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2675) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 658
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:2675) INFO: sysfs: Measured 299.4MHz, expected 300Mhz
(gem_ctx_freq:2675) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2675) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 658
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:2675) INFO: sysfs: Measured 489.2MHz, expected 480Mhz
(gem_ctx_freq:2675) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2675) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 658
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:2675) INFO: sysfs: Measured 668.9MHz, expected 660Mhz
(gem_ctx_freq:2675) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2675) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 658
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:2675) INFO: sysfs: Measured 848.5MHz, expected 840Mhz
(gem_ctx_freq:2675) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2675) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 658
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:2675) INFO: sysfs: Measured 1038.1MHz, expected 1020Mhz
(gem_ctx_freq:2675) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2675) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 658
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:2675) INFO: sysfs: Measured 1197.8MHz, expected 1200Mhz
(gem_ctx_freq:2675) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2675) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 658
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:2675) INFO: sysfs: Measured 1377.3MHz, expected 1380Mhz
(gem_ctx_freq:2675) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2675) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 658
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:2675) INFO: sysfs: Measured 1557.2MHz, expected 1560Mhz
(gem_ctx_freq:2675) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2675) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 658
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:2675) INFO: sysfs: Measured 1834.9MHz, expected 1740Mhz
(gem_ctx_freq:2675) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2675) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 658
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:2675) INFO: sysfs: Measured 2024.4MHz, expected 1920Mhz
(gem_ctx_freq:2675) CRITICAL: Test assertion failure function pmu_assert, file ../tests/intel/gem_ctx_freq.c:92:
(gem_ctx_freq:2675) CRITICAL: Failed assertion: __pmu_within_tolerance(actual, target)
(gem_ctx_freq:2675) CRITICAL: Measured frequency 2024.35MHz, is beyond target 1920±100Mhz
(gem_ctx_freq:2675) igt_core-INFO: Stack trace:
(gem_ctx_freq:2675) igt_core-INFO:   #0 ../lib/igt_core.c:2055 __igt_fail_assert()
(gem_ctx_freq:2675) igt_core-INFO:   #1 ../tests/intel/gem_ctx_freq.c:92 __igt_unique____real_main244()
(gem_ctx_freq:2675) igt_core-INFO:   #2 ../tests/intel/gem_ctx_freq.c:244 main()
(gem_ctx_freq:2675) igt_core-INFO:   #3 [__libc_init_first+0x8a]
(gem_ctx_freq:2675) igt_core-INFO:   #4 [__libc_start_main+0x8b]
(gem_ctx_freq:2675) igt_core-INFO:   #5 [_start+0x25]
****  END  ****
Dynamic subtest gt0: FAIL (2.728s)
Subtest sysfs: FAIL (2.730s)
Dmesg
<6> [529.277536] Console: switching to colour dummy device 80x25
<6> [529.278020] [IGT] gem_ctx_freq: executing
<7> [529.293448] i915 0000:03:00.0: [drm:i915_gem_open [i915]]
<7> [529.294974] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [529.307798] i915 0000:03:00.0: [drm:i915_gem_open [i915]]
<7> [529.309050] i915 0000:03:00.0: [drm:i915_gem_open [i915]]
<6> [529.318708] [IGT] gem_ctx_freq: starting subtest sysfs
<6> [529.319287] [IGT] gem_ctx_freq: starting dynamic subtest gt0
<7> [529.319835] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [529.344406] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [529.628051] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [529.895650] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [530.160888] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [530.426005] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [530.690961] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [530.956026] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [531.220993] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [531.486300] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [531.752272] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [532.048859] [IGT] gem_ctx_freq: finished subtest gt0, FAIL
<6> [532.050950] [IGT] gem_ctx_freq: finished subtest sysfs, FAIL
<6> [532.052779] [IGT] gem_ctx_freq: exiting, ret=98
<7> [532.053276] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [532.116018] i915 0000:03:00.0: [drm:drm_client_dev_restore] fbdev: ret=0
<6> [532.133088] Console: switching to colour frame buffer device 240x67
Created at 2025-03-06 09:19:47