[ 16.073531] NET: Registered protocol family 31 [ 16.073533] Bluetooth: HCI device and connection manager initialized [ 16.073536] Bluetooth: HCI socket layer initialized [ 16.073537] Bluetooth: L2CAP socket layer initialized [ 16.073675] Bluetooth: SCO socket layer initialized [ 16.075356] Bluetooth: RFCOMM TTY layer initialized [ 16.075360] Bluetooth: RFCOMM socket layer initialized [ 16.075361] Bluetooth: RFCOMM ver 1.11 [ 16.081582] Bluetooth: BNEP (Ethernet Emulation) ver 1.3 [ 16.081585] Bluetooth: BNEP filters: protocol multicast [ 16.645298] EXT4-fs (sda1): re-mounted. Opts: errors=remount-ro,user_xattr,commit=0 [ 16.662437] EXT4-fs (sdb1): re-mounted. Opts: commit=0 [ 21.533988] EXT4-fs (sda1): re-mounted. Opts: errors=remount-ro,user_xattr,commit=0 [ 21.541208] EXT4-fs (sdb1): re-mounted. Opts: commit=0 [ 26.220017] eth0: no IPv6 routers present [ 84.180592] exe (2206): /proc/2206/oom_adj is deprecated, please use /proc/2206/oom_score_adj instead. [ 1704.861780] show_signal_msg: 21 callbacks suppressed [ 1704.861786] oosplash.bin[3546]: segfault at 968 ip 00007fd8a3d5de56 sp 00007fff1982bc10 error 4 in libX11.so.6.3.0[7fd8a3d24000+133000] [ 3857.088574] nautilus[1727] general protection ip:4c0cbe sp:7fff5f56f0d0 error:0 in nautilus[400000+15b000] [ 4502.089119] nautilus[4412] general protection ip:4c0cbe sp:7fff19f9c960 error:0 in nautilus[400000+15b000] [ 8361.132916] EXT4-fs (sda1): re-mounted. Opts: errors=remount-ro,user_xattr,commit=0 [ 8361.256660] EXT4-fs (sdb1): re-mounted. Opts: commit=0 [ 8362.922431] PM: Syncing filesystems ... done. [ 8362.925280] PM: Preparing system for mem sleep [ 8363.270958] Freezing user space processes ... (elapsed 0.01 seconds) done. [ 8363.290099] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done. [ 8363.310092] PM: Entering mem sleep [ 8363.310130] Suspending console(s) (use no_console_suspend to debug) [ 8363.310529] sd 2:0:0:0: [sdc] Synchronizing SCSI cache [ 8363.310580] sd 1:0:0:0: [sdb] Synchronizing SCSI cache [ 8363.310707] sd 0:0:0:0: [sda] Synchronizing SCSI cache [ 8363.310825] sd 2:0:0:0: [sdc] Stopping disk [ 8363.310899] sd 1:0:0:0: [sdb] Stopping disk [ 8363.311001] serial 00:0a: disabled [ 8363.311005] serial 00:0a: wake-up capability disabled by ACPI [ 8363.311196] sd 0:0:0:0: [sda] Stopping disk [ 8363.311199] parport_pc 00:05: disabled [ 8363.311306] [drm] nouveau 0000:02:00.0: Disabling fbcon acceleration... [ 8363.311308] [drm] nouveau 0000:02:00.0: Unpinning framebuffer(s)... [ 8363.311330] ehci_hcd 0000:01:07.2: PCI INT C disabled [ 8363.311341] uhci_hcd 0000:01:07.1: PCI INT B disabled [ 8363.311347] uhci_hcd 0000:01:07.0: PCI INT A disabled [ 8363.311390] [drm] nouveau 0000:02:00.0: Evicting buffers... [ 8363.330112] ohci_hcd 0000:00:02.0: PCI INT A disabled [ 8363.350068] ehci_hcd 0000:00:02.1: PCI INT B disabled [ 8363.592645] PM: suspend of drv:sd dev:0:0:0:0 complete after 281.933 msecs [ 8363.592710] PM: suspend of drv:scsi dev:target0:0:0 complete after 281.945 msecs [ 8363.592724] PM: suspend of drv:scsi dev:host0 complete after 281.840 msecs [ 8363.834040] [drm] nouveau 0000:02:00.0: Idling channels... [ 8363.834256] [drm] nouveau 0000:02:00.0: Suspending GPU objects... [ 8363.890060] HDA Intel 0000:00:05.0: PCI INT B disabled [ 8363.910067] PM: suspend of drv:HDA Intel dev:0000:00:05.0 complete after 598.360 msecs [ 8364.310087] PM: suspend of drv:sd dev:2:0:0:0 complete after 999.558 msecs [ 8364.310102] PM: suspend of drv:scsi dev:target2:0:0 complete after 999.549 msecs [ 8364.310108] PM: suspend of drv:scsi dev:host2 complete after 999.262 msecs [ 8364.310161] sata_nv 0000:00:08.1: PCI INT B disabled [ 8364.310277] PM: suspend of drv:sd dev:1:0:0:0 complete after 999.700 msecs [ 8364.310286] PM: suspend of drv:scsi dev:target1:0:0 complete after 999.634 msecs [ 8364.310291] PM: suspend of drv:scsi dev:host1 complete after 999.426 msecs [ 8364.310345] sata_nv 0000:00:08.0: PCI INT A disabled [ 8364.330046] PM: suspend of drv:sata_nv dev:0000:00:08.0 complete after 1018.658 msecs [ 8364.330060] PM: suspend of drv:sata_nv dev:0000:00:08.1 complete after 1018.699 msecs [ 8364.915787] [drm] nouveau 0000:02:00.0: And we're gone! [ 8364.915815] nouveau 0000:02:00.0: PCI INT A disabled [ 8364.930047] PM: suspend of drv:nouveau dev:0000:02:00.0 complete after 1618.789 msecs [ 8364.930087] PM: suspend of drv:pcieport dev:0000:00:09.0 complete after 1618.723 msecs [ 8364.930101] PM: suspend of drv: dev:pci0000:00 complete after 1618.309 msecs [ 8364.930110] PM: suspend of devices complete after 1619.754 msecs [ 8364.930112] PM: suspend devices took 1.620 seconds [ 8365.050146] PM: late suspend of devices complete after 120.027 msecs [ 8365.050210] ACPI: Preparing to enter system sleep state S3 [ 8365.050964] PM: Saving platform NVS memory [ 8365.051380] Disabling non-boot CPUs ... [ 8365.052476] Broke affinity for irq 21 [ 8365.160035] CPU 1 is now offline [ 8365.160360] Extended CMOS year: 2000 [ 8365.160360] ACPI: Low-level resume complete [ 8365.160360] PM: Restoring platform NVS memory [ 8365.160360] PCI-DMA: Resuming GART IOMMU [ 8365.160360] PCI-DMA: Restoring GART aperture settings [ 8365.160360] Extended CMOS year: 2000 [ 8365.160360] Enabling non-boot CPUs ... [ 8365.160360] Booting Node 0 Processor 1 APIC 0x1 [ 8365.160360] smpboot cpu 1: start_ip = 96000 [ 8365.350031] Switched to NOHz mode on CPU #1 [ 8365.350117] CPU1 is up [ 8365.350478] ACPI: Waking up from system sleep state S3 [ 8365.351455] ohci_hcd 0000:00:02.0: restoring config space at offset 0x1 (was 0xb00007, writing 0xb00003) [ 8365.351475] ehci_hcd 0000:00:02.1: restoring config space at offset 0x1 (was 0xb00006, writing 0xb00002) [ 8365.351535] pci 0000:00:00.0: Found enabled HT MSI Mapping [ 8365.351549] HDA Intel 0000:00:05.0: restoring config space at offset 0x1 (was 0xb00006, writing 0xb00002) [ 8365.351597] pci 0000:00:00.0: Found enabled HT MSI Mapping [ 8365.351674] pci 0000:00:00.0: Found enabled HT MSI Mapping [ 8365.351736] pci 0000:00:00.0: Found enabled HT MSI Mapping [ 8365.351797] pci 0000:00:00.0: Found enabled HT MSI Mapping [ 8365.351808] pcieport 0000:00:09.0: restoring config space at offset 0x1 (was 0x100007, writing 0x100407) [ 8365.351871] pci 0000:00:00.0: Found enabled HT MSI Mapping [ 8365.351882] pcieport 0000:00:0b.0: restoring config space at offset 0x1 (was 0x100004, writing 0x100404) [ 8365.351947] pci 0000:00:00.0: Found enabled HT MSI Mapping [ 8365.351958] pcieport 0000:00:0c.0: restoring config space at offset 0x1 (was 0x100004, writing 0x100404) [ 8365.352025] pci 0000:00:00.0: Found enabled HT MSI Mapping [ 8365.352062] uhci_hcd 0000:01:07.0: restoring config space at offset 0x1 (was 0x2100117, writing 0x2100113) [ 8365.352084] uhci_hcd 0000:01:07.1: restoring config space at offset 0x1 (was 0x2100117, writing 0x2100113) [ 8365.352105] ehci_hcd 0000:01:07.2: restoring config space at offset 0x1 (was 0x2100117, writing 0x2100113) [ 8365.352119] nouveau 0000:02:00.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [ 8365.352123] nouveau 0000:02:00.0: restoring config space at offset 0xc (was 0x0, writing 0xdefe0000) [ 8365.352127] nouveau 0000:02:00.0: restoring config space at offset 0x9 (was 0x1, writing 0xec01) [ 8365.352131] nouveau 0000:02:00.0: restoring config space at offset 0x7 (was 0x4, writing 0xdc000004) [ 8365.352134] nouveau 0000:02:00.0: restoring config space at offset 0x5 (was 0xc, writing 0xc000000c) [ 8365.352137] nouveau 0000:02:00.0: restoring config space at offset 0x4 (was 0x0, writing 0xdf000000) [ 8365.352139] nouveau 0000:02:00.0: restoring config space at offset 0x3 (was 0x0, writing 0x10) [ 8365.352143] nouveau 0000:02:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100007) [ 8365.352280] PM: early resume of devices complete after 0.977 msecs [ 8365.352403] ohci_hcd 0000:00:02.0: PCI INT A -> Link[LUB0] -> GSI 20 (level, low) -> IRQ 20 [ 8365.352408] ohci_hcd 0000:00:02.0: setting latency timer to 64 [ 8365.352426] pci 0000:00:04.0: setting latency timer to 64 [ 8365.352424] ehci_hcd 0000:00:02.1: PCI INT B -> Link[LUB2] -> GSI 21 (level, low) -> IRQ 21 [ 8365.352430] ehci_hcd 0000:00:02.1: setting latency timer to 64 [ 8365.352437] HDA Intel 0000:00:05.0: PCI INT B -> Link[LAZA] -> GSI 22 (level, low) -> IRQ 22 [ 8365.352440] HDA Intel 0000:00:05.0: setting latency timer to 64 [ 8365.352464] pata_amd 0000:00:06.0: setting latency timer to 64 [ 8365.352711] sata_nv 0000:00:08.0: PCI INT A -> Link[LSA0] -> GSI 23 (level, low) -> IRQ 23 [ 8365.352713] sata_nv 0000:00:08.0: setting latency timer to 64 [ 8365.352725] sata_nv 0000:00:08.1: PCI INT B -> Link[LSA1] -> GSI 22 (level, low) -> IRQ 22 [ 8365.352728] sata_nv 0000:00:08.1: setting latency timer to 64 [ 8365.352750] uhci_hcd 0000:01:07.0: PCI INT A -> Link[LNKB] -> GSI 18 (level, low) -> IRQ 18 [ 8365.352769] usb usb4: root hub lost power or was reset [ 8365.352779] uhci_hcd 0000:01:07.1: PCI INT B -> Link[LNKC] -> GSI 17 (level, low) -> IRQ 17 [ 8365.352796] usb usb5: root hub lost power or was reset [ 8365.352805] ehci_hcd 0000:01:07.2: PCI INT C -> Link[LNKD] -> GSI 19 (level, low) -> IRQ 19 [ 8365.352821] usb usb2: root hub lost power or was reset [ 8365.352831] [drm] nouveau 0000:02:00.0: We're back, enabling device... [ 8365.352835] nouveau 0000:02:00.0: PCI INT A -> Link[LNED] -> GSI 16 (level, low) -> IRQ 16 [ 8365.352838] nouveau 0000:02:00.0: setting latency timer to 64 [ 8365.352840] [drm] nouveau 0000:02:00.0: POSTing device... [ 8365.352843] [drm] nouveau 0000:02:00.0: Parsing VBIOS init table 0 at offset 0xC5D1 [ 8365.353158] ata6: port disabled. ignoring. [ 8365.354208] parport_pc 00:05: activated [ 8365.354913] serial 00:0a: activated [ 8365.360347] sd 0:0:0:0: [sda] Starting disk [ 8365.360735] sd 1:0:0:0: [sdb] Starting disk [ 8365.360774] sd 2:0:0:0: [sdc] Starting disk [ 8365.380113] [drm] nouveau 0000:02:00.0: 0xDD54: i2c wr fail: -6 [ 8365.380122] [drm] nouveau 0000:02:00.0: Parsing VBIOS init table 1 at offset 0xCB70 [ 8365.390201] Extended CMOS year: 2000 [ 8365.422972] [drm] nouveau 0000:02:00.0: Parsing VBIOS init table 2 at offset 0xD8D8 [ 8365.422999] [drm] nouveau 0000:02:00.0: Parsing VBIOS init table 3 at offset 0xD9D6 [ 8365.424094] [drm] nouveau 0000:02:00.0: Parsing VBIOS init table 4 at offset 0xDC3E [ 8365.424096] [drm] nouveau 0000:02:00.0: Parsing VBIOS init table at offset 0xDCA3 [ 8365.444108] [drm] nouveau 0000:02:00.0: Restoring GPU objects... [ 8365.497745] [drm] nouveau 0000:02:00.0: Reinitialising engines... [ 8365.497786] [drm] nouveau 0000:02:00.0: Restoring mode... [ 8365.500078] PM: resume of drv:hub dev:2-0:1.0 complete after 144.967 msecs [ 8365.500084] PM: resume of drv: dev:ep_00 complete after 140.019 msecs [ 8365.500088] PM: resume of drv: dev:ep_81 complete after 144.980 msecs [ 8365.500111] PM: resume of drv:hub dev:3-0:1.0 complete after 140.027 msecs [ 8365.500116] PM: resume of drv: dev:ep_00 complete after 140.017 msecs [ 8365.500122] PM: resume of drv: dev:ep_81 complete after 140.031 msecs [ 8365.523227] PM: resume of drv:nouveau dev:0000:02:00.0 complete after 170.401 msecs [ 8365.570074] PM: resume of drv:hub dev:1-0:1.0 complete after 214.975 msecs [ 8365.570106] PM: resume of drv: dev:ep_00 complete after 215.003 msecs [ 8365.570135] PM: resume of drv: dev:ep_81 complete after 215.039 msecs [ 8365.570164] PM: resume of drv: dev:ep_00 complete after 209.443 msecs [ 8365.570167] PM: resume of drv:usb dev:1-4:1.1 complete after 209.489 msecs [ 8365.570170] PM: resume of drv:usb-storage dev:1-4:1.0 complete after 209.584 msecs [ 8365.570175] PM: resume of drv: dev:ep_85 complete after 209.484 msecs [ 8365.570180] PM: resume of drv: dev:ep_84 complete after 209.536 msecs [ 8365.570183] PM: resume of drv: dev:ep_05 complete after 209.477 msecs [ 8365.570191] PM: resume of drv: dev:ep_04 complete after 209.530 msecs [ 8365.570194] PM: resume of drv:scsi dev:host6 complete after 209.277 msecs [ 8365.570204] PM: resume of drv:scsi dev:target6:0:0 complete after 209.258 msecs [ 8365.570210] PM: resume of drv:scsi_host dev:host6 complete after 209.280 msecs [ 8365.570218] PM: resume of drv:sd dev:6:0:0:0 complete after 209.257 msecs [ 8365.570224] PM: resume of drv:scsi_device dev:6:0:0:0 complete after 209.249 msecs [ 8365.575123] PM: resume of drv:usbhid dev:3-9:1.1 complete after 214.262 msecs [ 8365.575139] PM: resume of drv: dev:ep_82 complete after 214.263 msecs [ 8365.575143] PM: resume of drv:usbhid dev:3-9:1.0 complete after 214.310 msecs [ 8365.575172] PM: resume of drv: dev:ep_00 complete after 214.275 msecs [ 8365.575196] PM: resume of drv: dev:ep_81 complete after 214.354 msecs [ 8365.579191] PM: resume of drv:uvcvideo dev:1-3:1.0 complete after 218.938 msecs [ 8365.579205] PM: resume of drv: dev:ep_87 complete after 218.938 msecs [ 8365.579208] PM: resume of drv: dev:ep_00 complete after 218.879 msecs [ 8365.579233] PM: resume of drv:uvcvideo dev:1-3:1.1 complete after 218.952 msecs [ 8365.579236] PM: resume of drv:snd-usb-audio dev:1-3:1.3 complete after 218.923 msecs [ 8365.579238] PM: resume of drv:snd-usb-audio dev:1-3:1.2 complete after 218.943 msecs [ 8365.600096] PM: resume of drv: dev:ep_00 complete after 239.889 msecs [ 8365.600120] PM: resume of drv:hub dev:4-0:1.0 complete after 239.994 msecs [ 8365.600124] PM: resume of drv:hub dev:5-0:1.0 complete after 239.968 msecs [ 8365.600128] PM: resume of drv: dev:ep_00 complete after 239.997 msecs [ 8365.600131] PM: resume of drv: dev:ep_81 complete after 240.008 msecs [ 8365.600133] PM: resume of drv: dev:ep_81 complete after 239.978 msecs [ 8365.840071] ata4: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [ 8365.860183] ata4.00: ACPI cmd ef/03:46:00:00:00:a0 (SET FEATURES) filtered out [ 8365.860186] ata4.00: ACPI cmd f5/00:00:00:00:00:00 (SECURITY FREEZE LOCK) filtered out [ 8365.900197] ata4.00: configured for UDMA/100 [ 8370.880049] ata2: link is slow to respond, please be patient (ready=0) [ 8370.880058] ata1: link is slow to respond, please be patient (ready=0) [ 8370.880065] ata3: link is slow to respond, please be patient (ready=0) [ 8375.380051] ata2: SRST failed (errno=-16) [ 8375.380065] ata1: SRST failed (errno=-16) [ 8375.380078] ata3: SRST failed (errno=-16) [ 8375.870074] ata2: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [ 8375.870081] ata3: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [ 8375.870164] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [ 8375.890172] ata3.00: ACPI cmd ef/03:46:00:00:00:a0 (SET FEATURES) filtered out [ 8375.890176] ata3.00: ACPI cmd f5/00:00:00:00:00:00 (SECURITY FREEZE LOCK) filtered out [ 8375.890183] ata2.00: ACPI cmd ef/03:46:00:00:00:a0 (SET FEATURES) filtered out [ 8375.890186] ata2.00: ACPI cmd f5/00:00:00:00:00:00 (SECURITY FREEZE LOCK) filtered out [ 8375.890346] ata1.00: ACPI cmd ef/03:46:00:00:00:a0 (SET FEATURES) filtered out [ 8375.890349] ata1.00: ACPI cmd f5/00:00:00:00:00:00 (SECURITY FREEZE LOCK) filtered out [ 8375.930363] ata1.00: configured for UDMA/133 [ 8375.942596] PM: resume of drv:sd dev:0:0:0:0 complete after 10582.250 msecs [ 8375.942631] PM: resume of drv:scsi_device dev:0:0:0:0 complete after 10582.162 msecs [ 8375.942659] PM: resume of drv:scsi_disk dev:0:0:0:0 complete after 10501.728 msecs [ 8375.960533] ata2.00: configured for UDMA/133 [ 8375.970529] ata3.00: configured for UDMA/133 [ 8375.977185] PM: resume of drv:sd dev:1:0:0:0 complete after 10616.445 msecs [ 8375.977234] PM: resume of drv:scsi_device dev:1:0:0:0 complete after 10616.470 msecs [ 8375.987443] PM: resume of drv:sd dev:2:0:0:0 complete after 10626.664 msecs [ 8375.987482] PM: resume of drv:scsi_device dev:2:0:0:0 complete after 10626.680 msecs [ 8375.987575] PM: resume of devices complete after 10635.236 msecs [ 8375.987699] PM: resume devices took 10.630 seconds [ 8375.987701] ------------[ cut here ]------------ [ 8375.987706] WARNING: at /build/buildd/linux-3.0.0/kernel/power/suspend_test.c:53 suspend_test_finish+0x86/0x90() [ 8375.987708] Hardware name: System Product Name [ 8375.987709] Component: resume devices, time: 10630 [ 8375.987710] Modules linked in: snd_hda_codec_realtek bnep rfcomm bluetooth speedstep_lib binfmt_misc ppdev joydev snd_usb_audio snd_usbmidi_lib uvcvideo videodev v4l2_compat_ioctl32 snd_hda_intel snd_hda_codec snd_hwdep snd_pcm parport_pc psmouse asus_atk0110 serio_raw snd_seq_midi snd_rawmidi snd_seq_midi_event snd_seq snd_timer snd_seq_device snd edac_core edac_mce_amd soundcore snd_page_alloc i2c_nforce2 lp parport vesafb nouveau ttm drm_kms_helper drm usb_storage i2c_algo_bit mxm_wmi wmi usbhid hid uas video pata_amd forcedeth sata_nv [ 8375.987736] Pid: 6279, comm: pm-suspend Not tainted 3.0.0-9-generic #14-Ubuntu [ 8375.987738] Call Trace: [ 8375.987743] [] warn_slowpath_common+0x7f/0xc0 [ 8375.987745] [] warn_slowpath_fmt+0x46/0x50 [ 8375.987747] [] suspend_test_finish+0x86/0x90 [ 8375.987749] [] suspend_devices_and_enter+0xca/0x1b0 [ 8375.987751] [] enter_state+0x11d/0x150 [ 8375.987753] [] state_store+0xb7/0xf0 [ 8375.987756] [] kobj_attr_store+0xf/0x30 [ 8375.987759] [] sysfs_write_file+0xef/0x170 [ 8375.987762] [] vfs_write+0xb3/0x180 [ 8375.987764] [] sys_write+0x4a/0x90 [ 8375.987767] [] system_call_fastpath+0x16/0x1b [ 8375.987769] ---[ end trace b541a23aa1ac58d7 ]--- [ 8375.987827] PM: Finishing wakeup. [ 8375.987828] Restarting tasks ... [ 8375.987896] usb 1-4: USB disconnect, device number 3 [ 8375.989438] done. [ 8377.536957] EXT4-fs (sda1): re-mounted. Opts: errors=remount-ro,user_xattr,commit=0 [ 8377.546367] EXT4-fs (sdb1): re-mounted. Opts: commit=0 [ 8377.610500] forcedeth 0000:00:07.0: irq 43 for MSI/MSI-X [ 8388.430043] eth0: no IPv6 routers present [ 8799.120663] [drm] nouveau 0000:02:00.0: PGRAPH - DATA_ERROR XY_OUT_OF_BOUNDS [ 8799.120677] [drm] nouveau 0000:02:00.0: PGRAPH - DATA_ERROR [ 8799.120688] [drm] nouveau 0000:02:00.0: PGRAPH - ch 5 (0x00052dc000) subc 7 class 0x5039 mthd 0x0328 data 0x00000000 [10618.221122] oosplash.bin[7406]: segfault at 968 ip 00007f0b682bee56 sp 00007fff5c17d130 error 4 in libX11.so.6.3.0[7f0b68285000+133000] [11922.716734] [drm:drm_edid_block_valid] *ERROR* EDID checksum is invalid, remainder is 128 [11922.716744] Raw EDID: [11922.716751] <3>00 ff ff ff ff ff ff 00 5a 63 22 38 01 01 01 01 ........Zc"8.... [11922.716757] <3>1d 13 01 03 80 34 1d 38 2e ae 95 a5 15 08 9b 26 .....4.8.......& [11922.716764] <3>12 10 14 bf af 80 91 80 b3 00 a9 00 95 00 90 00 ................ [11922.716770] <3>81 80 81 00 31 0f 02 3a 80 18 31 38 2d 00 18 2c ....1..:..18-.., [11922.716775] <3>05 00 08 22 21 00 00 1e 00 00 00 bf 00 12 34 06 ..."!.........4. [11922.716781] <3>30 39 32 39 30 32 32 31 30 0a 00 00 00 bd 00 32 092902210......2 [11922.716787] <3>0b 0f 12 12 00 0a 20 20 20 20 20 20 00 00 00 bc ...... .... [11922.716792] <3>00 16 18 32 34 33 33 37 2d 0a 20 20 20 20 01 2c ...24337-. ., [11922.716797] [13044.607601] EXT4-fs (sda1): re-mounted. Opts: errors=remount-ro,user_xattr,commit=0 [13044.617395] EXT4-fs (sdb1): re-mounted. Opts: commit=0 [13045.601043] PM: Syncing filesystems ... done. [13045.605491] PM: Preparing system for mem sleep [13046.031442] Freezing user space processes ... (elapsed 0.01 seconds) done. [13046.050101] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done. [13046.070094] PM: Entering mem sleep [13046.070139] Suspending console(s) (use no_console_suspend to debug) [13046.070528] sd 2:0:0:0: [sdc] Synchronizing SCSI cache [13046.070641] sd 1:0:0:0: [sdb] Synchronizing SCSI cache [13046.070723] sd 0:0:0:0: [sda] Synchronizing SCSI cache [13046.070839] sd 2:0:0:0: [sdc] Stopping disk [13046.070882] sd 0:0:0:0: [sda] Stopping disk [13046.070937] sd 1:0:0:0: [sdb] Stopping disk [13046.071037] serial 00:0a: disabled [13046.071042] serial 00:0a: wake-up capability disabled by ACPI [13046.071269] parport_pc 00:05: disabled [13046.071334] [drm] nouveau 0000:02:00.0: Disabling fbcon acceleration... [13046.071339] [drm] nouveau 0000:02:00.0: Unpinning framebuffer(s)... [13046.071385] [drm] nouveau 0000:02:00.0: Evicting buffers... [13046.071440] ehci_hcd 0000:01:07.2: PCI INT C disabled [13046.071452] uhci_hcd 0000:01:07.1: PCI INT B disabled [13046.071454] uhci_hcd 0000:01:07.0: PCI INT A disabled [13046.090116] ohci_hcd 0000:00:02.0: PCI INT A disabled [13046.110058] ehci_hcd 0000:00:02.1: PCI INT B disabled [13046.305577] [drm] nouveau 0000:02:00.0: Idling channels... [13046.305793] [drm] nouveau 0000:02:00.0: Suspending GPU objects... [13046.353138] PM: suspend of drv:sd dev:0:0:0:0 complete after 282.412 msecs [13046.353182] PM: suspend of drv:scsi dev:target0:0:0 complete after 282.401 msecs [13046.353195] PM: suspend of drv:scsi dev:host0 complete after 282.175 msecs [13046.610059] HDA Intel 0000:00:05.0: PCI INT B disabled [13046.630046] PM: suspend of drv:HDA Intel dev:0000:00:05.0 complete after 558.243 msecs [13047.070273] PM: suspend of drv:sd dev:2:0:0:0 complete after 999.747 msecs [13047.070291] PM: suspend of drv:sd dev:1:0:0:0 complete after 999.653 msecs [13047.070300] PM: suspend of drv:scsi dev:target1:0:0 complete after 999.598 msecs [13047.070306] PM: suspend of drv:scsi dev:host1 complete after 999.306 msecs [13047.070363] sata_nv 0000:00:08.0: PCI INT A disabled [13047.070397] PM: suspend of drv:scsi dev:target2:0:0 complete after 999.779 msecs [13047.070404] PM: suspend of drv:scsi dev:host2 complete after 999.472 msecs [13047.070447] sata_nv 0000:00:08.1: PCI INT B disabled [13047.090047] PM: suspend of drv:sata_nv dev:0000:00:08.1 complete after 1018.576 msecs [13047.090059] PM: suspend of drv:sata_nv dev:0000:00:08.0 complete after 1018.569 msecs [13047.388068] [drm] nouveau 0000:02:00.0: And we're gone! [13047.388096] nouveau 0000:02:00.0: PCI INT A disabled [13047.400050] PM: suspend of drv:nouveau dev:0000:02:00.0 complete after 1328.728 msecs [13047.400092] PM: suspend of drv:pcieport dev:0000:00:09.0 complete after 1328.622 msecs [13047.400106] PM: suspend of drv: dev:pci0000:00 complete after 1328.260 msecs [13047.400117] PM: suspend of devices complete after 1329.749 msecs [13047.400119] PM: suspend devices took 1.330 seconds [13047.520138] PM: late suspend of devices complete after 120.012 msecs [13047.520201] ACPI: Preparing to enter system sleep state S3 [13047.520944] PM: Saving platform NVS memory [13047.521370] Disabling non-boot CPUs ... [13047.630036] CPU 1 is now offline [13047.630346] Extended CMOS year: 2000 [13047.630346] ACPI: Low-level resume complete [13047.630346] PM: Restoring platform NVS memory [13047.630346] PCI-DMA: Resuming GART IOMMU [13047.630346] PCI-DMA: Restoring GART aperture settings [13047.630346] Extended CMOS year: 2000 [13047.630346] Enabling non-boot CPUs ... [13047.630346] Booting Node 0 Processor 1 APIC 0x1 [13047.630346] smpboot cpu 1: start_ip = 96000 [13047.820030] Switched to NOHz mode on CPU #1 [13047.820115] CPU1 is up [13047.820492] ACPI: Waking up from system sleep state S3 [13047.821470] ohci_hcd 0000:00:02.0: restoring config space at offset 0x1 (was 0xb00007, writing 0xb00003) [13047.821491] ehci_hcd 0000:00:02.1: restoring config space at offset 0x1 (was 0xb00006, writing 0xb00002) [13047.821505] pci 0000:00:04.0: restoring config space at offset 0xf (was 0x2020000, writing 0x6020000) [13047.821554] pci 0000:00:00.0: Found enabled HT MSI Mapping [13047.821567] HDA Intel 0000:00:05.0: restoring config space at offset 0x1 (was 0xb00006, writing 0xb00002) [13047.821615] pci 0000:00:00.0: Found enabled HT MSI Mapping [13047.821692] pci 0000:00:00.0: Found enabled HT MSI Mapping [13047.821754] pci 0000:00:00.0: Found enabled HT MSI Mapping [13047.821816] pci 0000:00:00.0: Found enabled HT MSI Mapping [13047.821826] pcieport 0000:00:09.0: restoring config space at offset 0x1 (was 0x100007, writing 0x100407) [13047.821889] pci 0000:00:00.0: Found enabled HT MSI Mapping [13047.821900] pcieport 0000:00:0b.0: restoring config space at offset 0x1 (was 0x100004, writing 0x100404) [13047.821965] pci 0000:00:00.0: Found enabled HT MSI Mapping [13047.821976] pcieport 0000:00:0c.0: restoring config space at offset 0x1 (was 0x100004, writing 0x100404) [13047.822043] pci 0000:00:00.0: Found enabled HT MSI Mapping [13047.822080] uhci_hcd 0000:01:07.0: restoring config space at offset 0x1 (was 0x2100117, writing 0x2100113) [13047.822102] uhci_hcd 0000:01:07.1: restoring config space at offset 0x1 (was 0x2100117, writing 0x2100113) [13047.822123] ehci_hcd 0000:01:07.2: restoring config space at offset 0x1 (was 0x2100117, writing 0x2100113) [13047.822137] nouveau 0000:02:00.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [13047.822141] nouveau 0000:02:00.0: restoring config space at offset 0xc (was 0x0, writing 0xdefe0000) [13047.822145] nouveau 0000:02:00.0: restoring config space at offset 0x9 (was 0x1, writing 0xec01) [13047.822148] nouveau 0000:02:00.0: restoring config space at offset 0x7 (was 0x4, writing 0xdc000004) [13047.822151] nouveau 0000:02:00.0: restoring config space at offset 0x5 (was 0xc, writing 0xc000000c) [13047.822154] nouveau 0000:02:00.0: restoring config space at offset 0x4 (was 0x0, writing 0xdf000000) [13047.822157] nouveau 0000:02:00.0: restoring config space at offset 0x3 (was 0x0, writing 0x10) [13047.822160] nouveau 0000:02:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100007) [13047.822290] PM: early resume of devices complete after 0.971 msecs [13047.822413] ohci_hcd 0000:00:02.0: PCI INT A -> Link[LUB0] -> GSI 20 (level, low) -> IRQ 20 [13047.822419] ohci_hcd 0000:00:02.0: setting latency timer to 64 [13047.822437] ehci_hcd 0000:00:02.1: PCI INT B -> Link[LUB2] -> GSI 21 (level, low) -> IRQ 21 [13047.822439] pci 0000:00:04.0: setting latency timer to 64 [13047.822446] ehci_hcd 0000:00:02.1: setting latency timer to 64 [13047.822450] HDA Intel 0000:00:05.0: PCI INT B -> Link[LAZA] -> GSI 22 (level, low) -> IRQ 22 [13047.822453] HDA Intel 0000:00:05.0: setting latency timer to 64 [13047.822463] pata_amd 0000:00:06.0: setting latency timer to 64 [13047.822495] sata_nv 0000:00:08.0: PCI INT A -> Link[LSA0] -> GSI 23 (level, low) -> IRQ 23 [13047.822507] sata_nv 0000:00:08.0: setting latency timer to 64 [13047.822563] sata_nv 0000:00:08.1: PCI INT B -> Link[LSA1] -> GSI 22 (level, low) -> IRQ 22 [13047.822585] sata_nv 0000:00:08.1: setting latency timer to 64 [13047.822634] uhci_hcd 0000:01:07.0: PCI INT A -> Link[LNKB] -> GSI 18 (level, low) -> IRQ 18 [13047.822710] uhci_hcd 0000:01:07.1: PCI INT B -> Link[LNKC] -> GSI 17 (level, low) -> IRQ 17 [13047.822711] usb usb4: root hub lost power or was reset [13047.822722] ehci_hcd 0000:01:07.2: PCI INT C -> Link[LNKD] -> GSI 19 (level, low) -> IRQ 19 [13047.822734] usb usb5: root hub lost power or was reset [13047.822743] [drm] nouveau 0000:02:00.0: We're back, enabling device... [13047.822740] usb usb2: root hub lost power or was reset [13047.822748] nouveau 0000:02:00.0: PCI INT A -> Link[LNED] -> GSI 16 (level, low) -> IRQ 16 [13047.822752] nouveau 0000:02:00.0: setting latency timer to 64 [13047.822754] [drm] nouveau 0000:02:00.0: POSTing device... [13047.822757] [drm] nouveau 0000:02:00.0: Parsing VBIOS init table 0 at offset 0xC5D1 [13047.823835] parport_pc 00:05: activated [13047.824541] serial 00:0a: activated [13047.824722] ata6: port disabled. ignoring. [13047.824921] sd 0:0:0:0: [sda] Starting disk [13047.824962] sd 1:0:0:0: [sdb] Starting disk [13047.824993] sd 2:0:0:0: [sdc] Starting disk [13047.850031] [drm] nouveau 0000:02:00.0: 0xDD54: i2c wr fail: -6 [13047.850040] [drm] nouveau 0000:02:00.0: Parsing VBIOS init table 1 at offset 0xCB70 [13047.860254] Extended CMOS year: 2000 [13047.892891] [drm] nouveau 0000:02:00.0: Parsing VBIOS init table 2 at offset 0xD8D8 [13047.892918] [drm] nouveau 0000:02:00.0: Parsing VBIOS init table 3 at offset 0xD9D6 [13047.894013] [drm] nouveau 0000:02:00.0: Parsing VBIOS init table 4 at offset 0xDC3E [13047.894015] [drm] nouveau 0000:02:00.0: Parsing VBIOS init table at offset 0xDCA3 [13047.914026] [drm] nouveau 0000:02:00.0: Restoring GPU objects... [13047.930080] PM: resume of drv:hub dev:1-0:1.0 complete after 105.407 msecs [13047.930087] PM: resume of drv: dev:ep_00 complete after 105.338 msecs [13047.930102] PM: resume of drv: dev:ep_81 complete after 105.383 msecs [13047.939183] PM: resume of drv:uvcvideo dev:1-3:1.0 complete after 114.316 msecs [13047.939189] PM: resume of drv:uvcvideo dev:1-3:1.1 complete after 114.305 msecs [13047.939193] PM: resume of drv:snd-usb-audio dev:1-3:1.2 complete after 114.299 msecs [13047.939197] PM: resume of drv:snd-usb-audio dev:1-3:1.3 complete after 114.292 msecs [13047.939201] PM: resume of drv: dev:ep_00 complete after 114.283 msecs [13047.939204] PM: resume of drv: dev:ep_87 complete after 114.331 msecs [13047.967731] [drm] nouveau 0000:02:00.0: Reinitialising engines... [13047.967772] [drm] nouveau 0000:02:00.0: Restoring mode... [13047.970076] PM: resume of drv:hub dev:2-0:1.0 complete after 145.315 msecs [13047.970082] PM: resume of drv: dev:ep_00 complete after 145.321 msecs [13047.970086] PM: resume of drv: dev:ep_81 complete after 145.327 msecs [13047.970110] PM: resume of drv:hub dev:3-0:1.0 complete after 145.344 msecs [13047.970114] PM: resume of drv: dev:ep_00 complete after 145.344 msecs [13047.970129] PM: resume of drv: dev:ep_81 complete after 145.361 msecs [13047.975108] PM: resume of drv:usbhid dev:3-9:1.0 complete after 150.060 msecs [13047.975113] PM: resume of drv:usbhid dev:3-9:1.1 complete after 150.049 msecs [13047.975119] PM: resume of drv: dev:ep_00 complete after 150.032 msecs [13047.975122] PM: resume of drv: dev:ep_81 complete after 150.070 msecs [13047.975126] PM: resume of drv: dev:ep_82 complete after 150.051 msecs [13047.993206] PM: resume of drv:nouveau dev:0000:02:00.0 complete after 170.469 msecs [13048.060081] PM: resume of drv:hub dev:4-0:1.0 complete after 235.298 msecs [13048.060102] PM: resume of drv: dev:ep_00 complete after 235.320 msecs [13048.060109] PM: resume of drv: dev:ep_00 complete after 235.272 msecs [13048.060141] PM: resume of drv: dev:ep_81 complete after 235.361 msecs [13048.060148] PM: resume of drv:hub dev:5-0:1.0 complete after 235.358 msecs [13048.060156] PM: resume of drv: dev:ep_81 complete after 235.334 msecs [13048.310069] ata4: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [13048.330184] ata4.00: ACPI cmd ef/03:46:00:00:00:a0 (SET FEATURES) filtered out [13048.330188] ata4.00: ACPI cmd f5/00:00:00:00:00:00 (SECURITY FREEZE LOCK) filtered out [13048.370198] ata4.00: configured for UDMA/100 [13053.350049] ata1: link is slow to respond, please be patient (ready=0) [13053.350058] ata2: link is slow to respond, please be patient (ready=0) [13053.350065] ata3: link is slow to respond, please be patient (ready=0) [13057.850047] ata2: SRST failed (errno=-16) [13057.850054] ata3: SRST failed (errno=-16) [13057.850059] ata1: SRST failed (errno=-16) [13058.340072] ata3: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [13058.340079] ata2: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [13058.340162] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [13058.360178] ata2.00: ACPI cmd ef/03:46:00:00:00:a0 (SET FEATURES) filtered out [13058.360185] ata3.00: ACPI cmd ef/03:46:00:00:00:a0 (SET FEATURES) filtered out [13058.360189] ata2.00: ACPI cmd f5/00:00:00:00:00:00 (SECURITY FREEZE LOCK) filtered out [13058.360192] ata3.00: ACPI cmd f5/00:00:00:00:00:00 (SECURITY FREEZE LOCK) filtered out [13058.360360] ata1.00: ACPI cmd ef/03:46:00:00:00:a0 (SET FEATURES) filtered out [13058.360363] ata1.00: ACPI cmd f5/00:00:00:00:00:00 (SECURITY FREEZE LOCK) filtered out [13058.400370] ata1.00: configured for UDMA/133 [13058.417906] PM: resume of drv:sd dev:0:0:0:0 complete after 10592.971 msecs [13058.417946] PM: resume of drv:scsi_device dev:0:0:0:0 complete after 10592.980 msecs [13058.417974] PM: resume of drv:scsi_disk dev:0:0:0:0 complete after 10507.174 msecs [13058.440587] ata3.00: configured for UDMA/133 [13058.440597] ata2.00: configured for UDMA/133 [13058.450465] PM: resume of drv:sd dev:2:0:0:0 complete after 10625.457 msecs [13058.450501] PM: resume of drv:scsi_device dev:2:0:0:0 complete after 10625.475 msecs [13058.456616] PM: resume of drv:sd dev:1:0:0:0 complete after 10631.639 msecs [13058.456724] PM: resume of drv:scsi_device dev:1:0:0:0 complete after 10631.732 msecs [13058.456765] PM: resume of devices complete after 10634.413 msecs [13058.456889] PM: resume devices took 10.630 seconds [13058.456890] ------------[ cut here ]------------ [13058.456896] WARNING: at /build/buildd/linux-3.0.0/kernel/power/suspend_test.c:53 suspend_test_finish+0x86/0x90() [13058.456898] Hardware name: System Product Name [13058.456899] Component: resume devices, time: 10630 [13058.456900] Modules linked in: snd_hda_codec_realtek bnep rfcomm bluetooth speedstep_lib binfmt_misc ppdev joydev snd_usb_audio snd_usbmidi_lib uvcvideo videodev v4l2_compat_ioctl32 snd_hda_intel snd_hda_codec snd_hwdep snd_pcm parport_pc psmouse asus_atk0110 serio_raw snd_seq_midi snd_rawmidi snd_seq_midi_event snd_seq snd_timer snd_seq_device snd edac_core edac_mce_amd soundcore snd_page_alloc i2c_nforce2 lp parport vesafb nouveau ttm drm_kms_helper drm usb_storage i2c_algo_bit mxm_wmi wmi usbhid hid uas video pata_amd forcedeth sata_nv [13058.456926] Pid: 8225, comm: pm-suspend Tainted: G W 3.0.0-9-generic #14-Ubuntu [13058.456927] Call Trace: [13058.456932] [] warn_slowpath_common+0x7f/0xc0 [13058.456934] [] warn_slowpath_fmt+0x46/0x50 [13058.456936] [] suspend_test_finish+0x86/0x90 [13058.456939] [] suspend_devices_and_enter+0xca/0x1b0 [13058.456941] [] enter_state+0x11d/0x150 [13058.456943] [] state_store+0xb7/0xf0 [13058.456945] [] kobj_attr_store+0xf/0x30 [13058.456948] [] sysfs_write_file+0xef/0x170 [13058.456951] [] vfs_write+0xb3/0x180 [13058.456953] [] sys_write+0x4a/0x90 [13058.456956] [] system_call_fastpath+0x16/0x1b [13058.456958] ---[ end trace b541a23aa1ac58d8 ]--- [13058.457015] PM: Finishing wakeup. [13058.457016] Restarting tasks ... done. [13059.656566] EXT4-fs (sda1): re-mounted. Opts: errors=remount-ro,user_xattr,commit=0 [13059.661130] EXT4-fs (sdb1): re-mounted. Opts: commit=0 [13059.686719] forcedeth 0000:00:07.0: irq 43 for MSI/MSI-X [13069.750038] eth0: no IPv6 routers present [13227.799941] [drm] nouveau 0000:02:00.0: PGRAPH - DATA_ERROR XY_OUT_OF_BOUNDS [13227.799955] [drm] nouveau 0000:02:00.0: PGRAPH - DATA_ERROR [13227.799966] [drm] nouveau 0000:02:00.0: PGRAPH - ch 5 (0x00052dc000) subc 7 class 0x5039 mthd 0x0328 data 0x00000000