[OpenSIPS-Users] Authentication problem
vishu gaddi
vishugaddi at gmail.com
Mon Sep 6 11:14:56 CEST 2010
Here is my code from opensips.cfg:
*
*
* if (!(method=="REGISTER") && is_from_local()) /*multidomain version*/*
* {*
* if(!check_source_address("0")){*
* if (!proxy_authorize("", "subscriber")) {*
* proxy_challenge("", "0");*
* exit;*
* }*
* if (!db_check_from()) {*
* sl_send_reply("403","Forbidden auth ID");*
* exit;*
* }*
*
*
* consume_credentials();*
* # caller authenticated*
* }*
* }*
*
*
and here is debug level 5. call is made from IP 216.214.25.18 to Opensips
server(IP 215.63.71.144). call is accepted by opensips even caller
ip 216.214.25.18 is not inserted in address table, in fact my address table
is empty this time.
*DEBUG:*
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:parse_msg: SIP
Request:
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:parse_msg: method:
<INVITE>
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:parse_msg: uri:
<sip:01112127773456 at 215.63.71.144 <sip%3A01112127773456 at 215.63.71.144>>
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:parse_msg:
version: <SIP/2.0>
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:parse_headers:
flags=2
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:get_hdr_field: cseq
<CSeq>: <1> <INVITE>
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:parse_via_param:
found param type 232, <branch> = <z9hG4bK06095510092506637788216>; state=16
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:parse_via: end of
header reached, state=5
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:parse_headers: via
found, flags=2
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:parse_headers: this
is the first via
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:receive_msg: After
parse_msg...
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:receive_msg:
preparing to run routing scripts...
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:parse_headers:
flags=100
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:parse_to: end of
header reached, state=10
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:parse_to:
display={}, ruri={sip:01112127773456 at 215.63.71.144<sip%3A01112127773456 at 215.63.71.144>
}
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:get_hdr_field: <To>
[36]; uri=[sip:01112127773456 at 215.63.71.144<sip%3A01112127773456 at 215.63.71.144>
]
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:get_hdr_field: to
body [<sip:01112127773456 at 215.63.71.144 <sip%3A01112127773456 at 215.63.71.144>
>#015#012]
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:get_hdr_field:
content_length=236
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:get_hdr_field:
found end of header
Sep 6 04:55:22 opensips /sbin/opensips[22154]:
DBG:maxfwd:is_maxfwd_present: max_forwards header not found!
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:uri:has_totag: no totag
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:parse_headers:
flags=78
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:tm:t_lookup_request:
start searching: hash=15721, isACK=0
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:tm:matching_3261:
RFC3261 transaction matching failed
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:tm:t_lookup_request: no
transaction found
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:parse_to_param:
tag=060955100925637788216
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:parse_to: end of
header reached, state=29
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:parse_to:
display={"121212121212"}, ruri={sip:121212121212 at 216.214.25.18:5060}
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:grep_sock_info:
checking if host==us: 13==9 && [216.214.25.18] == [127.0.0.1]
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:grep_sock_info:
checking if port 5060 matches port 5060
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:grep_sock_info:
checking if host==us: 13==13 && [216.214.25.18] == [215.63.71.144]
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:grep_sock_info:
checking if port 5060 matches port 5060
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:grep_sock_info:
checking if host==us: 13==9 && [216.214.25.18] == [127.0.0.1]
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:grep_sock_info:
checking if port 5060 matches port 5060
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:grep_sock_info:
checking if host==us: 13==13 && [216.214.25.18] == [215.63.71.144]
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:grep_sock_info:
checking if port 5060 matches port 5060
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:check_self: host !=
me
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:parse_headers:
flags=200
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:rr:find_first_route: No
Route headers found
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:rr:loose_route: There is
no Route HF
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:grep_sock_info:
checking if host==us: 13==9 && [215.63.71.144] == [127.0.0.1]
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:grep_sock_info:
checking if port 5060 matches port 5060
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:grep_sock_info:
checking if host==us: 13==13 && [215.63.71.144] == [215.63.71.144]
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:grep_sock_info:
checking if port 5060 matches port 5060
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:parse_headers:
flags=ffffffffffffffff
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:db_new_result:
allocate 28 bytes for result set at 0x81acba0
Sep 6 04:55:22 opensips /sbin/opensips[22154]:
DBG:db_mysql:db_mysql_get_columns: 2 columns returned from the query
Sep 6 04:55:22 opensips /sbin/opensips[22154]:
DBG:core:db_allocate_columns: allocate 32 bytes for result columns at
0x81acbc8
Sep 6 04:55:22 opensips /sbin/opensips[22154]:
DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x81acbd0)[0]=[username]
Sep 6 04:55:22 opensips /sbin/opensips[22154]:
DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type
Sep 6 04:55:22 opensips /sbin/opensips[22154]:
DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x81acbd8)[1]=[domain]
Sep 6 04:55:22 opensips /sbin/opensips[22154]:
DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type
Sep 6 04:55:22 opensips /sbin/opensips[22154]:
DBG:db_mysql:db_mysql_convert_rows: no rows returned from the query
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:alias_db:alias_db_query:
no alias found for R-URI
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:db_free_columns:
freeing result columns at 0x81acbc8
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:db_free_rows:
freeing 0 rows
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:db_free_result:
freeing result set at 0x81acba0
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:dialplan:dp_get_ivalue:
integer value
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:dialplan:dp_translate_f:
dpid is 0
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:dialplan:dp_get_svalue:
searching 15
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:dialplan:dp_translate_f:
input is 01112127773456
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:dialplan:translate:
regex operator testing
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:dialplan:test_match:
test string 01112127773456 against a pattern ^(011)[0-9].*
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:dialplan:test_match:
test_match:[0] 01112127773456
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:dialplan:test_match:
test_match:[1] 011
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:dialplan:translate:
found a matching rule 0xaf301ff0: pr 1, match_exp ^(011)[0-9].*
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:dialplan:translate: the
rule's attrs are pstn
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:dialplan:translate: the
copied attributes are: pstn
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:dialplan:test_match:
test string 01112127773456 against a pattern ^(011)([0-9].*)
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:dialplan:test_match:
test_match:[0] 01112127773456
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:dialplan:test_match:
test_match:[1] 011
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:dialplan:test_match:
test_match:[2] 12127773456
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:dialplan:dp_translate_f:
input 01112127773456 with dpid 0 => output 12127773456
Sep 6 04:55:22 opensips /sbin/opensips[22154]: pstn
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:comp_scriptvar: str
20 : pstn
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:core:comp_scriptvar: str
20 : pstn
Sep 6 04:55:22 opensips /sbin/opensips[22154]: DBG:drouting:do_routing:
using dr group 0
Please suggest.
Thanks,
Vishu
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.opensips.org/pipermail/users/attachments/20100906/27f48e52/attachment-0001.htm
More information about the Users
mailing list