Bug 96441

Summary: [i915] vblank wait timed out on crtc
Product: DRI Reporter: Malcolm Lewis <malcolmlewis>
Component: DRM/IntelAssignee: Intel GFX Bugs mailing list <intel-gfx-bugs>
Status: CLOSED DUPLICATE QA Contact: Intel GFX Bugs mailing list <intel-gfx-bugs>
Severity: normal    
Priority: medium CC: intel-gfx-bugs, nemesis
Version: unspecified   
Hardware: Other   
OS: Linux (All)   
Whiteboard:
i915 platform: I965GM i915 features: display/Other
Attachments:
Description Flags
Messages_beta3_kernel
none
Messages_4.7-rc3_kernel
none
Messages_4.7-rc3_kernel_debug none

Description Malcolm Lewis 2016-06-08 18:08:47 UTC
Hi
I'm using kernel 4.4.11 on SLED 12 and am getting the following journalctl entries as follows;

Jun 08 11:35:56 mizz-piggy kernel: ------------[ cut here ]------------
Jun 08 11:35:56 mizz-piggy kernel: WARNING: CPU: 1 PID: 229 at ../drivers/gpu/drm/drm_irq.c:1326 drm_wait_one_vblank+0x136/0x170 [drm]()
Jun 08 11:35:56 mizz-piggy kernel: vblank wait timed out on crtc 0
Jun 08 11:35:56 mizz-piggy kernel: Modules linked in: raid6_pq(+) sr_mod cdrom sd_mod ata_generic hid_generic usbhid ata_piix uas usb_stora
Jun 08 11:35:56 mizz-piggy kernel: Supported: Yes
Jun 08 11:35:56 mizz-piggy kernel: CPU: 1 PID: 229 Comm: plymouthd Tainted: G        W          4.4.11-41-default #1
Jun 08 11:35:56 mizz-piggy kernel: Hardware name: Apple Inc. MacBook3,1/Mac-F22788C8, BIOS     MB31.88Z.008E.B02.0803051832 03/05/08
Jun 08 11:35:56 mizz-piggy kernel:  0000000000000000 ffffffff81309f40 ffff88003f433978 ffffffffa019b27d
Jun 08 11:35:56 mizz-piggy kernel:  ffffffff8107c021 0000000000000000 ffff88003f4339c8 0000000000000000
Jun 08 11:35:56 mizz-piggy kernel:  000000000000000a ffff88003faab008 ffffffff8107c09c ffffffffa019e028
Jun 08 11:35:56 mizz-piggy kernel: Call Trace:
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffff81019a99>] dump_trace+0x59/0x310
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffff81019e3a>] show_stack_log_lvl+0xea/0x170
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffff8101abc1>] show_stack+0x21/0x40
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffff81309f40>] dump_stack+0x5c/0x7c
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffff8107c021>] warn_slowpath_common+0x81/0xb0
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffff8107c09c>] warn_slowpath_fmt+0x4c/0x50
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffffa0170196>] drm_wait_one_vblank+0x136/0x170 [drm]
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffffa037ee7e>] intel_pre_disable_primary+0x4e/0x80 [i915]
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffffa037f094>] intel_pre_plane_update+0xf4/0x120 [i915]
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffffa037f5c9>] intel_atomic_commit+0xd9/0x660 [i915]
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffffa038501b>] intel_release_load_detect_pipe+0xeb/0x160 [i915]
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffffa03bc4e5>] intel_tv_detect+0x375/0x570 [i915]
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffffa0114ba4>] drm_helper_probe_single_connector_modes_merge_bits+0x2d4/0x480 [drm_kms_helper]
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffffa017b812>] drm_mode_getconnector+0x322/0x390 [drm]
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffffa016e56f>] drm_ioctl+0x21f/0x440 [drm]
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffff81209f0d>] do_vfs_ioctl+0x2cd/0x4a0
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffff8120a154>] SyS_ioctl+0x74/0x80
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffff815e64ee>] entry_SYSCALL_64_fastpath+0x12/0x6d
Jun 08 11:35:56 mizz-piggy kernel: DWARF2 unwinder stuck at entry_SYSCALL_64_fastpath+0x12/0x6d
Jun 08 11:35:56 mizz-piggy kernel: 
Jun 08 11:35:56 mizz-piggy kernel: Leftover inexact backtrace:
Jun 08 11:35:56 mizz-piggy kernel: ---[ end trace 232fcfda67f553b3 ]---
Jun 08 11:35:56 mizz-piggy kernel: raid6: sse2x4   gen()  5842 MB/s
Jun 08 11:35:56 mizz-piggy kernel: ------------[ cut here ]------------
Jun 08 11:35:56 mizz-piggy kernel: WARNING: CPU: 1 PID: 229 at ../drivers/gpu/drm/drm_irq.c:1326 drm_wait_one_vblank+0x136/0x170 [drm]()
Jun 08 11:35:56 mizz-piggy kernel: vblank wait timed out on crtc 0
Jun 08 11:35:56 mizz-piggy kernel: Modules linked in: raid6_pq(+) sr_mod cdrom sd_mod ata_generic hid_generic usbhid ata_piix uas usb_stora
Jun 08 11:35:56 mizz-piggy kernel: Supported: Yes
Jun 08 11:35:56 mizz-piggy kernel: CPU: 1 PID: 229 Comm: plymouthd Tainted: G        W          4.4.11-41-default #1
Jun 08 11:35:56 mizz-piggy kernel: Hardware name: Apple Inc. MacBook3,1/Mac-F22788C8, BIOS     MB31.88Z.008E.B02.0803051832 03/05/08
Jun 08 11:35:56 mizz-piggy kernel:  0000000000000000 ffffffff81309f40 ffff88003f433990 ffffffffa019b27d
Jun 08 11:35:56 mizz-piggy kernel:  ffffffff8107c021 0000000000000000 ffff88003f4339e0 0000000000000000
Jun 08 11:35:56 mizz-piggy kernel:  000000000000000a ffff88003faab008 ffffffff8107c09c ffffffffa019e028
Jun 08 11:35:56 mizz-piggy kernel: Call Trace:
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffff81019a99>] dump_trace+0x59/0x310
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffff81019e3a>] show_stack_log_lvl+0xea/0x170
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffff8101abc1>] show_stack+0x21/0x40
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffff81309f40>] dump_stack+0x5c/0x7c
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffff8107c021>] warn_slowpath_common+0x81/0xb0
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffff8107c09c>] warn_slowpath_fmt+0x4c/0x50
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffffa0170196>] drm_wait_one_vblank+0x136/0x170 [drm]
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffffa0379f9f>] i9xx_crtc_disable+0x2f/0x420 [i915]
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffffa037f5ea>] intel_atomic_commit+0xfa/0x660 [i915]
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffffa038501b>] intel_release_load_detect_pipe+0xeb/0x160 [i915]
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffffa03bc4e5>] intel_tv_detect+0x375/0x570 [i915]
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffffa0114ba4>] drm_helper_probe_single_connector_modes_merge_bits+0x2d4/0x480 [drm_kms_helper]
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffffa017b812>] drm_mode_getconnector+0x322/0x390 [drm]
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffffa016e56f>] drm_ioctl+0x21f/0x440 [drm]
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffff81209f0d>] do_vfs_ioctl+0x2cd/0x4a0
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffff8120a154>] SyS_ioctl+0x74/0x80
Jun 08 11:35:56 mizz-piggy kernel:  [<ffffffff815e64ee>] entry_SYSCALL_64_fastpath+0x12/0x6d
Jun 08 11:35:56 mizz-piggy kernel: DWARF2 unwinder stuck at entry_SYSCALL_64_fastpath+0x12/0x6d
Jun 08 11:35:56 mizz-piggy kernel: 
Jun 08 11:35:56 mizz-piggy kernel: Leftover inexact backtrace:
Jun 08 11:35:56 mizz-piggy kernel: ---[ end trace 232fcfda67f553b4 ]---

Whilst I don't see any effects with normal use, they do fill the logs at random times.

Environment;
- System: MacBook3,1 A1181
- GPU: Intel GMA X3100;
VGA compatible controller [0300]: Intel Corporation Mobile GM965/GL960 Integrated Graphics Controller (primary) [8086:2a02] (rev 03)
- OS: SUSE Linux Enterprise 12 SP2 Beta2

I also have an open SUSE bug reference https://bugzilla.suse.com/show_bug.cgi?id=980429 as well.
Comment 1 Malcolm Lewis 2016-06-19 03:55:34 UTC
Created attachment 124597 [details]
Messages_beta3_kernel

Updated log messages for 4.4.13 kernel
Comment 2 Malcolm Lewis 2016-06-19 03:58:01 UTC
Created attachment 124598 [details]
Messages_4.7-rc3_kernel

This is also affecting the latest kernel and have attached messages file.
Comment 3 Malcolm Lewis 2016-06-19 03:59:49 UTC
Created attachment 124599 [details]
Messages_4.7-rc3_kernel_debug

4.7-rc3 kernel with drm.debug=0x0e boot option added.
Comment 4 Ryan Underwood 2016-06-29 23:02:58 UTC
Also happening on 4.5.7-040507-generic from ubuntu with intel_drv.so 2.99.917.
The effect is strange artifacts on the screen after some suspend-to-RAM/resume cycles.

[267338.532050] ------------[ cut here ]------------
[267338.532093] WARNING: CPU: 1 PID: 1640 at /home/kernel/COD/linux/drivers/gpu/drm/drm_irq.c:1329 drm_wait_one_vblank+0x1b5/0x1c0 [drm]()
[267338.532094] vblank wait timed out on crtc 1
[267338.532136] Modules linked in: rndis_host cdc_ether usbnet btrfs xor raid6_pq ufs qnx4 hfsplus hfs minix ntfs msdos jfs xfs libcrc32c openafs(POE) ctr ccm binfmt_misc arc4 snd_hda_codec_conexant snd_hda_codec_generic snd_hda_intel ath5k snd_hda_codec snd_hda_core snd_hwdep ath mac80211 snd_pcm snd_seq_midi snd_seq_midi_event coretemp gpio_ich snd_rawmidi snd_seq cfg80211 snd_seq_device snd_timer kvm snd hp_wmi sparse_keymap soundcore irqbypass input_leds joydev serio_raw shpchp lpc_ich mac_hid parport_pc ppdev lp parport autofs4 drbg ansi_cprng xts gf128mul algif_skcipher af_alg dm_crypt ums_realtek uas usb_storage i915 psmouse ahci libahci i2c_algo_bit drm_kms_helper pata_acpi syscopyarea sysfillrect 8139too sysimgblt fb_sys_fops 8139cp mii drm wmi fjes video
[267338.532139] CPU: 1 PID: 1640 Comm: Xorg Tainted: P        W  OE   4.5.7-040507-generic #201606100436
[267338.532139] Hardware name: Hewlett-Packard Compaq Presario C700 Notebook PC/30D9, BIOS F.35 03/29/2010
[267338.532142]  0000000000000286 00000000b6fe1220 ffff8800ba2777d0 ffffffff813e1173
[267338.532144]  ffff8800ba277818 ffffffffc005dd38 ffff8800ba277808 ffffffff81080ff2
[267338.532145]  ffff880035bf7000 0000000000000001 0000000000000000 000000000c001390
[267338.532146] Call Trace:
[267338.532151]  [<ffffffff813e1173>] dump_stack+0x63/0x90
[267338.532154]  [<ffffffff81080ff2>] warn_slowpath_common+0x82/0xc0
[267338.532156]  [<ffffffff8108108c>] warn_slowpath_fmt+0x5c/0x80
[267338.532159]  [<ffffffff810c3c75>] ? finish_wait+0x55/0x70
[267338.532170]  [<ffffffffc002d3a5>] drm_wait_one_vblank+0x1b5/0x1c0 [drm]
[267338.532171]  [<ffffffff810c4110>] ? wake_atomic_t_function+0x60/0x60
[267338.532226]  [<ffffffffc01dbc4d>] i9xx_crtc_disable+0x3d/0x460 [i915]
[267338.532248]  [<ffffffffc01d3b9c>] ? intel_crtc_disable_planes+0xdc/0xf0 [i915]
[267338.532271]  [<ffffffffc01e1521>] intel_atomic_commit+0x3c1/0xb40 [i915]
[267338.532285]  [<ffffffffc0046771>] ? drm_atomic_check_only+0x181/0x600 [drm]
[267338.532299]  [<ffffffffc0045f8f>] ? drm_atomic_set_crtc_for_connector+0x2f/0xe0 [drm]
[267338.532313]  [<ffffffffc0046c27>] drm_atomic_commit+0x37/0x60 [drm]
[267338.532330]  [<ffffffffc00ed89f>] restore_fbdev_mode+0x22f/0x260 [drm_kms_helper]
[267338.532343]  [<ffffffffc004589a>] ? drm_modeset_lock_all_ctx+0x9a/0xb0 [drm]
[267338.532350]  [<ffffffffc00efa83>] drm_fb_helper_restore_fbdev_mode_unlocked+0x33/0x80 [drm_kms_helper]
[267338.532356]  [<ffffffffc00efafd>] drm_fb_helper_set_par+0x2d/0x50 [drm_kms_helper]
[267338.532379]  [<ffffffffc01f70ca>] intel_fbdev_set_par+0x1a/0x60 [i915]
[267338.532381]  [<ffffffff81465396>] fb_set_var+0x236/0x470
[267338.532384]  [<ffffffff818211c3>] ? __schedule+0x2e3/0x780
[267338.532385]  [<ffffffff81821e90>] ? bit_wait+0x60/0x60
[267338.532386]  [<ffffffff81821695>] ? schedule+0x35/0x80
[267338.532389]  [<ffffffff8145b68f>] fbcon_blank+0x30f/0x350
[267338.532391]  [<ffffffff81821a54>] ? __wait_on_bit+0x74/0x90
[267338.532394]  [<ffffffff814f2ac3>] do_unblank_screen+0xd3/0x1a0
[267338.532396]  [<ffffffff814e871a>] vt_ioctl+0x50a/0x12f0
[267338.532398]  [<ffffffff8118da84>] ? unlock_page+0x74/0x80
[267338.532399]  [<ffffffff8118e293>] ? filemap_map_pages+0x1e3/0x2a0
[267338.532402]  [<ffffffff814dbc0f>] tty_ioctl+0x35f/0xc40
[267338.532404]  [<ffffffff811c2933>] ? handle_mm_fault+0x1343/0x1ae0
[267338.532406]  [<ffffffff812296f1>] do_vfs_ioctl+0xa1/0x5b0
[267338.532409]  [<ffffffff8106aa64>] ? __do_page_fault+0x1b4/0x400
[267338.532410]  [<ffffffff81229c79>] SyS_ioctl+0x79/0x90
[267338.532412]  [<ffffffff81825832>] entry_SYSCALL_64_fastpath+0x16/0x71
[267338.532413] ---[ end trace 5a9b062a79c04de3 ]---
Comment 5 Ryan Underwood 2016-06-29 23:09:49 UTC
Probably duplicate of https://bugs.freedesktop.org/show_bug.cgi?id=93782
Comment 6 Malcolm Lewis 2017-01-25 16:13:36 UTC
(In reply to Ryan Underwood from comment #5)
> Probably duplicate of https://bugs.freedesktop.org/show_bug.cgi?id=93782
Hi
It would appear to be the case, putting video=SVIDEO-1:d in the kernel boot command also fixed the problem for me.

I guess this bug should be closed?
Comment 7 Ryan Underwood 2017-01-26 03:57:24 UTC
Perhaps this one should be closed as duplicate of the other, but the overall situation is still unacceptable: to require the user to append an obscure module parameter in order for his system to 'just work'.
Comment 8 Jari Tahvanainen 2017-03-21 13:23:14 UTC
According the comment 5 and comment 6.

*** This bug has been marked as a duplicate of bug 93782 ***

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.