Bug#971068: linux-image-5.8.0-2-686-pae: Assertion failure in i915 intel_display.c#assert_plane() after resume from hibernation

[Salvatore Bonaccorso <carnil@debian.org>]

Hi,

On Sat, Oct 31, 2020 at 06:23:59PM +0100, наб wrote:
> retitle 971068 linux-image-5.9.0-1-686-pae: Assertion failure in i915 intel_display.c#assert_plane() after resume from hibernation
> found 971068 5.9.1-1
> thanks
> 
> Turns out the delay was because my system was horriby starved for I/O,
> switching to an SSD revealed that the display is ready immediately after
> unhibernating, so the impact of this is low.
> 
> Here's the crashes for 5.9.1-1 (uname -a:
> Linux nabtop 5.9.0-1-686-pae #1 SMP Debian 5.9.1-1 (2020-10-17) i686 GNU/Linux):
> 
> -- >8 --
> Oct 31 17:30:48 nabtop kernel: ------------[ cut here ]------------
> Oct 31 17:30:48 nabtop kernel: primary B assertion failure (expected off, current on)
> Oct 31 17:30:48 nabtop kernel: WARNING: CPU: 1 PID: 31490 at drivers/gpu/drm/i915/display/intel_display.c:1299 assert_plane+0xb9/0xd0 [i915]
> Oct 31 17:30:48 nabtop kernel: Modules linked in: tcp_diag udp_diag raw_diag inet_diag unix_diag af_packet_diag netlink_diag cuse fuse nls_utf8 cifs dns_resolver fscache zram zsmalloc ghash_generic gf128mul gcm ccm algif_aead des_generic libdes ctr cbc ecb algif_skcipher bnep cmac sha512_generic md4 algif_hash af_alg binfmt_misc zfs(POE) zunicode(POE) zlua(POE) zcommon(POE) znvpair(POE) zavl(POE) icp(POE) spl(OE) joydev btusb btrtl btbcm btintel bluetooth jitterentropy_rng uvcvideo videobuf2_vmalloc videobuf2_memops videobuf2_v4l2 videobuf2_common drbg videodev mc aes_generic crypto_simd cryptd ansi_cprng ecdh_generic ecc libaes snd_hda_codec_conexant snd_hda_codec_generic ledtrig_audio i915 iTCO_wdt iwldvm intel_pmc_bxt snd_hda_intel iTCO_vendor_support kvm_intel snd_intel_dspcfg watchdog mac80211 kvm snd_hda_codec libarc4 nls_ascii irqbypass snd_hda_core iwlwifi snd_hwdep i2c_i801 wmi_bmof pcspkr psmouse i2c_smbus evdev nls_cp437 snd_pcm vfat cfg80211 sg fat drm_kms_helper sky2 lpc_ich snd_timer
> Oct 31 17:30:48 nabtop kernel:  toshiba_acpi snd cec soundcore industrialio i2c_algo_bit sparse_keymap toshiba_bluetooth rfkill toshiba_haps ac button acpi_cpufreq nft_counter nf_log_ipv6 nf_log_ipv4 nf_log_common nft_log nft_limit nft_ct nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 libcrc32c nf_tables nfnetlink drm ip_tables x_tables ext4 crc16 mbcache jbd2 crc32c_generic sd_mod t10_pi crc_t10dif sr_mod crct10dif_generic cdrom crct10dif_common uhci_hcd ehci_pci ehci_hcd sdhci_pci cqhci ahci libahci libata sdhci serio_raw mmc_core firewire_ohci usbcore usb_common wmi battery video pkcs8_key_parser coretemp firewire_sbp2 firewire_core crc_itu_t scsi_mod parport_pc ppdev lp parport autofs4
> Oct 31 17:30:48 nabtop kernel: CPU: 1 PID: 31490 Comm: kworker/u4:4 Tainted: P        W  OE     5.9.0-1-686-pae #1 Debian 5.9.1-1
> Oct 31 17:30:48 nabtop kernel: Hardware name: TOSHIBA Satellite Pro U400/Satellite Pro U400, BIOS V5.00    10/26/2010
> Oct 31 17:30:48 nabtop kernel: Workqueue: events_unbound async_run_entry_fn
> Oct 31 17:30:48 nabtop kernel: EIP: assert_plane+0xb9/0xd0 [i915]
> Oct 31 17:30:48 nabtop kernel: Code: 90 b9 f6 72 bd f8 84 c0 ba f2 72 bd f8 89 c8 0f 44 c2 89 c7 89 f0 84 c0 57 0f 45 d1 52 ff 73 0c 68 08 9f bb f8 e8 e7 8d 56 df <0f> 0b 83 c4 10 e9 70 ff ff ff e8 f8 9f c9 df 8d b4 26 00 00 00 00
> Oct 31 17:30:48 nabtop kernel: EAX: 00000036 EBX: ecf17000 ECX: f6fe5140 EDX: ffffffd8
> Oct 31 17:30:48 nabtop kernel: ESI: 00000000 EDI: f8bd72f6 EBP: d3ad9cc4 ESP: d3ad9ca0
> Oct 31 17:30:48 nabtop kernel: DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 EFLAGS: 00010292
> Oct 31 17:30:48 nabtop kernel: CR0: 80050033 CR2: 00000000 CR3: 18bb2000 CR4: 000006f0
> Oct 31 17:30:48 nabtop kernel: Call Trace:
> Oct 31 17:30:48 nabtop kernel:  intel_disable_pipe+0x81/0x210 [i915]
> Oct 31 17:30:48 nabtop kernel:  i9xx_crtc_disable+0x6c/0x310 [i915]
> Oct 31 17:30:48 nabtop kernel:  ? __pm_runtime_resume+0x58/0x80
> Oct 31 17:30:48 nabtop kernel:  ? gen2_read8+0x170/0x170 [i915]
> Oct 31 17:30:48 nabtop kernel:  ? intel_synchronize_irq+0x19/0x20 [i915]
> Oct 31 17:30:48 nabtop kernel:  ? intel_crtc_disable_pipe_crc+0x9b/0xb0 [i915]
> Oct 31 17:30:48 nabtop kernel:  ? i830_enable_pipe+0x520/0x520 [i915]
> Oct 31 17:30:48 nabtop kernel:  intel_old_crtc_state_disables+0x106/0x160 [i915]
> Oct 31 17:30:48 nabtop kernel:  intel_atomic_commit_tail+0xcb2/0x12c0 [i915]
> Oct 31 17:30:48 nabtop kernel:  ? __schedule+0x27a/0x940
> Oct 31 17:30:48 nabtop kernel:  ? add_wait_queue_exclusive+0x60/0x60
> Oct 31 17:30:48 nabtop kernel:  ? add_wait_queue_exclusive+0x60/0x60
> Oct 31 17:30:48 nabtop kernel:  intel_atomic_commit+0x325/0x3b0 [i915]
> Oct 31 17:30:48 nabtop kernel:  ? intel_atomic_commit+0x325/0x3b0 [i915]
> Oct 31 17:30:48 nabtop kernel:  ? intel_atomic_commit_tail+0x12c0/0x12c0 [i915]
> Oct 31 17:30:48 nabtop kernel:  drm_atomic_commit+0x3a/0x50 [drm]
> Oct 31 17:30:48 nabtop kernel:  drm_atomic_helper_commit_duplicated_state+0xb6/0xd0 [drm_kms_helper]
> Oct 31 17:30:48 nabtop kernel:  __intel_display_resume+0x73/0xd0 [i915]
> Oct 31 17:30:48 nabtop kernel:  intel_display_resume+0x75/0xe0 [i915]
> Oct 31 17:30:48 nabtop kernel:  i915_drm_resume+0xb2/0x110 [i915]
> Oct 31 17:30:48 nabtop kernel:  i915_pm_restore+0x19/0x30 [i915]
> Oct 31 17:30:48 nabtop kernel:  pci_pm_restore+0x57/0xe0
> Oct 31 17:30:48 nabtop kernel:  dpm_run_callback+0x55/0x140
> Oct 31 17:30:48 nabtop kernel:  ? pci_pm_poweroff_noirq+0x110/0x110
> Oct 31 17:30:48 nabtop kernel:  device_resume+0x79/0x160
> Oct 31 17:30:48 nabtop kernel:  ? device_resume+0x160/0x160
> Oct 31 17:30:48 nabtop kernel:  async_resume+0x1b/0x30
> Oct 31 17:30:48 nabtop kernel:  async_run_entry_fn+0x3a/0x170
> Oct 31 17:30:48 nabtop kernel:  process_one_work+0x176/0x320
> Oct 31 17:30:48 nabtop kernel:  worker_thread+0x15e/0x3e0
> Oct 31 17:30:48 nabtop kernel:  kthread+0xf6/0x110
> Oct 31 17:30:48 nabtop kernel:  ? process_one_work+0x320/0x320
> Oct 31 17:30:48 nabtop kernel:  ? kthread_associate_blkcg+0x90/0x90
> Oct 31 17:30:48 nabtop kernel:  ret_from_fork+0x19/0x28
> Oct 31 17:30:48 nabtop kernel: ---[ end trace 992e82fb9b5b3b56 ]---
> -- >8 --
> 
> -- >8 --
> Oct 31 17:30:48 nabtop kernel: ------------[ cut here ]------------
> Oct 31 17:30:48 nabtop kernel: primary B assertion failure (expected off, current on)
> Oct 31 17:30:48 nabtop kernel: WARNING: CPU: 1 PID: 31490 at drivers/gpu/drm/i915/display/intel_display.c:1299 assert_plane+0xb9/0xd0 [i915]
> Oct 31 17:30:48 nabtop kernel: Modules linked in: tcp_diag udp_diag raw_diag inet_diag unix_diag af_packet_diag netlink_diag cuse fuse nls_utf8 cifs dns_resolver fscache zram zsmalloc ghash_generic gf128mul gcm ccm algif_aead des_generic libdes ctr cbc ecb algif_skcipher bnep cmac sha512_generic md4 algif_hash af_alg binfmt_misc zfs(POE) zunicode(POE) zlua(POE) zcommon(POE) znvpair(POE) zavl(POE) icp(POE) spl(OE) joydev btusb btrtl btbcm btintel bluetooth jitterentropy_rng uvcvideo videobuf2_vmalloc videobuf2_memops videobuf2_v4l2 videobuf2_common drbg videodev mc aes_generic crypto_simd cryptd ansi_cprng ecdh_generic ecc libaes snd_hda_codec_conexant snd_hda_codec_generic ledtrig_audio i915 iTCO_wdt iwldvm intel_pmc_bxt snd_hda_intel iTCO_vendor_support kvm_intel snd_intel_dspcfg watchdog mac80211 kvm snd_hda_codec libarc4 nls_ascii irqbypass snd_hda_core iwlwifi snd_hwdep i2c_i801 wmi_bmof pcspkr psmouse i2c_smbus evdev nls_cp437 snd_pcm vfat cfg80211 sg fat drm_kms_helper sky2 lpc_ich snd_timer
> Oct 31 17:30:48 nabtop kernel:  toshiba_acpi snd cec soundcore industrialio i2c_algo_bit sparse_keymap toshiba_bluetooth rfkill toshiba_haps ac button acpi_cpufreq nft_counter nf_log_ipv6 nf_log_ipv4 nf_log_common nft_log nft_limit nft_ct nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 libcrc32c nf_tables nfnetlink drm ip_tables x_tables ext4 crc16 mbcache jbd2 crc32c_generic sd_mod t10_pi crc_t10dif sr_mod crct10dif_generic cdrom crct10dif_common uhci_hcd ehci_pci ehci_hcd sdhci_pci cqhci ahci libahci libata sdhci serio_raw mmc_core firewire_ohci usbcore usb_common wmi battery video pkcs8_key_parser coretemp firewire_sbp2 firewire_core crc_itu_t scsi_mod parport_pc ppdev lp parport autofs4
> Oct 31 17:30:48 nabtop kernel: CPU: 1 PID: 31490 Comm: kworker/u4:4 Tainted: P        W  OE     5.9.0-1-686-pae #1 Debian 5.9.1-1
> Oct 31 17:30:48 nabtop kernel: Hardware name: TOSHIBA Satellite Pro U400/Satellite Pro U400, BIOS V5.00    10/26/2010
> Oct 31 17:30:48 nabtop kernel: Workqueue: events_unbound async_run_entry_fn
> Oct 31 17:30:48 nabtop kernel: EIP: assert_plane+0xb9/0xd0 [i915]
> Oct 31 17:30:48 nabtop kernel: Code: 90 b9 f6 72 bd f8 84 c0 ba f2 72 bd f8 89 c8 0f 44 c2 89 c7 89 f0 84 c0 57 0f 45 d1 52 ff 73 0c 68 08 9f bb f8 e8 e7 8d 56 df <0f> 0b 83 c4 10 e9 70 ff ff ff e8 f8 9f c9 df 8d b4 26 00 00 00 00
> Oct 31 17:30:48 nabtop kernel: EAX: 00000036 EBX: ecf17000 ECX: f6fe5140 EDX: ffffffd8
> Oct 31 17:30:48 nabtop kernel: ESI: 00000000 EDI: f8bd72f6 EBP: d3ad9d60 ESP: d3ad9d3c
> Oct 31 17:30:48 nabtop kernel: DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 EFLAGS: 00010292
> Oct 31 17:30:48 nabtop kernel: CR0: 80050033 CR2: 00000000 CR3: 18bb2000 CR4: 000006f0
> Oct 31 17:30:48 nabtop kernel: Call Trace:
> Oct 31 17:30:48 nabtop kernel:  intel_atomic_commit_tail+0xf03/0x12c0 [i915]
> Oct 31 17:30:48 nabtop kernel:  ? __schedule+0x27a/0x940
> Oct 31 17:30:48 nabtop kernel:  ? add_wait_queue_exclusive+0x60/0x60
> Oct 31 17:30:48 nabtop kernel:  ? add_wait_queue_exclusive+0x60/0x60
> Oct 31 17:30:48 nabtop kernel:  intel_atomic_commit+0x325/0x3b0 [i915]
> Oct 31 17:30:48 nabtop kernel:  ? intel_atomic_commit+0x325/0x3b0 [i915]
> Oct 31 17:30:48 nabtop kernel:  ? intel_atomic_commit_tail+0x12c0/0x12c0 [i915]
> Oct 31 17:30:48 nabtop kernel:  drm_atomic_commit+0x3a/0x50 [drm]
> Oct 31 17:30:48 nabtop kernel:  drm_atomic_helper_commit_duplicated_state+0xb6/0xd0 [drm_kms_helper]
> Oct 31 17:30:48 nabtop kernel:  __intel_display_resume+0x73/0xd0 [i915]
> Oct 31 17:30:48 nabtop kernel:  intel_display_resume+0x75/0xe0 [i915]
> Oct 31 17:30:48 nabtop kernel:  i915_drm_resume+0xb2/0x110 [i915]
> Oct 31 17:30:48 nabtop kernel:  i915_pm_restore+0x19/0x30 [i915]
> Oct 31 17:30:48 nabtop kernel:  pci_pm_restore+0x57/0xe0
> Oct 31 17:30:48 nabtop kernel:  dpm_run_callback+0x55/0x140
> Oct 31 17:30:48 nabtop kernel:  ? pci_pm_poweroff_noirq+0x110/0x110
> Oct 31 17:30:48 nabtop kernel:  device_resume+0x79/0x160
> Oct 31 17:30:48 nabtop kernel:  ? device_resume+0x160/0x160
> Oct 31 17:30:48 nabtop kernel:  async_resume+0x1b/0x30
> Oct 31 17:30:48 nabtop kernel:  async_run_entry_fn+0x3a/0x170
> Oct 31 17:30:48 nabtop kernel:  process_one_work+0x176/0x320
> Oct 31 17:30:48 nabtop kernel:  worker_thread+0x15e/0x3e0
> Oct 31 17:30:48 nabtop kernel:  kthread+0xf6/0x110
> Oct 31 17:30:48 nabtop kernel:  ? process_one_work+0x320/0x320
> Oct 31 17:30:48 nabtop kernel:  ? kthread_associate_blkcg+0x90/0x90
> Oct 31 17:30:48 nabtop kernel:  ret_from_fork+0x19/0x28
> Oct 31 17:30:48 nabtop kernel: ---[ end trace 992e82fb9b5b3b57 ]---
> -- >8 --

Is this still something you can reproduce with a current kernel from
the 5.10.y stable series? How about kernel from unstable (6.1.7-1) if
you can test that one as well?

Regards,
Salvatore