[  226.490637] IBM machine detected. Enabling interrupts during APM calls.
[  226.490643] apm: BIOS not found.
[  345.920906] PPP BSD Compression module registered
[  346.031115] PPP Deflate Compression module registered
[10303.749342] PM: Syncing filesystems ... done.
[10303.837106] PM: Preparing system for mem sleep
[10303.896534] Freezing user space processes ... (elapsed 0.01 seconds) done.
[10303.916052] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
[10303.932028] PM: Entering mem sleep
[10303.932127] Suspending console(s) (use no_console_suspend to debug)
[10303.932491] sd 3:0:0:0: [sdc] Synchronizing SCSI cache
[10303.932627] sd 3:0:0:0: [sdc] Stopping disk
[10303.932753] sd 0:0:0:0: [sda] Synchronizing SCSI cache
[10303.937969] option: option_instat_callback: error -2
[10303.943499] tpm_tis 00:0e: disabled
[10303.947399] parport_pc 00:0d: disabled
[10303.949660] i8042 aux 00:09: disabled
[10303.949876] sata_sil24 0000:04:00.0: PCI INT A disabled
[10303.950317] uhci_hcd 0000:00:1d.2: PCI INT C disabled
[10303.950371] uhci_hcd 0000:00:1d.1: PCI INT B disabled
[10303.950425] uhci_hcd 0000:00:1d.0: PCI INT A disabled
[10303.953068] uhci_hcd 0000:00:1d.3: PCI INT D disabled
[10303.968167] ehci_hcd 0000:00:1d.7: PCI INT A disabled
[10303.982202] sd 0:0:0:0: [sda] Stopping disk
[10304.029344] e1000e 0000:02:00.0: PCI INT A disabled
[10304.029354] e1000e 0000:02:00.0: PME# enabled
[10304.029370] pcieport 0000:00:1c.0: wake-up capability enabled by ACPI
[10304.052068] HDA Intel 0000:00:1b.0: PCI INT A disabled
[10304.068019] PM: suspend of drv:HDA Intel dev:0000:00:1b.0 complete after 117.459 msecs
[10304.585601] PM: suspend of drv:sd dev:0:0:0:0 complete after 652.850 msecs
[10304.585618] PM: suspend of drv:scsi dev:target0:0:0 complete after 652.864 msecs
[10304.585633] PM: suspend of drv:scsi dev:host0 complete after 643.267 msecs
[10304.585783] ata_piix 0000:00:1f.1: PCI INT A disabled
[10304.585789] PM: suspend of drv:ata_piix dev:0000:00:1f.1 complete after 635.691 msecs
[10304.585800] PM: suspend of drv: dev:pci0000:00 complete after 634.648 msecs
[10304.585809] PM: suspend of devices complete after 653.453 msecs
[10304.585813] PM: suspend devices took 0.652 seconds
[10304.600151] PM: late suspend of devices complete after 14.334 msecs
[10304.600481] ACPI: Preparing to enter system sleep state S3
[10304.624984] PM: Saving platform NVS memory
[10304.659080] Disabling non-boot CPUs ...
[10304.660694] CPU 1 is now offline
[10304.660698] SMP alternatives: switching to UP code
[10304.670162] Back to C!
[10304.670162] PM: Restoring platform NVS memory
[10304.670162] CPU0: Thermal monitoring handled by SMI
[10304.670162] Force enabled HPET at resume
[10304.670162] Enabling non-boot CPUs ...
[10304.670162] SMP alternatives: switching to SMP code
[10304.679518] Booting Node 0 Processor 1 APIC 0x1
[10304.669686] Initializing CPU#1
[10304.669686] CPU1: Thermal monitoring handled by SMI
[10304.804881] CPU1 is up
[10304.805829] ACPI: Waking up from system sleep state S3
[10304.807170] pcieport 0000:00:01.0: restoring config space at offset 0xf (was 0x40100, writing 0xc0105)
[10304.807179] pcieport 0000:00:01.0: restoring config space at offset 0xa (was 0xf, writing 0x0)
[10304.807184] pcieport 0000:00:01.0: restoring config space at offset 0x8 (was 0x0, writing 0xd810d810)
[10304.807189] pcieport 0000:00:01.0: restoring config space at offset 0x7 (was 0xf0, writing 0x4040)
[10304.807196] pcieport 0000:00:01.0: restoring config space at offset 0x3 (was 0x10000, writing 0x10008)
[10304.807201] pcieport 0000:00:01.0: restoring config space at offset 0x1 (was 0x100105, writing 0x100507)
[10304.807250] HDA Intel 0000:00:1b.0: restoring config space at offset 0x3 (was 0x0, writing 0x8)
[10304.807257] HDA Intel 0000:00:1b.0: restoring config space at offset 0x1 (was 0x100106, writing 0x100102)
[10304.807283] pcieport 0000:00:1c.0: restoring config space at offset 0xf (was 0x40100, writing 0x40109)
[10304.807294] pcieport 0000:00:1c.0: restoring config space at offset 0x9 (was 0x10001, writing 0x80118001)
[10304.807299] pcieport 0000:00:1c.0: restoring config space at offset 0x8 (was 0x0, writing 0xd800d800)
[10304.807305] pcieport 0000:00:1c.0: restoring config space at offset 0x7 (was 0x20000000, writing 0x5050)
[10304.807313] pcieport 0000:00:1c.0: restoring config space at offset 0x3 (was 0x810000, writing 0x810008)
[10304.807320] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100407)
[10304.807358] pcieport 0000:00:1c.1: restoring config space at offset 0xf (was 0x40200, writing 0x40205)
[10304.807369] pcieport 0000:00:1c.1: restoring config space at offset 0x9 (was 0x10001, writing 0x80318021)
[10304.807374] pcieport 0000:00:1c.1: restoring config space at offset 0x8 (was 0x0, writing 0xd820d820)
[10304.807380] pcieport 0000:00:1c.1: restoring config space at offset 0x7 (was 0x20000000, writing 0x6060)
[10304.807388] pcieport 0000:00:1c.1: restoring config space at offset 0x3 (was 0x810000, writing 0x810008)
[10304.807395] pcieport 0000:00:1c.1: restoring config space at offset 0x1 (was 0x100000, writing 0x100407)
[10304.807443] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001)
[10304.807472] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001)
[10304.807500] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001)
[10304.807528] uhci_hcd 0000:00:1d.3: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001)
[10304.807565] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102)
[10304.807593] pci 0000:00:1e.0: restoring config space at offset 0x9 (was 0x10011, writing 0x1fff1)
[10304.807599] pci 0000:00:1e.0: restoring config space at offset 0x8 (was 0x10, writing 0xfff0)
[10304.807604] pci 0000:00:1e.0: restoring config space at offset 0x7 (was 0x22800010, writing 0x228000f0)
[10304.807615] pci 0000:00:1e.0: restoring config space at offset 0x1 (was 0x100007, writing 0x100107)
[10304.807655] pci 0000:00:1f.0: restoring config space at offset 0x1 (was 0x2100007, writing 0x2100107)
[10304.807671] ata_piix 0000:00:1f.1: restoring config space at offset 0xf (was 0x100, writing 0x1ff)
[10304.807693] ata_piix 0000:00:1f.1: restoring config space at offset 0x1 (was 0x2800000, writing 0x2880005)
[10304.807740] radeon 0000:01:00.0: restoring config space at offset 0xf (was 0x1ff, writing 0x105)
[10304.807751] radeon 0000:01:00.0: restoring config space at offset 0x8 (was 0x1, writing 0x4001)
[10304.807757] radeon 0000:01:00.0: restoring config space at offset 0x6 (was 0x4, writing 0xd8100004)
[10304.807763] radeon 0000:01:00.0: restoring config space at offset 0x4 (was 0xc, writing 0xd000000c)
[10304.807768] radeon 0000:01:00.0: restoring config space at offset 0x3 (was 0x800000, writing 0x800008)
[10304.807774] radeon 0000:01:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100507)
[10304.807820] pci 0000:01:00.1: restoring config space at offset 0x4 (was 0x4, writing 0xd8110004)
[10304.807825] pci 0000:01:00.1: restoring config space at offset 0x3 (was 0x0, writing 0x8)
[10304.807831] pci 0000:01:00.1: restoring config space at offset 0x1 (was 0x100000, writing 0x100007)
[10304.807872] e1000e 0000:02:00.0: restoring config space at offset 0xf (was 0x100, writing 0x105)
[10304.807899] e1000e 0000:02:00.0: restoring config space at offset 0x6 (was 0x1, writing 0x5001)
[10304.807907] e1000e 0000:02:00.0: restoring config space at offset 0x5 (was 0x0, writing 0xd8000000)
[10304.807915] e1000e 0000:02:00.0: restoring config space at offset 0x4 (was 0x0, writing 0xd8080000)
[10304.807928] e1000e 0000:02:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100107)
[10304.807980] sata_sil24 0000:04:00.0: restoring config space at offset 0xf (was 0x100, writing 0x109)
[10304.808018] sata_sil24 0000:04:00.0: restoring config space at offset 0x8 (was 0x1, writing 0x6001)
[10304.808028] sata_sil24 0000:04:00.0: restoring config space at offset 0x6 (was 0x4, writing 0xd8200004)
[10304.808037] sata_sil24 0000:04:00.0: restoring config space at offset 0x4 (was 0x4, writing 0xd8204004)
[10304.808044] sata_sil24 0000:04:00.0: restoring config space at offset 0x3 (was 0x0, writing 0x8)
[10304.808053] sata_sil24 0000:04:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100107)
[10304.808165] PM: early resume of devices complete after 1.044 msecs
[10304.808539] HDA Intel 0000:00:1b.0: PCI INT A -> GSI 22 (level, low) -> IRQ 22
[10304.808549] HDA Intel 0000:00:1b.0: setting latency timer to 64
[10304.808594] HDA Intel 0000:00:1b.0: irq 43 for MSI/MSI-X
[10304.808646] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 23 (level, low) -> IRQ 23
[10304.808655] uhci_hcd 0000:00:1d.0: setting latency timer to 64
[10304.808679] usb usb2: root hub lost power or was reset
[10304.808703] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 19 (level, low) -> IRQ 19
[10304.808711] uhci_hcd 0000:00:1d.1: setting latency timer to 64
[10304.808733] usb usb3: root hub lost power or was reset
[10304.808755] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18
[10304.808764] uhci_hcd 0000:00:1d.2: setting latency timer to 64
[10304.808786] usb usb4: root hub lost power or was reset
[10304.808808] uhci_hcd 0000:00:1d.3: PCI INT D -> GSI 16 (level, low) -> IRQ 16
[10304.808817] uhci_hcd 0000:00:1d.3: setting latency timer to 64
[10304.808839] usb usb5: root hub lost power or was reset
[10304.808862] ehci_hcd 0000:00:1d.7: PCI INT A -> GSI 23 (level, low) -> IRQ 23
[10304.808871] ehci_hcd 0000:00:1d.7: setting latency timer to 64
[10304.808924] pci 0000:00:1e.0: setting latency timer to 64
[10304.808940] ata_piix 0000:00:1f.1: PCI INT A -> GSI 18 (level, low) -> IRQ 18
[10304.808947] ata_piix 0000:00:1f.1: setting latency timer to 64
[10304.808972] radeon 0000:01:00.0: setting latency timer to 64
[10304.808983] radeon 0000:01:00.0: f13e8200 unpin not necessary
[10304.808989] pcieport 0000:00:1c.0: wake-up capability disabled by ACPI
[10304.809012] e1000e 0000:02:00.0: PME# disabled
[10304.809122] e1000e 0000:02:00.0: Disabling ASPM  L1
[10304.809213] e1000e 0000:02:00.0: irq 45 for MSI/MSI-X
[10304.810096] sata_sil24 0000:04:00.0: PCI INT A -> GSI 17 (level, low) -> IRQ 17
[10304.810104] sata_sil24 0000:04:00.0: setting latency timer to 64
[10304.812702] sd 0:0:0:0: [sda] Starting disk
[10304.817152] ata2: port disabled. ignoring.
[10304.833436] i8042 aux 00:09: activated
[10304.839323] [drm] PCIE GART of 512M enabled (table at 0xD0040000).
[10304.839336] [drm] radeon: 2 quad pipes, 1 z pipes initialized.
[10304.839374] [drm] radeon: ring at 0x00000000B0000000
[10304.839575] [drm] ring test succeeded in 1 usecs
[10304.839596] [drm] ib test succeeded in 0 usecs
[10304.841478] sd 3:0:0:0: [sdc] Starting disk
[10304.851467] parport_pc 00:0d: activated
[10304.851771] tpm_tis 00:0e: activated
[10304.957055] PM: resume of drv:usb dev:usb4 complete after 144.365 msecs
[10304.957069] PM: resume of drv:hub dev:4-0:1.0 complete after 144.374 msecs
[10304.957084] PM: resume of drv:usb dev:usb3 complete after 144.400 msecs
[10304.957109] PM: resume of drv:usb dev:usb2 complete after 144.428 msecs
[10304.957114] PM: resume of drv:hub dev:3-0:1.0 complete after 144.427 msecs
[10304.957122] PM: resume of drv:hub dev:2-0:1.0 complete after 144.441 msecs
[10305.061019] PM: resume of drv:usb dev:usb5 complete after 248.324 msecs
[10305.061032] PM: resume of drv:hub dev:5-0:1.0 complete after 248.332 msecs
[10305.173019] usb 5-1: reset full speed USB device using uhci_hcd and address 2
[10305.322475] option 5-1:1.0: no reset_resume for driver option?
[10305.322479] option 5-1:1.1: no reset_resume for driver option?
[10305.322633] option1 ttyUSB0: GSM modem (1-port) converter now disconnected from ttyUSB0
[10305.322649] option 5-1:1.0: device disconnected
[10305.322716] option1 ttyUSB1: GSM modem (1-port) converter now disconnected from ttyUSB1
[10305.322740] option 5-1:1.1: device disconnected
[10305.322747] PM: resume of drv:usb dev:5-1 complete after 505.559 msecs
[10305.322763] PM: resume of drv:usb dev:5-1:1.0 complete after 505.570 msecs
[10305.322768] PM: resume of drv:usb-storage dev:5-1:1.2 complete after 505.570 msecs
[10305.322774] PM: resume of drv:usb dev:5-1:1.1 complete after 505.580 msecs
[10305.322784] PM: resume of drv:scsi dev:host7 complete after 505.586 msecs
[10305.322797] PM: resume of drv:scsi_host dev:host7 complete after 505.596 msecs
[10305.322805] PM: resume of drv:scsi dev:target7:0:0 complete after 483.285 msecs
[10305.322817] PM: resume of drv:sr dev:7:0:0:0 complete after 483.271 msecs
[10305.322828] PM: resume of drv:scsi_device dev:7:0:0:0 complete after 483.251 msecs
[10306.849017] tpm_tis 00:0e: tpm_transmit: tpm_send: error 4294967234
[10306.849023] PM: resume of drv:tpm_tis dev:00:0e complete after 1997.550 msecs
[10306.892030] ata3: SATA link down (SStatus 0 SControl 0)
[10307.007435] PM: resume of drv:i8042 dev:i8042 complete after 158.273 msecs
[10307.566550] psmouse serio1: ID: 10 00 64
[10309.852014] ata1: link is slow to respond, please be patient (ready=0)
[10312.648328] ata1.01: ACPI cmd ef/03:0c:00:00:00:b0 (SET FEATURES) filtered out
[10312.648333] ata1.01: ACPI cmd ef/03:42:00:00:00:b0 (SET FEATURES) filtered out
[10312.648337] ata1.01: ACPI cmd f5/00:00:00:00:00:b0 (SECURITY FREEZE LOCK) filtered out
[10312.680321] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out
[10312.680326] ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out
[10312.680330] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
[10312.704445] ata1.00: configured for UDMA/33
[10312.721234] ata1.01: configured for UDMA/33
[10312.737674] PM: resume of drv:sd dev:0:0:0:0 complete after 7924.971 msecs
[10312.737687] PM: resume of drv:scsi_device dev:0:0:0:0 complete after 7924.920 msecs
[10312.737695] PM: resume of drv:scsi_disk dev:0:0:0:0 complete after 5730.183 msecs
[10314.821020] ata4: softreset failed (timeout)
[10315.740005] 
[10315.740008] floppy driver state
[10315.740010] -------------------
[10315.740028] now=2503934 last interrupt=2857 diff=2501077 last called handler=seek_interrupt
[10315.740031] timeout_message=lock fdc
[10315.740033] last output bytes:
[10315.740036]  8 80 4294892612
[10315.740038]  8 80 4294892612
[10315.740041]  8 80 4294892612
[10315.740043]  8 80 4294892612
[10315.740045] 12 80 2855
[10315.740047]  0 90 2855
[10315.740049] 13 80 2855
[10315.740052]  0 90 2855
[10315.740054] 1a 90 2855
[10315.740056]  0 90 2855
[10315.740058]  3 80 2855
[10315.740060] c1 90 2855
[10315.740062] 10 90 2855
[10315.740064]  7 80 2855
[10315.740067]  0 90 2855
[10315.740069]  8 81 2855
[10315.740071]  f 80 2856
[10315.740073]  0 90 2856
[10315.740075]  1 90 2856
[10315.740077]  8 81 2857
[10315.740079] last result at 2857
[10315.740081] last redo_fd_request at 2862
[10315.740085] 20 01                                             .
[10315.740092] status=0
[10315.740094] fdc_busy=1
[10315.740100] do_floppy=reset_interrupt
[10315.740107] cont=f80d64d4
[10315.740109] current_req=(null)
[10315.740111] command_status=-1
[10315.740112] 
[10315.740116] floppy0: floppy timeout called
[10315.740129] PM: resume of drv:floppy dev:floppy.0 complete after 3002.413 msecs
[10317.037038] ata4: SATA link up 3.0 Gbps (SStatus 123 SControl 0)
[10317.039287] ata4.00: configured for UDMA/100
[10317.058977] PM: resume of drv:sd dev:3:0:0:0 complete after 12217.499 msecs
[10317.058994] PM: resume of drv:scsi_device dev:3:0:0:0 complete after 12217.491 msecs
[10317.059002] PM: resume of drv:scsi_disk dev:3:0:0:0 complete after 1318.838 msecs
[10317.059050] PM: resume of devices complete after 12250.839 msecs
[10317.059198] option 5-1:1.0: GSM modem (1-port) converter detected
[10317.059315] usb 5-1: GSM modem (1-port) converter now attached to ttyUSB1
[10317.059409] option 5-1:1.1: GSM modem (1-port) converter detected
[10317.059490] usb 5-1: GSM modem (1-port) converter now attached to ttyUSB2
[10317.059646] PM: resume devices took 12.248 seconds
[10317.059648] ------------[ cut here ]------------
[10317.059655] WARNING: at /build/buildd/linux-2.6.35/kernel/power/suspend_test.c:53 suspend_test_finish+0x89/0x90()
[10317.059658] Hardware name: 816775G
[10317.059660] Component: resume devices, time: 12248
[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
[10317.059702] Pid: 31263, comm: pm-suspend Not tainted 2.6.35-23-generic #40-Ubuntu
[10317.059704] Call Trace:
[10317.059712]  [<c014acf2>] warn_slowpath_common+0x72/0xa0
[10317.059716]  [<c01825c9>] ? suspend_test_finish+0x89/0x90
[10317.059719]  [<c01825c9>] ? suspend_test_finish+0x89/0x90
[10317.059723]  [<c014adc3>] warn_slowpath_fmt+0x33/0x40
[10317.059727]  [<c01825c9>] suspend_test_finish+0x89/0x90
[10317.059731]  [<c018239f>] suspend_devices_and_enter+0xbf/0xf0
[10317.059734]  [<c018248d>] enter_state+0xbd/0xf0
[10317.059738]  [<c0181afd>] state_store+0x6d/0xb0
[10317.059741]  [<c0181a90>] ? state_store+0x0/0xb0
[10317.059746]  [<c0351ec0>] kobj_attr_store+0x20/0x30
[10317.059751]  [<c0270199>] sysfs_write_file+0x99/0xf0
[10317.059756]  [<c0218ae2>] vfs_write+0xa2/0x190
[10317.059760]  [<c0270100>] ? sysfs_write_file+0x0/0xf0
[10317.059764]  [<c02193a2>] sys_write+0x42/0x70
[10317.059769]  [<c05c99f4>] syscall_call+0x7/0xb
[10317.059772] ---[ end trace e0cebc621f1ba168 ]---
[10317.059914] PM: Finishing wakeup.
[10317.059916] Restarting tasks ... done.