Request log details for session: R000024a6-01-5e3b8145

Time Message
2020-02-06 11:00:21,116 [Th 45 Req 53484 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - rlm_service: Starting Service Categorization - 99:384:00-1e-33-28-85-10
2020-02-06 11:00:21,121 [Th 45 Req 53484 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - Service Categorization time = 5 ms
2020-02-06 11:00:21,121 [Th 45 Req 53484 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - rlm_service: The request has been categorized into service "Aruba-1x-Auth-Wire"
2020-02-06 11:00:21,121 [Th 45 Req 53484 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - rlm_sql: searching for user stark in Local:localhost
2020-02-06 11:00:21,121 [RequestHandler-1-0x7f0a4add6700 r=psauto-1580723973-25341 h=223 r=R000024a6-01-5e3b8145] INFO Core.ServiceReqHandler - Service classification result = Aruba-1x-Auth-Wire
2020-02-06 11:00:21,125 [Th 45 Req 53484 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - rlm_sql: found user stark in Local:localhost
2020-02-06 11:00:21,125 [Th 45 Req 53484 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - SQL User lookup time = 4 ms
2020-02-06 11:00:21,125 [Th 45 Req 53484 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - rlm_eap_tls: Initiate
2020-02-06 11:00:21,125 [Th 45 Req 53484 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - reqst_update_state: Access-Challenge 99:88:00-1e-33-28-85-10:APYA7gAZAGXs0AAAus6lAJRDh2pjf2FdRWGU5Q==
2020-02-06 11:00:21,127 [Th 41 Req 53485 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - rlm_service: The request was categorized into service "Aruba-1x-Auth-Wire" - 100:422:00-1e-33-28-85-10
2020-02-06 11:00:21,128 [Th 41 Req 53485 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - rlm_eap_peap: Initiate
2020-02-06 11:00:21,128 [Th 41 Req 53485 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - reqst_update_state: Access-Challenge 100:88:00-1e-33-28-85-10:AJ0AuACVAAft0AAADdXiFRLs4Qe74vn6rESXBw==
2020-02-06 11:00:21,130 [Th 43 Req 53486 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - rlm_service: The request was categorized into service "Aruba-1x-Auth-Wire" - 101:582:00-1e-33-28-85-10
2020-02-06 11:00:21,134 [Th 43 Req 53486 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - TLS_accept:error in SSLv3 read client key exchange A
2020-02-06 11:00:21,134 [Th 43 Req 53486 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - TLS_accept:error in SSLv3 read client key exchange A
2020-02-06 11:00:21,134 [Th 43 Req 53486 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - reqst_update_state: Access-Challenge 101:1124:00-1e-33-28-85-10:AP8AAABMAPzu0AAAk/A44nfJ8JEIRSJ8lVWrRg==
2020-02-06 11:00:21,137 [Th 44 Req 53487 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - rlm_service: The request was categorized into service "Aruba-1x-Auth-Wire" - 102:422:00-1e-33-28-85-10
2020-02-06 11:00:21,137 [Th 44 Req 53487 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - reqst_update_state: Access-Challenge 102:347:00-1e-33-28-85-10:AD4A5ADCAC7v0AAAUQby+uHeEgTUWwWOGkg9HQ==
2020-02-06 11:00:21,142 [Th 42 Req 53488 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - rlm_service: The request was categorized into service "Aruba-1x-Auth-Wire" - 103:552:00-1e-33-28-85-10
2020-02-06 11:00:21,143 [Th 42 Req 53488 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - reqst_update_state: Access-Challenge 103:139:00-1e-33-28-85-10:AJsA4wCRAFLw0AAAt9EtmmCmgfLCZLqurgEN2g==
2020-02-06 11:00:21,148 [Th 46 Req 53489 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - rlm_service: The request was categorized into service "Aruba-1x-Auth-Wire" - 104:422:00-1e-33-28-85-10
2020-02-06 11:00:21,148 [Th 46 Req 53489 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - rlm_eap_peap: Session established.
2020-02-06 11:00:21,148 [Th 46 Req 53489 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - reqst_update_state: Access-Challenge 104:122:00-1e-33-28-85-10:AIYAaAC6ADnx0AAA2O412FmSdaIIrDk0U2O5mg==
2020-02-06 11:00:21,150 [Th 45 Req 53490 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - rlm_service: The request was categorized into service "Aruba-1x-Auth-Wire" - 105:457:00-1e-33-28-85-10
2020-02-06 11:00:21,150 [Th 45 Req 53490 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - rlm_eap_mschapv2: Issuing Challenge
2020-02-06 11:00:21,151 [Th 45 Req 53490 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - reqst_update_state: Access-Challenge 105:144:00-1e-33-28-85-10:AGAAwwBhABfy0AAAOZvzJ1ictJ0DGn7DWwruxA==
2020-02-06 11:00:21,154 [Th 41 Req 53491 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - rlm_service: The request was categorized into service "Aruba-1x-Auth-Wire" - 106:511:00-1e-33-28-85-10
2020-02-06 11:00:21,154 [Th 41 Req 53491 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - rlm_service: The request was categorized into service "Aruba-1x-Auth-Wire" - 243:0:00-1e-33-28-85-10
2020-02-06 11:00:21,154 [Th 41 Req 53491 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - rlm_eap_mschapv2: Received MSCHAPv2 Response from client
2020-02-06 11:00:21,154 [Th 41 Req 53491 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - rlm_mschap: MSCHAPv2 username used for challenge computation stark
2020-02-06 11:00:21,155 [Th 41 Req 53491 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - MS-Chap User Authentication time = 1 ms
2020-02-06 11:00:21,155 [Th 41 Req 53491 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - rlm_eap_mschapv2: Sending MSCHAPv2 Success reply
2020-02-06 11:00:21,155 [Th 41 Req 53491 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - reqst_update_state: Access-Challenge 106:164:00-1e-33-28-85-10:AGYA5QDwAFfz0AAAaJ/iCKNRUYddOR7/DCZg9w==
2020-02-06 11:00:21,158 [Th 43 Req 53492 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - rlm_service: The request was categorized into service "Aruba-1x-Auth-Wire" - 107:453:00-1e-33-28-85-10
2020-02-06 11:00:21,158 [Th 43 Req 53492 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - rlm_service: The request was categorized into service "Aruba-1x-Auth-Wire" - 244:0:00-1e-33-28-85-10
2020-02-06 11:00:21,158 [Th 43 Req 53492 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - rlm_eap_mschapv2: Received MSCHAPv2 Success from client
2020-02-06 11:00:21,158 [Th 43 Req 53492 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - rlm_policy: Starting Policy Evaluation.
2020-02-06 11:00:21,161 [RequestHandler-1-0x7f0a4add6700 r=psauto-1580723973-25342 h=239 r=R000024a6-01-5e3b8145] INFO Common.EndpointTable - Returning EndpointSPtr for macAddr 001e33288510
2020-02-06 11:00:21,161 [RequestHandler-1-0x7f0a4add6700 r=psauto-1580723973-25342 h=239 r=R000024a6-01-5e3b8145] INFO Common.AuthLocalUserTable - Returning AuthLocalUserSPtr for user ID stark
2020-02-06 11:00:21,161 [RequestHandler-1-0x7f0a4add6700 r=psauto-1580723973-25342 h=239 r=R000024a6-01-5e3b8145] INFO Common.TagDefinitionCacheTable - No InstanceTagDefCacheMap found for instance id = 3002 entity id = 29
2020-02-06 11:00:21,161 [RequestHandler-1-0x7f0a4add6700 r=psauto-1580723973-25342 h=239 r=R000024a6-01-5e3b8145] INFO Common.TagDefinitionCacheTable - Building the TagDefMapTable for NAD instance=3002
2020-02-06 11:00:21,161 [RequestHandler-1-0x7f0a4add6700 r=psauto-1580723973-25342 h=239 r=R000024a6-01-5e3b8145] INFO Common.TagDefinitionCacheTable - Built 0 tag(s) for NAD instanceId=3002|entityId=29
2020-02-06 11:00:21,161 [RequestHandler-1-0x7f0a4add6700 r=psauto-1580723973-25342 h=239 r=R000024a6-01-5e3b8145] INFO TAT.TagAttrHolderBuilder - No tags built for instanceId=3002|entity=Device
2020-02-06 11:00:21,161 [RequestHandler-1-0x7f0a4add6700 r=psauto-1580723973-25342 h=239 r=R000024a6-01-5e3b8145] INFO TAT.GuTagAttrHolderBuilder - buildAttrHolder: Tags cannot be built for instanceId=0 (NULL GuestUser)
2020-02-06 11:00:21,161 [RequestHandler-1-0x7f0a4add6700 r=psauto-1580723973-25342 h=239 r=R000024a6-01-5e3b8145] INFO Common.TagDefinitionCacheTable - No InstanceTagDefCacheMap found for instance id = 3007 entity id = 72
2020-02-06 11:00:21,161 [RequestHandler-1-0x7f0a4add6700 r=psauto-1580723973-25342 h=239 r=R000024a6-01-5e3b8145] INFO Common.TagDefinitionCacheTable - Building the TagDefMapTable for Endpoint instance=3007
2020-02-06 11:00:21,161 [RequestHandler-1-0x7f0a4add6700 r=psauto-1580723973-25342 h=239 r=R000024a6-01-5e3b8145] INFO Common.TagDefinitionCacheTable - Built 0 tag(s) for instanceId=3007|entityId=72|entityName=Endpoint
2020-02-06 11:00:21,161 [RequestHandler-1-0x7f0a4add6700 r=psauto-1580723973-25342 h=239 r=R000024a6-01-5e3b8145] INFO TAT.TagAttrHolderBuilder - No tags built for instanceId=3007|entity=Endpoint
2020-02-06 11:00:21,161 [RequestHandler-1-0x7f0a4add6700 r=psauto-1580723973-25342 h=239 r=R000024a6-01-5e3b8145] INFO TAT.OnboardTagAttrHolderBuilder - buildAttrHolder: Tags cannot be built for instanceId=0 (NULL Onboard Device User)
2020-02-06 11:00:21,162 [RequestHandler-1-0x7f0a4add6700 h=208281 c=R000024a6-01-5e3b8145] INFO Core.PETaskScheduler - *** PE_TASK_SCHEDULE_RADIUS Started ***
2020-02-06 11:00:21,162 [RequestHandler-1-0x7f0a4add6700 h=208281 c=R000024a6-01-5e3b8145] INFO Core.PETaskScheduler - ** Starting PETaskAuthSourceRestriction **
2020-02-06 11:00:21,162 [RequestHandler-1-0x7f0a4add6700 h=208281 c=R000024a6-01-5e3b8145] INFO Core.PETaskScheduler - ** Starting PETaskRoleMapping **
2020-02-06 11:00:21,162 [RequestHandler-1-0x7f0a4add6700 h=208282 c=R000024a6-01-5e3b8145] WARN REC.EvaluatorCtx - Prerequisites set is empty, not populating the Request Map
2020-02-06 11:00:21,162 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208281 c=R000024a6-01-5e3b8145] INFO Core.PETaskScheduler - ** Completed PETaskAuthSourceRestriction **
2020-02-06 11:00:21,163 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208283 c=R000024a6-01-5e3b8145] INFO Common.AuthLocalUserTable - Returning AuthLocalUserSPtr for user ID stark
2020-02-06 11:00:21,163 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208283 c=R000024a6-01-5e3b8145] INFO Core.PETaskRoleMapping - Roles: COMPUTER, User Authenticated]
2020-02-06 11:00:21,163 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208281 c=R000024a6-01-5e3b8145] INFO Core.PETaskScheduler - ** Completed PETaskRoleMapping **
2020-02-06 11:00:21,164 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208281 c=R000024a6-01-5e3b8145] INFO Core.PETaskScheduler - ** Starting PETaskPolicyResult **
2020-02-06 11:00:21,164 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208281 c=R000024a6-01-5e3b8145] INFO Core.PETaskScheduler - ** Completed PETaskPolicyResult **
2020-02-06 11:00:21,164 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208281 c=R000024a6-01-5e3b8145] INFO Core.PETaskScheduler - ** Starting PETaskEnforcement **
2020-02-06 11:00:21,165 [RequestHandler-1-0x7f0a4add6700 h=208286 c=R000024a6-01-5e3b8145] INFO Core.PETaskEnforcement - EnfProfiles: Aruba-Wird-Role
2020-02-06 11:00:21,165 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208281 c=R000024a6-01-5e3b8145] INFO Core.PETaskScheduler - ** Completed PETaskEnforcement **
2020-02-06 11:00:21,165 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208281 c=R000024a6-01-5e3b8145] INFO Core.PETaskScheduler - ** Starting PETaskRadiusEnfProfileBuilder **
2020-02-06 11:00:21,165 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208281 c=R000024a6-01-5e3b8145] INFO Core.PETaskScheduler - ** Starting PETaskRadiusCoAEnfProfileBuilder **
2020-02-06 11:00:21,165 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208281 c=R000024a6-01-5e3b8145] INFO Core.PETaskScheduler - ** Starting PETaskAppEnfProfileBuilder **
2020-02-06 11:00:21,165 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208281 c=R000024a6-01-5e3b8145] INFO Core.PETaskScheduler - ** Starting PETaskAgentEnfProfileBuilder **
2020-02-06 11:00:21,165 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208281 c=R000024a6-01-5e3b8145] INFO Core.PETaskScheduler - ** Starting PETaskPostAuthEnfProfileBuilder **
2020-02-06 11:00:21,165 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208281 c=R000024a6-01-5e3b8145] INFO Core.PETaskScheduler - ** Starting PETaskGenericEnfProfileBuilder **
2020-02-06 11:00:21,165 [RequestHandler-1-0x7f0a4add6700 h=208292 c=R000024a6-01-5e3b8145] INFO Core.PETaskGenericEnfProfileBuilder - getApplicableProfiles: No App enforcement (Generic) profiles applicable for this device
2020-02-06 11:00:21,166 [RequestHandler-1-0x7f0a4add6700 h=208287 c=R000024a6-01-5e3b8145] INFO Core.PETaskRadiusEnfProfileBuilder - EnfProfileAction=ACCEPT
2020-02-06 11:00:21,166 [RequestHandler-1-0x7f0a4add6700 h=208287 c=R000024a6-01-5e3b8145] INFO Core.PETaskRadiusEnfProfileBuilder - Radius enfProfiles used: Aruba-Wird-Role
2020-02-06 11:00:21,166 [RequestHandler-1-0x7f0a4add6700 h=208287 c=R000024a6-01-5e3b8145] INFO Core.EnfProfileComputer - getFinalSessionTimeout: sessionTimeout = 0
2020-02-06 11:00:21,167 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208281 c=R000024a6-01-5e3b8145] INFO Core.PETaskScheduler - ** Completed PETaskGenericEnfProfileBuilder **
2020-02-06 11:00:21,167 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208281 c=R000024a6-01-5e3b8145] INFO Core.PETaskScheduler - ** Completed PETaskAgentEnfProfileBuilder **
2020-02-06 11:00:21,167 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208281 c=R000024a6-01-5e3b8145] INFO Core.PETaskScheduler - ** Completed PETaskAppEnfProfileBuilder **
2020-02-06 11:00:21,167 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208281 c=R000024a6-01-5e3b8145] INFO Core.PETaskScheduler - ** Starting PETaskCliEnforcement **
2020-02-06 11:00:21,167 [RequestHandler-1-0x7f0a4add6700 h=208293 c=R000024a6-01-5e3b8145] INFO Core.PETaskCliEnforcement - startHandler: No commands for CLI enforcement
2020-02-06 11:00:21,167 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208281 c=R000024a6-01-5e3b8145] INFO Core.PETaskScheduler - ** Completed PETaskRadiusEnfProfileBuilder **
2020-02-06 11:00:21,167 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208291 c=R000024a6-01-5e3b8145] WARN Core.PETaskPostAuthEnfProfileBuilder - handleHttpResponseEv: Fetching Radius attributes from battery failed, errMsg=
2020-02-06 11:00:21,167 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208291 c=R000024a6-01-5e3b8145] INFO Core.PETaskPostAuthEnfProfileBuilder - getApplicableProfiles: No Post auth enforcement profiles applicable for this device
2020-02-06 11:00:21,167 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208288 c=R000024a6-01-5e3b8145] WARN Core.PETaskRadiusCoAEnfProfileBuilder - handleHttpResponseEv: Fetching Radius attributes from battery failed, errMsg=
2020-02-06 11:00:21,168 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208281 c=R000024a6-01-5e3b8145] INFO Core.PETaskScheduler - ** Completed PETaskCliEnforcement **
2020-02-06 11:00:21,168 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208281 c=R000024a6-01-5e3b8145] INFO Core.PETaskScheduler - ** Completed PETaskPostAuthEnfProfileBuilder **
2020-02-06 11:00:21,168 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208281 c=R000024a6-01-5e3b8145] INFO Core.PETaskScheduler - ** Completed PETaskRadiusCoAEnfProfileBuilder **
2020-02-06 11:00:21,168 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208281 c=R000024a6-01-5e3b8145] INFO Core.PETaskScheduler - ** Starting PETaskAuthStatusInfo **
2020-02-06 11:00:21,168 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208281 c=R000024a6-01-5e3b8145] INFO Core.PETaskScheduler - ** Starting PETaskOutputPolicyRes **
2020-02-06 11:00:21,168 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208281 c=R000024a6-01-5e3b8145] INFO Core.PETaskScheduler - ** Starting PETaskSessionLog **
2020-02-06 11:00:21,173 [RequestHandler-1-0x7f0a4add6700 h=208295 c=R000024a6-01-5e3b8145] INFO Core.XpipPolicyResHandler - populateResponseTlv: PETaskPostureOutput does not exist. Skip sending posture VAFs
2020-02-06 11:00:21,173 [RequestHandler-1-0x7f0a4add6700 h=208295 c=R000024a6-01-5e3b8145] INFO Core.PolicyResCollector - getSohr: Failed to generate Sohr
2020-02-06 11:00:21,173 [RequestHandler-1-0x7f0a4add6700 h=208294 c=R000024a6-01-5e3b8145] INFO Core.PolicyResCollector - getSohr: Failed to generate Sohr
2020-02-06 11:00:21,173 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208281 c=R000024a6-01-5e3b8145] INFO Core.PETaskScheduler - ** Completed PETaskSessionLog **
2020-02-06 11:00:21,174 [Th 43 Req 53492 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - Policy Evaluation time = 15 ms
2020-02-06 11:00:21,174 [Th 43 Req 53492 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - rlm_policy: Received Accept Enforcement Profile
2020-02-06 11:00:21,174 [Th 43 Req 53492 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - rlm_policy: Policy Server reply does not contain Posture-Validation-Response
2020-02-06 11:00:21,174 [Th 43 Req 53492 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - reqst_update_state: Access-Challenge 107:128:00-1e-33-28-85-10:AIcA4QARAO700AAAV7yB8cDyhvUbWQYaMeeG0g==
2020-02-06 11:00:21,174 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208281 c=R000024a6-01-5e3b8145] INFO Core.PETaskScheduler - ** Completed PETaskOutputPolicyRes **
2020-02-06 11:00:21,174 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208281 c=R000024a6-01-5e3b8145] INFO Core.PETaskScheduler - ** Completed PETaskAuthStatusInfo **
2020-02-06 11:00:21,174 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208281 c=R000024a6-01-5e3b8145] INFO Core.PETaskScheduler - *** PE_TASK_SCHEDULE_RADIUS Completed ***
2020-02-06 11:00:21,177 [Th 44 Req 53493 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - rlm_service: The request was categorized into service "Aruba-1x-Auth-Wire" - 108:462:00-1e-33-28-85-10
2020-02-06 11:00:21,177 [Th 44 Req 53493 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - rlm_policy: Bypassing Policy Evaluation.
2020-02-06 11:00:21,177 [Th 44 Req 53493 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - rlm_policy: Added Class attribute with value Class = 0x095d390f27b9489aad1a75b67bf4945ac00b0000000000005230303030323461362d30312d35653362383134350000000000000000000000
2020-02-06 11:00:21,178 [Th 44 Req 53493 SessId R000024a6-01-5e3b8145] INFO RadiusServer.Radius - Request processing time = 61 ms
2020-02-06 11:00:21,200 [RequestHandler-1-0x7f0a4add6700 r=R000024a6-01-5e3b8145 h=208299] ERROR Core.MacAuthSessionQueryEventHandler - Failed to get MacAuth session info for 001e33288510