Date: Tue, 10 Oct 2006 08:53:24 +0200 From: Goran Lowkrantz <goran.lowkrantz@ismobile.com> To: Max Laier <max@love2party.net> Cc: freebsd-stable@freebsd.org, sam@freebsd.org, "Andrew N. Below" <defan@zenon.net> Subject: Re: iwi, hidden SSID and wpa_supplicant problem Message-ID: <0042A1B114694CCCAA9D5265@[172.16.2.106]> In-Reply-To: <200610100504.56088.max@love2party.net> References: <089501c6ebb0$31848e20$970da8c0@jam.zenon.net> <0a2a01c6ebcb$e3d36bd0$970da8c0@jam.zenon.net> <200610092026.58504.max@love2party.net> <200610100504.56088.max@love2party.net>
next in thread | previous in thread | raw e-mail | index | archive | help
[-- Attachment #1 --] Hi Max, It works. Attached is the successfull log from wpa_supplicant. Thanks for the quick response. /glz --On Tuesday, October 10, 2006 05:04:46 +0200 Max Laier <max@love2party.net> wrote: > On Monday 09 October 2006 20:26, Max Laier wrote: >> On Monday 09 October 2006 19:53, Andrew N. Below wrote: >> > Hi. >> > >> > [..] >> > >> > > You can try using ap_scan=2 or whatever it is in the >> > > wpa_supplicant.conf file. This causes wpa_supplicant to use >> > > directed broadcasts msgs to each ap listed in the file. >> > >> > In my case setting ap_scan to 2 doesn't help. >> > >> > BTW, I got successfull connection some time ago when I >> > start to use /etc/rc.d/netif start iwi0 instead of manual >> > running of wpa_supplicant: >> > >> > defanbook# ifconfig iwi0 >> > iwi0: flags=8843<UP,BROADCAST,RUNNING,SIMPLEX,MULTICAST> mtu 1500 >> > inet 213.189.198.75 netmask 0xfffffff0 broadcast >> > 213.189.198.79 ether 00:12:f0:3d:cd:58 >> > media: IEEE 802.11 Wireless Ethernet autoselect mode 11b >> > (DS/11Mbps) status: associated >> > ssid ZENON-RADIO channel 11 bssid 00:07:0e:b8:d8:ee >> > authmode WPA privacy ON deftxkey UNDEF TKIP 2:128-bit TKIP >> > 3:128-bit txpowmax 100 bmiss 10 protmode CTS roaming MANUAL bintval >> > 100 >> > >> > I wrote bssid value to /etc/wpa_supplicant.conf and run >> > /etc/rc.d/netif. >> > >> > Then I drop connection (netif stop iwi0) and tried to start it again. >> > I got "associated" state in 5-6 minutes. >> > >> > In rc.conf I have: >> > >> > ifconfig_iwi0="ssid MY-SSID channel 11 WPA >> > >> > How can I get "-dd" output from wpa_supplicant started with netif? >> > It could be interesting. >> >> No idea, but a bit more stress testing did reveal a similar problem >> here. After I associated with the AP w/ hidden SSID I changed the >> channel via webinterface. The disconnect resulted in the exact problem >> you were having. Only stopping and restarting wpa_supplicant fixed the >> issue and I got associated on the new channel. Not sure what happens >> there yet, but something seems to get stuck in an undefined state. > > Could you try the attached - untested - patch? It seems - from looking > at the linux driver - that we have to remind the firmware of the ESSID > before doing a directed scan. That explains why it would sometimes work > (whenever we are coming straight from iwi_config) and sometimes not. > > Let me know if that improves things for you. Thanks. > > -- > /"\ Best regards, | mlaier@freebsd.org > \ / Max Laier | ICQ #67774661 > X http://pf4freebsd.love2party.net/ | mlaier@EFnet > / \ ASCII Ribbon Campaign | Against HTML Mail and News -- ................................................... the future isMobile Goran Lowkrantz <goran.lowkrantz@ismobile.com> System Architect, isMobile, Aurorum 2, S-977 75 Lule￥, Sweden Phone: +46(0)920-75559 Mobile: +46(0)70-587 87 82 Fax: +46(0)70-615 87 82 http://www.ismobile.com ............................................... [-- Attachment #2 --] Script started on Tue Oct 10 08:46:04 2006 Oct 10 08:46:04.685427: Initializing interface 'iwi0' conf '/etc/wpa_supplicant.conf' driver 'default' ctrl_interface 'N/A' Oct 10 08:46:04.685666: Configuration file '/etc/wpa_supplicant.conf' -> '/etc/wpa_supplicant.conf' Oct 10 08:46:04.685684: Reading configuration file '/etc/wpa_supplicant.conf' Oct 10 08:46:04.701130: ctrl_interface='/var/run/wpa_supplicant' Oct 10 08:46:04.703638: ctrl_interface_group=0 (from group name 'wheel') Oct 10 08:46:04.703660: Line: 4 - start of a new network block Oct 10 08:46:04.703690: ssid - hexdump_ascii(len=8): XX XX XX XX XX XX XX XX LCLSID Oct 10 08:46:04.703714: key_mgmt: 0x2 Oct 10 08:46:04.703740: scan_ssid=1 (0x1) Oct 10 08:46:04.703752: PSK (ASCII passphrase) - hexdump_ascii(len=8): YY YY YY YY YY YY YY YY iM03x123 Oct 10 08:46:04.751650: PSK (from passphrase) - hexdump(len=32): b6 5b 8a ca 3e 5f 5e b5 e7 37 a8 a6 8b 74 26 d2 b1 44 00 18 16 9f b1 f8 ca 0b 8b bf 6c d7 af e4 Oct 10 08:46:04.751730: Line: 24 - start of a new network block Oct 10 08:46:04.751746: ssid - hexdump_ascii(len=12): XX XX XX XX XX XX XX XX XX XX XX XX HOMESID Oct 10 08:46:04.751768: key_mgmt: 0x2 Oct 10 08:46:04.751780: scan_ssid=1 (0x1) Oct 10 08:46:04.751791: PSK (ASCII passphrase) - hexdump_ascii(len=18): YY YY YY YY YY YY YY YY YY YY YY YY YY YY YY YY ZZZZZZZZZZZZZZZZ YY YY ZZ Oct 10 08:46:04.751820: BSSID - hexdump(len=6): 00 11 95 3b 8f 5e Oct 10 08:46:04.783178: PSK (from passphrase) - hexdump(len=32): 52 fd 27 de cc 50 0f ea b9 e5 9f 0e a6 54 a3 1c b4 6c 28 ec 85 2f e9 bf 96 c8 a0 60 f2 8a 89 7a Oct 10 08:46:04.783521: Line: 32 - start of a new network block Oct 10 08:46:04.784685: ssid - hexdump_ascii(len=13): 43 72 79 73 74 61 6c 20 50 6c 61 7a 61 Crystal Plaza Oct 10 08:46:04.789123: key_mgmt: 0x4 Oct 10 08:46:04.789532: Line: 37 - start of a new network block Oct 10 08:46:04.789883: ssid - hexdump_ascii(len=7): 68 6f 6d 65 72 75 6e homerun Oct 10 08:46:04.790529: key_mgmt: 0x4 Oct 10 08:46:04.790886: Line: 42 - start of a new network block Oct 10 08:46:04.791092: ssid - hexdump_ascii(len=9): 4c 46 56 50 55 42 4c 49 43 LFVPUBLIC Oct 10 08:46:04.791490: key_mgmt: 0x4 Oct 10 08:46:04.791692: Line: 47 - start of a new network block Oct 10 08:46:04.791894: ssid - hexdump_ascii(len=3): 61 6e 79 any Oct 10 08:46:04.792282: key_mgmt: 0x4 Oct 10 08:46:04.792508: Priority group 0 Oct 10 08:46:04.792720: id=0 ssid='LCLSID' Oct 10 08:46:04.792916: id=1 ssid='HOMESID' Oct 10 08:46:04.793114: id=2 ssid='Crystal Plaza' Oct 10 08:46:04.793304: id=3 ssid='homerun' Oct 10 08:46:04.793500: id=4 ssid='LFVPUBLIC' Oct 10 08:46:04.793694: id=5 ssid='any' Oct 10 08:46:04.793903: Initializing interface (2) 'iwi0' Oct 10 08:46:04.804082: EAPOL: SUPP_PAE entering state DISCONNECTED Oct 10 08:46:04.804134: EAPOL: KEY_RX entering state NO_KEY_RECEIVE Oct 10 08:46:04.804259: EAPOL: SUPP_BE entering state INITIALIZE Oct 10 08:46:04.804420: EAP: EAP entering state DISABLED Oct 10 08:46:04.804888: EAPOL: External notification - portEnabled=0 Oct 10 08:46:04.805233: EAPOL: External notification - portValid=0 Oct 10 08:46:04.807136: Own MAC address: 00:16:6f:8b:0a:21 Oct 10 08:46:04.807233: wpa_driver_bsd_set_wpa: enabled=1 Oct 10 08:46:04.807608: wpa_driver_bsd_set_wpa_internal: wpa=3 privacy=1 Oct 10 08:46:04.807902: wpa_driver_bsd_del_key: keyidx=0 Oct 10 08:46:04.808311: wpa_driver_bsd_del_key: keyidx=1 Oct 10 08:46:04.808598: wpa_driver_bsd_del_key: keyidx=2 Oct 10 08:46:04.808938: wpa_driver_bsd_del_key: keyidx=3 Oct 10 08:46:04.809163: wpa_driver_bsd_set_countermeasures: enabled=0 Oct 10 08:46:04.809364: wpa_driver_bsd_set_drop_unencrypted: enabled=1 Oct 10 08:46:04.809580: Setting scan request: 0 sec 100000 usec Oct 10 08:46:04.809889: Using existing control interface directory. Oct 10 08:46:04.810269: Added interface iwi0 Oct 10 08:46:04.911113: State: DISCONNECTED -> SCANNING Oct 10 08:46:04.911184: Starting AP scan (specific SSID) Oct 10 08:46:04.911362: Scan SSID - hexdump_ascii(len=8): XX XX XX XX XX XX XX XX LCLSID Oct 10 08:46:07.987790: Received 0 bytes of scan results (4 BSSes) Oct 10 08:46:07.987832: Scan results: 4 Oct 10 08:46:07.987845: Selecting BSS from priority group 0 Oct 10 08:46:07.987855: 0: 00:09:5b:b8:c4:4d ssid='LCLSID' wpa_ie_len=24 rsn_ie_len=0 caps=0x11 Oct 10 08:46:07.987871: selected based on WPA IE Oct 10 08:46:07.987886: Trying to associate with 00:09:5b:b8:c4:4d (SSID='LCLSID' freq=2422 MHz) Oct 10 08:46:07.987897: Cancelling scan request Oct 10 08:46:07.987906: WPA: clearing own WPA/RSN IE Oct 10 08:46:07.987915: Automatic auth_alg selection: 0x1 Oct 10 08:46:07.987924: wpa_driver_bsd_set_auth_alg alg 0x1 authmode 1 Oct 10 08:46:07.987948: WPA: using IEEE 802.11i/D3.0 Oct 10 08:46:07.987957: WPA: Selected cipher suites: group 8 pairwise 8 key_mgmt 2 Oct 10 08:46:07.987968: 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 Oct 10 08:46:07.987991: WPA: clearing AP RSN IE Oct 10 08:46:07.988000: WPA: using GTK TKIP Oct 10 08:46:07.988009: WPA: using PTK TKIP Oct 10 08:46:07.988018: WPA: using KEY_MGMT WPA-PSK Oct 10 08:46:07.988028: 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 Oct 10 08:46:07.988051: No keys have been configured - skip key clearing Oct 10 08:46:07.988124: wpa_driver_bsd_set_drop_unencrypted: enabled=1 Oct 10 08:46:07.988140: State: SCANNING -> ASSOCIATING Oct 10 08:46:07.988150: wpa_driver_bsd_associate: ssid 'LCLSID' wpa ie len 24 pairwise 2 group 2 key mgmt 1 Oct 10 08:46:07.988165: wpa_driver_bsd_associate: set PRIVACY 1 Oct 10 08:46:07.990294: Setting authentication timeout: 10 sec 0 usec Oct 10 08:46:07.990317: EAPOL: External notification - EAP success=0 Oct 10 08:46:07.990351: EAPOL: External notification - EAP fail=0 Oct 10 08:46:07.990382: EAPOL: External notification - portControl=Auto Oct 10 08:46:08.007940: State: ASSOCIATING -> ASSOCIATED Oct 10 08:46:08.007995: Associated to a new BSS: BSSID=00:09:5b:b8:c4:4d Oct 10 08:46:08.008007: No keys have been configured - skip key clearing Oct 10 08:46:08.008020: Associated with 00:09:5b:b8:c4:4d Oct 10 08:46:08.008029: WPA: Association event - clear replay counter Oct 10 08:46:08.008043: EAPOL: External notification - portEnabled=0 Oct 10 08:46:08.008075: EAPOL: External notification - portValid=0 Oct 10 08:46:08.008106: EAPOL: External notification - EAP success=0 Oct 10 08:46:08.008135: EAPOL: External notification - portEnabled=1 Oct 10 08:46:08.008144: EAPOL: SUPP_PAE entering state CONNECTING Oct 10 08:46:08.008154: EAPOL: SUPP_BE entering state IDLE Oct 10 08:46:08.008171: Setting authentication timeout: 10 sec 0 usec Oct 10 08:46:08.011179: RX EAPOL from 00:09:5b:b8:c4:4d Oct 10 08:46:08.011220: RX EAPOL - hexdump(len=121): 01 03 00 75 fe 00 89 00 20 00 00 00 00 00 00 00 01 71 1f a0 ef b3 77 fb 64 22 4b 73 46 3e 38 dc c1 3c 6a c8 0c 05 41 24 46 3e 8d 57 91 a5 86 e8 26 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 16 dd 14 00 0f ac 04 38 13 a6 c3 73 13 5c 0e 23 3c 84 83 5c 32 b0 42 Oct 10 08:46:08.011295: Setting authentication timeout: 10 sec 0 usec Oct 10 08:46:08.011310: IEEE 802.1X RX: version=1 type=3 length=117 Oct 10 08:46:08.011321: EAPOL-Key type=254 Oct 10 08:46:08.011331: WPA: RX EAPOL-Key - hexdump(len=121): 01 03 00 75 fe 00 89 00 20 00 00 00 00 00 00 00 01 71 1f a0 ef b3 77 fb 64 22 4b 73 46 3e 38 dc c1 3c 6a c8 0c 05 41 24 46 3e 8d 57 91 a5 86 e8 26 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 16 dd 14 00 0f ac 04 38 13 a6 c3 73 13 5c 0e 23 3c 84 83 5c 32 b0 42 Oct 10 08:46:08.011416: State: ASSOCIATED -> 4WAY_HANDSHAKE Oct 10 08:46:08.011426: WPA: RX message 1 of 4-Way Handshake from 00:09:5b:b8:c4:4d (ver=1) Oct 10 08:46:08.011438: 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 Oct 10 08:46:08.012674: WPA: Renewed SNonce - hexdump(len=32): 51 68 0a 5e ea d0 b9 43 3a 5b b2 73 12 04 4b b7 7b e2 94 8c 20 19 15 d8 d7 b7 30 f8 0d 01 0d 70 Oct 10 08:46:08.012744: WPA: PMK - hexdump(len=32): b6 5b 8a ca 3e 5f 5e b5 e7 37 a8 a6 8b 74 26 d2 b1 44 00 18 16 9f b1 f8 ca 0b 8b bf 6c d7 af e4 Oct 10 08:46:08.012770: WPA: PTK - hexdump(len=64): ff b5 df 06 4d bf ae d5 6e 6c 26 62 5f b5 36 a3 f2 09 af 1a 7d a4 f7 c9 8e 5c 63 56 83 95 a5 24 31 bb 1a f4 61 03 a8 cd 13 e1 9f 53 b5 ec c6 62 ea 2c 07 67 8d 4d 32 54 61 94 d8 e4 59 26 9f c5 Oct 10 08:46:08.012808: WPA: Sending EAPOL-Key 2/4 Oct 10 08:46:08.012837: WPA: TX EAPOL-Key - hexdump(len=123): 01 03 00 77 fe 01 09 00 20 00 00 00 00 00 00 00 01 51 68 0a 5e ea d0 b9 43 3a 5b b2 73 12 04 4b b7 7b e2 94 8c 20 19 15 d8 d7 b7 30 f8 0d 01 0d 70 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 1a 1a fc 3e ba db 39 f6 97 96 11 3d d9 cd 7e 71 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 Oct 10 08:46:08.019338: RX EAPOL from 00:09:5b:b8:c4:4d Oct 10 08:46:08.019380: RX EAPOL - hexdump(len=121): 01 03 00 75 fe 00 89 00 20 00 00 00 00 00 00 00 02 22 3b 56 0d a1 94 d6 9b bd ac 2a a5 e8 06 94 c3 7e c7 9a 65 97 89 5c fc 46 5e 68 f0 bf f5 47 36 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 16 dd 14 00 0f ac 04 38 13 a6 c3 73 13 5c 0e 23 3c 84 83 5c 32 b0 42 Oct 10 08:46:08.019453: IEEE 802.1X RX: version=1 type=3 length=117 Oct 10 08:46:08.019464: EAPOL-Key type=254 Oct 10 08:46:08.019475: WPA: RX EAPOL-Key - hexdump(len=121): 01 03 00 75 fe 00 89 00 20 00 00 00 00 00 00 00 02 22 3b 56 0d a1 94 d6 9b bd ac 2a a5 e8 06 94 c3 7e c7 9a 65 97 89 5c fc 46 5e 68 f0 bf f5 47 36 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 16 dd 14 00 0f ac 04 38 13 a6 c3 73 13 5c 0e 23 3c 84 83 5c 32 b0 42 Oct 10 08:46:08.019562: State: 4WAY_HANDSHAKE -> 4WAY_HANDSHAKE Oct 10 08:46:08.019572: WPA: RX message 1 of 4-Way Handshake from 00:09:5b:b8:c4:4d (ver=1) Oct 10 08:46:08.019584: 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 Oct 10 08:46:08.021571: WPA: PMK - hexdump(len=32): b6 5b 8a ca 3e 5f 5e b5 e7 37 a8 a6 8b 74 26 d2 b1 44 00 18 16 9f b1 f8 ca 0b 8b bf 6c d7 af e4 Oct 10 08:46:08.021610: WPA: PTK - hexdump(len=64): 8b 99 a1 a5 b1 56 13 cf 62 7c de dd c3 99 6d 4b 07 d3 89 fd c6 1b 25 ba 38 31 15 48 7a 36 3d be 49 cc 59 48 bf 90 11 a7 77 ea ab f1 ca bc 62 04 fb 95 75 a0 28 54 80 29 58 71 7f 66 c6 9d 95 08 Oct 10 08:46:08.021648: WPA: Sending EAPOL-Key 2/4 Oct 10 08:46:08.021663: WPA: TX EAPOL-Key - hexdump(len=123): 01 03 00 77 fe 01 09 00 20 00 00 00 00 00 00 00 02 51 68 0a 5e ea d0 b9 43 3a 5b b2 73 12 04 4b b7 7b e2 94 8c 20 19 15 d8 d7 b7 30 f8 0d 01 0d 70 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 7e c1 95 06 7c ab a3 02 67 b4 34 f6 66 38 dc d0 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 Oct 10 08:46:08.026817: RX EAPOL from 00:09:5b:b8:c4:4d Oct 10 08:46:08.026854: RX EAPOL - hexdump(len=123): 01 03 00 77 fe 01 c9 00 20 00 00 00 00 00 00 00 03 22 3b 56 0d a1 94 d6 9b bd ac 2a a5 e8 06 94 c3 7e c7 9a 65 97 89 5c fc 46 5e 68 f0 bf f5 47 36 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 40 89 23 46 5a 22 ad 1d 2c 59 af 52 9d 95 0f a5 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 Oct 10 08:46:08.026928: IEEE 802.1X RX: version=1 type=3 length=119 Oct 10 08:46:08.026938: EAPOL-Key type=254 Oct 10 08:46:08.026949: WPA: RX EAPOL-Key - hexdump(len=123): 01 03 00 77 fe 01 c9 00 20 00 00 00 00 00 00 00 03 22 3b 56 0d a1 94 d6 9b bd ac 2a a5 e8 06 94 c3 7e c7 9a 65 97 89 5c fc 46 5e 68 f0 bf f5 47 36 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 40 89 23 46 5a 22 ad 1d 2c 59 af 52 9d 95 0f a5 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 Oct 10 08:46:08.027028: State: 4WAY_HANDSHAKE -> 4WAY_HANDSHAKE Oct 10 08:46:08.027038: WPA: RX message 3 of 4-Way Handshake from 00:09:5b:b8:c4:4d (ver=1) Oct 10 08:46:08.027049: 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 Oct 10 08:46:08.028239: WPA: Sending EAPOL-Key 4/4 Oct 10 08:46:08.028261: WPA: TX EAPOL-Key - hexdump(len=99): 01 03 00 5f fe 01 09 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 04 f3 c0 ba e7 0b f0 18 22 ab 78 05 e2 3b b5 00 00 00 Oct 10 08:46:08.028346: WPA: Installing PTK to the driver. Oct 10 08:46:08.028357: WPA: RSC - hexdump(len=6): 00 00 00 00 00 00 Oct 10 08:46:08.028388: wpa_driver_bsd_set_key: alg=TKIP addr=00:09:5b:b8:c4:4d key_idx=0 set_tx=1 seq_len=6 key_len=32 Oct 10 08:46:08.028418: State: 4WAY_HANDSHAKE -> GROUP_HANDSHAKE Oct 10 08:46:09.043633: RX EAPOL from 00:09:5b:b8:c4:4d Oct 10 08:46:09.043678: RX EAPOL - hexdump(len=131): 01 03 00 7f fe 13 91 00 20 00 00 00 00 00 00 00 05 ef 80 07 61 0f 56 5b 2d 80 37 0d e5 ab 57 ec 0a 4d 40 ff d6 c2 05 52 db 46 5f 51 f8 23 6b 77 96 df d2 7e fd 91 9c a2 af 35 0f f6 7f 07 7d 66 19 9a 2f 00 00 00 00 00 00 00 00 00 00 00 00 00 00 20 5c 7d 55 26 e6 f6 c6 ba 41 46 37 ba 5e 13 a9 00 20 f9 39 ff 1d 09 7c 5c 8f fc cd b7 43 d2 dc 28 6e 38 df 28 3a 38 da d9 b4 60 6a 9b 81 79 cc b7 de Oct 10 08:46:09.043753: IEEE 802.1X RX: version=1 type=3 length=127 Oct 10 08:46:09.043764: EAPOL-Key type=254 Oct 10 08:46:09.043774: WPA: RX EAPOL-Key - hexdump(len=131): 01 03 00 7f fe 13 91 00 20 00 00 00 00 00 00 00 05 ef 80 07 61 0f 56 5b 2d 80 37 0d e5 ab 57 ec 0a 4d 40 ff d6 c2 05 52 db 46 5f 51 f8 23 6b 77 96 df d2 7e fd 91 9c a2 af 35 0f f6 7f 07 7d 66 19 9a 2f 00 00 00 00 00 00 00 00 00 00 00 00 00 00 20 5c 7d 55 26 e6 f6 c6 ba 41 46 37 ba 5e 13 a9 00 20 f9 39 ff 1d 09 7c 5c 8f fc cd b7 43 d2 dc 28 6e 38 df 28 3a 38 da d9 b4 60 6a 9b 81 79 cc b7 de Oct 10 08:46:09.043856: State: GROUP_HANDSHAKE -> GROUP_HANDSHAKE Oct 10 08:46:09.043866: WPA: RX message 1 of Group Key Handshake from 00:09:5b:b8:c4:4d (ver=1) Oct 10 08:46:09.043886: WPA: Group Key - hexdump(len=32): bb 54 48 89 d3 18 5c 59 8a 23 46 f8 7c 6e 43 49 fb c7 d1 3e db 33 ec a8 f9 f9 38 7c 91 b1 90 b1 Oct 10 08:46:09.043953: WPA: Installing GTK to the driver (keyidx=1 tx=0). Oct 10 08:46:09.043964: WPA: RSC - hexdump(len=6): 9a 2f 00 00 00 00 Oct 10 08:46:09.043980: wpa_driver_bsd_set_key: alg=TKIP addr=ff:ff:ff:ff:ff:ff key_idx=1 set_tx=0 seq_len=6 key_len=32 Oct 10 08:46:09.044009: WPA: Sending EAPOL-Key 2/2 Oct 10 08:46:09.044023: WPA: TX EAPOL-Key - hexdump(len=99): 01 03 00 5f fe 03 11 00 20 00 00 00 00 00 00 00 05 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 42 75 9f 77 59 d6 e8 d6 e1 9e 79 23 4f b1 da 4d 00 00 Oct 10 08:46:09.044121: WPA: Key negotiation completed with 00:09:5b:b8:c4:4d [PTK=TKIP GTK=TKIP] Oct 10 08:46:09.044134: Cancelling authentication timeout Oct 10 08:46:09.044143: State: GROUP_HANDSHAKE -> COMPLETED Oct 10 08:46:09.044155: CTRL-EVENT-CONNECTED - Connection to 00:09:5b:b8:c4:4d completed (auth) Oct 10 08:46:09.044165: EAPOL: External notification - portValid=1 Oct 10 08:46:09.044183: EAPOL: External notification - EAP success=1 Oct 10 08:46:09.044192: EAPOL: SUPP_PAE entering state AUTHENTICATING Oct 10 08:46:09.044201: EAPOL: SUPP_BE entering state SUCCESS Oct 10 08:46:09.044586: EAP: EAP entering state DISABLED Oct 10 08:46:09.044598: EAPOL: SUPP_PAE entering state AUTHENTICATED Oct 10 08:46:09.044608: EAPOL: SUPP_BE entering state IDLE Oct 10 08:46:10.835691: EAPOL: startWhen --> 0 ^COct 10 08:46:40.439263: CTRL-EVENT-TERMINATING - signal 2 received Oct 10 08:46:40.439297: Removing interface iwi0 Oct 10 08:46:40.439308: State: COMPLETED -> DISCONNECTED Oct 10 08:46:40.439318: wpa_driver_bsd_deauthenticate Oct 10 08:46:40.439458: wpa_driver_bsd_del_key: keyidx=0 Oct 10 08:46:40.439704: wpa_driver_bsd_del_key: keyidx=1 Oct 10 08:46:40.439722: wpa_driver_bsd_del_key: keyidx=2 Oct 10 08:46:40.439734: wpa_driver_bsd_del_key: keyidx=3 Oct 10 08:46:40.439749: wpa_driver_bsd_del_key: addr=00:09:5b:b8:c4:4d keyidx=0 Oct 10 08:46:40.439764: EAPOL: External notification - portEnabled=0 Oct 10 08:46:40.439775: EAPOL: SUPP_PAE entering state DISCONNECTED Oct 10 08:46:40.439784: EAPOL: SUPP_BE entering state INITIALIZE Oct 10 08:46:40.439816: EAPOL: External notification - portValid=0 Oct 10 08:46:40.439846: wpa_driver_bsd_set_wpa: enabled=0 Oct 10 08:46:40.439855: wpa_driver_bsd_set_wpa_internal: wpa=0 privacy=0 Oct 10 08:46:40.439872: wpa_driver_bsd_set_drop_unencrypted: enabled=0 Oct 10 08:46:40.439884: wpa_driver_bsd_set_countermeasures: enabled=0 Oct 10 08:46:40.439895: No keys have been configured - skip key clearing Oct 10 08:46:40.440341: wpa_driver_bsd_set_wpa_internal: wpa=0 privacy=0 Oct 10 08:46:40.440885: Cancelling scan request Script done on Tue Oct 10 08:46:40 2006
Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?0042A1B114694CCCAA9D5265>