Error: command ['sh', '-c', 'dmesg | comm -13 /var/log/dmesg -'] failed with exit code 1: [ 27.123721] vboxdrv: Trying to deactivate the NMI watchdog permanently... [ 27.123727] vboxdrv: Warning: 2.6.31+ kernel detected. Most likely the hwardware performance [ 27.123729] vboxdrv: counter framework which can generate NMIs is active. You have to prevent [ 27.123730] vboxdrv: the usage of hardware performance counters by [ 27.123732] vboxdrv: echo 2 > /proc/sys/kernel/perf_counter_paranoid [ 27.123736] vboxdrv: Found 2 processor cores. [ 27.123818] vboxdrv: fAsync=1 offMin=0x44597d1d offMax=0x44597d1d [ 27.123871] vboxdrv: TSC mode is 'asynchronous', kernel timer mode is 'normal'. [ 27.123874] vboxdrv: Successfully loaded version 3.0.6_OSE (interface 0x000e0000). [ 27.500068] ppdev: user-space parallel port driver [ 53.649780] wlan0: authenticate with AP 00:1f:9f:eb:32:d9 [ 53.848156] wlan0: authenticate with AP 00:1f:9f:eb:32:d9 [ 53.850876] wlan0: authenticated [ 53.850883] wlan0: associate with AP 00:1f:9f:eb:32:d9 [ 53.933069] wlan0: RX AssocResp from 00:1f:9f:eb:32:d9 (capab=0x411 status=0 aid=1) [ 53.933075] wlan0: associated [ 53.933721] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 64.424017] wlan0: no IPv6 routers present [ 65.375346] ath5k phy0: unsupported jumbo [ 66.222836] ath5k phy0: unsupported jumbo comm: file 2 is not in sorted order [ 323.054417] wlan0: no probe response from AP 00:1f:9f:eb:32:d9 - disassociating [ 330.928150] wlan0: direct probe to AP 00:1f:9f:eb:32:d9 try 1 [ 330.934781] wlan0 direct probe responded [ 330.934785] wlan0: authenticate with AP 00:1f:9f:eb:32:d9 [ 330.969122] wlan0: authenticated [ 330.969129] wlan0: associate with AP 00:1f:9f:eb:32:d9 [ 331.177045] wlan0: associate with AP 00:1f:9f:eb:32:d9 [ 331.377043] wlan0: associate with AP 00:1f:9f:eb:32:d9 [ 331.545568] wlan0: RX ReassocResp from 00:1f:9f:eb:32:d9 (capab=0x411 status=0 aid=1) [ 331.545575] wlan0: associated [ 606.681360] wlan0: no probe response from AP 00:1f:9f:eb:32:d9 - disassociating [ 620.971620] wlan0: direct probe to AP 00:1f:9f:eb:32:d9 try 1 [ 620.973381] wlan0 direct probe responded [ 620.973387] wlan0: authenticate with AP 00:1f:9f:eb:32:d9 [ 620.977493] wlan0: authenticated [ 620.977504] wlan0: associate with AP 00:1f:9f:eb:32:d9 [ 620.989117] wlan0: RX ReassocResp from 00:1f:9f:eb:32:d9 (capab=0x411 status=0 aid=1) [ 620.989133] wlan0: associated [ 632.993123] wlan0: no probe response from AP 00:1f:9f:eb:32:d9 - disassociating [ 634.468104] wlan0: direct probe to AP 00:1f:9f:eb:32:d9 try 1 [ 634.664094] wlan0: direct probe to AP 00:1f:9f:eb:32:d9 try 2 [ 634.864370] wlan0: direct probe to AP 00:1f:9f:eb:32:d9 try 3 [ 635.064280] wlan0: direct probe to AP 00:1f:9f:eb:32:d9 timed out [ 640.842916] wlan0: authenticate with AP 00:1f:9f:eb:32:d9 [ 640.844762] wlan0: authenticated [ 640.844766] wlan0: associate with AP 00:1f:9f:eb:32:d9 [ 640.847503] wlan0: RX ReassocResp from 00:1f:9f:eb:32:d9 (capab=0x411 status=0 aid=1) [ 640.847507] wlan0: associated [ 678.147980] ath5k phy0: unsupported jumbo [ 824.092546] ath5k phy0: unsupported jumbo [ 898.572295] wlan0: no probe response from AP 00:1f:9f:eb:32:d9 - disassociating [ 912.776125] wlan0: authenticate with AP 00:1f:9f:eb:32:d9 [ 912.972272] wlan0: authenticate with AP 00:1f:9f:eb:32:d9 [ 913.172183] wlan0: authenticate with AP 00:1f:9f:eb:32:d9 [ 913.375514] wlan0: authentication with AP 00:1f:9f:eb:32:d9 timed out [ 946.786917] wlan0: direct probe to AP 00:1f:9f:eb:32:d9 try 1 [ 946.984053] wlan0: direct probe to AP 00:1f:9f:eb:32:d9 try 2 [ 947.184062] wlan0: direct probe to AP 00:1f:9f:eb:32:d9 try 3 [ 947.388049] wlan0: direct probe to AP 00:1f:9f:eb:32:d9 timed out [ 959.492948] wlan0: authenticate with AP 00:1f:9f:eb:32:d9 [ 959.689395] wlan0: authenticate with AP 00:1f:9f:eb:32:d9 [ 959.889721] wlan0: authenticate with AP 00:1f:9f:eb:32:d9 [ 960.091145] wlan0: authentication with AP 00:1f:9f:eb:32:d9 timed out [ 1003.545670] wlan0: direct probe to AP 00:1f:9f:eb:32:d9 try 1 [ 1003.744166] wlan0: direct probe to AP 00:1f:9f:eb:32:d9 try 2 [ 1003.948055] wlan0: direct probe to AP 00:1f:9f:eb:32:d9 try 3 [ 1004.148319] wlan0: direct probe to AP 00:1f:9f:eb:32:d9 timed out [ 1016.229771] wlan0: authenticate with AP 00:1f:9f:eb:32:d9 [ 1016.231591] wlan0: authenticated [ 1016.231594] wlan0: associate with AP 00:1f:9f:eb:32:d9 [ 1016.234277] wlan0: RX ReassocResp from 00:1f:9f:eb:32:d9 (capab=0x411 status=0 aid=1) [ 1016.234283] wlan0: associated [ 1028.336420] eth0: link up. [ 1028.337581] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 1038.569460] eth0: no IPv6 routers present [ 1110.061346] wlan0: deauthenticating by local choice (reason=3) [ 1110.126147] wlan0: disassociating by local choice (reason=3) [ 1112.602767] PM: Syncing filesystems ... done. [ 1112.605239] PM: Preparing system for mem sleep [ 1112.605243] Freezing user space processes ... (elapsed 0.00 seconds) done. [ 1112.606263] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done. [ 1112.606337] PM: Entering mem sleep [ 1112.606352] Suspending console(s) (use no_console_suspend to debug) [ 1112.664127] sd 1:0:0:0: [sda] Synchronizing SCSI cache [ 1112.764571] sd 1:0:0:0: [sda] Stopping disk [ 1114.368253] ath5k 0000:07:00.0: PCI INT A disabled [ 1114.381748] forcedeth 0000:00:0a.0: wake-up capability disabled by ACPI [ 1114.381757] forcedeth 0000:00:0a.0: PME# disabled [ 1114.381764] forcedeth 0000:00:0a.0: PCI INT A disabled [ 1114.572399] HDA Intel 0000:00:07.0: PCI INT A disabled [ 1114.588464] ata4: port disabled. ignoring. [ 1114.604397] ehci_hcd 0000:00:04.1: PCI INT B disabled [ 1114.604404] ohci_hcd 0000:00:04.0: PCI INT A disabled [ 1114.604411] ehci_hcd 0000:00:02.1: PCI INT B disabled [ 1114.604417] ohci_hcd 0000:00:02.0: PCI INT A disabled [ 1114.604490] PM: suspend devices took 2.000 seconds [ 1114.604822] ehci_hcd 0000:00:04.1: PME# disabled [ 1114.620587] ohci_hcd 0000:00:04.0: PME# disabled [ 1114.636575] ehci_hcd 0000:00:02.1: PME# disabled [ 1114.652185] ohci_hcd 0000:00:02.0: PME# disabled [ 1114.679123] ACPI: Preparing to enter system sleep state S3 [ 1114.712232] Disabling non-boot CPUs ... [ 1114.816016] CPU 1 is now offline [ 1114.816018] SMP alternatives: switching to UP code [ 1114.820754] CPU0 attaching NULL sched-domain. [ 1114.820758] CPU1 attaching NULL sched-domain. [ 1114.820767] CPU0 attaching NULL sched-domain. [ 1114.820994] CPU1 is down [ 1114.821073] Extended CMOS year: 2000 [ 1114.821073] Back to C! [ 1114.821073] Extended CMOS year: 2000 [ 1114.821073] Enabling non-boot CPUs ... [ 1114.821073] SMP alternatives: switching to SMP code [ 1114.828270] Booting processor 1 APIC 0x1 ip 0x6000 [ 1114.820579] Initializing CPU#1 [ 1114.820579] Calibrating delay using timer specific routine.. 4000.08 BogoMIPS (lpj=8000176) [ 1114.820579] CPU: L1 I Cache: 64K (64 bytes/line), D cache 64K (64 bytes/line) [ 1114.820579] CPU: L2 Cache: 512K (64 bytes/line) [ 1114.820579] CPU: Physical Processor ID: 0 [ 1114.820579] CPU: Processor Core ID: 1 [ 1114.916214] CPU1: AMD Turion Dual-Core RM-70 stepping 01 [ 1114.916294] CPU0 attaching NULL sched-domain. [ 1114.920031] Switched to high resolution mode on CPU 1 [ 1114.932024] CPU0 attaching sched-domain: [ 1114.932028] domain 0: span 0-1 level MC [ 1114.932031] groups: 0 1 [ 1114.932035] CPU1 attaching sched-domain: [ 1114.932037] domain 0: span 0-1 level MC [ 1114.932039] groups: 1 0 [ 1114.933021] CPU1 is up [ 1114.933025] ACPI: Waking up from system sleep state S3 [ 1115.007921] ohci_hcd 0000:00:02.0: restoring config space at offset 0x1 (was 0xb00007, writing 0xb00003) [ 1115.007937] ohci_hcd 0000:00:02.0: PME# disabled [ 1115.007959] ehci_hcd 0000:00:02.1: restoring config space at offset 0x1 (was 0xb00006, writing 0xb00002) [ 1115.007978] ehci_hcd 0000:00:02.1: PME# disabled [ 1115.007998] ohci_hcd 0000:00:04.0: restoring config space at offset 0x1 (was 0xb00007, writing 0xb00003) [ 1115.008014] ohci_hcd 0000:00:04.0: PME# disabled [ 1115.008036] ehci_hcd 0000:00:04.1: restoring config space at offset 0x1 (was 0xb00006, writing 0xb00002) [ 1115.008054] ehci_hcd 0000:00:04.1: PME# disabled [ 1115.008074] pata_amd 0000:00:06.0: restoring config space at offset 0x1 (was 0xb00005, writing 0xb80005) [ 1115.008096] HDA Intel 0000:00:07.0: restoring config space at offset 0xf (was 0x5020100, writing 0x502010a) [ 1115.008111] HDA Intel 0000:00:07.0: restoring config space at offset 0x4 (was 0x0, writing 0xc0000000) [ 1115.008117] HDA Intel 0000:00:07.0: restoring config space at offset 0x1 (was 0xb00000, writing 0xb00002) [ 1115.008252] HDA Intel 0000:00:07.0: Enabling HT MSI Mapping [ 1115.008400] pci 0000:00:08.0: Enabling HT MSI Mapping [ 1115.008423] ahci 0000:00:09.0: restoring config space at offset 0x1 (was 0xb00007, writing 0xb00407) [ 1115.008574] ahci 0000:00:09.0: Enabling HT MSI Mapping [ 1115.008749] forcedeth 0000:00:0a.0: Enabling HT MSI Mapping [ 1115.008917] pci 0000:00:0b.0: Enabling HT MSI Mapping [ 1115.009011] pcieport-driver 0000:00:14.0: restoring config space at offset 0x7 (was 0x1f1, writing 0x200001f1) [ 1115.009036] pcieport-driver 0000:00:14.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [ 1115.009236] nvidia 0000:02:00.0: restoring config space at offset 0xf (was 0x100, writing 0x10a) [ 1115.009244] nvidia 0000:02:00.0: restoring config space at offset 0x9 (was 0x1, writing 0x4001) [ 1115.009248] nvidia 0000:02:00.0: restoring config space at offset 0x7 (was 0xc, writing 0xc400000c) [ 1115.009253] nvidia 0000:02:00.0: restoring config space at offset 0x5 (was 0xc, writing 0xd000000c) [ 1115.009302] ath5k 0000:07:00.0: restoring config space at offset 0x3 (was 0x0, writing 0x8) [ 1115.193543] nForce2_smbus 0000:00:01.1: PME# disabled [ 1115.193551] ohci_hcd 0000:00:02.0: PME# disabled [ 1115.193562] ohci_hcd 0000:00:02.0: PCI INT A -> Link[LUS0] -> GSI 17 (level, low) -> IRQ 17 [ 1115.193569] ohci_hcd 0000:00:02.0: setting latency timer to 64 [ 1115.216569] ehci_hcd 0000:00:02.1: PME# disabled [ 1115.216574] ehci_hcd 0000:00:02.1: PCI INT B -> Link[LUS2] -> GSI 17 (level, low) -> IRQ 17 [ 1115.216580] ehci_hcd 0000:00:02.1: setting latency timer to 64 [ 1115.216584] usb usb1: root hub lost power or was reset [ 1115.216596] ehci_hcd 0000:00:02.1: debug port 1 [ 1115.216601] ehci_hcd 0000:00:02.1: cache line size of 64 is not supported [ 1115.216610] ohci_hcd 0000:00:04.0: PME# disabled [ 1115.216615] ohci_hcd 0000:00:04.0: PCI INT A -> Link[Z010] -> GSI 16 (level, low) -> IRQ 16 [ 1115.216620] ohci_hcd 0000:00:04.0: setting latency timer to 64 [ 1115.240566] ehci_hcd 0000:00:04.1: PME# disabled [ 1115.240571] ehci_hcd 0000:00:04.1: PCI INT B -> Link[Z011] -> GSI 16 (level, low) -> IRQ 16 [ 1115.240576] ehci_hcd 0000:00:04.1: setting latency timer to 64 [ 1115.240581] usb usb2: root hub lost power or was reset [ 1115.240590] ehci_hcd 0000:00:04.1: debug port 1 [ 1115.240595] ehci_hcd 0000:00:04.1: cache line size of 64 is not supported [ 1115.240606] pata_amd 0000:00:06.0: setting latency timer to 64 [ 1115.240625] HDA Intel 0000:00:07.0: PCI INT A -> Link[LAZA] -> GSI 19 (level, low) -> IRQ 19 [ 1115.240630] HDA Intel 0000:00:07.0: setting latency timer to 64 [ 1115.240665] pci 0000:00:08.0: setting latency timer to 64 [ 1115.240674] ahci 0000:00:09.0: setting latency timer to 64 [ 1115.240696] forcedeth 0000:00:0a.0: wake-up capability disabled by ACPI [ 1115.240701] forcedeth 0000:00:0a.0: PME# disabled [ 1115.241495] ata4: port disabled. ignoring. [ 1115.724568] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [ 1115.761113] pci 0000:00:0b.0: setting latency timer to 64 [ 1116.054707] ata1.00: configured for UDMA/100 [ 1116.106165] ata1: exception Emask 0x10 SAct 0x0 SErr 0x0 action 0x9 t4 [ 1116.106168] ata1: irq_stat 0x40000001 [ 1116.182387] ata1.00: configured for UDMA/100 [ 1116.182390] ata1: EH complete [ 1116.365028] ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [ 1116.366883] ata2.00: configured for UDMA/100 [ 1120.540263] ath5k 0000:07:00.0: PCI INT A -> Link[Z012] -> GSI 23 (level, low) -> IRQ 23 [ 1121.026079] sd 1:0:0:0: [sda] Starting disk [ 1121.176156] usb 1-1: reset high speed USB device using ehci_hcd and address 2 [ 1121.424474] usb 2-2: reset high speed USB device using ehci_hcd and address 2 [ 1121.605079] PM: resume devices took 6.596 seconds [ 1121.605082] ------------[ cut here ]------------ [ 1121.605090] WARNING: at /build/buildd/linux-2.6.31/kernel/power/suspend_test.c:52 suspend_test_finish+0x80/0x90() [ 1121.605093] Hardware name: Compaq Presario CQ50 Notebook PC [ 1121.605095] Component: resume devices [ 1121.605097] Modules linked in: binfmt_misc ppdev vboxnetadp vboxnetflt vboxdrv snd_hda_codec_nvhdmi snd_hda_codec_conexant snd_hda_intel snd_hda_codec snd_pcm_oss snd_mixer_oss snd_pcm arc4 snd_seq_dummy ecb snd_seq_oss ath5k joydev snd_seq_midi snd_rawmidi snd_seq_midi_event snd_seq mac80211 snd_timer led_class nvidia(P) uvcvideo videodev v4l1_compat snd_seq_device ath iptable_filter ip_tables x_tables video output psmouse serio_raw i2c_nforce2 cfg80211 agpgart snd soundcore snd_page_alloc shpchp lp parport usb_storage forcedeth [ 1121.605134] Pid: 2499, comm: pm-suspend Tainted: P 2.6.31-11-generic #38-Ubuntu [ 1121.605137] Call Trace: [ 1121.605144] [] warn_slowpath_common+0x6d/0xa0 [ 1121.605148] [] ? suspend_test_finish+0x80/0x90 [ 1121.605151] [] ? suspend_test_finish+0x80/0x90 [ 1121.605155] [] warn_slowpath_fmt+0x26/0x30 [ 1121.605159] [] suspend_test_finish+0x80/0x90 [ 1121.605162] [] suspend_devices_and_enter+0x9f/0xd0 [ 1121.605167] [] ? printk+0x18/0x1a [ 1121.605170] [] enter_state+0xb9/0xf0 [ 1121.605173] [] state_store+0x6d/0xb0 [ 1121.605176] [] ? state_store+0x0/0xb0 [ 1121.605180] [] kobj_attr_store+0x20/0x30 [ 1121.605185] [] sysfs_write_file+0x90/0x100 [ 1121.605190] [] vfs_write+0x9a/0x190 [ 1121.605193] [] ? sysfs_write_file+0x0/0x100 [ 1121.605197] [] ? do_page_fault+0x19b/0x380 [ 1121.605200] [] sys_write+0x3d/0x70 [ 1121.605204] [] syscall_call+0x7/0xb [ 1121.605207] ---[ end trace a804dd967d57aac5 ]--- [ 1121.605408] PM: Finishing wakeup. [ 1121.605410] Restarting tasks ... done. [ 1122.841366] forcedeth 0000:00:0a.0: irq 26 for MSI/MSI-X [ 1122.968936] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 1133.096139] eth0: no IPv6 routers present [ 1136.394944] wlan0: authenticate with AP 00:1f:9f:eb:32:d9 [ 1136.427511] wlan0: authenticated [ 1136.427523] wlan0: associate with AP 00:1f:9f:eb:32:d9 [ 1136.487880] wlan0: RX AssocResp from 00:1f:9f:eb:32:d9 (capab=0x411 status=0 aid=1) [ 1136.487893] wlan0: associated [ 1136.490292] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 1138.611723] eth0: link down. [ 1142.932221] wlan0: deauthenticating by local choice (reason=3) [ 1142.999489] wlan0: disassociating by local choice (reason=3) [ 1145.135914] eth0: link up. [ 1325.384045] eth0: link down. [ 1329.074445] PM: Syncing filesystems ... done. [ 1329.077230] PM: Preparing system for mem sleep [ 1329.077234] Freezing user space processes ... (elapsed 0.00 seconds) done. [ 1329.078196] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done. [ 1329.078258] PM: Entering mem sleep [ 1329.078273] Suspending console(s) (use no_console_suspend to debug) [ 1329.140049] sd 1:0:0:0: [sda] Synchronizing SCSI cache [ 1329.140108] sd 1:0:0:0: [sda] Stopping disk [ 1330.745650] ath5k 0000:07:00.0: PCI INT A disabled [ 1330.761527] forcedeth 0000:00:0a.0: wake-up capability disabled by ACPI [ 1330.761537] forcedeth 0000:00:0a.0: PME# disabled [ 1330.824048] HDA Intel 0000:00:07.0: PCI INT A disabled [ 1330.840071] ata4: port disabled. ignoring. [ 1330.856033] ehci_hcd 0000:00:04.1: PCI INT B disabled [ 1330.856040] ohci_hcd 0000:00:04.0: PCI INT A disabled [ 1330.856047] ehci_hcd 0000:00:02.1: PCI INT B disabled [ 1330.856053] ohci_hcd 0000:00:02.0: PCI INT A disabled [ 1330.856125] PM: suspend devices took 1.780 seconds [ 1330.856458] ehci_hcd 0000:00:04.1: PME# disabled [ 1330.872051] ohci_hcd 0000:00:04.0: PME# disabled [ 1330.888055] ehci_hcd 0000:00:02.1: PME# disabled [ 1330.904050] ohci_hcd 0000:00:02.0: PME# disabled [ 1330.930962] ACPI: Preparing to enter system sleep state S3 [ 1330.964893] Disabling non-boot CPUs ... [ 1331.068017] CPU 1 is now offline [ 1331.068020] SMP alternatives: switching to UP code [ 1331.072708] CPU0 attaching NULL sched-domain. [ 1331.072712] CPU1 attaching NULL sched-domain. [ 1331.072720] CPU0 attaching NULL sched-domain. [ 1331.072951] CPU1 is down [ 1331.073028] Extended CMOS year: 2000 [ 1331.073028] Back to C! [ 1331.073028] Extended CMOS year: 2000 [ 1331.073028] Enabling non-boot CPUs ... [ 1331.073028] SMP alternatives: switching to SMP code [ 1331.080219] Booting processor 1 APIC 0x1 ip 0x6000 [ 1331.072554] Initializing CPU#1 [ 1331.072554] Calibrating delay using timer specific routine.. 3998.07 BogoMIPS (lpj=7996157) [ 1331.072554] CPU: L1 I Cache: 64K (64 bytes/line), D cache 64K (64 bytes/line) [ 1331.072554] CPU: L2 Cache: 512K (64 bytes/line) [ 1331.072554] CPU: Physical Processor ID: 0 [ 1331.072554] CPU: Processor Core ID: 1 [ 1331.168216] CPU1: AMD Turion Dual-Core RM-70 stepping 01 [ 1331.168283] CPU0 attaching NULL sched-domain. [ 1331.169028] Switched to high resolution mode on CPU 1 [ 1331.184026] CPU0 attaching sched-domain: [ 1331.184030] domain 0: span 0-1 level MC [ 1331.184033] groups: 0 1 [ 1331.184037] CPU1 attaching sched-domain: [ 1331.184039] domain 0: span 0-1 level MC [ 1331.184041] groups: 1 0 [ 1331.185024] CPU1 is up [ 1331.185027] ACPI: Waking up from system sleep state S3 [ 1331.256439] ohci_hcd 0000:00:02.0: restoring config space at offset 0x1 (was 0xb00007, writing 0xb00003) [ 1331.256455] ohci_hcd 0000:00:02.0: PME# disabled [ 1331.256478] ehci_hcd 0000:00:02.1: restoring config space at offset 0x1 (was 0xb00006, writing 0xb00002) [ 1331.256496] ehci_hcd 0000:00:02.1: PME# disabled [ 1331.256516] ohci_hcd 0000:00:04.0: restoring config space at offset 0x1 (was 0xb00007, writing 0xb00003) [ 1331.256530] ohci_hcd 0000:00:04.0: PME# disabled [ 1331.256552] ehci_hcd 0000:00:04.1: restoring config space at offset 0x1 (was 0xb00006, writing 0xb00002) [ 1331.256570] ehci_hcd 0000:00:04.1: PME# disabled [ 1331.256608] HDA Intel 0000:00:07.0: restoring config space at offset 0xf (was 0x5020100, writing 0x502010a) [ 1331.256623] HDA Intel 0000:00:07.0: restoring config space at offset 0x4 (was 0x0, writing 0xc0000000) [ 1331.256631] HDA Intel 0000:00:07.0: restoring config space at offset 0x1 (was 0xb00000, writing 0xb00002) [ 1331.256767] HDA Intel 0000:00:07.0: Enabling HT MSI Mapping [ 1331.256915] pci 0000:00:08.0: Enabling HT MSI Mapping [ 1331.256938] ahci 0000:00:09.0: restoring config space at offset 0x1 (was 0xb00007, writing 0xb00407) [ 1331.257098] ahci 0000:00:09.0: Enabling HT MSI Mapping [ 1331.257273] forcedeth 0000:00:0a.0: Enabling HT MSI Mapping [ 1331.257441] pci 0000:00:0b.0: Enabling HT MSI Mapping [ 1331.257546] pcieport-driver 0000:00:14.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [ 1331.257746] nvidia 0000:02:00.0: restoring config space at offset 0xf (was 0x100, writing 0x10a) [ 1331.257754] nvidia 0000:02:00.0: restoring config space at offset 0x9 (was 0x1, writing 0x4001) [ 1331.257759] nvidia 0000:02:00.0: restoring config space at offset 0x7 (was 0xc, writing 0xc400000c) [ 1331.257764] nvidia 0000:02:00.0: restoring config space at offset 0x5 (was 0xc, writing 0xd000000c) [ 1331.257812] ath5k 0000:07:00.0: restoring config space at offset 0x3 (was 0x0, writing 0x8) [ 1331.438617] nForce2_smbus 0000:00:01.1: PME# disabled [ 1331.438626] ohci_hcd 0000:00:02.0: PME# disabled [ 1331.438637] ohci_hcd 0000:00:02.0: PCI INT A -> Link[LUS0] -> GSI 17 (level, low) -> IRQ 17 [ 1331.438643] ohci_hcd 0000:00:02.0: setting latency timer to 64 [ 1331.460579] ehci_hcd 0000:00:02.1: PME# disabled [ 1331.460584] ehci_hcd 0000:00:02.1: PCI INT B -> Link[LUS2] -> GSI 17 (level, low) -> IRQ 17 [ 1331.460590] ehci_hcd 0000:00:02.1: setting latency timer to 64 [ 1331.460595] usb usb1: root hub lost power or was reset [ 1331.460606] ehci_hcd 0000:00:02.1: debug port 1 [ 1331.460611] ehci_hcd 0000:00:02.1: cache line size of 64 is not supported [ 1331.460620] ohci_hcd 0000:00:04.0: PME# disabled [ 1331.460625] ohci_hcd 0000:00:04.0: PCI INT A -> Link[Z010] -> GSI 16 (level, low) -> IRQ 16 [ 1331.460630] ohci_hcd 0000:00:04.0: setting latency timer to 64 [ 1331.484577] ehci_hcd 0000:00:04.1: PME# disabled [ 1331.484583] ehci_hcd 0000:00:04.1: PCI INT B -> Link[Z011] -> GSI 16 (level, low) -> IRQ 16 [ 1331.484588] ehci_hcd 0000:00:04.1: setting latency timer to 64 [ 1331.484592] usb usb2: root hub lost power or was reset [ 1331.484601] ehci_hcd 0000:00:04.1: debug port 1 [ 1331.484606] ehci_hcd 0000:00:04.1: cache line size of 64 is not supported [ 1331.484617] pata_amd 0000:00:06.0: setting latency timer to 64 [ 1331.484635] HDA Intel 0000:00:07.0: PCI INT A -> Link[LAZA] -> GSI 19 (level, low) -> IRQ 19 [ 1331.484640] HDA Intel 0000:00:07.0: setting latency timer to 64 [ 1331.484676] pci 0000:00:08.0: setting latency timer to 64 [ 1331.484685] ahci 0000:00:09.0: setting latency timer to 64 [ 1331.484707] forcedeth 0000:00:0a.0: wake-up capability disabled by ACPI [ 1331.484712] forcedeth 0000:00:0a.0: PME# disabled [ 1331.485506] ata4: port disabled. ignoring. [ 1331.968576] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [ 1332.005107] pci 0000:00:0b.0: setting latency timer to 64 [ 1332.321961] ata1.00: configured for UDMA/100 [ 1332.373518] ata1: exception Emask 0x10 SAct 0x0 SErr 0x0 action 0x9 t4 [ 1332.373521] ata1: irq_stat 0x40000001 [ 1332.449693] ata1.00: configured for UDMA/100 [ 1332.449696] ata1: EH complete [ 1332.605029] ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [ 1332.606482] ata2.00: configured for UDMA/100 [ 1336.785514] ath5k 0000:07:00.0: PCI INT A -> Link[Z012] -> GSI 23 (level, low) -> IRQ 23 [ 1337.273148] sd 1:0:0:0: [sda] Starting disk [ 1337.440273] usb 1-1: reset high speed USB device using ehci_hcd and address 2 [ 1337.692486] usb 2-2: reset high speed USB device using ehci_hcd and address 2 [ 1337.873323] PM: resume devices took 6.616 seconds [ 1337.873326] ------------[ cut here ]------------ [ 1337.873334] WARNING: at /build/buildd/linux-2.6.31/kernel/power/suspend_test.c:52 suspend_test_finish+0x80/0x90() [ 1337.873337] Hardware name: Compaq Presario CQ50 Notebook PC [ 1337.873339] Component: resume devices [ 1337.873341] Modules linked in: binfmt_misc ppdev vboxnetadp vboxnetflt vboxdrv snd_hda_codec_nvhdmi snd_hda_codec_conexant snd_hda_intel snd_hda_codec snd_pcm_oss snd_mixer_oss snd_pcm arc4 snd_seq_dummy ecb snd_seq_oss ath5k joydev snd_seq_midi snd_rawmidi snd_seq_midi_event snd_seq mac80211 snd_timer led_class nvidia(P) uvcvideo videodev v4l1_compat snd_seq_device ath iptable_filter ip_tables x_tables video output psmouse serio_raw i2c_nforce2 cfg80211 agpgart snd soundcore snd_page_alloc shpchp lp parport usb_storage forcedeth [ 1337.873378] Pid: 3112, comm: pm-suspend Tainted: P W 2.6.31-11-generic #38-Ubuntu [ 1337.873381] Call Trace: [ 1337.873388] [] warn_slowpath_common+0x6d/0xa0 [ 1337.873392] [] ? suspend_test_finish+0x80/0x90 [ 1337.873396] [] ? suspend_test_finish+0x80/0x90 [ 1337.873399] [] warn_slowpath_fmt+0x26/0x30 [ 1337.873403] [] suspend_test_finish+0x80/0x90 [ 1337.873406] [] suspend_devices_and_enter+0x9f/0xd0 [ 1337.873411] [] ? printk+0x18/0x1a [ 1337.873414] [] enter_state+0xb9/0xf0 [ 1337.873417] [] state_store+0x6d/0xb0 [ 1337.873420] [] ? state_store+0x0/0xb0 [ 1337.873424] [] kobj_attr_store+0x20/0x30 [ 1337.873429] [] sysfs_write_file+0x90/0x100 [ 1337.873434] [] vfs_write+0x9a/0x190 [ 1337.873438] [] ? sysfs_write_file+0x0/0x100 [ 1337.873441] [] ? do_page_fault+0x19b/0x380 [ 1337.873444] [] sys_write+0x3d/0x70 [ 1337.873448] [] syscall_call+0x7/0xb [ 1337.873450] ---[ end trace a804dd967d57aac6 ]--- [ 1337.873652] PM: Finishing wakeup. [ 1337.873654] Restarting tasks ... done. [ 1338.885614] forcedeth 0000:00:0a.0: irq 26 for MSI/MSI-X [ 1338.885839] eth0: no link during initialization. [ 1338.886361] ADDRCONF(NETDEV_UP): eth0: link is not ready [ 1342.705599] PM: Syncing filesystems ... done. [ 1342.708398] PM: Preparing system for mem sleep [ 1342.708402] Freezing user space processes ... (elapsed 0.00 seconds) done. [ 1342.711583] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done. [ 1342.711648] PM: Entering mem sleep [ 1342.711664] Suspending console(s) (use no_console_suspend to debug) [ 1342.772184] sd 1:0:0:0: [sda] Synchronizing SCSI cache [ 1342.772228] sd 1:0:0:0: [sda] Stopping disk [ 1344.374694] ath5k 0000:07:00.0: PCI INT A disabled [ 1344.389841] forcedeth 0000:00:0a.0: wake-up capability disabled by ACPI [ 1344.389851] forcedeth 0000:00:0a.0: PME# disabled [ 1344.452578] HDA Intel 0000:00:07.0: PCI INT A disabled [ 1344.468607] ata4: port disabled. ignoring. [ 1344.484568] ehci_hcd 0000:00:04.1: PCI INT B disabled [ 1344.484575] ohci_hcd 0000:00:04.0: PCI INT A disabled [ 1344.484582] ehci_hcd 0000:00:02.1: PCI INT B disabled [ 1344.484588] ohci_hcd 0000:00:02.0: PCI INT A disabled [ 1344.484660] PM: suspend devices took 1.776 seconds [ 1344.484992] ehci_hcd 0000:00:04.1: PME# disabled [ 1344.500587] ohci_hcd 0000:00:04.0: PME# disabled [ 1344.516591] ehci_hcd 0000:00:02.1: PME# disabled [ 1344.532586] ohci_hcd 0000:00:02.0: PME# disabled [ 1344.559449] ACPI: Preparing to enter system sleep state S3 [ 1344.593534] Disabling non-boot CPUs ... [ 1344.696448] CPU 1 is now offline [ 1344.696451] SMP alternatives: switching to UP code [ 1344.701138] CPU0 attaching NULL sched-domain. [ 1344.701142] CPU1 attaching NULL sched-domain. [ 1344.701150] CPU0 attaching NULL sched-domain. [ 1344.701383] CPU1 is down [ 1344.701461] Extended CMOS year: 2000 [ 1344.701461] Back to C! [ 1344.701461] Extended CMOS year: 2000 [ 1344.701461] Enabling non-boot CPUs ... [ 1344.704198] SMP alternatives: switching to SMP code [ 1344.708555] Booting processor 1 APIC 0x1 ip 0x6000 [ 1344.700978] Initializing CPU#1 [ 1344.700978] Calibrating delay using timer specific routine.. 4000.10 BogoMIPS (lpj=8000209) [ 1344.700978] CPU: L1 I Cache: 64K (64 bytes/line), D cache 64K (64 bytes/line) [ 1344.700978] CPU: L2 Cache: 512K (64 bytes/line) [ 1344.700978] CPU: Physical Processor ID: 0 [ 1344.700978] CPU: Processor Core ID: 1 [ 1344.796207] CPU1: AMD Turion Dual-Core RM-70 stepping 01 [ 1344.796272] CPU0 attaching NULL sched-domain. [ 1344.797027] Switched to high resolution mode on CPU 1 [ 1344.812029] CPU0 attaching sched-domain: [ 1344.812033] domain 0: span 0-1 level MC [ 1344.812036] groups: 0 1 [ 1344.812040] CPU1 attaching sched-domain: [ 1344.812042] domain 0: span 0-1 level MC [ 1344.812045] groups: 1 0 [ 1344.813022] CPU1 is up [ 1344.813025] ACPI: Waking up from system sleep state S3 [ 1344.890419] ohci_hcd 0000:00:02.0: restoring config space at offset 0x1 (was 0xb00007, writing 0xb00003) [ 1344.890435] ohci_hcd 0000:00:02.0: PME# disabled [ 1344.890458] ehci_hcd 0000:00:02.1: restoring config space at offset 0x1 (was 0xb00006, writing 0xb00002) [ 1344.890476] ehci_hcd 0000:00:02.1: PME# disabled [ 1344.890496] ohci_hcd 0000:00:04.0: restoring config space at offset 0x1 (was 0xb00007, writing 0xb00003) [ 1344.890510] ohci_hcd 0000:00:04.0: PME# disabled [ 1344.890532] ehci_hcd 0000:00:04.1: restoring config space at offset 0x1 (was 0xb00006, writing 0xb00002) [ 1344.890550] ehci_hcd 0000:00:04.1: PME# disabled [ 1344.890588] HDA Intel 0000:00:07.0: restoring config space at offset 0xf (was 0x5020100, writing 0x502010a) [ 1344.890601] HDA Intel 0000:00:07.0: restoring config space at offset 0x4 (was 0x0, writing 0xc0000000) [ 1344.890608] HDA Intel 0000:00:07.0: restoring config space at offset 0x1 (was 0xb00000, writing 0xb00002) [ 1344.890743] HDA Intel 0000:00:07.0: Enabling HT MSI Mapping [ 1344.890891] pci 0000:00:08.0: Enabling HT MSI Mapping [ 1344.890914] ahci 0000:00:09.0: restoring config space at offset 0x1 (was 0xb00007, writing 0xb00407) [ 1344.891066] ahci 0000:00:09.0: Enabling HT MSI Mapping [ 1344.891241] forcedeth 0000:00:0a.0: Enabling HT MSI Mapping [ 1344.891409] pci 0000:00:0b.0: Enabling HT MSI Mapping [ 1344.891513] pcieport-driver 0000:00:14.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [ 1344.891713] nvidia 0000:02:00.0: restoring config space at offset 0xf (was 0x100, writing 0x10a) [ 1344.891721] nvidia 0000:02:00.0: restoring config space at offset 0x9 (was 0x1, writing 0x4001) [ 1344.891726] nvidia 0000:02:00.0: restoring config space at offset 0x7 (was 0xc, writing 0xc400000c) [ 1344.891731] nvidia 0000:02:00.0: restoring config space at offset 0x5 (was 0xc, writing 0xd000000c) [ 1344.891779] ath5k 0000:07:00.0: restoring config space at offset 0x3 (was 0x0, writing 0x8) [ 1345.070600] nForce2_smbus 0000:00:01.1: PME# disabled [ 1345.070609] ohci_hcd 0000:00:02.0: PME# disabled [ 1345.070620] ohci_hcd 0000:00:02.0: PCI INT A -> Link[LUS0] -> GSI 17 (level, low) -> IRQ 17 [ 1345.070626] ohci_hcd 0000:00:02.0: setting latency timer to 64 [ 1345.092567] ehci_hcd 0000:00:02.1: PME# disabled [ 1345.092573] ehci_hcd 0000:00:02.1: PCI INT B -> Link[LUS2] -> GSI 17 (level, low) -> IRQ 17 [ 1345.092578] ehci_hcd 0000:00:02.1: setting latency timer to 64 [ 1345.092583] usb usb1: root hub lost power or was reset [ 1345.092594] ehci_hcd 0000:00:02.1: debug port 1 [ 1345.092599] ehci_hcd 0000:00:02.1: cache line size of 64 is not supported [ 1345.092608] ohci_hcd 0000:00:04.0: PME# disabled [ 1345.092613] ohci_hcd 0000:00:04.0: PCI INT A -> Link[Z010] -> GSI 16 (level, low) -> IRQ 16 [ 1345.092618] ohci_hcd 0000:00:04.0: setting latency timer to 64 [ 1345.116565] ehci_hcd 0000:00:04.1: PME# disabled [ 1345.116571] ehci_hcd 0000:00:04.1: PCI INT B -> Link[Z011] -> GSI 16 (level, low) -> IRQ 16 [ 1345.116576] ehci_hcd 0000:00:04.1: setting latency timer to 64 [ 1345.116580] usb usb2: root hub lost power or was reset [ 1345.116590] ehci_hcd 0000:00:04.1: debug port 1 [ 1345.116594] ehci_hcd 0000:00:04.1: cache line size of 64 is not supported [ 1345.116605] pata_amd 0000:00:06.0: setting latency timer to 64 [ 1345.116624] HDA Intel 0000:00:07.0: PCI INT A -> Link[LAZA] -> GSI 19 (level, low) -> IRQ 19 [ 1345.116629] HDA Intel 0000:00:07.0: setting latency timer to 64 [ 1345.116665] pci 0000:00:08.0: setting latency timer to 64 [ 1345.116673] ahci 0000:00:09.0: setting latency timer to 64 [ 1345.116694] forcedeth 0000:00:0a.0: wake-up capability disabled by ACPI [ 1345.116699] forcedeth 0000:00:0a.0: PME# disabled [ 1345.117494] ata4: port disabled. ignoring. [ 1345.600567] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [ 1345.637143] pci 0000:00:0b.0: setting latency timer to 64 [ 1345.945667] ata1.00: configured for UDMA/100 [ 1345.997202] ata1: exception Emask 0x10 SAct 0x0 SErr 0x0 action 0x9 t4 [ 1345.997204] ata1: irq_stat 0x40000001 [ 1346.073341] ata1.00: configured for UDMA/100 [ 1346.073345] ata1: EH complete [ 1346.337027] ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [ 1346.338455] ata2.00: configured for UDMA/100 [ 1350.415713] ath5k 0000:07:00.0: PCI INT A -> Link[Z012] -> GSI 23 (level, low) -> IRQ 23 [ 1350.901661] sd 1:0:0:0: [sda] Starting disk [ 1351.068109] usb 1-1: reset high speed USB device using ehci_hcd and address 2 [ 1351.320200] usb 2-2: reset high speed USB device using ehci_hcd and address 2 [ 1351.501082] PM: resume devices took 6.612 seconds [ 1351.501084] ------------[ cut here ]------------ [ 1351.501092] WARNING: at /build/buildd/linux-2.6.31/kernel/power/suspend_test.c:52 suspend_test_finish+0x80/0x90() [ 1351.501095] Hardware name: Compaq Presario CQ50 Notebook PC [ 1351.501097] Component: resume devices [ 1351.501099] Modules linked in: binfmt_misc ppdev vboxnetadp vboxnetflt vboxdrv snd_hda_codec_nvhdmi snd_hda_codec_conexant snd_hda_intel snd_hda_codec snd_pcm_oss snd_mixer_oss snd_pcm arc4 snd_seq_dummy ecb snd_seq_oss ath5k joydev snd_seq_midi snd_rawmidi snd_seq_midi_event snd_seq mac80211 snd_timer led_class nvidia(P) uvcvideo videodev v4l1_compat snd_seq_device ath iptable_filter ip_tables x_tables video output psmouse serio_raw i2c_nforce2 cfg80211 agpgart snd soundcore snd_page_alloc shpchp lp parport usb_storage forcedeth [ 1351.501137] Pid: 3463, comm: pm-suspend Tainted: P W 2.6.31-11-generic #38-Ubuntu [ 1351.501139] Call Trace: [ 1351.501146] [] warn_slowpath_common+0x6d/0xa0 [ 1351.501150] [] ? suspend_test_finish+0x80/0x90 [ 1351.501154] [] ? suspend_test_finish+0x80/0x90 [ 1351.501157] [] warn_slowpath_fmt+0x26/0x30 [ 1351.501161] [] suspend_test_finish+0x80/0x90 [ 1351.501164] [] suspend_devices_and_enter+0x9f/0xd0 [ 1351.501169] [] ? printk+0x18/0x1a [ 1351.501172] [] enter_state+0xb9/0xf0 [ 1351.501175] [] state_store+0x6d/0xb0 [ 1351.501179] [] ? state_store+0x0/0xb0 [ 1351.501183] [] kobj_attr_store+0x20/0x30 [ 1351.501187] [] sysfs_write_file+0x90/0x100 [ 1351.501192] [] vfs_write+0x9a/0x190 [ 1351.501196] [] ? sysfs_write_file+0x0/0x100 [ 1351.501199] [] ? do_page_fault+0x19b/0x380 [ 1351.501203] [] sys_write+0x3d/0x70 [ 1351.501206] [] syscall_call+0x7/0xb [ 1351.501209] ---[ end trace a804dd967d57aac7 ]--- [ 1351.501409] PM: Finishing wakeup. [ 1351.501411] Restarting tasks ... done. [ 1352.581986] forcedeth 0000:00:0a.0: irq 26 for MSI/MSI-X [ 1352.582189] eth0: no link during initialization. [ 1352.582675] ADDRCONF(NETDEV_UP): eth0: link is not ready [ 1370.468998] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 1380.301922] eth0: link up. [ 1380.302993] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 1381.937388] wlan0: authenticate with AP 00:1f:9f:eb:32:d9 [ 1381.939449] wlan0: authenticated [ 1381.939453] wlan0: associate with AP 00:1f:9f:eb:32:d9 [ 1381.942633] wlan0: RX AssocResp from 00:1f:9f:eb:32:d9 (capab=0x411 status=0 aid=2) [ 1381.942639] wlan0: associated [ 1381.943460] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 1381.961290] ath5k phy0: unsupported jumbo [ 1391.064439] eth0: no IPv6 routers present [ 1392.232144] wlan0: no IPv6 routers present