[Kamailio-Users] strange fr_inv_timer behaviour

Tue Jun 30 11:26:04 CEST 2009

Hello,

On 06/30/2009 09:26 AM, hans at onsmail.nl wrote:
> I'm still trying to find out why the fr_inv_timer isn't working properly.
>
> I tried version 1.5 with a very basic configuration and then the 
> timeout is sent to early (about half the 'fr_inv_timer' value)
> but when running version 1.4 (on the same machine) everything is 
> working fine and the timeout occures after the amount of seconds 
> defined by 'fr_inv_timer'.
>
> Anyone any idea what can cause this behavior in 1.5 (and not in 1.4) ?
>
can you try attached patch?

Thanks,
Daniel

>
>
> ----- Original Message ----- From: <hans at onsmail.nl>
> To: "Daniel-Constantin Mierla" <miconda at gmail.com>
> Cc: <users at lists.kamailio.org>
> Sent: Wednesday, June 10, 2009 20:10
> Subject: Re: [Kamailio-Users] strange fr_inv_timer behaviour
>
>
>> Daniel,
>>
>> loadmodule "tm.so"
>> modparam("tm", "fr_inv_timer_avp", "$avp(s:callee_fr_inv_timer)")
>> modparam("tm", "fr_timer", 3)
>>
>> $avp(s:callee_fr_inv_timer) = 90;
>>
>> This setting causes a 408 to be generated after 30 seconds.
>>
>> If i don't use the avp but set fr_inv_timer directly i have the same 
>> problem.
>>
>> Kind regards
>> Hans
>>
>>
>>> Hello,
>>>
>>> can you send me all tm module parameters you set?
>>>
>>> I tried to reproduce, but all was fine:
>>> - 40 sec t/o
>>> INVITE: U 2009/06/10 12:52:54.457315 213.133.111.169:5062 ->
>>> 86.121.130.133:6536
>>> 408: U 2009/06/10 12:53:35.084385 213.133.111.169:5062 ->
>>> 86.121.130.133:5060
>>>
>>> - 60 sec t/o
>>> INVITE: U 2009/06/10 12:58:05.806196 213.133.111.169:5062 ->
>>> 86.121.130.133:6536
>>> 408: U 2009/06/10 12:59:05.644824 213.133.111.169:5062 ->
>>> 86.121.130.133:5060
>>>
>>>
>>> Thanks,
>>> Daniel
>>>
>>> On 06/03/2009 05:00 PM, hans at onsmail.nl wrote:
>>>> Hi,
>>>>
>>>> When setting ?fr_inv_timer? to 60s and the phone is not answered
>>>> kamailio
>>>> generates a timeout after 20s ? If ?fr_inv_timer? is set to 90s the
>>>> timeout is generated after 30s ?
>>>>
>>>> Doing a level 7 debug I received the following tm timer related output
>>>>
>>>> Jun  3 15:07:12 sip-proxy-01 /usr/local/sbin/kamailio[1755]:
>>>> DBG:tm:set_timer: relative timeout is 500000
>>>> Jun  3 15:07:12 sip-proxy-01 /usr/local/sbin/kamailio[1755]:
>>>> DBG:tm:insert_timer_unsafe: [4]: 0xafa6abc4 (16900000)
>>>> Jun  3 15:07:12 sip-proxy-01 /usr/local/sbin/kamailio[1755]:
>>>> DBG:tm:set_timer: relative timeout is 3
>>>> Jun  3 15:07:12 sip-proxy-01 /usr/local/sbin/kamailio[1755]:
>>>> DBG:tm:insert_timer_unsafe: [0]: 0xafa6abe0 (51)
>>>> Jun  3 15:07:12 sip-proxy-01 /usr/local/sbin/kamailio[1754]:
>>>> DBG:tm:set_timer: relative timeout is 60
>>>> Jun  3 15:07:12 sip-proxy-01 /usr/local/sbin/kamailio[1754]:
>>>> DBG:tm:insert_timer_unsafe: [1]: 0xafa6abe0 (108)
>>>> Jun  3 15:07:12 sip-proxy-01 /usr/local/sbin/kamailio[1751]:
>>>> DBG:tm:set_timer: relative timeout is 60
>>>> Jun  3 15:07:12 sip-proxy-01 /usr/local/sbin/kamailio[1751]:
>>>> DBG:tm:insert_timer_unsafe: [1]: 0xafa6abe0 (108)
>>>> Jun  3 15:07:12 sip-proxy-01 /usr/local/sbin/kamailio[1758]:
>>>> DBG:tm:utimer_routine: timer routine:4,tl=0xafa6abc4 next=(nil),
>>>> timeout=16900000
>>>>
>>>> <phone is ringing ....>
>>>>
>>>> Jun  3 15:07:32 sip-proxy-01 /usr/local/sbin/kamailio[1758]:
>>>> DBG:tm:timer_routine: timer routine:1,tl=0xafa6abe0 next=(nil),
>>>> timeout=108
>>>> Jun  3 15:07:32 sip-proxy-01 /usr/local/sbin/kamailio[1758]:
>>>> DBG:tm:final_response_handler: stop retr. and send CANCEL (0xafa6aa78)
>>>> Jun  3 15:07:32 sip-proxy-01 /usr/local/sbin/kamailio[1758]:
>>>> DBG:tm:t_should_relay_response: T_code=180, new_code=408
>>>> Jun  3 15:07:32 sip-proxy-01 /usr/local/sbin/kamailio[1758]:
>>>> DBG:tm:t_pick_branch: picked branch 0, code 408
>>>> Jun  3 15:07:32 sip-proxy-01 /usr/local/sbin/kamailio[1758]:
>>>> DBG:tm:t_check: start=0xafa6aa78
>>>> Jun  3 15:07:32 sip-proxy-01 /usr/local/sbin/kamailio[1758]:
>>>> DBG:tm:t_check: transaction already found!
>>>> Jun  3 15:07:32 sip-proxy-01 /usr/local/sbin/kamailio[1758]:
>>>> DBG:tm:pv_get_tm_reply_code: reply code is <408>
>>>>
>>>> version: kamailio 1.5.1-notls (i386/linux)
>>>> flags: STATISTICS, USE_IPV6, USE_TCP, DISABLE_NAGLE, USE_MCAST,
>>>> SHM_MMAP,
>>>> PKG_MALLOC, F_MALLOC, FAST_LOCK-ADAPTIVE_WAIT
>>>> ADAPTIVE_WAIT_LOOPS=1024, MAX_RECV_BUFFER_SIZE 262144, MAX_LISTEN 16,
>>>> MAX_URI_SIZE 1024, BUF_SIZE 65535, PKG_SIZE 4194304
>>>> poll method support: poll, epoll_lt, epoll_et, sigio_rt, select.
>>>> svnrevision: 2:5868M
>>>> @(#) $Id: main.c 5608 2009-02-13 16:48:17Z henningw $
>>>> main.c compiled on 14:40:00 Jun  3 2009 with gcc 4.1.2
>>>>
>>>> Kind regards
>>>> Hans
>>>>
>>>>
>>>>
>>>> _______________________________________________
>>>> Kamailio (OpenSER) - Users mailing list
>>>> Users at lists.kamailio.org
>>>> http://lists.kamailio.org/cgi-bin/mailman/listinfo/users
>>>> http://lists.openser-project.org/cgi-bin/mailman/listinfo/users
>>>>
>>>>
>>>
>>> -- 
>>> Daniel-Constantin Mierla
>>> http://www.asipto.com/
>>>
>>>
>>
>>
>>
>> _______________________________________________
>> Kamailio (OpenSER) - Users mailing list
>> Users at lists.kamailio.org
>> http://lists.kamailio.org/cgi-bin/mailman/listinfo/users
>> http://lists.openser-project.org/cgi-bin/mailman/listinfo/users 
>
>
> _______________________________________________
> Kamailio (OpenSER) - Users mailing list
> Users at lists.kamailio.org
> http://lists.kamailio.org/cgi-bin/mailman/listinfo/users
> http://lists.openser-project.org/cgi-bin/mailman/listinfo/users
>

-- 
Daniel-Constantin Mierla
http://www.asipto.com/

-------------- next part --------------
A non-text attachment was scrubbed...
Name: timer-noshared.patch
Type: text/x-patch
Size: 4204 bytes
Desc: not available
URL: <http://lists.kamailio.org/pipermail/users/attachments/20090630/353e58f0/attachment-0001.bin>