Hello, I'm wondering why kamailio will try doing a DNS lookup of the from host with a REGISTER packet when using TCP? It doesn't do this with UDP. I always get this error since the host is not a valid domain:
<core> [resolve.c:1726]: sip_hostport2su(): could not resolve hostname: "3.local"
Here is the full log with debug (error is last line)
Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [mem/shm_mem.c:111]: _shm_resize(): WARNING:vqm_resize: resize(0) called Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [tcp_main.c:2294]: tcpconn_send_put(): tcp_send: found fd in cache ( 10, 0x7f860bd18938, 1) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [tcp_main.c:2516]: tcpconn_do_send(): tcp_send: sending... Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [tcp_main.c:2550]: tcpconn_do_send(): tcp_send: after real write: c= 0x7f860bd18938 n=639 fd=10 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [tcp_main.c:2551]: tcpconn_do_send(): tcp_send: buf=#012SIP/2.0 401 Unauthorized#015#012Via: SIP/2.0/TCP 192.168.16.120:53972;received=192.168.213.162;rport=53972;branch=z9hG4bKPjac894585917043d28da015d397178725;alias#015#012From: "1003" sip:1003@3.local;tag=dbc7a9087cb84006b65d891e5ad1f5ea#015#012To: "1003" sip:1003@3.local;tag=ey7D0K9DX49DF#015#012Call-ID: ee72194a1b8e4effa2948e237d804b90#015#012CSeq: 1 REGISTER#015#012User-Agent: AMPSwitch#015#012Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE#015#012Supported: timer, path, replaces#015#012WWW-Authenticate: Digest realm="3.local", nonce="cdf32dde-ab14-4265-b491-bee703e83255", algorithm=MD5, qop="auth"#015#012Content-Length: 0#015#012#015#012 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: tm [t_reply.c:1663]: cleanup_uac_timers(): DEBUG: cleanup_uac_timers: RETR/FR timers reset Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [xavp.c:448]: xavp_destroy_list(): destroying xavp list (nil) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [receive.c:298]: receive_msg(): receive_msg: cleaning up Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [io_wait.h:388]: io_watch_add(): DBG: io_watch_add(0xa2c420, 6, 2, 0x7f860bd2dbe0), fd_no=1 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/msg_parser.c:629]: parse_msg(): version: <SIP/2.0> Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 235, <rport> = <n/a>; state=6 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKPj19019d19feaa4a06ac1d6cdc31a2e05d>; state=6 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 237, <alias> = <n/a>; state=16 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/parse_via.c:2672]: parse_via(): end of header reached, state=5 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/msg_parser.c:513]: parse_headers(): parse_headers: Via found, flags=2 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/msg_parser.c:515]: parse_headers(): parse_headers: this is the first via Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [receive.c:154]: receive_msg(): After parse_msg... Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [receive.c:197]: receive_msg(): preparing to run routing scripts... Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: maxfwd [mf_funcs.c:85]: is_maxfwd_present(): value = 70 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/parse_addr_spec.c:898]: parse_addr_spec(): end of header reached, state=10 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/msg_parser.c:190]: get_hdr_field(): DEBUG: get_hdr_field: <To> [27]; uri=[sip:1003@3.local] Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/msg_parser.c:192]: get_hdr_field(): DEBUG: to body ["1003" sip:1003@3.local#015#012] Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/msg_parser.c:170]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <1> <PUBLISH> Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/msg_parser.c:204]: get_hdr_field(): DEBUG: get_hdr_body : content_length=757 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/msg_parser.c:106]: get_hdr_field(): found end of header Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: sanity [mod_sanity.c:255]: w_sanity_check(): sanity checks result: 1 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: textops [textops.c:2478]: has_body_f(): content type is 196613 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: siputils [checks.c:103]: has_totag(): no totag Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: tm [t_lookup.c:1072]: t_check_msg(): DEBUG: t_check_msg: msg id=10 global id=9 T start=0xffffffffffffffff Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: tm [t_lookup.c:527]: t_lookup_request(): t_lookup_request: start searching: hash=12001, isACK=0 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: tm [t_lookup.c:485]: matching_3261(): DEBUG: RFC3261 transaction matching failed Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: tm [t_lookup.c:709]: t_lookup_request(): DEBUG: t_lookup_request: no transaction found Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: tm [t_lookup.c:1141]: t_check_msg(): DEBUG: t_check_msg: msg id=10 global id=10 T end=(nil) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: tm [t_lookup.c:1373]: t_newtran(): DEBUG: t_newtran: msg id=10 , global msg id=10 , T on entrance=(nil) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: tm [t_lookup.c:527]: t_lookup_request(): t_lookup_request: start searching: hash=12001, isACK=0 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: tm [t_lookup.c:485]: matching_3261(): DEBUG: RFC3261 transaction matching failed Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: tm [t_lookup.c:709]: t_lookup_request(): DEBUG: t_lookup_request: no transaction found Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [md5utils.c:67]: MD5StringArray(): DEBUG: MD5 calculated: d71ddc300035dfaa15e181fe4d6a9aa7 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [dns_cache.c:566]: _dns_hash_find(): dns_hash_find(_sip._tcp.3.local(17), 33), h=867 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [resolve.c:770]: get_record(): get_record: lookup(_sip._tcp.3.local, 33) failed Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [dns_cache.c:894]: dns_cache_mk_bad_entry(): dns_cache_mk_bad_entry(_sip._tcp.3.local, 33, 60, 1) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [dns_cache.c:827]: dns_cache_add(): dns_cache_add: adding _sip._tcp.3.local(17) 33 (flags=1) at 867 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [dns_cache.c:566]: _dns_hash_find(): dns_hash_find(3.local(7), 1), h=184 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [resolve.c:770]: get_record(): get_record: lookup(3.local, 1) failed Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [dns_cache.c:894]: dns_cache_mk_bad_entry(): dns_cache_mk_bad_entry(3.local, 1, 60, 1) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [dns_cache.c:827]: dns_cache_add(): dns_cache_add: adding 3.local(7) 1 (flags=1) at 184 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: ERROR: <core> [resolve.c:1726]: sip_hostport2su(): could not resolve hostname: "3.local"
Hello,
apparently the register was replied, then it is another request (could be another register though).
Can you load debugger module and set tis parameter cfgtrace to 1, redo the test and send the output?
Also, it would be good to get the sip message for that case -- inside the request_route, add:
xlog("received message: [[$rb]]\n");
Cheers, Daniel
On 12/11/14 21:56, Vik Killa wrote:
Hello, I'm wondering why kamailio will try doing a DNS lookup of the from host with a REGISTER packet when using TCP? It doesn't do this with UDP. I always get this error since the host is not a valid domain:
<core> [resolve.c:1726]: sip_hostport2su(): could not resolve hostname: "3.local"
Here is the full log with debug (error is last line)
Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [mem/shm_mem.c:111]: _shm_resize(): WARNING:vqm_resize: resize(0) called Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [tcp_main.c:2294]: tcpconn_send_put(): tcp_send: found fd in cache ( 10, 0x7f860bd18938, 1) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [tcp_main.c:2516]: tcpconn_do_send(): tcp_send: sending... Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [tcp_main.c:2550]: tcpconn_do_send(): tcp_send: after real write: c= 0x7f860bd18938 n=639 fd=10 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [tcp_main.c:2551]: tcpconn_do_send(): tcp_send: buf=#012SIP/2.0 401 Unauthorized#015#012Via: SIP/2.0/TCP 192.168.16.120:53972;received=192.168.213.162;rport=53972;branch=z9hG4bKPjac894585917043d28da015d397178725;alias#015#012From: "1003" sip:1003@3.local;tag=dbc7a9087cb84006b65d891e5ad1f5ea#015#012To: "1003" sip:1003@3.local;tag=ey7D0K9DX49DF#015#012Call-ID: ee72194a1b8e4effa2948e237d804b90#015#012CSeq: 1 REGISTER#015#012User-Agent: AMPSwitch#015#012Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE#015#012Supported: timer, path, replaces#015#012WWW-Authenticate: Digest realm="3.local", nonce="cdf32dde-ab14-4265-b491-bee703e83255", algorithm=MD5, qop="auth"#015#012Content-Length: 0#015#012#015#012 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: tm [t_reply.c:1663]: cleanup_uac_timers(): DEBUG: cleanup_uac_timers: RETR/FR timers reset Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [xavp.c:448]: xavp_destroy_list(): destroying xavp list (nil) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [receive.c:298]: receive_msg(): receive_msg: cleaning up Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [io_wait.h:388]: io_watch_add(): DBG: io_watch_add(0xa2c420, 6, 2, 0x7f860bd2dbe0), fd_no=1 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/msg_parser.c:629]: parse_msg(): version: <SIP/2.0> Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 235, <rport> = <n/a>; state=6 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKPj19019d19feaa4a06ac1d6cdc31a2e05d>; state=6 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 237, <alias> = <n/a>; state=16 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/parse_via.c:2672]: parse_via(): end of header reached, state=5 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/msg_parser.c:513]: parse_headers(): parse_headers: Via found, flags=2 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/msg_parser.c:515]: parse_headers(): parse_headers: this is the first via Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [receive.c:154]: receive_msg(): After parse_msg... Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [receive.c:197]: receive_msg(): preparing to run routing scripts... Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: maxfwd [mf_funcs.c:85]: is_maxfwd_present(): value = 70 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/parse_addr_spec.c:898]: parse_addr_spec(): end of header reached, state=10 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/msg_parser.c:190]: get_hdr_field(): DEBUG: get_hdr_field: <To> [27]; uri=[sip:1003@3.local] Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/msg_parser.c:192]: get_hdr_field(): DEBUG: to body ["1003" sip:1003@3.local#015#012] Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/msg_parser.c:170]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <1> <PUBLISH> Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/msg_parser.c:204]: get_hdr_field(): DEBUG: get_hdr_body : content_length=757 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/msg_parser.c:106]: get_hdr_field(): found end of header Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: sanity [mod_sanity.c:255]: w_sanity_check(): sanity checks result: 1 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: textops [textops.c:2478]: has_body_f(): content type is 196613 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: siputils [checks.c:103]: has_totag(): no totag Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: tm [t_lookup.c:1072]: t_check_msg(): DEBUG: t_check_msg: msg id=10 global id=9 T start=0xffffffffffffffff Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: tm [t_lookup.c:527]: t_lookup_request(): t_lookup_request: start searching: hash=12001, isACK=0 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: tm [t_lookup.c:485]: matching_3261(): DEBUG: RFC3261 transaction matching failed Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: tm [t_lookup.c:709]: t_lookup_request(): DEBUG: t_lookup_request: no transaction found Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: tm [t_lookup.c:1141]: t_check_msg(): DEBUG: t_check_msg: msg id=10 global id=10 T end=(nil) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: tm [t_lookup.c:1373]: t_newtran(): DEBUG: t_newtran: msg id=10 , global msg id=10 , T on entrance=(nil) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: tm [t_lookup.c:527]: t_lookup_request(): t_lookup_request: start searching: hash=12001, isACK=0 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: tm [t_lookup.c:485]: matching_3261(): DEBUG: RFC3261 transaction matching failed Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: tm [t_lookup.c:709]: t_lookup_request(): DEBUG: t_lookup_request: no transaction found Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [md5utils.c:67]: MD5StringArray(): DEBUG: MD5 calculated: d71ddc300035dfaa15e181fe4d6a9aa7 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [dns_cache.c:566]: _dns_hash_find(): dns_hash_find(_sip._tcp.3.local(17), 33), h=867 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [resolve.c:770]: get_record(): get_record: lookup(_sip._tcp.3.local, 33) failed Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [dns_cache.c:894]: dns_cache_mk_bad_entry(): dns_cache_mk_bad_entry(_sip._tcp.3.local, 33, 60, 1) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [dns_cache.c:827]: dns_cache_add(): dns_cache_add: adding _sip._tcp.3.local(17) 33 (flags=1) at 867 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [dns_cache.c:566]: _dns_hash_find(): dns_hash_find(3.local(7), 1), h=184 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [resolve.c:770]: get_record(): get_record: lookup(3.local, 1) failed Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [dns_cache.c:894]: dns_cache_mk_bad_entry(): dns_cache_mk_bad_entry(3.local, 1, 60, 1) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [dns_cache.c:827]: dns_cache_add(): dns_cache_add: adding 3.local(7) 1 (flags=1) at 184 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: ERROR: <core> [resolve.c:1726]: sip_hostport2su(): could not resolve hostname: "3.local"
SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list sr-users@lists.sip-router.org http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
Hi Daniel, Yes, I will try to get the requested details...
As far as the second REGISTER, this is true. I am forwarding the REGISTER request to freeswitch, it replies with SIP/2.0 401 Unauthorized Then the UA sends another REGISTER with the Authorization header.
I hope this makes sense, thanks. /V
On Wed, Nov 12, 2014 at 4:10 PM, Daniel-Constantin Mierla <miconda@gmail.com
wrote:
Hello,
apparently the register was replied, then it is another request (could be another register though).
Can you load debugger module and set tis parameter cfgtrace to 1, redo the test and send the output?
Also, it would be good to get the sip message for that case -- inside the request_route, add:
xlog("received message: [[$rb]]\n");
Cheers, Daniel
On 12/11/14 21:56, Vik Killa wrote:
Hello, I'm wondering why kamailio will try doing a DNS lookup of the from host with a REGISTER packet when using TCP? It doesn't do this with UDP. I always get this error since the host is not a valid domain:
<core> [resolve.c:1726]: sip_hostport2su(): could not resolve hostname: "3.local"
Here is the full log with debug (error is last line)
Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [mem/shm_mem.c:111]: _shm_resize(): WARNING:vqm_resize: resize(0) called Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [tcp_main.c:2294]: tcpconn_send_put(): tcp_send: found fd in cache ( 10, 0x7f860bd18938, 1) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [tcp_main.c:2516]: tcpconn_do_send(): tcp_send: sending... Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [tcp_main.c:2550]: tcpconn_do_send(): tcp_send: after real write: c= 0x7f860bd18938 n=639 fd=10 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [tcp_main.c:2551]: tcpconn_do_send(): tcp_send: buf=#012SIP/2.0 401 Unauthorized#015#012Via: SIP/2.0/TCP 192.168.16.120:53972;received=192.168.213.162;rport=53972;branch=z9hG4bKPjac894585917043d28da015d397178725;alias#015#012From: "1003" sip:1003@3.local;tag=dbc7a9087cb84006b65d891e5ad1f5ea#015#012To: "1003" sip:1003@3.local;tag=ey7D0K9DX49DF#015#012Call-ID: ee72194a1b8e4effa2948e237d804b90#015#012CSeq: 1 REGISTER#015#012User-Agent: AMPSwitch#015#012Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE#015#012Supported: timer, path, replaces#015#012WWW-Authenticate: Digest realm="3.local", nonce="cdf32dde-ab14-4265-b491-bee703e83255", algorithm=MD5, qop="auth"#015#012Content-Length: 0#015#012#015#012 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: tm [t_reply.c:1663]: cleanup_uac_timers(): DEBUG: cleanup_uac_timers: RETR/FR timers reset Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [usr_avp.c:643]: destroy_avp_list(): DEBUG:destroy_avp_list: destroying list (nil) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [xavp.c:448]: xavp_destroy_list(): destroying xavp list (nil) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [receive.c:298]: receive_msg(): receive_msg: cleaning up Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3026]: DEBUG: <core> [io_wait.h:388]: io_watch_add(): DBG: io_watch_add(0xa2c420, 6, 2, 0x7f860bd2dbe0), fd_no=1 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/msg_parser.c:629]: parse_msg(): version: <SIP/2.0> Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 235, <rport> = <n/a>; state=6 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKPj19019d19feaa4a06ac1d6cdc31a2e05d>; state=6 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 237, <alias> = <n/a>; state=16 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/parse_via.c:2672]: parse_via(): end of header reached, state=5 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/msg_parser.c:513]: parse_headers(): parse_headers: Via found, flags=2 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/msg_parser.c:515]: parse_headers(): parse_headers: this is the first via Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [receive.c:154]: receive_msg(): After parse_msg... Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [receive.c:197]: receive_msg(): preparing to run routing scripts... Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: maxfwd [mf_funcs.c:85]: is_maxfwd_present(): value = 70 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/parse_addr_spec.c:898]: parse_addr_spec(): end of header reached, state=10 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/msg_parser.c:190]: get_hdr_field(): DEBUG: get_hdr_field: <To> [27]; uri=[sip:1003@3.local] Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/msg_parser.c:192]: get_hdr_field(): DEBUG: to body ["1003" sip:1003@3.local#015#012] Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/msg_parser.c:170]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <1>
<PUBLISH> Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/msg_parser.c:204]: get_hdr_field(): DEBUG: get_hdr_body : content_length=757 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [parser/msg_parser.c:106]: get_hdr_field(): found end of header Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: sanity [mod_sanity.c:255]: w_sanity_check(): sanity checks result: 1 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: textops [textops.c:2478]: has_body_f(): content type is 196613 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: siputils [checks.c:103]: has_totag(): no totag Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: tm [t_lookup.c:1072]: t_check_msg(): DEBUG: t_check_msg: msg id=10 global id=9 T start=0xffffffffffffffff Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: tm [t_lookup.c:527]: t_lookup_request(): t_lookup_request: start searching: hash=12001, isACK=0 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: tm [t_lookup.c:485]: matching_3261(): DEBUG: RFC3261 transaction matching failed Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: tm [t_lookup.c:709]: t_lookup_request(): DEBUG: t_lookup_request: no transaction found Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: tm [t_lookup.c:1141]: t_check_msg(): DEBUG: t_check_msg: msg id=10 global id=10 T end=(nil) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: tm [t_lookup.c:1373]: t_newtran(): DEBUG: t_newtran: msg id=10 , global msg id=10 , T on entrance=(nil) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: tm [t_lookup.c:527]: t_lookup_request(): t_lookup_request: start searching: hash=12001, isACK=0 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: tm [t_lookup.c:485]: matching_3261(): DEBUG: RFC3261 transaction matching failed Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: tm [t_lookup.c:709]: t_lookup_request(): DEBUG: t_lookup_request: no transaction found Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [md5utils.c:67]: MD5StringArray(): DEBUG: MD5 calculated: d71ddc300035dfaa15e181fe4d6a9aa7 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [dns_cache.c:566]: _dns_hash_find(): dns_hash_find(_sip._tcp.3.local(17), 33), h=867 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [resolve.c:770]: get_record(): get_record: lookup(_sip._tcp.3.local, 33) failed Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [dns_cache.c:894]: dns_cache_mk_bad_entry(): dns_cache_mk_bad_entry(_sip._tcp.3.local, 33, 60, 1) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [dns_cache.c:827]: dns_cache_add(): dns_cache_add: adding _sip._tcp.3.local(17) 33 (flags=1) at 867 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [dns_cache.c:566]: _dns_hash_find(): dns_hash_find(3.local(7), 1), h=184 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [resolve.c:770]: get_record(): get_record: lookup(3.local, 1) failed Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [dns_cache.c:894]: dns_cache_mk_bad_entry(): dns_cache_mk_bad_entry(3.local, 1, 60, 1) Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: DEBUG: <core> [dns_cache.c:827]: dns_cache_add(): dns_cache_add: adding 3.local(7) 1 (flags=1) at 184 Nov 12 15:45:19 ua01-proxy01 /usr/sbin/kamailio[3025]: ERROR: <core> [resolve.c:1726]: sip_hostport2su(): could not resolve hostname: "3.local"
SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing listsr-users@lists.sip-router.orghttp://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
-- Daniel-Constantin Mierlahttp://twitter.com/#!/miconda - http://www.linkedin.com/in/miconda Kamailio Advanced Training, Nov 24-27, Berlin - http://www.asipto.com
SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list sr-users@lists.sip-router.org http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
Here is requested debugger info and SIP trace:
Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4657]: ERROR: <core> [tcp_main.c:4338]: tcpconn_main_timeout(): connect 192.168.207.162:54243 failed (timeout) Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=100 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=159 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=153 a=25 n=mf_process_maxfwd_header Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=164 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=159 a=24 n=sanity_check Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=171 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=181 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=110 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=103 a=25 n=is_method Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=110 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=286 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=272 a=25 n=as_check_switch_list Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=286 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=280 a=24 n=as_check_peer_list Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=284 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=302 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=299 a=41 n=isflagset Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=307 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=302 a=25 n=nat_uac_test Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=304 a=55 n=force_rport Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=305 a=24 n=fix_nated_contact Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=310 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=307 a=25 n=has_body Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=117 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=113 a=25 n=is_method Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=117 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/usr/local/testswitch/etc/kamailio.cfg] l=243 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/usr/local/testswitch/etc/kamailio.cfg] l=203 a=24 n=has_totag Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=122 a=24 n=t_check_trans Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=125 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[REGISTRAR] c=[/usr/local/testswitch/etc/kamailio.cfg] l=252 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[REGISTRAR] c=[/usr/local/testswitch/etc/kamailio.cfg] l=249 a=25 n=is_method Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[REGISTRAR] c=[/usr/local/testswitch/etc/kamailio.cfg] l=258 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[REGISTRAR] c=[/usr/local/testswitch/etc/kamailio.cfg] l=252 a=25 n=is_present_hf Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[REGISTRAR] c=[/usr/local/testswitch/etc/kamailio.cfg] l=263 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[REGISTRAR] c=[/usr/local/testswitch/etc/kamailio.cfg] l=258 a=26 n=as_handle_dst Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: testswitcher [testswitch.c:1737]: as_select_random(): DEBUG RANDOMLY SELECTED dst_uri sip:192.168.207.155:5060 Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[REGISTRAR] c=[/usr/local/testswitch/etc/kamailio.cfg] l=263 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=198 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=198 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=197 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=194 a=24 n=t_relay_to_tcp Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=198 a=2 n=exit Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=100 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=159 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=153 a=25 n=mf_process_maxfwd_header Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=164 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=159 a=24 n=sanity_check Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=171 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=181 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=110 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=103 a=25 n=is_method Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=110 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=286 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=272 a=25 n=as_check_switch_list Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=286 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=280 a=24 n=as_check_peer_list Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=284 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=302 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=299 a=41 n=isflagset Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=307 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=302 a=25 n=nat_uac_test Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=304 a=55 n=force_rport Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=305 a=24 n=fix_nated_contact Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=310 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=307 a=25 n=has_body Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=117 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=113 a=25 n=is_method Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=117 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/usr/local/testswitch/etc/kamailio.cfg] l=243 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/usr/local/testswitch/etc/kamailio.cfg] l=203 a=24 n=has_totag Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=122 a=24 n=t_check_trans Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=125 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[REGISTRAR] c=[/usr/local/testswitch/etc/kamailio.cfg] l=252 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[REGISTRAR] c=[/usr/local/testswitch/etc/kamailio.cfg] l=249 a=25 n=is_method Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[REGISTRAR] c=[/usr/local/testswitch/etc/kamailio.cfg] l=250 a=2 n=return Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=129 a=25 n=remove_hf Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=146 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=130 a=25 n=is_method Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=146 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=198 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=198 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=197 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=194 a=24 n=t_relay_to_tcp Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: <core> [resolve.c:1726]: sip_hostport2su(): could not resolve hostname: "3.local" Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: tm [ut.h:337]: uri2dst2(): failed to resolve "3.local" Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: tm [t_fwd.c:1778]: t_forward_nonack(): ERROR: t_forward_nonack: failure to add branches Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=195 a=24 n=sl_reply_error Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: sl [sl_funcs.c:387]: sl_reply_error(): ERROR: sl_reply_error used: Unresolvable destination (478/SL) Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=198 a=2 n=exit Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=100 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=159 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=153 a=25 n=mf_process_maxfwd_header Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=164 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=159 a=24 n=sanity_check Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=171 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=181 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=110 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=103 a=25 n=is_method Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=110 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=286 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=272 a=25 n=as_check_switch_list Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=286 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=280 a=24 n=as_check_peer_list Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=284 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=302 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=299 a=41 n=isflagset Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=307 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=302 a=25 n=nat_uac_test Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=304 a=55 n=force_rport Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=305 a=24 n=fix_nated_contact Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=310 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=307 a=25 n=has_body Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=117 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=113 a=25 n=is_method Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=114 a=24 n=record_route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=117 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/usr/local/testswitch/etc/kamailio.cfg] l=243 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/usr/local/testswitch/etc/kamailio.cfg] l=203 a=24 n=has_totag Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=122 a=24 n=t_check_trans Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=125 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[REGISTRAR] c=[/usr/local/testswitch/etc/kamailio.cfg] l=252 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[REGISTRAR] c=[/usr/local/testswitch/etc/kamailio.cfg] l=249 a=25 n=is_method Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[REGISTRAR] c=[/usr/local/testswitch/etc/kamailio.cfg] l=258 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[REGISTRAR] c=[/usr/local/testswitch/etc/kamailio.cfg] l=252 a=25 n=is_present_hf Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[REGISTRAR] c=[/usr/local/testswitch/etc/kamailio.cfg] l=263 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[REGISTRAR] c=[/usr/local/testswitch/etc/kamailio.cfg] l=258 a=26 n=as_handle_dst Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: testswitcher [testswitch.c:1737]: as_select_random(): DEBUG RANDOMLY SELECTED dst_uri sip:192.168.207.155:5060 Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[REGISTRAR] c=[/usr/local/testswitch/etc/kamailio.cfg] l=263 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=198 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=198 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=197 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=194 a=24 n=t_relay_to_tcp Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=198 a=2 n=exit Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=100 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=159 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=153 a=25 n=mf_process_maxfwd_header Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=164 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=159 a=24 n=sanity_check Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=171 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=181 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=110 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=103 a=25 n=is_method Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=110 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=286 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=272 a=25 n=as_check_switch_list Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=286 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=280 a=24 n=as_check_peer_list Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=284 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=302 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=299 a=41 n=isflagset Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=307 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=302 a=25 n=nat_uac_test Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=304 a=55 n=force_rport Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=305 a=24 n=fix_nated_contact Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=310 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[NAT_TEST_AND_CORRECT] c=[/usr/local/testswitch/etc/kamailio.cfg] l=307 a=25 n=has_body Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=117 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=113 a=25 n=is_method Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=117 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/usr/local/testswitch/etc/kamailio.cfg] l=243 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/usr/local/testswitch/etc/kamailio.cfg] l=203 a=24 n=has_totag Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=122 a=24 n=t_check_trans Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=125 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[REGISTRAR] c=[/usr/local/testswitch/etc/kamailio.cfg] l=252 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[REGISTRAR] c=[/usr/local/testswitch/etc/kamailio.cfg] l=249 a=25 n=is_method Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[REGISTRAR] c=[/usr/local/testswitch/etc/kamailio.cfg] l=258 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[REGISTRAR] c=[/usr/local/testswitch/etc/kamailio.cfg] l=252 a=25 n=is_present_hf Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[REGISTRAR] c=[/usr/local/testswitch/etc/kamailio.cfg] l=252 a=25 n=is_method Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[REGISTRAR] c=[/usr/local/testswitch/etc/kamailio.cfg] l=254 a=24 n=add_path Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[REGISTRAR] c=[/usr/local/testswitch/etc/kamailio.cfg] l=263 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[REGISTRAR] c=[/usr/local/testswitch/etc/kamailio.cfg] l=258 a=26 n=as_handle_dst Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: testswitcher [testswitch.c:1941]: as_handle_dst(): DEBUG 36de5b3989c34c0b82e367f239f1b722 -- found caller-id (sip: 192.168.207.155:5060) Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[REGISTRAR] c=[/usr/local/testswitch/etc/kamailio.cfg] l=263 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=198 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=198 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=197 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=194 a=24 n=t_relay_to_tcp Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=198 a=2 n=exit Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=100 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=159 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=153 a=25 n=mf_process_maxfwd_header Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=164 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=159 a=24 n=sanity_check Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=171 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=181 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=110 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=103 a=25 n=is_method Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=110 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=286 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=272 a=25 n=as_check_switch_list Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=273 a=39 n=setflag Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=117 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=113 a=25 n=is_method Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=117 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/usr/local/testswitch/etc/kamailio.cfg] l=243 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/usr/local/testswitch/etc/kamailio.cfg] l=203 a=24 n=has_totag Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/usr/local/testswitch/etc/kamailio.cfg] l=239 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/usr/local/testswitch/etc/kamailio.cfg] l=211 a=24 n=loose_route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/usr/local/testswitch/etc/kamailio.cfg] l=213 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=198 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=100 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=159 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=153 a=25 n=mf_process_maxfwd_header Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=164 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=159 a=24 n=sanity_check Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=171 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=181 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=110 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=103 a=25 n=is_method Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=110 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=286 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=272 a=25 n=as_check_switch_list Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=273 a=39 n=setflag Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=117 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=113 a=25 n=is_method Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=117 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/usr/local/testswitch/etc/kamailio.cfg] l=243 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/usr/local/testswitch/etc/kamailio.cfg] l=203 a=24 n=has_totag Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/usr/local/testswitch/etc/kamailio.cfg] l=239 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/usr/local/testswitch/etc/kamailio.cfg] l=211 a=24 n=loose_route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/usr/local/testswitch/etc/kamailio.cfg] l=213 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=198 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=193 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=190 a=24 n=t_relay_to_udp Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=198 a=2 n=exit Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=198 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=197 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=194 a=24 n=t_relay_to_tcp Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=198 a=2 n=exit Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4657]: ERROR: <core> [tcp_main.c:4159]: handle_tcpconn_ev(): connect 192.168.207.130:50226 failed Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4645]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=100 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4645]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=159 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4645]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=153 a=25 n=mf_process_maxfwd_header Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4645]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=164 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4645]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=159 a=24 n=sanity_check Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4645]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=171 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4645]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=181 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4645]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=110 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4645]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=103 a=25 n=is_method Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4645]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=110 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4645]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=286 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4645]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=272 a=25 n=as_check_switch_list Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4645]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=273 a=39 n=setflag Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4645]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=117 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4645]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=113 a=25 n=is_method Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4645]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=117 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4645]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/usr/local/testswitch/etc/kamailio.cfg] l=243 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4645]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/usr/local/testswitch/etc/kamailio.cfg] l=203 a=24 n=has_totag Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4645]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/usr/local/testswitch/etc/kamailio.cfg] l=239 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4645]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/usr/local/testswitch/etc/kamailio.cfg] l=211 a=24 n=loose_route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4645]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/usr/local/testswitch/etc/kamailio.cfg] l=213 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4645]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=198 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4645]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=193 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4645]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=190 a=24 n=t_relay_to_udp Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4645]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=198 a=2 n=exit Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=100 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=159 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=153 a=25 n=mf_process_maxfwd_header Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=164 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=159 a=24 n=sanity_check Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=171 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=181 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=110 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=103 a=25 n=is_method Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=110 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=286 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=272 a=25 n=as_check_switch_list Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=273 a=39 n=setflag Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=117 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=113 a=25 n=is_method Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=117 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/usr/local/testswitch/etc/kamailio.cfg] l=243 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/usr/local/testswitch/etc/kamailio.cfg] l=203 a=24 n=has_totag Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/usr/local/testswitch/etc/kamailio.cfg] l=239 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/usr/local/testswitch/etc/kamailio.cfg] l=211 a=24 n=loose_route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/usr/local/testswitch/etc/kamailio.cfg] l=213 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=198 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=198 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=197 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=194 a=24 n=t_relay_to_tcp Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=198 a=2 n=exit Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=100 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=159 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=153 a=25 n=mf_process_maxfwd_header Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=164 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=159 a=24 n=sanity_check Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=171 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=181 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=110 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=103 a=25 n=is_method Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=110 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=286 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=272 a=25 n=as_check_switch_list Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[CHECK_SOURCE_IP] c=[/usr/local/testswitch/etc/kamailio.cfg] l=273 a=39 n=setflag Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=117 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=113 a=25 n=is_method Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=117 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/usr/local/testswitch/etc/kamailio.cfg] l=243 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[WITHINDLG] c=[/usr/local/testswitch/etc/kamailio.cfg] l=203 a=24 n=has_totag Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=122 a=24 n=t_check_trans Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=125 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[REGISTRAR] c=[/usr/local/testswitch/etc/kamailio.cfg] l=252 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[REGISTRAR] c=[/usr/local/testswitch/etc/kamailio.cfg] l=249 a=25 n=is_method Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[REGISTRAR] c=[/usr/local/testswitch/etc/kamailio.cfg] l=250 a=2 n=return Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=129 a=25 n=remove_hf Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=146 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=130 a=25 n=is_method Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=146 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=198 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=198 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=197 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=194 a=24 n=t_relay_to_tcp Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4656]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=198 a=2 n=exit Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=100 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=159 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=153 a=25 n=mf_process_maxfwd_header Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=164 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=159 a=24 n=sanity_check Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=171 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=181 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=173 a=2 n=exit Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/usr/local/testswitch/etc/kamailio.cfg] l=100 a=5 n=route Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=159 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=153 a=25 n=mf_process_maxfwd_header Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=164 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=159 a=24 n=sanity_check Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=171 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=181 a=16 n=if Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4647]: ERROR: *** cfgtrace:request_route=[SANITY_CHECK] c=[/usr/local/testswitch/etc/kamailio.cfg] l=173 a=2 n=exit
----------------begin of packet ----------------------------- T 2014/11/12 16:19:59.281960 192.168.207.162:54261 -> 192.168.207.156:5060 [AP]REGISTER sip:3.local SIP/2.0 Via: SIP/2.0/TCP 192.168.16.120:54261 ;rport;branch=z9hG4bKPjde0f5e3c2ba94d109cbd8b58a76202a2;alias Max-Forwards: 70 From: "1003" sip:1003@3.local;tag=5238a8a4dd674f83b048404aba613f07 To: "1003" sip:1003@3.local Contact: sip:28745109@192.168.16.120:54241 ;transport=tcp;+sip.instance="urn:uuid:7d4ed3bd-451a-4406-a8e2-80315408b7c5" Call-ID: 36de5b3989c34c0b82e367f239f1b722 CSeq: 1 REGISTER Expires: 600 Supported: gruu User-Agent: Blink 0.9.1.2 (Windows) Content-Length: 0
------------------end of packet ----------------------------- ----------------begin of packet ----------------------------- T 2014/11/12 16:19:59.282233 192.168.207.162:54261 -> 192.168.207.156:5060 [AP]16.120:54261;rport;branch=z9hG4bKPjb1b6d82180ad4ed297a6286af3f9d5ad;alias Max-Forwards: 70 From: "1003" sip:1003@3.local;tag=a9093e2eca4142468aafaf71c5a0f539 To: sip:1003@3.local Contact: sip:28745109@192.168.16.120:54241;transport=tcp Call-ID: 00d24a7ab16b4f14b1bde0e1320dab2f CSeq: 17421 SUBSCRIBE Event: message-summary Expires: 600 Supported: 100rel, replaces, norefersub, gruu Accept: application/simple-message-summary Allow-Events: conference, message-summary, dialog, presence, presence.winfo, xcap-diff, dialog.winfo, refer User-Agent: Blink 0.9.1.2 (Windows) Content-Length: 0
------------------end of packet ----------------------------- ----------------begin of packet ----------------------------- T 2014/11/12 16:19:59.322155 192.168.207.156:44452 -> 192.168.207.155:5060 [AP]REGISTER sip:3.local SIP/2.0 Via: SIP/2.0/TCP 192.168.207.156;branch=z9hG4bKa7cf.4634aba540664e78e910641a1b21da45.0;i=3 Via: SIP/2.0/TCP 192.168.16.120:54261 ;received=192.168.207.162;rport=54261;branch=z9hG4bKPjde0f5e3c2ba94d109cbd8b58a76202a2;alias Max-Forwards: 69 From: "1003" sip:1003@3.local;tag=5238a8a4dd674f83b048404aba613f07 To: "1003" sip:1003@3.local Contact: sip:28745109@192.168.207.162:54261 ;transport=tcp;+sip.instance="urn:uuid:7d4ed3bd-451a-4406-a8e2-80315408b7c5" Call-ID: 36de5b3989c34c0b82e367f239f1b722 CSeq: 1 REGISTER Expires: 600 Supported: gruu User-Agent: Blink 0.9.1.2 (Windows) Content-Length: 0
------------------end of packet ----------------------------- ----------------begin of packet ----------------------------- T 2014/11/12 16:19:59.327370 192.168.207.155:5060 -> 192.168.207.156:44452 [AP]SIP/2.0 401 Unauthorized Via: SIP/2.0/TCP 192.168.207.156;branch=z9hG4bKa7cf.4634aba540664e78e910641a1b21da45.0;i=3;rport=44452 Via: SIP/2.0/TCP 192.168.16.120:54261 ;received=192.168.207.162;rport=54261;branch=z9hG4bKPjde0f5e3c2ba94d109cbd8b58a76202a2;alias From: "1003" sip:1003@3.local;tag=5238a8a4dd674f83b048404aba613f07 To: "1003" sip:1003@3.local;tag=v43gHvaS855XB Call-ID: 36de5b3989c34c0b82e367f239f1b722 CSeq: 1 REGISTER User-Agent: testswitch Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, path, replaces WWW-Authenticate: Digest realm="3.local", nonce="fc3c2ce9-82f3-439b-9738-605775450b22", algorithm=MD5, qop="auth" Content-Length: 0
------------------end of packet ----------------------------- ----------------begin of packet ----------------------------- T 2014/11/12 16:19:59.327929 192.168.207.156:5060 -> 192.168.207.162:54261 [AP]SIP/2.0 401 Unauthorized Via: SIP/2.0/TCP 192.168.16.120:54261 ;received=192.168.207.162;rport=54261;branch=z9hG4bKPjde0f5e3c2ba94d109cbd8b58a76202a2;alias From: "1003" sip:1003@3.local;tag=5238a8a4dd674f83b048404aba613f07 To: "1003" sip:1003@3.local;tag=v43gHvaS855XB Call-ID: 36de5b3989c34c0b82e367f239f1b722 CSeq: 1 REGISTER User-Agent: testswitch Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, path, replaces WWW-Authenticate: Digest realm="3.local", nonce="fc3c2ce9-82f3-439b-9738-605775450b22", algorithm=MD5, qop="auth" Content-Length: 0
------------------end of packet ----------------------------- ----------------begin of packet ----------------------------- T 2014/11/12 16:19:59.330133 192.168.207.162:54261 -> 192.168.207.156:5060 [AP]REGISTER sip:3.local SIP/2.0 Via: SIP/2.0/TCP 192.168.16.120:54261 ;rport;branch=z9hG4bKPjedf6431797aa480ead76c1a7ae101ade;alias Max-Forwards: 70 From: "1003" sip:1003@3.local;tag=5238a8a4dd674f83b048404aba613f07 To: "1003" sip:1003@3.local Contact: sip:28745109@192.168.16.120:54241 ;transport=tcp;+sip.instance="urn:uuid:7d4ed3bd-451a-4406-a8e2-80315408b7c5" Call-ID: 36de5b3989c34c0b82e367f239f1b722 CSeq: 2 REGISTER Expires: 600 Supported: gruu User-Agent: Blink 0.9.1.2 (Windows) Authorization: Digest username="1003", realm="3.local", nonce="fc3c2ce9-82f3-439b-9738-605775450b22", uri="sip:3.local", response="da2b6e363260b0387a5927704a28b831", algorithm=MD5, cnonce="c34b967e2bcb4b6d9e6670535ba08f99", qop=auth, nc=00000001 Content-Length: 0
------------------end of packet ----------------------------- ----------------begin of packet ----------------------------- T 2014/11/12 16:19:59.351125 192.168.207.156:5060 -> 192.168.207.162:54261 [AP]SIP/2.0 478 Unresolvable destination (478/SL) Via: SIP/2.0/TCP 192.168.16.120:54261 ;rport=54261;branch=z9hG4bKPja071889f86b2470398106d5a096e0111;alias;received=192.168.207.162 From: "1003" sip:1003@3.local;tag=24d0e6200fb44bc4b993a5b6cc0d3d6e To: "1003" sip:1003@3.local;tag=98beed43ea484d57160c0a87164dfce1.08a6 Call-ID: 47585b09fb134f65a2bbf82bc11bf212 CSeq: 1 PUBLISH Server: kamailio (4.2.0 (x86_64/linux)) Content-Length: 0
------------------end of packet ----------------------------- ----------------begin of packet ----------------------------- T 2014/11/12 16:19:59.354467 192.168.207.156:5060 -> 192.168.207.162:54261 [AP]SIP/2.0 478 Unresolvable destination (478/TM) Via: SIP/2.0/TCP 192.168.16.120:54261 ;rport=54261;branch=z9hG4bKPja071889f86b2470398106d5a096e0111;alias;received=192.168.207.162 From: "1003" sip:1003@3.local;tag=24d0e6200fb44bc4b993a5b6cc0d3d6e To: "1003" sip:1003@3.local;tag=b9d45a0d611ee9eea95e269f12755a03-08a6 Call-ID: 47585b09fb134f65a2bbf82bc11bf212 CSeq: 1 PUBLISH Server: kamailio (4.2.0 (x86_64/linux)) Content-Length: 0
------------------end of packet ----------------------------- ----------------begin of packet ----------------------------- T 2014/11/12 16:19:59.401809 192.168.207.156:44452 -> 192.168.207.155:5060 [AP]SUBSCRIBE sip:1003@3.local SIP/2.0 Record-Route: sip:192.168.207.156;transport=tcp;lr;ftag=a9093e2eca4142468aafaf71c5a0f539 Via: SIP/2.0/TCP 192.168.207.156;branch=z9hG4bK2f36.26692d180ee50d8d8b0758131825efe6.0;i=3 Via: SIP/2.0/TCP 192.168.16.120:54261 ;received=192.168.207.162;rport=54261;branch=z9hG4bKPjb1b6d82180ad4ed297a6286af3f9d5ad;alias Max-Forwards: 69 From: "1003" sip:1003@3.local;tag=a9093e2eca4142468aafaf71c5a0f539 To: sip:1003@3.local Contact: sip:28745109@192.168.207.162:54261;transport=tcp Call-ID: 00d24a7ab16b4f14b1bde0e1320dab2f CSeq: 17421 SUBSCRIBE Event: message-summary Expires: 600 Supported: 100rel, replaces, norefersub, gruu Accept: application/simple-message-summary Allow-Events: conference, message-summary, dialog, presence, presence.winfo, xcap-diff, dialog.winfo, refer User-Agent: Blink 0.9.1.2 (Windows) Content-Length: 0
------------------end of packet ----------------------------- ----------------begin of packet ----------------------------- T 2014/11/12 16:19:59.408240 192.168.207.155:5060 -> 192.168.207.156:44452 [AP]SIP/2.0 202 Accepted Via: SIP/2.0/TCP 192.168.207.156;branch=z9hG4bK2f36.26692d180ee50d8d8b0758131825efe6.0;i=3;rport=44452 Via: SIP/2.0/TCP 192.168.16.120:54261 ;received=192.168.207.162;rport=54261;branch=z9hG4bKPjb1b6d82180ad4ed297a6286af3f9d5ad;alias Record-Route: sip:192.168.207.156;transport=tcp;lr;ftag=a9093e2eca4142468aafaf71c5a0f539 From: "1003" sip:1003@3.local;tag=a9093e2eca4142468aafaf71c5a0f539 To: sip:1003@3.local;tag=Hs1HcBNyGssR Call-ID: 00d24a7ab16b4f14b1bde0e1320dab2f CSeq: 17421 SUBSCRIBE Contact: sip:1003@192.168.207.155:5060;transport=tcp Expires: 600 User-Agent: testswitch Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, path, replaces Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Subscription-State: active;expires=600 Content-Length: 0
------------------end of packet ----------------------------- ----------------begin of packet ----------------------------- T 2014/11/12 16:19:59.408700 192.168.207.156:5060 -> 192.168.207.162:54261 [AP]SIP/2.0 202 Accepted Via: SIP/2.0/TCP 192.168.16.120:54261 ;received=192.168.207.162;rport=54261;branch=z9hG4bKPjb1b6d82180ad4ed297a6286af3f9d5ad;alias Record-Route: sip:192.168.207.156;transport=tcp;lr;ftag=a9093e2eca4142468aafaf71c5a0f539 From: "1003" sip:1003@3.local;tag=a9093e2eca4142468aafaf71c5a0f539 To: sip:1003@3.local;tag=Hs1HcBNyGssR Call-ID: 00d24a7ab16b4f14b1bde0e1320dab2f CSeq: 17421 SUBSCRIBE Contact: sip:1003@192.168.207.155:5060;transport=tcp Expires: 600 User-Agent: testswitch Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, path, replaces Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Subscription-State: active;expires=600 Content-Length: 0
------------------end of packet ----------------------------- ----------------begin of packet ----------------------------- T 2014/11/12 16:19:59.419516 192.168.207.156:44452 -> 192.168.207.155:5060 [AP]REGISTER sip:3.local SIP/2.0 Via: SIP/2.0/TCP 192.168.207.156;branch=z9hG4bK77cf.f75504a26bfbefb4dbc3149fb23f8fae.0;i=3 Via: SIP/2.0/TCP 192.168.16.120:54261 ;received=192.168.207.162;rport=54261;branch=z9hG4bKPjedf6431797aa480ead76c1a7ae101ade;alias Max-Forwards: 69 From: "1003" sip:1003@3.local;tag=5238a8a4dd674f83b048404aba613f07 To: "1003" sip:1003@3.local Contact: sip:28745109@192.168.207.162:54261 ;transport=tcp;+sip.instance="urn:uuid:7d4ed3bd-451a-4406-a8e2-80315408b7c5" Call-ID: 36de5b3989c34c0b82e367f239f1b722 CSeq: 2 REGISTER Expires: 600 Supported: gruu User-Agent: Blink 0.9.1.2 (Windows) Authorization: Digest username="1003", realm="3.local", nonce="fc3c2ce9-82f3-439b-9738-605775450b22", uri="sip:3.local", response="da2b6e363260b0387a5927704a28b831", algorithm=MD5, cnonce="c34b967e2bcb4b6d9e6670535ba08f99", qop=auth, nc=00000001 Content-Length: 0 Path: sip:192.168.207.156;transport=tcp;lr
------------------end of packet ----------------------------- ----------------begin of packet ----------------------------- T 2014/11/12 16:19:59.430638 192.168.207.155:5060 -> 192.168.207.156:44452 [AP]SIP/2.0 200 OK Via: SIP/2.0/TCP 192.168.207.156;branch=z9hG4bK77cf.f75504a26bfbefb4dbc3149fb23f8fae.0;i=3;rport=44452 Via: SIP/2.0/TCP 192.168.16.120:54261 ;received=192.168.207.162;rport=54261;branch=z9hG4bKPjedf6431797aa480ead76c1a7ae101ade;alias From: "1003" sip:1003@3.local;tag=5238a8a4dd674f83b048404aba613f07 To: "1003" sip:1003@3.local;tag=ypp2mjc02Qj3j Call-ID: 36de5b3989c34c0b82e367f239f1b722 CSeq: 2 REGISTER Contact: sip:1003@192.168.207.130:5062;expires=2089 Contact: sip:28745109@192.168.207.162:54243;transport=tcp;expires=396 Contact: sip:28745109@192.168.207.162:54261;transport=tcp;expires=600 Date: Wed, 12 Nov 2014 21:20:43 GMT User-Agent: testswitch Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, path, replaces Path: sip:192.168.207.156;transport=tcp;lr Content-Length: 0
------------------end of packet ----------------------------- ----------------begin of packet ----------------------------- T 2014/11/12 16:19:59.431102 192.168.207.156:5060 -> 192.168.207.162:54261 [AP]SIP/2.0 200 OK Via: SIP/2.0/TCP 192.168.16.120:54261 ;received=192.168.207.162;rport=54261;branch=z9hG4bKPjedf6431797aa480ead76c1a7ae101ade;alias From: "1003" sip:1003@3.local;tag=5238a8a4dd674f83b048404aba613f07 To: "1003" sip:1003@3.local;tag=ypp2mjc02Qj3j Call-ID: 36de5b3989c34c0b82e367f239f1b722 CSeq: 2 REGISTER Contact: sip:1003@192.168.207.130:5062;expires=2089 Contact: sip:28745109@192.168.207.162:54243;transport=tcp;expires=396 Contact: sip:28745109@192.168.207.162:54261;transport=tcp;expires=600 Date: Wed, 12 Nov 2014 21:20:43 GMT User-Agent: testswitch Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, path, replaces Path: sip:192.168.207.156;transport=tcp;lr Content-Length: 0
The error is while trying to relay, which uses $ru or $du as next hop address.
Can you give exactly how t_relay_to_tcp() is used (what parameters)?
Also, add next xlog before relay function:
xlog("r-uri: $ru d-uri: $du\n");
Cheers, Daniel
On 12/11/14 22:24, Vik Killa wrote:
Here is requested debugger info and SIP trace:
[...] Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: *** cfgtrace:request_route=[RELAY] c=[/usr/local/testswitch/etc/kamailio.cfg] l=194 a=24 n=t_relay_to_tcp Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: <core> [resolve.c:1726]: sip_hostport2su(): could not resolve hostname: "3.local" Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: tm [ut.h:337]: uri2dst2(): failed to resolve "3.local" Nov 12 16:19:59 ua01-proxy01 /usr/sbin/kamailio[4654]: ERROR: tm [t_fwd.c:1778]: t_forward_nonack(): ERROR: t_forward_nonack: failure to add branches
-
Daniel-Constantin Mierla -
Vik Killa