[CI] igt@kms_frontbuffer_tracking@fbc-1p-* dmesg-warn - *ERROR* render: timed out waiting for forcewake ack request.
Submitted by Tomi Sarvela @tsa
Assigned to Intel GFX Bugs mailing list
Link to original bug (#107469)
Description
https://intel-gfx-ci.01.org/tree/drm-tip/IGT_4584/shard-snb4/igt@kms_frontbuffer_tracking@fbc-1p-offscren-pri-shrfb-draw-mmap-wc.html
[ 56.839338] Setting dangerous option enable_psr - tainting kernel
[ 56.839441] Setting dangerous option enable_fbc - tainting kernel
[ 57.746166] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 57.751320] ------------[ cut here ]------------
[ 57.751323] GT thread status wait timed out
[ 57.751409] WARNING: CPU: 5 PID: 264 at drivers/gpu/drm/i915/intel_uncore.c:303 __gen6_gt_wait_for_thread_c0+0x6e/0xa0 [i915]
[ 57.751413] Modules linked in: snd_hda_codec_hdmi snd_hda_codec_realtek snd_hda_codec_generic i915 x86_pkg_temp_thermal coretemp crct10dif_pclmul crc32_pclmul ghash_clmulni_intel snd_hda_intel snd_hda_codec snd_hwdep broadcom bcm_phy_lib snd_hda_core tg3 snd_pcm mei_me mei lpc_ich prime_numbers
[ 57.751486] CPU: 5 PID: 264 Comm: kworker/5:2 Tainted: G U 4.18.0-rc7-CI-CI_DRM_4605+ #1 (moved)
[ 57.751489] Hardware name: Dell Inc. XPS 8300 /0Y2MRG, BIOS A06 10/17/2011
[ 57.751551] Workqueue: events_long i915_hangcheck_elapsed [i915]
[ 57.751617] RIP: 0010:__gen6_gt_wait_for_thread_c0+0x6e/0xa0 [i915]
[ 57.751620] Code: 8b 92 5c 80 13 00 83 e2 07 75 d5 5b 5d c3 80 3d f9 fd 18 00 00 75 f4 48 c7 c7 28 53 2a a0 c6 05 e9 fd 18 00 01 e8 52 b5 ed e0 <0f> 0b eb dd 80 3d d8 fd 18 00 00 75 98 48 c7 c6 f8 52 2a a0 48 c7
[ 57.751809] RSP: 0018:ffffc900016f7d08 EFLAGS: 00010082
[ 57.751816] RAX: 0000000000000000 RBX: ffff8802104c0000 RCX: 0000000000000002
[ 57.751820] RDX: 0000000080000002 RSI: ffffffff820c701c RDI: 00000000ffffffff
[ 57.751824] RBP: 0000000d71f2e65c R08: 0000000000000000 R09: 0000000000000001
[ 57.751827] R10: ffffc900016f7ce8 R11: 0000000000000000 R12: ffff8802104c0eb0
[ 57.751831] R13: 0000000000000001 R14: 0000000000000000 R15: 0000000000000000
[ 57.751836] FS: 0000000000000000(0000) GS:ffff88022fb40000(0000) knlGS:0000000000000000
[ 57.751840] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 57.751844] CR2: 00007ff0abe99000 CR3: 0000000002210005 CR4: 00000000000606e0
[ 57.751847] Call Trace:
[ 57.751912] gen6_read32+0x188/0x290 [i915]
[ 57.751978] intel_engine_get_active_head+0xbe/0xd0 [i915]
[ 57.752041] i915_hangcheck_elapsed+0xdc/0x540 [i915]
[ 57.752057] ? lock_acquire+0xa6/0x210
[ 57.752074] process_one_work+0x248/0x6c0
[ 57.752089] worker_thread+0x37/0x380
[ 57.752098] ? process_one_work+0x6c0/0x6c0
[ 57.752103] kthread+0x119/0x130
[ 57.752109] ? kthread_flush_work_fn+0x10/0x10
[ 57.752119] ret_from_fork+0x3a/0x50
[ 57.752137] irq event stamp: 136048
[ 57.752143] hardirqs last enabled at (136047): [<ffffffff8193ff04>] _raw_spin_unlock_irq+0x24/0x50
[ 57.752149] hardirqs last disabled at (136048): [<ffffffff8193fd3d>] _raw_spin_lock_irqsave+0xd/0x50
[ 57.752154] softirqs last enabled at (132740): [<ffffffff81c0034f>] __do_softirq+0x34f/0x505
[ 57.752160] softirqs last disabled at (132733): [<ffffffff8108c835>] irq_exit+0xa5/0xc0
[ 57.752222] WARNING: CPU: 5 PID: 264 at drivers/gpu/drm/i915/intel_uncore.c:303 __gen6_gt_wait_for_thread_c0+0x6e/0xa0 [i915]
[ 57.752225] ---[ end trace b284483020a019c8 ]---
[ 57.802348] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 57.857503] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 57.912641] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 57.967777] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 58.022913] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 58.078049] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 58.133230] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 58.188372] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 58.243511] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 58.298656] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 58.353793] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 58.408940] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 58.464087] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 58.519228] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 58.574369] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 58.629509] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 58.684650] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 58.739789] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 58.794929] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 58.850169] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 58.905307] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 58.960444] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 60.754140] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 60.809503] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 60.864727] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 60.919875] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 60.975044] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 61.030224] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 61.085388] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 61.140586] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 61.195756] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 61.250927] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 61.306122] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 61.361293] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 61.416454] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 61.471624] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 61.526786] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 61.581954] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 61.637123] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 61.692293] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 61.747463] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 61.802632] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 61.857810] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 61.913048] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 61.968214] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 62.023386] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 62.078537] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 62.133681] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 62.188930] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 62.244089] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 62.299234] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 62.354382] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 62.409528] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 62.464677] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 62.519817] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 62.574966] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 62.630114] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 62.685259] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 62.740406] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 62.795551] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 62.850696] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 62.905936] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 62.961097] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 63.016238] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 63.071381] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 63.126524] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 63.181684] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 63.236830] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 63.291974] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 63.347120] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 63.402259] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 63.457408] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 63.512553] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 63.567700] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 63.622844] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 63.677992] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 63.733138] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 63.788282] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 63.843428] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 63.898597] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 63.953740] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 64.008880] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 64.064036] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 64.119181] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 64.174352] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 64.229496] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 64.238101] i915 0000:00:02.0: Resetting chip for hang on rcs0, bcs0, vcs0
[ 64.288224] [drm:fw_domains_get [i915]] ERROR render: timed out waiting for forcewake ack request.
[ 65.300123] [drm:stop_ring [i915]] ERROR rcs0 : timed out trying to stop ring
[ 65.300257] ------------[ cut here ]------------
[ 65.300261] WARN_ON((dev_priv->uncore.funcs.mmio_readl(dev_priv, (((const i915_reg_t){ .reg = (((engine)->mmio_base) + 0x9c) })), true) & (1 << 9)) == 0)
[ 65.300348] WARNING: CPU: 3 PID: 1390 at drivers/gpu/drm/i915/intel_ringbuffer.c:401 init_ring_common+0x8b4/0x990 [i915]
[ 65.300352] Modules linked in: snd_hda_codec_hdmi snd_hda_codec_realtek snd_hda_codec_generic i915 x86_pkg_temp_thermal coretemp crct10dif_pclmul crc32_pclmul ghash_clmulni_intel snd_hda_intel snd_hda_codec snd_hwdep broadcom bcm_phy_lib snd_hda_core tg3 snd_pcm mei_me mei lpc_ich prime_numbers
[ 65.300426] CPU: 3 PID: 1390 Comm: kms_frontbuffer Tainted: G U W 4.18.0-rc7-CI-CI_DRM_4605+ #1 (moved)
[ 65.300430] Hardware name: Dell Inc. XPS 8300 /0Y2MRG, BIOS A06 10/17/2011
[ 65.300493] RIP: 0010:init_ring_common+0x8b4/0x990 [i915]
[ 65.300496] Code: 0b 41 be 80 42 00 00 e9 30 fc ff ff 41 be 80 41 00 00 e9 25 fc ff ff 48 c7 c6 a8 4a 2a a0 48 c7 c7 35 62 28 a0 e8 3c 10 ee e0 <0f> 0b e9 a9 fc ff ff 48 c7 c1 57 62 28 a0 ba cc 00 00 00 48 c7 c6
[ 65.300686] RSP: 0018:ffffc90000353b60 EFLAGS: 00010282
[ 65.300693] RAX: 0000000000000000 RBX: ffff8802104c0000 RCX: 0000000000000001
[ 65.300697] RDX: 0000000080000001 RSI: ffffffff820c701c RDI: 00000000ffffffff
[ 65.300701] RBP: ffff880217b1c2a8 R08: 0000000018d51b99 R09: 0000000000000000
[ 65.300705] R10: 0000000000000000 R11: 0000000000000000 R12: ffff8802104c0000
[ 65.300708] R13: ffff88020ae417a8 R14: 00000000000020c0 R15: ffff880217b1a158
[ 65.300713] FS: 00007ff0b802b980(0000) GS:ffff88022fac0000(0000) knlGS:0000000000000000
[ 65.300717] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 65.300721] CR2: 00007fdc732f20f8 CR3: 000000021cd2e001 CR4: 00000000000606e0
[ 65.300724] Call Trace:
[ 65.300735] ? trace_hardirqs_on_caller+0xe0/0x1b0
[ 65.300801] init_render_ring+0xf/0x170 [i915]
[ 65.300862] i915_gem_init_hw+0x26e/0x300 [i915]
[ 65.300925] ? i915_request_wait+0x162/0x8a0 [i915]
[ 65.300971] i915_reset+0x23d/0x290 [i915]
[ 65.301032] __i915_wait_request_check_and_reset.isra.8+0x44/0x50 [i915]
[ 65.301090] i915_request_wait+0x4ee/0x8a0 [i915]
[ 65.301105] ? wake_up_q+0x70/0x70
[ 65.301113] ? wake_up_q+0x70/0x70
[ 65.301179] wait_for_timeline+0x131/0x2c0 [i915]
[ 65.301240] i915_gem_wait_for_idle.part.27+0x5a/0x1b0 [i915]
[ 65.301296] i915_drop_caches_set+0x1cb/0x1e0 [i915]
[ 65.301306] simple_attr_write+0xb0/0xd0
[ 65.301319] full_proxy_write+0x51/0x80
[ 65.301329] __vfs_write+0x31/0x180
[ 65.301339] ? rcu_read_lock_sched_held+0x6f/0x80
[ 65.301344] ? rcu_sync_lockdep_assert+0x29/0x50
[ 65.301350] ? __sb_start_write+0x152/0x1f0
[ 65.301355] ? __sb_start_write+0x168/0x1f0
[ 65.301364] vfs_write+0xbd/0x1a0
[ 65.301372] ksys_write+0x50/0xc0
[ 65.301383] do_syscall_64+0x55/0x190
[ 65.301391] entry_SYSCALL_64_after_hwframe+0x49/0xbe
[ 65.301396] RIP: 0033:0x7ff0b7297154
[ 65.301399] Code: 89 02 48 c7 c0 ff ff ff ff c3 66 2e 0f 1f 84 00 00 00 00 00 66 90 48 8d 05 b1 07 2e 00 8b 00 85 c0 75 13 b8 01 00 00 00 0f 05 <48> 3d 00 f0 ff ff 77 54 f3 c3 66 90 41 54 55 49 89 d4 53 48 89 f5
[ 65.301589] RSP: 002b:00007ffc7d3621d8 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
[ 65.301596] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007ff0b7297154
[ 65.301600] RDX: 0000000000000004 RSI: 000055c883f46c70 RDI: 0000000000000006
[ 65.301604] RBP: 000055c883f46c70 R08: 00007ff0b802b980 R09: 0000000000000000
[ 65.301608] R10: 0000000000000000 R11: 0000000000000246 R12: 000055c883f303f0
[ 65.301611] R13: 0000000000000004 R14: 00007ff0b756f2a0 R15: 00007ff0b756e760
[ 65.301630] irq event stamp: 222224
[ 65.301636] hardirqs last enabled at (222223): [<ffffffff810f8b9c>] console_unlock+0x3fc/0x600
[ 65.301642] hardirqs last disabled at (222224): [<ffffffff81a0111c>] error_entry+0x7c/0x100
[ 65.301647] softirqs last enabled at (206640): [<ffffffff81c0034f>] __do_softirq+0x34f/0x505
[ 65.301654] softirqs last disabled at (206631): [<ffffffff8108c835>] irq_exit+0xa5/0xc0
[ 65.301715] WARNING: CPU: 3 PID: 1390 at drivers/gpu/drm/i915/intel_ringbuffer.c:401 init_ring_common+0x8b4/0x990 [i915]
[ 65.301719] ---[ end trace b284483020a019c9 ]---
[ 65.352124] [drm:init_ring_common [i915]] ERROR rcs0 initialization failed ctl 00000000 (valid? 0) head 00000000 [0000c140] tail 00000000 [0000c140] start 00000000 [expected 00001000]
[ 65.352282] [drm:i915_gem_init_hw [i915]] ERROR Failed to restart rcs0 (-5)
[ 65.352371] [drm:i915_reset [i915]] ERROR Failed to initialise HW following reset (-5)