Attachment 310865 Details for Bug 453864 – wpa_supplicant debugging logfile from kernel-2.6.25.9-76.i686 (BROKEN)

wpa_supplicant debugging logfile from kernel-2.6.25.9-76.i686 (BROKEN)

wlan-error-startup.log (text/plain), 11.67 KB, created by Stefan Becker on 2008-07-02 22:40:18 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Stefan Becker

Created: 2008-07-02 22:40:18 UTC

Size: 11.67 KB

patch

obsolete

>Initializing interface 'wlan0' conf '/home/stefanb/laptop/wlan/wpa_supplicant.conf' driver 'default' ctrl_interface 'N/A' bridge 'N/A'
>Configuration file '/home/stefanb/laptop/wlan/wpa_supplicant.conf' -> '/home/stefanb/laptop/wlan/wpa_supplicant.conf'
>Reading configuration file '/home/stefanb/laptop/wlan/wpa_supplicant.conf'
>ap_scan=1
>Line: 2 - start of a new network block
>ssid - hexdump_ascii(len=6):
>     [REMOVED]                                 [REMOVED]          
>scan_ssid=1 (0x1)
>proto: 0x1
>key_mgmt: 0x2
>pairwise: 0x8
>group: 0x8
>PSK - hexdump(len=32): [REMOVED]
>Priority group 0
>   id=0 ssid='[REMOVED]'
>Initializing interface (2) 'wlan0'
>Interface wlan0 set UP - waiting a second for the driver to complete initialization
>SIOCGIWRANGE: WE(compiled)=22 WE(source)=21 enc_capa=0xf
>  capabilities: key_mgmt 0xf enc 0xf
>WEXT: Operstate: linkmode=1, operstate=5
>Own MAC address: 00:18:de:23:ac:d9
>wpa_driver_wext_set_wpa
>wpa_driver_wext_set_key: alg=0 key_idx=0 set_tx=0 seq_len=0 key_len=0
>wpa_driver_wext_set_keyioctl[SIOCSIWAUTH]: Operation not supported
>WEXT auth param 4 value 0x0 - : alg=0 key_idx=1 set_tx=0 seq_len=0 key_len=0
>wpa_driver_wext_set_key: alg=0 key_idx=2 set_tx=0 seq_len=0 key_len=0
>wpa_driver_wext_set_key: alg=0 key_idx=3 set_tx=0 seq_len=0 key_len=0
>wpa_driver_wext_set_countermeasures
>wpa_driver_wext_set_drop_unencrypted
>RSN: flushing PMKID list in the driver
>Setting scan request: 0 sec 100000 usec
>EAPOL: SUPP_PAE entering state DISCONNECTED
>EAPOL: KEY_RX entering state NO_KEY_RECEIVE
>EAPOL: SUPP_BE entering state INITIALIZE
>EAP: EAP entering state DISABLED
>Added interface wlan0
>RTM_NEWLINK: operstate=0 ifi_flags=0x1002 ()
>Wireless event: cmd=0x8b19 len=8
>Received 0 bytes of scan results (0 BSSes)
>CTRL-EVENT-SCAN-RESULTS 
>Selecting BSS from priority group 0
>Try to find WPA-enabled AP
>Try to find non-WPA AP
>No suitable AP found.
>Not rescheduling scan to ensure that specific SSID scans occur
>Ignore event for foreign ifindex 3
>RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
>RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
>RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
>Wireless event: cmd=0x8b06 len=8
>State: DISCONNECTED -> SCANNING
>Starting AP scan (specific SSID)
>Scan SSID - hexdump_ascii(len=6):
>     [REMOVED]                                 [REMOVED]          
>Trying to get current scan results first without requesting a new scan to speed up initial association
>Received 0 bytes of scan results (0 BSSes)
>CTRL-EVENT-SCAN-RESULTS 
>Selecting BSS from priority group 0
>Try to find WPA-enabled AP
>Try to find non-WPA AP
>No suitable AP found.
>Setting scan request: 0 sec 0 usec
>Starting AP scan (broadcast SSID)
>Scan requested (ret=0) - scan timeout 30 seconds
>EAPOL: disable timer tick
>Scan timeout - try to get results
>Received 0 bytes of scan results (0 BSSes)
>CTRL-EVENT-SCAN-RESULTS 
>Selecting BSS from priority group 0
>Try to find WPA-enabled AP
>Try to find non-WPA AP
>No suitable AP found.
>Setting scan request: 5 sec 0 usec
>Starting AP scan (specific SSID)
>Scan SSID - hexdump_ascii(len=6):
>     [REMOVED]                                 [REMOVED]          
>Scan requested (ret=0) - scan timeout 30 seconds
>RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
>Wireless event: cmd=0x8b19 len=8
>Received 250 bytes of scan results (1 BSSes)
>CTRL-EVENT-SCAN-RESULTS 
>Selecting BSS from priority group 0
>Try to find WPA-enabled AP
>0: 00:0f:cc:4e:c7:f4 ssid='[REMOVED]' wpa_ie_len=22 rsn_ie_len=0 caps=0x11
>   selected based on WPA IE
>   selected WPA AP 00:0f:cc:4e:c7:f4 ssid='[REMOVED]'
>Try to find non-WPA AP
>Trying to associate with 00:0f:cc:4e:c7:f4 (SSID='[REMOVED]' freq=2437 MHz)
>Cancelling scan request
>WPA: clearing own WPA/RSN IE
>Automatic auth_alg selection: 0x1
>WPA: using IEEE 802.11i/D3.0
>WPA: Selected cipher suites: group 8 pairwise 8 key_mgmt 2 proto 1
>WPA: set AP WPA IE - hexdump(len=24): dd 16 00 50 f2 01 01 00 00 50 f2 02 01 00 00 50 f2 02 01 00 00 50 f2 02
>WPA: clearing AP RSN IE
>WPA: using GTK TKIP
>WPA: using PTK TKIP
>WPA: using KEY_MGMT WPA-PSK
>WPA: Set own WPA IE default - hexdump(len=24): dd 16 00 50 f2 01 01 00 00 50 f2 02 01 00 00 50 f2 02 01 00 00 50 f2 02
>No keys have been configured - skip key clearing
>wpa_driver_wext_set_drop_unencrypted
>State: SCANNING -> ASSOCIATING
>wpa_driver_wext_set_operstate: operstate 0->0 (DORMANT)
>WEXT: Operstate: linkmode=-1, operstate=5
>wpa_driver_wext_associate
>Setting authentication timeout: 20 sec 0 usec
>EAPOL: External notification - EAP success=0
>EAPOL: External notification - EAP fail=0
>EAPOL: External notification - portControl=Auto
>RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
>Wireless event: cmd=0x8b06 len=8
>RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
>Wireless event: cmd=0x8b04 len=12
>RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP])
>Wireless event: cmd=0x8c02 len=163
>WEXT: Custom wireless event: 'ASSOCINFO(ReqIEs=00064d6f72646f72010802040b160c12182432043048606cdd160050f20101000050f20201000050f20201000050f202 RespIEs=010882848b960c12182432043048606c)'
>Association info event
>req_ies - hexdump(len=48): 00 06 [REMOVED] 01 08 02 04 0b 16 0c 12 18 24 32 04 30 48 60 6c dd 16 00 50 f2 01 01 00 00 50 f2 02 01 00 00 50 f2 02 01 00 00 50 f2 02
>resp_ies - hexdump(len=16): 01 08 82 84 8b 96 0c 12 18 24 32 04 30 48 60 6c
>WPA: set own WPA/RSN IE - hexdump(len=24): dd 16 00 50 f2 01 01 00 00 50 f2 02 01 00 00 50 f2 02 01 00 00 50 f2 02
>RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP])
>Wireless event: cmd=0x8b15 len=20
>Wireless event: new AP: 00:0f:cc:4e:c7:f4
>State: ASSOCIATING -> ASSOCIATED
>wpa_driver_wext_set_operstate: operstate 0->0 (DORMANT)
>WEXT: Operstate: linkmode=-1, operstate=5
>Associated to a new BSS: BSSID=00:0f:cc:4e:c7:f4
>No keys have been configured - skip key clearing
>Associated with 00:0f:cc:4e:c7:f4
>WPA: Association event - clear replay counter
>EAPOL: External notification - portEnabled=0
>EAPOL: External notification - portValid=0
>EAPOL: External notification - EAP success=0
>EAPOL: External notification - portEnabled=1
>EAPOL: SUPP_PAE entering state CONNECTING
>EAPOL: enable timer tick
>EAPOL: SUPP_BE entering state IDLE
>Setting authentication timeout: 10 sec 0 usec
>Cancelling scan request
>RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP])
>RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
>RX EAPOL from 00:0f:cc:4e:c7:f4
>RX EAPOL - hexdump(len=99): 01 03 00 5f fe 00 89 00 20 00 00 00 00 00 00 00 01 26 3b e0 98 ef 72 61 4c 7f 55 8c ff 92 2e c4 9c 5a 6b 64 ef 93 d7 50 1e 1e e7 b5 05 50 da c8 10 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
>Setting authentication timeout: 10 sec 0 usec
>IEEE 802.1X RX: version=1 type=3 length=95
>  EAPOL-Key type=254
>  key_info 0x89 (ver=1 keyidx=0 rsvd=0 Pairwise Ack)
>  key_length=32 key_data_length=0
>  replay_counter - hexdump(len=8): 00 00 00 00 00 00 00 01
>  key_nonce - hexdump(len=32): 26 3b e0 98 ef 72 61 4c 7f 55 8c ff 92 2e c4 9c 5a 6b 64 ef 93 d7 50 1e 1e e7 b5 05 50 da c8 10
>  key_iv - hexdump(len=16): 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
>  key_rsc - hexdump(len=8): 00 00 00 00 00 00 00 00
>  key_id (reserved) - hexdump(len=8): 00 00 00 00 00 00 00 00
>  key_mic - hexdump(len=16): 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
>WPA: RX EAPOL-Key - hexdump(len=99): 01 03 00 5f fe 00 89 00 20 00 00 00 00 00 00 00 01 26 3b e0 98 ef 72 61 4c 7f 55 8c ff 92 2e c4 9c 5a 6b 64 ef 93 d7 50 1e 1e e7 b5 05 50 da c8 10 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
>State: ASSOCIATED -> 4WAY_HANDSHAKE
>WPA: RX message 1 of 4-Way Handshake from 00:0f:cc:4e:c7:f4 (ver=1)
>WPA: Renewed SNonce - hexdump(len=32): 6c 8d 50 89 a2 de 6c 3d 7a e8 a9 69 a7 74 55 99 62 9b 0d d6 03 80 5a 7d 25 18 bd 38 be a2 9f f3
>WPA: PTK derivation - A1=00:18:de:23:ac:d9 A2=00:0f:cc:4e:c7:f4
>WPA: PMK - hexdump(len=32): [REMOVED]
>WPA: PTK - hexdump(len=64): [REMOVED]
>WPA: WPA IE for msg 2/4 - hexdump(len=24): dd 16 00 50 f2 01 01 00 00 50 f2 02 01 00 00 50 f2 02 01 00 00 50 f2 02
>WPA: Sending EAPOL-Key 2/4
>WPA: TX EAPOL-Key - hexdump(len=123): 01 03 00 77 fe 01 09 00 20 00 00 00 00 00 00 00 01 6c 8d 50 89 a2 de 6c 3d 7a e8 a9 69 a7 74 55 99 62 9b 0d d6 03 80 5a 7d 25 18 bd 38 be a2 9f f3 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 69 e1 b4 ce 39 47 ac b8 84 79 e1 aa 9d 73 5f b3 00 18 dd 16 00 50 f2 01 01 00 00 50 f2 02 01 00 00 50 f2 02 01 00 00 50 f2 02
>RX EAPOL from 00:0f:cc:4e:c7:f4
>RX EAPOL - hexdump(len=123): 01 03 00 77 fe 01 c9 00 20 00 00 00 00 00 00 00 02 26 3b e0 98 ef 72 61 4c 7f 55 8c ff 92 2e c4 9c 5a 6b 64 ef 93 d7 50 1e 1e e7 b5 05 50 da c8 10 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 0a 53 d1 4e 98 5f 28 56 2d 9c 93 07 f3 a8 3f 56 00 18 dd 16 00 50 f2 01 01 00 00 50 f2 02 01 00 00 50 f2 02 01 00 00 50 f2 02
>IEEE 802.1X RX: version=1 type=3 length=119
>  EAPOL-Key type=254
>  key_info 0x1c9 (ver=1 keyidx=0 rsvd=0 Pairwise Install Ack MIC)
>  key_length=32 key_data_length=24
>  replay_counter - hexdump(len=8): 00 00 00 00 00 00 00 02
>  key_nonce - hexdump(len=32): 26 3b e0 98 ef 72 61 4c 7f 55 8c ff 92 2e c4 9c 5a 6b 64 ef 93 d7 50 1e 1e e7 b5 05 50 da c8 10
>  key_iv - hexdump(len=16): 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
>  key_rsc - hexdump(len=8): 00 00 00 00 00 00 00 00
>  key_id (reserved) - hexdump(len=8): 00 00 00 00 00 00 00 00
>  key_mic - hexdump(len=16): 0a 53 d1 4e 98 5f 28 56 2d 9c 93 07 f3 a8 3f 56
>WPA: RX EAPOL-Key - hexdump(len=123): 01 03 00 77 fe 01 c9 00 20 00 00 00 00 00 00 00 02 26 3b e0 98 ef 72 61 4c 7f 55 8c ff 92 2e c4 9c 5a 6b 64 ef 93 d7 50 1e 1e e7 b5 05 50 da c8 10 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 0a 53 d1 4e 98 5f 28 56 2d 9c 93 07 f3 a8 3f 56 00 18 dd 16 00 50 f2 01 01 00 00 50 f2 02 01 00 00 50 f2 02 01 00 00 50 f2 02
>State: 4WAY_HANDSHAKE -> 4WAY_HANDSHAKE
>WPA: RX message 3 of 4-Way Handshake from 00:0f:cc:4e:c7:f4 (ver=1)
>WPA: IE KeyData - hexdump(len=24): dd 16 00 50 f2 01 01 00 00 50 f2 02 01 00 00 50 f2 02 01 00 00 50 f2 02
>WPA: Sending EAPOL-Key 4/4
>WPA: TX EAPOL-Key - hexdump(len=99): 01 03 00 5f fe 01 09 00 20 00 00 00 00 00 00 00 02 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 be 77 dd c4 a1 ea c8 fe 87 31 4e f2 4b 2d d6 02 00 00
>WPA: Installing PTK to the driver.
>WPA: RSC - hexdump(len=6): 00 00 00 00 00 00
>wpa_driver_wext_set_key: alg=2 key_idx=0 set_tx=1 seq_len=6 key_len=32
>State: 4WAY_HANDSHAKE -> GROUP_HANDSHAKE
>EAPOL: startWhen --> 0
>EAPOL: disable timer tick
>EAPOL: SUPP_PAE entering state CONNECTING
>EAPOL: enable timer tick
>EAPOL: txStart
>WPA: drop TX EAPOL in non-IEEE 802.1X mode (type=1 len=0)
>RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
>Wireless event: cmd=0x8b15 len=20
>Wireless event: new AP: 00:00:00:00:00:00
>Setting scan request: 0 sec 100000 usec
>Added BSSID 00:0f:cc:4e:c7:f4 into blacklist
>CTRL-EVENT-DISCONNECTED - Disconnect event - remove keys
>wpa_driver_wext_set_key: alg=0 key_idx=0 set_tx=0 seq_len=0 key_len=0
>wpa_driver_wext_set_key: alg=0 key_idx=1 set_tx=0 seq_len=0 key_len=0
>wpa_driver_wext_set_key: alg=0 key_idx=2 set_tx=0 seq_len=0 key_len=0
>wpa_driver_wext_set_key: alg=0 key_idx=3 set_tx=0 seq_len=0 key_len=0
>wpa_driver_wext_set_key: alg=0 key_idx=0 set_tx=0 seq_len=0 key_len=0
>State: GROUP_HANDSHAKE -> DISCONNECTED
>wpa_driver_wext_set_operstate: operstate 0->0 (DORMANT)
>WEXT: Operstate: linkmode=-1, operstate=5
>EAPOL: External notification - portEnabled=0
>EAPOL: SUPP_PAE entering state DISCONNECTED
>EAPOL: SUPP_BE entering state INITIALIZE
>EAPOL: External notification - portValid=0
>EAPOL: External notification - EAP success=0

Actions: View

Attachments on bug 453864: 310863 | 310865