Results for igt@gem_exec_suspend@basic-s3

Machine description: shard-rkl-3

Result: Dmesg-Fail 7 Warning(s)

git-log-oneline i915_display_info22 igt_runner22 runtimes22 results22.json results22-i915-load.json i915_display_info_post_exec22 boot22 dmesg22

DetailValue
Duration 22.75 seconds
Hostname
shard-rkl-3
Igt-Version
IGT-Version: 1.30-g0a005c489 (x86_64) (Linux: 6.14.0-rc4-CI_DRM_16194-g2a3ff290a74c+ x86_64)
Out
Using IGT_SRANDOM=1741085204 for randomisation
Opened device: /dev/dri/card0
Starting subtest: basic-S3
Starting dynamic subtest: smem
[cmd] rtcwake: assuming RTC uses UTC ...
[cmd] rtcwake: wakeup from "mem" using /dev/rtc0 at Tue Mar  4 10:47:00 2025
Stack trace:
  #0 ../lib/igt_core.c:2055 __igt_fail_assert()
  #1 ../lib/igt_aux.c:909 igt_system_suspend_autoresume()
  #2 ../tests/intel/gem_exec_suspend.c:272 run_test()
  #3 ../tests/intel/gem_exec_suspend.c:442 __igt_unique____real_main354()
  #4 ../tests/intel/gem_exec_suspend.c:354 main()
  #5 [__libc_init_first+0x8a]
  #6 [__libc_start_main+0x8b]
  #7 [_start+0x25]
Dynamic subtest smem: FAIL (22.747s)
Subtest basic-S3: FAIL (22.748s)
Err
Starting subtest: basic-S3
Starting dynamic subtest: smem
(gem_exec_suspend:3027) igt_core-WARNING: [cmd] rtcwake: write error
(gem_exec_suspend:3027) igt_aux-WARNING: rtcwake failed with 1
Check dmesg for further details.
(gem_exec_suspend:3027) igt_aux-CRITICAL: Test assertion failure function suspend_via_rtcwake, file ../lib/igt_aux.c:828:
(gem_exec_suspend:3027) igt_aux-CRITICAL: Failed assertion: ret == 0
(gem_exec_suspend:3027) igt_aux-CRITICAL: error: 1 != 0
Dynamic subtest smem failed.
**** DEBUG ****
(gem_exec_suspend:3027) intel_allocator_reloc-DEBUG: Using reloc allocator
(gem_exec_suspend:3027) i915/gem_engine_topology-DEBUG: using pre-allocated engine list
(gem_exec_suspend:3027) DEBUG: Test requirement passed: nengine
(gem_exec_suspend:3027) i915/gem_engine_topology-DEBUG: using pre-allocated engine list
(gem_exec_suspend:3027) DEBUG: Test requirement passed: nengine
(gem_exec_suspend:3027) ioctl_wrappers-DEBUG: Test requirement passed: __gem_set_caching(fd, handle, caching) == 0
(gem_exec_suspend:3027) DEBUG: Test requirement passed: __gem_execbuf(fd, &execbuf) == 0
(gem_exec_suspend:3027) DEBUG: Verifying result
(gem_exec_suspend:3027) ioctl_wrappers-DEBUG: Test requirement passed: __gem_set_caching(fd, handle, caching) == 0
(gem_exec_suspend:3027) DEBUG: Test requirement passed: __gem_execbuf(fd, &execbuf) == 0
(gem_exec_suspend:3027) igt_aux-DEBUG: Test requirement passed: (power_dir = open("/sys/power", O_RDONLY)) >= 0
(gem_exec_suspend:3027) igt_aux-DEBUG: Test requirement passed: is_state_supported(power_dir, state)
(gem_exec_suspend:3027) igt_aux-DEBUG: Test requirement passed: test == SUSPEND_TEST_NONE || faccessat(power_dir, "pm_test", R_OK | W_OK, 0) == 0
(gem_exec_suspend:3027) igt_aux-DEBUG: Test requirement passed: !(state == SUSPEND_STATE_DISK && !igt_get_total_swap_mb())
(gem_exec_suspend:3027) igt_aux-DEBUG: Test requirement passed: ret == 0
(gem_exec_suspend:3027) igt_core-INFO: [cmd] rtcwake: assuming RTC uses UTC ...
(gem_exec_suspend:3027) igt_core-WARNING: [cmd] rtcwake: write error
(gem_exec_suspend:3027) igt_core-INFO: [cmd] rtcwake: wakeup from "mem" using /dev/rtc0 at Tue Mar  4 10:47:00 2025
(gem_exec_suspend:3027) igt_aux-WARNING: rtcwake failed with 1
Check dmesg for further details.
(gem_exec_suspend:3027) igt_aux-DEBUG: suspend_stats:
success: 7
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:	
			
  last_failed_errno:	-16
			0
  last_failed_step:	suspend
			
(gem_exec_suspend:3027) igt_aux-CRITICAL: Test assertion failure function suspend_via_rtcwake, file ../lib/igt_aux.c:828:
(gem_exec_suspend:3027) igt_aux-CRITICAL: Failed assertion: ret == 0
(gem_exec_suspend:3027) igt_aux-CRITICAL: error: 1 != 0
(gem_exec_suspend:3027) igt_core-INFO: Stack trace:
(gem_exec_suspend:3027) igt_core-INFO:   #0 ../lib/igt_core.c:2055 __igt_fail_assert()
(gem_exec_suspend:3027) igt_core-INFO:   #1 ../lib/igt_aux.c:909 igt_system_suspend_autoresume()
(gem_exec_suspend:3027) igt_core-INFO:   #2 ../tests/intel/gem_exec_suspend.c:272 run_test()
(gem_exec_suspend:3027) igt_core-INFO:   #3 ../tests/intel/gem_exec_suspend.c:442 __igt_unique____real_main354()
(gem_exec_suspend:3027) igt_core-INFO:   #4 ../tests/intel/gem_exec_suspend.c:354 main()
(gem_exec_suspend:3027) igt_core-INFO:   #5 [__libc_init_first+0x8a]
(gem_exec_suspend:3027) igt_core-INFO:   #6 [__libc_start_main+0x8b]
(gem_exec_suspend:3027) igt_core-INFO:   #7 [_start+0x25]
****  END  ****
Dynamic subtest smem: FAIL (22.747s)
Subtest basic-S3: FAIL (22.748s)
Dmesg

<6> [900.342085] Console: switching to colour dummy device 80x25
<6> [900.342335] [IGT] gem_exec_suspend: executing
<7> [900.343804] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [900.344348] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [900.344527] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [900.344835] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<6> [900.352676] [IGT] gem_exec_suspend: starting subtest basic-S3
<6> [900.352954] [IGT] gem_exec_suspend: starting dynamic subtest smem
<7> [900.353149] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [900.354591] [drm:eb_validate_vma [i915]] EINVAL at eb_validate_vma:509
<7> [900.354901] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [900.782478] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [900.807904] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [901.227291] PM: suspend entry (s2idle)
<6> [901.227772] Filesystems sync: 0.000 seconds
<6> [901.236695] Freezing user space processes
<6> [901.238382] Freezing user space processes completed (elapsed 0.001 seconds)
<6> [901.238397] OOM killer disabled.
<6> [901.238402] Freezing remaining freezable tasks
<6> [901.240094] Freezing remaining freezable tasks completed (elapsed 0.001 seconds)
<3> [904.631974] mei_me 0000:00:16.0: timer: connect/disconnect timeout.
<3> [904.632698] mei_pxp 0000:00:16.0-fbf6fcf1-96cf-4e2e-a6a6-1bab8cbe36b1: cannot connect
<3> [904.632758] mei_pxp 0000:00:16.0-fbf6fcf1-96cf-4e2e-a6a6-1bab8cbe36b1: mei_cldev_enable failed. -14
<3> [904.632802] i915 0000:00:02.0: [drm] *ERROR* Failed to send PXP TEE message
<4> [904.632838] mei_pxp 0000:00:16.0-fbf6fcf1-96cf-4e2e-a6a6-1bab8cbe36b1: Trying to reset the channel...
<3> [910.775664] mei_me 0000:00:16.0: timer: connect/disconnect timeout.
<3> [910.776403] mei_pxp 0000:00:16.0-fbf6fcf1-96cf-4e2e-a6a6-1bab8cbe36b1: cannot connect
<3> [910.776456] mei_pxp 0000:00:16.0-fbf6fcf1-96cf-4e2e-a6a6-1bab8cbe36b1: mei_cldev_enable failed. -14
<3> [910.776497] i915 0000:00:02.0: [drm] *ERROR* Failed to send PXP TEE message
<4> [910.776530] mei_pxp 0000:00:16.0-fbf6fcf1-96cf-4e2e-a6a6-1bab8cbe36b1: Trying to reset the channel...
<3> [916.919415] mei_me 0000:00:16.0: timer: connect/disconnect timeout.
<3> [916.920082] mei_pxp 0000:00:16.0-fbf6fcf1-96cf-4e2e-a6a6-1bab8cbe36b1: cannot connect
<3> [916.920131] mei_pxp 0000:00:16.0-fbf6fcf1-96cf-4e2e-a6a6-1bab8cbe36b1: mei_cldev_enable failed. -14
<3> [916.920170] i915 0000:00:02.0: [drm] *ERROR* Failed to send PXP TEE message
<3> [916.920202] i915 0000:00:02.0: [drm] *ERROR* Failed to send tee msg for inv-stream-key-15, ret=[-14]
<7> [916.920259] i915 0000:00:02.0: [drm:pxp_session_work [i915]] PXP: processing event-flags 0x0000000a
<7> [916.920851] i915 0000:00:02.0: [drm:pxp_session_work [i915]] PXP: creating arb_session after invalidation
<4> [916.921404] mei_pxp 0000:00:16.0-fbf6fcf1-96cf-4e2e-a6a6-1bab8cbe36b1: Trying to reset the channel...
<3> [923.063169] mei_me 0000:00:16.0: timer: connect/disconnect timeout.
<3> [923.063817] mei_pxp 0000:00:16.0-fbf6fcf1-96cf-4e2e-a6a6-1bab8cbe36b1: cannot connect
<3> [923.063871] mei_pxp 0000:00:16.0-fbf6fcf1-96cf-4e2e-a6a6-1bab8cbe36b1: mei_cldev_enable failed. -14
<3> [923.063911] i915 0000:00:02.0: [drm] *ERROR* Failed to send PXP TEE message
<3> [923.063942] i915 0000:00:02.0: [drm] *ERROR* Failed to send tee msg init arb session, ret=[-14]
<3> [923.063980] i915 0000:00:02.0: [drm] *ERROR* tee cmd for arb session creation failed
<7> [923.077542] PM: suspend of devices aborted after 0.106 msecs
<7> [923.077556] PM: start suspend of devices aborted after 21838.366 msecs
<3> [923.077564] PM: Some devices failed to suspend, or early wake event detected
<7> [923.077722] PM: resume of devices complete after 0.009 msecs
<6> [923.081838] OOM killer enabled.
<6> [923.081848] Restarting tasks ... done.
<5> [923.083177] random: crng reseeded on system resumption
<6> [923.083471] PM: suspend exit
<6> [923.100525] [IGT] gem_exec_suspend: finished subtest smem, FAIL
<6> [923.100830] [IGT] gem_exec_suspend: finished subtest basic-S3, FAIL
<7> [923.120024] i915 0000:00:02.0: [drm:intel_audio_component_get_power [i915]] restored AUD_FREQ_CNTRL to 0x8010
<7> [923.207195] i915 0000:00:02.0: [drm:error_state_write [i915]] Resetting error state
<6> [923.207747] [IGT] gem_exec_suspend: exiting, ret=98
<7> [923.208431] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [923.290024] i915 0000:00:02.0: [drm:drm_client_dev_restore] intel-fbdev: ret=0
<6> [923.309158] Console: switching to colour frame buffer device 240x67
Created at 2025-03-05 02:14:53