[Freeswitch-users] Strange "timer_test" result

Tue Mar 27 17:40:59 MSD 2012

With "1ms-timer" the behaviour is changed but the "timer_test" remain
strange:

2012-03-27 15:36:49.609946 [CONSOLE] mod_commands.c:559 Timer Test: 1 sleep
20 1
2012-03-27 15:36:49.630810 [CONSOLE] mod_commands.c:559 Timer Test: 2 sleep
20 21225
2012-03-27 15:36:49.671927 [CONSOLE] mod_commands.c:559 Timer Test: 3 sleep
20 40716
2012-03-27 15:36:49.671927 [CONSOLE] mod_commands.c:559 Timer Test: 4 sleep
20 29
2012-03-27 15:36:49.690968 [CONSOLE] mod_commands.c:559 Timer Test: 5 sleep
20 19451
2012-03-27 15:36:49.714993 [CONSOLE] mod_commands.c:559 Timer Test: 6 sleep
20 23380
2012-03-27 15:36:49.714993 [CONSOLE] mod_commands.c:559 Timer Test: 7 sleep
20 35
2012-03-27 15:36:49.752814 [CONSOLE] mod_commands.c:559 Timer Test: 8 sleep
20 38474
2012-03-27 15:36:49.752814 [CONSOLE] mod_commands.c:559 Timer Test: 9 sleep
20 41
2012-03-27 15:36:49.776956 [CONSOLE] mod_commands.c:559 Timer Test: 10
sleep 20 23408
2012-03-27 15:36:49.798632 [CONSOLE] mod_commands.c:559 Timer Test: 11
sleep 20 22079
2012-03-27 15:36:49.838054 [CONSOLE] mod_commands.c:559 Timer Test: 12
sleep 20 39021
2012-03-27 15:36:49.838054 [CONSOLE] mod_commands.c:559 Timer Test: 13
sleep 20 35
2012-03-27 15:36:49.857783 [CONSOLE] mod_commands.c:559 Timer Test: 14
sleep 20 19946
2012-03-27 15:36:49.887887 [CONSOLE] mod_commands.c:559 Timer Test: 15
sleep 20 29935
2012-03-27 15:36:49.906809 [CONSOLE] mod_commands.c:559 Timer Test: 16
sleep 20 18774
2012-03-27 15:36:49.946751 [CONSOLE] mod_commands.c:559 Timer Test: 17
sleep 20 40290
2012-03-27 15:36:49.946751 [CONSOLE] mod_commands.c:559 Timer Test: 18
sleep 20 32
2012-03-27 15:36:49.966757 [CONSOLE] mod_commands.c:559 Timer Test: 19
sleep 20 19813
2012-03-27 15:36:50.005781 [CONSOLE] mod_commands.c:559 Timer Test: 20
sleep 20 39099
2012-03-27 15:36:50.005781 [CONSOLE] mod_commands.c:559 Timer Test: 21
sleep 20 24
2012-03-27 15:36:50.023894 [CONSOLE] mod_commands.c:559 Timer Test: 22
sleep 20 18116
2012-03-27 15:36:50.046022 [CONSOLE] mod_commands.c:559 Timer Test: 23
sleep 20 22046
2012-03-27 15:36:50.074716 [CONSOLE] mod_commands.c:559 Timer Test: 24
sleep 20 29054
2012-03-27 15:36:50.074716 [CONSOLE] mod_commands.c:559 Timer Test: 25
sleep 20 25
2012-03-27 15:36:50.111794 [CONSOLE] mod_commands.c:559 Timer Test: 26
sleep 20 37413
2012-03-27 15:36:50.131778 [CONSOLE] mod_commands.c:559 Timer Test: 27
sleep 20 19684
2012-03-27 15:36:50.155846 [CONSOLE] mod_commands.c:559 Timer Test: 28
sleep 20 23480
2012-03-27 15:36:50.155846 [CONSOLE] mod_commands.c:559 Timer Test: 29
sleep 20 37
2012-03-27 15:36:50.179738 [CONSOLE] mod_commands.c:559 Timer Test: 30
sleep 20 23811
2012-03-27 15:36:50.196725 [CONSOLE] mod_commands.c:559 Timer Test: 31
sleep 20 18828
2012-03-27 15:36:50.220604 [CONSOLE] mod_commands.c:559 Timer Test: 32
sleep 20 22205
2012-03-27 15:36:50.250696 [CONSOLE] mod_commands.c:559 Timer Test: 33
sleep 20 30868
2012-03-27 15:36:50.275841 [CONSOLE] mod_commands.c:559 Timer Test: 34
sleep 20 24303
2012-03-27 15:36:50.275841 [CONSOLE] mod_commands.c:559 Timer Test: 35
sleep 20 57
2012-03-27 15:36:50.299676 [CONSOLE] mod_commands.c:559 Timer Test: 36
sleep 20 24607
2012-03-27 15:36:50.319195 [CONSOLE] mod_commands.c:559 Timer Test: 37
sleep 20 18660
2012-03-27 15:36:50.336701 [CONSOLE] mod_commands.c:559 Timer Test: 38
sleep 20 18321
2012-03-27 15:36:50.377677 [CONSOLE] mod_commands.c:559 Timer Test: 39
sleep 20 40551
2012-03-27 15:36:50.377677 [CONSOLE] mod_commands.c:559 Timer Test: 40
sleep 20 33
2012-03-27 15:36:50.398692 [CONSOLE] mod_commands.c:559 Timer Test: 41
sleep 20 20552
2012-03-27 15:36:50.421692 [CONSOLE] mod_commands.c:559 Timer Test: 42
sleep 20 23208
2012-03-27 15:36:50.459684 [CONSOLE] mod_commands.c:559 Timer Test: 43
sleep 20 38668
2012-03-27 15:36:50.459684 [CONSOLE] mod_commands.c:559 Timer Test: 44
sleep 20 34
2012-03-27 15:36:50.478817 [CONSOLE] mod_commands.c:559 Timer Test: 45
sleep 20 18432
2012-03-27 15:36:50.519691 [CONSOLE] mod_commands.c:559 Timer Test: 46
sleep 20 41447
2012-03-27 15:36:50.519691 [CONSOLE] mod_commands.c:559 Timer Test: 47
sleep 20 29
2012-03-27 15:36:50.542590 [CONSOLE] mod_commands.c:559 Timer Test: 48
sleep 20 22699
2012-03-27 15:36:50.552674 [CONSOLE] mod_commands.c:559 Timer Test: 49
sleep 20 10034
2012-03-27 15:36:50.590676 [CONSOLE] mod_commands.c:559 Timer Test: 50
sleep 20 38060
2012-03-27 15:36:50.608681 [CONSOLE] mod_commands.c:559 Timer Test: 51
sleep 20 17448
2012-03-27 15:36:50.625755 [CONSOLE] mod_commands.c:559 Timer Test: 52
sleep 20 17767
2012-03-27 15:36:50.643693 [CONSOLE] mod_commands.c:559 Timer Test: 53
sleep 20 17263
2012-03-27 15:36:50.663677 [CONSOLE] mod_commands.c:559 Timer Test: 54
sleep 20 21429
2012-03-27 15:36:50.682676 [CONSOLE] mod_commands.c:559 Timer Test: 55
sleep 20 18072
2012-03-27 15:36:50.723740 [CONSOLE] mod_commands.c:559 Timer Test: 56
sleep 20 40933
2012-03-27 15:36:50.723740 [CONSOLE] mod_commands.c:559 Timer Test: 57
sleep 20 29
2012-03-27 15:36:50.758800 [CONSOLE] mod_commands.c:559 Timer Test: 58
sleep 20 35950
2012-03-27 15:36:50.758800 [CONSOLE] mod_commands.c:559 Timer Test: 59
sleep 20 30
2012-03-27 15:36:50.779674 [CONSOLE] mod_commands.c:559 Timer Test: 60
sleep 20 19772

The CPU load is low (20%) so what parameter can affect this? The CentOS
version? The kernel versione? The FS version? The number of cpu cores?

Stephen

On Mon, Mar 26, 2012 at 4:40 PM, Stephen Wilde <wstephen80 at gmail.com> wrote:

> Ok, I'll try with this parameter, I think I have to do a Freeswitch
> restart to make this change...
>
> Stephen
>
>
> On Mon, Mar 26, 2012 at 4:31 PM, Peter Olsson <
> peter.olsson at visionutveckling.se> wrote:
>
>>  You could try to enable the ”old” 1 ms-timer. It will be a little less
>> efficient (a little more CPU load), and I’m not sure it helps, but it’s
>> worth a try.****
>>
>> ** **
>>
>> In switch.conf.xml (under autoload_configs), add this: <param
>> name="1ms-timer" value="true"/> - within the settings-tags.****
>>
>> ** **
>>
>> /Peter****
>>
>> ** **
>>
>> *Från:* freeswitch-users-bounces at lists.freeswitch.org [mailto:
>> freeswitch-users-bounces at lists.freeswitch.org] *För *Stephen Wilde
>> *Skickat:* den 26 mars 2012 16:20
>>
>> *Till:* FreeSWITCH Users Help
>> *Ämne:* Re: [Freeswitch-users] Strange "timer_test" result****
>>
>> ** **
>>
>> Thank you Peter for your reply!****
>>
>> I have already tried the upgrade to latest git, now I'm on FreeSWITCH
>> Version 1.1.beta1 (git-c31a799 2012-03-24 14-11-49 -0700) and the result is
>> the same.****
>>
>> I have tried with few load (during night) and in this case the timer_test
>> is perfect.****
>>
>> Any suggestion?****
>>
>> ** **
>>
>> ** **
>>
>> On Mon, Mar 26, 2012 at 4:08 PM, Peter Olsson <
>> peter.olsson at visionutveckling.se> wrote:****
>>
>> Yes, most likely.****
>>
>>  ****
>>
>> It’s very strange though, that a machine like this gives so poor timing
>> results.****
>>
>>  ****
>>
>> The first thing I would do is to upgrade to latest GIT HEAD. A patch was
>> commited about two weeks ago, that does the calculation for timer_test more
>> properly (so time for logging is not calculated).****
>>
>>  ****
>>
>> Have you tried to do the same test with no load at all?****
>>
>>  ****
>>
>> /Peter****
>>
>>  ****
>>
>> *Från:* freeswitch-users-bounces at lists.freeswitch.org [mailto:
>> freeswitch-users-bounces at lists.freeswitch.org] *För *Stephen Wilde
>> *Skickat:* den 26 mars 2012 15:52
>> *Till:* FreeSWITCH Users Help
>> *Ämne:* Re: [Freeswitch-users] Strange "timer_test" result****
>>
>>  ****
>>
>> Can this issue affect the voice quality?****
>>
>>  ****
>>
>> On Fri, Mar 23, 2012 at 7:46 PM, Stephen Wilde <wstephen80 at gmail.com>
>> wrote:****
>>
>> Real hardware, a dedicate server with 2 Xeon X5670 (a total 24 core each
>> one with 12Mb cache at 2.93GHz) that is running at 20% - 25% of load. OS is
>> CentOS 5.7 64bit and FS is (git-0626c89 2012-02-29 14-45-39 -0600)****
>>
>>  ****
>>
>> On Fri, Mar 23, 2012 at 6:33 PM, Brian Foster <bdfoster at endigotech.com>
>> wrote:****
>>
>> Is this on virtualized or real hardware?****
>>
>>  ****
>>
>> -BDF****
>>
>> On Fri, Mar 23, 2012 at 1:31 PM, Stephen Wilde <wstephen80 at gmail.com>
>> wrote:****
>>
>>   I have run a "timer_test" in a dedicated FS server and I see strange
>> result: it's normal?****
>>
>>  ****
>>
>> Stephen****
>>
>>  ****
>>
>>  ****
>>
>> freeswitch at internal> timer_test 20 40****
>>
>> Avg: 19.866ms Total Time: 795.880ms****
>>
>>  ****
>>
>> 2012-03-23 18:25:54.157822 [CONSOLE] mod_commands.c:549 Timer Test:
>> samplecount after init: 1****
>>
>> 2012-03-23 18:25:54.178818 [CONSOLE] mod_commands.c:554 Timer Test:
>> samplecount after first step: 2****
>>
>> 2012-03-23 18:25:54.199833 [CONSOLE] mod_commands.c:563 Timer Test: 1
>> sleep 20 19568****
>>
>> 2012-03-23 18:25:54.231890 [CONSOLE] mod_commands.c:563 Timer Test: 2
>> sleep 20 38231****
>>
>> 2012-03-23 18:25:54.252816 [CONSOLE] mod_commands.c:563 Timer Test: 3
>> sleep 20 18847****
>>
>> 2012-03-23 18:25:54.262818 [CONSOLE] mod_commands.c:563 Timer Test: 4
>> sleep 20 13982****
>>
>> 2012-03-23 18:25:54.305813 [CONSOLE] mod_commands.c:563 Timer Test: 5
>> sleep 20 34793****
>>
>> 2012-03-23 18:25:54.305813 [CONSOLE] mod_commands.c:563 Timer Test: 6
>> sleep 20 2****
>>
>> 2012-03-23 18:25:54.326811 [CONSOLE] mod_commands.c:563 Timer Test: 7
>> sleep 20 23166****
>>
>> 2012-03-23 18:25:54.347807 [CONSOLE] mod_commands.c:563 Timer Test: 8
>> sleep 20 16957****
>>
>> 2012-03-23 18:25:54.357811 [CONSOLE] mod_commands.c:563 Timer Test: 9
>> sleep 20 17643****
>>
>> 2012-03-23 18:25:54.378828 [CONSOLE] mod_commands.c:563 Timer Test: 10
>> sleep 20 18786****
>>
>> 2012-03-23 18:25:54.399856 [CONSOLE] mod_commands.c:563 Timer Test: 11
>> sleep 20 25100****
>>
>> 2012-03-23 18:25:54.420855 [CONSOLE] mod_commands.c:563 Timer Test: 12
>> sleep 20 18552****
>>
>> 2012-03-23 18:25:54.441855 [CONSOLE] mod_commands.c:563 Timer Test: 13
>> sleep 20 18815****
>>
>> 2012-03-23 18:25:54.462798 [CONSOLE] mod_commands.c:563 Timer Test: 14
>> sleep 20 19464****
>>
>> 2012-03-23 18:25:54.484300 [CONSOLE] mod_commands.c:563 Timer Test: 15
>> sleep 20 22012****
>>
>> 2012-03-23 18:25:54.494804 [CONSOLE] mod_commands.c:563 Timer Test: 16
>> sleep 20 13980****
>>
>> 2012-03-23 18:25:54.515793 [CONSOLE] mod_commands.c:563 Timer Test: 17
>> sleep 20 19065****
>>
>> 2012-03-23 18:25:54.556792 [CONSOLE] mod_commands.c:563 Timer Test: 18
>> sleep 20 39585****
>>
>> 2012-03-23 18:25:54.556792 [CONSOLE] mod_commands.c:563 Timer Test: 19
>> sleep 20 2****
>>
>> 2012-03-23 18:25:54.577790 [CONSOLE] mod_commands.c:563 Timer Test: 20
>> sleep 20 26255****
>>
>> 2012-03-23 18:25:54.598790 [CONSOLE] mod_commands.c:563 Timer Test: 21
>> sleep 20 17872****
>>
>> 2012-03-23 18:25:54.630794 [CONSOLE] mod_commands.c:563 Timer Test: 22
>> sleep 20 32191****
>>
>> 2012-03-23 18:25:54.651790 [CONSOLE] mod_commands.c:563 Timer Test: 23
>> sleep 20 22634****
>>
>> 2012-03-23 18:25:54.672788 [CONSOLE] mod_commands.c:563 Timer Test: 24
>> sleep 20 15483****
>>
>> 2012-03-23 18:25:54.693783 [CONSOLE] mod_commands.c:563 Timer Test: 25
>> sleep 20 22813****
>>
>> 2012-03-23 18:25:54.714783 [CONSOLE] mod_commands.c:563 Timer Test: 26
>> sleep 20 17099****
>>
>> 2012-03-23 18:25:54.714783 [CONSOLE] mod_commands.c:563 Timer Test: 27
>> sleep 20 1****
>>
>> 2012-03-23 18:25:54.734832 [CONSOLE] mod_commands.c:563 Timer Test: 28
>> sleep 20 29108****
>>
>> 2012-03-23 18:25:54.755836 [CONSOLE] mod_commands.c:563 Timer Test: 29
>> sleep 20 11492****
>>
>> 2012-03-23 18:25:54.776830 [CONSOLE] mod_commands.c:563 Timer Test: 30
>> sleep 20 20855****
>>
>> 2012-03-23 18:25:54.808851 [CONSOLE] mod_commands.c:563 Timer Test: 31
>> sleep 20 32579****
>>
>> 2012-03-23 18:25:54.818833 [CONSOLE] mod_commands.c:563 Timer Test: 32
>> sleep 20 18173****
>>
>> 2012-03-23 18:25:54.850828 [CONSOLE] mod_commands.c:563 Timer Test: 33
>> sleep 20 22666****
>>
>> 2012-03-23 18:25:54.871855 [CONSOLE] mod_commands.c:563 Timer Test: 34
>> sleep 20 23792****
>>
>> 2012-03-23 18:25:54.892823 [CONSOLE] mod_commands.c:563 Timer Test: 35
>> sleep 20 26158****
>>
>> 2012-03-23 18:25:54.913823 [CONSOLE] mod_commands.c:563 Timer Test: 36
>> sleep 20 13080****
>>
>> 2012-03-23 18:25:54.934844 [CONSOLE] mod_commands.c:563 Timer Test: 37
>> sleep 20 24609****
>>
>> 2012-03-23 18:25:54.934844 [CONSOLE] mod_commands.c:563 Timer Test: 38
>> sleep 20 1****
>>
>> 2012-03-23 18:25:54.954766 [CONSOLE] mod_commands.c:563 Timer Test: 39
>> sleep 20 19413****
>>
>> 2012-03-23 18:25:54.975764 [CONSOLE] mod_commands.c:563 Timer Test: 40
>> sleep 20 19820****
>>
>> freeswitch at internal> status****
>>
>> UP 0 years, 0 days, 16 hours, 10 minutes, 25 seconds, 539 milliseconds,
>> 696 microseconds****
>>
>> FreeSWITCH is ready****
>>
>> 955611 session(s) since startup****
>>
>> 2192 session(s) 0/50****
>>
>> 6000 session(s) max****
>>
>> min idle cpu 0.00/74.00****
>>
>>  ****
>>
>> _________________________________________________________________________
>> Professional FreeSWITCH Consulting Services:
>> consulting at freeswitch.org
>> http://www.freeswitchsolutions.com
>>
>> 
>> 
>>
>> Official FreeSWITCH Sites
>> http://www.freeswitch.org
>> http://wiki.freeswitch.org
>> http://www.cluecon.com
>>
>> FreeSWITCH-users mailing list
>> FreeSWITCH-users at lists.freeswitch.org
>> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
>> UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
>> http://www.freeswitch.org****
>>
>>
>>
>> ****
>>
>>  ****
>>
>> --
>> Brian D. Foster
>> Endigo Computer LLC
>> Email: bdfoster at endigotech.com
>> Phone: 317-800-7876
>> Indianapolis, Indiana, USA
>>
>> This message contains confidential information and is intended for those
>> listed in the "To:", "CC:", and/or "BCC:" fields of the message header. If
>> you are not the intended recipient you are notified that disclosing,
>> copying, distributing or taking any action in reliance on the contents of
>> this information is strictly prohibited. E-mail transmission cannot be
>> guaranteed to be secure or error-free as information could be intercepted,
>> corrupted, lost, destroyed, arrive late or incomplete, or contain viruses.
>> The sender therefore does not accept liability for any errors or omissions
>> in the contents of this message, which arise as a result of e-mail
>> transmission. If verification is required please request a hard-copy
>> version.****
>>
>>
>> _________________________________________________________________________
>> Professional FreeSWITCH Consulting Services:
>> consulting at freeswitch.org
>> http://www.freeswitchsolutions.com
>>
>> 
>> 
>>
>> Official FreeSWITCH Sites
>> http://www.freeswitch.org
>> http://wiki.freeswitch.org
>> http://www.cluecon.com
>>
>> FreeSWITCH-users mailing list
>> FreeSWITCH-users at lists.freeswitch.org
>> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
>> UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
>> http://www.freeswitch.org****
>>
>>  ****
>>
>>  ****
>>
>>
>> _________________________________________________________________________
>> Professional FreeSWITCH Consulting Services:
>> consulting at freeswitch.org
>> http://www.freeswitchsolutions.com
>>
>> 
>> 
>>
>> Official FreeSWITCH Sites
>> http://www.freeswitch.org
>> http://wiki.freeswitch.org
>> http://www.cluecon.com
>>
>> FreeSWITCH-users mailing list
>> FreeSWITCH-users at lists.freeswitch.org
>> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
>> UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
>> http://www.freeswitch.org****
>>
>> ** **
>>
>> !DSPAM:4f7079c632761636018988! ****
>>
>> _________________________________________________________________________
>> Professional FreeSWITCH Consulting Services:
>> consulting at freeswitch.org
>> http://www.freeswitchsolutions.com
>>
>> 
>> 
>>
>> Official FreeSWITCH Sites
>> http://www.freeswitch.org
>> http://wiki.freeswitch.org
>> http://www.cluecon.com
>>
>> FreeSWITCH-users mailing list
>> FreeSWITCH-users at lists.freeswitch.org
>> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
>> UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
>> http://www.freeswitch.org
>>
>>
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20120327/06cd0ee1/attachment-0001.html 