Bug 110700 - intel driver crashes with kernel 5.1.2 when booting with external monitor connected to Mini-Displayport
Summary: intel driver crashes with kernel 5.1.2 when booting with external monitor con...
Status: RESOLVED WORKSFORME
Alias: None
Product: DRI
Classification: Unclassified
Component: DRM/Intel (show other bugs)
Version: unspecified
Hardware: x86-64 (AMD64) Linux (All)
: medium normal
Assignee: Intel GFX Bugs mailing list
QA Contact: Intel GFX Bugs mailing list
URL:
Whiteboard: Triaged
Keywords:
Depends on:
Blocks:
 
Reported: 2019-05-17 05:30 UTC by public
Modified: 2019-08-06 08:27 UTC (History)
1 user (show)

See Also:
i915 platform: IVB
i915 features: display/DP

Attachments
journalctl -k -b -1 output (175.22 KB, text/plain)
2019-05-17 05:30 UTC, public 		no flags Details
journalctl -b -1 (217.12 KB, text/plain)
2019-05-17 05:32 UTC, public 		no flags Details
View All

Description public 2019-05-17 05:30:09 UTC 
Created attachment 144285 [details]
journalctl -k -b -1 output

I have a Lenovo Carbon X1 Notebook with an external monitor connected to my a Mini Display Port.

After updating from 5.0.13.arch1-1 to 5.1.2.arch1-1, the intel driver appears to crash after starting X (at least the mouse and keyboard get unresponsive) when I boot with the external monitor connected. However, booting without the external monitor works just fine, and I can plug it in afterwards without experiencing any problems. Unfortunately I cannot get a dmesg, but journalctl logs are provided below.

Reverting to an earlier kernel version solves the problem.

The culprit seems to be:

May 17 07:05:20 Gauss kernel: ------------[ cut here ]------------
May 17 07:05:20 Gauss kernel: vblank wait timed out on crtc 1
May 17 07:05:20 Gauss kernel: WARNING: CPU: 2 PID: 985 at drivers/gpu/drm/drm_vblank.c:1092 drm_wait_one_vblank+0x15c/0x170 [drm]
May 17 07:05:20 Gauss kernel: Modules linked in: uvcvideo videobuf2_vmalloc videobuf2_memops videobuf2_v4l2 videobuf2_common videodev media cdc_mbim cdc_ncm usbnet cdc_wdm cdc_acm mii snd_hda_codec_hdmi snd_hda_codec_realtek snd_hda_codec_generic intel_rapl x86_pkg_temp_thermal intel_powerclamp coretemp kvm_intel kvm joydev mousedev irqbypass crct10dif_pclmul arc4 crc32_pclmul i915 iwldvm mac80211 ghash_clmulni_intel i2c_algo_bit iwlwifi iTCO_wdt mei_wdt drm_kms_helper mei_hdcp iTCO_vendor_support snd_hda_intel aesni_intel drm wmi_bmof snd_hda_codec cfg80211 aes_x86_64 crypto_simd snd_hda_core cryptd glue_helper snd_hwdep intel_cstate intel_uncore snd_pcm thinkpad_acpi intel_rapl_perf i2c_i801 intel_gtt psmouse agpgart nvram pcspkr snd_timer ledtrig_audio mei_me lpc_ich syscopyarea input_leds intel_rst rfkill sysfillrect snd battery ac sysimgblt soundcore fb_sys_fops mei wmi intel_smartconnect pcc_cpufreq soc_button_array evdev mac_hid crypto_user acpi_call(OE) ip_tables x_tables ext4 hid_generic usbhid
May 17 07:05:20 Gauss kernel:  crc32c_generic hid crc16 mbcache jbd2 sd_mod serio_raw atkbd libps2 ahci libahci crc32c_intel libata sdhci_pci cqhci xhci_pci sdhci scsi_mod ehci_pci xhci_hcd mmc_core ehci_hcd i8042 serio
May 17 07:05:20 Gauss kernel: CPU: 2 PID: 985 Comm: gnome-shell Tainted: G           OE     5.1.2-arch1-1-ARCH #1
May 17 07:05:20 Gauss kernel: Hardware name: LENOVO 34482M0/34482M0, BIOS G6ET96WW (2.56 ) 04/29/2013
May 17 07:05:20 Gauss kernel: RIP: 0010:drm_wait_one_vblank+0x15c/0x170 [drm]
May 17 07:05:20 Gauss kernel: Code: d2 0f 0b e9 32 ff ff ff 48 89 e6 4c 89 f7 e8 7b 8e a2 d2 45 85 e4 0f 85 14 ff ff ff 89 ee 48 c7 c7 28 b8 8c c0 e8 be e3 9d d2 <0f> 0b e9 ff fe ff ff e8 a8 e0 9d d2 0f 1f 84 00 00 00 00 00 0f 1f
May 17 07:05:20 Gauss kernel: RSP: 0018:ffffabd881517a10 EFLAGS: 00010282
May 17 07:05:20 Gauss kernel: RAX: 0000000000000000 RBX: ffff9d0b4b308000 RCX: 0000000000000000
May 17 07:05:20 Gauss kernel: RDX: 0000000000000007 RSI: 0000000000000086 RDI: 00000000ffffffff
May 17 07:05:20 Gauss kernel: RBP: 0000000000000001 R08: 00000000000006af R09: 0000000000000004
May 17 07:05:20 Gauss kernel: R10: 0000000000000000 R11: 0000000000000001 R12: 0000000000000000
May 17 07:05:20 Gauss kernel: R13: 000000000000005b R14: ffff9d0b4b181160 R15: 0000000000071000
May 17 07:05:20 Gauss kernel: FS:  00007faed74cd100(0000) GS:ffff9d0b56480000(0000) knlGS:0000000000000000
May 17 07:05:20 Gauss kernel: CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
May 17 07:05:20 Gauss kernel: CR2: 00007fbf375f45c0 CR3: 000000020731c002 CR4: 00000000001606e0
May 17 07:05:20 Gauss kernel: Call Trace:
May 17 07:05:20 Gauss kernel:  ? wait_woken+0x80/0x80
May 17 07:05:20 Gauss kernel:  ironlake_crtc_enable+0x44d/0xbc0 [i915]
May 17 07:05:20 Gauss kernel:  intel_update_crtc+0x5f/0x410 [i915]
May 17 07:05:20 Gauss kernel:  intel_update_crtcs+0x4e/0x70 [i915]
May 17 07:05:20 Gauss kernel:  intel_atomic_commit_tail+0x396/0xe90 [i915]
May 17 07:05:20 Gauss kernel:  intel_atomic_commit+0x2a9/0x2e0 [i915]
May 17 07:05:20 Gauss kernel:  drm_atomic_helper_set_config+0x80/0x90 [drm_kms_helper]
May 17 07:05:20 Gauss kernel:  drm_mode_setcrtc+0x18d/0x690 [drm]
May 17 07:05:20 Gauss kernel:  ? drm_mode_getcrtc+0x180/0x180 [drm]
May 17 07:05:20 Gauss kernel:  drm_ioctl_kernel+0xb2/0xf0 [drm]
May 17 07:05:20 Gauss kernel:  drm_ioctl+0x25f/0x3f0 [drm]
May 17 07:05:20 Gauss kernel:  ? drm_mode_getcrtc+0x180/0x180 [drm]
May 17 07:05:20 Gauss kernel:  do_vfs_ioctl+0xa4/0x630
May 17 07:05:20 Gauss kernel:  ? handle_mm_fault+0x10a/0x250
May 17 07:05:20 Gauss kernel:  ksys_ioctl+0x60/0x90
May 17 07:05:20 Gauss kernel:  __x64_sys_ioctl+0x16/0x20
May 17 07:05:20 Gauss kernel:  do_syscall_64+0x5b/0x180
May 17 07:05:20 Gauss kernel:  entry_SYSCALL_64_after_hwframe+0x44/0xa9
May 17 07:05:20 Gauss kernel: RIP: 0033:0x7faedf533cbb
May 17 07:05:20 Gauss kernel: Code: 0f 1e fa 48 8b 05 a5 d1 0c 00 64 c7 00 26 00 00 00 48 c7 c0 ff ff ff ff c3 66 0f 1f 44 00 00 f3 0f 1e fa b8 10 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 75 d1 0c 00 f7 d8 64 89 01 48
May 17 07:05:20 Gauss kernel: RSP: 002b:00007ffe5fb2ec28 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
May 17 07:05:20 Gauss kernel: RAX: ffffffffffffffda RBX: 00007ffe5fb2ec60 RCX: 00007faedf533cbb
May 17 07:05:20 Gauss kernel: RDX: 00007ffe5fb2ec60 RSI: 00000000c06864a2 RDI: 000000000000000b
May 17 07:05:20 Gauss kernel: RBP: 00007ffe5fb2ec60 R08: 0000000000000000 R09: 0000560d4e185700
May 17 07:05:20 Gauss kernel: R10: 0000560d4b7ac4f0 R11: 0000000000000246 R12: 00000000c06864a2
May 17 07:05:20 Gauss kernel: R13: 000000000000000b R14: 0000000000000000 R15: 0000560d4b7ac4f0
May 17 07:05:20 Gauss kernel: ---[ end trace c5563909b4ce3a59 ]---
May 17 07:05:20 Gauss kernel: ------------[ cut here ]------------


Please find attached the complete logs run with drm.debug=0x1e log_buf_len=1M. 

Right now I'm not able to bisect, however I'll try my best to provide more information if needed.
Comment 1 public 2019-05-17 05:32:07 UTC 
Created attachment 144286 [details]
journalctl -b -1
Comment 2 Lakshmi 2019-05-20 07:17:05 UTC 
HI, Can you please reproduce the issue with drmtip (https://cgit.freedesktop.org/drm-tip) and kernel parameters drm.debug=0x1e log_buf_len=4M? 
If the problem persists attach the full dmesg log.

This issue could be related to Bug 109568.
Comment 3 Ville Syrjala 2019-06-14 18:44:26 UTC 
May 17 07:05:20 Gauss kernel: [drm:ironlake_crtc_enable [i915]] *ERROR* mode set failed: pipe B stuck

The problem is the pipe didn't start for some reason. There is one workaround 
we're missing, but unfortunately the docs don't have enough details to implement it. Another thing we're doing differently to the spec is manual vs. auto fdi train. So maybe something to try there.

However, since this is a new regression, and there haven't been any changes to the relevant code that I can see, a bisect would be most helpful. Can you do that?

I have similar IVB Carbon X1 here but unfortunately I wasn't able to reproduce this myself :(
Comment 4 cool2000 2019-06-16 18:02:02 UTC 
Hi,
A have the similar error with linux kernel 5.1.9 generic (Ubuntu build)
Motherboard ASUS Z170I PRO GAMING, BIOS 0403 09/29/2015 with Display-port 4K monitor connected.

[    2.966444] ------------[ cut here ]------------
[    2.966445] vblank wait timed out on crtc 0
[    2.966464] WARNING: CPU: 0 PID: 257 at drivers/gpu/drm/drm_vblank.c:1092 drm_wait_one_vblank+0x174/0x180 [drm]
[    2.966464] Modules linked in: i915(+) mxm_wmi i2c_algo_bit psmouse drm_kms_helper syscopyarea sysfillrect sysimgblt fb_sys_fops drm e1000e(+) ahci libahci wmi video
[    2.966468] CPU: 0 PID: 257 Comm: systemd-udevd Not tainted 5.1.9-050109-generic #201906111132
[    2.966468] Hardware name: System manufacturer System Product Name/Z170I PRO GAMING, BIOS 0403 09/29/2015
[    2.966475] RIP: 0010:drm_wait_one_vblank+0x174/0x180 [drm]
[    2.966476] Code: 0b e9 29 ff ff ff 48 8d 75 a8 4c 89 ff e8 f4 11 9a dc 45 85 ed 0f 85 09 ff ff ff 44 89 e6 48 c7 c7 70 59 36 c0 e8 be 3e 95 dc <0f> 0b e9 f3 fe ff ff e8 70 3b 95 dc 0f 1f 44 00 00 55 8b b7 90 00
[    2.966477] RSP: 0018:ffffb44b41fcb740 EFLAGS: 00010286
[    2.966477] RAX: 0000000000000000 RBX: ffffa0f132d20000 RCX: ffffffff9e268488
[    2.966478] RDX: 0000000000000001 RSI: 0000000000000096 RDI: 0000000000000247
[    2.966478] RBP: ffffb44b41fcb798 R08: 00000000000002ca R09: 0000000000000004
[    2.966479] R10: 0000000000000000 R11: 0000000000000001 R12: 0000000000000000
[    2.966479] R13: 0000000000000000 R14: 0000000000000001 R15: ffffa0f140a50808
[    2.966480] FS:  00007f0f40809680(0000) GS:ffffa0f153c00000(0000) knlGS:0000000000000000
[    2.966480] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[    2.966480] CR2: 00007f0f407cb1dc CR3: 000000043307e004 CR4: 00000000003606f0
[    2.966481] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
[    2.966481] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
[    2.966482] Call Trace:
[    2.966485]  ? wait_woken+0x80/0x80
[    2.966513]  skl_update_crtcs+0x1cf/0x300 [i915]
[    2.966537]  intel_atomic_commit_tail+0x3ab/0xee0 [i915]
[    2.966560]  ? intel_atomic_commit_ready+0x4d/0x50 [i915]
[    2.966579]  ? __i915_sw_fence_complete+0x10e/0x1a0 [i915]
[    2.966602]  intel_atomic_commit+0x2b8/0x2f0 [i915]
[    2.966610]  drm_atomic_commit+0x4a/0x50 [drm]
[    2.966632]  intel_modeset_init+0xc73/0xfb0 [i915]
[    2.966651]  i915_driver_load+0xd0e/0x1460 [i915]
[    2.966653]  ? _cond_resched+0x19/0x30
[    2.966672]  i915_pci_probe+0x46/0x60 [i915]
[    2.966674]  local_pci_probe+0x47/0x80
[    2.966675]  pci_device_probe+0x11c/0x1a0
[    2.966677]  really_probe+0xfe/0x3b0
[    2.966678]  driver_probe_device+0xba/0x100
[    2.966679]  device_driver_attach+0x59/0x60
[    2.966680]  __driver_attach+0x8f/0x150
[    2.966680]  ? device_driver_attach+0x60/0x60
[    2.966681]  bus_for_each_dev+0x79/0xc0
[    2.966683]  ? kmem_cache_alloc_trace+0x1ba/0x1d0
[    2.966684]  driver_attach+0x1e/0x20
[    2.966684]  bus_add_driver+0x151/0x1f0
[    2.966685]  ? 0xffffffffc05d7000
[    2.966686]  driver_register+0x70/0xc0
[    2.966686]  ? 0xffffffffc05d7000
[    2.966688]  __pci_register_driver+0x57/0x60
[    2.966706]  i915_init+0x5a/0x5d [i915]
[    2.966708]  do_one_initcall+0x4a/0x1c4
[    2.966709]  ? __vfree+0x22/0x60
[    2.966710]  ? _cond_resched+0x19/0x30
[    2.966711]  ? kmem_cache_alloc_trace+0x164/0x1d0
[    2.966713]  do_init_module+0x60/0x220
[    2.966714]  load_module+0x16f9/0x1970
[    2.966715]  __do_sys_finit_module+0xbd/0x120
[    2.966716]  ? __do_sys_finit_module+0xbd/0x120
[    2.966717]  __x64_sys_finit_module+0x1a/0x20
[    2.966718]  do_syscall_64+0x5a/0x110
[    2.966719]  entry_SYSCALL_64_after_hwframe+0x44/0xa9
[    2.966720] RIP: 0033:0x7f0f40313839
[    2.966721] Code: 00 f3 c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 40 00 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 1f f6 2c 00 f7 d8 64 89 01 48
[    2.966721] RSP: 002b:00007ffe30cd0de8 EFLAGS: 00000246 ORIG_RAX: 0000000000000139
[    2.966722] RAX: ffffffffffffffda RBX: 000055eca335e650 RCX: 00007f0f40313839
[    2.966722] RDX: 0000000000000000 RSI: 00007f0f3fff2145 RDI: 0000000000000012
[    2.966723] RBP: 00007f0f3fff2145 R08: 0000000000000000 R09: 00007ffe30cd0f00
[    2.966723] R10: 0000000000000012 R11: 0000000000000246 R12: 0000000000000000
[    2.966723] R13: 000055eca33427e0 R14: 0000000000020000 R15: 000055eca335e650
[    2.966724] ---[ end trace ac05d76dc859767d ]---

and

[    3.150408] ------------[ cut here ]------------
[    3.150408] pipe_off wait timed out
[    3.150461] WARNING: CPU: 3 PID: 295 at drivers/gpu/drm/i915/intel_display.c:1045 intel_disable_pipe+0x15d/0x170 [i915]
[    3.150461] Modules linked in: hid_generic(+) usbhid hid uas usb_storage i915 mxm_wmi i2c_algo_bit psmouse drm_kms_helper syscopyarea sysfillrect sysimgblt fb_sys_fops drm e1000e(+) ahci libahci wmi video
[    3.150465] CPU: 3 PID: 295 Comm: kworker/u16:7 Tainted: G        W         5.1.9-050109-generic #201906111132
[    3.150465] Hardware name: System manufacturer System Product Name/Z170I PRO GAMING, BIOS 0403 09/29/2015
[    3.150468] Workqueue: events_unbound async_run_entry_fn
[    3.150491] RIP: 0010:intel_disable_pipe+0x15d/0x170 [i915]
[    3.150492] Code: e0 5b 41 5c 41 5d 41 5e 5d c3 31 f6 e8 3c af ff ff 48 8d 65 e0 5b 41 5c 41 5d 41 5e 5d c3 48 c7 c7 fe e3 55 c0 e8 a5 59 7f dc <0f> 0b eb b0 66 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 40 00 0f 1f 44
[    3.150492] RSP: 0018:ffffb44b424438b0 EFLAGS: 00010282
[    3.150493] RAX: 0000000000000000 RBX: ffffa0f132d20000 RCX: 0000000000000000
[    3.150493] RDX: 0000000000000000 RSI: 0000000000000002 RDI: 0000000000000202
[    3.150494] RBP: ffffb44b424438d0 R08: 0000000000000000 R09: 0000000000022700
[    3.150494] R10: 00000022a70fb73e R11: 00000000000308dc R12: 0000000000070008
[    3.150494] R13: 0000000000000000 R14: ffffa0f1333cd800 R15: ffffa0f132d20000
[    3.150495] FS:  0000000000000000(0000) GS:ffffa0f153cc0000(0000) knlGS:0000000000000000
[    3.150495] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[    3.150496] CR2: 00007f0f405e76e8 CR3: 000000014300e001 CR4: 00000000003606e0
[    3.150496] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
[    3.150496] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
[    3.150497] Call Trace:
[    3.150519]  haswell_crtc_disable+0xf1/0x140 [i915]
[    3.150541]  intel_atomic_commit_tail+0x24c/0xee0 [i915]
[    3.150562]  intel_atomic_commit+0x2b8/0x2f0 [i915]
[    3.150571]  drm_atomic_commit+0x4a/0x50 [drm]
[    3.150575]  restore_fbdev_mode_atomic+0x1bf/0x1d0 [drm_kms_helper]
[    3.150578]  restore_fbdev_mode+0x4e/0x160 [drm_kms_helper]
[    3.150580]  ? _cond_resched+0x19/0x30
[    3.150583]  drm_fb_helper_restore_fbdev_mode_unlocked+0x4e/0xa0 [drm_kms_helper]
[    3.150586]  drm_fb_helper_set_par+0x2d/0x50 [drm_kms_helper]
[    3.150607]  intel_fbdev_set_par+0x1a/0x50 [i915]
[    3.150609]  fbcon_init+0x4a4/0x5e0
[    3.150610]  visual_init+0xd5/0x130
[    3.150611]  do_bind_con_driver+0x1e8/0x2e0
[    3.150612]  do_take_over_console+0x129/0x1a0
[    3.150613]  do_fbcon_takeover+0x5c/0xb0
[    3.150614]  fbcon_event_notify+0x787/0x7b9
[    3.150615]  notifier_call_chain+0x4c/0x70
[    3.150616]  blocking_notifier_call_chain+0x43/0x60
[    3.150617]  fb_notifier_call_chain+0x1b/0x20
[    3.150618]  register_framebuffer+0x25c/0x350
[    3.150621]  __drm_fb_helper_initial_config_and_unlock+0x2c0/0x480 [drm_kms_helper]
[    3.150624]  drm_fb_helper_initial_config+0x35/0x40 [drm_kms_helper]
[    3.150644]  intel_fbdev_initial_config+0x18/0x30 [i915]
[    3.150646]  async_run_entry_fn+0x3c/0x150
[    3.150647]  process_one_work+0x20f/0x410
[    3.150648]  worker_thread+0x34/0x400
[    3.150649]  kthread+0x120/0x140
[    3.150649]  ? process_one_work+0x410/0x410
[    3.150650]  ? __kthread_parkme+0x70/0x70
[    3.150651]  ret_from_fork+0x35/0x40
[    3.150652] ---[ end trace ac05d76dc859767e ]---
Comment 5 Lakshmi 2019-07-29 11:56:19 UTC 
(In reply to Ville Syrjala from comment #3)
> May 17 07:05:20 Gauss kernel: [drm:ironlake_crtc_enable [i915]] *ERROR* mode
> set failed: pipe B stuck
> 
> The problem is the pipe didn't start for some reason. There is one
> workaround 
> we're missing, but unfortunately the docs don't have enough details to
> implement it. Another thing we're doing differently to the spec is manual
> vs. auto fdi train. So maybe something to try there.
> 
> However, since this is a new regression, and there haven't been any changes
> to the relevant code that I can see, a bisect would be most helpful. Can you
> do that?
> 
> I have similar IVB Carbon X1 here but unfortunately I wasn't able to
> reproduce this myself :(

Reporter, can you please bisect this issue to make progress with this bug?
Comment 6 public 2019-08-03 14:24:23 UTC 
After updating to kernel version 5.2.5-arch1-1-ARCH the bug is not reproducible, that is startup works as expected and there are no errors in the log files.

I think a bisect is not worth the effort anymore, as it's fixed in the latest version for me and noone else seems to be affected, right?
Thansk for your help.
Comment 7 Lakshmi 2019-08-06 08:27:21 UTC 
(In reply to public from comment #6)
> After updating to kernel version 5.2.5-arch1-1-ARCH the bug is not
> reproducible, that is startup works as expected and there are no errors in
> the log files.
> 
> I think a bisect is not worth the effort anymore, as it's fixed in the
> latest version for me and noone else seems to be affected, right?
> Thansk for your help.

Thanks for the feedback closing this bug as WORKSFORME.

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.