Request log details for session: R00001f06-03-51bb1093 
Time                     Message  
2013-06-14 14:46:11,324  [Th 35 Req 39201 SessId R00001f06-03-51bb1093] INFO RadiusServer.Radius - rlm_service: Starting Service Categorization - 221:209:18F46A2449A3 
2013-06-14 14:46:11,330  [RequestHandler-1-0x7fe3eeff7700 r=auto-15950 h=223 r=R00001f06-03-51bb1093] INFO Core.ServiceReqHandler - Service classification result = P7S1-Guest Guest MAC Authentication 
2013-06-14 14:46:11,331  [Th 35 Req 39201 SessId R00001f06-03-51bb1093] INFO RadiusServer.Radius - rlm_service: The request has been categorized into service "P7S1-Guest Guest MAC Authentication" 
2013-06-14 14:46:11,331  [Th 35 Req 39201 SessId R00001f06-03-51bb1093] INFO RadiusServer.Radius - rlm_sql: searching for user 18f46a2449a3 in Local:localhost 
2013-06-14 14:46:11,333  [Th 35 Req 39201 SessId R00001f06-03-51bb1093] INFO RadiusServer.Radius - rlm_sql: found user 18f46a2449a3 in Local:localhost 
2013-06-14 14:46:11,333  [Th 35 Req 39201 SessId R00001f06-03-51bb1093] INFO RadiusServer.Radius - rlm_policy: Starting Policy Evaluation. 
2013-06-14 14:46:11,335  [RequestHandler-1-0x7fe3eeff7700 r=auto-15951 h=231 r=R00001f06-03-51bb1093] ERROR Common.NadClientTable - getNadClient: Unknown NadClient 172.22.2.10 
2013-06-14 14:46:11,336  [RequestHandler-1-0x7fe3eeff7700 r=auto-15951 h=231 r=R00001f06-03-51bb1093] ERROR Common.NadClientTable - getNadClient: Unknown NadClient 172.22.2.10 
2013-06-14 14:46:11,336  [RequestHandler-1-0x7fe3eeff7700 r=auto-15951 h=231 r=R00001f06-03-51bb1093] INFO Common.EndpointTable - Returning EndpointSPtr for macAddr 18f46a2449a3 
2013-06-14 14:46:11,336  [RequestHandler-1-0x7fe3eeff7700 r=auto-15951 h=231 r=R00001f06-03-51bb1093] INFO Common.TagDefinitionCacheTable - No InstanceTagDefCacheMap found for instance id = 0 entity id = 29 
2013-06-14 14:46:11,336  [RequestHandler-1-0x7fe3eeff7700 r=auto-15951 h=231 r=R00001f06-03-51bb1093] WARN Common.TagDefinitionCacheTable - Failed to build TagDefinitionMap. Unknown NadClient for Id=0 
2013-06-14 14:46:11,336  [RequestHandler-1-0x7fe3eeff7700 r=auto-15951 h=231 r=R00001f06-03-51bb1093] INFO TAT.TagAttrHolderBuilder - No tags built for instanceId=0|entity=Device 
2013-06-14 14:46:11,336  [RequestHandler-1-0x7fe3eeff7700 r=auto-15951 h=231 r=R00001f06-03-51bb1093] INFO TAT.AluTagAttrHolderBuilder - buildAttrHolder: Tags cannot be built for instanceId=0 (NULL AuthLocalUser) 
2013-06-14 14:46:11,336  [RequestHandler-1-0x7fe3eeff7700 r=auto-15951 h=231 r=R00001f06-03-51bb1093] INFO TAT.GuTagAttrHolderBuilder - buildAttrHolder: Tags cannot be built for instanceId=0 (NULL GuestUser) 
2013-06-14 14:46:11,336  [RequestHandler-1-0x7fe3eeff7700 r=auto-15951 h=231 r=R00001f06-03-51bb1093] INFO TAT.OnboardTagAttrHolderBuilder - buildAttrHolder: Tags cannot be built for instanceId=0 (NULL Onboard Device User) 
2013-06-14 14:46:11,336  [RequestHandler-1-0x7fe3eeff7700 h=127624 c=R00001f06-03-51bb1093] INFO Core.PETaskScheduler - *** PE_TASK_SCHEDULE_RADIUS Started *** 
2013-06-14 14:46:11,337  [RequestHandler-1-0x7fe3eeff7700 h=127625 c=R00001f06-03-51bb1093] WARN REC.EvaluatorCtx - Prerequisites set is empty, not populating the Request Map 
2013-06-14 14:46:11,362  [RequestHandler-1-0x7fe3eeff7700 h=127626 c=R00001f06-03-51bb1093] INFO Core.PETaskRoleMapping - Roles: MAC Caching], User Authenticated] 
2013-06-14 14:46:11,366  [RequestHandler-1-0x7fe3eeff7700 h=127629 c=R00001f06-03-51bb1093] INFO Core.PETaskEnforcement - EnfProfiles: Deny Access Profile] 
2013-06-14 14:46:11,366  [RequestHandler-1-0x7fe3eeff7700 h=127631 c=R00001f06-03-51bb1093] WARN Core.SessionInfoOperations - Skip SessionInfoOperations::persistSessionInfo because of NULL NAD or NAD IP matching localhost 
2013-06-14 14:46:11,366  [RequestHandler-1-0x7fe3eeff7700 h=127631 c=R00001f06-03-51bb1093] ERROR Common.NadClientTable - getNadClient: Unknown NadClient 172.22.2.10 
2013-06-14 14:46:11,366  [RequestHandler-1-0x7fe3eeff7700 h=127631 c=R00001f06-03-51bb1093] INFO Core.PETaskRadiusEnfProfileBuilder - EnfProfileAction=DENY 
2013-06-14 14:46:11,366  [RequestHandler-1-0x7fe3eeff7700 h=127631 c=R00001f06-03-51bb1093] INFO Core.PETaskRadiusEnfProfileBuilder - Radius enfProfiles used: Deny Access Profile] 
2013-06-14 14:46:11,367  [RequestHandler-1-0x7fe3eeff7700 h=127631 c=R00001f06-03-51bb1093] INFO Core.EnfProfileComputer - getFinalSessionTimeout: sessionTimeout = 0 
2013-06-14 14:46:11,367  [RequestHandler-1-0x7fe3eeff7700 h=127635 c=R00001f06-03-51bb1093] INFO Core.PETaskCliEnforcement - startHandler: Request rejected. Skip CLI enforcement 
2013-06-14 14:46:11,368  [RequestHandler-1-0x7fe3eeff7700 r=R00001f06-03-51bb1093 h=127632 c=R00001f06-03-51bb1093] WARN Core.PETaskRadiusCoAEnfProfileBuilder - handleHttpResponseEv: Fetching Radius attributes from battery failed, errMsg= 
2013-06-14 14:46:11,369  [RequestHandler-1-0x7fe3eeff7700 r=R00001f06-03-51bb1093 h=127634 c=R00001f06-03-51bb1093] WARN Core.PETaskPostAuthEnfProfileBuilder - handleHttpResponseEv: Fetching Radius attributes from battery failed, errMsg= 
2013-06-14 14:46:11,374  [RequestHandler-1-0x7fe3eeff7700 h=127638 c=R00001f06-03-51bb1093] INFO Core.XpipPolicyResHandler - populateResponseTlv: PETaskPostureOutput does not exist. Skip sending posture VAFs 
2013-06-14 14:46:11,374  [RequestHandler-1-0x7fe3eeff7700 h=127638 c=R00001f06-03-51bb1093] INFO Core.PolicyResCollector - getSohr: Failed to generate Sohr 
2013-06-14 14:46:11,374  [RequestHandler-1-0x7fe3eeff7700 h=127637 c=R00001f06-03-51bb1093] WARN Core.RadiusEnfProfileHelper - getSessionTimeoutInSecs: SessionTimeout attribute missing in output 
2013-06-14 14:46:11,374  [RequestHandler-1-0x7fe3eeff7700 h=127636 c=R00001f06-03-51bb1093] INFO Core.PolicyResCollector - getSohr: Failed to generate Sohr 
2013-06-14 14:46:11,375  [Th 35 Req 39201 SessId R00001f06-03-51bb1093] INFO RadiusServer.Radius - rlm_policy: Received Deny Enforcement Profile 
2013-06-14 14:46:11,375  [Th 35 Req 39201 SessId R00001f06-03-51bb1093] INFO RadiusServer.Radius - rlm_policy: Policy Server reply does not contain Posture-Validation-Response 
2013-06-14 14:46:11,377  [RequestHandler-1-0x7fe3eeff7700 r=R00001f06-03-51bb1093 h=127624 c=R00001f06-03-51bb1093] INFO Core.PETaskScheduler - *** PE_TASK_SCHEDULE_RADIUS Completed ***