[Serusers] Proxy Problem Using CPL
Rohit Mutsuddi
mrohit at mahindrabt.com
Thu Oct 14 13:03:44 CEST 2004
Hi
This is the problem that i had using time-of day routing using proxy. First
i used is_staeful and force_stateful parameters. and the errors were
0(11326) SIP Request:
0(11326) method: <INVITE>
0(11326) uri: <sip:5002 at alice>
0(11326) version: <SIP/2.0>
0(11326) parse_headers: flags=1
0(11326) Found param type 235, <rport> = <n/a>; state=6
0(11326) Found param type 232, <branch> =
<z9hG4bK8C066CA53B44433989920A64C0268CF8>; state=16
0(11326) end of header reached, state=5
0(11326) parse_headers: Via found, flags=1
0(11326) parse_headers: this is the first via
0(11326) After parse_msg...
0(11326) preparing to run routing scripts...
0(11326) DEBUG : is_maxfwd_present: searching for max_forwards header
0(11326) parse_headers: flags=128
0(11326) end of header reached, state=9
0(11326) DEBUG: get_hdr_field: <To> [18]; uri=[sip:5002 at alice]
0(11326) DEBUG: to body [<sip:5002 at alice>
]
0(11326) get_hdr_field: cseq <CSeq>: <50033> <INVITE>
0(11326) DEBUG: is_maxfwd_present: value = 70
0(11326) DEBUG: add_param: tag=3119834829
0(11326) end of header reached, state=29
0(11326) parse_headers: flags=256
0(11326) DEBUG: get_hdr_body : content_length=293
0(11326) found end of header
0(11326) find_first_route(): No Route headers found
0(11326) loose_route(): There is no Route HF
0(11326) check_self - checking if host==us: 5==9 && [alice] == [10.5.1.11]
0(11326) check_self - checking if port 5060 matches port 5060
0(11326) DEBUG:cpl-c:get_dest_user: tring to get user from new_uri
0(11326) DEBUG:cpl-c:get_dest_user: tring to get user from R_uri
0(11326) DEBUG:get_user_script: fetching script for user <5002 at alice>
0(11326) query="select cpl_bin from cpl where user='5002 at alice'"
0(11326) DEBUG:get_user_script: we got the script len=134
0(11326) DEBUG:cpl_run_script: processing CPL node
0(11326) DEBUG:cpl_run_script: processing time-switch node
0(11326) DEBUG:cpl-c:run_time_switch: checking recv. time stamp <1097768133>
0(11326) ---> fill = Thu Oct 14 21:05:33 2004
0(11326) DEBUG:cpl_c:run_time_node: attribute [0] found :[20041001T000000]
0(11326) ----->dtstart = 1096569000 | Fri Oct 1 00:00:00 2004
0(11326) DEBUG:cpl_c:run_time_node: attribute [2] found :[PT24H]
0(11326) DEBUG:cpl_c:run_time_node: attribute [3] found :[weekly]
0(11326) DEBUG:cpl_c:run_time_node: attribute [10] found :[MO,WE,FR]
0(11326) DEBUG:cpl_c:run_time_switch: time cond. doesn't match !
0(11326) DEBUG:cpl-c:run_time_switch: matching on OTHERWISE node
0(11326) DEBUG:cpl_run_script: processing location node
0(11326) DEBUG:cpl_run_script: processing proxy node
0(11326) parse_headers: flags=16777216
0(11326) parse_headers: flags=4194304
0(11326) parse_headers: flags=2097152
0(11326) parse_headers: flags=8388608
0(11326) DEBUG: t_check: msg id=3 global id=0 T start=0xffffffff
0(11326) parse_headers: flags=-1
0(11326) parse_headers: flags=60
0(11326) t_lookup_request: start searching: hash=36281, isACK=0
0(11326) DEBUG: RFC3261 transaction matching failed
0(11326) DEBUG: t_lookup_request: no transaction found
0(11326) DEBUG: t_check: msg id=3 global id=3 T end=(nil)
0(11326) ERROR: t_reply: cannot send a t_reply to a message for which no
T-state has been established
0(11326) ERROR:cpl-c:run_proxy: failed to build new transaction!
0(11326) ERROR:cpl_c:cpl_run_script: runtime error
0(11326) rwrite(): Rewriting Request-URI with 'sip:5002 at 10.5.8.180:5060'
0(11326) DEBUG: t_addifnew: msg id=3 , global msg id=3 , T on entrance=(nil)
0(11326) parse_headers: flags=-1
0(11326) parse_headers: flags=60
0(11326) t_lookup_request: start searching: hash=36281, isACK=0
0(11326) DEBUG: RFC3261 transaction matching failed
0(11326) DEBUG: t_lookup_request: no transaction found
0(11326) SER: new INVITE
0(11326) parse_headers: flags=-1
0(11326) check_via_address(10.5.10.117, 10.5.10.117, 0)
0(11326) WARNING:vqm_resize: resize(0) called
0(11326) DEBUG: reply sent out. buf=0x80f2df8: SIP/2.0 1...,
shmem=0x402facc0: SIP/2.0 1
0(11326) DEBUG: t_reply: finished
0(11326) DEBUG: mk_proxy: doing DNS lookup...
0(11326) check_via_address(10.5.10.117, 10.5.10.117, 0)
0(11326) DEBUG: add_to_tail_of_timer[4]: 0x402f9748
0(11326) DEBUG: add_to_tail_of_timer[0]: 0x402f975c
0(11326) SER: new transaction fwd'ed
0(11326) DEBUG:destroy_avp_list: destroing list (nil)
0(11326) receive_msg: cleaning up
0(11326) SIP Reply (status):
0(11326) version: <SIP/2.0>
0(11326) status: <100>
0(11326) reason: <Trying>
0(11326) parse_headers: flags=1
0(11326) Found param type 232, <branch> = <z9hG4bK9bd8.a252786.0>; state=16
0(11326) end of header reached, state=5
0(11326) parse_headers: Via found, flags=1
0(11326) parse_headers: this is the first via
0(11326) After parse_msg...
0(11326) forward_reply: found module tm, passing reply to it
0(11326) DEBUG: t_check: msg id=4 global id=3 T start=0xffffffff
0(11326) parse_headers: flags=17
0(11326) Found param type 235, <rport> = <5060>; state=6
0(11326) Found param type 232, <branch> =
<z9hG4bK8C066CA53B44433989920A64C0268CF8>; state=16
0(11326) end of header reached, state=5
0(11326) parse_headers: Via found, flags=17
0(11326) parse_headers: this is the second via
0(11326) DEBUG: add_param: tag=122657584
0(11326) end of header reached, state=29
0(11326) DEBUG: get_hdr_field: <To> [32]; uri=[sip:5002 at alice]
0(11326) DEBUG: to body [<sip:5002 at alice>]
0(11326) get_hdr_field: cseq <CSeq>: <50033> <INVITE>
0(11326) parse_headers: flags=4
0(11326) DEBUG: t_reply_matching: hash 36281 label 109520170 branch 0
0(11326) DEBUG: t_reply_matching: reply matched (T=0x402f9620)!
0(11326) DEBUG: t_check: msg id=4 global id=4 T end=0x402f9620
0(11326) DEBUG: t_on_reply: org. status uas=100, uac[0]=0 local=0
is_invite=1)
0(11326) ->>>>>>>>> T_code=100, new_code=100
0(11326) DEBUG: relay_reply: branch=0, save=0, relay=-1
0(11326) DEBUG: add_to_tail_of_timer[1]: 0x402f975c
0(11326) DEBUG:destroy_avp_list: destroing list (nil)
0(11326) receive_msg: cleaning up
0(11326) SIP Reply (status):
0(11326) version: <SIP/2.0>
0(11326) status: <180>
0(11326) reason: <Ringing>Ñ.
Next I used the is_staeful option and did a t_newtran(); before doing a
cpl_run_script(...). And this gave a segmentation fault.
0(11341) SIP Request:
0(11341) method: <INVITE>
0(11341) uri: <sip:5002 at alice>
0(11341) version: <SIP/2.0>
0(11341) parse_headers: flags=1
0(11341) Found param type 235, <rport> = <n/a>; state=6
0(11341) Found param type 232, <branch> =
<z9hG4bK479AC5E6A09149CC8F7AD6FFDA57BB4A>; state=16
0(11341) end of header reached, state=5
0(11341) parse_headers: Via found, flags=1
0(11341) parse_headers: this is the first via
0(11341) After parse_msg...
0(11341) preparing to run routing scripts...
0(11341) DEBUG : is_maxfwd_present: searching for max_forwards header
0(11341) parse_headers: flags=128
0(11341) end of header reached, state=9
0(11341) DEBUG: get_hdr_field: <To> [18]; uri=[sip:5002 at alice]
0(11341) DEBUG: to body [<sip:5002 at alice>
]
0(11341) get_hdr_field: cseq <CSeq>: <28853> <INVITE>
0(11341) DEBUG: is_maxfwd_present: value = 70
0(11341) DEBUG: add_param: tag=2164890557
0(11341) end of header reached, state=29
0(11341) parse_headers: flags=256
0(11341) DEBUG: get_hdr_body : content_length=293
0(11341) found end of header
0(11341) find_first_route(): No Route headers found
0(11341) loose_route(): There is no Route HF
0(11341) check_self - checking if host==us: 5==9 && [alice] == [10.5.1.11]
0(11341) check_self - checking if port 5060 matches port 5060
0(11341) DEBUG: t_addifnew: msg id=1 , global msg id=0 , T on
entrance=0xffffffff
0(11341) parse_headers: flags=-1
0(11341) parse_headers: flags=60
0(11341) t_lookup_request: start searching: hash=50896, isACK=0
0(11341) DEBUG: RFC3261 transaction matching failed
0(11341) DEBUG: t_lookup_request: no transaction found
0(11341) DEBUG:cpl-c:get_dest_user: tring to get user from new_uri
0(11341) DEBUG:cpl-c:get_dest_user: tring to get user from R_uri
0(11341) DEBUG:get_user_script: fetching script for user <5002 at alice>
0(11341) query="select cpl_bin from cpl where user='5002 at alice'"
0(11341) DEBUG:get_user_script: we got the script len=134
0(11341) DEBUG:cpl_run_script: processing CPL node
0(11341) DEBUG:cpl_run_script: processing time-switch node
0(11341) DEBUG:cpl-c:run_time_switch: checking recv. time stamp <1097768264>
0(11341) ---> fill = Thu Oct 14 21:07:44 2004
0(11341) DEBUG:cpl_c:run_time_node: attribute [0] found :[20041001T000000]
0(11341) ----->dtstart = 1096569000 | Fri Oct 1 00:00:00 2004
0(11341) DEBUG:cpl_c:run_time_node: attribute [2] found :[PT24H]
0(11341) DEBUG:cpl_c:run_time_node: attribute [3] found :[weekly]
0(11341) DEBUG:cpl_c:run_time_node: attribute [10] found :[MO,WE,FR]
0(11341) DEBUG:cpl_c:run_time_switch: time cond. doesn't match !
0(11341) DEBUG:cpl-c:run_time_switch: matching on OTHERWISE node
0(11341) DEBUG:cpl_run_script: processing location node
0(11341) DEBUG:cpl_run_script: processing proxy node
0(11341) parse_headers: flags=16777216
0(11341) parse_headers: flags=4194304
0(11341) parse_headers: flags=2097152
0(11341) parse_headers: flags=8388608
Segmentation fault (core dumped)
The cpl file that i used was
<!DOCTYPE cpl PUBLIC "-//IETF//DTD RFCxxxx CPL1.0//EN"
"/etc/ser/cpl-06.dtd">
<cpl>
<incoming>
<time-switch>
<time dtstart="20041001T000000" duration="PT24H" freq="weekly"
byday="MO,WE,FR">
<lookup source="registration">
<success>
<proxy />
</success>
</lookup>
</time>
<otherwise>
<location url="sip:5003 at alice">
<proxy />
</location>
</otherwise>
</time-switch>
</incoming>
</cpl>
This problem comes in any script where i use proxy
Thanx in advance
~ Rohit
----- Original Message -----
From: "Bogdan-Andrei IANCU" <iancu at fokus.fraunhofer.de>
To: "Rohit Mutsuddi" <mrohit at mahindrabt.com>
Cc: <serusers at lists.iptel.org>
Sent: Thursday, October 14, 2004 3:50 PM
Subject: Re: [Serusers] Proxy Problem Using CPL
> Hi Rohit,
>
> What version are you using?
> Please send a full ser dump (debug=9) from the original INVITe to the
> end of processing.
>
> bogdan
>
> Rohit Mutsuddi wrote:
>
> > //
> > //Hello All//
> > /// /
> > //I am having a problem using the "forward-on-busy" option using CPL.
> > The following error occurs when an invite is sent. CPL script getrs
> > loaded properly using serctl but at runtime it does not work//
> > /// /
> > //*"ERROR: t_reply: cannot send a t_reply to a message for which no
> > T-state has been established"*//
> > /// /
>
>
*********************************************************
Disclaimer:
This message (including any attachments) contains
confidential information intended for a specific
individual and purpose, and is protected by law.
If you are not the intended recipient, you should
delete this message and are hereby notified that
any disclosure, copying, or distribution of this
message, or the taking of any action based on it,
is strictly prohibited.
*********************************************************
Visit us at http://www.mahindrabt.com
More information about the sr-users
mailing list