2007-05-08 06:34:41

by Miles Lane

[permalink] [raw]
Subject: 2.6.21 -- Lid button won't initiate suspend. Also, suspend didn't enter low-power state until I touched my mousepad.

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::

[ 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 [email protected]).
[ 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.
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:

[ 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


2007-05-08 10:28:21

by Rafael J. Wysocki

[permalink] [raw]
Subject: 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 [email protected]).
> [ 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 [email protected]
> 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

2007-05-08 16:33:54

by Miles Lane

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

Sorry, Rafael. Resending since I forgot to "reply all" before.

On 5/8/07, Rafael J. Wysocki <[email protected]> wrote:
> 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 [email protected]).
> > [ 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.

Yes.

> > 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?

Yes.

> > [ 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

2007-05-08 19:14:34

by Rafael J. Wysocki

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

On Tuesday, 8 May 2007 18:31, Miles Lane wrote:
> On 5/8/07, Rafael J. Wysocki <[email protected]> wrote:
> > 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 [email protected]).
> > > [ 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.
>
> Yes. I just cut out the part I thought might be helpful. If you want
> another test with a full dmesg, I will be happy to send that along.
>
> > > 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?
>
> Yes. I could rebuild with that unset and see what happens.

Please do that.

Greetings,
Rafael

PS
Please keep the CC list when you reply, thanks.