[SR-Users] Registration Authentication Error

Nathaniel L Keeling III forums at akan.net
Thu Sep 27 23:36:36 CEST 2012


Sorry, I thought I had saved it in plain text format. I have included 
the right file.

Thanks

Nathaniel

On 9/27/12 10:12 AM, Daniel-Constantin Mierla wrote:
> Can you sent the attachment in text format so it can be read from any 
> device? It should be just text content anyhow.
>
> Cheers,
> Daniel
>
> On 9/27/12 4:26 AM, Nathaniel L Keeling III wrote:
>> I am using the Jitsi sip client and tried the X-Lite sip client. I am 
>> not able to authenticate with either. I am including a text with the 
>> sip messages and some of kamailio logs.
>>
>> Thanks
>>
>> Nathaniel
>>
>> On 9/24/12 3:21 AM, Daniel-Constantin Mierla wrote:
>>> Hello,
>>>
>>> all seems ok from the logs, have you checked the realm in the 
>>> authorization header, is it the right one? Maybe you can just paste 
>>> the trace for a registration that fails.
>>>
>>> I can think of anything else that could go wrong, this part of the 
>>> code is used a lot. I assume it is a well known user agent/phone 
>>> that can't have a broken implementation.
>>>
>>> Cheers,
>>> Daniel
>>>
>>>
>>> On 9/21/12 10:43 PM, Nathaniel L Keeling III wrote:
>>>> here is the output from the log file of the test user:
>>>>
>>>> 2(2744) DEBUG: db_postgres [km_dbase.c:224]: sending query ok: 
>>>> 10046f6d0 (7) - [select password from subscriber where 
>>>> username='test' AND domain='akanvoice.com']
>>>>  2(2744) DEBUG: <core> [db_res.c:118]: allocate 48 bytes for result 
>>>> set at 10049a018
>>>>  2(2744) DEBUG: db_postgres [km_dbase.c:521]: 10046f6d0 
>>>> PQresultStatus(PGRES_TUPLES_OK) PQgetResult(1008b7e50)
>>>>  2(2744) DEBUG: db_postgres [km_res.c:108]: 1 columns returned from 
>>>> the query
>>>>  2(2744) DEBUG: <core> [db_res.c:155]: allocate 8 bytes for result 
>>>> names at 100499f28
>>>>  2(2744) DEBUG: <core> [db_res.c:165]: allocate 4 bytes for result 
>>>> types at 100499f40
>>>>  2(2744) DEBUG: db_postgres [km_res.c:126]: allocate 16 bytes for 
>>>> RES_NAMES[0] at 100499f58
>>>>  2(2744) DEBUG: db_postgres [km_res.c:133]: 
>>>> RES_NAMES(100499f58)[0]=[password]
>>>>  2(2744) DEBUG: db_postgres [km_res.c:166]: use DB1_STRING result type
>>>>  2(2744) DEBUG: db_postgres [km_res.c:222]: allocate for 1 columns 
>>>> 8 bytes in row buffer at 100499f78
>>>>  2(2744) DEBUG: <core> [db_res.c:184]: allocate 16 bytes for rows 
>>>> at 100499f90
>>>>  2(2744) DEBUG: db_postgres [km_res.c:243]: 
>>>> PQgetvalue(10046f6d0,0,0)=[test1234]
>>>>  2(2744) DEBUG: db_postgres [km_res.c:252]: [0][0] 
>>>> Column[password]=[test1234]
>>>>  2(2744) DEBUG: <core> [db_row.c:119]: allocate 32 bytes for row 
>>>> values at 100499fb0
>>>>  2(2744) DEBUG: <core> [db_val.c:117]: converting STRING [test1234]
>>>>  2(2744) DEBUG: <core> [db_val.c:127]: allocate 9 bytes memory for 
>>>> STRING at 100499fe0 2(2744) DEBUG: db_postgres [km_res.c:267]: 
>>>> freeing row buffer at 100499f78
>>>>  2(2744) DEBUG: db_postgres [km_dbase.c:393]: PQclear(1008b7e50) 
>>>> result set
>>>>  2(2744) DEBUG: auth [api.c:211]: check_response: Our result = 
>>>> '1793af7ca4c2a2feb31410fb6c113695'
>>>>  2(2744) DEBUG: auth [api.c:221]: check_response: Authorization failed
>>>>  2(2744) DEBUG: <core> [db_res.c:81]: freeing 1 columns
>>>>  2(2744) DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[0] at 
>>>> 100499f58
>>>>  2(2744) DEBUG: <core> [db_res.c:94]: freeing result names at 
>>>> 100499f28
>>>>  2(2744) DEBUG: <core> [db_res.c:99]: freeing result types at 
>>>> 100499f40
>>>>  2(2744) DEBUG: <core> [db_res.c:54]: freeing 1 rows
>>>>  2(2744) DEBUG: <core> [db_row.c:68]: free VAL_STRING[0] 'test1234' 
>>>> at 100499fe0
>>>>  2(2744) DEBUG: <core> [db_row.c:97]: freeing row values at 100499fb0
>>>>  2(2744) DEBUG: <core> [db_res.c:62]: freeing rows at 100499f90
>>>>  2(2744) DEBUG: <core> [db_res.c:136]: freeing result set at 10049a018
>>>>  2(2744) ERROR: *** cfgtrace: 
>>>> c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=730 a=27 
>>>> n=auth_challenge
>>>>  2(2744) DEBUG: auth [challenge.c:128]: build_challenge_hf: 
>>>> realm='akanvoice.com'
>>>>  2(2744) DEBUG: auth [challenge.c:270]: auth: 'WWW-Authenticate: 
>>>> Digest realm="akanvoice.com", nonce="UFzRV1Bc0CunOjSLvAkebJwYzCBSBRYH"
>>>>
>>>> Thanks
>>>>
>>>> Nathaniel
>>>> On 9/21/12 8:15 AM, Daniel-Constantin Mierla wrote:
>>>>> Hello,
>>>>>
>>>>> On 9/21/12 2:43 PM, Nathaniel L Keeling III wrote:
>>>>>> Yes, the password column of the subscriber's table contains the 
>>>>>> plain text password. Should the calculated HA1 string match the 
>>>>>> HA1 value in the database?
>>>>> no, if clear text password is used, the ha1 column is not 
>>>>> important at all.
>>>>>
>>>>> If you work with default config, it's really strange, I tested and 
>>>>> all goes fine. Can you add a temporary account with a simple 
>>>>> username/password to be sure no typo can happen and test again?
>>>>>
>>>>> Cheers,
>>>>> Daniel
>>>>> [...]
>>>>
>>>
>>
>

-------------- next part --------------
# ngrep -W byline port 5070
interface: eri0 (209.252.110.0/255.255.255.192)
filter: (ip) and ( port 5070 )
 1(15537) DEBUG: <core> [parser/msg_parser.c:623]: SIP Request:
 1(15537) DEBUG: <core> [parser/msg_parser.c:625]:  method:  <REGISTER>
 1(15537) DEBUG: <core> [parser/msg_parser.c:627]:  uri:     <sip:akanvoice.com>
 1(15537) DEBUG: <core> [parser/msg_parser.c:629]:  version: <SIP/2.0>
 1(15537) DEBUG: <core> [parser/parse_via.c:1284]: Found param type 232, <branch> = <z9hG4bK-d8754z-f62ab06b2e8aa77d-1---d8754z->; state=6
 1(15537) DEBUG: <core> [parser/parse_via.c:1284]: Found param type 235, <rport> = <n/a>; state=17
 1(15537) DEBUG: <core> [parser/parse_via.c:2672]: end of header reached, state=5
 1(15537) DEBUG: <core> [parser/msg_parser.c:513]: parse_headers: Via found, flags=2
 1(15537) DEBUG: <core> [parser/msg_parser.c:515]: parse_headers: this is the first via
 1(15537) DEBUG: <core> [receive.c:149]: After parse_msg...
 1(15537) DEBUG: <core> [receive.c:190]: preparing to run routing scripts...
 1(15537) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=468 a=6 n=route
 1(15537) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=572 a=17 n=if
 1(15537) DEBUG: <core> [socket_info.c:589]: grep_sock_info - checking if host==us: 13==14 && [75.182.52.170] == [209.252.110.38]
 1(15537) DEBUG: <core> [socket_info.c:589]: grep_sock_info - checking if host==us: 13==14 && [75.182.52.170] == [209.252.110.38]
 1(15537) DEBUG: <core> [forward.c:462]: check_self: host != me
 1(15537) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=563 a=17 n=if
 1(15537) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=569 a=17 n=if
 1(15537) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=563 a=25 n=pike_check_req
 1(15537) DEBUG: pike [ip_tree.c:279]: search on branch 75 (top=0)
 1(15537) DEBUG: pike [ip_tree.c:292]: only first 0 were matched!
 1(15537) DEBUG: pike [pike_funcs.c:97]: src IP [75.182.52.170],node=ffffffff76a72768; hits=[0,1],[0,0] node_flags=0 func_flags=1
 1(15537) DEBUG: pike [timer.c:39]: ffffffff76a72778 in ffffffff76a66918(ffffffff76a66918,ffffffff76a66918)
 1(15537) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=577 a=17 n=if
 1(15537) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=572 a=26 n=mf_process_maxfwd_header
 1(15537) DEBUG: maxfwd [mf_funcs.c:85]: value = 70 
 1(15537) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=582 a=17 n=if
 1(15537) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=577 a=27 n=sanity_check
 1(15537) DEBUG: <core> [parser/parse_to.c:799]: end of header reached, state=10
 1(15537) DEBUG: <core> [parser/msg_parser.c:190]: DEBUG: get_hdr_field: <To> [42]; uri=[sip:test at akanvoice.com] 
 1(15537) DEBUG: <core> [parser/msg_parser.c:192]: DEBUG: to body ["Test Account 1"<sip:test at akanvoice.com>
]
 1(15537) DEBUG: <core> [parser/msg_parser.c:170]: get_hdr_field: cseq <CSeq>: <1> <REGISTER>
 1(15537) DEBUG: <core> [parser/msg_parser.c:204]: DEBUG: get_hdr_body : content_length=0
 1(15537) DEBUG: <core> [parser/msg_parser.c:106]: found end of header
 1(15537) DEBUG: <core> [parser/parse_to.c:176]: DEBUG: add_param: tag=e9731d71
 1(15537) DEBUG: <core> [parser/parse_to.c:799]: end of header reached, state=29
 1(15537) DEBUG: sanity [mod_sanity.c:255]: sanity checks result: 1
 1(15537) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=471 a=6 n=route
 1(15537) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=752 a=57 n=force_rport
 1(15537) #
U 75.182.52.170:5060 -> 209.252.110.38:5070
REGISTER sip:akanvoice.com SIP/2.0.
Via: SIP/2.0/UDP 192.168.1.187:5060;branch=z9hG4bK-d8754z-f62ab06b2e8aa77d-1---d8754z-;rport.
Max-Forwards: 70.
Contact: <sip:test at 192.168.1.187:5060;rinstance=e3ca189fbfcbe3ea>.
To: "Test Account 1"<sip:test at akanvoice.com>.
From: "Test Account 1"<sip:test at akanvoice.com>;tag=e9731d71.
Call-ID: ZTJjYjkxOTI0NzVjMzg3NGIzNWE1Y2E5OGI4OTA5Yzk..
CSeq: 1 REGISTER.
Expires: 3600.
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO.
User-Agent: X-Lite release 5.0.0 stamp 67285.
Content-Length: 0.
.

ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=762 a=17 n=if
 1(15537) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=753 a=26 n=nat_uac_test
 1(15537) DEBUG: <core> [msg_translator.c:206]: check_via_address(75.182.52.170, 192.168.1.187, 0)
 1(15537) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=758 a=17 n=if
 1(15537) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=754 a=26 n=is_method
 1(15537) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=755 a=25 n=fix_nated_register
 1(15537) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=759 a=40 n=setflag
 1(15537) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=762 a=3 n=return
 1(15537) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=474 a=6 n=route
 1(15537) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=621 a=17 n=if
 1(15537) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=586 a=25 n=has_totag
 1(15537) DEBUG: siputils [checks.c:103]: no totag
 1(15537) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=486 a=17 n=if
 1(15537) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=479 a=26 n=is_method
 1(15537) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=486 a=25 n=t_check_trans
 1(15537) DEBUG: tm [t_lookup.c:1079]: DEBUG: t_check_msg: msg id=6 global id=5 T start=0
 1(15537) DEBUG: tm [t_lookup.c:527]: t_lookup_request: start searching: hash=37246, isACK=0
 1(15537) DEBUG: tm [t_lookup.c:485]: DEBUG: RFC3261 transaction matching failed
 1(15537) DEBUG: tm [t_lookup.c:709]: DEBUG: t_lookup_request: no transaction found
 1(15537) DEBUG: tm [t_lookup.c:1148]: DEBUG: t_check_msg: msg id=6 global id=6 T end=0
 1(15537) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=489 a=6 n=route
 1(15537) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=739 a=17 n=if
 1(15537) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=726 a=26 n=is_method
 1(15537) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=734 a=17 n=if
 1(15537) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=729 a=28 n=auth_check
 1(15537) DEBUG: auth_db [authorize.c:363]: realm [akanvoice.com] table [subscriber] flags [0]
 1(15537) DEBUG: auth [api.c:86]: auth:pre_auth: Credentials with realm 'akanvoice.com' not found
 1(15537) DEBUG: auth_db [authorize.c:180]: no credentials
 1(15537) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=730 a=27 n=auth_challenge
 1(15537) DEBUG: auth [challenge.c:128]: build_challenge_hf: realm='akanvoice.com'
 1(15537) DEBUG: auth [challenge.c:270]: auth: 'WWW-Authenticate: Digest realm="akanvoice.com", nonce="UGKZKFBil/y9yLc/fzPBmRvK6DebPBSE"
'
 1(15537) DEBUG: sl [sl.c:278]: reply in stateless mode (sl)
 1(15537) DEBUG: <core> [msg_translator.c:206]: check_via_address(75.182.52.170, 192.168.1.187, 0)
 1(15537) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=731 a=3 n=exit
 1(15537) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list ffffffff76a727b0
 1(15537) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list 0
 1(15537) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list 0
 1(15537) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list 0
 1(15537) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list 0
 1(15537) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list 0
 1(15537) DEBUG: <core> [xavp.c:365]: destroying xavp list 0
 1(15537) DEBUG: <core> [receive.c:293]: receive_msg: cleaning up
#
U 209.252.110.38:5070 -> 75.182.52.170:5060
SIP/2.0 401 Unauthorized.
Via: SIP/2.0/UDP 192.168.1.187:5060;branch=z9hG4bK-d8754z-f62ab06b2e8aa77d-1---d8754z-;rport=5060;received=75.182.52.170.
To: "Test Account 1"<sip:test at akanvoice.com>;tag=7ca97cfc550b7542df6bf3248071d5b9.7be1.
From: "Test Account 1"<sip:test at akanvoice.com>;tag=e9731d71.
Call-ID: ZTJjYjkxOTI0NzVjMzg3NGIzNWE1Y2E5OGI4OTA5Yzk..
CSeq: 1 REGISTER.
WWW-Authenticate: Digest realm="akanvoice.com", nonce="UGKZKFBil/y9yLc/fzPBmRvK6DebPBSE".
Server: kamailio (3.4.0-dev3 (sparc64/solaris)).
Content-Length: 0.
.

 4(15540) DEBUG: <core> [parser/msg_parser.c:623]: SIP Request:
 4(15540) DEBUG: <core> [parser/msg_parser.c:625]:  method:  <REGISTER>
 4(15540) DEBUG: <core> [parser/msg_parser.c:627]:  uri:     <sip:akanvoice.com>
 4(15540) DEBUG: <core> [parser/msg_parser.c:629]:  version: <SIP/2.0>
 4(15540) DEBUG: <core> [parser/parse_via.c:1284]: Found param type 232, <branch> = <z9hG4bK-d8754z-f62ab06b2e8aa77d-1---d8754z->; state=6
 4(15540) DEBUG: <core> [parser/parse_via.c:1284]: Found param type 235, <rport> = <n/a>; state=17
 4(15540) DEBUG: <core> [parser/parse_via.c:2672]: end of header reached, state=5
 4(15540) DEBUG: <core> [parser/msg_parser.c:513]: parse_headers: Via found, flags=2
 4(15540) DEBUG: <core> [parser/msg_parser.c:515]: parse_headers: this is the first via
 4(15540) DEBUG: <core> [receive.c:149]: After parse_msg...
 4(15540) DEBUG: <core> [receive.c:190]: preparing to run routing scripts...
 4(15540) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=468 a=6 n=route
 4(15540) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=572 a=17 n=if
 4(15540) DEBUG: <core> [socket_info.c:589]: grep_sock_info - checking if host==us: 13==14 && [75.182.52.170] == [209.252.110.38]
 4(15540) DEBUG: <core> [socket_info.c:589]: grep_sock_info - checking if host==us: 13==14 && [75.182.52.170] == [209.252.110.38]
 4(15540) DEBUG: <core> [forward.c:462]: check_self: host != me
 4(15540) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=563 a=17 n=if
 4(15540) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=569 a=17 n=if
 4(15540) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=563 a=25 n=pike_check_req
 4(15540) DEBUG: pike [ip_tree.c:279]: search on branch 75 (top=ffffffff76a72768)
 4(15540) DEBUG: pike [ip_tree.c:292]: only first 1 were matched!
 4(15540) DEBUG: pike [pike_funcs.c:97]: src IP [75.182.52.170],node=ffffffff76a72768; hits=[0,2],[0,0] node_flags=2 func_flags=8
 4(15540) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=577 a=17 n=if
 4(15540) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=572 a=26 n=mf_process_maxfwd_header
 4(15540) DEBUG: maxfwd [mf_funcs.c:85]: value = 70 
 4(15540) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=582 a=17 n=if
 4(15540) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=577 a=27 n=sanity_check
 4(15540) DEBUG: <core> [parser/parse_to.c:799]: end of header reached, state=10
 4(15540) DEBUG: <core> [parser/msg_parser.c:190]: DEBUG: get_hdr_field: <To> [42]; uri=[sip:test at akanvoice.com] 
 4(15540) DEBUG: <core> [parser/msg_parser.c:192]: DEBUG: to body ["Test Account 1"<sip:test at akanvoice.com>
]
 4(15540) DEBUG: <core> [parser/msg_parser.c:170]: get_hdr_field: cseq <CSeq>: <1> <REGISTER>
 4(15540) DEBUG: <core> [parser/msg_parser.c:204]: DEBUG: get_hdr_body : content_length=0
 4(15540) DEBUG: <core> [parser/msg_parser.c:106]: found end of header
 4(15540) DEBUG: <core> [parser/parse_to.c:176]: DEBUG: add_param: tag=e9731d71
 4(15540) DEBUG: <core> [parser/parse_to.c:799]: end of header reached, state=29
 4(15540) DEBUG: sanity [mod_sanity.c:255]: sanity checks result: 1
 4(15540) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=471 a=6 n=route
 4(15540) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=752 a=57 n=force_rport
 4(15540) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=762 a=17 n=if
 4(15540) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=753 a=26 n=nat_uac_test
 4(15540) DEBUG: <core> [msg_translator.c:206]: check_via_address(75.182.52.170, 192.168.1.187, 0)
 4(15540) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=758 a=17 n=if
 4(15540) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=754 a=26 n=is_method
 4(15540) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=755 a=25 n=fix_nated_register
 4(15540) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=759 a=40 n=setflag
 4(15540) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=762 a=3 n=return
 4(15540) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=474 a=6 n=route
 4(15540) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=621 a=17 n=if
 4(15540) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=586 a=25 n=has_totag
 4(15540) DEBUG: siputils [checks.c:103]: no totag
 4(15540) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=486 a=17 n=if
 4(15540) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=479 a=26 n=is_method
 4(15540) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=486 a=25 n=t_check_trans
 4(15540) DEBUG: tm [t_lookup.c:1079]: DEBUG: t_check_msg: msg id=6 global id=5 T start=0
 4(15540) DEBUG: tm [t_lookup.c:527]: t_lookup_request: start searching: hash=37246, isACK=0
 4(15540) DEBUG: tm [t_lookup.c:485]: DEBUG: RFC3261 transaction matching failed
 4(15540) DEBUG: tm [t_lookup.c:709]: DEBUG: t_lookup_request: no transaction found
 4(15540) DEBUG: tm [t_lookup.c:1148]: DEBUG: t_check_msg: msg id=6 global id=6 T end=0
 4(15540) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=489 a=6 n=route
 4(15540) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=739 a=17 n=if
 4(15540) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=726 a=26 n=is_method
 4(15540) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=734 a=17 n=if
 4(15540) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=729 a=28 n=auth_check
 4(15540) DEBUG: auth_db [authorize.c:363]: realm [akanvoice.com] table [subscriber] flags [0]
 4(15540) DEBUG: auth [api.c:86]: auth:pre_auth: Credentials with realm 'akanvoice.com' not found
 4(15540) DEBUG: auth_db [authorize.c:180]: no credentials
 4(15540) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=730 a=27 n=auth_challenge
 4(15540) DEBUG: auth [challenge.c:128]: build_challenge_hf: realm='akanvoice.com'
 4(15540) DEBUG: auth [challenge.c:270]: auth: 'WWW-Authenticate: Digest realm="akanvoice.com", nonce="UGKZKFBil/y9yLc/fzPBmRvK6DebPBSE"
'
 4(15540) DEBUG: sl [sl.c:278]: reply in stateless mode (sl)
 4(15540) DEBUG: <core> [msg_translator.c:206]: check_via_address(75.182.52.170, 192.168.1.187, 0)
 4(15540) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=731 a=3 n=exit
 4(15540) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list ffffffff76a727b0
 4(15540) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list 0
 4(15540) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list 0
 4(15540) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list 0
 4(15540) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list 0
 4(15540) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list 0
 4(15540) DEBUG: <core> [xavp.c:365]: destroying xavp list 0
 4(15540) DEBUG: <core> [receive.c:293]: receive_msg: cleaning up
#
U 75.182.52.170:5060 -> 209.252.110.38:5070
REGISTER sip:akanvoice.com SIP/2.0.
Via: SIP/2.0/UDP 192.168.1.187:5060;branch=z9hG4bK-d8754z-f62ab06b2e8aa77d-1---d8754z-;rport.
Max-Forwards: 70.
Contact: <sip:test at 192.168.1.187:5060;rinstance=e3ca189fbfcbe3ea>.
To: "Test Account 1"<sip:test at akanvoice.com>.
From: "Test Account 1"<sip:test at akanvoice.com>;tag=e9731d71.
Call-ID: ZTJjYjkxOTI0NzVjMzg3NGIzNWE1Y2E5OGI4OTA5Yzk..
CSeq: 1 REGISTER.
Expires: 3600.
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO.
User-Agent: X-Lite release 5.0.0 stamp 67285.
Content-Length: 0.
.

#
U 209.252.110.38:5070 -> 75.182.52.170:5060
SIP/2.0 401 Unauthorized.
Via: SIP/2.0/UDP 192.168.1.187:5060;branch=z9hG4bK-d8754z-f62ab06b2e8aa77d-1---d8754z-;rport=5060;received=75.182.52.170.
To: "Test Account 1"<sip:test at akanvoice.com>;tag=7ca97cfc550b7542df6bf3248071d5b9.7be1.
From: "Test Account 1"<sip:test at akanvoice.com>;tag=e9731d71.
Call-ID: ZTJjYjkxOTI0NzVjMzg3NGIzNWE1Y2E5OGI4OTA5Yzk..
CSeq: 1 REGISTER.
WWW-Authenticate: Digest realm="akanvoice.com", nonce="UGKZKFBil/y9yLc/fzPBmRvK6DebPBSE".
Server: kamailio (3.4.0-dev3 (sparc64/solaris)).
Content-Length: 0.
.

 2(15538) DEBUG: <core> [parser/msg_parser.c:623]: SIP Request:
 2(15538) DEBUG: <core> [parser/msg_parser.c:625]:  method:  <REGISTER>
 2(15538) DEBUG: <core> [parser/msg_parser.c:627]:  uri:     <sip:akanvoice.com>
 2(15538) DEBUG: <core> [parser/msg_parser.c:629]:  version: <SIP/2.0>
 2(15538) DEBUG: <core> [parser/parse_via.c:1284]: Found param type 232, <branch> = <z9hG4bK-d8754z-f62ab06b2e8aa77d-1---d8754z->; state=6
 2(15538) DEBUG: <core> [parser/parse_via.c:1284]: Found param type 235, <rport> = <n/a>; state=17
 2(15538) DEBUG: <core> [parser/parse_via.c:2672]: end of header reached, state=5
 2(15538) DEBUG: <core> [parser/msg_parser.c:513]: parse_headers: Via found, flags=2
 2(15538) DEBUG: <core> [parser/msg_parser.c:515]: parse_headers: this is the first via
 2(15538) DEBUG: <core> [receive.c:149]: After parse_msg...
 2(15538) DEBUG: <core> [receive.c:190]: preparing to run routing scripts...
 2(15538) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=468 a=6 n=route
 2(15538) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=572 a=17 n=if
 2(15538) DEBUG: <core> [socket_info.c:589]: grep_sock_info - checking if host==us: 13==14 && [75.182.52.170] == [209.252.110.38]
 2(15538) DEBUG: <core> [socket_info.c:589]: grep_sock_info - checking if host==us: 13==14 && [75.182.52.170] == [209.252.110.38]
 2(15538) DEBUG: <core> [forward.c:462]: check_self: host != me
 2(15538) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=563 a=17 n=if
 2(15538) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=569 a=17 n=if
 2(15538) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=563 a=25 n=pike_check_req
 2(15538) DEBUG: pike [ip_tree.c:279]: search on branch 75 (top=ffffffff76a72768)
 2(15538) DEBUG: pike [ip_tree.c:292]: only first 1 were matched!
 2(15538) DEBUG: pike [pike_funcs.c:97]: src IP [75.182.52.170],node=ffffffff76a72768; hits=[2,1],[0,0] node_flags=2 func_flags=8
 2(15538) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=577 a=17 n=if
 2(15538) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=572 a=26 n=mf_process_maxfwd_header
 2(15538) DEBUG: maxfwd [mf_funcs.c:85]: value = 70 
 2(15538) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=582 a=17 n=if
 2(15538) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=577 a=27 n=sanity_check
 2(15538) DEBUG: <core> [parser/parse_to.c:799]: end of header reached, state=10
 2(15538) DEBUG: <core> [parser/msg_parser.c:190]: DEBUG: get_hdr_field: <To> [42]; uri=[sip:test at akanvoice.com] 
 2(15538) DEBUG: <core> [parser/msg_parser.c:192]: DEBUG: to body ["Test Account 1"<sip:test at akanvoice.com>
]
 2(15538) DEBUG: <core> [parser/msg_parser.c:170]: get_hdr_field: cseq <CSeq>: <1> <REGISTER>
 2(15538) DEBUG: <core> [parser/msg_parser.c:204]: DEBUG: get_hdr_body : content_length=0
 2(15538) DEBUG: <core> [parser/msg_parser.c:106]: found end of header
 2(15538) DEBUG: <core> [parser/parse_to.c:176]: DEBUG: add_param: tag=e9731d71
 2(15538) DEBUG: <core> [parser/parse_to.c:799]: end of header reached, state=29
 2(15538) DEBUG: sanity [mod_sanity.c:255]: sanity checks result: 1
 2(15538) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=471 a=6 n=route
 2(15538) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=752 a=57 n=force_rport
 2(15538) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=762 a=17 n=if
 2(15538) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=753 a=26 n=nat_uac_test
 2(15538) DEBUG: <core> [msg_translator.c:206]: check_via_address(75.182.52.170, 192.168.1.187, 0)
 2(15538) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=758 a=17 n=if
 2(15538) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=754 a=26 n=is_method
 2(15538) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=755 a=25 n=fix_nated_register
 2(15538) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=759 a=40 n=setflag
 2(15538) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=762 a=3 n=return
 2(15538) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=474 a=6 n=route
 2(15538) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=621 a=17 n=if
 2(15538) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=586 a=25 n=has_totag
 2(15538) DEBUG: siputils [checks.c:103]: no totag
 2(15538) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=486 a=17 n=if
 2(15538) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=479 a=26 n=is_method
 2(15538) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=486 a=25 n=t_check_trans
 2(15538) DEBUG: tm [t_lookup.c:1079]: DEBUG: t_check_msg: msg id=6 global id=5 T start=0
 2(15538) DEBUG: tm [t_lookup.c:527]: t_lookup_request: start searching: hash=37246, isACK=0
 2(15538) DEBUG: tm [t_lookup.c:485]: DEBUG: RFC3261 transaction matching failed
 2(15538) DEBUG: tm [t_lookup.c:709]: DEBUG: t_lookup_request: no transaction found
 2(15538) DEBUG: tm [t_lookup.c:1148]: DEBUG: t_check_msg: msg id=6 global id=6 T end=0
 2(15538) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=489 a=6 n=route
 2(15538) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=739 a=17 n=if
 2(15538) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=726 a=26 n=is_method
 2(15538) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=734 a=17 n=if
 2(15538) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=729 a=28 n=auth_check
 2(15538) DEBUG: auth_db [authorize.c:363]: realm [akanvoice.com] table [subscriber] flags [0]
 2(15538) DEBUG: auth [api.c:86]: auth:pre_auth: Credentials with realm 'akanvoice.com' not found
 2(15538) DEBUG: auth_db [authorize.c:180]: no credentials
 2(15538) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=730 a=27 n=auth_challenge
 2(15538) DEBUG: auth [challenge.c:128]: build_challenge_hf: realm='akanvoice.com'
 2(15538) DEBUG: auth [challenge.c:270]: auth: 'WWW-Authenticate: Digest realm="akanvoice.com", nonce="UGKZKVBil/14M3ZU7os/5Qy9QwOCGWe4"
'
 2(15538) DEBUG: sl [sl.c:278]: reply in stateless mode (sl)
 2(15538) DEBUG: <core> [msg_translator.c:206]: check_via_address(75.182.52.170, 192.168.1.187, 0)
 2(15538) ERROR: *** cfgtrace: c=[/opt/kamailio-3.3/etc/kamailio/kamailio.cfg] l=731 a=3 n=exit
 2(15538) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list ffffffff76a727b0
 2(15538) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list 0
 2(15538) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list 0
 2(15538) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list 0
 2(15538) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list 0
 2(15538) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list 0
 2(15538) DEBUG: <core> [xavp.c:365]: destroying xavp list 0
 2(15538) DEBUG: <core> [receive.c:293]: receive_msg: cleaning up


More information about the sr-users mailing list