[OpenSIPS-Users] Trying to change the $ru to an address in location

Mike Tesliuk mike at ultra.net.br
Thu Sep 26 05:09:35 CEST 2013


Ok, the problem is caused by an engage_rtp_proxy() , i remove this options
and everything seems to work now.


2013/9/25 Mike Tesliuk <mike at ultra.net.br>

> I dont know exactly why ( im trying to find this why ), if i after check
> te $ru immediatly call the lookup , and send to the relay the package reach
> the destination , i will now investigate which rule cause the problem.
>
> if you guys find something on the log that i send please tell me
>
>
> 2013/9/25 Mike Tesliuk <mike at ultra.net.br>
>
>> Hello Vlad, first of all thanks for your reply .
>>
>>
>> Below some information that i hope you can check , in advice i say that
>> the package dont go out from opensips, i see on the debug, but i dont see
>> the package on my router (near opensips)
>>
>> i change the ip address information below to this
>>
>>
>>
>> ___ASTERISK___DESTINATION___ = the final destination of the call
>>
>> ____OPENSIPS___IP___ = the opensips ip address
>>
>> ___ASTERISK_ORIGINATE____ = the asterisk that originate the call to
>> opensips
>>
>>
>>
>> Just to remember the case, i receive on opensips a call  did at opensips_ip, i check everything , and change the $ru to account at opensips_ip
>> and send to lookup(location), the user was find and the send to t_relay
>>
>> I will apreciate a lot if you or someone else can check the logs below
>> because i can't figure out why this is not working, i dont see any relevant
>> message on log about the packege, everything seems to be executed, the only
>> strange thing that i check is this information (
>>
>> Sep 25 21:22:19 [25420] DBG:tm:matching_3261: RFC3261 transaction
>> matching failed
>> Sep 25 21:22:19 [25420] DBG:tm:t_lookup_request: no transaction found
>> Sep 25 21:22:19 [25420] DBG:tm:run_reqin_callbacks: trans=0x7fd613156710,
>> callback type 1, id 2 entered
>> Sep 25 21:22:19 [25420] DBG:core:parse_headers: flags=78
>> Sep 25 21:22:19 [25420] DBG:dialog:new_dlg_val: inserting
>> <accX_created>=<K?CR>
>> Sep 25 21:22:19 [25420] DBG:rr:is_direction: param ftag not found
>>
>>
>> )
>>
>>
>> im using for this test an opensips 1.9.1
>>
>>
>> thanks in advice for any help that you guys can provide.
>>
>>
>>
>> opensipsctl ul show
>>
>> Domain:: location table=512 records=1
>>     AOR:: 055011395010100000
>>         Contact:: sip:s at ___ASTERISK___DESTINATION___:5060 Q=
>>             Expires:: 94
>>             Callid:: 2dd8bd5d6570d1a47caa8ec67ae4197b@
>> ___ASTERISK___DESTINATION___
>>             Cseq:: 103
>>             User-agent:: PBXUltranet
>>
>>             State:: CS_SYNC
>>             Flags:: 0
>>             Cflag:: 0
>>             Socket:: udp:____OPENSIPS___IP___:5060
>>             Methods:: 4294967295
>>
>>
>>
>> iptables -L -n
>>
>> Chain INPUT (policy ACCEPT)
>> target     prot opt source               destination
>>
>> Chain FORWARD (policy ACCEPT)
>> target     prot opt source               destination
>>
>> Chain OUTPUT (policy ACCEPT)
>> target     prot opt source               destination
>>
>>
>>
>>
>> ----- tcpdump on opensips ------
>>
>>
>> 21:17:51.194560 16:44:c7:4e:35:2d > 00:30:48:94:6d:b6, ethertype IPv4
>> (0x0800), length 1261: (tos 0x10, ttl 64, id 0, offset 0, flags [DF], proto
>> UDP (17), length 1247)
>>     ____OPENSIPS___IP___.5060 > ___ASTERISK___DESTINATION___.5060: [bad
>> udp cksum fe56!] SIP, length: 1219
>>     INVITE sip:s at ___ASTERISK___DESTINATION___:5060 SIP/2.0
>>
>>
>>
>>
>> on my router i don't see any package, on the debug i have the result below
>>
>>
>>
>> Sep 25 21:22:19 [25420] DBG:core:parse_msg: SIP Request:
>> Sep 25 21:22:19 [25420] DBG:core:parse_msg:  method:  <INVITE>
>> Sep 25 21:22:19 [25420] DBG:core:parse_msg:  uri:     <sip:551133992377@
>> ____OPENSIPS___IP___>
>> Sep 25 21:22:19 [25420] DBG:core:parse_msg:  version: <SIP/2.0>
>> Sep 25 21:22:19 [25420] DBG:core:parse_headers: flags=2
>> Sep 25 21:22:19 [25420] DBG:core:parse_via_param: found param type 232,
>> <branch> = <z9hG4bK2b4132f9>; state=6
>> Sep 25 21:22:19 [25420] DBG:core:parse_via_param: found param type 235,
>> <rport> = <n/a>; state=17
>> Sep 25 21:22:19 [25420] DBG:core:parse_via: end of header reached, state=5
>> Sep 25 21:22:19 [25420] DBG:core:parse_headers: via found, flags=2
>> Sep 25 21:22:19 [25420] DBG:core:parse_headers: this is the first via
>> Sep 25 21:22:19 [25420] DBG:core:receive_msg: After parse_msg...
>> Sep 25 21:22:19 [25420] DBG:core:receive_msg: preparing to run routing
>> scripts...
>> Sep 25 21:22:19 [25420] DBG:core:parse_headers: flags=ffffffffffffffff
>> Sep 25 21:22:19 [25420] DBG:core:parse_to: end of header reached, state=10
>> Sep 25 21:22:19 [25420] DBG:core:parse_to: display={},
>> ruri={sip:551133992377 at ____OPENSIPS___IP___}
>> Sep 25 21:22:19 [25420] DBG:core:get_hdr_field: <To> [32];
>> uri=[sip:551133992377 at ____OPENSIPS___IP___]
>> Sep 25 21:22:19 [25420] DBG:core:get_hdr_field: to body
>> [<sip:551133992377 at ____OPENSIPS___IP___>
>> ]
>> Sep 25 21:22:19 [25420] DBG:core:get_hdr_field: cseq <CSeq>: <102>
>> <INVITE>
>> Sep 25 21:22:19 [25420] DBG:core:get_hdr_field: content_length=396
>> Sep 25 21:22:19 [25420] DBG:core:get_hdr_field: found end of header
>> Sep 25 21:22:19 [25420] DBG:core:decode_mime_type: Decoding MIME type
>> for:[application/sdp]
>> Sep 25 21:22:19 [25420] DBG:maxfwd:is_maxfwd_present: value = 70
>> Sep 25 21:22:19 [25420] DBG:uri:has_totag: no totag
>> Sep 25 21:22:19 [25420] DBG:core:parse_headers: flags=78
>> Sep 25 21:22:19 [25420] DBG:tm:t_lookup_request: start searching:
>> hash=21685, isACK=0
>> Sep 25 21:22:19 [25420] DBG:tm:matching_3261: RFC3261 transaction
>> matching failed
>> Sep 25 21:22:19 [25420] DBG:tm:t_lookup_request: no transaction found
>> Sep 25 21:22:19 [25420] DBG:permissions:check_src_addr_3: Looking for :
>> <99, ___ASTERISK_ORIGINATE____, 5060, 1> in tables
>> Sep 25 21:22:19 [25420] DBG:permissions:hash_match: no pattern to match
>> Sep 25 21:22:19 [25420] DBG:permissions:hash_match: match found in the
>> hash table
>> Sep 25 21:22:19 [25420] DBG:core:buf_init: initializing...
>> Chamada de entrada oriunda de ___ASTERISK_ORIGINATE____ para
>> 551133992377Sep 25 21:22:19 [25420] DBG:avpops:ops_dbquery_avps: query
>> [SELECT master,concurrency,dst FROM did WHERE did = '551133992377']
>> Sep 25 21:22:19 [25420] DBG:db_mysql:mysql_raise_event: MySQL status has
>> not changed: connected
>> Sep 25 21:22:19 [25420] DBG:core:db_new_result: allocate 48 bytes for
>> result set at 0x7fd61fcc8328
>> Sep 25 21:22:19 [25420] DBG:db_mysql:db_mysql_get_columns: 3 columns
>> returned from the query
>> Sep 25 21:22:19 [25420] DBG:core:db_allocate_columns: allocate 84 bytes
>> for result columns at 0x7fd61fcc93d0
>> Sep 25 21:22:19 [25420] DBG:db_mysql:db_mysql_get_columns:
>> RES_NAMES(0x7fd61fcc93e8)[0]=[master]
>> Sep 25 21:22:19 [25420] DBG:db_mysql:db_mysql_get_columns: use DB_STRING
>> result type
>> Sep 25 21:22:19 [25420] DBG:db_mysql:db_mysql_get_columns:
>> RES_NAMES(0x7fd61fcc93f8)[1]=[concurrency]
>> Sep 25 21:22:19 [25420] DBG:db_mysql:db_mysql_get_columns: use DB_INT
>> result type
>> Sep 25 21:22:19 [25420] DBG:db_mysql:db_mysql_get_columns:
>> RES_NAMES(0x7fd61fcc9408)[2]=[dst]
>> Sep 25 21:22:19 [25420] DBG:db_mysql:db_mysql_get_columns: use DB_STRING
>> result type
>> Sep 25 21:22:19 [25420] DBG:core:db_allocate_rows: allocate 112 bytes for
>> result rows and values at 0x7fd61fcc9440
>> Sep 25 21:22:19 [25420] DBG:db_mysql:db_mysql_str2val: converting STRING
>> [055011395010100000]
>> Sep 25 21:22:19 [25420] DBG:db_mysql:db_mysql_str2val: converting INT [1]
>> Sep 25 21:22:19 [25420] DBG:db_mysql:db_mysql_str2val: converting STRING
>> []
>> Sep 25 21:22:19 [25420] DBG:avpops:db_query_avp: rows [1]
>> Sep 25 21:22:19 [25420] DBG:avpops:db_query_avp: row [0]
>> Sep 25 21:22:19 [25420] DBG:avpops:db_close_query: close avp query
>> Sep 25 21:22:19 [25420] DBG:core:db_free_columns: freeing result columns
>> at 0x7fd61fcc93d0
>> Sep 25 21:22:19 [25420] DBG:core:db_free_rows: freeing 1 rows
>> Sep 25 21:22:19 [25420] DBG:core:db_free_row: freeing row values at
>> 0x7fd61fcc9450
>> Sep 25 21:22:19 [25420] DBG:core:db_free_rows: freeing rows at
>> 0x7fd61fcc9440
>> Sep 25 21:22:19 [25420] DBG:core:db_free_result: freeing result set at
>> 0x7fd61fcc8328
>> Did encontrado, seguindo regras para utilizacao em locationNovo destino
>> sip:055011395010100000 at ____OPENSIPS___IP___:5060Sep 25 21:22:19 [25420]
>> DBG:core:parse_headers: flags=200
>> Sep 25 21:22:19 [25420] DBG:rr:find_first_route: No Route headers found
>> Sep 25 21:22:19 [25420] DBG:rr:loose_route: There is no Route HF
>> Sep 25 21:22:19 [25420] DBG:core:parse_to_param: tag=as12dd45c8
>> Sep 25 21:22:19 [25420] DBG:core:parse_to: end of header reached, state=29
>> Sep 25 21:22:19 [25420] DBG:core:parse_to: display={"testemike"},
>> ruri={sip:testemike at ___ASTERISK_ORIGINATE____}
>> Sep 25 21:22:19 [25420] DBG:rtpproxy:engage_rtp_proxy2_f: engage called
>> from script
>> Sep 25 21:22:19 [25420] DBG:dialog:build_new_dlg: new dialog
>> 0x7fd61314a418 (c=481350dc261b4c297700ab3c51395c55@
>> ___ASTERISK_ORIGINATE____:5060,f=sip:testemike@
>> ___ASTERISK_ORIGINATE____,t=sip:551133992377 at ____OPENSIPS___IP___,ft=as12dd45c8)
>> on hash 1509
>> Sep 25 21:22:19 [25420] DBG:core:parse_headers: flags=ffffffffffffffff
>> Sep 25 21:22:19 [25420] DBG:dialog:init_leg_info: route_set , contact
>> sip:testemike at ___ASTERISK_ORIGINATE____:5060, cseq 102 and bind_addr
>> udp:____OPENSIPS___IP___:5060
>> Sep 25 21:22:19 [25420] DBG:dialog:dlg_add_leg_info: set leg 0 for
>> 0x7fd61314a418: tag=<as12dd45c8> rcseq=<0>
>> Sep 25 21:22:19 [25420] DBG:dialog:link_dlg: ref dlg 0x7fd61314a418 with
>> 4 -> 4 in h_entry 0x7fd613131f78 - 1509
>> Sep 25 21:22:19 [25420] DBG:rr:add_rr_param: adding (;did=5e5.91711eb7)
>> 0x7fd61fcc98d8
>> Sep 25 21:22:19 [25420] DBG:core:parse_headers: flags=2000
>> Sep 25 21:22:19 [25420] DBG:rtpproxy:engage_rtp_proxy2_f: message has sdp
>> body -> forcing rtp proxy
>> Sep 25 21:22:19 [25420] DBG:rtpproxy:force_rtp_proxy: force rtp proxy
>> with param1 <> and param2 <none>
>> Sep 25 21:22:19 [25420] DBG:core:parse_headers: flags=40
>> Sep 25 21:22:19 [25420] DBG:rtpproxy:force_rtp_proxy: Forcing body:
>> [v=0
>> o=root 1965651698 1965651698 IN IP4 ___ASTERISK_ORIGINATE____
>> s=SDP.Ultranet
>> c=IN IP4 ___ASTERISK_ORIGINATE____
>> t=0 0
>> m=audio 12566 RTP/AVP 8 0 3 111 97 18 101
>> a=rtpmap:8 PCMA/8000
>> a=rtpmap:0 PCMU/8000
>> a=rtpmap:3 GSM/8000
>> a=rtpmap:111 G726-32/8000
>> a=rtpmap:97 iLBC/8000
>> a=fmtp:97 mode=30
>> a=rtpmap:18 G729/8000
>> a=fmtp:18 annexb=no
>> a=rtpmap:101 telephone-event/8000
>> a=fmtp:101 0-16
>> a=ptime:20
>> a=sendrecv
>> ]
>> Sep 25 21:22:19 [25420] DBG:rtpproxy:force_rtp_proxy_body: proxy reply:
>> 39410 ____OPENSIPS___IP___
>>
>> Sep 25 21:22:19 [25420] DBG:dialog:new_dlg_val: inserting <rtpproxy_1>=<>
>> Sep 25 21:22:19 [25420] DBG:rtpproxy:engage_rtp_proxy2_f: stored values
>> in dialog
>> Sep 25 21:22:19 [25420] DBG:rtpproxy:engage_rtp_proxy2_f: registered
>> engage_callback
>> Sep 25 21:22:19 [25420] DBG:core:grep_sock_info: checking if host==us:
>> 11==11 &&  [____OPENSIPS___IP___] == [____OPENSIPS___IP___]
>> Sep 25 21:22:19 [25420] DBG:core:grep_sock_info: checking if port 5060
>> matches port 5060
>> Sep 25 21:22:19 [25420] DBG:core:comp_scriptvar: int 20 : 0 / 1
>> Verificando locationSep 25 21:22:19 [25420] DBG:registrar:lookup: found a
>> complete match
>> Sep 25 21:22:19 [25420] DBG:registrar:lookup: setting as ruri <sip:s@
>> ___ASTERISK___DESTINATION___:5060>
>> Sep 25 21:22:19 [25420] DBG:registrar:lookup: looking for branches
>> Sep 25 21:22:19 [25420] DBG:rtpproxy:force_rtp_proxy: force rtp proxy
>> with param1 <(null)> and param2 <none>
>> Sep 25 21:22:19 [25420] DBG:core:parse_headers: flags=40
>> Sep 25 21:22:19 [25420] DBG:rtpproxy:force_rtp_proxy: Forcing body:
>> [v=0
>> o=root 1965651698 1965651698 IN IP4 ___ASTERISK_ORIGINATE____
>> s=SDP.Ultranet
>> c=IN IP4 ___ASTERISK_ORIGINATE____
>> t=0 0
>> m=audio 12566 RTP/AVP 8 0 3 111 97 18 101
>> a=rtpmap:8 PCMA/8000
>> a=rtpmap:0 PCMU/8000
>> a=rtpmap:3 GSM/8000
>> a=rtpmap:111 G726-32/8000
>> a=rtpmap:97 iLBC/8000
>> a=fmtp:97 mode=30
>> a=rtpmap:18 G729/8000
>> a=fmtp:18 annexb=no
>> a=rtpmap:101 telephone-event/8000
>> a=fmtp:101 0-16
>> a=ptime:20
>> a=sendrecv
>> ]
>> Sep 25 21:22:19 [25420] DBG:rtpproxy:force_rtp_proxy_body: proxy reply:
>> 39410 ____OPENSIPS___IP___
>>
>> Sep 25 21:22:19 [25420] DBG:rr:add_rr_param: adding (;nat=yes)
>> 0x7fd61fcc9de8
>> Sep 25 21:22:19 [25420] DBG:core:pv_get_dsturi: no destination URI
>> Fazendo relay <null> - sip:s at ___ASTERISK___DESTINATION___:5060Sep 25
>> 21:22:19 [25420] DBG:tm:t_newtran: transaction on entrance=(nil)
>> Sep 25 21:22:19 [25420] DBG:core:parse_headers: flags=ffffffffffffffff
>> Sep 25 21:22:19 [25420] DBG:core:parse_headers: flags=78
>> Sep 25 21:22:19 [25420] DBG:tm:t_lookup_request: start searching:
>> hash=21685, isACK=0
>> Sep 25 21:22:19 [25420] DBG:tm:matching_3261: RFC3261 transaction
>> matching failed
>> Sep 25 21:22:19 [25420] DBG:tm:t_lookup_request: no transaction found
>> Sep 25 21:22:19 [25420] DBG:tm:run_reqin_callbacks: trans=0x7fd613156710,
>> callback type 1, id 2 entered
>> Sep 25 21:22:19 [25420] DBG:core:parse_headers: flags=78
>> Sep 25 21:22:19 [25420] DBG:dialog:new_dlg_val: inserting
>> <accX_created>=<K?CR>
>> Sep 25 21:22:19 [25420] DBG:rr:is_direction: param ftag not found
>> Sep 25 21:22:19 [25420] DBG:tm:run_reqin_callbacks: trans=0x7fd613156710,
>> callback type 1, id 1 entered
>> Sep 25 21:22:19 [25420] DBG:siptrace:trace_onreq_in: trace off...
>> Sep 25 21:22:19 [25420] DBG:tm:run_reqin_callbacks: trans=0x7fd613156710,
>> callback type 1, id 0 entered
>> Sep 25 21:22:19 [25420] DBG:dialog:dlg_onreq: t hash_index = 21685, t
>> label = 931045251
>> Sep 25 21:22:19 [25420] DBG:dialog:get_dlg_timeout: invalid AVP value,
>> use default timeout
>> Sep 25 21:22:19 [25420] DBG:core:parse_headers: flags=ffffffffffffffff
>> Sep 25 21:22:19 [25420] DBG:core:_shm_resize: resize(0) called
>> Sep 25 21:22:19 [25420] DBG:tm:_reply_light: reply sent out.
>> buf=0x7fd61fcca4f0: SIP/2.0 1..., shmem=0x7fd61315a0d0: SIP/2.0 1
>> Sep 25 21:22:19 [25420] DBG:tm:_reply_light: finished
>> Nova perna criada sip:s at ___ASTERISK___DESTINATION___:5060Sep 25 21:22:19
>> [25420] DBG:core:mk_proxy: doing DNS lookup...
>> Sep 25 21:22:19 [25420] DBG:core:parse_headers: flags=2000
>> Sep 25 21:22:19 [25420] DBG:core:parse_headers: flags=ffffffffffffffff
>> Sep 25 21:22:19 [25420] DBG:core:clen_builder: content-length: 448 (448)
>> Sep 25 21:22:19 [25420] DBG:tm:set_timer: relative timeout is 500000
>> Sep 25 21:22:19 [25420] DBG:tm:insert_timer_unsafe: [4]: 0x7fd613156930
>> (10600000)
>> Sep 25 21:22:19 [25420] DBG:tm:set_timer: relative timeout is 5
>> Sep 25 21:22:19 [25420] DBG:tm:insert_timer_unsafe: [0]: 0x7fd613156960
>> (15)
>> Sep 25 21:22:19 [25420] DBG:tm:t_relay_to: new transaction fwd'ed
>> Sep 25 21:22:19 [25420] DBG:tm:t_unref: UNREF_UNSAFE: [0x7fd613156710]
>> after is 0
>> Sep 25 21:22:19 [25420] DBG:dialog:unref_dlg: unref dlg 0x7fd61314a418
>> with 1 -> 3 in entry 0x7fd613131f78
>> Sep 25 21:22:19 [25420] DBG:core:destroy_avp_list: destroying list (nil)
>> Sep 25 21:22:19 [25420] DBG:core:receive_msg: cleaning up
>> Sep 25 21:22:19 [25423] DBG:tm:utimer_routine: timer
>> routine:4,tl=0x7fd613156930 next=(nil), timeout=10600000
>> Sep 25 21:22:19 [25423] DBG:tm:retransmission_handler:
>> retransmission_handler : request resending (t=0x7fd613156710, INVITE si ...
>> )
>> Sep 25 21:22:19 [25423] DBG:tm:set_timer: relative timeout is 1000000
>> Sep 25 21:22:19 [25423] DBG:tm:insert_timer_unsafe: [5]: 0x7fd613156930
>> (11600000)
>> Sep 25 21:22:19 [25423] DBG:tm:retransmission_handler:
>> retransmission_handler : done
>> Sep 25 21:22:20 [25423] DBG:tm:utimer_routine: timer
>> routine:5,tl=0x7fd613156930 next=(nil), timeout=11600000
>> Sep 25 21:22:20 [25423] DBG:tm:retransmission_handler:
>> retransmission_handler : request resending (t=0x7fd613156710, INVITE si ...
>> )
>> Sep 25 21:22:20 [25423] DBG:tm:set_timer: relative timeout is 2000000
>> Sep 25 21:22:20 [25423] DBG:tm:insert_timer_unsafe: [6]: 0x7fd613156930
>> (13600000)
>> Sep 25 21:22:20 [25423] DBG:tm:retransmission_handler:
>> retransmission_handler : done
>> Sep 25 21:22:23 [25423] DBG:tm:utimer_routine: timer
>> routine:6,tl=0x7fd613156930 next=(nil), timeout=13600000
>> Sep 25 21:22:23 [25423] DBG:tm:retransmission_handler:
>> retransmission_handler : request resending (t=0x7fd613156710, INVITE si ...
>> )
>> Sep 25 21:22:23 [25423] DBG:tm:set_timer: relative timeout is 4000000
>> Sep 25 21:22:23 [25423] DBG:tm:insert_timer_unsafe: [7]: 0x7fd613156930
>> (17600000)
>> Sep 25 21:22:23 [25423] DBG:tm:retransmission_handler:
>> retransmission_handler : done
>> Sep 25 21:22:25 [25423] DBG:tm:timer_routine: timer
>> routine:0,tl=0x7fd613156960 next=(nil), timeout=15
>> Sep 25 21:22:25 [25423] DBG:tm:final_response_handler: Cancel sent out,
>> sending 408 (0x7fd613156710)
>> Sep 25 21:22:25 [25423] DBG:tm:t_should_relay_response: T_code=100,
>> new_code=408
>> Sep 25 21:22:25 [25423] DBG:tm:t_pick_branch: picked branch 0, code 408
>> (prio=800)
>> Sep 25 21:22:25 [25423] DBG:tm:is_3263_failure: dns-failover test:
>> branch=0, last_recv=408, flags=1
>> Sep 25 21:22:25 [25423] DBG:tm:t_should_relay_response: trying DNS-based
>> failover
>> Sep 25 21:22:25 [25423] DBG:tm:run_trans_callbacks: trans=0x7fd613156710,
>> callback type 32, id 2 entered
>>
>>
>>
>>
>> 2013/9/25 Vlad Paiu <vladpaiu at opensips.org>
>>
>>>  Hello,
>>>
>>> The approach you're taking seems good, and it should definitely work.
>>>
>>> Do you receive any errors in the OpenSIPS logs ? If you make a SIP trace
>>> ( ngrep / tcpdump ) on the OpenSIPS machine, do you see the INVITE message
>>> getting out of OpenSIPS ?
>>>
>>> If you don't see the package being sent out even on the OpenSIPS
>>> machine, then it means that somehow your script doesn't forward that
>>> request, but drops it ( because ngrep on the OpenSIPS machine excludes any
>>> firewall issues - ngrep gets in even before the local iptables output chain
>>> ).
>>>
>>> Best Regards,
>>>
>>> Vlad Paiu
>>> OpenSIPS Developerhttp://www.opensips-solutions.com
>>>
>>> On 25.09.2013 15:36, Mike Tesliuk wrote:
>>>
>>>  Somebody have at least an idea if this is suposed to work ?
>>>
>>>  the package come to me, i check the did, change the $ru, and send to
>>> the location, the location find the user and the package dont reach the
>>> other side.
>>>
>>>  Thanks
>>>
>>>
>>> 2013/9/22 Mike Tesliuk <mike at ultra.net.br>
>>>
>>>>    Hello Guys,
>>>>
>>>>
>>>> Im trying to implement a system to manipulate DID's, the forward for
>>>> external address is ok, but in trying now to do the same with  a user that
>>>> is registered
>>>>
>>>>
>>>>  i create a new table where i have the did, the account and the
>>>> destination, if the destination is null so the opensips will check the
>>>> account on the location table.
>>>>
>>>>  basically i have this
>>>>
>>>> if(!$avp(91)){
>>>>                                         xlog("Did nao encontrado");
>>>>                                         sl_send_reply("404", "Not
>>>> Found");
>>>>                                         exit;
>>>>                                 }else{
>>>>                                         xlog("Did encontrado, seguindo
>>>> regras para utilizacao em location");
>>>>                                         $ru = "sip:" + $avp(91) +
>>>> "@IP_ADDRESS:5060";
>>>>                                         xlog("Novo destino $ru");
>>>>                                 }
>>>>
>>>>
>>>>  the avp(91) is the user account, the same that the user use to register
>>>>
>>>>
>>>>  when in this situation, the call go trouhg the location module, and
>>>> the system find the correct address.
>>>>
>>>>  i have on the log the same information that i have on opensipsctl ul
>>>> show
>>>>
>>>> Fazendo relay <null> - sip:055011395010100000 at IP_ADDR
>>>> :5081;rinstance=0f9054bc313f0cf1;transport=UDP
>>>>
>>>>
>>>>  below the output from ul show
>>>>
>>>>     AOR:: 055011395010100000
>>>>         Contact:: sip:055011395010100000 at IP_ADDR:5081;rinstance=0f9054bc313f0cf1;transport=UDP
>>>> Q=
>>>>             Expires:: 525
>>>>             Callid:: MTZhNzE1ZDYzYWU4Y2ViZDMzZTQzZWU1N2M0ZGFiZjQ.
>>>>             Cseq:: 2
>>>>             User-agent:: Zoiper Communicator 2.04.10164 rev.10204
>>>>             State:: CS_SYNC
>>>>             Flags:: 0
>>>>             Cflag:: 0
>>>>             Socket:: udp:GW_IP_ADDR:5060
>>>>             Methods:: 5951
>>>>
>>>>
>>>>
>>>>  But when i make the call, the ngrep show me the send of the invite,
>>>> but i dont see nothing on the other side.
>>>>
>>>>
>>>>  Below you have the invite
>>>>
>>>> U GW_IP_ADDR:5060 -> CUSTOMER_IP_ADDR:5081
>>>> INVITE sip:055011395010100000 at CUSTOMER_IP_ADDR:5081;rinstance=0f9054bc313f0cf1;transport=UDP
>>>> SIP/2.0.
>>>> Record-Route:
>>>> <sip:GW_IP_ADDR;lr;ftag=as657116d5;did=5b6.6e3954b;nat=yes>.
>>>> Via: SIP/2.0/UDP GW_IP_ADDR:5060;branch=z9hG4bK485d.8be72863.0.
>>>> Via: SIP/2.0/UDP
>>>> CALLER_IP_ADDR:5060;received=CALLER_IP_ADDR;branch=z9hG4bK1f912c35;rport=5060.
>>>> Max-Forwards: 69.
>>>> From: "testemike" <sip:testemike at CALLER_IP_ADDR>;tag=as657116d5.
>>>> To: <sip:551133992377 at GW_IP_ADDR>.
>>>> Contact: <sip:testemike at CALLER_IP_ADDR:5060>.
>>>> Call-ID: 40d32e5b3c52c58646d996d871ad8471 at CALLER_IP_ADDR:5060.
>>>> CSeq: 102 INVITE.
>>>> User-Agent: SIP.Ultranet.
>>>> Date: Mon, 23 Sep 2013 00:20:27 GMT.
>>>> Session-Expires: 600.
>>>> Min-SE: 90.
>>>> Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY,
>>>> INFO, PUBLISH.
>>>> Supported: replaces, timer.
>>>> Content-Type: application/sdp.
>>>> Content-Length: 446.
>>>> .
>>>> v=0.
>>>> o=root 985357135 985357135 IN IP4 CALLER_IP_ADDR.
>>>> s=SDP.Ultranet.
>>>> c=IN IP4 GW_IP_ADDRGW_IP_ADDR.
>>>> t=0 0.
>>>> m=audio 4229242292 RTP/AVP 8 0 3 111 97 18 101.
>>>> a=rtpmap:8 PCMA/8000.
>>>> a=rtpmap:0 PCMU/8000.
>>>> a=rtpmap:3 GSM/8000.
>>>> a=rtpmap:111 G726-32/8000.
>>>> a=rtpmap:97 iLBC/8000.
>>>> a=fmtp:97 mode=30.
>>>> a=rtpmap:18 G729/8000.
>>>> a=fmtp:18 annexb=no.
>>>> a=rtpmap:101 telephone-event/8000.
>>>> a=fmtp:101 0-16.
>>>> a=ptime:20.
>>>> a=sendrecv.
>>>> a=nortpproxy:yes.
>>>> a=nortpproxy:yes.
>>>>
>>>>
>>>>  after the invite, i get a request timeout message
>>>>
>>>>  i try to create some firewall rules on the customer side but i dont
>>>> see any package, from the opensips is like the package is beeing sended
>>>>
>>>>  i made a try using another machine that dont have nat and i cant see
>>>> the package in this case too.
>>>>
>>>>
>>>>
>>>>  anyone have an idea about this ?
>>>>
>>>>  Thanks.
>>>>
>>>
>>>
>>>
>>> _______________________________________________
>>> Users mailing listUsers at lists.opensips.orghttp://lists.opensips.org/cgi-bin/mailman/listinfo/users
>>>
>>>
>>>
>>> _______________________________________________
>>> Users mailing list
>>> Users at lists.opensips.org
>>> http://lists.opensips.org/cgi-bin/mailman/listinfo/users
>>>
>>>
>>
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.opensips.org/pipermail/users/attachments/20130926/19838081/attachment.htm>


More information about the Users mailing list