igt@kms_psr - fail - RPM raw-wakeref not held, WARNING: CPU: 0 PID: 0 at ./drivers/gpu/drm/i915/intel_runtime_pm.h:107 fwtable_write
https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_8397/fi-kbl-guc/dmesg0.txt
<7>[ 383.591023] [IGT] kms_psr: executing
<7>[ 383.594294] [IGT] kms_psr: exiting, ret=77
<5>[ 383.594462] Setting dangerous option reset - tainting kernel
<6>[ 383.594902] Console: switching to colour frame buffer device 128x48
<6>[ 383.623444] Console: switching to colour dummy device 80x25
<7>[ 383.623483] [IGT] kms_psr: executing
<7>[ 383.625177] [IGT] kms_psr: exiting, ret=77
<5>[ 383.625469] Setting dangerous option reset - tainting kernel
<6>[ 383.626205] Console: switching to colour frame buffer device 128x48
<6>[ 383.654583] Console: switching to colour dummy device 80x25
<7>[ 383.654621] [IGT] kms_psr: executing
<7>[ 383.656769] [IGT] kms_psr: exiting, ret=77
<5>[ 383.656937] Setting dangerous option reset - tainting kernel
<6>[ 383.657659] Console: switching to colour frame buffer device 128x48
<6>[ 383.687202] Console: switching to colour dummy device 80x25
<7>[ 383.687255] [IGT] kms_psr: executing
<7>[ 383.688877] [IGT] kms_psr: exiting, ret=77
<5>[ 383.689159] Setting dangerous option reset - tainting kernel
<6>[ 383.689796] Console: switching to colour frame buffer device 128x48
<4>[ 383.699560] ------------[ cut here ]------------
<4>[ 383.699593] RPM raw-wakeref not held
<4>[ 383.699646] WARNING: CPU: 0 PID: 0 at ./drivers/gpu/drm/i915/intel_runtime_pm.h:107 fwtable_write32+0x15f/0x260 [i915]
<4>[ 383.699647] Modules linked in: vgem snd_hda_codec_hdmi snd_hda_codec_realtek snd_hda_codec_generic i915 x86_pkg_temp_thermal coretemp mei_hdcp crct10dif_pclmul crc32_pclmul snd_hda_intel snd_intel_dspcfg ghash_clmulni_intel snd_hda_codec snd_hwdep snd_hda_core e1000e snd_pcm mei_me ptp pps_core mei prime_numbers
<4>[ 383.699657] CPU: 0 PID: 0 Comm: swapper/0 Tainted: G U 5.7.0-rc2-CI-CI_DRM_8397+ #1
<4>[ 383.699658] Hardware name: System manufacturer System Product Name/Z170M-PLUS, BIOS 3610 03/29/2018
<4>[ 383.699682] RIP: 0010:fwtable_write32+0x15f/0x260 [i915]
<4>[ 383.699683] Code: 6c f1 e0 0f 0b e9 f7 fe ff ff 80 3d 9e d9 2d 00 00 0f 85 f3 fe ff ff 48 c7 c7 01 bf 3c a0 c6 05 8a d9 2d 00 01 e8 d1 6c f1 e0 <0f> 0b e9 d9 fe ff ff 80 3d 76 d9 2d 00 00 0f 85 d7 fe ff ff 48 c7
<4>[ 383.699685] RSP: 0018:ffffc90000003e90 EFLAGS: 00010082
<4>[ 383.699686] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 0000000000010003
<4>[ 383.699687] RDX: 0000000080010003 RSI: 0000000000000000 RDI: 00000000ffffffff
<4>[ 383.699688] RBP: 000000007fffffdf R08: 0000000000000000 R09: 0000000000000001
<4>[ 383.699689] R10: 0000000021020a32 R11: 00000000fedc1828 R12: 0000000000044324
<4>[ 383.699690] R13: ffff88820d250ee8 R14: ffff88820e3ff780 R15: 0000000000000000
<4>[ 383.699691] FS: 0000000000000000(0000) GS:ffff88822ea00000(0000) knlGS:0000000000000000
<4>[ 383.699693] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
<4>[ 383.699694] CR2: 0000556cc3db9098 CR3: 0000000005610006 CR4: 00000000003606f0
<4>[ 383.699695] Call Trace:
<4>[ 383.699696] <IRQ>
<4>[ 383.699726] gen6_rps_irq_handler+0x8e/0x100 [i915]
<4>[ 383.699752] gen8_gt_irq_handler+0xd2/0x100 [i915]
<4>[ 383.699773] gen8_irq_handler+0x4c/0x90 [i915]
<4>[ 383.699777] __handle_irq_event_percpu+0x41/0x2e0
<4>[ 383.699780] handle_irq_event_percpu+0x2b/0x70
<4>[ 383.699782] handle_irq_event+0x2f/0x50
<4>[ 383.699784] handle_edge_irq+0x99/0x1b0
<4>[ 383.699787] do_IRQ+0x7e/0x160
<4>[ 383.699789] common_interrupt+0xf/0xf
<4>[ 383.699790] </IRQ>
<4>[ 383.699793] RIP: 0010:cpuidle_enter_state+0xb6/0x420
<4>[ 383.699794] Code: 00 31 ff e8 5c ee 89 ff 80 7c 24 0b 00 74 12 9c 58 f6 c4 02 0f 85 37 03 00 00 31 ff e8 d3 12 91 ff e8 ae 3f 95 ff fb 45 85 ed <0f> 88 cd 02 00 00 49 63 c5 4c 2b 24 24 48 8d 14 40 48 8d 14 90 48
<4>[ 383.699795] RSP: 0018:ffffffff82603e50 EFLAGS: 00000202 ORIG_RAX: ffffffffffffffd8
<4>[ 383.699797] RAX: 0000000080000001 RBX: ffffe8ffffa175b0 RCX: 0000000000000000
<4>[ 383.699798] RDX: ffffffff826178c0 RSI: 0000000000000006 RDI: ffffffff82386ea2
<4>[ 383.699799] RBP: ffffffff826b4340 R08: 0000000000000002 R09: 0000000000000000
<4>[ 383.699800] R10: 0000000000000000 R11: 0000000000000000 R12: 0000005956461feb
<4>[ 383.699801] R13: 0000000000000004 R14: 0000000000000004 R15: 0000000000000004
<4>[ 383.699808] cpuidle_enter+0x24/0x40
<4>[ 383.699811] do_idle+0x1f7/0x260
<4>[ 383.699814] cpu_startup_entry+0x14/0x20
<4>[ 383.699817] start_kernel+0x4bd/0x4df
<4>[ 383.699821] secondary_startup_64+0xa4/0xb0
<4>[ 383.699826] irq event stamp: 4674796
<4>[ 383.699828] hardirqs last enabled at (4674793): [<ffffffff81854d92>] cpuidle_enter_state+0xb2/0x420
<4>[ 383.699830] hardirqs last disabled at (4674794): [<ffffffff81001d50>] trace_hardirqs_off_thunk+0x1a/0x1c
<4>[ 383.699832] softirqs last enabled at (4674796): [<ffffffff810bbb8f>] irq_enter+0x6f/0x80
<4>[ 383.699833] softirqs last disabled at (4674795): [<ffffffff810bbb74>] irq_enter+0x54/0x80
<4>[ 383.699834] ---[ end trace 6b7a4c936c9e8e1f ]---
<4>[ 383.699835] ------------[ cut here ]------------
<4>[ 383.699836] RPM wakelock ref not held during HW access
<4>[ 383.699867] WARNING: CPU: 0 PID: 0 at ./drivers/gpu/drm/i915/intel_runtime_pm.h:115 fwtable_write32+0x186/0x260 [i915]
<4>[ 383.699868] Modules linked in: vgem snd_hda_codec_hdmi snd_hda_codec_realtek snd_hda_codec_generic i915 x86_pkg_temp_thermal coretemp mei_hdcp crct10dif_pclmul crc32_pclmul snd_hda_intel snd_intel_dspcfg ghash_clmulni_intel snd_hda_codec snd_hwdep snd_hda_core e1000e snd_pcm mei_me ptp pps_core mei prime_numbers
<4>[ 383.699875] CPU: 0 PID: 0 Comm: swapper/0 Tainted: G U W 5.7.0-rc2-CI-CI_DRM_8397+ #1
<4>[ 383.699876] Hardware name: System manufacturer System Product Name/Z170M-PLUS, BIOS 3610 03/29/2018
<4>[ 383.699898] RIP: 0010:fwtable_write32+0x186/0x260 [i915]
<4>[ 383.699899] Code: 6c f1 e0 0f 0b e9 d9 fe ff ff 80 3d 76 d9 2d 00 00 0f 85 d7 fe ff ff 48 c7 c7 80 34 38 a0 c6 05 62 d9 2d 00 01 e8 aa 6c f1 e0 <0f> 0b e9 bd fe ff ff 8b 0d c1 04 5d e2 85 c9 75 6a 49 8b bd 48 01
<4>[ 383.699900] RSP: 0018:ffffc90000003e90 EFLAGS: 00010082
<4>[ 383.699901] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 0000000000010003
<4>[ 383.699903] RDX: 0000000080010003 RSI: 0000000000000000 RDI: 00000000ffffffff
<4>[ 383.699904] RBP: 000000007fffffdf R08: 0000000000000000 R09: 0000000000000001
<4>[ 383.699905] R10: 0000000021020a32 R11: 00000000fedc1828 R12: 0000000000044324
<4>[ 383.699906] R13: ffff88820d250ee8 R14: ffff88820e3ff780 R15: 0000000000000000
<4>[ 383.699907] FS: 0000000000000000(0000) GS:ffff88822ea00000(0000) knlGS:0000000000000000
<4>[ 383.699908] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
<4>[ 383.699909] CR2: 0000556cc3db9098 CR3: 0000000005610006 CR4: 00000000003606f0
<4>[ 383.699910] Call Trace:
<4>[ 383.699911] <IRQ>
<4>[ 383.699939] gen6_rps_irq_handler+0x8e/0x100 [i915]
<4>[ 383.699965] gen8_gt_irq_handler+0xd2/0x100 [i915]
<4>[ 383.699990] gen8_irq_handler+0x4c/0x90 [i915]
<4>[ 383.699993] __handle_irq_event_percpu+0x41/0x2e0
<4>[ 383.699996] handle_irq_event_percpu+0x2b/0x70
<4>[ 383.699998] handle_irq_event+0x2f/0x50
<4>[ 383.700000] handle_edge_irq+0x99/0x1b0
<4>[ 383.700002] do_IRQ+0x7e/0x160
<4>[ 383.700004] common_interrupt+0xf/0xf
<4>[ 383.700006] </IRQ>
<4>[ 383.700007] RIP: 0010:cpuidle_enter_state+0xb6/0x420
<4>[ 383.700009] Code: 00 31 ff e8 5c ee 89 ff 80 7c 24 0b 00 74 12 9c 58 f6 c4 02 0f 85 37 03 00 00 31 ff e8 d3 12 91 ff e8 ae 3f 95 ff fb 45 85 ed <0f> 88 cd 02 00 00 49 63 c5 4c 2b 24 24 48 8d 14 40 48 8d 14 90 48
<4>[ 383.700010] RSP: 0018:ffffffff82603e50 EFLAGS: 00000202 ORIG_RAX: ffffffffffffffd8
<4>[ 383.700011] RAX: 0000000080000001 RBX: ffffe8ffffa175b0 RCX: 0000000000000000
<4>[ 383.700012] RDX: ffffffff826178c0 RSI: 0000000000000006 RDI: ffffffff82386ea2
<4>[ 383.700013] RBP: ffffffff826b4340 R08: 0000000000000002 R09: 0000000000000000
<4>[ 383.700014] R10: 0000000000000000 R11: 0000000000000000 R12: 0000005956461feb
<4>[ 383.700015] R13: 0000000000000004 R14: 0000000000000004 R15: 0000000000000004
<4>[ 383.700022] cpuidle_enter+0x24/0x40
<4>[ 383.700025] do_idle+0x1f7/0x260
<4>[ 383.700028] cpu_startup_entry+0x14/0x20
<4>[ 383.700030] start_kernel+0x4bd/0x4df
<4>[ 383.700033] secondary_startup_64+0xa4/0xb0
<4>[ 383.700039] irq event stamp: 4674796
<4>[ 383.700040] hardirqs last enabled at (4674793): [<ffffffff81854d92>] cpuidle_enter_state+0xb2/0x420
<4>[ 383.700041] hardirqs last disabled at (4674794): [<ffffffff81001d50>] trace_hardirqs_off_thunk+0x1a/0x1c
<4>[ 383.700043] softirqs last enabled at (4674796): [<ffffffff810bbb8f>] irq_enter+0x6f/0x80
<4>[ 383.700045] softirqs last disabled at (4674795): [<ffffffff810bbb74>] irq_enter+0x54/0x80
<4>[ 383.700045] ---[ end trace 6b7a4c936c9e8e20 ]---