Attachment 310863 Details for Bug 453864 – wpa_supplicant debugging logfile from kernel-2.6.25.9-72.fc9.i686 (OK)

wpa_supplicant debugging logfile from kernel-2.6.25.9-72.fc9.i686 (OK)

wlan-ok-startup.log (text/plain), 13.89 KB, created by Stefan Becker on 2008-07-02 22:36:16 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Stefan Becker

Created: 2008-07-02 22:36:16 UTC

Size: 13.89 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
>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 500 bytes of scan results (2 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=0x1003 ([UP])
>Wireless event: cmd=0x8b1a len=14
>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 44 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 44
>  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 44 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): 5b 1a ad 60 b0 a1 bc df 8c 15 66 e0 1f d1 6d 80 ce 6e 22 99 c9 e3 5a 4d 4f 99 83 41 d4 3f b3 da
>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 5b 1a ad 60 b0 a1 bc df 8c 15 66 e0 1f d1 6d 80 ce 6e 22 99 c9 e3 5a 4d 4f 99 83 41 d4 3f b3 da 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 bc 61 3c 7d 77 03 67 e3 49 f1 4c b6 07 eb 5d e3 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 44 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 d5 4d 29 25 2a 43 b9 79 44 70 59 c6 a7 d8 bc 01 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 44
>  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): d5 4d 29 25 2a 43 b9 79 44 70 59 c6 a7 d8 bc 01
>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 44 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 d5 4d 29 25 2a 43 b9 79 44 70 59 c6 a7 d8 bc 01 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 13 15 a6 4e 5b 42 47 a4 e8 06 3f 8a f7 7d fb 5f 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
>RX EAPOL from 00:0f:cc:4e:c7:f4
>RX EAPOL - hexdump(len=131): 01 03 00 7f fe 03 91 00 20 00 00 00 00 00 00 00 03 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 2b 5a 6b 64 ef 93 d7 50 1e 1e e7 b5 05 50 da c8 45 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 84 66 0e 0e f3 42 0d c6 ff 36 f8 3c 3d 3e 7a 42 00 20 59 8e 9d d2 39 53 f6 6d 19 e3 85 a1 93 4d 84 7a f0 35 0a b2 c8 74 f3 16 f3 7d 21 bb eb 81 17 00
>IEEE 802.1X RX: version=1 type=3 length=127
>  EAPOL-Key type=254
>  key_info 0x391 (ver=1 keyidx=1 rsvd=0 Group Ack MIC Secure)
>  key_length=32 key_data_length=32
>  replay_counter - hexdump(len=8): 00 00 00 00 00 00 00 03
>  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 2b
>  key_iv - hexdump(len=16): 5a 6b 64 ef 93 d7 50 1e 1e e7 b5 05 50 da c8 45
>  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): 84 66 0e 0e f3 42 0d c6 ff 36 f8 3c 3d 3e 7a 42
>WPA: RX EAPOL-Key - hexdump(len=131): 01 03 00 7f fe 03 91 00 20 00 00 00 00 00 00 00 03 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 2b 5a 6b 64 ef 93 d7 50 1e 1e e7 b5 05 50 da c8 45 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 84 66 0e 0e f3 42 0d c6 ff 36 f8 3c 3d 3e 7a 42 00 20 59 8e 9d d2 39 53 f6 6d 19 e3 85 a1 93 4d 84 7a f0 35 0a b2 c8 74 f3 16 f3 7d 21 bb eb 81 17 00
>WPA: RX message 1 of Group Key Handshake from 00:0f:cc:4e:c7:f4 (ver=1)
>State: GROUP_HANDSHAKE -> GROUP_HANDSHAKE
>WPA: Group Key - hexdump(len=32): [REMOVED]
>WPA: Installing GTK to the driver (keyidx=1 tx=0 len=32).
>WPA: RSC - hexdump(len=6): 00 00 00 00 00 00
>wpa_driver_wext_set_key: alg=2 key_idx=1 set_tx=0 seq_len=6 key_len=32
>WPA: Sending EAPOL-Key 2/2
>WPA: TX EAPOL-Key - hexdump(len=99): 01 03 00 5f fe 03 11 00 20 00 00 00 00 00 00 00 03 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 31 b2 77 a5 6c af ef 02 da a3 f5 93 70 d0 5e 57 00 00
>WPA: Key negotiation completed with 00:0f:cc:4e:c7:f4 [PTK=TKIP GTK=TKIP]
>Cancelling scan request
>Cancelling authentication timeout
>State: GROUP_HANDSHAKE -> COMPLETED
>CTRL-EVENT-CONNECTED - Connection to 00:0f:cc:4e:c7:f4 completed (auth) [id=0 id_str=]
>wpa_driver_wext_set_operstate: operstate 0->1 (UP)
>WEXT: Operstate: linkmode=-1, operstate=6
>EAPOL: External notification - portValid=1
>EAPOL: External notification - EAP success=1
>EAPOL: SUPP_PAE entering state AUTHENTICATING
>EAPOL: SUPP_BE entering state SUCCESS
>EAP: EAP entering state DISABLED
>EAPOL: SUPP_PAE entering state AUTHENTICATED
>EAPOL: SUPP_BE entering state IDLE
>EAPOL authentication completed successfully
>RTM_NEWLINK: operstate=1 ifi_flags=0x11043 ([UP][RUNNING][LOWER_UP])
>RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan0' added
>EAPOL: startWhen --> 0
>EAPOL: disable timer tick

Actions: View

Attachments on bug 453864: 310863 | 310865