https://intel-gfx-ci.01.org/tree/drm-tip/drmtip_348/fi-icl-guc/igt@kms_cursor_legacy@cursora-vs-flipa-atomic-transitions-varying-size.html <0> [311.947734] watchdog: BUG: soft lockup - CPU#5 stuck for 105s! [dmesg:1072] <4> [200.099667] Modules linked in: vgem snd_hda_codec_hdmi snd_hda_codec_realtek snd_hda_codec_generic mei_hdcp i915 x86_pkg_temp_thermal coretemp ax88179_178a usbnet mii snd_hda_intel crct10dif_pclmul snd_intel_nhlt snd_hda_codec crc32_pclmul e1000e snd_hwdep snd_hda_core ghash_clmulni_intel snd_pcm ptp pps_core mei_me mei prime_numbers <4> [200.099686] irq event stamp: 42467984 <4> [200.099693] hardirqs last enabled at (42467983): [<ffffffff9b1522e2>] ktime_get_coarse_real_ts64+0x92/0xa0 <4> [200.099697] hardirqs last disabled at (42467984): [<ffffffff9b001a8a>] trace_hardirqs_off_thunk+0x1a/0x20 <4> [200.099702] softirqs last enabled at (42467570): [<ffffffff9bc0033e>] __do_softirq+0x33e/0x4ae <4> [200.099706] softirqs last disabled at (42467563): [<ffffffff9b0bbf79>] irq_exit+0xa9/0xc0 <4> [200.099709] CPU: 5 PID: 1072 Comm: dmesg Tainted: G U 5.3.0-rc5-g0db9333be821-drmtip_348+ #1 <4> [200.099712] Hardware name: Intel Corporation Ice Lake Client Platform/IceLake U DDR4 SODIMM PD RVP, BIOS ICLSFWR1.R00.3175.A00.1904261428 04/26/2019 <4> [200.099715] RIP: 0010:ktime_get_coarse_real_ts64+0x94/0xa0 <4> [200.099718] Code: 8b 05 c8 ba 0f 01 48 d3 e8 48 8b 0d 0e bb 0f 01 49 89 45 08 49 89 4d 00 39 13 75 8e 5b 5d 41 5c 41 5d c3 e8 fe e0 04 00 55 9d <8b> 13 f6 c2 01 74 c8 f3 90 eb bd 90 41 57 41 56 41 55 41 54 55 53 <4> [200.099721] RSP: 0018:ffffa57a40dd7ce8 EFLAGS: 00000246 ORIG_RAX: ffffffffffffff13 <4> [200.099727] RAX: ffff9989a7a5c040 RBX: ffffffff9c24dd40 RCX: 0000000000000005 <4> [200.099731] RDX: 00000000000012ca RSI: ffff9989a7a5c918 RDI: ffffffff9c1008a9 <4> [200.099734] RBP: 0000000000000246 R08: ffff9989a7a5c918 R09: 0000000000000000 <4> [200.099736] R10: 0000000000000000 R11: 0000000000000000 R12: ffffffff9c24dd48 <4> [200.099738] R13: ffffa57a40dd7d10 R14: ffff9989b7af83c0 R15: 0000000000000000 <4> [200.099741] FS: 00007f12dba1e240(0000) GS:ffff9989cfe80000(0000) knlGS:0000000000000000 <4> [200.099743] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 <4> [200.099745] CR2: 00007f8f983278e0 CR3: 0000000884ea2002 CR4: 0000000000760ee0 <4> [200.099757] PKRU: 55555554 <4> [200.099759] Call Trace: <4> [200.099779] current_time+0x26/0x80 <4> [200.099785] file_update_time+0x5b/0x120 <4> [200.099793] __generic_file_write_iter+0x94/0x190 <4> [200.099800] ext4_file_write_iter+0x153/0x3a0 <4> [200.099808] new_sync_write+0x10d/0x1b0 <4> [200.099817] vfs_write+0xbd/0x1d0 <4> [200.099821] ksys_write+0x8f/0xe0 <4> [200.099827] do_syscall_64+0x55/0x1c0 <4> [200.099830] entry_SYSCALL_64_after_hwframe+0x49/0xbe <4> [200.099833] RIP: 0033:0x7f12daeff154 <4> [200.099836] 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 <4> [200.099837] RSP: 002b:00007ffcb88d3258 EFLAGS: 00000246 ORIG_RAX: 0000000000000001 <4> [200.099840] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007f12daeff154 <4> [200.099842] RDX: 0000000000000001 RSI: 00005589e6f6f0f5 RDI: 0000000000000001 <4> [200.099844] RBP: 00005589e6f6f0f5 R08: 0000000000000001 R09: 0000000000000000 <4> [200.099846] R10: 0000000000000005 R11: 0000000000000246 R12: 00007f12db1db760 <4> [200.099848] R13: 0000000000000001 R14: 00007f12db1d6760 R15: 0000000000000001 <7> [200.118377] [drm:skl_compute_wm [i915]] [PLANE:73:plane 7A] ddb ( 0 - 979) -> ( 0 - 0), size 979 -> 0 <7> [200.118403] [drm:skl_compute_wm [i915]] [PLANE:73:plane 7A] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm <7> [200.118425] [drm:skl_compute_wm [i915]] [PLANE:73:plane 7A] lines 1, 4, 4, 4, 5, 8, 13, 13, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [200.118446] [drm:skl_compute_wm [i915]] [PLANE:73:plane 7A] blocks 27, 125, 125, 125, 156, 249, 404, 404, 41 -> 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [200.118467] [drm:skl_compute_wm [i915]] [PLANE:73:plane 7A] min_ddb 31, 139, 139, 139, 173, 275, 446, 446, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [200.118516] [drm:intel_bw_atomic_check [i915]] pipe A data rate 0 num active planes 0 <6> [200.129024] [IGT] kms_cursor_legacy: exiting, ret=0 <5> [200.129284] Setting dangerous option reset - tainting kernel <4> [311.947352] clocksource: timekeeping watchdog on CPU2: Marking clocksource 'tsc' as unstable because the skew is too large: <4> [311.947367] clocksource: 'hpet' wd_now: 61e96c7d wd_last: e19272ca mask: ffffffff <4> [311.947369] clocksource: 'tsc' cs_now: 74fff6db75 cs_last: 4de577147a mask: ffffffffffffffff <7> [311.947466] [drm:edp_panel_vdd_off_sync [i915]] Turning eDP port A VDD off <7> [311.947671] [drm:edp_panel_vdd_off_sync [i915]] PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067 <7> [311.947716] [drm:intel_power_well_disable [i915]] disabling DC off <6> [311.947718] tsc: Marking TSC unstable due to clocksource watchdog <7> [311.947764] [drm:skl_enable_dc6 [i915]] Enabling DC6 <7> [311.947806] [drm:gen9_set_dc_state [i915]] Setting DC state from 00 to 02 <4> [311.947807] TSC found unstable after boot, most likely due to broken BIOS. Use 'tsc=unstable'. <6> [311.947813] sched_clock: Marking unstable (311941815763, 5965370)<-(312040333318, -92551794) <6> [311.948757] clocksource: Switched to clocksource hpet <7> [311.960637] [drm:skl_compute_wm [i915]] [PLANE:31:plane 1A] ddb ( 0 - 0) -> ( 0 - 979), size 0 -> 979 <7> [311.960661] [drm:skl_compute_wm [i915]] [PLANE:31:plane 1A] level wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm -> *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm <7> [311.960689] [drm:skl_compute_wm [i915]] [PLANE:31:plane 1A] lines 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 1, 4, 4, 4, 5, 8, 13, 13, 0 <7> [311.960710] [drm:skl_compute_wm [i915]] [PLANE:31:plane 1A] blocks 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 27, 125, 125, 125, 156, 249, 404, 404, 41 <7> [311.960731] [drm:skl_compute_wm [i915]] [PLANE:31:plane 1A] min_ddb 0, 0, 0, 0, 0, 0, 0, 0, 0 -> 31, 139, 139, 139, 173, 275, 446, 446, 0 <7> [311.960752] [drm:skl_compute_wm [i915]] [PLANE:80:cursor A] level *wm0,*wm1,*wm2,*wm3,*wm4,*wm5,*wm6,*wm7,*twm -> wm0, wm1, wm2, wm3, wm4, wm5, wm6, wm7, twm <7> [311.960773] [drm:skl_compute_wm [i915]] [PLANE:80:cursor A] lines 13, 4, 4, 4, 5, 8, 13, 13, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [311.960794] [drm:skl_compute_wm [i915]] [PLANE:80:cursor A] blocks 27, 9, 9, 9, 11, 17, 27, 27, 41 -> 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [311.960814] [drm:skl_compute_wm [i915]] [PLANE:80:cursor A] min_ddb 31, 11, 11, 11, 14, 20, 31, 31, 0 -> 0, 0, 0, 0, 0, 0, 0, 0, 0 <7> [311.960861] [drm:intel_bw_atomic_check [i915]] pipe A data rate 2133000 num active planes 1 <6> [311.980904] Console: switching to colour frame buffer device 480x135
The CI Bug Log issue associated to this bug has been updated. ### New filters associated * ICL: igt@kms_cursor_legacy@cursora-vs-flipa-atomic-transitions-varying-size - dmesg-warn - watchdog: BUG: soft lockup - CPU#5 stuck for 105s! [dmesg:1072] - https://intel-gfx-ci.01.org/tree/drm-tip/drmtip_348/fi-icl-guc/igt@kms_cursor_legacy@cursora-vs-flipa-atomic-transitions-varying-size.html
https://bugzilla.kernel.org/show_bug.cgi?id=203183 That's for Coffelake and pc10, but might be relevant.
kms_cursor_legacy tests cursor behaviour in various cases such as flips before and after cursor, two screen flips, modesets with blocking and non-blocking, atomic and legacy scenarios and stress tests to mention a few. The problem with the failing subtest occurs when we update cursor while doing atomic display commits in non-blocking fashion. The failure can cause lockups on screen as in this bug report or failure to update screen or cursor or both. From user perspective, it is a bad user experience if screen freezes for a long time. Therefore, one could estimate the bug severity as high. #assessment
Also seen once, on drmtip_348 (1 month old). Resolving.
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.