[192366.769194] WARNING: at /build/buildd/linux-2.6.31/kernel/power/suspend_test.c:52 suspend_test_finish+0x80/0x90() [192366.769198] Hardware name: T3882 [192366.769200] Component: resume devices [192366.769202] Modules linked in: binfmt_misc iptable_filter ip_tables x_tables snd_intel8x0 snd_ac97_codec ac97_bus snd_pcm_oss snd_mixer_oss snd_pcm snd_seq_dummy snd_seq_oss snd_seq_midi joydev snd_rawmidi snd_seq_midi_event fbcon tileblit font bitblit softcursor snd_seq lp i915 snd_timer snd_seq_device drm ppdev i2c_algo_bit snd video intel_agp soundcore parport_pc psmouse snd_page_alloc output agpgart shpchp serio_raw parport usb_storage usbhid e100 mii floppy [192366.769239] Pid: 11252, comm: pm-suspend Tainted: G W 2.6.31-12-generic #39-Ubuntu [192366.769242] Call Trace: [192366.769252] [] warn_slowpath_common+0x6d/0xa0 [192366.769256] [] ? suspend_test_finish+0x80/0x90 [192366.769260] [] ? suspend_test_finish+0x80/0x90 [192366.769264] [] warn_slowpath_fmt+0x26/0x30 [192366.769268] [] suspend_test_finish+0x80/0x90 [192366.769272] [] suspend_devices_and_enter+0x9f/0xd0 [192366.769278] [] ? printk+0x18/0x1a [192366.769282] [] enter_state+0xb9/0xf0 [192366.769285] [] state_store+0x6d/0xb0 [192366.769289] [] ? state_store+0x0/0xb0 [192366.769294] [] kobj_attr_store+0x20/0x30 [192366.769301] [] sysfs_write_file+0x90/0x100 [192366.769308] [] vfs_write+0x9a/0x190 [192366.769312] [] ? sysfs_write_file+0x0/0x100 [192366.769316] [] ? do_page_fault+0x19b/0x380 [192366.769320] [] sys_write+0x3d/0x70 [192366.769324] [] syscall_call+0x7/0xb [192366.769328] ---[ end trace cf48fd94f744a1ec ]--- [192366.769379] PM: Finishing wakeup. [192366.769381] Restarting tasks ... done. [192368.157778] ADDRCONF(NETDEV_UP): eth0: link is not ready [192370.000151] e100: eth0 NIC Link is Up 100 Mbps Full Duplex [192370.000380] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [192380.780014] eth0: no IPv6 routers present [194100.227908] PM: Syncing filesystems ... done. [194100.260871] PM: Preparing system for mem sleep [194100.260880] Freezing user space processes ... (elapsed 0.00 seconds) done. [194100.265448] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done. [194100.265598] PM: Entering mem sleep [194100.265618] Suspending console(s) (use no_console_suspend to debug) [194100.300034] sd 0:0:1:0: [sdb] Synchronizing SCSI cache [194100.712798] sd 0:0:1:0: [sdb] Stopping disk [194100.868297] sd 0:0:0:0: [sda] Synchronizing SCSI cache [194100.868436] sd 0:0:0:0: [sda] Stopping disk [194101.334780] parport_pc 00:08: disabled [194101.334940] serial 00:07: disabled [194101.334998] e100 0000:01:08.0: PME# enabled [194101.348217] Intel ICH 0000:00:1f.5: PCI INT B disabled [194101.348572] ata_piix 0000:00:1f.2: PCI INT A disabled [194101.348890] ata_piix 0000:00:1f.1: PCI INT A disabled [194101.348907] ehci_hcd 0000:00:1d.7: PCI INT D disabled [194101.348916] uhci_hcd 0000:00:1d.3: PCI INT A disabled [194101.348923] uhci_hcd 0000:00:1d.2: PCI INT C disabled [194101.348930] uhci_hcd 0000:00:1d.1: PCI INT B disabled [194101.348937] uhci_hcd 0000:00:1d.0: PCI INT A disabled [194101.373763] i915 0000:00:02.0: PCI INT A disabled [194101.388066] PM: suspend devices took 1.124 seconds [194101.388291] ehci_hcd 0000:00:1d.7: PME# disabled [194101.404278] ACPI: Preparing to enter system sleep state S3 [194101.404716] Disabling non-boot CPUs ... [194101.404742] Back to C! [194101.404742] Force enabled HPET at resume [194101.404742] ACPI: Waking up from system sleep state S3 [194101.404742] i915 0000:00:02.0: restoring config space at offset 0x1 (was 0x900007, writing 0x980007) [194101.404742] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [194101.404742] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [194101.404742] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [194101.404742] uhci_hcd 0000:00:1d.3: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001) [194101.404742] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102) [194101.404742] ehci_hcd 0000:00:1d.7: PME# disabled [194101.404742] ata_piix 0000:00:1f.1: restoring config space at offset 0x9 (was 0x0, writing 0x60000000) [194101.404742] ata_piix 0000:00:1f.1: restoring config space at offset 0x1 (was 0x2880005, writing 0x2880007) [194101.404742] Intel ICH 0000:00:1f.5: restoring config space at offset 0x1 (was 0x2900006, writing 0x2900002) [194101.404742] pci 0000:01:02.0: restoring config space at offset 0x1 (was 0x2900007, writing 0x2900107) [194101.404742] e100 0000:01:08.0: restoring config space at offset 0x1 (was 0x2900017, writing 0x2900117) [194101.404742] i915 0000:00:02.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [194101.404742] i915 0000:00:02.0: setting latency timer to 64 [194101.492933] [drm] DAC-5: set mode 1024x768 d [194101.493014] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [194101.493022] uhci_hcd 0000:00:1d.0: setting latency timer to 64 [194101.493042] usb usb2: root hub lost power or was reset [194101.493061] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 19 (level, low) -> IRQ 19 [194101.493068] uhci_hcd 0000:00:1d.1: setting latency timer to 64 [194101.493086] usb usb3: root hub lost power or was reset [194101.493116] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [194101.493122] uhci_hcd 0000:00:1d.2: setting latency timer to 64 [194101.493140] usb usb4: root hub lost power or was reset [194101.493164] uhci_hcd 0000:00:1d.3: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [194101.493171] uhci_hcd 0000:00:1d.3: setting latency timer to 64 [194101.493190] usb usb5: root hub lost power or was reset [194101.493207] ehci_hcd 0000:00:1d.7: PME# disabled [194101.493212] ehci_hcd 0000:00:1d.7: PCI INT D -> GSI 23 (level, low) -> IRQ 23 [194101.493219] ehci_hcd 0000:00:1d.7: setting latency timer to 64 [194101.493231] pci 0000:00:1e.0: setting latency timer to 64 [194101.493242] ata_piix 0000:00:1f.1: PCI INT A -> GSI 18 (level, low) -> IRQ 18 [194101.493248] ata_piix 0000:00:1f.1: setting latency timer to 64 [194101.497938] ata_piix 0000:00:1f.2: PCI INT A -> GSI 18 (level, low) -> IRQ 18 [194101.497944] ata_piix 0000:00:1f.2: setting latency timer to 64 [194101.497969] Intel ICH 0000:00:1f.5: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [194101.497976] Intel ICH 0000:00:1f.5: setting latency timer to 64 [194101.505969] pci 0000:01:02.0: PME# disabled [194101.505978] e100 0000:01:08.0: PME# disabled [194101.506908] serial 00:07: activated [194101.507786] parport_pc 00:08: activated [194101.676303] ata2.01: ACPI cmd ef/03:42:00:00:00:b0 filtered out [194101.676307] ata2.01: ACPI cmd ef/03:0c:00:00:00:b0 filtered out [194101.676727] ata2.00: ACPI cmd ef/03:42:00:00:00:a0 filtered out [194101.676731] ata2.00: ACPI cmd ef/03:0c:00:00:00:a0 filtered out [194101.676734] ata2.00: ACPI cmd f5/00:00:00:00:00:a0 filtered out [194101.677210] ata2.00: configured for UDMA/33 [194101.708201] ata2.01: configured for UDMA/33 [194102.052631] sd 0:0:0:0: [sda] Starting disk [194106.544023] ata1: link is slow to respond, please be patient (ready=0) [194107.212298] ata1.01: ACPI cmd ef/03:44:00:00:00:b0 filtered out [194107.212302] ata1.01: ACPI cmd ef/03:0c:00:00:00:b0 filtered out [194107.212631] ata1.01: ACPI cmd c6/00:10:00:00:00:b0 succeeded [194107.212635] ata1.01: ACPI cmd f5/00:00:00:00:00:b0 filtered out [194107.228294] ata1.00: ACPI cmd ef/03:45:00:00:00:a0 filtered out [194107.228298] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 filtered out [194107.228416] ata1.00: ACPI cmd c6/00:10:00:00:00:a0 succeeded [194107.228420] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 filtered out [194107.252312] ata1.00: configured for UDMA/100 [194107.269228] ata1.01: configured for UDMA/66 [194107.292305] ata1.00: configured for UDMA/100 [194107.309188] ata1.01: configured for UDMA/66 [194107.309193] ata1: EH complete [194107.312211] sd 0:0:1:0: [sdb] Starting disk [194110.312007] [194110.312011] floppy driver state [194110.312012] ------------------- [194110.312016] now=48452578 last interrupt=4294898499 diff=48521375 last called handler=f8069700 [194110.312019] timeout_message=lock fdc [194110.312021] last output bytes: [194110.312023] 8 80 4294892657 [194110.312025] 8 80 4294892657 [194110.312027] 8 80 4294892657 [194110.312029] 8 80 4294892657 [194110.312031] 12 80 4294898498 [194110.312032] 0 90 4294898498 [194110.312034] 13 90 4294898498 [194110.312036] 0 90 4294898498 [194110.312038] 1a 90 4294898498 [194110.312040] 0 90 4294898498 [194110.312042] 3 80 4294898498 [194110.312043] c1 90 4294898498 [194110.312045] 10 90 4294898498 [194110.312047] 7 80 4294898498 [194110.312049] 0 90 4294898498 [194110.312051] 8 81 4294898498 [194110.312053] f 80 4294898498 [194110.312054] 0 90 4294898498 [194110.312056] 1 90 4294898498 [194110.312058] 8 81 4294898499 [194110.312060] last result at 4294898499 [194110.312062] last redo_fd_request at 48016466 [194110.312063] 20 1 [194110.312073] status=0 [194110.312074] fdc_busy=1 [194110.312076] do_floppy=f8065770 [194110.312078] cont=f806e904 [194110.312080] current_req=(null) [194110.312082] command_status=-1 [194110.312083] [194110.312087] floppy0: floppy timeout called [194110.572017] usb 3-2: reset low speed USB device using uhci_hcd and address 2 [194110.996017] usb 4-2: reset full speed USB device using uhci_hcd and address 2 [194111.160213] PM: resume devices took 9.756 seconds