Bug 107381 - [NV117] Hang with 'fifo: write fault' and thousands of 'TRAP UNHANDLED 00000020'
Summary: [NV117] Hang with 'fifo: write fault' and thousands of 'TRAP UNHANDLED 00000020'
Status: RESOLVED MOVED
Alias: None
Product: xorg
Classification: Unclassified
Component: Driver/nouveau (show other bugs)
Version: unspecified
Hardware: x86-64 (AMD64) Linux (All)
: medium normal
Assignee: Nouveau Project
QA Contact: Xorg Project Team
URL:
Whiteboard:
Keywords:
Depends on:
Blocks:
 
Reported: 2018-07-25 22:48 UTC by Andrew
Modified: 2019-12-04 09:44 UTC (History)
0 users

See Also:
i915 platform:
i915 features:

Attachments
/var/log/syslog contents, edited to remove some duplicate messages (1.84 MB, text/plain)
2018-07-26 03:01 UTC, Andrew 		no flags Details
View All

Description Andrew 2018-07-25 22:48:00 UTC 
I was using Chrome when my display froze (the mouse still worked, but otherwise the screen was non-responsive).  After SSHing in, the following messages were in /var/log/syslog (dmesg wasn't helpful because the kernel message buffer had wrapped around):

...
gnome-panel.desktop[16108]: [16340:16340:0725/162405.571179:ERROR:gl_surface_presentation_helper.cc(115)] GetVSyncParametersIfAvailable() failed!
gnome-panel.desktop[16108]: [16340:16340:0725/162405.596384:ERROR:gl_surface_presentation_helper.cc(115)] GetVSyncParametersIfAvailable() failed!
kernel: [512690.788845] nouveau 0000:02:00.0: gr: TRAP ch 12 [007f108000 chrome[16340]]
kernel: [512690.788857] nouveau 0000:02:00.0: gr: MACRO 80000010 [WATCHDOG], pc: 0x111, op: 0xff111111
kernel: [512690.788867] nouveau 0000:02:00.0: gr: GPC0/TPC0/MP trap: global 00000000 [] warp 111111 []
kernel: [512690.788874] nouveau 0000:02:00.0: gr: GPC0/TPC1/MP trap: global 00000000 [] warp 111111 []
kernel: [512690.788881] nouveau 0000:02:00.0: gr: GPC0/TPC2/MP trap: global 00000000 [] warp 111111 []
kernel: [512690.788885] nouveau 0000:02:00.0: gr: TRAP UNHANDLED 00000020
kernel: [512690.788897] nouveau 0000:02:00.0: fifo: write fault at ff11178000 engine 00 [GR] client 15 [SCC_NB] reason 00 [PDE] on channel 12 [007f108000 chrome[16340]]
kernel: [512690.788911] nouveau 0000:02:00.0: fifo: channel 12: killed
kernel: [512690.788914] nouveau 0000:02:00.0: fifo: runlist 0: scheduled for recovery
kernel: [512690.788920] nouveau 0000:02:00.0: fifo: engine 0: scheduled for recovery
kernel: [512690.788931] nouveau 0000:02:00.0: gr: TRAP ch 12 [007f108000 chrome[16340]]
kernel: [512690.788935] nouveau 0000:02:00.0: gr: TRAP UNHANDLED 00000020
kernel: [512690.788946] nouveau 0000:02:00.0: gr: TRAP ch 12 [007f108000 chrome[16340]]
kernel: [512690.788949] nouveau 0000:02:00.0: gr: TRAP UNHANDLED 00000020
[ The above two messages repeated ~ 3,200 times ]
kernel: [512690.813965] nouveau 0000:02:00.0: chrome[16340]: channel 12 killed!
kernel: [512690.813971] nouveau 0000:02:00.0: gr: TRAP ch 12 [007f108000 chrome[16340]]
kernel: [512690.813973] nouveau 0000:02:00.0: gr: TRAP UNHANDLED 00000020
[ The above two messages repeat ten more times  ]
gnome-panel.desktop[16108]: [16340:16340:0725/162405.614008:ERROR:gl_surface_presentation_helper.cc(115)] GetVSyncParametersIfAvailable() failed!



Eventually the display appears to have crashed, and the following log messages occurred:

kernel: [514889.808652] nouveau 0000:02:00.0: fifo: PBDMA0: 04000000 [ACQUIRE] ch 6 [007f576000 systemd-logind[957]] subc 0 mthd 001c data 00001004
/usr/lib/gdm3/gdm-x-session[15566]: (**) Option "fd" "25"
/usr/lib/gdm3/gdm-x-session[15566]: (II) event1  - (II) Power Button: (II) device removed
/usr/lib/gdm3/gdm-x-session[15566]: (**) Option "fd" "28"
/usr/lib/gdm3/gdm-x-session[15566]: (II) event0  - (II) Power Button: (II) device removed
/usr/lib/gdm3/gdm-x-session[15566]: (**) Option "fd" "29"
/usr/lib/gdm3/gdm-x-session[15566]: (II) event2  - (II) Dell KB216 Wired Keyboard: (II) device removed
/usr/lib/gdm3/gdm-x-session[15566]: (**) Option "fd" "30"
/usr/lib/gdm3/gdm-x-session[15566]: (**) Option "fd" "31"
/usr/lib/gdm3/gdm-x-session[15566]: (II) event4  - (II) PixArt Dell MS116 USB Optical Mouse: (II) device removed
gnome-session-binary[15772]: WARNING: Could not get session path for session. Check that logind is properly installed and pam_systemd is getting used at login.
gnome-session[15772]: gnome-session-binary[15772]: WARNING: Could not get session path for session. Check that logind is properly installed and pam_systemd is getting used at login.
/usr/lib/gdm3/gdm-x-session[15566]: (**) Option "fd" "30"
/usr/lib/gdm3/gdm-x-session[15566]: (II) event3  - (II) Dell KB216 Wired Keyboard: (II) device removed
/usr/lib/gdm3/gdm-x-session[15566]: (II) AIGLX: Suspending AIGLX clients for VT switch
/usr/lib/gdm3/gdm-x-session[15566]: (II) NOUVEAU(0): NVLeaveVT is called.
/usr/lib/gdm3/gdm-x-session[15566]: (II) NOUVEAU(G0): NVLeaveVT is called.
systemd[1]: Started Getty on tty6.
/usr/lib/gdm3/gdm-x-session[15566]: (II) systemd-logind: got pause for 226:1
/usr/lib/gdm3/gdm-x-session[15566]: (II) systemd-logind: got pause for 226:0
/usr/lib/gdm3/gdm-x-session[15566]: (II) systemd-logind: got pause for 13:65
/usr/lib/gdm3/gdm-x-session[15566]: (II) systemd-logind: got pause for 13:67
/usr/lib/gdm3/gdm-x-session[15566]: (II) systemd-logind: got pause for 13:64
/usr/lib/gdm3/gdm-x-session[15566]: (II) systemd-logind: got pause for 13:66
/usr/lib/gdm3/gdm-x-session[15566]: (II) systemd-logind: got pause for 13:68
nautilus-deskto[16115]: gdk_event_set_source_device: assertion 'GDK_IS_DEVICE (device)' failed
terminator[16252]: gdk_event_set_source_device: assertion 'GDK_IS_DEVICE (device)' failed
kernel: [514890.022839] nautilus-deskto[16115]: segfault at 90 ip 00007fd9ec3a0d95 sp 00007ffdbf71ace0 error 4 in libgdk-3.so.0.2200.25[7fd9ec33e000+101000]
kernel: [514890.024149] terminator[16252]: segfault at 90 ip 00007fb0d1678d95 sp 00007ffcd51bd2b0 error 4 in libgdk-3.so.0.2200.25[7fb0d1616000+101000]
gnome-panel[16108]: gdk_event_set_source_device: assertion 'GDK_IS_DEVICE (device)' failed
gnome-panel[16108]: gdk_device_get_device_type: assertion 'GDK_IS_DEVICE (device)' failed
gnome-panel[16108]: gdk_device_list_slave_devices: assertion 'GDK_IS_DEVICE (device)' failed
gnome-panel[16108]: gdk_device_get_n_axes: assertion 'GDK_IS_DEVICE (device)' failed
gnome-panel[16108]: gdk_event_set_source_device: assertion 'GDK_IS_DEVICE (device)' failed
kernel: [514890.035217] gnome-panel[16108]: segfault at 90 ip 00007f4a87279138 sp 00007ffe5bcb6350 error 4 in libgdk-3.so.0.2200.25[7f4a87216000+101000]
systemd[15554]: Starting Notification regarding a crash report...
gnome-session[15772]: gnome-session-binary[15772]: WARNING: Application 'nautilus-classic.desktop' killed by signal 11
gnome-session[15772]: gnome-session-binary[15772]: WARNING: Application 'gnome-panel.desktop' killed by signal 11
gnome-session-binary[15772]: WARNING: Application 'nautilus-classic.desktop' killed by signal 11
gnome-session-binary[15772]: WARNING: Application 'gnome-panel.desktop' killed by signal 11
...
kernel: [514909.422983] CPU: 1 PID: 15568 Comm: Xorg Not tainted 4.13.0-46-generic #51-Ubuntu
kernel: [514909.422985] Hardware name: Dell Inc. Precision Tower 5810/0HHV7N, BIOS A20 07/26/2017
kernel: [514909.422987] task: ffff88ab2145c5c0 task.stack: ffffb47943474000
kernel: [514909.423040] RIP: 0010:nouveau_bo_move_ntfy+0x9b/0xa0 [nouveau]
kernel: [514909.423042] RSP: 0018:ffffb47943477840 EFLAGS: 00010286
kernel: [514909.423045] RAX: 00000000fffffff0 RBX: ffff88ab49a29d00 RCX: ffff88aa0771ccc0
kernel: [514909.423047] RDX: 0000000000000000 RSI: 0000000000000282 RDI: 0000000000000282
kernel: [514909.423048] RBP: ffffb47943477860 R08: 0000000000000000 R09: 000000000003f16b
kernel: [514909.423050] R10: ffffb47943477728 R11: 00000000003d0900 R12: ffffb47943477930
kernel: [514909.423052] R13: ffff88ab73335000 R14: ffff88ab733352f8 R15: ffffb47943477930
kernel: [514909.423055] FS:  00007f7ea52b6500(0000) GS:ffff88ab7f240000(0000) knlGS:0000000000000000
kernel: [514909.423057] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
kernel: [514909.423059] CR2: 00001fb578c78000 CR3: 00000007f4fee002 CR4: 00000000003606e0
kernel: [514909.423061] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
kernel: [514909.423063] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
kernel: [514909.423064] Call Trace:
kernel: [514909.423077]  ttm_bo_handle_move_mem+0x251/0x5c0 [ttm]
kernel: [514909.423083]  ? ttm_bo_mem_space+0x39d/0x470 [ttm]
kernel: [514909.423090]  ttm_bo_evict+0x141/0x330 [ttm]
kernel: [514909.423134]  ? __nv50_ram_put+0x66/0x90 [nouveau]
kernel: [514909.423142]  ttm_mem_evict_first+0x145/0x1a0 [ttm]
kernel: [514909.423149]  ttm_bo_mem_space+0x312/0x470 [ttm]
kernel: [514909.423156]  ttm_bo_validate+0xd4/0x160 [ttm]
kernel: [514909.423162]  ttm_bo_init_reserved+0x3bb/0x450 [ttm]
kernel: [514909.423168]  ttm_bo_init+0x2d/0x90 [ttm]
kernel: [514909.423218]  ? nouveau_bo_invalidate_caches+0x10/0x10 [nouveau]
kernel: [514909.423262]  nouveau_bo_new+0x1bc/0x2f0 [nouveau]
kernel: [514909.423303]  ? nouveau_bo_invalidate_caches+0x10/0x10 [nouveau]
kernel: [514909.423344]  nouveau_gem_new+0x64/0x130 [nouveau]
kernel: [514909.423384]  nouveau_gem_ioctl_new+0x80/0x140 [nouveau]
kernel: [514909.423422]  ? nouveau_gem_new+0x130/0x130 [nouveau]
kernel: [514909.423443]  drm_ioctl_kernel+0x5f/0xb0 [drm]
kernel: [514909.423459]  drm_ioctl+0x31b/0x3d0 [drm]
kernel: [514909.423499]  ? nouveau_gem_new+0x130/0x130 [nouveau]
kernel: [514909.423541]  nouveau_drm_ioctl+0x72/0xc0 [nouveau]
kernel: [514909.423548]  do_vfs_ioctl+0xa8/0x630
kernel: [514909.423553]  SyS_ioctl+0x79/0x90
kernel: [514909.423560]  entry_SYSCALL_64_fastpath+0x24/0xab
kernel: [514909.423562] RIP: 0033:0x7f7ea271cef7
kernel: [514909.423564] RSP: 002b:00007ffdc1942688 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
kernel: [514909.423567] RAX: ffffffffffffffda RBX: 00005578772b9820 RCX: 00007f7ea271cef7
kernel: [514909.423569] RDX: 00007ffdc19426e0 RSI: 00000000c0306480 RDI: 000000000000000d
kernel: [514909.423570] RBP: 00007ffdc1942720 R08: 0000000000000000 R09: 000055787747a760
kernel: [514909.423572] R10: 0000000000000030 R11: 0000000000000246 R12: 0000000040086409
kernel: [514909.423574] R13: 000000000000000d R14: 0000557876f2e7e0 R15: 00005578772b9820
kernel: [514909.423576] Code: 75 c5 31 d2 31 f6 4c 89 ef e8 42 dd f3 ff 85 c0 75 19 48 89 df e8 c6 0a fa ff 48 8b 1b 49 39 de 75 d2 5b 41 5c 41 5d 41 5e 5d c3 <0f> ff eb e3 90 0f 1f
 44 00 00 55 48 89 e5 41 57 41 56 41 55 41
kernel: [514909.423635] ---[ end trace ecbf69f5285cfa6c ]---


Finally, a bunch of the following messages were generated until I rebooted:

/usr/lib/gdm3/gdm-x-session[15566]: -12
kernel: [514924.526648] [TTM] Buffer eviction failed



Some info about my machine:

Linux system 4.13.0-46-generic #51-Ubuntu SMP Tue Jun 12 12:36:29 UTC 2018 x86_64 x86_64 x86_64 GNU/Linux

From Chrome:
GL_VENDOR: nouveau
GL_RENDERER: NV117
GL_VERSION: 3.0 Mesa 17.2.8

The video card is a Quadro K620

A few potentially interesting notes:
 - I routinely hit the following bug (and I hit it when rebooting after this crash): https://bugs.launchpad.net/ubuntu/+source/xserver-xorg-video-nouveau/+bug/1684123
 - The GetVSyncParametersIfAvailable log messages occurred 160,000 times over the course of four hours, and occurred directly before and directly after this issue (as can be seen in the log output above)

Let me know if there is any additional information that I can provide.  Thanks!
Comment 1 Andrew 2018-07-26 03:01:52 UTC 
Created attachment 140816 [details]
/var/log/syslog contents, edited to remove some duplicate messages

/var/log/syslog output.  To see the lines directly related to the issue, start from the bottom and scroll up
Comment 2 Martin Peres 2019-12-04 09:44:13 UTC 
-- GitLab Migration Automatic Message --

This bug has been migrated to freedesktop.org's GitLab instance and has been closed from further activity.

You can subscribe and participate further through the new bug through this link to our GitLab instance: https://gitlab.freedesktop.org/xorg/driver/xf86-video-nouveau/issues/446.

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.