[ 33.016219] Skipping EDID probe due to cached edid [ 33.200132] Skipping EDID probe due to cached edid [ 36.480078] eth0: no IPv6 routers present [ 40.572845] ppdev: user-space parallel port driver [ 40.901301] audit_printk_skb: 12 callbacks suppressed [ 40.901306] type=1400 audit(1278404255.819:19): operation="getattr" pid=1597 parent=1593 profile="/usr/sbin/cupsd" name="/lib/" pid=1597 comm="cupsd" requested_mask="r" denied_mask="r" fsuid=0 ouid=0 [ 40.901345] type=1400 audit(1278404255.819:20): operation="getattr" pid=1597 parent=1593 profile="/usr/sbin/cupsd" name="/usr/lib/" pid=1597 comm="cupsd" requested_mask="r" denied_mask="r" fsuid=0 ouid=0 [ 41.898738] Skipping EDID probe due to cached edid [ 42.058739] Skipping EDID probe due to cached edid [ 42.278701] Skipping EDID probe due to cached edid [ 57.216362] Skipping EDID probe due to cached edid [ 57.378695] Skipping EDID probe due to cached edid [ 57.538709] Skipping EDID probe due to cached edid [ 62.668987] Skipping EDID probe due to cached edid [ 69.598694] Skipping EDID probe due to cached edid [ 84.366087] wlan0: authenticate with 00:23:4d:90:b3:b4 (try 1) [ 84.368747] wlan0: authenticated [ 84.368785] wlan0: associate with 00:23:4d:90:b3:b4 (try 1) [ 84.371366] wlan0: RX AssocResp from 00:23:4d:90:b3:b4 (capab=0x411 status=0 aid=4) [ 84.371372] wlan0: associated [ 84.415600] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 84.916664] Intel AES-NI instructions are not detected. [ 85.112922] padlock: VIA PadLock not detected. [ 85.159273] type=1400 audit(1278404300.067:21): operation="getattr" pid=2849 parent=1041 profile="/sbin/dhclient3" name="/lib/" pid=2849 comm="dhclient" requested_mask="r" denied_mask="r" fsuid=0 ouid=0 [ 85.159314] type=1400 audit(1278404300.067:22): operation="getattr" pid=2849 parent=1041 profile="/sbin/dhclient3" name="/usr/lib/" pid=2849 comm="dhclient" requested_mask="r" denied_mask="r" fsuid=0 ouid=0 [ 94.450096] wlan0: no IPv6 routers present [ 106.698757] Skipping EDID probe due to cached edid [ 106.858692] Skipping EDID probe due to cached edid [ 107.018885] Skipping EDID probe due to cached edid [ 119.527701] tun0: Disabled Privacy Extensions [ 2438.392692] wlan0: deauthenticating from 00:23:4d:90:b3:b4 by local choice (reason=3) [ 2438.542590] cfg80211: All devices are disconnected, going to restore regulatory settings [ 2438.542599] cfg80211: Restoring regulatory settings while preserving user preference for: JP [ 2438.542605] cfg80211: Calling CRDA to update world regulatory domain [ 2438.542634] cfg80211: Calling CRDA for country: JP [ 2438.550181] cfg80211: Regulatory domain changed to country: JP [ 2438.550186] (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [ 2438.550191] (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm) [ 2438.550197] (2457000 KHz - 2482000 KHz @ 20000 KHz), (N/A, 2000 mBm) [ 2438.550201] (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm) [ 2438.550205] (4910000 KHz - 4930000 KHz @ 10000 KHz), (N/A, 2300 mBm) [ 2438.550209] (4910000 KHz - 4990000 KHz @ 40000 KHz), (N/A, 2300 mBm) [ 2438.550214] (4930000 KHz - 4950000 KHz @ 10000 KHz), (N/A, 2300 mBm) [ 2438.550218] (5030000 KHz - 5045000 KHz @ 10000 KHz), (N/A, 2300 mBm) [ 2438.550223] (5030000 KHz - 5090000 KHz @ 40000 KHz), (N/A, 2300 mBm) [ 2438.550227] (5050000 KHz - 5060000 KHz @ 10000 KHz), (N/A, 2300 mBm) [ 2438.550231] (5170000 KHz - 5250000 KHz @ 40000 KHz), (N/A, 2000 mBm) [ 2438.550236] (5250000 KHz - 5330000 KHz @ 40000 KHz), (N/A, 2000 mBm) [ 2438.550240] (5490000 KHz - 5710000 KHz @ 40000 KHz), (N/A, 2300 mBm) [ 2442.290206] usb 6-1: USB disconnect, address 4 [ 2442.290564] sierra ttyUSB0: Sierra USB modem converter now disconnected from ttyUSB0 [ 2442.290678] sierra ttyUSB1: Sierra USB modem converter now disconnected from ttyUSB1 [ 2442.290783] sierra ttyUSB2: Sierra USB modem converter now disconnected from ttyUSB2 [ 2442.290827] sierra 6-1:1.0: device disconnected [ 6605.078819] SGI XFS with ACLs, security attributes, realtime, large block/inode numbers, no debug enabled [ 6605.090227] SGI XFS Quota Management subsystem [ 6605.194374] JFS: nTxBlock = 8192, nTxLock = 65536 [ 6605.316989] NTFS driver 2.1.29 [Flags: R/O MODULE]. [ 6605.417223] QNX4 filesystem 0.2.3 registered. [ 6605.664210] Btrfs loaded [ 8588.671354] SysRq : Changing Loglevel [ 8588.671368] Loglevel set to 4 [ 8589.038268] SysRq : Changing Loglevel [ 8589.038281] Loglevel set to 3 [ 8595.388082] SysRq : Changing Loglevel [ 8595.388096] Loglevel set to 1 [ 9225.679030] gwibber-service[12409] trap int3 ip:7f1c8aa95cd2 sp:7f1c76ff8960 error:0 [ 9822.083433] gwibber-service[12454] trap int3 ip:7f1c8aa95cd2 sp:7f1c76ff8960 error:0 [ 9822.085900] gwibber-service[12455] trap int3 ip:7f1c8aa95cd2 sp:7f1c76ff8960 error:0 [33180.242070] python[22870]: segfault at 0 ip 00000000004a9159 sp 00007fff6c0909d0 error 6 in python2.6[400000+21d000] [33650.123808] Skipping EDID probe due to cached edid [33687.213224] Skipping EDID probe due to cached edid [34079.361457] Skipping EDID probe due to cached edid [34349.290119] usb 3-1: USB disconnect, address 2 [34349.291008] btusb_intr_complete: hci0 urb ffff8800946b7180 failed to resubmit (19) [34349.291021] btusb_bulk_complete: hci0 urb ffff8800946b7240 failed to resubmit (19) [34349.292013] btusb_bulk_complete: hci0 urb ffff8800946b7a80 failed to resubmit (19) [34349.292119] btusb_send_frame: hci0 urb ffff880005c76300 submission failed [34354.182878] PM: Syncing filesystems ... done. [34354.240041] PM: Preparing system for mem sleep [34356.113052] Freezing user space processes ... (elapsed 0.07 seconds) done. [34356.190097] Freezing remaining freezable tasks ... (elapsed 0.02 seconds) done. [34356.212627] PM: Entering mem sleep [34356.212646] Suspending console(s) (use no_console_suspend to debug) [34356.411715] PM: suspend of drv:psmouse dev:serio2 complete after 161.506 msecs [34356.412186] sd 2:0:0:0: [sda] Synchronizing SCSI cache [34356.412441] sd 2:0:0:0: [sda] Stopping disk [34356.514199] ehci_hcd 0000:00:1d.7: PCI INT D disabled [34356.514204] ACPI handle has no context! [34356.514223] sdhci-pci 0000:15:00.2: PCI INT C disabled [34356.514229] uhci_hcd 0000:00:1d.2: PCI INT C disabled [34356.514238] ACPI handle has no context! [34356.514259] uhci_hcd 0000:00:1d.1: PCI INT B disabled [34356.514282] uhci_hcd 0000:00:1d.0: PCI INT A disabled [34356.514359] pciehp 0000:00:1c.3:pcie04: pciehp_suspend ENTRY [34356.514373] ata2: port disabled. ignoring. [34356.514479] ata_piix 0000:00:1f.1: PCI INT C disabled [34356.514521] ehci_hcd 0000:00:1a.7: PCI INT C disabled [34356.514546] uhci_hcd 0000:00:1a.1: PCI INT B disabled [34356.514574] uhci_hcd 0000:00:1a.0: PCI INT A disabled [34356.516201] e1000e 0000:00:19.0: PCI INT A disabled [34356.516214] e1000e 0000:00:19.0: PME# enabled [34356.516227] e1000e 0000:00:19.0: wake-up capability enabled by ACPI [34356.532665] i915 0000:00:02.0: power state changed by ACPI to D3 [34356.620530] HDA Intel 0000:00:1b.0: PCI INT B disabled [34356.640047] PM: suspend of drv:HDA Intel dev:0000:00:1b.0 complete after 125.598 msecs [34356.830198] PM: suspend of drv:sd dev:2:0:0:0 complete after 418.015 msecs [34356.830219] PM: suspend of drv:scsi dev:target2:0:0 complete after 417.979 msecs [34356.830235] PM: suspend of drv:scsi dev:host2 complete after 417.937 msecs [34356.870029] PM: suspend of drv:ahci dev:0000:00:1f.2 complete after 355.893 msecs [34356.870049] PM: suspend of drv: dev:pci0000:00 complete after 354.793 msecs [34356.870068] PM: suspend of devices complete after 656.845 msecs [34356.870073] PM: suspend devices took 0.660 seconds [34356.962598] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D3 [34357.022613] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D3 [34357.082612] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D3 [34357.162610] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D3 [34357.222609] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D3 [34357.222814] PM: late suspend of devices complete after 352.736 msecs [34357.322601] ACPI: Preparing to enter system sleep state S3 [34357.722682] Disabling non-boot CPUs ... [34357.750184] Broke affinity for irq 12 [34357.750216] Broke affinity for irq 16 [34357.860024] CPU 1 is now offline [34357.860028] SMP alternatives: switching to UP code [34357.875503] Extended CMOS year: 2000 [34357.875503] Back to C! [34357.875503] Extended CMOS year: 2000 [34357.875503] Enabling non-boot CPUs ... [34357.875503] SMP alternatives: switching to SMP code [34357.883447] Booting Node 0 Processor 1 APIC 0x1 [34358.212546] CPU1 is up [34358.213477] ACPI: Waking up from system sleep state S3 [34359.082832] i915 0000:00:02.0: restoring config space at offset 0x1 (was 0x900007, writing 0x900407) [34359.082877] pci 0000:00:02.1: restoring config space at offset 0x1 (was 0x900000, writing 0x900007) [34359.083076] uhci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [34359.192595] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [34359.212607] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [34359.212673] uhci_hcd 0000:00:1a.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [34359.232607] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [34359.252608] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [34359.252618] PM: early resume of drv:uhci_hcd dev:0000:00:1a.1 complete after 169.517 msecs [34359.252705] ehci_hcd 0000:00:1a.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102) [34359.272607] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 [34359.292608] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 [34359.292720] HDA Intel 0000:00:1b.0: restoring config space at offset 0x1 (was 0x100106, writing 0x100102) [34359.292842] pcieport 0000:00:1c.0: restoring config space at offset 0x7 (was 0x20002020, writing 0x2020) [34359.292874] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [34359.293060] pcieport 0000:00:1c.1: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [34359.293221] pcieport 0000:00:1c.2: restoring config space at offset 0x7 (was 0x20004040, writing 0x4040) [34359.293252] pcieport 0000:00:1c.2: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [34359.293409] pcieport 0000:00:1c.3: restoring config space at offset 0x7 (was 0x20005050, writing 0x5050) [34359.293440] pcieport 0000:00:1c.3: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [34359.293600] pcieport 0000:00:1c.4: restoring config space at offset 0x7 (was 0x20006060, writing 0x6060) [34359.293632] pcieport 0000:00:1c.4: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [34359.312608] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [34359.332608] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [34359.332674] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [34359.352607] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [34359.372608] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [34359.372682] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [34359.392608] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0 [34359.412608] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0 [34359.412676] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [34359.432608] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0 [34359.452608] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0 [34359.452704] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102) [34359.472608] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [34359.492608] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [34359.492698] pci 0000:00:1e.0: restoring config space at offset 0x1 (was 0x100005, writing 0x100007) [34359.492899] ata_piix 0000:00:1f.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2880005) [34359.493017] ahci 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00007, writing 0x2b00407) [34359.493383] iwlagn 0000:03:00.0: restoring config space at offset 0x1 (was 0x100106, writing 0x40100106) [34359.510050] sdhci-pci 0000:15:00.2: BAR 0: set to [mem 0xf8301800-0xf83018ff] (PCI address [0xf8301800-0xf83018ff] [34359.510124] sdhci-pci 0000:15:00.2: restoring config space at offset 0x3 (was 0x800000, writing 0x804000) [34359.510141] sdhci-pci 0000:15:00.2: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100006) [34359.530046] r852 0000:15:00.5: BAR 0: set to [mem 0xf8302400-0xf83024ff] (PCI address [0xf8302400-0xf83024ff] [34359.530120] r852 0000:15:00.5: restoring config space at offset 0x3 (was 0x800000, writing 0x804000) [34359.530137] r852 0000:15:00.5: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100006) [34359.530769] PM: early resume of devices complete after 448.098 msecs [34359.541010] i915 0000:00:02.0: power state changed by ACPI to D0 [34359.541381] i915 0000:00:02.0: power state changed by ACPI to D0 [34359.541391] i915 0000:00:02.0: setting latency timer to 64 [34359.542680] e1000e 0000:00:19.0: wake-up capability disabled by ACPI [34359.542691] e1000e 0000:00:19.0: PME# disabled [34359.542856] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [34359.557107] uhci_hcd 0000:00:1a.0: PCI INT A -> GSI 20 (level, low) -> IRQ 20 [34359.557124] uhci_hcd 0000:00:1a.0: setting latency timer to 64 [34359.557164] usb usb3: root hub lost power or was reset [34359.557824] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [34359.557832] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 [34359.558036] HDA Intel 0000:00:1b.0: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [34359.558052] HDA Intel 0000:00:1b.0: setting latency timer to 64 [34359.558161] HDA Intel 0000:00:1b.0: irq 49 for MSI/MSI-X [34359.558288] pciehp 0000:00:1c.3:pcie04: pciehp_resume ENTRY [34359.558484] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [34359.558496] uhci_hcd 0000:00:1d.1: setting latency timer to 64 [34359.558538] usb usb6: root hub lost power or was reset [34359.558604] pci 0000:00:1e.0: setting latency timer to 64 [34359.558749] sdhci-pci 0000:15:00.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [34359.558754] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [34359.559853] ata_piix 0000:00:1f.1: PCI INT C -> GSI 16 (level, low) -> IRQ 16 [34359.559863] ata_piix 0000:00:1f.1: setting latency timer to 64 [34359.559963] ahci 0000:00:1f.2: setting latency timer to 64 [34359.560021] ata2: port disabled. ignoring. [34359.560072] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 [34359.560087] ehci_hcd 0000:00:1a.7: PCI INT C -> GSI 22 (level, low) -> IRQ 22 [34359.560104] ehci_hcd 0000:00:1a.7: setting latency timer to 64 [34359.560125] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [34359.560135] uhci_hcd 0000:00:1a.1: PCI INT B -> GSI 21 (level, low) -> IRQ 21 [34359.560153] uhci_hcd 0000:00:1a.1: setting latency timer to 64 [34359.560194] usb usb4: root hub lost power or was reset [34359.560550] sd 2:0:0:0: [sda] Starting disk [34359.561975] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [34359.561989] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0 [34359.563359] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [34359.563764] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [34359.563776] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [34359.563793] uhci_hcd 0000:00:1d.0: setting latency timer to 64 [34359.563829] usb usb5: root hub lost power or was reset [34359.563936] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0 [34359.563947] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [34359.563963] uhci_hcd 0000:00:1d.2: setting latency timer to 64 [34359.564003] usb usb7: root hub lost power or was reset [34359.564192] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [34359.564204] ehci_hcd 0000:00:1d.7: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [34359.564220] ehci_hcd 0000:00:1d.7: setting latency timer to 64 [34359.712622] PM: resume of drv:usb dev:usb4 complete after 152.592 msecs [34359.712661] PM: resume of drv:hub dev:4-0:1.0 complete after 152.578 msecs [34359.722728] PM: resume of drv:usb dev:usb7 complete after 162.539 msecs [34359.722846] PM: resume of drv:hub dev:7-0:1.0 complete after 162.628 msecs [34359.751211] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [34359.751217] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [34359.752858] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [34359.754287] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [34359.813478] ata1.00: configured for UDMA/33 [34359.820050] PM: resume of drv:usb dev:usb6 complete after 259.951 msecs [34359.820068] PM: resume of drv:usb dev:usb3 complete after 260.259 msecs [34359.820085] PM: resume of drv:hub dev:3-0:1.0 complete after 260.176 msecs [34359.820102] PM: resume of drv:hub dev:6-0:1.0 complete after 259.939 msecs [34359.830046] PM: resume of drv:usb dev:usb5 complete after 269.959 msecs [34359.830063] PM: resume of drv:usb dev:usb1 complete after 270.332 msecs [34359.830081] PM: resume of drv:hub dev:1-0:1.0 complete after 270.324 msecs [34359.830094] PM: resume of drv: dev:ep_81 complete after 268.507 msecs [34359.830169] PM: resume of drv:hub dev:5-0:1.0 complete after 270.076 msecs [34359.840046] PM: resume of drv:usb dev:usb2 complete after 280.261 msecs [34359.840062] PM: resume of drv:hub dev:2-0:1.0 complete after 280.261 msecs [34359.854682] PM: resume of drv:e1000e dev:0000:00:19.0 complete after 312.036 msecs [34359.952597] usb 3-2: reset full speed USB device using uhci_hcd and address 3 [34359.975389] PM: resume of drv:i915 dev:0000:00:02.0 complete after 444.269 msecs [34360.108057] PM: resume of drv:usb dev:3-2 complete after 547.434 msecs [34360.108085] PM: resume of drv:usb dev:3-2:1.0 complete after 547.433 msecs [34360.212602] usb 1-3: reset high speed USB device using ehci_hcd and address 4 [34360.509617] snd-usb-audio 1-3:1.2: no reset_resume for driver snd-usb-audio? [34360.509621] snd-usb-audio 1-3:1.3: no reset_resume for driver snd-usb-audio? [34360.509800] PM: resume of drv:usb dev:1-3 complete after 949.544 msecs [34360.509825] PM: resume of drv:usb dev:1-3:1.3 complete after 949.365 msecs [34360.509837] PM: resume of drv:uvcvideo dev:1-3:1.0 complete after 949.571 msecs [34360.509843] PM: resume of drv:usb dev:1-3:1.2 complete after 949.437 msecs [34360.509851] PM: resume of drv: dev:ep_87 complete after 666.814 msecs [34360.509855] PM: resume of drv:uvcvideo dev:1-3:1.1 complete after 949.558 msecs [34360.622761] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [34360.632556] usb 5-1: reset low speed USB device using uhci_hcd and address 2 [34360.633110] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [34360.633117] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [34360.633493] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [34360.633499] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [34360.637587] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [34360.637593] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [34360.637967] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [34360.637972] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [34360.639749] ata3.00: configured for UDMA/100 [34360.656287] ata3.00: configured for UDMA/100 [34360.656292] ata3: EH complete [34360.672534] PM: resume of drv:sd dev:2:0:0:0 complete after 1111.982 msecs [34360.672548] PM: resume of drv:scsi_device dev:2:0:0:0 complete after 1111.948 msecs [34360.672553] PM: resume of drv:scsi_disk dev:2:0:0:0 complete after 162.679 msecs [34360.939666] PM: resume of drv:usb dev:5-1 complete after 1378.989 msecs [34360.939704] PM: resume of drv:usb dev:5-1:1.0 complete after 1379.004 msecs [34360.939739] PM: resume of drv: dev:ep_81 complete after 267.127 msecs [34361.040130] usb 6-2: reset full speed USB device using uhci_hcd and address 3 [34361.197008] Synaptics Touchpad, model: 1, fw: 6.2, id: 0x81a0b1, caps: 0xa04793/0x300000/0x0 [34361.197011] Synaptics: Clickpad mode enabled [34361.197016] serio: Synaptics pass-through port at isa0060/serio1/input0 [34361.207071] PM: resume of drv:usb dev:6-2 complete after 1646.347 msecs [34361.207100] PM: resume of drv:usb dev:6-2:1.0 complete after 1646.350 msecs [34361.207128] PM: resume of drv: dev:ep_02 complete after 267.364 msecs [34361.237649] input: SynPS/2 Synaptics TouchPad as /devices/platform/i8042/serio1/input/input10 [34361.350098] PM: resume of drv:pcmcia_socket dev:pcmcia_socket0 complete after 142.890 msecs [34361.351808] thinkpad_acpi: ACPI backlight control delay disabled [34361.356868] PM: resume of devices complete after 1826.045 msecs [34361.368733] input: X10 Wireless Technology Inc USB Receiver as /devices/pci0000:00/0000:00:1d.0/usb5/5-1/input/input11 [34361.376643] usb 5-1: Weird data, len=1 ff 00 00 00 14 20 ... [34361.392454] PM: resume devices took 1.860 seconds [34361.392522] PM: Finishing wakeup. [34361.392525] Restarting tasks ... [34361.426996] [drm:output_poll_execute] *ERROR* delayed enqueue failed -125 [34361.504581] done. [34361.504592] video LNXVIDEO:00: Restoring backlight state [34361.754066] Skipping EDID probe due to cached edid [34366.102778] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [34366.160261] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [34366.161240] ADDRCONF(NETDEV_UP): eth0: link is not ready [34367.070066] usb 3-1: new full speed USB device using uhci_hcd and address 4 [34367.482820] IBM TrackPoint firmware: 0x0e, buttons: 3/3 [34367.523521] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: RX/TX [34367.523529] e1000e 0000:00:19.0: eth0: 10/100 speed: disabling TSO [34367.524431] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [34367.637370] type=1400 audit(1278444115.113:23): operation="getattr" pid=24702 parent=1041 profile="/sbin/dhclient3" name="/lib/" pid=24702 comm="dhclient" requested_mask="r" denied_mask="r" fsuid=0 ouid=0 [34367.637411] type=1400 audit(1278444115.113:24): operation="getattr" pid=24702 parent=1041 profile="/sbin/dhclient3" name="/usr/lib/" pid=24702 comm="dhclient" requested_mask="r" denied_mask="r" fsuid=0 ouid=0 [34367.712643] input: TPPS/2 IBM TrackPoint as /devices/platform/i8042/serio1/serio3/input/input12 [34377.762547] eth0: no IPv6 routers present [35165.172935] type=1400 audit(1278444912.659:25): operation="profile_replace" pid=25892 name="/usr/bin/evince" pid=25892 comm="apparmor_parser" [35165.174347] type=1400 audit(1278444912.659:26): operation="profile_replace" pid=25892 name="/usr/bin/evince-previewer" pid=25892 comm="apparmor_parser" [35165.175470] type=1400 audit(1278444912.659:27): operation="profile_replace" pid=25892 name="/usr/bin/evince-thumbnailer" pid=25892 comm="apparmor_parser" [37867.542697] usb 3-1: USB disconnect, address 4 [37867.543522] btusb_intr_complete: hci0 urb ffff880005920240 failed to resubmit (19) [37867.543538] btusb_bulk_complete: hci0 urb ffff8800378bc9c0 failed to resubmit (19) [37867.544544] btusb_bulk_complete: hci0 urb ffff8800378bcd80 failed to resubmit (19) [37867.544695] btusb_send_frame: hci0 urb ffff88004a7389c0 submission failed [37869.400319] PM: Syncing filesystems ... done. [37869.862611] PM: Preparing system for mem sleep [37870.590205] Freezing user space processes ... (elapsed 0.02 seconds) done. [37870.612620] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done. [37870.632599] PM: Entering mem sleep [37870.632616] Suspending console(s) (use no_console_suspend to debug) [37870.787693] PM: suspend of drv:psmouse dev:serio3 complete after 154.503 msecs [37870.830584] sd 2:0:0:0: [sda] Synchronizing SCSI cache [37870.830656] sd 2:0:0:0: [sda] Stopping disk [37870.931758] ACPI handle has no context! [37870.931774] sdhci-pci 0000:15:00.2: PCI INT C disabled [37870.931788] ACPI handle has no context! [37870.931814] ehci_hcd 0000:00:1d.7: PCI INT D disabled [37870.931845] uhci_hcd 0000:00:1d.2: PCI INT C disabled [37870.931846] uhci_hcd 0000:00:1d.1: PCI INT B disabled [37870.931878] uhci_hcd 0000:00:1d.0: PCI INT A disabled [37870.931906] pciehp 0000:00:1c.3:pcie04: pciehp_suspend ENTRY [37870.931964] ehci_hcd 0000:00:1a.7: PCI INT C disabled [37870.931997] uhci_hcd 0000:00:1a.1: PCI INT B disabled [37870.932021] uhci_hcd 0000:00:1a.0: PCI INT A disabled [37870.932507] ata2: port disabled. ignoring. [37870.932606] ata_piix 0000:00:1f.1: PCI INT C disabled [37870.933640] e1000e 0000:00:19.0: PME# enabled [37870.933653] e1000e 0000:00:19.0: wake-up capability enabled by ACPI [37870.950172] i915 0000:00:02.0: power state changed by ACPI to D3 [37871.040391] HDA Intel 0000:00:1b.0: PCI INT B disabled [37871.060029] PM: suspend of drv:HDA Intel dev:0000:00:1b.0 complete after 128.105 msecs [37871.217006] PM: suspend of drv:sd dev:2:0:0:0 complete after 386.429 msecs [37871.217026] PM: suspend of drv:scsi dev:target2:0:0 complete after 386.378 msecs [37871.217039] PM: suspend of drv:scsi dev:host2 complete after 386.308 msecs [37871.250029] PM: suspend of drv:ahci dev:0000:00:1f.2 complete after 318.309 msecs [37871.250047] PM: suspend of drv: dev:pci0000:00 complete after 317.138 msecs [37871.250061] PM: suspend of devices complete after 616.903 msecs [37871.250065] PM: suspend devices took 0.620 seconds [37871.292622] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D3 [37871.312610] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D3 [37871.332611] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D3 [37871.372609] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D3 [37871.442597] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D3 [37871.442805] PM: late suspend of devices complete after 192.734 msecs [37871.542600] ACPI: Preparing to enter system sleep state S3 [37871.942679] Disabling non-boot CPUs ... [37872.002682] Broke affinity for irq 17 [37872.002706] Broke affinity for irq 19 [37872.110035] CPU 1 is now offline [37872.110040] SMP alternatives: switching to UP code [37872.125574] Extended CMOS year: 2000 [37872.125574] Back to C! [37872.125574] Extended CMOS year: 2000 [37872.125574] Enabling non-boot CPUs ... [37872.125574] SMP alternatives: switching to SMP code [37872.133468] Booting Node 0 Processor 1 APIC 0x1 [37872.462542] CPU1 is up [37872.463474] ACPI: Waking up from system sleep state S3 [37873.332818] i915 0000:00:02.0: restoring config space at offset 0x1 (was 0x900007, writing 0x900407) [37873.332863] pci 0000:00:02.1: restoring config space at offset 0x1 (was 0x900000, writing 0x900007) [37873.333062] uhci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [37873.442595] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [37873.462609] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [37873.462676] uhci_hcd 0000:00:1a.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [37873.482608] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [37873.502608] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [37873.502617] PM: early resume of drv:uhci_hcd dev:0000:00:1a.1 complete after 169.530 msecs [37873.502705] ehci_hcd 0000:00:1a.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102) [37873.522608] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 [37873.542608] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 [37873.542719] HDA Intel 0000:00:1b.0: restoring config space at offset 0x1 (was 0x100106, writing 0x100102) [37873.542858] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [37873.543039] pcieport 0000:00:1c.1: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [37873.543220] pcieport 0000:00:1c.2: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [37873.543405] pcieport 0000:00:1c.3: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [37873.543582] pcieport 0000:00:1c.4: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [37873.562608] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [37873.582607] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [37873.582670] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [37873.602607] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [37873.622608] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [37873.622682] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [37873.642607] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0 [37873.662607] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0 [37873.662673] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [37873.682606] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0 [37873.702611] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0 [37873.702705] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102) [37873.722606] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [37873.742608] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [37873.742696] pci 0000:00:1e.0: restoring config space at offset 0x1 (was 0x100005, writing 0x100007) [37873.742894] ata_piix 0000:00:1f.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2880005) [37873.743009] ahci 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00007, writing 0x2b00407) [37873.743379] iwlagn 0000:03:00.0: restoring config space at offset 0x1 (was 0x100106, writing 0x100506) [37873.760049] sdhci-pci 0000:15:00.2: BAR 0: set to [mem 0xf8301800-0xf83018ff] (PCI address [0xf8301800-0xf83018ff] [37873.760123] sdhci-pci 0000:15:00.2: restoring config space at offset 0x3 (was 0x800000, writing 0x804000) [37873.760140] sdhci-pci 0000:15:00.2: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100006) [37873.780042] r852 0000:15:00.5: BAR 0: set to [mem 0xf8302400-0xf83024ff] (PCI address [0xf8302400-0xf83024ff] [37873.780116] r852 0000:15:00.5: restoring config space at offset 0x3 (was 0x800000, writing 0x804000) [37873.780133] r852 0000:15:00.5: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100006) [37873.780752] PM: early resume of devices complete after 448.078 msecs [37873.791004] i915 0000:00:02.0: power state changed by ACPI to D0 [37873.791375] i915 0000:00:02.0: power state changed by ACPI to D0 [37873.791385] i915 0000:00:02.0: setting latency timer to 64 [37873.792441] uhci_hcd 0000:00:1a.0: PCI INT A -> GSI 20 (level, low) -> IRQ 20 [37873.792455] uhci_hcd 0000:00:1a.0: setting latency timer to 64 [37873.792492] usb usb3: root hub lost power or was reset [37873.792540] e1000e 0000:00:19.0: wake-up capability disabled by ACPI [37873.792549] e1000e 0000:00:19.0: PME# disabled [37873.792762] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [37873.803314] pciehp 0000:00:1c.3:pcie04: pciehp_resume ENTRY [37873.805866] HDA Intel 0000:00:1b.0: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [37873.805882] HDA Intel 0000:00:1b.0: setting latency timer to 64 [37873.805982] HDA Intel 0000:00:1b.0: irq 49 for MSI/MSI-X [37873.806322] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [37873.806339] uhci_hcd 0000:00:1d.1: setting latency timer to 64 [37873.806373] usb usb6: root hub lost power or was reset [37873.806419] pci 0000:00:1e.0: setting latency timer to 64 [37873.806463] sdhci-pci 0000:15:00.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [37873.806468] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [37873.807668] ata_piix 0000:00:1f.1: PCI INT C -> GSI 16 (level, low) -> IRQ 16 [37873.807680] ata_piix 0000:00:1f.1: setting latency timer to 64 [37873.807765] ata2: port disabled. ignoring. [37873.807809] ahci 0000:00:1f.2: setting latency timer to 64 [37873.809226] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [37873.809618] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [37873.809631] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 [37873.809646] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0 [37873.809656] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [37873.810138] sd 2:0:0:0: [sda] Starting disk [37873.811808] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [37873.811820] uhci_hcd 0000:00:1a.1: PCI INT B -> GSI 21 (level, low) -> IRQ 21 [37873.811831] uhci_hcd 0000:00:1a.1: setting latency timer to 64 [37873.811871] usb usb4: root hub lost power or was reset [37873.812149] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [37873.812157] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [37873.812173] uhci_hcd 0000:00:1d.0: setting latency timer to 64 [37873.812214] usb usb5: root hub lost power or was reset [37873.813387] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 [37873.813402] ehci_hcd 0000:00:1a.7: PCI INT C -> GSI 22 (level, low) -> IRQ 22 [37873.813416] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0 [37873.813420] ehci_hcd 0000:00:1a.7: setting latency timer to 64 [37873.813427] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [37873.813443] uhci_hcd 0000:00:1d.2: setting latency timer to 64 [37873.813485] usb usb7: root hub lost power or was reset [37873.813512] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [37873.813522] ehci_hcd 0000:00:1d.7: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [37873.813538] ehci_hcd 0000:00:1d.7: setting latency timer to 64 [37873.962621] PM: resume of drv:usb dev:usb4 complete after 154.826 msecs [37873.962657] PM: resume of drv:hub dev:4-0:1.0 complete after 154.852 msecs [37873.972755] PM: resume of drv:usb dev:usb7 complete after 164.590 msecs [37873.972842] PM: resume of drv:hub dev:7-0:1.0 complete after 164.634 msecs [37873.993691] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [37873.993697] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [37873.995410] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [37873.996517] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [37874.043128] PM: resume of drv:i915 dev:0000:00:02.0 complete after 262.033 msecs [37874.053469] ata1.00: configured for UDMA/33 [37874.072599] PM: resume of drv:usb dev:usb3 complete after 264.983 msecs [37874.072615] PM: resume of drv:usb dev:usb6 complete after 264.693 msecs [37874.072628] PM: resume of drv:hub dev:3-0:1.0 complete after 264.911 msecs [37874.072641] PM: resume of drv:hub dev:6-0:1.0 complete after 264.507 msecs [37874.082625] PM: resume of drv:usb dev:usb5 complete after 274.809 msecs [37874.082647] PM: resume of drv:hub dev:5-0:1.0 complete after 274.778 msecs [37874.092603] PM: resume of drv:usb dev:usb2 complete after 285.055 msecs [37874.092618] PM: resume of drv:usb dev:usb1 complete after 286.141 msecs [37874.092635] PM: resume of drv:hub dev:1-0:1.0 complete after 285.127 msecs [37874.092650] PM: resume of drv: dev:ep_81 complete after 278.010 msecs [37874.092673] PM: resume of drv:hub dev:2-0:1.0 complete after 285.111 msecs [37874.102210] PM: resume of drv:e1000e dev:0000:00:19.0 complete after 309.929 msecs [37874.212607] usb 1-3: reset high speed USB device using ehci_hcd and address 4 [37874.482574] usb 6-2: reset full speed USB device using uhci_hcd and address 3 [37874.509193] snd-usb-audio 1-3:1.2: no reset_resume for driver snd-usb-audio? [37874.509197] snd-usb-audio 1-3:1.3: no reset_resume for driver snd-usb-audio? [37874.509409] PM: resume of drv:usb dev:1-3 complete after 699.477 msecs [37874.509434] PM: resume of drv:usb dev:1-3:1.3 complete after 699.373 msecs [37874.509450] PM: resume of drv:uvcvideo dev:1-3:1.0 complete after 699.485 msecs [37874.509455] PM: resume of drv:usb dev:1-3:1.2 complete after 699.418 msecs [37874.509463] PM: resume of drv:uvcvideo dev:1-3:1.1 complete after 699.472 msecs [37874.509468] PM: resume of drv:sound dev:card1 complete after 413.690 msecs [37874.645050] PM: resume of drv:usb dev:6-2 complete after 834.722 msecs [37874.645078] PM: resume of drv:usb dev:6-2:1.0 complete after 834.724 msecs [37874.802618] usb 3-2: reset full speed USB device using uhci_hcd and address 3 [37874.872615] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [37874.883990] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [37874.883997] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [37874.884371] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [37874.884377] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [37874.888479] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [37874.888486] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [37874.888861] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [37874.888867] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [37874.890503] ata3.00: configured for UDMA/100 [37874.913691] ata3.00: configured for UDMA/100 [37874.913696] ata3: EH complete [37874.931703] PM: resume of drv:sd dev:2:0:0:0 complete after 1121.568 msecs [37874.931720] PM: resume of drv:scsi_device dev:2:0:0:0 complete after 1121.528 msecs [37874.931732] PM: resume of drv:scsi_disk dev:2:0:0:0 complete after 422.240 msecs [37875.017655] PM: resume of drv:usb dev:3-2 complete after 1207.436 msecs [37875.017684] PM: resume of drv:usb dev:3-2:1.0 complete after 1207.438 msecs [37875.270096] usb 5-1: reset low speed USB device using uhci_hcd and address 2 [37875.405917] Synaptics Touchpad, model: 1, fw: 6.2, id: 0x81a0b1, caps: 0xa04793/0x300000/0x0 [37875.405921] Synaptics: Clickpad mode enabled [37875.405925] serio: Synaptics pass-through port at isa0060/serio1/input0 [37875.446710] input: SynPS/2 Synaptics TouchPad as /devices/platform/i8042/serio1/input/input13 [37875.579128] PM: resume of drv:usb dev:5-1 complete after 1768.855 msecs [37875.579159] PM: resume of drv:usb dev:5-1:1.0 complete after 1768.861 msecs [37875.579194] PM: resume of drv: dev:ep_81 complete after 561.470 msecs [37875.720058] PM: resume of drv:pcmcia_socket dev:pcmcia_socket0 complete after 140.692 msecs [37875.721670] thinkpad_acpi: ACPI backlight control delay disabled [37875.726728] PM: resume of devices complete after 1945.923 msecs [37875.738178] input: X10 Wireless Technology Inc USB Receiver as /devices/pci0000:00/0000:00:1d.0/usb5/5-1/input/input14 [37875.746108] usb 5-1: Weird data, len=1 ff 00 00 00 14 20 ... [37875.763282] PM: resume devices took 1.980 seconds [37875.763343] PM: Finishing wakeup. [37875.763346] Restarting tasks ... done. [37875.866156] video LNXVIDEO:00: Restoring backlight state [37876.269754] Skipping EDID probe due to cached edid [37877.292826] 4:3:1: cannot set freq 16000 to ep 0x86 [37877.840432] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [37877.890175] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [37877.891159] ADDRCONF(NETDEV_UP): eth0: link is not ready [37878.620830] usb 3-1: new full speed USB device using uhci_hcd and address 5 [37881.565163] IBM TrackPoint firmware: 0x0e, buttons: 3/3 [37881.796159] input: TPPS/2 IBM TrackPoint as /devices/platform/i8042/serio1/serio4/input/input15 [38118.752721] type=1400 audit(1278448948.969:28): operation="getattr" pid=27803 parent=16275 profile="/sbin/dhclient3" name="/lib/" pid=27803 comm="dhclient" requested_mask="r" denied_mask="r" fsuid=0 ouid=0 [38118.752762] type=1400 audit(1278448948.969:29): operation="getattr" pid=27803 parent=16275 profile="/sbin/dhclient3" name="/usr/lib/" pid=27803 comm="dhclient" requested_mask="r" denied_mask="r" fsuid=0 ouid=0 [38142.815872] e1000e: Intel(R) PRO/1000 Network Driver - 1.0.2-k4 [38142.815878] e1000e: Copyright (c) 1999 - 2009 Intel Corporation. [38142.815960] e1000e 0000:00:19.0: PCI INT A -> GSI 20 (level, low) -> IRQ 20 [38142.815988] e1000e 0000:00:19.0: setting latency timer to 64 [38142.816936] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [38143.286292] e1000e 0000:00:19.0: eth0: (PCI Express:2.5GB/s:Width x1) 00:1c:25:12:93:af [38143.286302] e1000e 0000:00:19.0: eth0: Intel(R) PRO/1000 Network Connection [38143.286591] e1000e 0000:00:19.0: eth0: MAC: 6, PHY: 6, PBA No: ffffff-0ff [38143.680427] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [38143.730270] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [38143.731637] ADDRCONF(NETDEV_UP): eth0: link is not ready [38145.160967] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: RX/TX [38145.160974] e1000e 0000:00:19.0: eth0: 10/100 speed: disabling TSO [38145.161822] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [38145.214594] type=1400 audit(1278448975.429:30): operation="getattr" pid=27824 parent=1041 profile="/sbin/dhclient3" name="/lib/" pid=27824 comm="dhclient" requested_mask="r" denied_mask="r" fsuid=0 ouid=0 [38145.214635] type=1400 audit(1278448975.429:31): operation="getattr" pid=27824 parent=1041 profile="/sbin/dhclient3" name="/usr/lib/" pid=27824 comm="dhclient" requested_mask="r" denied_mask="r" fsuid=0 ouid=0 [38155.210059] eth0: no IPv6 routers present [38270.280706] Skipping EDID probe due to cached edid [38318.048331] Skipping EDID probe due to cached edid [38338.447949] Skipping EDID probe due to cached edid [40655.885682] Skipping EDID probe due to cached edid [40909.114230] Skipping EDID probe due to cached edid [42297.550052] Skipping EDID probe due to cached edid [42311.680208] Skipping EDID probe due to cached edid [43725.180931] Skipping EDID probe due to cached edid [44278.580799] Skipping EDID probe due to cached edid [44298.693946] Skipping EDID probe due to cached edid [44434.610535] Skipping EDID probe due to cached edid [44560.547874] Skipping EDID probe due to cached edid [45263.700025] [drm:i915_hangcheck_elapsed] *ERROR* Hangcheck timer elapsed... GPU hung [45263.700210] [drm:i915_do_wait_request] *ERROR* i915_do_wait_request returns -5 (awaiting 1647887 at 1647886) [45265.058027] chromium-browse[29812]: segfault at 7fc6a8263f08 ip 00007fc6b4a80644 sp 00007fc6a242b7b0 error 4 in libpthread-2.12.so[7fc6b4a77000+18000] [45294.982718] Skipping EDID probe due to cached edid [45295.140799] Skipping EDID probe due to cached edid [45297.410405] ADDRCONF(NETDEV_UP): wlan0: link is not ready [45300.140080] usb 6-1: new full speed USB device using uhci_hcd and address 5 [45300.209745] Skipping EDID probe due to cached edid [45300.326288] sierra 6-1:1.0: Sierra USB modem converter detected [45300.327452] usb 6-1: Sierra USB modem converter now attached to ttyUSB0 [45300.327665] usb 6-1: Sierra USB modem converter now attached to ttyUSB1 [45300.327868] usb 6-1: Sierra USB modem converter now attached to ttyUSB2 [45300.367137] Skipping EDID probe due to cached edid [45300.589169] Skipping EDID probe due to cached edid [45310.056496] Skipping EDID probe due to cached edid [45310.219683] Skipping EDID probe due to cached edid [45310.379734] Skipping EDID probe due to cached edid [45312.359055] Skipping EDID probe due to cached edid [45320.569019] Skipping EDID probe due to cached edid [45331.896939] wlan0: authenticate with 00:23:4d:90:b3:b4 (try 1) [45331.898769] wlan0: authenticated [45331.898822] wlan0: associate with 00:23:4d:90:b3:b4 (try 1) [45331.901427] wlan0: RX AssocResp from 00:23:4d:90:b3:b4 (capab=0x411 status=0 aid=4) [45331.901433] wlan0: associated [45331.929214] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [45333.233073] type=1400 audit(1278456163.448:32): operation="getattr" pid=30174 parent=1041 profile="/sbin/dhclient3" name="/lib/" pid=30174 comm="dhclient" requested_mask="r" denied_mask="r" fsuid=0 ouid=0 [45333.233113] type=1400 audit(1278456163.448:33): operation="getattr" pid=30174 parent=1041 profile="/sbin/dhclient3" name="/usr/lib/" pid=30174 comm="dhclient" requested_mask="r" denied_mask="r" fsuid=0 ouid=0 [45342.392551] wlan0: no IPv6 routers present [45351.108715] Skipping EDID probe due to cached edid [45351.268645] Skipping EDID probe due to cached edid [45351.429029] Skipping EDID probe due to cached edid [45366.959533] Skipping EDID probe due to cached edid [45370.471012] Skipping EDID probe due to cached edid [47542.042687] usb 3-1: USB disconnect, address 5 [47542.042963] btusb_intr_complete: hci0 urb ffff880095f8e780 failed to resubmit (19) [47542.042984] btusb_bulk_complete: hci0 urb ffff880095f8ecc0 failed to resubmit (19) [47542.043966] btusb_bulk_complete: hci0 urb ffff880095f8ed80 failed to resubmit (19) [47542.044124] btusb_send_frame: hci0 urb ffff88007b9bba80 submission failed [47542.232329] iwlagn 0000:03:00.0: ACTIVATE a non DRIVER active station id 0 addr 00:23:4d:90:b3:b4 [47542.270243] wlan0: deauthenticating from 00:23:4d:90:b3:b4 by local choice (reason=3) [47542.301113] cfg80211: All devices are disconnected, going to restore regulatory settings [47542.301127] cfg80211: Restoring regulatory settings while preserving user preference for: JP [47542.301137] cfg80211: Calling CRDA to update world regulatory domain [47542.301171] cfg80211: Calling CRDA for country: JP [47542.438751] cfg80211: Regulatory domain changed to country: JP [47542.438756] (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [47542.438762] (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm) [47542.438767] (2457000 KHz - 2482000 KHz @ 20000 KHz), (N/A, 2000 mBm) [47542.438772] (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm) [47542.438776] (4910000 KHz - 4930000 KHz @ 10000 KHz), (N/A, 2300 mBm) [47542.438780] (4910000 KHz - 4990000 KHz @ 40000 KHz), (N/A, 2300 mBm) [47542.438785] (4930000 KHz - 4950000 KHz @ 10000 KHz), (N/A, 2300 mBm) [47542.438789] (5030000 KHz - 5045000 KHz @ 10000 KHz), (N/A, 2300 mBm) [47542.438794] (5030000 KHz - 5090000 KHz @ 40000 KHz), (N/A, 2300 mBm) [47542.438798] (5050000 KHz - 5060000 KHz @ 10000 KHz), (N/A, 2300 mBm) [47542.438802] (5170000 KHz - 5250000 KHz @ 40000 KHz), (N/A, 2000 mBm) [47542.438807] (5250000 KHz - 5330000 KHz @ 40000 KHz), (N/A, 2000 mBm) [47542.438811] (5490000 KHz - 5710000 KHz @ 40000 KHz), (N/A, 2300 mBm) [47544.092864] PM: Syncing filesystems ... done. [47544.152894] PM: Preparing system for mem sleep [47544.803023] Freezing user space processes ... (elapsed 0.01 seconds) done. [47544.822635] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done. [47544.840118] PM: Entering mem sleep [47544.840137] Suspending console(s) (use no_console_suspend to debug) [47544.994889] PM: suspend of drv:psmouse dev:serio4 complete after 154.042 msecs [47545.020582] sd 2:0:0:0: [sda] Synchronizing SCSI cache [47545.020657] sd 2:0:0:0: [sda] Stopping disk [47545.131489] ehci_hcd 0000:00:1d.7: PCI INT D disabled [47545.131516] uhci_hcd 0000:00:1d.2: PCI INT C disabled [47545.131540] uhci_hcd 0000:00:1d.1: PCI INT B disabled [47545.131573] uhci_hcd 0000:00:1d.0: PCI INT A disabled [47545.131658] pciehp 0000:00:1c.3:pcie04: pciehp_suspend ENTRY [47545.131675] ACPI handle has no context! [47545.131697] sdhci-pci 0000:15:00.2: PCI INT C disabled [47545.131712] ACPI handle has no context! [47545.131782] ata2: port disabled. ignoring. [47545.131889] ata_piix 0000:00:1f.1: PCI INT C disabled [47545.131929] ehci_hcd 0000:00:1a.7: PCI INT C disabled [47545.131950] uhci_hcd 0000:00:1a.1: PCI INT B disabled [47545.131975] uhci_hcd 0000:00:1a.0: PCI INT A disabled [47545.133595] e1000e 0000:00:19.0: PME# enabled [47545.133608] e1000e 0000:00:19.0: wake-up capability enabled by ACPI [47545.150166] i915 0000:00:02.0: power state changed by ACPI to D3 [47545.240377] HDA Intel 0000:00:1b.0: PCI INT B disabled [47545.260042] PM: suspend of drv:HDA Intel dev:0000:00:1b.0 complete after 128.287 msecs [47545.418667] PM: suspend of drv:sd dev:2:0:0:0 complete after 398.091 msecs [47545.418686] PM: suspend of drv:scsi dev:target2:0:0 complete after 398.006 msecs [47545.418703] PM: suspend of drv:scsi dev:host2 complete after 397.972 msecs [47545.450029] PM: suspend of drv:ahci dev:0000:00:1f.2 complete after 318.637 msecs [47545.450047] PM: suspend of drv: dev:pci0000:00 complete after 317.483 msecs [47545.450061] PM: suspend of devices complete after 609.330 msecs [47545.450066] PM: suspend devices took 0.610 seconds [47545.492621] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D3 [47545.512611] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D3 [47545.532611] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D3 [47545.572611] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D3 [47545.642597] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D3 [47545.642802] PM: late suspend of devices complete after 192.730 msecs [47545.742598] ACPI: Preparing to enter system sleep state S3 [47546.092681] Disabling non-boot CPUs ... [47546.220041] CPU 1 is now offline [47546.220046] SMP alternatives: switching to UP code [47546.235411] Extended CMOS year: 2000 [47546.235411] Back to C! [47546.235411] Extended CMOS year: 2000 [47546.235411] Enabling non-boot CPUs ... [47546.235411] SMP alternatives: switching to SMP code [47546.243295] Booting Node 0 Processor 1 APIC 0x1 [47546.552543] CPU1 is up [47546.553474] ACPI: Waking up from system sleep state S3 [47547.472820] i915 0000:00:02.0: restoring config space at offset 0x1 (was 0x900007, writing 0x900407) [47547.472866] pci 0000:00:02.1: restoring config space at offset 0x1 (was 0x900000, writing 0x900007) [47547.473058] uhci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [47547.582595] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [47547.602609] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [47547.602677] uhci_hcd 0000:00:1a.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [47547.622607] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [47547.642608] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [47547.642618] PM: early resume of drv:uhci_hcd dev:0000:00:1a.1 complete after 169.534 msecs [47547.642703] ehci_hcd 0000:00:1a.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102) [47547.662607] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 [47547.682607] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 [47547.682716] HDA Intel 0000:00:1b.0: restoring config space at offset 0x1 (was 0x100106, writing 0x100102) [47547.682857] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [47547.683040] pcieport 0000:00:1c.1: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [47547.683221] pcieport 0000:00:1c.2: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [47547.683404] pcieport 0000:00:1c.3: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [47547.683586] pcieport 0000:00:1c.4: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [47547.702609] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [47547.722608] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [47547.722673] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [47547.742606] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [47547.762606] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [47547.762678] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [47547.782608] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0 [47547.802608] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0 [47547.802675] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [47547.822606] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0 [47547.842607] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0 [47547.842702] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102) [47547.862606] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [47547.882608] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [47547.882693] pci 0000:00:1e.0: restoring config space at offset 0x1 (was 0x100005, writing 0x100007) [47547.882890] ata_piix 0000:00:1f.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2880005) [47547.883003] ahci 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00007, writing 0x2b00407) [47547.883369] iwlagn 0000:03:00.0: restoring config space at offset 0x1 (was 0x100106, writing 0x100506) [47547.900048] sdhci-pci 0000:15:00.2: BAR 0: set to [mem 0xf8301800-0xf83018ff] (PCI address [0xf8301800-0xf83018ff] [47547.900120] sdhci-pci 0000:15:00.2: restoring config space at offset 0x3 (was 0x800000, writing 0x804000) [47547.900137] sdhci-pci 0000:15:00.2: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100006) [47547.920045] r852 0000:15:00.5: BAR 0: set to [mem 0xf8302400-0xf83024ff] (PCI address [0xf8302400-0xf83024ff] [47547.920118] r852 0000:15:00.5: restoring config space at offset 0x3 (was 0x800000, writing 0x804000) [47547.920135] r852 0000:15:00.5: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100006) [47547.920783] PM: early resume of devices complete after 448.112 msecs [47547.930987] i915 0000:00:02.0: power state changed by ACPI to D0 [47547.931342] i915 0000:00:02.0: power state changed by ACPI to D0 [47547.931352] i915 0000:00:02.0: setting latency timer to 64 [47547.931390] e1000e 0000:00:19.0: wake-up capability disabled by ACPI [47547.931399] e1000e 0000:00:19.0: PME# disabled [47547.931572] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [47547.943135] uhci_hcd 0000:00:1a.0: PCI INT A -> GSI 20 (level, low) -> IRQ 20 [47547.943152] uhci_hcd 0000:00:1a.0: setting latency timer to 64 [47547.943193] usb usb3: root hub lost power or was reset [47547.943484] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [47547.943779] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [47547.943789] uhci_hcd 0000:00:1a.1: PCI INT B -> GSI 21 (level, low) -> IRQ 21 [47547.943805] uhci_hcd 0000:00:1a.1: setting latency timer to 64 [47547.943845] usb usb4: root hub lost power or was reset [47547.944147] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 [47547.944438] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 [47547.944452] ehci_hcd 0000:00:1a.7: PCI INT C -> GSI 22 (level, low) -> IRQ 22 [47547.944468] ehci_hcd 0000:00:1a.7: setting latency timer to 64 [47547.944536] HDA Intel 0000:00:1b.0: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [47547.944547] HDA Intel 0000:00:1b.0: setting latency timer to 64 [47547.944644] HDA Intel 0000:00:1b.0: irq 49 for MSI/MSI-X [47547.944822] pciehp 0000:00:1c.3:pcie04: pciehp_resume ENTRY [47547.945165] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [47547.945416] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [47547.945426] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [47547.945442] uhci_hcd 0000:00:1d.0: setting latency timer to 64 [47547.945484] usb usb5: root hub lost power or was reset [47547.945520] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [47547.945529] uhci_hcd 0000:00:1d.1: setting latency timer to 64 [47547.945563] usb usb6: root hub lost power or was reset [47547.945883] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0 [47547.946136] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0 [47547.946146] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [47547.946162] uhci_hcd 0000:00:1d.2: setting latency timer to 64 [47547.946203] usb usb7: root hub lost power or was reset [47547.946488] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [47547.946743] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [47547.946757] ehci_hcd 0000:00:1d.7: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [47547.946773] ehci_hcd 0000:00:1d.7: setting latency timer to 64 [47547.946845] pci 0000:00:1e.0: setting latency timer to 64 [47547.946865] ata_piix 0000:00:1f.1: PCI INT C -> GSI 16 (level, low) -> IRQ 16 [47547.946874] ata_piix 0000:00:1f.1: setting latency timer to 64 [47547.946917] ahci 0000:00:1f.2: setting latency timer to 64 [47547.947037] sdhci-pci 0000:15:00.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [47547.947042] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [47547.948157] ata2: port disabled. ignoring. [47547.951544] sd 2:0:0:0: [sda] Starting disk [47548.102705] PM: resume of drv:usb dev:usb7 complete after 151.472 msecs [47548.102740] PM: resume of drv:hub dev:7-0:1.0 complete after 151.477 msecs [47548.102746] PM: resume of drv:usb dev:usb4 complete after 151.687 msecs [47548.102762] PM: resume of drv:hub dev:4-0:1.0 complete after 151.676 msecs [47548.131229] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [47548.131235] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [47548.132849] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [47548.134296] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [47548.193301] ata1.00: configured for UDMA/33 [47548.212564] PM: resume of drv:usb dev:usb6 complete after 261.391 msecs [47548.212584] PM: resume of drv:usb dev:usb5 complete after 261.471 msecs [47548.212598] PM: resume of drv:hub dev:6-0:1.0 complete after 261.392 msecs [47548.212609] PM: resume of drv:hub dev:5-0:1.0 complete after 261.464 msecs [47548.220051] PM: resume of drv:usb dev:usb3 complete after 269.059 msecs [47548.220066] PM: resume of drv:hub dev:3-0:1.0 complete after 269.040 msecs [47548.230049] PM: resume of drv:usb dev:usb1 complete after 281.932 msecs [47548.230067] PM: resume of drv:usb dev:usb2 complete after 279.134 msecs [47548.230082] PM: resume of drv:hub dev:1-0:1.0 complete after 279.176 msecs [47548.230117] PM: resume of drv:hub dev:2-0:1.0 complete after 279.152 msecs [47548.230164] PM: resume of drv:usb dev:6-1 complete after 278.204 msecs [47548.230207] PM: resume of drv: dev:ep_81 complete after 281.649 msecs [47548.232553] PM: resume of drv:sierra dev:6-1:1.0 complete after 280.418 msecs [47548.244703] PM: resume of drv:e1000e dev:0000:00:19.0 complete after 313.311 msecs [47548.322868] PM: resume of drv:i915 dev:0000:00:02.0 complete after 401.743 msecs [47548.342610] usb 1-3: reset high speed USB device using ehci_hcd and address 4 [47548.622573] usb 6-2: reset full speed USB device using uhci_hcd and address 3 [47548.650309] snd-usb-audio 1-3:1.2: no reset_resume for driver snd-usb-audio? [47548.650314] snd-usb-audio 1-3:1.3: no reset_resume for driver snd-usb-audio? [47548.650514] PM: resume of drv:usb dev:1-3 complete after 699.211 msecs [47548.650538] PM: resume of drv:usb dev:1-3:1.2 complete after 699.165 msecs [47548.650554] PM: resume of drv:uvcvideo dev:1-3:1.0 complete after 699.222 msecs [47548.650558] PM: resume of drv:sound dev:card1 complete after 417.849 msecs [47548.650564] PM: resume of drv:uvcvideo dev:1-3:1.1 complete after 699.209 msecs [47548.650575] PM: resume of drv:usb dev:1-3:1.3 complete after 699.171 msecs [47548.804705] PM: resume of drv:usb dev:6-2 complete after 852.798 msecs [47548.804733] PM: resume of drv:usb dev:6-2:1.0 complete after 852.799 msecs [47548.962599] usb 3-2: reset full speed USB device using uhci_hcd and address 3 [47549.012620] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [47549.023671] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [47549.023678] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [47549.024047] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [47549.024053] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [47549.027994] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [47549.028000] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [47549.028374] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [47549.028380] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [47549.029998] ata3.00: configured for UDMA/100 [47549.053774] ata3.00: configured for UDMA/100 [47549.053779] ata3: EH complete [47549.071494] PM: resume of drv:sd dev:2:0:0:0 complete after 1119.953 msecs [47549.071511] PM: resume of drv:scsi_disk dev:2:0:0:0 complete after 420.927 msecs [47549.071526] PM: resume of drv:scsi_device dev:2:0:0:0 complete after 1119.927 msecs [47549.117660] PM: resume of drv:usb dev:3-2 complete after 1166.031 msecs [47549.117688] PM: resume of drv:usb dev:3-2:1.0 complete after 1166.030 msecs [47549.370103] usb 5-1: reset low speed USB device using uhci_hcd and address 2 [47549.540205] Synaptics Touchpad, model: 1, fw: 6.2, id: 0x81a0b1, caps: 0xa04793/0x300000/0x0 [47549.540209] Synaptics: Clickpad mode enabled [47549.540213] serio: Synaptics pass-through port at isa0060/serio1/input0 [47549.580830] input: SynPS/2 Synaptics TouchPad as /devices/platform/i8042/serio1/input/input16 [47549.679696] PM: resume of drv:usb dev:5-1 complete after 1728.007 msecs [47549.679732] PM: resume of drv:usb dev:5-1:1.0 complete after 1727.884 msecs [47549.679765] PM: resume of drv: dev:ep_81 complete after 562.039 msecs [47549.820079] PM: resume of drv:pcmcia_socket dev:pcmcia_socket0 complete after 140.138 msecs [47549.821701] thinkpad_acpi: ACPI backlight control delay disabled [47549.826795] PM: resume of devices complete after 1905.957 msecs [47549.838765] input: X10 Wireless Technology Inc USB Receiver as /devices/pci0000:00/0000:00:1d.0/usb5/5-1/input/input17 [47549.846679] usb 5-1: Weird data, len=1 ff 00 00 00 14 20 ... [47549.860904] PM: resume devices took 1.940 seconds [47549.860965] PM: Finishing wakeup. [47549.860968] Restarting tasks ... [47549.861041] usb 6-1: USB disconnect, address 5 [47549.861238] sierra ttyUSB0: Sierra USB modem converter now disconnected from ttyUSB0 [47549.861311] sierra ttyUSB1: Sierra USB modem converter now disconnected from ttyUSB1 [47549.861380] sierra ttyUSB2: Sierra USB modem converter now disconnected from ttyUSB2 [47549.861410] sierra 6-1:1.0: device disconnected [47549.916803] [drm:output_poll_execute] *ERROR* delayed enqueue failed -125 [47549.923565] done. [47549.923574] video LNXVIDEO:00: Restoring backlight state [47550.331544] Skipping EDID probe due to cached edid [47550.570052] usb 6-1: new full speed USB device using uhci_hcd and address 6 [47550.742765] sierra 6-1:1.0: Sierra USB modem converter detected [47550.745283] usb 6-1: Sierra USB modem converter now attached to ttyUSB0 [47550.745357] usb 6-1: Sierra USB modem converter now attached to ttyUSB1 [47550.745429] usb 6-1: Sierra USB modem converter now attached to ttyUSB2 [47551.930497] ADDRCONF(NETDEV_UP): wlan0: link is not ready [47552.080077] usb 3-1: new full speed USB device using uhci_hcd and address 6 [47552.273172] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [47552.332654] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [47552.333596] ADDRCONF(NETDEV_UP): eth0: link is not ready [47553.720995] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: RX/TX [47553.721005] e1000e 0000:00:19.0: eth0: 10/100 speed: disabling TSO [47553.722309] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [47555.425237] IBM TrackPoint firmware: 0x0e, buttons: 3/3 [47555.515446] type=1400 audit(1278530808.512:34): operation="getattr" pid=32049 parent=1041 profile="/sbin/dhclient3" name="/lib/" pid=32049 comm="dhclient" requested_mask="r" denied_mask="r" fsuid=0 ouid=0 [47555.515488] type=1400 audit(1278530808.512:35): operation="getattr" pid=32049 parent=1041 profile="/sbin/dhclient3" name="/usr/lib/" pid=32049 comm="dhclient" requested_mask="r" denied_mask="r" fsuid=0 ouid=0 [47555.660377] input: TPPS/2 IBM TrackPoint as /devices/platform/i8042/serio1/serio5/input/input18 [47556.884794] wlan0: authenticate with 00:23:4d:90:b3:b4 (try 1) [47556.886659] wlan0: authenticated [47556.886717] wlan0: associate with 00:23:4d:90:b3:b4 (try 1) [47556.889327] wlan0: RX AssocResp from 00:23:4d:90:b3:b4 (capab=0x411 status=0 aid=3) [47556.889335] wlan0: associated [47556.917890] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [47557.077890] type=1400 audit(1278530810.711:36): operation="getattr" pid=32140 parent=1041 profile="/sbin/dhclient3" name="/lib/" pid=32140 comm="dhclient" requested_mask="r" denied_mask="r" fsuid=0 ouid=0 [47557.077950] type=1400 audit(1278530810.711:37): operation="getattr" pid=32140 parent=1041 profile="/sbin/dhclient3" name="/usr/lib/" pid=32140 comm="dhclient" requested_mask="r" denied_mask="r" fsuid=0 ouid=0 [47563.920087] eth0: no IPv6 routers present [47567.540035] wlan0: no IPv6 routers present [50081.292642] usb 3-1: USB disconnect, address 6 [50081.293042] btusb_intr_complete: hci0 urb ffff88004ca10cc0 failed to resubmit (19) [50081.293056] btusb_bulk_complete: hci0 urb ffff88004ca10d80 failed to resubmit (19) [50081.294040] btusb_bulk_complete: hci0 urb ffff88004ca10a80 failed to resubmit (19) [50081.294156] btusb_send_frame: hci0 urb ffff880062436c00 submission failed [50081.672299] iwlagn 0000:03:00.0: ACTIVATE a non DRIVER active station id 0 addr 00:23:4d:90:b3:b4 [50081.710200] wlan0: deauthenticating from 00:23:4d:90:b3:b4 by local choice (reason=3) [50081.745394] cfg80211: All devices are disconnected, going to restore regulatory settings [50081.745406] cfg80211: Restoring regulatory settings while preserving user preference for: JP [50081.745416] cfg80211: Calling CRDA to update world regulatory domain [50081.745458] cfg80211: Calling CRDA for country: JP [50081.756579] cfg80211: Regulatory domain changed to country: JP [50081.756585] (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [50081.756590] (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm) [50081.756595] (2457000 KHz - 2482000 KHz @ 20000 KHz), (N/A, 2000 mBm) [50081.756599] (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm) [50081.756604] (4910000 KHz - 4930000 KHz @ 10000 KHz), (N/A, 2300 mBm) [50081.756608] (4910000 KHz - 4990000 KHz @ 40000 KHz), (N/A, 2300 mBm) [50081.756613] (4930000 KHz - 4950000 KHz @ 10000 KHz), (N/A, 2300 mBm) [50081.756617] (5030000 KHz - 5045000 KHz @ 10000 KHz), (N/A, 2300 mBm) [50081.756621] (5030000 KHz - 5090000 KHz @ 40000 KHz), (N/A, 2300 mBm) [50081.756626] (5050000 KHz - 5060000 KHz @ 10000 KHz), (N/A, 2300 mBm) [50081.756630] (5170000 KHz - 5250000 KHz @ 40000 KHz), (N/A, 2000 mBm) [50081.756634] (5250000 KHz - 5330000 KHz @ 40000 KHz), (N/A, 2000 mBm) [50081.756639] (5490000 KHz - 5710000 KHz @ 40000 KHz), (N/A, 2300 mBm) [50083.262878] PM: Syncing filesystems ... done. [50083.330057] PM: Preparing system for mem sleep [50084.002736] Freezing user space processes ... (elapsed 0.01 seconds) done. [50084.022640] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done. [50084.040150] PM: Entering mem sleep [50084.040168] Suspending console(s) (use no_console_suspend to debug) [50084.195025] PM: suspend of drv:psmouse dev:serio5 complete after 154.180 msecs [50084.240494] sd 2:0:0:0: [sda] Synchronizing SCSI cache [50084.240580] sd 2:0:0:0: [sda] Stopping disk [50084.350632] ACPI handle has no context! [50084.350647] sdhci-pci 0000:15:00.2: PCI INT C disabled [50084.350660] ACPI handle has no context! [50084.351132] ehci_hcd 0000:00:1d.7: PCI INT D disabled [50084.351153] uhci_hcd 0000:00:1d.2: PCI INT C disabled [50084.351173] uhci_hcd 0000:00:1d.1: PCI INT B disabled [50084.351195] uhci_hcd 0000:00:1d.0: PCI INT A disabled [50084.351243] pciehp 0000:00:1c.3:pcie04: pciehp_suspend ENTRY [50084.351354] ata2: port disabled. ignoring. [50084.351454] ata_piix 0000:00:1f.1: PCI INT C disabled [50084.351494] ehci_hcd 0000:00:1a.7: PCI INT C disabled [50084.351518] uhci_hcd 0000:00:1a.1: PCI INT B disabled [50084.351539] uhci_hcd 0000:00:1a.0: PCI INT A disabled [50084.353162] e1000e 0000:00:19.0: PME# enabled [50084.353176] e1000e 0000:00:19.0: wake-up capability enabled by ACPI [50084.370137] i915 0000:00:02.0: power state changed by ACPI to D3 [50084.460395] HDA Intel 0000:00:1b.0: PCI INT B disabled [50084.480042] PM: suspend of drv:HDA Intel dev:0000:00:1b.0 complete after 128.702 msecs [50084.635521] PM: suspend of drv:sd dev:2:0:0:0 complete after 395.042 msecs [50084.635538] PM: suspend of drv:scsi dev:target2:0:0 complete after 394.962 msecs [50084.635555] PM: suspend of drv:scsi dev:host2 complete after 394.889 msecs [50084.670039] PM: suspend of drv:ahci dev:0000:00:1f.2 complete after 318.992 msecs [50084.670057] PM: suspend of drv: dev:pci0000:00 complete after 317.925 msecs [50084.670071] PM: suspend of devices complete after 629.329 msecs [50084.670075] PM: suspend devices took 0.630 seconds [50084.712622] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D3 [50084.732612] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D3 [50084.752609] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D3 [50084.792612] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D3 [50084.862597] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D3 [50084.862802] PM: late suspend of devices complete after 192.721 msecs [50084.962600] ACPI: Preparing to enter system sleep state S3 [50085.312679] Disabling non-boot CPUs ... [50085.450039] CPU 1 is now offline [50085.450043] SMP alternatives: switching to UP code [50085.465647] Extended CMOS year: 2000 [50085.465647] Back to C! [50085.465647] Extended CMOS year: 2000 [50085.465647] Enabling non-boot CPUs ... [50085.465647] SMP alternatives: switching to SMP code [50085.473623] Booting Node 0 Processor 1 APIC 0x1 [50085.802543] CPU1 is up [50085.803475] ACPI: Waking up from system sleep state S3 [50086.722834] i915 0000:00:02.0: restoring config space at offset 0x1 (was 0x900007, writing 0x900407) [50086.722879] pci 0000:00:02.1: restoring config space at offset 0x1 (was 0x900000, writing 0x900007) [50086.723071] uhci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [50086.832597] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [50086.852608] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [50086.852676] uhci_hcd 0000:00:1a.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [50086.872606] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [50086.892608] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [50086.892618] PM: early resume of drv:uhci_hcd dev:0000:00:1a.1 complete after 169.522 msecs [50086.892706] ehci_hcd 0000:00:1a.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102) [50086.912609] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 [50086.932608] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 [50086.932719] HDA Intel 0000:00:1b.0: restoring config space at offset 0x1 (was 0x100106, writing 0x100102) [50086.932860] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [50086.933043] pcieport 0000:00:1c.1: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [50086.933229] pcieport 0000:00:1c.2: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [50086.933414] pcieport 0000:00:1c.3: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [50086.933594] pcieport 0000:00:1c.4: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [50086.952608] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [50086.972608] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [50086.972674] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [50086.992606] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [50087.012615] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [50087.012687] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [50087.032608] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0 [50087.052607] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0 [50087.052674] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [50087.072606] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0 [50087.092608] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0 [50087.092702] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102) [50087.112606] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [50087.132608] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [50087.132691] pci 0000:00:1e.0: restoring config space at offset 0x1 (was 0x100005, writing 0x100007) [50087.132889] ata_piix 0000:00:1f.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2880005) [50087.133006] ahci 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00007, writing 0x2b00407) [50087.133391] iwlagn 0000:03:00.0: restoring config space at offset 0x1 (was 0x100106, writing 0x100506) [50087.150048] sdhci-pci 0000:15:00.2: BAR 0: set to [mem 0xf8301800-0xf83018ff] (PCI address [0xf8301800-0xf83018ff] [50087.150120] sdhci-pci 0000:15:00.2: restoring config space at offset 0x3 (was 0x800000, writing 0x804000) [50087.150137] sdhci-pci 0000:15:00.2: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100006) [50087.170047] r852 0000:15:00.5: BAR 0: set to [mem 0xf8302400-0xf83024ff] (PCI address [0xf8302400-0xf83024ff] [50087.170121] r852 0000:15:00.5: restoring config space at offset 0x3 (was 0x800000, writing 0x804000) [50087.170138] r852 0000:15:00.5: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100006) [50087.170788] PM: early resume of devices complete after 448.118 msecs [50087.181012] i915 0000:00:02.0: power state changed by ACPI to D0 [50087.181372] i915 0000:00:02.0: power state changed by ACPI to D0 [50087.181383] i915 0000:00:02.0: setting latency timer to 64 [50087.181551] e1000e 0000:00:19.0: wake-up capability disabled by ACPI [50087.181563] e1000e 0000:00:19.0: PME# disabled [50087.181768] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [50087.193183] uhci_hcd 0000:00:1a.0: PCI INT A -> GSI 20 (level, low) -> IRQ 20 [50087.193199] uhci_hcd 0000:00:1a.0: setting latency timer to 64 [50087.193243] usb usb3: root hub lost power or was reset [50087.193561] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [50087.193819] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [50087.193829] uhci_hcd 0000:00:1a.1: PCI INT B -> GSI 21 (level, low) -> IRQ 21 [50087.193844] uhci_hcd 0000:00:1a.1: setting latency timer to 64 [50087.193885] usb usb4: root hub lost power or was reset [50087.194198] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 [50087.194453] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 [50087.194467] ehci_hcd 0000:00:1a.7: PCI INT C -> GSI 22 (level, low) -> IRQ 22 [50087.194483] ehci_hcd 0000:00:1a.7: setting latency timer to 64 [50087.194551] HDA Intel 0000:00:1b.0: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [50087.194560] HDA Intel 0000:00:1b.0: setting latency timer to 64 [50087.194653] HDA Intel 0000:00:1b.0: irq 49 for MSI/MSI-X [50087.194831] pciehp 0000:00:1c.3:pcie04: pciehp_resume ENTRY [50087.195149] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [50087.195427] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [50087.195436] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [50087.195452] uhci_hcd 0000:00:1d.0: setting latency timer to 64 [50087.195493] usb usb5: root hub lost power or was reset [50087.195527] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [50087.195537] uhci_hcd 0000:00:1d.1: setting latency timer to 64 [50087.195570] usb usb6: root hub lost power or was reset [50087.195816] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0 [50087.196094] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0 [50087.196104] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [50087.196119] uhci_hcd 0000:00:1d.2: setting latency timer to 64 [50087.196161] usb usb7: root hub lost power or was reset [50087.196441] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [50087.196701] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [50087.196716] ehci_hcd 0000:00:1d.7: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [50087.196731] ehci_hcd 0000:00:1d.7: setting latency timer to 64 [50087.196801] pci 0000:00:1e.0: setting latency timer to 64 [50087.196821] ata_piix 0000:00:1f.1: PCI INT C -> GSI 16 (level, low) -> IRQ 16 [50087.196833] ata_piix 0000:00:1f.1: setting latency timer to 64 [50087.196875] ahci 0000:00:1f.2: setting latency timer to 64 [50087.196995] sdhci-pci 0000:15:00.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [50087.197000] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [50087.198606] ata2: port disabled. ignoring. [50087.202230] sd 2:0:0:0: [sda] Starting disk [50087.352621] PM: resume of drv:usb dev:usb7 complete after 150.809 msecs [50087.352659] PM: resume of drv:hub dev:7-0:1.0 complete after 150.815 msecs [50087.360274] PM: resume of drv:usb dev:usb4 complete after 158.646 msecs [50087.360436] PM: resume of drv:hub dev:4-0:1.0 complete after 158.775 msecs [50087.381216] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [50087.381222] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [50087.382606] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [50087.384600] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [50087.432864] PM: resume of drv:i915 dev:0000:00:02.0 complete after 261.731 msecs [50087.443339] ata1.00: configured for UDMA/33 [50087.460053] PM: resume of drv:usb dev:usb5 complete after 258.363 msecs [50087.460067] PM: resume of drv:usb dev:usb3 complete after 258.499 msecs [50087.460080] PM: resume of drv:usb dev:usb6 complete after 258.339 msecs [50087.460088] PM: resume of drv:hub dev:5-0:1.0 complete after 258.368 msecs [50087.460096] PM: resume of drv:hub dev:6-0:1.0 complete after 258.301 msecs [50087.460103] PM: resume of drv:hub dev:3-0:1.0 complete after 258.502 msecs [50087.470094] PM: resume of drv:usb dev:usb1 complete after 272.017 msecs [50087.470111] PM: resume of drv:usb dev:usb2 complete after 268.602 msecs [50087.470130] PM: resume of drv:hub dev:1-0:1.0 complete after 268.657 msecs [50087.470140] PM: resume of drv:hub dev:2-0:1.0 complete after 268.598 msecs [50087.470148] PM: resume of drv: dev:ep_81 complete after 271.428 msecs [50087.470190] PM: resume of drv:usb dev:6-1 complete after 267.562 msecs [50087.470243] PM: resume of drv:sierra dev:6-1:1.0 complete after 267.573 msecs [50087.494675] PM: resume of drv:e1000e dev:0000:00:19.0 complete after 313.124 msecs [50087.590058] usb 1-3: reset high speed USB device using ehci_hcd and address 4 [50087.860640] usb 3-2: reset full speed USB device using uhci_hcd and address 3 [50087.889394] snd-usb-audio 1-3:1.2: no reset_resume for driver snd-usb-audio? [50087.889398] snd-usb-audio 1-3:1.3: no reset_resume for driver snd-usb-audio? [50087.889621] PM: resume of drv:usb dev:1-3 complete after 687.707 msecs [50087.889646] PM: resume of drv:usb dev:1-3:1.3 complete after 687.507 msecs [50087.889660] PM: resume of drv:uvcvideo dev:1-3:1.0 complete after 687.698 msecs [50087.889665] PM: resume of drv:usb dev:1-3:1.2 complete after 687.566 msecs [50087.889676] PM: resume of drv:uvcvideo dev:1-3:1.1 complete after 687.651 msecs [50087.889680] PM: resume of drv:sound dev:card1 complete after 416.957 msecs [50088.020061] PM: resume of drv:usb dev:3-2 complete after 817.761 msecs [50088.020089] PM: resume of drv:usb dev:3-2:1.0 complete after 817.737 msecs [50088.122591] usb 6-2: reset full speed USB device using uhci_hcd and address 3 [50088.260085] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [50088.264339] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [50088.264346] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [50088.264756] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [50088.264762] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [50088.268767] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [50088.268773] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [50088.269131] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [50088.269137] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [50088.270776] ata3.00: configured for UDMA/100 [50088.287102] PM: resume of drv:usb dev:6-2 complete after 1084.594 msecs [50088.287130] PM: resume of drv:usb dev:6-2:1.0 complete after 1084.544 msecs [50088.293690] ata3.00: configured for UDMA/100 [50088.293695] ata3: EH complete [50088.312169] PM: resume of drv:sd dev:2:0:0:0 complete after 1109.941 msecs [50088.312186] PM: resume of drv:scsi_disk dev:2:0:0:0 complete after 422.486 msecs [50088.312201] PM: resume of drv:scsi_device dev:2:0:0:0 complete after 1109.972 msecs [50088.532594] usb 5-1: reset low speed USB device using uhci_hcd and address 2 [50088.781591] Synaptics Touchpad, model: 1, fw: 6.2, id: 0x81a0b1, caps: 0xa04793/0x300000/0x0 [50088.781595] Synaptics: Clickpad mode enabled [50088.781600] serio: Synaptics pass-through port at isa0060/serio1/input0 [50088.823504] input: SynPS/2 Synaptics TouchPad as /devices/platform/i8042/serio1/input/input19 [50088.840069] PM: resume of drv:usb dev:5-1 complete after 1637.666 msecs [50088.840111] PM: resume of drv:usb dev:5-1:1.0 complete after 1637.650 msecs [50088.840146] PM: resume of drv: dev:ep_81 complete after 527.883 msecs [50088.990059] PM: resume of drv:pcmcia_socket dev:pcmcia_socket0 complete after 149.740 msecs [50088.991683] thinkpad_acpi: ACPI backlight control delay disabled [50088.996841] PM: resume of devices complete after 1825.996 msecs [50089.008157] input: X10 Wireless Technology Inc USB Receiver as /devices/pci0000:00/0000:00:1d.0/usb5/5-1/input/input20 [50089.016069] usb 5-1: Weird data, len=1 ff 00 00 00 14 20 ... [50089.031242] PM: resume devices took 1.860 seconds [50089.031303] PM: Finishing wakeup. [50089.031306] Restarting tasks ... [50089.031400] usb 6-1: USB disconnect, address 6 [50089.031602] sierra ttyUSB0: Sierra USB modem converter now disconnected from ttyUSB0 [50089.031675] sierra ttyUSB1: Sierra USB modem converter now disconnected from ttyUSB1 [50089.031745] sierra ttyUSB2: Sierra USB modem converter now disconnected from ttyUSB2 [50089.031776] sierra 6-1:1.0: device disconnected [50089.113320] done. [50089.113331] video LNXVIDEO:00: Restoring backlight state [50089.590861] usb 6-1: new full speed USB device using uhci_hcd and address 7 [50089.597842] Skipping EDID probe due to cached edid [50089.884162] sierra 6-1:1.0: Sierra USB modem converter detected [50089.885214] usb 6-1: Sierra USB modem converter now attached to ttyUSB0 [50089.885288] usb 6-1: Sierra USB modem converter now attached to ttyUSB1 [50089.885358] usb 6-1: Sierra USB modem converter now attached to ttyUSB2 [50090.481728] ADDRCONF(NETDEV_UP): wlan0: link is not ready [50090.813164] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [50090.872756] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [50090.874151] ADDRCONF(NETDEV_UP): eth0: link is not ready [50091.320083] usb 3-1: new full speed USB device using uhci_hcd and address 7 [50092.343663] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: RX/TX [50092.343670] e1000e 0000:00:19.0: eth0: 10/100 speed: disabling TSO [50092.344561] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [50092.380745] type=1400 audit(1278534919.781:38): operation="getattr" pid=1621 parent=1041 profile="/sbin/dhclient3" name="/lib/" pid=1621 comm="dhclient" requested_mask="r" denied_mask="r" fsuid=0 ouid=0 [50092.380786] type=1400 audit(1278534919.781:39): operation="getattr" pid=1621 parent=1041 profile="/sbin/dhclient3" name="/usr/lib/" pid=1621 comm="dhclient" requested_mask="r" denied_mask="r" fsuid=0 ouid=0 [50093.525992] wlan0: authenticate with 00:23:4d:90:b3:b4 (try 1) [50093.527854] wlan0: authenticated [50093.527928] wlan0: associate with 00:23:4d:90:b3:b4 (try 1) [50093.530548] wlan0: RX AssocResp from 00:23:4d:90:b3:b4 (capab=0x411 status=0 aid=3) [50093.530555] wlan0: associated [50093.560475] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [50094.812118] IBM TrackPoint firmware: 0x0e, buttons: 3/3 [50095.043703] input: TPPS/2 IBM TrackPoint as /devices/platform/i8042/serio1/serio6/input/input21 [50095.493350] type=1400 audit(1278534922.891:40): operation="getattr" pid=1705 parent=1041 profile="/sbin/dhclient3" name="/lib/" pid=1705 comm="dhclient" requested_mask="r" denied_mask="r" fsuid=0 ouid=0 [50095.493392] type=1400 audit(1278534922.891:41): operation="getattr" pid=1705 parent=1041 profile="/sbin/dhclient3" name="/usr/lib/" pid=1705 comm="dhclient" requested_mask="r" denied_mask="r" fsuid=0 ouid=0 [50103.352618] eth0: no IPv6 routers present [50104.017318] wlan0: no IPv6 routers present [50173.998588] Skipping EDID probe due to cached edid [58562.540163] usb 3-1: USB disconnect, address 7 [58562.540723] btusb_intr_complete: hci0 urb ffff88003fdfda80 failed to resubmit (19) [58562.540737] btusb_bulk_complete: hci0 urb ffff8800940f20c0 failed to resubmit (19) [58562.541718] btusb_bulk_complete: hci0 urb ffff8800593b4780 failed to resubmit (19) [58562.541834] btusb_send_frame: hci0 urb ffff88001439b9c0 submission failed [58562.852242] iwlagn 0000:03:00.0: ACTIVATE a non DRIVER active station id 0 addr 00:23:4d:90:b3:b4 [58562.872703] wlan0: deauthenticating from 00:23:4d:90:b3:b4 by local choice (reason=3) [58562.901395] cfg80211: All devices are disconnected, going to restore regulatory settings [58562.901404] cfg80211: Restoring regulatory settings while preserving user preference for: JP [58562.901411] cfg80211: Calling CRDA to update world regulatory domain [58562.901438] cfg80211: Calling CRDA for country: JP [58563.066424] cfg80211: Regulatory domain changed to country: JP [58563.066429] (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [58563.066434] (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm) [58563.066439] (2457000 KHz - 2482000 KHz @ 20000 KHz), (N/A, 2000 mBm) [58563.066443] (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm) [58563.066448] (4910000 KHz - 4930000 KHz @ 10000 KHz), (N/A, 2300 mBm) [58563.066452] (4910000 KHz - 4990000 KHz @ 40000 KHz), (N/A, 2300 mBm) [58563.066456] (4930000 KHz - 4950000 KHz @ 10000 KHz), (N/A, 2300 mBm) [58563.066460] (5030000 KHz - 5045000 KHz @ 10000 KHz), (N/A, 2300 mBm) [58563.066465] (5030000 KHz - 5090000 KHz @ 40000 KHz), (N/A, 2300 mBm) [58563.066469] (5050000 KHz - 5060000 KHz @ 10000 KHz), (N/A, 2300 mBm) [58563.066473] (5170000 KHz - 5250000 KHz @ 40000 KHz), (N/A, 2000 mBm) [58563.066478] (5250000 KHz - 5330000 KHz @ 40000 KHz), (N/A, 2000 mBm) [58563.066482] (5490000 KHz - 5710000 KHz @ 40000 KHz), (N/A, 2300 mBm) [58566.072850] PM: Syncing filesystems ... done. [58566.140081] PM: Preparing system for mem sleep [58566.730213] Freezing user space processes ... (elapsed 0.02 seconds) done. [58566.752638] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done. [58566.772618] PM: Entering mem sleep [58566.772635] Suspending console(s) (use no_console_suspend to debug) [58566.924945] PM: suspend of drv:psmouse dev:serio6 complete after 151.641 msecs [58566.970476] sd 2:0:0:0: [sda] Synchronizing SCSI cache [58566.970577] sd 2:0:0:0: [sda] Stopping disk [58567.081527] ata2: port disabled. ignoring. [58567.081692] ata_piix 0000:00:1f.1: PCI INT C disabled [58567.081716] ACPI handle has no context! [58567.081730] sdhci-pci 0000:15:00.2: PCI INT C disabled [58567.081744] ACPI handle has no context! [58567.081778] ehci_hcd 0000:00:1d.7: PCI INT D disabled [58567.081784] uhci_hcd 0000:00:1d.2: PCI INT C disabled [58567.081817] uhci_hcd 0000:00:1d.0: PCI INT A disabled [58567.081818] uhci_hcd 0000:00:1d.1: PCI INT B disabled [58567.081861] pciehp 0000:00:1c.3:pcie04: pciehp_suspend ENTRY [58567.081938] ehci_hcd 0000:00:1a.7: PCI INT C disabled [58567.081971] uhci_hcd 0000:00:1a.1: PCI INT B disabled [58567.081994] uhci_hcd 0000:00:1a.0: PCI INT A disabled [58567.083612] e1000e 0000:00:19.0: PME# enabled [58567.083626] e1000e 0000:00:19.0: wake-up capability enabled by ACPI [58567.100173] i915 0000:00:02.0: power state changed by ACPI to D3 [58567.190374] HDA Intel 0000:00:1b.0: PCI INT B disabled [58567.210042] PM: suspend of drv:HDA Intel dev:0000:00:1b.0 complete after 128.133 msecs [58567.370477] PM: suspend of drv:sd dev:2:0:0:0 complete after 400.007 msecs [58567.370497] PM: suspend of drv:scsi dev:target2:0:0 complete after 399.943 msecs [58567.370513] PM: suspend of drv:scsi dev:host2 complete after 399.903 msecs [58567.410029] PM: suspend of drv:ahci dev:0000:00:1f.2 complete after 328.633 msecs [58567.410045] PM: suspend of drv: dev:pci0000:00 complete after 327.336 msecs [58567.410057] PM: suspend of devices complete after 636.847 msecs [58567.410062] PM: suspend devices took 0.640 seconds [58567.452620] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D3 [58567.472611] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D3 [58567.492613] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D3 [58567.532609] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D3 [58567.602600] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D3 [58567.602811] PM: late suspend of devices complete after 192.741 msecs [58567.702600] ACPI: Preparing to enter system sleep state S3 [58568.052682] Disabling non-boot CPUs ... [58568.180042] CPU 1 is now offline [58568.180046] SMP alternatives: switching to UP code [58568.195400] Extended CMOS year: 2000 [58568.195400] Back to C! [58568.195400] Extended CMOS year: 2000 [58568.195400] Enabling non-boot CPUs ... [58568.195400] SMP alternatives: switching to SMP code [58568.203272] Booting Node 0 Processor 1 APIC 0x1 [58568.532542] CPU1 is up [58568.533473] ACPI: Waking up from system sleep state S3 [58569.452833] i915 0000:00:02.0: restoring config space at offset 0x1 (was 0x900007, writing 0x900407) [58569.452878] pci 0000:00:02.1: restoring config space at offset 0x1 (was 0x900000, writing 0x900007) [58569.453072] uhci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [58569.562597] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [58569.582609] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [58569.582678] uhci_hcd 0000:00:1a.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [58569.602607] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [58569.622606] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [58569.622616] PM: early resume of drv:uhci_hcd dev:0000:00:1a.1 complete after 169.519 msecs [58569.622702] ehci_hcd 0000:00:1a.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102) [58569.642608] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 [58569.662608] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 [58569.662722] HDA Intel 0000:00:1b.0: restoring config space at offset 0x1 (was 0x100106, writing 0x100102) [58569.662864] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [58569.663051] pcieport 0000:00:1c.1: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [58569.663236] pcieport 0000:00:1c.2: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [58569.663423] pcieport 0000:00:1c.3: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [58569.663608] pcieport 0000:00:1c.4: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [58569.682607] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [58569.702608] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [58569.702676] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [58569.722608] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [58569.742608] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [58569.742680] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [58569.762608] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0 [58569.782607] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0 [58569.782675] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [58569.802608] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0 [58569.822608] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0 [58569.822705] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102) [58569.842606] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [58569.862607] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [58569.862692] pci 0000:00:1e.0: restoring config space at offset 0x1 (was 0x100005, writing 0x100007) [58569.862886] ata_piix 0000:00:1f.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2880005) [58569.863000] ahci 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00007, writing 0x2b00407) [58569.863369] iwlagn 0000:03:00.0: restoring config space at offset 0x1 (was 0x100106, writing 0x100506) [58569.880049] sdhci-pci 0000:15:00.2: BAR 0: set to [mem 0xf8301800-0xf83018ff] (PCI address [0xf8301800-0xf83018ff] [58569.880124] sdhci-pci 0000:15:00.2: restoring config space at offset 0x3 (was 0x800000, writing 0x804000) [58569.880138] sdhci-pci 0000:15:00.2: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100006) [58569.900047] r852 0000:15:00.5: BAR 0: set to [mem 0xf8302400-0xf83024ff] (PCI address [0xf8302400-0xf83024ff] [58569.900121] r852 0000:15:00.5: restoring config space at offset 0x3 (was 0x800000, writing 0x804000) [58569.900138] r852 0000:15:00.5: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100006) [58569.900807] PM: early resume of devices complete after 448.137 msecs [58569.910993] i915 0000:00:02.0: power state changed by ACPI to D0 [58569.911356] i915 0000:00:02.0: power state changed by ACPI to D0 [58569.911366] i915 0000:00:02.0: setting latency timer to 64 [58569.912277] e1000e 0000:00:19.0: wake-up capability disabled by ACPI [58569.912286] e1000e 0000:00:19.0: PME# disabled [58569.912443] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [58569.912628] uhci_hcd 0000:00:1a.0: PCI INT A -> GSI 20 (level, low) -> IRQ 20 [58569.912644] uhci_hcd 0000:00:1a.0: setting latency timer to 64 [58569.912692] usb usb3: root hub lost power or was reset [58569.923147] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [58569.923445] uhci_hcd 0000:00:1a.1: power state changed by ACPI to D0 [58569.923456] uhci_hcd 0000:00:1a.1: PCI INT B -> GSI 21 (level, low) -> IRQ 21 [58569.923471] uhci_hcd 0000:00:1a.1: setting latency timer to 64 [58569.923512] usb usb4: root hub lost power or was reset [58569.923821] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 [58569.924102] ehci_hcd 0000:00:1a.7: power state changed by ACPI to D0 [58569.924116] ehci_hcd 0000:00:1a.7: PCI INT C -> GSI 22 (level, low) -> IRQ 22 [58569.924132] ehci_hcd 0000:00:1a.7: setting latency timer to 64 [58569.924203] HDA Intel 0000:00:1b.0: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [58569.924214] HDA Intel 0000:00:1b.0: setting latency timer to 64 [58569.924313] HDA Intel 0000:00:1b.0: irq 49 for MSI/MSI-X [58569.924491] pciehp 0000:00:1c.3:pcie04: pciehp_resume ENTRY [58569.924783] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [58569.925060] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [58569.925070] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [58569.925085] uhci_hcd 0000:00:1d.0: setting latency timer to 64 [58569.925127] usb usb5: root hub lost power or was reset [58569.925161] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [58569.925170] uhci_hcd 0000:00:1d.1: setting latency timer to 64 [58569.925204] usb usb6: root hub lost power or was reset [58569.925479] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0 [58569.925759] uhci_hcd 0000:00:1d.2: power state changed by ACPI to D0 [58569.925768] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [58569.925784] uhci_hcd 0000:00:1d.2: setting latency timer to 64 [58569.925826] usb usb7: root hub lost power or was reset [58569.926108] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [58569.926389] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [58569.926403] ehci_hcd 0000:00:1d.7: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [58569.926419] ehci_hcd 0000:00:1d.7: setting latency timer to 64 [58569.926486] pci 0000:00:1e.0: setting latency timer to 64 [58569.926507] ata_piix 0000:00:1f.1: PCI INT C -> GSI 16 (level, low) -> IRQ 16 [58569.926519] ata_piix 0000:00:1f.1: setting latency timer to 64 [58569.926562] ahci 0000:00:1f.2: setting latency timer to 64 [58569.926657] sdhci-pci 0000:15:00.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [58569.926662] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [58569.926671] ata2: port disabled. ignoring. [58569.929869] sd 2:0:0:0: [sda] Starting disk [58570.082872] PM: resume of drv:usb dev:usb7 complete after 154.577 msecs [58570.082906] PM: resume of drv:hub dev:7-0:1.0 complete after 154.578 msecs [58570.082911] PM: resume of drv:usb dev:usb4 complete after 154.791 msecs [58570.082958] PM: resume of drv:hub dev:4-0:1.0 complete after 154.810 msecs [58570.103726] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [58570.103733] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [58570.105157] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [58570.106969] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [58570.160986] ata1.00: configured for UDMA/33 [58570.174004] PM: resume of drv:i915 dev:0000:00:02.0 complete after 272.851 msecs [58570.190057] PM: resume of drv:usb dev:usb3 complete after 262.004 msecs [58570.190080] PM: resume of drv:hub dev:3-0:1.0 complete after 261.993 msecs [58570.190108] PM: resume of drv:usb dev:usb5 complete after 261.934 msecs [58570.190114] PM: resume of drv:usb dev:usb6 complete after 261.880 msecs [58570.190122] PM: resume of drv:hub dev:5-0:1.0 complete after 261.916 msecs [58570.190134] PM: resume of drv:hub dev:6-0:1.0 complete after 261.869 msecs [58570.202613] PM: resume of drv:usb dev:usb1 complete after 275.862 msecs [58570.202631] PM: resume of drv:usb dev:usb2 complete after 274.677 msecs [58570.202647] PM: resume of drv:hub dev:1-0:1.0 complete after 274.943 msecs [58570.202659] PM: resume of drv:hub dev:2-0:1.0 complete after 274.634 msecs [58570.202663] PM: resume of drv: dev:ep_81 complete after 273.342 msecs [58570.202707] PM: resume of drv:usb dev:6-1 complete after 272.557 msecs [58570.202758] PM: resume of drv:sierra dev:6-1:1.0 complete after 272.586 msecs [58570.242133] PM: resume of drv:e1000e dev:0000:00:19.0 complete after 329.854 msecs [58570.322602] usb 1-3: reset high speed USB device using ehci_hcd and address 4 [58570.619695] snd-usb-audio 1-3:1.2: no reset_resume for driver snd-usb-audio? [58570.619699] snd-usb-audio 1-3:1.3: no reset_resume for driver snd-usb-audio? [58570.619921] PM: resume of drv:usb dev:1-3 complete after 690.236 msecs [58570.619949] PM: resume of drv:usb dev:1-3:1.3 complete after 690.149 msecs [58570.619961] PM: resume of drv:uvcvideo dev:1-3:1.0 complete after 690.242 msecs [58570.619966] PM: resume of drv:usb dev:1-3:1.2 complete after 690.192 msecs [58570.619973] PM: resume of drv:uvcvideo dev:1-3:1.1 complete after 690.228 msecs [58570.619979] PM: resume of drv:sound dev:card1 complete after 414.881 msecs [58570.742594] usb 5-1: reset low speed USB device using uhci_hcd and address 2 [58570.932607] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [58570.940856] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [58570.940862] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [58570.941239] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [58570.941244] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [58570.945253] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [58570.945258] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [58570.945629] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [58570.945635] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [58570.947260] ata3.00: configured for UDMA/100 [58570.963844] ata3.00: configured for UDMA/100 [58570.963849] ata3: EH complete [58570.980324] PM: resume of drv:sd dev:2:0:0:0 complete after 1050.444 msecs [58570.980363] PM: resume of drv:scsi_device dev:2:0:0:0 complete after 1050.426 msecs [58570.980375] PM: resume of drv:scsi_disk dev:2:0:0:0 complete after 360.377 msecs [58571.050072] PM: resume of drv:usb dev:5-1 complete after 1120.032 msecs [58571.050110] PM: resume of drv:usb dev:5-1:1.0 complete after 1120.044 msecs [58571.152594] usb 6-2: reset full speed USB device using uhci_hcd and address 3 [58571.315097] PM: resume of drv:usb dev:6-2 complete after 1385.001 msecs [58571.315125] PM: resume of drv:usb dev:6-2:1.0 complete after 1385.002 msecs [58571.412556] usb 3-2: reset full speed USB device using uhci_hcd and address 3 [58571.510600] Synaptics Touchpad, model: 1, fw: 6.2, id: 0x81a0b1, caps: 0xa04793/0x300000/0x0 [58571.510604] Synaptics: Clickpad mode enabled [58571.510609] serio: Synaptics pass-through port at isa0060/serio1/input0 [58571.550858] input: SynPS/2 Synaptics TouchPad as /devices/platform/i8042/serio1/input/input22 [58571.568058] PM: resume of drv:usb dev:3-2 complete after 1638.094 msecs [58571.568087] PM: resume of drv:usb dev:3-2:1.0 complete after 1638.095 msecs [58571.568115] PM: resume of drv: dev:ep_81 complete after 587.692 msecs [58571.710059] PM: resume of drv:pcmcia_socket dev:pcmcia_socket0 complete after 141.844 msecs [58571.711684] thinkpad_acpi: ACPI backlight control delay disabled [58571.716776] PM: resume of devices complete after 1815.912 msecs [58571.729158] input: X10 Wireless Technology Inc USB Receiver as /devices/pci0000:00/0000:00:1d.0/usb5/5-1/input/input23 [58571.737072] usb 5-1: Weird data, len=1 ff 00 00 00 14 20 ... [58572.116042] PM: resume devices took 2.210 seconds [58572.116104] PM: Finishing wakeup. [58572.116107] Restarting tasks ... [58572.116201] usb 6-1: USB disconnect, address 7 [58572.116413] sierra ttyUSB0: Sierra USB modem converter now disconnected from ttyUSB0 [58572.116489] sierra ttyUSB1: Sierra USB modem converter now disconnected from ttyUSB1 [58572.116562] sierra ttyUSB2: Sierra USB modem converter now disconnected from ttyUSB2 [58572.116594] sierra 6-1:1.0: device disconnected [58572.116836] done. [58572.116841] video LNXVIDEO:00: Restoring backlight state [58572.190643] [drm:output_poll_execute] *ERROR* delayed enqueue failed -125 [58572.900063] usb 6-1: new full speed USB device using uhci_hcd and address 8 [58573.031973] Skipping EDID probe due to cached edid [58573.079138] sierra 6-1:1.0: Sierra USB modem converter detected [58573.080198] usb 6-1: Sierra USB modem converter now attached to ttyUSB0 [58573.080273] usb 6-1: Sierra USB modem converter now attached to ttyUSB1 [58573.080343] usb 6-1: Sierra USB modem converter now attached to ttyUSB2 [58575.770300] ADDRCONF(NETDEV_UP): wlan0: link is not ready [58576.113072] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [58576.170466] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [58576.171914] ADDRCONF(NETDEV_UP): eth0: link is not ready [58576.340075] usb 3-1: new full speed USB device using uhci_hcd and address 8 [58577.633464] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: RX/TX [58577.633471] e1000e 0000:00:19.0: eth0: 10/100 speed: disabling TSO [58577.634329] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [58577.684360] IBM TrackPoint firmware: 0x0e, buttons: 3/3 [58577.913554] type=1400 audit(1278575884.076:42): operation="getattr" pid=12928 parent=1041 profile="/sbin/dhclient3" name="/lib/" pid=12928 comm="dhclient" requested_mask="r" denied_mask="r" fsuid=0 ouid=0 [58577.913620] type=1400 audit(1278575884.076:43): operation="getattr" pid=12928 parent=1041 profile="/sbin/dhclient3" name="/usr/lib/" pid=12928 comm="dhclient" requested_mask="r" denied_mask="r" fsuid=0 ouid=0 [58577.915191] input: TPPS/2 IBM TrackPoint as /devices/platform/i8042/serio1/serio7/input/input24 [58578.822908] wlan0: authenticate with 00:23:4d:90:b3:b4 (try 1) [58578.824795] wlan0: authenticated [58578.824843] wlan0: associate with 00:23:4d:90:b3:b4 (try 1) [58578.827450] wlan0: RX AssocResp from 00:23:4d:90:b3:b4 (capab=0x411 status=0 aid=3) [58578.827459] wlan0: associated [58578.856210] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [58579.529239] type=1400 audit(1278575885.686:44): operation="getattr" pid=12943 parent=1041 profile="/sbin/dhclient3" name="/lib/" pid=12943 comm="dhclient" requested_mask="r" denied_mask="r" fsuid=0 ouid=0 [58579.529280] type=1400 audit(1278575885.686:45): operation="getattr" pid=12943 parent=1041 profile="/sbin/dhclient3" name="/usr/lib/" pid=12943 comm="dhclient" requested_mask="r" denied_mask="r" fsuid=0 ouid=0 [58587.820748] eth0: no IPv6 routers present [58589.400083] wlan0: no IPv6 routers present [60037.050765] type=1400 audit(1278577343.220:46): operation="getattr" pid=21512 parent=21511 profile="/usr/bin/evince-thumbnailer" name="/" pid=21512 comm="evince-thumbnai" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0 [60037.050809] type=1400 audit(1278577343.220:47): operation="getattr" pid=21512 parent=21511 profile="/usr/bin/evince-thumbnailer" name="/" pid=21512 comm="evince-thumbnai" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0 [60045.671741] type=1400 audit(1278577351.840:48): operation="getattr" pid=21519 parent=21518 profile="/usr/bin/evince-thumbnailer" name="/" pid=21519 comm="evince-thumbnai" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0 [60045.671783] type=1400 audit(1278577351.840:49): operation="getattr" pid=21519 parent=21518 profile="/usr/bin/evince-thumbnailer" name="/" pid=21519 comm="evince-thumbnai" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0 [60067.561718] type=1400 audit(1278577373.730:50): operation="getattr" pid=21527 parent=21526 profile="/usr/bin/evince-thumbnailer" name="/" pid=21527 comm="evince-thumbnai" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0 [60067.561758] type=1400 audit(1278577373.730:51): operation="getattr" pid=21527 parent=21526 profile="/usr/bin/evince-thumbnailer" name="/" pid=21527 comm="evince-thumbnai" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0 [60328.362258] iwlagn 0000:03:00.0: ACTIVATE a non DRIVER active station id 0 addr 00:23:4d:90:b3:b4 [60328.382648] wlan0: deauthenticating from 00:23:4d:90:b3:b4 by local choice (reason=3) [60328.511296] cfg80211: All devices are disconnected, going to restore regulatory settings [60328.511304] cfg80211: Restoring regulatory settings while preserving user preference for: JP [60328.511311] cfg80211: Calling CRDA to update world regulatory domain [60328.511332] cfg80211: Calling CRDA for country: JP [60328.619163] cfg80211: Regulatory domain changed to country: JP [60328.619168] (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [60328.619173] (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm) [60328.619178] (2457000 KHz - 2482000 KHz @ 20000 KHz), (N/A, 2000 mBm) [60328.619183] (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm) [60328.619187] (4910000 KHz - 4930000 KHz @ 10000 KHz), (N/A, 2300 mBm) [60328.619192] (4910000 KHz - 4990000 KHz @ 40000 KHz), (N/A, 2300 mBm) [60328.619196] (4930000 KHz - 4950000 KHz @ 10000 KHz), (N/A, 2300 mBm) [60328.619200] (5030000 KHz - 5045000 KHz @ 10000 KHz), (N/A, 2300 mBm) [60328.619205] (5030000 KHz - 5090000 KHz @ 40000 KHz), (N/A, 2300 mBm) [60328.619209] (5050000 KHz - 5060000 KHz @ 10000 KHz), (N/A, 2300 mBm) [60328.619214] (5170000 KHz - 5250000 KHz @ 40000 KHz), (N/A, 2000 mBm) [60328.619218] (5250000 KHz - 5330000 KHz @ 40000 KHz), (N/A, 2000 mBm) [60328.619222] (5490000 KHz - 5710000 KHz @ 40000 KHz), (N/A, 2300 mBm) [60333.292610] usb 6-1: USB disconnect, address 8 [60333.292881] sierra ttyUSB0: Sierra USB modem converter now disconnected from ttyUSB0 [60333.292964] sierra ttyUSB1: Sierra USB modem converter now disconnected from ttyUSB1 [60333.293038] sierra ttyUSB2: Sierra USB modem converter now disconnected from ttyUSB2 [60333.293067] sierra 6-1:1.0: device disconnected