[Pkg-utopia-maintainers] Bug#607868: Bug#607868: network-manager: crashes with SIGABRT, sometimes on DHCP or DSL connection, always on shutdown
Martin Steigerwald
Martin at lichtvoll.de
Thu Dec 30 10:06:41 UTC 2010
Am Thursday 23 December 2010 schrieb Michael Biebl:
> On 23.12.2010 10:40, Martin Steigerwald wrote:
> > Hmmm, that might be a way to try again with the debug package
> > installed. Yes, this seems to be reproducable always. But after
> > installing network-manager-dbg, libglib2.0-0-dbg,
> > libdbus-glib-1-2-dbg and libgcrypt11-dbg I still only get:
> >
> >
> > Are there other debug packages I need to install?
>
> You need to run NetworkManager within gdb.
>
> Install the gdb package, run /etc/init.d/network-manager stop,
> gdb /usr/sbin/NetworkManager
> run --no-daemon
> <let it crash>
> bt full
I tried, but I am not sure whether I am producing the original problem
here. I just send the process a SIGTERM as I expect the init script to do:
shambhala:~> gdb /usr/sbin/NetworkManager
GNU gdb (GDB) 7.2-debian
Copyright (C) 2010 Free Software Foundation, Inc.
License GPLv3+: GNU GPL version 3 or later
<http://gnu.org/licenses/gpl.html>
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law. Type "show copying"
and "show warranty" for details.
This GDB was configured as "i486-linux-gnu".
For bug reporting instructions, please see:
<http://www.gnu.org/software/gdb/bugs/>...
Reading symbols from /usr/sbin/NetworkManager...Reading symbols from
/usr/lib/debug/usr/sbin/NetworkManager...done.
done.
(gdb) run --no-daemon
Starting program: /usr/sbin/NetworkManager --no-daemon
[Thread debugging using libthread_db enabled]
NetworkManager[12152]: <info> NetworkManager (version 0.8.2) is
starting...
NetworkManager[12152]: <info> Read config file
/etc/NetworkManager/NetworkManager.conf
NetworkManager[12152]: <info> VPN: loaded
org.freedesktop.NetworkManager.pptp
NetworkManager[12152]: <info> VPN: loaded
org.freedesktop.NetworkManager.vpnc
NetworkManager[12152]: <info> VPN: loaded
org.freedesktop.NetworkManager.openvpn
NetworkManager[12152]: <info> modem-manager is now available
NetworkManager[12152]: <info> monitoring kernel firmware directory
'/lib/firmware'.
NetworkManager[12152]: <info> Loaded plugin keyfile: (c) 2007 - 2010 Red
Hat, Inc. To report bugs please use the NetworkManager mailing list.
NetworkManager[12152]: keyfile: parsing Auto eth0 ...
NetworkManager[12152]: keyfile: read connection 'Auto eth0'
NetworkManager[12152]: <info> found WiFi radio killswitch rfkill0 (at
/sys/devices/pci0000:00/0000:00:1e.0/0000:02:02.0/ieee80211/phy0/rfkill0)
(driver <unknown>)
NetworkManager[12152]: <info> WiFi enabled by radio killswitch; disabled
by state file
NetworkManager[12152]: <info> WWAN enabled by radio killswitch; enabled by
state file
NetworkManager[12152]: <info> WiMAX enabled by radio killswitch; enabled
by state file
NetworkManager[12152]: <info> Networking is enabled by state file
NetworkManager[12152]: <info> (eth0): carrier is ON
NetworkManager[12152]: <info> (eth0): new Ethernet device (driver: 'e1000'
ifindex: 2)
NetworkManager[12152]: <info> (eth0): exported as
/org/freedesktop/NetworkManager/Devices/0
NetworkManager[12152]: <info> (eth0): now managed
NetworkManager[12152]: <info> (eth0): device state change: 1 -> 2 (reason
2)
NetworkManager[12152]: <info> (eth0): preparing device.
NetworkManager[12152]: <info> (eth0): deactivating device (reason: 2).
NetworkManager[12152]: <info> (eth1): driver supports SSID scans
(scan_capa 0x21).
NetworkManager[12152]: <info> WiFi now disabled by radio killswitch
NetworkManager[12152]: <info> (eth1): new 802.11 WiFi device (driver:
'ipw2200' ifindex: 3)
NetworkManager[12152]: <info> (eth1): exported as
/org/freedesktop/NetworkManager/Devices/1
NetworkManager[12152]: <info> (eth1): now managed
NetworkManager[12152]: <info> (eth1): device state change: 1 -> 2 (reason
2)
NetworkManager[12152]: <info> (eth1): bringing up device.
NetworkManager[12152]: <info> (eth1): deactivating device (reason: 2).
NetworkManager[12152]: <warn> /sys/devices/virtual/net/vboxnet0: couldn't
determine device driver; ignoring...
/sbin/ifup: interface lo already configured
NetworkManager[12152]: <warn> bluez error getting default adapter: The
name org.bluez was not provided by any .service files
NetworkManager[12152]: <info> (eth0): device state change: 2 -> 3 (reason
0)
NetworkManager[12152]: <info> Activation (eth0) starting connection 'Auto
eth0'
NetworkManager[12152]: <info> (eth0): device state change: 3 -> 4 (reason
0)
NetworkManager[12152]: <info> Activation (eth0) Stage 1 of 5 (Device
Prepare) scheduled...
NetworkManager[12152]: <info> Activation (eth0) Stage 1 of 5 (Device
Prepare) started...
NetworkManager[12152]: <info> Activation (eth0) Stage 2 of 5 (Device
Configure) scheduled...
NetworkManager[12152]: <info> Activation (eth0) Stage 1 of 5 (Device
Prepare) complete.
NetworkManager[12152]: <info> Activation (eth0) Stage 2 of 5 (Device
Configure) starting...
NetworkManager[12152]: <info> (eth0): device state change: 4 -> 5 (reason
0)
NetworkManager[12152]: <info> Activation (eth0) Stage 2 of 5 (Device
Configure) successful.
NetworkManager[12152]: <info> Activation (eth0) Stage 3 of 5 (IP Configure
Start) scheduled.
NetworkManager[12152]: <info> Activation (eth0) Stage 2 of 5 (Device
Configure) complete.
NetworkManager[12152]: <info> Activation (eth0) Stage 3 of 5 (IP Configure
Start) started...
NetworkManager[12152]: <info> (eth0): device state change: 5 -> 7 (reason
0)
NetworkManager[12152]: <info> Activation (eth0) Beginning DHCPv4
transaction (timeout in 45 seconds)
NetworkManager[12152]: <info> dhclient started with pid 12156
[New Thread 0xb7876b70 (LWP 12157)]
NetworkManager[12152]: <info> Activation (eth0) Stage 3 of 5 (IP Configure
Start) complete.
Internet Systems Consortium DHCP Client 4.1.1-P1
Copyright 2004-2010 Internet Systems Consortium.
All rights reserved.
For info, please visit https://www.isc.org/software/dhcp/
NetworkManager[12152]: <info> (eth0): DHCPv4 state changed nbi -> preinit
Listening on LPF/eth0/00:11:25:46:ec:a5
Sending on LPF/eth0/00:11:25:46:ec:a5
Sending on Socket/fallback
DHCPREQUEST on eth0 to 255.255.255.255 port 67
DHCPACK from 10.0.0.9
NetworkManager[12152]: <info> (eth0): DHCPv4 state changed preinit ->
reboot
NetworkManager[12152]: <info> Activation (eth0) Stage 4 of 5 (IP4 Configure
Get) scheduled...
NetworkManager[12152]: <info> Activation (eth0) Stage 4 of 5 (IP4 Configure
Get) started...
NetworkManager[12152]: <info> address 10.0.0.21
NetworkManager[12152]: <info> prefix 16 (255.255.0.0)
NetworkManager[12152]: <info> gateway 10.0.0.9
NetworkManager[12152]: <info> hostname 'shambhala'
NetworkManager[12152]: <info> nameserver '10.0.0.9'
NetworkManager[12152]: <info> domain name 'lichtvoll'
NetworkManager[12152]: <info> Activation (eth0) Stage 5 of 5 (IP Configure
Commit) scheduled...
NetworkManager[12152]: <info> Activation (eth0) Stage 4 of 5 (IP4 Configure
Get) complete.
NetworkManager[12152]: <info> Activation (eth0) Stage 5 of 5 (IP Configure
Commit) started...
bound to 10.0.0.21 -- renewal in 17600 seconds.
NetworkManager[12152]: <info> (eth0): writing resolv.conf to
/sbin/resolvconf
NetworkManager[12152]: <info> (eth0): device state change: 7 -> 8 (reason
0)
NetworkManager[12152]: <info> Policy set 'Auto eth0' (eth0) as default for
IPv4 routing and DNS.
NetworkManager[12152]: <info> Activation (eth0) successful, device
activated.
NetworkManager[12152]: <info> Activation (eth0) Stage 5 of 5 (IP Configure
Commit) complete.
Program received signal SIGTERM, Terminated.
0xb7fe2424 in __kernel_vsyscall ()
(gdb) bt full
#0 0xb7fe2424 in __kernel_vsyscall ()
No symbol table info available.
#1 0xb7a7e696 in __poll (fds=0xb7b01ff4, nfds=6, timeout=3998) at
../sysdeps/unix/sysv/linux/poll.c:87
resultvar = <value optimized out>
oldtype = 0
result = <value optimized out>
#2 0xb7b82fbb in g_poll (fds=0x8113bd0, nfds=6, timeout=3998)
at /build/buildd-glib2.0_2.27.5-1-i386-
vAAa2H/glib2.0-2.27.5/glib/gpoll.c:132
No locals.
#3 0xb7b75abc in g_main_context_poll (context=0x80f5258, block=<value
optimized out>, dispatch=1, self=0x80ed190)
at /build/buildd-glib2.0_2.27.5-1-i386-
vAAa2H/glib2.0-2.27.5/glib/gmain.c:3404
poll_func = 0xb7b82f90 <g_poll>
#4 g_main_context_iterate (context=0x80f5258, block=<value optimized
out>, dispatch=1, self=0x80ed190)
at /build/buildd-glib2.0_2.27.5-1-i386-
vAAa2H/glib2.0-2.27.5/glib/gmain.c:3086
max_priority = 2147483647
timeout = 3998
some_ready = <value optimized out>
nfds = 6
allocated_nfds = <value optimized out>
fds = <value optimized out>
__PRETTY_FUNCTION__ = "g_main_context_iterate"
#5 0xb7b76227 in g_main_loop_run (loop=0x80f52e8)
at /build/buildd-glib2.0_2.27.5-1-i386-
vAAa2H/glib2.0-2.27.5/glib/gmain.c:3299
self = 0x80ed190
__PRETTY_FUNCTION__ = "g_main_loop_run"
#6 0x080881c6 in main (argc=1, argv=0xbffff824) at main.c:731
opt_ctx = <value optimized out>
become_daemon = 0
g_fatal_warnings = 0
pidfile = 0x80ee8b0 "/var/run/NetworkManager.pid"
state_file = 0x80ee668
"/var/lib/NetworkManager/NetworkManager.state"
dhcp = 0x0
config = 0x80ee7c8 "/etc/NetworkManager/NetworkManager.conf"
plugins = 0x80f1a40 "keyfile"
conf_plugins = 0x80f2530 "\002"
log_level = 0x0
log_domains = 0x0
dns = 0x0
wifi_enabled = 135269328
net_enabled = 1
wwan_enabled = 135206088
success = <value optimized out>
policy = 0x8100bd0
vpn_manager = 0x80f5e60
dns_mgr = 0x80fe858
dbus_mgr = 0x80f1050
---Type <return> to continue, or q <return> to quit---
sup_mgr = 0x80f14c8
dhcp_mgr = 0x80f14a0
error = 0x0
wrote_pidfile = 0
cfg_log_level = 0x0
cfg_log_domains = 0x0
options = {{long_name = 0x80d9e35 "no-daemon", short_name = 0
'\000', flags = 0, arg = G_OPTION_ARG_NONE,
arg_data = 0xbffff75c, description = 0x80d9e3f "Don't become a
daemon", arg_description = 0x0}, {
long_name = 0x80d9e55 "g-fatal-warnings", short_name = 0
'\000', flags = 0, arg = G_OPTION_ARG_NONE,
arg_data = 0xbffff758, description = 0x80d9e66 "Make all
warnings fatal", arg_description = 0x0}, {
long_name = 0x80d9e7e "pid-file", short_name = 0 '\000', flags =
0, arg = G_OPTION_ARG_FILENAME,
arg_data = 0xbffff754, description = 0x80d9748 "Specify the
location of a PID file",
arg_description = 0x80d9e87 "filename"}, {long_name = 0x80d9e90
"state-file", short_name = 0 '\000',
flags = 0, arg = G_OPTION_ARG_FILENAME, arg_data = 0xbffff750,
description = 0x80d9e9b "State file location", arg_description
= 0x80d9eaf "/path/to/state.file"}, {
long_name = 0x80da387 "config", short_name = 0 '\000', flags =
0, arg = G_OPTION_ARG_FILENAME,
arg_data = 0xbffff748, description = 0x80d9ec3 "Config file
location",
arg_description = 0x80d9ed8 "/path/to/config.file"}, {long_name
= 0x80d9e04 "plugins",
short_name = 0 '\000', flags = 0, arg = G_OPTION_ARG_STRING,
arg_data = 0xbffff744,
description = 0x80d976c "List of plugins separated by ','",
arg_description = 0x80d9eed "plugin1,plugin2"}, {long_name =
0x80d9efd "log-level",
short_name = 0 '\000', flags = 0, arg = G_OPTION_ARG_STRING,
arg_data = 0xbffff73c,
description = 0x80d9790 "Log level: one of [ERR, WARN, INFO,
DEBUG]",
arg_description = 0x80d9f07 "INFO"}, {long_name = 0x80d9f0c
"log-domains", short_name = 0 '\000',
flags = 0, arg = G_OPTION_ARG_STRING, arg_data = 0xbffff738,
description = 0x80d97bc "Log domains separated by ',': any
combination of
[NONE,HW,RKILL,ETHER,WIFI,BT,MB,DHCP4,DHCP6,PPP,WIFI_SCAN,IP4,IP6,AUTOIP4,DNS,VPN,SHARING,SUPPLICANT,USER_SET,SYS_SET,SUSPEND,CORE,DEVICE,OLPC]",
arg_description = 0x80d9f18 "HW,RFKILL,WIFI"}, {long_name = 0x0,
short_name = 0 '\000', flags = 0,
arg = G_OPTION_ARG_NONE, arg_data = 0x0, description = 0x0,
arg_description = 0x0}}
__PRETTY_FUNCTION__ = "main"
(gdb)
But this looks to me like a regular shutdown.
I still see
Dec 30 10:58:20 shambhala NetworkManager[2106]: <info> caught signal 15,
shutting down normally.
Dec 30 10:58:20 shambhala NetworkManager[2106]: <warn> caught signal 6.
Generating backtrace...
Dec 30 10:58:20 shambhala NetworkManager: ******************* START
**********************************
Dec 30 10:58:22 shambhala NetworkManager: [Thread debugging using
libthread_db enabled]
Dec 30 10:58:22 shambhala NetworkManager: [New Thread 0xb703cb70 (LWP
2131)]
Dec 30 10:58:23 shambhala NetworkManager: 0xb773a424 in __kernel_vsyscall
()
Dec 30 10:58:23 shambhala NetworkManager: ******************* END
**********************************
when I do /etc/init.d/network-manager stop.
Can it be that Network Manager generates a backtrace needlessly here and
all is well? I wonder about that signal 6 stuff. Is the init script
(needlessly?) sending it?
I don't see anything too obvious:
shambhala:~> grep kill /etc/init.d/network-manager
shambhala:~#1>
--
Martin 'Helios' Steigerwald - http://www.Lichtvoll.de
GPG: 03B0 0D6C 0040 0710 4AFA B82F 991B EAAC A599 84C7
-------------- next part --------------
A non-text attachment was scrubbed...
Name: not available
Type: application/pgp-signature
Size: 198 bytes
Desc: This is a digitally signed message part.
URL: <http://lists.alioth.debian.org/pipermail/pkg-utopia-maintainers/attachments/20101230/07f3dcf8/attachment.pgp>
More information about the Pkg-utopia-maintainers
mailing list