1340701836.974069: wpa_supplicant v1.0 1340701836.974939: random: Trying to read entropy from /dev/random 1340701836.975278: Initializing interface 'wlan' conf 'N/A' driver 'wext' ctrl_interface '/var/run/wpa_supplicant' bridge 'N/A' 1340701836.981249: rfkill: Cannot open RFKILL control device 1340701836.981423: WEXT: RFKILL status not available 1340701836.986392: SIOCGIWRANGE: WE(compiled)=22 WE(source)=13 enc_capa=0x0 1340701836.986579: capabilities: key_mgmt 0x0 enc 0x3 flags 0x0 1340701836.987712: WEXT: Failed to set bogus SSID to disconnect 1340701837.037671: netlink: Operstate: linkmode=1, operstate=5 1340701837.038937: wlan: Own MAC address: 00:12:cf:8f:19:1e 1340701837.039092: wpa_driver_wext_set_key: alg=0 key_idx=0 set_tx=0 seq_len=0 key_len=0 1340701837.047518: Driver did not support SIOCSIWENCODEEXT, trying SIOCSIWENCODE 1340701837.047826: wpa_driver_wext_set_key: alg=0 key_idx=1 set_tx=0 seq_len=0 key_len=0 1340701837.048572: Driver did not support SIOCSIWENCODEEXT, trying SIOCSIWENCODE 1340701837.048847: wpa_driver_wext_set_key: alg=0 key_idx=2 set_tx=0 seq_len=0 key_len=0 1340701837.049579: Driver did not support SIOCSIWENCODEEXT, trying SIOCSIWENCODE 1340701837.049859: wpa_driver_wext_set_key: alg=0 key_idx=3 set_tx=0 seq_len=0 key_len=0 1340701837.050587: Driver did not support SIOCSIWENCODEEXT, trying SIOCSIWENCODE 1340701837.050860: wpa_driver_wext_set_key: alg=0 key_idx=4 set_tx=0 seq_len=0 key_len=0 1340701837.051585: Driver did not support SIOCSIWENCODEEXT 1340701837.051744: wpa_driver_wext_set_key: alg=0 key_idx=5 set_tx=0 seq_len=0 key_len=0 1340701837.052346: Driver did not support SIOCSIWENCODEEXT 1340701837.052496: wpa_driver_wext_set_countermeasures 1340701837.053099: wlan: RSN: flushing PMKID list in the driver 1340701837.053437: wlan: State: DISCONNECTED -> INACTIVE 1340701837.053741: WPS: Set UUID for interface wlan 1340701837.103437: 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 1340701837.299875: EAPOL: SUPP_PAE entering state DISCONNECTED 1340701837.300123: EAPOL: Supplicant port status: Unauthorized 1340701837.300256: EAPOL: KEY_RX entering state NO_KEY_RECEIVE 1340701837.300292: EAPOL: SUPP_BE entering state INITIALIZE 1340701837.300327: EAP: EAP entering state DISABLED 1340701837.300393: EAPOL: Supplicant port status: Unauthorized 1340701837.300480: EAPOL: Supplicant port status: Unauthorized 1340701837.301504: wlan: Added interface wlan 1340701837.301660: Daemonize.. 1340701837.309353: random: Got 18/20 bytes from /dev/random 1340701837.309970: RTM_NEWLINK: operstate=0 ifi_flags=0x11043 ([UP][RUNNING][LOWER_UP]) 1340701837.310317: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan' added 1340701837.310833: WEXT: if_removed already cleared - ignore event 1340701837.311028: RTM_NEWLINK: operstate=0 ifi_flags=0x11043 ([UP][RUNNING][LOWER_UP]) 1340701837.311188: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan' added 1340701837.311402: WEXT: if_removed already cleared - ignore event 1340701837.311596: Wireless event: cmd=0x8b06 len=8 1340701837.311787: RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP]) 1340701837.311930: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan' added 1340701837.312159: WEXT: if_removed already cleared - ignore event 1340701837.312337: RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP]) 1340701837.312488: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan' added 1340701837.312682: WEXT: if_removed already cleared - ignore event 1340701837.312810: Wireless event: cmd=0x8b2a len=8 1340701837.312878: RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP]) 1340701837.313018: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan' added 1340701837.313218: WEXT: if_removed already cleared - ignore event 1340701837.313349: Wireless event: cmd=0x8b2a len=8 1340701837.313422: RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP]) 1340701837.313564: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan' added 1340701837.313766: WEXT: if_removed already cleared - ignore event 1340701837.313895: Wireless event: cmd=0x8b2a len=8 1340701837.313968: RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP]) 1340701837.314193: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan' added 1340701837.314472: WEXT: if_removed already cleared - ignore event 1340701837.314604: Wireless event: cmd=0x8b2a len=8 1340701838.305866: EAPOL: disable timer tick 1340701838.306128: EAPOL: Supplicant port status: Unauthorized 1340701841.498058: RX ctrl_iface - hexdump_ascii(len=11): 41 44 44 5f 4e 45 54 57 4f 52 4b ADD_NETWORK 1340701841.498930: CTRL_IFACE: ADD_NETWORK 1340701845.640629: RX ctrl_iface - hexdump_ascii(len=51): [REMOVED] 1340701845.641076: CTRL_IFACE: SET_NETWORK id=0 name='ssid' 1340701845.641236: CTRL_IFACE: value - hexdump_ascii(len=32): [REMOVED] 1340701845.641450: 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 1340701849.790371: RX ctrl_iface - hexdump_ascii(len=28): [REMOVED] 1340701849.790616: CTRL_IFACE: SET_NETWORK id=0 name='psk' 1340701849.790748: CTRL_IFACE: value - hexdump_ascii(len=10): [REMOVED] 1340701849.790860: PSK (ASCII passphrase) - hexdump_ascii(len=8): [REMOVED] 1340701850.134604: PSK (from passphrase) - hexdump(len=32): [REMOVED] 1340701854.281924: 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 1340701854.282246: CTRL_IFACE: ENABLE_NETWORK id=0 1340701854.282589: wlan: Setting scan request: 0 sec 0 usec 1340701854.283305: wlan: State: INACTIVE -> SCANNING 1340701854.283606: wlan: Starting AP scan for wildcard SSID 1340701857.225451: Scan requested (ret=0) - scan timeout 10 seconds 1340701863.071025: random: Got 2/2 bytes from /dev/random 1340701867.234478: Scan timeout - try to get results 1340701867.234799: wlan: Event SCAN_RESULTS (3) received 1340701867.236312: Received 2629 bytes of scan results (10 BSSes) 1340701867.236762: Sorted scan results 1340701867.236905: 00:26:44:a1:45:a9 freq=2437 qual=32 noise=-95 level=-63 flags=0x0 1340701867.236951: 00:1e:69:36:5f:11 freq=2462 qual=17 noise=-95 level=-78 flags=0x0 1340701867.236986: 68:7f:74:1b:ce:f8 freq=2437 qual=14 noise=-95 level=-81 flags=0x0 1340701867.237023: 00:26:24:79:10:eb freq=2462 qual=12 noise=-95 level=-83 flags=0x0 1340701867.237059: 00:18:84:13:4f:e2 freq=2422 qual=7 noise=-95 level=-88 flags=0x0 1340701867.237117: 00:24:01:6b:94:33 freq=2412 qual=6 noise=-95 level=-89 flags=0x0 1340701867.237151: 00:18:e7:d1:76:1e freq=2452 qual=6 noise=-95 level=-89 flags=0x0 1340701867.237186: e0:69:95:d4:d9:2e freq=2437 qual=5 noise=-95 level=-90 flags=0x0 1340701867.237220: 00:90:4b:85:31:5d freq=2412 qual=4 noise=-95 level=-91 flags=0x0 1340701867.237254: 00:18:84:13:4f:e1 freq=2422 qual=6 noise=-95 level=-89 flags=0x0 1340701867.237380: wlan: BSS: Start scan result update 1 1340701867.237633: wlan: BSS: Add new id 0 BSSID 00:26:44:a1:45:a9 SSID 'SoneraGateway00-26-44-A1-45-A9' 1340701867.237960: wlan: BSS: Add new id 1 BSSID 00:1e:69:36:5f:11 SSID 'Merton' 1340701867.238210: wlan: BSS: Add new id 2 BSSID 68:7f:74:1b:ce:f8 SSID 'piipin' 1340701867.238447: wlan: BSS: Add new id 3 BSSID 00:26:24:79:10:eb SSID 'Thom_D0049633' 1340701867.238682: wlan: BSS: Add new id 4 BSSID 00:18:84:13:4f:e2 SSID 'LapinVerkko' 1340701867.238922: wlan: BSS: Add new id 5 BSSID 00:24:01:6b:94:33 SSID 'lowball' 1340701867.239159: wlan: BSS: Add new id 6 BSSID 00:18:e7:d1:76:1e SSID 'pn' 1340701867.239395: wlan: BSS: Add new id 7 BSSID e0:69:95:d4:d9:2e SSID 'e4c4e2' 1340701867.239635: wlan: BSS: Add new id 8 BSSID 00:90:4b:85:31:5d SSID 'Piku' 1340701867.239869: wlan: BSS: Add new id 9 BSSID 00:18:84:13:4f:e1 SSID 'FON_Lapin' 1340701867.240058: Add randomness: count=1 entropy=0 1340701867.240166: random pool - hexdump(len=128): [REMOVED] 1340701867.240216: random_mix_pool - hexdump(len=8): [REMOVED] 1340701867.240274: random_mix_pool - hexdump(len=5): [REMOVED] 1340701867.240308: random pool - hexdump(len=128): [REMOVED] 1340701867.240347: Add randomness: count=2 entropy=1 1340701867.240410: random pool - hexdump(len=128): [REMOVED] 1340701867.240549: random_mix_pool - hexdump(len=8): [REMOVED] 1340701867.240658: random_mix_pool - hexdump(len=5): [REMOVED] 1340701867.240721: random pool - hexdump(len=128): [REMOVED] 1340701867.240766: Add randomness: count=3 entropy=2 1340701867.240842: random pool - hexdump(len=128): [REMOVED] 1340701867.240899: random_mix_pool - hexdump(len=8): [REMOVED] 1340701867.240949: random_mix_pool - hexdump(len=5): [REMOVED] 1340701867.240981: random pool - hexdump(len=128): [REMOVED] 1340701867.241022: Add randomness: count=4 entropy=3 1340701867.241075: random pool - hexdump(len=128): [REMOVED] 1340701867.241145: random_mix_pool - hexdump(len=8): [REMOVED] 1340701867.241205: random_mix_pool - hexdump(len=5): [REMOVED] 1340701867.241250: random pool - hexdump(len=128): [REMOVED] 1340701867.241304: Add randomness: count=5 entropy=4 1340701867.241377: random pool - hexdump(len=128): [REMOVED] 1340701867.241434: random_mix_pool - hexdump(len=8): [REMOVED] 1340701867.241488: random_mix_pool - hexdump(len=5): [REMOVED] 1340701867.241517: random pool - hexdump(len=128): [REMOVED] 1340701867.274519: Add randomness: count=6 entropy=5 1340701867.274651: random pool - hexdump(len=128): [REMOVED] 1340701867.274710: random_mix_pool - hexdump(len=8): [REMOVED] 1340701867.274783: random_mix_pool - hexdump(len=5): [REMOVED] 1340701867.274837: random pool - hexdump(len=128): [REMOVED] 1340701867.274881: Add randomness: count=7 entropy=6 1340701867.274953: random pool - hexdump(len=128): [REMOVED] 1340701867.275000: random_mix_pool - hexdump(len=8): [REMOVED] 1340701867.275056: random_mix_pool - hexdump(len=5): [REMOVED] 1340701867.275097: random pool - hexdump(len=128): [REMOVED] 1340701867.275159: Add randomness: count=8 entropy=7 1340701867.275216: random pool - hexdump(len=128): [REMOVED] 1340701867.275273: random_mix_pool - hexdump(len=8): [REMOVED] 1340701867.275340: random_mix_pool - hexdump(len=5): [REMOVED] 1340701867.275394: random pool - hexdump(len=128): [REMOVED] 1340701867.275438: Add randomness: count=9 entropy=8 1340701867.275500: random pool - hexdump(len=128): [REMOVED] 1340701867.275562: random_mix_pool - hexdump(len=8): [REMOVED] 1340701867.275610: random_mix_pool - hexdump(len=5): [REMOVED] 1340701867.275644: random pool - hexdump(len=128): [REMOVED] 1340701867.275689: Add randomness: count=10 entropy=9 1340701867.275755: random pool - hexdump(len=128): [REMOVED] 1340701867.275815: random_mix_pool - hexdump(len=8): [REMOVED] 1340701867.275874: random_mix_pool - hexdump(len=5): [REMOVED] 1340701867.275933: random pool - hexdump(len=128): [REMOVED] 1340701867.276025: wlan: New scan results available 1340701867.276345: wlan: Selecting BSS from priority group 0 1340701867.276575: 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=-63 1340701867.276831: wlan: selected based on RSN IE 1340701867.277048: wlan: selected BSS 00:26:44:a1:45:a9 ssid='SoneraGateway00-26-44-A1-45-A9' 1340701867.277313: 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 1340701867.277582: wlan: Trying to associate with 00:26:44:a1:45:a9 (SSID='SoneraGateway00-26-44-A1-45-A9' freq=2437 MHz) 1340701867.277783: FT: Stored MDIE and FTIE from (Re)Association Response - hexdump(len=0): 1340701867.277971: wlan: Cancelling scan request 1340701867.278193: wlan: WPA: clearing own WPA/RSN IE 1340701867.278368: wlan: Automatic auth_alg selection: 0x1 1340701867.278548: wlan: RSN: using IEEE 802.11i/D9.0 1340701867.278728: wlan: WPA: Selected cipher suites: group 8 pairwise 16 key_mgmt 2 proto 2 1340701867.278846: 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 1340701867.279001: 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 1340701867.279213: wlan: WPA: using GTK TKIP 1340701867.279343: wlan: WPA: using PTK CCMP 1340701867.279481: wlan: WPA: using KEY_MGMT WPA-PSK 1340701867.279630: wlan: WPA: not using MGMT group cipher 1340701867.279822: 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 1340701867.280135: wlan: No keys have been configured - skip key clearing 1340701867.280307: wlan: State: SCANNING -> ASSOCIATING 1340701867.280436: wpa_driver_wext_set_operstate: operstate 0->0 (DORMANT) 1340701867.280499: netlink: Operstate: linkmode=-1, operstate=5 1340701867.280794: wpa_driver_wext_associate 1340701867.280944: wpa_driver_wext_set_drop_unencrypted 1340701867.281297: wpa_driver_wext_set_psk 1340701867.282348: wlan: Association request to the driver failed 1340701867.282569: wlan: Setting authentication timeout: 5 sec 0 usec 1340701867.282786: EAPOL: External notification - EAP success=0 1340701867.282931: EAPOL: Supplicant port status: Unauthorized 1340701867.282980: EAPOL: External notification - EAP fail=0 1340701867.283082: EAPOL: Supplicant port status: Unauthorized 1340701867.283124: EAPOL: External notification - portControl=Auto 1340701867.283238: EAPOL: Supplicant port status: Unauthorized 1340701867.283320: RSN: Ignored PMKID candidate without preauth flag 1340701867.283621: RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP]) 1340701867.283785: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan' added 1340701867.284058: WEXT: if_removed already cleared - ignore event 1340701867.287404: Wireless event: cmd=0x8b06 len=8 1340701867.287537: RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP]) 1340701867.287678: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan' added 1340701867.287939: WEXT: if_removed already cleared - ignore event 1340701867.288065: Wireless event: cmd=0x8b04 len=12 1340701867.288136: RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP]) 1340701867.288275: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan' added 1340701867.288470: WEXT: if_removed already cleared - ignore event 1340701867.288598: Wireless event: cmd=0x8b1a len=38 1340701867.355261: RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP]) 1340701867.355467: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan' added 1340701867.355751: WEXT: if_removed already cleared - ignore event 1340701867.355882: Wireless event: cmd=0x8c02 len=61 1340701867.355958: WEXT: Custom wireless event: 'BEACONIE=30140100000fac020100000fac040100000fac020c00' 1340701867.356155: RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP]) 1340701867.356299: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan' added 1340701867.356507: WEXT: if_removed already cleared - ignore event 1340701867.356636: Wireless event: cmd=0x8c02 len=126 1340701867.356692: WEXT: Custom wireless event: 'ASSOCRESPIE=010882848b962430486c32040c121860dd09001018020000050000dd180050f2020101080003a4000027a4000042435e0062322f00' 1340701867.356872: RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP]) 1340701867.357024: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan' added 1340701867.357241: WEXT: if_removed already cleared - ignore event 1340701867.357369: Wireless event: cmd=0x8c02 len=183 1340701867.357434: WEXT: Custom wireless event: 'ASSOCINFO(ReqIEs=001e536f6e6572614761746577617930302d32362d34342d41312d34352d4139010882848b0c1296182432043048606c30140100000fac020100000fac040100000fac020000dd070050f202000100' 1340701867.357889: wlan: Event ASSOCINFO (4) received 1340701867.358094: wlan: Association info event 1340701867.358217: 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 1340701867.358528: 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 1340701867.358736: FT: Stored MDIE and FTIE from (Re)Association Response - hexdump(len=0): 1340701867.358908: RTM_NEWLINK: operstate=0 ifi_flags=0x11003 ([UP][LOWER_UP]) 1340701867.359054: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan' added 1340701867.359316: WEXT: if_removed already cleared - ignore event 1340701867.359525: Wireless event: cmd=0x8b15 len=20 1340701867.359658: Wireless event: new AP: 00:26:44:a1:45:a9 1340701867.359797: wlan: Event ASSOC (0) received 1340701867.359983: wlan: State: ASSOCIATING -> ASSOCIATED 1340701867.360115: wpa_driver_wext_set_operstate: operstate 0->0 (DORMANT) 1340701867.360165: netlink: Operstate: linkmode=-1, operstate=5 1340701867.360488: wlan: Associated to a new BSS: BSSID=00:26:44:a1:45:a9 1340701867.360620: Add randomness: count=11 entropy=10 1340701867.360666: random pool - hexdump(len=128): [REMOVED] 1340701867.360737: random_mix_pool - hexdump(len=8): [REMOVED] 1340701867.360794: random_mix_pool - hexdump(len=6): [REMOVED] 1340701867.360851: random pool - hexdump(len=128): [REMOVED] 1340701867.360932: wlan: No keys have been configured - skip key clearing 1340701867.361128: wlan: Associated with 00:26:44:a1:45:a9 1340701867.361349: wlan: WPA: Association event - clear replay counter 1340701867.361520: wlan: WPA: Clear old PTK 1340701867.361649: EAPOL: External notification - portEnabled=0 1340701867.361694: EAPOL: Supplicant port status: Unauthorized 1340701867.361788: EAPOL: External notification - portValid=0 1340701867.361866: EAPOL: Supplicant port status: Unauthorized 1340701867.361957: EAPOL: External notification - EAP success=0 1340701867.361995: EAPOL: Supplicant port status: Unauthorized 1340701867.362076: EAPOL: External notification - portEnabled=1 1340701867.362139: EAPOL: SUPP_PAE entering state CONNECTING 1340701867.362213: EAPOL: enable timer tick 1340701867.362274: EAPOL: SUPP_BE entering state IDLE 1340701867.362458: wlan: Setting authentication timeout: 10 sec 0 usec 1340701867.362645: wlan: Cancelling scan request 1340701867.424996: wlan: RX EAPOL from 00:26:44:a1:45:a9 1340701867.425148: 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 41 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 1340701867.425611: wlan: Setting authentication timeout: 10 sec 0 usec 1340701867.425882: wlan: IEEE 802.1X RX: version=2 type=3 length=95 1340701867.426044: wlan: EAPOL-Key type=2 1340701867.426224: wlan: key_info 0x8a (ver=2 keyidx=0 rsvd=0 Pairwise Ack) 1340701867.426394: wlan: key_length=16 key_data_length=0 1340701867.426510: replay_counter - hexdump(len=8): 00 00 00 00 00 00 00 01 1340701867.426589: 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 41 1340701867.426753: key_iv - hexdump(len=16): 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 1340701867.426837: key_rsc - hexdump(len=8): 00 00 00 00 00 00 00 00 1340701867.426886: key_id (reserved) - hexdump(len=8): 00 00 00 00 00 00 00 00 1340701867.426939: key_mic - hexdump(len=16): 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 1340701867.427033: 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 41 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 1340701867.427614: wlan: State: ASSOCIATED -> 4WAY_HANDSHAKE 1340701867.427823: wlan: WPA: RX message 1 of 4-Way Handshake from 00:26:44:a1:45:a9 (ver=2) 1340701867.427941: RSN: msg 1/4 key data - hexdump(len=0): 1340701867.428000: Get randomness: len=32 entropy=11 1340701867.436581: random from os_get_random - hexdump(len=32): [REMOVED] 1340701867.436979: random_mix_pool - hexdump(len=20): [REMOVED] 1340701867.437274: random from internal pool - hexdump(len=16): [REMOVED] 1340701867.437570: random_mix_pool - hexdump(len=20): [REMOVED] 1340701867.437859: random from internal pool - hexdump(len=16): [REMOVED] 1340701867.437990: mixed random - hexdump(len=32): [REMOVED] 1340701867.438035: WPA: Renewed SNonce - hexdump(len=32): a6 f6 b0 ed e6 b2 0e 43 87 c6 04 3f 21 d2 25 7f a3 7f 81 79 d8 ef c9 fa d2 b9 4d 36 1a 9d fe cc 1340701867.438527: WPA: PTK derivation - A1=00:12:cf:8f:19:1e A2=00:26:44:a1:45:a9 1340701867.438747: WPA: Nonce1 - hexdump(len=32): a6 f6 b0 ed e6 b2 0e 43 87 c6 04 3f 21 d2 25 7f a3 7f 81 79 d8 ef c9 fa d2 b9 4d 36 1a 9d fe cc 1340701867.438917: 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 41 1340701867.439048: WPA: PMK - hexdump(len=32): [REMOVED] 1340701867.439085: WPA: PTK - hexdump(len=48): [REMOVED] 1340701867.439125: 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 1340701867.439292: WPA: Replay Counter - hexdump(len=8): 00 00 00 00 00 00 00 01 1340701867.439464: wlan: WPA: Sending EAPOL-Key 2/4 1340701867.439819: WPA: KCK - hexdump(len=16): [REMOVED] 1340701867.439951: WPA: Derived Key MIC - hexdump(len=16): 91 7b e0 c0 b3 e4 81 27 07 a9 e1 d7 43 a2 9f 06 1340701867.440027: WPA: TX EAPOL-Key - hexdump(len=121): 01 03 00 75 02 01 0a 00 00 00 00 00 00 00 00 00 01 a6 f6 b0 ed e6 b2 0e 43 87 c6 04 3f 21 d2 25 7f a3 7f 81 79 d8 ef c9 fa d2 b9 4d 36 1a 9d fe cc 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 91 7b e0 c0 b3 e4 81 27 07 a9 e1 d7 43 a2 9f 06 00 16 30 14 01 00 00 0f ac 02 01 00 00 0f ac 04 01 00 00 0f ac 02 00 00 1340701867.534932: wlan: RX EAPOL from 00:26:44:a1:45:a9 1340701867.535095: 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 41 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 19 00 00 00 00 00 00 00 00 aa cd 70 31 53 92 34 24 88 a8 f9 e9 76 68 4e a7 00 60 d6 b4 1c d6 33 22 19 0a c0 74 63 fc 00 84 3f f0 e1 ef 2e 1a b8 5b 3c 77 78 00 a4 d6 47 f5 eb 1f a6 92 d2 2f e2 29 1f f1 81 8b d7 2a e2 7e 87 2a 24 9d 5d 57 fd d6 f7 34 36 2c 3d b1 02 e8 ec 16 31 ff 30 78 11 b5 01 3a a9 80 68 d6 f6 e7 dc c1 7e 68 55 42 13 d7 cc 4c e4 03 a1 58 31 47 ed 7b 1340701867.535884: wlan: IEEE 802.1X RX: version=2 type=3 length=191 1340701867.536019: wlan: EAPOL-Key type=2 1340701867.536203: wlan: key_info 0x13ca (ver=2 keyidx=0 rsvd=0 Pairwise Install Ack MIC Secure Encr) 1340701867.536368: wlan: key_length=16 key_data_length=96 1340701867.536484: replay_counter - hexdump(len=8): 00 00 00 00 00 00 00 02 1340701867.536561: 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 41 1340701867.536724: key_iv - hexdump(len=16): 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 1340701867.536802: key_rsc - hexdump(len=8): 00 00 00 00 00 00 00 19 1340701867.536852: key_id (reserved) - hexdump(len=8): 00 00 00 00 00 00 00 00 1340701867.536903: key_mic - hexdump(len=16): aa cd 70 31 53 92 34 24 88 a8 f9 e9 76 68 4e a7 1340701867.537000: 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 41 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 19 00 00 00 00 00 00 00 00 aa cd 70 31 53 92 34 24 88 a8 f9 e9 76 68 4e a7 00 60 d6 b4 1c d6 33 22 19 0a c0 74 63 fc 00 84 3f f0 e1 ef 2e 1a b8 5b 3c 77 78 00 a4 d6 47 f5 eb 1f a6 92 d2 2f e2 29 1f f1 81 8b d7 2a e2 7e 87 2a 24 9d 5d 57 fd d6 f7 34 36 2c 3d b1 02 e8 ec 16 31 ff 30 78 11 b5 01 3a a9 80 68 d6 f6 e7 dc c1 7e 68 55 42 13 d7 cc 4c e4 03 a1 58 31 47 ed 7b 1340701867.537900: RSN: encrypted key data - hexdump(len=96): d6 b4 1c d6 33 22 19 0a c0 74 63 fc 00 84 3f f0 e1 ef 2e 1a b8 5b 3c 77 78 00 a4 d6 47 f5 eb 1f a6 92 d2 2f e2 29 1f f1 81 8b d7 2a e2 7e 87 2a 24 9d 5d 57 fd d6 f7 34 36 2c 3d b1 02 e8 ec 16 31 ff 30 78 11 b5 01 3a a9 80 68 d6 f6 e7 dc c1 7e 68 55 42 13 d7 cc 4c e4 03 a1 58 31 47 ed 7b 1340701867.541959: WPA: decrypted EAPOL-Key key data - hexdump(len=88): [REMOVED] 1340701867.542201: wlan: State: 4WAY_HANDSHAKE -> 4WAY_HANDSHAKE 1340701867.542500: wlan: WPA: RX message 3 of 4-Way Handshake from 00:26:44:a1:45:a9 (ver=2) 1340701867.542614: 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 01 00 f1 03 23 80 60 60 28 c8 f6 d4 c7 5d 23 1b a4 7f f4 0a 4b b9 f5 1f ad 56 e0 53 14 62 89 41 b7 f5 dd 00 1340701867.542960: 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 1340701867.543129: 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 1340701867.543260: WPA: GTK in EAPOL-Key - hexdump(len=40): [REMOVED] 1340701867.543376: wlan: WPA: Sending EAPOL-Key 4/4 1340701867.543680: WPA: KCK - hexdump(len=16): [REMOVED] 1340701867.543812: WPA: Derived Key MIC - hexdump(len=16): f6 ef 68 bf 87 30 d6 5e 39 44 21 7a c7 93 10 36 1340701867.543902: 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 f6 ef 68 bf 87 30 d6 5e 39 44 21 7a c7 93 10 36 00 00 1340701867.545143: wlan: WPA: Installing PTK to the driver 1340701867.545299: wpa_driver_wext_set_key: alg=3 key_idx=0 set_tx=1 seq_len=6 key_len=16 1340701867.545880: EAPOL: External notification - portValid=1 1340701867.546115: wlan: State: 4WAY_HANDSHAKE -> GROUP_HANDSHAKE 1340701867.546269: RSN: received GTK in pairwise handshake - hexdump(len=34): [REMOVED] 1340701867.546372: WPA: Group Key - hexdump(len=32): [REMOVED] 1340701867.546508: wlan: WPA: Installing GTK to the driver (keyidx=1 tx=0 len=32) 1340701867.546627: WPA: RSC - hexdump(len=6): 00 00 00 00 00 00 1340701867.546728: wpa_driver_wext_set_key: alg=2 key_idx=1 set_tx=0 seq_len=6 key_len=32 1340701867.547341: wlan: WPA: Key negotiation completed with 00:26:44:a1:45:a9 [PTK=CCMP GTK=TKIP] 1340701867.547537: wlan: Cancelling authentication timeout 1340701867.547720: wlan: State: GROUP_HANDSHAKE -> COMPLETED 1340701867.547924: wlan: CTRL-EVENT-CONNECTED - Connection to 00:26:44:a1:45:a9 completed (auth) [id=0 id_str=] 1340701867.548039: wpa_driver_wext_set_operstate: operstate 0->1 (UP) 1340701867.548224: netlink: Operstate: linkmode=-1, operstate=6 1340701867.548693: EAPOL: External notification - portValid=1 1340701867.548890: EAPOL: External notification - EAP success=1 1340701867.548967: EAPOL: SUPP_PAE entering state AUTHENTICATING 1340701867.549012: EAPOL: SUPP_BE entering state SUCCESS 1340701867.549076: EAP: EAP entering state DISABLED 1340701867.549146: EAPOL: SUPP_PAE entering state AUTHENTICATED 1340701867.549219: EAPOL: Supplicant port status: Authorized 1340701867.549253: EAPOL: SUPP_BE entering state IDLE 1340701867.549343: EAPOL authentication completed successfully 1340701867.549710: RTM_NEWLINK: operstate=1 ifi_flags=0x11043 ([UP][RUNNING][LOWER_UP]) 1340701867.549866: RTM_NEWLINK, IFLA_IFNAME: Interface 'wlan' added 1340701867.550148: WEXT: if_removed already cleared - ignore event 1340701868.364354: EAPOL: startWhen --> 0 1340701868.364525: EAPOL: disable timer tick