Bug 13197 - Hang on resume from suspend to ram
Summary: Hang on resume from suspend to ram
Status: CLOSED INSUFFICIENT_DATA
Alias: None
Product: Timers
Classification: Unclassified
Component: Interval Timers (show other bugs)
Hardware: All Linux
: P1 normal
Assignee: timers_interval-timers
URL:
Keywords:
Depends on:
Blocks:
 
Reported: 2009-04-27 20:25 UTC by Sten Heinze
Modified: 2012-05-30 16:30 UTC (History)
1 user (show)

See Also:
Kernel Version: 2.6.30-rc3-git1
Subsystem:
Regression: No
Bisected commit-id:


Attachments
Environment (software, processor, modules, pci) (21.59 KB, text/plain)
2009-04-27 20:25 UTC, Sten Heinze
Details

Description Sten Heinze 2009-04-27 20:25:59 UTC
Created attachment 21143 [details]
Environment (software, processor, modules, pci)

On resume from suspend to ram I experience hangs. Only the blinking cursor is on the top left of the screen. It seems to appear randomly, independend if suspended from tty (via pm-suspend) or from X/KDE.

On my last try to reproduce the problem, it does not happen always, I found after waiting ~10-15 seconds, possibly longer, the resume process continues and eventually completes. In my /var/log/messages I found the two call traces below. How can I find the reason to this behaviour to fix it? Is there a way to debug that?

I did not use hpet=force to produce the call trace, but I am running with hpet=force added at the moment (on an ICH-4M).
I am running Debian testing with a vanilla kernel 2.6.30-rc3-git1 w/ linux-phc and tp_smapi patches on a Thinkpad X40. More information about my system is attached.

Thanks,
Sten


The first call trace:

Apr 27 13:51:09 brasilia kernel: [30300.828245] ------------[ cut here ]------------
Apr 27 13:51:09 brasilia kernel: [30300.828245] WARNING: at kernel/hrtimer.c:625 hres_timers_resume+0x3c/0x50()
Apr 27 13:51:09 brasilia kernel: [30300.828245] Hardware name: 23711CU
Apr 27 13:51:09 brasilia kernel: [30300.828245] hres_timers_resume() called with IRQs enabled!Modules linked in: i915 drm i2c_algo_bit joydev hdaps ipv6 tp_smapi thinkpad_ec acpi_cpufreq loop pcmcia ipw2100 snd_intel8x0m snd_intel8x0 libipw snd_ac97_codec yenta_socket rsrc_nonstatic ac97_bus lib80211 snd_pcm pcmcia_core snd_seq thinkpad_acpi irtty_sir snd_timer snd_seq_device i2c_i801 sir_dev shpchp psmouse rfkill nsc_ircc pcspkr pci_hotplug serio_raw evdev i2c_core video output snd soundcore snd_page_alloc rng_core nvram irda battery processor ac button crc_ccitt ext3 jbd mbcache ide_gd_mod ata_generic ata_piix libata scsi_mod ide_pci_generic mmc_block piix uhci_hcd sdhci_pci sdhci intel_agp mmc_core led_class e1000 ide_core ehci_hcd usbcore agpgart thermal fan thermal_sys
Apr 27 13:51:09 brasilia kernel: [30300.828245] Pid: 3872, comm: pm-suspend Not tainted 2.6.30-rc3-sh-pentiumm #1
Apr 27 13:51:09 brasilia kernel: [30300.828245] Call Trace:
Apr 27 13:51:09 brasilia kernel: [30300.828245]  [<c0127af7>] ? warn_slowpath+0x87/0xe0
Apr 27 13:51:09 brasilia kernel: [30300.828245]  [<c012d16d>] ? irq_exit+0x2d/0x90
Apr 27 13:51:09 brasilia kernel: [30300.828245]  [<c0112d19>] ? smp_apic_timer_interrupt+0x49/0x80
Apr 27 13:51:09 brasilia kernel: [30300.828245]  [<c01036ca>] ? apic_timer_interrupt+0x2a/0x30
Apr 27 13:51:09 brasilia kernel: [30300.828245]  [<c014a25a>] ? tick_notify+0x29a/0x3b0
Apr 27 13:51:09 brasilia kernel: [30300.828245]  [<c014a264>] ? tick_notify+0x2a4/0x3b0
Apr 27 13:51:09 brasilia kernel: [30300.828245]  [<c014248e>] ? notifier_call_chain+0x3e/0x80
Apr 27 13:51:09 brasilia kernel: [30300.828245]  [<c01412bc>] ? hres_timers_resume+0x3c/0x50
Apr 27 13:51:09 brasilia kernel: [30300.828245]  [<c0146027>] ? timekeeping_resume+0xf7/0x130
Apr 27 13:51:09 brasilia kernel: [30300.828245]  [<c02d8c11>] ? __sysdev_resume+0x11/0x50
Apr 27 13:51:09 brasilia kernel: [30300.828245]  [<c02d8c97>] ? sysdev_resume+0x47/0x80
Apr 27 13:51:09 brasilia kernel: [30300.828245]  [<c0154478>] ? suspend_devices_and_enter+0x158/0x1b0
Apr 27 13:51:09 brasilia kernel: [30300.828245]  [<c0154cee>] ? freeze_processes+0x4e/0xa0
Apr 27 13:51:09 brasilia kernel: [30300.828245]  [<c0154614>] ? enter_state+0xf4/0x140
Apr 27 13:51:09 brasilia kernel: [30300.828245]  [<c01546ec>] ? state_store+0x8c/0xd0
Apr 27 13:51:09 brasilia kernel: [30300.828245]  [<c0154660>] ? state_store+0x0/0xd0
Apr 27 13:51:09 brasilia kernel: [30300.828245]  [<c02556e4>] ? kobj_attr_store+0x24/0x30
Apr 27 13:51:09 brasilia kernel: [30300.828245]  [<c0205641>] ? sysfs_write_file+0xa1/0x110
Apr 27 13:51:09 brasilia kernel: [30300.828245]  [<c02055a0>] ? sysfs_write_file+0x0/0x110
Apr 27 13:51:09 brasilia kernel: [30300.828245]  [<c01b20c8>] ? vfs_write+0xa8/0x160
Apr 27 13:51:09 brasilia kernel: [30300.828245]  [<c01b2251>] ? sys_write+0x41/0x80
Apr 27 13:51:09 brasilia kernel: [30300.828245]  [<c0102ff0>] ? sysenter_do_call+0x12/0x22
Apr 27 13:51:09 brasilia kernel: [30300.828245] ---[ end trace 890d141bb486878b ]---

The second call trace, slighty different from the first one:

Apr 27 20:48:17 brasilia kernel: [ 5661.560245] ------------[ cut here ]------------
Apr 27 20:48:17 brasilia kernel: [ 5661.560245] WARNING: at kernel/hrtimer.c:625 hres_timers_resume+0x3c/0x50()
Apr 27 20:48:17 brasilia kernel: [ 5661.560245] Hardware name: 23711CU
Apr 27 20:48:17 brasilia kernel: [ 5661.560245] hres_timers_resume() called with IRQs enabled!Modules linked in: ipw2100 i915 drm i2c_algo_bit joydev hdaps ipv6 tp_smapi thinkpad_ec acpi_cpufreq loop pcmcia snd_intel8x0 snd_intel8x0m snd_ac97_codec ac97_bus libipw snd_pcm yenta_socket rsrc_nonstatic snd_seq lib80211 pcmcia_core irtty_sir snd_timer snd_seq_device i2c_i801 sir_dev thinkpad_acpi shpchp psmouse snd soundcore snd_page_alloc i2c_core rng_core pci_hotplug nsc_ircc rfkill video output evdev serio_raw pcspkr battery nvram ac processor irda button crc_ccitt ext3 jbd mbcache ide_gd_mod ata_generic ata_piix libata uhci_hcd scsi_mod ide_pci_generic mmc_block ehci_hcd piix sdhci_pci sdhci ide_core e1000 mmc_core led_class usbcore intel_agp agpgart thermal fan thermal_sys [last unloaded: ipw2100]
Apr 27 20:48:17 brasilia kernel: [ 5661.560245] Pid: 3780, comm: pm-suspend Not tainted 2.6.30-rc3-sh-pentiumm #1
Apr 27 20:48:17 brasilia kernel: [ 5661.560245] Call Trace:
Apr 27 20:48:17 brasilia kernel: [ 5661.560245]  [<c0127af7>] ? warn_slowpath+0x87/0xe0
Apr 27 20:48:17 brasilia kernel: [ 5661.560245]  [<c0146b84>] ? getnstimeofday+0x54/0x120
Apr 27 20:48:17 brasilia kernel: [ 5661.560245]  [<c012d16d>] ? irq_exit+0x2d/0x90
Apr 27 20:48:17 brasilia kernel: [ 5661.560245]  [<c0104c73>] ? do_IRQ+0x43/0xa0
Apr 27 20:48:17 brasilia kernel: [ 5661.560245]  [<c0142252>] ? down_trylock+0x32/0x60
Apr 27 20:48:17 brasilia kernel: [ 5661.560245]  [<c0112333>] ? lapic_next_event+0x13/0x20
Apr 27 20:48:17 brasilia kernel: [ 5661.560245]  [<c0149c43>] ? clockevents_program_event+0xa3/0x170
Apr 27 20:48:17 brasilia kernel: [ 5661.560245]  [<c014af72>] ? tick_dev_program_event+0x32/0xb0
Apr 27 20:48:17 brasilia kernel: [ 5661.560245]  [<c014b054>] ? tick_program_event+0x14/0x20
Apr 27 20:48:17 brasilia kernel: [ 5661.560245]  [<c014a264>] ? tick_notify+0x2a4/0x3b0
Apr 27 20:48:17 brasilia kernel: [ 5661.560245]  [<c014248e>] ? notifier_call_chain+0x3e/0x80
Apr 27 20:48:17 brasilia kernel: [ 5661.560245]  [<c01412bc>] ? hres_timers_resume+0x3c/0x50
Apr 27 20:48:17 brasilia kernel: [ 5661.560245]  [<c0146027>] ? timekeeping_resume+0xf7/0x130
Apr 27 20:48:17 brasilia kernel: [ 5661.560245]  [<c02d8c11>] ? __sysdev_resume+0x11/0x50
Apr 27 20:48:17 brasilia kernel: [ 5661.560245]  [<c02d8c97>] ? sysdev_resume+0x47/0x80
Apr 27 20:48:17 brasilia kernel: [ 5661.560245]  [<c0154478>] ? suspend_devices_and_enter+0x158/0x1b0
Apr 27 20:48:17 brasilia kernel: [ 5661.560245]  [<c0154cee>] ? freeze_processes+0x4e/0xa0
Apr 27 20:48:17 brasilia kernel: [ 5661.560245]  [<c0154614>] ? enter_state+0xf4/0x140
Apr 27 20:48:17 brasilia kernel: [ 5661.560245]  [<c01546ec>] ? state_store+0x8c/0xd0
Apr 27 20:48:17 brasilia kernel: [ 5661.560245]  [<c0154660>] ? state_store+0x0/0xd0
Apr 27 20:48:17 brasilia kernel: [ 5661.560245]  [<c02556e4>] ? kobj_attr_store+0x24/0x30
Apr 27 20:48:17 brasilia kernel: [ 5661.560245]  [<c0205641>] ? sysfs_write_file+0xa1/0x110
Apr 27 20:48:17 brasilia kernel: [ 5661.560245]  [<c02055a0>] ? sysfs_write_file+0x0/0x110
Apr 27 20:48:17 brasilia kernel: [ 5661.560245]  [<c01b20c8>] ? vfs_write+0xa8/0x160
Apr 27 20:48:17 brasilia kernel: [ 5661.560245]  [<c01b2251>] ? sys_write+0x41/0x80
Apr 27 20:48:17 brasilia kernel: [ 5661.560245]  [<c0102ff0>] ? sysenter_do_call+0x12/0x22
Apr 27 20:48:17 brasilia kernel: [ 5661.560245] ---[ end trace c4f6e96a3200f693 ]---

(All times are MEST or UTC+2h.)

Note You need to log in before you can comment on or make changes to this bug.