| Summary: | [CI] igt@* - dmesg-warn - *ERROR* Panel is unable to calculate any CRC after 6 vblanks | Unclaimed read from register 0x130090 | ||||||||
|---|---|---|---|---|---|---|---|---|---|
| Product: | DRI | Reporter: | Marta Löfstedt <marta.lofstedt> | ||||||
| Component: | DRM/Intel | Assignee: | Imre Deak <imre.deak> | ||||||
| Status: | CLOSED FIXED | QA Contact: | Intel GFX Bugs mailing list <intel-gfx-bugs> | ||||||
| Severity: | normal | ||||||||
| Priority: | medium | CC: | intel-gfx-bugs | ||||||
| Version: | DRI git | ||||||||
| Hardware: | Other | ||||||||
| OS: | All | ||||||||
| Whiteboard: | ReadyForDev | ||||||||
| i915 platform: | CFL | i915 features: | display/Other | ||||||
| Attachments: |
|
||||||||
|
Description
Marta Löfstedt
2017-10-18 09:41:57 UTC
https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_3261/shard-glkb2/igt@debugfs_test@read_all_entries.html [ 3203.809549] Unclaimed read from register 0x130090 [ 3203.809592] ------------[ cut here ]------------ [ 3203.809644] WARNING: CPU: 0 PID: 5669 at drivers/gpu/drm/i915/intel_uncore.c:860 __unclaimed_reg_debug+0x47/0x60 [i915] [ 3203.809647] Modules linked in: vgem snd_hda_codec_realtek snd_hda_codec_generic i915 x86_pkg_temp_thermal intel_powerclamp coretemp crct10dif_pclmul crc32_pclmul ghash_clmulni_intel snd_hda_intel snd_hda_codec snd_hwdep snd_hda_core r8169 mii snd_pcm mei_me prime_numbers mei i2c_hid pinctrl_geminilake pinctrl_intel [ 3203.809696] CPU: 0 PID: 5669 Comm: debugfs_test Tainted: G U 4.14.0-rc5-CI-CI_DRM_3261+ #1 [ 3203.809699] Hardware name: Intel Corp. Geminilake/GLK RVP2 LP4SD (07), BIOS GELKRVPA.X64.0062.B30.1708222146 08/22/2017 [ 3203.809702] task: ffff88013aab8040 task.stack: ffffc9000049c000 [ 3203.809750] RIP: 0010:__unclaimed_reg_debug+0x47/0x60 [i915] [ 3203.809754] RSP: 0018:ffffc9000049fcf8 EFLAGS: 00010092 [ 3203.809758] RAX: 0000000000000025 RBX: 0000000000000000 RCX: 0000000000000002 [ 3203.809761] RDX: 0000000080000002 RSI: ffffffff81d1849f RDI: 00000000ffffffff [ 3203.809764] RBP: ffffc9000049fd10 R08: 0000000000000001 R09: 0000000000000000 [ 3203.809767] R10: ffffc9000049fc88 R11: 0000000000000000 R12: 0000000000130090 [ 3203.809770] R13: 0000000000000001 R14: 0000000000000000 R15: ffff88016e840bb0 [ 3203.809773] FS: 00007fc61d044a40(0000) GS:ffff88017fc00000(0000) knlGS:0000000000000000 [ 3203.809778] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 3203.809781] CR2: 000055eb1ffe3008 CR3: 000000016cc26000 CR4: 00000000003406f0 [ 3203.809783] Call Trace: [ 3203.809833] fwtable_read32+0x243/0x2c0 [i915] [ 3203.809878] i915_drpc_info+0x27d/0x8e0 [i915] [ 3203.809886] seq_read+0xe1/0x3a0 [ 3203.809894] full_proxy_read+0x54/0x80 [ 3203.809902] __vfs_read+0x28/0x120 [ 3203.809907] ? putname+0x54/0x60 [ 3203.809912] ? kmem_cache_free+0x290/0x330 [ 3203.809915] ? kmem_cache_free+0x12c/0x330 [ 3203.809920] vfs_read+0xa8/0x150 [ 3203.809924] SyS_read+0x49/0xb0 [ 3203.809932] entry_SYSCALL_64_fastpath+0x1c/0xb1 [ 3203.809935] RIP: 0033:0x7fc61b51e6d0 [ 3203.809938] RSP: 002b:00007fff501a7a18 EFLAGS: 00000246 ORIG_RAX: 0000000000000000 [ 3203.809943] RAX: ffffffffffffffda RBX: 000055eb1ffc7f6b RCX: 00007fc61b51e6d0 [ 3203.809946] RDX: 0000000000000200 RSI: 00007fff501a7a30 RDI: 0000000000000006 [ 3203.809948] RBP: 00007fff501a7a30 R08: 000055eb1ff6f300 R09: 0000000000000000 [ 3203.809951] R10: 0000000000000000 R11: 0000000000000246 R12: 000055eb1ffc7a00 [ 3203.809954] R13: 0000000000000005 R14: 0000000000000006 R15: 0000000000000003 [ 3203.809960] Code: 01 75 31 84 db 75 2d 45 84 ed 48 c7 c0 fc 7c 24 a0 48 c7 c6 f2 7c 24 a0 48 0f 44 f0 44 89 e2 48 c7 c7 05 7d 24 a0 e8 4a 40 f6 e0 <0f> ff 83 2d 30 07 10 00 01 5b 41 5c 41 5d 5d c3 66 0f 1f 84 00 [ 3203.810058] ---[ end trace e04068ecac830ca6 ]--- [ 2150.111884] Unclaimed read from register 0x130090 [ 2150.111939] ------------[ cut here ]------------ [ 2150.112008] WARNING: CPU: 3 PID: 8268 at drivers/gpu/drm/i915/intel_uncore.c:860 __unclaimed_reg_debug+0x47/0x60 [i915] [ 2150.112012] Modules linked in: vgem snd_hda_codec_hdmi snd_hda_codec_realtek snd_hda_codec_generic x86_pkg_temp_thermal intel_powerclamp i915 coretemp crct10dif_pclmul crc32_pclmul ghash_clmulni_intel snd_hda_intel snd_hda_codec snd_hwdep snd_hda_core snd_pcm mei_me prime_numbers r8169 mei mii i2c_hid pinctrl_geminilake pinctrl_intel [last unloaded: vgem] [ 2150.112081] CPU: 3 PID: 8268 Comm: debugfs_test Tainted: G U 4.14.0-rc5-CI-CI_DRM_3272+ #1 [ 2150.112086] Hardware name: Intel Corp. Geminilake/GLK RVP1 DDR4 (05), BIOS GELKRVPA.X64.0062.B30.1708222146 08/22/2017 [ 2150.112091] task: ffff8801781a8040 task.stack: ffffc90000e2c000 [ 2150.112159] RIP: 0010:__unclaimed_reg_debug+0x47/0x60 [i915] [ 2150.112164] RSP: 0018:ffffc90000e2fcf8 EFLAGS: 00010092 [ 2150.112170] RAX: 0000000000000025 RBX: 0000000000000000 RCX: 0000000000000002 [ 2150.112174] RDX: 0000000080000002 RSI: ffffffff81cb3f8b RDI: 00000000ffffffff [ 2150.112178] RBP: ffffc90000e2fd10 R08: 0000000000000001 R09: 0000000000000000 [ 2150.112182] R10: ffffc90000e2fc88 R11: 0000000000000000 R12: 0000000000130090 [ 2150.112186] R13: 0000000000000001 R14: 0000000000000000 R15: ffff8801683c0bb0 [ 2150.112191] FS: 00007fb13630aa40(0000) GS:ffff88017fd80000(0000) knlGS:0000000000000000 [ 2150.112195] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 2150.112199] CR2: 00007fdcbdb2c020 CR3: 0000000113915000 CR4: 00000000003406e0 [ 2150.112203] Call Trace: [ 2150.112271] fwtable_read32+0x243/0x2c0 [i915] [ 2150.112333] i915_drpc_info+0x27d/0x8e0 [i915] [ 2150.112343] seq_read+0xe1/0x3a0 [ 2150.112356] full_proxy_read+0x54/0x80 [ 2150.112364] __vfs_read+0x28/0x120 [ 2150.112371] ? putname+0x54/0x60 [ 2150.112377] ? kmem_cache_free+0x290/0x330 [ 2150.112382] ? kmem_cache_free+0x12c/0x330 [ 2150.112388] vfs_read+0xa8/0x150 [ 2150.112395] SyS_read+0x49/0xb0 [ 2150.112404] entry_SYSCALL_64_fastpath+0x1c/0xb1 [ 2150.112409] RIP: 0033:0x7fb1347e46d0 [ 2150.112413] RSP: 002b:00007fff5e7af988 EFLAGS: 00000246 ORIG_RAX: 0000000000000000 [ 2150.112419] RAX: ffffffffffffffda RBX: 0000561424a4caeb RCX: 00007fb1347e46d0 [ 2150.112423] RDX: 0000000000000200 RSI: 00007fff5e7af9a0 RDI: 0000000000000006 [ 2150.112427] RBP: 00007fff5e7af9a0 R08: 0000561424a47b40 R09: 0000000000000000 [ 2150.112431] R10: 0000000000000000 R11: 0000000000000246 R12: 0000561424a4c580 [ 2150.112435] R13: 0000000000000005 R14: 0000000000000006 R15: 0000000000000000 [ 2150.112444] Code: 01 75 31 84 db 75 2d 45 84 ed 48 c7 c0 c9 6c 22 a0 48 c7 c6 bf 6c 22 a0 48 0f 44 f0 44 89 e2 48 c7 c7 d2 6c 22 a0 e8 2a 50 f8 e0 <0f> ff 83 2d 30 07 10 00 01 5b 41 5c 41 5d 5d c3 66 0f 1f 84 00 [ 2150.112578] ---[ end trace bd08d0d997cb72dd ]--- https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_3272/shard-glkb5/igt@debugfs_test@read_all_entries_display_off.html https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_3306/shard-glkb3/igt@kms_frontbuffer_tracking@fbc-1p-primscrn-pri-indfb-draw-mmap-gtt.html piglit [ 3798.061259] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks From dmesg it looks like the actual subtest hasn't started yet: <7>[ 3797.660555] [IGT] kms_frontbuffer_tracking: executing ... <3>[ 3798.061259] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks <7>[ 3798.078124] [IGT] kms_frontbuffer_tracking: starting subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt The same thing is going on ealier: <7>[ 3738.328402] [IGT] kms_frontbuffer_tracking: executing ... <3>[ 3738.728622] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks ... <7>[ 3738.746617] [IGT] kms_frontbuffer_tracking: starting subtest fbcpsr-suspend and here: <7>[ 3786.839316] [IGT] kms_frontbuffer_tracking: executing ... <3>[ 3787.250869] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks <7>[ 3787.267657] [IGT] kms_frontbuffer_tracking: starting subtest fbc-2p-scndscrn-pri-shrfb-draw-render The we can look in the previous shard on this machine without reboot: https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_3306/shard-glkb3/dmesg28.log <7>[ 3255.851528] [IGT] kms_frontbuffer_tracking: executing ... <3>[ 3256.262032] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks ... <7>[ 3256.279360] [IGT] kms_frontbuffer_tracking: starting subtest psr-1p-primscrn-pri-indfb-draw-pwrite In the run before that one: https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_3306/shard-glkb3/dmesg25.log The issue isn't present. However, in the on after this run, the last shard: https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_3306/shard-glkb3/dmesg34.log The issue continues: <7>[ 4388.690460] [IGT] kms_frontbuffer_tracking: executing ... <3>[ 4389.103319] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks <7>[ 4389.120204] [IGT] kms_frontbuffer_tracking: starting subtest fbc-2p-scndscrn-pri-shrfb-draw-blt and <7>[ 4565.469133] [IGT] kms_frontbuffer_tracking: executing ... <3>[ 4565.874254] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks <7>[ 4565.891824] [IGT] kms_frontbuffer_tracking: starting subtest psr-2p-primscrn-spr-indfb-move https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_3310/shard-glkb4/igt@perf@rc6-disable.html [ 4176.043375] Unclaimed read from register 0x130090 [ 4176.043427] ------------[ cut here ]------------ [ 4176.043505] WARNING: CPU: 3 PID: 10053 at drivers/gpu/drm/i915/intel_uncore.c:976 __unclaimed_reg_debug+0x47/0x60 [i915] [ 4176.043530] Modules linked in: i2c_dev snd_hda_intel i915 vgem snd_hda_codec_hdmi snd_hda_codec_realtek snd_hda_codec_generic x86_pkg_temp_thermal intel_powerclamp coretemp crct10dif_pclmul crc32_pclmul ghash_clmulni_intel snd_hda_codec snd_hwdep snd_hda_core mei_me snd_pcm mei r8169 mii prime_numbers i2c_hid pinctrl_geminilake pinctrl_intel [last unloaded: i915] [ 4176.043646] CPU: 3 PID: 10053 Comm: perf Tainted: G U W 4.14.0-rc7-CI-CI_DRM_3310+ #1 [ 4176.043667] Hardware name: Intel Corp. Geminilake/GLK RVP1 DDR4 (05), BIOS GELKRVPA.X64.0062.B30.1708222146 08/22/2017 [ 4176.043691] task: ffff8801681d0040 task.stack: ffffc90000130000 [ 4176.043754] RIP: 0010:__unclaimed_reg_debug+0x47/0x60 [i915] [ 4176.043768] RSP: 0018:ffffc90000133cf8 EFLAGS: 00010092 [ 4176.043783] RAX: 0000000000000025 RBX: 0000000000000000 RCX: 0000000000000002 [ 4176.043800] RDX: 0000000080000002 RSI: ffffffff81cb4dab RDI: 00000000ffffffff [ 4176.043817] RBP: ffffc90000133d10 R08: 0000000000000001 R09: 0000000000000000 [ 4176.043834] R10: ffffc90000133c88 R11: 0000000000000000 R12: 0000000000130090 [ 4176.043850] R13: 0000000000000001 R14: 0000000000000000 R15: ffff880172ae0bb8 [ 4176.043868] FS: 00007fe1965448c0(0000) GS:ffff88017fd80000(0000) knlGS:0000000000000000 [ 4176.043887] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 4176.043901] CR2: 0000562455bc7248 CR3: 000000017297d000 CR4: 00000000003406e0 [ 4176.043918] Call Trace: [ 4176.043975] fwtable_read32+0x243/0x2c0 [i915] [ 4176.044031] i915_drpc_info+0x27d/0x8e0 [i915] [ 4176.044049] seq_read+0xe1/0x3a0 [ 4176.044063] full_proxy_read+0x54/0x80 [ 4176.044077] __vfs_read+0x28/0x120 [ 4176.044091] ? SyS_newfstat+0x3a/0x50 [ 4176.044103] vfs_read+0xa8/0x150 [ 4176.044114] SyS_read+0x49/0xb0 [ 4176.044128] entry_SYSCALL_64_fastpath+0x1c/0xb1 [ 4176.044140] RIP: 0033:0x7fe194a4b890 [ 4176.044150] RSP: 002b:00007ffc5806c408 EFLAGS: 00000246 ORIG_RAX: 0000000000000000 [ 4176.044170] RAX: ffffffffffffffda RBX: 0000000000000005 RCX: 00007fe194a4b890 [ 4176.044187] RDX: 0000000000001000 RSI: 0000562455bc6240 RDI: 0000000000000006 [ 4176.044204] RBP: 0000000000000006 R08: 00007fe194d150a8 R09: 0000000000000000 [ 4176.044220] R10: 00007fe194d14b58 R11: 0000000000000246 R12: 0000000000000000 [ 4176.044237] R13: 00007ffc5806ddc0 R14: 0000000000000000 R15: 0000000000000000 [ 4176.044258] Code: 01 75 31 84 db 75 2d 45 84 ed 48 c7 c0 fe 4c 22 a0 48 c7 c6 f4 4c 22 a0 48 0f 44 f0 44 89 e2 48 c7 c7 07 4d 22 a0 e8 3a 85 f8 e0 <0f> ff 83 2d e0 2d 10 00 01 5b 41 5c 41 5d 5d c3 66 0f 1f 84 00 [ 4176.044396] ---[ end trace b919e89a83d0d7e0 ]--- This issue is happening on CFL with latest configuration. Test cases: igt@drv_suspend@debugfs-reader igt@drv_suspend@debugfs-reader-hibernate Hardware configuration: intel-gpu-tools-1.20-189-g1db1246 dmesg summary: [ 112.449242] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 112.599206] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 112.749203] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 112.899254] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 113.049197] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 113.199258] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 113.349189] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 113.483122] hpet_rtc_timer_reinit: 20 callbacks suppressed [ 113.483122] hpet1: lost 2 rtc interrupts This issue is happening on GLK with latest configuration. Test cases: igt@drv_suspend@debugfs-reader igt@drv_suspend@debugfs-reader-hibernate configuration IGT-Version: 1.20-gc0be331 (x86_64) (Linux: 4.15.0-rc4-drm-intel-qa-ww51-commit-bf5cdf9+ x86_64) [ 91.015687] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 91.182245] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 91.348790] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 91.515140] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 91.681693] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 91.848289] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 92.014802] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks CFL with IGT 1.20-g4cd4cc4, kernel 4.15.0-rc5-commit-8cb9e98+, the warn was capture in test igt@debugfs_test@read_all_entries. [ 69.501965] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks Note from: CI_DRM_3611 and all consecutive runs on GLK-shards, so far to CI_DRM_3617 https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_3611/shard-glkb3/igt@debugfs_test@read_all_entries.html hits: [ 139.108554] Unclaimed read from register 0x130090 [ 139.108666] WARNING: CPU: 1 PID: 1462 at drivers/gpu/drm/i915/intel_uncore.c:986 __unclaimed_reg_debug+0x3b/0x50 [i915] [ 139.108671] Modules linked in: vgem snd_hda_codec_hdmi snd_hda_codec_realtek snd_hda_codec_generic i915 x86_pkg_temp_thermal intel_powerclamp coretemp crct10dif_pclmul crc32_pclmul ghash_clmulni_intel snd_hda_intel snd_hda_codec snd_hwdep snd_hda_core snd_pcm r8169 mei_me mii mei prime_numbers i2c_hid pinctrl_geminilake pinctrl_intel [ 139.108800] CPU: 1 PID: 1462 Comm: debugfs_test Tainted: G U 4.15.0-rc7-CI-CI_DRM_3611+ #1 [ 139.108806] Hardware name: Intel Corp. Geminilake/GLK RVP1 DDR4 (05), BIOS GELKRVPA.X64.0062.B30.1708222146 08/22/2017 [ 139.108892] RIP: 0010:__unclaimed_reg_debug+0x3b/0x50 [i915] [ 139.108898] RSP: 0018:ffffc9000059bd38 EFLAGS: 00010092 [ 139.108908] RAX: 0000000000000025 RBX: 0000000000000000 RCX: 0000000000000002 [ 139.108914] RDX: 0000000080000002 RSI: ffffffff820ab3a7 RDI: 00000000ffffffff [ 139.108919] RBP: 0000000000130090 R08: 0000000000000000 R09: 0000000000000001 [ 139.108925] R10: ffffc9000059bcd0 R11: 0000000000000002 R12: 0000000000000001 [ 139.108930] R13: ffff8801695c0ca0 R14: 0000000000000000 R15: 0000000000000202 [ 139.108936] FS: 00007fbb4cd6da40(0000) GS:ffff88017fc80000(0000) knlGS:0000000000000000 [ 139.108942] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 139.108948] CR2: 000055921b94d2d8 CR3: 000000016a208000 CR4: 0000000000340ee0 [ 139.108953] Call Trace: [ 139.109046] fwtable_read32+0x214/0x290 [i915] [ 139.109131] i915_drpc_info+0x267/0x8c0 [i915] [ 139.109145] ? rcu_read_lock_sched_held+0x6f/0x80 [ 139.109162] seq_read+0xd8/0x3a0 [ 139.109176] ? debug_check_no_obj_freed+0x11f/0x230 [ 139.109190] full_proxy_read+0x4b/0x70 [ 139.109204] __vfs_read+0x1e/0x120 [ 139.109215] ? do_sys_open+0x197/0x1f0 [ 139.109226] ? do_sys_open+0x197/0x1f0 [ 139.109237] ? entry_SYSCALL_64_fastpath+0x5/0x89 [ 139.109248] vfs_read+0x9e/0x150 [ 139.109260] SyS_read+0x40/0xa0 [ 139.109274] entry_SYSCALL_64_fastpath+0x1c/0x89 [ 139.109281] RIP: 0033:0x7fbb4b2456d0 [ 139.109286] RSP: 002b:00007ffcd34b3888 EFLAGS: 00000246 [ 139.109315] Code: 3c 01 75 30 84 db 75 2c 45 84 e4 48 c7 c0 85 35 26 a0 48 c7 c6 7b 35 26 a0 48 0f 44 f0 89 ea 48 c7 c7 8e 35 26 a0 e8 b5 8c ed e0 <0f> ff 83 2d 4c bc 16 00 01 5b 5d 41 5c c3 0f 1f 80 00 00 00 00 [ 139.109629] ---[ end trace 8ffd6c56c54f09e5 ]--- i915_regs.h #define FORCEWAKE_ACK _MMIO(0x130090) I believe the backtrace is from: i915_debugfs.c -> static int gen6_drpc_info(struct seq_file *m) ... while (count++ < 50 && (I915_READ_NOTRACE(FORCEWAKE_ACK) & 1)) Interesting there are no IGT commits between CI_DRM_3611 - CI_DRM_3617, i.e. same test ordering for all the runs. maybe it isn't a regression. but some other evil thing happening before. So, before theigt@debugfs_test@read_all_entries there are: fail: igt/kms_frontbuffer_tracking/fbcpsr-1p-rte pass: igt/prime_vgem/fence-wait-render pass: igt/gem_exec_flush/basic-uc-pro-default skip: igt/kms_plane_lowres/pipe-f-tiling-none dmesg-warn: igt/pm_rpm/debugfs-read pass: igt/kms_3d igt/pm_rpm/debugfs-read <7>[ 98.926697] [drm:sandybridge_pcode_read [i915]] warning: pcode (read from mbox 5) mailbox access failed for i915_drpc_info [i915]: -6 - 6 => case GEN6_PCODE_ILLEGAL_CMD: return -ENXIO; static int gen6_drpc_info(struct seq_file *m) does: sandybridge_pcode_read(dev_priv, GEN6_PCODE_READ_RC6VIDS, &rc6vids); maybe GEN6_PCODE_READ_RC6VIDS is not available on GLK-shards This issue is happening on GLK with latest configuration. Test cases: igt@drv_suspend@debugfs-reader igt@drv_suspend@debugfs-reader-hibernate using IGT-Version: 1.20-g19c6c04 (x86_64) (Linux: 4.15.0-rc7-drm-intel-qa-ww2-commit-17fd162+ x86_64) [ 522.092188] atkbd serio0: Failed to enable keyboard on isa0060/serio0 [ 522.270930] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 522.420776] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 522.570663] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 522.720625] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 522.870458] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 523.020311] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 523.170154] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 524.383176] hpet1: lost 7162 rtc interrupts [ 525.579227] hpet1: lost 7162 rtc interrupts [ 526.571006] hpet1: lost 7161 rtc interrupts [ 526.856056] cache: parent cpu1 should not be sleeping [ 527.036223] usb usb1: root hub lost power or was reset [ 527.036225] usb usb2: root hub lost power or was reset [ 527.046453] sd 0:0:0:0: [sda] Starting disk [ 527.275788] atkbd serio0: Failed to deactivate keyboard on isa0060/serio0 [ 527.659785] atkbd serio0: Failed to enable keyboard on isa0060/serio0 [ 527.871037] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 527.929151] hpet1: lost 7160 rtc interrupts [ 528.087500] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 528.254138] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 528.453908] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 528.620446] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 528.797602] hpet1: lost 7161 rtc interrupts [ 528.886933] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 529.036662] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 529.203318] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 529.353088] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 529.503077] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 529.652969] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 529.802787] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks This tests has a dmesg-warn on CFL QA
Tests List:
igt@drv_suspend@debugfs-reader
igt@drv_suspend@debugfs-reader-hibernate
using IGT-Version: 1.20-g84a3080 (x86_64) (Linux: 4.15.0-rc8-drm-tip-ww3-commit-37eb04c+ x86_64)
======================================
dmesg-warn sample
======================================
. . .
[ 871.946912] (elapsed 0.176 seconds) done.
[ 871.948330] Suspending console(s) (use no_console_suspend to debug)
[ 872.292098] sd 4:0:0:0: [sda] Synchronizing SCSI cache
[ 872.292489] sd 4:0:0:0: [sda] Stopping disk
[ 872.308830] tpm tpm0: A TPM error (325) occurred stopping the TPM
[ 872.861846] IRQ 122: no longer affine to CPU8
[ 872.885746] IRQ 17: no longer affine to CPU9
[ 872.909690] IRQ 125: no longer affine to CPU10
[ 872.933554] IRQ 1: no longer affine to CPU11
[ 872.933561] IRQ 8: no longer affine to CPU11
[ 872.933565] IRQ 9: no longer affine to CPU11
[ 872.933572] IRQ 16: no longer affine to CPU11
[ 872.933577] IRQ 20: no longer affine to CPU11
[ 872.933584] IRQ 123: no longer affine to CPU11
[ 872.942497] cache: parent cpu1 should not be sleeping
[ 872.943660] cache: parent cpu2 should not be sleeping
[ 872.944798] cache: parent cpu3 should not be sleeping
[ 872.945950] cache: parent cpu4 should not be sleeping
[ 872.947132] cache: parent cpu5 should not be sleeping
[ 872.948436] cache: parent cpu6 should not be sleeping
[ 872.949682] cache: parent cpu7 should not be sleeping
[ 872.950980] cache: parent cpu8 should not be sleeping
[ 872.952323] cache: parent cpu9 should not be sleeping
[ 872.953731] cache: parent cpu10 should not be sleeping
[ 872.955161] cache: parent cpu11 should not be sleeping
[ 873.023806] ACPI: button: The lid device is not compliant to SW_LID.
[ 873.079073] hpet_rtc_timer_reinit: 19 callbacks suppressed
[ 873.079074] hpet1: lost 1427 rtc interrupts
[ 873.452873] sd 4:0:0:0: [sda] Starting disk
[ 873.714075] atkbd serio0: Failed to deactivate keyboard on isa0060/serio0
[ 874.090129] atkbd serio0: Failed to enable keyboard on isa0060/serio0
[ 874.117353] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks
[ 874.300780] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks
[ 874.484106] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks
[ 874.667559] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks
[ 874.850769] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks
[ 875.034178] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks
. . .
Created attachment 136761 [details]
kernel log
The following has also been seen on igt@debugfs_test@read_all_entries_display_off, not just igt@debugfs_test@read_all_entries. [ 336.785322] ------------[ cut here ]------------ [ 336.785363] Unclaimed read from register 0x130090 [ 336.785431] WARNING: CPU: 3 PID: 1793 at drivers/gpu/drm/i915/intel_uncore.c:986 __unclaimed_reg_debug+0x3b/0x50 [i915] [ 336.785435] Modules linked in: snd_hda_codec_hdmi snd_hda_codec_realtek snd_hda_codec_generic x86_pkg_temp_thermal i915 intel_powerclamp coretemp crct10dif_pclmul crc32_pclmul ghash_clmulni_intel snd_hda_intel snd_hda_codec snd_hwdep snd_hda_core snd_pcm r8169 mii mei_me prime_numbers mei i2c_hid pinctrl_geminilake pinctrl_intel [ 336.785498] CPU: 3 PID: 1793 Comm: debugfs_test Tainted: G U 4.15.0-rc8-CI-CI_DRM_3643+ #1 [ 336.785500] Hardware name: Intel Corp. Geminilake/GLK RVP1 DDR4 (05), BIOS GELKRVPA.X64.0062.B30.1708222146 08/22/2017 [ 336.785537] RIP: 0010:__unclaimed_reg_debug+0x3b/0x50 [i915] [ 336.785540] RSP: 0018:ffffc9000194bd38 EFLAGS: 00010092 [ 336.785544] RAX: 0000000000000025 RBX: 0000000000000000 RCX: 0000000000000002 [ 336.785547] RDX: 0000000080000002 RSI: ffffffff820abd07 RDI: 00000000ffffffff [ 336.785549] RBP: 0000000000130090 R08: 0000000000000000 R09: 0000000000000001 [ 336.785551] R10: ffffc9000194bcd0 R11: 0000000000000002 R12: 0000000000000001 [ 336.785554] R13: ffff880168650ca0 R14: 0000000000000000 R15: 0000000000000202 [ 336.785557] FS: 00007fc0bd595a40(0000) GS:ffff88017fd80000(0000) knlGS:0000000000000000 [ 336.785559] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 336.785562] CR2: 00007f110a6e4030 CR3: 000000017814a000 CR4: 0000000000340ee0 [ 336.785564] Call Trace: [ 336.785604] fwtable_read32+0x214/0x290 [i915] [ 336.785640] i915_drpc_info+0x267/0x8c0 [i915] [ 336.785646] ? rcu_read_lock_sched_held+0x6f/0x80 [ 336.785654] seq_read+0xd8/0x3a0 [ 336.785660] ? debug_check_no_obj_freed+0x11f/0x230 [ 336.785667] full_proxy_read+0x4b/0x70 [ 336.785673] __vfs_read+0x1e/0x120 [ 336.785678] ? do_sys_open+0x197/0x1f0 [ 336.785683] ? do_sys_open+0x197/0x1f0 [ 336.785688] ? entry_SYSCALL_64_fastpath+0x5/0x8f [ 336.785693] vfs_read+0x9e/0x150 [ 336.785698] SyS_read+0x40/0xa0 [ 336.785705] entry_SYSCALL_64_fastpath+0x22/0x8f [ 336.785708] RIP: 0033:0x7fc0bba6d6d0 [ 336.785710] RSP: 002b:00007ffdd2380998 EFLAGS: 00000246 [ 336.785723] Code: 3c 01 75 30 84 db 75 2c 45 84 e4 48 c7 c0 98 05 26 a0 48 c7 c6 8e 05 26 a0 48 0f 44 f0 89 ea 48 c7 c7 a1 05 26 a0 e8 55 c3 ed e0 <0f> ff 83 2d 6c b8 16 00 01 5b 5d 41 5c c3 0f 1f 80 00 00 00 00 [ 336.785854] ---[ end trace f74a4c54edc3891e ]--- Source: https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_3643/shard-glkb3/igt@debugfs_test@read_all_entries_display_off.html Adjusting back to Medium (after discussions), letting CI-Shards to define the priority according the impact over there. Sorry about any inconvenience caused. https://intel-gfx-ci.01.org/tree/drm-tip/IGT_4229/shard-glkb1/igt@gem_ctx_create@basic.html <7>[ 234.234820] [IGT] gem_ctx_create: executing <7>[ 234.234890] [drm:intel_power_well_enable [i915]] enabling dpio-common-c <7>[ 234.236312] [drm:intel_power_well_enable [i915]] enabling AUX B <7>[ 234.236349] [drm:intel_power_well_enable [i915]] enabling AUX C <7>[ 234.236387] [drm:intel_power_well_disable [i915]] disabling AUX C <7>[ 234.236423] [drm:intel_power_well_disable [i915]] disabling AUX B <7>[ 234.236459] [drm:intel_power_well_disable [i915]] disabling dpio-common-c <7>[ 234.236496] [drm:intel_power_well_disable [i915]] disabling dpio-common-b <7>[ 234.236532] [drm:intel_power_well_disable [i915]] disabling power well 2 <4>[ 234.237101] ------------[ cut here ]------------ <4>[ 234.237138] Unclaimed read from register 0x130090 <4>[ 234.237206] WARNING: CPU: 2 PID: 1936 at drivers/gpu/drm/i915/intel_uncore.c:986 __unclaimed_reg_debug+0x3b/0x50 [i915] <4>[ 234.237208] Modules linked in: vgem snd_hda_codec_hdmi snd_hda_codec_realtek snd_hda_codec_generic i915 x86_pkg_temp_thermal intel_powerclamp coretemp crct10dif_pclmul crc32_pclmul ghash_clmulni_intel snd_hda_intel snd_hda_codec snd_hwdep snd_hda_core snd_pcm r8169 mii prime_numbers mei_me mei i2c_hid pinctrl_geminilake pinctrl_intel <4>[ 234.237276] CPU: 2 PID: 1936 Comm: cat Tainted: G U 4.15.0-CI-CI_DRM_3736+ #1 <4>[ 234.237279] Hardware name: Intel Corp. Geminilake/GLK RVP2 LP4SD (07), BIOS GELKRVPA.X64.0062.B30.1708222146 08/22/2017 <4>[ 234.237315] RIP: 0010:__unclaimed_reg_debug+0x3b/0x50 [i915] <4>[ 234.237320] RSP: 0018:ffffc90000ba3d38 EFLAGS: 00010092 <4>[ 234.237327] RAX: 0000000000000025 RBX: 0000000000000000 RCX: 0000000000000002 <4>[ 234.237330] RDX: 0000000080000002 RSI: ffffffff820abf17 RDI: 00000000ffffffff <4>[ 234.237332] RBP: 0000000000130090 R08: 0000000000000000 R09: 0000000000000001 <4>[ 234.237334] R10: ffffc90000ba3cd0 R11: 0000000000000002 R12: 0000000000000001 <4>[ 234.237336] R13: ffff880167780ca0 R14: 0000000000000000 R15: 0000000000000202 <4>[ 234.237339] FS: 00007fb4568b5700(0000) GS:ffff88017fd00000(0000) knlGS:0000000000000000 <4>[ 234.237341] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 <4>[ 234.237344] CR2: 000055b3f5415100 CR3: 0000000172902000 CR4: 0000000000340ee0 <4>[ 234.237348] Call Trace: <4>[ 234.237391] fwtable_read32+0x214/0x290 [i915] <4>[ 234.237429] i915_drpc_info+0x267/0x8c0 [i915] <4>[ 234.237436] ? rcu_read_lock_sched_held+0x6f/0x80 <4>[ 234.237444] seq_read+0xd8/0x3a0 <4>[ 234.237452] full_proxy_read+0x4b/0x70 <4>[ 234.237459] __vfs_read+0x1e/0x120 <4>[ 234.237468] ? entry_SYSCALL_64_fastpath+0x5/0x8f <4>[ 234.237472] vfs_read+0x9e/0x150 <4>[ 234.237477] SyS_read+0x40/0xa0 <4>[ 234.237483] entry_SYSCALL_64_fastpath+0x22/0x8f <4>[ 234.237486] RIP: 0033:0x7fb4563e1890 <4>[ 234.237488] RSP: 002b:00007fffec12b328 EFLAGS: 00000246 <4>[ 234.237501] Code: 3c 01 75 30 84 db 75 2c 45 84 e4 48 c7 c0 aa 46 26 a0 48 c7 c6 a0 46 26 a0 48 0f 44 f0 89 ea 48 c7 c7 b3 46 26 a0 e8 15 b6 ed e0 <0f> ff 83 2d 1c 0c 17 00 01 5b 5d 41 5c c3 0f 1f 80 00 00 00 00 <4>[ 234.237631] ---[ end trace 7b6e6c28539f6d16 ]--- <7>[ 234.237803] [drm:sandybridge_pcode_read [i915]] warning: pcode (read from mbox 5) mailbox access failed for i915_drpc_info [i915]: -6 This test has a dmesg-warn on GLK QA
Tests List:
igt@drv_suspend@debugfs-reader-hibernate
igt@drv_suspend@debugfs-reader
IGT-Version: 1.21-g94bd67c (x86_64) (Linux: 4.15.0-drm-tip-ww6-commit-078873d+ x86_64)
======================================
dmesg-warn sample
======================================
. . .
[ 177.388077] (elapsed 0.037 seconds) done.
[ 177.389235] Suspending console(s) (use no_console_suspend to debug)
[ 178.296465] hpet_rtc_timer_reinit: 14 callbacks suppressed
[ 178.296466] hpet1: lost 7161 rtc interrupts
[ 179.254906] hpet1: lost 7161 rtc interrupts
[ 179.268253] sd 0:0:0:0: [sda] Synchronizing SCSI cache
[ 179.268930] sd 0:0:0:0: [sda] Stopping disk
[ 179.681697] IRQ 124: no longer affine to CPU1
[ 179.709678] IRQ fixup: irq 1 move in progress, old vector 33
[ 179.709774] IRQ 122: no longer affine to CPU2
[ 179.725495] IRQ 1: no longer affine to CPU3
[ 179.725513] IRQ 8: no longer affine to CPU3
[ 179.725523] IRQ 9: no longer affine to CPU3
[ 179.725540] IRQ 27: no longer affine to CPU3
[ 179.725562] IRQ 30: no longer affine to CPU3
[ 179.725583] IRQ 33: no longer affine to CPU3
[ 179.725593] IRQ 34: no longer affine to CPU3
[ 179.725604] IRQ 35: no longer affine to CPU3
[ 179.736129] cache: parent cpu1 should not be sleeping
[ 179.739679] cache: parent cpu2 should not be sleeping
[ 179.743416] cache: parent cpu3 should not be sleeping
[ 179.845790] ACPI: button: The lid device is not compliant to SW_LID.
[ 180.098407] sd 0:0:0:0: [sda] Starting disk
[ 180.655249] done.
[ 180.790665] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks
[ 180.846649] atkbd serio0: Failed to deactivate keyboard on isa0060/serio0
[ 180.940567] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks
[ 181.090451] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks
[ 181.226520] atkbd serio0: Failed to enable keyboard on isa0060/serio0
[ 181.240352] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks
[ 181.390203] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks
[ 181.539998] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks
[ 181.689871] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks
. . .
I suppose fixed already: "Thanks for the review and testing I pushed the patch to -dinq." Imre Deak <imre.deak@intel.com> 2018-02-08 13:23:31 commit 928f0cd0eb0511e19b416e34a030ebff6785fa52 fix integrated to CI_DRM_3749 no new occurrences I will archive the bug from cibuglog perspective, but since QA also has filed stuff on it I can't close. The following is still happening. Should I create a new bug? [ 234.237101] ------------[ cut here ]------------ [ 234.237138] Unclaimed read from register 0x130090 [ 234.237206] WARNING: CPU: 2 PID: 1936 at drivers/gpu/drm/i915/intel_uncore.c:986 __unclaimed_reg_debug+0x3b/0x50 [i915] [ 234.237208] Modules linked in: vgem snd_hda_codec_hdmi snd_hda_codec_realtek snd_hda_codec_generic i915 x86_pkg_temp_thermal intel_powerclamp coretemp crct10dif_pclmul crc32_pclmul ghash_clmulni_intel snd_hda_intel snd_hda_codec snd_hwdep snd_hda_core snd_pcm r8169 mii prime_numbers mei_me mei i2c_hid pinctrl_geminilake pinctrl_intel [ 234.237276] CPU: 2 PID: 1936 Comm: cat Tainted: G U 4.15.0-CI-CI_DRM_3736+ #1 [ 234.237279] Hardware name: Intel Corp. Geminilake/GLK RVP2 LP4SD (07), BIOS GELKRVPA.X64.0062.B30.1708222146 08/22/2017 [ 234.237315] RIP: 0010:__unclaimed_reg_debug+0x3b/0x50 [i915] [ 234.237320] RSP: 0018:ffffc90000ba3d38 EFLAGS: 00010092 [ 234.237327] RAX: 0000000000000025 RBX: 0000000000000000 RCX: 0000000000000002 [ 234.237330] RDX: 0000000080000002 RSI: ffffffff820abf17 RDI: 00000000ffffffff [ 234.237332] RBP: 0000000000130090 R08: 0000000000000000 R09: 0000000000000001 [ 234.237334] R10: ffffc90000ba3cd0 R11: 0000000000000002 R12: 0000000000000001 [ 234.237336] R13: ffff880167780ca0 R14: 0000000000000000 R15: 0000000000000202 [ 234.237339] FS: 00007fb4568b5700(0000) GS:ffff88017fd00000(0000) knlGS:0000000000000000 [ 234.237341] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 234.237344] CR2: 000055b3f5415100 CR3: 0000000172902000 CR4: 0000000000340ee0 [ 234.237348] Call Trace: [ 234.237391] fwtable_read32+0x214/0x290 [i915] [ 234.237429] i915_drpc_info+0x267/0x8c0 [i915] [ 234.237436] ? rcu_read_lock_sched_held+0x6f/0x80 [ 234.237444] seq_read+0xd8/0x3a0 [ 234.237452] full_proxy_read+0x4b/0x70 [ 234.237459] __vfs_read+0x1e/0x120 [ 234.237468] ? entry_SYSCALL_64_fastpath+0x5/0x8f [ 234.237472] vfs_read+0x9e/0x150 [ 234.237477] SyS_read+0x40/0xa0 [ 234.237483] entry_SYSCALL_64_fastpath+0x22/0x8f [ 234.237486] RIP: 0033:0x7fb4563e1890 [ 234.237488] RSP: 002b:00007fffec12b328 EFLAGS: 00000246 [ 234.237501] Code: 3c 01 75 30 84 db 75 2c 45 84 e4 48 c7 c0 aa 46 26 a0 48 c7 c6 a0 46 26 a0 48 0f 44 f0 89 ea 48 c7 c7 b3 46 26 a0 e8 15 b6 ed e0 <0f> ff 83 2d 1c 0c 17 00 01 5b 5d 41 5c c3 0f 1f 80 00 00 00 00 [ 234.237631] ---[ end trace 7b6e6c28539f6d16 ]--- [ 234.311753] Setting dangerous option reset - tainting kernel https://intel-gfx-ci.01.org/tree/drm-tip/IGT_4229/shard-glkb1/igt@gem_ctx_create@basic.html (In reply to Martin Peres from comment #21) > The following is still happening. Should I create a new bug? > > [ 234.237101] ------------[ cut here ]------------ > [ 234.237138] Unclaimed read from register 0x130090 > [ 234.237206] WARNING: CPU: 2 PID: 1936 at > drivers/gpu/drm/i915/intel_uncore.c:986 __unclaimed_reg_debug+0x3b/0x50 > [i915] > [ 234.237208] Modules linked in: vgem snd_hda_codec_hdmi > snd_hda_codec_realtek snd_hda_codec_generic i915 x86_pkg_temp_thermal > intel_powerclamp coretemp crct10dif_pclmul crc32_pclmul ghash_clmulni_intel > snd_hda_intel snd_hda_codec snd_hwdep snd_hda_core snd_pcm r8169 mii > prime_numbers mei_me mei i2c_hid pinctrl_geminilake pinctrl_intel > [ 234.237276] CPU: 2 PID: 1936 Comm: cat Tainted: G U > 4.15.0-CI-CI_DRM_3736+ #1 > [ 234.237279] Hardware name: Intel Corp. Geminilake/GLK RVP2 LP4SD (07), > BIOS GELKRVPA.X64.0062.B30.1708222146 08/22/2017 > [ 234.237315] RIP: 0010:__unclaimed_reg_debug+0x3b/0x50 [i915] > [ 234.237320] RSP: 0018:ffffc90000ba3d38 EFLAGS: 00010092 > [ 234.237327] RAX: 0000000000000025 RBX: 0000000000000000 RCX: > 0000000000000002 > [ 234.237330] RDX: 0000000080000002 RSI: ffffffff820abf17 RDI: > 00000000ffffffff > [ 234.237332] RBP: 0000000000130090 R08: 0000000000000000 R09: > 0000000000000001 > [ 234.237334] R10: ffffc90000ba3cd0 R11: 0000000000000002 R12: > 0000000000000001 > [ 234.237336] R13: ffff880167780ca0 R14: 0000000000000000 R15: > 0000000000000202 > [ 234.237339] FS: 00007fb4568b5700(0000) GS:ffff88017fd00000(0000) > knlGS:0000000000000000 > [ 234.237341] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 > [ 234.237344] CR2: 000055b3f5415100 CR3: 0000000172902000 CR4: > 0000000000340ee0 > [ 234.237348] Call Trace: > [ 234.237391] fwtable_read32+0x214/0x290 [i915] > [ 234.237429] i915_drpc_info+0x267/0x8c0 [i915] > [ 234.237436] ? rcu_read_lock_sched_held+0x6f/0x80 > [ 234.237444] seq_read+0xd8/0x3a0 > [ 234.237452] full_proxy_read+0x4b/0x70 > [ 234.237459] __vfs_read+0x1e/0x120 > [ 234.237468] ? entry_SYSCALL_64_fastpath+0x5/0x8f > [ 234.237472] vfs_read+0x9e/0x150 > [ 234.237477] SyS_read+0x40/0xa0 > [ 234.237483] entry_SYSCALL_64_fastpath+0x22/0x8f > [ 234.237486] RIP: 0033:0x7fb4563e1890 > [ 234.237488] RSP: 002b:00007fffec12b328 EFLAGS: 00000246 > [ 234.237501] Code: 3c 01 75 30 84 db 75 2c 45 84 e4 48 c7 c0 aa 46 26 a0 > 48 c7 c6 a0 46 26 a0 48 0f 44 f0 89 ea 48 c7 c7 b3 46 26 a0 e8 15 b6 ed e0 > <0f> ff 83 2d 1c 0c 17 00 01 5b 5d 41 5c c3 0f 1f 80 00 00 00 00 > [ 234.237631] ---[ end trace 7b6e6c28539f6d16 ]--- > [ 234.311753] Setting dangerous option reset - tainting kernel > > https://intel-gfx-ci.01.org/tree/drm-tip/IGT_4229/shard-glkb1/ > igt@gem_ctx_create@basic.html Martin,IGT_4229 is based on CI_DRM_3736 the fix was integrated to CI_DRM_3749 which is after your occurrence. There are 2 issues handled in this report: 1. [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks This is still unsolved I think. 2. Unclaimed read from register 0x130090 Fix for this already merged, per comment#19. (In reply to Imre Deak from comment #23) > There are 2 issues handled in this report: > > 1. [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any > CRC after 6 vblanks > > This is still unsolved I think. > > 2. Unclaimed read from register 0x130090 > > Fix for this already merged, per comment#19. Hm, actually there is also a third one: [drm:sandybridge_pcode_read [i915]] warning: pcode (read from mbox 5) mailbox access failed for i915_drpc_info [i915]: -6 for which there is a fix, but it's not merged yet. If QA want to reopen I am fine with that. However, for CI the only issues seen in a long time is the "Unclaimed read from register 0x130090" on GLK-shards. This issue appear to be fixed, therefore I have archived the bug from cibuglog perspective. The following test cases have dmesg-warn on CFL QA igt@drv_suspend@debugfs-reader igt@drv_suspend@debugfs-reader-hibernate IGT-Version: 1.21-ga2664f8 (x86_64) (Linux: 4.16.0-rc2-drm-intel-qa-ww9-commit-01a067a+ x86_64) [cmd] rtcwake: wakeup from "disk" using /dev/rtc0 at Sun Feb 25 06:09:08 2018 Subtest debugfs-reader-hibernate: SUCCESS (4.441s) [ 197.561673] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 197.695111] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 197.861730] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 198.045035] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 198.228417] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 198.411760] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 198.595041] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 198.922071] Suspending console(s) (use no_console_suspend to debug) [ 199.610452] cache: parent cpu1 should not be sleeping [ 199.611550] cache: parent cpu2 should not be sleeping [ 199.612653] cache: parent cpu3 should not be sleeping [ 199.613793] cache: parent cpu4 should not be sleeping [ 199.614976] cache: parent cpu5 should not be sleeping [ 199.616228] cache: parent cpu6 should not be sleeping [ 199.617477] cache: parent cpu7 should not be sleeping [ 199.618766] cache: parent cpu8 should not be sleeping [ 199.620095] cache: parent cpu9 should not be sleeping [ 199.621467] cache: parent cpu10 should not be sleeping [ 199.622932] cache: parent cpu11 should not be sleeping [ 199.672137] i2c_designware i2c_designware.0: Unknown Synopsys component type: 0xffffffff [ 199.672148] i2c_designware i2c_designware.1: Unknown Synopsys component type: 0xffffffff [ 199.705783] usb usb1: root hub lost power or was reset [ 199.705784] usb usb2: root hub lost power or was reset [ 199.938908] atkbd serio0: Failed to deactivate keyboard on isa0060/serio0 [ 200.310988] atkbd serio0: Failed to enable keyboard on isa0060/serio0 [ 200.937637] i2c_designware i2c_designware.0: timeout in disabling adapter [ 200.937659] i2c_designware i2c_designware.1: timeout in disabling adapter [ 201.140997] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 201.324108] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 201.507592] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 201.690756] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 201.840742] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 201.990994] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks Created attachment 137669 [details]
dmesg log
The following test cases have dmesg-warn on CFL QA igt@drv_suspend@debugfs-reader igt@drv_suspend@debugfs-reader-hibernat IGT-Version: 1.21-g68fb759 (x86_64) (Linux: 4.16.0-rc4-drm-intel-qa-ww10-commit-a994c52+ x86_64) [ 46.538739] (elapsed 0.152 seconds) done. [ 46.540187] Suspending console(s) (use no_console_suspend to debug) [ 47.054541] IRQ 142: no longer affine to CPU1 [ 47.078452] IRQ 144: no longer affine to CPU2 [ 47.078457] IRQ 146: no longer affine to CPU2 [ 47.102558] IRQ 134: no longer affine to CPU3 [ 47.102566] IRQ 141: no longer affine to CPU3 [ 47.126764] IRQ 136: no longer affine to CPU4 [ 47.126770] IRQ 138: no longer affine to CPU4 [ 47.150357] IRQ 140: no longer affine to CPU5 [ 47.178020] IRQ 124: no longer affine to CPU6 [ 47.178031] IRQ 139: no longer affine to CPU6 [ 47.301317] cache: parent cpu1 should not be sleeping [ 47.302405] cache: parent cpu2 should not be sleeping [ 47.303471] cache: parent cpu3 should not be sleeping [ 47.304564] cache: parent cpu4 should not be sleeping [ 47.305695] cache: parent cpu5 should not be sleeping [ 47.306930] cache: parent cpu6 should not be sleeping [ 47.308105] cache: parent cpu7 should not be sleeping [ 47.309330] cache: parent cpu8 should not be sleeping [ 47.310598] cache: parent cpu9 should not be sleeping [ 47.311930] cache: parent cpu10 should not be sleeping [ 47.313283] cache: parent cpu11 should not be sleeping [ 47.993649] atkbd serio0: Failed to deactivate keyboard on isa0060/serio0 [ 48.369679] atkbd serio0: Failed to enable keyboard on isa0060/serio0 [ 48.596880] done. [ 48.851449] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 49.034770] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 49.218033] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 49.401431] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 49.568111] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks [ 49.751431] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_3903/fi-cfl-u/igt@drv_suspend@debugfs-reader.html [ 330.361752] [drm:intel_dp_sink_crc [i915]] *ERROR* Panel is unable to calculate any CRC after 6 vblanks This was reopend due to CFL-u. However I just discovered this maybe new thing with the: <7>[ 39.903153] [drm:intel_dp_sink_crc_stop [i915]] TIMEOUT: Sink CRC counter is not zeroed after calculation is stopped ralated to this issue so I will close this again and use bug 105542 |
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.