[Serusers] t_replicate on register, then 404 not found

Doug Eubanks admin at dougware.net
Mon Jan 3 18:19:41 CET 2005 

I am still having problems...

I have completely changed some of my ser.cfg's order to no avail...

Can someone point me in the right direction on this?  I am sure it is a routing issue....

Thanks,
Doug Eubanks
> I have researched this list and all the docs I can find, but I am having a problem I can't solve.
> 
> 
> I am using a Sipura registering to my SER server which is replicating register requests to
> another SIP Gatekeeper.  We are using the other SIP gatekeeper for routing, and it appears that
> the registration request is being replicated (but then it is removed after a short timeout
> period).  Anyway, the username on the SIP device and in ser is a 11 digit phone number.
> 
> When I dial the phone number from another sip device that is registered, I get 404 Not Found.  I
> am including my debug for this call as well as parts of my ser.cfg.  Can anyone point me in the
> right direction? Theoretically, the SER server should send any 11 digit phone number registered
> to it directly to the registered endpoint, otherwise, relay it to the other SIP router...
> 
> Thanks for the help...
> 
> 
> 198.67.41.194 Is the SIP Router
> 198.67.41.196 Is my SER server
> phone is the user placing the call 12523152553 is the number being called....
> 
> 
> -----------------------------------ser.cfg Registration and Routing----------------------------
> if (uri=~"sip:1[0-9]+ at .*") { rewritehostport("198.67.41.194:5060");
> forward(uri:host, uri:port);
> };
> 
> 
> if (method=="REGISTER") { if (!proxy_authorize("sip.simflex.net" /* realm */, "subscriber" /* table
> name */ )) { proxy_challenge("sip.simflex.net", "0"); setflag(1); break; };
> if (!src_ip==198.67.41.194) { if(t_newtran()){ t_replicate("198.67.41.194", "5060"); };
> };
> save("location"); break; };
> 
> 
> 
> 
> 
> -----------------------------------DEBUG----------------------------
> SIP/2.0 183 Session Progress
> Call-ID: EBBF58CE-320D-4906-ADD5-34B16E162D8C at 10.0.0.2
> From: "sip.simflex.net" <sip:phone at sip.simflex.net:8286>;tag=3089475581
> To: <sip:12523152553 at sip.simflex.net>
> Content-Length: 0
> CSeq: 25148 INVITE
> Via: SIP/2.0/UDP
> 10.0.0.2:8286;received=198.67.41.187;rport=8286;received=198.67.41.187;rport=8286;branch=z9hG4bKA
> BE3A5E79A9544F6A76997C242A1E16C
> Record-Route: <sip:198.67.41.194:5060;lr>
> 
> 
> 
> 0(27492) DEBUG: reply relayed. buf=0x80c47a8: SIP/2.0 1..., shmem=0xb576a588: SIP/2.0 1
> 0(27492) DBG: callback type 7, id 1 entered
> 0(27492) DEBUG: add_to_tail_of_timer[1]: 0xb5766de4
> 0(27492) DEBUG:destroy_avp_list: destroing list (nil)
> 0(27492) receive_msg: cleaning up
> 0(27492) SIP Reply  (status):
> 0(27492)  version: <SIP/2.0>
> 0(27492)  status:  <183>
> 0(27492)  reason:  <Session Progress>
> 0(27492) parse_headers: flags=1
> 0(27492) end of header reached, state=9
> 0(27492) DEBUG: get_hdr_field: <To> [35]; uri=[sip:12523152553 at sip.simflex.net]
> 0(27492) DEBUG: to body [<sip:12523152553 at sip.simflex.net>
> ]
> 0(27492) DEBUG: get_hdr_body : content_length=219
> 0(27492) get_hdr_field: cseq <CSeq>: <25148> <INVITE>
> 0(27492) Found param type 232, <branch> = <0>; state=16
> 0(27492) end of header reached, state=5
> 0(27492) parse_headers: Via found, flags=1
> 0(27492) parse_headers: this is the first via
> 0(27492) After parse_msg...
> 0(27492) forward_reply: found module tm, passing reply to it
> 0(27492) DEBUG: t_check: msg id=19 global id=18 T start=0xffffffff
> 0(27492) parse_headers: flags=17
> 0(27492) parse_headers: flags=4
> 0(27492) DEBUG: t_reply_matching: failure to match a transaction
> 0(27492) DEBUG: t_check: msg id=19 global id=19 T end=(nil)
> 0(27492) parse_headers: flags=2
> 0(27492) Found param type 232, <branch> = <z9hG4bK174a.53dcb714.0>; state=16
> 0(27492) end of header reached, state=5
> 0(27492) parse_headers: Via found, flags=2
> 0(27492) parse_headers: this is the second via
> 0(27492)  old size: 784, new size: 743
> 0(27492) build_res_from_sip_res: copied size: orig:311, new: 270, rest: 473 msg=
> SIP/2.0 183 Session Progress
> Call-ID: EBBF58CE-320D-4906-ADD5-34B16E162D8C at 10.0.0.2
> From: "sip.simflex.net" <sip:phone at sip.simflex.net:8286>;tag=3089475581
> To: <sip:12523152553 at sip.simflex.net>
> Content-Length: 219
> Content-Type: application/sdp
> CSeq: 25148 INVITE
> Via: SIP/2.0/UDP 198.67.41.196;branch=z9hG4bK174a.53dcb714.0
> Via: SIP/2.0/UDP
> 10.0.0.2:8286;received=198.67.41.187;rport=8286;received=198.67.41.187;rport=8286;branch=z9hG4bKA
> BE3A5E79A9544F6A76997C242A1E16C
> Record-Route: <sip:198.67.41.194:5060;lr>
> 
> 
> v=0 o=MG4000|1.0 111 12345 IN IP4 198.67.41.194 s=- c=IN IP4 198.67.41.194 t=0 0 m=audio 1695 RTP/AVP
> 18 101
> a=rtpmap:101 telephone-event/8000
> a=fmtp:101 0-15
> a=X-sqn: 0
> a=X-cap: 1 image udptl t38
> a=ptime:10
> 
> 
> 0(27492) update_sock_struct_from_via: using via host
> 0(27492) update_sock_struct_from_via: trying SRV lookup
> 0(27492)  reply forwarded to 198.67.41.196:0
> 0(27492) DEBUG:destroy_avp_list: destroing list (nil)
> 0(27492) receive_msg: cleaning up
> 0(27492) SIP Reply  (status):
> 0(27492)  version: <SIP/2.0>
> 0(27492)  status:  <183>
> 0(27492)  reason:  <Session Progress>
> 0(27492) parse_headers: flags=1
> 0(27492) end of header reached, state=9
> 0(27492) DEBUG: get_hdr_field: <To> [35]; uri=[sip:12523152553 at sip.simflex.net]
> 0(27492) DEBUG: to body [<sip:12523152553 at sip.simflex.net>
> ]
> 0(27492) DEBUG: get_hdr_body : content_length=219
> 0(27492) get_hdr_field: cseq <CSeq>: <25148> <INVITE>
> 0(27492) Found param type 232, <branch> = <z9hG4bK174a.53dcb714.0>; state=16
> 0(27492) end of header reached, state=5
> 0(27492) parse_headers: Via found, flags=1
> 0(27492) parse_headers: this is the first via
> 0(27492) After parse_msg...
> 0(27492) forward_reply: found module tm, passing reply to it
> 0(27492) DEBUG: t_check: msg id=20 global id=19 T start=(nil)
> 0(27492) parse_headers: flags=17
> 0(27492) parse_headers: flags=4
> 0(27492) DEBUG: t_reply_matching: hash 42097 label 1098632501 branch 0
> 0(27492) DEBUG: t_reply_matching: reply matched (T=0xb5766ca8)!
> 0(27492) DBG: callback type 1, id 5 entered
> 0(27492) DEBUG: t_check: msg id=20 global id=20 T end=0xb5766ca8
> 0(27492) DEBUG: t_on_reply: org. status uas=183, uac[0]=183 local=0 is_invite=1)
> 0(27492) ->>>>>>>>> T_code=183, new_code=183
> 0(27492) DEBUG: relay_reply: branch=0, save=0, relay=0
> 0(27492)  old size: 743, new size: 681
> 0(27492) build_res_from_sip_res: copied size: orig:332, new: 270, rest: 411 msg=
> SIP/2.0 183 Session Progress
> Call-ID: EBBF58CE-320D-4906-ADD5-34B16E162D8C at 10.0.0.2
> From: "sip.simflex.net" <sip:phone at sip.simflex.net:8286>;tag=3089475581
> To: <sip:12523152553 at sip.simflex.net>
> Content-Length: 219
> Content-Type: application/sdp
> CSeq: 25148 INVITE
> Via: SIP/2.0/UDP
> 10.0.0.2:8286;received=198.67.41.187;rport=8286;received=198.67.41.187;rport=8286;branch=z9hG4bKA
> BE3A5E79A9544F6A76997C242A1E16C
> Record-Route: <sip:198.67.41.194:5060;lr>
> 
> 
> v=0 o=MG4000|1.0 111 12345 IN IP4 198.67.41.194 s=- c=IN IP4 198.67.41.194 t=0 0 m=audio 1695 RTP/AVP
> 18 101
> a=rtpmap:101 telephone-event/8000
> a=fmtp:101 0-15
> a=X-sqn: 0
> a=X-cap: 1 image udptl t38
> a=ptime:10
> 
> 
> 0(27492) DEBUG: reply relayed. buf=0x80c5a68: SIP/2.0 1..., shmem=0xb576a7e0: SIP/2.0 1
> 0(27492) DBG: callback type 7, id 1 entered
> 0(27492) DEBUG: add_to_tail_of_timer[1]: 0xb5766de4
> 0(27492) DEBUG:destroy_avp_list: destroing list (nil)
> 0(27492) receive_msg: cleaning up
> 0(27492) SIP Reply  (status):
> 0(27492)  version: <SIP/2.0>
> 0(27492)  status:  <404>
> 0(27492)  reason:  <Not Found>
> 0(27492) parse_headers: flags=1
> 0(27492) end of header reached, state=9
> 0(27492) DEBUG: get_hdr_field: <To> [35]; uri=[sip:12523152553 at sip.simflex.net]
> 0(27492) DEBUG: to body [<sip:12523152553 at sip.simflex.net>
> ]
> 0(27492) DEBUG: get_hdr_body : content_length=0
> 0(27492) get_hdr_field: cseq <CSeq>: <25148> <INVITE>
> 0(27492) Found param type 232, <branch> = <0>; state=16
> 0(27492) end of header reached, state=5
> 0(27492) parse_headers: Via found, flags=1
> 0(27492) parse_headers: this is the first via
> 0(27492) After parse_msg...
> 0(27492) forward_reply: found module tm, passing reply to it
> 0(27492) DEBUG: t_check: msg id=21 global id=20 T start=0xffffffff
> 0(27492) parse_headers: flags=17
> 0(27492) parse_headers: flags=4
> 0(27492) DEBUG: t_reply_matching: failure to match a transaction
> 0(27492) DEBUG: t_check: msg id=21 global id=21 T end=(nil)
> 0(27492) parse_headers: flags=2
> 0(27492) Found param type 232, <branch> = <z9hG4bK174a.53dcb714.0>; state=16
> 0(27492) end of header reached, state=5
> 0(27492) parse_headers: Via found, flags=2
> 0(27492) parse_headers: this is the second via
> 0(27492)  old size: 482, new size: 441
> 0(27492) build_res_from_sip_res: copied size: orig:271, new: 230, rest: 211 msg=
> SIP/2.0 404 Not Found
> Call-ID: EBBF58CE-320D-4906-ADD5-34B16E162D8C at 10.0.0.2
> From: "sip.simflex.net" <sip:phone at sip.simflex.net:8286>;tag=3089475581
> To: <sip:12523152553 at sip.simflex.net>
> Content-Length: 0
> CSeq: 25148 INVITE
> Via: SIP/2.0/UDP 198.67.41.196;branch=z9hG4bK174a.53dcb714.0
> Via: SIP/2.0/UDP
> 10.0.0.2:8286;received=198.67.41.187;rport=8286;received=198.67.41.187;rport=8286;branch=z9hG4bKA
> BE3A5E79A9544F6A76997C242A1E16C
> 
> 
> 
> 0(27492) update_sock_struct_from_via: using via host
> 0(27492) update_sock_struct_from_via: trying SRV lookup
> 0(27492)  reply forwarded to 198.67.41.196:0
> 0(27492) DEBUG:destroy_avp_list: destroing list (nil)
> 0(27492) receive_msg: cleaning up
> 0(27492) SIP Reply  (status):
> 0(27492)  version: <SIP/2.0>
> 0(27492)  status:  <404>
> 0(27492)  reason:  <Not Found>
> 0(27492) parse_headers: flags=1
> 0(27492) end of header reached, state=9
> 0(27492) DEBUG: get_hdr_field: <To> [35]; uri=[sip:12523152553 at sip.simflex.net]
> 0(27492) DEBUG: to body [<sip:12523152553 at sip.simflex.net>
> ]
> 0(27492) DEBUG: get_hdr_body : content_length=0
> 0(27492) get_hdr_field: cseq <CSeq>: <25148> <INVITE>
> 0(27492) Found param type 232, <branch> = <z9hG4bK174a.53dcb714.0>; state=16
> 0(27492) end of header reached, state=5
> 0(27492) parse_headers: Via found, flags=1
> 0(27492) parse_headers: this is the first via
> 0(27492) After parse_msg...
> 0(27492) forward_reply: found module tm, passing reply to it
> 0(27492) DEBUG: t_check: msg id=22 global id=21 T start=(nil)
> 0(27492) parse_headers: flags=17
> 0(27492) parse_headers: flags=4
> 0(27492) DEBUG: t_reply_matching: hash 42097 label 1098632501 branch 0
> 0(27492) DEBUG: t_reply_matching: reply matched (T=0xb5766ca8)!
> 0(27492) DBG: callback type 1, id 5 entered
> 0(27492) DEBUG: t_check: msg id=22 global id=22 T end=0xb5766ca8
> 0(27492) DEBUG: t_on_reply: org. status uas=183, uac[0]=183 local=0 is_invite=1)
> 0(27492) parse_headers: flags=4
> 0(27492) ->>>>>>>>> T_code=183, new_code=404
> 0(27492) DBG: callback type 6, id 4 entered
> 0(27492) DEBUG: relay_reply: branch=0, save=0, relay=0
> 0(27492)  old size: 441, new size: 379
> 0(27492) build_res_from_sip_res: copied size: orig:292, new: 230, rest: 149 msg=
> SIP/2.0 404 Not Found
> Call-ID: EBBF58CE-320D-4906-ADD5-34B16E162D8C at 10.0.0.2
> From: "sip.simflex.net" <sip:phone at sip.simflex.net:8286>;tag=3089475581
> To: <sip:12523152553 at sip.simflex.net>
> Content-Length: 0
> CSeq: 25148 INVITE
> Via: SIP/2.0/UDP
> 10.0.0.2:8286;received=198.67.41.187;rport=8286;received=198.67.41.187;rport=8286;branch=z9hG4bKA
> BE3A5E79A9544F6A76997C242A1E16C
> 
> 
> 
> 0(27492) DEBUG: reply relayed. buf=0x80c47a8: SIP/2.0 4..., shmem=0xb57681b8: SIP/2.0 4
> 0(27492) DBG: callback type 7, id 1 entered
> 0(27492) DEBUG: cleanup_uacs: RETR/FR timers reset
> 0(27492) DEBUG: add_to_tail_of_timer[4]: 0xb5766d5c
> 0(27492) DEBUG: add_to_tail_of_timer[0]: 0xb5766d70
> 0(27492) DEBUG:destroy_avp_list: destroing list (nil)
> 0(27492) receive_msg: cleaning up
> 0(27492) SIP Request:
> 0(27492)  method:  <ACK>
> 0(27492)  uri:     <sip:12523152553 at sip.simflex.net>
> 0(27492)  version: <SIP/2.0>
> 0(27492) parse_headers: flags=1
> 0(27492) Found param type 235, <rport> = <n/a>; state=6
> 0(27492) Found param type 232, <branch> = <z9hG4bKABE3A5E79A9544F6A76997C242A1E16C>; state=16
> 0(27492) end of header reached, state=5
> 0(27492) parse_headers: Via found, flags=1
> 0(27492) parse_headers: this is the first via
> 0(27492) After parse_msg...
> 0(27492) preparing to run routing scripts...
> 0(27492) DEBUG : sl_filter_ACK: to late to be a local ACK!
> 0(27492) lookup(): '12523152553' Not found in usrloc
> 0(27492) DEBUG : is_maxfwd_present: searching for max_forwards header
> 0(27492) parse_headers: flags=128
> 0(27492) end of header reached, state=9
> 0(27492) DEBUG: get_hdr_field: <To> [35]; uri=[sip:12523152553 at sip.simflex.net]
> 0(27492) DEBUG: to body [<sip:12523152553 at sip.simflex.net>
> ]
> 0(27492) get_hdr_field: cseq <CSeq>: <25148> <ACK>
> 0(27492) DEBUG: is_maxfwd_present: value = 70
> 0(27492) DEBUG: add_param: tag=3089475581
> 0(27492) end of header reached, state=29
> 0(27492) parse_headers: flags=256
> 0(27492) DEBUG: get_hdr_body : content_length=0
> 0(27492) found end of header
> 0(27492) find_first_route(): No Route headers found
> 0(27492) loose_route(): There is no Route HF
> 0(27492) DEBUG: mk_proxy: doing DNS lookup...
> 0(27492) check_via_address(198.67.41.187, 10.0.0.2, 0)
> 0(27492) Sending:
> 
> 
> _______________________________________________
> Serusers mailing list
> serusers at lists.iptel.org
> http://lists.iptel.org/mailman/listinfo/serusers
> 
> 
>

More information about the sr-users mailing list