Bug 106350 - [CI] igt@* - dmesg-warn - Link Training failed at link rate || pipe_off wait timed out
Summary: [CI] igt@* - dmesg-warn - Link Training failed at link rate || pipe_off wait ...
Status: RESOLVED INVALID
Alias: None
Product: DRI
Classification: Unclassified
Component: DRM/Intel (show other bugs)
Version: XOrg git
Hardware: Other All
: medium normal
Assignee: Intel GFX Bugs mailing list
QA Contact: Intel GFX Bugs mailing list
URL:
Whiteboard: ReadyForDev
Keywords:
Depends on:
Blocks:
 
Reported: 2018-05-02 11:27 UTC by Martin Peres
Modified: 2019-05-16 14:05 UTC (History)
2 users (show)

See Also:
i915 platform: BDW, CFL, CNL, ICL
i915 features: display/Other


Attachments

Description Martin Peres 2018-05-02 11:27:35 UTC
https://intel-gfx-ci.01.org/tree/drm-tip/drmtip_28/fi-cfl-u/igt@kms_vblank@pipe-c-wait-forked-busy.html

https://intel-gfx-ci.01.org/tree/drm-tip/drmtip_28/fi-cfl-u/igt@kms_flip@flip-vs-modeset-interruptible.html

https://intel-gfx-ci.01.org/tree/drm-tip/drmtip_28/fi-cfl-u/igt@kms_panel_fitting@atomic-fastset.html

[  149.996378] ------------[ cut here ]------------
[  149.996391] pipe_off wait timed out
[  149.996681] WARNING: CPU: 2 PID: 1512 at drivers/gpu/drm/i915/intel_display.c:1070 intel_disable_pipe+0x131/0x170 [i915]
[  149.996691] Modules linked in: snd_hda_codec_hdmi i915 x86_pkg_temp_thermal intel_powerclamp coretemp crct10dif_pclmul crc32_pclmul snd_hda_intel ghash_clmulni_intel e1000e snd_hda_codec snd_hwdep snd_hda_core snd_pcm mei_me prime_numbers mei
[  149.996846] CPU: 2 PID: 1512 Comm: kms_panel_fitti Tainted: G     U            4.17.0-rc3-g1d2a421b1f9b-drmtip_28+ #1
[  149.996856] Hardware name: Intel Corporation CoffeeLake Client Platform/CoffeeLake U DDR4 RVP, BIOS CNLSFWR1.R00.X124.B01.1802051324 02/05/2018
[  149.997049] RIP: 0010:intel_disable_pipe+0x131/0x170 [i915]
[  149.997060] RSP: 0018:ffff9a54806b3ad8 EFLAGS: 00010282
[  149.997077] RAX: 0000000000000000 RBX: ffff95308af20000 RCX: 0000000000000001
[  149.997088] RDX: 0000000080000001 RSI: ffffffffa20855ee RDI: 00000000ffffffff
[  149.997097] RBP: 000000000007f008 R08: 000000009d3c14e4 R09: 0000000000000000
[  149.997106] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000003
[  149.997115] R13: ffff95308a08ae98 R14: ffff95308af20000 R15: 0000000000000003
[  149.997127] FS:  00007f3903925980(0000) GS:ffff9530abc80000(0000) knlGS:0000000000000000
[  149.997137] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  149.997147] CR2: 000055888f6ec5f8 CR3: 00000004470b0005 CR4: 00000000003606e0
[  149.997155] Call Trace:
[  149.997360]  haswell_crtc_disable+0xeb/0x140 [i915]
[  149.997564]  intel_atomic_commit_tail+0x7b1/0xd20 [i915]
[  149.997782]  intel_atomic_commit+0x240/0x320 [i915]
[  149.997814]  drm_mode_atomic_ioctl+0x7e8/0x970
[  149.997884]  ? drm_atomic_set_property+0x520/0x520
[  149.997900]  drm_ioctl_kernel+0x7c/0xf0
[  149.997926]  drm_ioctl+0x2e6/0x3a0
[  149.997949]  ? drm_atomic_set_property+0x520/0x520
[  149.998005]  do_vfs_ioctl+0xa0/0x6c0
[  149.998021]  ? __do_page_fault+0x2b8/0x590
[  149.998056]  ksys_ioctl+0x35/0x60
[  149.998079]  __x64_sys_ioctl+0x11/0x20
[  149.998094]  do_syscall_64+0x55/0x190
[  149.998116]  entry_SYSCALL_64_after_hwframe+0x49/0xbe
[  149.998128] RIP: 0033:0x7f3902fd25d7
[  149.998138] RSP: 002b:00007ffe92eecf08 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
[  149.998157] RAX: ffffffffffffffda RBX: 000055888f6e1fe0 RCX: 00007f3902fd25d7
[  149.998166] RDX: 00007ffe92eecf60 RSI: 00000000c03864bc RDI: 0000000000000003
[  149.998176] RBP: 00007ffe92eecf60 R08: 000055888f6eb6d0 R09: 000000000000005a
[  149.998185] R10: 000000000000000f R11: 0000000000000246 R12: 00000000c03864bc
[  149.998194] R13: 0000000000000003 R14: 0000000000000000 R15: 0000000000000400
[  149.998238] Code: 00 6a 00 8d b4 0a 08 00 07 00 31 c9 ba 00 00 00 40 e8 74 34 fe ff 85 c0 5a 0f 84 55 ff ff ff 48 c7 c7 83 c6 61 c0 e8 6f f0 b1 e0 <0f> 0b e9 42 ff ff ff 85 d2 0f 84 6c ff ff ff 48 83 c4 08 89 ee 
[  149.998720] irq event stamp: 107790
[  149.998738] hardirqs last  enabled at (107789): [<ffffffffa10fc056>] console_unlock+0x426/0x640
[  149.998754] hardirqs last disabled at (107790): [<ffffffffa1a0111c>] error_entry+0x7c/0x100
[  149.998768] softirqs last  enabled at (107656): [<ffffffffa1c0032b>] __do_softirq+0x32b/0x4e1
[  149.998784] softirqs last disabled at (107647): [<ffffffffa108f6c4>] irq_exit+0xa4/0xb0
[  149.998973] WARNING: CPU: 2 PID: 1512 at drivers/gpu/drm/i915/intel_display.c:1070 intel_disable_pipe+0x131/0x170 [i915]
[  149.998982] ---[ end trace 5d5033b77765fa21 ]---
[  150.871037] [drm:intel_dp_start_link_train [i915]] *ERROR* [CONNECTOR:71:eDP-1] Link Training failed at link rate = 270000, lane count = 2


https://intel-gfx-ci.01.org/tree/drm-tip/drmtip_28/fi-cfl-u/igt@drv_hangman@error-state-capture-bsd.html

https://intel-gfx-ci.01.org/tree/drm-tip/drmtip_28/fi-cfl-u/igt@kms_draw_crc@draw-method-rgb565-mmap-wc-untiled.html

https://intel-gfx-ci.01.org/tree/drm-tip/drmtip_28/fi-cfl-u/igt@perf_pmu@busy-check-all-vecs0.html
	
[  173.283832] [drm:intel_dp_start_link_train [i915]] *ERROR* [CONNECTOR:71:eDP-1] Link Training failed at link rate = 270000, lane count = 2
[  173.470163] [drm:intel_dp_start_link_train [i915]] *ERROR* [CONNECTOR:71:eDP-1] Link Training failed at link rate = 270000, lane count = 2
[  173.659852] [drm:intel_dp_start_link_train [i915]] *ERROR* [CONNECTOR:71:eDP-1] Link Training failed at link rate = 270000, lane count = 2
Comment 2 Martin Peres 2018-06-08 10:14:37 UTC
Also seen on CNL:

https://intel-gfx-ci.01.org/tree/drm-tip/drmtip_57/fi-cnl-y3/igt@kms_panel_fitting@atomic-fastset.html

[  129.989199] ------------[ cut here ]------------
[  129.989204] pipe_off wait timed out
[  129.989288] WARNING: CPU: 2 PID: 1354 at drivers/gpu/drm/i915/intel_display.c:1098 intel_disable_pipe+0x131/0x170 [i915]
[  129.989291] Modules linked in: vgem snd_hda_codec_hdmi snd_hda_codec_realtek snd_hda_codec_generic i915 snd_hda_intel snd_hda_codec x86_pkg_temp_thermal intel_powerclamp coretemp snd_hwdep snd_hda_core crct10dif_pclmul crc32_pclmul ghash_clmulni_intel snd_pcm e1000e mei_me mei prime_numbers
[  129.989344] CPU: 2 PID: 1354 Comm: kms_panel_fitti Tainted: G     U            4.17.0-rc7-g0e963d962be7-drmtip_57+ #1
[  129.989347] Hardware name: Intel Corporation CannonLake Client Platform/CannonLake Y LPDDR4 RVP, BIOS CNLSFWR1.R00.X122.B01.1801151045 01/15/2018
[  129.989400] RIP: 0010:intel_disable_pipe+0x131/0x170 [i915]
[  129.989403] RSP: 0018:ffff9af740503ac8 EFLAGS: 00010286
[  129.989408] RAX: 0000000000000000 RBX: ffff8e3897000000 RCX: 0000000000000001
[  129.989411] RDX: 0000000080000001 RSI: ffffffff95086ce6 RDI: 00000000ffffffff
[  129.989414] RBP: 000000000007f008 R08: 00000000804cef4d R09: 0000000000000000
[  129.989417] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000003
[  129.989420] R13: ffff8e38897d8008 R14: ffff8e38897d8958 R15: ffff8e3897000000
[  129.989423] FS:  00007f165723f980(0000) GS:ffff8e38af900000(0000) knlGS:0000000000000000
[  129.989426] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  129.989429] CR2: 00007f41172940c0 CR3: 000000025595e001 CR4: 0000000000760ee0
[  129.989432] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
[  129.989434] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
[  129.989437] PKRU: 55555554
[  129.989439] Call Trace:
[  129.989497]  haswell_crtc_disable+0x104/0x170 [i915]
[  129.989505]  ? synchronize_irq+0x3e/0xb0
[  129.989561]  intel_atomic_commit_tail+0x78a/0xcf0 [i915]
[  129.989620]  intel_atomic_commit+0x240/0x320 [i915]
[  129.989630]  drm_mode_atomic_ioctl+0x7e8/0x970
[  129.989650]  ? drm_atomic_set_property+0x530/0x530
[  129.989655]  drm_ioctl_kernel+0x7c/0xf0
[  129.989663]  drm_ioctl+0x2e6/0x3a0
[  129.989669]  ? drm_atomic_set_property+0x530/0x530
[  129.989685]  do_vfs_ioctl+0xa0/0x6c0
[  129.989691]  ? __do_page_fault+0x2b8/0x590
[  129.989701]  ksys_ioctl+0x35/0x60
[  129.989708]  __x64_sys_ioctl+0x11/0x20
[  129.989712]  do_syscall_64+0x55/0x190
[  129.989719]  entry_SYSCALL_64_after_hwframe+0x49/0xbe
[  129.989723] RIP: 0033:0x7f16568eb5d7
[  129.989726] RSP: 002b:00007ffd55347e78 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
[  129.989731] RAX: ffffffffffffffda RBX: 0000564c0184a420 RCX: 00007f16568eb5d7
[  129.989734] RDX: 00007ffd55347ed0 RSI: 00000000c03864bc RDI: 0000000000000003
[  129.989737] RBP: 00007ffd55347ed0 R08: 0000564c01855720 R09: 000000000000007a
[  129.989739] R10: 0000000000000015 R11: 0000000000000246 R12: 00000000c03864bc
[  129.989742] R13: 0000000000000003 R14: 0000000000000000 R15: 0000000000000400
[  129.989755] Code: 00 6a 00 8d b4 0a 08 00 07 00 31 c9 ba 00 00 00 40 e8 64 2e fe ff 85 c0 5a 0f 84 55 ff ff ff 48 c7 c7 f7 06 59 c0 e8 df f1 ba d3 <0f> 0b e9 42 ff ff ff 85 d2 0f 84 6c ff ff ff 48 83 c4 08 89 ee 
[  129.989895] irq event stamp: 215472
[  129.989900] hardirqs last  enabled at (215471): [<ffffffff940fcb96>] console_unlock+0x426/0x640
[  129.989904] hardirqs last disabled at (215472): [<ffffffff94a0111c>] error_entry+0x7c/0x100
[  129.989908] softirqs last  enabled at (215250): [<ffffffff94c0032b>] __do_softirq+0x32b/0x4e1
[  129.989913] softirqs last disabled at (215241): [<ffffffff94090104>] irq_exit+0xa4/0xb0
[  129.989963] WARNING: CPU: 2 PID: 1354 at drivers/gpu/drm/i915/intel_display.c:1098 intel_disable_pipe+0x131/0x170 [i915]
[  129.989966] ---[ end trace 69c839f5c1a6de10 ]---
[  130.868182] [drm:intel_dp_start_link_train [i915]] *ERROR* [CONNECTOR:101:eDP-1] Link Training failed at link rate = 540000, lane count = 4
Comment 3 Martin Peres 2018-07-17 12:28:41 UTC
Also seen on WHL: https://intel-gfx-ci.01.org/tree/drm-tip/drmtip_78/fi-whl-u/igt@kms_vblank@pipe-a-wait-forked-hang.html

*ERROR* [CONNECTOR:71:eDP-1] Link Training failed at link rate = 540000, lane count = 4
Comment 4 Yann Soubeyrand 2018-08-19 08:48:20 UTC
Hi,

When booting my Asus Zenbook UX31A-R4003X with an external monitor connected using micro HDMI, I get the following errors and the PC is somewhat stuck. Plugging the monitor after booting does work.

[drm:intel_dp_start_link_train [i915]] *ERROR* [CONNECTOR:67:eDP-1] Link Training failed at link rate = 270000, lane count = 2
[drm:ironlake_crtc_enable [i915]] *ERROR* mode set failed: pipe A stuck
[drm:drm_atomic_helper_wait_for_flip_done [drm_kms_helper]] *ERROR* [CRTC:39:pipe A] flip_done timed out
[drm:drm_atomic_helper_wait_for_dependencies [drm_kms_helper]] *ERROR* [CRTC:39:pipe A] flip_done timed out
[drm:drm_atomic_helper_wait_for_dependencies [drm_kms_helper]] *ERROR* [CONNECTOR:67:eDP-1] flip_done timed out
[drm:drm_atomic_helper_wait_for_dependencies [drm_kms_helper]] *ERROR* [PLANE:28:primary A] flip_done timed out
[drm:drm_atomic_helper_wait_for_flip_done [drm_kms_helper]] *ERROR* [CRTC:39:pipe A] flip_done timed out

I'm using Fedora 28 running Linux 4.17.14-202.fc28.x86_64. Please ask if you need more informations and please tell me if my problem is not related to this bug and I need to open a new bug report.

Regards
Comment 5 Martin Peres 2018-08-31 13:42:37 UTC
Also seen on BDW (potentially indicating something that has to do with the panel more than anything):

https://intel-gfx-ci.01.org/tree/drm-tip/drmtip_92/fi-bdw-samus/igt@kms_panel_fitting@atomic-fastset.html

[   50.902945] ------------[ cut here ]------------
[   50.902951] pipe_off wait timed out
[   50.903084] WARNING: CPU: 1 PID: 1172 at drivers/gpu/drm/i915/intel_display.c:1098 intel_disable_pipe+0x131/0x170 [i915]
[   50.903088] Modules linked in: vgem snd_hda_codec_hdmi btusb btrtl x86_pkg_temp_thermal coretemp crct10dif_pclmul crc32_pclmul ghash_clmulni_intel btbcm ax88179_178a btintel i915 usbnet mii bluetooth ecdh_generic snd_hda_intel snd_hda_codec snd_hwdep snd_hda_core snd_pcm mei_me mei lpc_ich prime_numbers
[   50.903178] CPU: 1 PID: 1172 Comm: kms_panel_fitti Tainted: G     U            4.18.0-rc6-g79a6a05d5beb-drmtip_92+ #1
[   50.903181] Hardware name: GOOGLE Samus/Samus, BIOS MrChromebox 02/04/2018
[   50.903263] RIP: 0010:intel_disable_pipe+0x131/0x170 [i915]
[   50.903268] Code: 6a 00 8d b4 0a 08 00 07 00 31 c9 ba 00 00 00 40 e8 e4 2f fe ff 85 c0 5a 0f 84 55 ff ff ff 48 c7 c7 8b 5a 55 c0 e8 5f bc be e2 <0f> 0b e9 42 ff ff ff 85 d2 0f 84 6c ff ff ff 48 83 c4 08 89 ee 48 
[   50.903460] RSP: 0018:ffffaf43803e3ad0 EFLAGS: 00010282
[   50.903467] RAX: 0000000000000000 RBX: ffff966f98390000 RCX: 0000000000000001
[   50.903471] RDX: 0000000080000001 RSI: ffffffffa4085706 RDI: 00000000ffffffff
[   50.903475] RBP: 000000000007f008 R08: 000000009357721b R09: 0000000000000000
[   50.903479] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000003
[   50.903482] R13: ffff966fac0eae98 R14: ffff966f98390000 R15: ffff966f98390000
[   50.903487] FS:  00007fe35c5ad980(0000) GS:ffff966fbec80000(0000) knlGS:0000000000000000
[   50.903491] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[   50.903495] CR2: 0000558126f613a8 CR3: 00000004648d8002 CR4: 00000000003606e0
[   50.903499] Call Trace:
[   50.903588]  haswell_crtc_disable+0xd9/0x140 [i915]
[   50.903677]  intel_atomic_commit_tail+0x79f/0xd00 [i915]
[   50.903771]  intel_atomic_commit+0x240/0x320 [i915]
[   50.903786]  drm_mode_atomic_ioctl+0x837/0xa00
[   50.903814]  ? drm_atomic_set_property+0x630/0x630
[   50.903822]  drm_ioctl_kernel+0x7c/0xf0
[   50.903832]  drm_ioctl+0x2e6/0x3a0
[   50.903842]  ? drm_atomic_set_property+0x630/0x630
[   50.903865]  do_vfs_ioctl+0xa0/0x6d0
[   50.903873]  ? __do_page_fault+0x2b8/0x590
[   50.903887]  ksys_ioctl+0x35/0x60
[   50.903897]  __x64_sys_ioctl+0x11/0x20
[   50.903903]  do_syscall_64+0x55/0x190
[   50.903911]  entry_SYSCALL_64_after_hwframe+0x49/0xbe
[   50.903916] RIP: 0033:0x7fe35be735d7
[   50.903919] Code: b3 66 90 48 8b 05 b1 48 2d 00 64 c7 00 26 00 00 00 48 c7 c0 ff ff ff ff c3 66 2e 0f 1f 84 00 00 00 00 00 b8 10 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 81 48 2d 00 f7 d8 64 89 01 48 
[   50.904108] RSP: 002b:00007fffa95b29a8 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
[   50.904116] RAX: ffffffffffffffda RBX: 0000558126f5e860 RCX: 00007fe35be735d7
[   50.904120] RDX: 00007fffa95b2a00 RSI: 00000000c03864bc RDI: 0000000000000003
[   50.904124] RBP: 00007fffa95b2a00 R08: 0000558126f60ba0 R09: 000000000000004f
[   50.904128] R10: 000000000000000e R11: 0000000000000246 R12: 00000000c03864bc
[   50.904131] R13: 0000000000000003 R14: 0000000000000000 R15: 0000000000000400
[   50.904149] irq event stamp: 139296
[   50.904157] hardirqs last  enabled at (139295): [<ffffffffa30fc99c>] console_unlock+0x3fc/0x600
[   50.904163] hardirqs last disabled at (139296): [<ffffffffa3a0111c>] error_entry+0x7c/0x100
[   50.904169] softirqs last  enabled at (138746): [<ffffffffa3c0034f>] __do_softirq+0x34f/0x505
[   50.904177] softirqs last disabled at (138723): [<ffffffffa30905a5>] irq_exit+0xa5/0xc0
[   50.904258] WARNING: CPU: 1 PID: 1172 at drivers/gpu/drm/i915/intel_display.c:1098 intel_disable_pipe+0x131/0x170 [i915]
[   50.904262] ---[ end trace 80844efb1e4e774f ]---
[   51.828348] [drm:intel_dp_start_link_train [i915]] *ERROR* [CONNECTOR:65:eDP-1] Link Training failed at link rate = 270000, lane count = 4
Comment 6 CI Bug Log 2019-05-08 15:26:27 UTC
A CI Bug Log filter associated to this bug has been updated:

{- BDW CFL CNL WHL: all tests - dmesg-warn - pipe_off wait timed out -}
{+ BDW CFL CNL WHL: all tests - dmesg-warn - pipe_off wait timed out +}

New failures caught by the filter:

  * https://intel-gfx-ci.01.org/tree/drm-tip/drmtip_279/fi-icl-u2/igt@kms_plane_lowres@pipe-b-tiling-yf.html
Comment 7 CI Bug Log 2019-05-08 15:27:30 UTC
A CI Bug Log filter associated to this bug has been updated:

{- BDW CFL CNL WHL: all tests - dmesg-warn - pipe_off wait timed out -}
{+ BDW CFL CNL WHL ICL: all tests - dmesg-warn - pipe_off wait timed out +}


  No new failures caught with the new filter
Comment 8 CI Bug Log 2019-05-08 15:28:30 UTC
The CI Bug Log issue associated to this bug has been updated.

### New filters associated

* ICL: igt@runner@aborted - fail - Previous test: kms_plane_lowres (pipe-b-tiling-yf)
  - https://intel-gfx-ci.01.org/tree/drm-tip/drmtip_279/fi-icl-u2/igt@runner@aborted.html
Comment 9 Lakshmi 2019-05-08 15:29:04 UTC
(In reply to CI Bug Log from comment #6)
> A CI Bug Log filter associated to this bug has been updated:
> 
> {- BDW CFL CNL WHL: all tests - dmesg-warn - pipe_off wait timed out -}
> {+ BDW CFL CNL WHL: all tests - dmesg-warn - pipe_off wait timed out +}
> 
> New failures caught by the filter:
> 
>   *
> https://intel-gfx-ci.01.org/tree/drm-tip/drmtip_279/fi-icl-u2/
> igt@kms_plane_lowres@pipe-b-tiling-yf.html

Also seen on ICL.
Comment 10 Martin Peres 2019-05-16 12:54:03 UTC
This bug needs to be split. I already moved the icl-dsi failures to https://bugs.freedesktop.org/show_bug.cgi?id=110689, but we need to move the icl-u2 issues to another bug, then make CFL's '*ERROR* Link Training Unsuccessful' either as a separate bug or move it to a bug with all the platforms affected by this.
Comment 11 Lakshmi 2019-05-16 14:05:34 UTC
(In reply to Martin Peres from comment #10)
> This bug needs to be split. I already moved the icl-dsi failures to
> https://bugs.freedesktop.org/show_bug.cgi?id=110689, but we need to move the
> icl-u2 issues to another bug, then make CFL's '*ERROR* Link Training
> Unsuccessful' either as a separate bug or move it to a bug with all the
> platforms affected by this.

For icl-u2 separate bug is created Bug 110690. CFL's '*ERROR* Link Training
Unsuccessful' reported Bug 110691.


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.