Package: network-manager
Version: 0.6.4-8+b1
--- Please enter the report below this line. ---
Hi Michael,
Sorry for the delay. Attached is the output. Some additional info you might
find useful:
1) I'm using the madwifi driver from sid
2) I've had to use 'iwpriv ath0 mode 3' by default for a while now to
be able to connect to unencrypted networks with NM (this is not an
issue if I do dhclient ath0 directly). The same is true for this case
(a WEP encrypted network).
3) Once getting the IP fails, I cannot get to the same point again
(that is, entering the key and failing at getting an IP) without restarting
dhcdbd.
Let me know if you need any other information.
Cheers,
Carlos
--- System
information. --- Architecture: i386 Kernel: Linux 2.6.21.070604
Debian Release: lenny/sid
500 unstable www.debian-multimedia.org
500 unstable ftp.debian.org
1 experimental ftp.debian.org
--- Package information. ---
Depends (Version) | Installed
===================================-+-===============
libc6 (>= 2.5) | 2.5-11
libdbus-1-3 (>= 0.94) | 1.1.0-1
libdbus-glib-1-2 (>= 0.73) | 0.73-2
libgcrypt11 (>= 1.2.2) | 1.2.4-2
libglib2.0-0 (>= 2.12.9) | 2.12.12-1
libgpg-error0 (>= 1.4) | 1.4-2
libhal1 (>= 0.5) | 0.5.9-3
libiw29 (>= 28+29pre7) | 29~pre21-2
libnl1-pre6 | 1.0~pre6-5
libnm-util0 | 0.6.4-8+b1
iproute | 20070313-1
iputils-arping | 3:20070202-1
dhcdbd (>= 1.12-2) | 2.0-5
lsb-base (>= 2.0-6) | 3.1-23.1
wpasupplicant (>= 0.4.8) | 0.6.0~cvs20070224-3
dbus (>= 0.60) | 1.1.0-1
hal (>= 0.5.7.1) | 0.5.9-3
ifupdown | 0.6.8
adduser | 3.102
NetworkManager --no-daemon
NetworkManager: <information> starting...
NetworkManager: <information> Adding VPN service
'org.freedesktop.NetworkManager.vpnc' with name 'vpnc' and program
'/usr/lib/network-manager-vpnc/nm-vpnc-service'
NetworkManager: <information> eth0: Device is fully-supported using driver
'e1000'.
NetworkManager: <information> nm_device_init(): waiting for device's worker
thread to start
NetworkManager: <information> nm_device_init(): device's worker thread
started, continuing.
NetworkManager: <information> Now managing wired Ethernet (802.3) device
'eth0'.
NetworkManager: <information> Deactivating device eth0.
NetworkManager: <information> ath0: Device is fully-supported using driver
'ath_pci'.
NetworkManager: <information> nm_device_init(): waiting for device's worker
thread to start
NetworkManager: <information> nm_device_init(): device's worker thread
started, continuing.
NetworkManager: <information> Now managing wireless (802.11) device 'ath0'.
NetworkManager: <information> Deactivating device ath0.
NetworkManager: <information> Updating allowed wireless network lists.
NetworkManager: <information> Updating VPN Connections...
NetworkManager: <debug info> [1181867919.873775]
nm_device_802_11_wireless_get_activation_ap (): Forcing AP 'geoe'
NetworkManager: <information> User Switch:
/org/freedesktop/NetworkManager/Devices/ath0 / geoe
NetworkManager: <information> Deactivating device ath0.
NetworkManager: <information> Device ath0 activation scheduled...
NetworkManager: <information> Activation (ath0) started...
NetworkManager: <information> Activation (ath0) Stage 1 of 5 (Device Prepare)
scheduled...
NetworkManager: <information> Activation (ath0) Stage 1 of 5 (Device Prepare)
started...
NetworkManager: <information> Activation (ath0) Stage 2 of 5 (Device
Configure) scheduled...
NetworkManager: <information> Activation (ath0) Stage 1 of 5 (Device Prepare)
complete.
NetworkManager: <information> Activation (ath0) Stage 2 of 5 (Device
Configure) starting...
NetworkManager: <information> Activation (ath0/wireless): access point 'geoe'
is encrypted, but NO valid key exists. New key needed.
NetworkManager: <information> Activation (ath0) New wireless user key
requested for network 'geoe'.
NetworkManager: <information> Activation (ath0) Stage 2 of 5 (Device
Configure) complete.
NetworkManager: <information> Activation (ath0) New wireless user key for
network 'geoe' received.
NetworkManager: <information> Activation (ath0) Stage 1 of 5 (Device Prepare)
scheduled...
NetworkManager: <information> Activation (ath0) Stage 1 of 5 (Device Prepare)
started...
NetworkManager: <information> Activation (ath0) Stage 2 of 5 (Device
Configure) scheduled...
NetworkManager: <information> Activation (ath0) Stage 1 of 5 (Device Prepare)
complete.
NetworkManager: <information> Activation (ath0) Stage 2 of 5 (Device
Configure) starting...
NetworkManager: <information> Activation (ath0/wireless): access point 'geoe'
is encrypted, and a key exists. No new key needed.
NetworkManager: <information> SUP: sending command 'INTERFACE_ADD ath0
wext /var/run/wpa_supplicant '
NetworkManager: <information> SUP: response was 'OK'
NetworkManager: <information> SUP: sending command 'AP_SCAN 1'
NetworkManager: <information> SUP: response was 'OK'
NetworkManager: <information> SUP: sending command 'ADD_NETWORK'
NetworkManager: <information> SUP: response was '0'
NetworkManager: <information> SUP: sending command 'SET_NETWORK 0 ssid
67656f65'
NetworkManager: <information> SUP: response was 'OK'
NetworkManager: <information> SUP: sending command 'SET_NETWORK 0 key_mgmt
NONE'
NetworkManager: <information> SUP: response was 'OK'
NetworkManager: <information> SUP: sending command 'SET_NETWORK 0 wep_key0
<key>'
NetworkManager: <information> SUP: response was 'OK'
NetworkManager: <information> SUP: sending command 'SET_NETWORK 0
wep_tx_keyidx 0'
NetworkManager: <information> SUP: response was 'OK'
NetworkManager: <information> SUP: sending command 'ENABLE_NETWORK 0'
NetworkManager: <information> SUP: response was 'OK'
NetworkManager: <information> Activation (ath0) Stage 2 of 5 (Device
Configure) complete.
NetworkManager: <information> wpa_supplicant(3977): Global control interface
'/var/run/wpa_supplicant-global'
NetworkManager: <information> wpa_supplicant(3977): RX global ctrl_iface -
hexdump_ascii(len=49):
NetworkManager: <information> wpa_supplicant(3977): 49 4e 54 45 52 46 41
43 45 5f 41 44 44 20 61 74 INTERFACE_ADD at
NetworkManager: <information> wpa_supplicant(3977): 68 30 09 09 77 65 78
74 09 2f 76 61 72 2f 72 75 h0__wext_/var/ru
NetworkManager: <information> wpa_supplicant(3977): 6e 2f 77 70 61 5f 73
75 70 70 6c 69 63 61 6e 74 n/wpa_supplicant
NetworkManager: <information> wpa_supplicant(3977): 09
_
NetworkManager: <information> wpa_supplicant(3977): CTRL_IFACE GLOBAL
INTERFACE_ADD 'ath0 wext /var/run/wpa_supplicant '
NetworkManager: <information> wpa_supplicant(3977): Initializing interface
'ath0' conf 'N/A' driver 'wext' ctrl_interface '/var/run/wpa_supplicant' bridge
'N/A'
NetworkManager: <information> wpa_supplicant(3977): Initializing interface
(2) 'ath0'
NetworkManager: <information> wpa_supplicant(3977): EAPOL: SUPP_PAE entering
state DISCONNECTED
NetworkManager: <information> wpa_supplicant(3977): EAPOL: KEY_RX entering
state NO_KEY_RECEIVE
NetworkManager: <information> wpa_supplicant(3977): EAPOL: SUPP_BE entering
state INITIALIZE
NetworkManager: <information> wpa_supplicant(3977): EAP: EAP entering state
DISABLED
NetworkManager: <information> wpa_supplicant(3977): EAPOL: External
notification - portEnabled=0
NetworkManager: <information> wpa_supplicant(3977): EAPOL: External
notification - portValid=0
NetworkManager: <information> wpa_supplicant(3977): SIOCGIWRANGE:
WE(compiled)=22 WE(source)=13 enc_capa=0xf
NetworkManager: <information> wpa_supplicant(3977): capabilities: key_mgmt
0xf enc 0xf
NetworkManager: <information> wpa_supplicant(3977): WEXT: Operstate:
linkmode=1, operstate=5
NetworkManager: <information> wpa_supplicant(3977): d
NetworkManager: <information> wpa_supplicant(3977): wpa_driver_wext_set_wpa
NetworkManager: <information> wpa_supplicant(3977): wpa_driver_wext_set_key:
alg=0 key_idx=0 set_tx=0 seq_len=0 key_len=0
NetworkManager: <information> wpa_supplicant(3977): wpa_driver_wext_set_key:
alg=0 key_idx=1 set_tx=0 seq_len=0 key_len=0
NetworkManager: <information> wpa_supplicant(3977): wpa_driver_wext_set_key:
alg=0 key_idx=2 set_tx=0 seq_len=0 key_len=0
NetworkManager: <information> wpa_supplicant(3977): wpa_driver_wext_set_key:
alg=0 key_idx=3 set_tx=0 seq_len=0 key_len=0
NetworkManager: <information> wpa_supplicant(3977):
wpa_driver_wext_set_countermeasures
NetworkManager: <information> wpa_supplicant(3977):
wpa_driver_wext_set_drop_unencrypted
NetworkManager: <information> wpa_supplicant(3977): RSN: flushing PMKID list
in the driver
NetworkManager: <information> wpa_supplicant(3977): Setting scan request: 0
sec 100000 usec
NetworkManager: <information> wpa_supplicant(3977): Added interface ath0
NetworkManager: <information> wpa_supplicant(3977): RTM_NEWLINK: operstate=0
ifi_flags=0x1003 ([UP])
NetworkManager: <information> wpa_supplicant(3977): Wireless event:
cmd=0x8b06 len=8
NetworkManager: <information> wpa_supplicant(3977): RX ctrl_iface -
hexdump_ascii(len=9):
NetworkManager: <information> wpa_supplicant(3977): 41 50 5f 53 43 41 4e
20 31 AP_SCAN 1
NetworkManager: <information> wpa_supplicant(3977): RX ctrl_iface -
hexdump_ascii(len=11):
NetworkManager: <information> wpa_supplicant(3977): 41 44 44 5f 4e 45 54
57 4f 52 4b ADD_NETWORK
NetworkManager: <information> wpa_supplicant(3977): CTRL_IFACE: ADD_NETWORK
NetworkManager: <information> wpa_supplicant(3977): RX ctrl_iface -
hexdump_ascii(len=27): [REMOVED]
NetworkManager: <information> wpa_supplicant(3977): CTRL_IFACE: SET_NETWORK
id=0 name='ssid'
NetworkManager: <information> wpa_supplicant(3977): CTRL_IFACE: value -
hexdump_ascii(len=8): [REMOVED]
NetworkManager: <information> wpa_supplicant(3977): ssid -
hexdump_ascii(len=4):
NetworkManager: <information> wpa_supplicant(3977): geoe
NetworkManager: <information> wpa_supplicant(3977): RX ctrl_iface -
hexdump_ascii(len=27): [REMOVED]
NetworkManager: <information> wpa_supplicant(3977): CTRL_IFACE: SET_NETWORK
id=0 name='key_mgmt'
NetworkManager: <information> wpa_supplicant(3977): CTRL_IFACE: value -
hexdump_ascii(len=4): [REMOVED]
NetworkManager: <information> wpa_supplicant(3977): key_mgmt: 0x4
NetworkManager: <information> wpa_supplicant(3977): RX ctrl_iface -
hexdump_ascii(len=49): [REMOVED]
NetworkManager: <information> wpa_supplicant(3977): CTRL_IFACE: SET_NETWORK
id=0 name='wep_key0'
NetworkManager: <information> wpa_supplicant(3977): CTRL_IFACE: value -
hexdump_ascii(len=26): [REMOVED]
NetworkManager: <information> wpa_supplicant(3977): wep_key0 -
hexdump(len=13): [REMOVED]
NetworkManager: <information> wpa_supplicant(3977): RX ctrl_iface -
hexdump_ascii(len=29): [REMOVED]
NetworkManager: <information> wpa_supplicant(3977): CTRL_IFACE: SET_NETWORK
id=0 name='wep_tx_keyidx'
NetworkManager: <information> wpa_supplicant(3977): CTRL_IFACE: value -
hexdump_ascii(len=1): [REMOVED]
NetworkManager: <information> wpa_supplicant(3977): wep_tx_keyidx=0 (0x0)
NetworkManager: <information> wpa_supplicant(3977): RX ctrl_iface -
hexdump_ascii(len=16):
NetworkManager: <information> wpa_supplicant(3977): 45 4e 41 42 4c 45 5f
4e 45 54 57 4f 52 4b 20 30 ENABLE_NETWORK 0
NetworkManager: <information> wpa_supplicant(3977): CTRL_IFACE:
ENABLE_NETWORK id=0
NetworkManager: <information> wpa_supplicant(3977): Setting scan request: 0
sec 0 usec
NetworkManager: <information> wpa_supplicant(3977): State: DISCONNECTED ->
SCANNING
NetworkManager: <information> wpa_supplicant(3977): Starting AP scan
(broadcast SSID)
NetworkManager: <information> wpa_supplicant(3977): Trying to get current
scan results first without requesting a new scan to speed up initial association
NetworkManager: <information> wpa_supplicant(3977): Received 123 bytes of
scan results (1 BSSes)
NetworkManager: <information> wpa_supplicant(3977): Scan results: 1
NetworkManager: <information> wpa_supplicant(3977): Selecting BSS from
priority group 0
NetworkManager: <information> wpa_supplicant(3977): a_ie_len=0 rsn_ie_len=0
caps=0x11
NetworkManager: <information> wpa_supplicant(3977): skip - no WPA/RSN IE
NetworkManager: <information> wpa_supplicant(3977): selected non-WPA AP
00:14:bf:47:f3:40 ssid='geoe'
NetworkManager: <information> wpa_supplicant(3977): Trying to associate with
00:14:bf:47:f3:40 (SSID='geoe' freq=2437 MHz)
NetworkManager: <information> wpa_supplicant(3977): Cancelling scan request
NetworkManager: <information> wpa_supplicant(3977): WPA: clearing own WPA/RSN
IE
NetworkManager: <information> wpa_supplicant(3977): Automatic auth_alg
selection: 0x1
NetworkManager: <information> wpa_supplicant(3977): WPA: clearing AP WPA IE
NetworkManager: <information> wpa_supplicant(3977): WPA: clearing AP RSN IE
NetworkManager: <information> wpa_supplicant(3977): WPA: clearing own WPA/RSN
IE
NetworkManager: <information> wpa_supplicant(3977): No keys have been
configured - skip key clearing
NetworkManager: <information> wpa_supplicant(3977): wpa_driver_wext_set_key:
alg=1 key_idx=0 set_tx=1 seq_len=0 key_len=13
NetworkManager: <information> wpa_supplicant(3977):
wpa_driver_wext_set_drop_unencrypted
NetworkManager: <information> wpa_supplicant(3977): State: SCANNING ->
ASSOCIATING
NetworkManager: <information> wpa_supplicant(3977):
wpa_driver_wext_set_operstate: operstate 0->0 (DORMANT)
NetworkManager: <information> wpa_supplicant(3977): WEXT: Operstate:
linkmode=-1, operstate=5
NetworkManager: <information> wpa_supplicant(3977): wpa_driver_wext_associate
NetworkManager: <information> wpa_supplicant(3977): Setting authentication
timeout: 10 sec 0 usec
NetworkManager: <information> wpa_supplicant(3977): EAPOL: External
notification - portControl=ForceAuthorized
NetworkManager: <information> wpa_supplicant(3977): RTM_NEWLINK: operstate=0
ifi_flags=0x1003 ([UP])
NetworkManager: <information> wpa_supplicant(3977): Wireless event:
cmd=0x8b06 len=8
NetworkManager: <information> wpa_supplicant(3977): RTM_NEWLINK: operstate=0
ifi_flags=0x1003 ([UP])
NetworkManager: <information> wpa_supplicant(3977): Wireless event:
cmd=0x8b04 len=12
NetworkManager: <information> wpa_supplicant(3977): RTM_NEWLINK: operstate=0
ifi_flags=0x1003 ([UP])
NetworkManager: <information> wpa_supplicant(3977): Wireless event:
cmd=0x8b1a len=12
NetworkManager: <information> wpa_supplicant(3977): onitor attached -
hexdump(len=40): 2f 76 61 72 2f 72 75 6e 2f 4e 65 74 77 6f 72 6b 4d 61 6e 61 67
65 72 2f 77 70 61 5f 63 74 72 6c 5f 33 39 35 31 2d 32 00
NetworkManager: <information> wpa_supplicant(3977): RTM_NEWLINK: operstate=0
ifi_flags=0x1003 ([UP])
NetworkManager: <information> wpa_supplicant(3977): Wireless event:
cmd=0x8b19 len=8
NetworkManager: <information> wpa_supplicant(3977): Received 123 bytes of
scan results (1 BSSes)
NetworkManager: <information> wpa_supplicant(3977): Scan results: 1
NetworkManager: <information> wpa_supplicant(3977): Selecting BSS from
priority group 0
NetworkManager: <information> wpa_supplicant(3977): 0: 00:14:bf:47:f3:40
ssid='geoe' wpa_ie_len=0 rsn_ie_len=0 caps=0x11
NetworkManager: <information> wpa_supplicant(3977): skip - no WPA/RSN IE
NetworkManager: <information> wpa_supplicant(3977): selected non-WPA AP
00:14:bf:47:f3:40 ssid='geoe'
NetworkManager: <information> wpa_supplicant(3977): Already associated with
the selected AP.
NetworkManager: <information> wpa_supplicant(3977): RTM_NEWLINK: operstate=0
ifi_flags=0x11003 ([UP][LOWER_UP])
NetworkManager: <information> wpa_supplicant(3977): Wireless event:
cmd=0x8b15 len=20
NetworkManager: <information> wpa_supplicant(3977): Wireless event: new AP:
00:14:bf:47:f3:40
NetworkManager: <information> wpa_supplicant(3977): State: ASSOCIATING ->
ASSOCIATED
NetworkManager: <information> wpa_supplicant(3977):
wpa_driver_wext_set_operstate: operstate 0->0 (DORMANT)
NetworkManager: <information> wpa_supplicant(3977): WEXT: Operstate:
linkmode=-1, operstate=5
NetworkManager: <information> wpa_supplicant(3977): Associated to a new BSS:
BSSID=00:14:bf:47:f3:40
NetworkManager: <information> wpa_supplicant(3977): Associated with
00:14:bf:47:f3:40
NetworkManager: <information> Activation (ath0/wireless) Stage 2 of 5 (Device
Configure) successful. Connected to access point 'geoe'.
NetworkManager: <information> Activation (ath0) Stage 3 of 5 (IP Configure
Start) scheduled.
NetworkManager: <information> Activation (ath0) Stage 3 of 5 (IP Configure
Start) started...
NetworkManager: <information> Activation (ath0) Beginning DHCP transaction.
NetworkManager: <information> Activation (ath0) Stage 3 of 5 (IP Configure
Start) complete.
NetworkManager: <information> DHCP daemon state is now 12 (successfully
started) for interface ath0
NetworkManager: <information> DHCP daemon state is now 1 (starting) for
interface ath0
NetworkManager: <information> Device 'ath0' DHCP transaction took too long
(>45s), stopping it.
NetworkManager: <information> Activation (ath0) Stage 4 of 5 (IP Configure
Timeout) scheduled...
NetworkManager: <information> DHCP daemon state is now 14 (normal exit) for
interface ath0
NetworkManager: <information> DHCP daemon state is now 11 (unknown) for
interface ath0
NetworkManager: <information> DHCP daemon state is now 14 (normal exit) for
interface ath0
NetworkManager: <information> Activation (ath0) Stage 4 of 5 (IP Configure
Timeout) started...
NetworkManager: <debug info> [1181867974.556951]
real_act_stage4_ip_config_timeout (): Activation (ath0/wireless): could not get
IP configuration info for 'geoe', asking for new key.
NetworkManager: <information> Activation (ath0) New wireless user key
requested for network 'geoe'.
NetworkManager: <information> Activation (ath0) Stage 4 of 5 (IP Configure
Timeout) complete.
