Bug 101045 - [IGT][ILK] kms_busy, kms_flip and kms_pipe_crc_basic WARNs
Summary: [IGT][ILK] kms_busy, kms_flip and kms_pipe_crc_basic WARNs
Status: CLOSED FIXED
Alias: None
Product: DRI
Classification: Unclassified
Component: DRM/Intel (show other bugs)
Version: DRI git
Hardware: x86-64 (AMD64) Linux (All)
: medium normal
Assignee: Intel GFX Bugs mailing list
QA Contact: Intel GFX Bugs mailing list
URL:
Whiteboard: ReadyForDev
Keywords:
Depends on:
Blocks:
 
Reported: 2017-05-15 07:24 UTC by Tomi Sarvela
Modified: 2017-07-24 14:37 UTC (History)
1 user (show)

See Also:
i915 platform: ILK
i915 features: power/runtime PM


Attachments

Description Tomi Sarvela 2017-05-15 07:24:09 UTC
Iron Lake m540 laptop (HP Elitebook 8440p) gives ERROR on fast-feedback.testlist at gem_exec_suspend@basic-s4-devices

[  208.577917] [drm:wait_panel_status [i915]] *ERROR* Panel status timeout: status 90000009 control abcd0009

The problem continues through kms_busy, kms_cursor_legacy, kms_flip, kms_force_connector_basic and kms_pipe_crc_basic with warning.

First instance DRM-Tip commit (CI_DRM_2610)
c6aed18 drm-tip: 2017y-05m-14d-11h-52m-28s UTC integration manifest

Changes to the CI_DRM_2609: 2ea659a Linux 4.12-rc1 and ~200 commits more
https://intel-gfx-ci.01.org/CI/problems.html

[  279.379181] [drm:wait_panel_status [i915]] *ERROR* Panel status timeout: status 90000009 control abcd0000
[  279.438578] eDP port A panel power already on
[  279.438609] ------------[ cut here ]------------
[  279.438637] WARNING: CPU: 3 PID: 8866 at drivers/gpu/drm/i915/intel_dp.c:2213 edp_panel_on+0x1d1/0x1e0 [i915]
[  279.438639] Modules linked in: vgem snd_hda_codec_hdmi snd_hda_codec_generic i915 intel_powerclamp coretemp crct10dif_pclmul crc32_pclmul ghash_clmulni_intel snd_hda_intel snd_hda_codec snd_hwdep e1000e snd_hda_core mei_me snd_pcm ptp mei pps_core prime_numbers lpc_ich
[  279.438690] CPU: 3 PID: 8866 Comm: kms_busy Tainted: G     U          4.12.0-rc1-CI-CI_DRM_2610+ #1
[  279.438693] Hardware name: Hewlett-Packard HP EliteBook 8440p/172A, BIOS 68CCU Ver. F.24 09/13/2013
[  279.438696] task: ffff88012c824bc0 task.stack: ffffc90000d28000
[  279.438722] RIP: 0010:edp_panel_on+0x1d1/0x1e0 [i915]
[  279.438724] RSP: 0018:ffffc90000d2b958 EFLAGS: 00010292
[  279.438729] RAX: 0000000000000021 RBX: ffff880128da2258 RCX: 0000000000000001
[  279.438731] RDX: 0000000080000001 RSI: ffffffff81c8ffaa RDI: 00000000ffffffff
[  279.438734] RBP: ffffc90000d2b998 R08: ffff88012c825448 R09: 0000000000000000
[  279.438736] R10: 0000000000000000 R11: 0000000000000000 R12: ffff880128168000
[  279.438738] R13: ffff880128168000 R14: ffff880128da2158 R15: ffff880128168000
[  279.438741] FS:  00007ff65cae3a40(0000) GS:ffff880137cc0000(0000) knlGS:0000000000000000
[  279.438743] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  279.438782] CR2: 00007ffa509d7000 CR3: 000000012d56c000 CR4: 00000000000006e0
[  279.438786] Call Trace:
[  279.438828]  ? gen5_write32+0x15e/0x200 [i915]
[  279.438867]  ? intel_dp_program_link_training_pattern+0x9f/0x210 [i915]
[  279.438915]  intel_enable_dp+0x113/0x380 [i915]
[  279.438962]  g4x_enable_dp+0x3f/0x90 [i915]
[  279.438973]  ? trace_hardirqs_on+0xd/0x10
[  279.439017]  intel_encoders_enable.isra.68+0x6c/0x90 [i915]
[  279.439062]  ironlake_crtc_enable+0x335/0xbb0 [i915]
[  279.439107]  ? ibx_pch_dpll_get_hw_state+0x9c/0xb0 [i915]
[  279.439153]  intel_update_crtc+0x43/0xd0 [i915]
[  279.439539]  intel_update_crtcs+0x6a/0x80 [i915]
[  279.439582]  intel_atomic_commit_tail+0x2e2/0xfa0 [i915]
[  279.439632]  intel_atomic_commit+0x3fb/0x500 [i915]
[  279.439643]  ? drm_atomic_check_only+0x3a0/0x560
[  279.439652]  drm_atomic_commit+0x46/0x50
[  279.439692]  intel_crtc_restore_mode+0x3d/0xc0 [i915]
[  279.439735]  intel_dp_set_property+0xde/0x230 [i915]
[  279.439745]  drm_mode_connector_set_obj_prop+0x37/0x70
[  279.439780]  drm_mode_obj_set_property_ioctl+0xf5/0x140
[  279.439789]  drm_mode_connector_property_set_ioctl+0x2b/0x30
[  279.439799]  drm_ioctl+0x202/0x490
[  279.439804]  ? drm_mode_connector_set_obj_prop+0x70/0x70
[  279.439822]  ? __do_page_fault+0x29e/0x560
[  279.439832]  do_vfs_ioctl+0x90/0x6d0
[  279.440058]  ? entry_SYSCALL_64_fastpath+0x5/0xb1
[  279.440067]  ? __this_cpu_preempt_check+0x13/0x20
[  279.440073]  ? trace_hardirqs_on_caller+0xe7/0x1c0
[  279.440081]  SyS_ioctl+0x3c/0x70
[  279.440090]  entry_SYSCALL_64_fastpath+0x1c/0xb1
[  279.440095] RIP: 0033:0x7ff65afe7357
[  279.440100] RSP: 002b:00007ffdbd28c478 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
[  279.440109] RAX: ffffffffffffffda RBX: ffffffff81470183 RCX: 00007ff65afe7357
[  279.440114] RDX: 00007ffdbd28c4b0 RSI: 00000000c01064ab RDI: 0000000000000003
[  279.440118] RBP: ffffc90000d2bf88 R08: 0000000001bca8f0 R09: 0000000000000000
[  279.440123] R10: 000000000000009f R11: 0000000000000246 R12: 0000000001bca568
[  279.440127] R13: 0000000000000003 R14: 00000000c01064ab R15: 000000000000001c
[  279.440135]  ? __this_cpu_preempt_check+0x13/0x20
[  279.440146] Code: 24 18 0c 00 00 41 f6 84 24 26 0b 00 00 10 0f 85 25 ff ff ff e9 19 ff ff ff 8b 73 f8 48 c7 c7 00 61 28 a0 83 c6 41 e8 38 2a f7 e0 <0f> ff e9 56 fe ff ff 0f 1f 84 00 00 00 00 00 55 48 89 e5 41 56 
[  279.440405] ---[ end trace fc2c869e19a71fba ]---
[  285.723645] [drm:wait_panel_status [i915]] *ERROR* Panel status timeout: status 90000009 control abcd0000
[  285.809360] eDP port A panel power already on
[  285.809392] ------------[ cut here ]------------
[  285.809419] WARNING: CPU: 3 PID: 8866 at drivers/gpu/drm/i915/intel_dp.c:2213 edp_panel_on+0x1d1/0x1e0 [i915]
[  285.809422] Modules linked in: vgem snd_hda_codec_hdmi snd_hda_codec_generic i915 intel_powerclamp coretemp crct10dif_pclmul crc32_pclmul ghash_clmulni_intel snd_hda_intel snd_hda_codec snd_hwdep e1000e snd_hda_core mei_me snd_pcm ptp mei pps_core prime_numbers lpc_ich
[  285.809477] CPU: 3 PID: 8866 Comm: kms_busy Tainted: G     U  W       4.12.0-rc1-CI-CI_DRM_2610+ #1
[  285.809480] Hardware name: Hewlett-Packard HP EliteBook 8440p/172A, BIOS 68CCU Ver. F.24 09/13/2013
[  285.809483] task: ffff88012c824bc0 task.stack: ffffc90000d28000
[  285.809508] RIP: 0010:edp_panel_on+0x1d1/0x1e0 [i915]
[  285.809511] RSP: 0018:ffffc90000d2b9b0 EFLAGS: 00010282
[  285.809516] RAX: 0000000000000021 RBX: ffff880128da2258 RCX: 0000000000000001
[  285.809519] RDX: 0000000080000001 RSI: ffffffff81c8ffaa RDI: 00000000ffffffff
[  285.809521] RBP: ffffc90000d2b9f0 R08: ffff88012c825470 R09: 0000000000000000
[  285.809524] R10: 0000000000000000 R11: 0000000000000000 R12: ffff880128168000
[  285.809526] R13: ffff880128168000 R14: ffff880128da2158 R15: ffff880128168000
[  285.809529] FS:  00007ff65cae3a40(0000) GS:ffff880137cc0000(0000) knlGS:0000000000000000
[  285.809532] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  285.809534] CR2: 00007ff6583c4188 CR3: 0000000001e0f000 CR4: 00000000000006e0
[  285.809537] Call Trace:
[  285.809564]  ? gen5_write32+0x15e/0x200 [i915]
[  285.809589]  ? intel_dp_program_link_training_pattern+0x9f/0x210 [i915]
[  285.809616]  intel_enable_dp+0x113/0x380 [i915]
[  285.809644]  g4x_enable_dp+0x3f/0x90 [i915]
[  285.809650]  ? trace_hardirqs_on+0xd/0x10
[  285.809676]  intel_encoders_enable.isra.68+0x6c/0x90 [i915]
[  285.809704]  ironlake_crtc_enable+0x335/0xbb0 [i915]
[  285.809730]  ? ibx_pch_dpll_get_hw_state+0x9c/0xb0 [i915]
[  285.809758]  intel_update_crtc+0x43/0xd0 [i915]
[  285.809785]  intel_update_crtcs+0x6a/0x80 [i915]
[  285.809812]  intel_atomic_commit_tail+0x2e2/0xfa0 [i915]
[  285.809843]  intel_atomic_commit+0x3fb/0x500 [i915]
[  285.809848]  ? drm_atomic_check_only+0x3a0/0x560
[  285.809853]  drm_atomic_commit+0x46/0x50
[  285.809858]  restore_fbdev_mode+0x148/0x270
[  285.809864]  drm_fb_helper_restore_fbdev_mode_unlocked+0x2e/0x70
[  285.809889]  intel_fbdev_restore_mode+0x2f/0x90 [i915]
[  285.809915]  i915_driver_lastclose+0x9/0x10 [i915]
[  285.809958]  drm_lastclose+0x34/0xf0
[  285.809964]  drm_release+0x2f6/0x390
[  285.809976]  __fput+0xb4/0x1f0
[  285.809985]  ____fput+0x9/0x10
[  285.809993]  task_work_run+0x79/0xb0
[  285.810005]  do_exit+0x3e0/0xcc0
[  285.810016]  ? entry_SYSCALL_64_fastpath+0x5/0xb1
[  285.810027]  ? __this_cpu_preempt_check+0x13/0x20
[  285.810035]  ? trace_hardirqs_on_caller+0xe7/0x1c0
[  285.810045]  do_group_exit+0x40/0xc0
[  285.810054]  SyS_exit_group+0xf/0x10
[  285.810061]  entry_SYSCALL_64_fastpath+0x1c/0xb1
[  285.810067] RIP: 0033:0x7ff65afb6b98
[  285.810076] RSP: 002b:00007ffdbd28ce68 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7
[  285.810090] RAX: ffffffffffffffda RBX: ffffffff81470183 RCX: 00007ff65afb6b98
[  285.810096] RDX: 0000000000000000 RSI: 000000000000003c RDI: 0000000000000000
[  285.810102] RBP: ffffc90000d2bf88 R08: 00000000000000e7 R09: ffffffffffffff78
[  285.810110] R10: 00007ff6583c41a0 R11: 0000000000000246 R12: 0000000000000000
[  285.810117] R13: 00007ff65b2afc40 R14: 00007ff65b2aa8e0 R15: 0000000000000000
[  285.810127]  ? __this_cpu_preempt_check+0x13/0x20
[  285.810139] Code: 24 18 0c 00 00 41 f6 84 24 26 0b 00 00 10 0f 85 25 ff ff ff e9 19 ff ff ff 8b 73 f8 48 c7 c7 00 61 28 a0 83 c6 41 e8 38 2a f7 e0 <0f> ff e9 56 fe ff ff 0f 1f 84 00 00 00 00 00 55 48 89 e5 41 56 
[  285.810426] ---[ end trace fc2c869e19a71fbb ]---
Comment 1 Elizabeth 2017-06-20 19:23:04 UTC
Good afternoon Tomi,

Do you think any other log, dmesg, kern.log or other, could add any relevant information for the case? If so, could you please attach it?

Thanks.
Comment 2 Tomi Sarvela 2017-06-21 07:15:06 UTC
This issue is probably not relevant any more due to all the DP code changes.

Now, gem_exec_suspend@basic-s4-devices give occasionally the following error:

[drm:wait_panel_status [i915]] *ERROR* Panel status timeout: status 90000009 control abcd0009

All the information is available at https://intel-gfx-ci.01.org/CI/

Last 100 runs on fi-ilk-m540 https://intel-gfx-ci.01.org/CI/fi-ilk-m540.html

Last 100 basic-S4-devices https://intel-gfx-ci.01.org/CI/igt@gem_exec_suspend@basic-s4-devices.html

Example of one ILK-m540 result with links to dmesg and full test output
https://intel-gfx-ci.01.org/CI/CI_DRM_2745/fi-ilk-m540/igt@gem_exec_suspend@basic-s4-devices.html
Comment 3 Elizabeth 2017-06-22 14:20:00 UTC
(In reply to Tomi Sarvela from comment #2)
> This issue is probably not relevant any more due to all the DP code changes.
> 
> Now, gem_exec_suspend@basic-s4-devices give occasionally the following error:
> 
> [drm:wait_panel_status [i915]] *ERROR* Panel status timeout: status 90000009
> control abcd0009
> 
> All the information is available at https://intel-gfx-ci.01.org/CI/
> 
> Last 100 runs on fi-ilk-m540 https://intel-gfx-ci.01.org/CI/fi-ilk-m540.html
> 
> Last 100 basic-S4-devices
> https://intel-gfx-ci.01.org/CI/igt@gem_exec_suspend@basic-s4-devices.html
> 
> Example of one ILK-m540 result with links to dmesg and full test output
> https://intel-gfx-ci.01.org/CI/CI_DRM_2745/fi-ilk-m540/
> igt@gem_exec_suspend@basic-s4-devices.html

Hello Tomi, this seems to be a different problem from the first one that you reported. Could you please open a new bug if it is the case, and if the first is not relevant anymore could you change the status to closed. Thanks you.
Comment 5 Martin Peres 2017-07-24 14:37:50 UTC
Still no involvement from developers, but the issue cannot be reproduced anymore. So, let's close the bug!


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.