<!DOCTYPE HTML PUBLIC "-//W3C//DTD HTML 4.0 TRANSITIONAL//EN">
<HTML>
<HEAD>
<META HTTP-EQUIV="Content-Type" CONTENT="text/html; CHARSET=UTF-8">
<META NAME="GENERATOR" CONTENT="GtkHTML/3.24.5">
</HEAD>
<BODY>
On Thu, 2009-06-25 at 22:27 -0700, Fernando Lopez-Lezcano wrote:
<BLOCKQUOTE TYPE=CITE>
<PRE>
> It's really suspending. The power light is blinking like it normally
> does when suspended. Just when the laptop lid is opened or the power
> button pressed it tries to wake up (the screen comes on and a blinking
> cursor appears for a second) and then it resets itself.
Ok, I was going to post to lkml to see if they can spot something, but
maybe you could look a bit more /var/log/messages to see what the
context is for that BUG statement (that is, what is happening before and
after - is this while powering down, trying to power up, etc), that
could maybe help them...
Thanks for the report!
-- Fernando
</PRE>
</BLOCKQUOTE>
<BR>
Amazingly enough, I was finally able to get some information logged by following some of the steps in basic-pm-debugging.txt. This accomplished by doing "echo 1 > /sys/power/pm_trace; echo core > /sys/power/pm_test; echo mem > /sys/power/state." Some of the other test modes also created the exact same log message. Here it is with some context:<BR>
<BR>
Jul 1 19:32:35 localhost kernel: PM: Syncing filesystems ... done.<BR>
Jul 1 19:32:36 localhost kernel: [drm:i915_get_vblank_counter] *ERROR* trying to get vblank count for disabled pipe 0<BR>
Jul 1 19:32:45 localhost kernel: Freezing user space processes ... (elapsed 0.00 seconds) done.<BR>
Jul 1 19:32:45 localhost kernel: Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done.<BR>
Jul 1 19:32:45 localhost kernel: Suspending console(s) (use no_console_suspend to debug)<BR>
Jul 1 19:32:45 localhost kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache<BR>
Jul 1 19:32:45 localhost kernel: sd 0:0:0:0: [sda] Stopping disk<BR>
Jul 1 19:32:45 localhost kernel: sdhci-pci 0000:09:09.1: PME# disabled<BR>
Jul 1 19:32:45 localhost kernel: sdhci-pci 0000:09:09.1: PCI INT B disabled<BR>
Jul 1 19:32:45 localhost kernel: r8169 0000:08:00.0: PME# enabled<BR>
Jul 1 19:32:45 localhost kernel: r8169 0000:08:00.0: wake-up capability enabled by ACPI<BR>
Jul 1 19:32:45 localhost kernel: iwlagn 0000:02:00.0: PCI INT A disabled<BR>
Jul 1 19:32:45 localhost kernel: ata_piix 0000:00:1f.1: PCI INT A disabled<BR>
Jul 1 19:32:45 localhost kernel: ehci_hcd 0000:00:1d.7: PCI INT A disabled<BR>
Jul 1 19:32:45 localhost kernel: ehci_hcd 0000:00:1d.7: PME# disabled<BR>
Jul 1 19:32:45 localhost kernel: uhci_hcd 0000:00:1d.2: PCI INT C disabled<BR>
Jul 1 19:32:45 localhost kernel: uhci_hcd 0000:00:1d.1: PCI INT B disabled<BR>
Jul 1 19:32:45 localhost kernel: uhci_hcd 0000:00:1d.0: PCI INT A disabled<BR>
Jul 1 19:32:45 localhost kernel: HDA Intel 0000:00:1b.0: PCI INT A disabled<BR>
Jul 1 19:32:45 localhost kernel: ehci_hcd 0000:00:1a.7: PCI INT C disabled<BR>
Jul 1 19:32:45 localhost kernel: ehci_hcd 0000:00:1a.7: PME# disabled<BR>
Jul 1 19:32:45 localhost kernel: uhci_hcd 0000:00:1a.1: PCI INT B disabled<BR>
Jul 1 19:32:45 localhost kernel: uhci_hcd 0000:00:1a.0: PCI INT A disabled<BR>
Jul 1 19:32:45 localhost kernel: ACPI: Preparing to enter system sleep state S3<BR>
Jul 1 19:32:45 localhost kernel: Disabling non-boot CPUs ...<BR>
Jul 1 19:32:45 localhost kernel: Broke affinity for irq 9<BR>
Jul 1 19:32:45 localhost kernel: Broke affinity for irq 12<BR>
Jul 1 19:32:45 localhost kernel: Broke affinity for irq 27<BR>
Jul 1 19:32:45 localhost kernel: CPU 1 is now offline<BR>
Jul 1 19:32:45 localhost kernel: SMP alternatives: switching to UP code<BR>
Jul 1 19:32:45 localhost kernel: CPU1 is down<BR>
Jul 1 19:32:45 localhost kernel: ricoh-mmc: Suspending.<BR>
Jul 1 19:32:45 localhost kernel: ricoh-mmc: Controller is now re-enabled.<BR>
Jul 1 19:32:45 localhost kernel: BUG: sleeping function called from invalid context at kernel/rtmutex.c:685<BR>
Jul 1 19:32:45 localhost kernel: in_atomic(): 0, irqs_disabled(): 1, pid: 4322, name: bash<BR>
Jul 1 19:32:45 localhost kernel: Pid: 4322, comm: bash Not tainted 2.6.29.5-rt22 #1<BR>
Jul 1 19:32:45 localhost kernel: Call Trace:<BR>
Jul 1 19:32:45 localhost kernel: [<ffffffff8144b3ff>] ? rt_spin_lock_slowlock+0x0/0x27e<BR>
Jul 1 19:32:45 localhost kernel: [<ffffffff81047e30>] __might_sleep+0x11d/0x133<BR>
Jul 1 19:32:45 localhost kernel: [<ffffffff81087d17>] rt_spin_lock_fastlock+0x43/0xa2<BR>
Jul 1 19:32:45 localhost kernel: [<ffffffff8144c0c5>] rt_spin_lock+0x23/0x39<BR>
Jul 1 19:32:45 localhost kernel: [<ffffffff8101a6df>] read_persistent_clock+0x24/0x58<BR>
Jul 1 19:32:45 localhost kernel: [<ffffffff811fd63d>] ? pci_pm_suspend_noirq+0x43/0xb5<BR>
Jul 1 19:32:45 localhost kernel: [<ffffffff8107dccd>] timekeeping_suspend+0x1d/0xb2<BR>
Jul 1 19:32:45 localhost kernel: [<ffffffff812a3260>] sysdev_suspend+0x98/0x1f1<BR>
Jul 1 19:32:45 localhost kernel: [<ffffffff812aa564>] ? device_power_down+0x55/0x141<BR>
Jul 1 19:32:45 localhost kernel: [<ffffffff8108ecc8>] suspend_devices_and_enter+0x111/0x1c9<BR>
Jul 1 19:32:45 localhost kernel: [<ffffffff8108ef42>] enter_state+0x172/0x1f0<BR>
Jul 1 19:32:45 localhost kernel: [<ffffffff8108f086>] state_store+0xc6/0xfd<BR>
Jul 1 19:32:45 localhost kernel: [<ffffffff810fc5f2>] ? alloc_pages_current+0xcc/0xed<BR>
Jul 1 19:32:45 localhost kernel: [<ffffffff811e56c5>] kobj_attr_store+0x2a/0x40<BR>
Jul 1 19:32:45 localhost kernel: [<ffffffff8116aaa7>] sysfs_write_file+0xee/0x137<BR>
Jul 1 19:32:45 localhost kernel: [<ffffffff8110ab1c>] ? rw_verify_area+0x97/0xd1<BR>
Jul 1 19:32:45 localhost kernel: [<ffffffff8110b380>] vfs_write+0xbe/0x130<BR>
Jul 1 19:32:45 localhost kernel: [<ffffffff8110b4e8>] sys_write+0x56/0x93<BR>
Jul 1 19:32:45 localhost kernel: [<ffffffff81013102>] system_call_fastpath+0x16/0x1b<BR>
Jul 1 19:32:45 localhost kernel: Extended CMOS year: 2000<BR>
Jul 1 19:32:45 localhost kernel: suspend debug: Waiting for 5 seconds.<BR>
Jul 1 19:32:45 localhost kernel: Extended CMOS year: 2000<BR>
Jul 1 19:32:45 localhost kernel: ricoh-mmc: Resuming.<BR>
Jul 1 19:32:45 localhost kernel: ricoh-mmc: Controller is now disabled.<BR>
Jul 1 19:32:45 localhost kernel: Enabling non-boot CPUs ...<BR>
<BR>
<BR>
</BODY>
</HTML>