https://bugzilla.kernel.org/show_bug.cgi?id=47831
Summary: Long delays when waking up from suspend-to-ram on
Gigabyte MB
Product: ACPI
Version: 2.5
Kernel Version: 3.5.3
Platform: All
OS/Version: Linux
Tree: Mainline
Status: NEW
Severity: normal
Priority: P1
Component: Power-Sleep-Wake
AssignedTo: [email protected]
ReportedBy: [email protected]
Regression: No
This is the dmesg I get after a delayed wake up:
[ 3178.962307] nfsd: last server has exited, flushing export cache
[ 3179.100031] wlan0: deauthenticating from 00:25:9c:42:39:2a by local choice
(reason=3)
[ 3179.149969] cfg80211: Calling CRDA to update world regulatory domain
[ 3179.970156] ata1.00: configured for UDMA/133
[ 3179.970168] ata1: EH complete
[ 3180.059108] ata2.00: configured for UDMA/133
[ 3180.059117] ata2: EH complete
[ 3180.067181] ata4.00: configured for UDMA/133
[ 3180.067191] ata4: EH complete
[ 3180.362327] EXT4-fs (sdb2): re-mounted. Opts: commit=0
[ 3180.370345] EXT4-fs (sdb3): re-mounted. Opts: commit=0
[ 3180.621192] EXT4-fs (sdb6): re-mounted. Opts: commit=0
[ 3180.659779] EXT4-fs (dm-0): re-mounted. Opts: commit=0
[ 3180.664484] EXT4-fs (dm-1): re-mounted. Opts: commit=0
[ 3180.669042] EXT4-fs (sdb8): re-mounted. Opts: commit=0
[ 3180.671895] EXT4-fs (sdc1): re-mounted. Opts: commit=0
[ 3181.439943] PM: Syncing filesystems ... done.
[ 3181.556925] Freezing user space processes ... (elapsed 0.01 seconds) done.
[ 3181.568452] Freezing remaining freezable tasks ... (elapsed 0.01 seconds)
done.
[ 3181.579440] Suspending console(s) (use no_console_suspend to debug)
[ 3181.579880] sd 3:0:0:0: [sdc] Synchronizing SCSI cache
[ 3181.579910] sd 1:0:0:0: [sdb] Synchronizing SCSI cache
[ 3181.579943] sd 0:0:0:0: [sda] Synchronizing SCSI cache
[ 3181.580037] serial 00:08: disabled
[ 3181.580047] sd 1:0:0:0: [sdb] Stopping disk
[ 3181.580089] sd 0:0:0:0: [sda] Stopping disk
[ 3181.580227] sd 3:0:0:0: [sdc] Stopping disk
[ 3181.580562] ACPI handle has no context!
[ 3181.580566] ACPI handle has no context!
[ 3181.995677] ACPI handle has no context!
[ 3182.118450] PM: suspend of devices complete after 539.836 msecs
[ 3182.118597] PM: late suspend of devices complete after 0.145 msecs
[ 3182.118729] pcieport 0000:00:09.0: wake-up capability enabled by ACPI
[ 3182.129458] pcieport 0000:00:07.0: wake-up capability enabled by ACPI
[ 3182.140478] ohci_hcd 0000:00:14.5: wake-up capability enabled by ACPI
[ 3182.140567] ehci_hcd 0000:00:13.2: wake-up capability enabled by ACPI
[ 3182.151380] ohci_hcd 0000:00:13.1: wake-up capability enabled by ACPI
[ 3182.151400] ohci_hcd 0000:00:13.0: wake-up capability enabled by ACPI
[ 3182.151429] ehci_hcd 0000:00:12.2: wake-up capability enabled by ACPI
[ 3182.162358] ohci_hcd 0000:00:12.1: wake-up capability enabled by ACPI
[ 3182.162379] ohci_hcd 0000:00:12.0: wake-up capability enabled by ACPI
[ 3182.162399] PM: noirq suspend of devices complete after 43.880 msecs
[ 3182.162926] ACPI: Preparing to enter system sleep state S3
[ 3182.167448] PM: Saving platform NVS memory
[ 3182.167462] Disabling non-boot CPUs ...
[ 3182.168814] CPU 1 is now offline
[ 3182.170402] CPU 2 is now offline
[ 3182.172009] CPU 3 is now offline
[ 3182.173481] CPU 4 is now offline
[ 3182.174927] CPU 5 is now offline
[ 3182.176773] ACPI: Low-level resume complete
[ 3182.176802] PM: Restoring platform NVS memory
[ 3182.176815] PCI-DMA: Resuming GART IOMMU
[ 3182.176815] PCI-DMA: Restoring GART aperture settings
[ 3182.177144] Enabling non-boot CPUs ...
[ 3182.177206] Booting Node 0 Processor 1 APIC 0x1
[ 3182.188219] [Firmware Bug]: cpu 1, try to use APIC500 (LVT offset 0) for
vector 0x400, but the register is already in use for vector 0xf9 on another cpu
[ 3182.188220] perf: IBS APIC setup failed on cpu #1
[ 3182.190301] Switch to broadcast mode on CPU1
[ 3182.190530] CPU1 is up
[ 3182.190588] Booting Node 0 Processor 2 APIC 0x2
[ 3182.201596] [Firmware Bug]: cpu 2, try to use APIC500 (LVT offset 0) for
vector 0x400, but the register is already in use for vector 0xf9 on another cpu
[ 3182.201598] perf: IBS APIC setup failed on cpu #2
[ 3182.203686] Switch to broadcast mode on CPU2
[ 3182.203837] CPU2 is up
[ 3182.203908] Booting Node 0 Processor 3 APIC 0x3
[ 3182.214922] [Firmware Bug]: cpu 3, try to use APIC500 (LVT offset 0) for
vector 0x400, but the register is already in use for vector 0xf9 on another cpu
[ 3182.214923] perf: IBS APIC setup failed on cpu #3
[ 3182.217003] Switch to broadcast mode on CPU3
[ 3182.217241] CPU3 is up
[ 3182.217297] Booting Node 0 Processor 4 APIC 0x4
[ 3182.228311] [Firmware Bug]: cpu 4, try to use APIC500 (LVT offset 0) for
vector 0x400, but the register is already in use for vector 0xf9 on another cpu
[ 3182.228312] perf: IBS APIC setup failed on cpu #4
[ 3182.230392] Switch to broadcast mode on CPU4
[ 3182.230615] CPU4 is up
[ 3182.230722] Booting Node 0 Processor 5 APIC 0x5
[ 3182.241750] [Firmware Bug]: cpu 5, try to use APIC500 (LVT offset 0) for
vector 0x400, but the register is already in use for vector 0xf9 on another cpu
[ 3182.241751] perf: IBS APIC setup failed on cpu #5
[ 3182.243830] Switch to broadcast mode on CPU5
[ 3182.244056] CPU5 is up
[ 3182.250492] ACPI: Waking up from system sleep state S3
[ 3182.250808] ohci_hcd 0000:00:12.0: wake-up capability disabled by ACPI
[ 3182.250830] ohci_hcd 0000:00:12.1: wake-up capability disabled by ACPI
[ 3182.261226] ehci_hcd 0000:00:12.2: wake-up capability disabled by ACPI
[ 3182.261252] ohci_hcd 0000:00:13.0: wake-up capability disabled by ACPI
[ 3182.261274] ohci_hcd 0000:00:13.1: wake-up capability disabled by ACPI
[ 3182.272197] ehci_hcd 0000:00:13.2: wake-up capability disabled by ACPI
[ 3182.272352] ohci_hcd 0000:00:14.5: wake-up capability disabled by ACPI
[ 3182.322969] PM: noirq resume of devices complete after 72.494 msecs
[ 3182.323072] PM: early resume of devices complete after 0.057 msecs
[ 3182.323511] saa7134[0]: board init: gpio is 38500
[ 3182.323512] saa7134[0]: there are different flyvideo cards with different
tuners
[ 3182.323512] saa7134[0]: out there, you might have to use the tuner=<nr>
insmod
[ 3182.323512] saa7134[0]: option to override the default value.
[ 3182.323684] pcieport 0000:00:07.0: wake-up capability disabled by ACPI
[ 3182.323703] pcieport 0000:00:09.0: wake-up capability disabled by ACPI
[ 3182.324042] serial 00:08: activated
[ 3182.523687] usb 1-4: reset high-speed USB device number 4 using ehci_hcd
[ 3182.627531] ata6: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[ 3182.627572] ata5: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[ 3182.628503] ata6.00: configured for UDMA/100
[ 3182.629498] ata3: SATA link down (SStatus 0 SControl 300)
[ 3182.638507] ata9: SATA link down (SStatus 0 SControl 300)
[ 3182.638542] ata13: SATA link down (SStatus 0 SControl 300)
[ 3182.638551] ata15: SATA link down (SStatus 0 SControl 300)
[ 3182.638576] ata12: SATA link down (SStatus 0 SControl 300)
[ 3182.638606] ata10: SATA link down (SStatus 0 SControl 300)
[ 3182.638635] ata8: SATA link down (SStatus 0 SControl 300)
[ 3182.640509] ata14: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[ 3182.640541] ata11: SATA link down (SStatus 0 SControl 300)
[ 3182.640576] ata7: SATA link down (SStatus 0 SControl 300)
[ 3182.640697] ata14.00: configured for UDMA/66
[ 3182.720833] ata5.00: configured for UDMA/100
[ 3182.874040] firewire_core 0000:07:0e.0: rediscovered device fw0
[ 3182.878043] ata16: SATA link down (SStatus 0 SControl 300)
[ 3182.889041] ata16: exception Emask 0x10 SAct 0x0 SErr 0x4060000 action 0xe
frozen t4
[ 3182.889042] ata16: irq_stat 0x00000040, connection status changed
[ 3182.889046] ata16: hard resetting link
[ 3182.909456] snd-usb-audio 1-4:1.0: no reset_resume for driver snd-usb-audio?
[ 3182.909458] snd-usb-audio 1-4:1.1: no reset_resume for driver snd-usb-audio?
[ 3184.816506] ata2: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[ 3184.838030] ata2.00: configured for UDMA/133
[ 3184.848487] sd 1:0:0:0: [sdb] Starting disk
[ 3185.427365] ata16: COMRESET failed (errno=-32)
[ 3185.427369] ata16: reset failed (errno=-32), retrying in 8 secs
[ 3187.616353] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[ 3187.619477] ata1.00: configured for UDMA/133
[ 3187.630374] sd 0:0:0:0: [sda] Starting disk
[ 3187.667248] ata4: link is slow to respond, please be patient (ready=0)
[ 3190.925281] ata4: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[ 3190.943100] ata4.00: configured for UDMA/133
[ 3190.953284] sd 3:0:0:0: [sdc] Starting disk
[ 3192.870701] ata16: limiting SATA link speed to 1.5 Gbps
[ 3192.870703] ata16: hard resetting link
[ 3193.592400] ata16: SATA link down (SStatus 0 SControl 310)
[ 3193.603367] ata16: EH complete
[ 3193.605443] PM: resume of devices complete after 11303.053 msecs
[ 3193.661703] usb 2-2: USB disconnect, device number 4
[ 3193.661588] Restarting tasks ... done.
[ 3193.746033] ata16: exception Emask 0x10 SAct 0x0 SErr 0x4060000 action 0xe
frozen
[ 3193.746036] ata16: irq_stat 0x00000040, connection status changed
[ 3193.746070] ata16: hard resetting link
[ 3194.013673] usb 5-2: new full-speed USB device number 7 using ohci_hcd
[ 3194.049523] ata1.00: configured for UDMA/133
[ 3194.049534] ata1: EH complete
[ 3194.133585] ata2.00: configured for UDMA/133
[ 3194.133594] ata2: EH complete
[ 3194.141451] usb 5-2: device descriptor read/64, error -62
[ 3194.141774] ata4.00: configured for UDMA/133
[ 3194.141783] ata4: EH complete
[ 3194.265409] EXT4-fs (sdb2): re-mounted. Opts: commit=0
[ 3194.273129] EXT4-fs (sdb3): re-mounted. Opts: commit=0
[ 3194.368975] usb 5-2: device descriptor read/64, error -62
[ 3194.469826] ata16: SATA link down (SStatus 0 SControl 300)
[ 3194.480263] EXT4-fs (sdb6): re-mounted. Opts: commit=0
[ 3194.480734] ata16: EH complete
[ 3194.489801] EXT4-fs (dm-0): re-mounted. Opts: commit=0
[ 3194.494829] EXT4-fs (dm-1): re-mounted. Opts: commit=0
[ 3194.498927] EXT4-fs (sdb8): re-mounted. Opts: commit=0
[ 3194.501871] EXT4-fs (sdc1): re-mounted. Opts: commit=0
[ 3194.592576] usb 5-2: new full-speed USB device number 8 using ohci_hcd
[ 3194.672211] r8169 0000:04:00.0: eth0: link down
[ 3194.719316] usb 5-2: device descriptor read/64, error -62
[ 3194.723284] r8169 0000:05:00.0: eth1: link down
[ 3194.946913] usb 5-2: device descriptor read/64, error -62
[ 3195.170494] usb 5-2: new full-speed USB device number 9 using ohci_hcd
[ 3195.571762] usb 5-2: device not accepting address 9, error -62
[ 3195.694554] usb 5-2: new full-speed USB device number 10 using ohci_hcd
[ 3196.095792] usb 5-2: device not accepting address 10, error -62
[ 3196.095818] hub 5-0:1.0: unable to enumerate USB device on port 2
[ 3202.586381] CE: hpet increased min_delta_ns to 20113 nsec
I think these parts (for each core) are related to my problem:
[ 3182.190588] Booting Node 0 Processor 2 APIC 0x2
[ 3182.201596] [Firmware Bug]: cpu 2, try to use APIC500 (LVT offset 0) for
vector 0x400, but the register is already in use for vector 0xf9 on another cpu
[ 3182.201598] perf: IBS APIC setup failed on cpu #2
[ 3182.203686] Switch to broadcast mode on CPU2
[ 3182.203837] CPU2 is up
Some internet search showed that it has to do with these Gigabyte motherboards
but none of the fixes worked for me. Changing clocksource to hpet or adding
acpi_skip_timer_override parameter at boot did not work (supposedly these
worked for some boards to solve the problem)
--
Configure bugmail: https://bugzilla.kernel.org/userprefs.cgi?tab=email
------- You are receiving this mail because: -------
You are watching the assignee of the bug.
------------------------------------------------------------------------------
Everyone hates slow websites. So do we.
Make your web apps faster with AppDynamics
Download AppDynamics Lite for free today:
http://ad.doubleclick.net/clk;258768047;13503038;j?
http://info.appdynamics.com/FreeJavaPerformanceDownload.html
_______________________________________________
acpi-bugzilla mailing list
[email protected]
https://lists.sourceforge.net/lists/listinfo/acpi-bugzilla
