[ Re: eap-ttls failing]

Josh Hiner josh at remc1.org
Tue Jan 27 19:53:06 CET 2009


tnt at kalik.net wrote:
>> Ok, made new client cert and now it shows valid and displays "Provides
>> your identity to a remote Computer" as the intended purpose and on the
>> Details tab displays the correct info etc... The Certification Path
>> displays valid. Still same problem though (exact same problem) of just
>> sitting there at "Attempting to authenticate".
>>
>>     
>
> Have you deleted the old certificate from the certificate store? What
> does eapol.log say now.
>
> Ivan Kalik
> Kalik Informatika ISP
>
> -
> List info/subscribe/unsubscribe? See http://www.freeradius.org/list/users.html
>
>   
Yep, I have deleted the old certificate =D.

Here is what epol.log says. I see the part where the card goes into 
authenticate mode over and over again but I dont see a critical error. 
Search for this line where authentication just starts over and over? 
This appears on all laptops with different wireless cards but all use 
windows xp to setup eap-tls:

[1712] 13:41:51:028: ProcessReceivedPacket: EAPOLSTATE_AUTHENTICATING

There is an error about updating a registry key or something but that 
error should be normal as I've seen it on many machines that are able to 
connect via peap and ttls. Notice at the end it reports a disconnect, 
that is me finally clicking disconnect to stop the authentication loop.

<start of log>

[1208] 13:41:01:687: ElSessionChangeHandler: CONNECT for session = (0)


[1224] 13:41:01:687: ElUserLogonCallback: UserloggedOn = 0

[1224] 13:41:01:777: ElCheckUserModuleReady: No user logged on

[1224] 13:41:01:787: ElEapEnd entered

[1224] 13:41:01:787: FSMLogoff entered for port Intel(R) PRO/100 VE 
Network Connection #2 - Packet Scheduler Miniport

[1224] 13:41:01:787: ElEapEnd entered

[1224] 13:41:01:787: Setting state LOGOFF for port Intel(R) PRO/100 VE 
Network Connection #2 - Packet Scheduler Miniport

[1224] 13:41:01:787: FSMLogoff completed for port Intel(R) PRO/100 VE 
Network Connection #2 - Packet Scheduler Miniport

[1224] 13:41:01:787: ElReStartPort: Entered: pPCB=<000DEBE0>, 
pZCConnectInfo=<00000000>, Refcnt=<2>, EapFlags=<c0000000>, Notification=<a>

[1224] 13:41:01:787: ElRestartPortLocked: Entered: pPCB=<000DEBE0>, 
pZCConnectInfo=<00000000>, Refcnt=<2>, EapFlags=<c0000000>, Notification=<a>

[1224] 13:41:01:787: ElGetInterfaceNdisStatistics: 
pwszDeviceInterfaceName = (\Device\{3C90646A-0A9A-43B5-BFCC-7FE335265032})

[1224] 13:41:01:787: ElRestartPortLocked: Resetting Credentials for 
Intel(R) PRO/100 VE Network Connection #2 - Packet Scheduler Miniport

[1224] 13:41:01:787: ElReadPerPortRegistryParams: Setting 
dwEapFlags=<c0000000>

[1224] 13:41:01:797: ElReadPerPortRegistryParams: 
dwTotalMaxAuthFailCount = (3)

[1224] 13:41:01:797: DisconnectedPCB: Media is already disconnected 
<<IGNORE>>

[1224] 13:41:01:797: ElUserLogonCallback: completed with error 0

[1208] 13:41:02:699: ElSessionChangeHandler: LOGON for session = (0)

[1504] 13:41:02:709: ElUserLogonCallback: UserloggedOn = 1

[1504] 13:41:02:709: ElUserLogonCallback: User logon already detected, 
returning without processing

[1504] 13:41:02:709: ElUserLogonCallback: completed with error 0

[3828] 13:41:25:892: EAPOLQueryGUIDNCSState: For Port Intel(R) PRO/100 
VE Network Connection #2 - Packet Scheduler Miniport returning S_FALSE

[3828] 13:41:25:952: EAPOLQueryGUIDNCSState: 802.1X Port Inexistant for 
{FD7F1225-FD60-480C-8857-1DF3ECBC9C18}. Returning S_OK

[3828] 13:41:28:926: EAPOLTrayIconReady: Advise username = PINKY\jdhiner

[1504] 13:41:28:937: EAPOLTrayIconReadyWorker: Advise username = 
PINKY\jdhiner

[1504] 13:41:29:938: ElGetLoggedOnUserName: Got User Name PINKY\jdhiner

[1504] 13:41:29:938: EAPOLTrayIconReadyWorker: Tray icon ready for 
username PINKY\jdhiner

[1180] 13:41:35:887: ElGetInterfaceParams:  SsidLength=<11>, Found 
EapTypeId=<13>, SSIDLen=<11>

[1180] 13:41:35:887: ElGetCustomAuthData: SSIDLen=<11>, EapTypeId=<13>, 
Offset=<52/106>, dwAuthData=<42>

[1180] 13:41:35:887: ElGetCustomAuthData: SSIDLen=<11>, EapTypeId=<13>, 
Offset=<52/106>, dwAuthData=<42>

[1180] 13:41:35:887: ElGetCustomAuthData: SSIDLen=<11>, EapTypeId=<25>, 
Offset=<52/106>, dwAuthData=<0>

[1548] 13:41:35:897: ElGetInterfaceParams:  SsidLength=<11>, Found 
EapTypeId=<13>, SSIDLen=<11>

[1180] 13:41:35:897: ElGetCustomAuthData: SSIDLen=<11>, EapTypeId=<13>, 
Offset=<52/106>, dwAuthData=<42>

[1180] 13:41:35:897: ElGetCustomAuthData: SSIDLen=<11>, EapTypeId=<13>, 
Offset=<52/106>, dwAuthData=<42>

[1180] 13:41:35:897: ElGetCustomAuthData: SSIDLen=<11>, EapTypeId=<25>, 
Offset=<52/106>, dwAuthData=<0>

[1180] 13:41:35:897: ElGetInterfaceParams:  SsidLength=<13>, Found 
EapTypeId=<13>, SSIDLen=<13>

[1548] 13:41:35:897: ElGetCustomAuthData: SSIDLen=<13>, EapTypeId=<13>, 
Offset=<52/104>, dwAuthData=<40>

[1548] 13:41:35:897: ElGetCustomAuthData: SSIDLen=<13>, EapTypeId=<13>, 
Offset=<52/104>, dwAuthData=<40>

[1548] 13:41:35:897: ElGetCustomAuthData: SSIDLen=<13>, EapTypeId=<25>, 
Offset=<52/104>, dwAuthData=<0>

[1180] 13:41:43:598: ElSetCustomAuthData: EapTypeId=<13>, 
SSIDLength=<11>, InfoLength=<42>

[1180] 13:41:43:598: ElSetCustomAuthData: Set value succeeded, 
fFound=<1>, dwEapBlob=<106>, dwSizeOfSSID=<11>

[1180] 13:41:43:598: ElSetCustomAuthData: EapTypeId=<25>, 
SSIDLength=<11>, InfoLength=<0>

[1180] 13:41:43:598: ElSetCustomAuthData: Set value succeeded, 
fFound=<1>, dwEapBlob=<106>, dwSizeOfSSID=<11>

[1180] 13:41:43:598: ElSetInterfaceParams:  EapTypeId=<13> SSIDLen=<11>

[1180] 13:41:43:598: Setting stuff in registry for 
{B123A337-9DAB-45CD-B148-7A2E8A53AAED}

[1180] 13:41:43:598: ElSetInterfaceParams: Succeeded,  EapTypeId=<13> 
fFound=<1>, SSIDLen=<11>

[1180] 13:41:43:598: ElPostEapConfigChanged: SSIDLength=<11>

[1548] 13:41:43:598: ElWZCCfgUpdateSettings: Error in RegOpenKeyEx for 
base key, 2

[1548] 13:41:43:598: ElWZCCfgChangeHandler: ElWZCCfgUpdateSettings HKCU 
failed with error (2)

[1504] 13:41:43:608: ElGetInterfaceParams:  SsidLength=<11>, Found 
EapTypeId=<13>, SSIDLen=<11>

[1504] 13:41:43:608: ElProcessEapConfigChange: PCB not started, enabled, 
starting PCB

[1504] 13:41:43:608: ElZeroConfigNotify: Handle=(0), failcount=(0), 
lastauthtype=(0)

[1504] 13:41:46:702: ElEnumAndOpenInterfaces: DeviceDesc = , GUID = 
{B123A337-9DAB-45CD-B148-7A2E8A53AAED}

[1504] 13:41:46:702: ElNdisuioEnumerateInterfaces: Opening handle

[1504] 13:41:46:702: NdisuioEnumerateInterfaces: NDISUIO bound to: (0) 
\DEVICE\{3C90646A-0A9A-43B5-BFCC-7FE335265032}
     - Intel(R) PRO/100 VE Network Connection #2 - Packet Scheduler Miniport


[1504] 13:41:46:702: NdisuioEnumerateInterfaces: NDISUIO bound to: (1) 
\DEVICE\{B123A337-9DAB-45CD-B148-7A2E8A53AAED}
     - Wireless-G Notebook Adapter with RangeBooster - Packet Scheduler 
Miniport


[1504] 13:41:46:702: ElNdisuioEnumerateInterfaces: DeviceIoControl 
IOCTL_NDISUIO_QUERY_BINDING has no more entries

[1504] 13:41:46:702: Device: \DEVICE\{3C90646A-0A9A-43B5-BFCC-7FE335265032}

[1504] 13:41:46:702: Description: Intel(R) PRO/100 VE Network Connection 
#2 - Packet Scheduler Miniport

[1504] 13:41:46:702: Device: \DEVICE\{B123A337-9DAB-45CD-B148-7A2E8A53AAED}

[1504] 13:41:46:702: Description: Wireless-G Notebook Adapter with 
RangeBooster - Packet Scheduler Miniport

[1504] 13:41:46:702: ElEnumAndOpenInterfaces: Found interface after 
enumeration \DEVICE\{B123A337-9DAB-45CD-B148-7A2E8A53AAED}

[1504] 13:41:46:702: ElEnumAndOpenInterfaces: Did NOT find PCB already 
existing for interface

[1504] 13:41:46:702: ElOpenInterfaceHandle: Opening handle for 
\DEVICE\{B123A337-9DAB-45CD-B148-7A2E8A53AAED}

[1504] 13:41:46:702: ElOpenInterfaceHandle: Trying to access NDIS 
Device: \DEVICE\{B123A337-9DAB-45CD-B148-7A2E8A53AAED}


[1504] 13:41:46:702: ElOpenInterfaceHandle: 
OpenIntfHandle(\DEVICE\{B123A337-9DAB-45CD-B148-7A2E8A53AAED}) = 1243504

[1504] 13:41:46:702: ElOpenInterfaceHandle: Opened handle 0012F970 with 
dwRetCode 0

[1504] 13:41:46:702: ElCreatePort: Entered for Handle=(0012F970), 
GUID=({B123A337-9DAB-45CD-B148-7A2E8A53AAED}), Name=(Wireless-G Notebook 
Adapter with RangeBooster - Packet Scheduler Miniport), ZCId=(0), 
UserData=(00000000) Notification=<3>

[1504] 13:41:46:702: ElCreatePort: No PCB found for 
{B123A337-9DAB-45CD-B148-7A2E8A53AAED}

[1504] 13:41:46:702: ElGetInterfaceNdisStatistics: 
pwszDeviceInterfaceName = (\Device\{B123A337-9DAB-45CD-B148-7A2E8A53AAED})

[1504] 13:41:46:702: ElCreatePort: Ignoring WLAN indications for 
pZCConnectInfo == NULL

[1504] 13:41:46:702: ElEnumAndOpenInterfaces: Error in CreatePort = 13

[1504] 13:41:46:702: 
ElCloseInterfaceHandle(0x12f970,{B123A337-9DAB-45CD-B148-7A2E8A53AAED}) 
entered

[1504] 13:41:46:702: ElEnumAndOpenInterfaces: Completed with retcode = 0

[1504] 13:41:46:702: ElProcessEapConfigChange: Finished with error 0

[1712] 13:41:49:947: EAPOLQueryGUIDNCSState: 802.1X Port Inexistant for 
{B123A337-9DAB-45CD-B148-7A2E8A53AAED}. Returning S_OK

[1504] 13:41:49:957: ElMediaEventsHandler entered -- EventType=<7>

[1504] 13:41:49:957: ElMediaEventsHandler: Calling ElZeroConfigEvent

[1504] 13:41:49:957: ElGetInterfaceParams:  SsidLength=<11>, Found 
EapTypeId=<13>, SSIDLen=<11>

[1504] 13:41:49:957: ElEnumAndOpenInterfaces: DeviceDesc = , GUID = 
{B123A337-9DAB-45CD-B148-7A2E8A53AAED}

[1504] 13:41:49:957: ElNdisuioEnumerateInterfaces: Opening handle

[1504] 13:41:49:957: NdisuioEnumerateInterfaces: NDISUIO bound to: (0) 
\DEVICE\{3C90646A-0A9A-43B5-BFCC-7FE335265032}
     - Intel(R) PRO/100 VE Network Connection #2 - Packet Scheduler Miniport


[1504] 13:41:49:957: NdisuioEnumerateInterfaces: NDISUIO bound to: (1) 
\DEVICE\{B123A337-9DAB-45CD-B148-7A2E8A53AAED}
     - Wireless-G Notebook Adapter with RangeBooster - Packet Scheduler 
Miniport


[1504] 13:41:49:957: ElNdisuioEnumerateInterfaces: DeviceIoControl 
IOCTL_NDISUIO_QUERY_BINDING has no more entries

[1504] 13:41:49:957: Device: \DEVICE\{3C90646A-0A9A-43B5-BFCC-7FE335265032}

[1504] 13:41:49:957: Description: Intel(R) PRO/100 VE Network Connection 
#2 - Packet Scheduler Miniport

[1504] 13:41:49:957: Device: \DEVICE\{B123A337-9DAB-45CD-B148-7A2E8A53AAED}

[1504] 13:41:49:957: Description: Wireless-G Notebook Adapter with 
RangeBooster - Packet Scheduler Miniport

[1504] 13:41:49:957: ElEnumAndOpenInterfaces: Found interface after 
enumeration \DEVICE\{B123A337-9DAB-45CD-B148-7A2E8A53AAED}

[1504] 13:41:49:957: ElEnumAndOpenInterfaces: Did NOT find PCB already 
existing for interface

[1504] 13:41:49:957: ElOpenInterfaceHandle: Opening handle for 
\DEVICE\{B123A337-9DAB-45CD-B148-7A2E8A53AAED}

[1504] 13:41:49:957: ElOpenInterfaceHandle: Trying to access NDIS 
Device: \DEVICE\{B123A337-9DAB-45CD-B148-7A2E8A53AAED}


[1504] 13:41:49:957: ElOpenInterfaceHandle: 
OpenIntfHandle(\DEVICE\{B123A337-9DAB-45CD-B148-7A2E8A53AAED}) = 1243504

[1504] 13:41:49:957: ElOpenInterfaceHandle: Opened handle 0012F970 with 
dwRetCode 0

[1504] 13:41:49:957: ElCreatePort: Entered for Handle=(0012F970), 
GUID=({B123A337-9DAB-45CD-B148-7A2E8A53AAED}), Name=(Wireless-G Notebook 
Adapter with RangeBooster - Packet Scheduler Miniport), ZCId=(127), 
UserData=(0299BB88) Notification=<4>

[1504] 13:41:49:957: ElCreatePort: No PCB found for 
{B123A337-9DAB-45CD-B148-7A2E8A53AAED}

[1504] 13:41:49:957: ElGetInterfaceNdisStatistics: 
pwszDeviceInterfaceName = (\Device\{B123A337-9DAB-45CD-B148-7A2E8A53AAED})

[1504] 13:41:49:977: ElCreatePort: ElNdisuioQueryOIDValue for 
OID_802_3_CURRENT_ADDRESS successful

[1504] 13:41:49:977: 00 16 B6 5C AC DD 00 00 00 00 00 00 00 00 00 00 
|...\............|

[1504] 13:41:49:977: ElCreatePort: ElNdisuioQueryOIDValue for 
OID_802_11_INFRASTRUCTURE_MODE successful, Mode = (1)

[1504] 13:41:49:977: ElCreatePort: ElNdisuioQueryOIDValue for 
OID_802_11_BSSID successful

[1504] 13:41:49:977: 00 1F 41 3A 82 F9 00 00 00 00 00 00 00 00 00 00 
|..A:............|

[1504] 13:41:49:977: ElCreatePort: prdUserData not valid

[1504] 13:41:49:977: ElCreatePort: Port Network Identifier:

[1504] 13:41:49:977: 43 43 49 53 44 2D 52 45 4D 43 31 00 00 00 00 00 
|CCISD-REMC1.....|

[1504] 13:41:49:977: ElCreatePort: pPCB=<000E7E38>, 
AuthenticationMode=<3>, EncyptionStatus=<6>, usKeyDescription=<0>

[1504] 13:41:49:977: TIMER: Create  PCB                     Time: 2097148

[1504] 13:41:49:977: ElInitRegPortData: ElGetCustomAuthData returned 
error 603

[1504] 13:41:49:977: ElInitRegPortData: completed with error 0

[1504] 13:41:49:977: ElGetInterfaceParams:  SsidLength=<11>, Found 
EapTypeId=<13>, SSIDLen=<11>

[1504] 13:41:49:977: ElReadPerPortRegistryParams: Setting 
dwEapFlags=<80000000>

[1504] 13:41:49:977: ElGetCustomAuthData: SSIDLen=<11>, EapTypeId=<13>, 
Offset=<52/106>, dwAuthData=<42>

[1504] 13:41:49:977: ElGetCustomAuthData: SSIDLen=<11>, EapTypeId=<13>, 
Offset=<52/106>, dwAuthData=<42>

[1504] 13:41:49:977: ElReadPerPortRegistryParams: 
dwTotalMaxAuthFailCount = (3)

[1504] 13:41:49:977: TIMER: Create  PMKCACHE                Time: 2097148

[1504] 13:41:49:977: ElQueryBinaryOID(Wireless-G Notebook Adapter with 
RangeBooster - Packet Scheduler Miniport, 0xd010122)

[1504] 13:41:49:977: Device Wireless-G Notebook Adapter with 
RangeBooster - Packet Scheduler Miniport supports 4 PMKIDs in its cache

[1504] 13:41:49:977: TIMER: Create  PREAUTH                 Time: 2097148

[1712] 13:41:49:977: EAPOLQueryGUIDNCSState: For Port Wireless-G 
Notebook Adapter with RangeBooster - Packet Scheduler Miniport returning 
S_FALSE

[1504] 13:41:49:977: ElReadFromPort entered, pPCB = 000E7E38

[1504] 13:41:49:977: ElReadFromPort: pPCB = 000E7E38, RefCnt = 3

[1504] 13:41:49:977: FSMConnecting entered for port Wireless-G Notebook 
Adapter with RangeBooster - Packet Scheduler Miniport

[1504] 13:41:50:027: Current Mode is NOT WPA2. PreAuth disabled

[1504] 13:41:50:047: TIMER: Restart PCB                     Time: 60

[1504] 13:41:50:047: Sending EAPOL-Start frame on the interface 
Wireless-G Notebook Adapter with RangeBooster - Packet Scheduler Miniport

[1504] 13:41:50:047: ElWriteToPort entered: Pkt Length = 7

[1504] 13:41:50:047: ElWriteToPort: pPCB = 000E7E38, RefCnt = 5

[1504] 13:41:50:047: ElWriteToInterface entered

[1504] 13:41:50:047: ElWriteToInterface completed, RetCode = 0

[1504] 13:41:50:047: Setting state CONNECTING for port Wireless-G 
Notebook Adapter with RangeBooster - Packet Scheduler Miniport

[1504] 13:41:50:047: FSMConnecting completed for port Wireless-G 
Notebook Adapter with RangeBooster - Packet Scheduler Miniport

[1712] 13:41:50:047: EAPOLQueryGUIDNCSState: For Port Wireless-G 
Notebook Adapter with RangeBooster - Packet Scheduler Miniport returning 
S_FALSE

[1504] 13:41:50:047: ElCreatePort: Completed for GUID= 
{B123A337-9DAB-45CD-B148-7A2E8A53AAED}, Name = Wireless-G Notebook 
Adapter with RangeBooster - Packet Scheduler Miniport

[1504] 13:41:50:047: ElEnumAndOpenInterfaces: CreatePort successful

[1504] 13:41:50:047: ElCreateInterfaceEntry: Added to hash table GUID= 
{B123A337-9DAB-45CD-B148-7A2E8A53AAED} : Desc= Wireless-G Notebook 
Adapter with RangeBooster - Packet Scheduler Miniport at Index=0

[1504] 13:41:50:047: ElEnumAndOpenInterfaces: Completed with retcode = 0

[1504] 13:41:50:047: ElWriteCompletionRoutine sent out 19 bytes with error 0

[1504] 13:41:50:047: ElWriteCompletionRoutine: pPCB= 000E7E38, RefCnt = 3

[1504] 13:41:50:047: EapolReceiveDataPacket: receive 55 bytes

[1504] 13:41:50:047: ProcessReceivedPacket entered, length = 51

[1504] 13:41:50:047: ProcessReceivedPacket: EAP_Packet

[1504] 13:41:50:047: ProcessReceivedPacket: EAPOLSTATE_CONNECTING

[1504] 13:41:50:047: TIMER: Restart PCB                     Time: 2097148

[1504] 13:41:50:047: FSMAcquired entered for port Wireless-G Notebook 
Adapter with RangeBooster - Packet Scheduler Miniport

[1504] 13:41:50:047: TIMER: Restart PCB                     Time: 30

[1504] 13:41:50:047: ElEapEnd entered

[1504] 13:41:50:047: ElEapBegin entered

[1504] 13:41:50:047: ElEapBegin done

[1504] 13:41:50:047: ElEapWork: EapolPkt created at 000E3E40

[1504] 13:41:50:047: ElEapMakeMessage entered

[1504] 13:41:50:047: ElParseIdentityString: DisplayString = Please enter 
your login name

[1504] 13:41:50:047: ElParseIdentityString: LocalIdString =

[1504] 13:41:50:047: ElParseIdentityString: LocalIdString Length = 28

[1504] 13:41:50:047: ElParseIdentityString: Identity string does not 
contain tuples

[1504] 13:41:50:047: ElGetIdentity: Userlogged, Prev !Machine auth

[1504] 13:41:50:047: ElGetIdentity: Userlogged, <Maxauth, Prev !Machine 
auth: !MD5

[1504] 13:41:50:047: ElGetUserIdentity entered

[1504] 13:41:50:057: ElGetEapUserInfo: Error in RegOpenKeyEx for base key, 2

[1504] 13:41:50:057: ElGetCustomAuthData: SSIDLen=<11>, EapTypeId=<13>, 
Offset=<52/106>, dwAuthData=<42>

[1504] 13:41:50:057: ElGetCustomAuthData: SSIDLen=<11>, EapTypeId=<13>, 
Offset=<52/106>, dwAuthData=<42>

[1504] 13:41:50:518: ElGetUserIdentityOptimized: Got identity = josh

[1504] 13:41:50:518: ElGetUserIdentity: ElGetUserIdentityOptimized got 
identity without user module intervention

[1504] 13:41:50:518: ElGetUserIdentity completed with error 0

[1504] 13:41:50:518: ElGetIdentity: Userlogged, <Maxauth, Prev !Machine 
auth: No Error: User Auth fine

[1504] 13:41:50:518: Identity sent out = josh

[1504] 13:41:50:518: ElWriteToPort entered: Pkt Length = 15

[1504] 13:41:50:518: ElWriteToPort: pPCB = 000E7E38, RefCnt = 4

[1504] 13:41:50:518: ElWriteToInterface entered

[1504] 13:41:50:518: ElWriteToInterface completed, RetCode = 0

[1504] 13:41:50:518: Authentication Started on port Wireless-G Notebook 
Adapter with RangeBooster - Packet Scheduler Miniport using User credentials

[1504] 13:41:50:518: Setting state ACQUIRED for port Wireless-G Notebook 
Adapter with RangeBooster - Packet Scheduler Miniport

[1504] 13:41:50:528: FSMAcquired completed for port Wireless-G Notebook 
Adapter with RangeBooster - Packet Scheduler Miniport

[1504] 13:41:50:528: ProcessReceivedPacket: Reposting buffer on port 
{B123A337-9DAB-45CD-B148-7A2E8A53AAED}

[1504] 13:41:50:528: ElReadFromPort entered, pPCB = 000E7E38

[1504] 13:41:50:528: ElReadFromPort: pPCB = 000E7E38, RefCnt = 5

[1712] 13:41:50:528: EAPOLQueryGUIDNCSState: For Port Wireless-G 
Notebook Adapter with RangeBooster - Packet Scheduler Miniport returning 12

[1504] 13:41:50:528: ProcessReceivedPacket: pPCB= 000E7E38, RefCnt = 4

[1504] 13:41:50:528: ProcessReceivedPacket exit

[1504] 13:41:50:528: ElWriteCompletionRoutine sent out 27 bytes with error 0

[1504] 13:41:50:528: ElWriteCompletionRoutine: pPCB= 000E7E38, RefCnt = 3

[1504] 13:41:50:528: EapolReceiveDataPacket: receive 28 bytes

[1504] 13:41:50:528: ProcessReceivedPacket entered, length = 24

[1504] 13:41:50:528: ProcessReceivedPacket: EAP_Packet

[1504] 13:41:50:528: ProcessReceivedPacket: EAPOLSTATE_ACQUIRED

[1504] 13:41:50:528: TIMER: Restart PCB                     Time: 2097148

[1504] 13:41:50:528: FSMAuthenticating entered for port Wireless-G 
Notebook Adapter with RangeBooster - Packet Scheduler Miniport

[1504] 13:41:50:528: TIMER: Restart PCB                     Time: 30

[1504] 13:41:50:528: ElEapWork: EapolPkt created at 000E3E40

[1504] 13:41:50:528: ElEapMakeMessage entered

[1504] 13:41:50:528: ElMakeSupplicantMessage entered

[1504] 13:41:50:528: EAPSTATE_Initial

[1504] 13:41:50:528: ElEapDllBegin called for EAP Type 13

[1504] 13:41:50:528: ElEapDllBegin: Not Setting GUEST flag

[1504] 13:41:50:528: EAPSTATE_Working

[1504] 13:41:50:528: ElEapDllWork called for EAP Type 13

[1504] 13:41:50:958: EAP Dll returned Action=EAPACTION_Send

[1504] 13:41:50:958: ElEapDllWork finished for EAP Type 13 with error 0

[1504] 13:41:50:958: ElWriteToPort entered: Pkt Length = 86

[1504] 13:41:50:958: ElWriteToPort: pPCB = 000E7E38, RefCnt = 3

[1504] 13:41:50:958: ElWriteToInterface entered

[1504] 13:41:50:958: ElWriteToInterface completed, RetCode = 0

[1504] 13:41:50:958: Setting state AUTHENTICATING for port Wireless-G 
Notebook Adapter with RangeBooster - Packet Scheduler Miniport

[1504] 13:41:50:958: WZCNetmanConnectionStatusChanged: Entered

[1504] 13:41:50:958: QueueEvent: CoCreateInstance succeeded

[1504] 13:41:50:958: ConnectionStatusChanged completed

[1504] 13:41:50:958: FSMAuthenticating completed for port Wireless-G 
Notebook Adapter with RangeBooster - Packet Scheduler Miniport

[1504] 13:41:50:958: ProcessReceivedPacket: Reposting buffer on port 
{B123A337-9DAB-45CD-B148-7A2E8A53AAED}

[1504] 13:41:50:958: ElReadFromPort entered, pPCB = 000E7E38

[1504] 13:41:50:958: ElReadFromPort: pPCB = 000E7E38, RefCnt = 4

[1504] 13:41:50:958: ProcessReceivedPacket: pPCB= 000E7E38, RefCnt = 4

[1504] 13:41:50:958: ProcessReceivedPacket exit

[1504] 13:41:50:958: ElWriteCompletionRoutine sent out 98 bytes with error 0

[1504] 13:41:50:958: ElWriteCompletionRoutine: pPCB= 000E7E38, RefCnt = 3

[1504] 13:41:50:968: EAPOLQueryGUIDNCSState: For Port Wireless-G 
Notebook Adapter with RangeBooster - Packet Scheduler Miniport returning 8

[1712] 13:41:50:988: EapolReceiveDataPacket: receive 1046 bytes

[1712] 13:41:51:018: ProcessReceivedPacket entered, length = 1042

[1712] 13:41:51:018: ProcessReceivedPacket: EAP_Packet

[1712] 13:41:51:018: ProcessReceivedPacket: EAPOLSTATE_AUTHENTICATING

[1712] 13:41:51:018: TIMER: Restart PCB                     Time: 2097148

[1712] 13:41:51:018: FSMAuthenticating entered for port Wireless-G 
Notebook Adapter with RangeBooster - Packet Scheduler Miniport

[1712] 13:41:51:018: TIMER: Restart PCB                     Time: 30

[1712] 13:41:51:018: ElEapWork: EapolPkt created at 000E3E40

[1712] 13:41:51:018: ElEapMakeMessage entered

[1712] 13:41:51:018: ElMakeSupplicantMessage entered

[1712] 13:41:51:018: EAPSTATE_Working

[1712] 13:41:51:018: ElEapDllWork called for EAP Type 13

[1712] 13:41:51:018: EAP Dll returned Action=EAPACTION_Send

[1712] 13:41:51:018: ElEapDllWork finished for EAP Type 13 with error 0

[1712] 13:41:51:018: ElWriteToPort entered: Pkt Length = 12

[1712] 13:41:51:018: ElWriteToPort: pPCB = 000E7E38, RefCnt = 3

[1712] 13:41:51:018: ElWriteToInterface entered

[1712] 13:41:51:018: ElWriteToInterface completed, RetCode = 0

[1712] 13:41:51:018: Setting state AUTHENTICATING for port Wireless-G 
Notebook Adapter with RangeBooster - Packet Scheduler Miniport

[1712] 13:41:51:018: FSMAuthenticating completed for port Wireless-G 
Notebook Adapter with RangeBooster - Packet Scheduler Miniport

[1712] 13:41:51:018: ProcessReceivedPacket: Reposting buffer on port 
{B123A337-9DAB-45CD-B148-7A2E8A53AAED}

[1712] 13:41:51:018: ElReadFromPort entered, pPCB = 000E7E38

[1712] 13:41:51:018: ElReadFromPort: pPCB = 000E7E38, RefCnt = 4

[1712] 13:41:51:018: ProcessReceivedPacket: pPCB= 000E7E38, RefCnt = 4

[1712] 13:41:51:018: ProcessReceivedPacket exit

[1712] 13:41:51:018: ElWriteCompletionRoutine sent out 24 bytes with error 0

[1712] 13:41:51:018: ElWriteCompletionRoutine: pPCB= 000E7E38, RefCnt = 3

[1712] 13:41:51:028: EapolReceiveDataPacket: receive 1046 bytes

[1712] 13:41:51:028: ProcessReceivedPacket entered, length = 1042

[1712] 13:41:51:028: ProcessReceivedPacket: EAP_Packet

[1712] 13:41:51:028: ProcessReceivedPacket: EAPOLSTATE_AUTHENTICATING

[1712] 13:41:51:028: TIMER: Restart PCB                     Time: 2097148

[1712] 13:41:51:028: FSMAuthenticating entered for port Wireless-G 
Notebook Adapter with RangeBooster - Packet Scheduler Miniport

[1712] 13:41:51:028: TIMER: Restart PCB                     Time: 30

[1712] 13:41:51:028: ElEapWork: EapolPkt created at 00184500

[1712] 13:41:51:028: ElEapMakeMessage entered

[1712] 13:41:51:028: ElMakeSupplicantMessage entered

[1712] 13:41:51:028: EAPSTATE_Working

[1712] 13:41:51:028: ElEapDllWork called for EAP Type 13

[1712] 13:41:51:028: EAP Dll returned Action=EAPACTION_Send

[1712] 13:41:51:028: ElEapDllWork finished for EAP Type 13 with error 0

[1712] 13:41:51:028: ElWriteToPort entered: Pkt Length = 12

[1712] 13:41:51:028: ElWriteToPort: pPCB = 000E7E38, RefCnt = 3

[1712] 13:41:51:028: ElWriteToInterface entered

[1712] 13:41:51:028: ElWriteToInterface completed, RetCode = 0

[1712] 13:41:51:028: Setting state AUTHENTICATING for port Wireless-G 
Notebook Adapter with RangeBooster - Packet Scheduler Miniport

[1712] 13:41:51:028: FSMAuthenticating completed for port Wireless-G 
Notebook Adapter with RangeBooster - Packet Scheduler Miniport

[1712] 13:41:51:028: ProcessReceivedPacket: Reposting buffer on port 
{B123A337-9DAB-45CD-B148-7A2E8A53AAED}

[1712] 13:41:51:028: ElReadFromPort entered, pPCB = 000E7E38

[1712] 13:41:51:028: ElReadFromPort: pPCB = 000E7E38, RefCnt = 4

[1712] 13:41:51:028: ProcessReceivedPacket: pPCB= 000E7E38, RefCnt = 4

[1712] 13:41:51:028: ProcessReceivedPacket exit

[1712] 13:41:51:028: ElWriteCompletionRoutine sent out 24 bytes with error 0

[1712] 13:41:51:028: ElWriteCompletionRoutine: pPCB= 000E7E38, RefCnt = 3

[1712] 13:41:51:038: EapolReceiveDataPacket: receive 342 bytes

[1712] 13:41:51:038: ProcessReceivedPacket entered, length = 338

[1712] 13:41:51:038: ProcessReceivedPacket: EAP_Packet

[1712] 13:41:51:038: ProcessReceivedPacket: EAPOLSTATE_AUTHENTICATING

[1712] 13:41:51:038: TIMER: Restart PCB                     Time: 2097148

[1712] 13:41:51:038: FSMAuthenticating entered for port Wireless-G 
Notebook Adapter with RangeBooster - Packet Scheduler Miniport

[1712] 13:41:51:038: TIMER: Restart PCB                     Time: 30

[1712] 13:41:51:038: ElEapWork: EapolPkt created at 000E3E40

[1712] 13:41:51:038: ElEapMakeMessage entered

[1712] 13:41:51:038: ElMakeSupplicantMessage entered

[1712] 13:41:51:038: EAPSTATE_Working

[1712] 13:41:51:038: ElEapDllWork called for EAP Type 13

[1712] 13:41:51:098: EAP Dll returned Action=EAPACTION_Send

[1712] 13:41:51:098: ElEapDllWork finished for EAP Type 13 with error 0

[1712] 13:41:51:098: ElWriteToPort entered: Pkt Length = 1496

[1712] 13:41:51:098: ElWriteToPort: pPCB = 000E7E38, RefCnt = 3

[1712] 13:41:51:098: ElWriteToInterface entered

[1712] 13:41:51:098: ElWriteToInterface completed, RetCode = 0

[1712] 13:41:51:098: Setting state AUTHENTICATING for port Wireless-G 
Notebook Adapter with RangeBooster - Packet Scheduler Miniport

[1712] 13:41:51:098: FSMAuthenticating completed for port Wireless-G 
Notebook Adapter with RangeBooster - Packet Scheduler Miniport

[1712] 13:41:51:098: ProcessReceivedPacket: Reposting buffer on port 
{B123A337-9DAB-45CD-B148-7A2E8A53AAED}

[1712] 13:41:51:098: ElReadFromPort entered, pPCB = 000E7E38

[1712] 13:41:51:098: ElReadFromPort: pPCB = 000E7E38, RefCnt = 4

[1712] 13:41:51:098: ProcessReceivedPacket: pPCB= 000E7E38, RefCnt = 4

[1712] 13:41:51:098: ProcessReceivedPacket exit

[1712] 13:41:51:098: ElWriteCompletionRoutine sent out 1508 bytes with 
error 0

[1712] 13:41:51:098: ElWriteCompletionRoutine: pPCB= 000E7E38, RefCnt = 3

[1712] 13:41:53:352: EAPOLQueryGUIDNCSState: For Port Intel(R) PRO/100 
VE Network Connection #2 - Packet Scheduler Miniport returning S_FALSE

[1712] 13:41:53:382: EAPOLQueryGUIDNCSState: 802.1X Port Inexistant for 
{FD7F1225-FD60-480C-8857-1DF3ECBC9C18}. Returning S_OK

[1712] 13:41:53:412: EAPOLQueryGUIDNCSState: For Port Wireless-G 
Notebook Adapter with RangeBooster - Packet Scheduler Miniport returning 8

[1180] 13:42:16:405: ElSetCustomAuthData: EapTypeId=<13>, 
SSIDLength=<11>, InfoLength=<42>

[1180] 13:42:16:405: ElSetCustomAuthData: Set value succeeded, 
fFound=<1>, dwEapBlob=<106>, dwSizeOfSSID=<11>

[1180] 13:42:16:405: ElSetCustomAuthData: EapTypeId=<25>, 
SSIDLength=<11>, InfoLength=<0>

[1180] 13:42:16:415: ElSetCustomAuthData: Set value succeeded, 
fFound=<1>, dwEapBlob=<106>, dwSizeOfSSID=<11>

[1180] 13:42:16:415: ElSetInterfaceParams:  EapTypeId=<13> SSIDLen=<11>

[1180] 13:42:16:415: Setting stuff in registry for 
{B123A337-9DAB-45CD-B148-7A2E8A53AAED}

[1180] 13:42:16:415: ElSetInterfaceParams: Succeeded,  EapTypeId=<13> 
fFound=<1>, SSIDLen=<11>

[1180] 13:42:16:415: ElPostEapConfigChanged: SSIDLength=<11>

[2192] 13:42:16:415: ElGetInterfaceParams:  SsidLength=<11>, Found 
EapTypeId=<13>, SSIDLen=<11>

[2192] 13:42:16:415: ElProcessEapConfigChange: PCB ref and enabled, 
continue check

[2192] 13:42:16:415: ElGetCustomAuthData: SSIDLen=<11>, EapTypeId=<13>, 
Offset=<52/106>, dwAuthData=<42>

[2192] 13:42:16:415: ElGetCustomAuthData: SSIDLen=<11>, EapTypeId=<13>, 
Offset=<52/106>, dwAuthData=<42>

[2192] 13:42:16:415: ElProcessEapConfigChange: Same SSID, EAPType, 
CustomAuth, No content change

[2192] 13:42:16:415: ElProcessEapConfigChange: Finished with error 0

[1180] 13:42:16:415: ElWZCCfgUpdateSettings: Error in RegOpenKeyEx for 
base key, 2

[1180] 13:42:16:415: ElWZCCfgChangeHandler: ElWZCCfgUpdateSettings HKCU 
failed with error (2)

[1504] 13:42:19:519: ElMediaEventsHandler entered -- EventType=<6>

[1504] 13:42:19:519: ElMediaEventsHandler: Calling ElMediaSenseEventFromWZC

[1504] 13:42:19:519: ElMediaSenseEventFromWZC: Entered

[1504] 13:42:19:519: ElMediaSenseEventFromWZCWorker: For interface GUID 
({B123A337-9DAB-45CD-B148-7A2E8A53AAED})

[1504] 13:42:19:519: ElMediaSenseEventFromWZCWorker: Callback for sense 
disconnect

[1504] 13:42:19:519: Current Mode is NOT WPA2. PreAuth disabled

[1504] 13:42:19:519: FSMDisconnected entered for port Wireless-G 
Notebook Adapter with RangeBooster - Packet Scheduler Miniport

[1504] 13:42:19:519: Setting state DISCONNECTED for port Wireless-G 
Notebook Adapter with RangeBooster - Packet Scheduler Miniport

[1504] 13:42:19:519: FSMDisconnected completed for port Wireless-G 
Notebook Adapter with RangeBooster - Packet Scheduler Miniport

[1504] 13:42:19:519: ElMediaSenseEventFromWZCWorker: Port marked 
disconnected {B123A337-9DAB-45CD-B148-7A2E8A53AAED}

[1504] 13:42:19:519: ElMediaSenseCallbackWorker: processed, RetCode = 0

[1504] 13:42:19:519: ElReadFromPort entered, pPCB = 000E7E38

[1504] 13:42:19:519: ElReadFromPort: pPCB = 000E7E38, RefCnt = 3

[1712] 13:42:19:700: EAPOLQueryGUIDNCSState: For Port Intel(R) PRO/100 
VE Network Connection #2 - Packet Scheduler Miniport returning S_FALSE

[1712] 13:42:19:740: EAPOLQueryGUIDNCSState: 802.1X Port Inexistant for 
{FD7F1225-FD60-480C-8857-1DF3ECBC9C18}. Returning S_OK

[2192] 13:42:21:061: ElTimeoutCallbackRoutine entered

[2192] 13:42:21:061: ElTimeoutCallbackRoutine: No action in Disconnected 
state

[2192] 13:42:21:061: ElTimeoutCallbackRoutine completed

[1180] 13:42:21:993: ElGetInterfaceParams:  SsidLength=<11>, Found 
EapTypeId=<13>, SSIDLen=<11>

[1548] 13:42:21:993: ElGetCustomAuthData: SSIDLen=<11>, EapTypeId=<13>, 
Offset=<52/106>, dwAuthData=<42>

[1180] 13:42:21:993: ElGetCustomAuthData: SSIDLen=<11>, EapTypeId=<13>, 
Offset=<52/106>, dwAuthData=<42>

[1180] 13:42:21:993: ElGetCustomAuthData: SSIDLen=<11>, EapTypeId=<25>, 
Offset=<52/106>, dwAuthData=<0>

[1548] 13:42:22:013: ElGetInterfaceParams:  SsidLength=<11>, Found 
EapTypeId=<13>, SSIDLen=<11>

[1548] 13:42:22:013: ElGetCustomAuthData: SSIDLen=<11>, EapTypeId=<13>, 
Offset=<52/106>, dwAuthData=<42>

[1548] 13:42:22:013: ElGetCustomAuthData: SSIDLen=<11>, EapTypeId=<13>, 
Offset=<52/106>, dwAuthData=<42>

[1548] 13:42:22:013: ElGetCustomAuthData: SSIDLen=<11>, EapTypeId=<25>, 
Offset=<52/106>, dwAuthData=<0>

[1180] 13:42:22:023: ElGetInterfaceParams:  SsidLength=<13>, Found 
EapTypeId=<13>, SSIDLen=<13>

[1180] 13:42:22:023: ElGetCustomAuthData: SSIDLen=<13>, EapTypeId=<13>, 
Offset=<52/104>, dwAuthData=<40>

[1180] 13:42:22:023: ElGetCustomAuthData: SSIDLen=<13>, EapTypeId=<13>, 
Offset=<52/104>, dwAuthData=<40>

[1180] 13:42:22:033: ElGetCustomAuthData: SSIDLen=<13>, EapTypeId=<25>, 
Offset=<52/104>, dwAuthData=<0>

[2192] 13:42:28:372: EAPOLQueryGUIDNCSState: For Port Intel(R) PRO/100 
VE Network Connection #2 - Packet Scheduler Miniport returning S_FALSE

[2192] 13:42:28:392: EAPOLQueryGUIDNCSState: 802.1X Port Inexistant for 
{FD7F1225-FD60-480C-8857-1DF3ECBC9C18}. Returning S_OK



More information about the Freeradius-Users mailing list