Bug 107411

Summary: [CI][BAT] igt@* - dmesg-warn / dmesg-fail - WARN_ON(!pstate->fb)
Product: DRI Reporter: Tomi Sarvela <tomi.p.sarvela>
Component: DRM/IntelAssignee: Intel GFX Bugs mailing list <intel-gfx-bugs>
Status: CLOSED WORKSFORME QA Contact: Intel GFX Bugs mailing list <intel-gfx-bugs>
Severity: normal    
Priority: high CC: intel-gfx-bugs, martin.peres, przanoni
Version: DRI git   
Hardware: Other   
OS: All   
Whiteboard: Triaged
i915 platform: ICL i915 features: power/Other

Description Tomi Sarvela 2018-07-27 14:42:19 UTC
All IGT tests on ICL after latest build:

https://intel-gfx-ci.01.org/tree/drm-tip/IGT_4579/git-log-oneline.log
a2199947 meson: Fixup gem_mocs_settings
ff91dbc8 igt/gem_mocs_settings: Use i915_pmu to measure rc6 residency
b051e16e meson: Prefix generated rpathdirs to designate their use
299880dc amdgpu/meson: Set the correct rpath

https://intel-gfx-ci.01.org/tree/drm-tip/IGT_4579/fi-icl-u/igt@core_auth@basic-auth.html

[   39.839371] ------------[ cut here ]------------
[   39.839373] WARN_ON(!pstate->fb)
[   39.839410] WARNING: CPU: 7 PID: 1304 at drivers/gpu/drm/i915/intel_pm.c:4068 skl_check_pipe_max_pixel_rate+0x292/0x370 [i915]
[   39.839412] Modules linked in: snd_hda_codec_hdmi snd_hda_codec_realtek snd_hda_codec_generic i915 ax88179_178a usbnet mii x86_pkg_temp_thermal coretemp crct10dif_pclmul crc32_pclmul snd_hda_intel snd_hda_codec ghash_clmulni_intel snd_hwdep e1000e snd_hda_core snd_pcm prime_numbers
[   39.839464] CPU: 7 PID: 1304 Comm: core_auth Tainted: G        W         4.18.0-rc6-CI-CI_DRM_4560+ #1
[   39.839465] Hardware name: Intel Corporation Ice Lake Client Platform/IceLake U DDR4 SODIMM PD RVP, BIOS ICLSFWR1.R00.2222.A01.1805300339 05/30/2018
[   39.839491] RIP: 0010:skl_check_pipe_max_pixel_rate+0x292/0x370 [i915]
[   39.839492] Code: a8 52 a0 48 89 14 24 e8 3c 07 cb e0 0f 0b 48 8b 14 24 e9 19 fe ff ff 48 c7 c6 8f aa 52 a0 48 c7 c7 d6 a8 52 a0 e8 1e 07 cb e0 <0f> 0b b8 ea ff ff ff eb 97 b9 00 00 01 00 e9 2f ff ff ff 48 c7 c6 
[   39.839572] RSP: 0018:ffffc90000fcba30 EFLAGS: 00010282
[   39.839576] RAX: 0000000000000000 RBX: ffff88049fdc0000 RCX: 0000000000000001
[   39.839577] RDX: 0000000080000001 RSI: ffffffff820c6e04 RDI: 00000000ffffffff
[   39.839579] RBP: ffff880495e17c28 R08: 00000000a0ef63f8 R09: 0000000000000000
[   39.839581] R10: 000000000000001f R11: 0000000000000000 R12: ffff8804addd3fc8
[   39.839582] R13: ffff8804ade1d3d8 R14: ffff8804ade18958 R15: 0000000000010000
[   39.839584] FS:  00007f190a8b5980(0000) GS:ffff8804c09c0000(0000) knlGS:0000000000000000
[   39.839587] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[   39.839588] CR2: 000055fa80617ca8 CR3: 00000004a917a004 CR4: 0000000000760ee0
[   39.839590] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
[   39.839591] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
[   39.839593] PKRU: 55555554
[   39.839594] Call Trace:
[   39.839630]  intel_crtc_atomic_check+0x2b1/0x340 [i915]
[   39.839637]  drm_atomic_helper_check_planes+0x127/0x1c0
[   39.839668]  intel_atomic_check+0x427/0x10e0 [i915]
[   39.839682]  drm_atomic_check_only+0x422/0x670
[   39.839691]  drm_atomic_commit+0xe/0x50
[   39.839695]  restore_fbdev_mode_atomic+0x1d3/0x1f0
[   39.839709]  drm_fb_helper_restore_fbdev_mode_unlocked+0x42/0x90
[   39.839713]  drm_fb_helper_set_par+0x24/0x50
[   39.839753]  intel_fbdev_set_par+0x11/0x40 [i915]
[   39.839758]  fbcon_init+0x4db/0x680
[   39.839766]  visual_init+0xd0/0x130
[   39.839770]  do_bind_con_driver+0x1ef/0x3f0
[   39.839779]  store_bind+0x133/0x1a0
[   39.839785]  kernfs_fop_write+0x104/0x190
[   39.839792]  __vfs_write+0x31/0x180
[   39.839797]  ? rcu_read_lock_sched_held+0x6f/0x80
[   39.839800]  ? rcu_sync_lockdep_assert+0x29/0x50
[   39.839803]  ? __sb_start_write+0x152/0x1f0
[   39.839805]  ? __sb_start_write+0x168/0x1f0
[   39.839810]  vfs_write+0xbd/0x1a0
[   39.839814]  ksys_write+0x50/0xc0
[   39.839821]  do_syscall_64+0x55/0x190
[   39.839826]  entry_SYSCALL_64_after_hwframe+0x49/0xbe
[   39.839828] RIP: 0033:0x7f190a037281
[   39.839829] Code: c3 0f 1f 84 00 00 00 00 00 48 8b 05 59 8d 20 00 c3 0f 1f 84 00 00 00 00 00 8b 05 8a d1 20 00 85 c0 75 16 b8 01 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 57 f3 c3 0f 1f 44 00 00 41 54 55 49 89 d4 53 
[   39.839904] RSP: 002b:00007fffab8dbc88 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
[   39.839907] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f190a037281
[   39.839909] RDX: 0000000000000002 RSI: 00007f190a4af061 RDI: 0000000000000005
[   39.839910] RBP: 00007fffab8dccd0 R08: 000055fa8060fd03 R09: 0000000000000006
[   39.839912] R10: 0000000000000000 R11: 0000000000000246 R12: 00007f190a020718
[   39.839913] R13: 0000000000000003 R14: 00007f190a025628 R15: 00007f190a021d80
[   39.839925] irq event stamp: 50276
[   39.839928] hardirqs last  enabled at (50275): [<ffffffff810fa08c>] vprintk_emit+0x4bc/0x4d0
[   39.839932] hardirqs last disabled at (50276): [<ffffffff81a0111c>] error_entry+0x7c/0x100
[   39.839934] softirqs last  enabled at (50182): [<ffffffff81c0034f>] __do_softirq+0x34f/0x505
[   39.839937] softirqs last disabled at (50175): [<ffffffff8108c825>] irq_exit+0xa5/0xc0
[   39.839962] WARNING: CPU: 7 PID: 1304 at drivers/gpu/drm/i915/intel_pm.c:4068 skl_check_pipe_max_pixel_rate+0x292/0x370 [i915]
[   39.839964] ---[ end trace b4986f539149ad43 ]---
Comment 1 Paulo Zanoni 2018-08-10 22:54:27 UTC
This is green on CI currently since at least 4597, which is as far as the interface shows: https://intel-gfx-ci.01.org/tree/drm-tip/fi-icl-u.html

Something fixed it.
Comment 2 James Ausmus 2018-08-21 00:51:55 UTC
Still showing green, closing
Comment 3 Martin Peres 2018-08-28 09:51:49 UTC
Happened again yesterday. See https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_4709/fi-icl-u/boot0.log

<7>[   13.200993] [drm:intel_power_well_enable [i915]] enabling power well 4
<3>[   13.201162] [drm:intel_power_domains_verify_state [i915]] *ERROR* power well AUX A state mismatch (refcount 0/enabled 1)
<7>[   13.201285] [drm:intel_csr_ucode_init [i915]] No known CSR firmware for platform, disabling runtime PM
<4>[   13.202074] ------------[ cut here ]------------
<4>[   13.202080] Interrupt register 0x44428 is not zero: 0xe6321048
<4>[   13.202190] WARNING: CPU: 6 PID: 314 at drivers/gpu/drm/i915/i915_irq.c:177 gen3_assert_iir_is_zero+0x2f/0x90 [i915]
<4>[   13.202196] Modules linked in: ax88179_178a(+) usbnet x86_pkg_temp_thermal mii coretemp i915(+) crct10dif_pclmul crc32_pclmul snd_hda_intel snd_hda_codec ghash_clmulni_intel snd_hwdep snd_hda_core snd_pcm e1000e prime_numbers
<4>[   13.202251] CPU: 6 PID: 314 Comm: systemd-udevd Tainted: G        W         4.19.0-rc1-CI-CI_DRM_4709+ #1
<4>[   13.202254] Hardware name: Intel Corporation Ice Lake Client Platform/IceLake U DDR4 SODIMM PD RVP, BIOS ICLSFWR1.R00.2313.A01.1808012121 08/01/2018
<4>[   13.202318] RIP: 0010:gen3_assert_iir_is_zero+0x2f/0x90 [i915]
<4>[   13.202323] Code: 00 53 89 f5 48 89 fb 48 8b 87 30 0f 00 00 e8 98 44 ad e1 85 c0 75 03 5b 5d c3 89 c2 89 ee 48 c7 c7 b0 06 2b a0 e8 f1 5c f5 e0 <0f> 0b b9 01 00 00 00 48 8b 83 50 0f 00 00 89 ee 48 89 df ba ff ff
<4>[   13.202327] RSP: 0018:ffffc9000058ba70 EFLAGS: 00010286
<4>[   13.202334] RAX: 0000000000000000 RBX: ffff88049e100000 RCX: 0000000000000001
<4>[   13.202337] RDX: 0000000080000001 RSI: ffffffff82124d4a RDI: 00000000ffffffff
<4>[   13.202341] RBP: 0000000000044428 R08: 0000000004dfabf4 R09: 0000000000000000
<4>[   13.202344] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000020
<4>[   13.202347] R13: 00000000effff07f R14: 0000000000000002 R15: ffff88049e100000
<4>[   13.202351] FS:  00007f8b485a0680(0000) GS:ffff8804b0780000(0000) knlGS:0000000000000000
<4>[   13.202355] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
<4>[   13.202359] CR2: 000055dc8fcce068 CR3: 00000004a6598002 CR4: 0000000000760ee0
<4>[   13.202362] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
<4>[   13.202365] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
<4>[   13.202368] PKRU: 55555554
<4>[   13.202371] Call Trace:
<4>[   13.202430]  gen8_de_irq_postinstall+0x271/0x410 [i915]
<4>[   13.202489]  gen11_irq_postinstall+0x132/0x290 [i915]
<4>[   13.202498]  drm_irq_install+0xb0/0x120
<4>[   13.202552]  i915_driver_load+0xc2d/0x10c0 [i915]
<4>[   13.202562]  ? _raw_spin_unlock_irqrestore+0x4c/0x60
<4>[   13.202570]  ? lockdep_hardirqs_on+0xe0/0x1b0
<4>[   13.202653]  i915_pci_probe+0x29/0xa0 [i915]
<4>[   13.202665]  pci_device_probe+0xa1/0x130
<4>[   13.202679]  really_probe+0x25d/0x3c0
<4>[   13.202691]  driver_probe_device+0x10a/0x120
<4>[   13.202702]  __driver_attach+0xdb/0x100
<4>[   13.202711]  ? driver_probe_device+0x120/0x120
<4>[   13.202719]  bus_for_each_dev+0x74/0xc0
<4>[   13.202733]  bus_add_driver+0x15f/0x250
<4>[   13.202741]  ? 0xffffffffa03c3000
<4>[   13.202750]  driver_register+0x56/0xe0
<4>[   13.202757]  ? 0xffffffffa03c3000
<4>[   13.202764]  do_one_initcall+0x58/0x2e0
<4>[   13.202772]  ? rcu_lockdep_current_cpu_online+0x8f/0xd0
<4>[   13.202782]  ? do_init_module+0x1d/0x1ea
<4>[   13.202790]  ? rcu_read_lock_sched_held+0x6f/0x80
<4>[   13.202798]  ? kmem_cache_alloc_trace+0x264/0x290
<4>[   13.202813]  do_init_module+0x56/0x1ea
<4>[   13.202824]  load_module+0x26ba/0x29a0
<4>[   13.202845]  ? vfs_read+0x122/0x140
<4>[   13.202878]  ? __se_sys_finit_module+0xd3/0xf0
<4>[   13.202885]  __se_sys_finit_module+0xd3/0xf0
<4>[   13.202914]  do_syscall_64+0x55/0x190
<4>[   13.202924]  entry_SYSCALL_64_after_hwframe+0x49/0xbe
<4>[   13.202931] RIP: 0033:0x7f8b480c1839
<4>[   13.202937] 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
<4>[   13.202943] RSP: 002b:00007ffcf3fb45b8 EFLAGS: 00000246 ORIG_RAX: 0000000000000139
<4>[   13.202953] RAX: ffffffffffffffda RBX: 0000565108c73280 RCX: 00007f8b480c1839
<4>[   13.202957] RDX: 0000000000000000 RSI: 00007f8b47da00e5 RDI: 000000000000000f
<4>[   13.202962] RBP: 00007f8b47da00e5 R08: 0000000000000000 R09: 00007ffcf3fb46d0
<4>[   13.202967] R10: 000000000000000f R11: 0000000000000246 R12: 0000000000000000
<4>[   13.202972] R13: 0000565108c4b6e0 R14: 0000000000020000 R15: 0000565108c73280
<4>[   13.202998] irq event stamp: 470772
<4>[   13.203007] hardirqs last  enabled at (470771): [<ffffffff810f7d66>] console_unlock+0x1b6/0x5e0
<4>[   13.203014] hardirqs last disabled at (470772): [<ffffffff81001910>] trace_hardirqs_off_thunk+0x1a/0x1c
<4>[   13.203021] softirqs last  enabled at (470502): [<ffffffff81c0031d>] __do_softirq+0x31d/0x483
<4>[   13.203029] softirqs last disabled at (470485): [<ffffffff8108c359>] irq_exit+0xa9/0xc0
<4>[   13.203112] WARNING: CPU: 6 PID: 314 at drivers/gpu/drm/i915/i915_irq.c:177 gen3_assert_iir_is_zero+0x2f/0x90 [i915]
<4>[   13.203117] ---[ end trace a9e7bee318e5569d ]---

And then all the tests failed with:

[   38.313107] ------------[ cut here ]------------
[   38.313109] WARN_ON(!pstate->fb)
[   38.313145] WARNING: CPU: 1 PID: 1210 at drivers/gpu/drm/i915/intel_pm.c:4099 skl_check_pipe_max_pixel_rate+0x292/0x370 [i915]
[   38.313147] Modules linked in: snd_hda_codec_hdmi snd_hda_codec_realtek snd_hda_codec_generic ax88179_178a usbnet x86_pkg_temp_thermal mii coretemp i915 crct10dif_pclmul crc32_pclmul snd_hda_intel snd_hda_codec ghash_clmulni_intel snd_hwdep snd_hda_core snd_pcm e1000e prime_numbers
[   38.313188] CPU: 1 PID: 1210 Comm: drv_getparams_b Tainted: G        W         4.19.0-rc1-CI-CI_DRM_4709+ #1
[   38.313190] Hardware name: Intel Corporation Ice Lake Client Platform/IceLake U DDR4 SODIMM PD RVP, BIOS ICLSFWR1.R00.2313.A01.1808012121 08/01/2018
[   38.313213] RIP: 0010:skl_check_pipe_max_pixel_rate+0x292/0x370 [i915]
[   38.313217] Code: fc 29 a0 48 89 14 24 e8 ec b3 f3 e0 0f 0b 48 8b 14 24 e9 19 fe ff ff 48 c7 c6 1c fe 29 a0 48 c7 c7 52 fc 29 a0 e8 ce b3 f3 e0 <0f> 0b b8 ea ff ff ff eb 97 b9 00 00 01 00 e9 2f ff ff ff 48 c7 c6
[   38.313219] RSP: 0018:ffffc90001613ba8 EFLAGS: 00010282
[   38.313223] RAX: 0000000000000000 RBX: ffff88049e100000 RCX: 0000000000000001
[   38.313225] RDX: 0000000080000001 RSI: ffffffff820c3006 RDI: 00000000ffffffff
[   38.313227] RBP: ffff88049278c4a8 R08: 000000001e89abbc R09: 0000000000000000
[   38.313229] R10: 000000000000001f R11: 0000000000000000 R12: ffff8804a925dfa8
[   38.313231] R13: ffff8804a7de4138 R14: ffff8804a7de2548 R15: 0000000000010000
[   38.313234] FS:  00007f15557bc980(0000) GS:ffff8804b0640000(0000) knlGS:0000000000000000
[   38.313236] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[   38.313238] CR2: 000055f8f77bbc78 CR3: 00000004a9044003 CR4: 0000000000760ee0
[   38.313240] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
[   38.313243] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
[   38.313244] PKRU: 55555554
[   38.313246] Call Trace:
[   38.313282]  intel_crtc_atomic_check+0x2b1/0x340 [i915]
[   38.313290]  drm_atomic_helper_check_planes+0x127/0x1c0
[   38.313320]  intel_atomic_check+0x427/0x10e0 [i915]
[   38.313333]  drm_atomic_check_only+0x422/0x670
[   38.313341]  drm_atomic_commit+0xe/0x50
[   38.313346]  restore_fbdev_mode_atomic+0x1d3/0x1f0
[   38.313358]  drm_fb_helper_restore_fbdev_mode_unlocked+0x42/0x90
[   38.313392]  intel_fbdev_restore_mode+0x2b/0x70 [i915]
[   38.313396]  drm_lastclose+0x2b/0xe0
[   38.313400]  drm_release+0xeb/0x120
[   38.313407]  __fput+0xb9/0x1f0
[   38.313413]  task_work_run+0x82/0xb0
[   38.313419]  exit_to_usermode_loop+0x93/0xa0
[   38.313423]  do_syscall_64+0x14c/0x190
[   38.313428]  entry_SYSCALL_64_after_hwframe+0x49/0xbe
[   38.313431] RIP: 0033:0x7f1554f3d421
[   38.313434] Code: f7 d8 64 89 02 48 c7 c0 ff ff ff ff c3 66 2e 0f 1f 84 00 00 00 00 00 66 90 8b 05 ea cf 20 00 85 c0 75 16 b8 03 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 3f f3 c3 0f 1f 44 00 00 53 89 fb 48 83 ec 10
[   38.313436] RSP: 002b:00007fff062e32b8 EFLAGS: 00000246 ORIG_RAX: 0000000000000003
[   38.313440] RAX: 0000000000000000 RBX: 0000000000000001 RCX: 00007f1554f3d421
[   38.313442] RDX: 0000000000000000 RSI: 000055f8f778f118 RDI: 0000000000000003
[   38.313444] RBP: 00007fff062e32c0 R08: 00007f15557bc980 R09: 0000000000000000
[   38.313447] R10: 0000000000000000 R11: 0000000000000246 R12: 00007f1554f26718
[   38.313449] R13: 0000000000000003 R14: 00007f1554f2b628 R15: 00007f1554f27d80
[   38.313459] irq event stamp: 42660
[   38.313464] hardirqs last  enabled at (42659): [<ffffffff810f7d66>] console_unlock+0x1b6/0x5e0
[   38.313467] hardirqs last disabled at (42660): [<ffffffff81001910>] trace_hardirqs_off_thunk+0x1a/0x1c
[   38.313471] softirqs last  enabled at (42488): [<ffffffff81c0031d>] __do_softirq+0x31d/0x483
[   38.313474] softirqs last disabled at (42469): [<ffffffff8108c359>] irq_exit+0xa9/0xc0
[   38.313500] WARNING: CPU: 1 PID: 1210 at drivers/gpu/drm/i915/intel_pm.c:4099 skl_check_pipe_max_pixel_rate+0x292/0x370 [i915]
[   38.313502] ---[ end trace a9e7bee318e556b2 ]---
Comment 4 Martin Peres 2018-08-28 09:52:50 UTC
This only happened 4 times, but when it does, it fails for all the tests.
Comment 5 Imre Deak 2018-08-28 13:49:53 UTC
(In reply to Martin Peres from comment #3)
> Happened again yesterday. See
> https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_4709/fi-icl-u/boot0.log
> 
> <7>[   13.200993] [drm:intel_power_well_enable [i915]] enabling power well 4
> <3>[   13.201162] [drm:intel_power_domains_verify_state [i915]] *ERROR*
> power well AUX A state mismatch (refcount 0/enabled 1)

This is a false-positive, fixed in
https://patchwork.freedesktop.org/series/48794/

> <7>[   13.201285] [drm:intel_csr_ucode_init [i915]] No known CSR firmware
> for platform, disabling runtime PM

This one is expected, since no CSR (DMC) firmware info is specified yet for ICL. There is a patch from Anusha that adds that, but regardless things should work even without the firmware loaded.

> <4>[   13.202074] ------------[ cut here ]------------
> <4>[   13.202080] Interrupt register 0x44428 is not zero: 0xe6321048

This and the rest look independent issues.

> <4>[   13.202190] WARNING: CPU: 6 PID: 314 at
> drivers/gpu/drm/i915/i915_irq.c:177 gen3_assert_iir_is_zero+0x2f/0x90 [i915]
> <4>[   13.202196] Modules linked in: ax88179_178a(+) usbnet
> x86_pkg_temp_thermal mii coretemp i915(+) crct10dif_pclmul crc32_pclmul
> snd_hda_intel snd_hda_codec ghash_clmulni_intel snd_hwdep snd_hda_core
> snd_pcm e1000e prime_numbers
> <4>[   13.202251] CPU: 6 PID: 314 Comm: systemd-udevd Tainted: G        W   
> 4.19.0-rc1-CI-CI_DRM_4709+ #1
> <4>[   13.202254] Hardware name: Intel Corporation Ice Lake Client
> Platform/IceLake U DDR4 SODIMM PD RVP, BIOS ICLSFWR1.R00.2313.A01.1808012121
> 08/01/2018
> <4>[   13.202318] RIP: 0010:gen3_assert_iir_is_zero+0x2f/0x90 [i915]
> <4>[   13.202323] Code: 00 53 89 f5 48 89 fb 48 8b 87 30 0f 00 00 e8 98 44
> ad e1 85 c0 75 03 5b 5d c3 89 c2 89 ee 48 c7 c7 b0 06 2b a0 e8 f1 5c f5 e0
> <0f> 0b b9 01 00 00 00 48 8b 83 50 0f 00 00 89 ee 48 89 df ba ff ff
> <4>[   13.202327] RSP: 0018:ffffc9000058ba70 EFLAGS: 00010286
> <4>[   13.202334] RAX: 0000000000000000 RBX: ffff88049e100000 RCX:
> 0000000000000001
> <4>[   13.202337] RDX: 0000000080000001 RSI: ffffffff82124d4a RDI:
> 00000000ffffffff
> <4>[   13.202341] RBP: 0000000000044428 R08: 0000000004dfabf4 R09:
> 0000000000000000
> <4>[   13.202344] R10: 0000000000000000 R11: 0000000000000000 R12:
> 0000000000000020
> <4>[   13.202347] R13: 00000000effff07f R14: 0000000000000002 R15:
> ffff88049e100000
> <4>[   13.202351] FS:  00007f8b485a0680(0000) GS:ffff8804b0780000(0000)
> knlGS:0000000000000000
> <4>[   13.202355] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
> <4>[   13.202359] CR2: 000055dc8fcce068 CR3: 00000004a6598002 CR4:
> 0000000000760ee0
> <4>[   13.202362] DR0: 0000000000000000 DR1: 0000000000000000 DR2:
> 0000000000000000
> <4>[   13.202365] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7:
> 0000000000000400
> <4>[   13.202368] PKRU: 55555554
> <4>[   13.202371] Call Trace:
> <4>[   13.202430]  gen8_de_irq_postinstall+0x271/0x410 [i915]
> <4>[   13.202489]  gen11_irq_postinstall+0x132/0x290 [i915]
> <4>[   13.202498]  drm_irq_install+0xb0/0x120
> <4>[   13.202552]  i915_driver_load+0xc2d/0x10c0 [i915]
> <4>[   13.202562]  ? _raw_spin_unlock_irqrestore+0x4c/0x60
> <4>[   13.202570]  ? lockdep_hardirqs_on+0xe0/0x1b0
> <4>[   13.202653]  i915_pci_probe+0x29/0xa0 [i915]
> <4>[   13.202665]  pci_device_probe+0xa1/0x130
> <4>[   13.202679]  really_probe+0x25d/0x3c0
> <4>[   13.202691]  driver_probe_device+0x10a/0x120
> <4>[   13.202702]  __driver_attach+0xdb/0x100
> <4>[   13.202711]  ? driver_probe_device+0x120/0x120
> <4>[   13.202719]  bus_for_each_dev+0x74/0xc0
> <4>[   13.202733]  bus_add_driver+0x15f/0x250
> <4>[   13.202741]  ? 0xffffffffa03c3000
> <4>[   13.202750]  driver_register+0x56/0xe0
> <4>[   13.202757]  ? 0xffffffffa03c3000
> <4>[   13.202764]  do_one_initcall+0x58/0x2e0
> <4>[   13.202772]  ? rcu_lockdep_current_cpu_online+0x8f/0xd0
> <4>[   13.202782]  ? do_init_module+0x1d/0x1ea
> <4>[   13.202790]  ? rcu_read_lock_sched_held+0x6f/0x80
> <4>[   13.202798]  ? kmem_cache_alloc_trace+0x264/0x290
> <4>[   13.202813]  do_init_module+0x56/0x1ea
> <4>[   13.202824]  load_module+0x26ba/0x29a0
> <4>[   13.202845]  ? vfs_read+0x122/0x140
> <4>[   13.202878]  ? __se_sys_finit_module+0xd3/0xf0
> <4>[   13.202885]  __se_sys_finit_module+0xd3/0xf0
> <4>[   13.202914]  do_syscall_64+0x55/0x190
> <4>[   13.202924]  entry_SYSCALL_64_after_hwframe+0x49/0xbe
> <4>[   13.202931] RIP: 0033:0x7f8b480c1839
> <4>[   13.202937] 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
> <4>[   13.202943] RSP: 002b:00007ffcf3fb45b8 EFLAGS: 00000246 ORIG_RAX:
> 0000000000000139
> <4>[   13.202953] RAX: ffffffffffffffda RBX: 0000565108c73280 RCX:
> 00007f8b480c1839
> <4>[   13.202957] RDX: 0000000000000000 RSI: 00007f8b47da00e5 RDI:
> 000000000000000f
> <4>[   13.202962] RBP: 00007f8b47da00e5 R08: 0000000000000000 R09:
> 00007ffcf3fb46d0
> <4>[   13.202967] R10: 000000000000000f R11: 0000000000000246 R12:
> 0000000000000000
> <4>[   13.202972] R13: 0000565108c4b6e0 R14: 0000000000020000 R15:
> 0000565108c73280
> <4>[   13.202998] irq event stamp: 470772
> <4>[   13.203007] hardirqs last  enabled at (470771): [<ffffffff810f7d66>]
> console_unlock+0x1b6/0x5e0
> <4>[   13.203014] hardirqs last disabled at (470772): [<ffffffff81001910>]
> trace_hardirqs_off_thunk+0x1a/0x1c
> <4>[   13.203021] softirqs last  enabled at (470502): [<ffffffff81c0031d>]
> __do_softirq+0x31d/0x483
> <4>[   13.203029] softirqs last disabled at (470485): [<ffffffff8108c359>]
> irq_exit+0xa9/0xc0
> <4>[   13.203112] WARNING: CPU: 6 PID: 314 at
> drivers/gpu/drm/i915/i915_irq.c:177 gen3_assert_iir_is_zero+0x2f/0x90 [i915]
> <4>[   13.203117] ---[ end trace a9e7bee318e5569d ]---
> 
> And then all the tests failed with:
> 
> [   38.313107] ------------[ cut here ]------------
> [   38.313109] WARN_ON(!pstate->fb)
> [   38.313145] WARNING: CPU: 1 PID: 1210 at
> drivers/gpu/drm/i915/intel_pm.c:4099
> skl_check_pipe_max_pixel_rate+0x292/0x370 [i915]
> [   38.313147] Modules linked in: snd_hda_codec_hdmi snd_hda_codec_realtek
> snd_hda_codec_generic ax88179_178a usbnet x86_pkg_temp_thermal mii coretemp
> i915 crct10dif_pclmul crc32_pclmul snd_hda_intel snd_hda_codec
> ghash_clmulni_intel snd_hwdep snd_hda_core snd_pcm e1000e prime_numbers
> [   38.313188] CPU: 1 PID: 1210 Comm: drv_getparams_b Tainted: G        W   
> 4.19.0-rc1-CI-CI_DRM_4709+ #1
> [   38.313190] Hardware name: Intel Corporation Ice Lake Client
> Platform/IceLake U DDR4 SODIMM PD RVP, BIOS ICLSFWR1.R00.2313.A01.1808012121
> 08/01/2018
> [   38.313213] RIP: 0010:skl_check_pipe_max_pixel_rate+0x292/0x370 [i915]
> [   38.313217] Code: fc 29 a0 48 89 14 24 e8 ec b3 f3 e0 0f 0b 48 8b 14 24
> e9 19 fe ff ff 48 c7 c6 1c fe 29 a0 48 c7 c7 52 fc 29 a0 e8 ce b3 f3 e0 <0f>
> 0b b8 ea ff ff ff eb 97 b9 00 00 01 00 e9 2f ff ff ff 48 c7 c6
> [   38.313219] RSP: 0018:ffffc90001613ba8 EFLAGS: 00010282
> [   38.313223] RAX: 0000000000000000 RBX: ffff88049e100000 RCX:
> 0000000000000001
> [   38.313225] RDX: 0000000080000001 RSI: ffffffff820c3006 RDI:
> 00000000ffffffff
> [   38.313227] RBP: ffff88049278c4a8 R08: 000000001e89abbc R09:
> 0000000000000000
> [   38.313229] R10: 000000000000001f R11: 0000000000000000 R12:
> ffff8804a925dfa8
> [   38.313231] R13: ffff8804a7de4138 R14: ffff8804a7de2548 R15:
> 0000000000010000
> [   38.313234] FS:  00007f15557bc980(0000) GS:ffff8804b0640000(0000)
> knlGS:0000000000000000
> [   38.313236] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
> [   38.313238] CR2: 000055f8f77bbc78 CR3: 00000004a9044003 CR4:
> 0000000000760ee0
> [   38.313240] DR0: 0000000000000000 DR1: 0000000000000000 DR2:
> 0000000000000000
> [   38.313243] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7:
> 0000000000000400
> [   38.313244] PKRU: 55555554
> [   38.313246] Call Trace:
> [   38.313282]  intel_crtc_atomic_check+0x2b1/0x340 [i915]
> [   38.313290]  drm_atomic_helper_check_planes+0x127/0x1c0
> [   38.313320]  intel_atomic_check+0x427/0x10e0 [i915]
> [   38.313333]  drm_atomic_check_only+0x422/0x670
> [   38.313341]  drm_atomic_commit+0xe/0x50
> [   38.313346]  restore_fbdev_mode_atomic+0x1d3/0x1f0
> [   38.313358]  drm_fb_helper_restore_fbdev_mode_unlocked+0x42/0x90
> [   38.313392]  intel_fbdev_restore_mode+0x2b/0x70 [i915]
> [   38.313396]  drm_lastclose+0x2b/0xe0
> [   38.313400]  drm_release+0xeb/0x120
> [   38.313407]  __fput+0xb9/0x1f0
> [   38.313413]  task_work_run+0x82/0xb0
> [   38.313419]  exit_to_usermode_loop+0x93/0xa0
> [   38.313423]  do_syscall_64+0x14c/0x190
> [   38.313428]  entry_SYSCALL_64_after_hwframe+0x49/0xbe
> [   38.313431] RIP: 0033:0x7f1554f3d421
> [   38.313434] Code: f7 d8 64 89 02 48 c7 c0 ff ff ff ff c3 66 2e 0f 1f 84
> 00 00 00 00 00 66 90 8b 05 ea cf 20 00 85 c0 75 16 b8 03 00 00 00 0f 05 <48>
> 3d 00 f0 ff ff 77 3f f3 c3 0f 1f 44 00 00 53 89 fb 48 83 ec 10
> [   38.313436] RSP: 002b:00007fff062e32b8 EFLAGS: 00000246 ORIG_RAX:
> 0000000000000003
> [   38.313440] RAX: 0000000000000000 RBX: 0000000000000001 RCX:
> 00007f1554f3d421
> [   38.313442] RDX: 0000000000000000 RSI: 000055f8f778f118 RDI:
> 0000000000000003
> [   38.313444] RBP: 00007fff062e32c0 R08: 00007f15557bc980 R09:
> 0000000000000000
> [   38.313447] R10: 0000000000000000 R11: 0000000000000246 R12:
> 00007f1554f26718
> [   38.313449] R13: 0000000000000003 R14: 00007f1554f2b628 R15:
> 00007f1554f27d80
> [   38.313459] irq event stamp: 42660
> [   38.313464] hardirqs last  enabled at (42659): [<ffffffff810f7d66>]
> console_unlock+0x1b6/0x5e0
> [   38.313467] hardirqs last disabled at (42660): [<ffffffff81001910>]
> trace_hardirqs_off_thunk+0x1a/0x1c
> [   38.313471] softirqs last  enabled at (42488): [<ffffffff81c0031d>]
> __do_softirq+0x31d/0x483
> [   38.313474] softirqs last disabled at (42469): [<ffffffff8108c359>]
> irq_exit+0xa9/0xc0
> [   38.313500] WARNING: CPU: 1 PID: 1210 at
> drivers/gpu/drm/i915/intel_pm.c:4099
> skl_check_pipe_max_pixel_rate+0x292/0x370 [i915]
> [   38.313502] ---[ end trace a9e7bee318e556b2 ]---
Comment 6 Chris Wilson 2018-08-31 13:53:41 UTC
From hw state readout it appears that the device reports CRTC/pipe A off, but still has 2 planes enabled. Since the CRTC is off, we don't then disable it (or its plans) on the initial modeset, leaving the conflicting state in place.
Comment 7 Chris Wilson 2018-08-31 13:54:14 UTC
*** Bug 107716 has been marked as a duplicate of this bug. ***
Comment 8 Jani Saarinen 2018-10-16 15:53:02 UTC
Not see in a month, closing.

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.