1340701261.063765: wpa_supplicant v1.0 1340701261.064695: random: Trying to read entropy from /dev/random 1340701261.065055: Initializing interface 'wlan' conf 'N/A' driver 'wext' ctrl_interface '/var/run/wpa_supplicant' bridge 'N/A' 1340701261.070782: rfkill: Cannot open RFKILL control device 1340701261.071233: WEXT: RFKILL status not available 1340701261.089347: SIOCGIWRANGE: WE(compiled)=22 WE(source)=13 enc_capa=0x0 1340701261.089541: capabilities: key_mgmt 0x0 enc 0x3 flags 0x0 1340701261.092943: WEXT: Failed to set bogus SSID to disconnect 1340701261.146467: netlink: Operstate: linkmode=1, operstate=5 1340701261.147625: wlan: Own MAC address: 00:12:cf:8f:19:1e 1340701261.147782: wpa_driver_wext_set_key: alg=0 key_idx=0 set_tx=0 seq_len=0 key_len=0 1340701261.148474: Driver did not support SIOCSIWENCODEEXT, trying SIOCSIWENCODE 1340701261.148752: wpa_driver_wext_set_key: alg=0 key_idx=1 set_tx=0 seq_len=0 key_len=0 1340701261.149491: Driver did not support SIOCSIWENCODEEXT, trying SIOCSIWENCODE 1340701261.149756: wpa_driver_wext_set_key: alg=0 key_idx=2 set_tx=0 seq_len=0 key_len=0 1340701261.150510: Driver did not support SIOCSIWENCODEEXT, trying SIOCSIWENCODE 1340701261.150779: wpa_driver_wext_set_key: alg=0 key_idx=3 set_tx=0 seq_len=0 key_len=0 1340701261.152832: Driver did not support SIOCSIWENCODEEXT, trying SIOCSIWENCODE 1340701261.153203: wpa_driver_wext_set_key: alg=0 key_idx=4 set_tx=0 seq_len=0 key_len=0 1340701261.153974: Driver did not support SIOCSIWENCODEEXT 1340701261.154124: wpa_driver_wext_set_key: alg=0 key_idx=5 set_tx=0 seq_len=0 key_len=0 1340701261.157804: Driver did not support SIOCSIWENCODEEXT 1340701261.157976: wpa_driver_wext_set_countermeasures 1340701261.158447: wlan: RSN: flushing PMKID list in the driver 1340701261.158750: wlan: State: DISCONNECTED -> INACTIVE 1340701261.159065: WPS: Set UUID for interface wlan 1340701261.192951: WPS: UUID based on MAC address - hexdump(len=16): e2 ba 5e 89 ae 96 54 f8 bd cc 84 63 db a5 ca 02 1340701261.389039: EAPOL: SUPP_PAE entering state DISCONNECTED 1340701261.389288: EAPOL: Supplicant port status: Unauthorized 1340701261.389421: EAPOL: KEY_RX entering state NO_KEY_RECEIVE 1340701261.389457: EAPOL: SUPP_BE entering state INITIALIZE 1340701261.389491: EAP: EAP entering state DISABLED 1340701261.389561: EAPOL: Supplicant port status: Unauthorized 1340701261.389646: EAPOL: Supplicant port status: Unauthorized 1340701261.390678: wlan: Added interface wlan 1340701261.391107: Daemonize.. 1340701261.406705: random: Got 17/20 bytes from /dev/random 1340701261.407312: RTM_NEWLINK: operstate=0 ifi_flags=0x11043 ([UP][RUNNING][LOWER_UP]) 1340701261.407669: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan' added 1340701261.408155: WEXT: if_removed already cleared - ignore event 1340701261.408347: RTM_NEWLINK: operstate=0 ifi_flags=0x11043 ([UP][RUNNING][LOWER_UP]) 1340701261.408502: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan' added 1340701261.408696: WEXT: if_removed already cleared - ignore event 1340701261.408892: Wireless event: cmd=0x8b06 len=8 1340701261.409086: RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP]) 1340701261.409234: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan' added 1340701261.409461: WEXT: if_removed already cleared - ignore event 1340701261.409636: RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP]) 1340701261.409785: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan' added 1340701261.409993: WEXT: if_removed already cleared - ignore event 1340701261.410122: Wireless event: cmd=0x8b2a len=8 1340701261.410197: RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP]) 1340701261.410342: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan' added 1340701261.410551: WEXT: if_removed already cleared - ignore event 1340701261.410679: Wireless event: cmd=0x8b2a len=8 1340701261.410750: RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP]) 1340701261.423538: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan' added 1340701261.423841: WEXT: if_removed already cleared - ignore event 1340701261.423971: Wireless event: cmd=0x8b2a len=8 1340701261.424056: RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP]) 1340701261.424274: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan' added 1340701261.424538: WEXT: if_removed already cleared - ignore event 1340701261.424665: Wireless event: cmd=0x8b2a len=8 1340701262.391177: EAPOL: disable timer tick 1340701262.391437: EAPOL: Supplicant port status: Unauthorized 1340701265.580107: RX ctrl_iface - hexdump_ascii(len=11): 41 44 44 5f 4e 45 54 57 4f 52 4b ADD_NETWORK 1340701265.581517: CTRL_IFACE: ADD_NETWORK 1340701269.724313: RX ctrl_iface - hexdump_ascii(len=51): [REMOVED] 1340701269.724767: CTRL_IFACE: SET_NETWORK id=0 name='ssid' 1340701269.724919: CTRL_IFACE: value - hexdump_ascii(len=32): [REMOVED] 1340701269.725156: ssid - hexdump_ascii(len=30): 53 6f 6e 65 72 61 47 61 74 65 77 61 79 30 30 2d SoneraGateway00- 32 36 2d 34 34 2d 41 31 2d 34 35 2d 41 39 26-44-A1-45-A9 1340701273.875222: RX ctrl_iface - hexdump_ascii(len=28): [REMOVED] 1340701273.875467: CTRL_IFACE: SET_NETWORK id=0 name='psk' 1340701273.875599: CTRL_IFACE: value - hexdump_ascii(len=10): [REMOVED] 1340701273.875711: PSK (ASCII passphrase) - hexdump_ascii(len=8): [REMOVED] 1340701274.225281: PSK (from passphrase) - hexdump(len=32): [REMOVED] 1340701278.373350: RX ctrl_iface - hexdump_ascii(len=16): 45 4e 41 42 4c 45 5f 4e 45 54 57 4f 52 4b 20 30 ENABLE_NETWORK 0 1340701278.373672: CTRL_IFACE: ENABLE_NETWORK id=0 1340701278.374015: wlan: Setting scan request: 0 sec 0 usec 1340701278.374743: wlan: State: INACTIVE -> SCANNING 1340701278.375033: wlan: Starting AP scan for wildcard SSID 1340701281.321321: Scan requested (ret=0) - scan timeout 10 seconds 1340701284.119029: random: Got 3/3 bytes from /dev/random 1340701291.329762: Scan timeout - try to get results 1340701291.330083: wlan: Event SCAN_RESULTS (3) received 1340701291.331650: Received 2783 bytes of scan results (11 BSSes) 1340701291.332102: Sorted scan results 1340701291.332245: 00:26:44:a1:45:a9 freq=2437 qual=25 noise=-95 level=-70 flags=0x0 1340701291.332388: 00:1e:69:36:5f:11 freq=2462 qual=20 noise=-95 level=-75 flags=0x0 1340701291.332485: 00:18:e7:d1:76:1e freq=2452 qual=13 noise=-95 level=-82 flags=0x0 1340701291.332522: 00:24:01:6b:94:33 freq=2412 qual=10 noise=-95 level=-85 flags=0x0 1340701291.332557: 00:26:24:79:10:eb freq=2462 qual=10 noise=-95 level=-85 flags=0x0 1340701291.332606: 00:18:84:13:4f:e2 freq=2422 qual=8 noise=-95 level=-87 flags=0x0 1340701291.332643: 68:7f:74:1b:ce:f8 freq=2437 qual=7 noise=-95 level=-88 flags=0x0 1340701291.332677: 40:4a:03:b3:00:f8 freq=2427 qual=0 noise=-95 level=-95 flags=0x0 1340701291.332712: 00:26:24:1c:b7:25 freq=2452 qual=0 noise=-95 level=-95 flags=0x0 1340701291.332746: 00:90:4b:85:31:5d freq=2412 qual=4 noise=-95 level=-91 flags=0x0 1340701291.332781: 00:18:84:13:4f:e1 freq=2422 qual=6 noise=-95 level=-89 flags=0x0 1340701291.332911: wlan: BSS: Start scan result update 1 1340701291.333168: wlan: BSS: Add new id 0 BSSID 00:26:44:a1:45:a9 SSID 'SoneraGateway00-26-44-A1-45-A9' 1340701291.333495: wlan: BSS: Add new id 1 BSSID 00:1e:69:36:5f:11 SSID 'Merton' 1340701291.333740: wlan: BSS: Add new id 2 BSSID 00:18:e7:d1:76:1e SSID 'pn' 1340701291.333976: wlan: BSS: Add new id 3 BSSID 00:24:01:6b:94:33 SSID 'lowball' 1340701291.334213: wlan: BSS: Add new id 4 BSSID 00:26:24:79:10:eb SSID 'Thom_D0049633' 1340701291.334454: wlan: BSS: Add new id 5 BSSID 00:18:84:13:4f:e2 SSID 'LapinVerkko' 1340701291.334694: wlan: BSS: Add new id 6 BSSID 68:7f:74:1b:ce:f8 SSID 'piipin' 1340701291.334932: wlan: BSS: Add new id 7 BSSID 40:4a:03:b3:00:f8 SSID 'Elisa873' 1340701291.335172: wlan: BSS: Add new id 8 BSSID 00:26:24:1c:b7:25 SSID 'E3_14C' 1340701291.335405: wlan: BSS: Add new id 9 BSSID 00:90:4b:85:31:5d SSID 'Piku' 1340701291.335640: wlan: BSS: Add new id 10 BSSID 00:18:84:13:4f:e1 SSID 'FON_Lapin' 1340701291.335829: Add randomness: count=1 entropy=0 1340701291.335936: random pool - hexdump(len=128): [REMOVED] 1340701291.335988: random_mix_pool - hexdump(len=8): [REMOVED] 1340701291.336045: random_mix_pool - hexdump(len=5): [REMOVED] 1340701291.336159: random pool - hexdump(len=128): [REMOVED] 1340701291.336257: Add randomness: count=2 entropy=1 1340701291.336326: random pool - hexdump(len=128): [REMOVED] 1340701291.336396: random_mix_pool - hexdump(len=8): [REMOVED] 1340701291.336442: random_mix_pool - hexdump(len=5): [REMOVED] 1340701291.336491: random pool - hexdump(len=128): [REMOVED] 1340701291.336533: Add randomness: count=3 entropy=2 1340701291.336591: random pool - hexdump(len=128): [REMOVED] 1340701291.336645: random_mix_pool - hexdump(len=8): [REMOVED] 1340701291.336687: random_mix_pool - hexdump(len=5): [REMOVED] 1340701291.336729: random pool - hexdump(len=128): [REMOVED] 1340701291.336783: Add randomness: count=4 entropy=3 1340701291.336849: random pool - hexdump(len=128): [REMOVED] 1340701291.336908: random_mix_pool - hexdump(len=8): [REMOVED] 1340701291.336947: random_mix_pool - hexdump(len=5): [REMOVED] 1340701291.336996: random pool - hexdump(len=128): [REMOVED] 1340701291.337032: Add randomness: count=5 entropy=4 1340701291.337088: random pool - hexdump(len=128): [REMOVED] 1340701291.337148: random_mix_pool - hexdump(len=8): [REMOVED] 1340701291.337202: random_mix_pool - hexdump(len=5): [REMOVED] 1340701291.337237: random pool - hexdump(len=128): [REMOVED] 1340701291.337289: Add randomness: count=6 entropy=5 1340701291.337343: random pool - hexdump(len=128): [REMOVED] 1340701291.337401: random_mix_pool - hexdump(len=8): [REMOVED] 1340701291.337454: random_mix_pool - hexdump(len=5): [REMOVED] 1340701291.337508: random pool - hexdump(len=128): [REMOVED] 1340701291.337543: Add randomness: count=7 entropy=6 1340701291.337599: random pool - hexdump(len=128): [REMOVED] 1340701291.337658: random_mix_pool - hexdump(len=8): [REMOVED] 1340701291.337713: random_mix_pool - hexdump(len=5): [REMOVED] 1340701291.337756: random pool - hexdump(len=128): [REMOVED] 1340701291.337804: Add randomness: count=8 entropy=7 1340701291.337861: random pool - hexdump(len=128): [REMOVED] 1340701291.337922: random_mix_pool - hexdump(len=8): [REMOVED] 1340701291.337970: random_mix_pool - hexdump(len=5): [REMOVED] 1340701291.338015: random pool - hexdump(len=128): [REMOVED] 1340701291.338051: Add randomness: count=9 entropy=8 1340701291.338105: random pool - hexdump(len=128): [REMOVED] 1340701291.338161: random_mix_pool - hexdump(len=8): [REMOVED] 1340701291.338210: random_mix_pool - hexdump(len=5): [REMOVED] 1340701291.338250: random pool - hexdump(len=128): [REMOVED] 1340701291.338298: Add randomness: count=10 entropy=9 1340701291.338356: random pool - hexdump(len=128): [REMOVED] 1340701291.338418: random_mix_pool - hexdump(len=8): [REMOVED] 1340701291.338458: random_mix_pool - hexdump(len=5): [REMOVED] 1340701291.338502: random pool - hexdump(len=128): [REMOVED] 1340701291.338579: wlan: New scan results available 1340701291.338895: wlan: Selecting BSS from priority group 0 1340701291.339124: wlan: 0: 00:26:44:a1:45:a9 ssid='SoneraGateway00-26-44-A1-45-A9' wpa_ie_len=22 rsn_ie_len=20 caps=0x11 level=-70 1340701291.339377: wlan: selected based on RSN IE 1340701291.339886: wlan: selected BSS 00:26:44:a1:45:a9 ssid='SoneraGateway00-26-44-A1-45-A9' 1340701291.340174: wlan: Request association: reassociate: 1 selected: 00:26:44:a1:45:a9 bssid: 00:00:00:00:00:00 pending: 00:00:00:00:00:00 wpa_state: SCANNING 1340701291.340464: wlan: Trying to associate with 00:26:44:a1:45:a9 (SSID='SoneraGateway00-26-44-A1-45-A9' freq=2437 MHz) 1340701291.340685: FT: Stored MDIE and FTIE from (Re)Association Response - hexdump(len=0): 1340701291.340875: wlan: Cancelling scan request 1340701291.341092: wlan: WPA: clearing own WPA/RSN IE 1340701291.341266: wlan: Automatic auth_alg selection: 0x1 1340701291.341446: wlan: RSN: using IEEE 802.11i/D9.0 1340701291.341627: wlan: WPA: Selected cipher suites: group 8 pairwise 16 key_mgmt 2 proto 2 1340701291.341744: 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 1340701291.341906: 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 02 0c 00 1340701291.342204: wlan: WPA: using GTK TKIP 1340701291.342364: wlan: WPA: using PTK CCMP 1340701291.342521: wlan: WPA: using KEY_MGMT WPA-PSK 1340701291.342689: wlan: WPA: not using MGMT group cipher 1340701291.342813: WPA: Set own WPA IE default - hexdump(len=22): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 02 00 00 1340701291.343085: wlan: No keys have been configured - skip key clearing 1340701291.343252: wlan: State: SCANNING -> ASSOCIATING 1340701291.343385: wpa_driver_wext_set_operstate: operstate 0->0 (DORMANT) 1340701291.343446: netlink: Operstate: linkmode=-1, operstate=5 1340701291.343736: wpa_driver_wext_associate 1340701291.343894: wpa_driver_wext_set_drop_unencrypted 1340701291.344241: wpa_driver_wext_set_psk 1340701291.345309: wlan: Association request to the driver failed 1340701291.345535: wlan: Setting authentication timeout: 5 sec 0 usec 1340701291.345749: EAPOL: External notification - EAP success=0 1340701291.345889: EAPOL: Supplicant port status: Unauthorized 1340701291.345937: EAPOL: External notification - EAP fail=0 1340701291.346041: EAPOL: Supplicant port status: Unauthorized 1340701291.346095: EAPOL: External notification - portControl=Auto 1340701291.346212: EAPOL: Supplicant port status: Unauthorized 1340701291.346307: RSN: Ignored PMKID candidate without preauth flag 1340701291.346613: RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP]) 1340701291.346779: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan' added 1340701291.347058: WEXT: if_removed already cleared - ignore event 1340701291.347219: Wireless event: cmd=0x8b06 len=8 1340701291.347316: RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP]) 1340701291.347457: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan' added 1340701291.347666: WEXT: if_removed already cleared - ignore event 1340701291.347794: Wireless event: cmd=0x8b04 len=12 1340701291.347882: RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP]) 1340701291.348025: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan' added 1340701291.348230: WEXT: if_removed already cleared - ignore event 1340701291.348357: Wireless event: cmd=0x8b1a len=38 1340701291.410632: RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP]) 1340701291.410827: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan' added 1340701291.411111: WEXT: if_removed already cleared - ignore event 1340701291.411241: Wireless event: cmd=0x8c02 len=61 1340701291.411307: WEXT: Custom wireless event: 'BEACONIE=30140100000fac020100000fac040100000fac020c00' 1340701291.411491: RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP]) 1340701291.411633: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan' added 1340701291.411841: WEXT: if_removed already cleared - ignore event 1340701291.411969: Wireless event: cmd=0x8c02 len=126 1340701291.412025: WEXT: Custom wireless event: 'ASSOCRESPIE=010882848b962430486c32040c121860dd09001018020000050000dd180050f2020101080003a4000027a4000042435e0062322f00' 1340701291.412206: RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP]) 1340701291.412355: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan' added 1340701291.412571: WEXT: if_removed already cleared - ignore event 1340701291.412700: Wireless event: cmd=0x8c02 len=183 1340701291.412766: WEXT: Custom wireless event: 'ASSOCINFO(ReqIEs=001e536f6e6572614761746577617930302d32362d34342d41312d34352d4139010882848b0c1296182432043048606c30140100000fac020100000fac040100000fac020000dd070050f202000100' 1340701291.413221: wlan: Event ASSOCINFO (4) received 1340701291.413428: wlan: Association info event 1340701291.413552: req_ies - hexdump(len=79): 00 1e 53 6f 6e 65 72 61 47 61 74 65 77 61 79 30 30 2d 32 36 2d 34 34 2d 41 31 2d 34 35 2d 41 39 01 08 82 84 8b 0c 12 96 18 24 32 04 30 48 60 6c 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 02 00 00 dd 07 00 50 f2 02 00 01 00 1340701291.413863: WPA: set own WPA/RSN IE - hexdump(len=22): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 02 00 00 1340701291.414073: FT: Stored MDIE and FTIE from (Re)Association Response - hexdump(len=0): 1340701291.414245: RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP]) 1340701291.414464: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan' added 1340701291.414785: WEXT: if_removed already cleared - ignore event 1340701291.414922: Wireless event: cmd=0x8b15 len=20 1340701291.414979: Wireless event: new AP: 00:26:44:a1:45:a9 1340701291.415146: wlan: Event ASSOC (0) received 1340701291.415334: wlan: State: ASSOCIATING -> ASSOCIATED 1340701291.415466: wpa_driver_wext_set_operstate: operstate 0->0 (DORMANT) 1340701291.415518: netlink: Operstate: linkmode=-1, operstate=5 1340701291.415830: wlan: Associated to a new BSS: BSSID=00:26:44:a1:45:a9 1340701291.415955: Add randomness: count=11 entropy=10 1340701291.416001: random pool - hexdump(len=128): [REMOVED] 1340701291.416073: random_mix_pool - hexdump(len=8): [REMOVED] 1340701291.416138: random_mix_pool - hexdump(len=6): [REMOVED] 1340701291.416184: random pool - hexdump(len=128): [REMOVED] 1340701291.416264: wlan: No keys have been configured - skip key clearing 1340701291.416462: wlan: Associated with 00:26:44:a1:45:a9 1340701291.416690: wlan: WPA: Association event - clear replay counter 1340701291.416872: wlan: WPA: Clear old PTK 1340701291.416997: EAPOL: External notification - portEnabled=0 1340701291.417042: EAPOL: Supplicant port status: Unauthorized 1340701291.417135: EAPOL: External notification - portValid=0 1340701291.417217: EAPOL: Supplicant port status: Unauthorized 1340701291.417321: EAPOL: External notification - EAP success=0 1340701291.417374: EAPOL: Supplicant port status: Unauthorized 1340701291.417457: EAPOL: External notification - portEnabled=1 1340701291.417532: EAPOL: SUPP_PAE entering state CONNECTING 1340701291.417599: EAPOL: enable timer tick 1340701291.417669: EAPOL: SUPP_BE entering state IDLE 1340701291.417822: wlan: Setting authentication timeout: 10 sec 0 usec 1340701291.418005: wlan: Cancelling scan request 1340701291.450318: wlan: RX EAPOL from 00:26:44:a1:45:a9 1340701291.450471: RX EAPOL - hexdump(len=99): 02 03 00 5f 02 00 8a 00 10 00 00 00 00 00 00 00 01 38 5d b7 12 00 a1 fd 93 85 05 93 14 69 b8 d9 60 8b df 1c fd e4 17 c1 c6 38 e9 53 5c 4f 61 8f 3f 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 1340701291.450936: wlan: Setting authentication timeout: 10 sec 0 usec 1340701291.451205: wlan: IEEE 802.1X RX: version=2 type=3 length=95 1340701291.451369: wlan: EAPOL-Key type=2 1340701291.451549: wlan: key_info 0x8a (ver=2 keyidx=0 rsvd=0 Pairwise Ack) 1340701291.451721: wlan: key_length=16 key_data_length=0 1340701291.451837: replay_counter - hexdump(len=8): 00 00 00 00 00 00 00 01 1340701291.451916: key_nonce - hexdump(len=32): 38 5d b7 12 00 a1 fd 93 85 05 93 14 69 b8 d9 60 8b df 1c fd e4 17 c1 c6 38 e9 53 5c 4f 61 8f 3f 1340701291.452078: key_iv - hexdump(len=16): 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 1340701291.452157: key_rsc - hexdump(len=8): 00 00 00 00 00 00 00 00 1340701291.452205: key_id (reserved) - hexdump(len=8): 00 00 00 00 00 00 00 00 1340701291.452262: key_mic - hexdump(len=16): 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 1340701291.452362: WPA: RX EAPOL-Key - hexdump(len=99): 02 03 00 5f 02 00 8a 00 10 00 00 00 00 00 00 00 01 38 5d b7 12 00 a1 fd 93 85 05 93 14 69 b8 d9 60 8b df 1c fd e4 17 c1 c6 38 e9 53 5c 4f 61 8f 3f 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 1340701291.452950: wlan: State: ASSOCIATED -> 4WAY_HANDSHAKE 1340701291.453160: wlan: WPA: RX message 1 of 4-Way Handshake from 00:26:44:a1:45:a9 (ver=2) 1340701291.453279: RSN: msg 1/4 key data - hexdump(len=0): 1340701291.453337: Get randomness: len=32 entropy=11 1340701291.465158: random from os_get_random - hexdump(len=32): [REMOVED] 1340701291.465539: random_mix_pool - hexdump(len=20): [REMOVED] 1340701291.465830: random from internal pool - hexdump(len=16): [REMOVED] 1340701291.466126: random_mix_pool - hexdump(len=20): [REMOVED] 1340701291.466412: random from internal pool - hexdump(len=16): [REMOVED] 1340701291.466615: mixed random - hexdump(len=32): [REMOVED] 1340701291.466737: WPA: Renewed SNonce - hexdump(len=32): c1 03 f3 09 f6 9f 5b 4f 4b 9d bd c8 53 ea 69 43 ee e8 ed 02 a0 db d8 f3 d8 34 ee de 5e a0 78 45 1340701291.467146: WPA: PTK derivation - A1=00:12:cf:8f:19:1e A2=00:26:44:a1:45:a9 1340701291.467368: WPA: Nonce1 - hexdump(len=32): c1 03 f3 09 f6 9f 5b 4f 4b 9d bd c8 53 ea 69 43 ee e8 ed 02 a0 db d8 f3 d8 34 ee de 5e a0 78 45 1340701291.467534: WPA: Nonce2 - hexdump(len=32): 38 5d b7 12 00 a1 fd 93 85 05 93 14 69 b8 d9 60 8b df 1c fd e4 17 c1 c6 38 e9 53 5c 4f 61 8f 3f 1340701291.467664: WPA: PMK - hexdump(len=32): [REMOVED] 1340701291.467692: WPA: PTK - hexdump(len=48): [REMOVED] 1340701291.467728: WPA: WPA IE for msg 2/4 - hexdump(len=22): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 02 00 00 1340701291.467898: WPA: Replay Counter - hexdump(len=8): 00 00 00 00 00 00 00 01 1340701291.468078: wlan: WPA: Sending EAPOL-Key 2/4 1340701291.468434: WPA: KCK - hexdump(len=16): [REMOVED] 1340701291.468566: WPA: Derived Key MIC - hexdump(len=16): 19 43 6b 3c 8f e1 0c 75 e0 86 d4 74 e3 2a 33 80 1340701291.468660: WPA: TX EAPOL-Key - hexdump(len=121): 01 03 00 75 02 01 0a 00 00 00 00 00 00 00 00 00 01 c1 03 f3 09 f6 9f 5b 4f 4b 9d bd c8 53 ea 69 43 ee e8 ed 02 a0 db d8 f3 d8 34 ee de 5e a0 78 45 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 19 43 6b 3c 8f e1 0c 75 e0 86 d4 74 e3 2a 33 80 00 16 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 02 00 00 1340701291.550137: wlan: RX EAPOL from 00:26:44:a1:45:a9 1340701291.550296: RX EAPOL - hexdump(len=195): 02 03 00 bf 02 13 ca 00 10 00 00 00 00 00 00 00 02 38 5d b7 12 00 a1 fd 93 85 05 93 14 69 b8 d9 60 8b df 1c fd e4 17 c1 c6 38 e9 53 5c 4f 61 8f 3f 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 1c 00 00 00 00 00 00 00 00 c0 0c 7c 6a cd 5e 4e ff 13 f8 69 12 81 82 5c 99 00 60 a9 7b 3a 31 ba c7 ea 51 2a c6 cd 09 dc 6b f7 67 73 8f 12 6c 2d 18 94 f6 97 f0 90 8a 0d 4a 59 ef 6b de 94 1f 47 05 03 56 23 d9 7f ca 94 18 3f 99 f3 6d d6 26 32 0d c0 de c8 2f f0 f3 9b cc ae a9 59 4c 29 00 89 22 08 5e d8 ec e1 b2 4e a4 d7 56 34 ac f4 71 9f 64 f0 7c 76 b3 7f d1 3e 74 bd 8e 1340701291.551085: wlan: IEEE 802.1X RX: version=2 type=3 length=191 1340701291.551224: wlan: EAPOL-Key type=2 1340701291.551426: wlan: key_info 0x13ca (ver=2 keyidx=0 rsvd=0 Pairwise Install Ack MIC Secure Encr) 1340701291.551594: wlan: key_length=16 key_data_length=96 1340701291.551710: replay_counter - hexdump(len=8): 00 00 00 00 00 00 00 02 1340701291.551786: key_nonce - hexdump(len=32): 38 5d b7 12 00 a1 fd 93 85 05 93 14 69 b8 d9 60 8b df 1c fd e4 17 c1 c6 38 e9 53 5c 4f 61 8f 3f 1340701291.551951: key_iv - hexdump(len=16): 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 1340701291.552028: key_rsc - hexdump(len=8): 00 00 00 00 00 00 00 1c 1340701291.552078: key_id (reserved) - hexdump(len=8): 00 00 00 00 00 00 00 00 1340701291.552138: key_mic - hexdump(len=16): c0 0c 7c 6a cd 5e 4e ff 13 f8 69 12 81 82 5c 99 1340701291.552230: WPA: RX EAPOL-Key - hexdump(len=195): 02 03 00 bf 02 13 ca 00 10 00 00 00 00 00 00 00 02 38 5d b7 12 00 a1 fd 93 85 05 93 14 69 b8 d9 60 8b df 1c fd e4 17 c1 c6 38 e9 53 5c 4f 61 8f 3f 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 1c 00 00 00 00 00 00 00 00 c0 0c 7c 6a cd 5e 4e ff 13 f8 69 12 81 82 5c 99 00 60 a9 7b 3a 31 ba c7 ea 51 2a c6 cd 09 dc 6b f7 67 73 8f 12 6c 2d 18 94 f6 97 f0 90 8a 0d 4a 59 ef 6b de 94 1f 47 05 03 56 23 d9 7f ca 94 18 3f 99 f3 6d d6 26 32 0d c0 de c8 2f f0 f3 9b cc ae a9 59 4c 29 00 89 22 08 5e d8 ec e1 b2 4e a4 d7 56 34 ac f4 71 9f 64 f0 7c 76 b3 7f d1 3e 74 bd 8e 1340701291.553138: RSN: encrypted key data - hexdump(len=96): a9 7b 3a 31 ba c7 ea 51 2a c6 cd 09 dc 6b f7 67 73 8f 12 6c 2d 18 94 f6 97 f0 90 8a 0d 4a 59 ef 6b de 94 1f 47 05 03 56 23 d9 7f ca 94 18 3f 99 f3 6d d6 26 32 0d c0 de c8 2f f0 f3 9b cc ae a9 59 4c 29 00 89 22 08 5e d8 ec e1 b2 4e a4 d7 56 34 ac f4 71 9f 64 f0 7c 76 b3 7f d1 3e 74 bd 8e 1340701291.557266: WPA: decrypted EAPOL-Key key data - hexdump(len=88): [REMOVED] 1340701291.557516: wlan: State: 4WAY_HANDSHAKE -> 4WAY_HANDSHAKE 1340701291.557735: wlan: WPA: RX message 3 of 4-Way Handshake from 00:26:44:a1:45:a9 (ver=2) 1340701291.557853: WPA: IE KeyData - hexdump(len=88): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 02 0c 00 dd 16 00 50 f2 01 01 00 00 50 f2 02 01 00 00 50 f2 02 01 00 00 50 f2 02 dd 26 00 0f ac 01 02 00 13 c3 25 f9 8f b1 07 24 99 de 7f 35 c7 30 38 a4 69 a0 64 4d c0 14 09 70 8f 53 19 9a 38 52 67 b1 dd 00 1340701291.558197: WPA: RSN IE in EAPOL-Key - hexdump(len=22): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 02 0c 00 1340701291.558364: WPA: WPA IE in EAPOL-Key - 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 1340701291.558503: WPA: GTK in EAPOL-Key - hexdump(len=40): [REMOVED] 1340701291.558645: wlan: WPA: Sending EAPOL-Key 4/4 1340701291.558954: WPA: KCK - hexdump(len=16): [REMOVED] 1340701291.559094: WPA: Derived Key MIC - hexdump(len=16): c5 59 ca bf aa f2 c3 ab 6e d1 b1 ca ee 1d 6c a8 1340701291.559184: WPA: TX EAPOL-Key - hexdump(len=99): 01 03 00 5f 02 03 0a 00 00 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 c5 59 ca bf aa f2 c3 ab 6e d1 b1 ca ee 1d 6c a8 00 00 1340701291.560408: wlan: WPA: Installing PTK to the driver 1340701291.560575: wpa_driver_wext_set_key: alg=3 key_idx=0 set_tx=1 seq_len=6 key_len=16 1340701291.561145: EAPOL: External notification - portValid=1 1340701291.561381: wlan: State: 4WAY_HANDSHAKE -> GROUP_HANDSHAKE 1340701291.561531: RSN: received GTK in pairwise handshake - hexdump(len=34): [REMOVED] 1340701291.561631: WPA: Group Key - hexdump(len=32): [REMOVED] 1340701291.561782: wlan: WPA: Installing GTK to the driver (keyidx=2 tx=0 len=32) 1340701291.561912: WPA: RSC - hexdump(len=6): 00 00 00 00 00 00 1340701291.561999: wpa_driver_wext_set_key: alg=2 key_idx=2 set_tx=0 seq_len=6 key_len=32 1340701291.562604: wlan: WPA: Key negotiation completed with 00:26:44:a1:45:a9 [PTK=CCMP GTK=TKIP] 1340701291.562807: wlan: Cancelling authentication timeout 1340701291.562999: wlan: State: GROUP_HANDSHAKE -> COMPLETED 1340701291.563200: wlan: CTRL-EVENT-CONNECTED - Connection to 00:26:44:a1:45:a9 completed (auth) [id=0 id_str=] 1340701291.563318: wpa_driver_wext_set_operstate: operstate 0->1 (UP) 1340701291.563496: netlink: Operstate: linkmode=-1, operstate=6 1340701291.563964: EAPOL: External notification - portValid=1 1340701291.564161: EAPOL: External notification - EAP success=1 1340701291.564239: EAPOL: SUPP_PAE entering state AUTHENTICATING 1340701291.564299: EAPOL: SUPP_BE entering state SUCCESS 1340701291.564354: EAP: EAP entering state DISABLED 1340701291.564433: EAPOL: SUPP_PAE entering state AUTHENTICATED 1340701291.564502: EAPOL: Supplicant port status: Authorized 1340701291.564561: EAPOL: SUPP_BE entering state IDLE 1340701291.564649: EAPOL authentication completed successfully 1340701291.564968: RTM_NEWLINK: operstate=1 ifi_flags=0x11043 ([UP][RUNNING][LOWER_UP]) 1340701291.565131: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan' added 1340701291.565415: WEXT: if_removed already cleared - ignore event 1340701292.419662: EAPOL: startWhen --> 0 1340701292.419831: EAPOL: disable timer tick