| Time | Message |
|---|---|
| 2013-03-21 16:31:41,051 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Processing the authorize section of radiusd.conf |
| 2013-03-21 16:31:41,051 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - modcall: entering group authorize for request 13 |
| 2013-03-21 16:31:41,051 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - modcallauthorize]: module "dacl" returns noop for request 13 |
| 2013-03-21 16:31:41,051 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rlm_service: The request does not have Service-State attribute |
| 2013-03-21 16:31:41,051 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] INFO RadiusServer.Radius - rlm_service: Starting Service Categorization - 21:212:2477036A7238 |
| 2013-03-21 16:31:41,051 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rlm_service: service_get_polsvr_conn: Checking Id: 0 |
| 2013-03-21 16:31:41,052 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rlm_service: service_get_polsvr_conn: Got Id: 0, handle: 0x24e5970 |
| 2013-03-21 16:31:41,052 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rlm_service: add req-packet attributes |
| 2013-03-21 16:31:41,052 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - NAS-IP-Address = 192.168.25.10 |
| 2013-03-21 16:31:41,052 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - NAS-Port = 0 |
| 2013-03-21 16:31:41,052 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - NAS-Port-Type = Wireless-802.11 |
| 2013-03-21 16:31:41,052 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - User-Name = "tobiasg@sys-tec-gmbh.de" |
| 2013-03-21 16:31:41,052 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Service-Type = Login-User |
| 2013-03-21 16:31:41,052 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Calling-Station-Id = "2477036A7238" |
| 2013-03-21 16:31:41,052 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Called-Station-Id = "000B86647B90" |
| 2013-03-21 16:31:41,052 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Framed-IP-Address = 192.168.25.100 |
| 2013-03-21 16:31:41,052 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Aruba-Essid-Name = "SYS-TEC-GAST" |
| 2013-03-21 16:31:41,052 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Aruba-Location-Id = "AP125-1" |
| 2013-03-21 16:31:41,052 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Aruba-AP-Group = "SYSTEC_WLAN_GROUP" |
| 2013-03-21 16:31:41,052 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Aruba-Device-Type = "Win 7" |
| 2013-03-21 16:31:41,052 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Message-Authenticator = 0x26457adb1636e2346d5e6ce80a0779f1 |
| 2013-03-21 16:31:41,052 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rlm_service: add config attributes |
| 2013-03-21 16:31:41,052 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Session-Id = "R0000000d-01-514b27dd" |
| 2013-03-21 16:31:41,052 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rlm_service: add connection attributes |
| 2013-03-21 16:31:41,061 | [RequestHandler-1-0x7f79377fb700 r=auto-27 h=63 r=R0000000d-01-514b27dd] INFO Core.ServiceReqHandler - Service classification result = WLAN Enterprise Service |
| 2013-03-21 16:31:41,062 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rlm_service: Policy Server reply does not contain Requested-Posture-Credentials |
| 2013-03-21 16:31:41,063 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rlm_service: service_release_polsvr_conn: Release Id: 0, handle: 0x24e5970 |
| 2013-03-21 16:31:41,063 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] INFO RadiusServer.Radius - rlm_service: The request has been categorized into service "WLAN Enterprise Service" |
| 2013-03-21 16:31:41,063 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rlm_service: svcreq_list_add Service-State = 0x002c002a0018004a0d00000027048be21a8b3f934b5e0ef71e26e1aa, Session-Id = "R0000000d-01-514b27dd" |
| 2013-03-21 16:31:41,063 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - modcallauthorize]: module "service" returns ok for request 13 |
| 2013-03-21 16:31:41,063 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - modcall: leaving group authorize (returns ok) for request 13 |
| 2013-03-21 16:31:41,063 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Found Autz-Type svc_WLAN Enterprise Service_3001 |
| 2013-03-21 16:31:41,063 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Processing the authorize section of radiusd.conf |
| 2013-03-21 16:31:41,063 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - modcall: entering group svc_WLAN Enterprise Service_3001 for request 13 |
| 2013-03-21 16:31:41,063 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - modcall: entering group for request 13 |
| 2013-03-21 16:31:41,063 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] INFO RadiusServer.Radius - rlm_sql: searching for user tobiasg@sys-tec-gmbh.de in Local:localhost |
| 2013-03-21 16:31:41,063 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - radius_xlat: Running registered xlat function of module auth_local_db for string 'Username' |
| 2013-03-21 16:31:41,063 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rlm_sql (auth_local_db): - sql_xlat |
| 2013-03-21 16:31:41,063 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - radius_xlat: 'SELECT user_credential(password) AS User_Password, CASE WHEN enabled = FALSE THEN 225 WHEN ((expire_time is not null AND expire_time <= now())) THEN 226 ELSE 0 END AS Account_Status, tips_role.name as Role_Name FROM tips_auth_local_users JOIN tips_role ON (tips_auth_local_users.user_role = tips_role.id) WHERE user_id = 'tobiasg@sys-tec-gmbh.de'' |
| 2013-03-21 16:31:41,063 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rlm_sql (auth_local_db): Trying to (re)connect unconnected handle 31.. |
| 2013-03-21 16:31:41,063 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rlm_sql (auth_local_db): Attempting to connect rlm_sql_unixodbc #31 |
| 2013-03-21 16:31:41,085 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rlm_sql (auth_local_db): Connected new DB handle, #31 |
| 2013-03-21 16:31:41,085 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rlm_sql (auth_local_db): Reserving sql socket id: 31 |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rlm_sql (auth_local_db): User tobiasg@sys-tec-gmbh.de not found |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rlm_sql (auth_local_db): Released sql socket id: 31 |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rlm_sql (auth_local_db): User not found |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - modcallauthorize]: module "auth_local_db" returns notfound for request 13 |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - modcall: leaving group (returns notfound) for request 13 |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rlm_eap: No EAP-Message, not doing EAP |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - modcallauthorize]: module "svc_3001_eap" returns noop for request 13 |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rlm_auth_check: Allowed authentication methods: svc_3001_eap |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - radius: No MS Identity VP |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] INFO RadiusServer.Radius - rlm_auth_check: Auth-Type not set. |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] ERROR RadiusServer.Radius - rlm_auth_check: Auth-Type not set or authentication methods have not been configured. Rejecting it. |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - modcallauthorize]: module "svc_3001_auth_check" returns ok for request 13 |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - modcall: leaving group svc_WLAN Enterprise Service_3001 (returns ok) for request 13 |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rad_check_password: Found Auth-Type Reject |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rad_check_password: Auth-Type = Reject, rejecting user |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - auth: Failed to validate the user. |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Found Post-Auth-Type |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Processing the post-auth section of radiusd.conf |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - modcall: entering group REJECT for request 13 |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] INFO RadiusServer.Radius - rlm_policy: Starting Policy Evaluation. |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rlm_policy: policy_get_polsvr_conn: Checking Id: 0 |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rlm_policy: policy_get_polsvr_conn: Got Id: 0, handle: 0x256f370 |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rlm_policy: policy_add_request_vps |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - NAS-IP-Address = 192.168.25.10 |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - NAS-Port = 0 |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - NAS-Port-Type = Wireless-802.11 |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - User-Name = "tobiasg@sys-tec-gmbh.de" |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Service-Type = Login-User |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Calling-Station-Id = "2477036A7238" |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Called-Station-Id = "000B86647B90" |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Framed-IP-Address = 192.168.25.100 |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Aruba-Essid-Name = "SYS-TEC-GAST" |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Aruba-Location-Id = "AP125-1" |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Aruba-AP-Group = "SYSTEC_WLAN_GROUP" |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Aruba-Device-Type = "Win 7" |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rlm_policy: policy_add_config_vps - Request has the following config items |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Session-Id = "R0000000d-01-514b27dd" |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Service-Name = "WLAN Enterprise Service" |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Service-Id = 3001 |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Autz-Type = svc_WLAN Enterprise Service_3001 |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Auth-Type = Reject |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Post-Auth-Type = REJECT |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Service-Name = "WLAN Enterprise Service" |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Session-Id = "R0000000d-01-514b27dd" |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rlm_policy: policy_add_reply_vps |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rlm_policy: policy_add_conn_info |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rlm_policy: policy_add_authentication_attributes |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rlm_policy: policy_add_authorization_attributes |
| 2013-03-21 16:31:41,088 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rlm_policy: policy_add_certificate_attributes |
| 2013-03-21 16:31:41,092 | [RequestHandler-1-0x7f79377fb700 r=auto-28 h=65 r=R0000000d-01-514b27dd] INFO Common.EndpointTable - Returning NULL (EndpointPtr) for macAddr 2477036a7238 |
| 2013-03-21 16:31:41,092 | [RequestHandler-1-0x7f79377fb700 r=auto-28 h=65 r=R0000000d-01-514b27dd] INFO Common.TagDefinitionCacheTable - No InstanceTagDefCacheMap found for instance id = 3001 entity id = 29 |
| 2013-03-21 16:31:41,093 | [RequestHandler-1-0x7f79377fb700 r=auto-28 h=65 r=R0000000d-01-514b27dd] INFO Common.TagDefinitionCacheTable - Building the TagDefMapTable for NAD instance=3001 |
| 2013-03-21 16:31:41,093 | [RequestHandler-1-0x7f79377fb700 r=auto-28 h=65 r=R0000000d-01-514b27dd] INFO Common.TagDefinitionCacheTable - Built 0 tag(s) for NAD instanceId=3001|entityId=29 |
| 2013-03-21 16:31:41,093 | [RequestHandler-1-0x7f79377fb700 r=auto-28 h=65 r=R0000000d-01-514b27dd] INFO TAT.TagAttrHolderBuilder - No tags built for instanceId=3001|entity=Device |
| 2013-03-21 16:31:41,093 | [RequestHandler-1-0x7f79377fb700 r=auto-28 h=65 r=R0000000d-01-514b27dd] INFO TAT.AluTagAttrHolderBuilder - buildAttrHolder: Tags cannot be built for instanceId=0 (NULL AuthLocalUser) |
| 2013-03-21 16:31:41,093 | [RequestHandler-1-0x7f79377fb700 r=auto-28 h=65 r=R0000000d-01-514b27dd] INFO TAT.GuTagAttrHolderBuilder - buildAttrHolder: Tags cannot be built for instanceId=0 (NULL GuestUser) |
| 2013-03-21 16:31:41,093 | [RequestHandler-1-0x7f79377fb700 r=auto-28 h=65 r=R0000000d-01-514b27dd] INFO TAT.EndpointTagAttrHolderBuilder - buildAttrHolder: Tags cannot be built for instanceId=0 (NULL Endpoint) |
| 2013-03-21 16:31:41,093 | [RequestHandler-1-0x7f79377fb700 r=auto-28 h=65 r=R0000000d-01-514b27dd] INFO TAT.OnboardTagAttrHolderBuilder - buildAttrHolder: Tags cannot be built for instanceId=0 (NULL Onboard Device User) |
| 2013-03-21 16:31:41,093 | [RequestHandler-1-0x7f79377fb700 h=212 c=R0000000d-01-514b27dd] INFO Core.PETaskScheduler - *** PE_TASK_SCHEDULE_RADIUS Started *** |
| 2013-03-21 16:31:41,093 | [RequestHandler-1-0x7f79377fb700 h=214 c=R0000000d-01-514b27dd] INFO Core.PETaskRoleMapping - Roles: |
| 2013-03-21 16:31:41,095 | [RequestHandler-1-0x7f79377fb700 h=217 c=R0000000d-01-514b27dd] INFO Core.PETaskEnforcement - EnfProfiles: Allow Access Profile], Aruba Authenticated Role |
| 2013-03-21 16:31:41,098 | [RequestHandler-1-0x7f79377fb700 h=218 c=R0000000d-01-514b27dd] INFO Core.PETaskRadiusEnfProfileBuilder - EnfProfileAction=ACCEPT |
| 2013-03-21 16:31:41,098 | [RequestHandler-1-0x7f79377fb700 h=218 c=R0000000d-01-514b27dd] INFO Core.PETaskRadiusEnfProfileBuilder - Radius enfProfiles used: Allow Access Profile], Aruba Authenticated Role |
| 2013-03-21 16:31:41,098 | [RequestHandler-1-0x7f79377fb700 h=218 c=R0000000d-01-514b27dd] INFO Core.EnfProfileComputer - getFinalSessionTimeout: sessionTimeout = 0 |
| 2013-03-21 16:31:41,098 | [RequestHandler-1-0x7f79377fb700 h=222 c=R0000000d-01-514b27dd] INFO Core.PETaskCliEnforcement - startHandler: No commands for CLI enforcement |
| 2013-03-21 16:31:41,098 | [RequestHandler-1-0x7f79377fb700 r=R0000000d-01-514b27dd h=221 c=R0000000d-01-514b27dd] INFO Core.PETaskPostAuthEnfProfileBuilder - getApplicableProfiles: No Post auth enforcement profiles applicable for this device |
| 2013-03-21 16:31:41,098 | [RequestHandler-1-0x7f79377fb700 r=R0000000d-01-514b27dd h=219 c=R0000000d-01-514b27dd] INFO Core.PETaskRadiusCoAEnfProfileBuilder - getApplicableProfiles: No radius_coa enforcement profiles applicable for this device |
| 2013-03-21 16:31:41,101 | [RequestHandler-1-0x7f79377fb700 h=224 c=R0000000d-01-514b27dd] INFO Core.XpipPolicyResHandler - populateResponseTlv: PETaskPostureOutput does not exist. Skip sending posture VAFs |
| 2013-03-21 16:31:41,101 | [RequestHandler-1-0x7f79377fb700 h=224 c=R0000000d-01-514b27dd] INFO Core.PolicyResCollector - getSohr: Failed to generate Sohr |
| 2013-03-21 16:31:41,102 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rlm_policy: policy_add_resp_attrs |
| 2013-03-21 16:31:41,102 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] INFO RadiusServer.Radius - rlm_policy: Received Accept Enforcement Profile |
| 2013-03-21 16:31:41,102 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rlm_policy: Request rejected. Not adding Class attribute. |
| 2013-03-21 16:31:41,102 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] INFO RadiusServer.Radius - rlm_policy: Policy Server reply does not contain Posture-Validation-Response |
| 2013-03-21 16:31:41,102 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - rlm_policy: policy_release_polsvr_conn: Release Id: 0, handle: 0x256f370 |
| 2013-03-21 16:31:41,102 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - modcallpost-auth]: module "policy" returns reject for request 13 |
| 2013-03-21 16:31:41,102 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - modcall: leaving group REJECT (returns reject) for request 13 |
| 2013-03-21 16:31:41,102 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Delaying request 13 for 1 seconds |
| 2013-03-21 16:31:41,102 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Finished request 13 |
| 2013-03-21 16:31:41,102 | [Th 6 Req 13 SessId R0000000d-01-514b27dd] DEBUG RadiusServer.Radius - Going to the next request |
| 2013-03-21 16:31:41,102 | [RequestHandler-1-0x7f79377fb700 h=223 c=R0000000d-01-514b27dd] INFO Core.PolicyResCollector - getSohr: Failed to generate Sohr |
| 2013-03-21 16:31:41,102 | [RequestHandler-1-0x7f79377fb700 r=R0000000d-01-514b27dd h=212 c=R0000000d-01-514b27dd] INFO Core.PETaskScheduler - *** PE_TASK_SCHEDULE_RADIUS Completed *** |