Sep 11 12:00:55 samwise kernel: [23053.910939] ata1.00: configured for UDMA/133 Sep 11 12:00:55 samwise kernel: [23053.910947] ata1: EH complete Sep 11 12:00:55 samwise kernel: [23053.911253] sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA Sep 11 12:00:55 samwise kernel: [23054.334290] EXT4-fs (sda1): re-mounted. Opts: errors=remount-ro,commit=600 Sep 11 12:09:15 samwise kernel: [23554.695291] ptrace of non-child pid 21606 was attempted by: wineserver (pid 21602) Sep 11 12:09:15 samwise kernel: [23554.695402] ptrace of non-child pid 21608 was attempted by: wineserver (pid 21602) Sep 11 12:09:15 samwise kernel: [23554.695509] ptrace of non-child pid 21671 was attempted by: wineserver (pid 21602) Sep 11 12:09:15 samwise kernel: [23554.695615] ptrace of non-child pid 21683 was attempted by: wineserver (pid 21602) Sep 11 12:10:02 samwise kernel: [23600.877137] ptrace of non-child pid 21606 was attempted by: wineserver (pid 21602) Sep 11 12:10:02 samwise kernel: [23600.877248] ptrace of non-child pid 21608 was attempted by: wineserver (pid 21602) Sep 11 12:10:02 samwise kernel: [23600.877354] ptrace of non-child pid 21671 was attempted by: wineserver (pid 21602) Sep 11 12:10:02 samwise kernel: [23600.877460] ptrace of non-child pid 21683 was attempted by: wineserver (pid 21602) Sep 11 12:10:02 samwise kernel: [23600.877613] ptrace of non-child pid 21694 was attempted by: wineserver (pid 21602) Sep 11 12:10:02 samwise kernel: [23600.877719] ptrace of non-child pid 21714 was attempted by: wineserver (pid 21602) Sep 11 12:10:03 samwise kernel: [23602.174023] ptrace of non-child pid 21606 was attempted by: wineserver (pid 21602) Sep 11 12:10:03 samwise kernel: [23602.174134] ptrace of non-child pid 21608 was attempted by: wineserver (pid 21602) Sep 11 12:10:03 samwise kernel: [23602.174241] ptrace of non-child pid 21671 was attempted by: wineserver (pid 21602) Sep 11 12:10:03 samwise kernel: [23602.174348] ptrace of non-child pid 21683 was attempted by: wineserver (pid 21602) Sep 11 12:10:31 samwise kernel: [23630.188789] yama_ptrace_access_check: 2 callbacks suppressed Sep 11 12:10:31 samwise kernel: [23630.188796] ptrace of non-child pid 21811 was attempted by: wineserver (pid 21602) Sep 11 12:14:08 samwise kernel: [23847.534005] ata1: hard resetting link Sep 11 12:14:09 samwise kernel: [23847.852087] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300) Sep 11 12:14:09 samwise kernel: [23847.864039] ata1.00: configured for UDMA/133 Sep 11 12:14:09 samwise kernel: [23847.864047] ata1: EH complete Sep 11 12:14:09 samwise kernel: [23847.864364] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Sep 11 12:14:09 samwise kernel: [23848.346343] EXT4-fs (sda1): re-mounted. Opts: errors=remount-ro,commit=0 Sep 11 12:14:09 samwise kernel: [23848.464690] ata2: exception Emask 0x10 SAct 0x0 SErr 0x50000 action 0xe frozen Sep 11 12:14:09 samwise kernel: [23848.464695] ata2: irq_stat 0x00400000, PHY RDY changed Sep 11 12:14:09 samwise kernel: [23848.464698] ata2: SError: { PHYRdyChg CommWake } Sep 11 12:14:09 samwise kernel: [23848.464703] ata2: hard resetting link Sep 11 12:14:10 samwise kernel: [23849.009874] tg3 0000:02:00.0: PME# enabled Sep 11 12:14:10 samwise kernel: [23849.013039] tg3 0000:02:00.0: wake-up capability enabled by ACPI Sep 11 12:14:10 samwise kernel: [23849.204068] ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Sep 11 12:14:10 samwise kernel: [23849.206943] ata2.00: configured for UDMA/100 Sep 11 12:14:10 samwise kernel: [23849.207313] ata2: EH complete Sep 11 12:14:10 samwise kernel: [23849.272107] wlan0: deauthenticating from 00:24:a5:34:13:e2 by local choice (reason=3) Sep 11 12:14:10 samwise kernel: [23849.344052] cfg80211: All devices are disconnected, going to restore regulatory settings Sep 11 12:14:10 samwise kernel: [23849.344060] cfg80211: Restoring regulatory settings Sep 11 12:14:10 samwise kernel: [23849.344065] cfg80211: Calling CRDA to update world regulatory domain Sep 11 12:14:10 samwise kernel: [23849.378155] cfg80211: World regulatory domain updated: Sep 11 12:14:10 samwise kernel: [23849.378159] (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) Sep 11 12:14:10 samwise kernel: [23849.378162] (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) Sep 11 12:14:10 samwise kernel: [23849.378165] (2457000 KHz - 2482000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) Sep 11 12:14:10 samwise kernel: [23849.378168] (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) Sep 11 12:14:10 samwise kernel: [23849.378171] (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) Sep 11 12:14:10 samwise kernel: [23849.378174] (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) Sep 11 12:14:11 samwise kernel: [23849.793121] PM: Syncing filesystems ... done. Sep 11 12:14:11 samwise kernel: [23849.805546] PM: Preparing system for mem sleep Sep 11 12:17:01 samwise kernel: [23849.904382] Freezing user space processes ... (elapsed 0.01 seconds) done. Sep 11 12:17:01 samwise kernel: [23849.921090] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done. Sep 11 12:17:01 samwise kernel: [23849.936030] PM: Entering mem sleep Sep 11 12:17:01 samwise kernel: [23849.936059] Suspending console(s) (use no_console_suspend to debug) Sep 11 12:17:01 samwise kernel: [23849.936575] sd 0:0:0:0: [sda] Synchronizing SCSI cache Sep 11 12:17:01 samwise kernel: [23849.955895] ACPI handle has no context! Sep 11 12:17:01 samwise kernel: [23849.956047] ath9k 0000:03:00.0: PCI INT A disabled Sep 11 12:17:01 samwise kernel: [23849.956286] HDA Intel 0000:01:00.1: PCI INT B disabled Sep 11 12:17:01 samwise kernel: [23849.956336] ACPI handle has no context! Sep 11 12:17:01 samwise kernel: [23849.956380] uhci_hcd 0000:00:1d.3: PCI INT D disabled Sep 11 12:17:01 samwise kernel: [23849.956389] uhci_hcd 0000:00:1d.2: PCI INT C disabled Sep 11 12:17:01 samwise kernel: [23849.956398] uhci_hcd 0000:00:1d.1: PCI INT B disabled Sep 11 12:17:01 samwise kernel: [23849.956407] uhci_hcd 0000:00:1d.0: PCI INT A disabled Sep 11 12:17:01 samwise kernel: [23849.956498] ehci_hcd 0000:00:1a.7: PCI INT C disabled Sep 11 12:17:01 samwise kernel: [23849.956513] uhci_hcd 0000:00:1a.1: PCI INT B disabled Sep 11 12:17:01 samwise kernel: [23849.956523] uhci_hcd 0000:00:1a.0: PCI INT A disabled Sep 11 12:17:01 samwise kernel: [23849.973023] ehci_hcd 0000:00:1d.7: PCI INT A disabled Sep 11 12:17:01 samwise kernel: [23849.995788] sd 0:0:0:0: [sda] Stopping disk Sep 11 12:17:01 samwise kernel: [23850.061408] HDA Intel 0000:00:1b.0: PCI INT A disabled Sep 11 12:17:01 samwise kernel: [23850.077051] HDA Intel 0000:00:1b.0: power state changed by ACPI to D3 Sep 11 12:17:01 samwise kernel: [23850.077057] PM: suspend of drv:HDA Intel dev:0000:00:1b.0 complete after 120.634 msecs Sep 11 12:17:01 samwise kernel: [23850.279538] PM: suspend of drv:sd dev:0:0:0:0 complete after 342.965 msecs Sep 11 12:17:01 samwise kernel: [23850.279546] PM: suspend of drv:scsi dev:target0:0:0 complete after 342.931 msecs Sep 11 12:17:01 samwise kernel: [23850.279554] PM: suspend of drv:scsi dev:host0 complete after 342.862 msecs Sep 11 12:17:01 samwise kernel: [23850.357012] PM: suspend of drv:ahci dev:0000:00:1f.2 complete after 400.647 msecs Sep 11 12:17:01 samwise kernel: [23851.123282] [drm] Disabling audio support Sep 11 12:17:01 samwise kernel: [23851.139166] radeon 0000:01:00.0: f3485200 unpin not necessary Sep 11 12:17:01 samwise kernel: [23851.232024] PM: suspend of drv:radeon dev:0000:01:00.0 complete after 1275.679 msecs Sep 11 12:17:01 samwise kernel: [23851.232042] PM: suspend of drv:pcieport dev:0000:00:01.0 complete after 1275.511 msecs Sep 11 12:17:01 samwise kernel: [23851.232055] PM: suspend of drv: dev:pci0000:00 complete after 1275.514 msecs Sep 11 12:17:01 samwise kernel: [23851.232060] PM: suspend of devices complete after 1295.719 msecs Sep 11 12:17:01 samwise kernel: [23851.232063] PM: suspend devices took 1.296 seconds Sep 11 12:17:01 samwise kernel: [23851.264159] PM: late suspend of devices complete after 32.092 msecs Sep 11 12:17:01 samwise kernel: [23851.285049] ACPI: Preparing to enter system sleep state S3 Sep 11 12:17:01 samwise kernel: [23851.405505] PM: Saving platform NVS memory Sep 11 12:17:01 samwise kernel: [23851.411894] Disabling non-boot CPUs ... Sep 11 12:17:01 samwise kernel: [23851.516018] CPU 1 is now offline Sep 11 12:17:01 samwise kernel: [23851.516021] SMP alternatives: switching to UP code Sep 11 12:17:01 samwise kernel: [23851.523217] Extended CMOS year: 2000 Sep 11 12:17:01 samwise kernel: [23851.523217] Back to C! Sep 11 12:17:01 samwise kernel: [23851.523217] PM: Restoring platform NVS memory Sep 11 12:17:01 samwise kernel: [23851.523217] Extended CMOS year: 2000 Sep 11 12:17:01 samwise kernel: [23851.523217] Enabling non-boot CPUs ... Sep 11 12:17:01 samwise kernel: [23851.523217] SMP alternatives: switching to SMP code Sep 11 12:17:01 samwise kernel: [23851.530217] Booting Node 0 Processor 1 APIC 0x1 Sep 11 12:17:01 samwise kernel: [23851.522819] Initializing CPU#1 Sep 11 12:17:01 samwise kernel: [23851.636406] CPU1 is up Sep 11 12:17:01 samwise kernel: [23851.636921] ACPI: Waking up from system sleep state S3 Sep 11 12:17:01 samwise kernel: [23852.024354] pcieport 0000:00:01.0: restoring config space at offset 0x3 (was 0x10000, writing 0x10010) Sep 11 12:17:01 samwise kernel: [23852.024360] pcieport 0000:00:01.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) Sep 11 12:17:01 samwise kernel: [23852.024400] uhci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) Sep 11 12:17:01 samwise kernel: [23852.024434] uhci_hcd 0000:00:1a.1: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) Sep 11 12:17:01 samwise kernel: [23852.024474] ehci_hcd 0000:00:1a.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102) Sep 11 12:17:01 samwise kernel: [23852.024503] HDA Intel 0000:00:1b.0: restoring config space at offset 0xf (was 0x100, writing 0x10a) Sep 11 12:17:01 samwise kernel: [23852.024519] HDA Intel 0000:00:1b.0: restoring config space at offset 0x3 (was 0x0, writing 0x10) Sep 11 12:17:01 samwise kernel: [23852.024524] HDA Intel 0000:00:1b.0: restoring config space at offset 0x1 (was 0x100006, writing 0x100102) Sep 11 12:17:01 samwise kernel: [23852.024549] pcieport 0000:00:1c.0: restoring config space at offset 0xf (was 0x40100, writing 0x4010b) Sep 11 12:17:01 samwise kernel: [23852.024559] pcieport 0000:00:1c.0: restoring config space at offset 0x9 (was 0x10001, writing 0xc011c001) Sep 11 12:17:01 samwise kernel: [23852.024563] pcieport 0000:00:1c.0: restoring config space at offset 0x8 (was 0x0, writing 0xf410f410) Sep 11 12:17:01 samwise kernel: [23852.024568] pcieport 0000:00:1c.0: restoring config space at offset 0x7 (was 0x20000000, writing 0x20004040) Sep 11 12:17:01 samwise kernel: [23852.024572] pcieport 0000:00:1c.0: restoring config space at offset 0x6 (was 0x0, writing 0x20200) Sep 11 12:17:01 samwise kernel: [23852.024579] pcieport 0000:00:1c.0: restoring config space at offset 0x3 (was 0x810000, writing 0x810010) Sep 11 12:17:01 samwise kernel: [23852.024584] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100507) Sep 11 12:17:01 samwise kernel: [23852.024620] pcieport 0000:00:1c.1: restoring config space at offset 0xf (was 0x40200, writing 0x4020b) Sep 11 12:17:01 samwise kernel: [23852.024630] pcieport 0000:00:1c.1: restoring config space at offset 0x9 (was 0x10001, writing 0xc031c021) Sep 11 12:17:01 samwise kernel: [23852.024635] pcieport 0000:00:1c.1: restoring config space at offset 0x7 (was 0x20000000, writing 0x20005050) Sep 11 12:17:01 samwise kernel: [23852.024643] pcieport 0000:00:1c.1: restoring config space at offset 0x3 (was 0x810000, writing 0x810010) Sep 11 12:17:01 samwise kernel: [23852.024648] pcieport 0000:00:1c.1: restoring config space at offset 0x1 (was 0x100000, writing 0x100507) Sep 11 12:17:01 samwise kernel: [23852.024684] pcieport 0000:00:1c.4: restoring config space at offset 0xf (was 0x40100, writing 0x4010b) Sep 11 12:17:01 samwise kernel: [23852.024693] pcieport 0000:00:1c.4: restoring config space at offset 0x9 (was 0x10001, writing 0xf1f1f001) Sep 11 12:17:01 samwise kernel: [23852.024699] pcieport 0000:00:1c.4: restoring config space at offset 0x7 (was 0x20000000, writing 0x20003030) Sep 11 12:17:01 samwise kernel: [23852.024707] pcieport 0000:00:1c.4: restoring config space at offset 0x3 (was 0x810000, writing 0x810010) Sep 11 12:17:01 samwise kernel: [23852.024712] pcieport 0000:00:1c.4: restoring config space at offset 0x1 (was 0x100000, writing 0x100507) Sep 11 12:17:01 samwise kernel: [23852.024759] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) Sep 11 12:17:01 samwise kernel: [23852.024792] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) Sep 11 12:17:01 samwise kernel: [23852.024824] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) Sep 11 12:17:01 samwise kernel: [23852.024856] uhci_hcd 0000:00:1d.3: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) Sep 11 12:17:01 samwise kernel: [23852.024897] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102) Sep 11 12:17:01 samwise kernel: [23852.024919] pci 0000:00:1e.0: restoring config space at offset 0xf (was 0x40000, writing 0x400ff) Sep 11 12:17:01 samwise kernel: [23852.024928] pci 0000:00:1e.0: restoring config space at offset 0x9 (was 0x10001, writing 0x1fff1) Sep 11 12:17:01 samwise kernel: [23852.024933] pci 0000:00:1e.0: restoring config space at offset 0x8 (was 0x0, writing 0xfff0) Sep 11 12:17:01 samwise kernel: [23852.024937] pci 0000:00:1e.0: restoring config space at offset 0x7 (was 0x22800000, writing 0x228000f0) Sep 11 12:17:01 samwise kernel: [23852.024947] pci 0000:00:1e.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100107) Sep 11 12:17:01 samwise kernel: [23852.025014] ahci 0000:00:1f.2: restoring config space at offset 0xf (was 0x200, writing 0x20a) Sep 11 12:17:01 samwise kernel: [23852.025032] ahci 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00007, writing 0x2b00407) Sep 11 12:17:01 samwise kernel: [23852.025070] pci 0000:00:1f.3: restoring config space at offset 0x4 (was 0x4, writing 0xc0400004) Sep 11 12:17:01 samwise kernel: [23852.025097] radeon 0000:01:00.0: restoring config space at offset 0xf (was 0x1ff, writing 0x10b) Sep 11 12:17:01 samwise kernel: [23852.025112] radeon 0000:01:00.0: restoring config space at offset 0x5 (was 0x1, writing 0x2001) Sep 11 12:17:01 samwise kernel: [23852.025120] radeon 0000:01:00.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) Sep 11 12:17:01 samwise kernel: [23852.025163] HDA Intel 0000:01:00.1: restoring config space at offset 0xf (was 0x2ff, writing 0x20b) Sep 11 12:17:01 samwise kernel: [23852.025178] HDA Intel 0000:01:00.1: restoring config space at offset 0x4 (was 0x0, writing 0xf4010000) Sep 11 12:17:01 samwise kernel: [23852.025183] HDA Intel 0000:01:00.1: restoring config space at offset 0x3 (was 0x800000, writing 0x800010) Sep 11 12:17:01 samwise kernel: [23852.025189] HDA Intel 0000:01:00.1: restoring config space at offset 0x1 (was 0x100000, writing 0x100103) Sep 11 12:17:01 samwise kernel: [23852.025259] tg3 0000:02:00.0: restoring config space at offset 0x3 (was 0x0, writing 0x10) Sep 11 12:17:01 samwise kernel: [23852.025266] tg3 0000:02:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100106) Sep 11 12:17:01 samwise kernel: [23852.025313] ath9k 0000:03:00.0: restoring config space at offset 0xf (was 0x1ff, writing 0x10b) Sep 11 12:17:01 samwise kernel: [23852.025334] ath9k 0000:03:00.0: restoring config space at offset 0x4 (was 0x4, writing 0xf4200004) Sep 11 12:17:01 samwise kernel: [23852.025340] ath9k 0000:03:00.0: restoring config space at offset 0x3 (was 0x0, writing 0x10) Sep 11 12:17:01 samwise kernel: [23852.025347] ath9k 0000:03:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100107) Sep 11 12:17:01 samwise kernel: [23852.025627] PM: early resume of devices complete after 1.380 msecs Sep 11 12:17:01 samwise kernel: [23852.025824] uhci_hcd 0000:00:1a.0: PCI INT A -> GSI 20 (level, low) -> IRQ 20 Sep 11 12:17:01 samwise kernel: [23852.025831] uhci_hcd 0000:00:1a.0: setting latency timer to 64 Sep 11 12:17:01 samwise kernel: [23852.025852] usb usb3: root hub lost power or was reset Sep 11 12:17:01 samwise kernel: [23852.025889] uhci_hcd 0000:00:1a.1: PCI INT B -> GSI 20 (level, low) -> IRQ 20 Sep 11 12:17:01 samwise kernel: [23852.025895] uhci_hcd 0000:00:1a.1: setting latency timer to 64 Sep 11 12:17:01 samwise kernel: [23852.025915] ehci_hcd 0000:00:1a.7: PCI INT C -> GSI 20 (level, low) -> IRQ 20 Sep 11 12:17:01 samwise kernel: [23852.025916] usb usb4: root hub lost power or was reset Sep 11 12:17:01 samwise kernel: [23852.025923] ehci_hcd 0000:00:1a.7: setting latency timer to 64 Sep 11 12:17:01 samwise kernel: [23852.025945] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 23 (level, low) -> IRQ 23 Sep 11 12:17:01 samwise kernel: [23852.025950] uhci_hcd 0000:00:1d.0: setting latency timer to 64 Sep 11 12:17:01 samwise kernel: [23852.025965] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 Sep 11 12:17:01 samwise kernel: [23852.025973] uhci_hcd 0000:00:1d.1: setting latency timer to 64 Sep 11 12:17:01 samwise kernel: [23852.025977] usb usb5: root hub lost power or was reset Sep 11 12:17:01 samwise kernel: [23852.025997] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 Sep 11 12:17:01 samwise kernel: [23852.026000] usb usb6: root hub lost power or was reset Sep 11 12:17:01 samwise kernel: [23852.026004] uhci_hcd 0000:00:1d.2: setting latency timer to 64 Sep 11 12:17:01 samwise kernel: [23852.026020] uhci_hcd 0000:00:1d.3: PCI INT D -> GSI 18 (level, low) -> IRQ 18 Sep 11 12:17:01 samwise kernel: [23852.026025] usb usb7: root hub lost power or was reset Sep 11 12:17:01 samwise kernel: [23852.026028] uhci_hcd 0000:00:1d.3: setting latency timer to 64 Sep 11 12:17:01 samwise kernel: [23852.026044] ehci_hcd 0000:00:1d.7: PCI INT A -> GSI 23 (level, low) -> IRQ 23 Sep 11 12:17:01 samwise kernel: [23852.026051] usb usb8: root hub lost power or was reset Sep 11 12:17:01 samwise kernel: [23852.026052] ehci_hcd 0000:00:1d.7: setting latency timer to 64 Sep 11 12:17:01 samwise kernel: [23852.026070] pci 0000:00:1e.0: setting latency timer to 64 Sep 11 12:17:01 samwise kernel: [23852.026101] radeon 0000:01:00.0: setting latency timer to 64 Sep 11 12:17:01 samwise kernel: [23852.026104] ahci 0000:00:1f.2: setting latency timer to 64 Sep 11 12:17:01 samwise kernel: [23852.026168] HDA Intel 0000:01:00.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 Sep 11 12:17:01 samwise kernel: [23852.026179] HDA Intel 0000:01:00.1: setting latency timer to 64 Sep 11 12:17:01 samwise kernel: [23852.026292] HDA Intel 0000:01:00.1: irq 45 for MSI/MSI-X Sep 11 12:17:01 samwise kernel: [23852.026333] ath9k 0000:03:00.0: PCI INT A -> GSI 17 (level, low) -> IRQ 17 Sep 11 12:17:01 samwise kernel: [23852.026945] HDA Intel 0000:00:1b.0: power state changed by ACPI to D0 Sep 11 12:17:01 samwise kernel: [23852.026986] HDA Intel 0000:00:1b.0: power state changed by ACPI to D0 Sep 11 12:17:01 samwise kernel: [23852.027026] HDA Intel 0000:00:1b.0: power state changed by ACPI to D0 Sep 11 12:17:01 samwise kernel: [23852.027066] HDA Intel 0000:00:1b.0: power state changed by ACPI to D0 Sep 11 12:17:01 samwise kernel: [23852.027076] HDA Intel 0000:00:1b.0: PCI INT A -> GSI 21 (level, low) -> IRQ 21 Sep 11 12:17:01 samwise kernel: [23852.027088] HDA Intel 0000:00:1b.0: setting latency timer to 64 Sep 11 12:17:01 samwise kernel: [23852.027175] HDA Intel 0000:00:1b.0: irq 47 for MSI/MSI-X Sep 11 12:17:01 samwise kernel: [23852.027578] sd 0:0:0:0: [sda] Starting disk Sep 11 12:17:01 samwise kernel: [23852.028253] [drm] Clocks initialized ! Sep 11 12:17:01 samwise kernel: [23852.080780] [drm] ring test succeeded in 1 usecs Sep 11 12:17:01 samwise kernel: [23852.080799] [drm] ib test succeeded in 0 usecs Sep 11 12:17:01 samwise kernel: [23852.080800] [drm] Enabling audio support Sep 11 12:17:01 samwise kernel: [23852.156045] PM: resume of drv:usb dev:usb2 complete after 129.606 msecs Sep 11 12:17:01 samwise kernel: [23852.156064] PM: resume of drv:hub dev:2-0:1.0 complete after 128.826 msecs Sep 11 12:17:01 samwise kernel: [23852.168055] PM: resume of drv:usb dev:usb8 complete after 140.578 msecs Sep 11 12:17:01 samwise kernel: [23852.168073] PM: resume of drv:usb dev:usb6 complete after 140.662 msecs Sep 11 12:17:01 samwise kernel: [23852.168076] PM: resume of drv:hub dev:8-0:1.0 complete after 140.579 msecs Sep 11 12:17:01 samwise kernel: [23852.168080] PM: resume of drv:hub dev:6-0:1.0 complete after 140.651 msecs Sep 11 12:17:01 samwise kernel: [23852.168097] PM: resume of drv:usb dev:usb7 complete after 140.654 msecs Sep 11 12:17:01 samwise kernel: [23852.168100] PM: resume of drv:usb dev:usb4 complete after 140.758 msecs Sep 11 12:17:01 samwise kernel: [23852.168104] PM: resume of drv:hub dev:7-0:1.0 complete after 140.642 msecs Sep 11 12:17:01 samwise kernel: [23852.168109] PM: resume of drv:hub dev:4-0:1.0 complete after 140.747 msecs Sep 11 12:17:01 samwise kernel: [23852.168117] PM: resume of drv:usb dev:usb5 complete after 140.740 msecs Sep 11 12:17:01 samwise kernel: [23852.168126] PM: resume of drv:hub dev:5-0:1.0 complete after 140.731 msecs Sep 11 12:17:01 samwise kernel: [23852.168129] PM: resume of drv:usb dev:usb3 complete after 140.823 msecs Sep 11 12:17:01 samwise kernel: [23852.168139] PM: resume of drv:hub dev:3-0:1.0 complete after 140.814 msecs Sep 11 12:17:01 samwise kernel: [23852.268048] usb 2-5: reset high speed USB device using ehci_hcd and address 2 Sep 11 12:17:01 samwise kernel: [23852.360050] ata6: SATA link down (SStatus 0 SControl 300) Sep 11 12:17:01 samwise kernel: [23852.368048] ata5: SATA link down (SStatus 0 SControl 300) Sep 11 12:17:01 samwise kernel: [23852.450986] PM: resume of drv:usb dev:2-5 complete after 423.453 msecs Sep 11 12:17:01 samwise kernel: [23852.450998] PM: resume of drv:uvcvideo dev:2-5:1.1 complete after 423.434 msecs Sep 11 12:17:01 samwise kernel: [23852.451003] PM: resume of drv:uvcvideo dev:2-5:1.0 complete after 423.456 msecs Sep 11 12:17:01 samwise kernel: [23852.756045] ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Sep 11 12:17:01 samwise kernel: [23852.757166] ata2.00: configured for UDMA/100 Sep 11 12:17:01 samwise kernel: [23853.500268] PM: resume of drv:radeon dev:0000:01:00.0 complete after 1474.173 msecs Sep 11 12:17:01 samwise kernel: [23855.200051] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300) Sep 11 12:17:01 samwise kernel: [23855.210687] ata1.00: configured for UDMA/133 Sep 11 12:17:01 samwise kernel: [23855.237102] PM: resume of drv:sd dev:0:0:0:0 complete after 3209.521 msecs Sep 11 12:17:01 samwise kernel: [23855.237112] PM: resume of drv:scsi_device dev:0:0:0:0 complete after 3209.496 msecs Sep 11 12:17:01 samwise kernel: [23862.053020] PM: resume of drv:battery dev:PNP0C0A:00 complete after 10027.250 msecs Sep 11 12:17:01 samwise kernel: [23862.089052] PM: resume of devices complete after 10063.394 msecs Sep 11 12:17:01 samwise kernel: [23862.089242] PM: resume devices took 10.064 seconds Sep 11 12:17:01 samwise kernel: [23862.089244] ------------[ cut here ]------------ Sep 11 12:17:01 samwise kernel: [23862.089250] WARNING: at /build/buildd/linux-2.6.35/kernel/power/suspend_test.c:53 suspend_test_finish+0x89/0x90() Sep 11 12:17:01 samwise kernel: [23862.089252] Hardware name: Aspire 5738 Sep 11 12:17:01 samwise kernel: [23862.089254] Component: resume devices, time: 10064 Sep 11 12:17:01 samwise kernel: [23862.089256] Modules linked in: snd_seq_dummy nls_iso8859_1 nls_cp437 usb_storage btrfs zlib_deflate crc32c libcrc32c ufs qnx4 hfsplus hfs minix ntfs vfat msdos fat jfs xfs exportfs reiserfs aes_i586 aes_generic binfmt_misc parport_pc ppdev snd_hda_codec_atihdmi snd_hda_codec_realtek arc4 radeon snd_hda_intel snd_hda_codec snd_hwdep snd_pcm ath9k snd_seq_midi snd_rawmidi ath9k_common snd_seq_midi_event ath9k_hw ath ttm mac80211 snd_seq drm_kms_helper snd_timer snd_seq_device acer_wmi uvcvideo drm cfg80211 videodev v4l1_compat intel_agp i2c_algo_bit snd psmouse serio_raw led_class soundcore snd_page_alloc agpgart video output lp parport tg3 ahci libahci Sep 11 12:17:01 samwise kernel: [23862.089301] Pid: 21916, comm: pm-suspend Not tainted 2.6.35-20-generic #29-Ubuntu Sep 11 12:17:01 samwise kernel: [23862.089304] Call Trace: Sep 11 12:17:01 samwise kernel: [23862.089309] [] warn_slowpath_common+0x72/0xa0 Sep 11 12:17:01 samwise kernel: [23862.089313] [] ? suspend_test_finish+0x89/0x90 Sep 11 12:17:01 samwise kernel: [23862.089315] [] ? suspend_test_finish+0x89/0x90 Sep 11 12:17:01 samwise kernel: [23862.089319] [] warn_slowpath_fmt+0x33/0x40 Sep 11 12:17:01 samwise kernel: [23862.089321] [] suspend_test_finish+0x89/0x90 Sep 11 12:17:01 samwise kernel: [23862.089324] [] suspend_devices_and_enter+0xbf/0xf0 Sep 11 12:17:01 samwise kernel: [23862.089327] [] enter_state+0xbd/0xf0 Sep 11 12:17:01 samwise kernel: [23862.089330] [] state_store+0x6d/0xb0 Sep 11 12:17:01 samwise kernel: [23862.089333] [] ? state_store+0x0/0xb0 Sep 11 12:17:01 samwise kernel: [23862.089336] [] kobj_attr_store+0x20/0x30 Sep 11 12:17:01 samwise kernel: [23862.089340] [] sysfs_write_file+0x99/0xf0 Sep 11 12:17:01 samwise kernel: [23862.089344] [] vfs_write+0xa2/0x190 Sep 11 12:17:01 samwise kernel: [23862.089347] [] ? sysfs_write_file+0x0/0xf0 Sep 11 12:17:01 samwise kernel: [23862.089350] [] sys_write+0x42/0x70 Sep 11 12:17:01 samwise kernel: [23862.089354] [] syscall_call+0x7/0xb Sep 11 12:17:01 samwise kernel: [23862.089357] ---[ end trace b8540aa1a8c7bb90 ]--- Sep 11 12:17:01 samwise kernel: [23862.089392] PM: Finishing wakeup. Sep 11 12:17:01 samwise kernel: [23862.089394] Restarting tasks ... done. Sep 11 12:17:01 samwise kernel: [23862.118917] video LNXVIDEO:00: Restoring backlight state Sep 11 12:17:01 samwise kernel: [23862.305041] [drm:drm_mode_getfb] *ERROR* invalid framebuffer id Sep 11 12:17:01 samwise kernel: [23862.446490] tg3 0000:02:00.0: wake-up capability disabled by ACPI Sep 11 12:17:01 samwise kernel: [23862.446498] tg3 0000:02:00.0: PME# disabled Sep 11 12:17:01 samwise kernel: [23862.446581] tg3 0000:02:00.0: irq 48 for MSI/MSI-X Sep 11 12:17:01 samwise kernel: [23862.552056] ADDRCONF(NETDEV_UP): eth0: link is not ready Sep 11 12:17:01 samwise kernel: [23862.609173] ADDRCONF(NETDEV_UP): wlan0: link is not ready Sep 11 12:17:02 samwise kernel: [23862.974570] psmouse serio2: ID: 73 02 64 Sep 11 12:17:02 samwise kernel: [23863.324519] ata1.00: configured for UDMA/133 Sep 11 12:17:02 samwise kernel: [23863.324526] ata1: EH complete Sep 11 12:17:02 samwise kernel: [23863.597457] EXT4-fs (sda1): re-mounted. Opts: errors=remount-ro,commit=0 Sep 11 12:17:03 samwise kernel: [23864.202959] ata1.00: configured for UDMA/133 Sep 11 12:17:03 samwise kernel: [23864.202965] ata1: EH complete Sep 11 12:17:03 samwise kernel: [23864.615237] EXT4-fs (sda1): re-mounted. Opts: errors=remount-ro,commit=0 Sep 11 12:17:04 samwise kernel: [23864.930550] wlan0: authenticate with 00:24:a5:34:13:e2 (try 1) Sep 11 12:17:04 samwise kernel: [23864.932430] wlan0: authenticated Sep 11 12:17:04 samwise kernel: [23864.932447] wlan0: associate with 00:24:a5:34:13:e2 (try 1) Sep 11 12:17:04 samwise kernel: [23864.936619] wlan0: RX AssocResp from 00:24:a5:34:13:e2 (capab=0x431 status=0 aid=1) Sep 11 12:17:04 samwise kernel: [23864.936622] wlan0: associated Sep 11 12:17:04 samwise kernel: [23864.946624] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready Sep 11 12:17:04 samwise dhclient: Internet Systems Consortium DHCP Client V3.1.3 Sep 11 12:17:04 samwise dhclient: Copyright 2004-2009 Internet Systems Consortium. Sep 11 12:17:04 samwise dhclient: All rights reserved. Sep 11 12:17:04 samwise dhclient: For info, please visit https://www.isc.org/software/dhcp/ Sep 11 12:17:04 samwise dhclient: Sep 11 12:17:04 samwise dhclient: Listening on LPF/wlan0/0c:ee:e6:d5:31:35 Sep 11 12:17:04 samwise dhclient: Sending on LPF/wlan0/0c:ee:e6:d5:31:35 Sep 11 12:17:04 samwise dhclient: Sending on Socket/fallback Sep 11 12:17:04 samwise dhclient: DHCPREQUEST of 192.168.11.3 on wlan0 to 255.255.255.255 port 67 Sep 11 12:17:07 samwise dhclient: DHCPREQUEST of 192.168.11.3 on wlan0 to 255.255.255.255 port 67 Sep 11 12:17:07 samwise dhclient: DHCPACK of 192.168.11.3 from 192.168.11.1 Sep 11 12:17:07 samwise dhclient: bound to 192.168.11.3 -- renewal in 82165 seconds. Sep 11 12:17:13 samwise kernel: [23875.088042] wlan0: no IPv6 routers present Sep 11 12:29:36 samwise kernel: [24617.571926] ata1.00: configured for UDMA/133 Sep 11 12:29:36 samwise kernel: [24617.571934] ata1: EH complete Sep 11 12:29:36 samwise kernel: [24617.918385] EXT4-fs (sda1): re-mounted. Opts: errors=remount-ro,commit=0 Sep 11 12:29:37 samwise kernel: [24618.537797] tg3 0000:02:00.0: PME# enabled Sep 11 12:29:37 samwise kernel: [24618.537826] tg3 0000:02:00.0: wake-up capability enabled by ACPI Sep 11 12:29:37 samwise kernel: [24618.789123] wlan0: deauthenticating from 00:24:a5:34:13:e2 by local choice (reason=3) Sep 11 12:29:37 samwise kernel: [24618.865634] cfg80211: All devices are disconnected, going to restore regulatory settings Sep 11 12:29:37 samwise kernel: [24618.865643] cfg80211: Restoring regulatory settings Sep 11 12:29:37 samwise kernel: [24618.865648] cfg80211: Calling CRDA to update world regulatory domain Sep 11 12:29:37 samwise kernel: [24618.897919] cfg80211: World regulatory domain updated: Sep 11 12:29:37 samwise kernel: [24618.897924] (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) Sep 11 12:29:37 samwise kernel: [24618.897927] (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) Sep 11 12:29:37 samwise kernel: [24618.897930] (2457000 KHz - 2482000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) Sep 11 12:29:37 samwise kernel: [24618.897933] (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) Sep 11 12:29:37 samwise kernel: [24618.897936] (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) Sep 11 12:29:37 samwise kernel: [24618.897939] (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) Sep 11 12:29:38 samwise kernel: [24619.585391] PM: Syncing filesystems ... done. Sep 11 12:29:38 samwise kernel: [24619.597880] PM: Preparing system for mem sleep Sep 11 12:52:31 samwise kernel: [24619.696382] Freezing user space processes ... (elapsed 0.01 seconds) done. Sep 11 12:52:31 samwise kernel: [24619.713088] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done. Sep 11 12:52:31 samwise kernel: [24619.728079] PM: Entering mem sleep Sep 11 12:52:31 samwise kernel: [24619.728109] Suspending console(s) (use no_console_suspend to debug) Sep 11 12:52:31 samwise kernel: [24619.732186] sd 0:0:0:0: [sda] Synchronizing SCSI cache Sep 11 12:52:31 samwise kernel: [24619.732350] sd 0:0:0:0: [sda] Stopping disk Sep 11 12:52:31 samwise kernel: [24619.760992] ACPI handle has no context! Sep 11 12:52:31 samwise kernel: [24619.761146] ath9k 0000:03:00.0: PCI INT A disabled Sep 11 12:52:31 samwise kernel: [24619.761384] HDA Intel 0000:01:00.1: PCI INT B disabled Sep 11 12:52:31 samwise kernel: [24619.761434] ACPI handle has no context! Sep 11 12:52:31 samwise kernel: [24619.761477] uhci_hcd 0000:00:1d.3: PCI INT D disabled Sep 11 12:52:31 samwise kernel: [24619.761486] uhci_hcd 0000:00:1d.2: PCI INT C disabled Sep 11 12:52:31 samwise kernel: [24619.761495] uhci_hcd 0000:00:1d.1: PCI INT B disabled Sep 11 12:52:31 samwise kernel: [24619.761504] uhci_hcd 0000:00:1d.0: PCI INT A disabled Sep 11 12:52:31 samwise kernel: [24619.761608] ehci_hcd 0000:00:1a.7: PCI INT C disabled Sep 11 12:52:31 samwise kernel: [24619.761620] uhci_hcd 0000:00:1a.1: PCI INT B disabled Sep 11 12:52:31 samwise kernel: [24619.761630] uhci_hcd 0000:00:1a.0: PCI INT A disabled Sep 11 12:52:31 samwise kernel: [24619.776064] ehci_hcd 0000:00:1d.7: PCI INT A disabled Sep 11 12:52:31 samwise kernel: [24619.865413] HDA Intel 0000:00:1b.0: PCI INT A disabled Sep 11 12:52:31 samwise kernel: [24619.881064] HDA Intel 0000:00:1b.0: power state changed by ACPI to D3 Sep 11 12:52:31 samwise kernel: [24619.881070] PM: suspend of drv:HDA Intel dev:0000:00:1b.0 complete after 119.551 msecs Sep 11 12:52:31 samwise kernel: [24620.022227] PM: suspend of drv:sd dev:0:0:0:0 complete after 290.044 msecs Sep 11 12:52:31 samwise kernel: [24620.022236] PM: suspend of drv:scsi dev:target0:0:0 complete after 290.009 msecs Sep 11 12:52:31 samwise kernel: [24620.022245] PM: suspend of drv:scsi dev:host0 complete after 289.952 msecs Sep 11 12:52:31 samwise kernel: [24620.101012] PM: suspend of drv:ahci dev:0000:00:1f.2 complete after 339.549 msecs Sep 11 12:52:31 samwise kernel: [24620.909670] [drm] Disabling audio support Sep 11 12:52:31 samwise kernel: [24620.925556] radeon 0000:01:00.0: f3485200 unpin not necessary Sep 11 12:52:31 samwise kernel: [24621.020045] PM: suspend of drv:radeon dev:0000:01:00.0 complete after 1258.601 msecs Sep 11 12:52:31 samwise kernel: [24621.020061] PM: suspend of drv:pcieport dev:0000:00:01.0 complete after 1258.422 msecs Sep 11 12:52:31 samwise kernel: [24621.020074] PM: suspend of drv: dev:pci0000:00 complete after 1258.425 msecs Sep 11 12:52:31 samwise kernel: [24621.020080] PM: suspend of devices complete after 1291.688 msecs Sep 11 12:52:31 samwise kernel: [24621.020083] PM: suspend devices took 1.292 seconds Sep 11 12:52:31 samwise kernel: [24621.056157] PM: late suspend of devices complete after 36.071 msecs Sep 11 12:52:31 samwise kernel: [24621.076049] ACPI: Preparing to enter system sleep state S3 Sep 11 12:52:31 samwise kernel: [24621.196503] PM: Saving platform NVS memory Sep 11 12:52:31 samwise kernel: [24621.202962] Disabling non-boot CPUs ... Sep 11 12:52:31 samwise kernel: [24621.204129] CPU 1 is now offline Sep 11 12:52:31 samwise kernel: [24621.204132] SMP alternatives: switching to UP code Sep 11 12:52:31 samwise kernel: [24621.211301] Extended CMOS year: 2000 Sep 11 12:52:31 samwise kernel: [24621.211301] Back to C! Sep 11 12:52:31 samwise kernel: [24621.211301] PM: Restoring platform NVS memory Sep 11 12:52:31 samwise kernel: [24621.211301] Extended CMOS year: 2000 Sep 11 12:52:31 samwise kernel: [24621.211301] Enabling non-boot CPUs ... Sep 11 12:52:31 samwise kernel: [24621.211301] SMP alternatives: switching to SMP code Sep 11 12:52:31 samwise kernel: [24621.218216] Booting Node 0 Processor 1 APIC 0x1 Sep 11 12:52:31 samwise kernel: [24621.210897] Initializing CPU#1 Sep 11 12:52:31 samwise kernel: [24621.332404] CPU1 is up Sep 11 12:52:31 samwise kernel: [24621.332919] ACPI: Waking up from system sleep state S3 Sep 11 12:52:31 samwise kernel: [24621.712451] pcieport 0000:00:01.0: restoring config space at offset 0x3 (was 0x10000, writing 0x10010) Sep 11 12:52:31 samwise kernel: [24621.712456] pcieport 0000:00:01.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) Sep 11 12:52:31 samwise kernel: [24621.712497] uhci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) Sep 11 12:52:31 samwise kernel: [24621.712531] uhci_hcd 0000:00:1a.1: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) Sep 11 12:52:31 samwise kernel: [24621.712571] ehci_hcd 0000:00:1a.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102) Sep 11 12:52:31 samwise kernel: [24621.712600] HDA Intel 0000:00:1b.0: restoring config space at offset 0xf (was 0x100, writing 0x10a) Sep 11 12:52:31 samwise kernel: [24621.712616] HDA Intel 0000:00:1b.0: restoring config space at offset 0x3 (was 0x0, writing 0x10) Sep 11 12:52:31 samwise kernel: [24621.712621] HDA Intel 0000:00:1b.0: restoring config space at offset 0x1 (was 0x100006, writing 0x100102) Sep 11 12:52:31 samwise kernel: [24621.712646] pcieport 0000:00:1c.0: restoring config space at offset 0xf (was 0x40100, writing 0x4010b) Sep 11 12:52:31 samwise kernel: [24621.712656] pcieport 0000:00:1c.0: restoring config space at offset 0x9 (was 0x10001, writing 0xc011c001) Sep 11 12:52:31 samwise kernel: [24621.712660] pcieport 0000:00:1c.0: restoring config space at offset 0x8 (was 0x0, writing 0xf410f410) Sep 11 12:52:31 samwise kernel: [24621.712665] pcieport 0000:00:1c.0: restoring config space at offset 0x7 (was 0x20000000, writing 0x4040) Sep 11 12:52:31 samwise kernel: [24621.712669] pcieport 0000:00:1c.0: restoring config space at offset 0x6 (was 0x0, writing 0x20200) Sep 11 12:52:31 samwise kernel: [24621.712676] pcieport 0000:00:1c.0: restoring config space at offset 0x3 (was 0x810000, writing 0x810010) Sep 11 12:52:31 samwise kernel: [24621.712681] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100507) Sep 11 12:52:31 samwise kernel: [24621.712717] pcieport 0000:00:1c.1: restoring config space at offset 0xf (was 0x40200, writing 0x4020b) Sep 11 12:52:31 samwise kernel: [24621.712726] pcieport 0000:00:1c.1: restoring config space at offset 0x9 (was 0x10001, writing 0xc031c021) Sep 11 12:52:31 samwise kernel: [24621.712732] pcieport 0000:00:1c.1: restoring config space at offset 0x7 (was 0x20000000, writing 0x5050) Sep 11 12:52:31 samwise kernel: [24621.712740] pcieport 0000:00:1c.1: restoring config space at offset 0x3 (was 0x810000, writing 0x810010) Sep 11 12:52:31 samwise kernel: [24621.712745] pcieport 0000:00:1c.1: restoring config space at offset 0x1 (was 0x100000, writing 0x100507) Sep 11 12:52:31 samwise kernel: [24621.712780] pcieport 0000:00:1c.4: restoring config space at offset 0xf (was 0x40100, writing 0x4010b) Sep 11 12:52:31 samwise kernel: [24621.712790] pcieport 0000:00:1c.4: restoring config space at offset 0x9 (was 0x10001, writing 0xf1f1f001) Sep 11 12:52:31 samwise kernel: [24621.712795] pcieport 0000:00:1c.4: restoring config space at offset 0x7 (was 0x20000000, writing 0x3030) Sep 11 12:52:31 samwise kernel: [24621.712803] pcieport 0000:00:1c.4: restoring config space at offset 0x3 (was 0x810000, writing 0x810010) Sep 11 12:52:31 samwise kernel: [24621.712809] pcieport 0000:00:1c.4: restoring config space at offset 0x1 (was 0x100000, writing 0x100507) Sep 11 12:52:31 samwise kernel: [24621.712856] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) Sep 11 12:52:31 samwise kernel: [24621.712888] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) Sep 11 12:52:31 samwise kernel: [24621.712921] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) Sep 11 12:52:31 samwise kernel: [24621.712954] uhci_hcd 0000:00:1d.3: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) Sep 11 12:52:31 samwise kernel: [24621.712994] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102) Sep 11 12:52:31 samwise kernel: [24621.713026] pci 0000:00:1e.0: restoring config space at offset 0xf (was 0x40000, writing 0x400ff) Sep 11 12:52:31 samwise kernel: [24621.713035] pci 0000:00:1e.0: restoring config space at offset 0x9 (was 0x10001, writing 0x1fff1) Sep 11 12:52:31 samwise kernel: [24621.713040] pci 0000:00:1e.0: restoring config space at offset 0x8 (was 0x0, writing 0xfff0) Sep 11 12:52:31 samwise kernel: [24621.713044] pci 0000:00:1e.0: restoring config space at offset 0x7 (was 0x22800000, writing 0x228000f0) Sep 11 12:52:31 samwise kernel: [24621.713054] pci 0000:00:1e.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100107) Sep 11 12:52:31 samwise kernel: [24621.713111] ahci 0000:00:1f.2: restoring config space at offset 0xf (was 0x200, writing 0x20a) Sep 11 12:52:31 samwise kernel: [24621.713129] ahci 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00007, writing 0x2b00407) Sep 11 12:52:31 samwise kernel: [24621.713167] pci 0000:00:1f.3: restoring config space at offset 0x4 (was 0x4, writing 0xc0400004) Sep 11 12:52:31 samwise kernel: [24621.713195] radeon 0000:01:00.0: restoring config space at offset 0xf (was 0x1ff, writing 0x10b) Sep 11 12:52:31 samwise kernel: [24621.713209] radeon 0000:01:00.0: restoring config space at offset 0x5 (was 0x1, writing 0x2001) Sep 11 12:52:31 samwise kernel: [24621.713217] radeon 0000:01:00.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) Sep 11 12:52:31 samwise kernel: [24621.713260] HDA Intel 0000:01:00.1: restoring config space at offset 0xf (was 0x2ff, writing 0x20b) Sep 11 12:52:31 samwise kernel: [24621.713276] HDA Intel 0000:01:00.1: restoring config space at offset 0x4 (was 0x0, writing 0xf4010000) Sep 11 12:52:31 samwise kernel: [24621.713280] HDA Intel 0000:01:00.1: restoring config space at offset 0x3 (was 0x800000, writing 0x800010) Sep 11 12:52:31 samwise kernel: [24621.713286] HDA Intel 0000:01:00.1: restoring config space at offset 0x1 (was 0x100000, writing 0x100103) Sep 11 12:52:31 samwise kernel: [24621.713356] tg3 0000:02:00.0: restoring config space at offset 0x3 (was 0x0, writing 0x10) Sep 11 12:52:31 samwise kernel: [24621.713364] tg3 0000:02:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100106) Sep 11 12:52:31 samwise kernel: [24621.713411] ath9k 0000:03:00.0: restoring config space at offset 0xf (was 0x1ff, writing 0x10b) Sep 11 12:52:31 samwise kernel: [24621.713432] ath9k 0000:03:00.0: restoring config space at offset 0x4 (was 0x4, writing 0xf4200004) Sep 11 12:52:31 samwise kernel: [24621.713438] ath9k 0000:03:00.0: restoring config space at offset 0x3 (was 0x0, writing 0x10) Sep 11 12:52:31 samwise kernel: [24621.713445] ath9k 0000:03:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100107) Sep 11 12:52:31 samwise kernel: [24621.713725] PM: early resume of devices complete after 1.383 msecs Sep 11 12:52:31 samwise kernel: [24621.713921] uhci_hcd 0000:00:1a.0: PCI INT A -> GSI 20 (level, low) -> IRQ 20 Sep 11 12:52:31 samwise kernel: [24621.713927] uhci_hcd 0000:00:1a.0: setting latency timer to 64 Sep 11 12:52:31 samwise kernel: [24621.713948] usb usb3: root hub lost power or was reset Sep 11 12:52:31 samwise kernel: [24621.713986] uhci_hcd 0000:00:1a.1: PCI INT B -> GSI 20 (level, low) -> IRQ 20 Sep 11 12:52:31 samwise kernel: [24621.713992] uhci_hcd 0000:00:1a.1: setting latency timer to 64 Sep 11 12:52:31 samwise kernel: [24621.714013] ehci_hcd 0000:00:1a.7: PCI INT C -> GSI 20 (level, low) -> IRQ 20 Sep 11 12:52:31 samwise kernel: [24621.714015] usb usb4: root hub lost power or was reset Sep 11 12:52:31 samwise kernel: [24621.714021] ehci_hcd 0000:00:1a.7: setting latency timer to 64 Sep 11 12:52:31 samwise kernel: [24621.714044] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 23 (level, low) -> IRQ 23 Sep 11 12:52:31 samwise kernel: [24621.714049] uhci_hcd 0000:00:1d.0: setting latency timer to 64 Sep 11 12:52:31 samwise kernel: [24621.714064] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 Sep 11 12:52:31 samwise kernel: [24621.714072] uhci_hcd 0000:00:1d.1: setting latency timer to 64 Sep 11 12:52:31 samwise kernel: [24621.714076] usb usb5: root hub lost power or was reset Sep 11 12:52:31 samwise kernel: [24621.714096] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 Sep 11 12:52:31 samwise kernel: [24621.714099] usb usb6: root hub lost power or was reset Sep 11 12:52:31 samwise kernel: [24621.714103] uhci_hcd 0000:00:1d.2: setting latency timer to 64 Sep 11 12:52:31 samwise kernel: [24621.714119] uhci_hcd 0000:00:1d.3: PCI INT D -> GSI 18 (level, low) -> IRQ 18 Sep 11 12:52:31 samwise kernel: [24621.714124] usb usb7: root hub lost power or was reset Sep 11 12:52:31 samwise kernel: [24621.714128] uhci_hcd 0000:00:1d.3: setting latency timer to 64 Sep 11 12:52:31 samwise kernel: [24621.714144] ehci_hcd 0000:00:1d.7: PCI INT A -> GSI 23 (level, low) -> IRQ 23 Sep 11 12:52:31 samwise kernel: [24621.714150] usb usb8: root hub lost power or was reset Sep 11 12:52:31 samwise kernel: [24621.714151] ehci_hcd 0000:00:1d.7: setting latency timer to 64 Sep 11 12:52:31 samwise kernel: [24621.714169] pci 0000:00:1e.0: setting latency timer to 64 Sep 11 12:52:31 samwise kernel: [24621.714198] radeon 0000:01:00.0: setting latency timer to 64 Sep 11 12:52:31 samwise kernel: [24621.714204] ahci 0000:00:1f.2: setting latency timer to 64 Sep 11 12:52:31 samwise kernel: [24621.714270] HDA Intel 0000:01:00.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 Sep 11 12:52:31 samwise kernel: [24621.714282] HDA Intel 0000:01:00.1: setting latency timer to 64 Sep 11 12:52:31 samwise kernel: [24621.714392] HDA Intel 0000:01:00.1: irq 45 for MSI/MSI-X Sep 11 12:52:31 samwise kernel: [24621.714432] ath9k 0000:03:00.0: PCI INT A -> GSI 17 (level, low) -> IRQ 17 Sep 11 12:52:31 samwise kernel: [24621.715043] HDA Intel 0000:00:1b.0: power state changed by ACPI to D0 Sep 11 12:52:31 samwise kernel: [24621.715085] HDA Intel 0000:00:1b.0: power state changed by ACPI to D0 Sep 11 12:52:31 samwise kernel: [24621.715126] HDA Intel 0000:00:1b.0: power state changed by ACPI to D0 Sep 11 12:52:31 samwise kernel: [24621.715165] HDA Intel 0000:00:1b.0: power state changed by ACPI to D0 Sep 11 12:52:31 samwise kernel: [24621.715175] HDA Intel 0000:00:1b.0: PCI INT A -> GSI 21 (level, low) -> IRQ 21 Sep 11 12:52:31 samwise kernel: [24621.715187] HDA Intel 0000:00:1b.0: setting latency timer to 64 Sep 11 12:52:31 samwise kernel: [24621.715274] HDA Intel 0000:00:1b.0: irq 47 for MSI/MSI-X Sep 11 12:52:31 samwise kernel: [24621.715725] sd 0:0:0:0: [sda] Starting disk Sep 11 12:52:31 samwise kernel: [24621.716348] [drm] Clocks initialized ! Sep 11 12:52:31 samwise kernel: [24621.768867] [drm] ring test succeeded in 1 usecs Sep 11 12:52:31 samwise kernel: [24621.768886] [drm] ib test succeeded in 0 usecs Sep 11 12:52:31 samwise kernel: [24621.768888] [drm] Enabling audio support Sep 11 12:52:31 samwise kernel: [24621.844029] PM: resume of drv:usb dev:usb2 complete after 129.491 msecs Sep 11 12:52:31 samwise kernel: [24621.844047] PM: resume of drv:hub dev:2-0:1.0 complete after 128.710 msecs Sep 11 12:52:31 samwise kernel: [24621.856081] PM: resume of drv:usb dev:usb8 complete after 140.506 msecs Sep 11 12:52:31 samwise kernel: [24621.856099] PM: resume of drv:usb dev:usb6 complete after 140.591 msecs Sep 11 12:52:31 samwise kernel: [24621.856102] PM: resume of drv:hub dev:8-0:1.0 complete after 140.507 msecs Sep 11 12:52:31 samwise kernel: [24621.856106] PM: resume of drv:hub dev:6-0:1.0 complete after 140.581 msecs Sep 11 12:52:31 samwise kernel: [24621.856123] PM: resume of drv:usb dev:usb5 complete after 140.649 msecs Sep 11 12:52:31 samwise kernel: [24621.856126] PM: resume of drv:usb dev:usb7 complete after 140.585 msecs Sep 11 12:52:31 samwise kernel: [24621.856130] PM: resume of drv:hub dev:5-0:1.0 complete after 140.637 msecs Sep 11 12:52:31 samwise kernel: [24621.856135] PM: resume of drv:hub dev:7-0:1.0 complete after 140.577 msecs Sep 11 12:52:31 samwise kernel: [24621.856143] PM: resume of drv:usb dev:usb4 complete after 140.703 msecs Sep 11 12:52:31 samwise kernel: [24621.856152] PM: resume of drv:hub dev:4-0:1.0 complete after 140.692 msecs Sep 11 12:52:31 samwise kernel: [24621.856155] PM: resume of drv:usb dev:usb3 complete after 140.749 msecs Sep 11 12:52:31 samwise kernel: [24621.856164] PM: resume of drv:hub dev:3-0:1.0 complete after 140.741 msecs Sep 11 12:52:31 samwise kernel: [24621.956031] usb 2-5: reset high speed USB device using ehci_hcd and address 2 Sep 11 12:52:31 samwise kernel: [24622.048034] ata6: SATA link down (SStatus 0 SControl 300) Sep 11 12:52:31 samwise kernel: [24622.056032] ata5: SATA link down (SStatus 0 SControl 300) Sep 11 12:52:31 samwise kernel: [24622.139084] PM: resume of drv:usb dev:2-5 complete after 423.454 msecs Sep 11 12:52:31 samwise kernel: [24622.139095] PM: resume of drv:uvcvideo dev:2-5:1.1 complete after 423.386 msecs Sep 11 12:52:31 samwise kernel: [24622.139101] PM: resume of drv:uvcvideo dev:2-5:1.0 complete after 423.456 msecs Sep 11 12:52:31 samwise kernel: [24622.444044] ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Sep 11 12:52:31 samwise kernel: [24622.445177] ata2.00: configured for UDMA/100 Sep 11 12:52:31 samwise kernel: [24623.188268] PM: resume of drv:radeon dev:0000:01:00.0 complete after 1474.074 msecs Sep 11 12:52:31 samwise kernel: [24624.944050] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300) Sep 11 12:52:31 samwise kernel: [24624.959230] ata1.00: configured for UDMA/133 Sep 11 12:52:31 samwise kernel: [24624.974565] PM: resume of drv:sd dev:0:0:0:0 complete after 3258.837 msecs Sep 11 12:52:31 samwise kernel: [24624.974575] PM: resume of drv:scsi_device dev:0:0:0:0 complete after 3258.812 msecs Sep 11 12:52:31 samwise kernel: [24631.732143] PM: resume of drv:battery dev:PNP0C0A:00 complete after 10018.277 msecs Sep 11 12:52:31 samwise kernel: [24631.767537] PM: resume of devices complete after 10053.781 msecs Sep 11 12:52:31 samwise kernel: [24631.767727] PM: resume devices took 10.052 seconds Sep 11 12:52:31 samwise kernel: [24631.767728] ------------[ cut here ]------------ Sep 11 12:52:31 samwise kernel: [24631.767735] WARNING: at /build/buildd/linux-2.6.35/kernel/power/suspend_test.c:53 suspend_test_finish+0x89/0x90() Sep 11 12:52:31 samwise kernel: [24631.767737] Hardware name: Aspire 5738 Sep 11 12:52:31 samwise kernel: [24631.767739] Component: resume devices, time: 10052 Sep 11 12:52:31 samwise kernel: [24631.767740] Modules linked in: snd_seq_dummy nls_iso8859_1 nls_cp437 usb_storage btrfs zlib_deflate crc32c libcrc32c ufs qnx4 hfsplus hfs minix ntfs vfat msdos fat jfs xfs exportfs reiserfs aes_i586 aes_generic binfmt_misc parport_pc ppdev snd_hda_codec_atihdmi snd_hda_codec_realtek arc4 radeon snd_hda_intel snd_hda_codec snd_hwdep snd_pcm ath9k snd_seq_midi snd_rawmidi ath9k_common snd_seq_midi_event ath9k_hw ath ttm mac80211 snd_seq drm_kms_helper snd_timer snd_seq_device acer_wmi uvcvideo drm cfg80211 videodev v4l1_compat intel_agp i2c_algo_bit snd psmouse serio_raw led_class soundcore snd_page_alloc agpgart video output lp parport tg3 ahci libahci Sep 11 12:52:31 samwise kernel: [24631.767786] Pid: 22981, comm: pm-suspend Tainted: G W 2.6.35-20-generic #29-Ubuntu Sep 11 12:52:31 samwise kernel: [24631.767788] Call Trace: Sep 11 12:52:31 samwise kernel: [24631.767794] [] warn_slowpath_common+0x72/0xa0 Sep 11 12:52:31 samwise kernel: [24631.767797] [] ? suspend_test_finish+0x89/0x90 Sep 11 12:52:31 samwise kernel: [24631.767800] [] ? suspend_test_finish+0x89/0x90 Sep 11 12:52:31 samwise kernel: [24631.767803] [] warn_slowpath_fmt+0x33/0x40 Sep 11 12:52:31 samwise kernel: [24631.767806] [] suspend_test_finish+0x89/0x90 Sep 11 12:52:31 samwise kernel: [24631.767809] [] suspend_devices_and_enter+0xbf/0xf0 Sep 11 12:52:31 samwise kernel: [24631.767812] [] enter_state+0xbd/0xf0 Sep 11 12:52:31 samwise kernel: [24631.767814] [] state_store+0x6d/0xb0 Sep 11 12:52:31 samwise kernel: [24631.767817] [] ? state_store+0x0/0xb0 Sep 11 12:52:31 samwise kernel: [24631.767820] [] kobj_attr_store+0x20/0x30 Sep 11 12:52:31 samwise kernel: [24631.767824] [] sysfs_write_file+0x99/0xf0 Sep 11 12:52:31 samwise kernel: [24631.767829] [] vfs_write+0xa2/0x190 Sep 11 12:52:31 samwise kernel: [24631.767832] [] ? sysfs_write_file+0x0/0xf0 Sep 11 12:52:31 samwise kernel: [24631.767835] [] sys_write+0x42/0x70 Sep 11 12:52:31 samwise kernel: [24631.767839] [] syscall_call+0x7/0xb Sep 11 12:52:31 samwise kernel: [24631.767841] ---[ end trace b8540aa1a8c7bb91 ]--- Sep 11 12:52:31 samwise kernel: [24631.767876] PM: Finishing wakeup. Sep 11 12:52:31 samwise kernel: [24631.767878] Restarting tasks ... done. Sep 11 12:52:31 samwise kernel: [24631.799493] video LNXVIDEO:00: Restoring backlight state Sep 11 12:52:31 samwise kernel: [24632.464769] [drm:drm_mode_getfb] *ERROR* invalid framebuffer id Sep 11 12:52:32 samwise kernel: [24632.507554] tg3 0000:02:00.0: wake-up capability disabled by ACPI Sep 11 12:52:32 samwise kernel: [24632.507561] tg3 0000:02:00.0: PME# disabled Sep 11 12:52:32 samwise kernel: [24632.507643] tg3 0000:02:00.0: irq 48 for MSI/MSI-X Sep 11 12:52:32 samwise kernel: [24632.614191] ADDRCONF(NETDEV_UP): eth0: link is not ready Sep 11 12:52:32 samwise kernel: [24632.669118] ADDRCONF(NETDEV_UP): wlan0: link is not ready Sep 11 12:52:32 samwise kernel: [24632.795424] psmouse serio2: ID: 73 02 64 Sep 11 12:52:32 samwise kernel: [24633.384170] ata1.00: configured for UDMA/133 Sep 11 12:52:32 samwise kernel: [24633.384177] ata1: EH complete Sep 11 12:52:33 samwise kernel: [24633.736815] EXT4-fs (sda1): re-mounted. Opts: errors=remount-ro,commit=0 Sep 11 12:52:34 samwise kernel: [24634.944424] wlan0: authenticate with 00:24:a5:34:13:e2 (try 1) Sep 11 12:52:34 samwise kernel: [24634.948965] wlan0: authenticated Sep 11 12:52:34 samwise kernel: [24634.948982] wlan0: associate with 00:24:a5:34:13:e2 (try 1) Sep 11 12:52:34 samwise kernel: [24634.954683] wlan0: RX AssocResp from 00:24:a5:34:13:e2 (capab=0x431 status=0 aid=1) Sep 11 12:52:34 samwise kernel: [24634.954687] wlan0: associated Sep 11 12:52:34 samwise kernel: [24634.964847] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready Sep 11 12:52:34 samwise dhclient: Internet Systems Consortium DHCP Client V3.1.3 Sep 11 12:52:34 samwise dhclient: Copyright 2004-2009 Internet Systems Consortium. Sep 11 12:52:34 samwise dhclient: All rights reserved. Sep 11 12:52:34 samwise dhclient: For info, please visit https://www.isc.org/software/dhcp/ Sep 11 12:52:34 samwise dhclient: Sep 11 12:52:34 samwise dhclient: Listening on LPF/wlan0/0c:ee:e6:d5:31:35 Sep 11 12:52:34 samwise dhclient: Sending on LPF/wlan0/0c:ee:e6:d5:31:35 Sep 11 12:52:34 samwise dhclient: Sending on Socket/fallback Sep 11 12:52:34 samwise dhclient: DHCPREQUEST of 192.168.11.3 on wlan0 to 255.255.255.255 port 67 Sep 11 12:52:37 samwise dhclient: DHCPREQUEST of 192.168.11.3 on wlan0 to 255.255.255.255 port 67 Sep 11 12:52:37 samwise dhclient: DHCPACK of 192.168.11.3 from 192.168.11.1 Sep 11 12:52:37 samwise dhclient: bound to 192.168.11.3 -- renewal in 75664 seconds. Sep 11 12:52:44 samwise kernel: [24645.032044] wlan0: no IPv6 routers present