And, when I put the lines about sdpops in comments, everythings is working well...
Here is the debug mode messages:You have to know that I'm recreating the reality on once physical machine with different virtual machine.My network is like that: machine3UDP 172.16.0.12 NAT --------------- machine 1, 172.16.0.10 and 192.168.1.9 NAT(kamailio realtime asterisk) ----------- machine 2 and 3 (private network)192.168.1.15 and.16 TLSaf8448de310d568e03713(19429) DEBUG: auth [api.c:210]: check_response: Our result = '1fa92b49d32418c756adbcef119c0521'13(19429) DEBUG: auth [api.c:217]: check_response: Authorization is OK13(19429) DEBUG: <core> [db_res.c:81]: freeing 1 columns13(19429) DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[0] at 0xb736e5ec13(19429) DEBUG: <core> [db_res.c:94]: freeing result names at 0xb736e58413(19429) DEBUG: <core> [db_res.c:99]: freeing result types at 0xb736e5b813(19429) DEBUG: <core> [db_res.c:54]: freeing 1 rows13(19429) DEBUG: <core> [db_row.c:97]: freeing row values at 0xb736e65c13(19429) DEBUG: <core> [db_res.c:62]: freeing rows at 0xb736e62413(19429) DEBUG: <core> [db_res.c:136]: freeing result set at 0xb7371bf013(19429) DEBUG: <core> [socket_info.c:502]: grep_sock_info - checking if host==us: 11==11 && [192.168.1.9] == [192.168.1.9]13(19429) DEBUG: <core> [socket_info.c:505]: grep_sock_info - checking if port 5060 matches port 506013(19429) DEBUG: usrloc [ucontact.c:805]: exists callback for type= UL_CONTACT_UPDATE13(19429) DEBUG: registrar [reply.c:192]: created Contact HF: Contact: <sip:102@192.168.1.15:5061;transport=TLS;ob>;expires=300;received="sip:192.168.1.15:1158;transport=TLS"13(19429) DEBUG: sl [sl.c:278]: reply in stateless mode (sl)13(19429) DEBUG: <core> [msg_translator.c:204]: check_via_address(192.168.1.15, 192.168.1.15, 0)13(19429) DEBUG: <core> [tcp_main.c:2284]: tcp_send: send from reader (19429 (13)), reusing fd13(19429) DEBUG: <core> [tcp_main.c:2520]: tcp_send: sending...13(19429) DEBUG: <core> [tcp_main.c:2554]: tcp_send: after real write: c= 0xb35bc370 n=517 fd=1113(19429) DEBUG: <core> [tcp_main.c:2555]: tcp_send: buf=13(19429) DEBUG: <core> [select.c:424]: Calling SELECT 0xb737c78813(19429) DEBUG: <core> [select.c:424]: Calling SELECT 0xb737ebf413(19429) DEBUG: <core> [select.c:424]: Calling SELECT 0xb7384bd013(19429) DEBUG: <core> [select.c:424]: Calling SELECT 0xb7385ef013(19429) DEBUG: <core> [select.c:424]: Calling SELECT 0xb73872b413(19429) DEBUG: tm [uac.c:243]: DEBUG:tm:t_uac: next_hop=<sip:192.168.1.9:5080>13(19429) DEBUG: tm [uac.c:182]: DEBUG: dlg2hash: 4191713(19429) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list 0xb35d238813(19429) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)13(19429) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)13(19429) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)13(19429) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)13(19429) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)13(19429) DEBUG: <core> [xavp.c:365]: destroying xavp list (nil)13(19429) DEBUG: <core> [receive.c:291]: receive_msg: cleaning up4(19415) DEBUG: <core> [parser/msg_parser.c:628]: SIP Request:4(19415) DEBUG: <core> [parser/msg_parser.c:630]: method: <PUBLISH>4(19415) DEBUG: <core> [parser/msg_parser.c:632]: uri: <sip:102@sip.wtz.local>4(19415) DEBUG: <core> [parser/msg_parser.c:634]: version: <SIP/2.0>4(19415) DEBUG: <core> [parser/parse_via.c:1288]: Found param type 235, <rport> = <n/a>; state=64(19415) DEBUG: <core> [parser/parse_via.c:1288]: Found param type 232, <branch> = <z9hG4bKPjaaa2cc6202fd4abda385cac59b336e54>; state=164(19415) DEBUG: <core> [parser/parse_via.c:2563]: end of header reached, state=54(19415) DEBUG: <core> [parser/msg_parser.c:515]: parse_headers: Via found, flags=24(19415) DEBUG: <core> [parser/msg_parser.c:517]: parse_headers: this is the first via4(19415) DEBUG: <core> [receive.c:147]: After parse_msg...4(19415) DEBUG: <core> [receive.c:188]: preparing to run routing scripts...4(19415) DEBUG: <core> [parser/parse_to.c:177]: DEBUG: add_param: tag=78a5897e698d4401a128e4918e9edc0b4(19415) DEBUG: <core> [parser/parse_to.c:801]: end of header reached, state=294(19415) DEBUG: maxfwd [mf_funcs.c:85]: value = 704(19415) DEBUG: <core> [parser/parse_to.c:801]: end of header reached, state=104(19415) DEBUG: <core> [parser/msg_parser.c:187]: DEBUG: get_hdr_field: <To> [25]; uri=[sip:102@sip.wtz.local]4(19415) DEBUG: <core> [parser/msg_parser.c:189]: DEBUG: to body [<sip:102@sip.wtz.local>]4(19415) DEBUG: <core> [parser/msg_parser.c:167]: get_hdr_field: cseq <CSeq>: <18509> <PUBLISH>4(19415) DEBUG: <core> [parser/msg_parser.c:201]: DEBUG: get_hdr_body : content_length=2844(19415) DEBUG: <core> [parser/msg_parser.c:103]: found end of header4(19415) DEBUG: sanity [mod_sanity.c:251]: sanity checks result: 14(19415) DEBUG: <core> [msg_translator.c:204]: check_via_address(192.168.1.15, 192.168.1.15, 0)4(19415) DEBUG: siputils [checks.c:104]: no totag4(19415) DEBUG: tm [t_lookup.c:1079]: DEBUG: t_check_msg: msg id=2 global id=1 T start=(nil)4(19415) DEBUG: tm [t_lookup.c:527]: t_lookup_request: start searching: hash=21215, isACK=04(19415) DEBUG: tm [t_lookup.c:485]: DEBUG: RFC3261 transaction matching failed4(19415) DEBUG: tm [t_lookup.c:709]: DEBUG: t_lookup_request: no transaction found4(19415) DEBUG: tm [t_lookup.c:1148]: DEBUG: t_check_msg: msg id=2 global id=2 T end=(nil)4(19415) DEBUG: <core> [select.c:424]: Calling SELECT 0xb7376c384(19415) ERROR: permissions [trusted.c:415]: no connection to database4(19415) DEBUG: <core> [socket_info.c:502]: grep_sock_info - checking if host==us: 13==11 && [sip.wtz.local] == [192.168.1.9]4(19415) DEBUG: <core> [socket_info.c:505]: grep_sock_info - checking if port 5060 matches port 50604(19415) DEBUG: <core> [socket_info.c:502]: grep_sock_info - checking if host==us: 13==11 && [sip.wtz.local] == [192.168.1.9]4(19415) DEBUG: <core> [socket_info.c:505]: grep_sock_info - checking if port 5061 matches port 50604(19415) DEBUG: <core> [msg_translator.c:204]: check_via_address(192.168.1.15, 192.168.1.15, 0)4(19415) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)4(19415) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)4(19415) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)4(19415) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)4(19415) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)4(19415) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)4(19415) DEBUG: <core> [xavp.c:365]: destroying xavp list (nil)4(19415) DEBUG: <core> [receive.c:291]: receive_msg: cleaning up1(19412) DEBUG: <core> [parser/msg_parser.c:638]: SIP Reply (status):1(19412) DEBUG: <core> [parser/msg_parser.c:640]: version: <SIP/2.0>1(19412) DEBUG: <core> [parser/msg_parser.c:642]: status: <200>1(19412) DEBUG: <core> [parser/msg_parser.c:644]: reason: <OK>1(19412) DEBUG: <core> [parser/parse_via.c:1288]: Found param type 232, <branch> = <z9hG4bKdb3a.0be1df11.0>; state=61(19412) DEBUG: <core> [parser/parse_via.c:1288]: Found param type 234, <received> = <192.168.1.9>; state=161(19412) DEBUG: <core> [parser/parse_via.c:2563]: end of header reached, state=51(19412) DEBUG: <core> [parser/msg_parser.c:515]: parse_headers: Via found, flags=21(19412) DEBUG: <core> [parser/msg_parser.c:517]: parse_headers: this is the first via1(19412) DEBUG: <core> [receive.c:147]: After parse_msg...1(19412) DEBUG: tm [t_lookup.c:1079]: DEBUG: t_check_msg: msg id=3 global id=2 T start=0xffffffff1(19412) DEBUG: <core> [parser/parse_to.c:177]: DEBUG: add_param: tag=as699907a51(19412) DEBUG: <core> [parser/parse_to.c:801]: end of header reached, state=291(19412) DEBUG: <core> [parser/msg_parser.c:187]: DEBUG: get_hdr_field: <To> [36]; uri=[sip:102@192.168.1.9]1(19412) DEBUG: <core> [parser/msg_parser.c:189]: DEBUG: to body [sip:102@192.168.1.9]1(19412) DEBUG: <core> [parser/msg_parser.c:167]: get_hdr_field: cseq <CSeq>: <10> <REGISTER>1(19412) DEBUG: tm [t_lookup.c:965]: DEBUG: t_reply_matching: hash 41917 label 301801136 branch 01(19412) DEBUG: tm [t_lookup.c:1016]: DEBUG: t_reply_matching: reply matched (T=0xb35cfc68)!1(19412) DEBUG: tm [t_lookup.c:1148]: DEBUG: t_check_msg: msg id=3 global id=3 T end=0xb35cfc681(19412) DEBUG: tm [t_reply.c:2053]: DEBUG: reply_received: org. status uas=0, uac[0]=0 local=2 is_invite=0)1(19412) DEBUG: tm [t_reply.c:1168]: ->>>>>>>>> T_code=0, new_code=2001(19412) DEBUG: tm [t_reply.c:1931]: DEBUG: local_reply: branch=0, save=0, winner=01(19412) DEBUG: tm [t_reply.c:1968]: DEBUG: local transaction completed1(19412) DEBUG: tm [t_reply.c:1509]: DEBUG: cleanup_uac_timers: RETR/FR timers reset1(19412) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)1(19412) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)1(19412) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)1(19412) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)1(19412) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)1(19412) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)1(19412) DEBUG: <core> [xavp.c:365]: destroying xavp list (nil)1(19412) DEBUG: <core> [receive.c:291]: receive_msg: cleaning up2(19413) DEBUG: <core> [parser/msg_parser.c:628]: SIP Request:2(19413) DEBUG: <core> [parser/msg_parser.c:630]: method: <REGISTER>2(19413) DEBUG: <core> [parser/msg_parser.c:632]: uri: <sip:sip.wtz.local>2(19413) DEBUG: <core> [parser/msg_parser.c:634]: version: <SIP/2.0>2(19413) DEBUG: <core> [parser/parse_via.c:1288]: Found param type 235, <rport> = <n/a>; state=62(19413) DEBUG: <core> [parser/parse_via.c:1288]: Found param type 232, <branch> = <z9hG4bKPjb88ef0f513f643c9b9b08ad7dba384aa>; state=162(19413) DEBUG: <core> [parser/parse_via.c:2563]: end of header reached, state=52(19413) DEBUG: <core> [parser/msg_parser.c:515]: parse_headers: Via found, flags=22(19413) DEBUG: <core> [parser/msg_parser.c:517]: parse_headers: this is the first via2(19413) DEBUG: <core> [receive.c:147]: After parse_msg...2(19413) DEBUG: <core> [receive.c:188]: preparing to run routing scripts...2(19413) DEBUG: <core> [parser/parse_to.c:177]: DEBUG: add_param: tag=27a6e4f8cff94d9ab8a68d58011e55082(19413) DEBUG: <core> [parser/parse_to.c:801]: end of header reached, state=292(19413) DEBUG: <core> [parser/parse_to.c:801]: end of header reached, state=102(19413) DEBUG: <core> [parser/msg_parser.c:187]: DEBUG: get_hdr_field: <To> [23]; uri=[sip:103@sip.wtz.nat]2(19413) DEBUG: <core> [parser/msg_parser.c:189]: DEBUG: to body [<sip:103@sip.wtz.nat>]2(19413) DEBUG: <core> [parser/msg_parser.c:167]: get_hdr_field: cseq <CSeq>: <45402> <REGISTER>2(19413) DEBUG: <core> [parser/msg_parser.c:201]: DEBUG: get_hdr_body : content_length=02(19413) DEBUG: <core> [parser/msg_parser.c:103]: found end of header2(19413) DEBUG: <core> [parser/sdp/sdp.c:696]: message body has length zero2(19413) DEBUG: sdpops [sdpops_mod.c:657]: attempting to search for media type: [audio]2(19413) DEBUG: sdpops [sdpops_mod.c:662]: No sdp body2(19413) DEBUG: maxfwd [mf_funcs.c:85]: value = 702(19413) DEBUG: sanity [mod_sanity.c:251]: sanity checks result: 12(19413) DEBUG: <core> [msg_translator.c:204]: check_via_address(172.16.0.12, 172.16.0.12, 0)2(19413) DEBUG: siputils [checks.c:104]: no totag2(19413) DEBUG: tm [t_lookup.c:1079]: DEBUG: t_check_msg: msg id=3 global id=2 T start=0xffffffff2(19413) DEBUG: tm [t_lookup.c:527]: t_lookup_request: start searching: hash=36220, isACK=02(19413) DEBUG: tm [t_lookup.c:485]: DEBUG: RFC3261 transaction matching failed2(19413) DEBUG: tm [t_lookup.c:709]: DEBUG: t_lookup_request: no transaction found2(19413) DEBUG: tm [t_lookup.c:1148]: DEBUG: t_check_msg: msg id=3 global id=3 T end=(nil)2(19413) DEBUG: <core> [select.c:424]: Calling SELECT 0xb7376c382(19413) DEBUG: auth_db [authorize.c:303]: realm value [sip.wtz.nat]2(19413) DEBUG: auth [api.c:85]: auth:pre_auth: Credentials with realm 'sip.wtz.nat' not found2(19413) DEBUG: auth_db [authorize.c:177]: no credentials2(19413) DEBUG: auth [challenge.c:102]: build_challenge_hf: realm='sip.wtz.nat'2(19413) DEBUG: auth [challenge.c:244]: auth: 'WWW-Authenticate: Digest realm="sip.wtz.nat", nonce="T9X59E/V+Mg6xGlySWH+rfOEihqYhssq"'2(19413) DEBUG: sl [sl.c:278]: reply in stateless mode (sl)2(19413) DEBUG: <core> [msg_translator.c:204]: check_via_address(172.16.0.12, 172.16.0.12, 0)2(19413) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list 0xb35d23882(19413) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)2(19413) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)2(19413) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)2(19413) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)2(19413) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)2(19413) DEBUG: <core> [xavp.c:365]: destroying xavp list (nil)2(19413) DEBUG: <core> [receive.c:291]: receive_msg: cleaning up3(19414) DEBUG: <core> [parser/msg_parser.c:628]: SIP Request:3(19414) DEBUG: <core> [parser/msg_parser.c:630]: method: <REGISTER>3(19414) DEBUG: <core> [parser/msg_parser.c:632]: uri: <sip:sip.wtz.local>3(19414) DEBUG: <core> [parser/msg_parser.c:634]: version: <SIP/2.0>3(19414) DEBUG: <core> [parser/parse_via.c:1288]: Found param type 235, <rport> = <n/a>; state=63(19414) DEBUG: <core> [parser/parse_via.c:1288]: Found param type 232, <branch> = <z9hG4bKPjec9008971eff4b1fbea5ec76965dfe42>; state=163(19414) DEBUG: <core> [parser/parse_via.c:2563]: end of header reached, state=53(19414) DEBUG: <core> [parser/msg_parser.c:515]: parse_headers: Via found, flags=23(19414) DEBUG: <core> [parser/msg_parser.c:517]: parse_headers: this is the first via3(19414) DEBUG: <core> [receive.c:147]: After parse_msg...3(19414) DEBUG: <core> [receive.c:188]: preparing to run routing scripts...3(19414) DEBUG: <core> [parser/parse_to.c:177]: DEBUG: add_param: tag=27a6e4f8cff94d9ab8a68d58011e55083(19414) DEBUG: <core> [parser/parse_to.c:801]: end of header reached, state=293(19414) DEBUG: <core> [parser/parse_to.c:801]: end of header reached, state=103(19414) DEBUG: <core> [parser/msg_parser.c:187]: DEBUG: get_hdr_field: <To> [23]; uri=[sip:103@sip.wtz.nat]3(19414) DEBUG: <core> [parser/msg_parser.c:189]: DEBUG: to body [<sip:103@sip.wtz.nat>]3(19414) DEBUG: <core> [parser/msg_parser.c:167]: get_hdr_field: cseq <CSeq>: <45403> <REGISTER>3(19414) DEBUG: <core> [parser/msg_parser.c:201]: DEBUG: get_hdr_body : content_length=03(19414) DEBUG: <core> [parser/msg_parser.c:103]: found end of header3(19414) DEBUG: <core> [parser/sdp/sdp.c:696]: message body has length zero3(19414) DEBUG: sdpops [sdpops_mod.c:657]: attempting to search for media type: [audio]3(19414) DEBUG: sdpops [sdpops_mod.c:662]: No sdp body3(19414) DEBUG: maxfwd [mf_funcs.c:85]: value = 703(19414) DEBUG: sanity [mod_sanity.c:251]: sanity checks result: 13(19414) DEBUG: <core> [msg_translator.c:204]: check_via_address(172.16.0.12, 172.16.0.12, 0)3(19414) DEBUG: siputils [checks.c:104]: no totag3(19414) DEBUG: tm [t_lookup.c:1079]: DEBUG: t_check_msg: msg id=2 global id=1 T start=0xffffffff3(19414) DEBUG: tm [t_lookup.c:527]: t_lookup_request: start searching: hash=36221, isACK=03(19414) DEBUG: tm [t_lookup.c:485]: DEBUG: RFC3261 transaction matching failed3(19414) DEBUG: tm [t_lookup.c:709]: DEBUG: t_lookup_request: no transaction found3(19414) DEBUG: tm [t_lookup.c:1148]: DEBUG: t_check_msg: msg id=2 global id=2 T end=(nil)3(19414) DEBUG: <core> [select.c:424]: Calling SELECT 0xb7376c383(19414) DEBUG: auth_db [authorize.c:303]: realm value [sip.wtz.nat]3(19414) DEBUG: auth [api.c:95]: auth: digest-algo: parsed value: 03(19414) DEBUG: <core> [db_res.c:118]: allocate 28 bytes for result set at 0xb7371ad43(19414) DEBUG: db_mysql [km_res.c:68]: 1 columns returned from the query3(19414) DEBUG: <core> [db_res.c:155]: allocate 4 bytes for result names at 0xb73861143(19414) DEBUG: <core> [db_res.c:165]: allocate 4 bytes for result types at 0xb732be3c3(19414) DEBUG: db_mysql [km_res.c:85]: allocate 8 bytes for RES_NAMES[0] at 0xb736e3a03(19414) DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0xb736e3a0)[0]=[sippasswd]3(19414) DEBUG: db_mysql [km_res.c:136]: use DB1_STRING result type3(19414) DEBUG: <core> [db_res.c:184]: allocate 8 bytes for rows at 0xb736e3d83(19414) DEBUG: <core> [db_row.c:119]: allocate 20 bytes for row values at 0xb736e4103(19414) DEBUG: <core> [db_val.c:117]: converting STRING [103]3(19414) DEBUG: auth_db [authorize.c:121]: HA1 string calculated: 7c958fe006d9d282b8b1791acd644a9b3(19414) DEBUG: auth [api.c:210]: check_response: Our result = 'e76ca7c04e2060cfda3422bd689a3ce6'3(19414) DEBUG: auth [api.c:217]: check_response: Authorization is OK3(19414) DEBUG: <core> [db_res.c:81]: freeing 1 columns3(19414) DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[0] at 0xb736e3a03(19414) DEBUG: <core> [db_res.c:94]: freeing result names at 0xb73861143(19414) DEBUG: <core> [db_res.c:99]: freeing result types at 0xb732be3c3(19414) DEBUG: <core> [db_res.c:54]: freeing 1 rows3(19414) DEBUG: <core> [db_row.c:97]: freeing row values at 0xb736e4103(19414) DEBUG: <core> [db_res.c:62]: freeing rows at 0xb736e3d83(19414) DEBUG: <core> [db_res.c:136]: freeing result set at 0xb7371ad43(19414) DEBUG: <core> [socket_info.c:502]: grep_sock_info - checking if host==us: 13==11 && [sip.wtz.local] == [192.168.1.9]3(19414) DEBUG: <core> [socket_info.c:505]: grep_sock_info - checking if port 5060 matches port 50603(19414) DEBUG: <core> [socket_info.c:502]: grep_sock_info - checking if host==us: 13==11 && [sip.wtz.local] == [192.168.1.9]3(19414) DEBUG: <core> [socket_info.c:505]: grep_sock_info - checking if port 5061 matches port 50603(19414) DEBUG: usrloc [ucontact.c:805]: exists callback for type= UL_CONTACT_UPDATE3(19414) DEBUG: registrar [reply.c:192]: created Contact HF: Contact: <sip:103@172.16.0.12:5060;ob>;expires=300;received="sip:172.16.0.12:5060"3(19414) DEBUG: sl [sl.c:278]: reply in stateless mode (sl)3(19414) DEBUG: <core> [msg_translator.c:204]: check_via_address(172.16.0.12, 172.16.0.12, 0)3(19414) DEBUG: <core> [select.c:424]: Calling SELECT 0xb737c7883(19414) DEBUG: <core> [select.c:424]: Calling SELECT 0xb737ebf43(19414) DEBUG: <core> [select.c:424]: Calling SELECT 0xb7384bd03(19414) DEBUG: <core> [select.c:424]: Calling SELECT 0xb7385ef03(19414) DEBUG: <core> [select.c:424]: Calling SELECT 0xb73872b43(19414) DEBUG: tm [uac.c:243]: DEBUG:tm:t_uac: next_hop=<sip:192.168.1.9:5080>3(19414) DEBUG: tm [uac.c:182]: DEBUG: dlg2hash: 273783(19414) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list 0xb35d23883(19414) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)3(19414) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)3(19414) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)3(19414) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)3(19414) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)3(19414) DEBUG: <core> [xavp.c:365]: destroying xavp list (nil)3(19414) DEBUG: <core> [receive.c:291]: receive_msg: cleaning up4(19415) DEBUG: <core> [parser/msg_parser.c:638]: SIP Reply (status):4(19415) DEBUG: <core> [parser/msg_parser.c:640]: version: <SIP/2.0>4(19415) DEBUG: <core> [parser/msg_parser.c:642]: status: <200>4(19415) DEBUG: <core> [parser/msg_parser.c:644]: reason: <OK>4(19415) DEBUG: <core> [parser/parse_via.c:1288]: Found param type 232, <branch> = <z9hG4bK2fa6.37c16006.0>; state=64(19415) DEBUG: <core> [parser/parse_via.c:1288]: Found param type 234, <received> = <192.168.1.9>; state=164(19415) DEBUG: <core> [parser/parse_via.c:2563]: end of header reached, state=54(19415) DEBUG: <core> [parser/msg_parser.c:515]: parse_headers: Via found, flags=24(19415) DEBUG: <core> [parser/msg_parser.c:517]: parse_headers: this is the first via4(19415) DEBUG: <core> [receive.c:147]: After parse_msg...4(19415) DEBUG: tm [t_lookup.c:1079]: DEBUG: t_check_msg: msg id=3 global id=2 T start=(nil)4(19415) DEBUG: <core> [parser/parse_to.c:177]: DEBUG: add_param: tag=as50edab1b4(19415) DEBUG: <core> [parser/parse_to.c:801]: end of header reached, state=294(19415) DEBUG: <core> [parser/msg_parser.c:187]: DEBUG: get_hdr_field: <To> [36]; uri=[sip:103@192.168.1.9]4(19415) DEBUG: <core> [parser/msg_parser.c:189]: DEBUG: to body [sip:103@192.168.1.9]4(19415) DEBUG: <core> [parser/msg_parser.c:167]: get_hdr_field: cseq <CSeq>: <10> <REGISTER>4(19415) DEBUG: tm [t_lookup.c:965]: DEBUG: t_reply_matching: hash 27378 label 1611013235 branch 04(19415) DEBUG: tm [t_lookup.c:1016]: DEBUG: t_reply_matching: reply matched (T=0xb35cfc68)!4(19415) DEBUG: tm [t_lookup.c:1148]: DEBUG: t_check_msg: msg id=3 global id=3 T end=0xb35cfc684(19415) DEBUG: tm [t_reply.c:2053]: DEBUG: reply_received: org. status uas=0, uac[0]=0 local=2 is_invite=0)4(19415) DEBUG: tm [t_reply.c:1168]: ->>>>>>>>> T_code=0, new_code=2004(19415) DEBUG: tm [t_reply.c:1931]: DEBUG: local_reply: branch=0, save=0, winner=04(19415) DEBUG: tm [t_reply.c:1968]: DEBUG: local transaction completed4(19415) DEBUG: tm [t_reply.c:1509]: DEBUG: cleanup_uac_timers: RETR/FR timers reset4(19415) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)4(19415) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)4(19415) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)4(19415) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)4(19415) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)4(19415) DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)4(19415) DEBUG: <core> [xavp.c:365]: destroying xavp list (nil)4(19415) DEBUG: <core> [receive.c:291]: receive_msg: cleaning up13(19429) DEBUG: <core> [io_wait.h:617]: DBG: io_watch_del (0x82831e0, 11, -1, 0x10) fd_no=2 called13(19429) DEBUG: <core> [tcp_read.c:1089]: releasing con 0xb35bc370, state 1, fd=11, id=213(19429) DEBUG: <core> [tcp_read.c:1090]: extra_data 0xb35b9b5016(19433) DEBUG: <core> [tcp_main.c:3345]: handle_tcp_child: reader response= b35bc370, 1 from 116(19433) DEBUG: <core> [io_wait.h:390]: DBG: io_watch_add(0x8260fa0, 31, 2, 0xb35bc370), fd_no=2016(19433) DEBUG: <core> [tcp_main.c:3475]: handle_tcp_child: CONN_RELEASE 0xb35bc370 refcnt= 11(19412) DEBUG: <core> [udp_server.c:498]: udp_rcv_loop: probing packet received from 192.168.1.16 501952(19413) DEBUG: <core> [parser/msg_parser.c:628]: SIP Request:2(19413) DEBUG: <core> [parser/msg_parser.c:630]: method: <INVITE>2(19413) DEBUG: <core> [parser/msg_parser.c:632]: uri: <sip:102@sip.wtz.local>2(19413) DEBUG: <core> [parser/msg_parser.c:634]: version: <SIP/2.0>2(19413) DEBUG: <core> [parser/parse_via.c:1288]: Found param type 235, <rport> = <n/a>; state=62(19413) DEBUG: <core> [parser/parse_via.c:1288]: Found param type 232, <branch> = <z9hG4bKPj4ce735389e3f4d8aaa1a4891c1ec15a5>; state=162(19413) DEBUG: <core> [parser/parse_via.c:2563]: end of header reached, state=52(19413) DEBUG: <core> [parser/msg_parser.c:515]: parse_headers: Via found, flags=22(19413) DEBUG: <core> [parser/msg_parser.c:517]: parse_headers: this is the first via2(19413) DEBUG: <core> [receive.c:147]: After parse_msg...2(19413) DEBUG: <core> [receive.c:188]: preparing to run routing scripts...2(19413) DEBUG: <core> [parser/parse_to.c:177]: DEBUG: add_param: tag=b84abd4ec1314a7aae8acc436dc7e4a32(19413) DEBUG: <core> [parser/parse_to.c:801]: end of header reached, state=292(19413) DEBUG: <core> [parser/parse_to.c:801]: end of header reached, state=102(19413) DEBUG: <core> [parser/msg_parser.c:187]: DEBUG: get_hdr_field: <To> [25]; uri=[sip:102@sip.wtz.local]2(19413) DEBUG: <core> [parser/msg_parser.c:189]: DEBUG: to body [<sip:102@sip.wtz.local>]2(19413) DEBUG: <core> [parser/msg_parser.c:167]: get_hdr_field: cseq <CSeq>: <11479> <INVITE>2(19413) DEBUG: <core> [parser/msg_parser.c:201]: DEBUG: get_hdr_body : content_length=6562(19413) DEBUG: <core> [parser/msg_parser.c:103]: found end of header2(19413) DEBUG: <core> [parser/sdp/sdp_helpr_funcs.c:493]: located IP address [172.16.0.12] in `o=' field2(19413) DEBUG: <core> [parser/sdp/sdp_helpr_funcs.c:493]: located IP address [172.16.0.12] in `c=' field2(19413) DEBUG: <core> [parser/sdp/sdp_helpr_funcs.c:493]: located IP address [172.16.0.12] in `c=' field2(19413) DEBUG: sdpops [sdpops_mod.c:657]: attempting to search for media type: [audio]2(19413) DEBUG: sdpops [sdpops_mod.c:679]: stream 0 of 0 - media [audio]2(19413) DEBUG: sdpops [sdpops_mod.c:685]: removing media stream: audio16(19433) : <core> [pass_fd.c:293]: ERROR: receive_fd: EOF on 1116(19433) DEBUG: <core> [tcp_main.c:3555]: DBG: handle_ser_child: dead child 2, pid 19413 (shutting down?)16(19433) DEBUG: <core> [io_wait.h:617]: DBG: io_watch_del (0x8260fa0, 11, -1, 0x0) fd_no=21 called0(19411) ALERT: <core> [main.c:751]: child process 19413 exited by a signal 110(19411) ALERT: <core> [main.c:754]: core was not generated0(19411) INFO: <core> [main.c:766]: INFO: terminating due to SIGCHLD9(19424) INFO: <core> [main.c:817]: INFO: signal 15 received10(19425) INFO: <core> [main.c:817]: INFO: signal 15 received11(19426) INFO: <core> [main.c:817]: INFO: signal 15 received13(19429) INFO: <core> [main.c:817]: INFO: signal 15 received5(19416) INFO: <core> [main.c:817]: INFO: signal 15 received15(19432) INFO: <core> [main.c:817]: INFO: signal 15 received12(19428) INFO: <core> [main.c:817]: INFO: signal 15 received7(19418) INFO: <core> [main.c:817]: INFO: signal 15 received3(19414) INFO: <core> [main.c:817]: INFO: signal 15 received16(19433) INFO: <core> [main.c:817]: INFO: signal 15 received1(19412) INFO: <core> [main.c:817]: INFO: signal 15 received4(19415) INFO: <core> [main.c:817]: INFO: signal 15 received14(19430) INFO: <core> [main.c:817]: INFO: signal 15 received8(19423) INFO: <core> [main.c:817]: INFO: signal 15 received6(19417) INFO: <core> [main.c:817]: INFO: signal 15 received0(19411) ERROR: ctl [ctl.c:379]: ERROR: ctl: could not delete unix socket /tmp/kamailio_ctl: Operation not permitted (1)0(19411) DEBUG: <core> [db_pool.c:102]: removing connection from the pool0(19411) DEBUG: tm [t_funcs.c:122]: DEBUG: tm_shutdown : start0(19411) DEBUG: tm [t_funcs.c:125]: DEBUG: tm_shutdown : emptying hash table0(19411) DEBUG: tm [t_funcs.c:127]: DEBUG: tm_shutdown : removing semaphores0(19411) DEBUG: tm [t_funcs.c:129]: DEBUG: tm_shutdown : destroying tmcb lists0(19411) DEBUG: tm [t_funcs.c:132]: DEBUG: tm_shutdown : done0(19411) DEBUG: tls [tls_init.c:674]: tls module final tls destroy0(19411) DEBUG: <core> [mem/shm_mem.c:242]: shm_mem_destroy0(19411) DEBUG: <core> [mem/shm_mem.c:245]: destroying the shared memory lock0(19411) DEBUG: <core> [main.c:770]: terminating due to SIGCHLD2012/6/11 Daniel-Constantin Mierla <miconda@gmail.com>Hello,it should work in that route if it's a request with SDP. Can you send the ngrep of such SIP message along with log messages when debug=3 in your config?
On 6/11/12 3:19 PM, Grégoire Vandendeurpel wrote:
Hello,
I'm using Kamailio 3.2.3 and SDPOPS module.
I just have a question about the configuration:
What do you mean by "ANY_ROUTE" in configuration ??
Cause I don't know where in the configuration , I have to use the differents functions of SDPOPS.
If I do something like this:
request_route {
if ($fU == "103") {
sdp_remove_codecs_by_id("0,3,8");
#sdp_remove_media("audio");
}
It does not work .
So please help me about where I have to put this in??
Cheers,
Daniel
--
Daniel-Constantin Mierla - http://www.asipto.com
http://twitter.com/#!/miconda - http://www.linkedin.com/in/miconda
Kamailio Advanced Training, Seattle, USA, Sep 23-26, 2012 - http://asipto.com/u/katu
Kamailio Practical Workshop, Netherlands, Sep 10-12, 2012 - http://asipto.com/u/kpw
--Grégoire Vandendeurpel,IT Sector