[SR-Users] DRouting, routeid is not triggered
Daniel-Constantin Mierla
miconda at gmail.com
Thu Apr 24 18:09:16 CEST 2014
Can you try the patch from commit:
-
http://git.sip-router.org/cgi-bin/gitweb.cgi/sip-router/?a=commit;h=c3386295d7607a58d37a65b6822bf5f98b3fefa0
If you are using git, do a git pull, then you can pick the commit in
your branch (if you are not on master):
git cherry-pick -x c3386295d7607a58d37a65b6822bf5f98b3fefa0
Cheers,
Daniel
On 24/04/14 17:16, Daniel-Constantin Mierla wrote:
> Hello,
>
> busy with the release I didn't have time to troubleshoot more yet.
>
> Cheers,
> Daniel
>
> On 24/04/14 17:10, Maciej Bylica wrote:
>> Hello
>>
>> Do you need any other data to verify?
>>
>> Thanks.
>>
>>
>> 2014-04-23 12:11 GMT+02:00 Maciej Bylica <mbsip at gazeta.pl
>> <mailto:mbsip at gazeta.pl>>:
>>
>> Hi Daniel,
>>
>> Here is debug you requested.
>>
>> DEBUG: <core> [parser/msg_parser.c:623]: parse_msg(): SIP Request:
>> DEBUG: <core> [parser/msg_parser.c:625]: parse_msg(): method:
>> <INVITE>
>> DEBUG: <core> [parser/msg_parser.c:627]: parse_msg(): uri:
>> <sip:43111223344 at 10.10.10.5 <mailto:sip%3A43111223344 at 10.10.10.5>>
>> DEBUG: <core> [parser/msg_parser.c:629]: parse_msg(): version:
>> <SIP/2.0>
>> DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found
>> param type 235, <rport> = <n/a>; state=6
>> DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found
>> param type 232, <branch> = <z9hG4bKZZDHrKg1B4Q1c>; state=16
>> DEBUG: <core> [parser/parse_via.c:2672]: parse_via(): end of
>> header reached, state=5
>> DEBUG: <core> [parser/msg_parser.c:513]: parse_headers():
>> parse_headers: Via found, flags=2
>> DEBUG: <core> [parser/msg_parser.c:515]: parse_headers():
>> parse_headers: this is the first via
>> DEBUG: <core> [receive.c:152]: receive_msg(): After parse_msg...
>> DEBUG: <core> [receive.c:193]: receive_msg(): preparing to run
>> routing scripts...
>> DEBUG: maxfwd [mf_funcs.c:85]: is_maxfwd_present(): value = 69
>> DEBUG: maxfwd [maxfwd.c:161]: process_maxfwd_header(): value 69
>> decreased to 16
>> DEBUG: <core> [parser/parse_addr_spec.c:893]: parse_addr_spec():
>> end of header reached, state=10
>> DEBUG: <core> [parser/msg_parser.c:190]: get_hdr_field(): DEBUG:
>> get_hdr_field: <To> [32]; uri=[sip:43111223344 at 10.10.10.5
>> <mailto:sip%3A43111223344 at 10.10.10.5>]
>> DEBUG: <core> [parser/msg_parser.c:192]: get_hdr_field(): DEBUG:
>> to body [<sip:43111223344 at 10.10.10.5
>> <mailto:sip%3A43111223344 at 10.10.10.5>>#015#012]
>> DEBUG: <core> [parser/msg_parser.c:170]: get_hdr_field():
>> get_hdr_field: cseq <CSeq>: <58787375> <INVITE>
>> DEBUG: <core> [parser/msg_parser.c:204]: get_hdr_field(): DEBUG:
>> get_hdr_body : content_length=203
>> DEBUG: <core> [parser/msg_parser.c:106]: get_hdr_field(): found
>> end of header
>> DEBUG: <core> [parser/parse_addr_spec.c:176]: parse_to_param():
>> DEBUG: add_param: tag=1eQFK719e4cyS
>> DEBUG: <core> [parser/parse_addr_spec.c:893]: parse_addr_spec():
>> end of header reached, state=29
>> DEBUG: sanity [mod_sanity.c:255]: w_sanity_check(): sanity checks
>> result: 1
>> DEBUG: siputils [checks.c:103]: has_totag(): no totag
>> DEBUG: tm [t_lookup.c:1072]: t_check_msg(): DEBUG: t_check_msg:
>> msg id=1 global id=0 T start=0xffffffffffffffff
>> DEBUG: tm [t_lookup.c:527]: t_lookup_request(): t_lookup_request:
>> start searching: hash=49678, isACK=0
>> DEBUG: tm [t_lookup.c:485]: matching_3261(): DEBUG: RFC3261
>> transaction matching failed
>> DEBUG: tm [t_lookup.c:709]: t_lookup_request(): DEBUG:
>> t_lookup_request: no transaction found
>> DEBUG: tm [t_lookup.c:1141]: t_check_msg(): DEBUG: t_check_msg:
>> msg id=1 global id=1 T end=(nil)
>> DEBUG: <core> [socket_info.c:583]: grep_sock_info():
>> grep_sock_info - checking if host==us: 12==9 && [10.10.10.5] ==
>> [127.0.0.1]
>> DEBUG: <core> [socket_info.c:587]: grep_sock_info():
>> grep_sock_info - checking if port 5060 (advertise 0) matches port
>> 5060
>> DEBUG: <core> [socket_info.c:583]: grep_sock_info():
>> grep_sock_info - checking if host==us: 12==12 && [10.10.10.5] ==
>> [10.10.10.5]
>> DEBUG: <core> [socket_info.c:587]: grep_sock_info():
>> grep_sock_info - checking if port 5060 (advertise 0) matches port
>> 5060
>> DEBUG: registrar [lookup.c:158]: lookup(): '43111223344' Not
>> found in usrloc
>> DEBUG: tm [t_lookup.c:1373]: t_newtran(): DEBUG: t_newtran: msg
>> id=1 , global msg id=1 , T on entrance=(nil)
>> DEBUG: tm [t_lookup.c:527]: t_lookup_request(): t_lookup_request:
>> start searching: hash=49678, isACK=0
>> DEBUG: tm [t_lookup.c:485]: matching_3261(): DEBUG: RFC3261
>> transaction matching failed
>> DEBUG: tm [t_lookup.c:709]: t_lookup_request(): DEBUG:
>> t_lookup_request: no transaction found
>> DEBUG: tm [t_hooks.c:374]: run_reqin_callbacks_internal(): DBG:
>> trans=0x7f9ae79e2c10, callback type 1, id 0 entered
>> DEBUG: tm [t_hooks.c:374]: run_reqin_callbacks_internal(): DBG:
>> trans=0x7f9ae79e2c10, callback type 1, id 0 entered
>> DEBUG: <core> [md5utils.c:67]: MD5StringArray(): DEBUG: MD5
>> calculated: 60b78f5b572d3477887c1e8305c94b0a
>> DEBUG: drouting [drouting.c:720]: do_routing(): using dr group 10
>> DEBUG: drouting [prefix_tree.c:87]: internal_check_rt(): found
>> rgid 10 (rule list 0x7f9ae79e2a58)
>> DEBUG: drouting [drouting.c:895]: do_routing(): setting attr []
>> as for ruri
>> DEBUG: drouting [drouting.c:912]: do_routing(): setting the gw
>> [0] as ruri "sip:43111223344 at 10.10.10.9
>> <mailto:sip%3A43111223344 at 10.10.10.9>"
>> DEBUG: tm [t_lookup.c:1373]: t_newtran(): DEBUG: t_newtran: msg
>> id=1 , global msg id=1 , T on entrance=0x7f9ae79e2c10
>> DEBUG: tm [t_lookup.c:1378]: t_newtran(): DEBUG: t_newtran:
>> transaction already in process 0x7f9ae79e2c10
>> DEBUG: tm [t_funcs.c:347]: t_relay_to(): SER: new INVITE
>> DEBUG: <core> [msg_translator.c:204]: check_via_address():
>> check_via_address(10.10.5.5, 10.10.5.5, 0)
>> DEBUG: <core> [mem/shm_mem.c:111]: _shm_resize():
>> WARNING:vqm_resize: resize(0) called
>> DEBUG: tm [t_reply.c:728]: _reply_light(): DEBUG: reply sent out.
>> buf=0x7f9afe08a608: SIP/2.0 100 trying -...,
>> shmem=0x7f9ae79e5860: SIP/2.0 100 trying -
>> DEBUG: tm [t_reply.c:738]: _reply_light(): DEBUG: _reply_light:
>> finished
>> DEBUG: <script>: new branch [0] to sip:43111223344 at 10.10.10.9
>> <mailto:sip%3A43111223344 at 10.10.10.9>
>> DEBUG: <core> [msg_translator.c:204]: check_via_address():
>> check_via_address(10.10.5.5, 10.10.5.5, 0)
>> DEBUG: tm [t_funcs.c:394]: t_relay_to(): SER: new transaction fwd'ed
>> DEBUG: <core> [usr_avp.c:644]: destroy_avp_list():
>> DEBUG:destroy_avp_list: destroying list (nil)
>> DEBUG: <core> [usr_avp.c:644]: destroy_avp_list():
>> DEBUG:destroy_avp_list: destroying list (nil)
>> DEBUG: <core> [usr_avp.c:644]: destroy_avp_list():
>> DEBUG:destroy_avp_list: destroying list (nil)
>> DEBUG: <core> [usr_avp.c:644]: destroy_avp_list():
>> DEBUG:destroy_avp_list: destroying list (nil)
>> DEBUG: <core> [usr_avp.c:644]: destroy_avp_list():
>> DEBUG:destroy_avp_list: destroying list (nil)
>> DEBUG: <core> [usr_avp.c:644]: destroy_avp_list():
>> DEBUG:destroy_avp_list: destroying list (nil)
>> DEBUG: <core> [xavp.c:448]: xavp_destroy_list(): destroying xavp
>> list (nil)
>> DEBUG: <core> [receive.c:296]: receive_msg(): receive_msg:
>> cleaning up
>> DEBUG: <core> [parser/msg_parser.c:633]: parse_msg(): SIP Reply
>> (status):
>> DEBUG: <core> [parser/msg_parser.c:635]: parse_msg(): version:
>> <SIP/2.0>
>> DEBUG: <core> [parser/msg_parser.c:637]: parse_msg(): status: <100>
>> DEBUG: <core> [parser/msg_parser.c:639]: parse_msg(): reason:
>> <Trying>
>> DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found
>> param type 232, <branch> =
>> <z9hG4bKe02c.60b78f5b572d3477887c1e8305c94b0a.0>; state=16
>> DEBUG: <core> [parser/parse_via.c:2672]: parse_via(): end of
>> header reached, state=5
>> DEBUG: <core> [parser/msg_parser.c:513]: parse_headers():
>> parse_headers: Via found, flags=2
>> DEBUG: <core> [parser/msg_parser.c:515]: parse_headers():
>> parse_headers: this is the first via
>> DEBUG: <core> [receive.c:152]: receive_msg(): After parse_msg...
>> DEBUG: tm [t_lookup.c:1072]: t_check_msg(): DEBUG: t_check_msg:
>> msg id=1 global id=0 T start=0xffffffffffffffff
>> DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found
>> param type 235, <rport> = <5080>; state=6
>> DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found
>> param type 232, <branch> = <z9hG4bKZZDHrKg1B4Q1c>; state=16
>> DEBUG: <core> [parser/parse_via.c:2672]: parse_via(): end of
>> header reached, state=5
>> DEBUG: <core> [parser/msg_parser.c:513]: parse_headers():
>> parse_headers: Via found, flags=62
>> DEBUG: <core> [parser/msg_parser.c:526]: parse_headers():
>> parse_headers: this is the second via
>> DEBUG: <core> [parser/parse_addr_spec.c:893]: parse_addr_spec():
>> end of header reached, state=10
>> DEBUG: <core> [parser/msg_parser.c:190]: get_hdr_field(): DEBUG:
>> get_hdr_field: <To> [32]; uri=[sip:43111223344 at 10.10.10.5
>> <mailto:sip%3A43111223344 at 10.10.10.5>]
>> DEBUG: <core> [parser/msg_parser.c:192]: get_hdr_field(): DEBUG:
>> to body [<sip:43111223344 at 10.10.10.5
>> <mailto:sip%3A43111223344 at 10.10.10.5>>#015#012]
>> DEBUG: <core> [parser/msg_parser.c:170]: get_hdr_field():
>> get_hdr_field: cseq <CSeq>: <58787375> <INVITE>
>> DEBUG: tm [t_lookup.c:949]: t_reply_matching(): DEBUG:
>> t_reply_matching: hash 49678 label 0 branch 0
>> DEBUG: tm [t_lookup.c:1004]: t_reply_matching(): DEBUG:
>> t_reply_matching: reply matched (T=0x7f9ae79e2c10)!
>> DEBUG: tm [t_hooks.c:288]: run_trans_callbacks_internal(): DBG:
>> trans=0x7f9ae79e2c10, callback type 2, id 0 entered
>> DEBUG: acc [acc_logic.c:557]: tmcb_func(): acc callback called
>> for t(0x7f9ae79e2c10) event type 2, reply code 100
>> DEBUG: tm [t_lookup.c:1141]: t_check_msg(): DEBUG: t_check_msg:
>> msg id=1 global id=1 T end=0x7f9ae79e2c10
>> DEBUG: tm [t_reply.c:2206]: reply_received(): DEBUG:
>> reply_received: org. status uas=100, uac[0]=0 local=0 is_invite=1)
>> DEBUG: <script>: incoming reply
>> DEBUG: tm [t_reply.c:1304]: t_should_relay_response(): ->>>>>>>>>
>> T_code=100, new_code=100
>> DEBUG: tm [t_reply.c:1822]: relay_reply(): DEBUG: relay_reply:
>> branch=0, save=0, relay=-1 icode=0
>> DEBUG: <core> [usr_avp.c:644]: destroy_avp_list():
>> DEBUG:destroy_avp_list: destroying list (nil)
>> DEBUG: <core> [usr_avp.c:644]: destroy_avp_list():
>> DEBUG:destroy_avp_list: destroying list (nil)
>> DEBUG: <core> [usr_avp.c:644]: destroy_avp_list():
>> DEBUG:destroy_avp_list: destroying list (nil)
>> DEBUG: <core> [usr_avp.c:644]: destroy_avp_list():
>> DEBUG:destroy_avp_list: destroying list (nil)
>> DEBUG: <core> [usr_avp.c:644]: destroy_avp_list():
>> DEBUG:destroy_avp_list: destroying list (nil)
>> DEBUG: <core> [usr_avp.c:644]: destroy_avp_list():
>> DEBUG:destroy_avp_list: destroying list (nil)
>> DEBUG: <core> [xavp.c:448]: xavp_destroy_list(): destroying xavp
>> list (nil)
>> DEBUG: <core> [receive.c:296]: receive_msg(): receive_msg:
>> cleaning up
>> DEBUG: <core> [parser/msg_parser.c:633]: parse_msg(): SIP Reply
>> (status):
>> DEBUG: <core> [parser/msg_parser.c:635]: parse_msg(): version:
>> <SIP/2.0>
>> DEBUG: <core> [parser/msg_parser.c:637]: parse_msg(): status: <503>
>> DEBUG: <core> [parser/msg_parser.c:639]: parse_msg(): reason:
>> <Service unavailable>
>> DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found
>> param type 232, <branch> =
>> <z9hG4bKe02c.60b78f5b572d3477887c1e8305c94b0a.0>; state=16
>> DEBUG: <core> [parser/parse_via.c:2672]: parse_via(): end of
>> header reached, state=5
>> DEBUG: <core> [parser/msg_parser.c:513]: parse_headers():
>> parse_headers: Via found, flags=2
>> DEBUG: <core> [parser/msg_parser.c:515]: parse_headers():
>> parse_headers: this is the first via
>> DEBUG: <core> [receive.c:152]: receive_msg(): After parse_msg...
>> DEBUG: tm [t_lookup.c:1072]: t_check_msg(): DEBUG: t_check_msg:
>> msg id=1 global id=0 T start=0xffffffffffffffff
>> DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found
>> param type 235, <rport> = <5080>; state=6
>> DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found
>> param type 232, <branch> = <z9hG4bKZZDHrKg1B4Q1c>; state=16
>> DEBUG: <core> [parser/parse_via.c:2672]: parse_via(): end of
>> header reached, state=5
>> DEBUG: <core> [parser/msg_parser.c:513]: parse_headers():
>> parse_headers: Via found, flags=62
>> DEBUG: <core> [parser/msg_parser.c:526]: parse_headers():
>> parse_headers: this is the second via
>> DEBUG: <core> [parser/parse_addr_spec.c:893]: parse_addr_spec():
>> end of header reached, state=10
>> DEBUG: <core> [parser/msg_parser.c:190]: get_hdr_field(): DEBUG:
>> get_hdr_field: <To> [32]; uri=[sip:43111223344 at 10.10.10.5
>> <mailto:sip%3A43111223344 at 10.10.10.5>]
>> DEBUG: <core> [parser/msg_parser.c:192]: get_hdr_field(): DEBUG:
>> to body [<sip:43111223344 at 10.10.10.5
>> <mailto:sip%3A43111223344 at 10.10.10.5>>#015#012]
>> DEBUG: <core> [parser/msg_parser.c:170]: get_hdr_field():
>> get_hdr_field: cseq <CSeq>: <58787375> <INVITE>
>> DEBUG: tm [t_lookup.c:949]: t_reply_matching(): DEBUG:
>> t_reply_matching: hash 49678 label 0 branch 0
>> DEBUG: tm [t_lookup.c:1004]: t_reply_matching(): DEBUG:
>> t_reply_matching: reply matched (T=0x7f9ae79e2c10)!
>> DEBUG: tm [t_hooks.c:288]: run_trans_callbacks_internal(): DBG:
>> trans=0x7f9ae79e2c10, callback type 2, id 0 entered
>> DEBUG: acc [acc_logic.c:557]: tmcb_func(): acc callback called
>> for t(0x7f9ae79e2c10) event type 2, reply code 503
>> DEBUG: tm [t_lookup.c:1141]: t_check_msg(): DEBUG: t_check_msg:
>> msg id=1 global id=1 T end=0x7f9ae79e2c10
>> DEBUG: tm [t_reply.c:2206]: reply_received(): DEBUG:
>> reply_received: org. status uas=100, uac[0]=100 local=0 is_invite=1)
>> DEBUG: <script>: incoming reply
>> DEBUG: tm [t_reply.c:1304]: t_should_relay_response(): ->>>>>>>>>
>> T_code=100, new_code=503
>> DEBUG: tm [t_lookup.c:1072]: t_check_msg(): DEBUG: t_check_msg:
>> msg id=0 global id=0 T start=0x7f9ae79e2c10
>> DEBUG: tm [t_lookup.c:1144]: t_check_msg(): DEBUG: t_check_msg: T
>> already found!
>> DEBUG: tm [t_reply.c:1822]: relay_reply(): DEBUG: relay_reply:
>> branch=0, save=0, relay=0 icode=0
>> DEBUG: <core> [msg_translator.c:204]: check_via_address():
>> check_via_address(10.10.5.5, 10.10.5.5, 0)
>> DEBUG: tm [t_hooks.c:288]: run_trans_callbacks_internal(): DBG:
>> trans=0x7f9ae79e2c10, callback type 512, id 0 entered
>> DEBUG: acc [acc_logic.c:557]: tmcb_func(): acc callback called
>> for t(0x7f9ae79e2c10) event type 512, reply code 503
>> DEBUG: <core> [parser/msg_parser.c:623]: parse_msg(): SIP Request:
>> DEBUG: <core> [parser/msg_parser.c:625]: parse_msg(): method: <ACK>
>> DEBUG: <core> [parser/msg_parser.c:627]: parse_msg(): uri:
>> <sip:43111223344 at 10.10.10.5 <mailto:sip%3A43111223344 at 10.10.10.5>>
>> DEBUG: <core> [parser/msg_parser.c:629]: parse_msg(): version:
>> <SIP/2.0>
>> DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found
>> param type 235, <rport> = <n/a>; state=6
>> DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found
>> param type 232, <branch> = <z9hG4bKZZDHrKg1B4Q1c>; state=16
>> DEBUG: <core> [parser/parse_via.c:2672]: parse_via(): end of
>> header reached, state=5
>> DEBUG: <core> [parser/msg_parser.c:513]: parse_headers():
>> parse_headers: Via found, flags=2
>> DEBUG: <core> [parser/msg_parser.c:515]: parse_headers():
>> parse_headers: this is the first via
>> DEBUG: <core> [receive.c:152]: receive_msg(): After parse_msg...
>> DEBUG: <core> [receive.c:193]: receive_msg(): preparing to run
>> routing scripts...
>> DEBUG: sl [sl_funcs.c:412]: sl_filter_ACK(): DEBUG :
>> sl_filter_ACK: to late to be a local ACK!
>> DEBUG: maxfwd [mf_funcs.c:85]: is_maxfwd_present(): value = 69
>> DEBUG: maxfwd [maxfwd.c:161]: process_maxfwd_header(): value 69
>> decreased to 16
>> DEBUG: <core> [parser/parse_addr_spec.c:176]: parse_to_param():
>> DEBUG: add_param: tag=a6a1c5f60faecf035a1ae5b6e96e979a-3d6b
>> DEBUG: <core> [parser/parse_addr_spec.c:893]: parse_addr_spec():
>> end of header reached, state=29
>> DEBUG: <core> [parser/msg_parser.c:190]: get_hdr_field(): DEBUG:
>> get_hdr_field: <To> [74]; uri=[sip:43111223344 at 10.10.10.5
>> <mailto:sip%3A43111223344 at 10.10.10.5>]
>> DEBUG: <core> [parser/msg_parser.c:192]: get_hdr_field(): DEBUG:
>> to body [<sip:43111223344 at 10.10.10.5
>> <mailto:sip%3A43111223344 at 10.10.10.5>>]
>> DEBUG: <core> [parser/msg_parser.c:170]: get_hdr_field():
>> get_hdr_field: cseq <CSeq>: <58787375> <ACK>
>> DEBUG: <core> [parser/msg_parser.c:204]: get_hdr_field(): DEBUG:
>> get_hdr_body : content_length=0
>> DEBUG: <core> [parser/msg_parser.c:106]: get_hdr_field(): found
>> end of header
>> DEBUG: <core> [parser/parse_addr_spec.c:176]: parse_to_param():
>> DEBUG: add_param: tag=1eQFK719e4cyS
>> DEBUG: <core> [parser/parse_addr_spec.c:893]: parse_addr_spec():
>> end of header reached, state=29
>> DEBUG: tm [t_reply.c:1663]: cleanup_uac_timers(): DEBUG:
>> cleanup_uac_timers: RETR/FR timers reset
>> DEBUG: sanity [mod_sanity.c:255]: w_sanity_check(): sanity checks
>> result: 1
>> DEBUG: <core> [usr_avp.c:644]: destroy_avp_list():
>> DEBUG:destroy_avp_list: destroying list (nil)
>> DEBUG: <core> [usr_avp.c:644]: destroy_avp_list():
>> DEBUG:destroy_avp_list: destroying list (nil)
>> DEBUG: <core> [usr_avp.c:644]: destroy_avp_list():
>> DEBUG:destroy_avp_list: destroying list (nil)
>> DEBUG: siputils [checks.c:106]: has_totag(): totag found
>> DEBUG: <core> [usr_avp.c:644]: destroy_avp_list():
>> DEBUG:destroy_avp_list: destroying list (nil)
>> DEBUG: <core> [usr_avp.c:644]: destroy_avp_list():
>> DEBUG:destroy_avp_list: destroying list (nil)
>> DEBUG: <core> [usr_avp.c:644]: destroy_avp_list():
>> DEBUG:destroy_avp_list: destroying list (nil)
>> DEBUG: rr [loose.c:113]: find_first_route(): No Route headers found
>> DEBUG: <core> [xavp.c:448]: xavp_destroy_list(): destroying xavp
>> list (nil)
>> DEBUG: rr [loose.c:929]: loose_route(): There is no Route HF
>> DEBUG: <core> [receive.c:296]: receive_msg(): receive_msg:
>> cleaning up
>> DEBUG: tm [t_lookup.c:1072]: t_check_msg(): DEBUG: t_check_msg:
>> msg id=1 global id=0 T start=0xffffffffffffffff
>> DEBUG: tm [t_lookup.c:527]: t_lookup_request(): t_lookup_request:
>> start searching: hash=49678, isACK=1
>> DEBUG: tm [t_lookup.c:470]: matching_3261(): DEBUG: RFC3261
>> transaction matched, tid=ZZDHrKg1B4Q1c
>> DEBUG: tm [t_lookup.c:726]: t_lookup_request(): DEBUG:
>> t_lookup_request: transaction found (T=0x7f9ae79e2c10)
>> DEBUG: tm [t_lookup.c:1141]: t_check_msg(): DEBUG: t_check_msg:
>> msg id=1 global id=1 T end=0x7f9ae79e2c10
>> DEBUG: tm [t_reply.c:1663]: cleanup_uac_timers(): DEBUG:
>> cleanup_uac_timers: RETR/FR timers reset
>> DEBUG: <core> [timer.c:595]: timer_add_safe(): timer_add called
>> on an active timer 0x7f9ae79e2c90 (0x7f9ae778eb18,
>> 0x7f9ae778eb18), flags 201
>> DEBUG: tm [t_funcs.c:180]: put_on_wait(): tm: put_on_wait:
>> transaction 0x7f9ae79e2c10 already on wait
>> DEBUG: <core> [usr_avp.c:644]: destroy_avp_list():
>> DEBUG:destroy_avp_list: destroying list (nil)
>> DEBUG: <core> [usr_avp.c:644]: destroy_avp_list():
>> DEBUG:destroy_avp_list: destroying list (nil)
>> DEBUG: <core> [usr_avp.c:644]: destroy_avp_list():
>> DEBUG:destroy_avp_list: destroying list (nil)
>> DEBUG: <core> [usr_avp.c:644]: destroy_avp_list():
>> DEBUG:destroy_avp_list: destroying list (nil)
>> DEBUG: <core> [usr_avp.c:644]: destroy_avp_list():
>> DEBUG:destroy_avp_list: destroying list (nil)
>> DEBUG: <core> [usr_avp.c:644]: destroy_avp_list():
>> DEBUG:destroy_avp_list: destroying list (nil)
>> DEBUG: <core> [xavp.c:448]: xavp_destroy_list(): destroying xavp
>> list (nil)
>> DEBUG: <core> [receive.c:296]: receive_msg(): receive_msg:
>> cleaning up
>>
>>
>> and call flow:
>> 0.000000 10.10.5.5 -> 10.10.10.5 SIP/SDP 1100 Request: INVITE
>> sip:43111223344 at 10.10.10.5 <mailto:sip%3A43111223344 at 10.10.10.5>
>> | , with session description
>> 0.002140 10.10.10.5 -> 10.10.5.5 SIP 377 Status: 100 trying --
>> your call is important to us |
>> 0.002264 10.10.10.5 -> 10.10.10.9 SIP/SDP 1250 Request: INVITE
>> sip:43111223344 at 10.10.10.9 <mailto:sip%3A43111223344 at 10.10.10.9>
>> | , with session description
>> 0.002836 10.10.10.9 -> 10.10.10.5 SIP 442 Status: 100 Trying |
>> 0.370466 10.10.10.9 -> 10.10.10.5 SIP 565 Status: 503 Service
>> unavailable |
>> 0.370858 10.10.10.5 -> 10.10.10.9 SIP 379 Request: ACK
>> sip:43111223344 at 10.10.10.9 <mailto:sip%3A43111223344 at 10.10.10.9> |
>> 0.370969 10.10.10.5 -> 10.10.5.5 SIP 400 Status: 500 Service
>> Unavailable |
>> 0.371441 10.10.5.5 -> 10.10.10.5 SIP 404 Request: ACK
>> sip:43111223344 at 10.10.10.5 <mailto:sip%3A43111223344 at 10.10.10.5> |
>>
>> Thanks
>> Mac
>>
>>
>> 2014-04-22 19:51 GMT+02:00 Daniel-Constantin Mierla
>> <miconda at gmail.com <mailto:miconda at gmail.com>>:
>>
>> Hello,
>>
>> can you set debug=3 in kamailio.cfg and then send the syslog
>> messages for routing a call matching the drouting rule?
>>
>> Cheers,
>> Daniel
>>
>>
>> On 22/04/14 19:12, Maciej Bylica wrote:
>>> Hello,
>>>
>>> I am working on version: kamailio 4.1.2 (x86_64/linux) and
>>> heaving troubles with drouting module.
>>> The problem i am facing is that kamailio cannot enter
>>> routeid that is provided inside dr_rule table.
>>>
>>> My last try was to use standard script file with placing
>>> following data before t_relay
>>> if (!do_routing("10")) {
>>> sl_send_reply("403", "No route for You");
>>> exit;
>>> }
>>>
>>> additionaly i have added route definition
>>> route[1] {
>>> xlog("L_INFO","[INFO] Default route --- fn-$fn,
>>> fu-$fu, fU-$fU, ru-$ru, rU-$rU, sp-$sp, si-$si, tu-$tu,
>>> tU-$tU");
>>> uac_replace_from("sip:$fU at 10.10.10.5
>>> <mailto:fU at 10.10.10.5>");
>>>
>>> }
>>>
>>> My DB contains following data:
>>> +--------+---------+--------+---------+----------+---------+--------+--------------+
>>> | ruleid | groupid | prefix | timerec | priority | routeid |
>>> gwlist | description |
>>> +--------+---------+--------+---------+----------+---------+--------+--------------+
>>> | 1 | 10 | 43 | | 0 | 1 | 1
>>> | test rule |
>>> +--------+---------+--------+---------+----------+---------+--------+--------------+
>>>
>>> +------+------+---------------+-------+------------+-------+-------------+
>>> | gwid | type | address | strip | pri_prefix | attrs |
>>> description |
>>> +------+------+---------------+-------+------------+-------+-------------+
>>> | 1 | 10 | 10.10.10.9 | 0 | NULL | NULL |
>>> FirstGW |
>>> +------+------+---------------+-------+------------+-------+-------------+
>>>
>>> The result is that script is omitting route[1] without any
>>> purpose (xlog is not shown, $fU is not modified).
>>>
>>> Could somebody help me to understand whats going on?
>>>
>>> Thanks in advanced,
>>> Mac
>>>
>>>
>>> _______________________________________________
>>> SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list
>>> sr-users at lists.sip-router.org <mailto:sr-users at lists.sip-router.org>
>>> http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
>>
>> --
>> Daniel-Constantin Mierla -http://www.asipto.com
>> http://twitter.com/#!/miconda <http://twitter.com/#%21/miconda> -http://www.linkedin.com/in/miconda
>>
>>
>> _______________________________________________
>> SIP Express Router (SER) and Kamailio (OpenSER) - sr-users
>> mailing list
>> sr-users at lists.sip-router.org
>> <mailto:sr-users at lists.sip-router.org>
>> http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
>>
>>
>>
>
> --
> Daniel-Constantin Mierla -http://www.asipto.com
> http://twitter.com/#!/miconda -http://www.linkedin.com/in/miconda
--
Daniel-Constantin Mierla - http://www.asipto.com
http://twitter.com/#!/miconda - http://www.linkedin.com/in/miconda
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.sip-router.org/pipermail/sr-users/attachments/20140424/8e673ee7/attachment.html>
More information about the sr-users
mailing list