Results for igt@gem_ctx_freq@sysfs

Machine description: shard-dg2-1

Result: Fail

git-log-oneline i915_display_info1 igt_runner1 runtimes1 results1.json results1-i915-load.json i915_display_info_post_exec1 boot1 dmesg1

DetailValue
Duration 3.24 seconds
Hostname
shard-dg2-1
Igt-Version
IGT-Version: 1.30-g40b32b434 (x86_64) (Linux: 6.14.0-rc5-CI_DRM_16237-g6f2e5afc45e3+ x86_64)
Out
Using IGT_SRANDOM=1741304084 for randomisation
Opened device: /dev/dri/card0
Starting subtest: sysfs
Starting dynamic subtest: gt0
System min freq: 300MHz; max freq: 2100MHz
sysfs: Measured 299.0MHz, expected 300Mhz
sysfs: Measured 489.4MHz, expected 480Mhz
sysfs: Measured 667.7MHz, expected 660Mhz
sysfs: Measured 848.5MHz, expected 840Mhz
sysfs: Measured 1028.2MHz, expected 1020Mhz
sysfs: Measured 1198.6MHz, expected 1200Mhz
sysfs: Measured 1378.3MHz, expected 1380Mhz
sysfs: Measured 1557.3MHz, expected 1560Mhz
sysfs: Measured 1747.8MHz, expected 1740Mhz
sysfs: Measured 1936.6MHz, expected 1920Mhz
sysfs: Measured 2096.5MHz, expected 2100Mhz
sysfs: Measured 2021.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.243s)
Subtest sysfs: FAIL (3.243s)
Err
Starting subtest: sysfs
Starting dynamic subtest: gt0
(gem_ctx_freq:2228) CRITICAL: Test assertion failure function pmu_assert, file ../tests/intel/gem_ctx_freq.c:92:
(gem_ctx_freq:2228) CRITICAL: Failed assertion: __pmu_within_tolerance(actual, target)
(gem_ctx_freq:2228) CRITICAL: Measured frequency 2021.21MHz, is beyond target 1920±100Mhz
Dynamic subtest gt0 failed.
**** DEBUG ****
(gem_ctx_freq:2228) intel_allocator_reloc-DEBUG: Using reloc allocator
(gem_ctx_freq:2228) igt_pm-DEBUG: Test requirement passed: dir
(gem_ctx_freq:2228) igt_pm-DEBUG: Test requirement passed: igt_sysfs_has_attr(gtfd, "slpc_ignore_eff_freq")
(gem_ctx_freq:2228) DEBUG: Test requirement passed: get_sysfs_freq(dirfd, &sys_min, &sys_max)
(gem_ctx_freq:2228) INFO: System min freq: 300MHz; max freq: 2100MHz
(gem_ctx_freq:2228) i915/gem_engine_topology-DEBUG: Test requirement passed: intel_graphics_ver(devid) <= IP_VER(12, 70)
(gem_ctx_freq:2228) i915/gem_engine_topology-DEBUG: Test requirement passed: intel_graphics_ver(devid) <= IP_VER(12, 70)
(gem_ctx_freq:2228) i915/gem_engine_topology-DEBUG: Test requirement passed: intel_graphics_ver(devid) <= IP_VER(12, 70)
(gem_ctx_freq:2228) i915/gem_engine_topology-DEBUG: Test requirement passed: intel_graphics_ver(devid) <= IP_VER(12, 70)
(gem_ctx_freq:2228) i915/gem_engine_topology-DEBUG: Test requirement passed: intel_graphics_ver(devid) <= IP_VER(12, 70)
(gem_ctx_freq:2228) i915/gem_engine_topology-DEBUG: Test requirement passed: intel_graphics_ver(devid) <= IP_VER(12, 70)
(gem_ctx_freq:2228) i915/gem_engine_topology-DEBUG: Test requirement passed: intel_graphics_ver(devid) <= IP_VER(12, 70)
(gem_ctx_freq:2228) DEBUG: Test requirement passed: ci
(gem_ctx_freq:2228) DEBUG: Test requirement passed: pmu >= 0
(gem_ctx_freq:2228) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2228) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 54
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:2228) INFO: sysfs: Measured 299.0MHz, expected 300Mhz
(gem_ctx_freq:2228) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2228) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 54
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:2228) INFO: sysfs: Measured 489.4MHz, expected 480Mhz
(gem_ctx_freq:2228) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2228) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 54
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:2228) INFO: sysfs: Measured 667.7MHz, expected 660Mhz
(gem_ctx_freq:2228) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2228) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 54
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:2228) INFO: sysfs: Measured 848.5MHz, expected 840Mhz
(gem_ctx_freq:2228) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2228) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 54
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:2228) INFO: sysfs: Measured 1028.2MHz, expected 1020Mhz
(gem_ctx_freq:2228) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2228) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 54
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:2228) INFO: sysfs: Measured 1198.6MHz, expected 1200Mhz
(gem_ctx_freq:2228) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2228) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 54
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:2228) INFO: sysfs: Measured 1378.3MHz, expected 1380Mhz
(gem_ctx_freq:2228) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2228) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 54
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:2228) INFO: sysfs: Measured 1557.3MHz, expected 1560Mhz
(gem_ctx_freq:2228) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2228) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 54
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:2228) INFO: sysfs: Measured 1747.8MHz, expected 1740Mhz
(gem_ctx_freq:2228) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2228) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 54
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:2228) INFO: sysfs: Measured 1936.6MHz, expected 1920Mhz
(gem_ctx_freq:2228) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2228) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 54
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:2228) INFO: sysfs: Measured 2096.5MHz, expected 2100Mhz
(gem_ctx_freq:2228) igt_dummyload-DEBUG: Test requirement passed: nengine
(gem_ctx_freq:2228) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? no
RPS active? no
GPU busy? yes
Boosts outstanding? 0
Interactive? 54
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:2228) INFO: sysfs: Measured 2021.2MHz, expected 1920Mhz
(gem_ctx_freq:2228) CRITICAL: Test assertion failure function pmu_assert, file ../tests/intel/gem_ctx_freq.c:92:
(gem_ctx_freq:2228) CRITICAL: Failed assertion: __pmu_within_tolerance(actual, target)
(gem_ctx_freq:2228) CRITICAL: Measured frequency 2021.21MHz, is beyond target 1920±100Mhz
(gem_ctx_freq:2228) igt_core-INFO: Stack trace:
(gem_ctx_freq:2228) igt_core-INFO:   #0 ../lib/igt_core.c:2055 __igt_fail_assert()
(gem_ctx_freq:2228) igt_core-INFO:   #1 ../tests/intel/gem_ctx_freq.c:92 __igt_unique____real_main244()
(gem_ctx_freq:2228) igt_core-INFO:   #2 ../tests/intel/gem_ctx_freq.c:244 main()
(gem_ctx_freq:2228) igt_core-INFO:   #3 [__libc_init_first+0x8a]
(gem_ctx_freq:2228) igt_core-INFO:   #4 [__libc_start_main+0x8b]
(gem_ctx_freq:2228) igt_core-INFO:   #5 [_start+0x25]
****  END  ****
Dynamic subtest gt0: FAIL (3.243s)
Subtest sysfs: FAIL (3.243s)
Dmesg
<6> [166.437165] Console: switching to colour dummy device 80x25
<6> [166.437343] [IGT] gem_ctx_freq: executing
<7> [166.453194] i915 0000:03:00.0: [drm:i915_gem_open [i915]]
<7> [166.454787] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [166.464804] i915 0000:03:00.0: [drm:i915_gem_open [i915]]
<7> [166.466068] i915 0000:03:00.0: [drm:i915_gem_open [i915]]
<6> [166.474690] [IGT] gem_ctx_freq: starting subtest sysfs
<6> [166.474940] [IGT] gem_ctx_freq: starting dynamic subtest gt0
<7> [166.475144] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [166.502363] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [166.780020] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [167.040237] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [167.303982] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [167.568150] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [167.831503] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [168.094771] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [168.357904] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [168.622484] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [168.885479] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [169.148167] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [169.411914] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [169.717938] [IGT] gem_ctx_freq: finished subtest gt0, FAIL
<6> [169.718494] [IGT] gem_ctx_freq: finished subtest sysfs, FAIL
<6> [169.719113] [IGT] gem_ctx_freq: exiting, ret=98
<7> [169.719618] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [169.765509] i915 0000:03:00.0: [drm:drm_client_dev_restore] fbdev: ret=0
<6> [169.782913] Console: switching to colour frame buffer device 240x67
Created at 2025-03-07 00:54:56