Stdout
Using IGT_SRANDOM=1723591549 for randomisation
Opened device: /dev/dri/card0
Starting subtest: s2idle-vm-bind-userptr
[cmd] rtcwake: wakeup from "freeze" using /dev/rtc0 at Tue Aug 13 23:26:06 2024
Stack trace:
#0 ../../../usr/src/igt-gpu-tools/lib/igt_core.c:1988 __igt_fail_assert()
#1 ../../../usr/src/igt-gpu-tools/lib/igt_aux.c:828 igt_system_suspend_autoresume()
#2 ../../../usr/src/igt-gpu-tools/tests/intel/xe_pm.c:367 test_exec.isra.0()
#3 ../../../usr/src/igt-gpu-tools/tests/intel/xe_pm.c:763 __igt_unique____real_main679()
#4 ../../../usr/src/igt-gpu-tools/tests/intel/xe_pm.c:679 main()
#5 [__libc_start_main+0xf3]
#6 [_start+0x2e]
Subtest s2idle-vm-bind-userptr: FAIL (1.532s)
Stderr
Starting subtest: s2idle-vm-bind-userptr
(xe_pm:973) igt_core-WARNING: [cmd] rtcwake: [cmd] write error
(xe_pm:973) igt_aux-WARNING: rtcwake failed with 1
Check dmesg for further details.
(xe_pm:973) igt_aux-CRITICAL: Test assertion failure function suspend_via_rtcwake, file ../../../usr/src/igt-gpu-tools/lib/igt_aux.c:828:
(xe_pm:973) igt_aux-CRITICAL: Failed assertion: ret == 0
(xe_pm:973) igt_aux-CRITICAL: error: 1 != 0
Subtest s2idle-vm-bind-userptr failed.
**** DEBUG ****
(xe_pm:973) igt_aux-DEBUG: Test requirement passed: (power_dir = open("/sys/power", O_RDONLY)) >= 0
(xe_pm:973) igt_aux-DEBUG: Test requirement passed: is_state_supported(power_dir, state)
(xe_pm:973) igt_aux-DEBUG: Test requirement passed: test == SUSPEND_TEST_NONE || faccessat(power_dir, "pm_test", R_OK | W_OK, 0) == 0
(xe_pm:973) igt_aux-DEBUG: Test requirement passed: !(state == SUSPEND_STATE_DISK && !igt_get_total_swap_mb())
(xe_pm:973) igt_aux-DEBUG: Test requirement passed: ret == 0
(xe_pm:973) igt_core-INFO: [cmd] rtcwake: wakeup from "freeze" using /dev/rtc0 at Tue Aug 13 23:26:06 2024
(xe_pm:973) igt_core-WARNING: [cmd] rtcwake: [cmd] write error
(xe_pm:973) igt_aux-WARNING: rtcwake failed with 1
Check dmesg for further details.
(xe_pm:973) igt_aux-DEBUG: suspend_stats:
success: 0
fail: 1
failed_freeze: 0
failed_prepare: 0
failed_suspend: 1
failed_suspend_late: 0
failed_suspend_noirq: 0
failed_resume_noirq: 0
failed_resume_early: 0
failed_resume: 0
failures:
last_failed_dev: 0000:00:1f.6
last_failed_errno: -2
0
last_failed_step: suspend
(xe_pm:973) igt_aux-CRITICAL: Test assertion failure function suspend_via_rtcwake, file ../../../usr/src/igt-gpu-tools/lib/igt_aux.c:828:
(xe_pm:973) igt_aux-CRITICAL: Failed assertion: ret == 0
(xe_pm:973) igt_aux-CRITICAL: error: 1 != 0
(xe_pm:973) igt_core-INFO: Stack trace:
(xe_pm:973) igt_core-INFO: #0 ../../../usr/src/igt-gpu-tools/lib/igt_core.c:1988 __igt_fail_assert()
(xe_pm:973) igt_core-INFO: #1 ../../../usr/src/igt-gpu-tools/lib/igt_aux.c:828 igt_system_suspend_autoresume()
(xe_pm:973) igt_core-INFO: #2 ../../../usr/src/igt-gpu-tools/tests/intel/xe_pm.c:367 test_exec.isra.0()
(xe_pm:973) igt_core-INFO: #3 ../../../usr/src/igt-gpu-tools/tests/intel/xe_pm.c:763 __igt_unique____real_main679()
(xe_pm:973) igt_core-INFO: #4 ../../../usr/src/igt-gpu-tools/tests/intel/xe_pm.c:679 main()
(xe_pm:973) igt_core-INFO: #5 [__libc_start_main+0xf3]
(xe_pm:973) igt_core-INFO: #6 [_start+0x2e]
**** END ****
Subtest s2idle-vm-bind-userptr: FAIL (1.532s)
Dmesg
<7> [168.738740] xe 0000:00:02.0: [drm:intel_power_well_disable [xe]] disabling DC_off
<7> [168.738846] xe 0000:00:02.0: [drm:skl_enable_dc6 [xe]] Enabling DC6
<7> [168.738910] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 00 to 02
<6> [168.754634] Console: switching to colour dummy device 80x25
<6> [168.754756] [IGT] xe_pm: executing
<6> [168.871905] [IGT] xe_pm: starting subtest s2idle-vm-bind-userptr
<6> [168.965596] PM: suspend entry (s2idle)
<6> [168.970921] Filesystems sync: 0.005 seconds
<6> [168.976875] Freezing user space processes
<6> [168.979198] Freezing user space processes completed (elapsed 0.002 seconds)
<6> [168.979251] OOM killer disabled.
<6> [168.979253] Freezing remaining freezable tasks
<6> [169.002356] Freezing remaining freezable tasks completed (elapsed 0.023 seconds)
<6> [169.025646] r8169 0000:7f:00.0 enp127s0: Link is Down
<6> [169.025671] e1000e: EEE TX LPI TIMER: 00000011
<7> [169.028764] xe 0000:00:02.0: [drm:xe_pm_suspend [xe]] Suspending device
<7> [169.029322] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling DC_off
<7> [169.030085] xe 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [xe]] Setting DC state from 02 to 00
<7> [169.030184] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_2
<7> [169.031090] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_B
<7> [169.031199] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_C
<7> [169.031296] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PW_D
<7> [169.031384] xe 0000:00:02.0: [drm:intel_power_well_enable [xe]] enabling PICA_TC
<7> [169.031839] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [169.031908] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.active (expected yes, found no)
<7> [169.031968] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [169.032026] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [169.032084] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in dp_m_n (expected tu 64 data 6329869/8388608 link 421991/524288, found tu 0, data 0/0 link 0/0)
<7> [169.032141] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in output_types (expected 0x00000100, found 0x00000000)
<7> [169.032194] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [169.032244] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 2880, found 0)
<7> [169.032293] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 3040, found 0)
<7> [169.032341] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 2880, found 0)
<7> [169.032388] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 3040, found 0)
<7> [169.032435] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 2928, found 0)
<7> [169.032480] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 2960, found 0)
<7> [169.032526] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 1800, found 0)
<7> [169.032570] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 1800, found 0)
<7> [169.032616] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 1803, found 0)
<7> [169.032659] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 1809, found 0)
<7> [169.032703] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 1906, found 0)
<7> [169.032745] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 1906, found 0)
<7> [169.032786] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 2880, found 0)
<7> [169.032827] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_htotal (expected 3040, found 0)
<7> [169.032869] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_start (expected 2880, found 0)
<7> [169.032912] xe 0000:00:02.0: [drm:intel_pipe_config_compare [xe]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hblank_end (expected 3040, found 0)