[Pkg-utopia-maintainers] Bug#427999: nm output

Carlos Moffat carlos.lst at eldiabloenlosdetalles.net
Fri Jun 15 00:53:21 UTC 2007


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

-------------- next part --------------
 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.




More information about the Pkg-utopia-maintainers mailing list