[ 17.994859] Bluetooth: L2CAP ver 2.14 [ 17.994862] Bluetooth: L2CAP socket layer initialized [ 17.998920] Bluetooth: BNEP (Ethernet Emulation) ver 1.3 [ 17.998923] Bluetooth: BNEP filters: protocol multicast [ 18.004320] Bridge firewalling registered [ 18.009548] Bluetooth: SCO (Voice Link) ver 0.6 [ 18.009551] Bluetooth: SCO socket layer initialized [ 18.045318] ppdev: user-space parallel port driver [ 18.120938] Bluetooth: RFCOMM TTY layer initialized [ 18.120942] Bluetooth: RFCOMM socket layer initialized [ 18.120944] Bluetooth: RFCOMM ver 1.11 [ 20.984319] CPU0 attaching NULL sched-domain. [ 20.984323] CPU1 attaching NULL sched-domain. [ 21.580217] CPU0 attaching sched-domain: [ 21.580220] domain 0: span 0-1 level MC [ 21.580222] groups: 0 1 [ 21.580227] CPU1 attaching sched-domain: [ 21.580228] domain 0: span 0-1 level MC [ 21.580230] groups: 1 0 [ 25.518907] CPU0 attaching NULL sched-domain. [ 25.518912] CPU1 attaching NULL sched-domain. [ 25.580127] CPU0 attaching sched-domain: [ 25.580130] domain 0: span 0-1 level MC [ 25.580132] groups: 0 1 [ 25.580137] CPU1 attaching sched-domain: [ 25.580139] domain 0: span 0-1 level MC [ 25.580141] groups: 1 0 [ 41.201014] wlan0: direct probe to AP 00:1c:df:82:fe:7b (try 1) [ 41.201032] wlan0: deauthenticating from 00:1c:df:82:fe:7b by local choice (reason=3) [ 41.201049] wlan0: direct probe to AP 00:1c:df:82:fe:7b (try 1) [ 41.206032] wlan0: direct probe responded [ 41.206037] wlan0: authenticate with AP 00:1c:df:82:fe:7b (try 1) [ 41.241256] wlan0: authenticated [ 41.241282] wlan0: associate with AP 00:1c:df:82:fe:7b (try 1) [ 41.292806] wlan0: RX AssocResp from 00:1c:df:82:fe:7b (capab=0x431 status=0 aid=4) [ 41.292810] wlan0: associated [ 41.294104] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 41.642360] Intel AES-NI instructions are not detected. [ 41.706316] padlock: VIA PadLock not detected. [ 51.421284] wlan0: no IPv6 routers present [ 1148.068857] CPU0 attaching NULL sched-domain. [ 1148.068862] CPU1 attaching NULL sched-domain. [ 1148.150089] CPU0 attaching sched-domain: [ 1148.150092] domain 0: span 0-1 level MC [ 1148.150094] groups: 0 1 [ 1148.150098] CPU1 attaching sched-domain: [ 1148.150100] domain 0: span 0-1 level MC [ 1148.150102] groups: 1 0 [ 1149.071323] wlan0: deauthenticating from 00:1c:df:82:fe:7b by local choice (reason=3) [ 1152.450200] PM: Syncing filesystems ... done. [ 1152.601282] PM: Preparing system for mem sleep [ 1152.601285] Freezing user space processes ... (elapsed 0.00 seconds) done. [ 1152.602044] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done. [ 1152.602081] PM: Entering mem sleep [ 1152.602097] Suspending console(s) (use no_console_suspend to debug) [ 1152.720127] PM: suspend of drv:ieee80211 dev:phy0 complete after 117.562 msecs [ 1152.721848] btusb_intr_complete: hci0 urb ffff88013722b0c0 failed to resubmit (1) [ 1152.722844] btusb_bulk_complete: hci0 urb ffff880138dbb240 failed to resubmit (1) [ 1152.723844] btusb_bulk_complete: hci0 urb ffff88012a2e7b40 failed to resubmit (1) [ 1152.740479] dvb-usb: AVerMedia A309 successfully deinitialized and disconnected. [ 1152.760111] sd 0:0:0:0: [sda] Synchronizing SCSI cache [ 1152.760360] sd 0:0:0:0: [sda] Stopping disk [ 1153.088743] PM: suspend of drv:sd dev:0:0:0:0 complete after 328.634 msecs [ 1153.516196] PM: suspend of drv:psmouse dev:serio1 complete after 415.988 msecs [ 1153.612779] jmb38x_ms 0000:06:00.3: PCI INT A disabled [ 1153.630191] sdhci-pci 0000:06:00.1: PCI INT A disabled [ 1153.850146] ehci_hcd 0000:00:1d.7: PCI INT A disabled [ 1153.850158] uhci_hcd 0000:00:1d.3: PCI INT C disabled [ 1153.850167] uhci_hcd 0000:00:1d.2: PCI INT D disabled [ 1153.850176] uhci_hcd 0000:00:1d.1: PCI INT B disabled [ 1153.850185] uhci_hcd 0000:00:1d.0: PCI INT A disabled [ 1154.070158] HDA Intel 0000:00:1b.0: PCI INT A disabled [ 1154.070207] ACPI handle has no context! [ 1154.090092] PM: suspend of drv:HDA Intel dev:0000:00:1b.0 complete after 239.873 msecs [ 1154.090102] ehci_hcd 0000:00:1a.7: PCI INT D disabled [ 1154.090111] uhci_hcd 0000:00:1a.1: PCI INT B disabled [ 1154.090121] uhci_hcd 0000:00:1a.0: PCI INT A disabled [ 1154.090396] PM: suspend of devices complete after 1487.916 msecs [ 1154.090398] PM: suspend devices took 1.490 seconds [ 1154.090813] r8169 0000:03:00.0: PME# enabled [ 1154.090903] r8169 0000:03:00.0: wake-up capability enabled by ACPI [ 1154.150143] PM: late suspend of devices complete after 59.741 msecs [ 1154.150468] ACPI: Preparing to enter system sleep state S3 [ 1154.390008] Disabling non-boot CPUs ... [ 1154.390026] CPU0 attaching NULL sched-domain. [ 1154.390029] CPU1 attaching NULL sched-domain. [ 1154.550014] CPU0 attaching NULL sched-domain. [ 1154.551143] Broke affinity for irq 12 [ 1154.551152] Broke affinity for irq 16 [ 1154.660019] CPU 1 is now offline [ 1154.660022] SMP alternatives: switching to UP code [ 1154.666364] Back to C! [ 1154.666364] CPU0: Thermal monitoring enabled (TM1) [ 1154.666364] Enabling non-boot CPUs ... [ 1154.666364] SMP alternatives: switching to SMP code [ 1154.672555] Booting processor 1 APIC 0x1 ip 0x6000 [ 1154.666001] Initializing CPU#1 [ 1154.666001] CPU: L1 I cache: 32K, L1 D cache: 32K [ 1154.666001] CPU: L2 cache: 3072K [ 1154.666001] CPU 1/0x1 -> Node 0 [ 1154.666001] CPU: Physical Processor ID: 0 [ 1154.666001] CPU: Processor Core ID: 1 [ 1154.666001] CPU1: Thermal monitoring enabled (TM1) [ 1154.833959] CPU1: Intel(R) Core(TM)2 Duo CPU P8600 @ 2.40GHz stepping 06 [ 1154.835636] CPU0 attaching NULL sched-domain. [ 1154.900022] CPU0 attaching sched-domain: [ 1154.900025] domain 0: span 0-1 level MC [ 1154.900027] groups: 0 1 [ 1154.900031] CPU1 attaching sched-domain: [ 1154.900032] domain 0: span 0-1 level MC [ 1154.900034] groups: 1 0 [ 1154.902339] CPU1 is up [ 1154.902985] ACPI: Waking up from system sleep state S3 [ 1155.056350] pcieport 0000:00:01.0: restoring config space at offset 0xf (was 0x80100, writing 0x8010b) [ 1155.056360] pcieport 0000:00:01.0: restoring config space at offset 0x1 (was 0x100007, writing 0x100407) [ 1155.056394] uhci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) [ 1155.056422] uhci_hcd 0000:00:1a.1: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) [ 1155.056456] ehci_hcd 0000:00:1a.7: restoring config space at offset 0x1 (was 0x2900006, writing 0x2900002) [ 1155.056493] HDA Intel 0000:00:1b.0: restoring config space at offset 0x1 (was 0x100006, writing 0x100002) [ 1155.056514] pcieport 0000:00:1c.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [ 1155.056523] pcieport 0000:00:1c.0: restoring config space at offset 0x7 (was 0x20008080, writing 0x8080) [ 1155.056531] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100007, writing 0x100407) [ 1155.056562] pcieport 0000:00:1c.1: restoring config space at offset 0xf (was 0x200, writing 0x20b) [ 1155.056571] pcieport 0000:00:1c.1: restoring config space at offset 0x7 (was 0x20007060, writing 0x7060) [ 1155.056579] pcieport 0000:00:1c.1: restoring config space at offset 0x1 (was 0x100007, writing 0x100407) [ 1155.056609] pcieport 0000:00:1c.2: restoring config space at offset 0xf (was 0x300, writing 0x30b) [ 1155.056619] pcieport 0000:00:1c.2: restoring config space at offset 0x7 (was 0x20005050, writing 0x5050) [ 1155.056627] pcieport 0000:00:1c.2: restoring config space at offset 0x1 (was 0x100000, writing 0x100407) [ 1155.056657] pcieport 0000:00:1c.3: restoring config space at offset 0xf (was 0x400, writing 0x40b) [ 1155.056667] pcieport 0000:00:1c.3: restoring config space at offset 0x7 (was 0x20004040, writing 0x4040) [ 1155.056675] pcieport 0000:00:1c.3: restoring config space at offset 0x1 (was 0x100000, writing 0x100407) [ 1155.056705] pcieport 0000:00:1c.4: restoring config space at offset 0xf (was 0x100, writing 0x10b) [ 1155.056720] pcieport 0000:00:1c.4: restoring config space at offset 0x1 (was 0x100007, writing 0x100407) [ 1155.056750] pcieport 0000:00:1c.5: restoring config space at offset 0xf (was 0x200, writing 0x20b) [ 1155.056759] pcieport 0000:00:1c.5: restoring config space at offset 0x7 (was 0x20002020, writing 0x2020) [ 1155.056767] pcieport 0000:00:1c.5: restoring config space at offset 0x1 (was 0x100007, writing 0x100407) [ 1155.056807] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) [ 1155.056835] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) [ 1155.056862] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) [ 1155.056889] uhci_hcd 0000:00:1d.3: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) [ 1155.056924] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900006, writing 0x2900002) [ 1155.056947] pci 0000:00:1e.0: restoring config space at offset 0x9 (was 0x10001, writing 0x1fff1) [ 1155.056951] pci 0000:00:1e.0: restoring config space at offset 0x8 (was 0x0, writing 0xfff0) [ 1155.056955] pci 0000:00:1e.0: restoring config space at offset 0x7 (was 0x62800000, writing 0x628000f0) [ 1155.056963] pci 0000:00:1e.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100007) [ 1155.057024] ahci 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00007, writing 0x2b00407) [ 1155.057117] nvidia 0000:01:00.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [ 1155.057179] nvidia 0000:01:00.0: restoring config space at offset 0x3 (was 0x10, writing 0x0) [ 1155.057416] r8169 0000:03:00.0: restoring config space at offset 0xf (was 0x1ff, writing 0x10b) [ 1155.057424] r8169 0000:03:00.0: restoring config space at offset 0xc (was 0x0, writing 0xffff0000) [ 1155.057443] r8169 0000:03:00.0: restoring config space at offset 0x1 (was 0x100007, writing 0x100407) [ 1155.057513] ohci1394 0000:06:00.0: restoring config space at offset 0x9 (was 0x0, writing 0xda100c00) [ 1155.057588] sdhci-pci 0000:06:00.1: restoring config space at offset 0x3 (was 0x800000, writing 0x800010) [ 1155.057648] pci 0000:06:00.2: restoring config space at offset 0x3 (was 0x800000, writing 0x800010) [ 1155.057655] pci 0000:06:00.2: restoring config space at offset 0x1 (was 0x100007, writing 0x100003) [ 1155.057711] jmb38x_ms 0000:06:00.3: restoring config space at offset 0x3 (was 0x800000, writing 0x800010) [ 1155.057771] pci 0000:06:00.4: restoring config space at offset 0x3 (was 0x800000, writing 0x800010) [ 1155.057998] PM: early resume of devices complete after 1.741 msecs [ 1155.140338] uhci_hcd 0000:00:1a.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [ 1155.140344] uhci_hcd 0000:00:1a.0: setting latency timer to 64 [ 1155.140363] usb usb3: root hub lost power or was reset [ 1155.140379] uhci_hcd 0000:00:1a.1: PCI INT B -> GSI 21 (level, low) -> IRQ 21 [ 1155.140383] uhci_hcd 0000:00:1a.1: setting latency timer to 64 [ 1155.140401] usb usb4: root hub lost power or was reset [ 1155.140417] ehci_hcd 0000:00:1a.7: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [ 1155.140421] ehci_hcd 0000:00:1a.7: setting latency timer to 64 [ 1155.140430] HDA Intel 0000:00:1b.0: PCI INT A -> GSI 22 (level, low) -> IRQ 22 [ 1155.140434] HDA Intel 0000:00:1b.0: setting latency timer to 64 [ 1155.140473] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 20 (level, low) -> IRQ 20 [ 1155.140477] uhci_hcd 0000:00:1d.0: setting latency timer to 64 [ 1155.140495] usb usb5: root hub lost power or was reset [ 1155.140510] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 19 (level, low) -> IRQ 19 [ 1155.140515] uhci_hcd 0000:00:1d.1: setting latency timer to 64 [ 1155.140533] usb usb6: root hub lost power or was reset [ 1155.140548] uhci_hcd 0000:00:1d.2: PCI INT D -> GSI 16 (level, low) -> IRQ 16 [ 1155.140552] uhci_hcd 0000:00:1d.2: setting latency timer to 64 [ 1155.140570] usb usb7: root hub lost power or was reset [ 1155.140608] uhci_hcd 0000:00:1d.3: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [ 1155.140612] uhci_hcd 0000:00:1d.3: setting latency timer to 64 [ 1155.140630] usb usb8: root hub lost power or was reset [ 1155.140645] ehci_hcd 0000:00:1d.7: PCI INT A -> GSI 20 (level, low) -> IRQ 20 [ 1155.140650] ehci_hcd 0000:00:1d.7: setting latency timer to 64 [ 1155.140678] pci 0000:00:1e.0: setting latency timer to 64 [ 1155.140688] ahci 0000:00:1f.2: setting latency timer to 64 [ 1155.832418] PM: resume of drv:nvidia dev:0000:01:00.0 complete after 691.642 msecs [ 1155.832471] iwlagn 0000:02:00.0: RF_KILL bit toggled to enable radio. [ 1155.832604] r8169 0000:03:00.0: wake-up capability disabled by ACPI [ 1155.832609] r8169 0000:03:00.0: PME# disabled [ 1155.891132] ohci1394: fw-host0: OHCI-1394 1.1 (PCI): IRQ=[16] MMIO=[da100000-da1007ff] Max Packet=[2048] IR/IT contexts=[4/4] [ 1155.899264] sdhci-pci 0000:06:00.1: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [ 1155.899276] sdhci-pci 0000:06:00.1: setting latency timer to 64 [ 1155.899294] jmb38x_ms 0000:06:00.3: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [ 1155.899299] jmb38x_ms 0000:06:00.3: setting latency timer to 64 [ 1155.950109] ata5: SATA link down (SStatus 0 SControl 300) [ 1156.130090] ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [ 1156.156468] ata2.00: configured for UDMA/100 [ 1156.160090] ata6: SATA link down (SStatus 0 SControl 300) [ 1156.210091] PM: resume of drv:usb dev:usb2 complete after 279.976 msecs [ 1156.480083] PM: resume of drv:usb dev:usb7 complete after 269.947 msecs [ 1156.600089] usb 2-4: reset high speed USB device using ehci_hcd and address 2 [ 1156.789795] PM: resume of drv:usb dev:2-4 complete after 303.357 msecs [ 1156.789810] sd 0:0:0:0: [sda] Starting disk [ 1158.170087] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [ 1158.177740] ata1.00: configured for UDMA/100 [ 1158.192802] PM: resume of drv:sd dev:0:0:0:0 complete after 1402.993 msecs [ 1158.310088] usb 2-8: reset high speed USB device using ehci_hcd and address 4 [ 1158.463185] PM: resume of drv:usb dev:2-8 complete after 270.360 msecs [ 1158.580090] usb 7-2: reset full speed USB device using uhci_hcd and address 2 [ 1158.736164] btusb 7-2:1.0: no reset_resume for driver btusb? [ 1158.736167] btusb 7-2:1.1: no reset_resume for driver btusb? [ 1158.980253] PM: resume of drv:usb dev:7-2 complete after 517.054 msecs [ 1158.980413] PM: resume of devices complete after 3922.377 msecs [ 1158.991792] dvb-usb: found a 'AVerMedia A309' in cold state, will try to load a firmware [ 1158.991797] usb 2-8: firmware: requesting dvb-usb-af9015.fw [ 1218.990111] dvb-usb: did not find the firmware file. (dvb-usb-af9015.fw) Please see linux/Documentation/dvb/ for more details on firmware-problems. (-2) [ 1218.990119] dvb_usb_af9015: probe of 2-8:1.0 failed with error -2 [ 1218.990359] PM: resume devices took 63.940 seconds [ 1218.990360] ------------[ cut here ]------------ [ 1218.990369] WARNING: at /build/buildd/linux-2.6.32/kernel/power/suspend_test.c:53 suspend_test_finish+0x88/0x90() [ 1218.990371] Hardware name: HP Pavilion dv5 Notebook PC [ 1218.990373] Component: resume devices, time: 63940 [ 1218.990374] Modules linked in: cryptd aes_x86_64 aes_generic binfmt_misc rfcomm ppdev sco bridge stp bnep l2cap joydev mxl5005s af9013 snd_hda_codec_nvhdmi snd_hda_codec_idt snd_hda_intel snd_hda_codec snd_hwdep snd_pcm_oss snd_mixer_oss snd_pcm snd_seq_dummy snd_seq_oss snd_seq_midi snd_rawmidi snd_seq_midi_event snd_seq snd_timer snd_seq_device dvb_usb_af9015 dvb_usb dvb_core uvcvideo videodev v4l1_compat v4l2_compat_ioctl32 btusb bluetooth snd fbcon tileblit font bitblit softcursor arc4 iwlagn iwlcore mac80211 jmb38x_ms psmouse serio_raw lirc_ene0100 lirc_dev cfg80211 nvidia(P) vga16fb vgastate video output soundcore intel_agp snd_page_alloc sdhci_pci sdhci memstick led_class lp parport ohci1394 r8169 mii ieee1394 ahci [ 1218.990417] Pid: 2088, comm: pm-suspend Tainted: P 2.6.32-19-generic #28-Ubuntu [ 1218.990419] Call Trace: [ 1218.990426] [] warn_slowpath_common+0x7b/0xc0 [ 1218.990428] [] warn_slowpath_fmt+0x41/0x50 [ 1218.990431] [] suspend_test_finish+0x88/0x90 [ 1218.990434] [] suspend_devices_and_enter+0xb1/0xe0 [ 1218.990436] [] enter_state+0xd8/0x110 [ 1218.990439] [] state_store+0x9a/0x100 [ 1218.990444] [] kobj_attr_store+0x17/0x20 [ 1218.990449] [] sysfs_write_file+0xe5/0x170 [ 1218.990453] [] vfs_write+0xb8/0x1a0 [ 1218.990458] [] ? do_page_fault+0x158/0x3b0 [ 1218.990461] [] sys_write+0x51/0x80 [ 1218.990467] [] system_call_fastpath+0x16/0x1b [ 1218.990469] ---[ end trace d3717ce74cb06638 ]--- [ 1218.990514] PM: Finishing wakeup. [ 1218.990515] Restarting tasks ... done. [ 1220.053989] Registered led device: iwl-phy0::radio [ 1220.054006] Registered led device: iwl-phy0::assoc [ 1220.054022] Registered led device: iwl-phy0::RX [ 1220.054038] Registered led device: iwl-phy0::TX [ 1220.081902] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 1220.083215] r8169: eth0: link down [ 1220.083575] ADDRCONF(NETDEV_UP): eth0: link is not ready [ 1221.033961] CPU0 attaching NULL sched-domain. [ 1221.033965] CPU1 attaching NULL sched-domain. [ 1221.109403] CPU0 attaching sched-domain: [ 1221.109407] domain 0: span 0-1 level MC [ 1221.109409] groups: 0 1 [ 1221.109414] CPU1 attaching sched-domain: [ 1221.109415] domain 0: span 0-1 level MC [ 1221.109417] groups: 1 0 [ 1223.286842] wlan0: deauthenticating from 00:1c:df:82:fe:7b by local choice (reason=3) [ 1223.301463] wlan0: direct probe to AP 00:1c:df:82:fe:7b (try 1) [ 1223.304598] wlan0: direct probe responded [ 1223.304601] wlan0: authenticate with AP 00:1c:df:82:fe:7b (try 1) [ 1223.326474] wlan0: authenticated [ 1223.326489] wlan0: associate with AP 00:1c:df:82:fe:7b (try 1) [ 1223.378165] wlan0: RX AssocResp from 00:1c:df:82:fe:7b (capab=0x431 status=0 aid=4) [ 1223.378168] wlan0: associated [ 1223.379895] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 1233.484612] wlan0: no IPv6 routers present