Dear all , I have a problem: My Network Diagram:
IP for SER Server, Radiusclient (the same computer): 203.160.97.232 IP for Radius Server (Radiator): 203.160.97.234 IP for GW SIP to PSTN (Cisco AS5350) 203.160.97.233 IP for IP PHONE (Zyxel 2000W) 203.160.97.236
* Compile Radius client: radiusclient-0.4.8.tar.gz ./configure Make all Make install * Compile SER -- Change Exclude modules in Makefiles: remove "auth_radius", "group_radius", and "uri_radius" among excluded modules.
Make proper Make all Make install * I have change Radiusclient.conf (in /usr/local/etc/radiusclient)for Radiusclient :
.... Authserver 203.160.97.234:1645 Accserver 203.160.97.234:1646
Binaddr 203.160.97.232
* Add line in file dictionary $INCLUDE /usr/local/etc/radiusclient/dictionary.ser
* Change file servers 203.160.97.234 mysecret add line /usr/local/lib in file /etc/ld.so.conf ldconfig –v
1: I use IP phone or SIP soft phone (xten) dial directly to GW as5350 and don't use SIP server + radius, everything is OK 2: IP phone or SIP client authenicated by radius radiator OK 3: Make a call by IP phone --->SIP(SER + Radius)---->GW----->PSTN : OK
But time for call is only 8 second -- But time for call is only 8 second
This is my ser.cfg: # # $Id: ser.cfg,v 1.21.4.1 2003/11/10 15:35:15 andrei Exp $ # ----------- global configuration parameters ------------------------
debug=8 fork=yes log_stderror=yes
check_via=no # (cmd. line: -v) dns=no # (cmd. line: -r) rev_dns=no # (cmd. line: -R) port=5060 #children=4 fifo="/tmp/ser_fifo"
# ------------------ module loading ---------------------------------- loadmodule "/usr/local/lib/ser/modules/sl.so" loadmodule "/usr/local/lib/ser/modules/tm.so" loadmodule "/usr/local/lib/ser/modules/rr.so" loadmodule "/usr/local/lib/ser/modules/maxfwd.so" loadmodule "/usr/local/lib/ser/modules/usrloc.so" loadmodule "/usr/local/lib/ser/modules/registrar.so"
loadmodule "/usr/local/lib/ser/modules/auth.so" loadmodule "/usr/local/lib/ser/modules/auth_radius.so"
# ----------------- setting module-specific parameters --------------- modparam("usrloc", "db_mode", 0) modparam("rr", "enable_full_lr", 1) # ------------------------- request routing logic -------------------
route{
if (!mf_process_maxfwd_header("10")) { sl_send_reply("483","Too Many Hops"); break; }; if ( msg:len > max_len ) { sl_send_reply("513", "Message too big"); break; };
# authenticate register message using radius if (method=="REGISTER") { # Uncomment this if you want to use digest authentication if (!radius_www_authorize("")) { www_challenge("", "0"); break; }; save("location"); break; };
# route (proxy) invite message to gateway if (method=="INVITE") || (method=="CANCEL") { # Uncomment this if you want to use digest authentication if (!radius_www_authorize("")) { www_challenge("", "0"); break; };
record_route(); rewritehostport("203.160.97.233:5060"); if (!t_relay()) { sl_reply_error(); }; break; };
}
My Debug session:
[root@SIP-SG01 sbin]# 15(21163) SIP Request: 15(21163) method: <INVITE> 15(21163) uri: sip:08117@203.160.97.232:5060 15(21163) version: <SIP/2.0> 15(21163) parse_headers: flags=1 15(21163) Found param type 232, <branch> = <z9hG4bkbd74baa8656e3b>; state=16 15(21163) end of header reached, state=5 15(21163) parse_headers: Via found, flags=1 15(21163) parse_headers: this is the first via 15(21163) After parse_msg... 15(21163) preparing to run routing scripts... 15(21163) DEBUG : is_maxfwd_present: searching for max_forwards header 15(21163) parse_headers: flags=128 15(21163) end of header reached, state=9 15(21163) DEBUG: get_hdr_field: <To> [39]; uri=[sip:08117@203.160.97.232;user=phone] 15(21163) DEBUG: to body [sip:08117@203.160.97.232;user=phone ] 15(21163) get_hdr_field: cseq <CSeq>: <1> <INVITE> 15(21163) DEBUG: is_maxfwd_present: value = 70 15(21163) DEBUG: add_param: tag=35A33BE5CA4876B7CB 15(21163) end of header reached, state=29 15(21163) parse_headers: flags=4096 15(21163) DEBUG: get_hdr_body : content_length=201 15(21163) found end of header 15(21163) pre_auth(): Credentials with given realm not found 15(21163) build_auth_hf(): 'WWW-Authenticate: Digest realm="203.160.97.232", nonce="425850ba29ebdf74552c5946fe7de2bed452d4d6" ' 15(21163) parse_headers: flags=-1 15(21163) check_via_address(203.160.97.236, 203.160.97.236, 0) 15(21163) DEBUG:destroy_avp_list: destroing list (nil) 15(21163) receive_msg: cleaning up 9(21157) SIP Request: 9(21157) method: <ACK> 9(21157) uri: sip:08117@203.160.97.232:5060 9(21157) version: <SIP/2.0> 9(21157) parse_headers: flags=1 9(21157) Found param type 232, <branch> = <z9hG4bkbd74baa8656e3b>; state=16 9(21157) end of header reached, state=5 9(21157) parse_headers: Via found, flags=1 9(21157) parse_headers: this is the first via 9(21157) After parse_msg... 9(21157) preparing to run routing scripts... 9(21157) parse_headers: flags=4 9(21157) DEBUG: add_param: tag=b27e1a1d33761e85846fc98f5f3a7e58.35a3 9(21157) end of header reached, state=29 9(21157) DEBUG: get_hdr_field: <To> [81]; uri=[sip:08117@203.160.97.232;user=phone] 9(21157) DEBUG: to body [sip:08117@203.160.97.232;user=phone] 9(21157) DEBUG: sl_filter_ACK : local ACK found -> dropping it! 9(21157) DEBUG:destroy_avp_list: destroing list (nil) 9(21157) receive_msg: cleaning up 10(21158) SIP Request: 10(21158) method: <INVITE> 10(21158) uri: sip:08117@203.160.97.232:5060 10(21158) version: <SIP/2.0> 10(21158) parse_headers: flags=1 10(21158) Found param type 232, <branch> = <z9hG4bkbd74baa8656e3b>; state=16 10(21158) end of header reached, state=5 10(21158) parse_headers: Via found, flags=1 10(21158) parse_headers: this is the first via 10(21158) After parse_msg... 10(21158) preparing to run routing scripts... 10(21158) DEBUG : is_maxfwd_present: searching for max_forwards header 10(21158) parse_headers: flags=128 10(21158) end of header reached, state=9 10(21158) DEBUG: get_hdr_field: <To> [39]; uri=[sip:08117@203.160.97.232;user=phone] 10(21158) DEBUG: to body [sip:08117@203.160.97.232;user=phone ] 10(21158) get_hdr_field: cseq <CSeq>: <2> <INVITE> 10(21158) DEBUG: is_maxfwd_present: value = 70 10(21158) DEBUG: add_param: tag=35A33BE5CA4876B7CB 10(21158) end of header reached, state=29 10(21158) check_nonce(): comparing [425850ba29ebdf74552c5946fe7de2bed452d4d6] and [425850ba29ebdf74552c5946fe7de2bed452d4d6] 11(21159) udp_rcv_loop: probing packet received from 203.160.97.229 50195 10(21158) radius_authorize_sterman(): Success 10(21158) save_rpid(): rpid value is '' 10(21158) DEBUG: t_addifnew: msg id=1 , global msg id=0 , T on entrance=0xffffffff 10(21158) parse_headers: flags=-1 10(21158) DEBUG: get_hdr_body : content_length=201 10(21158) found end of header 10(21158) parse_headers: flags=60 10(21158) t_lookup_request: start searching: hash=39311, isACK=0 10(21158) DEBUG: proceeding to pre-RFC3261 transaction matching 10(21158) DEBUG: t_lookup_request: no transaction found 10(21158) SER: new INVITE 10(21158) parse_headers: flags=-1 10(21158) check_via_address(203.160.97.236, 203.160.97.236, 0) 10(21158) WARNING:vqm_resize: resize(0) called 10(21158) DEBUG: reply sent out. buf=0x80db9c0: SIP/2.0 1..., shmem=0xb5618a78: SIP/2.0 1 10(21158) DEBUG: t_reply: finished 10(21158) DEBUG: mk_proxy: doing DNS lookup... 10(21158) check_via_address(203.160.97.236, 203.160.97.236, 0) 10(21158) DEBUG: add_to_tail_of_timer[4]: 0xb5617328 10(21158) DEBUG: add_to_tail_of_timer[0]: 0xb561733c 10(21158) SER: new transaction fwd'ed 10(21158) DEBUG:destroy_avp_list: destroing list (nil) 10(21158) receive_msg: cleaning up 14(21162) SIP Reply (status): 14(21162) version: <SIP/2.0> 14(21162) status: <100> 14(21162) reason: <Trying> 14(21162) parse_headers: flags=1 14(21162) Found param type 232, <branch> = <z9hG4bKf899.35479332.0>; state=9 14(21162) parse_via: next_via 14(21162) Found param type 232, <branch> = <z9hG4bkbd74baa8656e3b>; state=16 14(21162) end of header reached, state=5 14(21162) parse_headers: Via found, flags=1 14(21162) parse_headers: this is the first via 14(21162) After parse_msg... 14(21162) forward_reply: found module tm, passing reply to it 14(21162) DEBUG: t_check: msg id=1 global id=0 T start=0xffffffff 14(21162) parse_headers: flags=17 14(21162) DEBUG: add_param: tag=E753CD6-1F94 14(21162) end of header reached, state=29 14(21162) DEBUG: get_hdr_field: <To> [56]; uri=[sip:08117@203.160.97.232;user=phone] 14(21162) DEBUG: to body [sip:08117@203.160.97.232;user=phone] 14(21162) get_hdr_field: cseq <CSeq>: <2> <INVITE> 14(21162) parse_headers: flags=4 14(21162) DEBUG: t_reply_matching: hash 39311 label 590967891 branch 0 14(21162) DEBUG: t_reply_matching: reply matched (T=0xb5617200)! 14(21162) DEBUG: t_check: msg id=1 global id=1 T end=0xb5617200 14(21162) DEBUG: t_on_reply: org. status uas=100, uac[0]=0 local=0 is_invite=1) 14(21162) ->>>>>>>>> T_code=100, new_code=100 14(21162) DEBUG: relay_reply: branch=0, save=0, relay=-1 14(21162) DEBUG: add_to_tail_of_timer[1]: 0xb561733c 14(21162) DEBUG:destroy_avp_list: destroing list (nil) 14(21162) receive_msg: cleaning up 18(21166) DEBUG: timer routine:4,tl=0xb5617328 next=(nil) 16(21164) SIP Reply (status): 16(21164) version: <SIP/2.0> 16(21164) status: <183> 16(21164) reason: <Session Progress> 16(21164) parse_headers: flags=1 16(21164) Found param type 232, <branch> = <z9hG4bKf899.35479332.0>; state=9 16(21164) parse_via: next_via 16(21164) Found param type 232, <branch> = <z9hG4bkbd74baa8656e3b>; state=16 16(21164) end of header reached, state=5 16(21164) parse_headers: Via found, flags=1 16(21164) parse_headers: this is the first via 16(21164) After parse_msg... 16(21164) forward_reply: found module tm, passing reply to it 16(21164) DEBUG: t_check: msg id=1 global id=0 T start=0xffffffff 16(21164) parse_headers: flags=17 16(21164) DEBUG: add_param: tag=E753CD6-1F94 16(21164) end of header reached, state=29 16(21164) DEBUG: get_hdr_field: <To> [56]; uri=[sip:08117@203.160.97.232;user=phone] 16(21164) DEBUG: to body [sip:08117@203.160.97.232;user=phone] 16(21164) get_hdr_field: cseq <CSeq>: <2> <INVITE> 16(21164) parse_headers: flags=4 16(21164) DEBUG: t_reply_matching: hash 39311 label 590967891 branch 0 16(21164) DEBUG: t_reply_matching: reply matched (T=0xb5617200)! 16(21164) DEBUG: t_check: msg id=1 global id=1 T end=0xb5617200 16(21164) DEBUG: t_on_reply: org. status uas=100, uac[0]=100 local=0 is_invite=1) 16(21164) ->>>>>>>>> T_code=100, new_code=183 16(21164) DEBUG: relay_reply: branch=0, save=0, relay=0 16(21164) old size: 889, new size: 832 16(21164) build_res_from_sip_res: copied size: orig:92, new: 35, rest: 797 msg= SIP/2.0 183 Session Progress Via: SIP/2.0/UDP 203.160.97.236:5060;branch=z9hG4bkbd74baa8656e3b From: Zyxel01sip:100@203.160.97.232;user=phone;tag=35A33BE5CA4876B7CB To: sip:08117@203.160.97.232;user=phone;tag=E753CD6-1F94 Date: Wed, 03 Mar 1993 19:22:44 GMT Call-ID: 19943-DCB1-72FD-46D3-3FD11DC9E9C6@203.160.97.236 Server: Cisco-SIPGateway/IOS-12.x CSeq: 2 INVITE Allow-Events: telephone-event Contact: sip:08117@203.160.97.233:5060 Record-Route: sip:08117@203.160.97.232;ftag=35A33BE5CA4876B7CB;lr=on Content-Disposition: session;handling=required Content-Type: application/sdp Content-Length: 208
v=0 o=CiscoSystemsSIP-GW-UserAgent 3705 1351 IN IP4 203.160.97.233 s=SIP Call c=IN IP4 203.160.97.233 t=0 0 m=audio 17344 RTP/AVP 18 c=IN IP4 203.160.97.233 a=rtpmap:18 G729/8000 a=fmtp:18 annexb=no
16(21164) DEBUG: reply relayed. buf=0x80db138: SIP/2.0 1..., shmem=0xb56191b8: SIP/2.0 1 16(21164) DEBUG: add_to_tail_of_timer[1]: 0xb561733c 16(21164) DEBUG:destroy_avp_list: destroing list (nil) 16(21164) receive_msg: cleaning up 9(21157) SIP Reply (status): 9(21157) version: <SIP/2.0> 9(21157) status: <200> 9(21157) reason: <OK> 9(21157) parse_headers: flags=1 9(21157) Found param type 232, <branch> = <z9hG4bKf899.35479332.0>; state=9 9(21157) parse_via: next_via 9(21157) Found param type 232, <branch> = <z9hG4bkbd74baa8656e3b>; state=16 9(21157) end of header reached, state=5 9(21157) parse_headers: Via found, flags=1 9(21157) parse_headers: this is the first via 9(21157) After parse_msg... 9(21157) forward_reply: found module tm, passing reply to it 9(21157) DEBUG: t_check: msg id=4 global id=0 T start=0xffffffff 9(21157) parse_headers: flags=17 9(21157) DEBUG: add_param: tag=E753CD6-1F94 9(21157) end of header reached, state=29 9(21157) DEBUG: get_hdr_field: <To> [56]; uri=[sip:08117@203.160.97.232;user=phone] 9(21157) DEBUG: to body [sip:08117@203.160.97.232;user=phone] 9(21157) get_hdr_field: cseq <CSeq>: <2> <INVITE> 9(21157) parse_headers: flags=4 9(21157) DEBUG: t_reply_matching: hash 39311 label 590967891 branch 0 9(21157) DEBUG: t_reply_matching: reply matched (T=0xb5617200)! 9(21157) DEBUG: t_check: msg id=4 global id=4 T end=0xb5617200 9(21157) DEBUG: t_on_reply: org. status uas=183, uac[0]=183 local=0 is_invite=1) 9(21157) ->>>>>>>>> T_code=183, new_code=200 9(21157) DEBUG: relay_reply: branch=0, save=0, relay=0 9(21157) old size: 915, new size: 858 9(21157) build_res_from_sip_res: copied size: orig:78, new: 21, rest: 837 msg= SIP/2.0 200 OK Via: SIP/2.0/UDP 203.160.97.236:5060;branch=z9hG4bkbd74baa8656e3b From: Zyxel01sip:100@203.160.97.232;user=phone;tag=35A33BE5CA4876B7CB To: sip:08117@203.160.97.232;user=phone;tag=E753CD6-1F94 Date: Wed, 03 Mar 1993 19:22:44 GMT Call-ID: 19943-DCB1-72FD-46D3-3FD11DC9E9C6@203.160.97.236 Server: Cisco-SIPGateway/IOS-12.x CSeq: 2 INVITE Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, COMET, REFER, SUBSCRIBE, NOTIFY, INFO Allow-Events: telephone-event Contact: sip:08117@203.160.97.233:5060 Record-Route: sip:08117@203.160.97.232;ftag=35A33BE5CA4876B7CB;lr=on Content-Type: application/sdp Content-Length: 208
v=0 o=CiscoSystemsSIP-GW-UserAgent 3705 1351 IN IP4 203.160.97.233 s=SIP Call c=IN IP4 203.160.97.233 t=0 0 m=audio 17344 RTP/AVP 18 c=IN IP4 203.160.97.233 a=rtpmap:18 G729/8000 a=fmtp:18 annexb=no
9(21157) DEBUG: reply relayed. buf=0x80db4d0: SIP/2.0 2..., shmem=0xb56191b8: SIP/2.0 2 9(21157) DEBUG: cleanup_uacs: RETR/FR timers reset 9(21157) DEBUG: add_to_tail_of_timer[2]: 0xb5617248 9(21157) DEBUG:destroy_avp_list: destroing list (nil) 9(21157) receive_msg: cleaning up 10(21158) SIP Request: 10(21158) method: <ACK> 10(21158) uri: sip:08117@203.160.97.232 10(21158) version: <SIP/2.0> 10(21158) parse_headers: flags=1 10(21158) Found param type 232, <branch> = <z9hG4bkbd74baa8656e3b>; state=16 10(21158) end of header reached, state=5 10(21158) parse_headers: Via found, flags=1 10(21158) parse_headers: this is the first via 10(21158) After parse_msg... 10(21158) preparing to run routing scripts... 10(21158) DEBUG : sl_filter_ACK: to late to be a local ACK! 10(21158) DEBUG : is_maxfwd_present: searching for max_forwards header 10(21158) parse_headers: flags=128 10(21158) DEBUG: add_param: tag=E753CD6-1F94 10(21158) end of header reached, state=29 10(21158) DEBUG: get_hdr_field: <To> [56]; uri=[sip:08117@203.160.97.232;user=phone] 10(21158) DEBUG: to body [sip:08117@203.160.97.232;user=phone] 10(21158) get_hdr_field: cseq <CSeq>: <2> <ACK> 10(21158) DEBUG: get_hdr_body : content_length=0 10(21158) found end of header 10(21158) DEBUG: is_maxfwd_present: max_forwards header not found! 10(21158) DEBUG:destroy_avp_list: destroing list (nil) 10(21158) receive_msg: cleaning up 18(21166) DEBUG: timer routine:1,tl=0xb561733c next=(nil) 12(21160) SIP Reply (status): 12(21160) version: <SIP/2.0> 12(21160) status: <200> 12(21160) reason: <OK> 12(21160) parse_headers: flags=1 12(21160) Found param type 232, <branch> = <z9hG4bKf899.35479332.0>; state=9 12(21160) parse_via: next_via 12(21160) Found param type 232, <branch> = <z9hG4bkbd74baa8656e3b>; state=16 12(21160) end of header reached, state=5 12(21160) parse_headers: Via found, flags=1 12(21160) parse_headers: this is the first via 12(21160) After parse_msg... 12(21160) forward_reply: found module tm, passing reply to it 12(21160) DEBUG: t_check: msg id=1 global id=0 T start=0xffffffff 12(21160) parse_headers: flags=17 12(21160) DEBUG: add_param: tag=E753CD6-1F94 12(21160) end of header reached, state=29 12(21160) DEBUG: get_hdr_field: <To> [56]; uri=[sip:08117@203.160.97.232;user=phone] 12(21160) DEBUG: to body [sip:08117@203.160.97.232;user=phone] 12(21160) get_hdr_field: cseq <CSeq>: <2> <INVITE> 12(21160) parse_headers: flags=4 12(21160) DEBUG: t_reply_matching: hash 39311 label 590967891 branch 0 12(21160) DEBUG: t_reply_matching: reply matched (T=0xb5617200)! 12(21160) DEBUG: t_check: msg id=1 global id=1 T end=0xb5617200 12(21160) DEBUG: t_on_reply: org. status uas=200, uac[0]=200 local=0 is_invite=1) 12(21160) ->>>>>>>>> T_code=200, new_code=200 12(21160) DBG: t_should_relay: 200 INV after final sent 12(21160) DEBUG: relay_reply: branch=0, save=0, relay=0 12(21160) old size: 915, new size: 858 12(21160) build_res_from_sip_res: copied size: orig:78, new: 21, rest: 837 msg= SIP/2.0 200 OK Via: SIP/2.0/UDP 203.160.97.236:5060;branch=z9hG4bkbd74baa8656e3b From: Zyxel01sip:100@203.160.97.232;user=phone;tag=35A33BE5CA4876B7CB To: sip:08117@203.160.97.232;user=phone;tag=E753CD6-1F94 Date: Wed, 03 Mar 1993 19:22:44 GMT Call-ID: 19943-DCB1-72FD-46D3-3FD11DC9E9C6@203.160.97.236 Server: Cisco-SIPGateway/IOS-12.x CSeq: 2 INVITE Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, COMET, REFER, SUBSCRIBE, NOTIFY, INFO Allow-Events: telephone-event Contact: sip:08117@203.160.97.233:5060 Record-Route: sip:08117@203.160.97.232;ftag=35A33BE5CA4876B7CB;lr=on Content-Type: application/sdp Content-Length: 208
v=0 o=CiscoSystemsSIP-GW-UserAgent 3705 1351 IN IP4 203.160.97.233 s=SIP Call c=IN IP4 203.160.97.233 t=0 0 m=audio 17344 RTP/AVP 18 c=IN IP4 203.160.97.233 a=rtpmap:18 G729/8000 a=fmtp:18 annexb=no
12(21160) DEBUG: reply relayed. buf=0x80db138: SIP/2.0 2..., shmem=0xb56191b8: SIP/2.0 2 12(21160) DEBUG:destroy_avp_list: destroing list (nil) 12(21160) receive_msg: cleaning up 14(21162) SIP Reply (status): 14(21162) version: <SIP/2.0> 14(21162) status: <200> 14(21162) reason: <OK> 14(21162) parse_headers: flags=1 14(21162) Found param type 232, <branch> = <z9hG4bKf899.35479332.0>; state=9 14(21162) parse_via: next_via 14(21162) Found param type 232, <branch> = <z9hG4bkbd74baa8656e3b>; state=16 14(21162) end of header reached, state=5 14(21162) parse_headers: Via found, flags=1 14(21162) parse_headers: this is the first via 14(21162) After parse_msg... 14(21162) forward_reply: found module tm, passing reply to it 14(21162) DEBUG: t_check: msg id=2 global id=1 T start=0xffffffff 14(21162) parse_headers: flags=17 14(21162) DEBUG: add_param: tag=E753CD6-1F94 14(21162) end of header reached, state=29 14(21162) DEBUG: get_hdr_field: <To> [56]; uri=[sip:08117@203.160.97.232;user=phone] 14(21162) DEBUG: to body [sip:08117@203.160.97.232;user=phone] 14(21162) get_hdr_field: cseq <CSeq>: <2> <INVITE> 14(21162) parse_headers: flags=4 14(21162) DEBUG: t_reply_matching: hash 39311 label 590967891 branch 0 14(21162) DEBUG: t_reply_matching: reply matched (T=0xb5617200)! 14(21162) DEBUG: t_check: msg id=2 global id=2 T end=0xb5617200 14(21162) DEBUG: t_on_reply: org. status uas=200, uac[0]=200 local=0 is_invite=1) 14(21162) ->>>>>>>>> T_code=200, new_code=200 14(21162) DBG: t_should_relay: 200 INV after final sent 14(21162) DEBUG: relay_reply: branch=0, save=0, relay=0 14(21162) old size: 915, new size: 858 14(21162) build_res_from_sip_res: copied size: orig:78, new: 21, rest: 837 msg= SIP/2.0 200 OK Via: SIP/2.0/UDP 203.160.97.236:5060;branch=z9hG4bkbd74baa8656e3b From: Zyxel01sip:100@203.160.97.232;user=phone;tag=35A33BE5CA4876B7CB To: sip:08117@203.160.97.232;user=phone;tag=E753CD6-1F94 Date: Wed, 03 Mar 1993 19:22:44 GMT Call-ID: 19943-DCB1-72FD-46D3-3FD11DC9E9C6@203.160.97.236 Server: Cisco-SIPGateway/IOS-12.x CSeq: 2 INVITE Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, COMET, REFER, SUBSCRIBE, NOTIFY, INFO Allow-Events: telephone-event Contact: sip:08117@203.160.97.233:5060 Record-Route: sip:08117@203.160.97.232;ftag=35A33BE5CA4876B7CB;lr=on Content-Type: application/sdp Content-Length: 208
v=0 o=CiscoSystemsSIP-GW-UserAgent 3705 1351 IN IP4 203.160.97.233 s=SIP Call c=IN IP4 203.160.97.233 t=0 0 m=audio 17344 RTP/AVP 18 c=IN IP4 203.160.97.233 a=rtpmap:18 G729/8000 a=fmtp:18 annexb=no
14(21162) DEBUG: reply relayed. buf=0x80db138: SIP/2.0 2..., shmem=0xb56191b8: SIP/2.0 2 14(21162) DEBUG:destroy_avp_list: destroing list (nil) 14(21162) receive_msg: cleaning up 15(21163) SIP Reply (status): 15(21163) version: <SIP/2.0> 15(21163) status: <200> 15(21163) reason: <OK> 15(21163) parse_headers: flags=1 15(21163) Found param type 232, <branch> = <z9hG4bKf899.35479332.0>; state=9 15(21163) parse_via: next_via 15(21163) Found param type 232, <branch> = <z9hG4bkbd74baa8656e3b>; state=16 15(21163) end of header reached, state=5 15(21163) parse_headers: Via found, flags=1 15(21163) parse_headers: this is the first via 15(21163) After parse_msg... 15(21163) forward_reply: found module tm, passing reply to it 15(21163) DEBUG: t_check: msg id=2 global id=0 T start=0xffffffff 15(21163) parse_headers: flags=17 15(21163) DEBUG: add_param: tag=E753CD6-1F94 15(21163) end of header reached, state=29 15(21163) DEBUG: get_hdr_field: <To> [56]; uri=[sip:08117@203.160.97.232;user=phone] 15(21163) DEBUG: to body [sip:08117@203.160.97.232;user=phone] 15(21163) get_hdr_field: cseq <CSeq>: <2> <INVITE> 15(21163) parse_headers: flags=4 15(21163) DEBUG: t_reply_matching: hash 39311 label 590967891 branch 0 15(21163) DEBUG: t_reply_matching: reply matched (T=0xb5617200)! 15(21163) DEBUG: t_check: msg id=2 global id=2 T end=0xb5617200 15(21163) DEBUG: t_on_reply: org. status uas=200, uac[0]=200 local=0 is_invite=1) 15(21163) ->>>>>>>>> T_code=200, new_code=200 15(21163) DBG: t_should_relay: 200 INV after final sent 15(21163) DEBUG: relay_reply: branch=0, save=0, relay=0 15(21163) old size: 915, new size: 858 15(21163) build_res_from_sip_res: copied size: orig:78, new: 21, rest: 837 msg= SIP/2.0 200 OK Via: SIP/2.0/UDP 203.160.97.236:5060;branch=z9hG4bkbd74baa8656e3b From: Zyxel01sip:100@203.160.97.232;user=phone;tag=35A33BE5CA4876B7CB To: sip:08117@203.160.97.232;user=phone;tag=E753CD6-1F94 Date: Wed, 03 Mar 1993 19:22:44 GMT Call-ID: 19943-DCB1-72FD-46D3-3FD11DC9E9C6@203.160.97.236 Server: Cisco-SIPGateway/IOS-12.x CSeq: 2 INVITE Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, COMET, REFER, SUBSCRIBE, NOTIFY, INFO Allow-Events: telephone-event Contact: sip:08117@203.160.97.233:5060 Record-Route: sip:08117@203.160.97.232;ftag=35A33BE5CA4876B7CB;lr=on Content-Type: application/sdp Content-Length: 208
v=0 o=CiscoSystemsSIP-GW-UserAgent 3705 1351 IN IP4 203.160.97.233 s=SIP Call c=IN IP4 203.160.97.233 t=0 0 m=audio 17344 RTP/AVP 18 c=IN IP4 203.160.97.233 a=rtpmap:18 G729/8000 a=fmtp:18 annexb=no
15(21163) DEBUG: reply relayed. buf=0x80db510: SIP/2.0 2..., shmem=0xb56191b8: SIP/2.0 2 15(21163) DEBUG:destroy_avp_list: destroing list (nil) 15(21163) receive_msg: cleaning up 18(21166) DEBUG: timer routine:2,tl=0xb5617248 next=(nil) 18(21166) DEBUG: wait_handler : removing 0xb5617200 from table 18(21166) DEBUG: delete transaction 0xb5617200 18(21166) DEBUG: wait_handler : done
Yoy may want to check out this thread: http://lists.iptel.org/pipermail/serusers/2004-December/014155.html
Correctly set up connections that disconnect after a short while is a typical symptom for disappearing ACKs. I have seen the same thing with Cisco GW and Zyxel 2000W phones. Make sure your loose route config in ser.cfg picks up the ACK correctly and forwards it. g-)
Nguyen Dang Tien wrote:
Dear all , I have a problem: My Network Diagram:
IP for SER Server, Radiusclient (the same computer): 203.160.97.232 IP for Radius Server (Radiator): 203.160.97.234 IP for GW SIP to PSTN (Cisco AS5350) 203.160.97.233 IP for IP PHONE (Zyxel 2000W) 203.160.97.236
- Compile Radius client: radiusclient-0.4.8.tar.gz ./configure Make all Make install
- Compile SER -- Change Exclude modules in Makefiles: remove "auth_radius",
"group_radius", and "uri_radius" among excluded modules.
Make proper Make all Make install
- I have change Radiusclient.conf (in /usr/local/etc/radiusclient)for
Radiusclient :
.... Authserver 203.160.97.234:1645 Accserver 203.160.97.234:1646
Binaddr 203.160.97.232
Add line in file dictionary $INCLUDE /usr/local/etc/radiusclient/dictionary.ser
Change file servers 203.160.97.234 mysecret
add line /usr/local/lib in file /etc/ld.so.conf ldconfig –v
1: I use IP phone or SIP soft phone (xten) dial directly to GW as5350 and don't use SIP server + radius, everything is OK 2: IP phone or SIP client authenicated by radius radiator OK 3: Make a call by IP phone --->SIP(SER + Radius)---->GW----->PSTN : OK
But time for call is only 8 second -- But time for call is only 8 second
This is my ser.cfg: # # $Id: ser.cfg,v 1.21.4.1 2003/11/10 15:35:15 andrei Exp $ # ----------- global configuration parameters ------------------------
debug=8 fork=yes log_stderror=yes
check_via=no # (cmd. line: -v) dns=no # (cmd. line: -r) rev_dns=no # (cmd. line: -R) port=5060 #children=4 fifo="/tmp/ser_fifo"
# ------------------ module loading ---------------------------------- loadmodule "/usr/local/lib/ser/modules/sl.so" loadmodule "/usr/local/lib/ser/modules/tm.so" loadmodule "/usr/local/lib/ser/modules/rr.so" loadmodule "/usr/local/lib/ser/modules/maxfwd.so" loadmodule "/usr/local/lib/ser/modules/usrloc.so" loadmodule "/usr/local/lib/ser/modules/registrar.so"
loadmodule "/usr/local/lib/ser/modules/auth.so" loadmodule "/usr/local/lib/ser/modules/auth_radius.so"
# ----------------- setting module-specific parameters --------------- modparam("usrloc", "db_mode", 0) modparam("rr", "enable_full_lr", 1) # ------------------------- request routing logic -------------------
route{
if (!mf_process_maxfwd_header("10")) { sl_send_reply("483","Too Many Hops"); break; }; if ( msg:len > max_len ) { sl_send_reply("513", "Message too big"); break; }; # authenticate register message using radius if (method=="REGISTER") { # Uncomment this if you want to use digest authentication if (!radius_www_authorize("")) { www_challenge("", "0"); break; }; save("location"); break; }; # route (proxy) invite message to gateway if (method=="INVITE") || (method=="CANCEL") { # Uncomment this if you want to use digest authentication if (!radius_www_authorize("")) { www_challenge("", "0"); break; }; record_route(); rewritehostport("203.160.97.233:5060"); if (!t_relay()) { sl_reply_error(); }; break; };}
My Debug session:
[root@SIP-SG01 sbin]# 15(21163) SIP Request: 15(21163) method: <INVITE> 15(21163) uri: sip:08117@203.160.97.232:5060 15(21163) version: <SIP/2.0> 15(21163) parse_headers: flags=1 15(21163) Found param type 232, <branch> = <z9hG4bkbd74baa8656e3b>; state=16 15(21163) end of header reached, state=5 15(21163) parse_headers: Via found, flags=1 15(21163) parse_headers: this is the first via 15(21163) After parse_msg... 15(21163) preparing to run routing scripts... 15(21163) DEBUG : is_maxfwd_present: searching for max_forwards header 15(21163) parse_headers: flags=128 15(21163) end of header reached, state=9 15(21163) DEBUG: get_hdr_field: <To> [39]; uri=[sip:08117@203.160.97.232;user=phone] 15(21163) DEBUG: to body [sip:08117@203.160.97.232;user=phone ] 15(21163) get_hdr_field: cseq <CSeq>: <1> <INVITE> 15(21163) DEBUG: is_maxfwd_present: value = 70 15(21163) DEBUG: add_param: tag=35A33BE5CA4876B7CB 15(21163) end of header reached, state=29 15(21163) parse_headers: flags=4096 15(21163) DEBUG: get_hdr_body : content_length=201 15(21163) found end of header 15(21163) pre_auth(): Credentials with given realm not found 15(21163) build_auth_hf(): 'WWW-Authenticate: Digest realm="203.160.97.232", nonce="425850ba29ebdf74552c5946fe7de2bed452d4d6" ' 15(21163) parse_headers: flags=-1 15(21163) check_via_address(203.160.97.236, 203.160.97.236, 0) 15(21163) DEBUG:destroy_avp_list: destroing list (nil) 15(21163) receive_msg: cleaning up 9(21157) SIP Request: 9(21157) method: <ACK> 9(21157) uri: sip:08117@203.160.97.232:5060 9(21157) version: <SIP/2.0> 9(21157) parse_headers: flags=1 9(21157) Found param type 232, <branch> = <z9hG4bkbd74baa8656e3b>; state=16 9(21157) end of header reached, state=5 9(21157) parse_headers: Via found, flags=1 9(21157) parse_headers: this is the first via 9(21157) After parse_msg... 9(21157) preparing to run routing scripts... 9(21157) parse_headers: flags=4 9(21157) DEBUG: add_param: tag=b27e1a1d33761e85846fc98f5f3a7e58.35a3 9(21157) end of header reached, state=29 9(21157) DEBUG: get_hdr_field: <To> [81]; uri=[sip:08117@203.160.97.232;user=phone] 9(21157) DEBUG: to body [sip:08117@203.160.97.232;user=phone] 9(21157) DEBUG: sl_filter_ACK : local ACK found -> dropping it! 9(21157) DEBUG:destroy_avp_list: destroing list (nil) 9(21157) receive_msg: cleaning up 10(21158) SIP Request: 10(21158) method: <INVITE> 10(21158) uri: sip:08117@203.160.97.232:5060 10(21158) version: <SIP/2.0> 10(21158) parse_headers: flags=1 10(21158) Found param type 232, <branch> = <z9hG4bkbd74baa8656e3b>; state=16 10(21158) end of header reached, state=5 10(21158) parse_headers: Via found, flags=1 10(21158) parse_headers: this is the first via 10(21158) After parse_msg... 10(21158) preparing to run routing scripts... 10(21158) DEBUG : is_maxfwd_present: searching for max_forwards header 10(21158) parse_headers: flags=128 10(21158) end of header reached, state=9 10(21158) DEBUG: get_hdr_field: <To> [39]; uri=[sip:08117@203.160.97.232;user=phone] 10(21158) DEBUG: to body [sip:08117@203.160.97.232;user=phone ] 10(21158) get_hdr_field: cseq <CSeq>: <2> <INVITE> 10(21158) DEBUG: is_maxfwd_present: value = 70 10(21158) DEBUG: add_param: tag=35A33BE5CA4876B7CB 10(21158) end of header reached, state=29 10(21158) check_nonce(): comparing [425850ba29ebdf74552c5946fe7de2bed452d4d6] and [425850ba29ebdf74552c5946fe7de2bed452d4d6] 11(21159) udp_rcv_loop: probing packet received from 203.160.97.229 50195 10(21158) radius_authorize_sterman(): Success 10(21158) save_rpid(): rpid value is '' 10(21158) DEBUG: t_addifnew: msg id=1 , global msg id=0 , T on entrance=0xffffffff 10(21158) parse_headers: flags=-1 10(21158) DEBUG: get_hdr_body : content_length=201 10(21158) found end of header 10(21158) parse_headers: flags=60 10(21158) t_lookup_request: start searching: hash=39311, isACK=0 10(21158) DEBUG: proceeding to pre-RFC3261 transaction matching 10(21158) DEBUG: t_lookup_request: no transaction found 10(21158) SER: new INVITE 10(21158) parse_headers: flags=-1 10(21158) check_via_address(203.160.97.236, 203.160.97.236, 0) 10(21158) WARNING:vqm_resize: resize(0) called 10(21158) DEBUG: reply sent out. buf=0x80db9c0: SIP/2.0 1..., shmem=0xb5618a78: SIP/2.0 1 10(21158) DEBUG: t_reply: finished 10(21158) DEBUG: mk_proxy: doing DNS lookup... 10(21158) check_via_address(203.160.97.236, 203.160.97.236, 0) 10(21158) DEBUG: add_to_tail_of_timer[4]: 0xb5617328 10(21158) DEBUG: add_to_tail_of_timer[0]: 0xb561733c 10(21158) SER: new transaction fwd'ed 10(21158) DEBUG:destroy_avp_list: destroing list (nil) 10(21158) receive_msg: cleaning up 14(21162) SIP Reply (status): 14(21162) version: <SIP/2.0> 14(21162) status: <100> 14(21162) reason: <Trying> 14(21162) parse_headers: flags=1 14(21162) Found param type 232, <branch> = <z9hG4bKf899.35479332.0>; state=9 14(21162) parse_via: next_via 14(21162) Found param type 232, <branch> = <z9hG4bkbd74baa8656e3b>; state=16 14(21162) end of header reached, state=5 14(21162) parse_headers: Via found, flags=1 14(21162) parse_headers: this is the first via 14(21162) After parse_msg... 14(21162) forward_reply: found module tm, passing reply to it 14(21162) DEBUG: t_check: msg id=1 global id=0 T start=0xffffffff 14(21162) parse_headers: flags=17 14(21162) DEBUG: add_param: tag=E753CD6-1F94 14(21162) end of header reached, state=29 14(21162) DEBUG: get_hdr_field: <To> [56]; uri=[sip:08117@203.160.97.232;user=phone] 14(21162) DEBUG: to body [sip:08117@203.160.97.232;user=phone] 14(21162) get_hdr_field: cseq <CSeq>: <2> <INVITE> 14(21162) parse_headers: flags=4 14(21162) DEBUG: t_reply_matching: hash 39311 label 590967891 branch 0 14(21162) DEBUG: t_reply_matching: reply matched (T=0xb5617200)! 14(21162) DEBUG: t_check: msg id=1 global id=1 T end=0xb5617200 14(21162) DEBUG: t_on_reply: org. status uas=100, uac[0]=0 local=0 is_invite=1) 14(21162) ->>>>>>>>> T_code=100, new_code=100 14(21162) DEBUG: relay_reply: branch=0, save=0, relay=-1 14(21162) DEBUG: add_to_tail_of_timer[1]: 0xb561733c 14(21162) DEBUG:destroy_avp_list: destroing list (nil) 14(21162) receive_msg: cleaning up 18(21166) DEBUG: timer routine:4,tl=0xb5617328 next=(nil) 16(21164) SIP Reply (status): 16(21164) version: <SIP/2.0> 16(21164) status: <183> 16(21164) reason: <Session Progress> 16(21164) parse_headers: flags=1 16(21164) Found param type 232, <branch> = <z9hG4bKf899.35479332.0>; state=9 16(21164) parse_via: next_via 16(21164) Found param type 232, <branch> = <z9hG4bkbd74baa8656e3b>; state=16 16(21164) end of header reached, state=5 16(21164) parse_headers: Via found, flags=1 16(21164) parse_headers: this is the first via 16(21164) After parse_msg... 16(21164) forward_reply: found module tm, passing reply to it 16(21164) DEBUG: t_check: msg id=1 global id=0 T start=0xffffffff 16(21164) parse_headers: flags=17 16(21164) DEBUG: add_param: tag=E753CD6-1F94 16(21164) end of header reached, state=29 16(21164) DEBUG: get_hdr_field: <To> [56]; uri=[sip:08117@203.160.97.232;user=phone] 16(21164) DEBUG: to body [sip:08117@203.160.97.232;user=phone] 16(21164) get_hdr_field: cseq <CSeq>: <2> <INVITE> 16(21164) parse_headers: flags=4 16(21164) DEBUG: t_reply_matching: hash 39311 label 590967891 branch 0 16(21164) DEBUG: t_reply_matching: reply matched (T=0xb5617200)! 16(21164) DEBUG: t_check: msg id=1 global id=1 T end=0xb5617200 16(21164) DEBUG: t_on_reply: org. status uas=100, uac[0]=100 local=0 is_invite=1) 16(21164) ->>>>>>>>> T_code=100, new_code=183 16(21164) DEBUG: relay_reply: branch=0, save=0, relay=0 16(21164) old size: 889, new size: 832 16(21164) build_res_from_sip_res: copied size: orig:92, new: 35, rest: 797 msg= SIP/2.0 183 Session Progress Via: SIP/2.0/UDP 203.160.97.236:5060;branch=z9hG4bkbd74baa8656e3b From: Zyxel01sip:100@203.160.97.232;user=phone;tag=35A33BE5CA4876B7CB To: sip:08117@203.160.97.232;user=phone;tag=E753CD6-1F94 Date: Wed, 03 Mar 1993 19:22:44 GMT Call-ID: 19943-DCB1-72FD-46D3-3FD11DC9E9C6@203.160.97.236 Server: Cisco-SIPGateway/IOS-12.x CSeq: 2 INVITE Allow-Events: telephone-event Contact: sip:08117@203.160.97.233:5060 Record-Route: sip:08117@203.160.97.232;ftag=35A33BE5CA4876B7CB;lr=on Content-Disposition: session;handling=required Content-Type: application/sdp Content-Length: 208
v=0 o=CiscoSystemsSIP-GW-UserAgent 3705 1351 IN IP4 203.160.97.233 s=SIP Call c=IN IP4 203.160.97.233 t=0 0 m=audio 17344 RTP/AVP 18 c=IN IP4 203.160.97.233 a=rtpmap:18 G729/8000 a=fmtp:18 annexb=no
16(21164) DEBUG: reply relayed. buf=0x80db138: SIP/2.0 1..., shmem=0xb56191b8: SIP/2.0 1 16(21164) DEBUG: add_to_tail_of_timer[1]: 0xb561733c 16(21164) DEBUG:destroy_avp_list: destroing list (nil) 16(21164) receive_msg: cleaning up 9(21157) SIP Reply (status): 9(21157) version: <SIP/2.0> 9(21157) status: <200> 9(21157) reason: <OK> 9(21157) parse_headers: flags=1 9(21157) Found param type 232, <branch> = <z9hG4bKf899.35479332.0>; state=9 9(21157) parse_via: next_via 9(21157) Found param type 232, <branch> = <z9hG4bkbd74baa8656e3b>; state=16 9(21157) end of header reached, state=5 9(21157) parse_headers: Via found, flags=1 9(21157) parse_headers: this is the first via 9(21157) After parse_msg... 9(21157) forward_reply: found module tm, passing reply to it 9(21157) DEBUG: t_check: msg id=4 global id=0 T start=0xffffffff 9(21157) parse_headers: flags=17 9(21157) DEBUG: add_param: tag=E753CD6-1F94 9(21157) end of header reached, state=29 9(21157) DEBUG: get_hdr_field: <To> [56]; uri=[sip:08117@203.160.97.232;user=phone] 9(21157) DEBUG: to body [sip:08117@203.160.97.232;user=phone] 9(21157) get_hdr_field: cseq <CSeq>: <2> <INVITE> 9(21157) parse_headers: flags=4 9(21157) DEBUG: t_reply_matching: hash 39311 label 590967891 branch 0 9(21157) DEBUG: t_reply_matching: reply matched (T=0xb5617200)! 9(21157) DEBUG: t_check: msg id=4 global id=4 T end=0xb5617200 9(21157) DEBUG: t_on_reply: org. status uas=183, uac[0]=183 local=0 is_invite=1) 9(21157) ->>>>>>>>> T_code=183, new_code=200 9(21157) DEBUG: relay_reply: branch=0, save=0, relay=0 9(21157) old size: 915, new size: 858 9(21157) build_res_from_sip_res: copied size: orig:78, new: 21, rest: 837 msg= SIP/2.0 200 OK Via: SIP/2.0/UDP 203.160.97.236:5060;branch=z9hG4bkbd74baa8656e3b From: Zyxel01sip:100@203.160.97.232;user=phone;tag=35A33BE5CA4876B7CB To: sip:08117@203.160.97.232;user=phone;tag=E753CD6-1F94 Date: Wed, 03 Mar 1993 19:22:44 GMT Call-ID: 19943-DCB1-72FD-46D3-3FD11DC9E9C6@203.160.97.236 Server: Cisco-SIPGateway/IOS-12.x CSeq: 2 INVITE Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, COMET, REFER, SUBSCRIBE, NOTIFY, INFO Allow-Events: telephone-event Contact: sip:08117@203.160.97.233:5060 Record-Route: sip:08117@203.160.97.232;ftag=35A33BE5CA4876B7CB;lr=on Content-Type: application/sdp Content-Length: 208
v=0 o=CiscoSystemsSIP-GW-UserAgent 3705 1351 IN IP4 203.160.97.233 s=SIP Call c=IN IP4 203.160.97.233 t=0 0 m=audio 17344 RTP/AVP 18 c=IN IP4 203.160.97.233 a=rtpmap:18 G729/8000 a=fmtp:18 annexb=no
9(21157) DEBUG: reply relayed. buf=0x80db4d0: SIP/2.0 2..., shmem=0xb56191b8: SIP/2.0 2 9(21157) DEBUG: cleanup_uacs: RETR/FR timers reset 9(21157) DEBUG: add_to_tail_of_timer[2]: 0xb5617248 9(21157) DEBUG:destroy_avp_list: destroing list (nil) 9(21157) receive_msg: cleaning up 10(21158) SIP Request: 10(21158) method: <ACK> 10(21158) uri: sip:08117@203.160.97.232 10(21158) version: <SIP/2.0> 10(21158) parse_headers: flags=1 10(21158) Found param type 232, <branch> = <z9hG4bkbd74baa8656e3b>; state=16 10(21158) end of header reached, state=5 10(21158) parse_headers: Via found, flags=1 10(21158) parse_headers: this is the first via 10(21158) After parse_msg... 10(21158) preparing to run routing scripts... 10(21158) DEBUG : sl_filter_ACK: to late to be a local ACK! 10(21158) DEBUG : is_maxfwd_present: searching for max_forwards header 10(21158) parse_headers: flags=128 10(21158) DEBUG: add_param: tag=E753CD6-1F94 10(21158) end of header reached, state=29 10(21158) DEBUG: get_hdr_field: <To> [56]; uri=[sip:08117@203.160.97.232;user=phone] 10(21158) DEBUG: to body [sip:08117@203.160.97.232;user=phone] 10(21158) get_hdr_field: cseq <CSeq>: <2> <ACK> 10(21158) DEBUG: get_hdr_body : content_length=0 10(21158) found end of header 10(21158) DEBUG: is_maxfwd_present: max_forwards header not found! 10(21158) DEBUG:destroy_avp_list: destroing list (nil) 10(21158) receive_msg: cleaning up 18(21166) DEBUG: timer routine:1,tl=0xb561733c next=(nil) 12(21160) SIP Reply (status): 12(21160) version: <SIP/2.0> 12(21160) status: <200> 12(21160) reason: <OK> 12(21160) parse_headers: flags=1 12(21160) Found param type 232, <branch> = <z9hG4bKf899.35479332.0>; state=9 12(21160) parse_via: next_via 12(21160) Found param type 232, <branch> = <z9hG4bkbd74baa8656e3b>; state=16 12(21160) end of header reached, state=5 12(21160) parse_headers: Via found, flags=1 12(21160) parse_headers: this is the first via 12(21160) After parse_msg... 12(21160) forward_reply: found module tm, passing reply to it 12(21160) DEBUG: t_check: msg id=1 global id=0 T start=0xffffffff 12(21160) parse_headers: flags=17 12(21160) DEBUG: add_param: tag=E753CD6-1F94 12(21160) end of header reached, state=29 12(21160) DEBUG: get_hdr_field: <To> [56]; uri=[sip:08117@203.160.97.232;user=phone] 12(21160) DEBUG: to body [sip:08117@203.160.97.232;user=phone] 12(21160) get_hdr_field: cseq <CSeq>: <2> <INVITE> 12(21160) parse_headers: flags=4 12(21160) DEBUG: t_reply_matching: hash 39311 label 590967891 branch 0 12(21160) DEBUG: t_reply_matching: reply matched (T=0xb5617200)! 12(21160) DEBUG: t_check: msg id=1 global id=1 T end=0xb5617200 12(21160) DEBUG: t_on_reply: org. status uas=200, uac[0]=200 local=0 is_invite=1) 12(21160) ->>>>>>>>> T_code=200, new_code=200 12(21160) DBG: t_should_relay: 200 INV after final sent 12(21160) DEBUG: relay_reply: branch=0, save=0, relay=0 12(21160) old size: 915, new size: 858 12(21160) build_res_from_sip_res: copied size: orig:78, new: 21, rest: 837 msg= SIP/2.0 200 OK Via: SIP/2.0/UDP 203.160.97.236:5060;branch=z9hG4bkbd74baa8656e3b From: Zyxel01sip:100@203.160.97.232;user=phone;tag=35A33BE5CA4876B7CB To: sip:08117@203.160.97.232;user=phone;tag=E753CD6-1F94 Date: Wed, 03 Mar 1993 19:22:44 GMT Call-ID: 19943-DCB1-72FD-46D3-3FD11DC9E9C6@203.160.97.236 Server: Cisco-SIPGateway/IOS-12.x CSeq: 2 INVITE Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, COMET, REFER, SUBSCRIBE, NOTIFY, INFO Allow-Events: telephone-event Contact: sip:08117@203.160.97.233:5060 Record-Route: sip:08117@203.160.97.232;ftag=35A33BE5CA4876B7CB;lr=on Content-Type: application/sdp Content-Length: 208
v=0 o=CiscoSystemsSIP-GW-UserAgent 3705 1351 IN IP4 203.160.97.233 s=SIP Call c=IN IP4 203.160.97.233 t=0 0 m=audio 17344 RTP/AVP 18 c=IN IP4 203.160.97.233 a=rtpmap:18 G729/8000 a=fmtp:18 annexb=no
12(21160) DEBUG: reply relayed. buf=0x80db138: SIP/2.0 2..., shmem=0xb56191b8: SIP/2.0 2 12(21160) DEBUG:destroy_avp_list: destroing list (nil) 12(21160) receive_msg: cleaning up 14(21162) SIP Reply (status): 14(21162) version: <SIP/2.0> 14(21162) status: <200> 14(21162) reason: <OK> 14(21162) parse_headers: flags=1 14(21162) Found param type 232, <branch> = <z9hG4bKf899.35479332.0>; state=9 14(21162) parse_via: next_via 14(21162) Found param type 232, <branch> = <z9hG4bkbd74baa8656e3b>; state=16 14(21162) end of header reached, state=5 14(21162) parse_headers: Via found, flags=1 14(21162) parse_headers: this is the first via 14(21162) After parse_msg... 14(21162) forward_reply: found module tm, passing reply to it 14(21162) DEBUG: t_check: msg id=2 global id=1 T start=0xffffffff 14(21162) parse_headers: flags=17 14(21162) DEBUG: add_param: tag=E753CD6-1F94 14(21162) end of header reached, state=29 14(21162) DEBUG: get_hdr_field: <To> [56]; uri=[sip:08117@203.160.97.232;user=phone] 14(21162) DEBUG: to body [sip:08117@203.160.97.232;user=phone] 14(21162) get_hdr_field: cseq <CSeq>: <2> <INVITE> 14(21162) parse_headers: flags=4 14(21162) DEBUG: t_reply_matching: hash 39311 label 590967891 branch 0 14(21162) DEBUG: t_reply_matching: reply matched (T=0xb5617200)! 14(21162) DEBUG: t_check: msg id=2 global id=2 T end=0xb5617200 14(21162) DEBUG: t_on_reply: org. status uas=200, uac[0]=200 local=0 is_invite=1) 14(21162) ->>>>>>>>> T_code=200, new_code=200 14(21162) DBG: t_should_relay: 200 INV after final sent 14(21162) DEBUG: relay_reply: branch=0, save=0, relay=0 14(21162) old size: 915, new size: 858 14(21162) build_res_from_sip_res: copied size: orig:78, new: 21, rest: 837 msg= SIP/2.0 200 OK Via: SIP/2.0/UDP 203.160.97.236:5060;branch=z9hG4bkbd74baa8656e3b From: Zyxel01sip:100@203.160.97.232;user=phone;tag=35A33BE5CA4876B7CB To: sip:08117@203.160.97.232;user=phone;tag=E753CD6-1F94 Date: Wed, 03 Mar 1993 19:22:44 GMT Call-ID: 19943-DCB1-72FD-46D3-3FD11DC9E9C6@203.160.97.236 Server: Cisco-SIPGateway/IOS-12.x CSeq: 2 INVITE Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, COMET, REFER, SUBSCRIBE, NOTIFY, INFO Allow-Events: telephone-event Contact: sip:08117@203.160.97.233:5060 Record-Route: sip:08117@203.160.97.232;ftag=35A33BE5CA4876B7CB;lr=on Content-Type: application/sdp Content-Length: 208
v=0 o=CiscoSystemsSIP-GW-UserAgent 3705 1351 IN IP4 203.160.97.233 s=SIP Call c=IN IP4 203.160.97.233 t=0 0 m=audio 17344 RTP/AVP 18 c=IN IP4 203.160.97.233 a=rtpmap:18 G729/8000 a=fmtp:18 annexb=no
14(21162) DEBUG: reply relayed. buf=0x80db138: SIP/2.0 2..., shmem=0xb56191b8: SIP/2.0 2 14(21162) DEBUG:destroy_avp_list: destroing list (nil) 14(21162) receive_msg: cleaning up 15(21163) SIP Reply (status): 15(21163) version: <SIP/2.0> 15(21163) status: <200> 15(21163) reason: <OK> 15(21163) parse_headers: flags=1 15(21163) Found param type 232, <branch> = <z9hG4bKf899.35479332.0>; state=9 15(21163) parse_via: next_via 15(21163) Found param type 232, <branch> = <z9hG4bkbd74baa8656e3b>; state=16 15(21163) end of header reached, state=5 15(21163) parse_headers: Via found, flags=1 15(21163) parse_headers: this is the first via 15(21163) After parse_msg... 15(21163) forward_reply: found module tm, passing reply to it 15(21163) DEBUG: t_check: msg id=2 global id=0 T start=0xffffffff 15(21163) parse_headers: flags=17 15(21163) DEBUG: add_param: tag=E753CD6-1F94 15(21163) end of header reached, state=29 15(21163) DEBUG: get_hdr_field: <To> [56]; uri=[sip:08117@203.160.97.232;user=phone] 15(21163) DEBUG: to body [sip:08117@203.160.97.232;user=phone] 15(21163) get_hdr_field: cseq <CSeq>: <2> <INVITE> 15(21163) parse_headers: flags=4 15(21163) DEBUG: t_reply_matching: hash 39311 label 590967891 branch 0 15(21163) DEBUG: t_reply_matching: reply matched (T=0xb5617200)! 15(21163) DEBUG: t_check: msg id=2 global id=2 T end=0xb5617200 15(21163) DEBUG: t_on_reply: org. status uas=200, uac[0]=200 local=0 is_invite=1) 15(21163) ->>>>>>>>> T_code=200, new_code=200 15(21163) DBG: t_should_relay: 200 INV after final sent 15(21163) DEBUG: relay_reply: branch=0, save=0, relay=0 15(21163) old size: 915, new size: 858 15(21163) build_res_from_sip_res: copied size: orig:78, new: 21, rest: 837 msg= SIP/2.0 200 OK Via: SIP/2.0/UDP 203.160.97.236:5060;branch=z9hG4bkbd74baa8656e3b From: Zyxel01sip:100@203.160.97.232;user=phone;tag=35A33BE5CA4876B7CB To: sip:08117@203.160.97.232;user=phone;tag=E753CD6-1F94 Date: Wed, 03 Mar 1993 19:22:44 GMT Call-ID: 19943-DCB1-72FD-46D3-3FD11DC9E9C6@203.160.97.236 Server: Cisco-SIPGateway/IOS-12.x CSeq: 2 INVITE Allow: INVITE, OPTIONS, BYE, CANCEL, ACK, PRACK, COMET, REFER, SUBSCRIBE, NOTIFY, INFO Allow-Events: telephone-event Contact: sip:08117@203.160.97.233:5060 Record-Route: sip:08117@203.160.97.232;ftag=35A33BE5CA4876B7CB;lr=on Content-Type: application/sdp Content-Length: 208
v=0 o=CiscoSystemsSIP-GW-UserAgent 3705 1351 IN IP4 203.160.97.233 s=SIP Call c=IN IP4 203.160.97.233 t=0 0 m=audio 17344 RTP/AVP 18 c=IN IP4 203.160.97.233 a=rtpmap:18 G729/8000 a=fmtp:18 annexb=no
15(21163) DEBUG: reply relayed. buf=0x80db510: SIP/2.0 2..., shmem=0xb56191b8: SIP/2.0 2 15(21163) DEBUG:destroy_avp_list: destroing list (nil) 15(21163) receive_msg: cleaning up 18(21166) DEBUG: timer routine:2,tl=0xb5617248 next=(nil) 18(21166) DEBUG: wait_handler : removing 0xb5617200 from table 18(21166) DEBUG: delete transaction 0xb5617200 18(21166) DEBUG: wait_handler : done
Serusers mailing list serusers@lists.iptel.org http://lists.iptel.org/mailman/listinfo/serusers
-
Greger V. Teigre -
Nguyen Dang Tien