Suspend/Hibernate still failing on 8.01

[shoofy]

I still can't suspend or hibernate on 8.01. I'm running Ubuntu Gutsy on a Dell E1505 with a Mobility Radeon X1400. I've seen reports of other people with this configuration suspending/hibernating successfully, so I wonder what I'm doing wrong.

For suspend the syslog gives me this:

gnome-power-manager: (aaron) Suspending computer because the suspend button has been pressed
NetworkManager: <debug> [1200968383.575992] nm_hal_device_removed(): Device removed (hal udi is '/org/freedesktop/Hal/devices/computer_logicaldev_input_2').
NetworkManager: <debug> [1200968383.579275] nm_hal_device_removed(): Device removed (hal udi is '/org/freedesktop/Hal/devices/computer_logicaldev_input_1').
NetworkManager: <debug> [1200968383.581693] nm_hal_device_removed(): Device removed (hal udi is '/org/freedesktop/Hal/devices/computer_logicaldev_input_0').
kernel: [ 675.856000] input: Lid Switch as /class/input/input6
kernel: [ 675.856000] ACPI: Lid Switch [LID]
kernel: [ 675.856000] input: Power Button (CM) as /class/input/input7
kernel: [ 675.856000] ACPI: Power Button (CM) [PBTN]
kernel: [ 675.856000] input: Sleep Button (CM) as /class/input/input8
kernel: [ 675.856000] ACPI: Sleep Button (CM) [SBTN]
NetworkManager: <debug> [1200968383.745672] nm_hal_device_added(): New device added (hal udi is '/org/freedesktop/Hal/devices/computer_logicaldev_input_0').
NetworkManager: <debug> [1200968383.797681] nm_hal_device_added(): New device added (hal udi is '/org/freedesktop/Hal/devices/computer_logicaldev_input_1').
NetworkManager: <debug> [1200968383.802889] nm_hal_device_added(): New device added (hal udi is '/org/freedesktop/Hal/devices/computer_logicaldev_input_2').
gnome-power-manager: (aaron) Resuming computer
ays-linux gnome-power-manager: (aaron) suspend failed

[shoofy]

For Hibernate I get this (I'll have to split it up between posts because of the length):

dhcdbd: Unrequested down ?:3
NetworkManager: <info> DHCP daemon state is now 14 (normal exit) for interface eth0
avahi-daemon[5910]: Interface eth0.IPv4 no longer relevant for mDNS.
avahi-daemon[5910]: Leaving mDNS multicast group on interface eth0.IPv4 with address 128.253.27.155.
avahi-daemon[5910]: Withdrawing address record for fe80::215:c5ff:fe16:88b3 on eth0.
avahi-daemon[5910]: Withdrawing address record for XXX.XXX.XXX.XXX on eth0.
NetworkManager: <info> SWITCH: found better connection 'eth1' than current connection 'eth0'.
dhcdbd: message_handler: message handler not found under /com/redhat/dhcp/eth1 for sub-path eth1.dbus.get.reason
NetworkManager: <info> Will activate connection 'eth1/XXXXXX'.
NetworkManager: <info> Device eth1 activation scheduled...
NetworkManager: <info> Deactivating device eth0.
avahi-daemon[5910]: Interface ham0.IPv4 no longer relevant for mDNS.
avahi-daemon[5910]: Leaving mDNS multicast group on interface ham0.IPv4 with address XXX.XXX.XXX.XXX.
avahi-daemon[5910]: Withdrawing address record for XXX.XXX.XXX.XXX on ham0.
NetworkManager: <info> Activation (eth1) started...
NetworkManager: <info> Activation (eth1) Stage 1 of 5 (Device Prepare) scheduled...
NetworkManager: <info> Activation (eth1) Stage 1 of 5 (Device Prepare) started...
NetworkManager: <info> Activation (eth1) Stage 2 of 5 (Device Configure) scheduled...
NetworkManager: <info> Activation (eth1) Stage 1 of 5 (Device Prepare) complete.
NetworkManager: <info> Activation (eth1) Stage 2 of 5 (Device Configure) starting...
NetworkManager: <info> Activation (eth1/wireless): access point 'XXXXXXX' is unencrypted, no key needed.
kernel: [ 1118.812000] ADDRCONF(NETDEV_UP): eth1: link is not ready
hcid[5965]: Stopping SDP server
hcid[5965]: Unregister path: /org/bluez/hci0
hcid[5965]: Unregister path: /org/bluez
hcid[5965]: Shutting down local server
hcid[5965]: Exit
input[5973]: Unregistered manager path
input[5973]: Exit
audio[5974]: Removing service record 0x10000 failed: The name org.bluez was not provided by any .service files
audio[5974]: Unregistered manager path
audio[5974]: Exit
NetworkManager: <debug> [1200968827.590201] nm_hal_device_removed(): Device removed (hal udi is '/org/freedesktop/Hal/devices/net_00_15_c5_16_88_b3').
NetworkManager: <info> Deactivating device eth0.
kernel: [ 1119.448000] ACPI: PCI interrupt for device 0000:03:00.0 disabled
NetworkManager: <info> Old device 'eth1' activating, won't change.
NetworkManager: <info> supplicant_interface_init() - connect to global ctrl socket (0/10).
NetworkManager: <debug> [1200968828.159209] nm_hal_device_removed(): Device removed (hal udi is '/org/freedesktop/Hal/devices/net_00_13_02_5e_27_d6').
NetworkManager: <info> Deactivating device eth1.
NetworkManager: <info> Activation (eth1): cancelling...
NetworkManager: <info> Activation (eth1) cancellation handler scheduled...
NetworkManager: <info> Activation (eth1): waiting for device to cancel activation.
NetworkManager: <info> supplicant_interface_init() - connect to global ctrl socket (1/10).
kernel: [ 1119.984000] ACPI: PCI interrupt for device 0000:0b:00.0 disabled
NetworkManager: <info> SUP: sending command 'INTERFACE_ADD eth1^I^Iwext^I/var/run/wpa_supplicant2^I'
kernel: [ 1120.112000] ieee80211_crypt: unregistered algorithm 'NULL'
NetworkManager: <info> SUP: response was 'FAIL'
NetworkManager: <WARN> nm_utils_supplicant_request_with_check(): supplicant_interface_init: supplicant error for 'INTERFACE_ADD eth1^I^Iwext^I/var/run/wpa_supplicant2^I'. Response: 'FAIL'
NetworkManager: <WARN> real_act_stage2_config(): Activation (eth1/wireless): couldn't connect to the supplicant.
NetworkManager: <info> Activation (eth1) failure scheduled...
NetworkManager: <info> Activation (eth1) Stage 2 of 5 (Device Configure) complete.
NetworkManager: <info> Activation (eth1): cancelled.
NetworkManager: <WARN> nm_device_802_11_wireless_get_essid(): error getting ESSID for device eth1: No such device
NetworkManager: <info> Activation (eth1) cancellation handled.
NetworkManager: <WARN> nm_device_802_11_wireless_get_mode(): error getting card mode on eth1: No such device
NetworkManager: <info> Activation (eth1) failed for access point (XXXXXXX)
NetworkManager: <info> Activation (eth1) failed.
NetworkManager: <info> Deactivating device eth1.
NetworkManager: <WARN> nm_device_802_11_wireless_get_mode(): error getting card mode on eth1: No such device
kernel: [ 1121.840000] PM: suspend-to-disk mode set to 'shutdown'
kernel: [ 1122.512000] b44.c:v1.01 (Jun 16, 2006)
kernel: [ 1122.512000] ACPI: PCI Interrupt 0000:03:00.0[A] -> GSI 17 (level, low) -> IRQ 22
kernel: [ 1122.516000] eth0: Broadcom 4400 10/100BaseT Ethernet 00:15:c5:16:88:b3
NetworkManager: <debug> [1200968830.703274] nm_hal_device_added(): New device added (hal udi is '/org/freedesktop/Hal/devices/net_00_15_c5_16_88_b3').
kernel: [ 1122.544000] ADDRCONF(NETDEV_UP): eth0: link is not ready
NetworkManager: <info> eth0: Device is fully-supported using driver 'b44'.
NetworkManager: <info> nm_device_init(): waiting for device's worker thread to start
NetworkManager: <info> nm_device_init(): device's worker thread started, continuing.
NetworkManager: <info> Now managing wired Ethernet (802.3) device 'eth0'.
NetworkManager: <info> Deactivating device eth0.
kernel: [ 1122.564000] ieee80211_crypt: registered algorithm 'NULL'
kernel: [ 1122.568000] ieee80211: 802.11 data/management/control stack, git-1.1.13
kernel: [ 1122.568000] ieee80211: Copyright (C) 2004-2005 Intel Corporation <jketreno@linux.intel.com>
kernel: [ 1122.588000] ipw3945: Intel(R) PRO/Wireless 3945 Network Connection driver for Linux, 1.2.2mp
kernel: [ 1122.588000] ipw3945: Copyright(c) 2003-2006 Intel Corporation
kernel: [ 1122.588000] ACPI: PCI Interrupt 0000:0b:00.0[A] -> GSI 16 (level, low) -> IRQ 16
kernel: [ 1122.588000] PCI: Setting latency timer of device 0000:0b:00.0 to 64
kernel: [ 1122.588000] ipw3945: Detected Intel PRO/Wireless 3945ABG Network Connection
kernel: [ 1124.368000] ipw3945: Detected geography ABG (11 802.11bg channels, 13 802.11a channels)
NetworkManager: <debug> [1200968832.750188] nm_hal_device_added(): New device added (hal udi is '/org/freedesktop/Hal/devices/net_00_13_02_5e_27_d6').
kernel: [ 1124.596000] ADDRCONF(NETDEV_UP): eth1: link is not ready
NetworkManager: <info> eth1: Device is fully-supported using driver 'ipw3945'.
NetworkManager: <info> nm_device_init(): waiting for device's worker thread to start
NetworkManager: <info> nm_device_init(): device's worker thread started, continuing.
NetworkManager: <info> Now managing wireless (802.11) device 'eth1'.
NetworkManager: <info> Deactivating device eth1.
kernel: [ 1125.540000] b44: eth0: Link is up at 10 Mbps, full duplex.
NetworkManager: <info> Will activate wired connection 'eth0' because it now has a link.
NetworkManager: <info> SWITCH: no current connection, found better connection 'eth0'.
kernel: [ 1125.540000] b44: eth0: Flow control is off for TX and off for RX.
kernel: [ 1125.540000] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
NetworkManager: <info> Will activate connection 'eth0'.
NetworkManager: <info> Device eth0 activation scheduled...
NetworkManager: <info> Activation (eth0) started...
NetworkManager: <info> Activation (eth0) Stage 1 of 5 (Device Prepare) scheduled...
NetworkManager: <info> Activation (eth0) Stage 1 of 5 (Device Prepare) started...
NetworkManager: <info> Activation (eth0) Stage 2 of 5 (Device Configure) scheduled...
NetworkManager: <info> Activation (eth0) Stage 1 of 5 (Device Prepare) complete.
NetworkManager: <info> Activation (eth0) Stage 2 of 5 (Device Configure) starting...
NetworkManager: <info> Activation (eth0) Stage 2 of 5 (Device Configure) successful.
NetworkManager: <info> Activation (eth0) Stage 3 of 5 (IP Configure Start) scheduled.
NetworkManager: <info> Activation (eth0) Stage 2 of 5 (Device Configure) complete.
NetworkManager: <info> Activation (eth0) Stage 3 of 5 (IP Configure Start) started...
hcid[10398]: Bluetooth HCI daemon
hcid[10398]: HCI dev 0 registered
hcid[10398]: HCI dev 0 already up
hcid[10398]: Device hci0 has been added
hcid[10398]: Starting security manager 0
hcid[10398]: Device hci0 has been activated
hcid[10398]: Starting SDP server
hcid[10398]: Created local server at unix:abstract=/var/run/dbus-iOolYbkN4Y,guid=f47b3434acca8a13d67bb60047955482
input[10402]: Bluetooth Input daemon
audio[10403]: Bluetooth Audio daemon
input[10402]: Registered input manager path:/org/bluez/input

[shoofy]

Hibernate attempt continued:

audio[10403]: Parsing /etc/bluetooth/audio.conf failed: No such file or directory
audio[10403]: Unix socket created: 5
hcid[10398]: Default passkey agent (:1.25, /org/bluez/passkey) registered
hcid[10398]: Default authorization agent (:1.25, /org/bluez/auth) registered
audio[10403]: add_service_record: got record id 0x10000
audio[10403]: add_service_record: got record id 0x10001
audio[10403]: Registered manager path:/org/bluez/audio
NetworkManager: <debug> [1200968834.380304] nm_hal_device_removed(): Device removed (hal udi is '/org/freedesktop/Hal/devices/computer_logicaldev_input_0').
NetworkManager: <debug> [1200968834.383605] nm_hal_device_removed(): Device removed (hal udi is '/org/freedesktop/Hal/devices/computer_logicaldev_input_1').
NetworkManager: <debug> [1200968834.388200] nm_hal_device_removed(): Device removed (hal udi is '/org/freedesktop/Hal/devices/computer_logicaldev_input_2').
kernel: [ 1126.240000] input: Lid Switch as /class/input/input9
kernel: [ 1126.240000] ACPI: Lid Switch [LID]
kernel: [ 1126.240000] input: Power Button (CM) as /class/input/input10
kernel: [ 1126.240000] ACPI: Power Button (CM) [PBTN]
kernel: [ 1126.240000] input: Sleep Button (CM) as /class/input/input11
kernel: [ 1126.240000] ACPI: Sleep Button (CM) [SBTN]
kernel: [ 1126.348000] ACPI: Thermal Zone [THM] (42 C)
NetworkManager: <debug> [1200968834.517612] nm_hal_device_added(): New device added (hal udi is '/org/freedesktop/Hal/devices/computer_logicaldev_input_0').
NetworkManager: <debug> [1200968834.519076] nm_hal_device_added(): New device added (hal udi is '/org/freedesktop/Hal/devices/computer_logicaldev_input_1').
NetworkManager: <debug> [1200968834.520348] nm_hal_device_added(): New device added (hal udi is '/org/freedesktop/Hal/devices/computer_logicaldev_input_2').
kernel: [ 1126.416000] ACPI: AC Adapter [AC] (on-line)
kernel: [ 1126.456000] ACPI: Battery Slot [BAT0] (battery present)
anacron[10528]: Anacron 2.3 started on 2008-01-21
anacron[10528]: Normal exit (0 jobs run)
avahi-daemon[5910]: Registering new address record for fe80::215:c5ff:fe16:88b3 on eth0.*.
NetworkManager: <info> Activation (eth0) Beginning DHCP transaction.
NetworkManager: <info> Activation (eth0) Stage 3 of 5 (IP Configure Start) complete.
NetworkManager: <info> DHCP daemon state is now 12 (successfully started) for interface eth0
NetworkManager: <info> DHCP daemon state is now 1 (starting) for interface eth0
dhclient: DHCPREQUEST on eth0 to 255.255.255.255 port 67
dhclient: DHCPACK from XXX.XXX.XXX.XXX
avahi-daemon[5910]: Joining mDNS multicast group on interface eth0.IPv4 with address 128.253.27.155.
avahi-daemon[5910]: New relevant interface eth0.IPv4 for mDNS.
avahi-daemon[5910]: Registering new address record for XXX.XXX.XXX.XXX on eth0.IPv4.
avahi-daemon[5910]: Withdrawing address record for XXX.XXX.XXX.XXX on eth0.
avahi-daemon[5910]: Leaving mDNS multicast group on interface eth0.IPv4 with address XXX.XXX.XXX.XXX.
avahi-daemon[5910]: Interface eth0.IPv4 no longer relevant for mDNS.
avahi-daemon[5910]: Joining mDNS multicast group on interface eth0.IPv4 with address 128.253.27.155.
avahi-daemon[5910]: New relevant interface eth0.IPv4 for mDNS.
avahi-daemon[5910]: Registering new address record for XXX.XXX.XXX.XXX on eth0.IPv4.
dhclient: bound to XXX.XXX.XXX.XXX -- renewal in 1537 seconds.
NetworkManager: <info> DHCP daemon state is now 4 (reboot) for interface eth0
NetworkManager: <info> Activation (eth0) Stage 4 of 5 (IP Configure Get) scheduled...
NetworkManager: <info> Activation (eth0) Stage 4 of 5 (IP Configure Get) started...
dhcdbd: message_handler: message handler not found under /com/redhat/dhcp/eth0 for sub-path eth0.dbus.get.host_name
dhcdbd: message_handler: message handler not found under /com/redhat/dhcp/eth0 for sub-path eth0.dbus.get.nis_domain
dhcdbd: message_handler: message handler not found under /com/redhat/dhcp/eth0 for sub-path eth0.dbus.get.nis_servers
NetworkManager: <info> Retrieved the following IP4 configuration from the DHCP daemon:
<snip>
NetworkManager: <info> Activation (eth0) Stage 5 of 5 (IP Configure Commit) scheduled...
NetworkManager: <info> Activation (eth0) Stage 4 of 5 (IP Configure Get) complete.
NetworkManager: <info> Activation (eth0) Stage 5 of 5 (IP Configure Commit) started...
avahi-daemon[5910]: Withdrawing address record for 128.253.27.155 on eth0.
avahi-daemon[5910]: Leaving mDNS multicast group on interface eth0.IPv4 with address XXX.XXX.XXX.XXX.
avahi-daemon[5910]: Interface eth0.IPv4 no longer relevant for mDNS.
avahi-daemon[5910]: Withdrawing address record for fe80::215:c5ff:fe16:88b3 on eth0.
avahi-daemon[5910]: Joining mDNS multicast group on interface eth0.IPv4 with address 128.253.27.155.
avahi-daemon[5910]: New relevant interface eth0.IPv4 for mDNS.
avahi-daemon[5910]: Registering new address record for XXX.XXX.XXX.XXX on eth0.IPv4.
NetworkManager: <info> Clearing nscd hosts cache.
NetworkManager: <WARN> nm_spawn_process(): nm_spawn_process('/usr/sbin/nscd -i hosts'): could not spawn process. (Failed to execute child process "/usr/sbin/nscd" (No such file or directory))
NetworkManager: <info> Activation (eth0) Finish handler scheduled.
NetworkManager: <info> Activation (eth0) Stage 5 of 5 (IP Configure Commit) complete.
NetworkManager: <info> Activation (eth0) successful, device activated.
ntpdate[10631]: the NTP socket is in use, exiting
avahi-daemon[5910]: Registering new address record for fe80::215:c5ff:fe16:88b3 on eth0.*.
gnome-power-manager: (aaron) Resuming computer
gnome-power-manager: (aaron) hibernate failed
kernel: [ 1136.892000] [fglrx:firegl_free_mutex] *ERROR* mutex id 0x00000002 not found in mutex list

Neither of these seem to give me any reason for suspend/hibernate failing. Are there other places that I can look for clues?

This new fglrx also seems to be giving me problems with whenever gnome-screensaver turns off the monitor, it doesn't come back on.

[oyvind]

So, suspend fails, and the computer comes back online by itself afterwords ? Suspend doesn't cause a crash, it just doesn't work ? In that case, what is the contents of your kernel log after a failed suspend-attempt ? Type 'dmesg' in a terminal window and paste the contents somewhere.

[shoofy]

Yes, after failing it just returns to where it was and pops up a message that it failed. If gnome-screensaver is enabled it locks the screen when it comes back.

After failed suspend:

[60645.500000] input: Lid Switch as /class/input/input12
[60645.500000] ACPI: Lid Switch [LID]
[60645.500000] input: Power Button (CM) as /class/input/input13
[60645.500000] ACPI: Power Button (CM) [PBTN]
[60645.500000] input: Sleep Button (CM) as /class/input/input14
[60645.500000] ACPI: Sleep Button (CM) [SBTN]

After failed hibernate:

[60688.576000] ADDRCONF(NETDEV_UP): eth1: link is not ready
[60689.376000] ACPI: PCI interrupt for device 0000:03:00.0 disabled
[60689.916000] ACPI: PCI interrupt for device 0000:0b:00.0 disabled
[60690.164000] ieee80211_crypt: unregistered algorithm 'NULL'
[60692.552000] PM: suspend-to-disk mode set to 'shutdown'
[60693.324000] b44.c:v1.01 (Jun 16, 2006)
[60693.324000] ACPI: PCI Interrupt 0000:03:00.0[A] -> GSI 17 (level, low) -> IRQ 22
[60693.328000] eth0: Broadcom 4400 10/100BaseT Ethernet 00:15:c5:16:88:b3
[60693.352000] ADDRCONF(NETDEV_UP): eth0: link is not ready
[60693.384000] ieee80211_crypt: registered algorithm 'NULL'
[60693.384000] ieee80211: 802.11 data/management/control stack, git-1.1.13
[60693.384000] ieee80211: Copyright (C) 2004-2005 Intel Corporation <jketreno@linux.intel.com>
[60693.424000] ipw3945: Intel(R) PRO/Wireless 3945 Network Connection driver for Linux, 1.2.2mp
[60693.424000] ipw3945: Copyright(c) 2003-2006 Intel Corporation
[60693.424000] ACPI: PCI Interrupt 0000:0b:00.0[A] -> GSI 16 (level, low) -> IRQ 16
[60693.424000] PCI: Setting latency timer of device 0000:0b:00.0 to 64
[60693.424000] ipw3945: Detected Intel PRO/Wireless 3945ABG Network Connection
[60695.272000] ipw3945: Detected geography ABG (11 802.11bg channels, 13 802.11a channels)
[60695.512000] ADDRCONF(NETDEV_UP): eth1: link is not ready
[60696.344000] b44: eth0: Link is up at 10 Mbps, full duplex.
[60696.344000] b44: eth0: Flow control is off for TX and off for RX.
[60696.344000] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[60697.052000] input: Lid Switch as /class/input/input15
[60697.052000] ACPI: Lid Switch [LID]
[60697.052000] input: Power Button (CM) as /class/input/input16
[60697.052000] ACPI: Power Button (CM) [PBTN]
[60697.072000] input: Sleep Button (CM) as /class/input/input17
[60697.072000] ACPI: Sleep Button (CM) [SBTN]
[60697.172000] ACPI: Thermal Zone [THM] (46 C)
[60697.240000] ACPI: AC Adapter [AC] (on-line)
[60697.280000] ACPI: Battery Slot [BAT0] (battery present)

[homerhomer]

This worked for me

edit /etc/default/acpi-support

and change the following

POST_VIDEO=false
SAVE_VBE_STATE=false


enjoy

[oyvind]

Yes, after failing it just returns to where it was and pops up a message that it failed. If gnome-screensaver is enabled it locks the screen when it comes back.
<snip>

That was all the dmesg output after a failed suspend ? You sure ? No hint there, I guess. I'd try homerhomer's suggestion first (I've disabled all those options myself, in /etc/default/acpi-support, but forgot to mention it). But I'm not sure that will help you, since you are unable to suspend at all. Those options probably will only help if you have trouble with resuming from a successful suspend.

The fglrx-driver should take care of kicking you graphics card back into life on resume, as long as you are suspending from within X. Those ACPI resume commands (POST video, save VBE state, etc) can certainly interfere with that process.

[shoofy]

I had those options disabled already. No luck.

I see that a lot of people seem to be having luck with updating to the Hardy kernel and then suspend/hibernate works for them. Any reason not to do this?

[bernhard]

I'm having a similar problem here with gutsy and the generic kernel, fglrx 8.01 and a Radeon Mobility x1600 in my LG S1pro Laptop.

The symptom is as usual: I tell the computer to switch to suspend, all works well, the monitor goes off, the hdd shuts down but then the power led and the fan stay on and the laptop is dead as a doornail until a hard (power button 5 s) shutdown.

Yes, I've tried the settings in acpi-support but to no avail.

My question is - what should I look for, and where? Dmesg? Xorg.log?

Could someone with more Linux-skills than myself please give me a hint, how to pinpoint the problem?

P.S.: Suspend and resume work fine when using the "vesa" xorg-driver.

P.P.S.: Oh - and I am using a 1680x1050 resolution.

[mits]

hi,
though i'd share my story of failed suspend (and ask for your ideas and tips )
my laptop seems to suspend properly, but when i hit the button to resume, it accessed the hdd for some secs and then...nothing
oh, and the cards fan starts spinning like crazy after about 10 or so secs...
with drivers prior to 7.12 (if i remember well) the suspend part didn't work as well, kinda like what bernhard described