Attachment 155701 Details for Bug 241777 – Debug Output

Debug Output

WpaSupplicantOutput (text/plain), 16.34 KB, created by Roland Wolters on 2007-05-30 15:02:43 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Roland Wolters

Created: 2007-05-30 15:02:43 UTC

Size: 16.34 KB

patch

obsolete

>#wpa__supplicant -ddw -c /etc/wpa_supplicant/wpa_supplicant.conf -ieth1 -Dwext
>
>Initializing interface 'eth1' conf '/etc/wpa_supplicant/wpa_supplicant.conf' driver 'wext' ctrl_interface 'N/A' bridge 'N/A'
>Configuration file '/etc/wpa_supplicant/wpa_supplicant.conf' -> '/etc/wpa_supplicant/wpa_supplicant.conf'
>Reading configuration file '/etc/wpa_supplicant/wpa_supplicant.conf'
>ctrl_interface='/var/run/wpa_supplicant'
>ctrl_interface_group='wheel' (DEPRECATED)
>Line: 4 - start of a new network block
>ssid - hexdump_ascii(len=6):
>     38 30 32 2e 31 58                                 802.1X          
>proto: 0x1
>key_mgmt: 0x1
>pairwise: 0x8
>group: 0x8
>eap methods - hexdump(len=16): 00 00 00 00 15 00 00 00 00 00 00 00 00 00 00 00
>anonymous_identity - hexdump_ascii(len=21):
>     61 6e 6f 6e 79 6d 6f 75 73 40 75 6e 69 2d 6a 65   anonymous@uni-je     6e 61 2e 64 65                                    na.de           
>identity - hexdump_ascii(len=18):
>     70 31 77 6f 72 6f 40 75 6e 69 2d 6a 65 6e 61 2e   p1woro@uni-jena.     64 65                                             de              
>password - hexdump_ascii(len=8): [REMOVED]
>
>ca_cert - hexdump_ascii(len=19):
>     2f 65 74 63 2f 63 65 72 74 2f 63 61 63 65 72 74   /etc/cert/cacert     2e 70 6d                                          .pm             
>phase2 - hexdump_ascii(len=8):
>     61 75 74 68 3d 50 41 50                           auth=PAP        
>priority=1 (0x1)
>Priority group 1
>   id=0 ssid='802.1X'
>Initializing interface (2) 'eth1'
>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
>EAPOL: External notification - portEnabled=0
>EAPOL: External notification - portValid=0
>SIOCGIWRANGE: WE(compiled)=22 WE(source)=18 enc_capa=0xf
>  capabilities: key_mgmt 0xf enc 0xf
>WEXT: Operstate: linkmode=1, operstate=5
>Own MAC address: 00:0e:35:68:17:93
>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_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_countermeasures
>wpa_driver_wext_set_drop_unencrypted
>Setting scan request: 0 sec 100000 usec
>ctrl_interface_group=10 (from group name 'wheel')
>Added interface eth1
>RTM_NEWLINK: operstate=0 ifi_flags=0x1002 ()
>Wireless event: cmd=0x8b06 len=8
>RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
>RTM_NEWLINK, IFLA_IFNAME: Interface 'eth1' added
>RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
>RTM_NEWLINK, IFLA_IFNAME: Interface 'eth1' added
>State: DISCONNECTED -> SCANNING
>Starting AP scan (broadcast SSID)
>Trying to get current scan results first without requesting a new scan to speed up initial association
>Received 3222 bytes of scan results (11 BSSes)
>Scan results: 11
>Selecting BSS from priority group 1
>0: 00:12:da:9e:58:a1 ssid='vlan20.uni-jena.de' wpa_ie_len=26 rsn_ie_len=22 caps=0x11
>   skip - SSID mismatch
>1: 00:12:da:9e:58:a0 ssid='802.1X' wpa_ie_len=26 rsn_ie_len=22 caps=0x11
>   selected based on WPA IE
>Trying to associate with 00:12:da:9e:58:a0 (SSID='802.1X' 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 1 proto 1
>WPA: set AP WPA IE - hexdump(len=26): dd 18 00 50 f2 01 01 00 00 50 f2 02 01 00 00 50 f2 02 01 00 00 50 f2 01 28 00
>WPA: set AP RSN IE - hexdump(len=22): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 01 28 00
>WPA: using GTK TKIP
>WPA: using PTK TKIP
>WPA: using KEY_MGMT 802.1X
>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 01
>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: 15 sec 0 usec
>EAPOL: External notification - portControl=Auto
>RSN: Ignored PMKID candidate without preauth flag
>RSN: Ignored PMKID candidate without preauth flag
>RSN: Ignored PMKID candidate without preauth flag
>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=0x1003 ([UP])
>Wireless event: cmd=0x8b19 len=8
>Received 3220 bytes of scan results (11 BSSes)
>Scan results: 11
>Selecting BSS from priority group 1
>0: 00:12:da:9e:58:a1 ssid='vlan20.uni-jena.de' wpa_ie_len=26 rsn_ie_len=22 caps=0x11
>   skip - SSID mismatch
>1: 00:12:da:9e:58:a0 ssid='802.1X' wpa_ie_len=26 rsn_ie_len=22 caps=0x11
>   selected based on WPA IE
>Already associated with the selected AP.
>RSN: Ignored PMKID candidate without preauth flag
>RSN: Ignored PMKID candidate without preauth flag
>RSN: Ignored PMKID candidate without preauth flag
>RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP])
>Wireless event: cmd=0x8b15 len=20
>Wireless event: new AP: 00:12:da:9e:58:a0
>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:12:da:9e:58:a0
>No keys have been configured - skip key clearing
>Associated with 00:12:da:9e:58:a0
>WPA: Association event - clear replay counter
>EAPOL: External notification - portEnabled=0
>EAPOL: External notification - portValid=0
>EAPOL: External notification - portEnabled=1
>EAPOL: SUPP_PAE entering state CONNECTING
>EAPOL: SUPP_BE entering state IDLE
>EAP: EAP entering state INITIALIZE
>EAP: EAP 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 'eth1' added
>RX EAPOL from 00:12:da:9e:58:a0
>RX EAPOL - hexdump(len=55): 01 00 00 33 01 01 00 33 01 00 6e 65 74 77 6f 72 6b 69 64 3d 38 30 32 2e 31 58 2c 6e 61 73 69 64 3d 66 73 75 6a 2d 61 70 31 32 30 30 2d 32 2c 70 6f 72 74 69 64 3d 30
>Setting authentication timeout: 70 sec 0 usec
>EAPOL: Received EAP-Packet frame
>EAPOL: SUPP_PAE entering state RESTART
>EAP: EAP entering state INITIALIZE
>EAP: EAP entering state IDLE
>EAPOL: SUPP_PAE entering state AUTHENTICATING
>EAPOL: SUPP_BE entering state REQUEST
>EAPOL: getSuppRsp
>EAP: EAP entering state RECEIVED
>EAP: Received EAP-Request id=1 method=1 vendor=0 vendorMethod=0
>EAP: EAP entering state IDENTITY
>CTRL-EVENT-EAP-STARTED EAP authentication started
>EAP: EAP-Request Identity data - hexdump_ascii(len=46):
>     00 6e 65 74 77 6f 72 6b 69 64 3d 38 30 32 2e 31   _networkid=802.1     58 2c 6e 61 73 69 64 3d 66 73 75 6a 2d 61 70 31   X,nasid=fsuj-ap1     32 30 30 2d 32 2c 70 6f 72 74 69 64 3d 30         200-2,portid=0  
>EAP: using anonymous identity - hexdump_ascii(len=21):
>     61 6e 6f 6e 79 6d 6f 75 73 40 75 6e 69 2d 6a 65   anonymous@uni-je     6e 61 2e 64 65                                    na.de           
>EAP: EAP entering state SEND_RESPONSE
>EAP: EAP entering state IDLE
>EAPOL: SUPP_BE entering state RESPONSE
>EAPOL: txSuppRsp
>TX EAPOL - hexdump(len=30): 01 00 00 1a 02 01 00 1a 01 61 6e 6f 6e 79 6d 6f 75 73 40 75 6e 69 2d 6a 65 6e 61 2e 64 65
>EAPOL: SUPP_BE entering state RECEIVE
>RX EAPOL from 00:12:da:9e:58:a0
>RX EAPOL - hexdump(len=46): 01 00 00 06 01 02 00 06 15 20 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
>EAPOL: Received EAP-Packet frame
>EAPOL: SUPP_BE entering state REQUEST
>EAPOL: getSuppRsp
>EAP: EAP entering state RECEIVED
>EAP: Received EAP-Request id=2 method=21 vendor=0 vendorMethod=0
>EAP: EAP entering state GET_METHOD
>EAP: Initialize selected EAP method: vendor 0 method 21 (TTLS)
>EAP-TTLS: Phase2 type: PAP
>CTRL-EVENT-EAP-METHOD EAP vendor 0 method 21 (TTLS) selected
>EAP: EAP entering state METHOD
>SSL: Received packet(len=6) - Flags 0x20
>EAP-TTLS: Start (server ver=0, own ver=0)
>EAP-TTLS: Using TTLS version 0
>OpenSSL: tls_connection_ca_cert - Failed to load root certificates error:02001002:system library:fopen:No such file or directory
>OpenSSL: pending error: error:2006D080:BIO routines:BIO_new_file:no such file
>OpenSSL: pending error: error:0B084002:x509 certificate routines:X509_load_cert_crl_file:system lib
>OpenSSL: tls_load_ca_der - Failed load CA in DER format error:02001002:system library:fopen:No such file or directory
>OpenSSL: pending error: error:20074002:BIO routines:FILE_CTRL:system lib
>OpenSSL: pending error: error:0B06F002:x509 certificate routines:X509_load_cert_file:system lib
>TLS: Failed to set TLS connection parameters
>EAP-TTLS: Failed to initialize SSL.
>EAP: method process -> ignore=FALSE methodState=MAY_CONT decision=FAIL
>EAP: EAP entering state SEND_RESPONSE
>EAP: EAP entering state IDLE
>EAPOL: startWhen --> 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:12:da:9e:58:a0 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: ASSOCIATED -> 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
>EAP: EAP entering state DISABLED
>EAPOL: External notification - portValid=0
>RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
>RTM_NEWLINK, IFLA_IFNAME: Interface 'eth1' added
>RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
>Wireless event: cmd=0x8b15 len=20
>Wireless event: new AP: 00:00:00:00:00:00
>Added BSSID 00:00:00:00:00:00 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: DISCONNECTED -> DISCONNECTED
>wpa_driver_wext_set_operstate: operstate 0->0 (DORMANT)
>WEXT: Operstate: linkmode=-1, operstate=5
>EAPOL: External notification - portEnabled=0
>EAPOL: External notification - portValid=0
>State: DISCONNECTED -> SCANNING
>Starting AP scan (broadcast SSID)
>RTM_NEWLINK: operstate=0 ifi_flags=0x1003 ([UP])
>Wireless event: cmd=0x8b19 len=8
>Received 1173 bytes of scan results (4 BSSes)
>Scan results: 4
>Selecting BSS from priority group 1
>0: 00:12:da:9e:58:a1 ssid='vlan20.uni-jena.de' wpa_ie_len=26 rsn_ie_len=22 caps=0x11
>   skip - SSID mismatch
>1: 00:12:da:9e:58:a2 ssid='vlan25.uni-jena.de' wpa_ie_len=26 rsn_ie_len=22 caps=0x11
>   skip - SSID mismatch
>2: 00:12:da:9e:58:a0 ssid='802.1X' wpa_ie_len=26 rsn_ie_len=22 caps=0x11
>   selected based on WPA IE
>Trying to associate with 00:12:da:9e:58:a0 (SSID='802.1X' 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 1 proto 1
>WPA: set AP WPA IE - hexdump(len=26): dd 18 00 50 f2 01 01 00 00 50 f2 02 01 00 00 50 f2 02 01 00 00 50 f2 01 28 00
>WPA: set AP RSN IE - hexdump(len=22): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 01 28 00
>WPA: using GTK TKIP
>WPA: using PTK TKIP
>WPA: using KEY_MGMT 802.1X
>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 01
>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: 15 sec 0 usec
>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=0x8b15 len=20
>Wireless event: new AP: 00:12:da:9e:58:a0
>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:12:da:9e:58:a0
>No keys have been configured - skip key clearing
>Associated with 00:12:da:9e:58:a0
>WPA: Association event - clear replay counter
>EAPOL: External notification - portEnabled=0
>EAPOL: External notification - portValid=0
>EAPOL: External notification - portEnabled=1
>EAPOL: SUPP_PAE entering state CONNECTING
>EAPOL: SUPP_BE entering state IDLE
>EAP: EAP entering state INITIALIZE
>EAP: deinitialize previously used EAP method (21, TTLS) at INITIALIZE
>*** glibc detected *** wpa_supplicant: double free or corruption (!prev): 0x09327be0 ***
>======= Backtrace: =========
>/lib/libc.so.6[0x42303f41]
>/lib/libc.so.6(cfree+0x90)[0x42307580]
>wpa_supplicant[0x806390d]
>wpa_supplicant[0x8063f9c]
>wpa_supplicant[0x8064b52]
>wpa_supplicant[0x806267e]
>wpa_supplicant[0x807d930]
>wpa_supplicant[0x808500d]
>wpa_supplicant[0x804fb33]
>wpa_supplicant[0x804ffd6]
>wpa_supplicant[0x8078b98]
>wpa_supplicant[0x807ed65]
>/lib/libc.so.6(__libc_start_main+0xe0)[0x422b1f70]
>wpa_supplicant[0x804b9a1]
>======= Memory map: ========
>00499000-004a3000 r-xp 00000000 08:01 649001     /lib/libnss_files-2.6.so
>004a3000-004a4000 r-xp 00009000 08:01 649001     /lib/libnss_files-2.6.so
>004a4000-004a5000 rwxp 0000a000 08:01 649001     /lib/libnss_files-2.6.so
>00f47000-00f48000 r-xp 00f47000 00:00 0          [vdso]
>08048000-08099000 r-xp 00000000 08:01 694830     /usr/sbin/wpa_supplicant
>08099000-0809b000 rwxp 00051000 08:01 694830     /usr/sbin/wpa_supplicant
>0931d000-0933e000 rwxp 0931d000 00:00 0 
>4227d000-42298000 r-xp 00000000 08:01 651750     /lib/ld-2.6.so
>42298000-42299000 r-xp 0001a000 08:01 651750     /lib/ld-2.6.so
>42299000-4229a000 rwxp 0001b000 08:01 651750     /lib/ld-2.6.so
>4229c000-423ea000 r-xp 00000000 08:01 651751     /lib/libc-2.6.so
>423ea000-423ec000 r-xp 0014e000 08:01 651751     /lib/libc-2.6.so
>423ec000-423ed000 rwxp 00150000 08:01 651751     /lib/libc-2.6.so
>423ed000-423f0000 rwxp 423ed000 00:00 0 
>4241d000-42420000 r-xp 00000000 08:01 651752     /lib/libdl-2.6.so
>42420000-42421000 r-xp 00002000 08:01 651752     /lib/libdl-2.6.so
>42421000-42422000 rwxp 00003000 08:01 651752     /lib/libdl-2.6.so
>4243e000-42450000 r-xp 00000000 08:01 651756     /lib/libz.so.1.2.3
>42450000-42451000 rwxp 00011000 08:01 651756     /lib/libz.so.1.2.3
>426ca000-426cc000 r-xp 00000000 08:01 651764     /lib/libcap.so.1.10
>426cc000-426cd000 rwxp 00002000 08:01 651764     /lib/libcap.so.1.10
>4275b000-42795000 r-xp 00000000 08:01 651765     /lib/libdbus-1.so.3.2.0
>42795000-42796000 rwxp 00039000 08:01 651765     /lib/libdbus-1.so.3.2.0
>429e0000-429f0000 r-xp 00000000 08:01 651768     /lib/libresolv-2.6.so
>429f0000-429f1000 r-xp 0000f000 08:01 651768     /lib/libresolv-2.6.so
>429f1000-429f2000 rwxp 00010000 08:01 651768     /lib/libresolv-2.6.so
>429f2000-429f4000 rwxp 429f2000 00:00 0 
>42af7000-42c13000 r-xp 00000000 08:01 651770     /lib/libcrypto.so.0.9.8b
>42c13000-42c25000 rwxp 0011c000 08:01 651770     /lib/libcrypto.so.0.9.8b
>42c25000-42c29000 rwxp 42c25000 00:00 0 
>43083000-43085000 r-xp 00000000 08:01 651769     /lib/libcom_err.so.2.1
>43085000-43086000 rwxp 00001000 08:01 651769     /lib/libcom_err.so.2.1
>43125000-4314a000 r-xp 00000000 08:01 697417     /usr/lib/libk5crypto.so.3.1
>4314a000-4314b000 rwxp 00025000 08:01 697417     /usr/lib/libk5crypto.so.3.1
>4318b000-431b7000 r-xp 00000000 08:01 697419     /usr/lib/libgssapi_krb5.so.2.2
>431b7000-431b9000 rwxp 0002c000 08:01 697419     /usr/lib/libgssapi_krb5.so.2.2
>431bb000-431bd000 r-xp 00000000 08:01 651767     /lib/libkeyutils-1.2.so
>431bd000-431be000 rwxp 00001000 08:01 651767     /lib/libkeyutils-1.2.so
>431c0000-431c7000 r-xp 00000000 08:01 697416     /usr/lib/libkrb5support.so.0.1
>431c7000-431c8000 rwxp 00006000 08:01 697416     /usr/lib/libkrb5s
>Abgebrochen
>

Actions: View

Attachments on bug 241777: 155701 | 155822 | 155823