You are not logged in.

#1 2011-01-29 13:58:15

lsas
Member
Registered: 2010-11-23
Posts: 23

Cant turn into sleep mode

I cant put my Thinkpad X200s into sleep mode.

I've comment out my /etc/acpid/events/anything and deleted the handler.sh , and create a /etc/acpid/events/ibm_hotkey and ibm_hotkey.sh :

event=ibm/hotkey
action=/etc/acpi/ibm_hotkey.sh %e
#!/bin/sh
# ACPI action for Thinkpad special keys.

case "$1" in
      ibm/hotkey)
        case "$2" in
            HKEY)
              case "$4" in
                #00001002) # Lock screen
                #;;
                #00001003) # Switching display off
                #  xset dpms force off
                #;;
                00001004) # Sleep Mode
                  logger "ACPI $2 $4 : Sleep button pressed."
                  /usr/sbin/pm-suspend
                ;;
                #00001005) # Switch Bluetooth
                #;;
                0001007) # Toggle external display
                  if [ "$(xrandr -q | grep "VGA connected")" ]; then
                    if [ "$(xrandr -q | grep "VGA connected [0-9]")" ]; then
                        xrandr --output VGA --off
                    else
                        xrandr --output VGA --auto
                    fi
                  else
                    xrandr --output VGA --off
                  fi
                ;;
                #00001008) # Toggle Trackpoint/Touchpad
                #;;
                #00001009) # Eject from dock
                #;;
                0000100c) # Hibernate
                  logger "ACPI $2 $4 : Hibernate button pressed."
                  /usr/sbin/pm-hibernate
                ;;
                00001011) # Brightness down
                  CUR="xbacklight -get"
                  CUR="echo $CUR | awk '{print $1-5}'"
                  xbacklight -set $CUR
                ;;
                00001012) # Brightness up
                  CUR=`xbacklight -get`
                  CUR="echo $CUR | awk '{print $1+5}'"
                  xbacklight -set $CUR
                ;;
                #00001014) # Toggle zoom
                #;;
                #00001018) # ThinkVantage button
                #;;
                *) logger "ACPI action undefined for $2 / $4" ;;
              esac
            ;;

            *) logger "ACPI group/action undefined: $1 / $2" ;;
        esac
    *) logger "ACPI group/action undefined: $1 / $2" ;;
esac

If i try to type fn+f4, the system tries to go into sleep mode, it switch off the display and then the "half moon" led start blinking, but after one maybe two seconds the system wake up automatically and show the window popup for session unlock (actually i'm using kde 4.6)

This is the everything.log

Jan 29 13:31:08 Saponetta NetworkManager[1997]: <info> sleep requested (sleeping: no  enabled: yes)
Jan 29 13:31:08 Saponetta NetworkManager[1997]: <info> sleeping or disabling...
Jan 29 13:31:08 Saponetta NetworkManager[1997]: <info> (eth0): now unmanaged
Jan 29 13:31:08 Saponetta NetworkManager[1997]: <info> (eth0): device state change: 2 -> 1 (reason 37)
Jan 29 13:31:08 Saponetta NetworkManager[1997]: <info> (eth0): cleaning up...
Jan 29 13:31:08 Saponetta NetworkManager[1997]: <info> (eth0): taking down device.
Jan 29 13:31:08 Saponetta NetworkManager[1997]: <info> (wlan0): now unmanaged
Jan 29 13:31:08 Saponetta NetworkManager[1997]: <info> (wlan0): device state change: 8 -> 1 (reason 37)
Jan 29 13:31:08 Saponetta NetworkManager[1997]: <info> (wlan0): deactivating device (reason: 37).
Jan 29 13:31:08 Saponetta dhcpcd[4822]: received SIGTERM, stopping
Jan 29 13:31:08 Saponetta dhcpcd[4822]: wlan0: removing interface
Jan 29 13:31:08 Saponetta NetworkManager[1997]: <info> (wlan0): canceled DHCP transaction, DHCP client pid 4822
Jan 29 13:31:08 Saponetta NetworkManager[1997]: <info> (wlan0): cleaning up...
Jan 29 13:31:08 Saponetta NetworkManager[1997]: <info> (wlan0): taking down device.
Jan 29 13:31:08 Saponetta kernel: wlan0: deauthenticating from 00:23:8e:89:03:54 by local choice (reason=3)
Jan 29 13:31:08 Saponetta kernel: cfg80211: Calling CRDA to update world regulatory domain
Jan 29 13:31:08 Saponetta NetworkManager[1997]: <warn> (pid 4822) unhandled DHCP event for interface wlan0
Jan 29 13:31:09 Saponetta kernel: usb 4-2: USB disconnect, address 7
Jan 29 13:31:09 Saponetta kernel: PM: Syncing filesystems ... done.
Jan 29 13:31:09 Saponetta kernel: PM: Preparing system for mem sleep
Jan 29 13:31:11 Saponetta kernel: Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 29 13:31:11 Saponetta kernel: Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 29 13:31:11 Saponetta kernel: PM: Entering mem sleep
Jan 29 13:31:11 Saponetta kernel: Suspending console(s) (use no_console_suspend to debug)
Jan 29 13:31:11 Saponetta kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache
Jan 29 13:31:11 Saponetta kernel: sd 0:0:0:0: [sda] Stopping disk
Jan 29 13:31:11 Saponetta kernel: tpm_tis 00:0a: tpm_transmit: tpm_send: error 4294967291
Jan 29 13:31:11 Saponetta kernel: legacy_suspend(): pnp_bus_suspend+0x0/0x80 returns -5
Jan 29 13:31:11 Saponetta kernel: PM: Device 00:0a failed to suspend: error -5
Jan 29 13:31:11 Saponetta kernel: PM: Some devices failed to suspend
Jan 29 13:31:11 Saponetta kernel: sd 0:0:0:0: [sda] Starting disk
Jan 29 13:31:11 Saponetta kernel: psmouse serio1: ID: 10 00 64
Jan 29 13:31:11 Saponetta kernel: PM: resume of devices complete after 1126.055 msecs
Jan 29 13:31:11 Saponetta kernel: IBM TrackPoint firmware: 0x0e, buttons: 3/3
Jan 29 13:31:11 Saponetta kernel: input: TPPS/2 IBM TrackPoint as /devices/platform/i8042/serio1/input/input17
Jan 29 13:31:11 Saponetta kernel: PM: Finishing wakeup.
Jan 29 13:31:11 Saponetta kernel: Restarting tasks ... done.
Jan 29 13:31:11 Saponetta kernel: video LNXVIDEO:00: Restoring backlight state
Jan 29 13:31:11 Saponetta acpid: client 2010[0:0] has disconnected
Jan 29 13:31:11 Saponetta acpid: client connected from 2010[0:0]
Jan 29 13:31:11 Saponetta acpid: 1 client rule loaded
Jan 29 13:31:11 Saponetta laptop-mode: Laptop mode 
Jan 29 13:31:11 Saponetta laptop-mode: enabled, not active
Jan 29 13:31:11 Saponetta NetworkManager[1997]: <info> wake requested (sleeping: yes  enabled: yes)
Jan 29 13:31:11 Saponetta NetworkManager[1997]: <info> waking up and re-enabling...
Jan 29 13:31:11 Saponetta NetworkManager[1997]: <info> (eth0): now managed
Jan 29 13:31:11 Saponetta NetworkManager[1997]: <info> (eth0): device state change: 1 -> 2 (reason 2)
Jan 29 13:31:11 Saponetta NetworkManager[1997]: <info> (eth0): bringing up device.
Jan 29 13:31:11 Saponetta kernel: e1000e 0000:00:19.0: irq 45 for MSI/MSI-X
Jan 29 13:31:11 Saponetta kernel: e1000e 0000:00:19.0: irq 45 for MSI/MSI-X
Jan 29 13:31:11 Saponetta kernel: ADDRCONF(NETDEV_UP): eth0: link is not ready
Jan 29 13:31:11 Saponetta NetworkManager[1997]: <info> (eth0): preparing device.
Jan 29 13:31:11 Saponetta NetworkManager[1997]: <info> (eth0): deactivating device (reason: 2).
Jan 29 13:31:11 Saponetta NetworkManager[1997]: <info> (wlan0): now managed
Jan 29 13:31:11 Saponetta NetworkManager[1997]: <info> (wlan0): device state change: 1 -> 2 (reason 2)
Jan 29 13:31:11 Saponetta NetworkManager[1997]: <info> (wlan0): bringing up device.
Jan 29 13:31:11 Saponetta kernel: ADDRCONF(NETDEV_UP): wlan0: link is not ready
Jan 29 13:31:11 Saponetta NetworkManager[1997]: <info> (wlan0): preparing device.
Jan 29 13:31:11 Saponetta NetworkManager[1997]: <info> (wlan0): deactivating device (reason: 2).
Jan 29 13:31:11 Saponetta NetworkManager[1997]: <info> (wlan0): supplicant interface state:  starting -> ready
Jan 29 13:31:11 Saponetta NetworkManager[1997]: <info> (wlan0): device state change: 2 -> 3 (reason 42)
Jan 29 13:31:11 Saponetta kernel: usb 4-2: new full speed USB device using uhci_hcd and address 8
Jan 29 13:31:15 Saponetta NetworkManager[1997]: <info> Activation (wlan0) starting connection 'Casa PD'
Jan 29 13:31:15 Saponetta NetworkManager[1997]: <info> (wlan0): device state change: 3 -> 4 (reason 0)
Jan 29 13:31:15 Saponetta NetworkManager[1997]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Jan 29 13:31:15 Saponetta NetworkManager[1997]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Jan 29 13:31:15 Saponetta NetworkManager[1997]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Jan 29 13:31:15 Saponetta NetworkManager[1997]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Jan 29 13:31:15 Saponetta NetworkManager[1997]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Jan 29 13:31:15 Saponetta NetworkManager[1997]: <info> (wlan0): device state change: 4 -> 5 (reason 0)
Jan 29 13:31:15 Saponetta NetworkManager[1997]: <info> Activation (wlan0/wireless): access point 'Casa PD' has security, but secrets are required.
Jan 29 13:31:15 Saponetta NetworkManager[1997]: <info> (wlan0): device state change: 5 -> 6 (reason 0)
Jan 29 13:31:15 Saponetta NetworkManager[1997]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Jan 29 13:31:15 Saponetta NetworkManager[1997]: <warn> Failed to update connection secrets: 1 802-1x
Jan 29 13:31:15 Saponetta NetworkManager[1997]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Jan 29 13:31:15 Saponetta NetworkManager[1997]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Jan 29 13:31:15 Saponetta NetworkManager[1997]: <info> (wlan0): device state change: 6 -> 4 (reason 0)
Jan 29 13:31:15 Saponetta NetworkManager[1997]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Jan 29 13:31:15 Saponetta NetworkManager[1997]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Jan 29 13:31:15 Saponetta NetworkManager[1997]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Jan 29 13:31:15 Saponetta NetworkManager[1997]: <info> (wlan0): device state change: 4 -> 5 (reason 0)
Jan 29 13:31:15 Saponetta NetworkManager[1997]: <info> Activation (wlan0/wireless): connection 'Casa PD' has security, and secrets exist.  No new secrets needed.
Jan 29 13:31:15 Saponetta NetworkManager[1997]: <info> Config: added 'ssid' value 'Alice-48329575'
Jan 29 13:31:15 Saponetta NetworkManager[1997]: <info> Config: added 'scan_ssid' value '1'
Jan 29 13:31:15 Saponetta NetworkManager[1997]: <info> Config: added 'key_mgmt' value 'WPA-PSK'
Jan 29 13:31:15 Saponetta NetworkManager[1997]: <info> Config: added 'psk' value '<omitted>'
Jan 29 13:31:15 Saponetta NetworkManager[1997]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Jan 29 13:31:15 Saponetta NetworkManager[1997]: <info> Config: set interface ap_scan to 1
Jan 29 13:31:15 Saponetta NetworkManager[1997]: <info> (wlan0): supplicant connection state:  inactive -> scanning
Jan 29 13:31:18 Saponetta kernel: wlan0: authenticate with 00:23:8e:89:03:54 (try 1)
Jan 29 13:31:18 Saponetta NetworkManager[1997]: <info> (wlan0): supplicant connection state:  scanning -> associating
Jan 29 13:31:18 Saponetta kernel: wlan0: authenticated
Jan 29 13:31:18 Saponetta kernel: wlan0: associate with 00:23:8e:89:03:54 (try 1)
Jan 29 13:31:18 Saponetta kernel: wlan0: RX AssocResp from 00:23:8e:89:03:54 (capab=0x411 status=0 aid=1)
Jan 29 13:31:18 Saponetta kernel: wlan0: associated
Jan 29 13:31:18 Saponetta kernel: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready

In the log i cant see the line "ACPI $2 $4 : Sleep button pressed." written in the script, so it seems like suspend isnt request by ibm_hotkey.sh. I've do also a test with commented event ibm_hotkey but same thing happend.. So who's sending the suspend request ?

By the way even with pm-suspend from the command line it doesnt work, i think because of the tpm error. I've try to search for that error but i cant find a solution yet.
The kernel have the tpm compiled as module and it load by default
# lsmod | grep tpm
tpm_tis               6132  0
tpm                     9505  1 tpm_tis
tpm_bios             4661  1 tpm

Any advices for the acpi script and for the sleep error?

Many Thanks to all anyway.

Offline

#2 2011-02-23 06:01:16

realturner
Member
Registered: 2010-04-29
Posts: 3

Re: Cant turn into sleep mode

Hi,
I've just encountered the thing same as yours and found a thread discussing issues you talked about:
http://www.serverphorums.com/read.php?12,224256

Seems like the patch in https://lkml.org/lkml/2010/10/21/456 could fix this problem, though I haven't compile the kernel yet.

Offline

Board footer

Powered by FluxBB