wpa/winxp/peap, hostapd+madwifi - no response to EAP Identity?

Rusty Chris Holleman reverendbean at yahoo.com
Mon Jan 2 11:48:04 EST 2006


My setup: madwifi(-old) current subversion #1372,
           hostapd-0.4.7 using integrated EAP server
           debian w/custom 2.6.12 kernel
           WPA/PEAP/MSCHAPv2 w/ Windows XP SP2 supplicant
 
 WPA-PSK works fine.  I haven't been able to get PEAP or TTLS to work, though.  On the
 windows side it tries to connect for about a minute and then gives up.  The hostapd
 logs suggest that the windows box is not responding to Request-Identity.  And in
 eapol.log on the windows box, there are in fact some errors (GetWinStationUserToken?)
 that suggest problems trying to fetch an identity, but I don't know what would cause
 that or if it is the root cause or not.
 
 Any ideas?
 
 EAPOL.LOG: ----------------------------------------------------------------------
 
 [1112] 10:11:07:510: ElGetInterfaceParams:  SsidLength=<9>, Found EapTypeId=<13>, SSIDLen=<9>
 [1520] 10:11:07:510: ElGetCustomAuthData: SSIDLen=<9>, EapTypeId=<13>, Offset=<52/712>, dwAuthData=<42>
 [1520] 10:11:07:510: ElGetCustomAuthData: SSIDLen=<9>, EapTypeId=<13>, Offset=<52/712>, dwAuthData=<42>
 [1520] 10:11:07:510: ElGetCustomAuthData: SSIDLen=<9>, EapTypeId=<21>, Offset=<52/712>, dwAuthData=<520>
 [1520] 10:11:07:510: ElGetCustomAuthData: SSIDLen=<9>, EapTypeId=<21>, Offset=<52/712>, dwAuthData=<520>
 [452] 10:11:07:510: ElGetCustomAuthData: SSIDLen=<9>, EapTypeId=<25>, Offset=<52/712>, dwAuthData=<62>
 [452] 10:11:07:510: ElGetCustomAuthData: SSIDLen=<9>, EapTypeId=<25>, Offset=<52/712>, dwAuthData=<62>
 [1520] 10:11:07:510: ElGetInterfaceParams:  SsidLength=<9>, Found EapTypeId=<13>, SSIDLen=<9>
 [1112] 10:11:07:510: ElGetCustomAuthData: SSIDLen=<9>, EapTypeId=<13>, Offset=<52/712>, dwAuthData=<42>
 [1112] 10:11:07:510: ElGetCustomAuthData: SSIDLen=<9>, EapTypeId=<13>, Offset=<52/712>, dwAuthData=<42>
 [1520] 10:11:07:510: ElGetCustomAuthData: SSIDLen=<9>, EapTypeId=<21>, Offset=<52/712>, dwAuthData=<520>
 [1520] 10:11:07:510: ElGetCustomAuthData: SSIDLen=<9>, EapTypeId=<21>, Offset=<52/712>, dwAuthData=<520>
 [452] 10:11:07:510: ElGetCustomAuthData: SSIDLen=<9>, EapTypeId=<25>, Offset=<52/712>, dwAuthData=<62>
 [452] 10:11:07:510: ElGetCustomAuthData: SSIDLen=<9>, EapTypeId=<25>, Offset=<52/712>, dwAuthData=<62>
 [1520] 10:11:15:336: ElSetCustomAuthData: EapTypeId=<13>, SSIDLength=<9>, InfoLength=<42>
 [1520] 10:11:15:336: ElSetCustomAuthData: Set value succeeded, fFound=<1>, dwEapBlob=<712>, dwSizeOfSSID=<9>
 [1520] 10:11:15:336: ElSetCustomAuthData: EapTypeId=<21>, SSIDLength=<9>, InfoLength=<520>
 [1520] 10:11:15:336: ElSetCustomAuthData: Set value succeeded, fFound=<1>, dwEapBlob=<712>, dwSizeOfSSID=<9>
 [452] 10:11:15:336: ElSetCustomAuthData: EapTypeId=<25>, SSIDLength=<9>, InfoLength=<62>
 [452] 10:11:15:336: ElSetCustomAuthData: Set value succeeded, fFound=<1>, dwEapBlob=<712>, dwSizeOfSSID=<9>
 [1520] 10:11:15:336: ElSetInterfaceParams:  EapTypeId=<13> SSIDLen=<9>
 [1520] 10:11:15:336: Setting stuff in registry for {BEEC21CF-A056-4649-AD22-EDDF64CD0841}
 [1520] 10:11:15:336: ElSetInterfaceParams: Succeeded,  EapTypeId=<13> fFound=<1>, SSIDLen=<9>
 [1520] 10:11:15:336: ElPostEapConfigChanged: SSIDLength=<9>
 [452] 10:11:15:336: ElGetWinStationUserToken: GetWinStationUserToken failed for SessionId (2) with error (1008)
 [452] 10:11:15:336: ElGetWinStationUserToken: GetWinStationUserToken failed for session= (2) with error= (1008)
 [452] 10:11:15:336: ElWZCCfgUpdateSettings: ElGetWinStationUserToken failed with error 1
 [452] 10:11:15:336: ElWZCCfgChangeHandler: ElWZCCfgUpdateSettings HKCU failed with error (1)
 [1108] 10:11:15:336: ElGetInterfaceParams:  SsidLength=<9>, Found EapTypeId=<13>, SSIDLen=<9>
 [1108] 10:11:15:336: ElProcessEapConfigChange: PCB not started, enabled, starting PCB
 [1108] 10:11:15:336: ElZeroConfigNotify: Handle=(0), failcount=(0), lastauthtype=(0)
 [1108] 10:11:15:367: ElEnumAndOpenInterfaces: DeviceDesc = , GUID = {BEEC21CF-A056-4649-AD22-EDDF64CD0841}
 [1108] 10:11:15:367: ElNdisuioEnumerateInterfaces: Opening handle
 [1108] 10:11:15:367: NdisuioEnumerateInterfaces: NDISUIO bound to: (0) \DEVICE\{BEEC21CF-A056-4649-AD22-EDDF64CD0841}
      - Linksys Wireless-G PCI Adapter - Packet Scheduler Miniport
 
 [1108] 10:11:15:367: NdisuioEnumerateInterfaces: NDISUIO bound to: (1) \DEVICE\{76F19F9C-4738-4415-BDE4-FFA009978A55}
      - Intel® PRO/100 VE Desktop Connection - Packet Scheduler Miniport
 
 [1108] 10:11:15:367: ElNdisuioEnumerateInterfaces: DeviceIoControl IOCTL_NDISUIO_QUERY_BINDING has no more entries
 [1108] 10:11:15:383: Device: \DEVICE\{BEEC21CF-A056-4649-AD22-EDDF64CD0841}
 [1108] 10:11:15:383: Description: Linksys Wireless-G PCI Adapter - Packet Scheduler Miniport
 [1108] 10:11:15:383: ElEnumAndOpenInterfaces: Found interface after enumeration \DEVICE\{BEEC21CF-A056-4649-AD22-EDDF64CD0841}
 [1108] 10:11:15:383: ElEnumAndOpenInterfaces: Did NOT find PCB already existing for interface
 [1108] 10:11:15:383: ElOpenInterfaceHandle: Opening handle for \DEVICE\{BEEC21CF-A056-4649-AD22-EDDF64CD0841}
 [1108] 10:11:15:383: ElOpenInterfaceHandle: Trying to access NDIS Device: \DEVICE\{BEEC21CF-A056-4649-AD22-EDDF64CD0841}
 
 [1108] 10:11:15:383: ElOpenInterfaceHandle: OpenIntfHandle(\DEVICE\{BEEC21CF-A056-4649-AD22-EDDF64CD0841}) = 660
 [1108] 10:11:15:383: ElOpenInterfaceHandle: Opened handle 00000294 with dwRetCode 0
 [1108] 10:11:15:383: ElCreatePort: Entered for Handle=(00000294), GUID=({BEEC21CF-A056-4649-AD22-EDDF64CD0841}), Name=(Linksys Wireless-G PCI Adapter - Packet Scheduler Miniport), ZCId=(0), UserData=(00000000) Notification=<3>
 [1108] 10:11:15:383: ElCreatePort: No PCB found for {BEEC21CF-A056-4649-AD22-EDDF64CD0841}
 [1108] 10:11:15:383: ElGetInterfaceNdisStatistics: pwszDeviceInterfaceName = (\Device\{BEEC21CF-A056-4649-AD22-EDDF64CD0841})
 [1108] 10:11:15:383: ElCreatePort: Ignoring WLAN indications for pZCConnectInfo == NULL
 [1108] 10:11:15:383: ElEnumAndOpenInterfaces: Error in CreatePort = 13
 [1108] 10:11:15:383: ElCloseInterfaceHandle(0x294,{BEEC21CF-A056-4649-AD22-EDDF64CD0841}) entered
 [1108] 10:11:15:383: Device: \DEVICE\{76F19F9C-4738-4415-BDE4-FFA009978A55}
 [1108] 10:11:15:383: Description: Intel® PRO/100 VE Desktop Connection - Packet Scheduler Miniport
 [1108] 10:11:15:383: ElEnumAndOpenInterfaces: Completed with retcode = 0
 [1108] 10:11:15:383: ElProcessEapConfigChange: Finished with error 0
 [1072] 10:11:18:445: EAPOLQueryGUIDNCSState: 802.1X Port Inexistant. Returning S_OK
 [1108] 10:11:18:445: ElMediaEventsHandler entered -- EventType=<7>
 [1108] 10:11:18:445: ElMediaEventsHandler: Calling ElZeroConfigEvent 
 [1108] 10:11:18:445: ElGetInterfaceParams:  SsidLength=<9>, Found EapTypeId=<13>, SSIDLen=<9>
 [1108] 10:11:18:445: ElEnumAndOpenInterfaces: DeviceDesc = , GUID = {BEEC21CF-A056-4649-AD22-EDDF64CD0841}
 [1108] 10:11:18:445: ElNdisuioEnumerateInterfaces: Opening handle
 [1108] 10:11:18:445: NdisuioEnumerateInterfaces: NDISUIO bound to: (0) \DEVICE\{BEEC21CF-A056-4649-AD22-EDDF64CD0841}
      - Linksys Wireless-G PCI Adapter - Packet Scheduler Miniport
 
 [1108] 10:11:18:445: NdisuioEnumerateInterfaces: NDISUIO bound to: (1) \DEVICE\{76F19F9C-4738-4415-BDE4-FFA009978A55}
      - Intel® PRO/100 VE Desktop Connection - Packet Scheduler Miniport
 
 [1108] 10:11:18:445: ElNdisuioEnumerateInterfaces: DeviceIoControl IOCTL_NDISUIO_QUERY_BINDING has no more entries
 [1108] 10:11:18:445: Device: \DEVICE\{BEEC21CF-A056-4649-AD22-EDDF64CD0841}
 [1108] 10:11:18:445: Description: Linksys Wireless-G PCI Adapter - Packet Scheduler Miniport
 [1108] 10:11:18:445: ElEnumAndOpenInterfaces: Found interface after enumeration \DEVICE\{BEEC21CF-A056-4649-AD22-EDDF64CD0841}
 [1108] 10:11:18:445: ElEnumAndOpenInterfaces: Did NOT find PCB already existing for interface
 [1108] 10:11:18:445: ElOpenInterfaceHandle: Opening handle for \DEVICE\{BEEC21CF-A056-4649-AD22-EDDF64CD0841}
 [1108] 10:11:18:445: ElOpenInterfaceHandle: Trying to access NDIS Device: \DEVICE\{BEEC21CF-A056-4649-AD22-EDDF64CD0841}
 
 [1108] 10:11:18:445: ElOpenInterfaceHandle: OpenIntfHandle(\DEVICE\{BEEC21CF-A056-4649-AD22-EDDF64CD0841}) = 660
 [1108] 10:11:18:445: ElOpenInterfaceHandle: BindIoCompletionCallback already done !!!
 [1108] 10:11:18:445: ElOpenInterfaceHandle: Opened handle 00000294 with dwRetCode 0
 [1108] 10:11:18:445: ElCreatePort: Entered for Handle=(00000294), GUID=({BEEC21CF-A056-4649-AD22-EDDF64CD0841}), Name=(Linksys Wireless-G PCI Adapter - Packet Scheduler Miniport), ZCId=(24), UserData=(000D39B4) Notification=<4>
 [1108] 10:11:18:445: ElCreatePort: No PCB found for {BEEC21CF-A056-4649-AD22-EDDF64CD0841}
 [1108] 10:11:18:445: ElGetInterfaceNdisStatistics: pwszDeviceInterfaceName = (\Device\{BEEC21CF-A056-4649-AD22-EDDF64CD0841})
 [1108] 10:11:18:460: ElCreatePort: ElNdisuioQueryOIDValue for OID_802_3_CURRENT_ADDRESS successful
 [1108] 10:11:18:460: 00 0F 66 E6 89 E9 00 00 00 00 00 00 00 00 00 00 |..f.............|
 [1108] 10:11:18:460: ElCreatePort: ElNdisuioQueryOIDValue for OID_802_11_INFRASTRUCTURE_MODE successful, Mode = (1)
 [1108] 10:11:18:460: ElCreatePort: ElNdisuioQueryOIDValue for OID_802_11_BSSID successful
 [1108] 10:11:18:460: 00 0F B5 35 09 5C 00 00 00 00 00 00 00 00 00 00 |...5.\..........|
 [1108] 10:11:18:460: ElCreatePort: prdUserData not valid
 [1108] 10:11:18:460: ElCreatePort: Port Network Identifier:
 [1108] 10:11:18:460: 64 61 77 67 68 61 77 73 65 00 00 00 00 00 00 00 |dawghawse.......|
 [1108] 10:11:18:460: ElCreatePort: pPCB=<000FB358>, AuthenticationMode=<3>, EncyptionStatus=<4>, usKeyDescription=<1>
 [1108] 10:11:18:460: TIMER: Create  PCB                     Time: 2097148
 [1108] 10:11:18:460: ElInitRegPortData: ElGetCustomAuthData returned error 603
 [1108] 10:11:18:460: ElInitRegPortData: completed with error 0
 [1108] 10:11:18:460: ElGetInterfaceParams:  SsidLength=<9>, Found EapTypeId=<13>, SSIDLen=<9>
 [1108] 10:11:18:460: ElReadPerPortRegistryParams: Setting dwEapFlags=<e0000000>
 [1108] 10:11:18:460: ElGetCustomAuthData: SSIDLen=<9>, EapTypeId=<13>, Offset=<52/712>, dwAuthData=<42>
 [1108] 10:11:18:460: ElGetCustomAuthData: SSIDLen=<9>, EapTypeId=<13>, Offset=<52/712>, dwAuthData=<42>
 [1108] 10:11:18:460: ElReadPerPortRegistryParams: dwTotalMaxAuthFailCount = (6)
 [1108] 10:11:18:460: ElReadFromPort entered
 [1108] 10:11:18:460: ElReadFromPort: pPCB = 000FB358, RefCnt = 3
 [1108] 10:11:18:460: FSMConnecting entered for port Linksys Wireless-G PCI Adapter - Packet Scheduler Miniport
 [1108] 10:11:18:460: TIMER: Restart PCB                     Time: 60
 [1108] 10:11:18:460: ElWriteToPort entered: Pkt Length = 7
 [1108] 10:11:18:460: ElWriteToPort: pPCB = 000FB358, RefCnt = 4
 [1108] 10:11:18:460: ElWriteToInterface entered
 [1108] 10:11:18:460: ElWriteToInterface completed, RetCode = 0
 [1108] 10:11:18:460: Setting state CONNECTING for port Linksys Wireless-G PCI Adapter - Packet Scheduler Miniport
 [1108] 10:11:18:460: FSMConnecting completed for port Linksys Wireless-G PCI Adapter - Packet Scheduler Miniport
 [1108] 10:11:18:460: ElCreatePort: Completed for GUID= {BEEC21CF-A056-4649-AD22-EDDF64CD0841}, Name = Linksys Wireless-G PCI Adapter - Packet Scheduler Miniport
 [1108] 10:11:18:460: ElEnumAndOpenInterfaces: CreatePort successful
 [1108] 10:11:18:460: ElCreateInterfaceEntry: Added to hash table GUID= {BEEC21CF-A056-4649-AD22-EDDF64CD0841} : Desc= Linksys Wireless-G PCI Adapter - Packet Scheduler Miniport at Index=0
 [1108] 10:11:18:460: Device: \DEVICE\{76F19F9C-4738-4415-BDE4-FFA009978A55}
 [1108] 10:11:18:460: Description: Intel® PRO/100 VE Desktop Connection - Packet Scheduler Miniport
 [1108] 10:11:18:460: ElEnumAndOpenInterfaces: Completed with retcode = 0
 [1636] 10:11:18:460: ElIoCompletionRoutine called, 19 bytes xferred
 [1636] 10:11:18:460: ElWriteCompletionRoutine sent out 19 bytes with error 0
 [1636] 10:11:18:460: ElWriteCompletionRoutine: pPCB= 000FB358, RefCnt = 3
 [1108] 10:11:18:460: ElIoCompletionRoutine called, 77 bytes xferred
 [1108] 10:11:18:460: ElReadCompletionRoutine entered, 77 bytes recvd
 [1108] 10:11:18:460: ProcessReceivedPacket entered, length = 77
 [1108] 10:11:18:492: ProcessReceivedPacket: EAP_Packet
 [1108] 10:11:18:507: ProcessReceivedPacket: EAPOLSTATE_CONNECTING
 [1108] 10:11:18:507: TIMER: Restart PCB                     Time: 2097148
 [1108] 10:11:18:507: FSMAcquired entered for port Linksys Wireless-G PCI Adapter - Packet Scheduler Miniport
 [1108] 10:11:18:507: TIMER: Restart PCB                     Time: 30
 [1108] 10:11:18:507: ElEapEnd entered
 [1108] 10:11:18:507: ElEapBegin entered
 [1108] 10:11:18:507: ElEapBegin done
 [1108] 10:11:18:507: ElEapWork: EapolPkt created at 0014FDF0
 [1108] 10:11:18:507: ElEapMakeMessage entered
 [1108] 10:11:18:507: ElParseIdentityString: DisplayString = dawghawse
 [1108] 10:11:18:507: ElParseIdentityString: LocalIdString = networkid=dawghawse,nasid=dawghawse,portid=0
 [1108] 10:11:18:507: ElParseIdentityString: LocalIdString Length = 54
 [1108] 10:11:18:507: ElParseIdentityString: NetworkID Size = 10
 [1108] 10:11:18:507: Got NetworkId = dawghawse
 [1108] 10:11:18:507: Got NASId = dawghawse
 [1108] 10:11:18:507: ElParseIdentityString: For PortId, length = 1
 [1108] 10:11:18:507: Got PortId = 0
 [1108] 10:11:18:507: ElParseIdentityString: End of String reached
 [1108] 10:11:18:507: ElParseIdentityString: Out of while loop
 [1108] 10:11:18:507: ElParseIdentityString: Out of while loop: NO ERROR
 [1108] 10:11:18:507: ElParseIdentityString: Calling NLARegister_802_1X with params {BEEC21CF-A056-4649-AD22-EDDF64CD0841} and networkid=dawghawse,nasid=dawghawse,portid=0
 [1108] 10:11:18:507: NLARegister_802_1X: Entered
 [1108] 10:11:18:507: NLAConnectLPC: Entered
 [1108] 10:11:18:507: NLARegister_802_1X: g_hNLA_LPC_Port != NULL
 [1108] 10:11:18:507: NLARegister_802_1X: Completed with status = 0
 [1108] 10:11:18:507: ElParseIdentityString: Returned after calling NLARegister_802_1X
 [1108] 10:11:18:507: ElGetIdentity: Userlogged, Prev !Machine auth
 [1108] 10:11:18:507: ElGetIdentity: Userlogged, <Maxauth, Prev !Machine auth: !MD5
 [1108] 10:11:18:507: ElGetUserIdentity entered
 [1108] 10:11:18:507: ElGetWinStationUserToken: GetWinStationUserToken failed for SessionId (2) with error (1008)
 [1108] 10:11:18:507: ElGetWinStationUserToken: GetWinStationUserToken failed for session= (2) with error= (1008)
 [1108] 10:11:18:507: ElGetUserIdentity: ElGetWinStationUserToken failed with error (1008)
 [1108] 10:11:18:507: ElGetUserIdentity completed with error 1008
 [1108] 10:11:18:507: ElGetIdentity: Error in ElGetUserIdentity 1008
 [1108] 10:11:18:507: ElGetIdentity: Userlogged, <Maxauth, Prev !Machine auth: ERROR
 [1108] 10:11:18:507: ElEapMakeMessage: Error in ElGetIdentity 1008
 [1108] 10:11:18:507: ElEapWork: ElEapMakeMessage returned error 1008
 [1108] 10:11:18:507: FSMAcquired: Error in ElEapWork 1008
 [1108] 10:11:18:507: FSMAcquired completed for port Linksys Wireless-G PCI Adapter - Packet Scheduler Miniport
 [1108] 10:11:18:507: ProcessReceivedPacket: Reposting buffer on port {BEEC21CF-A056-4649-AD22-EDDF64CD0841}
 [1108] 10:11:18:507: ElReadFromPort entered
 [1108] 10:11:18:507: ElReadFromPort: pPCB = 000FB358, RefCnt = 4
 [1108] 10:11:18:507: ProcessReceivedPacket: pPCB= 000FB358, RefCnt = 3
 [1108] 10:11:18:507: ProcessReceivedPacket exit
 [1072] 10:11:18:507: ElIoCompletionRoutine called, 77 bytes xferred
 [1072] 10:11:18:507: ElReadCompletionRoutine entered, 77 bytes recvd
 [1072] 10:11:18:507: ProcessReceivedPacket entered, length = 77
 [1072] 10:11:18:507: ProcessReceivedPacket: EAP_Packet
 [1072] 10:11:18:507: ProcessReceivedPacket: EAPOLSTATE_CONNECTING
 [1072] 10:11:18:507: TIMER: Restart PCB                     Time: 2097148
 
 hostapd output: ----------------------------------------------------------------------
 
 l2_packet_receive - recvfrom: Network is down
 Configuration file: hostapd.conf
 madwifi_set_iface_flags: dev_up=0
 Using interface ath0 with hwaddr 00:0f:b5:35:09:5c and ssid 'dawghawse'
 madwifi_set_ieee8021x: enabled=1
 madwifi_configure_wpa: group key cipher=1
 madwifi_configure_wpa: pairwise key ciphers=0x2
 madwifi_configure_wpa: key management algorithms=0x1
 madwifi_configure_wpa: rsn capabilities=0x0
 madwifi_configure_wpa: enable WPA= 0x1
 madwifi_set_iface_flags: dev_up=1
 madwifi_set_privacy: enabled=1
 WPA: group state machine entering state GTK_INIT
 GMK - hexdump(len=32): fb 56 eb 61 f2 99 45 59 e6 3a ff 7e 1b 24 aa 01 46 7d 65 e9 c5 88 d8 d7 75 a9 6a 31 35 4e 31 82
 GTK - hexdump(len=32): e1 3e c4 5d 4b ac ee 53 55 49 eb 26 b3 c7 4c 7c c3 89 ff 15 95 41 6b cd 55 31 5f c9 57 94 4f 7a
 WPA: group state machine entering state SETKEYSDONE
 madwifi_set_key: alg=TKIP addr=00:00:00:00:00:00 key_idx=1
 Flushing old station entries
 madwifi_sta_deauth: addr=ff:ff:ff:ff:ff:ff reason_code=3
 Deauthenticate all stations
 Wireless event: cmd=0x8b19 len=12
 Wireless event: cmd=0x8c03 len=20
 ath0: STA 00:0f:66:e6:89:e9 IEEE 802.11: associated
   New STA
 ath0: STA 00:0f:66:e6:89:e9 WPA: event 1 notification
 ath0: STA 00:0f:66:e6:89:e9 IEEE 802.1X: start authentication
 EAP: State machine created
 IEEE 802.1X: 00:0f:66:e6:89:e9 AUTH_PAE entering state INITIALIZE
 IEEE 802.1X: 00:0f:66:e6:89:e9 BE_AUTH entering state INITIALIZE
 IEEE 802.1X: 00:0f:66:e6:89:e9 REAUTH_TIMER entering state INITIALIZE
 IEEE 802.1X: 00:0f:66:e6:89:e9 AUTH_KEY_TX entering state NO_KEY_TRANSMIT
 IEEE 802.1X: 00:0f:66:e6:89:e9 KEY_RX entering state NO_KEY_RECEIVE
 IEEE 802.1X: 00:0f:66:e6:89:e9 CTRL_DIR entering state IN_OR_BOTH
 IEEE 802.1X: 00:0f:66:e6:89:e9 AUTH_PAE entering state INITIALIZE
 IEEE 802.1X: 00:0f:66:e6:89:e9 BE_AUTH entering state IDLE
 IEEE 802.1X: 00:0f:66:e6:89:e9 KEY_RX entering state NO_KEY_RECEIVE
 IEEE 802.1X: 00:0f:66:e6:89:e9 CTRL_DIR entering state FORCE_BOTH
 IEEE 802.1X: 00:0f:66:e6:89:e9 AUTH_PAE entering state INITIALIZE
 IEEE 802.1X: 00:0f:66:e6:89:e9 KEY_RX entering state NO_KEY_RECEIVE
 ath0: STA 00:0f:66:e6:89:e9 WPA: start authentication
 WPA: 00:0f:66:e6:89:e9 WPA_PTK entering state INITIALIZE
 madwifi_del_key: addr=00:0f:66:e6:89:e9 key_idx=0
 WPA: 00:0f:66:e6:89:e9 WPA_PTK_GROUP entering state IDLE
 WPA: 00:0f:66:e6:89:e9 WPA_PTK entering state AUTHENTICATION
 WPA: 00:0f:66:e6:89:e9 WPA_PTK entering state AUTHENTICATION2
 IEEE 802.1X: 00:0f:66:e6:89:e9 AUTH_PAE entering state DISCONNECTED
 ath0: STA 00:0f:66:e6:89:e9 IEEE 802.1X: unauthorizing port
 madwifi_set_sta_authorized: addr=00:0f:66:e6:89:e9 authorized=0
 IEEE 802.1X: 00:0f:66:e6:89:e9 REAUTH_TIMER entering state INITIALIZE
 IEEE 802.1X: 00:0f:66:e6:89:e9 AUTH_PAE entering state RESTART
 IEEE 802.1X: Integrated EAP server in use - do not generate EAP-Request/Identity
 IEEE 802.1X: 00:0f:66:e6:89:e9 REAUTH_TIMER entering state INITIALIZE
 IEEE 802.1X: 00:0f:66:e6:89:e9 REAUTH_TIMER entering state INITIALIZE
 EAP: EAP entering state INITIALIZE
 EAP: EAP entering state SELECT_ACTION
 EAP: getDecision: no identity known yet -> CONTINUE
 EAP: EAP entering state PROPOSE_METHOD
 EAP: getNextMethod: type 1
 get_eap_methods(1) => Identity
 EAP: EAP entering state METHOD_REQUEST
 EAP: building EAP-Request: Identifier 103
 EAP: EAP entering state SEND_REQUEST
 EAP: eapReqData -> EAPOL - hexdump(len=59): 01 67 00 3b 01 64 61 77 67 68 61 77 73 65 00 6e 65 74 77 6f 72 6b 69 64 3d 64 61 77 67 68 61 77 73 65 2c 6e 61 73 69 64 3d 64 61 77 67 68 61 77 73 65 2c 70 6f 72 74 69 64 3d 30
 EAP: EAP entering state IDLE
 IEEE 802.1X: 00:0f:66:e6:89:e9 AUTH_PAE entering state CONNECTING
 IEEE 802.1X: 00:0f:66:e6:89:e9 REAUTH_TIMER entering state INITIALIZE
 IEEE 802.1X: 00:0f:66:e6:89:e9 AUTH_PAE entering state AUTHENTICATING
 IEEE 802.1X: 00:0f:66:e6:89:e9 BE_AUTH entering state REQUEST
 IEEE 802.1X: Sending EAP Packet w/ code 1 to 00:0f:66:e6:89:e9 (identifier 103)
 TX EAPOL - hexdump(len=77): 00 0f 66 e6 89 e9 00 0f b5 35 09 5c 88 8e 02 00 00 3b 01 67 00 3b 01 64 61 77 67 68 61 77 73 65 00 6e 65 74 77 6f 72 6b 69 64 3d 64 61 77 67 68 61 77 73 65 2c 6e 61 73 69 64 3d 64 61 77 67 68 61 77 73 65 2c 70 6f 72 74 69 64 3d 30
 IEEE 802.1X: 00:0f:66:e6:89:e9 REAUTH_TIMER entering state INITIALIZE
 IEEE 802.1X: 00:0f:66:e6:89:e9 REAUTH_TIMER entering state INITIALIZE
 IEEE 802.1X: 5 bytes from 00:0f:66:e6:89:e9
    IEEE 802.1X: version=1 type=1 length=0
    ignoring 1 extra octets after IEEE 802.1X packet
 ath0: STA 00:0f:66:e6:89:e9 IEEE 802.1X: received EAPOL-Start from STA
 ath0: STA 00:0f:66:e6:89:e9 WPA: event 5 notification
 WPA: 00:0f:66:e6:89:e9 WPA_PTK entering state AUTHENTICATION2
 IEEE 802.1X: 00:0f:66:e6:89:e9 AUTH_PAE entering state ABORTING
 IEEE 802.1X: 00:0f:66:e6:89:e9 BE_AUTH entering state INITIALIZE
 ath0: STA 00:0f:66:e6:89:e9 IEEE 802.1X: aborting authentication
 IEEE 802.1X: 00:0f:66:e6:89:e9 REAUTH_TIMER entering state INITIALIZE
 IEEE 802.1X: 00:0f:66:e6:89:e9 AUTH_PAE entering state RESTART
 IEEE 802.1X: Integrated EAP server in use - do not generate EAP-Request/Identity
 IEEE 802.1X: 00:0f:66:e6:89:e9 BE_AUTH entering state IDLE
 IEEE 802.1X: 00:0f:66:e6:89:e9 REAUTH_TIMER entering state INITIALIZE
 IEEE 802.1X: 00:0f:66:e6:89:e9 REAUTH_TIMER entering state INITIALIZE
 EAP: EAP entering state INITIALIZE
 EAP: EAP entering state SELECT_ACTION
 EAP: getDecision: no identity known yet -> CONTINUE
 EAP: EAP entering state PROPOSE_METHOD
 EAP: getNextMethod: type 1
 get_eap_methods(1) => Identity
 EAP: EAP entering state METHOD_REQUEST
 EAP: building EAP-Request: Identifier 198
 EAP: EAP entering state SEND_REQUEST
 EAP: eapReqData -> EAPOL - hexdump(len=59): 01 c6 00 3b 01 64 61 77 67 68 61 77 73 65 00 6e 65 74 77 6f 72 6b 69 64 3d 64 61 77 67 68 61 77 73 65 2c 6e 61 73 69 64 3d 64 61 77 67 68 61 77 73 65 2c 70 6f 72 74 69 64 3d 30
 EAP: EAP entering state IDLE
 IEEE 802.1X: 00:0f:66:e6:89:e9 AUTH_PAE entering state CONNECTING
 IEEE 802.1X: 00:0f:66:e6:89:e9 REAUTH_TIMER entering state INITIALIZE
 IEEE 802.1X: 00:0f:66:e6:89:e9 AUTH_PAE entering state AUTHENTICATING
 IEEE 802.1X: 00:0f:66:e6:89:e9 BE_AUTH entering state REQUEST
 IEEE 802.1X: Sending EAP Packet w/ code 1 to 00:0f:66:e6:89:e9 (identifier 198)
 TX EAPOL - hexdump(len=77): 00 0f 66 e6 89 e9 00 0f b5 35 09 5c 88 8e 02 00 00 3b 01 c6 00 3b 01 64 61 77 67 68 61 77 73 65 00 6e 65 74 77 6f 72 6b 69 64 3d 64 61 77 67 68 61 77 73 65 2c 6e 61 73 69 64 3d 64 61 77 67 68 61 77 73 65 2c 70 6f 72 74 69 64 3d 30
 IEEE 802.1X: 00:0f:66:e6:89:e9 REAUTH_TIMER entering state INITIALIZE
 IEEE 802.1X: 00:0f:66:e6:89:e9 REAUTH_TIMER entering state INITIALIZE
 IEEE 802.1X: 00:0f:66:e6:89:e9 REAUTH_TIMER entering state INITIALIZE
  -- repeats for a while--
 ... the supplicant will try EAPOL-Start several more times, but the
 ... result is the same as above.
 
 
 hostapd.conf ----------------------------------------------------------------------
 
 ssid=dawghawse
 
 auth_algs=3
 
 # IEEE 802.1X-2004
 
 ieee8021x=1
 
 eap_message=dawghawse\0networkid=dawghawse,nasid=dawghawse,portid=0
 
 wep_key_len_broadcast=0
 wep_key_len_unicast=0
 wep_rekey_period=0
 
 eapol_key_index_workaround=1
 
 eap_reauth_period=3600
 
 # Integrated EAP server
 
 eap_server=1
 
 wpa=1
 
 wpa_key_mgmt=WPA-EAP
 
 wpa_pairwise=TKIP
 
 





More information about the HostAP mailing list