Summary: | [NV86] nouveau/kernel 3.18.0-rc1: nouveau deadlocks on 2nd Xorg start or reboot | ||
---|---|---|---|
Product: | xorg | Reporter: | Christian Vogel <vogelchr> |
Component: | Driver/nouveau | Assignee: | Nouveau Project <nouveau> |
Status: | RESOLVED MOVED | QA Contact: | Xorg Project Team <xorg-team> |
Severity: | major | ||
Priority: | medium | ||
Version: | unspecified | ||
Hardware: | x86-64 (AMD64) | ||
OS: | Linux (All) | ||
Whiteboard: | |||
i915 platform: | i915 features: | ||
Attachments: |
Created attachment 108439 [details]
/var/log/Xorg.0.log on normal X-server start up to termination
Starting and stopping the X-server the first time looks unremarkable.
[ 34.778] resize called 2944 1280
-> here display manager appears
-> I then stop lightdm to terminate X-server
[ 77.620] (II) evdev: Logitech USB-PS/2 Optical Mouse: Close
Can you bisect? I assume this wasn't an issue in 3.17? Created attachment 108440 [details]
Disassembly of nouveau_pmops_runtime_suspend
As the only nouveau-specific thing in the kernel-stack-trace seems to be nouveau_pmops_runtime_suspend, I'm adding a disassembly.
Unfortunately the two calls to pm_runtime_forbid() can't even be distinguished, as there's only one call, and the 2nd one is optimized by gcc to a branch upwards, I've marked the actual location from the stacktrace with #####.
(In reply to Ilia Mirkin from comment #2) > Can you bisect? I assume this wasn't an issue in 3.17? Sorry... I've not mentioned that. It is an issue since I put in the Nvidia card, about ... over one year, to be sure. I just wasn't sufficiently annoyed until now. Seems like you're being hit by runtime pm somehow... Can you confirm by booting with nouveau.runpm=0 to see if that resolves your issues? runpm was new in kernel 3.12 iirc (for nouveau). (In reply to Ilia Mirkin from comment #5) > nouveau.runpm=0 This fixes the issue with the hung X-Server, I can terminate and re-start X-servers as expected when logged in via ssh. But parts of the bug remain, namely that the X-console will freeze as soon as the VT on which the X-server was active is selected: - system boots, X-server works, I can login, use applications - stop lightdm -> X-server turns off, screen goes black, keyboard does not work - via ssh: start lightdm -> X-server restarts, everything looks ok again A funny variation of that theme: - system works, running X - switch to VT2 (Ctrl-Alt-F2), I get the linux vt #2, everything ok - on the console (or via ssh): stop lightdm -> nothing visible changes, X terminates in the background - switch to VT3 (Ctrl-Alt-F3), I get the linux vt #3, all ok - switch to VT1 (Ctrl-Alt-F1) where the X-server was active before: -> cursor stops blinking, keyboard no longer responsive, screen content frozen - via ssh: start lightdm -> X server starts up, I can login into X and use applications, keyboard works (actually, that's how I write this text now...) - switch to VT2, VT3, ... works now. ---> Why does the framebuffer-console hang when I change into the VT previously occupied by nouveau/xorg? (I want to add: For a user that doesn't have a second machine to ssh remotely, or to have a serial terminal, the end result is probably the same than with nouveau being hung in powermanagement -> No other way to get the machine working than to reset/restart.) I've same issue, but on Arch Linux 4.1 with NVIDIA GeForce GTX 650 Ti nouveau crashes kernel that can't even reboot/poweroff, only with hard reset. adding nouveau.runpm=0 to kernel parameters atleast it doesn't crash. kernel: [drm] Initialized drm 1.1.0 20060810 kernel: nouveau [ DEVICE][0000:01:00.0] BOOT0 : 0x0e6060a1 kernel: nouveau [ DEVICE][0000:01:00.0] Chipset: GK106 (NVE6) kernel: nouveau [ DEVICE][0000:01:00.0] Family : NVE0 kernel: nouveau [ VBIOS][0000:01:00.0] using image from PROM kernel: nouveau [ VBIOS][0000:01:00.0] BIT signature found kernel: nouveau [ VBIOS][0000:01:00.0] version 80.06.21.00.37 kernel: nouveau [ PMC][0000:01:00.0] MSI interrupts enabled kernel: nouveau [ PFB][0000:01:00.0] RAM type: GDDR5 kernel: nouveau [ PFB][0000:01:00.0] RAM size: 1024 MiB kernel: nouveau [ PFB][0000:01:00.0] ZCOMP: 0 tags kernel: nouveau [ VOLT][0000:01:00.0] GPU voltage: 887500uv kernel: nouveau [ PTHERM][0000:01:00.0] FAN control: PWM kernel: nouveau [ PTHERM][0000:01:00.0] fan management: automatic kernel: nouveau [ PTHERM][0000:01:00.0] internal sensor: yes kernel: nouveau [ CLK][0000:01:00.0] 07: core 324 MHz memory 648 MHz kernel: nouveau [ CLK][0000:01:00.0] 0a: core 549 MHz memory 1620 MHz kernel: nouveau [ CLK][0000:01:00.0] 0f: core 928-954 MHz memory 5400 MHz kernel: nouveau [ CLK][0000:01:00.0] --: core 324 MHz memory 648 MHz kernel: nouveau [ DRM] VRAM: 1024 MiB kernel: nouveau [ DRM] GART: 1048576 MiB kernel: nouveau [ DRM] TMDS table version 2.0 kernel: nouveau [ DRM] DCB version 4.0 kernel: nouveau [ DRM] DCB outp 00: 01000f02 00020030 kernel: nouveau [ DRM] DCB outp 01: 02000f00 00020030 kernel: nouveau [ DRM] DCB outp 02: 08011f82 0f420030 kernel: nouveau [ DRM] DCB outp 03: 02022f62 0f420010 kernel: nouveau [ DRM] DCB conn 00: 00001030 kernel: nouveau [ DRM] DCB conn 01: 00002131 kernel: nouveau [ DRM] DCB conn 02: 00010263 kernel: [drm] Supports vblank timestamp caching Rev 2 (21.10.2013). kernel: [drm] Driver supports precise vblank timestamp query. kernel: nouveau [ DRM] MM: using COPY for buffer copies kernel: nouveau [ DRM] allocated 2560x1440 fb: 0x60000, bo ffff880223222000 kernel: fbcon: nouveaufb (fb0) is primary device kernel: nouveau 0000:01:00.0: fb0: nouveaufb frame buffer device kernel: nouveau 0000:01:00.0: registered panic notifier kernel: [drm] Initialized nouveau 1.2.2 20120801 for 0000:01:00.0 on minor 0 kernel: INFO: task kworker/2:2:115 blocked for more than 120 seconds. kernel: Not tainted 4.1.0-ARCH-dirty #3 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kernel: kworker/2:2 D ffff880222da3bb8 0 115 2 0x00000000 kernel: Workqueue: pm pm_runtime_work kernel: ffff880222da3bb8 ffff880225240000 ffff880225335180 ffffffff81b1e8e8 kernel: ffff880222da4000 ffff880224e3e146 ffff880224e3e200 0000000000000000 kernel: 0000000000000000 ffff880222da3bd8 ffffffff81587d77 ffff880224e3e146 kernel: Call Trace: kernel: [<ffffffff81587d77>] schedule+0x37/0x90 kernel: [<ffffffff813ff65d>] rpm_resume+0x20d/0x6b0 kernel: [<ffffffff810bc6b0>] ? wake_atomic_t_function+0x60/0x60 kernel: [<ffffffff813ffde3>] pm_runtime_forbid+0x43/0x50 kernel: [<ffffffffa0368778>] nouveau_pmops_runtime_suspend+0xc8/0xf0 [nouveau] kernel: [<ffffffff81311baf>] pci_pm_runtime_suspend+0x5f/0x140 kernel: [<ffffffff81311b50>] ? pci_legacy_suspend_late+0xf0/0xf0 kernel: [<ffffffff813fe466>] __rpm_callback+0x36/0x90 kernel: [<ffffffff813fe4e8>] rpm_callback+0x28/0x90 kernel: [<ffffffff813feae6>] rpm_suspend+0x126/0x690 kernel: [<ffffffff8101477c>] ? __switch_to+0x2bc/0x5e0 kernel: [<ffffffff814002f2>] pm_runtime_work+0x72/0xc0 kernel: [<ffffffff8109193b>] process_one_work+0x14b/0x470 kernel: [<ffffffff81091ca8>] worker_thread+0x48/0x4c0 kernel: [<ffffffff81091c60>] ? process_one_work+0x470/0x470 kernel: [<ffffffff81091c60>] ? process_one_work+0x470/0x470 kernel: [<ffffffff810977f8>] kthread+0xd8/0xf0 kernel: [<ffffffff81097720>] ? kthread_worker_fn+0x170/0x170 kernel: [<ffffffff8158bda2>] ret_from_fork+0x42/0x70 kernel: [<ffffffff81097720>] ? kthread_worker_fn+0x170/0x170 kernel: INFO: task Xorg.wrap:1012 blocked for more than 120 seconds. kernel: Not tainted 4.1.0-ARCH-dirty #3 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kernel: Xorg.wrap D ffff8800bdc979d8 0 1012 962 0x00000000 kernel: ffff8800bdc979d8 ffff880225241460 ffff880222ccf010 ffff880224ab81b0 kernel: ffff8800bdc98000 ffff880224e3e146 ffff880224e3e200 0000000000000000 kernel: 0000000000000004 ffff8800bdc979f8 ffffffff81587d77 ffff880224e3e146 kernel: Call Trace: kernel: [<ffffffff81587d77>] schedule+0x37/0x90 kernel: [<ffffffff813ff65d>] rpm_resume+0x20d/0x6b0 kernel: [<ffffffff810bc6b0>] ? wake_atomic_t_function+0x60/0x60 kernel: [<ffffffff813ffb3f>] __pm_runtime_resume+0x3f/0x60 kernel: [<ffffffffa0368d4d>] nouveau_drm_open+0x3d/0x280 [nouveau] kernel: [<ffffffff811c2e1e>] ? kmem_cache_alloc_trace+0x1fe/0x230 kernel: [<ffffffffa007a85f>] drm_open+0x1af/0x4c0 [drm] kernel: [<ffffffffa0081799>] drm_stub_open+0xa9/0x120 [drm] kernel: [<ffffffff811e594e>] chrdev_open+0xae/0x1f0 kernel: [<ffffffff811de867>] do_dentry_open+0x227/0x330 kernel: [<ffffffff811e58a0>] ? cdev_put+0x30/0x30 kernel: [<ffffffff811dec69>] vfs_open+0x49/0x50 kernel: [<ffffffff811ef63e>] do_last.isra.11+0x33e/0xf00 kernel: [<ffffffff811eddfe>] ? path_init+0x17e/0x460 kernel: [<ffffffff811f0291>] path_openat+0x91/0x690 kernel: [<ffffffff81166135>] ? filemap_map_pages+0x135/0x270 kernel: [<ffffffff811f1d29>] do_filp_open+0x49/0xd0 kernel: [<ffffffff812dde5a>] ? find_next_zero_bit+0x1a/0x30 kernel: [<ffffffff811ff347>] ? __alloc_fd+0xa7/0x130 kernel: [<ffffffff811dfe9d>] do_sys_open+0x14d/0x250 kernel: [<ffffffff811dffbe>] SyS_open+0x1e/0x20 kernel: [<ffffffff8158b9ae>] system_call_fastpath+0x12/0x71 kernel: INFO: task libvirtd:1463 blocked for more than 120 seconds. kernel: Not tainted 4.1.0-ARCH-dirty #3 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kernel: libvirtd D ffff8800bc91bc78 0 1463 1 0x00000000 kernel: ffff8800bc91bc78 ffff880225241e90 ffff8800c0bc8a30 0000000000000000 kernel: ffff8800bc91c000 ffff880224e3e146 ffff880224e3e200 ffff880224e3e146 kernel: 00007f96227a0c30 ffff8800bc91bc98 ffffffff81587d77 ffff880224e3e146 kernel: Call Trace: kernel: [<ffffffff81587d77>] schedule+0x37/0x90 kernel: [<ffffffff813fe78d>] __pm_runtime_barrier+0xad/0x170 kernel: [<ffffffff810bc6b0>] ? wake_atomic_t_function+0x60/0x60 kernel: [<ffffffff813ffc0b>] pm_runtime_barrier+0x5b/0xc0 kernel: [<ffffffff8130fd5b>] pci_config_pm_runtime_get+0x3b/0x60 kernel: [<ffffffff81314b36>] pci_read_config+0x96/0x2b0 kernel: [<ffffffff8125b13a>] sysfs_kf_bin_read+0x4a/0x70 kernel: [<ffffffff8125a798>] kernfs_fop_read+0xa8/0x170 kernel: [<ffffffff811e03c7>] __vfs_read+0x37/0x100 kernel: [<ffffffff8128314e>] ? security_file_permission+0x8e/0xa0 kernel: [<ffffffff811e0d37>] vfs_read+0x87/0x140 kernel: [<ffffffff811e1d2a>] SyS_pread64+0x9a/0xc0 kernel: [<ffffffff8158b9ae>] system_call_fastpath+0x12/0x71 kernel: INFO: task kworker/2:2:115 blocked for more than 120 seconds. kernel: Not tainted 4.1.0-ARCH-dirty #3 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kernel: kworker/2:2 D ffff880222da3bb8 0 115 2 0x00000000 kernel: Workqueue: pm pm_runtime_work kernel: ffff880222da3bb8 ffff880225240000 ffff880225335180 ffffffff81b1e8e8 kernel: ffff880222da4000 ffff880224e3e146 ffff880224e3e200 0000000000000000 kernel: 0000000000000000 ffff880222da3bd8 ffffffff81587d77 ffff880224e3e146 kernel: Call Trace: kernel: [<ffffffff81587d77>] schedule+0x37/0x90 kernel: [<ffffffff813ff65d>] rpm_resume+0x20d/0x6b0 kernel: [<ffffffff810bc6b0>] ? wake_atomic_t_function+0x60/0x60 kernel: [<ffffffff813ffde3>] pm_runtime_forbid+0x43/0x50 kernel: [<ffffffffa0368778>] nouveau_pmops_runtime_suspend+0xc8/0xf0 [nouveau] kernel: [<ffffffff81311baf>] pci_pm_runtime_suspend+0x5f/0x140 kernel: [<ffffffff81311b50>] ? pci_legacy_suspend_late+0xf0/0xf0 kernel: [<ffffffff813fe466>] __rpm_callback+0x36/0x90 kernel: [<ffffffff813fe4e8>] rpm_callback+0x28/0x90 kernel: [<ffffffff813feae6>] rpm_suspend+0x126/0x690 kernel: [<ffffffff8101477c>] ? __switch_to+0x2bc/0x5e0 kernel: [<ffffffff814002f2>] pm_runtime_work+0x72/0xc0 kernel: [<ffffffff8109193b>] process_one_work+0x14b/0x470 kernel: [<ffffffff81091ca8>] worker_thread+0x48/0x4c0 kernel: [<ffffffff81091c60>] ? process_one_work+0x470/0x470 kernel: [<ffffffff81091c60>] ? process_one_work+0x470/0x470 kernel: [<ffffffff810977f8>] kthread+0xd8/0xf0 kernel: [<ffffffff81097720>] ? kthread_worker_fn+0x170/0x170 kernel: [<ffffffff8158bda2>] ret_from_fork+0x42/0x70 kernel: [<ffffffff81097720>] ? kthread_worker_fn+0x170/0x170 [ 185.819] (II) Loader magic: 0x817d60 [ 185.819] (II) Module ABI versions: [ 185.819] X.Org ANSI C Emulation: 0.4 [ 185.819] X.Org Video Driver: 19.0 [ 185.819] X.Org XInput driver : 21.1 [ 185.819] X.Org Server Extension : 9.0 [ 185.821] (EE) systemd-logind: failed to get session: PID 2044 does not belong to any known session [ 185.822] (II) xfree86: Adding drm device (/dev/dri/card0) [ 185.824] (--) PCI:*(0:1:0:0) 10de:11c6:1462:2805 rev 161, Mem @ 0xfa000000/16777216, 0xd0000000/134217728, 0xde000000/33554432, I/O @ 0x0000af00/128, BIOS @ 0x????????/524288 [ 185.825] (II) Open ACPI successful (/var/run/acpid.socket) [ 185.825] (II) LoadModule: "glx" [ 185.825] (II) Loading /usr/lib/xorg/modules/extensions/libglx.so [ 185.826] (II) Module glx: vendor="X.Org Foundation" [ 185.826] compiled for 1.17.2, module version = 1.0.0 [ 185.826] ABI class: X.Org Server Extension, version 9.0 [ 185.826] (==) AIGLX enabled [ 185.826] (II) LoadModule: "nouveau" [ 185.826] (II) Loading /usr/lib/xorg/modules/drivers/nouveau_drv.so [ 185.827] (II) Module nouveau: vendor="X.Org Foundation" [ 185.827] compiled for 1.17.0, module version = 1.0.11 [ 185.827] Module class: X.Org Video Driver [ 185.827] ABI class: X.Org Video Driver, version 19.0 [ 185.827] (II) NOUVEAU driver [ 185.827] (II) NOUVEAU driver for NVIDIA chipset families : [ 185.827] RIVA TNT (NV04) [ 185.827] RIVA TNT2 (NV05) [ 185.827] GeForce 256 (NV10) [ 185.827] GeForce 2 (NV11, NV15) [ 185.827] GeForce 4MX (NV17, NV18) [ 185.827] GeForce 3 (NV20) [ 185.827] GeForce 4Ti (NV25, NV28) [ 185.827] GeForce FX (NV3x) [ 185.827] GeForce 6 (NV4x) [ 185.827] GeForce 7 (G7x) [ 185.827] GeForce 8 (G8x) [ 185.827] GeForce GTX 200 (NVA0) [ 185.827] GeForce GTX 400 (NVC0) [ 185.827] (++) using VT number 1 [ 185.830] (II) [drm] nouveau interface version: 1.2.2 [ 185.830] (II) Loading sub module "dri2" [ 185.830] (II) LoadModule: "dri2" [ 185.830] (II) Module "dri2" already built-in [ 185.831] (--) NOUVEAU(0): Chipset: "NVIDIA NVE6" [ 185.831] (**) NOUVEAU(0): Depth 24, (--) framebuffer bpp 32 [ 185.831] (==) NOUVEAU(0): RGB weight 888 [ 185.831] (==) NOUVEAU(0): Default visual is TrueColor [ 185.831] (==) NOUVEAU(0): Using HW cursor [ 185.831] (==) NOUVEAU(0): GLX sync to VBlank enabled. [ 185.831] (==) NOUVEAU(0): Page flipping enabled [ 185.831] (==) NOUVEAU(0): Swap limit set to 1 [Max allowed 2] [ 185.831] (==) NOUVEAU(0): Page flipping synced to vblank by kernel. [ 185.831] (II) NOUVEAU(0): Initializing outputs ... [ 185.843] (II) NOUVEAU(0): Output DVI-I-1 using monitor section DVI-I-0 [ 185.873] (II) NOUVEAU(0): Output DVI-D-1 has no monitor section [ 185.874] (II) NOUVEAU(0): Output HDMI-1 has no monitor section [ 185.874] (II) NOUVEAU(0): 3 crtcs needed for screen. [ 185.876] (II) NOUVEAU(0): Allocated crtc nr. 0 to this screen. [ 185.876] (II) NOUVEAU(0): Allocated crtc nr. 1 to this screen. [ 185.876] (II) NOUVEAU(0): Allocated crtc nr. 2 to this screen. [ 185.876] (II) NOUVEAU(0): Allocated crtc nr. 3 to this screen. [ 185.888] (II) NOUVEAU(0): EDID for output DVI-I-1 [ 185.918] (II) NOUVEAU(0): EDID for output DVI-D-1 [ 185.918] (II) NOUVEAU(0): Manufacturer: DEL Model: 407e Serial#: 875704403 [ 185.918] (II) NOUVEAU(0): Year: 2014 Week: 35 [ 185.918] (II) NOUVEAU(0): EDID Version: 1.3 [ 185.918] (II) NOUVEAU(0): Digital Display Input [ 185.918] (II) NOUVEAU(0): Max Image Size [cm]: horiz.: 60 vert.: 34 [ 185.918] (II) NOUVEAU(0): Gamma: 2.20 [ 185.918] (II) NOUVEAU(0): DPMS capabilities: StandBy Suspend Off [ 185.918] (II) NOUVEAU(0): Supported color encodings: RGB 4:4:4 YCrCb 4:4:4 [ 185.918] (II) NOUVEAU(0): First detailed timing is preferred mode [ 185.918] (II) NOUVEAU(0): redX: 0.653 redY: 0.336 greenX: 0.295 greenY: 0.640 [ 185.918] (II) NOUVEAU(0): blueX: 0.146 blueY: 0.042 whiteX: 0.313 whiteY: 0.329 [ 185.918] (II) NOUVEAU(0): Supported established timings: [ 185.918] (II) NOUVEAU(0): 720x400@70Hz [ 185.918] (II) NOUVEAU(0): 640x480@60Hz [ 185.918] (II) NOUVEAU(0): 640x480@75Hz [ 185.918] (II) NOUVEAU(0): 800x600@60Hz [ 185.918] (II) NOUVEAU(0): 800x600@75Hz [ 185.918] (II) NOUVEAU(0): 1024x768@60Hz [ 185.918] (II) NOUVEAU(0): 1024x768@75Hz [ 185.918] (II) NOUVEAU(0): 1280x1024@75Hz [ 185.918] (II) NOUVEAU(0): Manufacturer's mask: 0 [ 185.918] (II) NOUVEAU(0): Supported standard timings: [ 185.918] (II) NOUVEAU(0): #0: hsize: 1280 vsize 800 refresh: 60 vid: 129 [ 185.918] (II) NOUVEAU(0): #1: hsize: 1680 vsize 1050 refresh: 60 vid: 179 [ 185.918] (II) NOUVEAU(0): #2: hsize: 1920 vsize 1200 refresh: 60 vid: 209 [ 185.918] (II) NOUVEAU(0): #3: hsize: 1152 vsize 864 refresh: 75 vid: 20337 [ 185.918] (II) NOUVEAU(0): #4: hsize: 1600 vsize 1200 refresh: 60 vid: 16553 [ 185.918] (II) NOUVEAU(0): #5: hsize: 1280 vsize 1024 refresh: 60 vid: 32897 [ 185.918] (II) NOUVEAU(0): #6: hsize: 1920 vsize 1080 refresh: 60 vid: 49361 [ 185.918] (II) NOUVEAU(0): Supported detailed timing: [ 185.918] (II) NOUVEAU(0): clock: 241.5 MHz Image Size: 597 x 336 mm [ 185.918] (II) NOUVEAU(0): h_active: 2560 h_sync: 2608 h_sync_end 2640 h_blank_end 2720 h_border: 0 [ 185.918] (II) NOUVEAU(0): v_active: 1440 v_sync: 1443 v_sync_end 1448 v_blanking: 1481 v_border: 0 [ 185.918] (II) NOUVEAU(0): Serial No: 7JNY548P420S [ 185.918] (II) NOUVEAU(0): Monitor name: DELL U2713HM [ 185.918] (II) NOUVEAU(0): Ranges: V min: 49 V max: 86 Hz, H min: 29 H max: 113 kHz, PixClock max 285 MHz [ 185.918] (II) NOUVEAU(0): EDID (in hex): [ 185.918] (II) NOUVEAU(0): 00ffffffffffff0010ac7e4053303234 [ 185.918] (II) NOUVEAU(0): 23180103803c2278ea4bb5a7564ba325 [ 185.918] (II) NOUVEAU(0): 0a5054a54b008100b300d100714fa940 [ 185.918] (II) NOUVEAU(0): 8180d1c00101565e00a0a0a029503020 [ 185.918] (II) NOUVEAU(0): 350055502100001a000000ff00374a4e [ 185.918] (II) NOUVEAU(0): 5935343850343230530a000000fc0044 [ 185.918] (II) NOUVEAU(0): 454c4c205532373133484d0a000000fd [ 185.918] (II) NOUVEAU(0): 0031561d711c000a20202020202000c1 [ 185.918] (II) NOUVEAU(0): Printing probed modes for output DVI-D-1 [ 185.918] (II) NOUVEAU(0): Modeline "2560x1440"x60.0 241.50 2560 2608 2640 2720 1440 1443 1448 1481 +hsync -vsync (88.8 kHz eP) [ 185.918] (II) NOUVEAU(0): Modeline "1920x1200"x60.0 154.00 1920 1968 2000 2080 1200 1203 1209 1235 +hsync -vsync (74.0 kHz e) [ 185.918] (II) NOUVEAU(0): Modeline "1920x1080"x60.0 172.78 1920 2040 2248 2576 1080 1081 1084 1118 -hsync +vsync (67.1 kHz) [ 185.918] (II) NOUVEAU(0): Modeline "1600x1200"x60.0 162.00 1600 1664 1856 2160 1200 1201 1204 1250 +hsync +vsync (75.0 kHz e) [ 185.918] (II) NOUVEAU(0): Modeline "1680x1050"x59.9 119.00 1680 1728 1760 1840 1050 1053 1059 1080 +hsync -vsync (64.7 kHz e) [ 185.918] (II) NOUVEAU(0): Modeline "1280x1024"x75.0 135.00 1280 1296 1440 1688 1024 1025 1028 1066 +hsync +vsync (80.0 kHz e) [ 185.918] (II) NOUVEAU(0): Modeline "1280x1024"x60.0 108.00 1280 1328 1440 1688 1024 1025 1028 1066 +hsync +vsync (64.0 kHz e) [ 185.918] (II) NOUVEAU(0): Modeline "1280x800"x59.9 71.00 1280 1328 1360 1440 800 803 809 823 +hsync -vsync (49.3 kHz e) [ 185.918] (II) NOUVEAU(0): Modeline "1152x864"x75.0 108.00 1152 1216 1344 1600 864 865 868 900 +hsync +vsync (67.5 kHz e) [ 185.918] (II) NOUVEAU(0): Modeline "1024x768"x75.1 78.80 1024 1040 1136 1312 768 769 772 800 +hsync +vsync (60.1 kHz e) [ 185.919] (II) NOUVEAU(0): Modeline "1024x768"x60.0 65.00 1024 1048 1184 1344 768 771 777 806 -hsync -vsync (48.4 kHz e) [ 185.919] (II) NOUVEAU(0): Modeline "800x600"x75.0 49.50 800 816 896 1056 600 601 604 625 +hsync +vsync (46.9 kHz e) [ 185.919] (II) NOUVEAU(0): Modeline "800x600"x60.3 40.00 800 840 968 1056 600 601 605 628 +hsync +vsync (37.9 kHz e) [ 185.919] (II) NOUVEAU(0): Modeline "640x480"x75.0 31.50 640 656 720 840 480 481 484 500 -hsync -vsync (37.5 kHz e) [ 185.919] (II) NOUVEAU(0): Modeline "640x480"x60.0 25.20 640 656 752 800 480 490 492 525 -hsync -vsync (31.5 kHz e) [ 185.919] (II) NOUVEAU(0): Modeline "720x400"x70.1 28.32 720 738 846 900 400 412 414 449 -hsync +vsync (31.5 kHz e) [ 185.920] (II) NOUVEAU(0): EDID for output HDMI-1 [ 185.920] (II) NOUVEAU(0): Output DVI-I-1 disconnected [ 185.920] (II) NOUVEAU(0): Output DVI-D-1 connected [ 185.920] (II) NOUVEAU(0): Output HDMI-1 disconnected [ 185.920] (II) NOUVEAU(0): Using exact sizes for initial modes [ 185.920] (II) NOUVEAU(0): Output DVI-D-1 using initial mode 2560x1440 [ 185.920] (II) NOUVEAU(0): Using default gamma of (1.0, 1.0, 1.0) unless otherwise stated. [ 185.920] (--) NOUVEAU(0): Virtual size is 2560x1440 (pitch 0) [ 185.920] (**) NOUVEAU(0): Driver mode "2560x1440": 241.5 MHz (scaled from 0.0 MHz), 88.8 kHz, 60.0 Hz [ 185.920] (II) NOUVEAU(0): Modeline "2560x1440"x60.0 241.50 2560 2608 2640 2720 1440 1443 1448 1481 +hsync -vsync (88.8 kHz eP) [ 185.920] (**) NOUVEAU(0): Driver mode "1920x1200": 154.0 MHz (scaled from 0.0 MHz), 74.0 kHz, 60.0 Hz [ 185.920] (II) NOUVEAU(0): Modeline "1920x1200"x60.0 154.00 1920 1968 2000 2080 1200 1203 1209 1235 +hsync -vsync (74.0 kHz e) [ 185.920] (**) NOUVEAU(0): Mode "1920x1080": 172.8 MHz (scaled from 0.0 MHz), 67.1 kHz, 60.0 Hz [ 185.920] (II) NOUVEAU(0): Modeline "1920x1080"x60.0 172.78 1920 2040 2248 2576 1080 1081 1084 1118 -hsync +vsync (67.1 kHz) [ 185.920] (**) NOUVEAU(0): Driver mode "1600x1200": 162.0 MHz (scaled from 0.0 MHz), 75.0 kHz, 60.0 Hz [ 185.920] (II) NOUVEAU(0): Modeline "1600x1200"x60.0 162.00 1600 1664 1856 2160 1200 1201 1204 1250 +hsync +vsync (75.0 kHz e) [ 185.920] (**) NOUVEAU(0): Driver mode "1680x1050": 119.0 MHz (scaled from 0.0 MHz), 64.7 kHz, 59.9 Hz [ 185.920] (II) NOUVEAU(0): Modeline "1680x1050"x59.9 119.00 1680 1728 1760 1840 1050 1053 1059 1080 +hsync -vsync (64.7 kHz e) [ 185.920] (**) NOUVEAU(0): Driver mode "1280x1024": 135.0 MHz (scaled from 0.0 MHz), 80.0 kHz, 75.0 Hz [ 185.920] (II) NOUVEAU(0): Modeline "1280x1024"x75.0 135.00 1280 1296 1440 1688 1024 1025 1028 1066 +hsync +vsync (80.0 kHz e) [ 185.920] (**) NOUVEAU(0): Driver mode "1280x1024": 108.0 MHz (scaled from 0.0 MHz), 64.0 kHz, 60.0 Hz [ 185.920] (II) NOUVEAU(0): Modeline "1280x1024"x60.0 108.00 1280 1328 1440 1688 1024 1025 1028 1066 +hsync +vsync (64.0 kHz e) [ 185.920] (**) NOUVEAU(0): Driver mode "1280x800": 71.0 MHz (scaled from 0.0 MHz), 49.3 kHz, 59.9 Hz [ 185.920] (II) NOUVEAU(0): Modeline "1280x800"x59.9 71.00 1280 1328 1360 1440 800 803 809 823 +hsync -vsync (49.3 kHz e) [ 185.920] (**) NOUVEAU(0): Driver mode "1152x864": 108.0 MHz (scaled from 0.0 MHz), 67.5 kHz, 75.0 Hz [ 185.920] (II) NOUVEAU(0): Modeline "1152x864"x75.0 108.00 1152 1216 1344 1600 864 865 868 900 +hsync +vsync (67.5 kHz e) [ 185.920] (**) NOUVEAU(0): Driver mode "1024x768": 78.8 MHz (scaled from 0.0 MHz), 60.1 kHz, 75.1 Hz [ 185.920] (II) NOUVEAU(0): Modeline "1024x768"x75.1 78.80 1024 1040 1136 1312 768 769 772 800 +hsync +vsync (60.1 kHz e) [ 185.920] (**) NOUVEAU(0): Driver mode "1024x768": 65.0 MHz (scaled from 0.0 MHz), 48.4 kHz, 60.0 Hz [ 185.920] (II) NOUVEAU(0): Modeline "1024x768"x60.0 65.00 1024 1048 1184 1344 768 771 777 806 -hsync -vsync (48.4 kHz e) [ 185.920] (**) NOUVEAU(0): Driver mode "800x600": 49.5 MHz (scaled from 0.0 MHz), 46.9 kHz, 75.0 Hz [ 185.920] (II) NOUVEAU(0): Modeline "800x600"x75.0 49.50 800 816 896 1056 600 601 604 625 +hsync +vsync (46.9 kHz e) [ 185.920] (**) NOUVEAU(0): Driver mode "800x600": 40.0 MHz (scaled from 0.0 MHz), 37.9 kHz, 60.3 Hz [ 185.920] (II) NOUVEAU(0): Modeline "800x600"x60.3 40.00 800 840 968 1056 600 601 605 628 +hsync +vsync (37.9 kHz e) [ 185.920] (**) NOUVEAU(0): Driver mode "640x480": 31.5 MHz (scaled from 0.0 MHz), 37.5 kHz, 75.0 Hz [ 185.920] (II) NOUVEAU(0): Modeline "640x480"x75.0 31.50 640 656 720 840 480 481 484 500 -hsync -vsync (37.5 kHz e) [ 185.920] (**) NOUVEAU(0): Driver mode "640x480": 25.2 MHz (scaled from 0.0 MHz), 31.5 kHz, 60.0 Hz [ 185.920] (II) NOUVEAU(0): Modeline "640x480"x60.0 25.20 640 656 752 800 480 490 492 525 -hsync -vsync (31.5 kHz e) [ 185.920] (**) NOUVEAU(0): Driver mode "720x400": 28.3 MHz (scaled from 0.0 MHz), 31.5 kHz, 70.1 Hz [ 185.920] (II) NOUVEAU(0): Modeline "720x400"x70.1 28.32 720 738 846 900 400 412 414 449 -hsync +vsync (31.5 kHz e) [ 185.920] (==) NOUVEAU(0): DPI set to (96, 96) [ 185.920] (II) Loading sub module "fb" [ 185.920] (II) LoadModule: "fb" [ 185.920] (II) Loading /usr/lib/xorg/modules/libfb.so [ 185.920] (II) Module fb: vendor="X.Org Foundation" [ 185.920] compiled for 1.17.2, module version = 1.0.0 [ 185.920] ABI class: X.Org ANSI C Emulation, version 0.4 [ 185.920] (II) Loading sub module "shadowfb" [ 185.920] (II) LoadModule: "shadowfb" [ 185.921] (II) Loading /usr/lib/xorg/modules/libshadowfb.so [ 185.921] (II) Module shadowfb: vendor="X.Org Foundation" [ 185.921] compiled for 1.17.2, module version = 1.0.0 [ 185.921] ABI class: X.Org ANSI C Emulation, version 0.4 [ 185.921] (--) Depth 24 pixmap format is 32 bpp [ 185.925] (II) NOUVEAU(0): Channel setup complete. [ 185.927] (II) NOUVEAU(0): [COPY] async initialised. [ 185.927] (II) NOUVEAU(0): [DRI2] Setup complete [ 185.927] (II) NOUVEAU(0): [DRI2] DRI driver: nouveau [ 185.927] (II) NOUVEAU(0): [DRI2] VDPAU driver: nouveau [ 185.927] (II) Loading sub module "exa" [ 185.927] (II) LoadModule: "exa" [ 185.927] (II) Loading /usr/lib/xorg/modules/libexa.so [ 185.927] (II) Module exa: vendor="X.Org Foundation" [ 185.927] compiled for 1.17.2, module version = 2.6.0 [ 185.927] ABI class: X.Org Video Driver, version 19.0 [ 185.927] (II) EXA(0): Driver allocated offscreen pixmaps [ 185.927] (II) EXA(0): Driver registered support for the following operations: [ 185.927] (II) Solid [ 185.927] (II) Copy [ 185.927] (II) Composite (RENDER acceleration) [ 185.927] (II) UploadToScreen [ 185.927] (II) DownloadFromScreen [ 185.927] (==) NOUVEAU(0): Backing store enabled [ 185.928] (==) NOUVEAU(0): Silken mouse enabled [ 185.928] (II) NOUVEAU(0): [XvMC] Associated with Nouveau GeForce 8/9 Textured Video. [ 185.928] (II) NOUVEAU(0): [XvMC] Extension initialized. [ 185.928] (**) NOUVEAU(0): DPMS enabled [ 185.928] (II) NOUVEAU(0): RandR 1.2 enabled, ignore the following RandR disabled message. [ 185.928] (--) RandR disabled [ 185.959] (II) AIGLX: enabled GLX_MESA_copy_sub_buffer [ 185.959] (II) AIGLX: enabled GLX_ARB_create_context [ 185.959] (II) AIGLX: enabled GLX_ARB_create_context_profile [ 185.959] (II) AIGLX: enabled GLX_EXT_create_context_es2_profile [ 185.959] (II) AIGLX: enabled GLX_INTEL_swap_event [ 185.959] (II) AIGLX: enabled GLX_SGI_swap_control and GLX_MESA_swap_control [ 185.959] (II) AIGLX: enabled GLX_EXT_framebuffer_sRGB [ 185.959] (II) AIGLX: enabled GLX_ARB_fbconfig_float [ 185.959] (II) AIGLX: GLX_EXT_texture_from_pixmap backed by buffer objects [ 185.960] (II) AIGLX: Loaded and initialized nouveau [ 185.960] (II) GLX: Initialized DRI2 GL provider for screen 0 [ 185.964] (II) NOUVEAU(0): NVEnterVT is called. [ 185.982] (II) NOUVEAU(0): Setting screen physical size to 677 x 381 [ 185.982] resize called 2560 1440 [ 186.086] (II) config/udev: Adding input device Power Button (/dev/input/event1) [ 186.086] (**) Power Button: Applying InputClass "evdev keyboard catchall" [ 186.086] (**) Power Button: Applying InputClass "system-keyboard" [ 186.086] (II) LoadModule: "evdev" [ 186.086] (II) Loading /usr/lib/xorg/modules/input/evdev_drv.so [ 186.086] (II) Module evdev: vendor="X.Org Foundation" [ 186.086] compiled for 1.17.1, module version = 2.9.2 [ 186.086] Module class: X.Org XInput Driver [ 186.086] ABI class: X.Org XInput driver, version 21.0 [ 189.370] (II) AIGLX: Suspending AIGLX clients for VT switch [ 189.370] (II) NOUVEAU(0): NVLeaveVT is called. [ 193.746] (II) Open ACPI successful (/var/run/acpid.socket) [ 193.746] (II) AIGLX: Resuming AIGLX clients after VT switch [ 193.746] (II) NOUVEAU(0): NVEnterVT is called. [ 193.811] (II) NOUVEAU(0): EDID vendor "DEL", prod id 16510 [ 193.811] (II) NOUVEAU(0): Using hsync ranges from config file [ 193.811] (II) NOUVEAU(0): Using vrefresh ranges from config file [ 193.811] (II) NOUVEAU(0): Printing DDC gathered Modelines: [ 193.811] (II) NOUVEAU(0): Modeline "2560x1440"x0.0 241.50 2560 2608 2640 2720 1440 1443 1448 1481 +hsync -vsync (88.8 kHz eP) [ 193.811] (II) NOUVEAU(0): Modeline "800x600"x0.0 40.00 800 840 968 1056 600 601 605 628 +hsync +vsync (37.9 kHz e) [ 193.811] (II) NOUVEAU(0): Modeline "640x480"x0.0 31.50 640 656 720 840 480 481 484 500 -hsync -vsync (37.5 kHz e) [ 193.811] (II) NOUVEAU(0): Modeline "640x480"x0.0 25.18 640 656 752 800 480 490 492 525 -hsync -vsync (31.5 kHz e) [ 193.811] (II) NOUVEAU(0): Modeline "720x400"x0.0 28.32 720 738 846 900 400 412 414 449 -hsync +vsync (31.5 kHz e) [ 193.811] (II) NOUVEAU(0): Modeline "1280x1024"x0.0 135.00 1280 1296 1440 1688 1024 1025 1028 1066 +hsync +vsync (80.0 kHz e) [ 193.811] (II) NOUVEAU(0): Modeline "1024x768"x0.0 78.75 1024 1040 1136 1312 768 769 772 800 +hsync +vsync (60.0 kHz e) [ 193.811] (II) NOUVEAU(0): Modeline "1024x768"x0.0 65.00 1024 1048 1184 1344 768 771 777 806 -hsync -vsync (48.4 kHz e) [ 193.811] (II) NOUVEAU(0): Modeline "800x600"x0.0 49.50 800 816 896 1056 600 601 604 625 +hsync +vsync (46.9 kHz e) [ 193.811] (II) NOUVEAU(0): Modeline "1280x800"x0.0 71.00 1280 1328 1360 1440 800 803 809 823 +hsync -vsync (49.3 kHz e) [ 193.811] (II) NOUVEAU(0): Modeline "1680x1050"x0.0 119.00 1680 1728 1760 1840 1050 1053 1059 1080 +hsync -vsync (64.7 kHz e) [ 193.811] (II) NOUVEAU(0): Modeline "1920x1200"x0.0 154.00 1920 1968 2000 2080 1200 1203 1209 1235 +hsync -vsync (74.0 kHz e) [ 193.811] (II) NOUVEAU(0): Modeline "1152x864"x0.0 108.00 1152 1216 1344 1600 864 865 868 900 +hsync +vsync (67.5 kHz e) [ 193.811] (II) NOUVEAU(0): Modeline "1600x1200"x0.0 162.00 1600 1664 1856 2160 1200 1201 1204 1250 +hsync +vsync (75.0 kHz e) [ 193.811] (II) NOUVEAU(0): Modeline "1280x1024"x0.0 108.00 1280 1328 1440 1688 1024 1025 1028 1066 +hsync +vsync (64.0 kHz e) [ 193.811] (II) NOUVEAU(0): Modeline "1920x1080"x60.0 172.80 1920 2040 2248 2576 1080 1081 1084 1118 -hsync +vsync (67.1 kHz e) [ 196.663] (II) AIGLX: Suspending AIGLX clients for VT switch -- 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/143. |
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.
Created attachment 108436 [details] Dump of serial console during bootup... up to hang on shutdown. Summary: I can start Xorg *once* just fine, also switch to/from text-consoles. But once this X-server ends, both monitors will turn black and go to powersave. After this has happened, a new X-server will hang. Also a clean reboot is no longer possible, because also the shutdown-code running in the Kernel will hang with a similar stack trace. This bug is reproducible 100%. Hardware: NVIDIA Corporation G86 [Quadro NVS 290] (rev a1) BOOT0 : 0x086f00a2 Chipset: G86 (NV86) Family : NV50 Platform: amd64 Linux-Kernel: 3.18.0-rc1 Distribution: Arch-Linux Xorg server: xorg-server 1.16.1-1 (from Archlinux repository) Xorg driver: xf86-video-nouveau 1.0.11-2 (from Archlinux repository) Everything looks pretty unremarkable while using the computer normally running X which is very stable, can run for days. Also terminating the X server looks uneventful. *** *** Starting the second X-server hangs... *** [root@optiplex ~]# ps axf | grep X 4173 pts/1 D+ 0:00 | \_ /usr/bin/Xorg.wrap [root@optiplex ~]# cat /proc/4173/wchan rpm_resume [root@optiplex ~]# cat /proc/4173/syscall 2 0x7fffc7a788c0 0x2 0x7fffc7a788ce 0x690 0x7f0c3e0ed140 0x0 0x7fffc7a77fb0 0x7f0c3e06a330 [root@optiplex ~]# cat /proc/4173/stack [<ffffffff8146b222>] rpm_resume+0x220/0x4b7 [<ffffffff8146b4fb>] __pm_runtime_resume+0x42/0x5e [<ffffffff8143064d>] nouveau_drm_open+0x3d/0x249 [<ffffffff8138fc3d>] drm_open+0x235/0x43e [<ffffffff8139543f>] drm_stub_open+0xc1/0xee [<ffffffff81169cb1>] chrdev_open+0x151/0x18b [<ffffffff81163cde>] do_dentry_open+0x245/0x2b7 [<ffffffff81163fb3>] finish_open+0x35/0x40 [<ffffffff81171e14>] do_last.isra.32+0x83a/0xa7c [<ffffffff8117226e>] path_openat+0x218/0x5cd [<ffffffff811735fd>] do_filp_open+0x49/0xad [<ffffffff81164fec>] do_sys_open+0x15a/0x1fd [<ffffffff811650ad>] SyS_open+0x1e/0x20 [<ffffffff815c7529>] system_call_fastpath+0x12/0x17 [<ffffffffffffffff>] 0xffffffffffffffff *** *** Alternatively, after a new reboot, not trying to start a 2nd X-server, *** and shutting down the machine, this hangcheck info appears on the serial *** console two minutes after the shutdown... *** [ 240.486671] INFO: task kworker/0:3:126 blocked for more than 120 seconds. [ 240.493460] Not tainted 3.18.0-rc1-cv+ #4 [ 240.497980] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 240.505796] kworker/0:3 D ffff880127c143c0 0 126 2 0x00000000 [ 240.512849] Workqueue: pm pm_runtime_work [ 240.516858] ffff8800cb3cfbd8 0000000000000046 00000000000003ff ffff8800cb3cffd8 [ 240.524264] ffff8800cb1ae5c0 00000000000143c0 ffffffff81a18540 ffff8800cb1ae5c0 [ 240.531668] 0000000000000000 0000000000000000 0000000000000000 0000000000000000 [ 240.539087] Call Trace: [ 240.541538] [<ffffffff812b3001>] ? cpumask_next_and+0x20/0x3e [ 240.547357] [<ffffffff81082838>] ? load_balance+0x20e/0x893 [ 240.552999] [<ffffffff81019bd3>] ? native_sched_clock+0x28/0x93 [ 240.558987] [<ffffffff815c3e43>] schedule+0x69/0x6b [ 240.563936] [<ffffffff8146b222>] rpm_resume+0x220/0x4b7 [ 240.569231] [<ffffffff81088191>] ? __wake_up_sync+0x12/0x12 [ 240.574871] [<ffffffff8146b710>] pm_runtime_forbid+0x42/0x4f [ 240.580599] [<ffffffff8142f6cd>] nouveau_pmops_runtime_suspend+0x32/0xd2 [ 240.587366] [<ffffffff812e2972>] pci_pm_runtime_suspend+0x63/0x110 [ 240.593612] [<ffffffff812e290f>] ? pci_legacy_suspend+0xbe/0xbe [ 240.599598] [<ffffffff8146a40c>] __rpm_callback+0x3a/0x62 [ 240.605064] [<ffffffff8146a4a8>] rpm_callback+0x74/0x8a [ 240.610357] [<ffffffff8146aa60>] rpm_suspend+0x25b/0x459 [ 240.615738] [<ffffffff8146b9d5>] pm_runtime_work+0x7b/0x88 [ 240.621292] [<ffffffff8106a735>] process_one_work+0x1b5/0x365 [ 240.627105] [<ffffffff8106b281>] worker_thread+0x29d/0x381 [ 240.632657] [<ffffffff8106afe4>] ? rescuer_thread+0x24c/0x24c [ 240.638472] [<ffffffff8106ed95>] kthread+0xf3/0xfb [ 240.643333] [<ffffffff8106eca2>] ? kthread_create_on_node+0x1a9/0x1a9 [ 240.649839] [<ffffffff815c747c>] ret_from_fork+0x7c/0xb0 [ 240.655219] [<ffffffff8106eca2>] ? kthread_create_on_node+0x1a9/0x1a9