[Users] Radius Authentication failed ?
Daniel-Constantin Mierla
daniel at voice-system.ro
Thu Mar 30 13:12:43 CEST 2006
Have you got any message is syslog coming from radiusclient-ng library?
The FreeRadius server reports ok for authentication.
Cheers,
Daniel
On 03/30/06 05:15, Nguyen Duc Phi wrote:
> I config openser authenticate from Radius. when softphone register to
> openser, Freeradius response "Sending Access-Accept" but openser
> inform "ERROR:auth_radius:radius_authorize_sterman: rc_auth failed" So
> softphone not registered. I search this title in google and find on
> "*OpenSER Users Mailing List*", I didnt find solution to
> fix problem. Could someone help me fix this problem ?
>
> Here is list of product's version I used.
> openser-1.0.1
> OS : CentOS-4 x86_64
> radiusclient-ng-0.5.2
> freeradius-1.0.5
>
> openser show debug :
>
> 8(8985) parse_headers: flags=ffffffffffffffff
> 8(8985) check_via_address(192.168.212.123, 192.168.212.123, 0)
> 8(8985) DEBUG:destroy_avp_list: destroying list (nil)
> 8(8985) receive_msg: cleaning up
> 7(8982) SIP Request:
> 7(8982) method: <REGISTER>
> 7(8982) uri: <sip:vdc.com.vn>
> 7(8982) version: <SIP/2.0>
> 7(8982) parse_headers: flags=2
> 7(8982) DEBUG: get_hdr_body : content_length=0
> 7(8982) get_hdr_field: cseq <CSeq>: <2> <REGISTER>
> 7(8982) DEBUG:parse_to:end of header reached, state=9
> 7(8982) DEBUG: get_hdr_field: <To> [23]; uri=[sip:5001 at vdc.com.vn]
> 7(8982) DEBUG: to body [<sip:5001 at vdc.com.vn>
> ]
> 7(8982) Found param type 235, <rport> = <n/a>; state=6
> 7(8982) Found param type 232, <branch> =
> <z9hG4bKc0a8d47b0131c9b1442b39c80000367c00000003>; state=16
> 7(8982) end of header reached, state=5
> 7(8982) parse_headers: Via found, flags=2
> 7(8982) parse_headers: this is the first via
> 7(8982) After parse_msg...
> 7(8982) preparing to run routing scripts...
> 7(8982) DEBUG:maxfwd:is_maxfwd_present: value = 70
> 7(8982) parse_headers: flags=200
> 7(8982) found end of header
> 7(8982) find_first_route: No Route headers found
> 7(8982) loose_route: There is no Route HF
> 7(8982) grep_sock_info - checking if host==us: 10==9 && [vdc.com.vn]
> == [127.0.0.1]
> 7(8982) grep_sock_info - checking if port 5060 matches port 5060
> 7(8982) grep_sock_info - checking if host==us: 10==13 &&
> [vdc.com.vn] == [192.168.212.9]
> 7(8982) grep_sock_info - checking if port 5060 matches port 5060
> 7(8982) grep_sock_info - checking if host==us: 10==9 && [vdc.com.vn]
> == [127.0.0.1]
> 7(8982) grep_sock_info - checking if port 5060 matches port 5060
> 7(8982) grep_sock_info - checking if host==us: 10==13 &&
> [vdc.com.vn] == [192.168.212.9]
> 7(8982) grep_sock_info - checking if port 5060 matches port 5060
> 7(8982) grep_sock_info - checking if host==us: 10==9 && [vdc.com.vn]
> == [127.0.0.1]
> 7(8982) grep_sock_info - checking if port 5060 matches port 5060
> 7(8982) grep_sock_info - checking if host==us: 10==13 &&
> [vdc.com.vn] == [192.168.212.9]
> 7(8982) grep_sock_info - checking if port 5060 matches port 5060
> 7(8982) grep_sock_info - checking if host==us: 10==9 && [vdc.com.vn]
> == [127.0.0.1]
> 7(8982) grep_sock_info - checking if port 5060 matches port 5060
> 7(8982) grep_sock_info - checking if host==us: 10==13 &&
> [vdc.com.vn] == [192.168.212.9]
> 7(8982) grep_sock_info - checking if port 5060 matches port 5060
> 7(8982) check_nonce(): comparing
> [442b360523cece6362803c97fa7fb10b37680cd8] and
> [442b360523cece6362803c97fa7fb10b37680cd8]
> 7(8982) ERROR:auth_radius:radius_authorize_sterman: rc_auth failed
> 7(8982) build_auth_hf(): 'WWW-Authenticate: Digest
> realm="vdc.com.vn", nonce="442b360523cece6362803c97fa7fb10b37680cd8"
> '
> 7(8982) parse_headers: flags=ffffffffffffffff
> 7(8982) check_via_address(192.168.212.123, 192.168.212.123, 0)
> 7(8982) DEBUG:destroy_avp_list: destroying list (nil)
> 7(8982) receive_msg: cleaning up
>
> Radius show debug:
>
> rad_recv: Access-Request packet from host 192.168.212.9:32826, id=205,
> length=203
> User-Name = "5001 at vdc.com.vn <mailto:5001 at vdc.com.vn>"
> Digest-Attributes = 0x0a0635303031
> Digest-Attributes = 0x010c7664632e636f6d2e766e
> Digest-Attributes =
> 0x022a34343262333630353233636563653633363238303363393766613766623130623337363830636438
> Digest-Attributes = 0x04107369703a7664632e636f6d2e766e
> Digest-Attributes = 0x030a5245474953544552
> Digest-Response = "1c3d532fc6c1c37004c6df6027e6242c"
> Service-Type = 0x0000000f00000000
> Sip-Uri-User = "5001"
> NAS-Port = 0x000013c400000000
> NAS-IP-Address = 0xc0a8d40900000000
> Processing the authorize section of radiusd.conf
> modcall: entering group authorize for request 0
> Invalid operator for item Suffix: reverting to '=='
> Invalid operator for item Suffix: reverting to '=='
> Invalid operator for item Suffix: reverting to '=='
> Invalid operator for item Suffix: reverting to '=='
> Invalid operator for item Suffix: reverting to '=='
> Invalid operator for item Suffix: reverting to '=='
> Invalid operator for item Suffix: reverting to '=='
> Invalid operator for item Suffix: reverting to '=='
> hints: Matched DEFAULT at 82
> modcall[authorize]: module "preprocess" returns ok for request 0
> modcall[authorize]: module "chap" returns noop for request 0
> modcall[authorize]: module "mschap" returns noop for request 0
> rlm_digest: Converting Digest-Attributes to something sane...
> Digest-User-Name = "5001"
> Digest-Realm = "vdc.com.vn"
> Digest-Nonce = "442b360523cece6362803c97fa7fb10b37680cd8"
> Digest-URI = "sip:vdc.com.vn"
> Digest-Method = "REGISTER"
> rlm_digest: Adding Auth-Type = DIGEST
> modcall[authorize]: module "digest" returns ok for request 0
> rlm_realm: No '@' <mailto:%27@%27> in User-Name = "5001", looking
> up realm NULL
> rlm_realm: No such realm "NULL"
> modcall[authorize]: module "suffix" returns noop for request 0
> radius_xlat: '5001'
> rlm_sql (sql): sql_set_user escaped user --> '5001'
> radius_xlat: 'SELECT 1 as id,'5001' as UserName,'User-Password' as
> Attribute,subscriber_password as Value,'==' as op FROM subscribers
> WHERE subscriber_username = '5001'AND subscriber_status=1'
> rlm_sql (sql): Reserving sql socket id: 4
> radius_xlat: ''
> radius_xlat: 'SELECT 1 as id,'5001' as UserName,'Session-Timeout' as
> Attribute,getSessionTime('5001','')as Value,'=' as op FROM dual'
> radius_xlat: ''
> rlm_sql (sql): Released sql socket id: 4
> modcall[authorize]: module "sql" returns ok for request 0
> modcall: group authorize returns ok for request 0
> rad_check_password: Found Auth-Type DIGEST
> auth: type "digest"
> Processing the authenticate section of radiusd.conf
> modcall: entering group authenticate for request 0
> A1 = 5001:vdc.com.vn:test
> A2 = REGISTER:sip:vdc.com.vn
> H(A1) = 454e15015603bd4bd79faf0c5ddd3346
> H(A2) = ac5bd79ed3d6bd2bddcb1cffafbbd09a
> KD =
> 454e15015603bd4bd79faf0c5ddd3346:442b360523cece6362803c97fa7fb10b37680cd8:ac5bd79ed3d6bd2bddcb1cffafbbd09a
> EXPECTED 1c3d532fc6c1c37004c6df6027e6242c
> RECEIVED 1c3d532fc6c1c37004c6df6027e6242c
> modcall[authenticate]: module "digest" returns ok for request 0
> modcall: group authenticate returns ok for request 0
> Login OK: [5001] (from client 192.168.212.9 port 3134307025)
> Sending Access-Accept of id 205 to 192.168.212.9:32826
> Session-Timeout = 60
> Finished request 0
> Going to the next request
> --- Walking the entire request list ---
> Waking up in 6 seconds...
> --- Walking the entire request list ---
> Cleaning up request 0 ID 205 with timestamp 442b3adf
> Nothing to do. Sleeping until we see a request.
>
> Best regards,
> Nguyen
> ------------------------------------------------------------------------
>
> _______________________________________________
> Users mailing list
> Users at openser.org
> http://openser.org/cgi-bin/mailman/listinfo/users
>
More information about the Users
mailing list