[SR-Users] DRouting, routeid is not triggered

Daniel-Constantin Mierla miconda at gmail.com
Thu Apr 24 17:16:28 CEST 2014


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

-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.sip-router.org/pipermail/sr-users/attachments/20140424/002b9dbf/attachment.html>


More information about the sr-users mailing list