i7-1260p suspend failure and kernel stack traces
This is on a Linux msi-mint 5.19.0-rc4+ #4 SMP PREEMPT_DYNAMIC Sun Jul 3 15:47:36 EDT 2022 x86_64 x86_64 x86_64 GNU/Linux
MSI Laptop Summit E13FlipEvo A12MT/MS-13P3
In an attempt to fix suspend issues with older kernels, I've compiled/installed drm-tip (commit 1521a456fc4a93afd21a1eb38066f22ce3f2e380 June 3rd, 2022). I see two stack traces in syslog:
Jul 3 16:28:36 msi-mint kernel: [ 6.380059] ------------[ cut here ]------------
Jul 3 16:28:36 msi-mint kernel: [ 6.380070] i915 0000:00:02.0: drm_WARN_ON(intel_dp->pps.vdd_wakeref)
Jul 3 16:28:36 msi-mint kernel: [ 6.380113] WARNING: CPU: 4 PID: 274 at drivers/gpu/drm/i915/display/intel_pps.c:594 intel_pps_vdd_on_unlocked+0x282/0x290
[i915]
Jul 3 16:28:36 msi-mint kernel: [ 6.380569] Modules linked in: hid_sensor_custom hid_sensor_hub intel_ishtp_hid i915(+) drm_buddy i2c_algo_bit ttm drm_dis
play_helper cec rc_core drm_kms_helper hid_generic syscopyarea sysfillrect crct10dif_pclmul crc32_pclmul ghash_clmulni_intel aesni_intel sysimgblt crypto_simd
rtsx_pci_sdmmc psmouse cryptd nvme intel_lpss_pci fb_sys_fops i2c_i801 xhci_pci intel_ish_ipc intel_lpss i2c_smbus drm xhci_pci_renesas i2c_hid_acpi thunderb
olt nvme_core intel_ishtp rtsx_pci idma64 i2c_hid hid wmi video pinctrl_tigerlake
Jul 3 16:28:36 msi-mint kernel: [ 6.380660] CPU: 4 PID: 274 Comm: systemd-udevd Not tainted 5.19.0-rc4+ #4
Jul 3 16:28:36 msi-mint kernel: [ 6.380670] Hardware name: Micro-Star International Co., Ltd. Summit E13FlipEvo A12MT/MS-13P3, BIOS E13P3IMS.10B 06/08/202
2
Jul 3 16:28:36 msi-mint kernel: [ 6.380676] RIP: 0010:intel_pps_vdd_on_unlocked+0x282/0x290 [i915]
Jul 3 16:28:36 msi-mint kernel: [ 6.381048] Code: 4c 8b 77 50 4d 85 f6 75 03 4c 8b 37 e8 b7 84 98 ec 48 c7 c1 38 08 8f c0 4c 89 f2 48 c7 c7 94 34 90 c0 48
89 c6 e8 ad 76 db ec <0f> 0b e9 11 fe ff ff e8 42 e1 e1 ec 66 90 0f 1f 44 00 00 55 48 89
Jul 3 16:28:36 msi-mint kernel: [ 6.381056] RSP: 0018:ffff99ee810e3450 EFLAGS: 00010282
Jul 3 16:28:36 msi-mint kernel: [ 6.381065] RAX: 0000000000000000 RBX: ffff89d8da02a170 RCX: 0000000000000000
Jul 3 16:28:36 msi-mint kernel: [ 6.381070] RDX: 0000000000000001 RSI: 00000000ffffdfff RDI: 00000000ffffffff
Jul 3 16:28:36 msi-mint kernel: [ 6.381074] RBP: ffff99ee810e34a8 R08: 0000000000000000 R09: ffff99ee810e32b8
Jul 3 16:28:36 msi-mint kernel: [ 6.381077] R10: 0000000000000001 R11: 0000000000000001 R12: ffff89d8da2f8000
Jul 3 16:28:36 msi-mint kernel: [ 6.381081] R13: 0000000000000001 R14: ffff89d8c29bb570 R15: ffff89d8da02a170
Jul 3 16:28:36 msi-mint kernel: [ 6.381085] FS: 00007fbf0bdce880(0000) GS:ffff89e037900000(0000) knlGS:0000000000000000
Jul 3 16:28:36 msi-mint kernel: [ 6.381090] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
Jul 3 16:28:36 msi-mint kernel: [ 6.381095] CR2: 000055fac53c2008 CR3: 00000001184de003 CR4: 0000000000770ee0
Jul 3 16:28:36 msi-mint kernel: [ 6.381100] PKRU: 55555554
Jul 3 16:28:36 msi-mint kernel: [ 6.381103] Call Trace:
Jul 3 16:28:36 msi-mint kernel: [ 6.381107] <TASK>
Jul 3 16:28:36 msi-mint kernel: [ 6.381114] ? intel_display_power_get+0x58/0x70 [i915]
Jul 3 16:28:36 msi-mint kernel: [ 6.381515] intel_dp_aux_xfer+0x102/0x870 [i915]
Jul 3 16:28:36 msi-mint kernel: [ 6.381859] ? _raw_spin_unlock_irqrestore+0x27/0x3b
Jul 3 16:28:36 msi-mint kernel: [ 6.381872] ? hrtimer_try_to_cancel+0x2e/0x110
Jul 3 16:28:36 msi-mint kernel: [ 6.381887] intel_dp_aux_transfer+0xf0/0x2b0 [i915]
Jul 3 16:28:36 msi-mint kernel: [ 6.382201] ? _raw_spin_lock_irqsave+0x28/0x50
Jul 3 16:28:36 msi-mint kernel: [ 6.382209] ? _raw_spin_unlock_irqrestore+0x27/0x3b
Jul 3 16:28:36 msi-mint kernel: [ 6.382218] drm_dp_dpcd_access+0x6f/0x120 [drm_display_helper]
Jul 3 16:28:36 msi-mint kernel: [ 6.382255] drm_dp_dpcd_write+0x92/0xe0 [drm_display_helper]
Jul 3 16:28:36 msi-mint kernel: [ 6.382291] intel_dp_set_power+0x61/0x160 [i915]
Jul 3 16:28:36 msi-mint kernel: [ 6.382606] intel_ddi_post_disable+0x3ea/0x440 [i915]
Jul 3 16:28:36 msi-mint kernel: [ 6.382937] intel_encoders_post_disable+0x83/0xa0 [i915]
Jul 3 16:28:36 msi-mint kernel: [ 6.383314] hsw_crtc_disable+0x51/0x70 [i915]
Jul 3 16:28:36 msi-mint kernel: [ 6.383640] intel_old_crtc_state_disables.isra.0+0x3d/0xa0 [i915]
Jul 3 16:28:36 msi-mint kernel: [ 6.383947] intel_atomic_commit_tail+0x3a5/0xdc0 [i915]
Jul 3 16:28:36 msi-mint kernel: [ 6.384269] intel_atomic_commit+0x330/0x3a0 [i915]
Jul 3 16:28:36 msi-mint kernel: [ 6.384576] drm_atomic_commit+0x94/0xc0 [drm]
Jul 3 16:28:36 msi-mint kernel: [ 6.384693] ? drm_plane_get_damage_clips.cold+0x1d/0x1d [drm]
Jul 3 16:28:36 msi-mint kernel: [ 6.384824] intel_modeset_init+0x221/0x260 [i915]
Jul 3 16:28:36 msi-mint kernel: [ 6.385216] i915_driver_probe+0x5e8/0xd90 [i915]
Jul 3 16:28:36 msi-mint kernel: [ 6.385503] ? acpi_dev_found+0x66/0x70
Jul 3 16:28:36 msi-mint kernel: [ 6.385516] i915_pci_probe+0x5a/0x140 [i915]
Jul 3 16:28:36 msi-mint kernel: [ 6.385788] ? _raw_spin_unlock_irqrestore+0x27/0x3b
Jul 3 16:28:36 msi-mint kernel: [ 6.385798] local_pci_probe+0x48/0x90
Jul 3 16:28:36 msi-mint kernel: [ 6.385805] ? pci_match_device+0xde/0x130
Jul 3 16:28:36 msi-mint kernel: [ 6.385814] pci_device_probe+0xc8/0x240
Jul 3 16:28:36 msi-mint kernel: [ 6.385824] really_probe+0x184/0x360
Jul 3 16:28:36 msi-mint kernel: [ 6.385835] __driver_probe_device+0x109/0x180
Jul 3 16:28:36 msi-mint kernel: [ 6.385844] driver_probe_device+0x23/0xa0
Jul 3 16:28:36 msi-mint kernel: [ 6.385853] __driver_attach+0xb9/0x160
Jul 3 16:28:36 msi-mint kernel: [ 6.385861] ? __device_attach_driver+0xe0/0xe0
Jul 3 16:28:36 msi-mint kernel: [ 6.385870] bus_for_each_dev+0x7c/0xc0
Jul 3 16:28:36 msi-mint kernel: [ 6.385880] driver_attach+0x1e/0x20
Jul 3 16:28:36 msi-mint kernel: [ 6.385887] bus_add_driver+0x161/0x200
Jul 3 16:28:36 msi-mint kernel: [ 6.385896] driver_register+0x74/0xd0
Jul 3 16:28:36 msi-mint kernel: [ 6.385905] __pci_register_driver+0x68/0x70
Jul 3 16:28:36 msi-mint kernel: [ 6.385911] i915_pci_register_driver+0x23/0x30 [i915]
Jul 3 16:28:36 msi-mint kernel: [ 6.386095] i915_init+0x24/0x87 [i915]
Jul 3 16:28:36 msi-mint kernel: [ 6.386136] ? 0xffffffffc097c000
Jul 3 16:28:36 msi-mint kernel: [ 6.386137] do_one_initcall+0x46/0x200
Jul 3 16:28:36 msi-mint kernel: [ 6.386139] ? kmem_cache_alloc_trace+0x193/0x4c0
Jul 3 16:28:36 msi-mint kernel: [ 6.386141] do_init_module+0x52/0x200
Jul 3 16:28:36 msi-mint kernel: [ 6.386143] load_module+0x1dea/0x2060
Jul 3 16:28:36 msi-mint kernel: [ 6.386145] __do_sys_finit_module+0xc5/0x130
Jul 3 16:28:36 msi-mint kernel: [ 6.386146] ? __do_sys_finit_module+0xc5/0x130
Jul 3 16:28:36 msi-mint kernel: [ 6.386147] __x64_sys_finit_module+0x1a/0x20
Jul 3 16:28:36 msi-mint kernel: [ 6.386148] do_syscall_64+0x38/0x90
Jul 3 16:28:36 msi-mint kernel: [ 6.386150] entry_SYSCALL_64_after_hwframe+0x46/0xb0
Jul 3 16:28:36 msi-mint kernel: [ 6.386151] RIP: 0033:0x7fbf0c3f873d
Jul 3 16:28:36 msi-mint kernel: [ 6.386152] Code: 00 c3 66 2e 0f 1f 84 00 00 00 00 00 90 f3 0f 1e fa 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 23 37 0d 00 f7 d8 64 89 01 48
Jul 3 16:28:36 msi-mint kernel: [ 6.386153] RSP: 002b:00007ffd1b131098 EFLAGS: 00000246 ORIG_RAX: 0000000000000139
Jul 3 16:28:36 msi-mint kernel: [ 6.386154] RAX: ffffffffffffffda RBX: 000055fac5334ca0 RCX: 00007fbf0c3f873d
Jul 3 16:28:36 msi-mint kernel: [ 6.386155] RDX: 0000000000000000 RSI: 00007fbf0c2d8ded RDI: 0000000000000017
Jul 3 16:28:36 msi-mint kernel: [ 6.386155] RBP: 0000000000020000 R08: 0000000000000000 R09: 0000000000000000
Jul 3 16:28:36 msi-mint kernel: [ 6.386156] R10: 0000000000000017 R11: 0000000000000246 R12: 00007fbf0c2d8ded
Jul 3 16:28:36 msi-mint kernel: [ 6.386156] R13: 0000000000000000 R14: 000055fac53364a0 R15: 000055fac5334ca0
Jul 3 16:28:36 msi-mint kernel: [ 6.386157] </TASK>
Jul 3 16:28:36 msi-mint kernel: [ 6.386158] ---[ end trace 0000000000000000 ]---
and sometime later:
Jul 3 16:40:32 msi-mint kernel: [ 726.308223] INFO: task kworker/u33:0:180 blocked for more than 604 seconds.
Jul 3 16:40:32 msi-mint kernel: [ 726.308247] Tainted: G W 5.19.0-rc4+ #4
Jul 3 16:40:32 msi-mint kernel: [ 726.308253] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Jul 3 16:40:32 msi-mint kernel: [ 726.308257] task:kworker/u33:0 state:D stack: 0 pid: 180 ppid: 2 flags:0x00004000
Jul 3 16:40:32 msi-mint kernel: [ 726.308274] Workqueue: hci0 hci_power_on [bluetooth]
Jul 3 16:40:32 msi-mint kernel: [ 726.308355] Call Trace:
Jul 3 16:40:32 msi-mint kernel: [ 726.308360] <TASK>
Jul 3 16:40:32 msi-mint kernel: [ 726.308369] __schedule+0xa11/0x1400
Jul 3 16:40:32 msi-mint kernel: [ 726.308385] ? update_load_avg+0x74/0x750
Jul 3 16:40:32 msi-mint kernel: [ 726.308399] ? place_entity+0x81/0xa0
Jul 3 16:40:32 msi-mint kernel: [ 726.308409] schedule+0x58/0xc0
Jul 3 16:40:32 msi-mint kernel: [ 726.308418] schedule_timeout+0x1f3/0x290
Jul 3 16:40:32 msi-mint kernel: [ 726.308424] ? ttwu_do_activate+0xb8/0x4e0
Jul 3 16:40:32 msi-mint kernel: [ 726.308430] ? sched_clock_cpu+0x12/0xd0
Jul 3 16:40:32 msi-mint kernel: [ 726.308441] ? _raw_spin_lock+0x17/0x40
Jul 3 16:40:32 msi-mint kernel: [ 726.308449] wait_for_completion+0x8b/0x140
Jul 3 16:40:32 msi-mint kernel: [ 726.308461] __flush_work+0x137/0x1f0
Jul 3 16:40:32 msi-mint kernel: [ 726.308470] ? flush_workqueue_prep_pwqs+0x120/0x120
Jul 3 16:40:32 msi-mint kernel: [ 726.308478] __cancel_work_timer+0x11c/0x1a0
Jul 3 16:40:32 msi-mint kernel: [ 726.308486] ? led_trigger_event+0x55/0x60
Jul 3 16:40:32 msi-mint kernel: [ 726.308498] cancel_work_sync+0x10/0x20
Jul 3 16:40:32 msi-mint kernel: [ 726.308506] hci_dev_close_sync+0x2a/0x550 [bluetooth]
Jul 3 16:40:32 msi-mint kernel: [ 726.308629] ? _raw_spin_lock+0x17/0x40
Jul 3 16:40:32 msi-mint kernel: [ 726.308638] hci_dev_do_close+0x2a/0x60 [bluetooth]
Jul 3 16:40:32 msi-mint kernel: [ 726.308698] hci_power_on+0x91/0x200 [bluetooth]
Jul 3 16:40:32 msi-mint kernel: [ 726.308754] ? lock_timer_base+0x72/0xa0
Jul 3 16:40:32 msi-mint kernel: [ 726.308768] process_one_work+0x21a/0x3f0
Jul 3 16:40:32 msi-mint kernel: [ 726.308776] worker_thread+0x4a/0x3b0
Jul 3 16:40:32 msi-mint kernel: [ 726.308784] ? process_one_work+0x3f0/0x3f0
Jul 3 16:40:32 msi-mint kernel: [ 726.308790] kthread+0xfd/0x130
Jul 3 16:40:32 msi-mint kernel: [ 726.308800] ? kthread_complete_and_exit+0x20/0x20
Jul 3 16:40:32 msi-mint kernel: [ 726.308811] ret_from_fork+0x1f/0x30
Jul 3 16:40:32 msi-mint kernel: [ 726.308827] </TASK>
The latter repeats.
Suspend isn't working: seems to kind of not do much of anything, the machine doesn't go to sleep. Attempting to shutdown after a (failed) suspend seems to hang in the shutdown process and requires a hard power down.
I've attached dmidecode output. dmidecode.txt
Please let me know if there is more logs/info required to track this down.