Bug 106651

Summary:	[CI] igt@pm_rps@min-max-config-idle - fail - Failed assertion: igt_wait_helper(&lh.igt_proc) == 0
Product:	DRI	Reporter:	Martin Peres <martin.peres>
Component:	DRM/Intel	Assignee:	Intel GFX Bugs mailing list <intel-gfx-bugs>
Status:	CLOSED FIXED	QA Contact:	Intel GFX Bugs mailing list <intel-gfx-bugs>
Severity:	normal
Priority:	medium	CC:	intel-gfx-bugs
Version:	XOrg git
Hardware:	Other
OS:	All
Whiteboard:	ReadyForDev
i915 platform:	HSW	i915 features:	power/Other

Description Martin Peres 2018-05-25 13:20:12 UTC

https://intel-gfx-ci.01.org/tree/drm-tip/IGT_4475/shard-hsw5/igt@pm_rps@min-max-config-idle.html

(pm_rps:1688) CRITICAL: Test assertion failure function load_helper_stop, file ../tests/pm_rps.c:283:
(pm_rps:1688) CRITICAL: Failed assertion: igt_wait_helper(&lh.igt_proc) == 0
Subtest min-max-config-idle failed.
**** DEBUG ****
(pm_rps:1688) DEBUG: 
Check original min and max...
(pm_rps:1688) drmtest-DEBUG: Test requirement passed: is_i915_device(fd) && has_known_intel_chipset(fd)
(pm_rps:1688) igt_debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0'
(pm_rps:1688) ioctl_wrappers-DEBUG: Test requirement passed: dir >= 0
(pm_rps:1688) ioctl_wrappers-DEBUG: Test requirement passed: err == 0
(pm_rps:1688) DEBUG: gt freq (MHz):  cur=350  min=200  max=1250  RP0=1250  RP1=350  RPn=200  boost=1300
(pm_rps:1688) DEBUG: gt freq (MHz):  cur=200  min=200  max=1250  RP0=1250  RP1=350  RPn=200  boost=1300
(pm_rps:1688) igt_debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0'
(pm_rps:1688) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? 1
GPU busy? no [0 requests]
CPU waiting? 0
Boosts outstanding? 0
Frequency requested 200
  min hard:200, soft:200; max soft:1250, hard:1300
  idle:200, efficient:350, boost:1300
pm_rps [1688]: 0 boosts
pm_rps [1688]: 0 boosts
Kernel (anonymous) boosts: 0

RPS Autotuning inactive
(pm_rps:1688) DEBUG: Required 250 msec to reach cur=idle
(pm_rps:1688) DEBUG: 
Set min=RPn and max=RP0...
(pm_rps:1688) drmtest-DEBUG: Test requirement passed: is_i915_device(fd) && has_known_intel_chipset(fd)
(pm_rps:1688) igt_debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0'
(pm_rps:1688) ioctl_wrappers-DEBUG: Test requirement passed: dir >= 0
(pm_rps:1688) ioctl_wrappers-DEBUG: Test requirement passed: err == 0
(pm_rps:1688) DEBUG: gt freq (MHz):  cur=350  min=200  max=1250  RP0=1250  RP1=350  RPn=200  boost=1300
(pm_rps:1688) DEBUG: gt freq (MHz):  cur=200  min=200  max=1250  RP0=1250  RP1=350  RPn=200  boost=1300
(pm_rps:1688) igt_debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0'
(pm_rps:1688) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? 1
GPU busy? no [0 requests]
CPU waiting? 0
Boosts outstanding? 0
Frequency requested 200
  min hard:200, soft:200; max soft:1250, hard:1300
  idle:200, efficient:350, boost:1300
pm_rps [1688]: 0 boosts
pm_rps [1688]: 0 boosts
Kernel (anonymous) boosts: 0

RPS Autotuning inactive
(pm_rps:1688) DEBUG: Required 250 msec to reach cur=idle
(pm_rps:1688) DEBUG: 
Increase min to midpoint...
(pm_rps:1688) drmtest-DEBUG: Test requirement passed: is_i915_device(fd) && has_known_intel_chipset(fd)
(pm_rps:1688) igt_debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0'
(pm_rps:1688) ioctl_wrappers-DEBUG: Test requirement passed: dir >= 0
(pm_rps:1688) ioctl_wrappers-DEBUG: Test requirement passed: err == 0
(pm_rps:1688) DEBUG: gt freq (MHz):  cur=750  min=750  max=1250  RP0=1250  RP1=350  RPn=200  boost=1300
(pm_rps:1688) DEBUG: gt freq (MHz):  cur=200  min=750  max=1250  RP0=1250  RP1=350  RPn=200  boost=1300
(pm_rps:1688) igt_debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0'
(pm_rps:1688) igt_debugfs-DEBUG: i915_rps_boost_info:
RPS enabled? 1
GPU busy? no [0 requests]
CPU waiting? 0
Boosts outstanding? 0
Frequency requested 200
  min hard:200, soft:750; max soft:1250, hard:1300
  idle:200, efficient:350, boost:1300
pm_rps [1688]: 0 boosts
pm_rps [1688]: 0 boosts
Kernel (anonymous) boosts: 0

RPS Autotuning inactive
(pm_rps:1688) DEBUG: Required 250 msec to reach cur=idle
(pm_rps:1688) DEBUG: 
Increase min to RP0...
(pm_rps:1688) drmtest-DEBUG: Test requirement passed: is_i915_device(fd) && has_known_intel_chipset(fd)
(pm_rps:1688) igt_debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0'
(pm_rps:1688) ioctl_wrappers-DEBUG: Test requirement passed: dir >= 0
(pm_rps:1688) ioctl_wrappers-DEBUG: Test requirement passed: err == 0
(pm_rps:1688) CRITICAL: Test assertion failure function load_helper_stop, file ../tests/pm_rps.c:283:
(pm_rps:1688) CRITICAL: Failed assertion: igt_wait_helper(&lh.igt_proc) == 0
(pm_rps:1688) igt_core-INFO: Stack trace:
(pm_rps:1688) igt_core-INFO:   #0 [__igt_fail_assert+0x180]
(pm_rps:1688) igt_core-INFO:   #1 [load_helper_stop+0x55]
(pm_rps:1688) igt_core-INFO:   #2 [do_load_gpu+0x1d]
(pm_rps:1688) igt_core-INFO:   #3 [min_max_config+0x15b]
(pm_rps:1688) igt_core-INFO:   #4 [__real_main588+0x2ad]
(pm_rps:1688) igt_core-INFO:   #5 [main+0x44]
(pm_rps:1688) igt_core-INFO:   #6 [__libc_start_main+0xe7]
(pm_rps:1688) igt_core-INFO:   #7 [_start+0x2a]
****  END  ****

Comment 1 Martin Peres 2018-05-25 13:22:05 UTC

Also seen on drmtip_37: https://intel-gfx-ci.01.org/tree/drm-tip/drmtip_37/fi-hsw-4200u/igt@pm_rps@min-max-config-idle.html

Comment 2 Chris Wilson 2018-05-25 13:26:11 UTC

I'm fed up of that wait helper spontaneously combusting without trace.

Comment 3 Chris Wilson 2018-09-06 19:46:08 UTC

Recently updated helper mechanism, claiming fixed.

Comment 4 Martin Peres 2018-09-18 08:51:59 UTC

Did not happen since drmtip_37 (4 months, 1 week ago), closing.

Use of freedesktop.org services, including Bugzilla, is subject to our Code of Conduct. How we collect and use information is described in our Privacy Policy.