Hi again Quaker On Feb 11, 2008 9:45 AM, Quaker Fang <Quaker.Fang at sun.com> wrote: > Hi Johan, > > > Johan wrote: > > Hi Quaker > > > > Do you, or anybody else for that matter, have any news on this? It still does not appear to work for me in Build 80. > > > wpi driver of b80 or b79b should support WPA/PSK already, could you > please tell the steps you connect to the AP and the configuration of > your AP? > > -- > Quaker >
Results of re-testing. Accesspoint config: Mode: *802.11b+g* ESSID: *hartz-3* ESSID Hide: *Disabled* Channel: *1* Regulatory Domain: *N. America* Security Mode: *WPA2 Pre-shared Key* WPA2 Algoritm: *TKIP* SharedKey: *secret* Group Key Renewal: *3600 sec* There may be other settings somewhere, let me know if there is something interesting to report. bash-3.2# dladm scan-wifi LINK ESSID BSSID/IBSSID SEC STRENGTH MODE SPEED wpi0 hartz-3 0:13:d3:73:9e:9a wpa excellent g 54Mb bash-3.2# dladm connect-wifi -s wpa -k newkey -e hartz-3 dladm: cannot connect link 'wpi0': operation timed out ------------------ bash-3.2# echo "wpa_debug_level, 1/W 1" | mdb -p `pgrep wpad` wpad`wpa_debug_level: 0x4 = 0x1 ------------------ Messages Seen while connect-wifi is running: Feb 12 21:30:26 solwarg mac: [ID 744254 kern.info] NOTICE: wpi0 link up Feb 12 21:30:26 solwarg mac: [ID 486395 kern.info] NOTICE: wpi0 link down Feb 12 21:30:35 solwarg wpad[1174]: [ID 702911 daemon.notice] Signal 15 received - terminating Feb 12 21:30:35 solwarg wpad[1174]: [ID 702911 daemon.notice] <= eloop_run() Feb 12 21:30:35 solwarg wpad[1174]: [ID 702911 daemon.notice] wpa_driver_wifi_disassociate Feb 12 21:30:35 solwarg wpad[1174]: [ID 702911 daemon.notice] wpa_driver_wifi_set_key Feb 12 21:30:35 solwarg wpad[1174]: [ID 702911 daemon.notice] wpa_driver_wifi_del_key: id=0 Feb 12 21:30:35 solwarg wpad[1174]: [ID 702911 daemon.notice] wpa_driver_wifi_set_key Feb 12 21:30:35 solwarg wpad[1174]: [ID 702911 daemon.notice] wpa_driver_wifi_del_key: id=1 Feb 12 21:30:35 solwarg wpad[1174]: [ID 702911 daemon.notice] wpa_driver_wifi_set_key Feb 12 21:30:35 solwarg wpad[1174]: [ID 702911 daemon.notice] wpa_driver_wifi_del_key: id=2 Feb 12 21:30:35 solwarg wpad[1174]: [ID 702911 daemon.notice] wpa_driver_wifi_set_key Feb 12 21:30:35 solwarg wpad[1174]: [ID 702911 daemon.notice] wpa_driver_wifi_del_key: id=3 Feb 12 21:30:35 solwarg wpad[1174]: [ID 702911 daemon.notice] wpa_driver_wifi_set_key Feb 12 21:30:35 solwarg wpad[1174]: [ID 702911 daemon.notice] wpa_driver_wifi_del_key: id=0 Feb 12 21:30:35 solwarg wpad[1174]: [ID 702911 daemon.notice] wpa_driver_wifi_set_wpa: enable=0 Feb 12 21:30:35 solwarg wpad[1174]: [ID 702911 daemon.notice] wpa_driver_wifi_set_wpa_ie Feb 12 21:30:35 solwarg wpad[1174]: [ID 702911 daemon.notice] wpa_supplicant_door_destroy(/var/run/wpa_door_wpi0) Feb 12 21:30:36 solwarg mac: [ID 744254 kern.info] NOTICE: wpi0 link up Feb 12 21:30:37 solwarg mac: [ID 486395 kern.info] NOTICE: wpi0 link down And just to be clear about that, the above text appears each time, including a wpi0 link up / link down immediately after running the command and again when the command finally gives up. I thought it was boring - it looked the same each time. So I decided I could do better, using a script like this: bash-3.2# cat /tmp/doboth dladm connect-wifi -s wpa -k newkey -e hartz-3 & while ! echo "wpa_debug_level, 1/W 1" | mdb -p `pgrep wpad` do echo ".\n" done . /tmp/doboth And this time I saw much more in the log file, like this: Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_supplicant_door_setup(/var/run/wpa_door_wpi0) Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_set_wpa: enable=1 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_set_key Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_del_key: id=0 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_set_key Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_del_key: id=1 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_set_key Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_del_key: id=2 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_set_key Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_del_key: id=3 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] Setting scan request: 0 sec 100000 usec Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] => eloop_run Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] Starting AP scan (specific SSID) Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] Scan SSID: hartz-3 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_scan Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_disassociate Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_scan: return Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_get_scan_results: interface name =wpi0 max size=64 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] Scan results: 1 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] Selecting BSS from scan results (1) Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] 0: 00:13:d3:73:9e:9a ssid='hartz-3' wpa_ie_len=22 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] selected Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] Trying to associate with 00:13:d3:73:9e:9a (SSID='hartz-3' freq=2412 MHz) Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] Cancelling scan request Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] RSN: using IEEE 802.11i/D9.0 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] WPA: Own WPA IE - hexdump(len=22): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 02 01 00 00 0f ac 02 00 00 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_set_key Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_del_key: id=0 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_set_key Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_del_key: id=1 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_set_key Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_del_key: id=2 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_set_key Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_del_key: id=3 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_set_key Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_del_key: id=0 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_associate : 00:13:ffffffd3:73:ffffff9e:ffffff9a Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_set_wpa_ie Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] Setting authentication timeout: 15 sec 0 usec Feb 12 21:46:37 solwarg mac: [ID 744254 kern.info] NOTICE: wpi0 link up Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] Feb 12 21:46:37 solwarg Association event - clear replay counter Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_get_bssid: 00:13:d3:73:9e:9a Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] Associated to a new BSS: BSSID=00:13:d3:73:9e:9a Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_set_key Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_del_key: id=0 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_set_key Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_del_key: id=1 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_set_key Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_del_key: id=2 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_set_key Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_del_key: id=3 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_set_key Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_del_key: id=0 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] Setting authentication timeout: 10 sec 0 usec Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] RX EAPOL from 00:13:d3:73:9e:9a Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] Setting authentication timeout: 10 sec 0 usec Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] WPA: EAPOL frame len 99 Feb 12 21:46:37 solwarg Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] hdr_len=4, key_len=95 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] IEEE 802.1XRX: version=1 type=3 length=95 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] EAPOL-Key type=2 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] WPA: RX message 1 of 4-Way Handshake from 00:13:d3:73:9e:9a (ver=1) Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_get_ssid: ssid=hartz-3 len=7 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_get_bssid: 00:13:d3:73:9e:9a Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] entry len=7 ssid=hartz-3, driver len=7 ssid=hartz-3 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] RSN: msg 1/4 key data - hexdump(len=0): Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] WPA: WPA IE for msg 2/4 - hexdump(len=22): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 02 01 00 00 0f ac 02 00 00 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] WPA: Renewed SNonce - hexdump(len=32): 42 8f 5f bf 54 1c 03 d6 2d 6d 1e e5 6c b6 ae 2d 4c 65 a8 f2 13 ad ad 5b 7b 11 74 88 77 c8 d0 9d Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] WPA: PMK - hexdump(len=32): dc 08 15 1f 07 13 2c 36 d6 14 67 d0 40 f8 57 8d 3e 02 60 15 73 10 fe e0 e8 16 8c 84 44 4c fc a9 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] WPA: PTK - hexdump(len=64): bc 72 8f 60 63 5a eb 20 23 83 61 24 a5 15 79 49 ff 2f 4e 98 ed 78 77 7b a5 db d4 ca b2 2d 46 2b 0c 8f a7 83 60 97 0c 35 72 47 1b 67 c7 2d 30 b1 4f 6b 28 3b 68 32 19 e0 3f 1c 4a ee 55 fa 50 4d Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] WPA: EAPOL-Key MIC - hexdump(len=16): 2c 23 bb 4d 5b ee 08 d8 01 d2 48 a5 e1 b2 8b bc Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] WPA: Sending EAPOL-Key 2/4 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] RX EAPOL from 00:13:d3:73:9e:9a Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] WPA: EAPOL frame len 167 Feb 12 21:46:37 solwarg Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] hdr_len=4, key_len=95 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] IEEE 802.1XRX: version=1 type=3 length=163 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] EAPOL-Key type=2 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] RSN: encrypted key data - hexdump(len=68): e5 49 77 bc ae 42 ba 70 a7 27 3c ae 3f 43 03 95 7b 50 96 4b ca 66 e0 37 0d 21 1b 90 53 a9 d2 d0 c5 5e 64 b0 f8 c8 9b 8a 00 59 51 2b d4 1f 12 79 c4 bd 50 78 7e 88 6c 1f 48 c6 87 95 fe 0c 41 49 99 8d 74 81 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] WPA: decrypted EAPOL-Key key data - hexdump(len=68): de 76 df 83 7d 17 58 36 80 c0 2d fa fb 10 c9 d0 a9 8e d9 0b 42 01 82 1e d5 93 1e 57 72 7b eb 92 a4 b5 da 2e bf 06 cb ba 41 4c bb 73 b6 3e a8 56 e2 9b 27 f5 c5 42 79 de b0 bf 56 e0 f9 f3 e3 3e 8b 47 e5 20 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] WPA: RX message 3 of 4-Way Handshake from 00:13:d3:73:9e:9a (ver=1) Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] RSN: key data underflow (ie=222 len=118) Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] WPA: WPA IE in 3/4 msg does not match with WPA IE in Beacon/ProbeResp (src=00:13:d3:73:9e:9a) Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] WPA: WPA IE in Beacon/ProbeResp - hexdump(len=22): 30 14 01 00 00 0f ac 02 01 00 00 0f ac 02 01 00 00 0f ac 02 00 00 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] WPA: WPA IE in 3/4 msg - hexdump(len=0): Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_disassociate Feb 12 21:46:37 solwarg mac: [ID 486395 kern.info] NOTICE: wpi0 link down Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_set_key Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_del_key: id=0 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_set_key Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_del_key: id=1 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_set_key Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_del_key: id=2 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_set_key Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_del_key: id=3 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_set_key Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_del_key: id=0 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] Setting scan request: 0 sec 0 usec Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] Starting AP scan (specific SSID) Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] Scan SSID: hartz-3 Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_scan Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_disassociate Feb 12 21:46:37 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_scan: return Feb 12 21:46:38 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_get_scan_results: interface name =wpi0 max size=64 Feb 12 21:46:38 solwarg wpad[1291]: [ID 702911 daemon.notice] Scan results: 1 Feb 12 21:46:38 solwarg wpad[1291]: [ID 702911 daemon.notice] Selecting BSS from scan results (1) Feb 12 21:46:38 solwarg wpad[1291]: [ID 702911 daemon.notice] 0: 00:13:d3:73:9e:9a ssid='hartz-3' wpa_ie_len=22 Feb 12 21:46:38 solwarg wpad[1291]: [ID 702911 daemon.notice] selected Feb 12 21:46:38 solwarg wpad[1291]: [ID 702911 daemon.notice] Already associated with the selected AP. Feb 12 21:46:46 solwarg wpad[1291]: [ID 702911 daemon.notice] Signal 15 received - terminating Feb 12 21:46:46 solwarg wpad[1291]: [ID 702911 daemon.notice] <= eloop_run() Feb 12 21:46:46 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_disassociate Feb 12 21:46:46 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_set_key Feb 12 21:46:46 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_del_key: id=0 Feb 12 21:46:46 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_set_key Feb 12 21:46:46 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_del_key: id=1 Feb 12 21:46:46 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_set_key Feb 12 21:46:46 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_del_key: id=2 Feb 12 21:46:46 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_set_key Feb 12 21:46:46 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_del_key: id=3 Feb 12 21:46:46 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_set_key Feb 12 21:46:46 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_del_key: id=0 Feb 12 21:46:46 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_set_wpa: enable=0 Feb 12 21:46:46 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_driver_wifi_set_wpa_ie Feb 12 21:46:46 solwarg wpad[1291]: [ID 702911 daemon.notice] wpa_supplicant_door_destroy(/var/run/wpa_door_wpi0) Feb 12 21:46:54 solwarg mac: [ID 744254 kern.info] NOTICE: wpi0 link up Feb 12 21:46:55 solwarg mac: [ID 486395 kern.info] NOTICE: wpi0 link down Quite a bit more interesting, but does not give me any clues as to the cause of my problem. Thank you, _Johan -------------- next part -------------- An HTML attachment was scrubbed... URL: <http://mail.opensolaris.org/pipermail/laptop-discuss/attachments/20080212/693bfa37/attachment.html>