10b) [41046.216078] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x8 (was 0x1, writing 0x1801) [41046.216092] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [41046.224059] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [41046.232059] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [41046.240058] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [41046.248058] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [41046.248064] uhci_hcd 0000:00:1d.1: restoring config space at offset 0xf (was 0x200, writing 0x20b) [41046.248078] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x8 (was 0x1, writing 0x1821) [41046.248091] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [41046.256058] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [41046.264059] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [41046.264068] uhci_hcd 0000:00:1d.2: restoring config space at offset 0xf (was 0x300, writing 0x30b) [41046.264081] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x8 (was 0x1, writing 0x1841) [41046.264094] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [41046.264107] uhci_hcd 0000:00:1d.3: restoring config space at offset 0xf (was 0x400, writing 0x40b) [41046.264120] uhci_hcd 0000:00:1d.3: restoring config space at offset 0x8 (was 0x1, writing 0x1861) [41046.264133] uhci_hcd 0000:00:1d.3: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [41046.264154] ehci_hcd 0000:00:1d.7: restoring config space at offset 0xf (was 0x400, writing 0x40b) [41046.264173] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x4 (was 0x0, writing 0xa8000000) [41046.264181] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900102) [41046.272059] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [41046.280058] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [41046.280126] Intel ICH 0000:00:1e.2: restoring config space at offset 0x1 (was 0x2900007, writing 0x2900003) [41046.280165] pci 0000:00:1e.3: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) [41046.280303] radeon 0000:01:00.0: restoring config space at offset 0x1 (was 0x100103, writing 0x100507) [41046.280359] tg3 0000:02:00.0: restoring config space at offset 0xc (was 0x0, writing 0xff7e0000) [41046.280386] tg3 0000:02:00.0: restoring config space at offset 0x1 (was 0x100102, writing 0x100106) [41046.280959] PM: early resume of devices complete after 116.867 msecs [41046.324183] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [41046.324342] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [41046.324350] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [41046.324357] uhci_hcd 0000:00:1d.0: setting latency timer to 64 [41046.324381] usb usb2: root hub lost power or was reset [41046.324568] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [41046.324729] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [41046.324734] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [41046.324741] uhci_hcd 0000:00:1d.1: setting latency timer to 64 [41046.324763] usb usb3: root hub lost power or was reset [41046.324793] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [41046.324799] uhci_hcd 0000:00:1d.2: setting latency timer to 64 [41046.324821] usb usb4: root hub lost power or was reset [41046.324848] uhci_hcd 0000:00:1d.3: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [41046.324854] uhci_hcd 0000:00:1d.3: setting latency timer to 64 [41046.324876] usb usb5: root hub lost power or was reset [41046.325050] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [41046.325213] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [41046.325220] ehci_hcd 0000:00:1d.7: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [41046.325227] ehci_hcd 0000:00:1d.7: setting latency timer to 64 [41046.325256] pci 0000:00:1e.0: setting latency timer to 64 [41046.325266] Intel ICH 0000:00:1e.2: PCI INT A -> GSI 22 (level, low) -> IRQ 22 [41046.325273] Intel ICH 0000:00:1e.2: setting latency timer to 64 [41047.337809] PM: resume of drv:Intel ICH dev:0000:00:1e.2 complete after 1012.548 msecs [41047.337826] ata_piix 0000:00:1f.2: setting latency timer to 64 [41047.339800] radeon 0000:01:00.0: power state changed by ACPI to D0 [41047.340351] radeon 0000:01:00.0: power state changed by ACPI to D0 [41047.340709] radeon 0000:01:00.0: power state changed by ACPI to D0 [41047.340750] radeon 0000:01:00.0: power state changed by ACPI to D0 [41047.340756] radeon 0000:01:00.0: setting latency timer to 64 [41047.340763] radeon 0000:01:00.0: e7488e00 unpin not necessary [41047.340972] [drm] GPU reset succeed (RBBM_STATUS=0x00000140) [41047.482826] [drm] radeon: 1 quad pipes, 1 Z pipes initialized. [41047.508827] [drm] PCIE GART of 512M enabled (table at 0x00040000). [41047.508837] [drm] radeon: cp idle (0x10000C03) [41047.508869] [drm] radeon: ring at 0x0000000020000000 [41047.508890] [drm] ring test succeeded in 1 usecs [41047.508905] [drm] ib test succeeded in 0 usecs [41047.529446] ata2.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [41047.529450] ata2.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [41047.590128] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [41047.590133] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [41047.590136] ata1.00: ACPI cmd ef/03:45:00:00:00:a0 (SET FEATURES) filtered out [41047.590140] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [41047.590205] ata2.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [41047.594768] ata2.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [41047.594968] PM: resume of drv:radeon dev:0000:01:00.0 complete after 255.222 msecs [41047.610295] ata1.00: configured for UDMA/100 [41047.616324] ata2.00: configured for UDMA/33 [41047.732065] PM: resume of drv:yenta_cardbus dev:0000:04:00.0 complete after 137.076 msecs [41047.732069] eth1: Coming out of suspend... [41047.732077] ipw2200 0000:04:02.0: PCI INT A -> GSI 21 (level, low) -> IRQ 21 [41047.759699] serial 00:0a: activated [41047.760338] parport_pc 00:0b: activated [41047.761039] nsc-ircc 00:0c: activated [41048.076070] PM: resume of drv:usb dev:usb1 complete after 314.621 msecs [41048.324031] PM: resume of drv:usb dev:usb2 complete after 247.946 msecs [41048.572031] PM: resume of drv:usb dev:usb3 complete after 247.986 msecs [41048.820030] PM: resume of drv:usb dev:usb4 complete after 247.985 msecs [41048.821861] sd 0:0:0:0: [sda] Starting disk [41051.844015] [41051.844017] floppy driver state [41051.844019] ------------------- [41051.844021] now=10187961 last interrupt=4294906090 diff=10249167 last called handler=f80a90a0 [41051.844024] timeout_message=lock fdc [41051.844025] last output bytes: [41051.844027] 18 80 4294892592 [41051.844029] 8 80 4294892592 [41051.844031] 8 80 4294892592 [41051.844033] 8 80 4294892592 [41051.844034] 8 80 4294892592 [41051.844036] 12 80 4294905911 [41051.844038] 0 90 4294905911 [41051.844039] 13 80 4294905911 [41051.844041] 0 90 4294905911 [41051.844043] 1a 90 4294905911 [41051.844044] 0 90 4294905911 [41051.844046] 3 80 4294905911 [41051.844048] c1 90 4294905911 [41051.844049] 10 90 4294905911 [41051.844051] 7 80 4294905911 [41051.844053] 0 90 4294905911 [41051.844054] 8 81 4294905998 [41051.844056] 7 80 4294906003 [41051.844058] 0 90 4294906003 [41051.844059] 8 81 4294906090 [41051.844061] last result at 4294906090 [41051.844062] last redo_fd_request at 9942920 [41051.844064] 70 0 [41051.844073] status=0 [41051.844074] fdc_busy=1 [41051.844075] do_floppy=f80a45b0 [41051.844077] cont=f80ab290 [41051.844079] current_req=(null) [41051.844080] command_status=-1 [41051.844082] [41051.844085] floppy0: floppy timeout called [41051.844099] PM: resume of drv:floppy dev:floppy.0 complete after 2997.696 msecs [41051.956064] usb 3-1: reset full speed USB device using uhci_hcd and address 2 [41052.110177] PM: resume of drv:usb dev:3-1 complete after 266.064 msecs [41052.220066] usb 4-2: reset full speed USB device using uhci_hcd and address 2 [41052.370181] PM: resume of drv:usb dev:4-2 complete after 259.988 msecs [41052.632061] usb 2-1: reset low speed USB device using uhci_hcd and address 3 [41052.939217] PM: resume of drv:usb dev:2-1 complete after 565.952 msecs [41053.048026] usb 3-2: reset full speed USB device using uhci_hcd and address 3 [41053.233211] snd-usb-audio 3-2:1.0: no reset_resume for driver snd-usb-audio? [41053.233214] snd-usb-audio 3-2:1.1: no reset_resume for driver snd-usb-audio? [41053.233216] snd-usb-audio 3-2:1.2: no reset_resume for driver snd-usb-audio? [41053.233538] PM: resume of drv:usb dev:3-2 complete after 294.280 msecs [41053.233558] PM: resume of devices complete after 6952.511 msecs [41053.302747] PM: resume devices took 7.020 seconds [41053.302786] PM: Finishing wakeup. [41053.302788] Restarting tasks ... [41053.303478] hub 1-0:1.0: over-current change on port 3 [41053.341061] done. [41053.405251] hub 1-0:1.0: over-current change on port 4 [41053.508059] hub 3-0:1.0: over-current change on port 1 [41053.612030] hub 3-0:1.0: over-current change on port 2 [41060.208120] tg3 0000:02:00.0: PME# disabled [41060.408797] ADDRCONF(NETDEV_UP): eth0: link is not ready [41060.422322] ADDRCONF(NETDEV_UP): eth1: link is not ready [41066.365912] ADDRCONF(NETDEV_CHANGE): eth1: link becomes ready [44645.084518] tg3 0000:02:00.0: PME# enabled [44647.646362] PM: Syncing filesystems ... done. [44647.647795] PM: Preparing system for mem sleep [44647.647801] Freezing user space processes ... (elapsed 0.01 seconds) done. [44647.664706] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done. [44647.664761] PM: Entering mem sleep [44647.664776] Suspending console(s) (use no_console_suspend to debug) [44647.911441] PM: suspend of drv:psmouse dev:serio2 complete after 215.319 msecs [44647.940103] sd 0:0:0:0: [sda] Synchronizing SCSI cache [44647.940261] sd 0:0:0:0: [sda] Stopping disk [44648.339598] PM: suspend of drv:sd dev:0:0:0:0 complete after 399.495 msecs [44648.734399] PM: suspend of drv:psmouse dev:serio1 complete after 394.742 msecs [44649.336063] PM: suspend of drv:atkbd dev:serio0 complete after 601.659 msecs [44649.338689] nsc-ircc 00:0c: disabled [44649.338973] parport_pc 00:0b: disabled [44649.339253] serial 00:0a: disabled [44649.339356] eth1: Going into suspend... [44649.340344] ipw2200 0000:04:02.0: PCI INT A disabled [44649.340352] ACPI handle has no context! [44649.560068] radeon 0000:01:00.0: Refused to change power state, currently in D0 [44649.560143] radeon 0000:01:00.0: power state changed by ACPI to D3 [44649.560157] PM: suspend of drv:radeon dev:0000:01:00.0 complete after 204.004 msecs [44649.576274] Intel ICH 0000:00:1e.2: PCI INT A disabled [44649.576318] ehci_hcd 0000:00:1d.7: PCI INT D disabled [44649.576328] uhci_hcd 0000:00:1d.3: PCI INT D disabled [44649.576338] uhci_hcd 0000:00:1d.2: PCI INT C disabled [44649.576346] uhci_hcd 0000:00:1d.1: PCI INT B disabled [44649.576355] uhci_hcd 0000:00:1d.0: PCI INT A disabled [44649.576572] PM: suspend of devices complete after 1911.577 msecs [44649.576575] PM: suspend devices took 1.912 seconds [44649.600066] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D3 [44649.608059] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D3 [44649.636052] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D3 [44649.636246] PM: late suspend of devices complete after 59.666 msecs [44649.676054] ACPI: Preparing to enter system sleep state S3 [44649.856159] Disabling non-boot CPUs ... [44649.856215] Extended CMOS year: 2000 [44649.856215] Back to C! [44649.856215] CPU0: Thermal monitoring enabled (TM2) [44649.856215] Extended CMOS year: 2000 [44649.856215] Force enabled HPET at resume [44649.856215] ACPI: Waking up from system sleep state S3 [44650.200199] pcieport 0000:00:01.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [44650.200238] pcieport 0000:00:1c.0: restoring config space at offset 0x9 (was 0x1fff1, writing 0x40114001) [44650.200245] pcieport 0000:00:1c.0: restoring config space at offset 0x7 (was 0xf0, writing 0x9090) [44650.200257] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [44650.200321] pcieport 0000:00:1c.2: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [44650.244050] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [44650.252059] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [44650.252065] uhci_hcd 0000:00:1d.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [44650.252078] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x8 (was 0x1, writing 0x1801) [44650.252091] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [44650.260059] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [44650.268058] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [44650.276058] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [44650.284058] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [44650.284064] uhci_hcd 0000:00:1d.1: restoring config space at offset 0xf (was 0x200, writing 0x20b) [44650.284077] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x8 (was 0x1, writing 0x1821) [44650.284091] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [44650.292059] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [44650.300058] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [44650.300067] uhci_hcd 0000:00:1d.2: restoring config space at offset 0xf (was 0x300, writing 0x30b) [44650.300081] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x8 (was 0x1, writing 0x1841) [44650.300094] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [44650.300107] uhci_hcd 0000:00:1d.3: restoring config space at offset 0xf (was 0x400, writing 0x40b) [44650.300120] uhci_hcd 0000:00:1d.3: restoring config space at offset 0x8 (was 0x1, writing 0x1861) [44650.300133] uhci_hcd 0000:00:1d.3: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [44650.300154] ehci_hcd 0000:00:1d.7: restoring config space at offset 0xf (was 0x400, writing 0x40b) [44650.300173] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x4 (was 0x0, writing 0xa8000000) [44650.300181] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900102) [44650.308058] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [44650.316058] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [44650.316126] Intel ICH 0000:00:1e.2: restoring config space at offset 0x1 (was 0x2900007, writing 0x2900003) [44650.316164] pci 0000:00:1e.3: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) [44650.316302] radeon 0000:01:00.0: restoring config space at offset 0x1 (was 0x100103, writing 0x100507) [44650.316359] tg3 0000:02:00.0: restoring config space at offset 0xc (was 0x0, writing 0xff7e0000) [44650.316386] tg3 0000:02:00.0: restoring config space at offset 0x1 (was 0x100102, writing 0x100106) [44650.316961] PM: early resume of devices complete after 116.870 msecs [44650.359751] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [44650.359908] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [44650.359916] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [44650.359923] uhci_hcd 0000:00:1d.0: setting latency timer to 64 [44650.359947] usb usb2: root hub lost power or was reset [44650.360181] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [44650.360343] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [44650.360349] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [44650.360355] uhci_hcd 0000:00:1d.1: setting latency timer to 64 [44650.360377] usb usb3: root hub lost power or was reset [44650.360408] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [44650.360414] uhci_hcd 0000:00:1d.2: setting latency timer to 64 [44650.360435] usb usb4: root hub lost power or was reset [44650.360462] uhci_hcd 0000:00:1d.3: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [44650.360468] uhci_hcd 0000:00:1d.3: setting latency timer to 64 [44650.360490] usb usb5: root hub lost power or was reset [44650.360672] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [44650.360837] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [44650.360844] ehci_hcd 0000:00:1d.7: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [44650.360851] ehci_hcd 0000:00:1d.7: setting latency timer to 64 [44650.360881] pci 0000:00:1e.0: setting latency timer to 64 [44650.360891] Intel ICH 0000:00:1e.2: PCI INT A -> GSI 22 (level, low) -> IRQ 22 [44650.360897] Intel ICH 0000:00:1e.2: setting latency timer to 64 [44651.373808] PM: resume of drv:Intel ICH dev:0000:00:1e.2 complete after 1012.923 msecs [44651.373825] ata_piix 0000:00:1f.2: setting latency timer to 64 [44651.376308] radeon 0000:01:00.0: power state changed by ACPI to D0 [44651.376368] radeon 0000:01:00.0: power state changed by ACPI to D0 [44651.376704] radeon 0000:01:00.0: power state changed by ACPI to D0 [44651.376743] radeon 0000:01:00.0: power state changed by ACPI to D0 [44651.376749] radeon 0000:01:00.0: setting latency timer to 64 [44651.376756] radeon 0000:01:00.0: e7488e00 unpin not necessary [44651.376966] [drm] GPU reset succeed (RBBM_STATUS=0x00000140) [44651.518805] [drm] radeon: 1 quad pipes, 1 Z pipes initialized. [44651.544825] [drm] PCIE GART of 512M enabled (table at 0x00040000). [44651.544835] [drm] radeon: cp idle (0x10000C03) [44651.544866] [drm] radeon: ring at 0x0000000020000000 [44651.544888] [drm] ring test succeeded in 1 usecs [44651.544903] [drm] ib test succeeded in 0 usecs [44651.565444] ata2.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [44651.565448] ata2.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [44651.626123] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [44651.626127] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [44651.626131] ata1.00: ACPI cmd ef/03:45:00:00:00:a0 (SET FEATURES) filtered out [44651.626134] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [44651.626200] ata2.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [44651.631515] ata2.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [44651.631718] PM: resume of drv:radeon dev:0000:01:00.0 complete after 255.978 msecs [44651.646293] ata1.00: configured for UDMA/100 [44651.652323] ata2.00: configured for UDMA/33 [44651.768064] PM: resume of drv:yenta_cardbus dev:0000:04:00.0 complete after 136.323 msecs [44651.768069] eth1: Coming out of suspend... [44651.768077] ipw2200 0000:04:02.0: PCI INT A -> GSI 21 (level, low) -> IRQ 21 [44651.795927] serial 00:0a: activated [44651.796566] parport_pc 00:0b: activated [44651.797268] nsc-ircc 00:0c: activated [44652.112069] PM: resume of drv:usb dev:usb1 complete after 314.388 msecs [44652.360047] PM: resume of drv:usb dev:usb2 complete after 247.963 msecs [44652.608030] PM: resume of drv:usb dev:usb3 complete after 247.969 msecs [44652.856030] PM: resume of drv:usb dev:usb4 complete after 247.985 msecs [44652.858018] sd 0:0:0:0: [sda] Starting disk [44655.876052] [44655.876054] floppy driver state [44655.876055] ------------------- [44655.876058] now=11088969 last interrupt=4294906090 diff=11150175 last called handler=f80a90a0 [44655.876061] timeout_message=lock fdc [44655.876062] last output bytes: [44655.876064] 18 80 4294892592 [44655.876066] 8 80 4294892592 [44655.876068] 8 80 4294892592 [44655.876073] 8 80 4294892592 [44655.876075] 8 80 4294892592 [44655.876076] 12 80 4294905911 [44655.876078] 0 90 4294905911 [44655.876080] 13 80 4294905911 [44655.876081] 0 90 4294905911 [44655.876083] 1a 90 4294905911 [44655.876085] 0 90 4294905911 [44655.876086] 3 80 4294905911 [44655.876088] c1 90 4294905911 [44655.876090] 10 90 4294905911 [44655.876092] 7 80 4294905911 [44655.876093] 0 90 4294905911 [44655.876095] 8 81 4294905998 [44655.876097] 7 80 4294906003 [44655.876098] 0 90 4294906003 [44655.876100] 8 81 4294906090 [44655.876101] last result at 4294906090 [44655.876103] last redo_fd_request at 10187961 [44655.876104] 70 0 [44655.876113] status=0 [44655.876115] fdc_busy=1 [44655.876116] do_floppy=f80a45b0 [44655.876118] cont=f80ab290 [44655.876119] current_req=(null) [44655.876121] command_status=-1 [44655.876122] [44655.876126] floppy0: floppy timeout called [44655.876151] PM: resume of drv:floppy dev:floppy.0 complete after 2996.644 msecs [44655.988064] usb 3-1: reset full speed USB device using uhci_hcd and address 2 [44656.143180] PM: resume of drv:usb dev:3-1 complete after 267.014 msecs [44656.252062] usb 4-2: reset full speed USB device using uhci_hcd and address 2 [44656.402180] PM: resume of drv:usb dev:4-2 complete after 258.984 msecs [44656.664065] usb 2-1: reset low speed USB device using uhci_hcd and address 3 [44656.971255] PM: resume of drv:usb dev:2-1 complete after 565.991 msecs [44657.080022] usb 3-2: reset full speed USB device using uhci_hcd and address 3 [44657.265213] snd-usb-audio 3-2:1.0: no reset_resume for driver snd-usb-audio? [44657.265216] snd-usb-audio 3-2:1.1: no reset_resume for driver snd-usb-audio? [44657.265219] snd-usb-audio 3-2:1.2: no reset_resume for driver snd-usb-audio? [44657.265547] PM: resume of drv:usb dev:3-2 complete after 294.251 msecs [44657.265567] PM: resume of devices complete after 6948.518 msecs [44657.334752] PM: resume devices took 7.016 seconds [44657.334792] PM: Finishing wakeup. [44657.334794] Restarting tasks ... [44657.335402] hub 1-0:1.0: over-current change on port 3 [44657.373544] done. [44657.436041] hub 1-0:1.0: over-current change on port 4 [44657.540044] hub 3-0:1.0: over-current change on port 1 [44657.646264] hub 3-0:1.0: over-current change on port 2 [44660.195125] tg3 0000:02:00.0: PME# disabled [44660.352825] ADDRCONF(NETDEV_UP): eth0: link is not ready [44660.362067] ADDRCONF(NETDEV_UP): eth1: link is not ready [44661.066156] ADDRCONF(NETDEV_CHANGE): eth1: link becomes ready [45182.561137] tg3 0000:02:00.0: PME# enabled [45183.477294] PM: Syncing filesystems ... done. [45183.478639] PM: Preparing system for mem sleep [45183.478645] Freezing user space processes ... (elapsed 0.00 seconds) done. [45183.480968] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done. [45183.481027] PM: Entering mem sleep [45183.481045] Suspending console(s) (use no_console_suspend to debug) [45183.717260] PM: suspend of drv:psmouse dev:serio2 complete after 205.129 msecs [45183.748112] sd 0:0:0:0: [sda] Synchronizing SCSI cache [45183.748276] sd 0:0:0:0: [sda] Stopping disk [45184.143847] PM: suspend of drv:sd dev:0:0:0:0 complete after 395.736 msecs [45184.531571] PM: suspend of drv:psmouse dev:serio1 complete after 387.665 msecs [45185.132078] PM: suspend of drv:atkbd dev:serio0 complete after 600.501 msecs [45185.134086] nsc-ircc 00:0c: disabled [45185.134351] parport_pc 00:0b: disabled [45185.134630] serial 00:0a: disabled [45185.134734] eth1: Going into suspend... [45185.135673] ipw2200 0000:04:02.0: PCI INT A disabled [45185.135681] ACPI handle has no context! [45185.376073] radeon 0000:01:00.0: Refused to change power state, currently in D0 [45185.376134] radeon 0000:01:00.0: power state changed by ACPI to D3 [45185.376147] PM: suspend of drv:radeon dev:0000:01:00.0 complete after 227.986 msecs [45185.392264] Intel ICH 0000:00:1e.2: PCI INT A disabled [45185.392308] ehci_hcd 0000:00:1d.7: PCI INT D disabled [45185.392317] uhci_hcd 0000:00:1d.3: PCI INT D disabled [45185.392327] uhci_hcd 0000:00:1d.2: PCI INT C disabled [45185.392335] uhci_hcd 0000:00:1d.1: PCI INT B disabled [45185.392344] uhci_hcd 0000:00:1d.0: PCI INT A disabled [45185.392552] PM: suspend of devices complete after 1911.281 msecs [45185.392555] PM: suspend devices took 1.912 seconds [45185.416067] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D3 [45185.424062] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D3 [45185.452051] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D3 [45185.452246] PM: late suspend of devices complete after 59.685 msecs [45185.492056] ACPI: Preparing to enter system sleep state S3 [45185.672160] Disabling non-boot CPUs ... [45185.672216] Extended CMOS year: 2000 [45185.672216] Back to C! [45185.672216] CPU0: Thermal monitoring enabled (TM2) [45185.672216] Extended CMOS year: 2000 [45185.672216] Force enabled HPET at resume [45185.672216] ACPI: Waking up from system sleep state S3 [45186.016201] pcieport 0000:00:01.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [45186.016240] pcieport 0000:00:1c.0: restoring config space at offset 0x9 (was 0x1fff1, writing 0x40114001) [45186.016247] pcieport 0000:00:1c.0: restoring config space at offset 0x7 (was 0xf0, writing 0x9090) [45186.016259] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [45186.016323] pcieport 0000:00:1c.2: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [45186.060052] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [45186.068061] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [45186.068067] uhci_hcd 0000:00:1d.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [45186.068080] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x8 (was 0x1, writing 0x1801) [45186.068093] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [45186.076061] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [45186.084072] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [45186.092060] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [45186.100060] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [45186.100066] uhci_hcd 0000:00:1d.1: restoring config space at offset 0xf (was 0x200, writing 0x20b) [45186.100079] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x8 (was 0x1, writing 0x1821) [45186.100092] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [45186.108060] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [45186.116060] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [45186.116069] uhci_hcd 0000:00:1d.2: restoring config space at offset 0xf (was 0x300, writing 0x30b) [45186.116083] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x8 (was 0x1, writing 0x1841) [45186.116096] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [45186.116109] uhci_hcd 0000:00:1d.3: restoring config space at offset 0xf (was 0x400, writing 0x40b) [45186.116122] uhci_hcd 0000:00:1d.3: restoring config space at offset 0x8 (was 0x1, writing 0x1861) [45186.116135] uhci_hcd 0000:00:1d.3: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [45186.116156] ehci_hcd 0000:00:1d.7: restoring config space at offset 0xf (was 0x400, writing 0x40b) [45186.116175] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x4 (was 0x0, writing 0xa8000000) [45186.116184] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900102) [45186.124061] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [45186.132060] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [45186.132128] Intel ICH 0000:00:1e.2: restoring config space at offset 0x1 (was 0x2900007, writing 0x2900003) [45186.132167] pci 0000:00:1e.3: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) [45186.132305] radeon 0000:01:00.0: restoring config space at offset 0x1 (was 0x180103, writing 0x100507) [45186.132363] tg3 0000:02:00.0: restoring config space at offset 0xc (was 0x0, writing 0xff7e0000) [45186.132389] tg3 0000:02:00.0: restoring config space at offset 0x1 (was 0x100102, writing 0x100106) [45186.132964] PM: early resume of devices complete after 116.870 msecs [45186.175003] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [45186.175204] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [45186.175213] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [45186.175219] uhci_hcd 0000:00:1d.0: setting latency timer to 64 [45186.175242] usb usb2: root hub lost power or was reset [45186.175431] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [45186.175596] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [45186.175602] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [45186.175608] uhci_hcd 0000:00:1d.1: setting latency timer to 64 [45186.175630] usb usb3: root hub lost power or was reset [45186.175659] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [45186.175666] uhci_hcd 0000:00:1d.2: setting latency timer to 64 [45186.175688] usb usb4: root hub lost power or was reset [45186.175716] uhci_hcd 0000:00:1d.3: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [45186.175722] uhci_hcd 0000:00:1d.3: setting latency timer to 64 [45186.175743] usb usb5: root hub lost power or was reset [45186.175917] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [45186.176171] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [45186.176178] ehci_hcd 0000:00:1d.7: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [45186.176185] ehci_hcd 0000:00:1d.7: setting latency timer to 64 [45186.176215] pci 0000:00:1e.0: setting latency timer to 64 [45186.176225] Intel ICH 0000:00:1e.2: PCI INT A -> GSI 22 (level, low) -> IRQ 22 [45186.176231] Intel ICH 0000:00:1e.2: setting latency timer to 64 [45187.189815] PM: resume of drv:Intel ICH dev:0000:00:1e.2 complete after 1013.596 msecs [45187.189832] ata_piix 0000:00:1f.2: setting latency timer to 64 [45187.191737] radeon 0000:01:00.0: power state changed by ACPI to D0 [45187.192335] radeon 0000:01:00.0: power state changed by ACPI to D0 [45187.192647] radeon 0000:01:00.0: power state changed by ACPI to D0 [45187.192686] radeon 0000:01:00.0: power state changed by ACPI to D0 [45187.192692] radeon 0000:01:00.0: setting latency timer to 64 [45187.192699] radeon 0000:01:00.0: e7488e00 unpin not necessary [45187.192908] [drm] GPU reset succeed (RBBM_STATUS=0x00000140) [45187.334853] [drm] radeon: 1 quad pipes, 1 Z pipes initialized. [45187.360804] [drm] PCIE GART of 512M enabled (table at 0x00040000). [45187.360808] [drm] radeon: cp idle (0x10000C03) [45187.360840] [drm] radeon: ring at 0x0000000020000000 [45187.360861] [drm] ring test succeeded in 1 usecs [45187.360876] [drm] ib test succeeded in 0 usecs [45187.381124] ata2.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [45187.381128] ata2.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [45187.441836] ata2.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [45187.446794] ata2.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [45187.446942] PM: resume of drv:radeon dev:0000:01:00.0 complete after 255.259 msecs [45187.468327] ata2.00: configured for UDMA/33 [45187.584116] PM: resume of drv:yenta_cardbus dev:0000:04:00.0 complete after 137.151 msecs [45187.584120] eth1: Coming out of suspend... [45187.584128] ipw2200 0000:04:02.0: PCI INT A -> GSI 21 (level, low) -> IRQ 21 [45187.611930] serial 00:0a: activated [45187.612570] parport_pc 00:0b: activated [45187.613271] nsc-ircc 00:0c: activated [45187.652202] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [45187.652206] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [45187.652210] ata1.00: ACPI cmd ef/03:45:00:00:00:a0 (SET FEATURES) filtered out [45187.652214] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [45187.734181] ata1.00: configured for UDMA/100 [45187.928120] PM: resume of drv:usb dev:usb1 complete after 314.436 msecs [45188.176111] PM: resume of drv:usb dev:usb2 complete after 247.977 msecs [45188.424116] PM: resume of drv:usb dev:usb3 complete after 247.991 msecs [45188.672116] PM: resume of drv:usb dev:usb4 complete after 247.986 msecs [45188.674050] sd 0:0:0:0: [sda] Starting disk [45191.692055] [45191.692057] floppy driver state [45191.692058] ------------------- [45191.692061] now=11222923 last interrupt=4294906090 diff=11284129 last called handler=f80a90a0 [45191.692064] timeout_message=lock fdc [45191.692065] last output bytes: [45191.692067] 18 80 4294892592 [45191.692069] 8 80 4294892592 [45191.692071] 8 80 4294892592 [45191.692073] 8 80 4294892592 [45191.692074] 8 80 4294892592 [45191.692076] 12 80 4294905911 [45191.692078] 0 90 4294905911 [45191.692079] 13 80 4294905911 [45191.692081] 0 90 4294905911 [45191.692083] 1a 90 4294905911 [45191.692084] 0 90 4294905911 [45191.692086] 3 80 4294905911 [45191.692088] c1 90 4294905911 [45191.692089] 10 90 4294905911 [45191.692091] 7 80 4294905911 [45191.692093] 0 90 4294905911 [45191.692094] 8 81 4294905998 [45191.692096] 7 80 4294906003 [45191.692098] 0 90 4294906003 [45191.692099] 8 81 4294906090 [45191.692101] last result at 4294906090 [45191.692102] last redo_fd_request at 11088969 [45191.692104] 70 0 [45191.692112] status=0 [45191.692114] fdc_busy=1 [45191.692115] do_floppy=f80a45b0 [45191.692117] cont=f80ab290 [45191.692119] current_req=(null) [45191.692120] command_status=-1 [45191.692121] [45191.692125] floppy0: floppy timeout called [45191.692139] PM: resume of drv:floppy dev:floppy.0 complete after 2998.218 msecs [45191.804026] usb 3-1: reset full speed USB device using uhci_hcd and address 2 [45191.959731] PM: resume of drv:usb dev:3-1 complete after 267.578 msecs [45192.068065] usb 4-2: reset full speed USB device using uhci_hcd and address 2 [45192.217605] PM: resume of drv:usb dev:4-2 complete after 257.858 msecs [45192.480062] usb 2-1: reset low speed USB device using uhci_hcd and address 3 [45192.787889] PM: resume of drv:usb dev:2-1 complete after 567.203 msecs [45192.896025] usb 3-2: reset full speed USB device using uhci_hcd and address 3 [45193.081761] snd-usb-audio 3-2:1.0: no reset_resume for driver snd-usb-audio? [45193.081764] snd-usb-audio 3-2:1.1: no reset_resume for driver snd-usb-audio? [45193.081766] snd-usb-audio 3-2:1.2: no reset_resume for driver snd-usb-audio? [45193.082111] PM: resume of drv:usb dev:3-2 complete after 294.182 msecs [45193.082131] PM: resume of devices complete after 6949.073 msecs [45193.151300] PM: resume devices took 7.016 seconds [45193.151339] PM: Finishing wakeup. [45193.151341] Restarting tasks ... [45193.151896] hub 1-0:1.0: over-current change on port 3 [45193.217001] done. [45193.252062] hub 1-0:1.0: over-current change on port 4 [45193.356069] hub 3-0:1.0: over-current change on port 1 [45193.460457] hub 3-0:1.0: over-current change on port 2 [45193.626823] tg3 0000:02:00.0: PME# disabled [45193.812070] ADDRCONF(NETDEV_UP): eth0: link is not ready [45193.818627] ADDRCONF(NETDEV_UP): eth1: link is not ready [45194.790775] ADDRCONF(NETDEV_CHANGE): eth1: link becomes ready [45653.300445] tg3 0000:02:00.0: PME# enabled [45653.978029] PM: Syncing filesystems ... done. [45653.978667] PM: Preparing system for mem sleep [45653.978672] Freezing user space processes ... (elapsed 0.00 seconds) done. [45653.981729] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done. [45653.981790] PM: Entering mem sleep [45653.981808] Suspending console(s) (use no_console_suspend to debug) [45654.227087] PM: suspend of drv:psmouse dev:serio2 complete after 214.970 msecs [45654.256101] sd 0:0:0:0: [sda] Synchronizing SCSI cache [45654.283830] sd 0:0:0:0: [sda] Stopping disk [45654.750076] PM: suspend of drv:sd dev:0:0:0:0 complete after 493.975 msecs [45655.140293] PM: suspend of drv:psmouse dev:serio1 complete after 390.157 msecs [45655.740019] PM: suspend of drv:atkbd dev:serio0 complete after 599.720 msecs [45655.742024] nsc-ircc 00:0c: disabled [45655.742290] parport_pc 00:0b: disabled [45655.742569] serial 00:0a: disabled [45655.742672] eth1: Going into suspend... [45655.743603] ipw2200 0000:04:02.0: PCI INT A disabled [45655.743611] ACPI handle has no context! [45655.992066] radeon 0000:01:00.0: Refused to change power state, currently in D0 [45655.992142] radeon 0000:01:00.0: power state changed by ACPI to D3 [45655.992157] PM: suspend of drv:radeon dev:0000:01:00.0 complete after 236.009 msecs [45656.008252] Intel ICH 0000:00:1e.2: PCI INT A disabled [45656.008297] ehci_hcd 0000:00:1d.7: PCI INT D disabled [45656.008306] uhci_hcd 0000:00:1d.3: PCI INT D disabled [45656.008316] uhci_hcd 0000:00:1d.2: PCI INT C disabled [45656.008325] uhci_hcd 0000:00:1d.1: PCI INT B disabled [45656.008334] uhci_hcd 0000:00:1d.0: PCI INT A disabled [45656.008549] PM: suspend of devices complete after 2026.517 msecs [45656.008552] PM: suspend devices took 2.028 seconds [45656.032064] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D3 [45656.040058] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D3 [45656.068047] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D3 [45656.068242] PM: late suspend of devices complete after 59.685 msecs [45656.108052] ACPI: Preparing to enter system sleep state S3 [45656.288158] Disabling non-boot CPUs ... [45656.288214] Extended CMOS year: 2000 [45656.288214] Back to C! [45656.288214] CPU0: Thermal monitoring enabled (TM2) [45656.288214] Extended CMOS year: 2000 [45656.288214] Force enabled HPET at resume [45656.288214] ACPI: Waking up from system sleep state S3 [45656.632197] pcieport 0000:00:01.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [45656.632236] pcieport 0000:00:1c.0: restoring config space at offset 0x9 (was 0x1fff1, writing 0x40114001) [45656.632243] pcieport 0000:00:1c.0: restoring config space at offset 0x7 (was 0xf0, writing 0x9090) [45656.632255] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [45656.632319] pcieport 0000:00:1c.2: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [45656.676047] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [45656.684057] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [45656.684063] uhci_hcd 0000:00:1d.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [45656.684076] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x8 (was 0x1, writing 0x1801) [45656.684089] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [45656.692057] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [45656.700056] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [45656.708056] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [45656.716056] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [45656.716062] uhci_hcd 0000:00:1d.1: restoring config space at offset 0xf (was 0x200, writing 0x20b) [45656.716075] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x8 (was 0x1, writing 0x1821) [45656.716089] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [45656.724056] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [45656.732056] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [45656.732065] uhci_hcd 0000:00:1d.2: restoring config space at offset 0xf (was 0x300, writing 0x30b) [45656.732079] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x8 (was 0x1, writing 0x1841) [45656.732092] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [45656.732105] uhci_hcd 0000:00:1d.3: restoring config space at offset 0xf (was 0x400, writing 0x40b) [45656.732118] uhci_hcd 0000:00:1d.3: restoring config space at offset 0x8 (was 0x1, writing 0x1861) [45656.732131] uhci_hcd 0000:00:1d.3: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [45656.732152] ehci_hcd 0000:00:1d.7: restoring config space at offset 0xf (was 0x400, writing 0x40b) [45656.732171] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x4 (was 0x0, writing 0xa8000000) [45656.732179] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900102) [45656.740056] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [45656.748056] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [45656.748124] Intel ICH 0000:00:1e.2: restoring config space at offset 0x1 (was 0x2900007, writing 0x2900003) [45656.748163] pci 0000:00:1e.3: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) [45656.748301] radeon 0000:01:00.0: restoring config space at offset 0x1 (was 0x100103, writing 0x100507) [45656.748357] tg3 0000:02:00.0: restoring config space at offset 0xc (was 0x0, writing 0xff7e0000) [45656.748384] tg3 0000:02:00.0: restoring config space at offset 0x1 (was 0x100102, writing 0x100106) [45656.748955] PM: early resume of devices complete after 116.865 msecs [45656.791343] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [45656.791499] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [45656.791507] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [45656.791514] uhci_hcd 0000:00:1d.0: setting latency timer to 64 [45656.791538] usb usb2: root hub lost power or was reset [45656.791737] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [45656.791893] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [45656.791898] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [45656.791905] uhci_hcd 0000:00:1d.1: setting latency timer to 64 [45656.791928] usb usb3: root hub lost power or was reset [45656.791957] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [45656.791963] uhci_hcd 0000:00:1d.2: setting latency timer to 64 [45656.791986] usb usb4: root hub lost power or was reset [45656.792106] uhci_hcd 0000:00:1d.3: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [45656.792113] uhci_hcd 0000:00:1d.3: setting latency timer to 64 [45656.792135] usb usb5: root hub lost power or was reset [45656.792309] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [45656.792472] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [45656.792479] ehci_hcd 0000:00:1d.7: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [45656.792485] ehci_hcd 0000:00:1d.7: setting latency timer to 64 [45656.792515] pci 0000:00:1e.0: setting latency timer to 64 [45656.792525] Intel ICH 0000:00:1e.2: PCI INT A -> GSI 22 (level, low) -> IRQ 22 [45656.792531] Intel ICH 0000:00:1e.2: setting latency timer to 64 [45657.805811] PM: resume of drv:Intel ICH dev:0000:00:1e.2 complete after 1013.291 msecs [45657.805828] ata_piix 0000:00:1f.2: setting latency timer to 64 [45657.808244] radeon 0000:01:00.0: power state changed by ACPI to D0 [45657.808603] radeon 0000:01:00.0: power state changed by ACPI to D0 [45657.808644] radeon 0000:01:00.0: power state changed by ACPI to D0 [45657.808680] radeon 0000:01:00.0: power state changed by ACPI to D0 [45657.808686] radeon 0000:01:00.0: setting latency timer to 64 [45657.808693] radeon 0000:01:00.0: e7488e00 unpin not necessary [45657.808902] [drm] GPU reset succeed (RBBM_STATUS=0x00000140) [45657.950767] [drm] radeon: 1 quad pipes, 1 Z pipes initialized. [45657.976764] [drm] PCIE GART of 512M enabled (table at 0x00040000). [45657.976774] [drm] radeon: cp idle (0x10000C03) [45657.976806] [drm] radeon: ring at 0x0000000020000000 [45657.976827] [drm] ring test succeeded in 1 usecs [45657.976841] [drm] ib test succeeded in 0 usecs [45657.997070] ata2.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [45657.997074] ata2.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [45658.057720] ata2.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [45658.062280] ata2.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [45658.062436] PM: resume of drv:radeon dev:0000:01:00.0 complete after 254.758 msecs [45658.084318] ata2.00: configured for UDMA/33 [45658.112609] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [45658.112613] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [45658.112617] ata1.00: ACPI cmd ef/03:45:00:00:00:a0 (SET FEATURES) filtered out [45658.112621] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [45658.138183] ata1.00: configured for UDMA/100 [45658.200061] PM: resume of drv:yenta_cardbus dev:0000:04:00.0 complete after 137.606 msecs [45658.200065] eth1: Coming out of suspend... [45658.200073] ipw2200 0000:04:02.0: PCI INT A -> GSI 21 (level, low) -> IRQ 21 [45658.227710] serial 00:0a: activated [45658.228348] parport_pc 00:0b: activated [45658.229052] nsc-ircc 00:0c: activated [45658.544048] PM: resume of drv:usb dev:usb1 complete after 314.586 msecs [45658.792025] PM: resume of drv:usb dev:usb2 complete after 247.962 msecs [45659.040044] PM: resume of drv:usb dev:usb3 complete after 248.004 msecs [45659.288020] PM: resume of drv:usb dev:usb4 complete after 247.962 msecs [45659.290007] sd 0:0:0:0: [sda] Starting disk [45662.308015] [45662.308017] floppy driver state [45662.308018] ------------------- [45662.308021] now=11340577 last interrupt=4294906090 diff=11401783 last called handler=f80a90a0 [45662.308024] timeout_message=lock fdc [45662.308025] last output bytes: [45662.308027] 18 80 4294892592 [45662.308029] 8 80 4294892592 [45662.308031] 8 80 4294892592 [45662.308032] 8 80 4294892592 [45662.308034] 8 80 4294892592 [45662.308036] 12 80 4294905911 [45662.308037] 0 90 4294905911 [45662.308039] 13 80 4294905911 [45662.308041] 0 90 4294905911 [45662.308042] 1a 90 4294905911 [45662.308044] 0 90 4294905911 [45662.308046] 3 80 4294905911 [45662.308047] c1 90 4294905911 [45662.308049] 10 90 4294905911 [45662.308051] 7 80 4294905911 [45662.308052] 0 90 4294905911 [45662.308054] 8 81 4294905998 [45662.308056] 7 80 4294906003 [45662.308057] 0 90 4294906003 [45662.308059] 8 81 4294906090 [45662.308061] last result at 4294906090 [45662.308062] last redo_fd_request at 11222923 [45662.308064] 70 0 [45662.308072] status=0 [45662.308074] fdc_busy=1 [45662.308075] do_floppy=f80a45b0 [45662.308077] cont=f80ab290 [45662.308079] current_req=(null) [45662.308080] command_status=-1 [45662.308081] [45662.308085] floppy0: floppy timeout called [45662.308099] PM: resume of drv:floppy dev:floppy.0 complete after 2996.380 msecs [45662.420064] usb 3-1: reset full speed USB device using uhci_hcd and address 2 [45662.575631] PM: resume of drv:usb dev:3-1 complete after 267.518 msecs [45662.684062] usb 4-2: reset full speed USB device using uhci_hcd and address 2 [45662.834757] PM: resume of drv:usb dev:4-2 complete after 259.109 msecs [45663.096062] usb 2-1: reset low speed USB device using uhci_hcd and address 3 [45663.403583] PM: resume of drv:usb dev:2-1 complete after 565.697 msecs [45663.512062] usb 3-2: reset full speed USB device using uhci_hcd and address 3 [45663.693672] snd-usb-audio 3-2:1.0: no reset_resume for driver snd-usb-audio? [45663.693674] snd-usb-audio 3-2:1.1: no reset_resume for driver snd-usb-audio? [45663.693677] snd-usb-audio 3-2:1.2: no reset_resume for driver snd-usb-audio? [45663.693998] PM: resume of drv:usb dev:3-2 complete after 290.374 msecs [45663.694019] PM: resume of devices complete after 6944.976 msecs [45663.763194] PM: resume devices took 7.012 seconds [45663.763233] PM: Finishing wakeup. [45663.763235] Restarting tasks ... [45663.763807] hub 1-0:1.0: over-current change on port 3 [45663.830475] done. [45663.864042] hub 1-0:1.0: over-current change on port 4 [45663.968055] hub 3-0:1.0: over-current change on port 1 [45664.072060] hub 3-0:1.0: over-current change on port 2 [45664.387883] tg3 0000:02:00.0: PME# disabled [45664.584257] ADDRCONF(NETDEV_UP): eth0: link is not ready [45664.599434] ADDRCONF(NETDEV_UP): eth1: link is not ready [45665.261018] ADDRCONF(NETDEV_CHANGE): eth1: link becomes ready [46135.836505] tg3 0000:02:00.0: PME# enabled [46138.355524] PM: Syncing filesystems ... done. [46138.356265] PM: Preparing system for mem sleep [46138.356270] Freezing user space processes ... (elapsed 0.01 seconds) done. [46138.371283] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done. [46138.371340] PM: Entering mem sleep [46138.371358] Suspending console(s) (use no_console_suspend to debug) [46138.612903] PM: suspend of drv:psmouse dev:serio2 complete after 212.815 msecs [46138.644073] sd 0:0:0:0: [sda] Synchronizing SCSI cache [46138.644201] sd 0:0:0:0: [sda] Stopping disk [46139.018998] PM: suspend of drv:sd dev:0:0:0:0 complete after 374.926 msecs [46139.407972] PM: suspend of drv:psmouse dev:serio1 complete after 388.918 msecs [46140.008032] PM: suspend of drv:atkbd dev:serio0 complete after 600.054 msecs [46140.009939] nsc-ircc 00:0c: disabled [46140.010204] parport_pc 00:0b: disabled [46140.010484] serial 00:0a: disabled [46140.010586] eth1: Going into suspend... [46140.011538] ipw2200 0000:04:02.0: PCI INT A disabled [46140.011546] ACPI handle has no context! [46140.284069] radeon 0000:01:00.0: Refused to change power state, currently in D0 [46140.284145] radeon 0000:01:00.0: power state changed by ACPI to D3 [46140.284160] PM: suspend of drv:radeon dev:0000:01:00.0 complete after 260.042 msecs [46140.300273] Intel ICH 0000:00:1e.2: PCI INT A disabled [46140.300317] ehci_hcd 0000:00:1d.7: PCI INT D disabled [46140.300327] uhci_hcd 0000:00:1d.3: PCI INT D disabled [46140.300337] uhci_hcd 0000:00:1d.2: PCI INT C disabled [46140.300346] uhci_hcd 0000:00:1d.1: PCI INT B disabled [46140.300355] uhci_hcd 0000:00:1d.0: PCI INT A disabled [46140.300572] PM: suspend of devices complete after 1928.986 msecs [46140.300575] PM: suspend devices took 1.932 seconds [46140.324067] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D3 [46140.332060] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D3 [46140.360049] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D3 [46140.360244] PM: late suspend of devices complete after 59.664 msecs [46140.400054] ACPI: Preparing to enter system sleep state S3 [46140.580159] Disabling non-boot CPUs ... [46140.580215] Extended CMOS year: 2000 [46140.580215] Back to C! [46140.580215] CPU0: Thermal monitoring enabled (TM2) [46140.580215] Extended CMOS year: 2000 [46140.580215] Force enabled HPET at resume [46140.580215] ACPI: Waking up from system sleep state S3 [46140.924199] pcieport 0000:00:01.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [46140.924238] pcieport 0000:00:1c.0: restoring config space at offset 0x9 (was 0x1fff1, writing 0x40114001) [46140.924245] pcieport 0000:00:1c.0: restoring config space at offset 0x7 (was 0xf0, writing 0x9090) [46140.924257] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [46140.924321] pcieport 0000:00:1c.2: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [46140.968049] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [46140.976059] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [46140.976065] uhci_hcd 0000:00:1d.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [46140.976078] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x8 (was 0x1, writing 0x1801) [46140.976091] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [46140.984059] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [46140.992058] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [46141.000097] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [46141.008059] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [46141.008065] uhci_hcd 0000:00:1d.1: restoring config space at offset 0xf (was 0x200, writing 0x20b) [46141.008078] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x8 (was 0x1, writing 0x1821) [46141.008091] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [46141.016058] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [46141.024058] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [46141.024068] uhci_hcd 0000:00:1d.2: restoring config space at offset 0xf (was 0x300, writing 0x30b) [46141.024081] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x8 (was 0x1, writing 0x1841) [46141.024094] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [46141.024107] uhci_hcd 0000:00:1d.3: restoring config space at offset 0xf (was 0x400, writing 0x40b) [46141.024120] uhci_hcd 0000:00:1d.3: restoring config space at offset 0x8 (was 0x1, writing 0x1861) [46141.024133] uhci_hcd 0000:00:1d.3: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [46141.024154] ehci_hcd 0000:00:1d.7: restoring config space at offset 0xf (was 0x400, writing 0x40b) [46141.024173] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x4 (was 0x0, writing 0xa8000000) [46141.024181] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900102) [46141.032058] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [46141.040058] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [46141.040125] Intel ICH 0000:00:1e.2: restoring config space at offset 0x1 (was 0x2900007, writing 0x2900003) [46141.040164] pci 0000:00:1e.3: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) [46141.040302] radeon 0000:01:00.0: restoring config space at offset 0x1 (was 0x100103, writing 0x100507) [46141.040358] tg3 0000:02:00.0: restoring config space at offset 0xc (was 0x0, writing 0xff7e0000) [46141.040384] tg3 0000:02:00.0: restoring config space at offset 0x1 (was 0x100102, writing 0x100106) [46141.040958] PM: early resume of devices complete after 116.866 msecs [46141.083360] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [46141.083516] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [46141.083524] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [46141.083531] uhci_hcd 0000:00:1d.0: setting latency timer to 64 [46141.083554] usb usb2: root hub lost power or was reset [46141.083741] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [46141.083940] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [46141.083945] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [46141.083952] uhci_hcd 0000:00:1d.1: setting latency timer to 64 [46141.083974] usb usb3: root hub lost power or was reset [46141.084018] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [46141.084024] uhci_hcd 0000:00:1d.2: setting latency timer to 64 [46141.084048] usb usb4: root hub lost power or was reset [46141.084156] uhci_hcd 0000:00:1d.3: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [46141.084162] uhci_hcd 0000:00:1d.3: setting latency timer to 64 [46141.084184] usb usb5: root hub lost power or was reset [46141.084368] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [46141.084526] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [46141.084533] ehci_hcd 0000:00:1d.7: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [46141.084540] ehci_hcd 0000:00:1d.7: setting latency timer to 64 [46141.084569] pci 0000:00:1e.0: setting latency timer to 64 [46141.084579] Intel ICH 0000:00:1e.2: PCI INT A -> GSI 22 (level, low) -> IRQ 22 [46141.084585] Intel ICH 0000:00:1e.2: setting latency timer to 64 [46142.097808] PM: resume of drv:Intel ICH dev:0000:00:1e.2 complete after 1013.235 msecs [46142.097825] ata_piix 0000:00:1f.2: setting latency timer to 64 [46142.099798] radeon 0000:01:00.0: power state changed by ACPI to D0 [46142.099835] radeon 0000:01:00.0: power state changed by ACPI to D0 [46142.100409] radeon 0000:01:00.0: power state changed by ACPI to D0 [46142.100743] radeon 0000:01:00.0: power state changed by ACPI to D0 [46142.100752] radeon 0000:01:00.0: setting latency timer to 64 [46142.100759] radeon 0000:01:00.0: e7488e00 unpin not necessary [46142.100969] [drm] GPU reset succeed (RBBM_STATUS=0x00000140) [46142.242807] [drm] radeon: 1 quad pipes, 1 Z pipes initialized. [46142.268829] [drm] PCIE GART of 512M enabled (table at 0x00040000). [46142.268839] [drm] radeon: cp idle (0x10000C03) [46142.268871] [drm] radeon: ring at 0x0000000020000000 [46142.268892] [drm] ring test succeeded in 1 usecs [46142.268907] [drm] ib test succeeded in 0 usecs [46142.289448] ata2.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [46142.289452] ata2.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [46142.350127] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [46142.350132] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [46142.350135] ata1.00: ACPI cmd ef/03:45:00:00:00:a0 (SET FEATURES) filtered out [46142.350139] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [46142.350204] ata2.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [46142.354809] ata2.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [46142.355010] PM: resume of drv:radeon dev:0000:01:00.0 complete after 255.267 msecs [46142.370294] ata1.00: configured for UDMA/100 [46142.376323] ata2.00: configured for UDMA/33 [46142.492065] PM: resume of drv:yenta_cardbus dev:0000:04:00.0 complete after 137.033 msecs [46142.492069] eth1: Coming out of suspend... [46142.492077] ipw2200 0000:04:02.0: PCI INT A -> GSI 21 (level, low) -> IRQ 21 [46142.520156] serial 00:0a: activated [46142.520779] parport_pc 00:0b: activated [46142.521482] nsc-ircc 00:0c: activated [46142.836069] PM: resume of drv:usb dev:usb1 complete after 314.174 msecs [46143.084048] PM: resume of drv:usb dev:usb2 complete after 247.964 msecs [46143.332030] PM: resume of drv:usb dev:usb3 complete after 247.968 msecs [46143.580029] PM: resume of drv:usb dev:usb4 complete after 247.985 msecs [46143.582686] sd 0:0:0:0: [sda] Starting disk [46146.608052] [46146.608054] floppy driver state [46146.608055] ------------------- [46146.608058] now=11461652 last interrupt=4294906090 diff=11522858 last called handler=f80a90a0 [46146.608061] timeout_message=lock fdc [46146.608062] last output bytes: [46146.608064] 18 80 4294892592 [46146.608066] 8 80 4294892592 [46146.608068] 8 80 4294892592 [46146.608069] 8 80 4294892592 [46146.608071] 8 80 4294892592 [46146.608073] 12 80 4294905911 [46146.608074] 0 90 4294905911 [46146.608076] 13 80 4294905911 [46146.608078] 0 90 4294905911 [46146.608079] 1a 90 4294905911 [46146.608081] 0 90 4294905911 [46146.608083] 3 80 4294905911 [46146.608084] c1 90 4294905911 [46146.608086] 10 90 4294905911 [46146.608088] 7 80 4294905911 [46146.608089] 0 90 4294905911 [46146.608091] 8 81 4294905998 [46146.608093] 7 80 4294906003 [46146.608094] 0 90 4294906003 [46146.608096] 8 81 4294906090 [46146.608097] last result at 4294906090 [46146.608099] last redo_fd_request at 11340577 [46146.608101] 70 0 [46146.608109] status=0 [46146.608111] fdc_busy=1 [46146.608112] do_floppy=f80a45b0 [46146.608114] cont=f80ab290 [46146.608115] current_req=(null) [46146.608117] command_status=-1 [46146.608118] [46146.608122] floppy0: floppy timeout called [46146.608136] PM: resume of drv:floppy dev:floppy.0 complete after 2999.726 msecs [46146.720026] usb 3-1: reset full speed USB device using uhci_hcd and address 2 [46146.875179] PM: resume of drv:usb dev:3-1 complete after 267.030 msecs [46146.984058] usb 4-2: reset full speed USB device using uhci_hcd and address 2 [46147.134182] PM: resume of drv:usb dev:4-2 complete after 258.986 msecs [46147.396065] usb 2-1: reset low speed USB device using uhci_hcd and address 3 [46147.703256] PM: resume of drv:usb dev:2-1 complete after 565.973 msecs [46147.812025] usb 3-2: reset full speed USB device using uhci_hcd and address 3 [46147.997214] snd-usb-audio 3-2:1.0: no reset_resume for driver snd-usb-audio? [46147.997216] snd-usb-audio 3-2:1.1: no reset_resume for driver snd-usb-audio? [46147.997219] snd-usb-audio 3-2:1.2: no reset_resume for driver snd-usb-audio? [46147.997541] PM: resume of drv:usb dev:3-2 complete after 294.245 msecs [46147.997560] PM: resume of devices complete after 6956.514 msecs [46148.066744] PM: resume devices took 7.024 seconds [46148.066783] PM: Finishing wakeup. [46148.066785] Restarting tasks ... [46148.067364] hub 1-0:1.0: over-current change on port 3 [46148.119381] done. [46148.168038] hub 1-0:1.0: over-current change on port 4 [46148.272036] hub 3-0:1.0: over-current change on port 1 [46148.376020] hub 3-0:1.0: over-current change on port 2 [46152.022160] tg3 0000:02:00.0: PME# disabled [46152.217018] ADDRCONF(NETDEV_UP): eth0: link is not ready [46152.227817] ADDRCONF(NETDEV_UP): eth1: link is not ready [46152.919113] ADDRCONF(NETDEV_CHANGE): eth1: link becomes ready [48828.216501] tg3 0000:02:00.0: PME# enabled [48829.273502] PM: Syncing filesystems ... done. [48829.274247] PM: Preparing system for mem sleep [48829.274253] Freezing user space processes ... (elapsed 0.00 seconds) done. [48829.277205] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done. [48829.277266] PM: Entering mem sleep [48829.277284] Suspending console(s) (use no_console_suspend to debug) [48829.525874] PM: suspend of drv:psmouse dev:serio2 complete after 217.753 msecs [48829.556068] sd 0:0:0:0: [sda] Synchronizing SCSI cache [48829.556212] sd 0:0:0:0: [sda] Stopping disk [48829.952513] PM: suspend of drv:sd dev:0:0:0:0 complete after 396.445 msecs [48830.346017] PM: suspend of drv:psmouse dev:serio1 complete after 393.446 msecs [48830.948025] PM: suspend of drv:atkbd dev:serio0 complete after 602.003 msecs [48830.950288] nsc-ircc 00:0c: disabled [48830.950553] parport_pc 00:0b: disabled [48830.950833] serial 00:0a: disabled [48830.950936] eth1: Going into suspend... [48830.951140] ipw2200 0000:04:02.0: PCI INT A disabled [48830.951148] ACPI handle has no context! [48831.244072] radeon 0000:01:00.0: Refused to change power state, currently in D0 [48831.244148] radeon 0000:01:00.0: power state changed by ACPI to D3 [48831.244163] PM: suspend of drv:radeon dev:0000:01:00.0 complete after 280.008 msecs [48831.260221] Intel ICH 0000:00:1e.2: PCI INT A disabled [48831.260265] ehci_hcd 0000:00:1d.7: PCI INT D disabled [48831.260275] uhci_hcd 0000:00:1d.3: PCI INT D disabled [48831.260284] uhci_hcd 0000:00:1d.2: PCI INT C disabled [48831.260293] uhci_hcd 0000:00:1d.1: PCI INT B disabled [48831.260302] uhci_hcd 0000:00:1d.0: PCI INT A disabled [48831.260519] PM: suspend of devices complete after 1983.012 msecs [48831.260522] PM: suspend devices took 1.984 seconds [48831.284066] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D3 [48831.292060] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D3 [48831.320049] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D3 [48831.320244] PM: late suspend of devices complete after 59.716 msecs [48831.360054] ACPI: Preparing to enter system sleep state S3 [48831.540160] Disabling non-boot CPUs ... [48831.540215] Extended CMOS year: 2000 [48831.540215] Back to C! [48831.540215] CPU0: Thermal monitoring enabled (TM2) [48831.540215] Extended CMOS year: 2000 [48831.540215] Force enabled HPET at resume [48831.540215] ACPI: Waking up from system sleep state S3 [48831.884199] pcieport 0000:00:01.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [48831.884238] pcieport 0000:00:1c.0: restoring config space at offset 0x9 (was 0x1fff1, writing 0x40114001) [48831.884245] pcieport 0000:00:1c.0: restoring config space at offset 0x7 (was 0xf0, writing 0x9090) [48831.884257] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [48831.884321] pcieport 0000:00:1c.2: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [48831.928049] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [48831.936059] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [48831.936065] uhci_hcd 0000:00:1d.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [48831.936078] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x8 (was 0x1, writing 0x1801) [48831.936091] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [48831.944059] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [48831.952058] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [48831.960058] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [48831.968059] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [48831.968065] uhci_hcd 0000:00:1d.1: restoring config space at offset 0xf (was 0x200, writing 0x20b) [48831.968078] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x8 (was 0x1, writing 0x1821) [48831.968091] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [48831.976058] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [48831.984058] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [48831.984067] uhci_hcd 0000:00:1d.2: restoring config space at offset 0xf (was 0x300, writing 0x30b) [48831.984081] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x8 (was 0x1, writing 0x1841) [48831.984094] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [48831.984107] uhci_hcd 0000:00:1d.3: restoring config space at offset 0xf (was 0x400, writing 0x40b) [48831.984120] uhci_hcd 0000:00:1d.3: restoring config space at offset 0x8 (was 0x1, writing 0x1861) [48831.984133] uhci_hcd 0000:00:1d.3: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [48831.984154] ehci_hcd 0000:00:1d.7: restoring config space at offset 0xf (was 0x400, writing 0x40b) [48831.984172] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x4 (was 0x0, writing 0xa8000000) [48831.984180] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900102) [48831.992058] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [48832.000067] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [48832.000135] Intel ICH 0000:00:1e.2: restoring config space at offset 0x1 (was 0x2900007, writing 0x2900003) [48832.000174] pci 0000:00:1e.3: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) [48832.000313] radeon 0000:01:00.0: restoring config space at offset 0x1 (was 0x100103, writing 0x100507) [48832.000369] tg3 0000:02:00.0: restoring config space at offset 0xc (was 0x0, writing 0xff7e0000) [48832.000395] tg3 0000:02:00.0: restoring config space at offset 0x1 (was 0x100102, writing 0x100106) [48832.000972] PM: early resume of devices complete after 116.880 msecs [48832.043665] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [48832.043831] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [48832.043839] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [48832.043846] uhci_hcd 0000:00:1d.0: setting latency timer to 64 [48832.043869] usb usb2: root hub lost power or was reset [48832.044157] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [48832.044324] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [48832.044329] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [48832.044336] uhci_hcd 0000:00:1d.1: setting latency timer to 64 [48832.044358] usb usb3: root hub lost power or was reset [48832.044385] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [48832.044392] uhci_hcd 0000:00:1d.2: setting latency timer to 64 [48832.044415] usb usb4: root hub lost power or was reset [48832.044442] uhci_hcd 0000:00:1d.3: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [48832.044448] uhci_hcd 0000:00:1d.3: setting latency timer to 64 [48832.044470] usb usb5: root hub lost power or was reset [48832.044647] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [48832.044806] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [48832.044813] ehci_hcd 0000:00:1d.7: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [48832.044819] ehci_hcd 0000:00:1d.7: setting latency timer to 64 [48832.044849] pci 0000:00:1e.0: setting latency timer to 64 [48832.044859] Intel ICH 0000:00:1e.2: PCI INT A -> GSI 22 (level, low) -> IRQ 22 [48832.044866] Intel ICH 0000:00:1e.2: setting latency timer to 64 [48833.057798] PM: resume of drv:Intel ICH dev:0000:00:1e.2 complete after 1012.944 msecs [48833.057815] ata_piix 0000:00:1f.2: setting latency timer to 64 [48833.059702] radeon 0000:01:00.0: power state changed by ACPI to D0 [48833.059762] radeon 0000:01:00.0: power state changed by ACPI to D0 [48833.060336] radeon 0000:01:00.0: power state changed by ACPI to D0 [48833.060672] radeon 0000:01:00.0: power state changed by ACPI to D0 [48833.060681] radeon 0000:01:00.0: setting latency timer to 64 [48833.060688] radeon 0000:01:00.0: e7488e00 unpin not necessary [48833.060897] [drm] GPU reset succeed (RBBM_STATUS=0x00000140) [48833.203360] [drm] radeon: 1 quad pipes, 1 Z pipes initialized. [48833.229311] [drm] PCIE GART of 512M enabled (table at 0x00040000). [48833.229321] [drm] radeon: cp idle (0x10000C03) [48833.229353] [drm] radeon: ring at 0x0000000020000000 [48833.229374] [drm] ring test succeeded in 1 usecs [48833.229389] [drm] ib test succeeded in 0 usecs [48833.249627] ata2.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [48833.249631] ata2.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [48833.310307] ata2.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [48833.314921] ata2.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [48833.334916] PM: resume of drv:radeon dev:0000:01:00.0 complete after 275.248 msecs [48833.348326] ata2.00: configured for UDMA/33 [48833.364611] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [48833.364615] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [48833.364619] ata1.00: ACPI cmd ef/03:45:00:00:00:a0 (SET FEATURES) filtered out [48833.364622] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [48833.390182] ata1.00: configured for UDMA/100 [48833.472064] PM: resume of drv:yenta_cardbus dev:0000:04:00.0 complete after 136.608 msecs [48833.472069] eth1: Coming out of suspend... [48833.472077] ipw2200 0000:04:02.0: PCI INT A -> GSI 21 (level, low) -> IRQ 21 [48833.499691] serial 00:0a: activated [48833.500329] parport_pc 00:0b: activated [48833.501032] nsc-ircc 00:0c: activated [48833.816029] PM: resume of drv:usb dev:usb1 complete after 314.588 msecs [48834.064031] PM: resume of drv:usb dev:usb2 complete after 247.987 msecs [48834.312031] PM: resume of drv:usb dev:usb3 complete after 247.986 msecs [48834.560026] PM: resume of drv:usb dev:usb4 complete after 247.982 msecs [48834.561961] sd 0:0:0:0: [sda] Starting disk [48837.580015] [48837.580017] floppy driver state [48837.580018] ------------------- [48837.580021] now=12134395 last interrupt=4294906090 diff=12195601 last called handler=f80a90a0 [48837.580023] timeout_message=lock fdc [48837.580025] last output bytes: [48837.580027] 18 80 4294892592 [48837.580029] 8 80 4294892592 [48837.580030] 8 80 4294892592 [48837.580032] 8 80 4294892592 [48837.580034] 8 80 4294892592 [48837.580035] 12 80 4294905911 [48837.580037] 0 90 4294905911 [48837.580039] 13 80 4294905911 [48837.580040] 0 90 4294905911 [48837.580042] 1a 90 4294905911 [48837.580044] 0 90 4294905911 [48837.580045] 3 80 4294905911 [48837.580047] c1 90 4294905911 [48837.580049] 10 90 4294905911 [48837.580050] 7 80 4294905911 [48837.580052] 0 90 4294905911 [48837.580054] 8 81 4294905998 [48837.580055] 7 80 4294906003 [48837.580057] 0 90 4294906003 [48837.580059] 8 81 4294906090 [48837.580060] last result at 4294906090 [48837.580062] last redo_fd_request at 11461652 [48837.580063] 70 0 [48837.580072] status=0 [48837.580073] fdc_busy=1 [48837.580075] do_floppy=f80a45b0 [48837.580076] cont=f80ab290 [48837.580078] current_req=(null) [48837.580080] command_status=-1 [48837.580081] [48837.580085] floppy0: floppy timeout called [48837.580099] PM: resume of drv:floppy dev:floppy.0 complete after 2996.840 msecs [48837.692026] usb 3-1: reset full speed USB device using uhci_hcd and address 2 [48837.847182] PM: resume of drv:usb dev:3-1 complete after 267.069 msecs [48837.956062] usb 4-2: reset full speed USB device using uhci_hcd and address 2 [48838.106182] PM: resume of drv:usb dev:4-2 complete after 258.984 msecs [48838.368064] usb 2-1: reset low speed USB device using uhci_hcd and address 3 [48838.675218] PM: resume of drv:usb dev:2-1 complete after 565.939 msecs [48838.784062] usb 3-2: reset full speed USB device using uhci_hcd and address 3 [48838.965217] snd-usb-audio 3-2:1.0: no reset_resume for driver snd-usb-audio? [48838.965219] snd-usb-audio 3-2:1.1: no reset_resume for driver snd-usb-audio? [48838.965222] snd-usb-audio 3-2:1.2: no reset_resume for driver snd-usb-audio? [48838.965547] PM: resume of drv:usb dev:3-2 complete after 290.289 msecs [48838.965568] PM: resume of devices complete after 6964.508 msecs [48839.034753] PM: resume devices took 7.032 seconds [48839.034793] PM: Finishing wakeup. [48839.034795] Restarting tasks ... [48839.035386] hub 1-0:1.0: over-current change on port 3 [48839.091931] done. [48839.136039] hub 1-0:1.0: over-current change on port 4 [48839.240526] hub 3-0:1.0: over-current change on port 1 [48839.344087] hub 3-0:1.0: over-current change on port 2 [48840.795909] tg3 0000:02:00.0: PME# disabled [48840.964641] ADDRCONF(NETDEV_UP): eth0: link is not ready [48840.980613] ADDRCONF(NETDEV_UP): eth1: link is not ready [48841.252261] ADDRCONF(NETDEV_CHANGE): eth1: link becomes ready [54233.156462] tg3 0000:02:00.0: PME# enabled [54236.352948] PM: Syncing filesystems ... done. [54236.498414] PM: Preparing system for mem sleep [54236.498420] Freezing user space processes ... (elapsed 0.00 seconds) done. [54236.500952] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done. [54236.501008] PM: Entering mem sleep [54236.501025] Suspending console(s) (use no_console_suspend to debug) [54236.740763] PM: suspend of drv:psmouse dev:serio2 complete after 208.648 msecs [54236.772103] sd 0:0:0:0: [sda] Synchronizing SCSI cache [54236.772269] sd 0:0:0:0: [sda] Stopping disk [54237.168188] PM: suspend of drv:sd dev:0:0:0:0 complete after 396.086 msecs [54237.599944] PM: suspend of drv:psmouse dev:serio1 complete after 431.695 msecs [54238.204026] PM: suspend of drv:atkbd dev:serio0 complete after 604.077 msecs [54238.206756] nsc-ircc 00:0c: disabled [54238.207021] parport_pc 00:0b: disabled [54238.207299] serial 00:0a: disabled [54238.207403] eth1: Going into suspend... [54238.208342] ipw2200 0000:04:02.0: PCI INT A disabled [54238.208350] ACPI handle has no context! [54238.432069] radeon 0000:01:00.0: Refused to change power state, currently in D0 [54238.432144] radeon 0000:01:00.0: power state changed by ACPI to D3 [54238.432159] PM: suspend of drv:radeon dev:0000:01:00.0 complete after 208.042 msecs [54238.448260] Intel ICH 0000:00:1e.2: PCI INT A disabled [54238.448304] ehci_hcd 0000:00:1d.7: PCI INT D disabled [54238.448314] uhci_hcd 0000:00:1d.3: PCI INT D disabled [54238.448323] uhci_hcd 0000:00:1d.2: PCI INT C disabled [54238.448332] uhci_hcd 0000:00:1d.1: PCI INT B disabled [54238.448341] uhci_hcd 0000:00:1d.0: PCI INT A disabled [54238.448556] PM: suspend of devices complete after 1947.308 msecs [54238.448559] PM: suspend devices took 1.948 seconds [54238.472066] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D3 [54238.480060] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D3 [54238.508049] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D3 [54238.508244] PM: late suspend of devices complete after 59.680 msecs [54238.548054] ACPI: Preparing to enter system sleep state S3 [54238.728159] Disabling non-boot CPUs ... [54238.728216] Extended CMOS year: 2000 [54238.728216] Back to C! [54238.728216] CPU0: Thermal monitoring enabled (TM2) [54238.728216] Extended CMOS year: 2000 [54238.728216] Force enabled HPET at resume [54238.728216] ACPI: Waking up from system sleep state S3 [54239.072199] pcieport 0000:00:01.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [54239.072238] pcieport 0000:00:1c.0: restoring config space at offset 0x9 (was 0x1fff1, writing 0x40114001) [54239.072245] pcieport 0000:00:1c.0: restoring config space at offset 0x7 (was 0xf0, writing 0x9090) [54239.072257] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [54239.072321] pcieport 0000:00:1c.2: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [54239.116050] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [54239.124059] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [54239.124065] uhci_hcd 0000:00:1d.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [54239.124078] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x8 (was 0x1, writing 0x1801) [54239.124091] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [54239.132059] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [54239.140058] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [54239.148058] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [54239.156058] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [54239.156064] uhci_hcd 0000:00:1d.1: restoring config space at offset 0xf (was 0x200, writing 0x20b) [54239.156077] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x8 (was 0x1, writing 0x1821) [54239.156091] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [54239.164059] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [54239.172065] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [54239.172074] uhci_hcd 0000:00:1d.2: restoring config space at offset 0xf (was 0x300, writing 0x30b) [54239.172087] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x8 (was 0x1, writing 0x1841) [54239.172101] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [54239.172114] uhci_hcd 0000:00:1d.3: restoring config space at offset 0xf (was 0x400, writing 0x40b) [54239.172127] uhci_hcd 0000:00:1d.3: restoring config space at offset 0x8 (was 0x1, writing 0x1861) [54239.172140] uhci_hcd 0000:00:1d.3: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [54239.172161] ehci_hcd 0000:00:1d.7: restoring config space at offset 0xf (was 0x400, writing 0x40b) [54239.172180] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x4 (was 0x0, writing 0xa8000000) [54239.172188] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900102) [54239.180059] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [54239.188059] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [54239.188127] Intel ICH 0000:00:1e.2: restoring config space at offset 0x1 (was 0x2900007, writing 0x2900003) [54239.188166] pci 0000:00:1e.3: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) [54239.188304] radeon 0000:01:00.0: restoring config space at offset 0x1 (was 0x100103, writing 0x100507) [54239.188361] tg3 0000:02:00.0: restoring config space at offset 0xc (was 0x0, writing 0xff7e0000) [54239.188388] tg3 0000:02:00.0: restoring config space at offset 0x1 (was 0x100102, writing 0x100106) [54239.188986] PM: early resume of devices complete after 116.895 msecs [54239.231356] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [54239.231518] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [54239.231526] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [54239.231533] uhci_hcd 0000:00:1d.0: setting latency timer to 64 [54239.231557] usb usb2: root hub lost power or was reset [54239.231747] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [54239.231903] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [54239.231908] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [54239.231915] uhci_hcd 0000:00:1d.1: setting latency timer to 64 [54239.231937] usb usb3: root hub lost power or was reset [54239.231967] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [54239.231973] uhci_hcd 0000:00:1d.2: setting latency timer to 64 [54239.231996] usb usb4: root hub lost power or was reset [54239.232118] uhci_hcd 0000:00:1d.3: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [54239.232125] uhci_hcd 0000:00:1d.3: setting latency timer to 64 [54239.232147] usb usb5: root hub lost power or was reset [54239.232325] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [54239.232483] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [54239.232490] ehci_hcd 0000:00:1d.7: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [54239.232497] ehci_hcd 0000:00:1d.7: setting latency timer to 64 [54239.232527] pci 0000:00:1e.0: setting latency timer to 64 [54239.232537] Intel ICH 0000:00:1e.2: PCI INT A -> GSI 22 (level, low) -> IRQ 22 [54239.232544] Intel ICH 0000:00:1e.2: setting latency timer to 64 [54240.245809] PM: resume of drv:Intel ICH dev:0000:00:1e.2 complete after 1013.277 msecs [54240.245826] ata_piix 0000:00:1f.2: setting latency timer to 64 [54240.247728] radeon 0000:01:00.0: power state changed by ACPI to D0 [54240.248300] radeon 0000:01:00.0: power state changed by ACPI to D0 [54240.248636] radeon 0000:01:00.0: power state changed by ACPI to D0 [54240.248676] radeon 0000:01:00.0: power state changed by ACPI to D0 [54240.248682] radeon 0000:01:00.0: setting latency timer to 64 [54240.248689] radeon 0000:01:00.0: e7488e00 unpin not necessary [54240.248899] [drm] GPU reset succeed (RBBM_STATUS=0x00000140) [54240.390779] [drm] radeon: 1 quad pipes, 1 Z pipes initialized. [54240.416701] [drm] PCIE GART of 512M enabled (table at 0x00040000). [54240.416711] [drm] radeon: cp idle (0x10000C03) [54240.416743] [drm] radeon: ring at 0x0000000020000000 [54240.416764] [drm] ring test succeeded in 1 usecs [54240.416780] [drm] ib test succeeded in 0 usecs [54240.437021] ata2.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [54240.437026] ata2.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [54240.497702] ata2.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [54240.502778] ata2.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [54240.502929] PM: resume of drv:radeon dev:0000:01:00.0 complete after 255.256 msecs [54240.524328] ata2.00: configured for UDMA/33 [54240.640063] PM: resume of drv:yenta_cardbus dev:0000:04:00.0 complete after 137.113 msecs [54240.640068] eth1: Coming out of suspend... [54240.640076] ipw2200 0000:04:02.0: PCI INT A -> GSI 21 (level, low) -> IRQ 21 [54240.667931] serial 00:0a: activated [54240.668570] parport_pc 00:0b: activated [54240.669274] nsc-ircc 00:0c: activated [54240.776557] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [54240.776562] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [54240.776566] ata1.00: ACPI cmd ef/03:45:00:00:00:a0 (SET FEATURES) filtered out [54240.776570] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [54240.802160] ata1.00: configured for UDMA/100 [54240.984069] PM: resume of drv:usb dev:usb1 complete after 314.380 msecs [54241.232031] PM: resume of drv:usb dev:usb2 complete after 247.947 msecs [54241.480031] PM: resume of drv:usb dev:usb3 complete after 247.986 msecs [54241.728031] PM: resume of drv:usb dev:usb4 complete after 247.986 msecs [54241.730172] sd 0:0:0:0: [sda] Starting disk [54244.744016] [54244.744017] floppy driver state [54244.744019] ------------------- [54244.744022] now=13486186 last interrupt=4294906090 diff=13547392 last called handler=f80a90a0 [54244.744024] timeout_message=lock fdc [54244.744025] last output bytes: [54244.744027] 18 80 4294892592 [54244.744029] 8 80 4294892592 [54244.744031] 8 80 4294892592 [54244.744033] 8 80 4294892592 [54244.744034] 8 80 4294892592 [54244.744036] 12 80 4294905911 [54244.744038] 0 90 4294905911 [54244.744039] 13 80 4294905911 [54244.744041] 0 90 4294905911 [54244.744043] 1a 90 4294905911 [54244.744044] 0 90 4294905911 [54244.744046] 3 80 4294905911 [54244.744048] c1 90 4294905911 [54244.744049] 10 90 4294905911 [54244.744051] 7 80 4294905911 [54244.744053] 0 90 4294905911 [54244.744054] 8 81 4294905998 [54244.744056] 7 80 4294906003 [54244.744058] 0 90 4294906003 [54244.744059] 8 81 4294906090 [54244.744061] last result at 4294906090 [54244.744062] last redo_fd_request at 12134395 [54244.744064] 70 0 [54244.744073] status=0 [54244.744074] fdc_busy=1 [54244.744076] do_floppy=f80a45b0 [54244.744077] cont=f80ab290 [54244.744079] current_req=(null) [54244.744080] command_status=-1 [54244.744082] [54244.744085] floppy0: floppy timeout called [54244.744099] PM: resume of drv:floppy dev:floppy.0 complete after 2998.179 msecs [54244.856063] usb 3-1: reset full speed USB device using uhci_hcd and address 2 [54245.011180] PM: resume of drv:usb dev:3-1 complete after 267.067 msecs [54245.120062] usb 4-2: reset full speed USB device using uhci_hcd and address 2 [54245.270183] PM: resume of drv:usb dev:4-2 complete after 258.986 msecs [54245.532061] usb 2-1: reset low speed USB device using uhci_hcd and address 3 [54245.839219] PM: resume of drv:usb dev:2-1 complete after 565.930 msecs [54245.948025] usb 3-2: reset full speed USB device using uhci_hcd and address 3 [54246.129215] snd-usb-audio 3-2:1.0: no reset_resume for driver snd-usb-audio? [54246.129218] snd-usb-audio 3-2:1.1: no reset_resume for driver snd-usb-audio? [54246.129221] snd-usb-audio 3-2:1.2: no reset_resume for driver snd-usb-audio? [54246.129549] PM: resume of drv:usb dev:3-2 complete after 290.289 msecs [54246.129570] PM: resume of devices complete after 6940.494 msecs [54246.198751] PM: resume devices took 7.008 seconds [54246.198791] PM: Finishing wakeup. [54246.198793] Restarting tasks ... [54246.199377] hub 1-0:1.0: over-current change on port 3 [54246.239277] done. [54246.300309] hub 1-0:1.0: over-current change on port 4 [54246.404044] hub 3-0:1.0: over-current change on port 1 [54246.508034] hub 3-0:1.0: over-current change on port 2 [54248.253257] tg3 0000:02:00.0: PME# disabled [54248.417946] ADDRCONF(NETDEV_UP): eth0: link is not ready [54248.425667] ADDRCONF(NETDEV_UP): eth1: link is not ready [54249.415702] ADDRCONF(NETDEV_CHANGE): eth1: link becomes ready [56209.372758] tg3 0000:02:00.0: PME# enabled [56210.421119] PM: Syncing filesystems ... done. [56210.422795] PM: Preparing system for mem sleep [56210.422801] Freezing user space processes ... (elapsed 0.00 seconds) done. [56210.425567] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done. [56210.425626] PM: Entering mem sleep [56210.425643] Suspending console(s) (use no_console_suspend to debug) [56210.675066] PM: suspend of drv:psmouse dev:serio2 complete after 218.980 msecs [56210.704103] sd 0:0:0:0: [sda] Synchronizing SCSI cache [56210.704290] sd 0:0:0:0: [sda] Stopping disk [56211.097608] PM: suspend of drv:sd dev:0:0:0:0 complete after 393.506 msecs [56211.529610] PM: suspend of drv:psmouse dev:serio1 complete after 431.942 msecs [56212.132063] PM: suspend of drv:atkbd dev:serio0 complete after 602.448 msecs [56212.134081] nsc-ircc 00:0c: disabled [56212.134345] parport_pc 00:0b: disabled [56212.134624] serial 00:0a: disabled [56212.134727] eth1: Going into suspend... [56212.135664] ipw2200 0000:04:02.0: PCI INT A disabled [56212.135672] ACPI handle has no context! [56212.408070] radeon 0000:01:00.0: Refused to change power state, currently in D0 [56212.408147] radeon 0000:01:00.0: power state changed by ACPI to D3 [56212.408162] PM: suspend of drv:radeon dev:0000:01:00.0 complete after 260.007 msecs [56212.424268] Intel ICH 0000:00:1e.2: PCI INT A disabled [56212.424312] ehci_hcd 0000:00:1d.7: PCI INT D disabled [56212.424322] uhci_hcd 0000:00:1d.3: PCI INT D disabled [56212.424331] uhci_hcd 0000:00:1d.2: PCI INT C disabled [56212.424340] uhci_hcd 0000:00:1d.1: PCI INT B disabled [56212.424349] uhci_hcd 0000:00:1d.0: PCI INT A disabled [56212.424567] PM: suspend of devices complete after 1998.701 msecs [56212.424570] PM: suspend devices took 2.000 seconds [56212.448067] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D3 [56212.456060] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D3 [56212.484049] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D3 [56212.484250] PM: late suspend of devices complete after 59.674 msecs [56212.524054] ACPI: Preparing to enter system sleep state S3 [56212.704159] Disabling non-boot CPUs ... [56212.704215] Extended CMOS year: 2000 [56212.704215] Back to C! [56212.704215] CPU0: Thermal monitoring enabled (TM2) [56212.704215] Extended CMOS year: 2000 [56212.704215] Force enabled HPET at resume [56212.704215] ACPI: Waking up from system sleep state S3 [56213.048200] pcieport 0000:00:01.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [56213.048239] pcieport 0000:00:1c.0: restoring config space at offset 0x9 (was 0x1fff1, writing 0x40114001) [56213.048246] pcieport 0000:00:1c.0: restoring config space at offset 0x7 (was 0xf0, writing 0x9090) [56213.048258] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [56213.048322] pcieport 0000:00:1c.2: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [56213.092050] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [56213.100059] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [56213.100065] uhci_hcd 0000:00:1d.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [56213.100078] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x8 (was 0x1, writing 0x1801) [56213.100091] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [56213.108059] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [56213.116058] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [56213.124058] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [56213.132058] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [56213.132064] uhci_hcd 0000:00:1d.1: restoring config space at offset 0xf (was 0x200, writing 0x20b) [56213.132077] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x8 (was 0x1, writing 0x1821) [56213.132091] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [56213.140059] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [56213.148058] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [56213.148067] uhci_hcd 0000:00:1d.2: restoring config space at offset 0xf (was 0x300, writing 0x30b) [56213.148081] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x8 (was 0x1, writing 0x1841) [56213.148094] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [56213.148107] uhci_hcd 0000:00:1d.3: restoring config space at offset 0xf (was 0x400, writing 0x40b) [56213.148120] uhci_hcd 0000:00:1d.3: restoring config space at offset 0x8 (was 0x1, writing 0x1861) [56213.148133] uhci_hcd 0000:00:1d.3: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [56213.148154] ehci_hcd 0000:00:1d.7: restoring config space at offset 0xf (was 0x400, writing 0x40b) [56213.148172] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x4 (was 0x0, writing 0xa8000000) [56213.148180] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900102) [56213.156058] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [56213.164058] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [56213.164125] Intel ICH 0000:00:1e.2: restoring config space at offset 0x1 (was 0x2900007, writing 0x2900003) [56213.164165] pci 0000:00:1e.3: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) [56213.164303] radeon 0000:01:00.0: restoring config space at offset 0x1 (was 0x180103, writing 0x100507) [56213.164361] tg3 0000:02:00.0: restoring config space at offset 0xc (was 0x0, writing 0xff7f0000) [56213.164388] tg3 0000:02:00.0: restoring config space at offset 0x1 (was 0x100102, writing 0x100106) [56213.164961] PM: early resume of devices complete after 116.869 msecs [56213.207593] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [56213.207754] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [56213.207763] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [56213.207769] uhci_hcd 0000:00:1d.0: setting latency timer to 64 [56213.207793] usb usb2: root hub lost power or was reset [56213.208104] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [56213.208266] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [56213.208272] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [56213.208279] uhci_hcd 0000:00:1d.1: setting latency timer to 64 [56213.208302] usb usb3: root hub lost power or was reset [56213.208332] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [56213.208338] uhci_hcd 0000:00:1d.2: setting latency timer to 64 [56213.208360] usb usb4: root hub lost power or was reset [56213.208387] uhci_hcd 0000:00:1d.3: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [56213.208394] uhci_hcd 0000:00:1d.3: setting latency timer to 64 [56213.208414] usb usb5: root hub lost power or was reset [56213.208586] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [56213.208749] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [56213.208756] ehci_hcd 0000:00:1d.7: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [56213.208763] ehci_hcd 0000:00:1d.7: setting latency timer to 64 [56213.208793] pci 0000:00:1e.0: setting latency timer to 64 [56213.208803] Intel ICH 0000:00:1e.2: PCI INT A -> GSI 22 (level, low) -> IRQ 22 [56213.208809] Intel ICH 0000:00:1e.2: setting latency timer to 64 [56214.221804] PM: resume of drv:Intel ICH dev:0000:00:1e.2 complete after 1013.006 msecs [56214.221821] ata_piix 0000:00:1f.2: setting latency timer to 64 [56214.223792] radeon 0000:01:00.0: power state changed by ACPI to D0 [56214.224365] radeon 0000:01:00.0: power state changed by ACPI to D0 [56214.224699] radeon 0000:01:00.0: power state changed by ACPI to D0 [56214.224740] radeon 0000:01:00.0: power state changed by ACPI to D0 [56214.224746] radeon 0000:01:00.0: setting latency timer to 64 [56214.224752] radeon 0000:01:00.0: e7488e00 unpin not necessary [56214.224962] [drm] GPU reset succeed (RBBM_STATUS=0x00000140) [56214.366829] [drm] radeon: 1 quad pipes, 1 Z pipes initialized. [56214.392873] [drm] PCIE GART of 512M enabled (table at 0x00040000). [56214.392877] [drm] radeon: cp idle (0x10000C03) [56214.392908] [drm] radeon: ring at 0x0000000020000000 [56214.392929] [drm] ring test succeeded in 1 usecs [56214.392944] [drm] ib test succeeded in 0 usecs [56214.413486] ata2.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [56214.413490] ata2.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [56214.474165] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [56214.474169] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [56214.474173] ata1.00: ACPI cmd ef/03:45:00:00:00:a0 (SET FEATURES) filtered out [56214.474177] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [56214.474242] ata2.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [56214.479026] ata2.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [56214.479226] PM: resume of drv:radeon dev:0000:01:00.0 complete after 255.488 msecs [56214.494290] ata1.00: configured for UDMA/100 [56214.500323] ata2.00: configured for UDMA/33 [56214.616064] PM: resume of drv:yenta_cardbus dev:0000:04:00.0 complete after 136.816 msecs [56214.616068] eth1: Coming out of suspend... [56214.616076] ipw2200 0000:04:02.0: PCI INT A -> GSI 21 (level, low) -> IRQ 21 [56214.643922] serial 00:0a: activated [56214.644561] parport_pc 00:0b: activated [56214.645264] nsc-ircc 00:0c: activated [56214.960069] PM: resume of drv:usb dev:usb1 complete after 314.393 msecs [56215.208047] PM: resume of drv:usb dev:usb2 complete after 247.964 msecs [56215.456031] PM: resume of drv:usb dev:usb3 complete after 247.970 msecs [56215.704029] PM: resume of drv:usb dev:usb4 complete after 247.983 msecs [56215.706073] sd 0:0:0:0: [sda] Starting disk [56218.720052] [56218.720054] floppy driver state [56218.720055] ------------------- [56218.720058] now=13979680 last interrupt=4294906090 diff=14040886 last called handler=f80a90a0 [56218.720060] timeout_message=lock fdc [56218.720062] last output bytes: [56218.720064] 18 80 4294892592 [56218.720065] 8 80 4294892592 [56218.720067] 8 80 4294892592 [56218.720069] 8 80 4294892592 [56218.720071] 8 80 4294892592 [56218.720072] 12 80 4294905911 [56218.720074] 0 90 4294905911 [56218.720076] 13 80 4294905911 [56218.720077] 0 90 4294905911 [56218.720079] 1a 90 4294905911 [56218.720081] 0 90 4294905911 [56218.720082] 3 80 4294905911 [56218.720084] c1 90 4294905911 [56218.720086] 10 90 4294905911 [56218.720087] 7 80 4294905911 [56218.720089] 0 90 4294905911 [56218.720091] 8 81 4294905998 [56218.720092] 7 80 4294906003 [56218.720094] 0 90 4294906003 [56218.720096] 8 81 4294906090 [56218.720097] last result at 4294906090 [56218.720099] last redo_fd_request at 13486186 [56218.720100] 70 0 [56218.720109] status=0 [56218.720110] fdc_busy=1 [56218.720112] do_floppy=f80a45b0 [56218.720113] cont=f80ab290 [56218.720115] current_req=(null) [56218.720117] command_status=-1 [56218.720118] [56218.720122] floppy0: floppy timeout called [56218.720136] PM: resume of drv:floppy dev:floppy.0 complete after 2997.783 msecs [56218.832064] usb 3-1: reset full speed USB device using uhci_hcd and address 2 [56218.987180] PM: resume of drv:usb dev:3-1 complete after 267.030 msecs [56219.096063] usb 4-2: reset full speed USB device using uhci_hcd and address 2 [56219.246180] PM: resume of drv:usb dev:4-2 complete after 258.983 msecs [56219.508061] usb 2-1: reset low speed USB device using uhci_hcd and address 3 [56219.815255] PM: resume of drv:usb dev:2-1 complete after 565.982 msecs [56219.924025] usb 3-2: reset full speed USB device using uhci_hcd and address 3 [56220.109214] snd-usb-audio 3-2:1.0: no reset_resume for driver snd-usb-audio? [56220.109216] snd-usb-audio 3-2:1.1: no reset_resume for driver snd-usb-audio? [56220.109219] snd-usb-audio 3-2:1.2: no reset_resume for driver snd-usb-audio? [56220.109536] PM: resume of drv:usb dev:3-2 complete after 294.241 msecs [56220.109557] PM: resume of devices complete after 6944.507 msecs [56220.178745] PM: resume devices took 7.012 seconds [56220.178785] PM: Finishing wakeup. [56220.178786] Restarting tasks ... [56220.179353] hub 1-0:1.0: over-current change on port 3 [56220.240199] done. [56220.280093] hub 1-0:1.0: over-current change on port 4 [56220.384767] hub 3-0:1.0: over-current change on port 1 [56220.488044] hub 3-0:1.0: over-current change on port 2 [56220.689000] tg3 0000:02:00.0: PME# disabled [56221.203877] ADDRCONF(NETDEV_UP): eth0: link is not ready [56221.215551] ADDRCONF(NETDEV_UP): eth1: link is not ready [56221.845211] ADDRCONF(NETDEV_CHANGE): eth1: link becomes ready [57115.829331] tg3 0000:02:00.0: PME# enabled [57117.786938] PM: Syncing filesystems ... done. [57117.788194] PM: Preparing system for mem sleep [57117.788200] Freezing user space processes ... (elapsed 0.00 seconds) done. [57117.790617] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done. [57117.790676] PM: Entering mem sleep [57117.790693] Suspending console(s) (use no_console_suspend to debug) [57118.033232] PM: suspend of drv:psmouse dev:serio2 complete after 213.146 msecs [57118.064107] sd 0:0:0:0: [sda] Synchronizing SCSI cache [57118.064255] sd 0:0:0:0: [sda] Stopping disk [57118.447989] PM: suspend of drv:sd dev:0:0:0:0 complete after 383.882 msecs [57118.877752] PM: suspend of drv:psmouse dev:serio1 complete after 429.694 msecs [57119.480026] PM: suspend of drv:atkbd dev:serio0 complete after 602.268 msecs [57119.481989] nsc-ircc 00:0c: disabled [57119.482255] parport_pc 00:0b: disabled [57119.482534] serial 00:0a: disabled [57119.482636] eth1: Going into suspend... [57119.483577] ipw2200 0000:04:02.0: PCI INT A disabled [57119.483584] ACPI handle has no context! [57119.752069] radeon 0000:01:00.0: Refused to change power state, currently in D0 [57119.752132] radeon 0000:01:00.0: power state changed by ACPI to D3 [57119.752145] PM: suspend of drv:radeon dev:0000:01:00.0 complete after 256.026 msecs [57119.768270] Intel ICH 0000:00:1e.2: PCI INT A disabled [57119.768315] ehci_hcd 0000:00:1d.7: PCI INT D disabled [57119.768325] uhci_hcd 0000:00:1d.3: PCI INT D disabled [57119.768334] uhci_hcd 0000:00:1d.2: PCI INT C disabled [57119.768343] uhci_hcd 0000:00:1d.1: PCI INT B disabled [57119.768352] uhci_hcd 0000:00:1d.0: PCI INT A disabled [57119.768561] PM: suspend of devices complete after 1977.644 msecs [57119.768565] PM: suspend devices took 1.980 seconds [57119.792066] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D3 [57119.800060] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D3 [57119.828049] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D3 [57119.828245] PM: late suspend of devices complete after 59.675 msecs [57119.868054] ACPI: Preparing to enter system sleep state S3 [57120.048159] Disabling non-boot CPUs ... [57120.048214] Extended CMOS year: 2000 [57120.048214] Back to C! [57120.048214] CPU0: Thermal monitoring enabled (TM2) [57120.048214] Extended CMOS year: 2000 [57120.048214] Force enabled HPET at resume [57120.048214] ACPI: Waking up from system sleep state S3 [57120.392200] pcieport 0000:00:01.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [57120.392238] pcieport 0000:00:1c.0: restoring config space at offset 0x9 (was 0x1fff1, writing 0x40114001) [57120.392245] pcieport 0000:00:1c.0: restoring config space at offset 0x7 (was 0xf0, writing 0x9090) [57120.392257] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [57120.392321] pcieport 0000:00:1c.2: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [57120.436050] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [57120.444058] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [57120.444064] uhci_hcd 0000:00:1d.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [57120.444078] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x8 (was 0x1, writing 0x1801) [57120.444091] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [57120.452058] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [57120.460058] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [57120.468058] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [57120.476058] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [57120.476064] uhci_hcd 0000:00:1d.1: restoring config space at offset 0xf (was 0x200, writing 0x20b) [57120.476078] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x8 (was 0x1, writing 0x1821) [57120.476091] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [57120.484058] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [57120.492058] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [57120.492067] uhci_hcd 0000:00:1d.2: restoring config space at offset 0xf (was 0x300, writing 0x30b) [57120.492080] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x8 (was 0x1, writing 0x1841) [57120.492094] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [57120.492107] uhci_hcd 0000:00:1d.3: restoring config space at offset 0xf (was 0x400, writing 0x40b) [57120.492120] uhci_hcd 0000:00:1d.3: restoring config space at offset 0x8 (was 0x1, writing 0x1861) [57120.492133] uhci_hcd 0000:00:1d.3: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [57120.492154] ehci_hcd 0000:00:1d.7: restoring config space at offset 0xf (was 0x400, writing 0x40b) [57120.492173] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x4 (was 0x0, writing 0xa8000000) [57120.492181] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900102) [57120.500059] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [57120.508058] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [57120.508126] Intel ICH 0000:00:1e.2: restoring config space at offset 0x1 (was 0x2900007, writing 0x2900003) [57120.508165] pci 0000:00:1e.3: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) [57120.508303] radeon 0000:01:00.0: restoring config space at offset 0x1 (was 0x100103, writing 0x100507) [57120.508359] tg3 0000:02:00.0: restoring config space at offset 0xc (was 0x0, writing 0xff7e0000) [57120.508385] tg3 0000:02:00.0: restoring config space at offset 0x1 (was 0x100102, writing 0x100106) [57120.508959] PM: early resume of devices complete after 116.867 msecs [57120.552183] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [57120.552386] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [57120.552395] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [57120.552401] uhci_hcd 0000:00:1d.0: setting latency timer to 64 [57120.552425] usb usb2: root hub lost power or was reset [57120.552613] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [57120.552774] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [57120.552779] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [57120.552786] uhci_hcd 0000:00:1d.1: setting latency timer to 64 [57120.552809] usb usb3: root hub lost power or was reset [57120.552836] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [57120.552842] uhci_hcd 0000:00:1d.2: setting latency timer to 64 [57120.552865] usb usb4: root hub lost power or was reset [57120.552892] uhci_hcd 0000:00:1d.3: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [57120.552898] uhci_hcd 0000:00:1d.3: setting latency timer to 64 [57120.552921] usb usb5: root hub lost power or was reset [57120.553103] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [57120.553271] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [57120.553278] ehci_hcd 0000:00:1d.7: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [57120.553285] ehci_hcd 0000:00:1d.7: setting latency timer to 64 [57120.553315] pci 0000:00:1e.0: setting latency timer to 64 [57120.553325] Intel ICH 0000:00:1e.2: PCI INT A -> GSI 22 (level, low) -> IRQ 22 [57120.553332] Intel ICH 0000:00:1e.2: setting latency timer to 64 [57121.565805] PM: resume of drv:Intel ICH dev:0000:00:1e.2 complete after 1012.485 msecs [57121.565822] ata_piix 0000:00:1f.2: setting latency timer to 64 [57121.567728] radeon 0000:01:00.0: power state changed by ACPI to D0 [57121.568300] radeon 0000:01:00.0: power state changed by ACPI to D0 [57121.568635] radeon 0000:01:00.0: power state changed by ACPI to D0 [57121.568676] radeon 0000:01:00.0: power state changed by ACPI to D0 [57121.568682] radeon 0000:01:00.0: setting latency timer to 64 [57121.568689] radeon 0000:01:00.0: e7488e00 unpin not necessary [57121.568899] [drm] GPU reset succeed (RBBM_STATUS=0x00000140) [57121.710746] [drm] radeon: 1 quad pipes, 1 Z pipes initialized. [57121.736746] [drm] PCIE GART of 512M enabled (table at 0x00040000). [57121.736757] [drm] radeon: cp idle (0x10000C03) [57121.736789] [drm] radeon: ring at 0x0000000020000000 [57121.736810] [drm] ring test succeeded in 1 usecs [57121.736825] [drm] ib test succeeded in 0 usecs [57121.757064] ata2.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [57121.757068] ata2.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [57121.817744] ata2.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [57121.822643] ata2.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [57121.822791] PM: resume of drv:radeon dev:0000:01:00.0 complete after 255.116 msecs [57121.844325] ata2.00: configured for UDMA/33 [57121.872614] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [57121.872618] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [57121.872622] ata1.00: ACPI cmd ef/03:45:00:00:00:a0 (SET FEATURES) filtered out [57121.872625] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [57121.898177] ata1.00: configured for UDMA/100 [57121.960063] PM: resume of drv:yenta_cardbus dev:0000:04:00.0 complete after 137.251 msecs [57121.960068] eth1: Coming out of suspend... [57121.960076] ipw2200 0000:04:02.0: PCI INT A -> GSI 21 (level, low) -> IRQ 21 [57121.988147] serial 00:0a: activated [57121.988770] parport_pc 00:0b: activated [57121.989471] nsc-ircc 00:0c: activated [57122.304068] PM: resume of drv:usb dev:usb1 complete after 314.183 msecs [57122.552046] PM: resume of drv:usb dev:usb2 complete after 247.963 msecs [57122.800031] PM: resume of drv:usb dev:usb3 complete after 247.971 msecs [57123.048030] PM: resume of drv:usb dev:usb4 complete after 247.985 msecs [57123.050478] sd 0:0:0:0: [sda] Starting disk [57126.064016] [57126.064017] floppy driver state [57126.064019] ------------------- [57126.064022] now=14206516 last interrupt=4294906090 diff=14267722 last called handler=f80a90a0 [57126.064024] timeout_message=lock fdc [57126.064025] last output bytes: [57126.064027] 18 80 4294892592 [57126.064029] 8 80 4294892592 [57126.064031] 8 80 4294892592 [57126.064032] 8 80 4294892592 [57126.064034] 8 80 4294892592 [57126.064036] 12 80 4294905911 [57126.064037] 0 90 4294905911 [57126.064039] 13 80 4294905911 [57126.064041] 0 90 4294905911 [57126.064042] 1a 90 4294905911 [57126.064044] 0 90 4294905911 [57126.064046] 3 80 4294905911 [57126.064047] c1 90 4294905911 [57126.064049] 10 90 4294905911 [57126.064050] 7 80 4294905911 [57126.064052] 0 90 4294905911 [57126.064054] 8 81 4294905998 [57126.064055] 7 80 4294906003 [57126.064057] 0 90 4294906003 [57126.064059] 8 81 4294906090 [57126.064060] last result at 4294906090 [57126.064062] last redo_fd_request at 13979680 [57126.064063] 70 0 [57126.064072] status=0 [57126.064073] fdc_busy=1 [57126.064075] do_floppy=f80a45b0 [57126.064076] cont=f80ab290 [57126.064078] current_req=(null) [57126.064080] command_status=-1 [57126.064081] [57126.064084] floppy0: floppy timeout called [57126.064099] PM: resume of drv:floppy dev:floppy.0 complete after 2998.091 msecs [57126.176063] usb 3-1: reset full speed USB device using uhci_hcd and address 2 [57126.331178] PM: resume of drv:usb dev:3-1 complete after 267.066 msecs [57126.440063] usb 4-2: reset full speed USB device using uhci_hcd and address 2 [57126.590184] PM: resume of drv:usb dev:4-2 complete after 258.988 msecs [57126.852061] usb 2-1: reset low speed USB device using uhci_hcd and address 3 [57127.159254] PM: resume of drv:usb dev:2-1 complete after 565.980 msecs [57127.268025] usb 3-2: reset full speed USB device using uhci_hcd and address 3 [57127.453213] snd-usb-audio 3-2:1.0: no reset_resume for driver snd-usb-audio? [57127.453216] snd-usb-audio 3-2:1.1: no reset_resume for driver snd-usb-audio? [57127.453218] snd-usb-audio 3-2:1.2: no reset_resume for driver snd-usb-audio? [57127.453584] PM: resume of drv:usb dev:3-2 complete after 294.289 msecs [57127.453604] PM: resume of devices complete after 6944.557 msecs [57127.522753] PM: resume devices took 7.012 seconds [57127.522794] PM: Finishing wakeup. [57127.522796] Restarting tasks ... [57127.523339] hub 1-0:1.0: over-current change on port 3 [57127.580325] done. [57127.624049] hub 1-0:1.0: over-current change on port 4 [57127.728052] hub 3-0:1.0: over-current change on port 1 [57127.832189] hub 3-0:1.0: over-current change on port 2 [57127.974299] tg3 0000:02:00.0: PME# disabled [57128.203555] ADDRCONF(NETDEV_UP): eth0: link is not ready [57128.210238] ADDRCONF(NETDEV_UP): eth1: link is not ready [57129.141576] ADDRCONF(NETDEV_CHANGE): eth1: link becomes ready [60094.288144] usb 3-2: USB disconnect, address 3 [60097.496105] usb 1-4: new high speed USB device using ehci_hcd and address 14 [60097.629800] usb 1-4: configuration #1 chosen from 1 choice [60129.784460] tg3 0000:02:00.0: PME# enabled [60130.463842] PM: Syncing filesystems ... done. [60130.465160] PM: Preparing system for mem sleep [60130.465166] Freezing user space processes ... (elapsed 0.00 seconds) done. [60130.467594] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done. [60130.467653] PM: Entering mem sleep [60130.467671] Suspending console(s) (use no_console_suspend to debug) [60130.709428] PM: suspend of drv:psmouse dev:serio2 complete after 213.279 msecs [60130.740102] sd 0:0:0:0: [sda] Synchronizing SCSI cache [60130.740279] sd 0:0:0:0: [sda] Stopping disk [60131.131269] PM: suspend of drv:sd dev:0:0:0:0 complete after 391.168 msecs [60131.559408] PM: suspend of drv:psmouse dev:serio1 complete after 428.080 msecs [60132.160069] PM: suspend of drv:atkbd dev:serio0 complete after 600.656 msecs [60132.162256] nsc-ircc 00:0c: disabled [60132.162522] parport_pc 00:0b: disabled [60132.162801] serial 00:0a: disabled [60132.162905] eth1: Going into suspend... [60132.163890] ipw2200 0000:04:02.0: PCI INT A disabled [60132.163898] ACPI handle has no context! [60132.388067] radeon 0000:01:00.0: Refused to change power state, currently in D0 [60132.388121] radeon 0000:01:00.0: power state changed by ACPI to D3 [60132.388134] PM: suspend of drv:radeon dev:0000:01:00.0 complete after 212.016 msecs [60132.404269] Intel ICH 0000:00:1e.2: PCI INT A disabled [60132.404313] ehci_hcd 0000:00:1d.7: PCI INT D disabled [60132.404323] uhci_hcd 0000:00:1d.3: PCI INT D disabled [60132.404332] uhci_hcd 0000:00:1d.2: PCI INT C disabled [60132.404341] uhci_hcd 0000:00:1d.1: PCI INT B disabled [60132.404350] uhci_hcd 0000:00:1d.0: PCI INT A disabled [60132.404554] PM: suspend of devices complete after 1936.659 msecs [60132.404557] PM: suspend devices took 1.940 seconds [60132.428065] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D3 [60132.436060] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D3 [60132.464049] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D3 [60132.464245] PM: late suspend of devices complete after 59.683 msecs [60132.504054] ACPI: Preparing to enter system sleep state S3 [60132.684158] Disabling non-boot CPUs ... [60132.684214] Extended CMOS year: 2000 [60132.684214] Back to C! [60132.684214] CPU0: Thermal monitoring enabled (TM2) [60132.684214] Extended CMOS year: 2000 [60132.684214] Force enabled HPET at resume [60132.684214] ACPI: Waking up from system sleep state S3 [60133.028199] pcieport 0000:00:01.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [60133.028238] pcieport 0000:00:1c.0: restoring config space at offset 0x9 (was 0x1fff1, writing 0x40114001) [60133.028246] pcieport 0000:00:1c.0: restoring config space at offset 0x7 (was 0xf0, writing 0x9090) [60133.028257] pcieport 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [60133.028321] pcieport 0000:00:1c.2: restoring config space at offset 0x1 (was 0x100107, writing 0x100507) [60133.072049] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [60133.080059] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [60133.080064] uhci_hcd 0000:00:1d.0: restoring config space at offset 0xf (was 0x100, writing 0x10b) [60133.080078] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x8 (was 0x1, writing 0x1801) [60133.080091] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [60133.088059] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [60133.096058] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [60133.104058] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [60133.112058] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [60133.112064] uhci_hcd 0000:00:1d.1: restoring config space at offset 0xf (was 0x200, writing 0x20b) [60133.112077] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x8 (was 0x1, writing 0x1821) [60133.112091] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [60133.120058] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [60133.128071] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [60133.128080] uhci_hcd 0000:00:1d.2: restoring config space at offset 0xf (was 0x300, writing 0x30b) [60133.128093] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x8 (was 0x1, writing 0x1841) [60133.128106] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [60133.128119] uhci_hcd 0000:00:1d.3: restoring config space at offset 0xf (was 0x400, writing 0x40b) [60133.128133] uhci_hcd 0000:00:1d.3: restoring config space at offset 0x8 (was 0x1, writing 0x1861) [60133.128146] uhci_hcd 0000:00:1d.3: restoring config space at offset 0x1 (was 0x2800000, writing 0x2800001) [60133.128166] ehci_hcd 0000:00:1d.7: restoring config space at offset 0xf (was 0x400, writing 0x40b) [60133.128185] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x4 (was 0x0, writing 0xa8000000) [60133.128193] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900000, writing 0x2900102) [60133.136059] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [60133.144058] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [60133.144126] Intel ICH 0000:00:1e.2: restoring config space at offset 0x1 (was 0x2900007, writing 0x2900003) [60133.144165] pci 0000:00:1e.3: restoring config space at offset 0x1 (was 0x2900005, writing 0x2900001) [60133.144302] radeon 0000:01:00.0: restoring config space at offset 0x1 (was 0x100103, writing 0x100507) [60133.144359] tg3 0000:02:00.0: restoring config space at offset 0xc (was 0x0, writing 0xff7e0000) [60133.144385] tg3 0000:02:00.0: restoring config space at offset 0x1 (was 0x100102, writing 0x100106) [60133.144953] PM: early resume of devices complete after 116.862 msecs [60133.187359] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [60133.187518] uhci_hcd 0000:00:1d.0: power state changed by ACPI to D0 [60133.187527] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16 [60133.187534] uhci_hcd 0000:00:1d.0: setting latency timer to 64 [60133.187556] usb usb2: root hub lost power or was reset [60133.187753] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [60133.187918] uhci_hcd 0000:00:1d.1: power state changed by ACPI to D0 [60133.187923] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17 [60133.187930] uhci_hcd 0000:00:1d.1: setting latency timer to 64 [60133.187953] usb usb3: root hub lost power or was reset [60133.187981] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18 [60133.187988] uhci_hcd 0000:00:1d.2: setting latency timer to 64 [60133.188010] usb usb4: root hub lost power or was reset [60133.188134] uhci_hcd 0000:00:1d.3: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [60133.188140] uhci_hcd 0000:00:1d.3: setting latency timer to 64 [60133.188162] usb usb5: root hub lost power or was reset [60133.188342] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [60133.188500] ehci_hcd 0000:00:1d.7: power state changed by ACPI to D0 [60133.188507] ehci_hcd 0000:00:1d.7: PCI INT D -> GSI 19 (level, low) -> IRQ 19 [60133.188514] ehci_hcd 0000:00:1d.7: setting latency timer to 64 [60133.188543] pci 0000:00:1e.0: setting latency timer to 64 [60133.188553] Intel ICH 0000:00:1e.2: PCI INT A -> GSI 22 (level, low) -> IRQ 22 [60133.188560] Intel ICH 0000:00:1e.2: setting latency timer to 64 [60134.201804] PM: resume of drv:Intel ICH dev:0000:00:1e.2 complete after 1013.256 msecs [60134.201821] ata_piix 0000:00:1f.2: setting latency timer to 64 [60134.204233] radeon 0000:01:00.0: power state changed by ACPI to D0 [60134.204591] radeon 0000:01:00.0: power state changed by ACPI to D0 [60134.204631] radeon 0000:01:00.0: power state changed by ACPI to D0 [60134.204668] radeon 0000:01:00.0: power state changed by ACPI to D0 [60134.204673] radeon 0000:01:00.0: setting latency timer to 64 [60134.204681] radeon 0000:01:00.0: e7488e00 unpin not necessary [60134.204890] [drm] GPU reset succeed (RBBM_STATUS=0x00000140) [60134.346779] [drm] radeon: 1 quad pipes, 1 Z pipes initialized. [60134.372716] [drm] PCIE GART of 512M enabled (table at 0x00040000). [60134.372726] [drm] radeon: cp idle (0x10000C03) [60134.372758] [drm] radeon: ring at 0x0000000020000000 [60134.372779] [drm] ring test succeeded in 1 usecs [60134.372794] [drm] ib test succeeded in 0 usecs [60134.393033] ata2.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out [60134.393037] ata2.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [60134.453713] ata2.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded [60134.458667] ata2.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded [60134.478663] PM: resume of drv:radeon dev:0000:01:00.0 complete after 274.995 msecs [60134.492324] ata2.00: configured for UDMA/33 [60134.616371] PM: resume of drv:yenta_cardbus dev:0000:04:00.0 complete after 137.170 msecs [60134.616376] eth1: Coming out of suspend... [60134.616384] ipw2200 0000:04:02.0: PCI INT A -> GSI 21 (level, low) -> IRQ 21 [60134.643853] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded [60134.643858] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out [60134.643861] ata1.00: ACPI cmd ef/03:45:00:00:00:a0 (SET FEATURES) filtered out [60134.643865] ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out [60134.644598] serial 00:0a: activated [60134.645219] parport_pc 00:0b: activated [60134.645922] nsc-ircc 00:0c: activated [60134.749949] ata1.00: configured for UDMA/100 [60134.964067] PM: resume of drv:usb dev:usb1 complete after 317.732 msecs [60135.212047] PM: resume of drv:usb dev:usb2 complete after 247.966 msecs [60135.460029] PM: resume of drv:usb dev:usb3 complete after 247.968 msecs [60135.708029] PM: resume of drv:usb dev:usb4 complete after 247.986 msecs [60135.710479] sd 0:0:0:0: [sda] Starting disk [60138.728016] [60138.728017] floppy driver state [60138.728019] ------------------- [60138.728021] now=14959682 last interrupt=4294906090 diff=15020888 last called handler=f80a90a0 [60138.728024] timeout_message=lock fdc [60138.728025] last output bytes: [60138.728027] 18 80 4294892592 [60138.728029] 8 80 4294892592 [60138.728031] 8 80 4294892592 [60138.728033] 8 80 4294892592 [60138.728034] 8 80 4294892592 [60138.728036] 12 80 4294905911 [60138.728038] 0 90 4294905911 [60138.728039] 13 80 4294905911 [60138.728041] 0 90 4294905911 [60138.728043] 1a 90 4294905911 [60138.728044] 0 90 4294905911 [60138.728046] 3 80 4294905911 [60138.728048] c1 90 4294905911 [60138.728049] 10 90 4294905911 [60138.728051] 7 80 4294905911 [60138.728053] 0 90 4294905911 [60138.728054] 8 81 4294905998 [60138.728056] 7 80 4294906003 [60138.728058] 0 90 4294906003 [60138.728059] 8 81 4294906090 [60138.728061] last result at 4294906090 [60138.728062] last redo_fd_request at 14206516 [60138.728064] 70 0 [60138.728073] status=0 [60138.728074] fdc_busy=1 [60138.728076] do_floppy=f80a45b0 [60138.728077] cont=f80ab290 [60138.728079] current_req=(null) [60138.728080] command_status=-1 [60138.728082] [60138.728085] floppy0: floppy timeout called [60138.728099] PM: resume of drv:floppy dev:floppy.0 complete after 2999.217 msecs [60138.840026] usb 3-1: reset full speed USB device using uhci_hcd and address 2 [60138.995178] PM: resume of drv:usb dev:3-1 complete after 267.065 msecs [60139.104064] usb 4-2: reset full speed USB device using uhci_hcd and address 2 [60139.254183] PM: resume of drv:usb dev:4-2 complete after 258.988 msecs [60139.516062] usb 2-1: reset low speed USB device using uhci_hcd and address 3 [60139.823257] PM: resume of drv:usb dev:2-1 complete after 565.986 msecs [60139.932028] usb 1-4: reset high speed USB device using ehci_hcd and address 14 [60140.065063] PM: resume of drv:usb dev:1-4 complete after 241.774 msecs [60140.065079] PM: resume of devices complete after 6920.037 msecs [60140.065222] PM: resume devices took 6.920 seconds [60140.065259] PM: Finishing wakeup. [60140.065261] Restarting tasks ... [60140.065792] hub 1-0:1.0: over-current change on port 3 [60140.104476] done. [60140.168078] hub 1-0:1.0: over-current change on port 4 [60140.272052] hub 3-0:1.0: over-current change on port 1 [60140.376060] hub 3-0:1.0: over-current change on port 2 [60140.439405] tg3 0000:02:00.0: PME# disabled [60140.598246] ADDRCONF(NETDEV_UP): eth0: link is not ready [60140.606303] ADDRCONF(NETDEV_UP): eth1: link is not ready [60140.725413] ADDRCONF(NETDEV_CHANGE): eth1: link becomes ready [61021.568454] tg3 0000:02:00.0: PME# enabled