Nov 28 07:46:39 vlD-kuci modem-manager: Modem /org/freedesktop/ModemManager/Modems/0: state changed (connected -> disconnecting) Nov 28 07:46:40 vlD-kuci modem-manager: Got failure code 3: No carrier Nov 28 07:46:40 vlD-kuci modem-manager: Modem /org/freedesktop/ModemManager/Modems/0: state changed (disconnecting -> registered) Nov 28 07:46:40 vlD-kuci kernel: [10303.749342] PM: Syncing filesystems ... done. Nov 28 07:46:40 vlD-kuci kernel: [10303.837106] PM: Preparing system for mem sleep Nov 28 08:08:56 vlD-kuci kernel: [10303.896534] Freezing user space processes ... (elapsed 0.01 seconds) done. Nov 28 08:08:56 vlD-kuci modem-manager: (ttyUSB0) closing serial device... Nov 28 08:08:56 vlD-kuci kernel: [10303.916052] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done. Nov 28 08:08:56 vlD-kuci kernel: [10303.932028] PM: Entering mem sleep Nov 28 08:08:56 vlD-kuci kernel: [10303.932127] Suspending console(s) (use no_console_suspend to debug) Nov 28 08:08:56 vlD-kuci kernel: [10303.932491] sd 3:0:0:0: [sdc] Synchronizing SCSI cache Nov 28 08:08:56 vlD-kuci kernel: [10303.932627] sd 3:0:0:0: [sdc] Stopping disk Nov 28 08:08:56 vlD-kuci kernel: [10303.932753] sd 0:0:0:0: [sda] Synchronizing SCSI cache Nov 28 08:08:56 vlD-kuci kernel: [10303.937969] option: option_instat_callback: error -2 Nov 28 08:08:56 vlD-kuci kernel: [10303.943499] tpm_tis 00:0e: disabled Nov 28 08:08:56 vlD-kuci kernel: [10303.947399] parport_pc 00:0d: disabled Nov 28 08:08:56 vlD-kuci kernel: [10303.949660] i8042 aux 00:09: disabled Nov 28 08:08:56 vlD-kuci kernel: [10303.949876] sata_sil24 0000:04:00.0: PCI INT A disabled Nov 28 08:08:56 vlD-kuci kernel: [10303.950317] uhci_hcd 0000:00:1d.2: PCI INT C disabled Nov 28 08:08:56 vlD-kuci kernel: [10303.950371] uhci_hcd 0000:00:1d.1: PCI INT B disabled Nov 28 08:08:56 vlD-kuci kernel: [10303.950425] uhci_hcd 0000:00:1d.0: PCI INT A disabled Nov 28 08:08:56 vlD-kuci kernel: [10303.953068] uhci_hcd 0000:00:1d.3: PCI INT D disabled Nov 28 08:08:56 vlD-kuci kernel: [10303.968167] ehci_hcd 0000:00:1d.7: PCI INT A disabled Nov 28 08:08:56 vlD-kuci kernel: [10303.982202] sd 0:0:0:0: [sda] Stopping disk Nov 28 08:08:56 vlD-kuci kernel: [10304.029344] e1000e 0000:02:00.0: PCI INT A disabled Nov 28 08:08:56 vlD-kuci kernel: [10304.029354] e1000e 0000:02:00.0: PME# enabled Nov 28 08:08:56 vlD-kuci kernel: [10304.029370] pcieport 0000:00:1c.0: wake-up capability enabled by ACPI Nov 28 08:08:56 vlD-kuci kernel: [10304.052068] HDA Intel 0000:00:1b.0: PCI INT A disabled Nov 28 08:08:56 vlD-kuci kernel: [10304.068019] PM: suspend of drv:HDA Intel dev:0000:00:1b.0 complete after 117.459 msecs Nov 28 08:08:56 vlD-kuci kernel: [10304.585601] PM: suspend of drv:sd dev:0:0:0:0 complete after 652.850 msecs Nov 28 08:08:56 vlD-kuci kernel: [10304.585618] PM: suspend of drv:scsi dev:target0:0:0 complete after 652.864 msecs Nov 28 08:08:56 vlD-kuci kernel: [10304.585633] PM: suspend of drv:scsi dev:host0 complete after 643.267 msecs Nov 28 08:08:56 vlD-kuci kernel: [10304.585783] ata_piix 0000:00:1f.1: PCI INT A disabled Nov 28 08:08:56 vlD-kuci kernel: [10304.585789] PM: suspend of drv:ata_piix dev:0000:00:1f.1 complete after 635.691 msecs Nov 28 08:08:56 vlD-kuci kernel: [10304.585800] PM: suspend of drv: dev:pci0000:00 complete after 634.648 msecs Nov 28 08:08:56 vlD-kuci kernel: [10304.585809] PM: suspend of devices complete after 653.453 msecs Nov 28 08:08:56 vlD-kuci kernel: [10304.585813] PM: suspend devices took 0.652 seconds Nov 28 08:08:56 vlD-kuci kernel: [10304.600151] PM: late suspend of devices complete after 14.334 msecs Nov 28 08:08:56 vlD-kuci kernel: [10304.600481] ACPI: Preparing to enter system sleep state S3 Nov 28 08:08:56 vlD-kuci kernel: [10304.624984] PM: Saving platform NVS memory Nov 28 08:08:56 vlD-kuci kernel: [10304.659080] Disabling non-boot CPUs ... Nov 28 08:08:56 vlD-kuci kernel: [10304.660694] CPU 1 is now offline Nov 28 08:08:56 vlD-kuci kernel: [10304.660698] SMP alternatives: switching to UP code Nov 28 08:08:56 vlD-kuci kernel: [10304.670162] Back to C! Nov 28 08:08:56 vlD-kuci kernel: [10304.670162] PM: Restoring platform NVS memory Nov 28 08:08:56 vlD-kuci kernel: [10304.670162] CPU0: Thermal monitoring handled by SMI Nov 28 08:08:56 vlD-kuci kernel: [10304.670162] Force enabled HPET at resume Nov 28 08:08:56 vlD-kuci kernel: [10304.670162] Enabling non-boot CPUs ... Nov 28 08:08:56 vlD-kuci kernel: [10304.670162] SMP alternatives: switching to SMP code Nov 28 08:08:56 vlD-kuci kernel: [10304.679518] Booting Node 0 Processor 1 APIC 0x1 Nov 28 08:08:56 vlD-kuci kernel: [10304.669686] Initializing CPU#1 Nov 28 08:08:56 vlD-kuci kernel: [10304.669686] CPU1: Thermal monitoring handled by SMI Nov 28 08:08:56 vlD-kuci kernel: [10304.804881] CPU1 is up Nov 28 08:08:56 vlD-kuci kernel: [10304.805829] ACPI: Waking up from system sleep state S3 Nov 28 08:08:56 vlD-kuci kernel: [10304.807170] pcieport 0000:00:01.0: restoring config space at offset 0xf (was 0x40100, writing 0xc0105) Nov 28 08:08:56 vlD-kuci kernel: [10304.807179] pcieport 0000:00:01.0: restoring config space at offset 0xa (was 0xf, writing 0x0) Nov 28 08:08:56 vlD-kuci kernel: [10304.807184] pcieport 0000:00:01.0: restoring config space at offset 0x8 (was 0x0, writing 0xd810d810) Nov 28 08:08:56 vlD-kuci kernel: [10304.807189] pcieport 0000:00:01.0: restoring config space at offset 0x7 (was 0xf0, writing 0x4040) Nov 28 08:08:56 vlD-kuci kernel: [10304.807196] pcieport 0000:00:01.0: restoring config space at offset 0x3 (was 0x10000, writing 0x10008) Nov 28 08:08:56 vlD-kuci kernel: [10304.807201] pcieport 0000:00:01.0: restoring config space at offset 0x1 (was 0x100105, writing 0x100507) Nov 28 08:08:56 vlD-kuci kernel: [10304.807250] HDA Intel 0000:00:1b.0: restoring config space at offset 0x3 (was 0x0, writing 0x8) Nov 28 08:08:56 vlD-kuci kernel: [10304.807257] HDA Intel 0000:00:1b.0: restoring config space at offset 0x1 (was 0x100106, writing 0x100102) Nov 28 08:08:56 vlD-kuci kernel: [10304.807283] pcieport 0000:00:1c.0: restoring config space at offset 0xf (was 0x40100, writing 0x40109) Nov 28 08:08:56 vlD-kuci kernel: [10304.807294] pcieport 0000:00:1c.0: restoring config space at offset 0x9 (was 0x10001, writing 0x80118001) Nov 28 08:08:56 vlD-kuci kernel: [10304.807299] pcieport 0000:00:1c.0: restoring config space at offset 0x8 (was 0x0, writing 0xd800d800) Nov 28 08:08:56 vlD-kuci kernel: [10304.807305] pcieport 0000:00:1c.0: restoring config space at offset 0x7 (was 0x20000000, writing 0x5050) Nov 28 08:08:56 vlD-kuci kernel: [10304.807313] pcieport 0000:00:1c.0: restoring config space at offset 0x3 (was 0x810000, writing 0x810008) Nov 28 08:08:56 vlD-kuci kernel: [10304.807320] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100407) Nov 28 08:08:56 vlD-kuci kernel: [10304.807358] pcieport 0000:00:1c.1: restoring config space at offset 0xf (was 0x40200, writing 0x40205) Nov 28 08:08:56 vlD-kuci kernel: [10304.807369] pcieport 0000:00:1c.1: restoring config space at offset 0x9 (was 0x10001, writing 0x80318021) Nov 28 08:08:56 vlD-kuci kernel: [10304.807374] pcieport 0000:00:1c.1: restoring config space at offset 0x8 (was 0x0, writing 0xd820d820) Nov 28 08:08:56 vlD-kuci kernel: [10304.807380] pcieport 0000:00:1c.1: restoring config space at offset 0x7 (was 0x20000000, writing 0x6060) Nov 28 08:08:56 vlD-kuci kernel: [10304.807388] pcieport 0000:00:1c.1: restoring config space at offset 0x3 (was 0x810000, writing 0x810008) Nov 28 08:08:56 vlD-kuci kernel: [10304.807395] pcieport 0000:00:1c.1: restoring config space at offset 0x1 (was 0x100000, writing 0x100407) Nov 28 08:08:56 vlD-kuci kernel: [10304.807443] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) Nov 28 08:08:56 vlD-kuci kernel: [10304.807472] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) Nov 28 08:08:56 vlD-kuci kernel: [10304.807500] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) Nov 28 08:08:56 vlD-kuci kernel: [10304.807528] uhci_hcd 0000:00:1d.3: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) Nov 28 08:08:56 vlD-kuci kernel: [10304.807565] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102) Nov 28 08:08:56 vlD-kuci kernel: [10304.807593] pci 0000:00:1e.0: restoring config space at offset 0x9 (was 0x10011, writing 0x1fff1) Nov 28 08:08:56 vlD-kuci kernel: [10304.807599] pci 0000:00:1e.0: restoring config space at offset 0x8 (was 0x10, writing 0xfff0) Nov 28 08:08:56 vlD-kuci kernel: [10304.807604] pci 0000:00:1e.0: restoring config space at offset 0x7 (was 0x22800010, writing 0x228000f0) Nov 28 08:08:56 vlD-kuci kernel: [10304.807615] pci 0000:00:1e.0: restoring config space at offset 0x1 (was 0x100007, writing 0x100107) Nov 28 08:08:56 vlD-kuci kernel: [10304.807655] pci 0000:00:1f.0: restoring config space at offset 0x1 (was 0x2100007, writing 0x2100107) Nov 28 08:08:56 vlD-kuci kernel: [10304.807671] ata_piix 0000:00:1f.1: restoring config space at offset 0xf (was 0x100, writing 0x1ff) Nov 28 08:08:56 vlD-kuci kernel: [10304.807693] ata_piix 0000:00:1f.1: restoring config space at offset 0x1 (was 0x2800000, writing 0x2880005) Nov 28 08:08:56 vlD-kuci kernel: [10304.807740] radeon 0000:01:00.0: restoring config space at offset 0xf (was 0x1ff, writing 0x105) Nov 28 08:08:56 vlD-kuci kernel: [10304.807751] radeon 0000:01:00.0: restoring config space at offset 0x8 (was 0x1, writing 0x4001) Nov 28 08:08:56 vlD-kuci kernel: [10304.807757] radeon 0000:01:00.0: restoring config space at offset 0x6 (was 0x4, writing 0xd8100004) Nov 28 08:08:56 vlD-kuci kernel: [10304.807763] radeon 0000:01:00.0: restoring config space at offset 0x4 (was 0xc, writing 0xd000000c) Nov 28 08:08:56 vlD-kuci kernel: [10304.807768] radeon 0000:01:00.0: restoring config space at offset 0x3 (was 0x800000, writing 0x800008) Nov 28 08:08:56 vlD-kuci kernel: [10304.807774] radeon 0000:01:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100507) Nov 28 08:08:56 vlD-kuci kernel: [10304.807820] pci 0000:01:00.1: restoring config space at offset 0x4 (was 0x4, writing 0xd8110004) Nov 28 08:08:56 vlD-kuci kernel: [10304.807825] pci 0000:01:00.1: restoring config space at offset 0x3 (was 0x0, writing 0x8) Nov 28 08:08:56 vlD-kuci kernel: [10304.807831] pci 0000:01:00.1: restoring config space at offset 0x1 (was 0x100000, writing 0x100007) Nov 28 08:08:56 vlD-kuci kernel: [10304.807872] e1000e 0000:02:00.0: restoring config space at offset 0xf (was 0x100, writing 0x105) Nov 28 08:08:56 vlD-kuci kernel: [10304.807899] e1000e 0000:02:00.0: restoring config space at offset 0x6 (was 0x1, writing 0x5001) Nov 28 08:08:56 vlD-kuci kernel: [10304.807907] e1000e 0000:02:00.0: restoring config space at offset 0x5 (was 0x0, writing 0xd8000000) Nov 28 08:08:56 vlD-kuci kernel: [10304.807915] e1000e 0000:02:00.0: restoring config space at offset 0x4 (was 0x0, writing 0xd8080000) Nov 28 08:08:56 vlD-kuci kernel: [10304.807928] e1000e 0000:02:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100107) Nov 28 08:08:56 vlD-kuci kernel: [10304.807980] sata_sil24 0000:04:00.0: restoring config space at offset 0xf (was 0x100, writing 0x109) Nov 28 08:08:56 vlD-kuci kernel: [10304.808018] sata_sil24 0000:04:00.0: restoring config space at offset 0x8 (was 0x1, writing 0x6001) Nov 28 08:08:56 vlD-kuci kernel: [10304.808028] sata_sil24 0000:04:00.0: restoring config space at offset 0x6 (was 0x4, writing 0xd8200004) Nov 28 08:08:56 vlD-kuci kernel: [10304.808037] sata_sil24 0000:04:00.0: restoring config space at offset 0x4 (was 0x4, writing 0xd8204004) Nov 28 08:08:56 vlD-kuci kernel: [10304.808044] sata_sil24 0000:04:00.0: restoring config space at offset 0x3 (was 0x0, writing 0x8) Nov 28 08:08:56 vlD-kuci kernel: [10304.808053] sata_sil24 0000:04:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100107) Nov 28 08:08:56 vlD-kuci kernel: [10304.808165] PM: early resume of devices complete after 1.044 msecs Nov 28 08:08:56 vlD-kuci kernel: [10304.808539] HDA Intel 0000:00:1b.0: PCI INT A -> GSI 22 (level, low) -> IRQ 22 Nov 28 08:08:56 vlD-kuci kernel: [10304.808549] HDA Intel 0000:00:1b.0: setting latency timer to 64 Nov 28 08:08:56 vlD-kuci kernel: [10304.808594] HDA Intel 0000:00:1b.0: irq 43 for MSI/MSI-X Nov 28 08:08:56 vlD-kuci kernel: [10304.808646] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 23 (level, low) -> IRQ 23 Nov 28 08:08:56 vlD-kuci kernel: [10304.808655] uhci_hcd 0000:00:1d.0: setting latency timer to 64 Nov 28 08:08:56 vlD-kuci kernel: [10304.808679] usb usb2: root hub lost power or was reset Nov 28 08:08:56 vlD-kuci kernel: [10304.808703] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 19 (level, low) -> IRQ 19 Nov 28 08:08:56 vlD-kuci kernel: [10304.808711] uhci_hcd 0000:00:1d.1: setting latency timer to 64 Nov 28 08:08:56 vlD-kuci kernel: [10304.808733] usb usb3: root hub lost power or was reset Nov 28 08:08:56 vlD-kuci kernel: [10304.808755] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 Nov 28 08:08:56 vlD-kuci kernel: [10304.808764] uhci_hcd 0000:00:1d.2: setting latency timer to 64 Nov 28 08:08:56 vlD-kuci kernel: [10304.808786] usb usb4: root hub lost power or was reset Nov 28 08:08:56 vlD-kuci kernel: [10304.808808] uhci_hcd 0000:00:1d.3: PCI INT D -> GSI 16 (level, low) -> IRQ 16 Nov 28 08:08:56 vlD-kuci kernel: [10304.808817] uhci_hcd 0000:00:1d.3: setting latency timer to 64 Nov 28 08:08:56 vlD-kuci kernel: [10304.808839] usb usb5: root hub lost power or was reset Nov 28 08:08:56 vlD-kuci kernel: [10304.808862] ehci_hcd 0000:00:1d.7: PCI INT A -> GSI 23 (level, low) -> IRQ 23 Nov 28 08:08:56 vlD-kuci kernel: [10304.808871] ehci_hcd 0000:00:1d.7: setting latency timer to 64 Nov 28 08:08:56 vlD-kuci kernel: [10304.808924] pci 0000:00:1e.0: setting latency timer to 64 Nov 28 08:08:56 vlD-kuci kernel: [10304.808940] ata_piix 0000:00:1f.1: PCI INT A -> GSI 18 (level, low) -> IRQ 18 Nov 28 08:08:56 vlD-kuci kernel: [10304.808947] ata_piix 0000:00:1f.1: setting latency timer to 64 Nov 28 08:08:56 vlD-kuci kernel: [10304.808972] radeon 0000:01:00.0: setting latency timer to 64 Nov 28 08:08:56 vlD-kuci kernel: [10304.808983] radeon 0000:01:00.0: f13e8200 unpin not necessary Nov 28 08:08:56 vlD-kuci kernel: [10304.808989] pcieport 0000:00:1c.0: wake-up capability disabled by ACPI Nov 28 08:08:56 vlD-kuci kernel: [10304.809012] e1000e 0000:02:00.0: PME# disabled Nov 28 08:08:56 vlD-kuci kernel: [10304.809122] e1000e 0000:02:00.0: Disabling ASPM L1 Nov 28 08:08:56 vlD-kuci kernel: [10304.809213] e1000e 0000:02:00.0: irq 45 for MSI/MSI-X Nov 28 08:08:56 vlD-kuci kernel: [10304.810096] sata_sil24 0000:04:00.0: PCI INT A -> GSI 17 (level, low) -> IRQ 17 Nov 28 08:08:56 vlD-kuci kernel: [10304.810104] sata_sil24 0000:04:00.0: setting latency timer to 64 Nov 28 08:08:56 vlD-kuci kernel: [10304.812702] sd 0:0:0:0: [sda] Starting disk Nov 28 08:08:56 vlD-kuci kernel: [10304.817152] ata2: port disabled. ignoring. Nov 28 08:08:56 vlD-kuci kernel: [10304.833436] i8042 aux 00:09: activated Nov 28 08:08:56 vlD-kuci kernel: [10304.839323] [drm] PCIE GART of 512M enabled (table at 0xD0040000). Nov 28 08:08:56 vlD-kuci kernel: [10304.839336] [drm] radeon: 2 quad pipes, 1 z pipes initialized. Nov 28 08:08:56 vlD-kuci kernel: [10304.839374] [drm] radeon: ring at 0x00000000B0000000 Nov 28 08:08:56 vlD-kuci kernel: [10304.839575] [drm] ring test succeeded in 1 usecs Nov 28 08:08:56 vlD-kuci kernel: [10304.839596] [drm] ib test succeeded in 0 usecs Nov 28 08:08:56 vlD-kuci kernel: [10304.841478] sd 3:0:0:0: [sdc] Starting disk Nov 28 08:08:56 vlD-kuci kernel: [10304.851467] parport_pc 00:0d: activated Nov 28 08:08:56 vlD-kuci kernel: [10304.851771] tpm_tis 00:0e: activated Nov 28 08:08:56 vlD-kuci kernel: [10304.957055] PM: resume of drv:usb dev:usb4 complete after 144.365 msecs Nov 28 08:08:56 vlD-kuci kernel: [10304.957069] PM: resume of drv:hub dev:4-0:1.0 complete after 144.374 msecs Nov 28 08:08:56 vlD-kuci kernel: [10304.957084] PM: resume of drv:usb dev:usb3 complete after 144.400 msecs Nov 28 08:08:56 vlD-kuci kernel: [10304.957109] PM: resume of drv:usb dev:usb2 complete after 144.428 msecs Nov 28 08:08:56 vlD-kuci kernel: [10304.957114] PM: resume of drv:hub dev:3-0:1.0 complete after 144.427 msecs Nov 28 08:08:56 vlD-kuci kernel: [10304.957122] PM: resume of drv:hub dev:2-0:1.0 complete after 144.441 msecs Nov 28 08:08:56 vlD-kuci kernel: [10305.061019] PM: resume of drv:usb dev:usb5 complete after 248.324 msecs Nov 28 08:08:56 vlD-kuci kernel: [10305.061032] PM: resume of drv:hub dev:5-0:1.0 complete after 248.332 msecs Nov 28 08:08:56 vlD-kuci kernel: [10305.173019] usb 5-1: reset full speed USB device using uhci_hcd and address 2 Nov 28 08:08:56 vlD-kuci kernel: [10305.322475] option 5-1:1.0: no reset_resume for driver option? Nov 28 08:08:56 vlD-kuci kernel: [10305.322479] option 5-1:1.1: no reset_resume for driver option? Nov 28 08:08:56 vlD-kuci kernel: [10305.322633] option1 ttyUSB0: GSM modem (1-port) converter now disconnected from ttyUSB0 Nov 28 08:08:56 vlD-kuci kernel: [10305.322649] option 5-1:1.0: device disconnected Nov 28 08:08:56 vlD-kuci kernel: [10305.322716] option1 ttyUSB1: GSM modem (1-port) converter now disconnected from ttyUSB1 Nov 28 08:08:56 vlD-kuci kernel: [10305.322740] option 5-1:1.1: device disconnected Nov 28 08:08:56 vlD-kuci kernel: [10305.322747] PM: resume of drv:usb dev:5-1 complete after 505.559 msecs Nov 28 08:08:56 vlD-kuci kernel: [10305.322763] PM: resume of drv:usb dev:5-1:1.0 complete after 505.570 msecs Nov 28 08:08:56 vlD-kuci kernel: [10305.322768] PM: resume of drv:usb-storage dev:5-1:1.2 complete after 505.570 msecs Nov 28 08:08:56 vlD-kuci kernel: [10305.322774] PM: resume of drv:usb dev:5-1:1.1 complete after 505.580 msecs Nov 28 08:08:56 vlD-kuci kernel: [10305.322784] PM: resume of drv:scsi dev:host7 complete after 505.586 msecs Nov 28 08:08:56 vlD-kuci kernel: [10305.322797] PM: resume of drv:scsi_host dev:host7 complete after 505.596 msecs Nov 28 08:08:56 vlD-kuci kernel: [10305.322805] PM: resume of drv:scsi dev:target7:0:0 complete after 483.285 msecs Nov 28 08:08:56 vlD-kuci kernel: [10305.322817] PM: resume of drv:sr dev:7:0:0:0 complete after 483.271 msecs Nov 28 08:08:56 vlD-kuci kernel: [10305.322828] PM: resume of drv:scsi_device dev:7:0:0:0 complete after 483.251 msecs Nov 28 08:08:56 vlD-kuci kernel: [10306.849017] tpm_tis 00:0e: tpm_transmit: tpm_send: error 4294967234 Nov 28 08:08:56 vlD-kuci kernel: [10306.849023] PM: resume of drv:tpm_tis dev:00:0e complete after 1997.550 msecs Nov 28 08:08:56 vlD-kuci kernel: [10306.892030] ata3: SATA link down (SStatus 0 SControl 0) Nov 28 08:08:56 vlD-kuci kernel: [10307.007435] PM: resume of drv:i8042 dev:i8042 complete after 158.273 msecs Nov 28 08:08:56 vlD-kuci kernel: [10307.566550] psmouse serio1: ID: 10 00 64 Nov 28 08:08:56 vlD-kuci kernel: [10309.852014] ata1: link is slow to respond, please be patient (ready=0) Nov 28 08:08:56 vlD-kuci kernel: [10312.648328] ata1.01: ACPI cmd ef/03:0c:00:00:00:b0 (SET FEATURES) filtered out Nov 28 08:08:56 vlD-kuci kernel: [10312.648333] ata1.01: ACPI cmd ef/03:42:00:00:00:b0 (SET FEATURES) filtered out Nov 28 08:08:56 vlD-kuci kernel: [10312.648337] ata1.01: ACPI cmd f5/00:00:00:00:00:b0 (SECURITY FREEZE LOCK) filtered out Nov 28 08:08:56 vlD-kuci kernel: [10312.680321] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out Nov 28 08:08:56 vlD-kuci kernel: [10312.680326] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out Nov 28 08:08:56 vlD-kuci kernel: [10312.680330] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out Nov 28 08:08:56 vlD-kuci kernel: [10312.704445] ata1.00: configured for UDMA/33 Nov 28 08:08:56 vlD-kuci kernel: [10312.721234] ata1.01: configured for UDMA/33 Nov 28 08:08:56 vlD-kuci kernel: [10312.737674] PM: resume of drv:sd dev:0:0:0:0 complete after 7924.971 msecs Nov 28 08:08:56 vlD-kuci kernel: [10312.737687] PM: resume of drv:scsi_device dev:0:0:0:0 complete after 7924.920 msecs Nov 28 08:08:56 vlD-kuci kernel: [10312.737695] PM: resume of drv:scsi_disk dev:0:0:0:0 complete after 5730.183 msecs Nov 28 08:08:56 vlD-kuci kernel: [10314.821020] ata4: softreset failed (timeout) Nov 28 08:08:56 vlD-kuci kernel: [10315.740005] Nov 28 08:08:56 vlD-kuci kernel: [10315.740008] floppy driver state Nov 28 08:08:56 vlD-kuci kernel: [10315.740010] ------------------- Nov 28 08:08:56 vlD-kuci kernel: [10315.740028] now=2503934 last interrupt=2857 diff=2501077 last called handler=seek_interrupt Nov 28 08:08:56 vlD-kuci kernel: [10315.740031] timeout_message=lock fdc Nov 28 08:08:56 vlD-kuci kernel: [10315.740033] last output bytes: Nov 28 08:08:56 vlD-kuci kernel: [10315.740036] 8 80 4294892612 Nov 28 08:08:56 vlD-kuci kernel: [10315.740038] 8 80 4294892612 Nov 28 08:08:56 vlD-kuci kernel: [10315.740041] 8 80 4294892612 Nov 28 08:08:56 vlD-kuci kernel: [10315.740043] 8 80 4294892612 Nov 28 08:08:56 vlD-kuci kernel: [10315.740045] 12 80 2855 Nov 28 08:08:56 vlD-kuci kernel: [10315.740047] 0 90 2855 Nov 28 08:08:56 vlD-kuci kernel: [10315.740049] 13 80 2855 Nov 28 08:08:56 vlD-kuci kernel: [10315.740052] 0 90 2855 Nov 28 08:08:56 vlD-kuci kernel: [10315.740054] 1a 90 2855 Nov 28 08:08:56 vlD-kuci kernel: [10315.740056] 0 90 2855 Nov 28 08:08:56 vlD-kuci kernel: [10315.740058] 3 80 2855 Nov 28 08:08:56 vlD-kuci kernel: [10315.740060] c1 90 2855 Nov 28 08:08:56 vlD-kuci kernel: [10315.740062] 10 90 2855 Nov 28 08:08:56 vlD-kuci kernel: [10315.740064] 7 80 2855 Nov 28 08:08:56 vlD-kuci kernel: [10315.740067] 0 90 2855 Nov 28 08:08:56 vlD-kuci kernel: [10315.740069] 8 81 2855 Nov 28 08:08:56 vlD-kuci kernel: [10315.740071] f 80 2856 Nov 28 08:08:56 vlD-kuci kernel: [10315.740073] 0 90 2856 Nov 28 08:08:56 vlD-kuci kernel: [10315.740075] 1 90 2856 Nov 28 08:08:56 vlD-kuci kernel: [10315.740077] 8 81 2857 Nov 28 08:08:56 vlD-kuci kernel: [10315.740079] last result at 2857 Nov 28 08:08:56 vlD-kuci kernel: [10315.740081] last redo_fd_request at 2862 Nov 28 08:08:56 vlD-kuci kernel: [10315.740085] 20 01 . Nov 28 08:08:56 vlD-kuci kernel: [10315.740092] status=0 Nov 28 08:08:56 vlD-kuci kernel: [10315.740094] fdc_busy=1 Nov 28 08:08:56 vlD-kuci kernel: [10315.740100] do_floppy=reset_interrupt Nov 28 08:08:56 vlD-kuci kernel: [10315.740107] cont=f80d64d4 Nov 28 08:08:56 vlD-kuci kernel: [10315.740109] current_req=(null) Nov 28 08:08:56 vlD-kuci kernel: [10315.740111] command_status=-1 Nov 28 08:08:56 vlD-kuci kernel: [10315.740112] Nov 28 08:08:56 vlD-kuci kernel: [10315.740116] floppy0: floppy timeout called Nov 28 08:08:56 vlD-kuci kernel: [10315.740129] PM: resume of drv:floppy dev:floppy.0 complete after 3002.413 msecs Nov 28 08:08:56 vlD-kuci kernel: [10317.037038] ata4: SATA link up 3.0 Gbps (SStatus 123 SControl 0) Nov 28 08:08:56 vlD-kuci kernel: [10317.039287] ata4.00: configured for UDMA/100 Nov 28 08:08:56 vlD-kuci kernel: [10317.058977] PM: resume of drv:sd dev:3:0:0:0 complete after 12217.499 msecs Nov 28 08:08:56 vlD-kuci kernel: [10317.058994] PM: resume of drv:scsi_device dev:3:0:0:0 complete after 12217.491 msecs Nov 28 08:08:56 vlD-kuci kernel: [10317.059002] PM: resume of drv:scsi_disk dev:3:0:0:0 complete after 1318.838 msecs Nov 28 08:08:56 vlD-kuci kernel: [10317.059050] PM: resume of devices complete after 12250.839 msecs Nov 28 08:08:56 vlD-kuci kernel: [10317.059198] option 5-1:1.0: GSM modem (1-port) converter detected Nov 28 08:08:56 vlD-kuci kernel: [10317.059315] usb 5-1: GSM modem (1-port) converter now attached to ttyUSB1 Nov 28 08:08:56 vlD-kuci kernel: [10317.059409] option 5-1:1.1: GSM modem (1-port) converter detected Nov 28 08:08:56 vlD-kuci kernel: [10317.059490] usb 5-1: GSM modem (1-port) converter now attached to ttyUSB2 Nov 28 08:08:56 vlD-kuci kernel: [10317.059646] PM: resume devices took 12.248 seconds Nov 28 08:08:56 vlD-kuci kernel: [10317.059648] ------------[ cut here ]------------ Nov 28 08:08:56 vlD-kuci kernel: [10317.059655] WARNING: at /build/buildd/linux-2.6.35/kernel/power/suspend_test.c:53 suspend_test_finish+0x89/0x90() Nov 28 08:08:56 vlD-kuci kernel: [10317.059658] Hardware name: 816775G Nov 28 08:08:56 vlD-kuci kernel: [10317.059660] Component: resume devices, time: 12248 Nov 28 08:08:56 vlD-kuci kernel: [10317.059662] Modules linked in: snd_seq_dummy ppp_deflate zlib_deflate bsd_comp ppp_async crc_ccitt binfmt_misc reiserfs nls_iso8859_1 nls_cp437 vfat fat snd_hda_codec_analog snd_hda_intel snd_hda_codec snd_hwdep radeon snd_pcm snd_seq_midi snd_rawmidi snd_seq_midi_event ttm snd_seq drm_kms_helper snd_timer snd_seq_device ppdev tpm_tis option parport_pc usb_wwan tpm tpm_bios usbserial snd drm i2c_scmi intel_agp psmouse led_class soundcore serio_raw i2c_algo_bit snd_page_alloc agpgart lp parport usb_storage e1000e floppy sata_sil24 Nov 28 08:08:56 vlD-kuci kernel: [10317.059702] Pid: 31263, comm: pm-suspend Not tainted 2.6.35-23-generic #40-Ubuntu Nov 28 08:08:56 vlD-kuci kernel: [10317.059704] Call Trace: Nov 28 08:08:56 vlD-kuci kernel: [10317.059712] [] warn_slowpath_common+0x72/0xa0 Nov 28 08:08:56 vlD-kuci kernel: [10317.059716] [] ? suspend_test_finish+0x89/0x90 Nov 28 08:08:56 vlD-kuci kernel: [10317.059719] [] ? suspend_test_finish+0x89/0x90 Nov 28 08:08:56 vlD-kuci kernel: [10317.059723] [] warn_slowpath_fmt+0x33/0x40 Nov 28 08:08:56 vlD-kuci kernel: [10317.059727] [] suspend_test_finish+0x89/0x90 Nov 28 08:08:56 vlD-kuci kernel: [10317.059731] [] suspend_devices_and_enter+0xbf/0xf0 Nov 28 08:08:56 vlD-kuci kernel: [10317.059734] [] enter_state+0xbd/0xf0 Nov 28 08:08:56 vlD-kuci kernel: [10317.059738] [] state_store+0x6d/0xb0 Nov 28 08:08:56 vlD-kuci kernel: [10317.059741] [] ? state_store+0x0/0xb0 Nov 28 08:08:56 vlD-kuci kernel: [10317.059746] [] kobj_attr_store+0x20/0x30 Nov 28 08:08:56 vlD-kuci kernel: [10317.059751] [] sysfs_write_file+0x99/0xf0 Nov 28 08:08:56 vlD-kuci kernel: [10317.059756] [] vfs_write+0xa2/0x190 Nov 28 08:08:56 vlD-kuci kernel: [10317.059760] [] ? sysfs_write_file+0x0/0xf0 Nov 28 08:08:56 vlD-kuci kernel: [10317.059764] [] sys_write+0x42/0x70 Nov 28 08:08:56 vlD-kuci kernel: [10317.059769] [] syscall_call+0x7/0xb Nov 28 08:08:56 vlD-kuci kernel: [10317.059772] ---[ end trace e0cebc621f1ba168 ]--- Nov 28 08:08:56 vlD-kuci kernel: [10317.059914] PM: Finishing wakeup. Nov 28 08:08:56 vlD-kuci kernel: [10317.059916] Restarting tasks ... done. Nov 28 08:08:56 vlD-kuci modem-manager: Modem /org/freedesktop/ModemManager/Modems/0: state changed (registered -> disabled) Nov 28 08:08:56 vlD-kuci modem-manager: Removed modem /sys/devices/pci0000:00/0000:00:1d.3/usb5/5-1 Nov 28 08:08:58 vlD-kuci modem-manager: (Huawei): (ttyUSB2) deferring support check Nov 28 08:08:58 vlD-kuci modem-manager: (ttyUSB1) opening serial device... Nov 28 08:08:58 vlD-kuci modem-manager: (ttyUSB1): probe requested by plugin 'Huawei' Nov 28 08:08:59 vlD-kuci modem-manager: (ttyUSB1) closing serial device... Nov 28 08:08:59 vlD-kuci modem-manager: (ttyUSB1) opening serial device... Nov 28 08:08:59 vlD-kuci modem-manager: (Huawei): GSM modem /sys/devices/pci0000:00/0000:00:1d.3/usb5/5-1 claimed port ttyUSB1 Nov 28 08:08:59 vlD-kuci modem-manager: Added modem /sys/devices/pci0000:00/0000:00:1d.3/usb5/5-1 Nov 28 08:08:59 vlD-kuci modem-manager: (tty/ttyUSB1): outstanding support task prevents export of /sys/devices/pci0000:00/0000:00:1d.3/usb5/5-1 Nov 28 08:08:59 vlD-kuci modem-manager: (tty/ttyUSB2): outstanding support task prevents export of /sys/devices/pci0000:00/0000:00:1d.3/usb5/5-1 Nov 28 08:08:59 vlD-kuci modem-manager: (tty/ttyUSB2): outstanding support task prevents export of /sys/devices/pci0000:00/0000:00:1d.3/usb5/5-1 Nov 28 08:08:59 vlD-kuci modem-manager: (ttyUSB1) closing serial device... Nov 28 08:09:01 vlD-kuci modem-manager: (ttyUSB2): re-checking support... Nov 28 08:09:01 vlD-kuci modem-manager: (ttyUSB2) opening serial device... Nov 28 08:09:07 vlD-kuci modem-manager: (ttyUSB2) closing serial device... Nov 28 08:09:07 vlD-kuci modem-manager: (Huawei): GSM modem /sys/devices/pci0000:00/0000:00:1d.3/usb5/5-1 claimed port ttyUSB2 Nov 28 08:09:07 vlD-kuci modem-manager: Exported modem /sys/devices/pci0000:00/0000:00:1d.3/usb5/5-1 as /org/freedesktop/ModemManager/Modems/1 Nov 28 08:09:07 vlD-kuci modem-manager: (/org/freedesktop/ModemManager/Modems/1): data port is ttyUSB1 Nov 28 08:09:08 vlD-kuci modem-manager: (ttyUSB1) opening serial device... Nov 28 08:09:08 vlD-kuci modem-manager: Modem /org/freedesktop/ModemManager/Modems/1: state changed (disabled -> enabling) Nov 28 08:09:08 vlD-kuci modem-manager: (ttyUSB2) opening serial device... Nov 28 08:09:08 vlD-kuci modem-manager: Modem /org/freedesktop/ModemManager/Modems/1: state changed (enabling -> enabled) Nov 28 08:09:08 vlD-kuci modem-manager: CS registration state changed: 1 Nov 28 08:09:08 vlD-kuci modem-manager: Modem /org/freedesktop/ModemManager/Modems/1: state changed (enabled -> registered) Nov 28 08:09:08 vlD-kuci modem-manager: PS registration state changed: 1 Nov 28 08:09:08 vlD-kuci modem-manager: Modem /org/freedesktop/ModemManager/Modems/1: state changed (registered -> connecting) Nov 28 08:09:08 vlD-kuci modem-manager: Modem /org/freedesktop/ModemManager/Modems/1: state changed (connecting -> connected) Nov 28 08:09:08 vlD-kuci modem-manager: (net/ppp0): could not get port's parent device Nov 28 08:09:13 vlD-kuci modem-manager: Access Technology: 6 Nov 28 08:09:14 vlD-kuci modem-manager: Duration: 2 Up: 1 Kbps Down: 1 Kbps Total: 0 Total: 0 Nov 28 08:09:17 vlD-kuci modem-manager: Duration: 4 Up: 1 Kbps Down: 2 Kbps Total: 0 Total: 1 Nov 28 08:09:19 vlD-kuci modem-manager: Duration: 6 Up: 0 Kbps Down: 0 Kbps Total: 0 Total: 1 Nov 28 08:09:21 vlD-kuci modem-manager: Duration: 8 Up: 0 Kbps Down: 0 Kbps Total: 0 Total: 1 Nov 28 08:09:23 vlD-kuci modem-manager: Duration: 10 Up: 0 Kbps Down: 0 Kbps Total: 0 Total: 1 Nov 28 08:09:25 vlD-kuci modem-manager: Access Technology: 5 Nov 28 08:09:25 vlD-kuci modem-manager: Duration: 12 Up: 0 Kbps Down: 0 Kbps Total: 0 Total: 1 Nov 28 08:09:27 vlD-kuci modem-manager: Access Technology: 6 Nov 28 08:09:27 vlD-kuci modem-manager: Duration: 14 Up: 0 Kbps Down: 1 Kbps Total: 0 Total: 1 Nov 28 08:09:29 vlD-kuci modem-manager: Duration: 16 Up: 9 Kbps Down: 14 Kbps Total: 3 Total: 5 Nov 28 08:09:31 vlD-kuci modem-manager: Duration: 18 Up: 8 Kbps Down: 31 Kbps Total: 5 Total: 12 Nov 28 08:09:33 vlD-kuci modem-manager: Duration: 20 Up: 3 Kbps Down: 3 Kbps Total: 5 Total: 13 Nov 28 08:09:35 vlD-kuci modem-manager: Duration: 22 Up: 3 Kbps Down: 32 Kbps Total: 6 Total: 21 Nov 28 08:09:37 vlD-kuci modem-manager: Duration: 24 Up: 25 Kbps Down: 13 Kbps Total: 13 Total: 25 Nov 28 08:09:39 vlD-kuci modem-manager: Duration: 26 Up: 9 Kbps Down: 70 Kbps Total: 15 Total: 42 Nov 28 08:09:41 vlD-kuci modem-manager: Duration: 28 Up: 14 Kbps Down: 60 Kbps Total: 18 Total: 57 Nov 28 08:09:43 vlD-kuci modem-manager: Duration: 30 Up: 23 Kbps Down: 438 Kbps Total: 24 Total: 164 Nov 28 08:09:45 vlD-kuci modem-manager: Duration: 32 Up: 4 Kbps Down: 3 Kbps Total: 25 Total: 164 Nov 28 08:09:47 vlD-kuci modem-manager: Duration: 34 Up: 0 Kbps Down: 4 Kbps Total: 26 Total: 165 Nov 28 08:09:49 vlD-kuci modem-manager: Duration: 36 Up: 0 Kbps Down: 0 Kbps Total: 26 Total: 165 Nov 28 08:09:51 vlD-kuci modem-manager: Duration: 38 Up: 0 Kbps Down: 0 Kbps Total: 26 Total: 165 Nov 28 08:09:53 vlD-kuci modem-manager: Duration: 40 Up: 0 Kbps Down: 0 Kbps Total: 26 Total: 165 Nov 28 08:09:54 vlD-kuci modem-manager: Access Technology: 5 Nov 28 08:09:55 vlD-kuci modem-manager: Duration: 42 Up: 0 Kbps Down: 0 Kbps Total: 26 Total: 165 Nov 28 08:09:57 vlD-kuci modem-manager: Duration: 44 Up: 0 Kbps Down: 0 Kbps Total: 26 Total: 165 Nov 28 08:09:59 vlD-kuci modem-manager: Access Technology: 6 Nov 28 08:09:59 vlD-kuci modem-manager: Duration: 46 Up: 3 Kbps Down: 0 Kbps Total: 26 Total: 166 Nov 28 08:10:01 vlD-kuci modem-manager: Duration: 48 Up: 0 Kbps Down: 0 Kbps Total: 27 Total: 166 Nov 28 08:10:03 vlD-kuci modem-manager: Duration: 50 Up: 0 Kbps Down: 0 Kbps Total: 27 Total: 166 Nov 28 08:10:05 vlD-kuci modem-manager: Duration: 52 Up: 0 Kbps Down: 0 Kbps Total: 27 Total: 166 Nov 28 08:10:07 vlD-kuci modem-manager: Duration: 54 Up: 0 Kbps Down: 0 Kbps Total: 27 Total: 166 Nov 28 08:10:09 vlD-kuci modem-manager: Duration: 56 Up: 0 Kbps Down: 0 Kbps Total: 27 Total: 166 Nov 28 08:10:11 vlD-kuci modem-manager: Duration: 58 Up: 0 Kbps Down: 0 Kbps Total: 27 Total: 166 Nov 28 08:10:12 vlD-kuci modem-manager: Access Technology: 5 Nov 28 08:10:13 vlD-kuci modem-manager: Duration: 60 Up: 1 Kbps Down: 0 Kbps Total: 27 Total: 166 Nov 28 08:10:14 vlD-kuci modem-manager: Access Technology: 6 Nov 28 08:10:15 vlD-kuci modem-manager: Duration: 62 Up: 2 Kbps Down: 1 Kbps Total: 27 Total: 166 Nov 28 08:10:17 vlD-kuci modem-manager: Duration: 64 Up: 0 Kbps Down: 0 Kbps Total: 27 Total: 166 Nov 28 08:10:19 vlD-kuci modem-manager: Duration: 66 Up: 0 Kbps Down: 0 Kbps Total: 27 Total: 166 Nov 28 08:10:21 vlD-kuci modem-manager: Duration: 68 Up: 0 Kbps Down: 0 Kbps Total: 27 Total: 166 Nov 28 08:10:23 vlD-kuci modem-manager: Duration: 70 Up: 0 Kbps Down: 0 Kbps Total: 27 Total: 166 Nov 28 08:10:23 vlD-kuci modem-manager: Access Technology: 5 Nov 28 08:10:25 vlD-kuci modem-manager: Duration: 72 Up: 0 Kbps Down: 0 Kbps Total: 27 Total: 166 Nov 28 08:10:27 vlD-kuci modem-manager: Duration: 74 Up: 0 Kbps Down: 0 Kbps Total: 27 Total: 166 Nov 28 08:10:29 vlD-kuci modem-manager: Duration: 76 Up: 0 Kbps Down: 0 Kbps Total: 27 Total: 166 Nov 28 08:10:31 vlD-kuci modem-manager: Duration: 78 Up: 0 Kbps Down: 0 Kbps Total: 27 Total: 166 Nov 28 08:10:33 vlD-kuci modem-manager: Duration: 80 Up: 0 Kbps Down: 0 Kbps Total: 27 Total: 166 Nov 28 08:10:35 vlD-kuci modem-manager: Duration: 82 Up: 0 Kbps Down: 0 Kbps Total: 27 Total: 166 Nov 28 08:10:37 vlD-kuci modem-manager: Duration: 84 Up: 0 Kbps Down: 0 Kbps Total: 27 Total: 166 Nov 28 08:10:39 vlD-kuci modem-manager: Duration: 86 Up: 0 Kbps Down: 0 Kbps Total: 27 Total: 166 Nov 28 08:10:41 vlD-kuci modem-manager: Duration: 88 Up: 0 Kbps Down: 0 Kbps Total: 27 Total: 166 Nov 28 08:10:43 vlD-kuci modem-manager: Duration: 90 Up: 0 Kbps Down: 0 Kbps Total: 27 Total: 166 Nov 28 08:10:45 vlD-kuci modem-manager: Duration: 92 Up: 0 Kbps Down: 0 Kbps Total: 28 Total: 166 Nov 28 08:10:47 vlD-kuci modem-manager: Duration: 94 Up: 0 Kbps Down: 0 Kbps Total: 28 Total: 167 Nov 28 08:10:49 vlD-kuci modem-manager: Duration: 96 Up: 0 Kbps Down: 0 Kbps Total: 28 Total: 167 Nov 28 08:10:51 vlD-kuci modem-manager: Duration: 98 Up: 0 Kbps Down: 0 Kbps Total: 28 Total: 167