[150775.248808] PM: early resume of devices complete after 0.254 msecs [150775.252068] e1000e 0000:00:19.0: System wakeup disabled by ACPI [150775.252121] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [150775.252467] usb usb3: root hub lost power or was reset [150775.252513] usb usb4: root hub lost power or was reset [150775.252721] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [150775.252905] usb usb5: root hub lost power or was reset [150775.252948] usb usb6: root hub lost power or was reset [150775.252991] usb usb7: root hub lost power or was reset [150775.253319] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [150775.254329] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [150775.266171] ata2: port disabled--ignoring [150776.145708] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [150776.145712] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [150776.146717] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [150776.147714] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [150776.172444] ata1.00: configured for UDMA/33 [150776.172680] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [150776.244069] ata5: SATA link down (SStatus 0 SControl 300) [150776.464082] usb 3-2: reset full-speed USB device number 2 using uhci_hcd [150776.636039] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [150776.644100] firewire_core 0000:15:00.1: rediscovered device fw0 [150776.645874] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [150776.645878] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [150776.646176] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [150776.646179] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [150776.649340] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [150776.649344] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [150776.649651] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [150776.649654] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [150776.651153] ata3.00: configured for UDMA/100 [150776.664127] sd 2:0:0:0: [sda] Starting disk [150776.828954] thinkpad_acpi: ACPI backlight control delay disabled [150776.831156] PM: resume of devices complete after 1582.343 msecs [150776.966844] Restarting kernel threads ... done. [150776.967203] PM: Basic memory bitmaps freed [150776.967207] Restarting tasks ... done. [150776.979517] video LNXVIDEO:00: Restoring backlight state [150777.824957] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [150777.825073] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [153710.504104] Syncing filesystems ... done. [153710.550954] Freezing user space processes ... (elapsed 0.002 seconds) done. [153710.553715] PM: Marking nosave pages: [mem 0x0009d000-0x000fffff] [153710.553725] PM: Basic memory bitmaps created [153710.553849] PM: Preallocating image memory... done (allocated 271261 pages) [153711.365993] PM: Allocated 1085044 kbytes in 0.81 seconds (1339.56 MB/s) [153711.365998] Freezing remaining freezable tasks ... (elapsed 0.003 seconds) done. [153711.370203] Suspending console(s) (use no_console_suspend to debug) [153711.964181] PM: freeze of devices complete after 593.968 msecs [153711.964556] PM: late freeze of devices complete after 0.371 msecs [153711.965955] PM: noirq freeze of devices complete after 1.395 msecs [153711.966649] ACPI: Preparing to enter system sleep state S4 [153711.970983] PM: Saving platform NVS memory [153711.971346] Disabling non-boot CPUs ... [153711.972848] kvm: disabling virtualization on CPU1 [153711.972877] smpboot: CPU 1 is now offline [153711.973577] PM: Creating hibernation image: [153711.976859] PM: Need to copy 221548 pages [153711.976859] PM: Normal pages needed: 221548 + 1024, available pages: 292024 [153711.976859] PM: Hibernation image created (221548 pages copied) [153711.976859] Enabling non-boot CPUs ... [153711.976859] x86: Booting SMP configuration: [153711.976859] smpboot: Booting Node 0 Processor 1 APIC 0x1 [153711.976859] kvm: enabling virtualization on CPU1 [153711.985148] ACPI Exception: AE_BAD_PARAMETER, Returned by Handler for [EmbeddedControl] (20131115/evregion-282) [153711.985159] ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPC_.EC__.LPMD] (Node ffff880079f73618), AE_BAD_PARAMETER (20131115/psparse-536) [153711.985169] ACPI Error: Method parse/execution failed [\_PR_.CPU0._PPC] (Node ffff880079f98b18), AE_BAD_PARAMETER (20131115/psparse-536) [153711.985178] ACPI Error: Method parse/execution failed [\_PR_.CPU1._PPC] (Node ffff880079f98938), AE_BAD_PARAMETER (20131115/psparse-536) [153711.985185] ACPI Exception: AE_BAD_PARAMETER, Evaluating _PPC (20131115/processor_perflib-140) [153711.985236] CPU1 is up [153711.988534] ACPI: Waking up from system sleep state S4 [153712.023215] PM: noirq thaw of devices complete after 0.633 msecs [153712.023520] PM: early thaw of devices complete after 0.252 msecs [153712.028100] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [153712.044282] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [153712.044386] ata2: port disabled--ignoring [153712.112215] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [153712.204545] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [153712.204549] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [153712.204967] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [153712.205417] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [153712.228465] ata1.00: configured for UDMA/33 [153712.364067] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [153712.364092] ata5: SATA link down (SStatus 0 SControl 300) [153712.365178] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [153712.365182] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [153712.365428] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [153712.365431] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [153712.367873] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [153712.367877] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [153712.368102] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [153712.368105] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [153712.369256] ata3.00: configured for UDMA/100 [153712.512056] smapi smapi: set_real_thresh: set stop to 85 for bat=0 [153712.624061] smapi smapi: set_real_thresh: set start to 64 for bat=0 [153712.624735] firewire_core 0000:15:00.1: rediscovered device fw0 [153712.736055] smapi smapi: set_real_thresh: set stop to 0 for bat=1 [153712.848067] smapi smapi: set_real_thresh: set start to 0 for bat=1 [153712.989014] thinkpad_acpi: ACPI backlight control delay disabled [153712.990712] PM: thaw of devices complete after 967.185 msecs [153713.860895] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [153713.861007] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [153721.075277] Suspending console(s) (use no_console_suspend to debug) [153721.214782] sd 2:0:0:0: [sda] Synchronizing SCSI cache [153721.214947] sd 2:0:0:0: [sda] Stopping disk [153721.780095] PM: suspend of devices complete after 704.292 msecs [153721.780450] PM: late suspend of devices complete after 0.350 msecs [153721.828418] ehci-pci 0000:00:1d.7: System wakeup enabled by ACPI [153721.844168] uhci_hcd 0000:00:1d.2: System wakeup enabled by ACPI [153721.844280] uhci_hcd 0000:00:1d.1: System wakeup enabled by ACPI [153721.845173] uhci_hcd 0000:00:1d.0: System wakeup enabled by ACPI [153721.845906] ehci-pci 0000:00:1a.7: System wakeup enabled by ACPI [153721.860175] uhci_hcd 0000:00:1a.1: System wakeup enabled by ACPI [153721.860284] uhci_hcd 0000:00:1a.0: System wakeup enabled by ACPI [153721.860391] e1000e 0000:00:19.0: System wakeup enabled by ACPI [153721.876120] PM: noirq suspend of devices complete after 95.667 msecs [153721.876797] ACPI: Preparing to enter system sleep state S3 [153721.881331] PM: Saving platform NVS memory [153721.881814] Disabling non-boot CPUs ... [153721.883267] kvm: disabling virtualization on CPU1 [153721.984042] smpboot: CPU 1 is now offline [153721.984415] ACPI: Low-level resume complete [153721.984415] PM: Restoring platform NVS memory [153721.984415] Enabling non-boot CPUs ... [153721.984415] x86: Booting SMP configuration: [153721.984415] smpboot: Booting Node 0 Processor 1 APIC 0x1 [153721.984415] kvm: enabling virtualization on CPU1 [153722.036164] CPU1 is up [153722.039476] ACPI: Waking up from system sleep state S3 [153722.144270] uhci_hcd 0000:00:1a.0: System wakeup disabled by ACPI [153722.144373] uhci_hcd 0000:00:1a.1: System wakeup disabled by ACPI [153722.160162] ehci-pci 0000:00:1a.7: System wakeup disabled by ACPI [153722.177933] uhci_hcd 0000:00:1d.0: System wakeup disabled by ACPI [153722.178032] uhci_hcd 0000:00:1d.1: System wakeup disabled by ACPI [153722.178126] uhci_hcd 0000:00:1d.2: System wakeup disabled by ACPI [153722.192139] ehci-pci 0000:00:1d.7: System wakeup disabled by ACPI [153722.288507] PM: noirq resume of devices complete after 175.413 msecs [153722.288833] PM: early resume of devices complete after 0.275 msecs [153722.288972] e1000e 0000:00:19.0: System wakeup disabled by ACPI [153722.289023] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [153722.289443] usb usb3: root hub lost power or was reset [153722.289562] usb usb4: root hub lost power or was reset [153722.289774] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [153722.289946] usb usb5: root hub lost power or was reset [153722.289989] usb usb6: root hub lost power or was reset [153722.290033] usb usb7: root hub lost power or was reset [153722.300318] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [153722.301329] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [153722.301442] ata2: port disabled--ignoring [153723.188543] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [153723.188547] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [153723.189537] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [153723.190539] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [153723.212251] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [153723.212636] ata1.00: configured for UDMA/33 [153723.288059] ata5: SATA link down (SStatus 0 SControl 300) [153723.496121] usb 3-2: reset full-speed USB device number 2 using uhci_hcd [153723.680222] firewire_core 0000:15:00.1: rediscovered device fw0 [153723.684073] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [153723.698779] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [153723.698783] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [153723.699092] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [153723.699095] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [153723.702260] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [153723.702264] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [153723.702551] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [153723.702555] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [153723.704063] ata3.00: configured for UDMA/100 [153723.720140] sd 2:0:0:0: [sda] Starting disk [153723.881083] thinkpad_acpi: ACPI backlight control delay disabled [153723.882826] PM: resume of devices complete after 1593.987 msecs [153724.018511] Restarting kernel threads ... done. [153724.019163] PM: Basic memory bitmaps freed [153724.019203] Restarting tasks ... done. [153724.027185] video LNXVIDEO:00: Restoring backlight state [153724.852946] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [153724.853061] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [173997.692814] init: anacron main process (18621) killed by TERM signal [173999.026516] Syncing filesystems ... done. [173999.067912] Freezing user space processes ... (elapsed 0.002 seconds) done. [173999.070629] PM: Marking nosave pages: [mem 0x0009d000-0x000fffff] [173999.070639] PM: Basic memory bitmaps created [173999.070762] PM: Preallocating image memory... done (allocated 271246 pages) [174001.736175] PM: Allocated 1084984 kbytes in 2.66 seconds (407.88 MB/s) [174001.736179] Freezing remaining freezable tasks ... (elapsed 0.211 seconds) done. [174001.948615] Suspending console(s) (use no_console_suspend to debug) [174002.580390] PM: freeze of devices complete after 631.763 msecs [174002.580855] PM: late freeze of devices complete after 0.461 msecs [174002.582271] PM: noirq freeze of devices complete after 1.412 msecs [174002.582971] ACPI: Preparing to enter system sleep state S4 [174002.587452] PM: Saving platform NVS memory [174002.587826] Disabling non-boot CPUs ... [174002.589351] kvm: disabling virtualization on CPU1 [174002.692029] smpboot: CPU 1 is now offline [174002.692738] PM: Creating hibernation image: [174002.696009] PM: Need to copy 218743 pages [174002.696009] PM: Normal pages needed: 218743 + 1024, available pages: 294822 [174002.696009] PM: Hibernation image created (218743 pages copied) [174002.696009] Enabling non-boot CPUs ... [174002.696009] x86: Booting SMP configuration: [174002.696009] smpboot: Booting Node 0 Processor 1 APIC 0x1 [174002.696009] kvm: enabling virtualization on CPU1 [174002.704337] ACPI Exception: AE_BAD_PARAMETER, Returned by Handler for [EmbeddedControl] (20131115/evregion-282) [174002.704348] ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPC_.EC__.LPMD] (Node ffff880079f73618), AE_BAD_PARAMETER (20131115/psparse-536) [174002.704358] ACPI Error: Method parse/execution failed [\_PR_.CPU0._PPC] (Node ffff880079f98b18), AE_BAD_PARAMETER (20131115/psparse-536) [174002.704367] ACPI Error: Method parse/execution failed [\_PR_.CPU1._PPC] (Node ffff880079f98938), AE_BAD_PARAMETER (20131115/psparse-536) [174002.704374] ACPI Exception: AE_BAD_PARAMETER, Evaluating _PPC (20131115/processor_perflib-140) [174002.704426] CPU1 is up [174002.707693] ACPI: Waking up from system sleep state S4 [174002.739394] PM: noirq thaw of devices complete after 0.634 msecs [174002.739699] PM: early thaw of devices complete after 0.252 msecs [174002.739879] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [174002.757904] ata2: port disabled--ignoring [174002.772290] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [174002.832212] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [174002.930483] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [174002.930487] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [174002.930916] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [174002.931805] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [174002.952446] ata1.00: configured for UDMA/33 [174003.084079] ata5: SATA link down (SStatus 0 SControl 300) [174003.084107] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [174003.085240] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [174003.085245] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [174003.085489] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [174003.085493] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [174003.087959] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [174003.087962] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [174003.088185] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [174003.088189] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [174003.089307] ata3.00: configured for UDMA/100 [174003.224071] smapi smapi: set_real_thresh: set stop to 85 for bat=0 [174003.336075] smapi smapi: set_real_thresh: set start to 64 for bat=0 [174003.336814] firewire_core 0000:15:00.1: rediscovered device fw0 [174003.448028] smapi smapi: set_real_thresh: set stop to 0 for bat=1 [174003.560070] smapi smapi: set_real_thresh: set start to 0 for bat=1 [174003.701039] thinkpad_acpi: ACPI backlight control delay disabled [174003.702748] PM: thaw of devices complete after 963.043 msecs [174004.624896] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [174004.625009] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [174011.953247] Suspending console(s) (use no_console_suspend to debug) [174012.104366] sd 2:0:0:0: [sda] Synchronizing SCSI cache [174012.104425] sd 2:0:0:0: [sda] Stopping disk [174012.668108] PM: suspend of devices complete after 714.326 msecs [174012.668460] PM: late suspend of devices complete after 0.348 msecs [174012.716404] ehci-pci 0000:00:1d.7: System wakeup enabled by ACPI [174012.732172] uhci_hcd 0000:00:1d.2: System wakeup enabled by ACPI [174012.732281] uhci_hcd 0000:00:1d.1: System wakeup enabled by ACPI [174012.733230] uhci_hcd 0000:00:1d.0: System wakeup enabled by ACPI [174012.733961] ehci-pci 0000:00:1a.7: System wakeup enabled by ACPI [174012.748175] uhci_hcd 0000:00:1a.1: System wakeup enabled by ACPI [174012.748284] uhci_hcd 0000:00:1a.0: System wakeup enabled by ACPI [174012.748394] e1000e 0000:00:19.0: System wakeup enabled by ACPI [174012.764121] PM: noirq suspend of devices complete after 95.658 msecs [174012.764801] ACPI: Preparing to enter system sleep state S3 [174012.769563] PM: Saving platform NVS memory [174012.770038] Disabling non-boot CPUs ... [174012.771637] kvm: disabling virtualization on CPU1 [174012.872061] smpboot: CPU 1 is now offline [174012.872377] ACPI: Low-level resume complete [174012.872377] PM: Restoring platform NVS memory [174012.872377] Enabling non-boot CPUs ... [174012.872377] x86: Booting SMP configuration: [174012.872377] smpboot: Booting Node 0 Processor 1 APIC 0x1 [174012.872377] kvm: enabling virtualization on CPU1 [174012.920117] CPU1 is up [174012.923424] ACPI: Waking up from system sleep state S3 [174013.024248] uhci_hcd 0000:00:1a.0: System wakeup disabled by ACPI [174013.024351] uhci_hcd 0000:00:1a.1: System wakeup disabled by ACPI [174013.040143] ehci-pci 0000:00:1a.7: System wakeup disabled by ACPI [174013.057973] uhci_hcd 0000:00:1d.0: System wakeup disabled by ACPI [174013.058075] uhci_hcd 0000:00:1d.1: System wakeup disabled by ACPI [174013.058175] uhci_hcd 0000:00:1d.2: System wakeup disabled by ACPI [174013.072137] ehci-pci 0000:00:1d.7: System wakeup disabled by ACPI [174013.168490] PM: noirq resume of devices complete after 174.562 msecs [174013.168811] PM: early resume of devices complete after 0.270 msecs [174013.172061] e1000e 0000:00:19.0: System wakeup disabled by ACPI [174013.172114] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [174013.172475] usb usb3: root hub lost power or was reset [174013.172521] usb usb4: root hub lost power or was reset [174013.172736] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [174013.172914] usb usb5: root hub lost power or was reset [174013.172957] usb usb6: root hub lost power or was reset [174013.173001] usb usb7: root hub lost power or was reset [174013.183379] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [174013.184393] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [174013.184785] ata2: port disabled--ignoring [174014.069217] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [174014.069221] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [174014.070176] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [174014.071161] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [174014.092237] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [174014.092635] ata1.00: configured for UDMA/33 [174014.168053] ata5: SATA link down (SStatus 0 SControl 300) [174014.376121] usb 3-2: reset full-speed USB device number 2 using uhci_hcd [174014.556132] firewire_core 0000:15:00.1: rediscovered device fw0 [174014.560078] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [174014.572343] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [174014.572347] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [174014.572654] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [174014.572657] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [174014.575834] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [174014.575838] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [174014.576149] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [174014.576152] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [174014.577639] ata3.00: configured for UDMA/100 [174014.592148] sd 2:0:0:0: [sda] Starting disk [174014.757003] thinkpad_acpi: ACPI backlight control delay disabled [174014.758757] PM: resume of devices complete after 1589.940 msecs [174014.902764] Restarting kernel threads ... done. [174014.903175] PM: Basic memory bitmaps freed [174014.903179] Restarting tasks ... done. [174014.912477] video LNXVIDEO:00: Restoring backlight state [174015.748942] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [174015.749056] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [174033.054850] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [174034.090286] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [174034.192164] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [174034.192370] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [174034.204215] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [174035.532970] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [174035.533085] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [174035.533132] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [174041.078193] wlan0: authenticate with 00:09:5b:d4:ec:24 [174041.078447] wlan0: send auth to 00:09:5b:d4:ec:24 (try 1/3) [174041.080887] wlan0: authenticated [174041.081089] ath5k 0000:03:00.0 wlan0: disabling HT/VHT due to WEP/TKIP use [174041.081095] ath5k 0000:03:00.0 wlan0: disabling HT as WMM/QoS is not supported by the AP [174041.081100] ath5k 0000:03:00.0 wlan0: disabling VHT as WMM/QoS is not supported by the AP [174041.084054] wlan0: associate with 00:09:5b:d4:ec:24 (try 1/3) [174041.086239] wlan0: RX AssocResp from 00:09:5b:d4:ec:24 (capab=0x431 status=0 aid=1) [174041.086587] wlan0: associated [174041.086628] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [174673.125572] type=1400 audit(1398352491.251:107): apparmor="STATUS" operation="profile_replace" profile="unconfined" name="/usr/lib/cups/backend/cups-pdf" pid=19468 comm="apparmor_parser" [174673.125589] type=1400 audit(1398352491.251:108): apparmor="STATUS" operation="profile_replace" profile="unconfined" name="/usr/sbin/cupsd" pid=19468 comm="apparmor_parser" [174673.126465] type=1400 audit(1398352491.251:109): apparmor="STATUS" operation="profile_replace" profile="unconfined" name="/usr/sbin/cupsd" pid=19468 comm="apparmor_parser" [180833.005335] ath5k: ath5k_hw_get_isr: ISR: 0x00000080 IMR: 0x00000000 [192353.007485] ath5k: ath5k_hw_get_isr: ISR: 0x00000080 IMR: 0x00000000 [199073.009517] ath5k: ath5k_hw_get_isr: ISR: 0x00000080 IMR: 0x00000000 [214433.009260] ath5k: ath5k_hw_get_isr: ISR: 0x00000080 IMR: 0x00000000 [227166.224109] ath5k: ath5k_hw_get_isr: ISR: 0x00000001 IMR: 0x00000000 [228062.033424] wlan0: deauthenticating from 00:09:5b:d4:ec:24 by local choice (reason=3) [228062.034392] cfg80211: Calling CRDA to update world regulatory domain [228063.130916] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [228063.130967] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [228063.151727] cfg80211: World regulatory domain updated: [228063.151733] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [228063.151738] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [228063.151743] cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [228063.151747] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [228063.151751] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [228063.151756] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [228065.892586] init: anacron main process (29141) killed by TERM signal [228067.787589] Syncing filesystems ... done. [228067.919405] Freezing user space processes ... (elapsed 0.112 seconds) done. [228068.032271] PM: Marking nosave pages: [mem 0x0009d000-0x000fffff] [228068.032281] PM: Basic memory bitmaps created [228068.032412] PM: Preallocating image memory... done (allocated 271261 pages) [228068.886770] PM: Allocated 1085044 kbytes in 0.85 seconds (1276.52 MB/s) [228068.886775] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done. [228068.888798] Suspending console(s) (use no_console_suspend to debug) [228069.472183] PM: freeze of devices complete after 583.375 msecs [228069.472594] PM: late freeze of devices complete after 0.407 msecs [228069.474001] PM: noirq freeze of devices complete after 1.403 msecs [228069.474710] ACPI: Preparing to enter system sleep state S4 [228069.479168] PM: Saving platform NVS memory [228069.479534] Disabling non-boot CPUs ... [228069.481041] kvm: disabling virtualization on CPU1 [228069.481063] smpboot: CPU 1 is now offline [228069.481759] PM: Creating hibernation image: [228069.485052] PM: Need to copy 221417 pages [228069.485052] PM: Normal pages needed: 221417 + 1024, available pages: 292156 [228069.485052] PM: Hibernation image created (221417 pages copied) [228069.485052] Enabling non-boot CPUs ... [228069.485052] x86: Booting SMP configuration: [228069.485052] smpboot: Booting Node 0 Processor 1 APIC 0x1 [228069.485052] kvm: enabling virtualization on CPU1 [228069.493333] ACPI Exception: AE_BAD_PARAMETER, Returned by Handler for [EmbeddedControl] (20131115/evregion-282) [228069.493344] ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPC_.EC__.LPMD] (Node ffff880079f73618), AE_BAD_PARAMETER (20131115/psparse-536) [228069.493354] ACPI Error: Method parse/execution failed [\_PR_.CPU0._PPC] (Node ffff880079f98b18), AE_BAD_PARAMETER (20131115/psparse-536) [228069.493363] ACPI Error: Method parse/execution failed [\_PR_.CPU1._PPC] (Node ffff880079f98938), AE_BAD_PARAMETER (20131115/psparse-536) [228069.493370] ACPI Exception: AE_BAD_PARAMETER, Evaluating _PPC (20131115/processor_perflib-140) [228069.493420] CPU1 is up [228069.496723] ACPI: Waking up from system sleep state S4 [228069.532825] PM: noirq thaw of devices complete after 0.633 msecs [228069.533130] PM: early thaw of devices complete after 0.252 msecs [228069.536101] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [228069.552704] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [228069.553792] ata2: port disabled--ignoring [228069.620191] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [228069.726496] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [228069.726500] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [228069.726950] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [228069.727393] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [228069.748434] ata1.00: configured for UDMA/33 [228069.872065] ata5: SATA link down (SStatus 0 SControl 300) [228069.872092] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [228069.873187] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [228069.873192] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [228069.873416] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [228069.873420] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [228069.875863] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [228069.875867] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [228069.876102] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [228069.876106] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [228069.877252] ata3.00: configured for UDMA/100 [228070.020052] smapi smapi: set_real_thresh: set stop to 85 for bat=0 [228070.132065] smapi smapi: set_real_thresh: set start to 64 for bat=0 [228070.132729] firewire_core 0000:15:00.1: rediscovered device fw0 [228070.244055] smapi smapi: set_real_thresh: set stop to 0 for bat=1 [228070.356053] smapi smapi: set_real_thresh: set start to 0 for bat=1 [228070.497001] thinkpad_acpi: ACPI backlight control delay disabled [228070.498711] PM: thaw of devices complete after 965.575 msecs [228071.508897] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [228071.509009] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [228079.163998] Suspending console(s) (use no_console_suspend to debug) [228079.315253] sd 2:0:0:0: [sda] Synchronizing SCSI cache [228079.315378] sd 2:0:0:0: [sda] Stopping disk [228079.888113] PM: suspend of devices complete after 723.546 msecs [228079.888467] PM: late suspend of devices complete after 0.349 msecs [228079.936412] ehci-pci 0000:00:1d.7: System wakeup enabled by ACPI [228079.952171] uhci_hcd 0000:00:1d.2: System wakeup enabled by ACPI [228079.952281] uhci_hcd 0000:00:1d.1: System wakeup enabled by ACPI [228079.953213] uhci_hcd 0000:00:1d.0: System wakeup enabled by ACPI [228079.953946] ehci-pci 0000:00:1a.7: System wakeup enabled by ACPI [228079.968176] uhci_hcd 0000:00:1a.1: System wakeup enabled by ACPI [228079.968287] uhci_hcd 0000:00:1a.0: System wakeup enabled by ACPI [228079.968397] e1000e 0000:00:19.0: System wakeup enabled by ACPI [228079.984123] PM: noirq suspend of devices complete after 95.654 msecs [228079.984805] ACPI: Preparing to enter system sleep state S3 [228079.989560] PM: Saving platform NVS memory [228079.990057] Disabling non-boot CPUs ... [228079.991664] kvm: disabling virtualization on CPU1 [228080.092032] smpboot: CPU 1 is now offline [228080.092382] ACPI: Low-level resume complete [228080.092382] PM: Restoring platform NVS memory [228080.092382] Enabling non-boot CPUs ... [228080.092382] x86: Booting SMP configuration: [228080.092382] smpboot: Booting Node 0 Processor 1 APIC 0x1 [228080.092382] kvm: enabling virtualization on CPU1 [228080.140117] CPU1 is up [228080.143433] ACPI: Waking up from system sleep state S3 [228080.244264] uhci_hcd 0000:00:1a.0: System wakeup disabled by ACPI [228080.244365] uhci_hcd 0000:00:1a.1: System wakeup disabled by ACPI [228080.260155] ehci-pci 0000:00:1a.7: System wakeup disabled by ACPI [228080.277974] uhci_hcd 0000:00:1d.0: System wakeup disabled by ACPI [228080.278066] uhci_hcd 0000:00:1d.1: System wakeup disabled by ACPI [228080.278164] uhci_hcd 0000:00:1d.2: System wakeup disabled by ACPI [228080.292140] ehci-pci 0000:00:1d.7: System wakeup disabled by ACPI [228080.388508] PM: noirq resume of devices complete after 174.622 msecs [228080.388828] PM: early resume of devices complete after 0.269 msecs [228080.389070] e1000e 0000:00:19.0: System wakeup disabled by ACPI [228080.389161] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [228080.399825] usb usb3: root hub lost power or was reset [228080.399912] usb usb4: root hub lost power or was reset [228080.400140] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [228080.400317] usb usb5: root hub lost power or was reset [228080.400360] usb usb6: root hub lost power or was reset [228080.400403] usb usb7: root hub lost power or was reset [228080.400838] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [228080.401849] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [228080.401972] ata2: port disabled--ignoring [228081.280552] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [228081.280556] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [228081.281548] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [228081.282537] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [228081.304479] ata1.00: configured for UDMA/33 [228081.308198] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [228081.380089] ata5: SATA link down (SStatus 0 SControl 300) [228081.596124] usb 3-2: reset full-speed USB device number 2 using uhci_hcd [228081.772081] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [228081.776103] firewire_core 0000:15:00.1: rediscovered device fw0 [228081.778597] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [228081.778601] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [228081.778876] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [228081.778880] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [228081.782116] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [228081.782120] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [228081.782428] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [228081.782431] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [228081.783902] ata3.00: configured for UDMA/100 [228081.800130] sd 2:0:0:0: [sda] Starting disk [228081.960995] thinkpad_acpi: ACPI backlight control delay disabled [228081.962770] PM: resume of devices complete after 1573.935 msecs [228082.098312] Restarting kernel threads ... done. [228082.098977] PM: Basic memory bitmaps freed [228082.098981] Restarting tasks ... done. [228082.111206] video LNXVIDEO:00: Restoring backlight state [228082.980915] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [228082.981038] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [229166.965588] type=1400 audit(1398438643.869:110): apparmor="STATUS" operation="profile_replace" profile="unconfined" name="/usr/lib/cups/backend/cups-pdf" pid=30162 comm="apparmor_parser" [229166.965605] type=1400 audit(1398438643.869:111): apparmor="STATUS" operation="profile_replace" profile="unconfined" name="/usr/sbin/cupsd" pid=30162 comm="apparmor_parser" [229166.966485] type=1400 audit(1398438643.869:112): apparmor="STATUS" operation="profile_replace" profile="unconfined" name="/usr/sbin/cupsd" pid=30162 comm="apparmor_parser" [240301.311693] rhythmbox[31854]: segfault at 0 ip 00007fbd3d9f548f sp 00007fff2c916f90 error 4 in libgtk-3.so.0.1000.8[7fbd3d836000+4ff000] [241289.489800] Syncing filesystems ... done. [241289.537568] Freezing user space processes ... (elapsed 0.002 seconds) done. [241289.540142] PM: Marking nosave pages: [mem 0x0009d000-0x000fffff] [241289.540152] PM: Basic memory bitmaps created [241289.540269] PM: Preallocating image memory... done (allocated 271256 pages) [241290.828843] PM: Allocated 1085024 kbytes in 1.28 seconds (847.67 MB/s) [241290.828847] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done. [241290.830910] Suspending console(s) (use no_console_suspend to debug) [241291.412181] PM: freeze of devices complete after 581.261 msecs [241291.412581] PM: late freeze of devices complete after 0.394 msecs [241291.413990] PM: noirq freeze of devices complete after 1.405 msecs [241291.414699] ACPI: Preparing to enter system sleep state S4 [241291.419086] PM: Saving platform NVS memory [241291.419453] Disabling non-boot CPUs ... [241291.420968] kvm: disabling virtualization on CPU1 [241291.420997] smpboot: CPU 1 is now offline [241291.421706] PM: Creating hibernation image: [241291.424979] PM: Need to copy 221767 pages [241291.424979] PM: Normal pages needed: 221767 + 1024, available pages: 291805 [241291.424979] PM: Hibernation image created (221767 pages copied) [241291.424979] Enabling non-boot CPUs ... [241291.424979] x86: Booting SMP configuration: [241291.424979] smpboot: Booting Node 0 Processor 1 APIC 0x1 [241291.424979] kvm: enabling virtualization on CPU1 [241291.433269] ACPI Exception: AE_BAD_PARAMETER, Returned by Handler for [EmbeddedControl] (20131115/evregion-282) [241291.433280] ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPC_.EC__.LPMD] (Node ffff880079f73618), AE_BAD_PARAMETER (20131115/psparse-536) [241291.433290] ACPI Error: Method parse/execution failed [\_PR_.CPU0._PPC] (Node ffff880079f98b18), AE_BAD_PARAMETER (20131115/psparse-536) [241291.433299] ACPI Error: Method parse/execution failed [\_PR_.CPU1._PPC] (Node ffff880079f98938), AE_BAD_PARAMETER (20131115/psparse-536) [241291.433306] ACPI Exception: AE_BAD_PARAMETER, Evaluating _PPC (20131115/processor_perflib-140) [241291.433356] CPU1 is up [241291.436654] ACPI: Waking up from system sleep state S4 [241291.471409] PM: noirq thaw of devices complete after 0.635 msecs [241291.471715] PM: early thaw of devices complete after 0.253 msecs [241291.476100] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [241291.493539] ata2: port disabled--ignoring [241291.509053] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [241291.560199] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [241291.656524] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [241291.656527] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [241291.656942] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [241291.657428] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [241291.680465] ata1.00: configured for UDMA/33 [241291.812071] ata5: SATA link down (SStatus 0 SControl 300) [241291.812102] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [241291.813196] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [241291.813200] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [241291.813441] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [241291.813444] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [241291.815906] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [241291.815910] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [241291.816118] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [241291.816122] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [241291.817284] ata3.00: configured for UDMA/100 [241291.960047] smapi smapi: set_real_thresh: set stop to 85 for bat=0 [241292.072065] smapi smapi: set_real_thresh: set start to 64 for bat=0 [241292.072771] firewire_core 0000:15:00.1: rediscovered device fw0 [241292.184053] smapi smapi: set_real_thresh: set stop to 0 for bat=1 [241292.296055] smapi smapi: set_real_thresh: set start to 0 for bat=1 [241292.437024] thinkpad_acpi: ACPI backlight control delay disabled [241292.438732] PM: thaw of devices complete after 967.011 msecs [241293.292897] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [241293.293009] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [241301.598208] Suspending console(s) (use no_console_suspend to debug) [241301.754573] sd 2:0:0:0: [sda] Synchronizing SCSI cache [241301.754740] sd 2:0:0:0: [sda] Stopping disk [241302.300136] PM: suspend of devices complete after 701.388 msecs [241302.300487] PM: late suspend of devices complete after 0.346 msecs [241302.348413] ehci-pci 0000:00:1d.7: System wakeup enabled by ACPI [241302.364168] uhci_hcd 0000:00:1d.2: System wakeup enabled by ACPI [241302.364280] uhci_hcd 0000:00:1d.1: System wakeup enabled by ACPI [241302.365167] uhci_hcd 0000:00:1d.0: System wakeup enabled by ACPI [241302.365896] ehci-pci 0000:00:1a.7: System wakeup enabled by ACPI [241302.380171] uhci_hcd 0000:00:1a.1: System wakeup enabled by ACPI [241302.380278] uhci_hcd 0000:00:1a.0: System wakeup enabled by ACPI [241302.380388] e1000e 0000:00:19.0: System wakeup enabled by ACPI [241302.396120] PM: noirq suspend of devices complete after 95.630 msecs [241302.396806] ACPI: Preparing to enter system sleep state S3 [241302.401472] PM: Saving platform NVS memory [241302.401985] Disabling non-boot CPUs ... [241302.403588] kvm: disabling virtualization on CPU1 [241302.504039] smpboot: CPU 1 is now offline [241302.504384] ACPI: Low-level resume complete [241302.504384] PM: Restoring platform NVS memory [241302.504384] Enabling non-boot CPUs ... [241302.504384] x86: Booting SMP configuration: [241302.504384] smpboot: Booting Node 0 Processor 1 APIC 0x1 [241302.504384] kvm: enabling virtualization on CPU1 [241302.552137] CPU1 is up [241302.555456] ACPI: Waking up from system sleep state S3 [241302.660233] uhci_hcd 0000:00:1a.0: System wakeup disabled by ACPI [241302.660330] uhci_hcd 0000:00:1a.1: System wakeup disabled by ACPI [241302.676159] ehci-pci 0000:00:1a.7: System wakeup disabled by ACPI [241302.693990] uhci_hcd 0000:00:1d.0: System wakeup disabled by ACPI [241302.694092] uhci_hcd 0000:00:1d.1: System wakeup disabled by ACPI [241302.694190] uhci_hcd 0000:00:1d.2: System wakeup disabled by ACPI [241302.708140] ehci-pci 0000:00:1d.7: System wakeup disabled by ACPI [241302.804502] PM: noirq resume of devices complete after 176.567 msecs [241302.804807] PM: early resume of devices complete after 0.254 msecs [241302.808060] e1000e 0000:00:19.0: System wakeup disabled by ACPI [241302.808114] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [241302.808464] usb usb3: root hub lost power or was reset [241302.808510] usb usb4: root hub lost power or was reset [241302.808725] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [241302.808902] usb usb5: root hub lost power or was reset [241302.808945] usb usb6: root hub lost power or was reset [241302.808988] usb usb7: root hub lost power or was reset [241302.819374] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [241302.820387] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [241302.820772] ata2: port disabled--ignoring [241303.700563] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [241303.700567] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [241303.701541] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [241303.702525] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [241303.728478] ata1.00: configured for UDMA/33 [241303.736213] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [241303.803729] ata5: SATA link down (SStatus 0 SControl 300) [241304.012124] usb 3-2: reset full-speed USB device number 2 using uhci_hcd [241304.192220] firewire_core 0000:15:00.1: rediscovered device fw0 [241304.196089] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [241304.203383] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [241304.203387] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [241304.203686] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [241304.203690] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [241304.206912] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [241304.206916] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [241304.207231] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [241304.207235] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [241304.208746] ata3.00: configured for UDMA/100 [241304.224145] sd 2:0:0:0: [sda] Starting disk [241304.385019] thinkpad_acpi: ACPI backlight control delay disabled [241304.386944] PM: resume of devices complete after 1582.131 msecs [241304.522471] Restarting kernel threads ... done. [241304.522753] PM: Basic memory bitmaps freed [241304.522758] Restarting tasks ... done. [241304.534654] video LNXVIDEO:00: Restoring backlight state [241305.368960] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [241305.369075] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [262352.925265] init: anacron main process (4471) killed by TERM signal [262358.566172] Syncing filesystems ... done. [262358.601328] Freezing user space processes ... (elapsed 0.002 seconds) done. [262358.603918] PM: Marking nosave pages: [mem 0x0009d000-0x000fffff] [262358.603928] PM: Basic memory bitmaps created [262358.604096] PM: Preallocating image memory... done (allocated 271258 pages) [262359.603471] PM: Allocated 1085032 kbytes in 0.99 seconds (1095.99 MB/s) [262359.603475] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done. [262359.605564] Suspending console(s) (use no_console_suspend to debug) [262360.180183] PM: freeze of devices complete after 574.608 msecs [262360.180623] PM: late freeze of devices complete after 0.435 msecs [262360.182034] PM: noirq freeze of devices complete after 1.407 msecs [262360.182721] ACPI: Preparing to enter system sleep state S4 [262360.187036] PM: Saving platform NVS memory [262360.187409] Disabling non-boot CPUs ... [262360.188918] kvm: disabling virtualization on CPU1 [262360.188947] smpboot: CPU 1 is now offline [262360.189678] PM: Creating hibernation image: [262360.192929] PM: Need to copy 202857 pages [262360.192929] PM: Normal pages needed: 202857 + 1024, available pages: 310720 [262360.192929] PM: Hibernation image created (202857 pages copied) [262360.192929] Enabling non-boot CPUs ... [262360.192929] x86: Booting SMP configuration: [262360.192929] smpboot: Booting Node 0 Processor 1 APIC 0x1 [262360.192929] kvm: enabling virtualization on CPU1 [262360.201239] ACPI Exception: AE_BAD_PARAMETER, Returned by Handler for [EmbeddedControl] (20131115/evregion-282) [262360.201250] ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPC_.EC__.LPMD] (Node ffff880079f73618), AE_BAD_PARAMETER (20131115/psparse-536) [262360.201260] ACPI Error: Method parse/execution failed [\_PR_.CPU0._PPC] (Node ffff880079f98b18), AE_BAD_PARAMETER (20131115/psparse-536) [262360.201269] ACPI Error: Method parse/execution failed [\_PR_.CPU1._PPC] (Node ffff880079f98938), AE_BAD_PARAMETER (20131115/psparse-536) [262360.201276] ACPI Exception: AE_BAD_PARAMETER, Evaluating _PPC (20131115/processor_perflib-140) [262360.201328] CPU1 is up [262360.204629] ACPI: Waking up from system sleep state S4 [262360.239499] PM: noirq thaw of devices complete after 0.635 msecs [262360.239803] PM: early thaw of devices complete after 0.252 msecs [262360.244101] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [262360.260255] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [262360.260438] ata2: port disabled--ignoring [262360.328201] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [262360.420583] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [262360.420587] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [262360.421011] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [262360.421443] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [262360.444477] ata1.00: configured for UDMA/33 [262360.580058] ata5: SATA link down (SStatus 0 SControl 300) [262360.580088] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [262360.581191] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [262360.581195] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [262360.581434] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [262360.581438] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [262360.583902] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [262360.583906] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [262360.584127] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [262360.584130] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [262360.585273] ata3.00: configured for UDMA/100 [262360.728055] smapi smapi: set_real_thresh: set stop to 85 for bat=0 [262360.824094] firewire_core 0000:15:00.1: rediscovered device fw0 [262360.840055] smapi smapi: set_real_thresh: set start to 64 for bat=0 [262360.952056] smapi smapi: set_real_thresh: set stop to 0 for bat=1 [262361.064055] smapi smapi: set_real_thresh: set start to 0 for bat=1 [262361.205032] thinkpad_acpi: ACPI backlight control delay disabled [262361.206771] PM: thaw of devices complete after 966.962 msecs [262362.060896] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [262362.061008] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [262368.655404] Suspending console(s) (use no_console_suspend to debug) [262368.811699] sd 2:0:0:0: [sda] Synchronizing SCSI cache [262368.811856] sd 2:0:0:0: [sda] Stopping disk [262369.376120] PM: suspend of devices complete after 720.179 msecs [262369.376474] PM: late suspend of devices complete after 0.348 msecs [262369.424415] ehci-pci 0000:00:1d.7: System wakeup enabled by ACPI [262369.440172] uhci_hcd 0000:00:1d.2: System wakeup enabled by ACPI [262369.440284] uhci_hcd 0000:00:1d.1: System wakeup enabled by ACPI [262369.441185] uhci_hcd 0000:00:1d.0: System wakeup enabled by ACPI [262369.441914] ehci-pci 0000:00:1a.7: System wakeup enabled by ACPI [262369.456173] uhci_hcd 0000:00:1a.1: System wakeup enabled by ACPI [262369.456284] uhci_hcd 0000:00:1a.0: System wakeup enabled by ACPI [262369.456395] e1000e 0000:00:19.0: System wakeup enabled by ACPI [262369.472120] PM: noirq suspend of devices complete after 95.643 msecs [262369.472802] ACPI: Preparing to enter system sleep state S3 [262369.477497] PM: Saving platform NVS memory [262369.478023] Disabling non-boot CPUs ... [262369.479638] kvm: disabling virtualization on CPU1 [262369.580032] smpboot: CPU 1 is now offline [262369.580359] ACPI: Low-level resume complete [262369.580359] PM: Restoring platform NVS memory [262369.580359] Enabling non-boot CPUs ... [262369.580359] x86: Booting SMP configuration: [262369.580359] smpboot: Booting Node 0 Processor 1 APIC 0x1 [262369.580359] kvm: enabling virtualization on CPU1 [262369.628118] CPU1 is up [262369.631428] ACPI: Waking up from system sleep state S3 [262369.732266] uhci_hcd 0000:00:1a.0: System wakeup disabled by ACPI [262369.732368] uhci_hcd 0000:00:1a.1: System wakeup disabled by ACPI [262369.748156] ehci-pci 0000:00:1a.7: System wakeup disabled by ACPI [262369.765926] uhci_hcd 0000:00:1d.0: System wakeup disabled by ACPI [262369.766023] uhci_hcd 0000:00:1d.1: System wakeup disabled by ACPI [262369.766117] uhci_hcd 0000:00:1d.2: System wakeup disabled by ACPI [262369.780130] ehci-pci 0000:00:1d.7: System wakeup disabled by ACPI [262369.876504] PM: noirq resume of devices complete after 174.105 msecs [262369.876809] PM: early resume of devices complete after 0.254 msecs [262369.880070] e1000e 0000:00:19.0: System wakeup disabled by ACPI [262369.880125] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [262369.880477] usb usb3: root hub lost power or was reset [262369.880524] usb usb4: root hub lost power or was reset [262369.880740] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [262369.880917] usb usb5: root hub lost power or was reset [262369.880961] usb usb6: root hub lost power or was reset [262369.881004] usb usb7: root hub lost power or was reset [262369.881328] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [262369.882338] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [262369.894162] ata2: port disabled--ignoring [262370.776556] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [262370.776560] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [262370.777536] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [262370.778536] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [262370.800206] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [262370.804474] ata1.00: configured for UDMA/33 [262370.880075] ata5: SATA link down (SStatus 0 SControl 300) [262371.096128] usb 3-2: reset full-speed USB device number 2 using uhci_hcd [262371.268039] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [262371.276098] firewire_core 0000:15:00.1: rediscovered device fw0 [262371.276169] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [262371.276174] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [262371.276486] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [262371.276490] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [262371.279710] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [262371.279714] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [262371.280044] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [262371.280048] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [262371.281573] ata3.00: configured for UDMA/100 [262371.296151] sd 2:0:0:0: [sda] Starting disk [262371.461010] thinkpad_acpi: ACPI backlight control delay disabled [262371.462892] PM: resume of devices complete after 1586.077 msecs [262371.597260] Restarting kernel threads ... done. [262371.597540] PM: Basic memory bitmaps freed [262371.597544] Restarting tasks ... done. [262371.609809] video LNXVIDEO:00: Restoring backlight state [262372.492948] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [262372.493064] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [264397.875912] type=1400 audit(1398531828.290:113): apparmor="STATUS" operation="profile_replace" profile="unconfined" name="/usr/lib/cups/backend/cups-pdf" pid=5634 comm="apparmor_parser" [264397.875929] type=1400 audit(1398531828.290:114): apparmor="STATUS" operation="profile_replace" profile="unconfined" name="/usr/sbin/cupsd" pid=5634 comm="apparmor_parser" [264397.876860] type=1400 audit(1398531828.294:115): apparmor="STATUS" operation="profile_replace" profile="unconfined" name="/usr/sbin/cupsd" pid=5634 comm="apparmor_parser" [265458.579329] Syncing filesystems ... done. [265458.651737] Freezing user space processes ... (elapsed 0.002 seconds) done. [265458.654370] PM: Marking nosave pages: [mem 0x0009d000-0x000fffff] [265458.654379] PM: Basic memory bitmaps created [265458.654502] PM: Preallocating image memory... done (allocated 271259 pages) [265459.800870] PM: Allocated 1085036 kbytes in 1.14 seconds (951.78 MB/s) [265459.800875] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done. [265459.803019] Suspending console(s) (use no_console_suspend to debug) [265460.636350] PM: freeze of devices complete after 833.320 msecs [265460.636825] PM: late freeze of devices complete after 0.470 msecs [265460.638246] PM: noirq freeze of devices complete after 1.417 msecs [265460.638939] ACPI: Preparing to enter system sleep state S4 [265460.643359] PM: Saving platform NVS memory [265460.643723] Disabling non-boot CPUs ... [265460.645234] kvm: disabling virtualization on CPU1 [265460.748049] smpboot: CPU 1 is now offline [265460.748760] PM: Creating hibernation image: [265460.752015] PM: Need to copy 214614 pages [265460.752015] PM: Normal pages needed: 214614 + 1024, available pages: 298957 [265460.752015] PM: Hibernation image created (214614 pages copied) [265460.752015] Enabling non-boot CPUs ... [265460.752015] x86: Booting SMP configuration: [265460.752015] smpboot: Booting Node 0 Processor 1 APIC 0x1 [265460.752015] kvm: enabling virtualization on CPU1 [265460.760357] ACPI Exception: AE_BAD_PARAMETER, Returned by Handler for [EmbeddedControl] (20131115/evregion-282) [265460.760368] ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPC_.EC__.LPMD] (Node ffff880079f73618), AE_BAD_PARAMETER (20131115/psparse-536) [265460.760378] ACPI Error: Method parse/execution failed [\_PR_.CPU0._PPC] (Node ffff880079f98b18), AE_BAD_PARAMETER (20131115/psparse-536) [265460.760387] ACPI Error: Method parse/execution failed [\_PR_.CPU1._PPC] (Node ffff880079f98938), AE_BAD_PARAMETER (20131115/psparse-536) [265460.760394] ACPI Exception: AE_BAD_PARAMETER, Evaluating _PPC (20131115/processor_perflib-140) [265460.760452] CPU1 is up [265460.763721] ACPI: Waking up from system sleep state S4 [265460.797172] PM: noirq thaw of devices complete after 0.632 msecs [265460.797476] PM: early thaw of devices complete after 0.251 msecs [265460.797655] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [265460.816080] ata2: port disabled--ignoring [265460.833055] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [265460.888190] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [265460.980580] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [265460.980584] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [265460.980990] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [265460.981422] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [265461.004450] ata1.00: configured for UDMA/33 [265461.136062] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [265461.136091] ata5: SATA link down (SStatus 0 SControl 300) [265461.137168] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [265461.137172] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [265461.137412] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [265461.137416] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [265461.139866] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [265461.139870] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [265461.140086] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [265461.140090] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [265461.141260] ata3.00: configured for UDMA/100 [265461.288059] smapi smapi: set_real_thresh: set stop to 85 for bat=0 [265461.396088] firewire_core 0000:15:00.1: rediscovered device fw0 [265461.400054] smapi smapi: set_real_thresh: set start to 64 for bat=0 [265461.512054] smapi smapi: set_real_thresh: set stop to 0 for bat=1 [265461.624052] smapi smapi: set_real_thresh: set start to 0 for bat=1 [265461.765015] thinkpad_acpi: ACPI backlight control delay disabled [265461.766691] PM: thaw of devices complete after 969.209 msecs [265462.632897] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [265462.633010] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [265469.426948] Suspending console(s) (use no_console_suspend to debug) [265469.590563] sd 2:0:0:0: [sda] Synchronizing SCSI cache [265469.590700] sd 2:0:0:0: [sda] Stopping disk [265470.140108] PM: suspend of devices complete after 712.625 msecs [265470.140459] PM: late suspend of devices complete after 0.347 msecs [265470.188418] ehci-pci 0000:00:1d.7: System wakeup enabled by ACPI [265470.204172] uhci_hcd 0000:00:1d.2: System wakeup enabled by ACPI [265470.204285] uhci_hcd 0000:00:1d.1: System wakeup enabled by ACPI [265470.205274] uhci_hcd 0000:00:1d.0: System wakeup enabled by ACPI [265470.206010] ehci-pci 0000:00:1a.7: System wakeup enabled by ACPI [265470.220171] uhci_hcd 0000:00:1a.1: System wakeup enabled by ACPI [265470.220282] uhci_hcd 0000:00:1a.0: System wakeup enabled by ACPI [265470.220393] e1000e 0000:00:19.0: System wakeup enabled by ACPI [265470.236123] PM: noirq suspend of devices complete after 95.661 msecs [265470.236800] ACPI: Preparing to enter system sleep state S3 [265470.241505] PM: Saving platform NVS memory [265470.242046] Disabling non-boot CPUs ... [265470.243656] kvm: disabling virtualization on CPU1 [265470.344046] smpboot: CPU 1 is now offline [265470.344403] ACPI: Low-level resume complete [265470.344403] PM: Restoring platform NVS memory [265470.344403] Enabling non-boot CPUs ... [265470.344403] x86: Booting SMP configuration: [265470.344403] smpboot: Booting Node 0 Processor 1 APIC 0x1 [265470.344403] kvm: enabling virtualization on CPU1 [265470.396134] CPU1 is up [265470.399452] ACPI: Waking up from system sleep state S3 [265470.500278] uhci_hcd 0000:00:1a.0: System wakeup disabled by ACPI [265470.500386] uhci_hcd 0000:00:1a.1: System wakeup disabled by ACPI [265470.516157] ehci-pci 0000:00:1a.7: System wakeup disabled by ACPI [265470.533940] uhci_hcd 0000:00:1d.0: System wakeup disabled by ACPI [265470.534039] uhci_hcd 0000:00:1d.1: System wakeup disabled by ACPI [265470.534135] uhci_hcd 0000:00:1d.2: System wakeup disabled by ACPI [265470.548141] ehci-pci 0000:00:1d.7: System wakeup disabled by ACPI [265470.644494] PM: noirq resume of devices complete after 174.562 msecs [265470.644836] PM: early resume of devices complete after 0.290 msecs [265470.648062] e1000e 0000:00:19.0: System wakeup disabled by ACPI [265470.648115] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [265470.648474] usb usb3: root hub lost power or was reset [265470.648520] usb usb4: root hub lost power or was reset [265470.648736] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [265470.648913] usb usb5: root hub lost power or was reset [265470.648957] usb usb6: root hub lost power or was reset [265470.648999] usb usb7: root hub lost power or was reset [265470.659381] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [265470.660396] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [265470.660513] ata2: port disabled--ignoring [265471.540675] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [265471.540679] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [265471.541502] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [265471.542487] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [265471.568454] ata1.00: configured for UDMA/33 [265471.572200] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [265471.640108] ata5: SATA link down (SStatus 0 SControl 300) [265471.852124] usb 3-2: reset full-speed USB device number 2 using uhci_hcd [265472.032092] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [265472.032109] firewire_core 0000:15:00.1: rediscovered device fw0 [265472.043024] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [265472.043028] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [265472.043319] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [265472.043322] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [265472.046516] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [265472.046520] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [265472.046829] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [265472.046833] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [265472.048385] ata3.00: configured for UDMA/100 [265472.064139] sd 2:0:0:0: [sda] Starting disk [265472.225014] thinkpad_acpi: ACPI backlight control delay disabled [265472.226758] PM: resume of devices complete after 1581.916 msecs [265472.361074] Restarting kernel threads ... done. [265472.361746] PM: Basic memory bitmaps freed [265472.361750] Restarting tasks ... done. [265472.375503] video LNXVIDEO:00: Restoring backlight state [265473.192963] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [265473.193078] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [265481.727453] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [265482.542266] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [265482.644151] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [265482.644359] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [265482.656147] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [265483.988953] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [265483.989069] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [265483.989109] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [265488.855102] wlan0: authenticate with 00:09:5b:d4:ec:24 [265488.855838] wlan0: send auth to 00:09:5b:d4:ec:24 (try 1/3) [265488.861275] wlan0: authenticated [265488.861942] ath5k 0000:03:00.0 wlan0: disabling HT/VHT due to WEP/TKIP use [265488.861949] ath5k 0000:03:00.0 wlan0: disabling HT as WMM/QoS is not supported by the AP [265488.861954] ath5k 0000:03:00.0 wlan0: disabling VHT as WMM/QoS is not supported by the AP [265488.864228] wlan0: associate with 00:09:5b:d4:ec:24 (try 1/3) [265488.866386] wlan0: RX AssocResp from 00:09:5b:d4:ec:24 (capab=0x431 status=0 aid=2) [265488.866733] wlan0: associated [265488.866773] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [267753.315784] wlan0: deauthenticating from 00:09:5b:d4:ec:24 by local choice (reason=3) [267753.316848] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [267753.317788] cfg80211: Calling CRDA to update world regulatory domain [267753.390201] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [267753.390247] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [267753.791231] cfg80211: World regulatory domain updated: [267753.791238] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [267753.791244] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [267753.791248] cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [267753.791253] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [267753.791257] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [267753.791261] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [267756.364660] Syncing filesystems ... done. [267756.384707] Freezing user space processes ... (elapsed 0.002 seconds) done. [267756.387408] PM: Marking nosave pages: [mem 0x0009d000-0x000fffff] [267756.387417] PM: Basic memory bitmaps created [267756.387534] PM: Preallocating image memory... done (allocated 271251 pages) [267757.263735] PM: Allocated 1085004 kbytes in 0.87 seconds (1247.13 MB/s) [267757.263740] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done. [267757.265774] Suspending console(s) (use no_console_suspend to debug) [267757.848182] PM: freeze of devices complete after 582.399 msecs [267757.848545] PM: late freeze of devices complete after 0.359 msecs [267757.849952] PM: noirq freeze of devices complete after 1.403 msecs [267757.850732] ACPI: Preparing to enter system sleep state S4 [267757.855085] PM: Saving platform NVS memory [267757.855456] Disabling non-boot CPUs ... [267757.856964] kvm: disabling virtualization on CPU1 [267757.856986] smpboot: CPU 1 is now offline [267757.857703] PM: Creating hibernation image: [267757.860975] PM: Need to copy 192929 pages [267757.860975] PM: Normal pages needed: 192929 + 1024, available pages: 320638 [267757.860975] PM: Hibernation image created (192929 pages copied) [267757.860975] Enabling non-boot CPUs ... [267757.860975] x86: Booting SMP configuration: [267757.860975] smpboot: Booting Node 0 Processor 1 APIC 0x1 [267757.860975] kvm: enabling virtualization on CPU1 [267757.869278] ACPI Exception: AE_BAD_PARAMETER, Returned by Handler for [EmbeddedControl] (20131115/evregion-282) [267757.869290] ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPC_.EC__.LPMD] (Node ffff880079f73618), AE_BAD_PARAMETER (20131115/psparse-536) [267757.869299] ACPI Error: Method parse/execution failed [\_PR_.CPU0._PPC] (Node ffff880079f98b18), AE_BAD_PARAMETER (20131115/psparse-536) [267757.869308] ACPI Error: Method parse/execution failed [\_PR_.CPU1._PPC] (Node ffff880079f98938), AE_BAD_PARAMETER (20131115/psparse-536) [267757.869315] ACPI Exception: AE_BAD_PARAMETER, Evaluating _PPC (20131115/processor_perflib-140) [267757.869368] CPU1 is up [267757.872669] ACPI: Waking up from system sleep state S4 [267757.907365] PM: noirq thaw of devices complete after 0.634 msecs [267757.907671] PM: early thaw of devices complete after 0.252 msecs [267757.907851] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [267757.926123] ata2: port disabled--ignoring [267757.940294] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [267758.004308] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [267758.088550] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [267758.088554] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [267758.098552] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [267758.099001] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [267758.120468] ata1.00: configured for UDMA/33 [267758.252065] ata5: SATA link down (SStatus 0 SControl 300) [267758.252093] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [267758.253250] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [267758.253254] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [267758.253501] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [267758.253505] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [267758.255974] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [267758.255978] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [267758.256202] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [267758.256206] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [267758.257342] ata3.00: configured for UDMA/100 [267758.392055] smapi smapi: set_real_thresh: set stop to 85 for bat=0 [267758.504061] smapi smapi: set_real_thresh: set start to 64 for bat=0 [267758.504759] firewire_core 0000:15:00.1: rediscovered device fw0 [267758.616057] smapi smapi: set_real_thresh: set stop to 0 for bat=1 [267758.728055] smapi smapi: set_real_thresh: set start to 0 for bat=1 [267758.869006] thinkpad_acpi: ACPI backlight control delay disabled [267758.870724] PM: thaw of devices complete after 963.047 msecs [267759.888897] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [267759.889009] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [267765.637303] Suspending console(s) (use no_console_suspend to debug) [267765.789413] sd 2:0:0:0: [sda] Synchronizing SCSI cache [267765.789575] sd 2:0:0:0: [sda] Stopping disk [267766.332128] PM: suspend of devices complete after 694.297 msecs [267766.332484] PM: late suspend of devices complete after 0.352 msecs [267766.380414] ehci-pci 0000:00:1d.7: System wakeup enabled by ACPI [267766.396175] uhci_hcd 0000:00:1d.2: System wakeup enabled by ACPI [267766.396287] uhci_hcd 0000:00:1d.1: System wakeup enabled by ACPI [267766.397209] uhci_hcd 0000:00:1d.0: System wakeup enabled by ACPI [267766.397941] ehci-pci 0000:00:1a.7: System wakeup enabled by ACPI [267766.412175] uhci_hcd 0000:00:1a.1: System wakeup enabled by ACPI [267766.412285] uhci_hcd 0000:00:1a.0: System wakeup enabled by ACPI [267766.412394] e1000e 0000:00:19.0: System wakeup enabled by ACPI [267766.428122] PM: noirq suspend of devices complete after 95.632 msecs [267766.428798] ACPI: Preparing to enter system sleep state S3 [267766.433616] PM: Saving platform NVS memory [267766.434170] Disabling non-boot CPUs ... [267766.435770] kvm: disabling virtualization on CPU1 [267766.536043] smpboot: CPU 1 is now offline [267766.536373] ACPI: Low-level resume complete [267766.536373] PM: Restoring platform NVS memory [267766.536373] Enabling non-boot CPUs ... [267766.536373] x86: Booting SMP configuration: [267766.536373] smpboot: Booting Node 0 Processor 1 APIC 0x1 [267766.536373] kvm: enabling virtualization on CPU1 [267766.584118] CPU1 is up [267766.587437] ACPI: Waking up from system sleep state S3 [267766.692234] uhci_hcd 0000:00:1a.0: System wakeup disabled by ACPI [267766.692329] uhci_hcd 0000:00:1a.1: System wakeup disabled by ACPI [267766.708145] ehci-pci 0000:00:1a.7: System wakeup disabled by ACPI [267766.725920] uhci_hcd 0000:00:1d.0: System wakeup disabled by ACPI [267766.726018] uhci_hcd 0000:00:1d.1: System wakeup disabled by ACPI [267766.726111] uhci_hcd 0000:00:1d.2: System wakeup disabled by ACPI [267766.740137] ehci-pci 0000:00:1d.7: System wakeup disabled by ACPI [267766.836512] PM: noirq resume of devices complete after 176.380 msecs [267766.836818] PM: early resume of devices complete after 0.255 msecs [267766.837028] e1000e 0000:00:19.0: System wakeup disabled by ACPI [267766.837096] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [267766.837440] usb usb3: root hub lost power or was reset [267766.837485] usb usb4: root hub lost power or was reset [267766.837690] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [267766.847906] usb usb5: root hub lost power or was reset [267766.847950] usb usb6: root hub lost power or was reset [267766.847994] usb usb7: root hub lost power or was reset [267766.848338] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [267766.849349] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [267766.851085] ata2: port disabled--ignoring [267767.740540] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [267767.740544] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [267767.741531] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [267767.742526] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [267767.764207] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [267767.764782] ata1.00: configured for UDMA/33 [267767.844056] ata5: SATA link down (SStatus 0 SControl 300) [267768.048126] usb 3-2: reset full-speed USB device number 2 using uhci_hcd [267768.232087] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [267768.236176] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [267768.236180] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [267768.236473] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [267768.236477] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [267768.239585] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [267768.239588] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [267768.239886] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [267768.239889] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [267768.240084] firewire_core 0000:15:00.1: rediscovered device fw0 [267768.241402] ata3.00: configured for UDMA/100 [267768.256116] sd 2:0:0:0: [sda] Starting disk [267768.420947] thinkpad_acpi: ACPI backlight control delay disabled [267768.422705] PM: resume of devices complete after 1585.881 msecs [267768.552129] Restarting kernel threads ... done. [267768.552781] PM: Basic memory bitmaps freed [267768.552785] Restarting tasks ... done. [267768.563194] video LNXVIDEO:00: Restoring backlight state [267769.412951] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [267769.413067] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [267772.994827] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [267773.510284] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [267773.612166] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [267773.612319] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [267773.624418] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [267774.956939] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [267774.957055] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [267774.957094] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [267777.472892] wlan0: authenticate with 00:09:5b:d4:ec:24 [267777.473151] wlan0: send auth to 00:09:5b:d4:ec:24 (try 1/3) [267777.474676] wlan0: authenticated [267777.474865] ath5k 0000:03:00.0 wlan0: disabling HT/VHT due to WEP/TKIP use [267777.474872] ath5k 0000:03:00.0 wlan0: disabling HT as WMM/QoS is not supported by the AP [267777.474877] ath5k 0000:03:00.0 wlan0: disabling VHT as WMM/QoS is not supported by the AP [267777.476059] wlan0: associate with 00:09:5b:d4:ec:24 (try 1/3) [267777.478232] wlan0: RX AssocResp from 00:09:5b:d4:ec:24 (capab=0x431 status=0 aid=3) [267777.478584] wlan0: associated [267777.478626] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [271209.007010] ath5k: ath5k_hw_get_isr: ISR: 0x00000080 IMR: 0x00000000 [272529.005689] ath5k: ath5k_hw_get_isr: ISR: 0x00000080 IMR: 0x00000000 [272769.792079] ath5k: ath5k_hw_get_isr: ISR: 0x00000001 IMR: 0x00000000 [274929.007545] ath5k: ath5k_hw_get_isr: ISR: 0x00000080 IMR: 0x00000000 [275662.272121] ath5k: ath5k_hw_get_isr: ISR: 0x00000001 IMR: 0x00000000 [282249.005898] ath5k: ath5k_hw_get_isr: ISR: 0x00000080 IMR: 0x00000000 [284529.006783] ath5k: ath5k_hw_get_isr: ISR: 0x00000080 IMR: 0x00000000 [289400.982271] wlan0: deauthenticating from 00:09:5b:d4:ec:24 by local choice (reason=3) [289400.983043] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [289400.984203] cfg80211: Calling CRDA to update world regulatory domain [289401.198467] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [289401.198511] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [289401.219722] cfg80211: World regulatory domain updated: [289401.219729] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [289401.219734] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [289401.219738] cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [289401.219743] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [289401.219747] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [289401.219751] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [289403.526791] init: anacron main process (10915) killed by TERM signal [289404.676161] Syncing filesystems ... done. [289404.721744] Freezing user space processes ... (elapsed 0.002 seconds) done. [289404.724430] PM: Marking nosave pages: [mem 0x0009d000-0x000fffff] [289404.724440] PM: Basic memory bitmaps created [289404.724560] PM: Preallocating image memory... done (allocated 271265 pages) [289406.135677] PM: Allocated 1085060 kbytes in 1.41 seconds (769.54 MB/s) [289406.135682] Freezing remaining freezable tasks ... (elapsed 0.089 seconds) done. [289406.225818] Suspending console(s) (use no_console_suspend to debug) [289406.856349] PM: freeze of devices complete after 630.520 msecs [289406.856814] PM: late freeze of devices complete after 0.460 msecs [289406.858232] PM: noirq freeze of devices complete after 1.414 msecs [289406.858935] ACPI: Preparing to enter system sleep state S4 [289406.863199] PM: Saving platform NVS memory [289406.863574] Disabling non-boot CPUs ... [289406.865055] kvm: disabling virtualization on CPU1 [289406.865084] smpboot: CPU 1 is now offline [289406.865831] PM: Creating hibernation image: [289406.869066] PM: Need to copy 225321 pages [289406.869066] PM: Normal pages needed: 225321 + 1024, available pages: 288253 [289406.869066] PM: Hibernation image created (225321 pages copied) [289406.869066] Enabling non-boot CPUs ... [289406.869066] x86: Booting SMP configuration: [289406.869066] smpboot: Booting Node 0 Processor 1 APIC 0x1 [289406.869066] kvm: enabling virtualization on CPU1 [289406.877407] ACPI Exception: AE_BAD_PARAMETER, Returned by Handler for [EmbeddedControl] (20131115/evregion-282) [289406.877418] ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPC_.EC__.LPMD] (Node ffff880079f73618), AE_BAD_PARAMETER (20131115/psparse-536) [289406.877428] ACPI Error: Method parse/execution failed [\_PR_.CPU0._PPC] (Node ffff880079f98b18), AE_BAD_PARAMETER (20131115/psparse-536) [289406.877437] ACPI Error: Method parse/execution failed [\_PR_.CPU1._PPC] (Node ffff880079f98938), AE_BAD_PARAMETER (20131115/psparse-536) [289406.877444] ACPI Exception: AE_BAD_PARAMETER, Evaluating _PPC (20131115/processor_perflib-140) [289406.877495] CPU1 is up [289406.880809] ACPI: Waking up from system sleep state S4 [289406.916917] PM: noirq thaw of devices complete after 0.633 msecs [289406.917223] PM: early thaw of devices complete after 0.253 msecs [289406.924110] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [289406.936545] ata2: port disabled--ignoring [289406.940280] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [289407.004211] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [289407.114478] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [289407.114482] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [289407.114934] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [289407.115366] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [289407.136447] ata1.00: configured for UDMA/33 [289407.256064] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [289407.257168] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [289407.257173] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [289407.257414] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [289407.257418] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [289407.259855] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [289407.259859] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [289407.260069] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [289407.260078] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [289407.261186] ata3.00: configured for UDMA/100 [289407.264059] ata5: SATA link down (SStatus 0 SControl 300) [289407.408057] smapi smapi: set_real_thresh: set stop to 85 for bat=0 [289407.504093] firewire_core 0000:15:00.1: rediscovered device fw0 [289407.520051] smapi smapi: set_real_thresh: set start to 64 for bat=0 [289407.632052] smapi smapi: set_real_thresh: set stop to 0 for bat=1 [289407.744052] smapi smapi: set_real_thresh: set start to 0 for bat=1 [289407.885011] thinkpad_acpi: ACPI backlight control delay disabled [289407.886778] PM: thaw of devices complete after 969.549 msecs [289408.744899] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [289408.745011] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [289417.485824] Suspending console(s) (use no_console_suspend to debug) [289417.641592] sd 2:0:0:0: [sda] Synchronizing SCSI cache [289417.641760] sd 2:0:0:0: [sda] Stopping disk [289418.228108] PM: suspend of devices complete after 741.749 msecs [289418.228463] PM: late suspend of devices complete after 0.350 msecs [289418.276412] ehci-pci 0000:00:1d.7: System wakeup enabled by ACPI [289418.292171] uhci_hcd 0000:00:1d.2: System wakeup enabled by ACPI [289418.292283] uhci_hcd 0000:00:1d.1: System wakeup enabled by ACPI [289418.293188] uhci_hcd 0000:00:1d.0: System wakeup enabled by ACPI [289418.293924] ehci-pci 0000:00:1a.7: System wakeup enabled by ACPI [289418.308172] uhci_hcd 0000:00:1a.1: System wakeup enabled by ACPI [289418.308282] uhci_hcd 0000:00:1a.0: System wakeup enabled by ACPI [289418.308393] e1000e 0000:00:19.0: System wakeup enabled by ACPI [289418.324122] PM: noirq suspend of devices complete after 95.657 msecs [289418.324806] ACPI: Preparing to enter system sleep state S3 [289418.329520] PM: Saving platform NVS memory [289418.329885] Disabling non-boot CPUs ... [289418.331495] kvm: disabling virtualization on CPU1 [289418.432036] smpboot: CPU 1 is now offline [289418.432366] ACPI: Low-level resume complete [289418.432366] PM: Restoring platform NVS memory [289418.432366] Enabling non-boot CPUs ... [289418.432366] x86: Booting SMP configuration: [289418.432366] smpboot: Booting Node 0 Processor 1 APIC 0x1 [289418.432366] kvm: enabling virtualization on CPU1 [289418.480116] CPU1 is up [289418.483430] ACPI: Waking up from system sleep state S3 [289418.584275] uhci_hcd 0000:00:1a.0: System wakeup disabled by ACPI [289418.584378] uhci_hcd 0000:00:1a.1: System wakeup disabled by ACPI [289418.600161] ehci-pci 0000:00:1a.7: System wakeup disabled by ACPI [289418.617979] uhci_hcd 0000:00:1d.0: System wakeup disabled by ACPI [289418.618080] uhci_hcd 0000:00:1d.1: System wakeup disabled by ACPI [289418.618177] uhci_hcd 0000:00:1d.2: System wakeup disabled by ACPI [289418.632139] ehci-pci 0000:00:1d.7: System wakeup disabled by ACPI [289418.728507] PM: noirq resume of devices complete after 174.553 msecs [289418.728833] PM: early resume of devices complete after 0.274 msecs [289418.732060] e1000e 0000:00:19.0: System wakeup disabled by ACPI [289418.732115] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [289418.732467] usb usb3: root hub lost power or was reset [289418.732514] usb usb4: root hub lost power or was reset [289418.732729] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [289418.732906] usb usb5: root hub lost power or was reset [289418.732949] usb usb6: root hub lost power or was reset [289418.732992] usb usb7: root hub lost power or was reset [289418.743371] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [289418.744383] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [289418.744500] ata2: port disabled--ignoring [289419.628573] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [289419.628577] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [289419.629526] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [289419.630511] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [289419.652201] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [289419.653254] ata1.00: configured for UDMA/33 [289419.728049] ata5: SATA link down (SStatus 0 SControl 300) [289419.936125] usb 3-2: reset full-speed USB device number 2 using uhci_hcd [289420.120085] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [289420.120106] firewire_core 0000:15:00.1: rediscovered device fw0 [289420.125480] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [289420.125484] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [289420.125783] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [289420.125787] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [289420.128945] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [289420.128949] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [289420.129238] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [289420.129241] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [289420.130716] ata3.00: configured for UDMA/100 [289420.144147] sd 2:0:0:0: [sda] Starting disk [289420.309026] thinkpad_acpi: ACPI backlight control delay disabled [289420.310764] PM: resume of devices complete after 1581.925 msecs [289420.455674] Restarting kernel threads ... done. [289420.456413] PM: Basic memory bitmaps freed [289420.456417] Restarting tasks ... done. [289420.465421] video LNXVIDEO:00: Restoring backlight state [289421.276953] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [289421.277068] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [289431.794786] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [289432.516359] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [289432.620151] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [289432.620361] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [289432.632682] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [289433.960954] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [289433.961070] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [289433.961110] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [289437.024823] wlan0: authenticate with 00:09:5b:d4:ec:24 [289437.025076] wlan0: send auth to 00:09:5b:d4:ec:24 (try 1/3) [289437.026630] wlan0: authenticated [289437.026855] ath5k 0000:03:00.0 wlan0: disabling HT/VHT due to WEP/TKIP use [289437.026863] ath5k 0000:03:00.0 wlan0: disabling HT as WMM/QoS is not supported by the AP [289437.026868] ath5k 0000:03:00.0 wlan0: disabling VHT as WMM/QoS is not supported by the AP [289437.028117] wlan0: associate with 00:09:5b:d4:ec:24 (try 1/3) [289437.030295] wlan0: RX AssocResp from 00:09:5b:d4:ec:24 (capab=0x431 status=0 aid=3) [289437.030640] wlan0: associated [289437.030677] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [289991.340103] ath5k: ath5k_hw_get_isr: ISR: 0x00000001 IMR: 0x00000000 [290029.945556] type=1400 audit(1398612481.511:116): apparmor="STATUS" operation="profile_replace" profile="unconfined" name="/usr/lib/cups/backend/cups-pdf" pid=11860 comm="apparmor_parser" [290029.945573] type=1400 audit(1398612481.511:117): apparmor="STATUS" operation="profile_replace" profile="unconfined" name="/usr/sbin/cupsd" pid=11860 comm="apparmor_parser" [290029.946459] type=1400 audit(1398612481.511:118): apparmor="STATUS" operation="profile_replace" profile="unconfined" name="/usr/sbin/cupsd" pid=11860 comm="apparmor_parser" [295148.006061] ath5k: ath5k_hw_get_isr: ISR: 0x00000080 IMR: 0x00000000 [313748.005756] ath5k: ath5k_hw_get_isr: ISR: 0x00000080 IMR: 0x00000000 [320829.888120] ath5k: ath5k_hw_get_isr: ISR: 0x00000001 IMR: 0x00000000 [326348.006613] ath5k: ath5k_hw_get_isr: ISR: 0x00000080 IMR: 0x00000000 [333308.006644] ath5k: ath5k_hw_get_isr: ISR: 0x00000080 IMR: 0x00000000 [334508.006639] ath5k: ath5k_hw_get_isr: ISR: 0x00000080 IMR: 0x00000000 [337508.006602] ath5k: ath5k_hw_get_isr: ISR: 0x00000080 IMR: 0x00000000 [337868.002852] ath5k: ath5k_hw_get_isr: ISR: 0x00000080 IMR: 0x00000000 [341128.796914] wlan0: deauthenticating from 00:09:5b:d4:ec:24 by local choice (reason=3) [341128.797826] cfg80211: Calling CRDA to update world regulatory domain [341129.463695] cfg80211: World regulatory domain updated: [341129.463704] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [341129.463710] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [341129.463714] cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [341129.463718] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [341129.463723] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [341129.463727] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [341129.662252] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [341129.662299] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [341131.859580] init: anacron main process (16414) killed by TERM signal [341133.520485] Syncing filesystems ... done. [341133.564795] Freezing user space processes ... (elapsed 0.004 seconds) done. [341133.569692] PM: Marking nosave pages: [mem 0x0009d000-0x000fffff] [341133.569701] PM: Basic memory bitmaps created [341133.569819] PM: Preallocating image memory... done (allocated 271277 pages) [341134.659328] PM: Allocated 1085108 kbytes in 1.08 seconds (1004.72 MB/s) [341134.659332] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done. [341134.661350] Suspending console(s) (use no_console_suspend to debug) [341135.252185] PM: freeze of devices complete after 590.825 msecs [341135.252612] PM: late freeze of devices complete after 0.422 msecs [341135.254023] PM: noirq freeze of devices complete after 1.407 msecs [341135.254751] ACPI: Preparing to enter system sleep state S4 [341135.259092] PM: Saving platform NVS memory [341135.259489] Disabling non-boot CPUs ... [341135.261000] kvm: disabling virtualization on CPU1 [341135.261029] smpboot: CPU 1 is now offline [341135.261725] PM: Creating hibernation image: [341135.265011] PM: Need to copy 211652 pages [341135.265011] PM: Normal pages needed: 211652 + 1024, available pages: 301923 [341135.265011] PM: Hibernation image created (211652 pages copied) [341135.265011] Enabling non-boot CPUs ... [341135.265011] x86: Booting SMP configuration: [341135.265011] smpboot: Booting Node 0 Processor 1 APIC 0x1 [341135.265011] kvm: enabling virtualization on CPU1 [341135.273291] ACPI Exception: AE_BAD_PARAMETER, Returned by Handler for [EmbeddedControl] (20131115/evregion-282) [341135.273302] ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPC_.EC__.LPMD] (Node ffff880079f73618), AE_BAD_PARAMETER (20131115/psparse-536) [341135.273312] ACPI Error: Method parse/execution failed [\_PR_.CPU0._PPC] (Node ffff880079f98b18), AE_BAD_PARAMETER (20131115/psparse-536) [341135.273321] ACPI Error: Method parse/execution failed [\_PR_.CPU1._PPC] (Node ffff880079f98938), AE_BAD_PARAMETER (20131115/psparse-536) [341135.273328] ACPI Exception: AE_BAD_PARAMETER, Evaluating _PPC (20131115/processor_perflib-140) [341135.273378] CPU1 is up [341135.276676] ACPI: Waking up from system sleep state S4 [341135.312710] PM: noirq thaw of devices complete after 0.634 msecs [341135.313014] PM: early thaw of devices complete after 0.252 msecs [341135.313190] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [341135.334106] ata2: port disabled--ignoring [341135.345525] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [341135.404196] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [341135.496522] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [341135.496526] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [341135.496945] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [341135.497379] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [341135.520463] ata1.00: configured for UDMA/33 [341135.656065] ata5: SATA link down (SStatus 0 SControl 300) [341135.656094] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [341135.657207] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [341135.657211] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [341135.657457] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [341135.657461] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [341135.659918] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [341135.659922] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [341135.660145] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [341135.660149] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [341135.661279] ata3.00: configured for UDMA/100 [341135.800043] smapi smapi: set_real_thresh: set stop to 85 for bat=0 [341135.904095] firewire_core 0000:15:00.1: rediscovered device fw0 [341135.912058] smapi smapi: set_real_thresh: set start to 64 for bat=0 [341136.024054] smapi smapi: set_real_thresh: set stop to 0 for bat=1 [341136.136055] smapi smapi: set_real_thresh: set start to 0 for bat=1 [341136.277005] thinkpad_acpi: ACPI backlight control delay disabled [341136.278724] PM: thaw of devices complete after 965.704 msecs [341137.116895] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [341137.117008] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [341144.537127] Suspending console(s) (use no_console_suspend to debug) [341144.692938] sd 2:0:0:0: [sda] Synchronizing SCSI cache [341144.693105] sd 2:0:0:0: [sda] Stopping disk [341145.288109] PM: suspend of devices complete after 750.443 msecs [341145.288465] PM: late suspend of devices complete after 0.352 msecs [341145.336416] ehci-pci 0000:00:1d.7: System wakeup enabled by ACPI [341145.352171] uhci_hcd 0000:00:1d.2: System wakeup enabled by ACPI [341145.352283] uhci_hcd 0000:00:1d.1: System wakeup enabled by ACPI [341145.353229] uhci_hcd 0000:00:1d.0: System wakeup enabled by ACPI [341145.353960] ehci-pci 0000:00:1a.7: System wakeup enabled by ACPI [341145.368171] uhci_hcd 0000:00:1a.1: System wakeup enabled by ACPI [341145.368281] uhci_hcd 0000:00:1a.0: System wakeup enabled by ACPI [341145.368390] e1000e 0000:00:19.0: System wakeup enabled by ACPI [341145.384120] PM: noirq suspend of devices complete after 95.651 msecs [341145.384807] ACPI: Preparing to enter system sleep state S3 [341145.389347] PM: Saving platform NVS memory [341145.389736] Disabling non-boot CPUs ... [341145.391200] kvm: disabling virtualization on CPU1 [341145.492041] smpboot: CPU 1 is now offline [341145.492387] ACPI: Low-level resume complete [341145.492387] PM: Restoring platform NVS memory [341145.492387] Enabling non-boot CPUs ... [341145.492387] x86: Booting SMP configuration: [341145.492387] smpboot: Booting Node 0 Processor 1 APIC 0x1 [341145.492387] kvm: enabling virtualization on CPU1 [341145.540113] CPU1 is up [341145.543422] ACPI: Waking up from system sleep state S3 [341145.644247] uhci_hcd 0000:00:1a.0: System wakeup disabled by ACPI [341145.644342] uhci_hcd 0000:00:1a.1: System wakeup disabled by ACPI [341145.660143] ehci-pci 0000:00:1a.7: System wakeup disabled by ACPI [341145.677938] uhci_hcd 0000:00:1d.0: System wakeup disabled by ACPI [341145.678040] uhci_hcd 0000:00:1d.1: System wakeup disabled by ACPI [341145.678141] uhci_hcd 0000:00:1d.2: System wakeup disabled by ACPI [341145.692143] ehci-pci 0000:00:1d.7: System wakeup disabled by ACPI [341145.788483] PM: noirq resume of devices complete after 173.275 msecs [341145.788791] PM: early resume of devices complete after 0.257 msecs [341145.792060] e1000e 0000:00:19.0: System wakeup disabled by ACPI [341145.792114] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [341145.792463] usb usb3: root hub lost power or was reset [341145.792509] usb usb4: root hub lost power or was reset [341145.792723] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [341145.792899] usb usb5: root hub lost power or was reset [341145.792943] usb usb6: root hub lost power or was reset [341145.792986] usb usb7: root hub lost power or was reset [341145.803365] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [341145.804379] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [341145.804755] ata2: port disabled--ignoring [341146.688571] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [341146.688574] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [341146.689543] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [341146.690543] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [341146.712205] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [341146.712776] ata1.00: configured for UDMA/33 [341146.788072] ata5: SATA link down (SStatus 0 SControl 300) [341146.996082] usb 3-2: reset full-speed USB device number 2 using uhci_hcd [341147.180074] firewire_core 0000:15:00.1: rediscovered device fw0 [341147.184076] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [341147.189095] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [341147.189099] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [341147.189398] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [341147.189402] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [341147.192562] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [341147.192566] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [341147.192876] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [341147.192879] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [341147.194373] ata3.00: configured for UDMA/100 [341147.208144] sd 2:0:0:0: [sda] Starting disk [341147.372995] thinkpad_acpi: ACPI backlight control delay disabled [341147.374747] PM: resume of devices complete after 1585.950 msecs [341147.512088] Restarting kernel threads ... done. [341147.512528] PM: Basic memory bitmaps freed [341147.512532] Restarting tasks ... done. [341147.522256] video LNXVIDEO:00: Restoring backlight state [341148.352931] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [341148.353047] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [341153.278889] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [341153.816490] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [341153.920165] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [341153.920385] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [341153.932830] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [341155.265000] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [341155.265124] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [341155.265195] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [341158.092282] wlan0: authenticate with 00:09:5b:d4:ec:24 [341158.092545] wlan0: send auth to 00:09:5b:d4:ec:24 (try 1/3) [341158.094091] wlan0: authenticated [341158.094538] ath5k 0000:03:00.0 wlan0: disabling HT/VHT due to WEP/TKIP use [341158.094544] ath5k 0000:03:00.0 wlan0: disabling HT as WMM/QoS is not supported by the AP [341158.094549] ath5k 0000:03:00.0 wlan0: disabling VHT as WMM/QoS is not supported by the AP [341158.096246] wlan0: associate with 00:09:5b:d4:ec:24 (try 1/3) [341158.098550] wlan0: RX AssocResp from 00:09:5b:d4:ec:24 (capab=0x431 status=0 aid=3) [341158.098900] wlan0: associated [341158.098940] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [343052.799800] type=1400 audit(1398695473.301:119): apparmor="STATUS" operation="profile_replace" profile="unconfined" name="/usr/lib/cups/backend/cups-pdf" pid=17503 comm="apparmor_parser" [343052.799816] type=1400 audit(1398695473.301:120): apparmor="STATUS" operation="profile_replace" profile="unconfined" name="/usr/sbin/cupsd" pid=17503 comm="apparmor_parser" [343052.800765] type=1400 audit(1398695473.305:121): apparmor="STATUS" operation="profile_replace" profile="unconfined" name="/usr/sbin/cupsd" pid=17503 comm="apparmor_parser" [345429.007016] ath5k: ath5k_hw_get_isr: ISR: 0x00000080 IMR: 0x00000000 [350709.006965] ath5k: ath5k_hw_get_isr: ISR: 0x00000080 IMR: 0x00000000 [356829.007288] ath5k: ath5k_hw_get_isr: ISR: 0x00000080 IMR: 0x00000000 [360309.006332] ath5k: ath5k_hw_get_isr: ISR: 0x00000080 IMR: 0x00000000 [380716.860105] ath5k: ath5k_hw_get_isr: ISR: 0x00000001 IMR: 0x00000000 [380723.516074] ath5k: ath5k_hw_get_isr: ISR: 0x00000001 IMR: 0x00000000 [380764.178338] wlan0: deauthenticating from 00:09:5b:d4:ec:24 by local choice (reason=3) [380764.180431] cfg80211: Calling CRDA to update world regulatory domain [380765.178252] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [380765.178299] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [380765.179351] cfg80211: World regulatory domain updated: [380765.179356] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [380765.179361] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [380765.179366] cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [380765.179370] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [380765.179374] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [380765.179378] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [380770.722139] Syncing filesystems ... done. [380770.764801] Freezing user space processes ... (elapsed 0.087 seconds) done. [380770.852257] PM: Marking nosave pages: [mem 0x0009d000-0x000fffff] [380770.852266] PM: Basic memory bitmaps created [380770.852386] PM: Preallocating image memory... done (allocated 271261 pages) [380772.615358] PM: Allocated 1085044 kbytes in 1.76 seconds (616.50 MB/s) [380772.615362] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done. [380772.617443] Suspending console(s) (use no_console_suspend to debug) [380773.452321] PM: freeze of devices complete after 834.867 msecs [380773.452785] PM: late freeze of devices complete after 0.459 msecs [380773.454204] PM: noirq freeze of devices complete after 1.414 msecs [380773.454915] ACPI: Preparing to enter system sleep state S4 [380773.459211] PM: Saving platform NVS memory [380773.459580] Disabling non-boot CPUs ... [380773.461069] kvm: disabling virtualization on CPU1 [380773.461097] smpboot: CPU 1 is now offline [380773.461843] PM: Creating hibernation image: [380773.465079] PM: Need to copy 223652 pages [380773.465079] PM: Normal pages needed: 223652 + 1024, available pages: 289917 [380773.465079] PM: Hibernation image created (223652 pages copied) [380773.465079] Enabling non-boot CPUs ... [380773.465079] x86: Booting SMP configuration: [380773.465079] smpboot: Booting Node 0 Processor 1 APIC 0x1 [380773.465079] kvm: enabling virtualization on CPU1 [380773.473426] ACPI Exception: AE_BAD_PARAMETER, Returned by Handler for [EmbeddedControl] (20131115/evregion-282) [380773.473437] ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPC_.EC__.LPMD] (Node ffff880079f73618), AE_BAD_PARAMETER (20131115/psparse-536) [380773.473447] ACPI Error: Method parse/execution failed [\_PR_.CPU0._PPC] (Node ffff880079f98b18), AE_BAD_PARAMETER (20131115/psparse-536) [380773.473455] ACPI Error: Method parse/execution failed [\_PR_.CPU1._PPC] (Node ffff880079f98938), AE_BAD_PARAMETER (20131115/psparse-536) [380773.473463] ACPI Exception: AE_BAD_PARAMETER, Evaluating _PPC (20131115/processor_perflib-140) [380773.473513] CPU1 is up [380773.476827] ACPI: Waking up from system sleep state S4 [380773.511407] PM: noirq thaw of devices complete after 0.635 msecs [380773.511711] PM: early thaw of devices complete after 0.252 msecs [380773.516100] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [380773.528261] ata2: port disabled--ignoring [380773.532265] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [380773.600198] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [380773.692547] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [380773.692550] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [380773.693031] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [380773.693448] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [380773.720478] ata1.00: configured for UDMA/33 [380773.848067] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [380773.849168] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [380773.849173] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [380773.849414] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [380773.849417] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [380773.851855] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [380773.851859] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [380773.852064] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [380773.852068] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [380773.853162] ata3.00: configured for UDMA/100 [380773.856056] ata5: SATA link down (SStatus 0 SControl 300) [380774.000059] smapi smapi: set_real_thresh: set stop to 85 for bat=0 [380774.096092] firewire_core 0000:15:00.1: rediscovered device fw0 [380774.112053] smapi smapi: set_real_thresh: set start to 64 for bat=0 [380774.224052] smapi smapi: set_real_thresh: set stop to 0 for bat=1 [380774.336051] smapi smapi: set_real_thresh: set start to 0 for bat=1 [380774.477001] thinkpad_acpi: ACPI backlight control delay disabled [380774.478729] PM: thaw of devices complete after 967.012 msecs [380775.320897] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [380775.321009] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [380782.308517] Suspending console(s) (use no_console_suspend to debug) [380782.460212] sd 2:0:0:0: [sda] Synchronizing SCSI cache [380782.460352] sd 2:0:0:0: [sda] Stopping disk [380783.020137] PM: suspend of devices complete after 711.094 msecs [380783.020492] PM: late suspend of devices complete after 0.350 msecs [380783.068415] ehci-pci 0000:00:1d.7: System wakeup enabled by ACPI [380783.084176] uhci_hcd 0000:00:1d.2: System wakeup enabled by ACPI [380783.084289] uhci_hcd 0000:00:1d.1: System wakeup enabled by ACPI [380783.085198] uhci_hcd 0000:00:1d.0: System wakeup enabled by ACPI [380783.085933] ehci-pci 0000:00:1a.7: System wakeup enabled by ACPI [380783.100168] uhci_hcd 0000:00:1a.1: System wakeup enabled by ACPI [380783.100279] uhci_hcd 0000:00:1a.0: System wakeup enabled by ACPI [380783.100387] e1000e 0000:00:19.0: System wakeup enabled by ACPI [380783.116120] PM: noirq suspend of devices complete after 95.625 msecs [380783.116794] ACPI: Preparing to enter system sleep state S3 [380783.121659] PM: Saving platform NVS memory [380783.122078] Disabling non-boot CPUs ... [380783.123682] kvm: disabling virtualization on CPU1 [380783.224043] smpboot: CPU 1 is now offline [380783.224390] ACPI: Low-level resume complete [380783.224390] PM: Restoring platform NVS memory [380783.224390] Enabling non-boot CPUs ... [380783.224390] x86: Booting SMP configuration: [380783.224390] smpboot: Booting Node 0 Processor 1 APIC 0x1 [380783.224390] kvm: enabling virtualization on CPU1 [380783.272130] CPU1 is up [380783.275441] ACPI: Waking up from system sleep state S3 [380783.376278] uhci_hcd 0000:00:1a.0: System wakeup disabled by ACPI [380783.376376] uhci_hcd 0000:00:1a.1: System wakeup disabled by ACPI [380783.392163] ehci-pci 0000:00:1a.7: System wakeup disabled by ACPI [380783.410013] uhci_hcd 0000:00:1d.0: System wakeup disabled by ACPI [380783.410115] uhci_hcd 0000:00:1d.1: System wakeup disabled by ACPI [380783.410215] uhci_hcd 0000:00:1d.2: System wakeup disabled by ACPI [380783.424133] ehci-pci 0000:00:1d.7: System wakeup disabled by ACPI [380783.520508] PM: noirq resume of devices complete after 174.363 msecs [380783.520829] PM: early resume of devices complete after 0.269 msecs [380783.524060] e1000e 0000:00:19.0: System wakeup disabled by ACPI [380783.524114] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [380783.524467] usb usb3: root hub lost power or was reset [380783.524512] usb usb4: root hub lost power or was reset [380783.524727] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [380783.524903] usb usb5: root hub lost power or was reset [380783.524947] usb usb6: root hub lost power or was reset [380783.524990] usb usb7: root hub lost power or was reset [380783.535368] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [380783.536381] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [380783.538049] ata2: port disabled--ignoring [380784.416540] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [380784.416544] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [380784.417521] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [380784.418521] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [380784.440469] ata1.00: configured for UDMA/33 [380784.444231] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [380784.517021] ata5: SATA link down (SStatus 0 SControl 300) [380784.728130] usb 3-2: reset full-speed USB device number 2 using uhci_hcd [380784.908092] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [380784.908108] firewire_core 0000:15:00.1: rediscovered device fw0 [380784.918586] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [380784.918590] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [380784.918901] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [380784.918905] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [380784.922066] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [380784.922070] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [380784.922378] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [380784.922382] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [380784.923870] ata3.00: configured for UDMA/100 [380784.940130] sd 2:0:0:0: [sda] Starting disk [380785.101064] thinkpad_acpi: ACPI backlight control delay disabled [380785.102795] PM: resume of devices complete after 1581.960 msecs [380785.249892] Restarting kernel threads ... done. [380785.250614] PM: Basic memory bitmaps freed [380785.250618] Restarting tasks ... done. [380785.259117] video LNXVIDEO:00: Restoring backlight state [380786.068939] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [380786.069055] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [382498.233339] Syncing filesystems ... done. [382498.244251] Freezing user space processes ... (elapsed 0.003 seconds) done. [382498.248300] PM: Marking nosave pages: [mem 0x0009d000-0x000fffff] [382498.248309] PM: Basic memory bitmaps created [382498.248427] PM: Preallocating image memory... done (allocated 271251 pages) [382499.112114] PM: Allocated 1085004 kbytes in 0.86 seconds (1261.63 MB/s) [382499.112119] Freezing remaining freezable tasks ... (elapsed 0.293 seconds) done. [382499.406223] Suspending console(s) (use no_console_suspend to debug) [382500.240318] PM: freeze of devices complete after 834.083 msecs [382500.240780] PM: late freeze of devices complete after 0.458 msecs [382500.242192] PM: noirq freeze of devices complete after 1.408 msecs [382500.242898] ACPI: Preparing to enter system sleep state S4 [382500.247386] PM: Saving platform NVS memory [382500.247748] Disabling non-boot CPUs ... [382500.249246] kvm: disabling virtualization on CPU1 [382500.352028] smpboot: CPU 1 is now offline [382500.352660] PM: Creating hibernation image: [382500.356009] PM: Need to copy 223820 pages [382500.356009] PM: Normal pages needed: 223820 + 1024, available pages: 289753 [382500.356009] PM: Hibernation image created (223820 pages copied) [382500.356009] Enabling non-boot CPUs ... [382500.356009] x86: Booting SMP configuration: [382500.356009] smpboot: Booting Node 0 Processor 1 APIC 0x1 [382500.356009] kvm: enabling virtualization on CPU1 [382500.364290] ACPI Exception: AE_BAD_PARAMETER, Returned by Handler for [EmbeddedControl] (20131115/evregion-282) [382500.364301] ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPC_.EC__.LPMD] (Node ffff880079f73618), AE_BAD_PARAMETER (20131115/psparse-536) [382500.364311] ACPI Error: Method parse/execution failed [\_PR_.CPU0._PPC] (Node ffff880079f98b18), AE_BAD_PARAMETER (20131115/psparse-536) [382500.364320] ACPI Error: Method parse/execution failed [\_PR_.CPU1._PPC] (Node ffff880079f98938), AE_BAD_PARAMETER (20131115/psparse-536) [382500.364327] ACPI Exception: AE_BAD_PARAMETER, Evaluating _PPC (20131115/processor_perflib-140) [382500.364379] CPU1 is up [382500.367648] ACPI: Waking up from system sleep state S4 [382500.399493] PM: noirq thaw of devices complete after 0.634 msecs [382500.399798] PM: early thaw of devices complete after 0.252 msecs [382500.408097] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [382500.418990] ata2: port disabled--ignoring [382500.424276] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [382500.488286] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [382500.584592] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [382500.584595] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [382500.585003] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [382500.585438] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [382500.612439] ata1.00: configured for UDMA/33 [382500.740067] ata5: SATA link down (SStatus 0 SControl 300) [382500.748066] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [382500.749183] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [382500.749187] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [382500.749433] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [382500.749437] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [382500.751901] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [382500.751905] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [382500.752125] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [382500.752129] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [382500.753267] ata3.00: configured for UDMA/100 [382500.892057] smapi smapi: set_real_thresh: set stop to 85 for bat=0 [382500.988088] firewire_core 0000:15:00.1: rediscovered device fw0 [382501.004054] smapi smapi: set_real_thresh: set start to 64 for bat=0 [382501.116054] smapi smapi: set_real_thresh: set stop to 0 for bat=1 [382501.228054] smapi smapi: set_real_thresh: set start to 0 for bat=1 [382501.369009] thinkpad_acpi: ACPI backlight control delay disabled [382501.370717] PM: thaw of devices complete after 970.913 msecs [382503.048896] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [382503.049008] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [382509.646616] Suspending console(s) (use no_console_suspend to debug) [382509.810953] sd 2:0:0:0: [sda] Synchronizing SCSI cache [382509.811059] sd 2:0:0:0: [sda] Stopping disk [382510.364110] PM: suspend of devices complete after 716.963 msecs [382510.364467] PM: late suspend of devices complete after 0.352 msecs [382510.412407] ehci-pci 0000:00:1d.7: System wakeup enabled by ACPI [382510.428172] uhci_hcd 0000:00:1d.2: System wakeup enabled by ACPI [382510.428284] uhci_hcd 0000:00:1d.1: System wakeup enabled by ACPI [382510.429153] uhci_hcd 0000:00:1d.0: System wakeup enabled by ACPI [382510.429884] ehci-pci 0000:00:1a.7: System wakeup enabled by ACPI [382510.444175] uhci_hcd 0000:00:1a.1: System wakeup enabled by ACPI [382510.444285] uhci_hcd 0000:00:1a.0: System wakeup enabled by ACPI [382510.444394] e1000e 0000:00:19.0: System wakeup enabled by ACPI [382510.460117] PM: noirq suspend of devices complete after 95.648 msecs [382510.460790] ACPI: Preparing to enter system sleep state S3 [382510.465330] PM: Saving platform NVS memory [382510.465754] Disabling non-boot CPUs ... [382510.467216] kvm: disabling virtualization on CPU1 [382510.568037] smpboot: CPU 1 is now offline [382510.568372] ACPI: Low-level resume complete [382510.568372] PM: Restoring platform NVS memory [382510.568372] Enabling non-boot CPUs ... [382510.568372] x86: Booting SMP configuration: [382510.568372] smpboot: Booting Node 0 Processor 1 APIC 0x1 [382510.568372] kvm: enabling virtualization on CPU1 [382510.616116] CPU1 is up [382510.619425] ACPI: Waking up from system sleep state S3 [382510.720281] uhci_hcd 0000:00:1a.0: System wakeup disabled by ACPI [382510.720376] uhci_hcd 0000:00:1a.1: System wakeup disabled by ACPI [382510.736160] ehci-pci 0000:00:1a.7: System wakeup disabled by ACPI [382510.753989] uhci_hcd 0000:00:1d.0: System wakeup disabled by ACPI [382510.754088] uhci_hcd 0000:00:1d.1: System wakeup disabled by ACPI [382510.754187] uhci_hcd 0000:00:1d.2: System wakeup disabled by ACPI [382510.768139] ehci-pci 0000:00:1d.7: System wakeup disabled by ACPI [382510.864512] PM: noirq resume of devices complete after 174.700 msecs [382510.864833] PM: early resume of devices complete after 0.269 msecs [382510.868069] e1000e 0000:00:19.0: System wakeup disabled by ACPI [382510.868124] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [382510.868473] usb usb3: root hub lost power or was reset [382510.868519] usb usb4: root hub lost power or was reset [382510.868726] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [382510.868910] usb usb5: root hub lost power or was reset [382510.868953] usb usb6: root hub lost power or was reset [382510.868996] usb usb7: root hub lost power or was reset [382510.869322] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [382510.870332] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [382510.882145] ata2: port disabled--ignoring [382511.764537] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [382511.764541] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [382511.765514] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [382511.766499] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [382511.788235] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [382511.788616] ata1.00: configured for UDMA/33 [382511.872055] ata5: SATA link down (SStatus 0 SControl 300) [382512.072121] usb 3-2: reset full-speed USB device number 2 using uhci_hcd [382512.260077] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [382512.271469] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [382512.271474] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [382512.271757] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [382512.271760] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [382512.274988] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [382512.274992] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [382512.275293] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [382512.275297] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [382512.276108] firewire_core 0000:15:00.1: rediscovered device fw0 [382512.276811] ata3.00: configured for UDMA/100 [382512.292138] sd 2:0:0:0: [sda] Starting disk [382512.453034] thinkpad_acpi: ACPI backlight control delay disabled [382512.454780] PM: resume of devices complete after 1589.941 msecs [382512.589492] Restarting kernel threads ... done. [382512.590203] PM: Basic memory bitmaps freed [382512.590207] Restarting tasks ... done. [382512.600332] video LNXVIDEO:00: Restoring backlight state [382513.436928] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [382513.437043] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [382521.630940] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [382522.410261] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [382522.512156] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [382522.512362] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [382522.524152] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [382523.836967] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [382523.837082] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [382523.837130] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [382527.558816] wlan0: authenticate with 00:09:5b:d4:ec:24 [382527.559078] wlan0: send auth to 00:09:5b:d4:ec:24 (try 1/3) [382527.560613] wlan0: authenticated [382527.560917] ath5k 0000:03:00.0 wlan0: disabling HT/VHT due to WEP/TKIP use [382527.560924] ath5k 0000:03:00.0 wlan0: disabling HT as WMM/QoS is not supported by the AP [382527.560929] ath5k 0000:03:00.0 wlan0: disabling VHT as WMM/QoS is not supported by the AP [382527.564039] wlan0: associate with 00:09:5b:d4:ec:24 (try 1/3) [382527.566234] wlan0: RX AssocResp from 00:09:5b:d4:ec:24 (capab=0x431 status=0 aid=3) [382527.566581] wlan0: associated [382527.566621] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [383458.703598] type=1400 audit(1398746302.128:122): apparmor="STATUS" operation="profile_replace" profile="unconfined" name="/usr/lib/cups/backend/cups-pdf" pid=29770 comm="apparmor_parser" [383458.703615] type=1400 audit(1398746302.128:123): apparmor="STATUS" operation="profile_replace" profile="unconfined" name="/usr/sbin/cupsd" pid=29770 comm="apparmor_parser" [383458.708927] type=1400 audit(1398746302.136:124): apparmor="STATUS" operation="profile_replace" profile="unconfined" name="/usr/sbin/cupsd" pid=29770 comm="apparmor_parser" [386693.916388] wlan0: deauthenticating from 00:09:5b:d4:ec:24 by local choice (reason=3) [386693.917360] cfg80211: Calling CRDA to update world regulatory domain [386694.106504] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [386694.106550] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [386694.734967] cfg80211: World regulatory domain updated: [386694.734975] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [386694.734980] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [386694.734985] cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [386694.734989] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [386694.734993] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [386694.734997] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [386697.704396] Syncing filesystems ... done. [386697.728716] Freezing user space processes ... (elapsed 0.002 seconds) done. [386697.731511] PM: Marking nosave pages: [mem 0x0009d000-0x000fffff] [386697.731521] PM: Basic memory bitmaps created [386697.731645] PM: Preallocating image memory... done (allocated 271261 pages) [386700.501322] PM: Allocated 1085044 kbytes in 2.76 seconds (393.13 MB/s) [386700.501326] Freezing remaining freezable tasks ... (elapsed 0.838 seconds) done. [386701.340417] Suspending console(s) (use no_console_suspend to debug) [386701.972302] PM: freeze of devices complete after 631.873 msecs [386701.972770] PM: late freeze of devices complete after 0.463 msecs [386701.974192] PM: noirq freeze of devices complete after 1.418 msecs [386701.974896] ACPI: Preparing to enter system sleep state S4 [386701.979285] PM: Saving platform NVS memory [386701.979651] Disabling non-boot CPUs ... [386701.981140] kvm: disabling virtualization on CPU1 [386701.981170] smpboot: CPU 1 is now offline [386701.981908] PM: Creating hibernation image: [386701.985151] PM: Need to copy 217416 pages [386701.985151] PM: Normal pages needed: 217416 + 1024, available pages: 296154 [386701.985151] PM: Hibernation image created (217416 pages copied) [386701.985151] Enabling non-boot CPUs ... [386701.985151] x86: Booting SMP configuration: [386701.985151] smpboot: Booting Node 0 Processor 1 APIC 0x1 [386701.985151] kvm: enabling virtualization on CPU1 [386701.993488] ACPI Exception: AE_BAD_PARAMETER, Returned by Handler for [EmbeddedControl] (20131115/evregion-282) [386701.993499] ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPC_.EC__.LPMD] (Node ffff880079f73618), AE_BAD_PARAMETER (20131115/psparse-536) [386701.993509] ACPI Error: Method parse/execution failed [\_PR_.CPU0._PPC] (Node ffff880079f98b18), AE_BAD_PARAMETER (20131115/psparse-536) [386701.993518] ACPI Error: Method parse/execution failed [\_PR_.CPU1._PPC] (Node ffff880079f98938), AE_BAD_PARAMETER (20131115/psparse-536) [386701.993525] ACPI Exception: AE_BAD_PARAMETER, Evaluating _PPC (20131115/processor_perflib-140) [386701.993577] CPU1 is up [386701.996891] ACPI: Waking up from system sleep state S4 [386702.033192] PM: noirq thaw of devices complete after 0.634 msecs [386702.033497] PM: early thaw of devices complete after 0.252 msecs [386702.040112] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [386702.052141] ata2: port disabled--ignoring [386702.056278] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [386702.124239] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [386702.230524] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [386702.230528] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [386702.230933] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [386702.231367] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [386702.265569] ata1.00: configured for UDMA/33 [386702.376070] ata5: SATA link down (SStatus 0 SControl 300) [386702.376107] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [386702.377230] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [386702.377234] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [386702.377480] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [386702.377484] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [386702.379966] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [386702.379970] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [386702.380197] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [386702.380200] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [386702.381337] ata3.00: configured for UDMA/100 [386702.528054] smapi smapi: set_real_thresh: set stop to 85 for bat=0 [386702.620094] firewire_core 0000:15:00.1: rediscovered device fw0 [386702.640055] smapi smapi: set_real_thresh: set start to 64 for bat=0 [386702.752055] smapi smapi: set_real_thresh: set stop to 0 for bat=1 [386702.864053] smapi smapi: set_real_thresh: set start to 0 for bat=1 [386703.005034] thinkpad_acpi: ACPI backlight control delay disabled [386703.006732] PM: thaw of devices complete after 973.229 msecs [386703.856896] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [386703.857008] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [386710.690108] Suspending console(s) (use no_console_suspend to debug) [386710.829388] sd 2:0:0:0: [sda] Synchronizing SCSI cache [386710.829523] sd 2:0:0:0: [sda] Stopping disk [386711.392109] PM: suspend of devices complete after 701.473 msecs [386711.392466] PM: late suspend of devices complete after 0.353 msecs [386711.440411] ehci-pci 0000:00:1d.7: System wakeup enabled by ACPI [386711.456176] uhci_hcd 0000:00:1d.2: System wakeup enabled by ACPI [386711.456289] uhci_hcd 0000:00:1d.1: System wakeup enabled by ACPI [386711.457120] uhci_hcd 0000:00:1d.0: System wakeup enabled by ACPI [386711.457855] ehci-pci 0000:00:1a.7: System wakeup enabled by ACPI [386711.472175] uhci_hcd 0000:00:1a.1: System wakeup enabled by ACPI [386711.472285] uhci_hcd 0000:00:1a.0: System wakeup enabled by ACPI [386711.472394] e1000e 0000:00:19.0: System wakeup enabled by ACPI [386711.488119] PM: noirq suspend of devices complete after 95.650 msecs [386711.488792] ACPI: Preparing to enter system sleep state S3 [386711.493354] PM: Saving platform NVS memory [386711.493798] Disabling non-boot CPUs ... [386711.495263] kvm: disabling virtualization on CPU1 [386711.596038] smpboot: CPU 1 is now offline [386711.596362] ACPI: Low-level resume complete [386711.596362] PM: Restoring platform NVS memory [386711.596362] Enabling non-boot CPUs ... [386711.596362] x86: Booting SMP configuration: [386711.596362] smpboot: Booting Node 0 Processor 1 APIC 0x1 [386711.596362] kvm: enabling virtualization on CPU1 [386711.644115] CPU1 is up [386711.647425] ACPI: Waking up from system sleep state S3 [386711.748273] uhci_hcd 0000:00:1a.0: System wakeup disabled by ACPI [386711.748371] uhci_hcd 0000:00:1a.1: System wakeup disabled by ACPI [386711.764160] ehci-pci 0000:00:1a.7: System wakeup disabled by ACPI [386711.781957] uhci_hcd 0000:00:1d.0: System wakeup disabled by ACPI [386711.782058] uhci_hcd 0000:00:1d.1: System wakeup disabled by ACPI [386711.782150] uhci_hcd 0000:00:1d.2: System wakeup disabled by ACPI [386711.796127] ehci-pci 0000:00:1d.7: System wakeup disabled by ACPI [386711.892513] PM: noirq resume of devices complete after 174.311 msecs [386711.892835] PM: early resume of devices complete after 0.272 msecs [386711.896070] e1000e 0000:00:19.0: System wakeup disabled by ACPI [386711.896125] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [386711.896473] usb usb3: root hub lost power or was reset [386711.896519] usb usb4: root hub lost power or was reset [386711.896726] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [386711.896913] usb usb5: root hub lost power or was reset [386711.896955] usb usb6: root hub lost power or was reset [386711.896998] usb usb7: root hub lost power or was reset [386711.897324] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [386711.898334] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [386711.909600] ata2: port disabled--ignoring [386712.792552] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [386712.792556] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [386712.793546] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [386712.794547] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [386712.816488] ata1.00: configured for UDMA/33 [386712.816602] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [386712.892145] ata5: SATA link down (SStatus 0 SControl 300) [386713.132125] usb 3-2: reset full-speed USB device number 2 using uhci_hcd [386713.288061] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [386713.302637] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [386713.302641] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [386713.302941] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [386713.302944] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [386713.306171] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [386713.306175] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [386713.306477] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [386713.306481] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [386713.307986] ata3.00: configured for UDMA/100 [386713.312105] firewire_core 0000:15:00.1: rediscovered device fw0 [386713.324131] sd 2:0:0:0: [sda] Starting disk [386713.485023] thinkpad_acpi: ACPI backlight control delay disabled [386713.486811] PM: resume of devices complete after 1593.969 msecs [386713.632902] Restarting kernel threads ... done. [386713.633612] PM: Basic memory bitmaps freed [386713.633616] Restarting tasks ... done. [386713.642225] video LNXVIDEO:00: Restoring backlight state [386714.812948] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [386714.813063] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [391236.522552] Syncing filesystems ... done. [391236.570057] Freezing user space processes ... (elapsed 0.004 seconds) done. [391236.574864] PM: Marking nosave pages: [mem 0x0009d000-0x000fffff] [391236.574874] PM: Basic memory bitmaps created [391236.574996] PM: Preallocating image memory... done (allocated 271260 pages) [391237.447033] PM: Allocated 1085040 kbytes in 0.87 seconds (1247.17 MB/s) [391237.447038] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done. [391237.449066] Suspending console(s) (use no_console_suspend to debug) [391238.080315] PM: freeze of devices complete after 631.239 msecs [391238.080760] PM: late freeze of devices complete after 0.440 msecs [391238.082172] PM: noirq freeze of devices complete after 1.408 msecs [391238.082899] ACPI: Preparing to enter system sleep state S4 [391238.087114] PM: Saving platform NVS memory [391238.087486] Disabling non-boot CPUs ... [391238.088994] kvm: disabling virtualization on CPU1 [391238.089016] smpboot: CPU 1 is now offline [391238.089707] PM: Creating hibernation image: [391238.093005] PM: Need to copy 207458 pages [391238.093005] PM: Normal pages needed: 207458 + 1024, available pages: 306114 [391238.093005] PM: Hibernation image created (207458 pages copied) [391238.093005] Enabling non-boot CPUs ... [391238.093005] x86: Booting SMP configuration: [391238.093005] smpboot: Booting Node 0 Processor 1 APIC 0x1 [391238.093005] kvm: enabling virtualization on CPU1 [391238.101283] ACPI Exception: AE_BAD_PARAMETER, Returned by Handler for [EmbeddedControl] (20131115/evregion-282) [391238.101294] ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPC_.EC__.LPMD] (Node ffff880079f73618), AE_BAD_PARAMETER (20131115/psparse-536) [391238.101304] ACPI Error: Method parse/execution failed [\_PR_.CPU0._PPC] (Node ffff880079f98b18), AE_BAD_PARAMETER (20131115/psparse-536) [391238.101313] ACPI Error: Method parse/execution failed [\_PR_.CPU1._PPC] (Node ffff880079f98938), AE_BAD_PARAMETER (20131115/psparse-536) [391238.101320] ACPI Exception: AE_BAD_PARAMETER, Evaluating _PPC (20131115/processor_perflib-140) [391238.101371] CPU1 is up [391238.104673] ACPI: Waking up from system sleep state S4 [391238.139266] PM: noirq thaw of devices complete after 0.634 msecs [391238.139571] PM: early thaw of devices complete after 0.252 msecs [391238.144101] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [391238.161549] ata2: port disabled--ignoring [391238.177055] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [391238.228200] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [391238.324524] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [391238.324528] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [391238.324942] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [391238.325375] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [391238.348476] ata1.00: configured for UDMA/33 [391238.480069] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [391238.480094] ata5: SATA link down (SStatus 0 SControl 300) [391238.481171] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [391238.481176] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [391238.481420] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [391238.481424] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [391238.484700] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [391238.484704] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [391238.484965] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [391238.484968] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [391238.486101] ata3.00: configured for UDMA/100 [391238.628054] smapi smapi: set_real_thresh: set stop to 85 for bat=0 [391238.740066] smapi smapi: set_real_thresh: set start to 64 for bat=0 [391238.740738] firewire_core 0000:15:00.1: rediscovered device fw0 [391238.852054] smapi smapi: set_real_thresh: set stop to 0 for bat=1 [391238.964053] smapi smapi: set_real_thresh: set start to 0 for bat=1 [391239.105010] thinkpad_acpi: ACPI backlight control delay disabled [391239.106713] PM: thaw of devices complete after 967.136 msecs [391239.960897] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [391239.961008] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [391247.292181] Suspending console(s) (use no_console_suspend to debug) [391247.444777] sd 2:0:0:0: [sda] Synchronizing SCSI cache [391247.444947] sd 2:0:0:0: [sda] Stopping disk [391248.020099] PM: suspend of devices complete after 727.378 msecs [391248.020455] PM: late suspend of devices complete after 0.352 msecs [391248.068416] ehci-pci 0000:00:1d.7: System wakeup enabled by ACPI [391248.084171] uhci_hcd 0000:00:1d.2: System wakeup enabled by ACPI [391248.084284] uhci_hcd 0000:00:1d.1: System wakeup enabled by ACPI [391248.085211] uhci_hcd 0000:00:1d.0: System wakeup enabled by ACPI [391248.085946] ehci-pci 0000:00:1a.7: System wakeup enabled by ACPI [391248.100177] uhci_hcd 0000:00:1a.1: System wakeup enabled by ACPI [391248.100288] uhci_hcd 0000:00:1a.0: System wakeup enabled by ACPI [391248.100398] e1000e 0000:00:19.0: System wakeup enabled by ACPI [391248.116121] PM: noirq suspend of devices complete after 95.662 msecs [391248.116803] ACPI: Preparing to enter system sleep state S3 [391248.121554] PM: Saving platform NVS memory [391248.122015] Disabling non-boot CPUs ... [391248.123617] kvm: disabling virtualization on CPU1 [391248.224046] smpboot: CPU 1 is now offline [391248.224389] ACPI: Low-level resume complete [391248.224389] PM: Restoring platform NVS memory [391248.224389] Enabling non-boot CPUs ... [391248.224389] x86: Booting SMP configuration: [391248.224389] smpboot: Booting Node 0 Processor 1 APIC 0x1 [391248.224389] kvm: enabling virtualization on CPU1 [391248.276119] CPU1 is up [391248.279438] ACPI: Waking up from system sleep state S3 [391248.384238] uhci_hcd 0000:00:1a.0: System wakeup disabled by ACPI [391248.384333] uhci_hcd 0000:00:1a.1: System wakeup disabled by ACPI [391248.400159] ehci-pci 0000:00:1a.7: System wakeup disabled by ACPI [391248.417992] uhci_hcd 0000:00:1d.0: System wakeup disabled by ACPI [391248.418084] uhci_hcd 0000:00:1d.1: System wakeup disabled by ACPI [391248.418182] uhci_hcd 0000:00:1d.2: System wakeup disabled by ACPI [391248.432136] ehci-pci 0000:00:1d.7: System wakeup disabled by ACPI [391248.528505] PM: noirq resume of devices complete after 176.453 msecs [391248.528809] PM: early resume of devices complete after 0.253 msecs [391248.529010] e1000e 0000:00:19.0: System wakeup disabled by ACPI [391248.529080] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [391248.529424] usb usb3: root hub lost power or was reset [391248.529468] usb usb4: root hub lost power or was reset [391248.529671] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [391248.539886] usb usb5: root hub lost power or was reset [391248.539929] usb usb6: root hub lost power or was reset [391248.539973] usb usb7: root hub lost power or was reset [391248.540318] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [391248.541329] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [391248.543171] ata2: port disabled--ignoring [391249.428573] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [391249.428577] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [391249.429550] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [391249.430551] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [391249.452471] ata1.00: configured for UDMA/33 [391249.456221] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [391249.532074] ata5: SATA link down (SStatus 0 SControl 300) [391249.740123] usb 3-2: reset full-speed USB device number 2 using uhci_hcd [391249.920096] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [391249.920111] firewire_core 0000:15:00.1: rediscovered device fw0 [391249.930421] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [391249.930425] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [391249.930725] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [391249.930729] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [391249.933905] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [391249.933909] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [391249.934193] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [391249.934197] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [391249.935686] ata3.00: configured for UDMA/100 [391249.948104] sd 2:0:0:0: [sda] Starting disk [391250.112993] thinkpad_acpi: ACPI backlight control delay disabled [391250.114802] PM: resume of devices complete after 1585.987 msecs [391250.251319] Restarting kernel threads ... done. [391250.251973] PM: Basic memory bitmaps freed [391250.251978] Restarting tasks ... done. [391250.261478] video LNXVIDEO:00: Restoring backlight state [391251.096952] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [391251.097068] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [391258.398890] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [391259.058257] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [391259.160169] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [391259.160329] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [391259.172022] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [391260.501006] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [391260.501127] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [391260.501185] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [391263.589854] wlan0: authenticate with 00:09:5b:d4:ec:24 [391263.590109] wlan0: send auth to 00:09:5b:d4:ec:24 (try 1/3) [391263.591781] wlan0: authenticated [391263.591984] ath5k 0000:03:00.0 wlan0: disabling HT/VHT due to WEP/TKIP use [391263.591991] ath5k 0000:03:00.0 wlan0: disabling HT as WMM/QoS is not supported by the AP [391263.591996] ath5k 0000:03:00.0 wlan0: disabling VHT as WMM/QoS is not supported by the AP [391263.596047] wlan0: associate with 00:09:5b:d4:ec:24 (try 1/3) [391263.598207] wlan0: RX AssocResp from 00:09:5b:d4:ec:24 (capab=0x431 status=0 aid=3) [391263.598559] wlan0: associated [391263.598603] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [394008.588541] wlan0: deauthenticating from 00:09:5b:d4:ec:24 by local choice (reason=3) [394008.592518] cfg80211: Calling CRDA to update world regulatory domain [394008.630129] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [394008.630174] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [394009.213645] cfg80211: World regulatory domain updated: [394009.213652] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [394009.213658] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [394009.213662] cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [394009.213666] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [394009.213671] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [394009.213675] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [394011.550453] Syncing filesystems ... done. [394011.567394] Freezing user space processes ... (elapsed 0.002 seconds) done. [394011.570252] PM: Marking nosave pages: [mem 0x0009d000-0x000fffff] [394011.570262] PM: Basic memory bitmaps created [394011.570384] PM: Preallocating image memory... done (allocated 271261 pages) [394012.358259] PM: Allocated 1085044 kbytes in 0.78 seconds (1391.08 MB/s) [394012.358264] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done. [394012.360373] Suspending console(s) (use no_console_suspend to debug) [394012.952151] PM: freeze of devices complete after 591.768 msecs [394012.952534] PM: late freeze of devices complete after 0.378 msecs [394012.953938] PM: noirq freeze of devices complete after 1.399 msecs [394012.954644] ACPI: Preparing to enter system sleep state S4 [394012.958891] PM: Saving platform NVS memory [394012.959270] Disabling non-boot CPUs ... [394012.960767] kvm: disabling virtualization on CPU1 [394012.960789] smpboot: CPU 1 is now offline [394012.961459] PM: Creating hibernation image: [394012.964777] PM: Need to copy 222261 pages [394012.964777] PM: Normal pages needed: 222261 + 1024, available pages: 291299 [394012.964777] PM: Restoring platform NVS memory [394012.964777] Enabling non-boot CPUs ... [394012.964777] x86: Booting SMP configuration: [394012.964777] smpboot: Booting Node 0 Processor 1 APIC 0x1 [394012.964777] kvm: enabling virtualization on CPU1 [394013.004057] CPU1 is up [394013.006111] ACPI: Waking up from system sleep state S4 [394013.068597] PM: noirq restore of devices complete after 31.710 msecs [394013.068785] PM: early restore of devices complete after 0.147 msecs [394013.132101] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [394013.132445] usb usb4: root hub lost power or was reset [394013.132499] usb usb3: root hub lost power or was reset [394013.132528] usb usb1: root hub lost power or was reset [394013.136763] ehci-pci 0000:00:1a.7: cache line size of 64 is not supported [394013.136889] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [394013.146970] usb usb5: root hub lost power or was reset [394013.147009] usb usb6: root hub lost power or was reset [394013.147046] usb usb7: root hub lost power or was reset [394013.147075] usb usb2: root hub lost power or was reset [394013.151330] ehci-pci 0000:00:1d.7: cache line size of 64 is not supported [394013.152799] ata2: port disabled--ignoring [394013.228206] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [394013.316504] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [394013.316506] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [394013.316912] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [394013.317346] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [394013.340449] ata1.00: configured for UDMA/33 [394013.472083] ata5: SATA link down (SStatus 0 SControl 300) [394013.472107] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [394013.473153] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [394013.473155] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [394013.473385] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [394013.473387] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [394013.475756] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [394013.475759] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [394013.476000] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [394013.476022] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [394013.477171] ata3.00: configured for UDMA/100 [394013.492098] sd 2:0:0:0: [sda] Starting disk [394013.592108] usb 3-2: reset full-speed USB device number 2 using uhci_hcd [394013.628026] smapi smapi: set_real_thresh: set stop to 85 for bat=0 [394013.712090] firewire_core 0000:15:00.1: rediscovered device fw0 [394013.740068] smapi smapi: set_real_thresh: set start to 64 for bat=0 [394013.852077] smapi smapi: set_real_thresh: set stop to 0 for bat=1 [394013.964040] smapi smapi: set_real_thresh: set start to 0 for bat=1 [394014.104738] thinkpad_acpi: ACPI backlight control delay disabled [394014.105787] PM: restore of devices complete after 976.319 msecs [394014.113814] Restarting kernel threads ... done. [394014.114309] PM: Basic memory bitmaps freed [394014.114327] usb 1-4: USB disconnect, device number 4 [394014.114311] Restarting tasks ... done. [394014.121072] video LNXVIDEO:00: Restoring backlight state [394026.622712] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [394027.002455] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [394027.104189] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [394027.104437] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [394027.116739] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [394031.214991] wlan0: authenticate with f8:4f:57:36:a7:20 [394031.219319] wlan0: direct probe to f8:4f:57:36:a7:20 (try 1/3) [394031.420085] wlan0: direct probe to f8:4f:57:36:a7:20 (try 2/3) [394031.624116] wlan0: direct probe to f8:4f:57:36:a7:20 (try 3/3) [394031.828102] wlan0: authentication with f8:4f:57:36:a7:20 timed out [394032.049314] wlan0: authenticate with 84:78:ac:e8:6c:60 [394032.053257] wlan0: send auth to 84:78:ac:e8:6c:60 (try 1/3) [394032.057997] wlan0: authenticated [394032.060164] wlan0: associate with 84:78:ac:e8:6c:60 (try 1/3) [394032.070814] wlan0: RX AssocResp from 84:78:ac:e8:6c:60 (capab=0x421 status=0 aid=5) [394032.071068] wlan0: associated [394032.071104] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [394032.071152] cfg80211: Calling CRDA for country: US [394032.358504] ath: EEPROM regdomain: 0x8348 [394032.358509] ath: EEPROM indicates we should expect a country code [394032.358512] ath: doing EEPROM country->regdmn map search [394032.358515] ath: country maps to regdmn code: 0x3a [394032.358517] ath: Country alpha2 being used: US [394032.358519] ath: Regpair used: 0x3a [394032.358522] ath: regdomain 0x8348 dynamically updated by country IE [394032.358524] cfg80211: Regulatory domain changed to country: US [394032.358527] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [394032.358530] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2700 mBm) [394032.358534] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 1700 mBm) [394032.358537] cfg80211: (5250000 KHz - 5330000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [394032.358540] cfg80211: (5490000 KHz - 5600000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [394032.358543] cfg80211: (5650000 KHz - 5710000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [394032.358547] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 3000 mBm) [394032.358550] cfg80211: (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 4000 mBm) [394034.530559] wlan0: deauthenticated from 84:78:ac:e8:6c:60 (Reason: 7) [394034.536495] cfg80211: Calling CRDA to update world regulatory domain [394034.537275] wlan0: authenticate with 84:78:ac:e8:6c:60 [394034.537595] wlan0: send auth to 84:78:ac:e8:6c:60 (try 1/3) [394034.538624] wlan0: authenticated [394034.540308] wlan0: associate with 84:78:ac:e8:6c:60 (try 1/3) [394034.544254] cfg80211: World regulatory domain updated: [394034.544260] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [394034.544266] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [394034.544270] cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [394034.544274] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [394034.544279] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [394034.544283] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [394034.551514] wlan0: RX AssocResp from 84:78:ac:e8:6c:60 (capab=0x421 status=0 aid=5) [394034.551740] wlan0: associated [394034.551803] cfg80211: Calling CRDA for country: US [394034.555531] ath: EEPROM regdomain: 0x8348 [394034.555535] ath: EEPROM indicates we should expect a country code [394034.555537] ath: doing EEPROM country->regdmn map search [394034.555539] ath: country maps to regdmn code: 0x3a [394034.555541] ath: Country alpha2 being used: US [394034.555543] ath: Regpair used: 0x3a [394034.555545] ath: regdomain 0x8348 dynamically updated by country IE [394034.555547] cfg80211: Regulatory domain changed to country: US [394034.555549] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [394034.555552] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2700 mBm) [394034.555554] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 1700 mBm) [394034.555557] cfg80211: (5250000 KHz - 5330000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [394034.555559] cfg80211: (5490000 KHz - 5600000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [394034.555562] cfg80211: (5650000 KHz - 5710000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [394034.555564] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 3000 mBm) [394034.555567] cfg80211: (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 4000 mBm) [394126.888498] cfg80211: Calling CRDA to update world regulatory domain [394126.898555] cfg80211: World regulatory domain updated: [394126.898564] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [394126.898572] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [394126.898578] cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [394126.898585] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [394126.898591] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [394126.898597] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [394127.100965] wlan0: authenticate with f8:4f:57:36:a7:2f [394127.110399] wlan0: direct probe to f8:4f:57:36:a7:2f (try 1/3) [394127.312067] wlan0: send auth to f8:4f:57:36:a7:2f (try 2/3) [394127.327196] wlan0: send auth to f8:4f:57:36:a7:2f (try 3/3) [394127.335424] wlan0: authentication with f8:4f:57:36:a7:2f timed out [394131.070073] wlan0: authenticate with f8:4f:57:36:a7:2f [394131.076128] wlan0: direct probe to f8:4f:57:36:a7:2f (try 1/3) [394131.280109] wlan0: direct probe to f8:4f:57:36:a7:2f (try 2/3) [394131.484103] wlan0: direct probe to f8:4f:57:36:a7:2f (try 3/3) [394131.688101] wlan0: authentication with f8:4f:57:36:a7:2f timed out [394132.757172] wlan0: authenticate with 84:78:ac:e8:6c:60 [394132.767003] wlan0: send auth to 84:78:ac:e8:6c:60 (try 1/3) [394132.788506] wlan0: authenticated [394132.792112] wlan0: associate with 84:78:ac:e8:6c:60 (try 1/3) [394132.916105] wlan0: associate with 84:78:ac:e8:6c:60 (try 2/3) [394132.935624] wlan0: RX AssocResp from 84:78:ac:e8:6c:60 (capab=0x421 status=0 aid=5) [394132.936091] wlan0: associated [394132.937659] cfg80211: Calling CRDA for country: US [394132.947222] ath: EEPROM regdomain: 0x8348 [394132.947230] ath: EEPROM indicates we should expect a country code [394132.947236] ath: doing EEPROM country->regdmn map search [394132.947241] ath: country maps to regdmn code: 0x3a [394132.947246] ath: Country alpha2 being used: US [394132.947250] ath: Regpair used: 0x3a [394132.947256] ath: regdomain 0x8348 dynamically updated by country IE [394132.947261] cfg80211: Regulatory domain changed to country: US [394132.947265] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [394132.947272] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2700 mBm) [394132.947279] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 1700 mBm) [394132.947285] cfg80211: (5250000 KHz - 5330000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [394132.947291] cfg80211: (5490000 KHz - 5600000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [394132.947298] cfg80211: (5650000 KHz - 5710000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [394132.947304] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 3000 mBm) [394132.947310] cfg80211: (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 4000 mBm) [394181.326798] wlan0: deauthenticating from 84:78:ac:e8:6c:60 by local choice (reason=3) [394181.327219] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [394181.327915] cfg80211: Calling CRDA to update world regulatory domain [394181.332670] cfg80211: World regulatory domain updated: [394181.332675] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [394181.332678] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [394181.332681] cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [394181.332684] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [394181.332686] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [394181.332689] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [394185.013837] wlan0: authenticate with 00:03:52:94:76:50 [394185.032628] wlan0: send auth to 00:03:52:94:76:50 (try 1/3) [394185.034027] wlan0: authenticated [394185.040049] wlan0: associate with 00:03:52:94:76:50 (try 1/3) [394185.043308] wlan0: RX AssocResp from 00:03:52:94:76:50 (capab=0xc21 status=0 aid=11) [394185.043548] wlan0: associated [402780.002468] ath5k: ath5k_hw_get_isr: ISR: 0x00000080 IMR: 0x00000000 [403991.564129] ath5k: ath5k_hw_get_isr: ISR: 0x00000001 IMR: 0x00000000 [404501.360490] wlan0: deauthenticating from 00:03:52:94:76:50 by local choice (reason=3) [404501.361209] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [404501.362707] cfg80211: Calling CRDA to update world regulatory domain [404501.371535] cfg80211: World regulatory domain updated: [404501.371539] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [404501.371542] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [404501.371545] cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [404501.371548] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [404501.371550] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [404501.371553] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [404501.494123] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [404501.494189] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [404504.358009] Syncing filesystems ... done. [404504.462941] Freezing user space processes ... (elapsed 0.002 seconds) done. [404504.465262] PM: Marking nosave pages: [mem 0x0009d000-0x000fffff] [404504.465268] PM: Basic memory bitmaps created [404504.465355] PM: Preallocating image memory... done (allocated 271261 pages) [404506.614829] PM: Allocated 1085044 kbytes in 2.14 seconds (507.02 MB/s) [404506.614833] Freezing remaining freezable tasks ... (elapsed 0.633 seconds) done. [404507.248571] Suspending console(s) (use no_console_suspend to debug) [404507.880264] PM: freeze of devices complete after 631.685 msecs [404507.880560] PM: late freeze of devices complete after 0.292 msecs [404507.881695] PM: noirq freeze of devices complete after 1.133 msecs [404507.882181] ACPI: Preparing to enter system sleep state S4 [404507.885966] PM: Saving platform NVS memory [404507.886238] Disabling non-boot CPUs ... [404507.887623] kvm: disabling virtualization on CPU1 [404507.988047] smpboot: CPU 1 is now offline [404507.988571] PM: Creating hibernation image: [404507.992014] PM: Need to copy 224222 pages [404507.992014] PM: Normal pages needed: 224222 + 1024, available pages: 289355 [404507.992014] PM: Restoring platform NVS memory [404507.992014] Enabling non-boot CPUs ... [404507.992014] x86: Booting SMP configuration: [404507.992014] smpboot: Booting Node 0 Processor 1 APIC 0x1 [404507.992014] kvm: enabling virtualization on CPU1 [404508.040123] CPU1 is up [404508.043399] ACPI: Waking up from system sleep state S4 [404508.112695] PM: noirq restore of devices complete after 36.774 msecs [404508.112998] PM: early restore of devices complete after 0.253 msecs [404508.222581] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [404508.222932] usb usb3: root hub lost power or was reset [404508.222976] usb usb4: root hub lost power or was reset [404508.223026] usb usb1: root hub lost power or was reset [404508.227317] ehci-pci 0000:00:1a.7: cache line size of 64 is not supported [404508.227497] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [404508.227676] usb usb5: root hub lost power or was reset [404508.227717] usb usb6: root hub lost power or was reset [404508.227758] usb usb7: root hub lost power or was reset [404508.227796] usb usb2: root hub lost power or was reset [404508.232136] ehci-pci 0000:00:1d.7: cache line size of 64 is not supported [404508.242383] ata2: port disabled--ignoring [404508.316190] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [404508.412536] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [404508.412540] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [404508.412939] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [404508.413373] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [404508.437287] ata1.00: configured for UDMA/33 [404508.564072] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [404508.565193] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [404508.565197] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [404508.565437] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [404508.565441] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [404508.567846] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [404508.567850] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [404508.568065] ata5: SATA link down (SStatus 0 SControl 300) [404508.568099] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [404508.568103] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [404508.569192] ata3.00: configured for UDMA/100 [404508.584164] sd 2:0:0:0: [sda] Starting disk [404508.680111] usb 3-2: reset full-speed USB device number 2 using uhci_hcd [404508.712057] smapi smapi: set_real_thresh: set stop to 85 for bat=0 [404508.804085] firewire_core 0000:15:00.1: rediscovered device fw0 [404508.824079] smapi smapi: set_real_thresh: set start to 64 for bat=0 [404508.936046] smapi smapi: set_real_thresh: set stop to 0 for bat=1 [404509.048047] smapi smapi: set_real_thresh: set start to 0 for bat=1 [404509.188973] thinkpad_acpi: ACPI backlight control delay disabled [404509.190708] PM: restore of devices complete after 968.601 msecs [404509.205279] Restarting kernel threads ... done. [404509.205685] PM: Basic memory bitmaps freed [404509.205689] Restarting tasks ... done. [404509.214976] video LNXVIDEO:00: Restoring backlight state [404509.320424] usb 1-4: new high-speed USB device number 5 using ehci-pci [404509.452454] usb 1-4: New USB device found, idVendor=04b3, idProduct=4485 [404509.452461] usb 1-4: New USB device strings: Mfr=0, Product=0, SerialNumber=0 [404509.452750] hub 1-4:1.0: USB hub found [404509.452814] hub 1-4:1.0: 4 ports detected [404510.032911] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [404510.033025] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [404510.033064] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [404532.062802] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [404532.442321] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [404532.544159] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [404532.544311] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [404532.555889] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [404533.884956] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [404533.885072] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [404533.885119] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [404537.070984] wlan0: authenticate with 00:09:5b:d4:ec:24 [404537.076002] wlan0: send auth to 00:09:5b:d4:ec:24 (try 1/3) [404537.077555] wlan0: authenticated [404537.078350] ath5k 0000:03:00.0 wlan0: disabling HT/VHT due to WEP/TKIP use [404537.078357] ath5k 0000:03:00.0 wlan0: disabling HT as WMM/QoS is not supported by the AP [404537.078362] ath5k 0000:03:00.0 wlan0: disabling VHT as WMM/QoS is not supported by the AP [404537.080079] wlan0: associate with 00:09:5b:d4:ec:24 (try 1/3) [404537.082346] wlan0: RX AssocResp from 00:09:5b:d4:ec:24 (capab=0x431 status=0 aid=2) [404537.082692] wlan0: associated [404537.082731] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [405929.008503] ath5k: ath5k_hw_get_isr: ISR: 0x00000400 IMR: 0x00000000 [405999.703207] type=1400 audit(1398832175.711:125): apparmor="STATUS" operation="profile_replace" profile="unconfined" name="/usr/lib/cups/backend/cups-pdf" pid=3395 comm="apparmor_parser" [405999.703224] type=1400 audit(1398832175.711:126): apparmor="STATUS" operation="profile_replace" profile="unconfined" name="/usr/sbin/cupsd" pid=3395 comm="apparmor_parser" [405999.704136] type=1400 audit(1398832175.715:127): apparmor="STATUS" operation="profile_replace" profile="unconfined" name="/usr/sbin/cupsd" pid=3395 comm="apparmor_parser" [408487.557071] wlan0: deauthenticating from 00:09:5b:d4:ec:24 by local choice (reason=3) [408487.559099] cfg80211: Calling CRDA to update world regulatory domain [408488.164200] cfg80211: World regulatory domain updated: [408488.164208] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [408488.164213] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [408488.164218] cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [408488.164222] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [408488.164226] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [408488.164230] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [408488.230632] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [408488.230679] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [408491.497491] Syncing filesystems ... done. [408491.527721] Freezing user space processes ... (elapsed 0.002 seconds) done. [408491.530505] PM: Marking nosave pages: [mem 0x0009d000-0x000fffff] [408491.530514] PM: Basic memory bitmaps created [408491.530637] PM: Preallocating image memory... done (allocated 271259 pages) [408495.536228] PM: Allocated 1085036 kbytes in 4.00 seconds (271.25 MB/s) [408495.536233] Freezing remaining freezable tasks ... (elapsed 1.115 seconds) done. [408496.651929] Suspending console(s) (use no_console_suspend to debug) [408497.284318] PM: freeze of devices complete after 632.377 msecs [408497.284757] PM: late freeze of devices complete after 0.435 msecs [408497.286175] PM: noirq freeze of devices complete after 1.413 msecs [408497.286883] ACPI: Preparing to enter system sleep state S4 [408497.291082] PM: Saving platform NVS memory [408497.291453] Disabling non-boot CPUs ... [408497.292855] kvm: disabling virtualization on CPU1 [408497.292885] smpboot: CPU 1 is now offline [408497.293588] PM: Creating hibernation image: [408497.296866] PM: Need to copy 220775 pages [408497.296866] PM: Normal pages needed: 220775 + 1024, available pages: 292794 [408497.296866] PM: Hibernation image created (220775 pages copied) [408497.296866] Enabling non-boot CPUs ... [408497.296866] x86: Booting SMP configuration: [408497.296866] smpboot: Booting Node 0 Processor 1 APIC 0x1 [408497.296866] kvm: enabling virtualization on CPU1 [408497.305186] ACPI Exception: AE_BAD_PARAMETER, Returned by Handler for [EmbeddedControl] (20131115/evregion-282) [408497.305197] ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPC_.EC__.LPMD] (Node ffff880079f73618), AE_BAD_PARAMETER (20131115/psparse-536) [408497.305207] ACPI Error: Method parse/execution failed [\_PR_.CPU0._PPC] (Node ffff880079f98b18), AE_BAD_PARAMETER (20131115/psparse-536) [408497.305216] ACPI Error: Method parse/execution failed [\_PR_.CPU1._PPC] (Node ffff880079f98938), AE_BAD_PARAMETER (20131115/psparse-536) [408497.305223] ACPI Exception: AE_BAD_PARAMETER, Evaluating _PPC (20131115/processor_perflib-140) [408497.305271] CPU1 is up [408497.308572] ACPI: Waking up from system sleep state S4 [408497.345046] PM: noirq thaw of devices complete after 0.633 msecs [408497.345350] PM: early thaw of devices complete after 0.252 msecs [408497.348101] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [408497.364254] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [408497.364438] ata2: port disabled--ignoring [408497.432195] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [408497.524586] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [408497.524590] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [408497.525012] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [408497.525505] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [408497.548465] ata1.00: configured for UDMA/33 [408497.684073] ata5: SATA link down (SStatus 0 SControl 300) [408497.688061] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [408497.689168] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [408497.689172] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [408497.689413] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [408497.689417] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [408497.691871] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [408497.691875] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [408497.692095] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [408497.692100] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [408497.693263] ata3.00: configured for UDMA/100 [408497.832053] smapi smapi: set_real_thresh: set stop to 85 for bat=0 [408497.928089] firewire_core 0000:15:00.1: rediscovered device fw0 [408497.944050] smapi smapi: set_real_thresh: set start to 64 for bat=0 [408498.056050] smapi smapi: set_real_thresh: set stop to 0 for bat=1 [408498.168051] smapi smapi: set_real_thresh: set start to 0 for bat=1 [408498.309034] thinkpad_acpi: ACPI backlight control delay disabled [408498.310770] PM: thaw of devices complete after 965.413 msecs [408499.180895] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [408499.181007] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [408505.801150] Suspending console(s) (use no_console_suspend to debug) [408505.957830] sd 2:0:0:0: [sda] Synchronizing SCSI cache [408505.957999] sd 2:0:0:0: [sda] Stopping disk [408506.504129] PM: suspend of devices complete after 702.452 msecs [408506.504483] PM: late suspend of devices complete after 0.349 msecs [408506.552416] ehci-pci 0000:00:1d.7: System wakeup enabled by ACPI [408506.568173] uhci_hcd 0000:00:1d.2: System wakeup enabled by ACPI [408506.568285] uhci_hcd 0000:00:1d.1: System wakeup enabled by ACPI [408506.569277] uhci_hcd 0000:00:1d.0: System wakeup enabled by ACPI [408506.570011] ehci-pci 0000:00:1a.7: System wakeup enabled by ACPI [408506.584170] uhci_hcd 0000:00:1a.1: System wakeup enabled by ACPI [408506.584281] uhci_hcd 0000:00:1a.0: System wakeup enabled by ACPI [408506.584391] e1000e 0000:00:19.0: System wakeup enabled by ACPI [408506.600120] PM: noirq suspend of devices complete after 95.634 msecs [408506.600793] ACPI: Preparing to enter system sleep state S3 [408506.605487] PM: Saving platform NVS memory [408506.605983] Disabling non-boot CPUs ... [408506.607580] kvm: disabling virtualization on CPU1 [408506.708040] smpboot: CPU 1 is now offline [408506.708394] ACPI: Low-level resume complete [408506.708394] PM: Restoring platform NVS memory [408506.708394] Enabling non-boot CPUs ... [408506.708394] x86: Booting SMP configuration: [408506.708394] smpboot: Booting Node 0 Processor 1 APIC 0x1 [408506.708394] kvm: enabling virtualization on CPU1 [408506.760135] CPU1 is up [408506.763449] ACPI: Waking up from system sleep state S3 [408506.872247] uhci_hcd 0000:00:1a.0: System wakeup disabled by ACPI [408506.872341] uhci_hcd 0000:00:1a.1: System wakeup disabled by ACPI [408506.888153] ehci-pci 0000:00:1a.7: System wakeup disabled by ACPI [408506.905999] uhci_hcd 0000:00:1d.0: System wakeup disabled by ACPI [408506.906096] uhci_hcd 0000:00:1d.1: System wakeup disabled by ACPI [408506.906192] uhci_hcd 0000:00:1d.2: System wakeup disabled by ACPI [408506.920135] ehci-pci 0000:00:1d.7: System wakeup disabled by ACPI [408507.016505] PM: noirq resume of devices complete after 175.592 msecs [408507.016829] PM: early resume of devices complete after 0.272 msecs [408507.020060] e1000e 0000:00:19.0: System wakeup disabled by ACPI [408507.020114] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [408507.020468] usb usb3: root hub lost power or was reset [408507.020514] usb usb4: root hub lost power or was reset [408507.020728] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [408507.020902] usb usb5: root hub lost power or was reset [408507.020945] usb usb6: root hub lost power or was reset [408507.020988] usb usb7: root hub lost power or was reset [408507.031367] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [408507.032382] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [408507.034378] ata2: port disabled--ignoring [408507.912528] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [408507.912531] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [408507.913505] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [408507.914490] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [408507.936458] ata1.00: configured for UDMA/33 [408507.944197] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [408508.016070] ata5: SATA link down (SStatus 0 SControl 300) [408508.224126] usb 3-2: reset full-speed USB device number 2 using uhci_hcd [408508.404210] firewire_core 0000:15:00.1: rediscovered device fw0 [408508.408085] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [408508.420309] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [408508.420313] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [408508.420594] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [408508.420598] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [408508.423822] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [408508.423826] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [408508.424123] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [408508.424126] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [408508.425619] ata3.00: configured for UDMA/100 [408508.440126] sd 2:0:0:0: [sda] Starting disk [408508.605024] thinkpad_acpi: ACPI backlight control delay disabled [408508.607063] PM: resume of devices complete after 1590.229 msecs [408508.750160] Restarting kernel threads ... done. [408508.750495] PM: Basic memory bitmaps freed [408508.750499] Restarting tasks ... done. [408508.759817] video LNXVIDEO:00: Restoring backlight state [408509.624943] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [408509.625058] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [408673.135224] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [408673.638482] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [408673.740193] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [408673.740437] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [408673.754680] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [408675.104991] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [408675.105113] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [408675.105171] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [408677.780397] wlan0: authenticate with 00:09:5b:d4:ec:24 [408677.780654] wlan0: send auth to 00:09:5b:d4:ec:24 (try 1/3) [408677.782239] wlan0: authenticated [408677.782676] ath5k 0000:03:00.0 wlan0: disabling HT/VHT due to WEP/TKIP use [408677.782683] ath5k 0000:03:00.0 wlan0: disabling HT as WMM/QoS is not supported by the AP [408677.782689] ath5k 0000:03:00.0 wlan0: disabling VHT as WMM/QoS is not supported by the AP [408677.784120] wlan0: associate with 00:09:5b:d4:ec:24 (try 1/3) [408677.786281] wlan0: RX AssocResp from 00:09:5b:d4:ec:24 (capab=0x431 status=0 aid=3) [408677.786632] wlan0: associated [408677.786671] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [415408.622327] wlan0: deauthenticating from 00:09:5b:d4:ec:24 by local choice (reason=3) [415408.623086] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [415408.624911] cfg80211: Calling CRDA to update world regulatory domain [415408.806169] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [415408.806214] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [415409.495016] cfg80211: World regulatory domain updated: [415409.495023] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [415409.495029] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [415409.495033] cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [415409.495037] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [415409.495042] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [415409.495046] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [415411.797130] Syncing filesystems ... done. [415411.843367] Freezing user space processes ... (elapsed 0.004 seconds) done. [415411.848308] PM: Marking nosave pages: [mem 0x0009d000-0x000fffff] [415411.848318] PM: Basic memory bitmaps created [415411.848440] PM: Preallocating image memory... done (allocated 271251 pages) [415415.111769] PM: Allocated 1085004 kbytes in 3.26 seconds (332.82 MB/s) [415415.111773] Freezing remaining freezable tasks ... (elapsed 1.653 seconds) done. [415416.766260] Suspending console(s) (use no_console_suspend to debug) [415417.396377] PM: freeze of devices complete after 630.105 msecs [415417.396828] PM: late freeze of devices complete after 0.446 msecs [415417.398236] PM: noirq freeze of devices complete after 1.405 msecs [415417.398942] ACPI: Preparing to enter system sleep state S4 [415417.403143] PM: Saving platform NVS memory [415417.403522] Disabling non-boot CPUs ... [415417.404923] kvm: disabling virtualization on CPU1 [415417.404953] smpboot: CPU 1 is now offline [415417.405657] PM: Creating hibernation image: [415417.408933] PM: Need to copy 212102 pages [415417.408933] PM: Normal pages needed: 212102 + 1024, available pages: 301472 [415417.408933] PM: Restoring platform NVS memory [415417.408933] Enabling non-boot CPUs ... [415417.408933] x86: Booting SMP configuration: [415417.408933] smpboot: Booting Node 0 Processor 1 APIC 0x1 [415417.408933] kvm: enabling virtualization on CPU1 [415417.456136] CPU1 is up [415417.459403] ACPI: Waking up from system sleep state S4 [415417.524669] PM: noirq restore of devices complete after 32.571 msecs [415417.524973] PM: early restore of devices complete after 0.253 msecs [415417.635152] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [415417.635501] usb usb3: root hub lost power or was reset [415417.635545] usb usb4: root hub lost power or was reset [415417.635593] usb usb1: root hub lost power or was reset [415417.639880] ehci-pci 0000:00:1a.7: cache line size of 64 is not supported [415417.650022] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [415417.650356] usb usb5: root hub lost power or was reset [415417.650399] usb usb6: root hub lost power or was reset [415417.650441] usb usb7: root hub lost power or was reset [415417.650480] usb usb2: root hub lost power or was reset [415417.654820] ehci-pci 0000:00:1d.7: cache line size of 64 is not supported [415417.656510] ata2: port disabled--ignoring [415417.728248] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [415417.830502] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [415417.830506] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [415417.830984] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [415417.831403] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [415417.852424] ata1.00: configured for UDMA/33 [415417.980058] ata5: SATA link down (SStatus 0 SControl 300) [415417.980127] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [415417.981217] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [415417.981222] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [415417.981444] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [415417.981447] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [415417.983867] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [415417.983870] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [415417.984087] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [415417.984091] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [415417.985196] ata3.00: configured for UDMA/100 [415418.004146] sd 2:0:0:0: [sda] Starting disk [415418.092110] usb 1-4: reset high-speed USB device number 5 using ehci-pci [415418.136057] smapi smapi: set_real_thresh: set stop to 85 for bat=0 [415418.208085] firewire_core 0000:15:00.1: rediscovered device fw0 [415418.248054] smapi smapi: set_real_thresh: set start to 64 for bat=0 [415418.336088] usb 3-2: reset full-speed USB device number 2 using uhci_hcd [415418.360054] smapi smapi: set_real_thresh: set stop to 0 for bat=1 [415418.472051] smapi smapi: set_real_thresh: set start to 0 for bat=1 [415418.613031] thinkpad_acpi: ACPI backlight control delay disabled [415418.615030] PM: restore of devices complete after 980.375 msecs [415418.629705] Restarting kernel threads ... done. [415418.630154] PM: Basic memory bitmaps freed [415418.630158] Restarting tasks ... done. [415418.639246] video LNXVIDEO:00: Restoring backlight state [415419.460969] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [415419.461087] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [415431.318825] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [415432.562317] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [415432.664143] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [415432.664391] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [415432.771094] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [415434.008920] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [415434.009036] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [415434.009075] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [415437.145797] wlan0: authenticate with 00:09:5b:d4:ec:24 [415437.146052] wlan0: send auth to 00:09:5b:d4:ec:24 (try 1/3) [415437.147587] wlan0: authenticated [415437.147784] ath5k 0000:03:00.0 wlan0: disabling HT/VHT due to WEP/TKIP use [415437.147791] ath5k 0000:03:00.0 wlan0: disabling HT as WMM/QoS is not supported by the AP [415437.147796] ath5k 0000:03:00.0 wlan0: disabling VHT as WMM/QoS is not supported by the AP [415437.148060] wlan0: associate with 00:09:5b:d4:ec:24 (try 1/3) [415437.150369] wlan0: RX AssocResp from 00:09:5b:d4:ec:24 (capab=0x431 status=0 aid=3) [415437.150711] wlan0: associated [415437.150747] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [418131.394628] tracker-extract[9537]: segfault at 7fff11e33ff8 ip 00007f680bd0aa22 sp 00007fff11e34000 error 6 in libpoppler.so.44.0.0[7f680bba4000+21a000] [418249.910517] gjs-console[8823]: segfault at 0 ip 00007f53ac9bb764 sp 00007fffd42a76c0 error 4 in libmozjs-24.so.0.0.0[7f53ac775000+56f000] [418384.855639] gjs-console[10403]: segfault at 8 ip 00007f0ba38b5040 sp 00007fffcb3c7758 error 4 in libmozjs-24.so.0.0.0[7f0ba3717000+56f000] [419007.024749] gjs-console[11203]: segfault at 0 ip 00007f7199c39764 sp 00007fff3df49670 error 4 in libmozjs-24.so.0.0.0[7f71999f3000+56f000] [433232.915153] wlan0: deauthenticating from 00:09:5b:d4:ec:24 by local choice (reason=3) [433232.937051] cfg80211: Calling CRDA to update world regulatory domain [433232.938083] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [433232.938128] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [433236.116639] cfg80211: World regulatory domain updated: [433236.116647] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [433236.116652] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [433236.116657] cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [433236.116661] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [433236.116665] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [433236.116669] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [433240.124551] init: anacron main process (14198) killed by TERM signal [433241.931228] Syncing filesystems ... done. [433241.963314] Freezing user space processes ... (elapsed 0.025 seconds) done. [433241.989082] PM: Marking nosave pages: [mem 0x0009d000-0x000fffff] [433241.989091] PM: Basic memory bitmaps created [433241.989220] PM: Preallocating image memory... done (allocated 271261 pages) [433242.742457] PM: Allocated 1085044 kbytes in 0.75 seconds (1446.72 MB/s) [433242.742462] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done. [433242.744575] Suspending console(s) (use no_console_suspend to debug) [433243.308180] PM: freeze of devices complete after 563.595 msecs [433243.308583] PM: late freeze of devices complete after 0.398 msecs [433243.309988] PM: noirq freeze of devices complete after 1.402 msecs [433243.310711] ACPI: Preparing to enter system sleep state S4 [433243.315098] PM: Saving platform NVS memory [433243.315468] Disabling non-boot CPUs ... [433243.316984] kvm: disabling virtualization on CPU1 [433243.317013] smpboot: CPU 1 is now offline [433243.317761] PM: Creating hibernation image: [433243.320994] PM: Need to copy 219386 pages [433243.320994] PM: Normal pages needed: 219386 + 1024, available pages: 294181 [433243.320994] PM: Hibernation image created (219386 pages copied) [433243.320994] Enabling non-boot CPUs ... [433243.320994] x86: Booting SMP configuration: [433243.320994] smpboot: Booting Node 0 Processor 1 APIC 0x1 [433243.320994] kvm: enabling virtualization on CPU1 [433243.329329] ACPI Exception: AE_BAD_PARAMETER, Returned by Handler for [EmbeddedControl] (20131115/evregion-282) [433243.329340] ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPC_.EC__.LPMD] (Node ffff880079f73618), AE_BAD_PARAMETER (20131115/psparse-536) [433243.329350] ACPI Error: Method parse/execution failed [\_PR_.CPU0._PPC] (Node ffff880079f98b18), AE_BAD_PARAMETER (20131115/psparse-536) [433243.329359] ACPI Error: Method parse/execution failed [\_PR_.CPU1._PPC] (Node ffff880079f98938), AE_BAD_PARAMETER (20131115/psparse-536) [433243.329366] ACPI Exception: AE_BAD_PARAMETER, Evaluating _PPC (20131115/processor_perflib-140) [433243.329418] CPU1 is up [433243.332719] ACPI: Waking up from system sleep state S4 [433243.368763] PM: noirq thaw of devices complete after 0.634 msecs [433243.369068] PM: early thaw of devices complete after 0.252 msecs [433243.369247] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [433243.389977] ata2: port disabled--ignoring [433243.403201] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [433243.460200] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [433243.552521] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [433243.552525] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [433243.552939] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [433243.553372] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [433243.576449] ata1.00: configured for UDMA/33 [433243.712062] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [433243.712089] ata5: SATA link down (SStatus 0 SControl 300) [433243.713163] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [433243.713167] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [433243.713409] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [433243.713413] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [433243.715848] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [433243.715852] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [433243.716110] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [433243.716114] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [433243.717223] ata3.00: configured for UDMA/100 [433243.856049] smapi smapi: set_real_thresh: set stop to 85 for bat=0 [433243.968066] smapi smapi: set_real_thresh: set start to 64 for bat=0 [433243.968728] firewire_core 0000:15:00.1: rediscovered device fw0 [433244.080055] smapi smapi: set_real_thresh: set stop to 0 for bat=1 [433244.192056] smapi smapi: set_real_thresh: set start to 0 for bat=1 [433244.333030] thinkpad_acpi: ACPI backlight control delay disabled [433244.334727] PM: thaw of devices complete after 965.653 msecs [433247.697049] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [433247.697165] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [433252.752804] Suspending console(s) (use no_console_suspend to debug) [433252.909250] sd 2:0:0:0: [sda] Synchronizing SCSI cache [433252.909418] sd 2:0:0:0: [sda] Stopping disk [433253.480109] PM: suspend of devices complete after 726.775 msecs [433253.480462] PM: late suspend of devices complete after 0.348 msecs [433253.528412] ehci-pci 0000:00:1d.7: System wakeup enabled by ACPI [433253.544175] uhci_hcd 0000:00:1d.2: System wakeup enabled by ACPI [433253.544287] uhci_hcd 0000:00:1d.1: System wakeup enabled by ACPI [433253.545296] uhci_hcd 0000:00:1d.0: System wakeup enabled by ACPI [433253.546035] ehci-pci 0000:00:1a.7: System wakeup enabled by ACPI [433253.560175] uhci_hcd 0000:00:1a.1: System wakeup enabled by ACPI [433253.560286] uhci_hcd 0000:00:1a.0: System wakeup enabled by ACPI [433253.560396] e1000e 0000:00:19.0: System wakeup enabled by ACPI [433253.576123] PM: noirq suspend of devices complete after 95.657 msecs [433253.576796] ACPI: Preparing to enter system sleep state S3 [433253.581559] PM: Saving platform NVS memory [433253.582089] Disabling non-boot CPUs ... [433253.583696] kvm: disabling virtualization on CPU1 [433253.684040] smpboot: CPU 1 is now offline [433253.684382] ACPI: Low-level resume complete [433253.684382] PM: Restoring platform NVS memory [433253.684382] Enabling non-boot CPUs ... [433253.684382] x86: Booting SMP configuration: [433253.684382] smpboot: Booting Node 0 Processor 1 APIC 0x1 [433253.684382] kvm: enabling virtualization on CPU1 [433253.732119] CPU1 is up [433253.735437] ACPI: Waking up from system sleep state S3 [433253.836248] uhci_hcd 0000:00:1a.0: System wakeup disabled by ACPI [433253.836342] uhci_hcd 0000:00:1a.1: System wakeup disabled by ACPI [433253.852146] ehci-pci 0000:00:1a.7: System wakeup disabled by ACPI [433253.869975] uhci_hcd 0000:00:1d.0: System wakeup disabled by ACPI [433253.870077] uhci_hcd 0000:00:1d.1: System wakeup disabled by ACPI [433253.870181] uhci_hcd 0000:00:1d.2: System wakeup disabled by ACPI [433253.884134] ehci-pci 0000:00:1d.7: System wakeup disabled by ACPI [433253.980481] PM: noirq resume of devices complete after 172.891 msecs [433253.980787] PM: early resume of devices complete after 0.255 msecs [433253.984061] e1000e 0000:00:19.0: System wakeup disabled by ACPI [433253.984114] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [433253.984463] usb usb3: root hub lost power or was reset [433253.984509] usb usb4: root hub lost power or was reset [433253.984725] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [433253.984905] usb usb5: root hub lost power or was reset [433253.984947] usb usb6: root hub lost power or was reset [433253.984992] usb usb7: root hub lost power or was reset [433253.995371] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [433253.996384] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [433253.998104] ata2: port disabled--ignoring [433254.880598] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [433254.880601] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [433254.881591] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [433254.882589] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [433254.904230] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [433254.904612] ata1.00: configured for UDMA/33 [433254.976128] ata5: SATA link down (SStatus 0 SControl 300) [433255.192087] usb 3-2: reset full-speed USB device number 2 using uhci_hcd [433255.372098] firewire_core 0000:15:00.1: rediscovered device fw0 [433255.376085] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [433255.388318] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [433255.388322] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [433255.388603] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [433255.388607] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [433255.391805] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [433255.391809] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [433255.392203] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [433255.392207] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [433255.393733] ata3.00: configured for UDMA/100 [433255.408133] sd 2:0:0:0: [sda] Starting disk [433255.573013] thinkpad_acpi: ACPI backlight control delay disabled [433255.574988] PM: resume of devices complete after 1594.196 msecs [433255.714996] Restarting kernel threads ... done. [433255.715300] PM: Basic memory bitmaps freed [433255.715304] Restarting tasks ... done. [433255.730375] video LNXVIDEO:00: Restoring backlight state [433256.564950] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [433256.565066] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [433263.559139] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [433264.152860] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [433264.256212] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [433264.256412] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [433264.269137] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [433265.580952] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [433265.581068] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [433265.581107] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [433268.720176] wlan0: authenticate with 00:09:5b:d4:ec:24 [433268.720437] wlan0: send auth to 00:09:5b:d4:ec:24 (try 1/3) [433268.722013] wlan0: authenticated [433268.722212] ath5k 0000:03:00.0 wlan0: disabling HT/VHT due to WEP/TKIP use [433268.722219] ath5k 0000:03:00.0 wlan0: disabling HT as WMM/QoS is not supported by the AP [433268.722224] ath5k 0000:03:00.0 wlan0: disabling VHT as WMM/QoS is not supported by the AP [433268.724099] wlan0: associate with 00:09:5b:d4:ec:24 (try 1/3) [433268.726264] wlan0: RX AssocResp from 00:09:5b:d4:ec:24 (capab=0x431 status=0 aid=3) [433268.726609] wlan0: associated [433268.726647] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [433816.385932] wlan0: deauthenticating from 00:09:5b:d4:ec:24 by local choice (reason=3) [433816.386819] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [433816.387965] cfg80211: Calling CRDA to update world regulatory domain [433816.438184] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [433816.438230] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [433816.653748] cfg80211: World regulatory domain updated: [433816.653756] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [433816.653761] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [433816.653766] cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [433816.653770] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [433816.653774] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [433816.653778] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [433818.461176] init: anacron main process (14501) killed by TERM signal [433819.320860] Syncing filesystems ... done. [433819.336450] Freezing user space processes ... (elapsed 0.002 seconds) done. [433819.339245] PM: Marking nosave pages: [mem 0x0009d000-0x000fffff] [433819.339255] PM: Basic memory bitmaps created [433819.339374] PM: Preallocating image memory... done (allocated 271261 pages) [433820.698758] PM: Allocated 1085044 kbytes in 1.35 seconds (803.73 MB/s) [433820.698762] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done. [433820.700795] Suspending console(s) (use no_console_suspend to debug) [433821.332320] PM: freeze of devices complete after 631.514 msecs [433821.332783] PM: late freeze of devices complete after 0.459 msecs [433821.334199] PM: noirq freeze of devices complete after 1.412 msecs [433821.334920] ACPI: Preparing to enter system sleep state S4 [433821.339222] PM: Saving platform NVS memory [433821.339589] Disabling non-boot CPUs ... [433821.341080] kvm: disabling virtualization on CPU1 [433821.341109] smpboot: CPU 1 is now offline [433821.341841] PM: Creating hibernation image: [433821.345091] PM: Need to copy 220407 pages [433821.345091] PM: Normal pages needed: 220407 + 1024, available pages: 293164 [433821.345091] PM: Hibernation image created (220407 pages copied) [433821.345091] Enabling non-boot CPUs ... [433821.345091] x86: Booting SMP configuration: [433821.345091] smpboot: Booting Node 0 Processor 1 APIC 0x1 [433821.345091] kvm: enabling virtualization on CPU1 [433821.353416] ACPI Exception: AE_BAD_PARAMETER, Returned by Handler for [EmbeddedControl] (20131115/evregion-282) [433821.353427] ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPC_.EC__.LPMD] (Node ffff880079f73618), AE_BAD_PARAMETER (20131115/psparse-536) [433821.353437] ACPI Error: Method parse/execution failed [\_PR_.CPU0._PPC] (Node ffff880079f98b18), AE_BAD_PARAMETER (20131115/psparse-536) [433821.353446] ACPI Error: Method parse/execution failed [\_PR_.CPU1._PPC] (Node ffff880079f98938), AE_BAD_PARAMETER (20131115/psparse-536) [433821.353453] ACPI Exception: AE_BAD_PARAMETER, Evaluating _PPC (20131115/processor_perflib-140) [433821.353503] CPU1 is up [433821.356815] ACPI: Waking up from system sleep state S4 [433821.391272] PM: noirq thaw of devices complete after 0.636 msecs [433821.391576] PM: early thaw of devices complete after 0.251 msecs [433821.391754] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [433821.409920] ata2: port disabled--ignoring [433821.424283] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [433821.484192] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [433821.576519] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [433821.576523] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [433821.576938] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [433821.577371] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [433821.600440] ata1.00: configured for UDMA/33 [433821.728065] ata5: SATA link down (SStatus 0 SControl 300) [433821.732068] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [433821.733164] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [433821.733169] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [433821.733409] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [433821.733412] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [433821.736631] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [433821.736635] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [433821.736857] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [433821.736860] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [433821.738015] ata3.00: configured for UDMA/100 [433821.872060] smapi smapi: set_real_thresh: set stop to 85 for bat=0 [433821.984056] smapi smapi: set_real_thresh: set start to 64 for bat=0 [433821.988094] firewire_core 0000:15:00.1: rediscovered device fw0 [433822.096055] smapi smapi: set_real_thresh: set stop to 0 for bat=1 [433822.208055] smapi smapi: set_real_thresh: set start to 0 for bat=1 [433822.349032] thinkpad_acpi: ACPI backlight control delay disabled [433822.350739] PM: thaw of devices complete after 959.156 msecs [433823.184899] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [433823.185011] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [433830.760963] Suspending console(s) (use no_console_suspend to debug) [433830.915174] sd 2:0:0:0: [sda] Synchronizing SCSI cache [433830.915295] sd 2:0:0:0: [sda] Stopping disk [433831.456108] PM: suspend of devices complete after 694.618 msecs [433831.456464] PM: late suspend of devices complete after 0.351 msecs [433831.504418] ehci-pci 0000:00:1d.7: System wakeup enabled by ACPI [433831.520168] uhci_hcd 0000:00:1d.2: System wakeup enabled by ACPI [433831.520280] uhci_hcd 0000:00:1d.1: System wakeup enabled by ACPI [433831.521126] uhci_hcd 0000:00:1d.0: System wakeup enabled by ACPI [433831.521859] ehci-pci 0000:00:1a.7: System wakeup enabled by ACPI [433831.536170] uhci_hcd 0000:00:1a.1: System wakeup enabled by ACPI [433831.536281] uhci_hcd 0000:00:1a.0: System wakeup enabled by ACPI [433831.536390] e1000e 0000:00:19.0: System wakeup enabled by ACPI [433831.552120] PM: noirq suspend of devices complete after 95.652 msecs [433831.552793] ACPI: Preparing to enter system sleep state S3 [433831.557349] PM: Saving platform NVS memory [433831.557887] Disabling non-boot CPUs ... [433831.559347] kvm: disabling virtualization on CPU1 [433831.660047] smpboot: CPU 1 is now offline [433831.660395] ACPI: Low-level resume complete [433831.660395] PM: Restoring platform NVS memory [433831.660395] Enabling non-boot CPUs ... [433831.660395] x86: Booting SMP configuration: [433831.660395] smpboot: Booting Node 0 Processor 1 APIC 0x1 [433831.660395] kvm: enabling virtualization on CPU1 [433831.712111] CPU1 is up [433831.715426] ACPI: Waking up from system sleep state S3 [433831.816285] uhci_hcd 0000:00:1a.0: System wakeup disabled by ACPI [433831.816382] uhci_hcd 0000:00:1a.1: System wakeup disabled by ACPI [433831.832170] ehci-pci 0000:00:1a.7: System wakeup disabled by ACPI [433831.849998] uhci_hcd 0000:00:1d.0: System wakeup disabled by ACPI [433831.850097] uhci_hcd 0000:00:1d.1: System wakeup disabled by ACPI [433831.850192] uhci_hcd 0000:00:1d.2: System wakeup disabled by ACPI [433831.864138] ehci-pci 0000:00:1d.7: System wakeup disabled by ACPI [433831.960509] PM: noirq resume of devices complete after 174.416 msecs [433831.960836] PM: early resume of devices complete after 0.276 msecs [433831.964058] e1000e 0000:00:19.0: System wakeup disabled by ACPI [433831.964112] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [433831.964468] usb usb3: root hub lost power or was reset [433831.964515] usb usb4: root hub lost power or was reset [433831.964730] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [433831.964907] usb usb5: root hub lost power or was reset [433831.964949] usb usb6: root hub lost power or was reset [433831.964993] usb usb7: root hub lost power or was reset [433831.975373] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [433831.976386] sdhci-pci 0000:15:00.2: Will use DMA mode even though HW doesn't fully claim to support it. [433831.976496] ata2: port disabled--ignoring [433832.856595] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [433832.856599] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [433832.857571] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [433832.858557] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [433832.884466] ata1.00: configured for UDMA/33 [433832.892213] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [433832.959741] ata5: SATA link down (SStatus 0 SControl 300) [433833.168124] usb 3-2: reset full-speed USB device number 2 using uhci_hcd [433833.348082] firewire_core 0000:15:00.1: rediscovered device fw0 [433833.408082] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [433833.420150] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [433833.420155] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [433833.420453] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [433833.420457] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [433833.423685] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [433833.423689] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [433833.423995] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [433833.423999] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [433833.425571] ata3.00: configured for UDMA/100 [433833.444256] sd 2:0:0:0: [sda] Starting disk [433833.605011] thinkpad_acpi: ACPI backlight control delay disabled [433833.606753] PM: resume of devices complete after 1645.910 msecs [433833.747571] Restarting kernel threads ... done. [433833.747902] PM: Basic memory bitmaps freed [433833.747906] Restarting tasks ... done. [433833.765913] video LNXVIDEO:00: Restoring backlight state [433834.508956] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [433834.509072] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [435688.863208] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [435689.414473] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [435689.516159] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [435689.516420] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [435689.529444] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [435690.841018] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [435690.841140] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [435690.841200] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [435693.370993] wlan0: authenticate with 00:09:5b:d4:ec:24 [435693.371252] wlan0: send auth to 00:09:5b:d4:ec:24 (try 1/3) [435693.372937] wlan0: authenticated [435693.373144] ath5k 0000:03:00.0 wlan0: disabling HT/VHT due to WEP/TKIP use [435693.373151] ath5k 0000:03:00.0 wlan0: disabling HT as WMM/QoS is not supported by the AP [435693.373156] ath5k 0000:03:00.0 wlan0: disabling VHT as WMM/QoS is not supported by the AP [435693.376106] wlan0: associate with 00:09:5b:d4:ec:24 (try 1/3) [435693.380478] wlan0: RX AssocResp from 00:09:5b:d4:ec:24 (capab=0x431 status=0 aid=2) [435693.380832] wlan0: associated [435693.380933] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [436007.141941] type=1400 audit(1398955763.478:128): apparmor="DENIED" operation="open" profile="/usr/lib/telepathy/mission-control-5" name="/usr/local/lib/libnm-glib.so.4.7.0" pid=16522 comm="mission-control" requested_mask="r" denied_mask="r" fsuid=106 ouid=0 [436007.165221] type=1400 audit(1398955763.502:129): apparmor="DENIED" operation="open" profile="/usr/lib/telepathy/mission-control-5" name="/usr/local/lib/libnm-util.so.2.5.0" pid=16522 comm="mission-control" requested_mask="r" denied_mask="r" fsuid=106 ouid=0 [436007.395564] type=1400 audit(1398955763.730:130): apparmor="DENIED" operation="open" profile="/usr/lib/telepathy/mission-control-5" name="/etc/dconf/profile/gdm" pid=16522 comm="mission-control" requested_mask="r" denied_mask="r" fsuid=106 ouid=0 [436029.829188] type=1400 audit(1398955786.166:131): apparmor="DENIED" operation="open" profile="/usr/lib/telepathy/mission-control-5" name="/usr/local/lib/libnm-glib.so.4.7.0" pid=16945 comm="mission-control" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0 [436029.830392] type=1400 audit(1398955786.166:132): apparmor="DENIED" operation="open" profile="/usr/lib/telepathy/mission-control-5" name="/usr/local/lib/libnm-util.so.2.5.0" pid=16945 comm="mission-control" requested_mask="r" denied_mask="r" fsuid=1000 ouid=0 [436703.088162] usb 1-3: new high-speed USB device number 6 using ehci-pci [436703.222774] usb 1-3: New USB device found, idVendor=1516, idProduct=8628 [436703.222784] usb 1-3: New USB device strings: Mfr=1, Product=2, SerialNumber=3 [436703.222792] usb 1-3: Product: USB_DRIVE [436703.222799] usb 1-3: Manufacturer: [436703.222805] usb 1-3: SerialNumber: 8699 [436703.830984] usb-storage 1-3:1.0: USB Mass Storage device detected [436703.831097] scsi5 : usb-storage 1-3:1.0 [436703.831247] usbcore: registered new interface driver usb-storage [436704.828811] scsi 5:0:0:0: Direct-Access USB_DRIVE 1.00 PQ: 0 ANSI: 2 [436704.829312] sd 5:0:0:0: Attached scsi generic sg2 type 0 [436704.830023] sd 5:0:0:0: [sdb] 254336 512-byte logical blocks: (130 MB/124 MiB) [436704.830649] sd 5:0:0:0: [sdb] Write Protect is off [436704.830656] sd 5:0:0:0: [sdb] Mode Sense: 03 00 00 00 [436704.831258] sd 5:0:0:0: [sdb] No Caching mode page found [436704.831264] sd 5:0:0:0: [sdb] Assuming drive cache: write through [436704.837020] sd 5:0:0:0: [sdb] No Caching mode page found [436704.837028] sd 5:0:0:0: [sdb] Assuming drive cache: write through [436704.840407] sdb: sdb1 [436704.846486] sd 5:0:0:0: [sdb] No Caching mode page found [436704.846494] sd 5:0:0:0: [sdb] Assuming drive cache: write through [436704.846501] sd 5:0:0:0: [sdb] Attached SCSI removable disk [436725.655365] sdb: detected capacity change from 130220032 to 0 [436728.156692] usb 1-3: USB disconnect, device number 6 [436731.616081] ath5k: ath5k_hw_get_isr: ISR: 0x00001000 IMR: 0x00000000 [436785.368237] wlan0: deauthenticating from 00:09:5b:d4:ec:24 by local choice (reason=3) [436785.369220] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [436785.370897] cfg80211: Calling CRDA to update world regulatory domain [436785.429681] cfg80211: World regulatory domain updated: [436785.429688] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [436785.429693] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [436785.429697] cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [436785.429702] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [436785.429706] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [436785.429710] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [436785.430400] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [436785.430447] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [436788.328745] Syncing filesystems ... done. [436788.338567] Freezing user space processes ... (elapsed 0.004 seconds) done. [436788.343428] PM: Marking nosave pages: [mem 0x0009d000-0x000fffff] [436788.343438] PM: Basic memory bitmaps created [436788.343559] PM: Preallocating image memory... done (allocated 271249 pages) [436789.158856] PM: Allocated 1084996 kbytes in 0.81 seconds (1339.50 MB/s) [436789.158861] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done. [436789.160884] Suspending console(s) (use no_console_suspend to debug) [436789.792365] PM: freeze of devices complete after 631.469 msecs [436789.792816] PM: late freeze of devices complete after 0.447 msecs [436789.794229] PM: noirq freeze of devices complete after 1.409 msecs [436789.794949] ACPI: Preparing to enter system sleep state S4 [436789.799238] PM: Saving platform NVS memory [436789.799607] Disabling non-boot CPUs ... [436789.801118] kvm: disabling virtualization on CPU1 [436789.801148] smpboot: CPU 1 is now offline [436789.801891] PM: Creating hibernation image: [436789.805129] PM: Need to copy 212278 pages [436789.805129] PM: Normal pages needed: 212278 + 1024, available pages: 301292 [436789.805129] PM: Restoring platform NVS memory [436789.805129] Enabling non-boot CPUs ... [436789.805129] x86: Booting SMP configuration: [436789.805129] smpboot: Booting Node 0 Processor 1 APIC 0x1 [436789.805129] kvm: enabling virtualization on CPU1 [436789.852115] CPU1 is up [436789.855373] ACPI: Waking up from system sleep state S4 [436789.920667] PM: noirq restore of devices complete after 32.708 msecs [436789.920971] PM: early restore of devices complete after 0.253 msecs [436790.032248] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [436790.043184] usb usb3: root hub lost power or was reset [436790.043229] usb usb4: root hub lost power or was reset [436790.043276] usb usb1: root hub lost power or was reset [436790.047556] ehci-pci 0000:00:1a.7: cache line size of 64 is not supported [436790.047731] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [436790.047913] usb usb5: root hub lost power or was reset [436790.047956] usb usb6: root hub lost power or was reset [436790.047999] usb usb7: root hub lost power or was reset [436790.048055] usb usb2: root hub lost power or was reset [436790.052404] ehci-pci 0000:00:1d.7: cache line size of 64 is not supported [436790.054318] ata2: port disabled--ignoring [436790.124208] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [436790.222510] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [436790.222514] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [436790.222937] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [436790.223369] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [436790.247323] ata1.00: configured for UDMA/33 [436790.376087] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [436790.377222] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [436790.377227] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [436790.377450] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [436790.377454] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [436790.379874] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [436790.379878] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [436790.380068] ata5: SATA link down (SStatus 0 SControl 300) [436790.380103] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [436790.380106] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [436790.381260] ata3.00: configured for UDMA/100 [436790.400162] sd 2:0:0:0: [sda] Starting disk [436790.492125] usb 1-4: reset high-speed USB device number 5 using ehci-pci [436790.528073] smapi smapi: set_real_thresh: set stop to 85 for bat=0 [436790.620087] firewire_core 0000:15:00.1: rediscovered device fw0 [436790.640044] smapi smapi: set_real_thresh: set start to 64 for bat=0 [436790.736100] usb 3-2: reset full-speed USB device number 2 using uhci_hcd [436790.752063] smapi smapi: set_real_thresh: set stop to 0 for bat=1 [436790.864061] smapi smapi: set_real_thresh: set start to 0 for bat=1 [436791.005004] thinkpad_acpi: ACPI backlight control delay disabled [436791.006762] PM: restore of devices complete after 975.722 msecs [436791.021317] Restarting kernel threads ... done. [436791.021811] PM: Basic memory bitmaps freed [436791.021816] Restarting tasks ... done. [436791.036273] video LNXVIDEO:00: Restoring backlight state [436791.868931] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [436791.869046] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [436799.202979] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [436799.790398] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [436799.896148] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [436799.896409] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [436799.911015] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [436799.941533] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [436799.941576] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [436800.174701] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [436800.185588] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [436800.562457] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [436800.664193] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [436800.664361] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [436802.004958] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [436802.005074] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [436802.005114] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [436804.581574] wlan0: authenticate with 00:09:5b:d4:ec:24 [436804.581837] wlan0: send auth to 00:09:5b:d4:ec:24 (try 1/3) [436804.583416] wlan0: authenticated [436804.583727] ath5k 0000:03:00.0 wlan0: disabling HT/VHT due to WEP/TKIP use [436804.583733] ath5k 0000:03:00.0 wlan0: disabling HT as WMM/QoS is not supported by the AP [436804.583738] ath5k 0000:03:00.0 wlan0: disabling VHT as WMM/QoS is not supported by the AP [436804.584234] wlan0: associate with 00:09:5b:d4:ec:24 (try 1/3) [436804.586385] wlan0: RX AssocResp from 00:09:5b:d4:ec:24 (capab=0x431 status=0 aid=1) [436804.586741] wlan0: associated [436804.586780] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [451996.007144] ath5k: ath5k_hw_get_isr: ISR: 0x00000080 IMR: 0x00000000 [460876.008150] ath5k: ath5k_hw_get_isr: ISR: 0x00000080 IMR: 0x00000000 [464965.532111] ath5k: ath5k_hw_get_isr: ISR: 0x00000001 IMR: 0x00000000 [469830.568155] usb 1-3: new high-speed USB device number 7 using ehci-pci [469830.703864] usb 1-3: New USB device found, idVendor=0bc2, idProduct=5033 [469830.703874] usb 1-3: New USB device strings: Mfr=1, Product=2, SerialNumber=3 [469830.703882] usb 1-3: Product: FreeAgent GoFlex [469830.703889] usb 1-3: Manufacturer: Seagate [469830.703896] usb 1-3: SerialNumber: NA0CRPGL [469830.704604] usb-storage 1-3:1.0: USB Mass Storage device detected [469830.704751] scsi6 : usb-storage 1-3:1.0 [469831.705183] scsi 6:0:0:0: Direct-Access Seagate FreeAgent GoFlex SA17 PQ: 0 ANSI: 4 [469831.705910] sd 6:0:0:0: Attached scsi generic sg2 type 0 [469831.706747] sd 6:0:0:0: [sdb] 1953525164 512-byte logical blocks: (1.00 TB/931 GiB) [469831.707375] sd 6:0:0:0: [sdb] Write Protect is off [469831.707385] sd 6:0:0:0: [sdb] Mode Sense: 1c 00 00 00 [469831.709120] sd 6:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [469831.785667] sdb: sdb1 sdb2 sdb3 [469831.788372] sd 6:0:0:0: [sdb] Attached SCSI disk [469833.689831] EXT4-fs (sdb1): mounted filesystem with ordered data mode. Opts: (null) [469834.166146] hfsplus: write access to a journaled filesystem is not supported, use the force option at your own risk, mounting read-only. [470236.141645] ath5k: ath5k_hw_get_isr: ISR: 0x00000080 IMR: 0x00000000 [472282.712242] sd 6:0:0:0: [sdb] Synchronizing SCSI cache [472282.717726] sd 6:0:0:0: [sdb] [472282.717732] Result: hostbyte=DID_OK driverbyte=DRIVER_SENSE [472282.717737] sd 6:0:0:0: [sdb] [472282.717740] Sense Key : Illegal Request [current] [472282.717747] sd 6:0:0:0: [sdb] [472282.717752] Add. Sense: Invalid field in cdb [472282.726420] usb 1-3: USB disconnect, device number 7 [472982.547273] wlan0: deauthenticating from 00:09:5b:d4:ec:24 by local choice (reason=3) [472982.566055] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [472982.566104] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [472982.566381] cfg80211: Calling CRDA to update world regulatory domain [472984.402515] cfg80211: World regulatory domain updated: [472984.402523] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [472984.402528] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [472984.402533] cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [472984.402537] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm) [472984.402541] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [472984.402545] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm) [472988.675242] init: anacron main process (21522) killed by TERM signal [472990.134360] Syncing filesystems ... done. [472990.191175] Freezing user space processes ... (elapsed 0.123 seconds) done. [472990.314837] PM: Marking nosave pages: [mem 0x0009d000-0x000fffff] [472990.314847] PM: Basic memory bitmaps created [472990.314965] PM: Preallocating image memory... done (allocated 271261 pages) [472991.208880] PM: Allocated 1085044 kbytes in 0.89 seconds (1219.15 MB/s) [472991.208885] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done. [472991.210891] Suspending console(s) (use no_console_suspend to debug) [472991.772176] PM: freeze of devices complete after 561.276 msecs [472991.772539] PM: late freeze of devices complete after 0.358 msecs [472991.773944] PM: noirq freeze of devices complete after 1.401 msecs [472991.774705] ACPI: Preparing to enter system sleep state S4 [472991.779037] PM: Saving platform NVS memory [472991.779410] Disabling non-boot CPUs ... [472991.780920] kvm: disabling virtualization on CPU1 [472991.780942] smpboot: CPU 1 is now offline [472991.781685] PM: Creating hibernation image: [472991.784931] PM: Need to copy 196939 pages [472991.784931] PM: Normal pages needed: 196939 + 1024, available pages: 316626 [472991.784931] PM: Restoring platform NVS memory [472991.784931] Enabling non-boot CPUs ... [472991.784931] x86: Booting SMP configuration: [472991.784931] smpboot: Booting Node 0 Processor 1 APIC 0x1 [472991.784931] kvm: enabling virtualization on CPU1 [472991.832117] CPU1 is up [472991.835381] ACPI: Waking up from system sleep state S4 [472991.900661] PM: noirq restore of devices complete after 32.571 msecs [472991.900968] PM: early restore of devices complete after 0.255 msecs [472991.998875] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [472991.999390] usb usb3: root hub lost power or was reset [472991.999473] usb usb4: root hub lost power or was reset [472991.999531] usb usb1: root hub lost power or was reset [472992.003799] ehci-pci 0000:00:1a.7: cache line size of 64 is not supported [472992.003982] snd_hda_intel 0000:00:1b.0: irq 48 for MSI/MSI-X [472992.004138] usb usb5: root hub lost power or was reset [472992.004180] usb usb6: root hub lost power or was reset [472992.004221] usb usb7: root hub lost power or was reset [472992.004260] usb usb2: root hub lost power or was reset [472992.008574] ehci-pci 0000:00:1d.7: cache line size of 64 is not supported [472992.020266] ata2: port disabled--ignoring [472992.092211] tpm_tis 00:09: TPM is disabled/deactivated (0x6) [472992.184563] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [472992.184567] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [472992.184967] ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [472992.185387] ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [472992.212479] ata1.00: configured for UDMA/33 [472992.344079] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) [472992.344108] ata5: SATA link down (SStatus 0 SControl 300) [472992.345715] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [472992.345719] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [472992.345959] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [472992.345963] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [472992.348404] ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [472992.348409] ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [472992.348622] ata3.00: ACPI cmd ef/5f:00:00:00:00:a0 (SET FEATURES) succeeded [472992.348626] ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out [472992.349729] ata3.00: configured for UDMA/100 [472992.364125] sd 2:0:0:0: [sda] Starting disk [472992.460089] usb 3-2: reset full-speed USB device number 2 using uhci_hcd [472992.496070] smapi smapi: set_real_thresh: set stop to 85 for bat=0 [472992.580101] firewire_core 0000:15:00.1: rediscovered device fw0 [472992.608065] smapi smapi: set_real_thresh: set start to 64 for bat=0 [472992.708116] usb 1-4: reset high-speed USB device number 5 using ehci-pci [472992.720050] smapi smapi: set_real_thresh: set stop to 0 for bat=1 [472992.832049] smapi smapi: set_real_thresh: set start to 0 for bat=1 [472992.972980] thinkpad_acpi: ACPI backlight control delay disabled [472992.974974] PM: restore of devices complete after 976.380 msecs [472992.989675] Restarting kernel threads ... done. [472992.990236] PM: Basic memory bitmaps freed [472992.990240] Restarting tasks ... done. [472993.017867] video LNXVIDEO:00: Restoring backlight state [472993.828952] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [472993.829068] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [473000.334807] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [473000.994258] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [473001.096164] e1000e 0000:00:19.0: irq 45 for MSI/MSI-X [473001.096341] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [473001.108204] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready [473002.476994] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: Rx/Tx [473002.477116] e1000e 0000:00:19.0 eth0: 10/100 speed: disabling TSO [473002.477176] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [473005.478397] wlan0: authenticate with 00:09:5b:d4:ec:24 [473005.478757] wlan0: send auth to 00:09:5b:d4:ec:24 (try 1/3) [473005.482191] wlan0: authenticated [473005.482393] ath5k 0000:03:00.0 wlan0: disabling HT/VHT due to WEP/TKIP use [473005.482400] ath5k 0000:03:00.0 wlan0: disabling HT as WMM/QoS is not supported by the AP [473005.482405] ath5k 0000:03:00.0 wlan0: disabling VHT as WMM/QoS is not supported by the AP [473005.484050] wlan0: associate with 00:09:5b:d4:ec:24 (try 1/3) [473005.486241] wlan0: RX AssocResp from 00:09:5b:d4:ec:24 (capab=0x431 status=0 aid=2) [473005.486583] wlan0: associated [473005.486620] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [473214.003258] ath5k: ath5k_hw_get_isr: ISR: 0x00000080 IMR: 0x00000000 [474064.824419] type=1400 audit(1399050465.041:133): apparmor="STATUS" operation="profile_replace" profile="unconfined" name="/usr/lib/cups/backend/cups-pdf" pid=22573 comm="apparmor_parser" [474064.824436] type=1400 audit(1399050465.041:134): apparmor="STATUS" operation="profile_replace" profile="unconfined" name="/usr/sbin/cupsd" pid=22573 comm="apparmor_parser" [474064.825325] type=1400 audit(1399050465.041:135): apparmor="STATUS" operation="profile_replace" profile="unconfined" name="/usr/sbin/cupsd" pid=22573 comm="apparmor_parser" [480637.006834] ath5k: ath5k_hw_get_isr: ISR: 0x00000080 IMR: 0x00000000