Re: 2.6.21 -- Lid button won't initiate suspend. Also, suspend didn't enter low-power state until I touched my mousepad.

Hi,

On Tuesday, 8 May 2007 08:34, Miles Lane wrote:
Firstly, all my attempts to get suspend to start by pressing my
laptop's lid button are failing.

Here's the log info from about eight attempts::

linux-acpi added to the CC list.

[ 66.080135] ACPI: AC Adapter [ACAD] (on-line)
[ 66.201949] ACPI: Battery Slot [BAT0] (battery present)
[ 66.237885] input: Power Button (FF) as /class/input/input2
[ 66.252274] ACPI: Power Button (FF) [PWRF]
[ 66.267691] input: Lid Switch as /class/input/input3
[ 66.280884] ACPI: Lid Switch [LID0]
[ 66.296423] input: Sleep Button (CM) as /class/input/input4
[ 66.309328] ACPI: Sleep Button (CM) [SLPB]
[ 66.324930] No dock devices found.
[ 66.369537] ACPI: CPU0 (power states: C1[C1] C2[C2] C3[C3])
[ 66.386972] ACPI: Video Device [GFX0] (multi-head: yes rom: yes post: no)
[ 50.683328] Time: acpi_pm clocksource has been installed.
[ 53.729994] [ACPI Debug] String: [0x1C] "Temperature increasing: _Q80"
[ 54.203327] eth0: link down
[ 55.933327] PM: Adding info for No Bus:vcs7
[ 55.933327] PM: Adding info for No Bus:vcsa7
[ 56.396661] ppdev: user-space parallel port driver
[ 56.449994] PM: Removing info for No Bus:vcs7
[ 56.449994] PM: Removing info for No Bus:vcsa7
[ 56.649994] PM: Adding info for No Bus:vcs7
[ 56.649994] PM: Adding info for No Bus:vcsa7
[ 57.483327] [drm] Initialized drm 1.1.0 20060810
[ 57.533327] ACPI: PCI Interrupt 0000:00:02.0[A] -> GSI 16 (level,
low) -> IRQ 18
[ 57.539994] [drm] Initialized i915 1.6.0 20060119 on minor 0
[ 57.543327] [drm] Initialized i915 1.6.0 20060119 on minor 1
[ 60.216660] apm: BIOS version 1.2 Flags 0x03 (Driver version 1.16ac)
[ 60.219993] PM: Adding info for No Bus:apm_bios
[ 61.366660] Installing knfsd (copyright (C) 1996 okir@xxxxxxxxxxxx).
[ 61.629993] NFSD: Using /var/lib/nfs/v4recovery as the NFSv4 state
recovery directory
[ 61.689993] NFSD: starting 90-second grace period
[ 62.766660] usb usb4: usb auto-resume
[ 62.766660] usb usb4: finish resume
[ 62.766660] hub 4-0:1.0: hub_resume
[ 62.769993] usb usb4: wakeup_rh
[ 62.806660] hub 4-0:1.0: state 7 ports 2 chg 0000 evt 0000
[ 62.806660] usb usb3: usb auto-resume
[ 62.806660] usb usb3: finish resume
[ 62.806660] hub 3-0:1.0: hub_resume
[ 62.806660] usb usb3: wakeup_rh
[ 62.843327] hub 3-0:1.0: state 7 ports 2 chg 0000 evt 0000
[ 62.843327] usb usb1: usb auto-resume
[ 62.843327] usb usb1: finish resume
[ 62.843327] hub 1-0:1.0: hub_resume
[ 62.843327] usb usb1: wakeup_rh
[ 62.879993] hub 1-0:1.0: state 7 ports 2 chg 0000 evt 0000
[ 62.879993] usb usb2: usb auto-resume
[ 62.879993] usb usb2: finish resume
[ 62.879993] hub 2-0:1.0: hub_resume
[ 62.879993] ehci_hcd 0000:00:1d.7: resume root hub
[ 62.913327] hub 2-0:1.0: state 7 ports 6 chg 0000 evt 0000
[ 63.269993] Clocksource tsc unstable (delta = -166083281 ns)
[ 63.796660] usb usb4: suspend_rh (auto-stop)
[ 63.833326] usb usb3: suspend_rh (auto-stop)
[ 63.869993] usb usb1: suspend_rh (auto-stop)
[ 64.806660] hub 4-0:1.0: hub_suspend
[ 64.806660] usb usb4: suspend_rh
[ 64.806660] usb usb4: usb auto-suspend
[ 64.843326] hub 3-0:1.0: hub_suspend
[ 64.843326] usb usb3: suspend_rh
[ 64.843326] usb usb3: usb auto-suspend
[ 64.879993] hub 1-0:1.0: hub_suspend
[ 64.879993] usb usb1: suspend_rh
[ 64.879993] usb usb1: usb auto-suspend
[ 64.913326] hub 2-0:1.0: hub_suspend
[ 64.913326] ehci_hcd 0000:00:1d.7: suspend root hub
[ 64.913326] usb usb2: usb auto-suspend
[ 68.549993] usb usb4: usb auto-resume
[ 68.549993] usb usb4: finish resume
[ 68.553326] hub 4-0:1.0: hub_resume
[ 68.553326] usb usb4: wakeup_rh
[ 68.593326] hub 4-0:1.0: state 7 ports 2 chg 0000 evt 0000
[ 68.593326] usb usb3: usb auto-resume
[ 68.596659] usb usb3: finish resume
[ 68.599993] hub 3-0:1.0: hub_resume
[ 68.599993] usb usb3: wakeup_rh
[ 68.626659] Bluetooth: Core ver 2.11
[ 68.626659] PM: Adding info for platform:bluetooth
[ 68.629993] NET: Registered protocol family 31
[ 68.629993] Bluetooth: HCI device and connection manager initialized
[ 68.629993] Bluetooth: HCI socket layer initialized
[ 68.683326] hub 3-0:1.0: state 7 ports 2 chg 0000 evt 0000
[ 68.686659] usb usb1: usb auto-resume
[ 68.686659] usb usb1: finish resume
[ 68.686659] hub 1-0:1.0: hub_resume
[ 68.686659] usb usb1: wakeup_rh
[ 68.723326] hub 1-0:1.0: state 7 ports 2 chg 0000 evt 0000
[ 68.723326] usb usb2: usb auto-resume
[ 68.723326] usb usb2: finish resume
[ 68.723326] hub 2-0:1.0: hub_resume
[ 68.723326] ehci_hcd 0000:00:1d.7: resume root hub
[ 68.746659] Bluetooth: L2CAP ver 2.8
[ 68.746659] Bluetooth: L2CAP socket layer initialized
[ 68.763326] hub 2-0:1.0: state 7 ports 6 chg 0000 evt 0000
[ 68.826659] Bluetooth: RFCOMM socket layer initialized
[ 68.826659] Bluetooth: RFCOMM TTY layer initialized
[ 68.826659] Bluetooth: RFCOMM ver 1.8
[ 69.583326] usb usb4: suspend_rh (auto-stop)
[ 69.673326] usb usb3: suspend_rh (auto-stop)
[ 69.713326] usb usb1: suspend_rh (auto-stop)
[ 70.593326] hub 4-0:1.0: hub_suspend
[ 70.593326] usb usb4: suspend_rh
[ 70.593326] usb usb4: usb auto-suspend
[ 70.686659] hub 3-0:1.0: hub_suspend
[ 70.686659] usb usb3: suspend_rh
[ 70.686659] usb usb3: usb auto-suspend
[ 70.689992] [ACPI Debug] String: [0x1C] "Temperature increasing: _Q80"
[ 73.759992] hub 1-0:1.0: hub_suspend
[ 73.759992] usb usb1: suspend_rh
[ 73.759992] usb usb1: usb auto-suspend
[ 73.759992] hub 2-0:1.0: hub_suspend
[ 73.759992] ehci_hcd 0000:00:1d.7: suspend root hub
[ 73.759992] usb usb2: usb auto-suspend
[ 89.083324] [ACPI Debug] String: [0x1C] "Temperature increasing: _Q80"
[ 91.086657] [ACPI Debug] String: [0x1C] "Temperature increasing: _Q80"
[ 93.116657] NET: Registered protocol family 10

Then I tried initiating a suspend from the Gnome System menu. The
suspend proceeded until the screen went black, but the disk stayed
spun up and the LEDs on the keyboards stayed lit up. When I touched
the synaptics mousepad, the system entered the low power state.

Did it wake up? Your log ends at the "early resume" stage.

On subsequent attempts to enter the suspend state, I didn't need to
touch the mouse to get it to work.

Here is the log information from the flawed suspend process. I don't
see anything indicating the mousepad activity:

It probably only generated an interrupt that allowed the system to complete
the suspend.

Do you have CONFIG_NO_HZ set?

[ 540.193279] PM: Preparing system for mem sleep
[ 540.203279] Stopping tasks ... done.
[ 541.229945] Suspending console(s)
[ 541.229945] platform bluetooth: suspend
[ 541.229945] ac97 0-0:unknown codec: suspend
[ 541.229945] iTCO_wdt iTCO_wdt: suspend
[ 541.229945] usbdev4.1: PM: suspend 0->2, parent usb4 already 2
[ 541.229945] usbdev4.1_ep81: PM: suspend 0->2, parent 4-0:1.0 already 2
[ 541.229945] hub 4-0:1.0: PM: suspend 2-->2
[ 541.229945] hub 4-0:1.0: PM: suspend 2->2, parent usb4 already 2
[ 541.229945] usbdev4.1_ep00: PM: suspend 0->2, parent usb4 already 2
[ 541.229945] usb usb4: PM: suspend 2-->2
[ 541.229945] usbdev3.1: PM: suspend 0->2, parent usb3 already 2
[ 541.229945] usbdev3.1_ep81: PM: suspend 0->2, parent 3-0:1.0 already 2
[ 541.229945] hub 3-0:1.0: PM: suspend 2-->2
[ 541.229945] hub 3-0:1.0: PM: suspend 2->2, parent usb3 already 2
[ 541.229945] usbdev3.1_ep00: PM: suspend 0->2, parent usb3 already 2
[ 541.229945] usb usb3: PM: suspend 2-->2
[ 541.229945] usbdev2.1: PM: suspend 0->2, parent usb2 already 2
[ 541.229945] usbdev2.1_ep81: PM: suspend 0->2, parent 2-0:1.0 already 2
[ 541.229945] hub 2-0:1.0: PM: suspend 2-->2
[ 541.229945] hub 2-0:1.0: PM: suspend 2->2, parent usb2 already 2
[ 541.229945] usbdev2.1_ep00: PM: suspend 0->2, parent usb2 already 2
[ 541.229945] usb usb2: PM: suspend 2-->2
[ 541.229945] sr 1:0:0:0: suspend
[ 541.229945] sd 0:0:0:0: suspend
[ 542.726612] usbdev1.1: PM: suspend 0->2, parent usb1 already 2
[ 542.726612] usbdev1.1_ep81: PM: suspend 0->2, parent 1-0:1.0 already 2
[ 542.726612] hub 1-0:1.0: PM: suspend 2-->2
[ 542.726612] hub 1-0:1.0: PM: suspend 2->2, parent usb1 already 2
[ 542.726612] usbdev1.1_ep00: PM: suspend 0->2, parent usb1 already 2
[ 542.726612] usb usb1: PM: suspend 2-->2
[ 542.726612] psmouse serio1: suspend
[ 543.093279] atkbd serio0: suspend
[ 546.719945] i8042 i8042: suspend
[ 546.719945] serial8250 serial8250: suspend
[ 546.719945] vesafb vesafb.0: suspend
[ 546.719945] platform pcspkr: suspend
[ 546.719945] i8042 aux 00:06: suspend
[ 546.719945] i8042 kbd 00:05: suspend
[ 546.719945] system 00:04: suspend
[ 546.719945] pnp 00:03: suspend
[ 546.719945] pnp 00:02: suspend
[ 546.719945] pnp 00:01: suspend, may wakeup
[ 546.719945] pnp 00:00: suspend
[ 546.719945] sdhci 0000:01:09.4: suspend
[ 546.719945] sdhci [sdhci_suspend()]: Suspending...
[ 546.719945] mmc0: clock 0Hz busmode 1 powermode 0 cs 0 Vdd 0 width 0 timing 0
[ 546.719945] mmc1: clock 0Hz busmode 1 powermode 0 cs 0 Vdd 0 width 0 timing 0
[ 546.719945] mmc2: clock 0Hz busmode 1 powermode 0 cs 0 Vdd 0 width 0 timing 0
[ 546.719945] ACPI: PCI interrupt for device 0000:01:09.4 disabled
[ 546.733278] tifm_7xx1 0000:01:09.3: suspend
[ 546.733278] ACPI: PCI interrupt for device 0000:01:09.3 disabled
[ 546.746611] ohci1394 0000:01:09.2: suspend
[ 546.759945] yenta_cardbus 0000:01:09.0: suspend
[ 546.759945] pci 0000:01:06.0: suspend
[ 546.759945] pci 0000:01:00.0: suspend
[ 546.759945] pci 0000:00:1f.6: suspend
[ 546.759945] Intel ICH 0000:00:1f.5: suspend
[ 546.759945] codec_write 0: semaphore is not ready for register 0x26
[ 546.759945] ACPI: PCI interrupt for device 0000:00:1f.5 disabled
[ 546.759945] pci 0000:00:1f.3: suspend
[ 546.759945] ata_piix 0000:00:1f.1: suspend
[ 546.759945] ACPI: PCI interrupt for device 0000:00:1f.1 disabled
[ 546.759945] pci_set_power_state(): 0000:00:1f.1: state=3, current state=5
[ 546.759945] pci 0000:00:1f.0: suspend
[ 546.759945] pci 0000:00:1e.0: suspend
[ 546.759945] ehci_hcd 0000:00:1d.7: suspend, may wakeup
[ 546.759945] ACPI: PCI interrupt for device 0000:00:1d.7 disabled
[ 546.773278] ehci_hcd 0000:00:1d.7: --> PCI D3/wakeup
[ 546.773278] uhci_hcd 0000:00:1d.2: suspend
[ 546.773278] uhci_hcd 0000:00:1d.2: uhci_suspend
[ 546.773278] ACPI: PCI interrupt for device 0000:00:1d.2 disabled
[ 546.773278] uhci_hcd 0000:00:1d.2: --> PCI D0/legacy
[ 546.773278] uhci_hcd 0000:00:1d.1: suspend
[ 546.773278] uhci_hcd 0000:00:1d.1: uhci_suspend
[ 546.773278] ACPI: PCI interrupt for device 0000:00:1d.1 disabled
[ 546.773278] uhci_hcd 0000:00:1d.1: --> PCI D0/legacy
[ 546.773278] uhci_hcd 0000:00:1d.0: suspend
[ 546.773278] uhci_hcd 0000:00:1d.0: uhci_suspend
[ 546.773278] ACPI: PCI interrupt for device 0000:00:1d.0 disabled
[ 546.773278] uhci_hcd 0000:00:1d.0: --> PCI D0/legacy
[ 546.773278] pci 0000:00:02.1: suspend
[ 546.773278] pci 0000:00:02.0: suspend
[ 546.773278] pci 0000:00:00.3: suspend
[ 546.773278] pci 0000:00:00.1: suspend
[ 546.773278] agpgart-intel 0000:00:00.0: suspend
[ 546.773278] acpi thermal:01: suspend
[ 546.773278] acpi thermal:00: suspend
[ 546.773278] acpi pnp0c14:00: suspend
[ 546.773278] acpi device:18: suspend
[ 546.773278] acpi device:17: suspend
[ 546.773278] acpi device:16: suspend
[ 546.773278] acpi device:15: suspend
[ 546.773278] acpi device:14: suspend
[ 546.773278] acpi device:13: suspend
[ 546.773278] acpi device:12: suspend
[ 546.773278] acpi device:11: suspend
[ 546.773278] acpi device:10: suspend
[ 546.773278] acpi device:0f: suspend
[ 546.773278] acpi device:0e: suspend
[ 546.773278] acpi device:0d: suspend
[ 546.773278] acpi device:0c: suspend
[ 546.773278] acpi device:0b: suspend
[ 546.773278] acpi SYN0110:00: suspend
[ 546.773278] acpi PNP0303:00: suspend
[ 546.773278] ec PNP0C09:00: suspend
[ 546.773278] acpi PNP0C02:00: suspend
[ 546.773278] acpi PNP0200:00: suspend
[ 546.773278] acpi PNP0C04:00: suspend
[ 546.773278] acpi PNP0B00:00: suspend
[ 546.773278] acpi PNP0000:00: suspend
[ 546.773278] acpi PNP0100:00: suspend
[ 546.773278] pci_link PNP0C0F:07: suspend
[ 546.773278] pci_link PNP0C0F:06: suspend
[ 546.773278] pci_link PNP0C0F:05: suspend
[ 546.773278] pci_link PNP0C0F:04: suspend
[ 546.773278] pci_link PNP0C0F:03: suspend
[ 546.773278] pci_link PNP0C0F:02: suspend
[ 546.773278] pci_link PNP0C0F:01: suspend
[ 546.773278] pci_link PNP0C0F:00: suspend
[ 546.773278] acpi device:0a: suspend
[ 546.773278] acpi device:09: suspend
[ 546.773278] acpi device:08: suspend
[ 546.773278] acpi device:07: suspend
[ 546.773278] acpi device:06: suspend
[ 546.773278] acpi device:05: suspend
[ 546.773278] acpi device:04: suspend
[ 546.773278] acpi device:03: suspend
[ 546.773278] acpi device:02: suspend
[ 546.773278] video video:00: suspend
[ 546.773278] acpi device:01: suspend
[ 546.773278] pci_root PNP0A03:00: suspend
[ 546.773278] button PNP0C0E:00: suspend
[ 546.773278] button PNP0C0D:00: suspend
[ 546.773278] battery PNP0C0A:00: suspend
[ 546.773278] ac ACPI0003:00: suspend
[ 546.773278] acpi device:00: suspend
[ 546.773278] processor ACPI0007:00: suspend
[ 546.773278] button button_power:00: suspend
[ 546.773278] acpi acpi_system:00: suspend
[ 546.773278] PM: Entering mem sleep
[ 546.773278] platform bluetooth: LATE suspend
[ 546.773278] iTCO_wdt iTCO_wdt: LATE suspend
[ 546.773278] serial8250 serial8250: LATE suspend
[ 546.773278] vesafb vesafb.0: LATE suspend
[ 546.773278] platform pcspkr: LATE suspend
[ 546.773278] sdhci 0000:01:09.4: LATE suspend
[ 546.773278] tifm_7xx1 0000:01:09.3: LATE suspend
[ 546.773278] ohci1394 0000:01:09.2: LATE suspend
[ 546.773278] yenta_cardbus 0000:01:09.0: LATE suspend
[ 546.773278] pci 0000:01:06.0: LATE suspend
[ 546.773278] pci 0000:01:00.0: LATE suspend
[ 546.773278] pci 0000:00:1f.6: LATE suspend
[ 546.773278] Intel ICH 0000:00:1f.5: LATE suspend
[ 546.773278] pci 0000:00:1f.3: LATE suspend
[ 546.773278] pci 0000:00:1f.0: LATE suspend
[ 546.773278] pci 0000:00:1e.0: LATE suspend
[ 546.773278] pci 0000:00:02.1: LATE suspend
[ 546.773278] pci 0000:00:02.0: LATE suspend
[ 546.773278] pci 0000:00:00.3: LATE suspend
[ 546.773278] pci 0000:00:00.1: LATE suspend
[ 546.773278] agpgart-intel 0000:00:00.0: LATE suspend
[ 546.773278] hwsleep-0323 [03] enter_sleep_state : Entering
sleep state [S3]
[ 546.773278] Intel machine check architecture supported.
[ 546.773278] Intel machine check reporting enabled on CPU#0.
[ 546.773278] Back to C!
[ 546.773278] agpgart-intel 0000:00:00.0: EARLY resume
[ 546.773278] PCI: Calling quirk c01be2f7 for 0000:00:00.0
[ 546.773278] pci 0000:00:00.1: EARLY resume
[ 546.773278] PCI: Calling quirk c01be2f7 for 0000:00:00.1
[ 546.773278] pci 0000:00:00.3: EARLY resume
[ 546.773278] PCI: Calling quirk c01be2f7 for 0000:00:00.3
[ 546.773278] pci 0000:00:02.0: EARLY resume
[ 546.773278] PCI: Calling quirk c01be2f7 for 0000:00:02.0
[ 546.773278] pci 0000:00:02.1: EARLY resume
[ 546.773278] PCI: Calling quirk c01be2f7 for 0000:00:02.1
[ 546.773278] uhci_hcd 0000:00:1d.0: EARLY resume
[ 546.773278] PCI: Calling quirk c01be2f7 for 0000:00:1d.0
[ 546.773278] uhci_hcd 0000:00:1d.1: EARLY resume
[ 546.773278] PCI: Calling quirk c01be2f7 for 0000:00:1d.1
[ 546.773278] uhci_hcd 0000:00:1d.2: EARLY resume
[ 546.773278] PCI: Calling quirk c01be2f7 for 0000:00:1d.2
[ 546.773278] ehci_hcd 0000:00:1d.7: EARLY resume
[ 546.773278] PCI: Calling quirk c01be2f7 for 0000:00:1d.7
[ 546.773278] pci 0000:00:1e.0: EARLY resume
[ 546.773278] PCI: Calling quirk c01be2f7 for 0000:00:1e.0
[ 546.773278] pci 0000:00:1f.0: EARLY resume
[ 546.773278] PCI: Calling quirk c01be541 for 0000:00:1f.0
[ 546.773278] PCI: Calling quirk c01be2f7 for 0000:00:1f.0
[ 546.773278] ata_piix 0000:00:1f.1: EARLY resume
[ 546.773278] PCI: Calling quirk c01be2f7 for 0000:00:1f.1
[ 546.773278] pci 0000:00:1f.3: EARLY resume
[ 546.773278] PCI: Calling quirk c01be2f7 for 0000:00:1f.3
[ 546.773278] Intel ICH 0000:00:1f.5: EARLY resume
[ 546.773278] PCI: Calling quirk c01be2f7 for 0000:00:1f.5
[ 546.773278] pci 0000:00:1f.6: EARLY resume
[ 546.773278] PCI: Calling quirk c01be2f7 for 0000:00:1f.6
[ 546.773278] pci 0000:01:00.0: EARLY resume
[ 546.773278] PCI: Calling quirk c01be2f7 for 0000:01:00.0
[ 546.773278] pci 0000:01:06.0: EARLY resume
[ 546.773278] PCI: Calling quirk c01be2f7 for 0000:01:06.0
[ 546.773278] yenta_cardbus 0000:01:09.0: EARLY resume
[ 546.773278] PCI: Calling quirk c01be2f7 for 0000:01:09.0
[ 546.773278] ohci1394 0000:01:09.2: EARLY resume
[ 546.773278] PCI: Calling quirk c01be2f7 for 0000:01:09.2
[ 546.773278] tifm_7xx1 0000:01:09.3: EARLY resume
[ 546.773278] PCI: Calling quirk c01be2f7 for 0000:01:09.3
[ 546.773278] sdhci 0000:01:09.4: EARLY resume
[ 546.773278] PCI: Calling quirk c01be2f7 for 0000:01:09.4
[ 546.773278] platform pcspkr: EARLY resume
[ 546.773278] vesafb vesafb.0: EARLY resume
[ 546.773278] serial8250 serial8250: EARLY resume
-
To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
the body of a message to majordomo@xxxxxxxxxxxxxxx
More majordomo info at http://vger.kernel.org/majordomo-info.html
Please read the FAQ at http://www.tux.org/lkml/



--
If you don't have the time to read,
you don't have the time or the tools to write.
- Stephen King
-
To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
the body of a message to majordomo@xxxxxxxxxxxxxxx
More majordomo info at http://vger.kernel.org/majordomo-info.html
Please read the FAQ at http://www.tux.org/lkml/