Bug 106426

Summary:	[CI][ELK] RIP: 0010:drm_wait_one_vblank+0x175/0x180 on igt@kms_pipe_crc_basic@nonblocking-crc-pipe-b
Product:	DRI	Reporter:	Tomi Sarvela <tomi.p.sarvela>
Component:	DRM/Intel	Assignee:	Intel GFX Bugs mailing list <intel-gfx-bugs>
Status:	CLOSED WORKSFORME	QA Contact:	Intel GFX Bugs mailing list <intel-gfx-bugs>
Severity:	normal
Priority:	medium	CC:	intel-gfx-bugs
Version:	unspecified
Hardware:	x86-64 (AMD64)
OS:	Linux (All)
Whiteboard:
i915 platform:		i915 features:

Description Tomi Sarvela 2018-05-07 10:17:54 UTC

Recent DRM-Tip got dmesg splat on igt@kms_pipe_crc_basic@nonblocking-crc-pipe-b:

https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_4141/fi-elk-e7500/igt@kms_pipe_crc_basic@nonblocking-crc-pipe-b.html

[  356.079084] ------------[ cut here ]------------
[  356.079087] vblank wait timed out on crtc 1
[  356.079111] WARNING: CPU: 0 PID: 3537 at drivers/gpu/drm/drm_vblank.c:1084 drm_wait_one_vblank+0x175/0x180
[  356.079112] Modules linked in: vgem i915 snd_hda_codec_realtek coretemp snd_hda_codec_generic snd_hda_intel snd_hda_codec snd_hwdep snd_hda_core snd_pcm lpc_ich mei_me e1000e mei prime_numbers
[  356.079136] CPU: 0 PID: 3537 Comm: kms_pipe_crc_ba Tainted: G     U            4.17.0-rc3-CI-CI_DRM_4141+ #1
[  356.079138] Hardware name: Hewlett-Packard HP Compaq 8000 Elite CMT PC/3647h, BIOS 786G7 v01.02 10/22/2009
[  356.079141] RIP: 0010:drm_wait_one_vblank+0x175/0x180
[  356.079143] RSP: 0018:ffffc90000eb7a00 EFLAGS: 00010286
[  356.079146] RAX: 0000000000000000 RBX: ffff880108f50000 RCX: 0000000000000001
[  356.079149] RDX: 0000000080000001 RSI: 0000000000000001 RDI: 00000000ffffffff
[  356.079150] RBP: 0000000000000001 R08: 0000000000000000 R09: 0000000000000000
[  356.079152] R10: ffffc90000eb7950 R11: ffffffff82243d38 R12: 0000000000000000
[  356.079154] R13: 000000000000077b R14: ffff880108558b68 R15: ffff8800d923d3d8
[  356.079157] FS:  00007ff92192a980(0000) GS:ffff88011bc00000(0000) knlGS:0000000000000000
[  356.079159] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[  356.079162] CR2: 00007f0f1ca68cc0 CR3: 0000000108582000 CR4: 00000000000406f0
[  356.079163] Call Trace:
[  356.079169]  ? wait_woken+0x90/0x90
[  356.079248]  intel_pre_plane_update+0x17c/0x220 [i915]
[  356.079324]  intel_atomic_commit_tail+0xce/0xd20 [i915]
[  356.079403]  intel_atomic_commit+0x240/0x320 [i915]
[  356.079409]  restore_fbdev_mode_atomic+0x1ad/0x220
[  356.079419]  drm_fb_helper_restore_fbdev_mode_unlocked+0x42/0x90
[  356.079423]  drm_fb_helper_set_par+0x24/0x50
[  356.079496]  intel_fbdev_set_par+0x11/0x60 [i915]
[  356.079501]  fbcon_init+0x4db/0x680
[  356.079507]  visual_init+0xd0/0x130
[  356.079511]  do_bind_con_driver+0x1ef/0x3f0
[  356.079517]  do_unbind_con_driver+0x1a8/0x230
[  356.079524]  store_bind+0xad/0x1a0
[  356.079530]  kernfs_fop_write+0x104/0x190
[  356.079535]  __vfs_write+0x31/0x160
[  356.079541]  ? rcu_sync_lockdep_assert+0x9/0x50
[  356.079544]  ? __sb_start_write+0x152/0x1f0
[  356.079547]  ? __sb_start_write+0x168/0x1f0
[  356.079551]  vfs_write+0xbd/0x1a0
[  356.079555]  ksys_write+0x50/0xc0
[  356.079560]  do_syscall_64+0x55/0x190
[  356.079564]  entry_SYSCALL_64_after_hwframe+0x49/0xbe
[  356.079567] RIP: 0033:0x7ff9212c2281
[  356.079569] RSP: 002b:00007fffb5073758 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
[  356.079572] RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00007ff9212c2281
[  356.079575] RDX: 0000000000000002 RSI: 00007ff921525254 RDI: 000000000000000a
[  356.079577] RBP: 00007fffb50747a0 R08: 000055d1116fbdb3 R09: 0000000000000006
[  356.079578] R10: 0000000000000000 R11: 0000000000000246 R12: 00007ff9212ab718
[  356.079580] R13: 0000000000000003 R14: 00007ff9212b0628 R15: 00007ff9212acd80
[  356.079588] Code: 2f ff ff ff e8 bd 11 a7 ff 48 89 e6 4c 89 f7 e8 62 24 ac ff 45 85 e4 0f 85 0c ff ff ff 89 ee 48 c7 c7 88 98 0f 82 e8 bb 0e a7 ff <0f> 0b e9 f7 fe ff ff 0f 1f 40 00 8b b7 f8 00 00 00 48 8b 3f e9 
[  356.079655] irq event stamp: 0
[  356.079658] hardirqs last  enabled at (0): [<0000000000000000>]           (null)
[  356.079662] hardirqs last disabled at (0): [<ffffffff810813e2>] copy_process.part.7+0x322/0x1d30
[  356.079666] softirqs last  enabled at (0): [<ffffffff810813e2>] copy_process.part.7+0x322/0x1d30
[  356.079668] softirqs last disabled at (0): [<0000000000000000>]           (null)
[  356.079672] WARNING: CPU: 0 PID: 3537 at drivers/gpu/drm/drm_vblank.c:1084 drm_wait_one_vblank+0x175/0x180
[  356.079674] ---[ end trace 7a2b4fdcf1d576be ]---

Comment 1 Martin Peres 2018-06-19 21:50:54 UTC

Occurred only once, on CI_DRM_4141 (1 month, 2 weeks / 768 runs ago). Closing!

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.