Request log details for session: R004e3b8d-01-587614ec Time Message 2017-01-11 12:20:12,029 [Th 181 Req 40939400 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - rlm_service: Starting Service Categorization - 191:262:8086F2AF18B5 2017-01-11 12:20:12,032 [Th 181 Req 40939400 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - Service Categorization time = 3 ms 2017-01-11 12:20:12,032 [Th 181 Req 40939400 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - rlm_service: The request has been categorized into service "Municipality Aruba 802.1X Wireless" 2017-01-11 12:20:12,032 [Th 181 Req 40939400 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - rlm_ldap: searching for user computer2.municipality.intra in AD:ad-01.municipality.intra 2017-01-11 12:20:12,032 [RequestHandler-1-0x7f7acfbdd700 r=psauto-1467958883-10903124 h=223 r=R004e3b8d-01-587614ec] INFO Core.ServiceReqHandler - Service classification result = Municipality Aruba 802.1X Wireless 2017-01-11 12:20:12,034 [Th 181 Req 40939400 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - rlm_ldap: found user computer2$ in AD:ad-01.municipality.intra 2017-01-11 12:20:12,034 [Th 181 Req 40939400 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - LDAP/AD User lookup time = 2 ms 2017-01-11 12:20:12,034 [Th 181 Req 40939400 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - rlm_eap_peap: Initiate 2017-01-11 12:20:12,034 [Th 181 Req 40939400 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - reqst_update_state: Access-Challenge 191:76:8086F2AF18B5:0x00a700010063008f88af7002e951726102b001e41de12721b3f0fd60 2017-01-11 12:20:12,049 [Th 178 Req 40939401 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - rlm_service: The request was categorized into service "Municipality Aruba 802.1X Wireless" - 152:257:8086F2AF18B5 2017-01-11 12:20:12,049 [Th 178 Req 40939401 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - rlm_eap_tls: Initiate 2017-01-11 12:20:12,049 [Th 178 Req 40939401 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - reqst_update_state: Access-Challenge 152:76:8086F2AF18B5:0x007f004800d1006989af7002e79eed28c7551b5e6a93a94d9ceb24a7 2017-01-11 12:20:12,093 [Th 175 Req 40939402 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - rlm_service: The request was categorized into service "Municipality Aruba 802.1X Wireless" - 195:392:8086F2AF18B5 2017-01-11 12:20:12,095 [Th 175 Req 40939402 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - TLS_accept:error in SSLv3 read client certificate A 2017-01-11 12:20:12,095 [Th 175 Req 40939402 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - reqst_update_state: Access-Challenge 195:1112:8086F2AF18B5:0x00cc00d700ab00418aaf7002ee2a332177b2d27ba5e9b517f807c511 2017-01-11 12:20:12,112 [Th 183 Req 40939403 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - rlm_service: The request was categorized into service "Municipality Aruba 802.1X Wireless" - 211:257:8086F2AF18B5 2017-01-11 12:20:12,112 [Th 183 Req 40939403 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - reqst_update_state: Access-Challenge 211:1108:8086F2AF18B5:0x00960067000e009d8baf70026b03fa8bbd3f24d44d49aef7adeeb760 2017-01-11 12:20:12,118 [Th 177 Req 40939404 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - rlm_service: The request was categorized into service "Municipality Aruba 802.1X Wireless" - 210:257:8086F2AF18B5 2017-01-11 12:20:12,118 [Th 177 Req 40939404 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - reqst_update_state: Access-Challenge 210:1108:8086F2AF18B5:0x0081004b002800bc8caf70022cd723b54605dc5cbf387204a9f528e4 2017-01-11 12:20:12,154 [Th 179 Req 40939405 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - rlm_service: The request was categorized into service "Municipality Aruba 802.1X Wireless" - 181:257:8086F2AF18B5 2017-01-11 12:20:12,154 [Th 179 Req 40939405 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - reqst_update_state: Access-Challenge 181:1108:8086F2AF18B5:0x0096000d001a00338daf7002b40123430cdfd4acad8d3e99ce788984 2017-01-11 12:20:12,162 [Th 176 Req 40939406 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - rlm_service: The request was categorized into service "Municipality Aruba 802.1X Wireless" - 196:257:8086F2AF18B5 2017-01-11 12:20:12,162 [Th 176 Req 40939406 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - reqst_update_state: Access-Challenge 196:703:8086F2AF18B5:0x002d00a600c3006a8eaf700285288fb83980db9635d8b3f221f53593 2017-01-11 12:20:12,191 [Th 180 Req 40939407 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - rlm_service: The request was categorized into service "Municipality Aruba 802.1X Wireless" - 170:1753:8086F2AF18B5 2017-01-11 12:20:12,191 [Th 180 Req 40939407 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - reqst_update_state: Access-Challenge 170:76:8086F2AF18B5:0x00470018008800d58faf70024301f486a66bc53a186caae5f42aa041 2017-01-11 12:20:12,196 [Th 184 Req 40939408 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - rlm_service: The request was categorized into service "Municipality Aruba 802.1X Wireless" - 222:945:8086F2AF18B5 2017-01-11 12:20:12,197 [Th 184 Req 40939408 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - chain-depth=1, 2017-01-11 12:20:12,197 [Th 184 Req 40939408 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - error=0 2017-01-11 12:20:12,197 [Th 184 Req 40939408 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - --> User-Name = host/computer2.municipality.intra 2017-01-11 12:20:12,197 [Th 184 Req 40939408 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - --> subject = /DC=intra/DC=municipality/CN=municipalityRootCA 2017-01-11 12:20:12,197 [Th 184 Req 40939408 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - --> issuer = /DC=intra/DC=municipality/CN=municipalityRootCA 2017-01-11 12:20:12,197 [Th 184 Req 40939408 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - --> verify return:1 2017-01-11 12:20:12,197 [Th 184 Req 40939408 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - chain-depth=0, 2017-01-11 12:20:12,197 [Th 184 Req 40939408 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - error=0 2017-01-11 12:20:12,197 [Th 184 Req 40939408 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - --> User-Name = host/computer2.municipality.intra 2017-01-11 12:20:12,197 [Th 184 Req 40939408 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - --> subject = /CN=computer2.municipality.intra 2017-01-11 12:20:12,197 [Th 184 Req 40939408 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - --> issuer = /DC=intra/DC=municipality/CN=municipalityRootCA 2017-01-11 12:20:12,197 [Th 184 Req 40939408 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - --> verify return:1 2017-01-11 12:20:12,198 [Th 184 Req 40939408 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - reqst_update_state: Access-Challenge 222:139:8086F2AF18B5:0x0019007a006a00ef90af7002540d89f02c33bf973e72310584ccfd58 2017-01-11 12:20:12,206 [Th 182 Req 40939409 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - rlm_service: The request was categorized into service "Municipality Aruba 802.1X Wireless" - 215:257:8086F2AF18B5 2017-01-11 12:20:12,206 [Th 182 Req 40939409 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - rlm_eap_tls: Session established. 2017-01-11 12:20:12,206 [Th 182 Req 40939409 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - rlm_policy: Starting Policy Evaluation. 2017-01-11 12:20:12,208 [RequestHandler-1-0x7f7acfbdd700 r=psauto-1467958883-10903125 h=239 r=R004e3b8d-01-587614ec] INFO Common.EndpointTable - Returning EndpointSPtr for macAddr 8086f2af18b5 2017-01-11 12:20:12,208 [RequestHandler-1-0x7f7acfbdd700 r=psauto-1467958883-10903125 h=239 r=R004e3b8d-01-587614ec] INFO Common.TagDefinitionCacheTable - No InstanceTagDefCacheMap found for instance id = 3003 entity id = 29 2017-01-11 12:20:12,208 [RequestHandler-1-0x7f7acfbdd700 r=psauto-1467958883-10903125 h=239 r=R004e3b8d-01-587614ec] INFO Common.TagDefinitionCacheTable - Building the TagDefMapTable for NAD instance=3003 2017-01-11 12:20:12,208 [RequestHandler-1-0x7f7acfbdd700 r=psauto-1467958883-10903125 h=239 r=R004e3b8d-01-587614ec] INFO Common.TagDefinitionCacheTable - Built 0 tag(s) for NAD instanceId=3003|entityId=29 2017-01-11 12:20:12,208 [RequestHandler-1-0x7f7acfbdd700 r=psauto-1467958883-10903125 h=239 r=R004e3b8d-01-587614ec] INFO TAT.TagAttrHolderBuilder - No tags built for instanceId=3003|entity=Device 2017-01-11 12:20:12,208 [RequestHandler-1-0x7f7acfbdd700 r=psauto-1467958883-10903125 h=239 r=R004e3b8d-01-587614ec] INFO TAT.AluTagAttrHolderBuilder - buildAttrHolder: Tags cannot be built for instanceId=0 (NULL AuthLocalUser) 2017-01-11 12:20:12,208 [RequestHandler-1-0x7f7acfbdd700 r=psauto-1467958883-10903125 h=239 r=R004e3b8d-01-587614ec] INFO TAT.GuTagAttrHolderBuilder - buildAttrHolder: Tags cannot be built for instanceId=0 (NULL GuestUser) 2017-01-11 12:20:12,208 [RequestHandler-1-0x7f7acfbdd700 r=psauto-1467958883-10903125 h=239 r=R004e3b8d-01-587614ec] INFO TAT.OnboardTagAttrHolderBuilder - buildAttrHolder: Tags cannot be built for instanceId=0 (NULL Onboard Device User) 2017-01-11 12:20:12,209 [RequestHandler-1-0x7f7acfbdd700 h=92957698 c=R004e3b8d-01-587614ec] INFO Core.PETaskScheduler - *** PE_TASK_SCHEDULE_RADIUS Started *** 2017-01-11 12:20:12,209 [RequestHandler-1-0x7f7acfbdd700 h=92957698 c=R004e3b8d-01-587614ec] INFO Core.PETaskScheduler - ** Starting PETaskAuthSourceRestriction ** 2017-01-11 12:20:12,209 [RequestHandler-1-0x7f7acfbdd700 h=92957698 c=R004e3b8d-01-587614ec] INFO Core.PETaskScheduler - ** Starting PETaskRoleMapping ** 2017-01-11 12:20:12,209 [RequestHandler-1-0x7f7acfbdd700 h=92957699 c=R004e3b8d-01-587614ec] WARN REC.EvaluatorCtx - Prerequisites set is empty, not populating the Request Map 2017-01-11 12:20:12,209 [RequestHandler-1-0x7f7acfbdd700 r=R004e3b8d-01-587614ec h=92957698 c=R004e3b8d-01-587614ec] INFO Core.PETaskScheduler - ** Completed PETaskAuthSourceRestriction ** 2017-01-11 12:20:12,210 [RequestHandler-1-0x7f7acfbdd700 h=92957700 c=R004e3b8d-01-587614ec] INFO Core.PETaskRoleMapping - Roles: AD-Personal-Dator, Machine Authenticated] 2017-01-11 12:20:12,210 [RequestHandler-1-0x7f7acfbdd700 r=R004e3b8d-01-587614ec h=92957698 c=R004e3b8d-01-587614ec] INFO Core.PETaskScheduler - ** Completed PETaskRoleMapping ** 2017-01-11 12:20:12,211 [RequestHandler-1-0x7f7acfbdd700 r=R004e3b8d-01-587614ec h=92957698 c=R004e3b8d-01-587614ec] INFO Core.PETaskScheduler - ** Starting PETaskPolicyResult ** 2017-01-11 12:20:12,211 [RequestHandler-1-0x7f7acfbdd700 r=R004e3b8d-01-587614ec h=92957698 c=R004e3b8d-01-587614ec] INFO Core.PETaskScheduler - ** Completed PETaskPolicyResult ** 2017-01-11 12:20:12,211 [RequestHandler-1-0x7f7acfbdd700 r=R004e3b8d-01-587614ec h=92957698 c=R004e3b8d-01-587614ec] INFO Core.PETaskScheduler - ** Starting PETaskEnforcement ** 2017-01-11 12:20:12,211 [RequestHandler-1-0x7f7acfbdd700 h=92957703 c=R004e3b8d-01-587614ec] INFO Core.PETaskEnforcement - EnfProfiles: Municipality Aruba 802.1X Wireless Update Endpoint Location, Municipality Aruba 802.1X - AD-Personal-Dator 2017-01-11 12:20:12,211 [RequestHandler-1-0x7f7acfbdd700 r=R004e3b8d-01-587614ec h=92957698 c=R004e3b8d-01-587614ec] INFO Core.PETaskScheduler - ** Completed PETaskEnforcement ** 2017-01-11 12:20:12,211 [RequestHandler-1-0x7f7acfbdd700 r=R004e3b8d-01-587614ec h=92957698 c=R004e3b8d-01-587614ec] INFO Core.PETaskScheduler - ** Starting PETaskRadiusEnfProfileBuilder ** 2017-01-11 12:20:12,211 [RequestHandler-1-0x7f7acfbdd700 r=R004e3b8d-01-587614ec h=92957698 c=R004e3b8d-01-587614ec] INFO Core.PETaskScheduler - ** Starting PETaskRadiusCoAEnfProfileBuilder ** 2017-01-11 12:20:12,211 [RequestHandler-1-0x7f7acfbdd700 r=R004e3b8d-01-587614ec h=92957698 c=R004e3b8d-01-587614ec] INFO Core.PETaskScheduler - ** Starting PETaskAppEnfProfileBuilder ** 2017-01-11 12:20:12,211 [RequestHandler-1-0x7f7acfbdd700 r=R004e3b8d-01-587614ec h=92957698 c=R004e3b8d-01-587614ec] INFO Core.PETaskScheduler - ** Starting PETaskPostAuthEnfProfileBuilder ** 2017-01-11 12:20:12,211 [RequestHandler-1-0x7f7acfbdd700 r=R004e3b8d-01-587614ec h=92957698 c=R004e3b8d-01-587614ec] INFO Core.PETaskScheduler - ** Starting PETaskGenericEnfProfileBuilder ** 2017-01-11 12:20:12,212 [RequestHandler-1-0x7f7acfbdd700 h=92957708 c=R004e3b8d-01-587614ec] INFO Core.PETaskGenericEnfProfileBuilder - getApplicableProfiles: No App enforcement (Generic) profiles applicable for this device 2017-01-11 12:20:12,212 [RequestHandler-1-0x7f7acfbdd700 h=92957706 c=R004e3b8d-01-587614ec] ERROR Common.AppEnfProfileTable - getAppType: Failed for id=3003 2017-01-11 12:20:12,212 [RequestHandler-1-0x7f7acfbdd700 h=92957706 c=R004e3b8d-01-587614ec] ERROR Common.AppEnfProfileCacheTable - 2017-01-11 12:20:12,212 [RequestHandler-1-0x7f7acfbdd700 h=92957704 c=R004e3b8d-01-587614ec] INFO Core.PETaskRadiusEnfProfileBuilder - EnfProfileAction=ACCEPT 2017-01-11 12:20:12,212 [RequestHandler-1-0x7f7acfbdd700 h=92957704 c=R004e3b8d-01-587614ec] INFO Core.PETaskRadiusEnfProfileBuilder - Radius enfProfiles used: Municipality Aruba 802.1X - AD-Personal-Dator 2017-01-11 12:20:12,212 [RequestHandler-1-0x7f7acfbdd700 h=92957704 c=R004e3b8d-01-587614ec] INFO Core.EnfProfileComputer - getFinalSessionTimeout: sessionTimeout = 0 2017-01-11 12:20:12,212 [RequestHandler-1-0x7f7acfbdd700 r=R004e3b8d-01-587614ec h=92957698 c=R004e3b8d-01-587614ec] INFO Core.PETaskScheduler - ** Completed PETaskGenericEnfProfileBuilder ** 2017-01-11 12:20:12,212 [RequestHandler-1-0x7f7acfbdd700 r=R004e3b8d-01-587614ec h=92957698 c=R004e3b8d-01-587614ec] INFO Core.PETaskScheduler - ** Completed PETaskAppEnfProfileBuilder ** 2017-01-11 12:20:12,212 [RequestHandler-1-0x7f7acfbdd700 r=R004e3b8d-01-587614ec h=92957698 c=R004e3b8d-01-587614ec] INFO Core.PETaskScheduler - ** Starting PETaskCliEnforcement ** 2017-01-11 12:20:12,212 [RequestHandler-1-0x7f7acfbdd700 h=92957709 c=R004e3b8d-01-587614ec] INFO Core.PETaskCliEnforcement - startHandler: No commands for CLI enforcement 2017-01-11 12:20:12,212 [RequestHandler-1-0x7f7acfbdd700 r=R004e3b8d-01-587614ec h=92957698 c=R004e3b8d-01-587614ec] INFO Core.PETaskScheduler - ** Completed PETaskRadiusEnfProfileBuilder ** 2017-01-11 12:20:12,212 [RequestHandler-1-0x7f7acfbdd700 r=R004e3b8d-01-587614ec h=92957698 c=R004e3b8d-01-587614ec] INFO Core.PETaskScheduler - ** Completed PETaskCliEnforcement ** 2017-01-11 12:20:12,214 [RequestHandler-1-0x7f7acfbdd700 r=R004e3b8d-01-587614ec h=92957707 c=R004e3b8d-01-587614ec] INFO Core.PETaskPostAuthEnfProfileBuilder - Post auth enforcement profiles used: Municipality Aruba 802.1X Wireless Update Endpoint Location 2017-01-11 12:20:12,214 [RequestHandler-1-0x7f7acfbdd700 r=R004e3b8d-01-587614ec h=92957707 c=R004e3b8d-01-587614ec] INFO Core.PETaskPostAuthEnfProfileBuilder - UnknownAutzParams to fetch for PostAuthEnfProfiles: : 2017-01-11 12:20:12,214 [RequestHandler-1-0x7f7acfbdd700 r=R004e3b8d-01-587614ec h=92957707 c=R004e3b8d-01-587614ec] INFO Core.PETaskPostAuthEnfProfileBuilder - UnknownNAutzParams to fetch for PostAuthEnfProfiles: : Radius:Aruba:Aruba-Location-Id, Radius:IETF:NAS-IP-Address 2017-01-11 12:20:12,215 [RequestHandler-1-0x7f7acfbdd700 r=R004e3b8d-01-587614ec h=92957698 c=R004e3b8d-01-587614ec] INFO Core.PETaskScheduler - ** Completed PETaskPostAuthEnfProfileBuilder ** 2017-01-11 12:20:12,216 [RequestHandler-1-0x7f7acfbdd700 r=R004e3b8d-01-587614ec h=92957705 c=R004e3b8d-01-587614ec] INFO Core.PETaskRadiusCoAEnfProfileBuilder - getApplicableProfiles: No radius_coa enforcement profiles applicable for this device 2017-01-11 12:20:12,216 [RequestHandler-1-0x7f7acfbdd700 r=R004e3b8d-01-587614ec h=92957698 c=R004e3b8d-01-587614ec] INFO Core.PETaskScheduler - ** Completed PETaskRadiusCoAEnfProfileBuilder ** 2017-01-11 12:20:12,216 [RequestHandler-1-0x7f7acfbdd700 r=R004e3b8d-01-587614ec h=92957698 c=R004e3b8d-01-587614ec] INFO Core.PETaskScheduler - ** Starting PETaskAuthStatusInfo ** 2017-01-11 12:20:12,216 [RequestHandler-1-0x7f7acfbdd700 r=R004e3b8d-01-587614ec h=92957698 c=R004e3b8d-01-587614ec] INFO Core.PETaskScheduler - ** Starting PETaskOutputPolicyRes ** 2017-01-11 12:20:12,216 [RequestHandler-1-0x7f7acfbdd700 r=R004e3b8d-01-587614ec h=92957698 c=R004e3b8d-01-587614ec] INFO Core.PETaskScheduler - ** Starting PETaskSessionLog ** 2017-01-11 12:20:12,219 [Th 182 Req 40939409 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - Policy Evaluation time = 12 ms 2017-01-11 12:20:12,219 [Th 182 Req 40939409 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - rlm_policy: Received Accept Enforcement Profile 2017-01-11 12:20:12,219 [Th 182 Req 40939409 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - rlm_policy: Added Class attribute with value Class = 0x10ecd1e85a504a90b2726b3a6b85cf97b90b0000000000005230303465336238642d30312d35383736313465630000000000000000000000 2017-01-11 12:20:12,219 [Th 182 Req 40939409 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - rlm_policy: Policy Server reply does not contain Posture-Validation-Response 2017-01-11 12:20:12,219 [RequestHandler-1-0x7f7acfbdd700 h=92957711 c=R004e3b8d-01-587614ec] INFO Core.XpipPolicyResHandler - populateResponseTlv: PETaskPostureOutput does not exist. Skip sending posture VAFs 2017-01-11 12:20:12,219 [RequestHandler-1-0x7f7acfbdd700 h=92957711 c=R004e3b8d-01-587614ec] INFO Core.PolicyResCollector - getSohr: Failed to generate Sohr 2017-01-11 12:20:12,220 [Th 182 Req 40939409 SessId R004e3b8d-01-587614ec] INFO RadiusServer.Radius - Request processing time = 190 ms 2017-01-11 12:20:12,220 [RequestHandler-1-0x7f7acfbdd700 h=92957710 c=R004e3b8d-01-587614ec] INFO Core.PolicyResCollector - getSohr: Failed to generate Sohr 2017-01-11 12:20:12,220 [RequestHandler-1-0x7f7acfbdd700 r=R004e3b8d-01-587614ec h=92957698 c=R004e3b8d-01-587614ec] INFO Core.PETaskScheduler - ** Completed PETaskSessionLog ** 2017-01-11 12:20:12,220 [RequestHandler-1-0x7f7acfbdd700 r=R004e3b8d-01-587614ec h=92957698 c=R004e3b8d-01-587614ec] INFO Core.PETaskScheduler - ** Completed PETaskOutputPolicyRes ** 2017-01-11 12:20:12,220 [RequestHandler-1-0x7f7acfbdd700 r=R004e3b8d-01-587614ec h=92957698 c=R004e3b8d-01-587614ec] INFO Core.PETaskScheduler - ** Completed PETaskAuthStatusInfo ** 2017-01-11 12:20:12,220 [RequestHandler-1-0x7f7acfbdd700 r=R004e3b8d-01-587614ec h=92957698 c=R004e3b8d-01-587614ec] INFO Core.PETaskScheduler - *** PE_TASK_SCHEDULE_RADIUS Completed ***