Arch Linux

Error log :

May 5 19:26:45 fredo-arch NetworkManager: <WARN> nm_signal_handler(): Caught signal 15, shutting down normally.
May 5 19:26:45 fredo-arch NetworkManager: <info> (eth0): now unmanaged
May 5 19:26:45 fredo-arch NetworkManager: <info> (eth0): device state change: 2 -> 1
May 5 19:26:45 fredo-arch NetworkManager: <info> (eth0): cleaning up...
May 5 19:26:45 fredo-arch NetworkManager: <info> (eth0): taking down device.
May 5 19:26:45 fredo-arch NetworkManager: <info> (wlan0): now unmanaged
May 5 19:26:45 fredo-arch NetworkManager: <info> (wlan0): device state change: 3 -> 1
May 5 19:26:45 fredo-arch NetworkManager: <info> (wlan0): cleaning up...
May 5 19:26:45 fredo-arch NetworkManager: <info> (wlan0): taking down device.
May 5 19:26:45 fredo-arch kernel: wlan0: deauthenticating by local choice (reason=3)
May 5 19:26:45 fredo-arch NetworkManager: <info> disconnected by the system bus.
May 5 19:26:45 fredo-arch syslog-ng[4126]: Termination requested via signal, terminating;
May 5 19:26:45 fredo-arch syslog-ng[4126]: syslog-ng shutting down; version='3.0.1'

My DAEMONS line :

DAEMONS=(syslog-ng !network netfs crond alsa hal pulseaudio networkmanager cpufreq fam avahi-daemon avahi-dnsconfd cups ntpd stbd gdm)

More info : when hanging, there is a message with NM_IS_SYSCONFIG_SETTINGS in it.

I found a redhat bugzilla entry : https://bugzilla.redhat.com/show_bug.cgi?id=472774

And a post in archlinux.org forum : http://bbs.archlinux.org/viewtopic.php?id=70130

I will try wicd to see if it is a network manager issue.

Wicd is not an answer to this issue.

My wifi hardware if it could be related :

05:00.0 Ethernet controller: Atheros Communications Inc. AR242x 802.11abg Wireless PCI Express Adapter (rev 01)

And a wicd related log when shutdown is not automated :

ay 6 16:43:08 fredo-arch dhcpcd[6622]: wlan0: sending signal 1 to pid 4721
May 6 16:43:08 fredo-arch wlan0: waiting for pid 4721 to exit
May 6 16:43:08 fredo-arch dhcpcd[4721]: wlan0: received SIGHUP, releasing lease
May 6 16:43:08 fredo-arch dhcpcd[6622]: wlan0: waiting for pid 4721 to exit
May 6 16:43:08 fredo-arch avahi-daemon[4560]: Withdrawing address record for 192.168.1.10 on wlan0.
May 6 16:43:08 fredo-arch avahi-daemon[4560]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.10.
May 6 16:43:08 fredo-arch avahi-daemon[4560]: Interface wlan0.IPv4 no longer relevant for mDNS.
May 6 16:43:08 fredo-arch kernel: wlan0: deauthenticating by local choice (reason=3)
May 6 16:43:08 fredo-arch avahi-daemon[4560]: Withdrawing address record for fe80::21e:4cff:fe9f:d694 on wlan0.
May 6 16:43:08 fredo-arch kernel: ADDRCONF(NETDEV_UP): wlan0: link is not ready
May 6 16:43:16 fredo-arch gnome-session[4771]: WARNING: Unable to list sessions: Rejected send message, 2 matched rules; type="method_call", sender=":1.16" (uid=1000 pid=4771 comm="gnome-session ") interface="org.freedesktop.ConsoleKit.Manager" member="GetSessions" error name="(unset)" requested_reply=0 destination="org.freedesktop.ConsoleKit" (uid=0 pid=4375 comm="/usr/sbin/console-kit-daemon "))
May 6 16:43:16 fredo-arch console-kit-daemon[4375]: GLib-GObject-WARNING: IA__g_object_get_valist: value location for `gchararray' passed as NULL
May 6 16:43:16 fredo-arch console-kit-daemon[4375]: GLib-GObject-WARNING: IA__g_object_get_valist: value location for `gchararray' passed as NULL
May 6 16:43:16 fredo-arch console-kit-daemon[4375]: GLib-GObject-WARNING: IA__g_object_get_valist: value location for `gchararray' passed as NULL
May 6 16:43:16 fredo-arch shutdown[6661]: shutting down for system halt
May 6 16:43:16 fredo-arch console-kit-daemon[4375]: GLib-GObject-WARNING: IA__g_object_get_valist: value location for `gchararray' passed as NULL
May 6 16:43:16 fredo-arch shutdown[6658]: shutting down for system halt
May 6 16:43:16 fredo-arch console-kit-daemon[4375]: GLib-GObject-WARNING: IA__g_object_get_valist: value location for `gchararray' passed as NULL
May 6 16:43:16 fredo-arch shutdown[6668]: shutting down for system halt
May 6 16:43:16 fredo-arch console-kit-daemon[4375]: GLib-GObject-WARNING: IA__g_object_get_valist: value location for `gchararray' passed as NULL
May 6 16:43:16 fredo-arch shutdown[6671]: shutting down for system halt
May 6 16:43:16 fredo-arch console-kit-daemon[4375]: GLib-GObject-WARNING: IA__g_object_get_valist: value location for `gchararray' passed as NULL
May 6 16:43:16 fredo-arch shutdown[6674]: shutting down for system halt
May 6 16:43:16 fredo-arch console-kit-daemon[4375]: GLib-GObject-WARNING: IA__g_object_get_valist: value location for `gchararray' passed as NULL
May 6 16:43:16 fredo-arch shutdown[6681]: shutting down for system halt
May 6 16:43:16 fredo-arch shutdown[6685]: shutting down for system halt
May 6 16:43:17 fredo-arch init: Switching to runlevel: 0
May 6 16:43:18 fredo-arch ntpd_initres[4608]: ntpd exiting on signal 15
May 6 16:43:18 fredo-arch ntpd[4601]: ntpd exiting on signal 15
May 6 16:43:18 fredo-arch avahi-dnsconfd[4570]: Got SIGTERM, quitting.
May 6 16:43:18 fredo-arch avahi-daemon[4560]: Got SIGTERM, quitting.
May 6 16:43:18 fredo-arch console-kit-daemon[4375]: GLib-GObject-WARNING: instance with invalid (NULL) class pointer
May 6 16:43:18 fredo-arch console-kit-daemon[4375]: GLib-GObject-CRITICAL: g_signal_emit_valist: assertion `G_TYPE_CHECK_INSTANCE (instance)' failed
May 6 16:43:18 fredo-arch console-kit-daemon[4375]: GLib-GObject-CRITICAL: g_object_unref: assertion `G_IS_OBJECT (object)' failed
May 6 16:43:19 fredo-arch syslog-ng[4104]: Termination requested via signal, terminating;
May 6 16:43:19 fredo-arch syslog-ng[4104]: syslog-ng shutting down; version='3.0.1'
May 6 16:44:19 fredo-arch syslog-ng[4042]: syslog-ng starting up; version='3.0.1'

Sorry to "spam" this bug. But I'm trying to give as many information as possible.

And last log, a blocked shutdown log after I stopped all network before asking for powerdown :

May 6 16:43:16 fredo-arch gnome-session[4771]: WARNING: Unable to list sessions: Rejected send message, 2 matched rules; type="method_call", sender=":1.16" (uid=1000 pid=4771 comm="gnome-session ") interface="org.freedesktop.ConsoleKit.Manager" member="GetSessions" error name="(unset)" requested_reply=0 destination="org.freedesktop.ConsoleKit" (uid=0 pid=4375 comm="/usr/sbin/console-kit-daemon "))
May 6 16:43:16 fredo-arch console-kit-daemon[4375]: GLib-GObject-WARNING: IA__g_object_get_valist: value location for `gchararray' passed as NULL
May 6 16:43:16 fredo-arch console-kit-daemon[4375]: GLib-GObject-WARNING: IA__g_object_get_valist: value location for `gchararray' passed as NULL
May 6 16:43:16 fredo-arch console-kit-daemon[4375]: GLib-GObject-WARNING: IA__g_object_get_valist: value location for `gchararray' passed as NULL
May 6 16:43:16 fredo-arch shutdown[6661]: shutting down for system halt
May 6 16:43:16 fredo-arch console-kit-daemon[4375]: GLib-GObject-WARNING: IA__g_object_get_valist: value location for `gchararray' passed as NULL
May 6 16:43:16 fredo-arch shutdown[6658]: shutting down for system halt
May 6 16:43:16 fredo-arch console-kit-daemon[4375]: GLib-GObject-WARNING: IA__g_object_get_valist: value location for `gchararray' passed as NULL
May 6 16:43:16 fredo-arch shutdown[6668]: shutting down for system halt
May 6 16:43:16 fredo-arch console-kit-daemon[4375]: GLib-GObject-WARNING: IA__g_object_get_valist: value location for `gchararray' passed as NULL
May 6 16:43:16 fredo-arch shutdown[6671]: shutting down for system halt
May 6 16:43:16 fredo-arch console-kit-daemon[4375]: GLib-GObject-WARNING: IA__g_object_get_valist: value location for `gchararray' passed as NULL
May 6 16:43:16 fredo-arch shutdown[6674]: shutting down for system halt
May 6 16:43:16 fredo-arch console-kit-daemon[4375]: GLib-GObject-WARNING: IA__g_object_get_valist: value location for `gchararray' passed as NULL
May 6 16:43:16 fredo-arch shutdown[6681]: shutting down for system halt
May 6 16:43:16 fredo-arch shutdown[6685]: shutting down for system halt

Could it be related to last update of coreutils in testing ? Seems to be also after this upgrade that it started to happen.

Looks like keeping coreutils 7.2 instead of 7.3 fixes the problem. Weird ?

coreutils-7.4 will make its way to [testing] today. Can you please test and report back?

I will test it asap is it available on my mirror. Will tell you asap.

No more luck with coreutils 7.4.

I will send logs with coreutils-7.2 and coreutils 7.4, both taken from daemon.log and everything.log.

If it could help, here are some lines from my /etc/rc.conf file :

MODULES=(!snd_pcsp fuse ath5k uvcvideo powernow-k8 cpufreq_ondemand kvm-amd)
DAEMONS=(syslog-ng !network netfs crond alsa hal pulseaudio networkmanager cpufreq fam avahi-daemon avahi-dnsconfd cups ntpd stbd gdm)

Logs with coreutils 7.2

And logs with coreutils 7.4

Oops, forgot logs :(

Well, since consolekit update, all seems to be allright. Kinda weird bug.