[ 15.259632] Bluetooth: L2CAP ver 2.14 [ 15.259635] Bluetooth: L2CAP socket layer initialized [ 15.266316] Bluetooth: BNEP (Ethernet Emulation) ver 1.3 [ 15.266319] Bluetooth: BNEP filters: protocol multicast [ 15.276590] Bridge firewalling registered [ 15.284833] Bluetooth: SCO (Voice Link) ver 0.6 [ 15.284837] Bluetooth: SCO socket layer initialized [ 15.318097] iwlagn 0000:03:00.0: firmware: requesting iwlwifi-4965-2.ucode [ 15.325750] ppdev: user-space parallel port driver [ 15.361970] iwlagn 0000:03:00.0: loaded firmware version 228.61.2.24 [ 15.398523] Bluetooth: RFCOMM TTY layer initialized [ 15.398528] Bluetooth: RFCOMM socket layer initialized [ 15.398531] Bluetooth: RFCOMM ver 1.11 [ 15.591774] Registered led device: iwl-phy0::radio [ 15.591797] Registered led device: iwl-phy0::assoc [ 15.591817] Registered led device: iwl-phy0::RX [ 15.591842] Registered led device: iwl-phy0::TX [ 15.638328] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 16.868025] cfg80211: Found new beacon on frequency: 5765 MHz (Ch 153) on phy0 [ 21.488360] e1000e 0000:00:19.0: irq 26 for MSI/MSI-X [ 21.544188] e1000e 0000:00:19.0: irq 26 for MSI/MSI-X [ 21.544525] ADDRCONF(NETDEV_UP): eth0: link is not ready [ 25.849945] Registered led device: iwl-phy0::radio [ 25.849975] Registered led device: iwl-phy0::assoc [ 25.850008] Registered led device: iwl-phy0::RX [ 25.850028] Registered led device: iwl-phy0::TX [ 25.882981] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 26.282885] e1000e 0000:00:19.0: irq 26 for MSI/MSI-X [ 26.336600] e1000e 0000:00:19.0: irq 26 for MSI/MSI-X [ 26.336983] ADDRCONF(NETDEV_UP): eth0: link is not ready [ 26.665859] Registered led device: iwl-phy0::radio [ 26.665894] Registered led device: iwl-phy0::assoc [ 26.665920] Registered led device: iwl-phy0::RX [ 26.665939] Registered led device: iwl-phy0::TX [ 26.698976] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 32.142440] wlan0: direct probe to AP c0:3f:0e:86:c7:fa (try 1) [ 32.340047] wlan0: direct probe to AP c0:3f:0e:86:c7:fa (try 2) [ 32.341106] wlan0: direct probe responded [ 32.341109] wlan0: authenticate with AP c0:3f:0e:86:c7:fa (try 1) [ 32.341532] wlan0: authenticated [ 32.341555] wlan0: associate with AP c0:3f:0e:86:c7:fa (try 1) [ 32.342500] wlan0: RX AssocResp from c0:3f:0e:86:c7:fa (capab=0x411 status=0 aid=1) [ 32.342504] wlan0: associated [ 32.369857] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 32.552902] padlock: VIA PadLock not detected. [ 32.816031] __ratelimit: 15 callbacks suppressed [ 32.816035] type=1503 audit(1288631869.486:17): operation="open" pid=1848 parent=1697 profile="/sbin/dhclient3" requested_mask="r::" denied_mask="r::" fsuid=0 ouid=0 name="/var/lib/wicd/dhclient.conf" [ 43.296016] wlan0: no IPv6 routers present [ 59.320655] iwlagn 0000:03:00.0: iwl_tx_agg_start on ra = c0:3f:0e:86:c7:fa tid = 0 [ 162.841152] usb 3-2: USB disconnect, address 3 [ 162.841836] btusb_intr_complete: hci0 urb f2305500 failed to resubmit (19) [ 162.841861] btusb_bulk_complete: hci0 urb f225ea80 failed to resubmit (19) [ 162.842842] btusb_bulk_complete: hci0 urb f225e780 failed to resubmit (19) [ 162.843178] btusb_send_frame: hci0 urb efe25580 submission failed [ 162.925127] wlan0: deauthenticating from c0:3f:0e:86:c7:fa by local choice (reason=3) [ 163.222453] Registered led device: iwl-phy0::radio [ 163.222498] Registered led device: iwl-phy0::assoc [ 163.222538] Registered led device: iwl-phy0::RX [ 163.222579] Registered led device: iwl-phy0::TX [ 163.273699] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 163.736547] e1000e 0000:00:19.0: irq 26 for MSI/MSI-X [ 163.792238] e1000e 0000:00:19.0: irq 26 for MSI/MSI-X [ 163.792904] ADDRCONF(NETDEV_UP): eth0: link is not ready [ 164.070568] Registered led device: iwl-phy0::radio [ 164.070614] Registered led device: iwl-phy0::assoc [ 164.070655] Registered led device: iwl-phy0::RX [ 164.070702] Registered led device: iwl-phy0::TX [ 164.116462] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 164.446511] Registered led device: iwl-phy0::radio [ 164.446558] Registered led device: iwl-phy0::assoc [ 164.446597] Registered led device: iwl-phy0::RX [ 164.446636] Registered led device: iwl-phy0::TX [ 164.477730] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 164.896528] e1000e 0000:00:19.0: irq 26 for MSI/MSI-X [ 164.952246] e1000e 0000:00:19.0: irq 26 for MSI/MSI-X [ 164.952901] ADDRCONF(NETDEV_UP): eth0: link is not ready [ 165.106570] PM: Syncing filesystems ... done. [ 165.108390] PM: Preparing system for mem sleep [ 165.108394] Freezing user space processes ... (elapsed 0.00 seconds) done. [ 165.109404] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done. [ 165.109492] PM: Entering mem sleep [ 165.109506] Suspending console(s) (use no_console_suspend to debug) [ 165.176071] sd 2:0:0:0: [sda] Synchronizing SCSI cache [ 165.387692] sd 2:0:0:0: [sda] Stopping disk [ 165.786321] PM: suspend of drv:sd dev:2:0:0:0 complete after 610.251 msecs [ 166.464064] PM: suspend of drv:atkbd dev:serio0 complete after 603.438 msecs [ 166.512646] serial 00:0a: disabled [ 166.513915] ACPI handle has no context! [ 166.513928] sdhci-pci 0000:05:00.2: PCI INT C disabled [ 166.513941] ACPI handle has no context! [ 166.533267] ACPI handle has no context! [ 166.596264] ata2: port disabled. ignoring. [ 166.596402] ata_piix 0000:00:1f.1: PCI INT C disabled [ 166.596428] ehci_hcd 0000:00:1d.7: PCI INT D disabled [ 166.596448] uhci_hcd 0000:00:1d.1: PCI INT B disabled [ 166.596470] uhci_hcd 0000:00:1d.0: PCI INT A disabled [ 166.596478] pciehp 0000:00:1c.1:pcie04: pciehp_suspend ENTRY [ 166.596486] pciehp 0000:00:1c.0:pcie04: pciehp_suspend ENTRY [ 166.700643] HDA Intel 0000:00:1b.0: PCI INT B disabled [ 166.716132] PM: suspend of drv:HDA Intel dev:0000:00:1b.0 complete after 119.632 msecs [ 166.716150] ehci_hcd 0000:00:1a.7: PCI INT C disabled [ 166.716170] uhci_hcd 0000:00:1a.1: PCI INT B disabled [ 166.716186] uhci_hcd 0000:00:1a.0: PCI INT A disabled [ 166.919922] e1000e 0000:00:19.0: PCI INT A disabled [ 166.919934] e1000e 0000:00:19.0: PME# enabled [ 166.919941] e1000e 0000:00:19.0: wake-up capability enabled by ACPI [ 166.932146] PM: suspend of drv:e1000e dev:0000:00:19.0 complete after 215.951 msecs [ 166.964178] i915 0000:00:02.0: power state changed by ACPI to D3 [ 166.964468] PM: suspend of devices complete after 1854.602 msecs [ 166.964471] PM: suspend devices took 1.856 seconds [ 167.008076] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D3 [ 167.032087] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D3 [ 167.072083] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D3 [ 167.096084] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D3 [ 167.096278] PM: late suspend of devices complete after 131.800 msecs [ 167.136079] ACPI: Preparing to enter system sleep state S3 [ 167.304019] Disabling non-boot CPUs ... [ 167.304043] CPU0 attaching NULL sched-domain. [ 167.304047] CPU1 attaching NULL sched-domain. [ 167.368023] CPU0 attaching NULL sched-domain. [ 167.369140] Breaking affinity for irq 1 [ 167.369185] Breaking affinity for irq 17 [ 167.369280] Breaking affinity for irq 28 [ 167.472032] CPU 1 is now offline [ 167.472035] SMP alternatives: switching to UP code [ 167.481785] Extended CMOS year: 2000 [ 167.481785] Back to C! [ 167.481785] CPU0: Thermal monitoring enabled (TM2) [ 167.481785] Extended CMOS year: 2000 [ 167.481785] Enabling non-boot CPUs ... [ 167.481785] SMP alternatives: switching to SMP code [ 167.490348] Booting processor 1 APIC 0x1 ip 0x6000 [ 167.481389] Initializing CPU#1 [ 167.481389] CPU: L1 I cache: 32K, L1 D cache: 32K [ 167.481389] CPU: L2 cache: 4096K [ 167.481389] CPU: Physical Processor ID: 0 [ 167.481389] CPU: Processor Core ID: 1 [ 167.481389] CPU1: Thermal monitoring enabled (TM2) [ 167.580085] CPU1: Intel(R) Core(TM)2 Duo CPU L7500 @ 1.60GHz stepping 0b [ 167.580145] CPU0 attaching NULL sched-domain. [ 167.608025] CPU0 attaching sched-domain: [ 167.608028] domain 0: span 0-1 level MC [ 167.608031] groups: 0 1 [ 167.608036] CPU1 attaching sched-domain: [ 167.608038] domain 0: span 0-1 level MC [ 167.608041] groups: 1 0 [ 167.624202] CPU1 is up [ 167.624930] ACPI: Waking up from system sleep state S3 [ 168.100268] i915 0000:00:02.0: restoring config space at offset 0x1 (was 0x900007, writing 0x900407) [ 168.100306] pci 0000:00:02.1: restoring config space at offset 0x1 (was 0x900000, writing 0x900007) [ 168.100488] uhci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [ 168.144076] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [ 168.152085] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [ 168.152150] uhci_hcd 0000:00:1a.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [ 168.160084] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [ 168.168084] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [ 168.168167] ehci_hcd 0000:00:1a.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102) [ 168.176084] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 [ 168.184083] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 [ 168.184191] HDA Intel 0000:00:1b.0: restoring config space at offset 0x1 (was 0x100106, writing 0x100102) [ 168.184306] pcieport 0000:00:1c.0: restoring config space at offset 0x7 (was 0x20002020, writing 0x2020) [ 168.184336] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [ 168.184514] pcieport 0000:00:1c.1: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [ 168.192084] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [ 168.200084] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [ 168.200149] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [ 168.208084] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [ 168.216084] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [ 168.216155] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [ 168.216261] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102) [ 168.224085] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [ 168.232083] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [ 168.232163] pci 0000:00:1e.0: restoring config space at offset 0x1 (was 0x100005, writing 0x100007) [ 168.232462] ahci 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00007, writing 0x2b00407) [ 168.232794] iwlagn 0000:03:00.0: restoring config space at offset 0x1 (was 0x100106, writing 0x40100106) [ 168.248113] ohci1394 0000:05:00.1: restoring config space at offset 0x3 (was 0x800000, writing 0x802000) [ 168.248128] ohci1394 0000:05:00.1: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100006) [ 168.264103] sdhci-pci 0000:05:00.2: restoring config space at offset 0x3 (was 0x800000, writing 0x804000) [ 168.264118] sdhci-pci 0000:05:00.2: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100006) [ 168.264504] PM: early resume of devices complete after 164.371 msecs [ 168.305673] i915 0000:00:02.0: power state changed by ACPI to D0 [ 168.305721] i915 0000:00:02.0: power state changed by ACPI to D0 [ 168.305728] i915 0000:00:02.0: setting latency timer to 64 [ 168.448275] PM: resume of drv:i915 dev:0000:00:02.0 complete after 142.681 msecs [ 168.448326] e1000e 0000:00:19.0: PCI INT A -> GSI 20 (level, low) -> IRQ 20 [ 168.448336] e1000e 0000:00:19.0: setting latency timer to 64 [ 168.448349] e1000e 0000:00:19.0: wake-up capability disabled by ACPI [ 168.448359] e1000e 0000:00:19.0: PME# disabled [ 168.448455] e1000e 0000:00:19.0: irq 26 for MSI/MSI-X [ 168.776295] PM: resume of drv:e1000e dev:0000:00:19.0 complete after 328.006 msecs [ 168.776313] uhci_hcd 0000:00:1a.0: PCI INT A -> GSI 20 (level, low) -> IRQ 20 [ 168.776327] uhci_hcd 0000:00:1a.0: setting latency timer to 64 [ 168.776363] usb usb3: root hub lost power or was reset [ 168.776674] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [ 168.776920] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [ 168.776928] uhci_hcd 0000:00:1a.1: PCI INT B -> GSI 21 (level, low) -> IRQ 21 [ 168.776942] uhci_hcd 0000:00:1a.1: setting latency timer to 64 [ 168.776976] usb usb4: root hub lost power or was reset [ 168.777216] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 [ 168.777456] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 [ 168.777470] ehci_hcd 0000:00:1a.7: PCI INT C -> GSI 22 (level, low) -> IRQ 22 [ 168.777486] ehci_hcd 0000:00:1a.7: setting latency timer to 64 [ 168.777513] HDA Intel 0000:00:1b.0: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [ 168.777528] HDA Intel 0000:00:1b.0: setting latency timer to 64 [ 168.777565] pciehp 0000:00:1c.0:pcie04: pciehp_resume ENTRY [ 168.777577] pciehp 0000:00:1c.1:pcie04: pciehp_resume ENTRY [ 168.777825] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [ 168.778079] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [ 168.778087] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [ 168.778098] uhci_hcd 0000:00:1d.0: setting latency timer to 64 [ 168.778132] usb usb5: root hub lost power or was reset [ 168.778164] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [ 168.778178] uhci_hcd 0000:00:1d.1: setting latency timer to 64 [ 168.778212] usb usb6: root hub lost power or was reset [ 168.778461] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [ 168.778670] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [ 168.778682] ehci_hcd 0000:00:1d.7: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [ 168.778693] ehci_hcd 0000:00:1d.7: setting latency timer to 64 [ 168.778721] pci 0000:00:1e.0: setting latency timer to 64 [ 168.778743] ata_piix 0000:00:1f.1: PCI INT C -> GSI 16 (level, low) -> IRQ 16 [ 168.778752] ata_piix 0000:00:1f.1: setting latency timer to 64 [ 168.779240] ata2: port disabled. ignoring. [ 168.780296] ahci 0000:00:1f.2: setting latency timer to 64 [ 168.920503] PM: resume of drv:yenta_cardbus dev:0000:05:00.0 complete after 140.092 msecs [ 168.978145] ohci1394: fw-host0: OHCI-1394 1.1 (PCI): IRQ=[17] MMIO=[d7efe800-d7efefff] Max Packet=[2048] IR/IT contexts=[4/4] [ 168.984271] sdhci-pci 0000:05:00.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [ 168.984275] sdhci-pci 0000:05:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [ 168.986006] serial 00:0a: activated [ 169.172160] PM: resume of drv:usb dev:usb1 complete after 147.379 msecs [ 169.448058] PM: resume of drv:usb dev:usb3 complete after 247.885 msecs [ 169.450891] sd 2:0:0:0: [sda] Starting disk [ 169.828072] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [ 169.835811] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [ 169.835818] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [ 169.835823] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [ 169.838461] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [ 169.838467] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [ 169.838473] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [ 169.839644] ata3.00: configured for UDMA/133 [ 169.854698] ata3.00: configured for UDMA/133 [ 169.854702] ata3: EH complete [ 169.877017] PM: resume of drv:sd dev:2:0:0:0 complete after 426.121 msecs [ 169.988053] usb 3-1: reset full speed USB device using uhci_hcd and address 2 [ 170.137176] PM: resume of drv:usb dev:3-1 complete after 260.128 msecs [ 170.354030] Registered led device: iwl-phy0::radio [ 170.354056] Registered led device: iwl-phy0::assoc [ 170.354076] Registered led device: iwl-phy0::RX [ 170.354097] Registered led device: iwl-phy0::TX [ 170.392048] PM: resume of drv:ieee80211 dev:phy0 complete after 254.741 msecs [ 170.395667] PM: resume of devices complete after 2131.117 msecs [ 170.395884] PM: resume devices took 2.128 seconds [ 170.395913] PM: Finishing wakeup. [ 170.395915] Restarting tasks ... done. [ 173.552114] usb 3-2: new full speed USB device using uhci_hcd and address 4 [ 173.715420] usb 3-2: configuration #1 chosen from 1 choice [ 175.058369] Registered led device: iwl-phy0::radio [ 175.058393] Registered led device: iwl-phy0::assoc [ 175.058414] Registered led device: iwl-phy0::RX [ 175.058435] Registered led device: iwl-phy0::TX [ 175.107390] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 175.532614] e1000e 0000:00:19.0: irq 26 for MSI/MSI-X [ 175.588204] e1000e 0000:00:19.0: irq 26 for MSI/MSI-X [ 175.588803] ADDRCONF(NETDEV_UP): eth0: link is not ready [ 175.947574] Registered led device: iwl-phy0::radio [ 175.947619] Registered led device: iwl-phy0::assoc [ 175.947660] Registered led device: iwl-phy0::RX [ 175.947698] Registered led device: iwl-phy0::TX [ 175.979681] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 178.086185] wlan0: direct probe to AP c0:3f:0e:86:c7:fa (try 1) [ 178.087255] wlan0: direct probe responded [ 178.087263] wlan0: authenticate with AP c0:3f:0e:86:c7:fa (try 1) [ 178.087705] wlan0: authenticated [ 178.087740] wlan0: associate with AP c0:3f:0e:86:c7:fa (try 1) [ 178.088693] wlan0: RX AssocResp from c0:3f:0e:86:c7:fa (capab=0x411 status=0 aid=1) [ 178.088701] wlan0: associated [ 178.125119] wlan0: deauthenticating from c0:3f:0e:86:c7:fa by local choice (reason=3) [ 178.131979] wlan0: direct probe to AP c0:3f:0e:86:c7:fa (try 1) [ 178.177749] wlan0: deauthenticating from c0:3f:0e:86:c7:fa by local choice (reason=3) [ 178.177883] wlan0: direct probe to AP c0:3f:0e:86:c7:fa (try 1) [ 178.376085] wlan0: direct probe to AP c0:3f:0e:86:c7:fa (try 2) [ 178.377154] wlan0: direct probe responded [ 178.377160] wlan0: authenticate with AP c0:3f:0e:86:c7:fa (try 1) [ 178.377605] wlan0: authenticated [ 178.377641] wlan0: associate with AP c0:3f:0e:86:c7:fa (try 1) [ 178.378676] wlan0: RX AssocResp from c0:3f:0e:86:c7:fa (capab=0x411 status=0 aid=1) [ 178.378683] wlan0: associated [ 178.404513] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 179.152974] type=1503 audit(1288632022.833:18): operation="open" pid=2705 parent=2678 profile="/sbin/dhclient3" requested_mask="r::" denied_mask="r::" fsuid=0 ouid=0 name="/var/lib/wicd/dhclient.conf" [ 188.992073] wlan0: no IPv6 routers present [ 476.036414] iwlagn 0000:03:00.0: iwl_tx_agg_start on ra = c0:3f:0e:86:c7:fa tid = 0 [ 1562.589053] CE: hpet increasing min_delta_ns to 15000 nsec [ 2506.949104] mmc0: new high speed SDHC card at address 0007 [ 2506.957070] mmcblk0: mmc0:0007 SD16G 15.0 GiB [ 2506.957134] mmcblk0: p1 [ 2527.288129] usb 3-2: USB disconnect, address 4 [ 2527.288463] btusb_intr_complete: hci0 urb f1ba9000 failed to resubmit (19) [ 2527.288488] btusb_bulk_complete: hci0 urb f1ba9100 failed to resubmit (19) [ 2527.289469] btusb_bulk_complete: hci0 urb f1ba9e80 failed to resubmit (19) [ 2527.290055] btusb_send_frame: hci0 urb ef941600 submission failed [ 2527.320854] wlan0: deauthenticating from c0:3f:0e:86:c7:fa by local choice (reason=3) [ 2527.614331] Registered led device: iwl-phy0::radio [ 2527.614362] Registered led device: iwl-phy0::assoc [ 2527.614397] Registered led device: iwl-phy0::RX [ 2527.614417] Registered led device: iwl-phy0::TX [ 2527.655423] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 2528.144584] e1000e 0000:00:19.0: irq 26 for MSI/MSI-X [ 2528.200253] e1000e 0000:00:19.0: irq 26 for MSI/MSI-X [ 2528.200913] ADDRCONF(NETDEV_UP): eth0: link is not ready [ 2528.462331] Registered led device: iwl-phy0::radio [ 2528.462355] Registered led device: iwl-phy0::assoc [ 2528.462378] Registered led device: iwl-phy0::RX [ 2528.462398] Registered led device: iwl-phy0::TX [ 2528.495444] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 2528.822489] Registered led device: iwl-phy0::radio [ 2528.822518] Registered led device: iwl-phy0::assoc [ 2528.822540] Registered led device: iwl-phy0::RX [ 2528.822561] Registered led device: iwl-phy0::TX [ 2528.863372] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 2529.288551] e1000e 0000:00:19.0: irq 26 for MSI/MSI-X [ 2529.344227] e1000e 0000:00:19.0: irq 26 for MSI/MSI-X [ 2529.344835] ADDRCONF(NETDEV_UP): eth0: link is not ready [ 2529.458084] PM: Syncing filesystems ... done. [ 2529.460261] PM: Preparing system for mem sleep [ 2529.460265] Freezing user space processes ... (elapsed 0.00 seconds) done. [ 2529.461270] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done. [ 2529.461324] PM: Entering mem sleep [ 2529.461338] Suspending console(s) (use no_console_suspend to debug) [ 2529.528074] sd 2:0:0:0: [sda] Synchronizing SCSI cache [ 2529.651066] sd 2:0:0:0: [sda] Stopping disk [ 2530.052027] PM: suspend of drv:sd dev:2:0:0:0 complete after 523.953 msecs [ 2530.728054] PM: suspend of drv:atkbd dev:serio0 complete after 603.817 msecs [ 2530.776641] serial 00:0a: disabled [ 2530.776806] mmc0: card 0007 removed [ 2530.810522] ACPI handle has no context! [ 2530.810534] sdhci-pci 0000:05:00.2: PCI INT C disabled [ 2530.810546] ACPI handle has no context! [ 2530.830304] ACPI handle has no context! [ 2530.892229] ata2: port disabled. ignoring. [ 2530.892332] ata_piix 0000:00:1f.1: PCI INT C disabled [ 2530.892360] ehci_hcd 0000:00:1d.7: PCI INT D disabled [ 2530.892379] uhci_hcd 0000:00:1d.1: PCI INT B disabled [ 2530.892398] uhci_hcd 0000:00:1d.0: PCI INT A disabled [ 2530.892406] pciehp 0000:00:1c.1:pcie04: pciehp_suspend ENTRY [ 2530.892414] pciehp 0000:00:1c.0:pcie04: pciehp_suspend ENTRY [ 2530.996402] HDA Intel 0000:00:1b.0: PCI INT B disabled [ 2531.012142] PM: suspend of drv:HDA Intel dev:0000:00:1b.0 complete after 119.719 msecs [ 2531.012161] ehci_hcd 0000:00:1a.7: PCI INT C disabled [ 2531.012180] uhci_hcd 0000:00:1a.1: PCI INT B disabled [ 2531.012200] uhci_hcd 0000:00:1a.0: PCI INT A disabled [ 2531.215931] e1000e 0000:00:19.0: PCI INT A disabled [ 2531.215943] e1000e 0000:00:19.0: PME# enabled [ 2531.215950] e1000e 0000:00:19.0: wake-up capability enabled by ACPI [ 2531.228147] PM: suspend of drv:e1000e dev:0000:00:19.0 complete after 215.938 msecs [ 2531.268178] i915 0000:00:02.0: power state changed by ACPI to D3 [ 2531.268464] PM: suspend of devices complete after 1806.764 msecs [ 2531.268467] PM: suspend devices took 1.808 seconds [ 2531.292091] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D3 [ 2531.300086] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D3 [ 2531.324085] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D3 [ 2531.352077] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D3 [ 2531.352276] PM: late suspend of devices complete after 83.802 msecs [ 2531.392078] ACPI: Preparing to enter system sleep state S3 [ 2531.560020] Disabling non-boot CPUs ... [ 2531.560042] CPU0 attaching NULL sched-domain. [ 2531.560046] CPU1 attaching NULL sched-domain. [ 2531.624023] CPU0 attaching NULL sched-domain. [ 2531.625180] Breaking affinity for irq 18 [ 2531.728033] CPU 1 is now offline [ 2531.728036] SMP alternatives: switching to UP code [ 2531.737762] Extended CMOS year: 2000 [ 2531.737762] Back to C! [ 2531.737762] CPU0: Thermal monitoring enabled (TM2) [ 2531.737762] Extended CMOS year: 2000 [ 2531.737762] Enabling non-boot CPUs ... [ 2531.737762] SMP alternatives: switching to SMP code [ 2531.746341] Booting processor 1 APIC 0x1 ip 0x6000 [ 2531.737384] Initializing CPU#1 [ 2531.737384] CPU: L1 I cache: 32K, L1 D cache: 32K [ 2531.737384] CPU: L2 cache: 4096K [ 2531.737384] CPU: Physical Processor ID: 0 [ 2531.737384] CPU: Processor Core ID: 1 [ 2531.737384] CPU1: Thermal monitoring enabled (TM2) [ 2531.836060] CPU1: Intel(R) Core(TM)2 Duo CPU L7500 @ 1.60GHz stepping 0b [ 2531.836120] CPU0 attaching NULL sched-domain. [ 2531.864025] CPU0 attaching sched-domain: [ 2531.864028] domain 0: span 0-1 level MC [ 2531.864031] groups: 0 1 [ 2531.864037] CPU1 attaching sched-domain: [ 2531.864039] domain 0: span 0-1 level MC [ 2531.864041] groups: 1 0 [ 2531.880199] CPU1 is up [ 2531.880925] ACPI: Waking up from system sleep state S3 [ 2532.356271] i915 0000:00:02.0: restoring config space at offset 0x1 (was 0x900007, writing 0x900407) [ 2532.356310] pci 0000:00:02.1: restoring config space at offset 0x1 (was 0x900000, writing 0x900007) [ 2532.356502] uhci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [ 2532.400076] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [ 2532.408085] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [ 2532.408146] uhci_hcd 0000:00:1a.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [ 2532.416084] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [ 2532.424084] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [ 2532.424165] ehci_hcd 0000:00:1a.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102) [ 2532.432084] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 [ 2532.440084] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 [ 2532.440189] HDA Intel 0000:00:1b.0: restoring config space at offset 0x1 (was 0x100106, writing 0x100102) [ 2532.440322] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [ 2532.440498] pcieport 0000:00:1c.1: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [ 2532.448084] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [ 2532.456084] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [ 2532.456147] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [ 2532.464084] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [ 2532.472084] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [ 2532.472155] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [ 2532.472257] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102) [ 2532.480084] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [ 2532.488084] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [ 2532.488165] pci 0000:00:1e.0: restoring config space at offset 0x1 (was 0x100005, writing 0x100007) [ 2532.488453] ahci 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00007, writing 0x2b00407) [ 2532.488819] iwlagn 0000:03:00.0: restoring config space at offset 0x1 (was 0x100106, writing 0x100506) [ 2532.504112] ohci1394 0000:05:00.1: restoring config space at offset 0x3 (was 0x800000, writing 0x802000) [ 2532.504127] ohci1394 0000:05:00.1: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100006) [ 2532.520103] sdhci-pci 0000:05:00.2: restoring config space at offset 0x3 (was 0x800000, writing 0x804000) [ 2532.520118] sdhci-pci 0000:05:00.2: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100006) [ 2532.520505] PM: early resume of devices complete after 164.372 msecs [ 2532.561877] i915 0000:00:02.0: power state changed by ACPI to D0 [ 2532.561925] i915 0000:00:02.0: power state changed by ACPI to D0 [ 2532.561932] i915 0000:00:02.0: setting latency timer to 64 [ 2532.704277] PM: resume of drv:i915 dev:0000:00:02.0 complete after 142.471 msecs [ 2532.704328] e1000e 0000:00:19.0: PCI INT A -> GSI 20 (level, low) -> IRQ 20 [ 2532.704338] e1000e 0000:00:19.0: setting latency timer to 64 [ 2532.704351] e1000e 0000:00:19.0: wake-up capability disabled by ACPI [ 2532.704360] e1000e 0000:00:19.0: PME# disabled [ 2532.704459] e1000e 0000:00:19.0: irq 26 for MSI/MSI-X [ 2533.032297] PM: resume of drv:e1000e dev:0000:00:19.0 complete after 328.006 msecs [ 2533.032315] uhci_hcd 0000:00:1a.0: PCI INT A -> GSI 20 (level, low) -> IRQ 20 [ 2533.032329] uhci_hcd 0000:00:1a.0: setting latency timer to 64 [ 2533.032364] usb usb3: root hub lost power or was reset [ 2533.032685] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [ 2533.033255] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [ 2533.033263] uhci_hcd 0000:00:1a.1: PCI INT B -> GSI 21 (level, low) -> IRQ 21 [ 2533.033277] uhci_hcd 0000:00:1a.1: setting latency timer to 64 [ 2533.033313] usb usb4: root hub lost power or was reset [ 2533.033574] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 [ 2533.033784] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 [ 2533.033796] ehci_hcd 0000:00:1a.7: PCI INT C -> GSI 22 (level, low) -> IRQ 22 [ 2533.033809] ehci_hcd 0000:00:1a.7: setting latency timer to 64 [ 2533.033833] HDA Intel 0000:00:1b.0: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [ 2533.033847] HDA Intel 0000:00:1b.0: setting latency timer to 64 [ 2533.033876] pciehp 0000:00:1c.0:pcie04: pciehp_resume ENTRY [ 2533.033887] pciehp 0000:00:1c.1:pcie04: pciehp_resume ENTRY [ 2533.034132] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [ 2533.034338] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [ 2533.034345] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [ 2533.034356] uhci_hcd 0000:00:1d.0: setting latency timer to 64 [ 2533.034391] usb usb5: root hub lost power or was reset [ 2533.034423] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [ 2533.034437] uhci_hcd 0000:00:1d.1: setting latency timer to 64 [ 2533.034470] usb usb6: root hub lost power or was reset [ 2533.034713] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [ 2533.034922] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [ 2533.034934] ehci_hcd 0000:00:1d.7: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [ 2533.034947] ehci_hcd 0000:00:1d.7: setting latency timer to 64 [ 2533.034977] pci 0000:00:1e.0: setting latency timer to 64 [ 2533.034998] ata_piix 0000:00:1f.1: PCI INT C -> GSI 16 (level, low) -> IRQ 16 [ 2533.035008] ata_piix 0000:00:1f.1: setting latency timer to 64 [ 2533.035525] ata2: port disabled. ignoring. [ 2533.036541] ahci 0000:00:1f.2: setting latency timer to 64 [ 2533.176135] PM: resume of drv:yenta_cardbus dev:0000:05:00.0 complete after 139.471 msecs [ 2533.234148] ohci1394: fw-host0: OHCI-1394 1.1 (PCI): IRQ=[17] MMIO=[d7efe800-d7efefff] Max Packet=[2048] IR/IT contexts=[4/4] [ 2533.240267] sdhci-pci 0000:05:00.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [ 2533.240270] sdhci-pci 0000:05:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [ 2533.241992] serial 00:0a: activated [ 2533.424169] PM: resume of drv:usb dev:usb1 complete after 146.357 msecs [ 2533.700045] PM: resume of drv:usb dev:usb3 complete after 247.875 msecs [ 2533.703218] sd 2:0:0:0: [sda] Starting disk [ 2533.916558] mmc0: new high speed SDHC card at address 0007 [ 2533.916584] mmc mmc0:0007: parent mmc0 should not be sleeping [ 2533.916712] mmcblk0: mmc0:0007 SD16G 15.0 GiB [ 2533.916778] mmcblk0: p1 [ 2534.140060] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [ 2534.149565] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [ 2534.149571] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [ 2534.149577] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [ 2534.152203] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [ 2534.152214] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [ 2534.152217] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [ 2534.153437] ata3.00: configured for UDMA/133 [ 2534.170707] ata3.00: configured for UDMA/133 [ 2534.170712] ata3: EH complete [ 2534.190756] PM: resume of drv:sd dev:2:0:0:0 complete after 487.534 msecs [ 2534.300061] usb 3-1: reset full speed USB device using uhci_hcd and address 2 [ 2534.449163] PM: resume of drv:usb dev:3-1 complete after 258.374 msecs [ 2534.666005] Registered led device: iwl-phy0::radio [ 2534.666040] Registered led device: iwl-phy0::assoc [ 2534.666059] Registered led device: iwl-phy0::RX [ 2534.666078] Registered led device: iwl-phy0::TX [ 2534.704058] PM: resume of drv:ieee80211 dev:phy0 complete after 254.764 msecs [ 2534.707475] PM: resume of devices complete after 2186.925 msecs [ 2534.707717] PM: resume devices took 2.184 seconds [ 2534.707750] PM: Finishing wakeup. [ 2534.707752] Restarting tasks ... done. [ 2537.732080] usb 3-2: new full speed USB device using uhci_hcd and address 5 [ 2537.906282] usb 3-2: configuration #1 chosen from 1 choice [ 2539.329313] Registered led device: iwl-phy0::radio [ 2539.329359] Registered led device: iwl-phy0::assoc [ 2539.329399] Registered led device: iwl-phy0::RX [ 2539.329438] Registered led device: iwl-phy0::TX [ 2539.368469] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 2539.788545] e1000e 0000:00:19.0: irq 26 for MSI/MSI-X [ 2539.844219] e1000e 0000:00:19.0: irq 26 for MSI/MSI-X [ 2539.844816] ADDRCONF(NETDEV_UP): eth0: link is not ready [ 2540.195428] Registered led device: iwl-phy0::radio [ 2540.195476] Registered led device: iwl-phy0::assoc [ 2540.195519] Registered led device: iwl-phy0::RX [ 2540.195561] Registered led device: iwl-phy0::TX [ 2540.238972] ADDRCONF(NETDEV_UP): wlan0: link is not ready [ 2542.336951] wlan0: direct probe to AP c0:3f:0e:86:c7:fa (try 1) [ 2542.338063] wlan0: direct probe responded [ 2542.338071] wlan0: authenticate with AP c0:3f:0e:86:c7:fa (try 1) [ 2542.338535] wlan0: authenticated [ 2542.338569] wlan0: associate with AP c0:3f:0e:86:c7:fa (try 1) [ 2542.339461] wlan0: RX AssocResp from c0:3f:0e:86:c7:fa (capab=0x411 status=0 aid=1) [ 2542.339468] wlan0: associated [ 2542.376069] wlan0: deauthenticating from c0:3f:0e:86:c7:fa by local choice (reason=3) [ 2542.382895] wlan0: direct probe to AP c0:3f:0e:86:c7:fa (try 1) [ 2542.429714] wlan0: deauthenticating from c0:3f:0e:86:c7:fa by local choice (reason=3) [ 2542.429846] wlan0: direct probe to AP c0:3f:0e:86:c7:fa (try 1) [ 2542.431072] wlan0: direct probe responded [ 2542.431079] wlan0: authenticate with AP c0:3f:0e:86:c7:fa (try 1) [ 2542.431596] wlan0: authenticated [ 2542.431627] wlan0: associate with AP c0:3f:0e:86:c7:fa (try 1) [ 2542.432612] wlan0: RX AssocResp from c0:3f:0e:86:c7:fa (capab=0x411 status=0 aid=1) [ 2542.432619] wlan0: associated [ 2542.457426] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 2543.414326] type=1503 audit(1288634397.120:19): operation="open" pid=4909 parent=4882 profile="/sbin/dhclient3" requested_mask="r::" denied_mask="r::" fsuid=0 ouid=0 name="/var/lib/wicd/dhclient.conf" [ 2553.408046] wlan0: no IPv6 routers present [ 4238.285542] iwlagn 0000:03:00.0: iwl_tx_agg_start on ra = c0:3f:0e:86:c7:fa tid = 0 [ 4634.046405] Monitor-Mwait will be used to enter C-3 state