[DC] [CRTC:44:crtc-0] vblank wait timed out

[Michel Dänzer]

I sometimes get the attached dmesg splat when the GDM login screen times
out and fades to black (presumably specifically when it finally sets
DPMS off, which disables the vblank interrupt).

I've seen this for the first time today, so it might have been
introduced by one of the DC changes which landed in amd-staging-drm-next
since yesterday. But since it doesn't happen every time, I can't be sure
of that yet.


-- 
Earthling Michel Dänzer               |               http://www.amd.com
Libre software enthusiast             |             Mesa and X developer
-------------- next part --------------
[  327.895512] [CRTC:44:crtc-0] vblank wait timed out
[  327.895562] ------------[ cut here ]------------
[  327.895586] WARNING: CPU: 14 PID: 237 at drivers/gpu/drm//drm_atomic_helper.c:1240 drm_atomic_helper_wait_for_vblanks.part.17+0x7a8/0x900 [drm_kms_helper]
[  327.895589] Modules linked in: lz4 lz4_compress cpufreq_powersave cpufreq_userspace cpufreq_conservative binfmt_misc nls_ascii nls_cp437 vfat fat edac_mce_amd amdgpu(O) amdkfd(O) radeon(O) chash wmi_bmof ppdev kvm irqbypass crct10dif_pclmul crc32_pclmul snd_hda_codec_realtek ghash_clmulni_intel pcbc snd_hda_codec_generic ttm(O) efi_pstore snd_hda_codec_hdmi drm_kms_helper(O) snd_hda_intel snd_hda_codec drm(O) snd_hda_core snd_hwdep snd_pcm aesni_intel i2c_algo_bit aes_x86_64 snd_timer fb_sys_fops crypto_simd glue_helper syscopyarea r8169 sysfillrect cryptd efivars pcspkr sysimgblt ccp mfd_core sp5100_tco snd mii parport_pc sg rng_core soundcore i2c_piix4 parport wmi i2c_designware_platform i2c_designware_core button acpi_cpufreq tcp_bbr sch_fq nct6775 hwmon_vid sunrpc efivarfs ip_tables x_tables
[  327.895774]  autofs4 ext4 crc16 mbcache jbd2 fscrypto dm_mod raid10 raid1 raid0 multipath linear md_mod sd_mod evdev hid_generic usbhid hid xhci_pci ahci libahci xhci_hcd libata crc32c_intel usbcore scsi_mod shpchp gpio_amdpt gpio_generic
[  327.895852] CPU: 14 PID: 237 Comm: kworker/u32:7 Tainted: G        W  O    4.14.0-rc3+ #40
[  327.895856] Hardware name: Micro-Star International Co., Ltd. MS-7A34/B350 TOMAHAWK (MS-7A34), BIOS 1.80 09/13/2017
[  327.895876] Workqueue: events_unbound commit_work [drm_kms_helper]
[  327.895883] task: ffff88039deb18c0 task.stack: ffff88039def8000
[  327.895902] RIP: 0010:drm_atomic_helper_wait_for_vblanks.part.17+0x7a8/0x900 [drm_kms_helper]
[  327.895905] RSP: 0018:ffff88039deff248 EFLAGS: 00010286
[  327.895913] RAX: 0000000000000026 RBX: 0000000000000000 RCX: 1ffff10073bdfe20
[  327.895916] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffff8803ae3961d8
[  327.895920] RBP: ffff8803a937a600 R08: 1ffff10073bdfddb R09: 0000000000000000
[  327.895924] R10: 0000000000000002 R11: ffffffff99091440 R12: ffff88038ae64400
[  327.895927] R13: 0000000000004b1b R14: dffffc0000000000 R15: 0000000000000000
[  327.895932] FS:  0000000000000000(0000) GS:ffff8803ae380000(0000) knlGS:0000000000000000
[  327.895936] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  327.895940] CR2: 00007f377e423000 CR3: 00000003a79a8000 CR4: 00000000003406e0
[  327.895943] Call Trace:
[  327.895979]  ? drm_atomic_helper_commit_modeset_disables+0x1130/0x1130 [drm_kms_helper]
[  327.895989]  ? finish_wait+0x380/0x380
[  327.896010]  ? drm_atomic_helper_commit_hw_done+0x1d1/0x390 [drm_kms_helper]
[  327.896159]  amdgpu_dm_atomic_commit_tail+0x1b81/0x4550 [amdgpu]
[  327.896326]  ? dm_crtc_duplicate_state+0x130/0x130 [amdgpu]
[  327.896332]  ? process_one_work+0x9da/0x1b00
[  327.896342]  ? find_held_lock+0x32/0x1c0
[  327.896349]  ? lock_release+0x7e0/0x7e0
[  327.896374]  ? drm_atomic_helper_wait_for_dependencies+0x406/0x830 [drm_kms_helper]
[  327.896402]  commit_tail+0x93/0xe0 [drm_kms_helper]
[  327.896410]  process_one_work+0xabc/0x1b00
[  327.896419]  ? do_raw_spin_trylock+0x190/0x190
[  327.896434]  ? work_on_cpu_safe+0x50/0x50
[  327.896441]  ? _raw_spin_unlock_irq+0x24/0x40
[  327.896447]  ? finish_task_switch+0x1e0/0x710
[  327.896452]  ? finish_task_switch+0x1b7/0x710
[  327.896457]  ? wq_worker_waking_up+0xc0/0xc0
[  327.896467]  ? preempt_notifier_dec+0x20/0x20
[  327.896485]  ? __schedule+0x964/0x20a0
[  327.896499]  ? firmware_map_remove+0x70/0x70
[  327.896507]  ? lock_downgrade+0x6b0/0x6b0
[  327.896526]  ? lockdep_rcu_suspicious+0x150/0x150
[  327.896541]  ? find_held_lock+0x32/0x1c0
[  327.896554]  ? lock_acquire+0x19d/0x400
[  327.896558]  ? worker_thread+0x434/0x1720
[  327.896570]  ? lock_release+0x7e0/0x7e0
[  327.896578]  ? try_to_del_timer_sync+0xbf/0x120
[  327.896584]  ? del_timer+0x120/0x120
[  327.896606]  worker_thread+0x216/0x1720
[  327.896631]  ? process_one_work+0x1b00/0x1b00
[  327.896635]  ? find_held_lock+0x32/0x1c0
[  327.896645]  ? do_raw_spin_trylock+0x190/0x190
[  327.896661]  ? _raw_spin_unlock_irq+0x24/0x40
[  327.896667]  ? finish_task_switch+0x1e0/0x710
[  327.896672]  ? finish_task_switch+0x1b7/0x710
[  327.896683]  ? preempt_notifier_dec+0x20/0x20
[  327.896701]  ? __schedule+0x964/0x20a0
[  327.896707]  ? depot_save_stack+0x12d/0x470
[  327.896720]  ? firmware_map_remove+0x70/0x70
[  327.896725]  ? graph_lock+0xd0/0xd0
[  327.896734]  ? kthread+0x99/0x400
[  327.896738]  ? ret_from_fork+0x25/0x30
[  327.896750]  ? lockdep_rcu_suspicious+0x150/0x150
[  327.896780]  ? schedule+0xf3/0x3b0
[  327.896785]  ? lock_downgrade+0x6b0/0x6b0
[  327.896791]  ? __schedule+0x20a0/0x20a0
[  327.896798]  ? do_wait_intr+0x340/0x340
[  327.896806]  ? __lockdep_init_map+0xdf/0x590
[  327.896816]  ? do_raw_spin_trylock+0x190/0x190
[  327.896833]  ? process_one_work+0x1b00/0x1b00
[  327.896839]  kthread+0x335/0x400
[  327.896845]  ? kthread_create_on_node+0xc0/0xc0
[  327.896853]  ret_from_fork+0x25/0x30
[  327.896871] Code: 54 24 20 48 89 f8 48 c1 e8 03 42 0f b6 04 30 84 c0 74 04 3c 03 7e 31 41 8b b4 24 c8 00 00 00 48 c7 c7 00 1f 77 c1 e8 e0 0d 95 d5 <0f> ff e9 fa fb ff ff e8 9c bb db d5 eb bd 48 8b 7c 24 48 e8 90 
[  327.897012] ---[ end trace dafcd9b5c7bdfeda ]---