<meta http-equiv="Content-Type" content="text/html; charset=iso-8859-1">
<html><head><meta name="Generator" content="Microsoft Word 14 (filtered medium)"><style><!--
/* Font Definitions */
@font-face
{font-family:Calibri;
panose-1:2 15 5 2 2 2 4 3 2 4;}
@font-face
{font-family:Tahoma;
panose-1:2 11 6 4 3 5 4 4 2 4;}
@font-face
{font-family:Consolas;
panose-1:2 11 6 9 2 2 4 3 2 4;}
/* Style Definitions */
p.MsoNormal, li.MsoNormal, div.MsoNormal
{margin:0cm;
margin-bottom:.0001pt;
font-size:12.0pt;
font-family:"Times New Roman","serif";
color:black;}
a:link, span.MsoHyperlink
{mso-style-priority:99;
color:blue;
text-decoration:underline;}
a:visited, span.MsoHyperlinkFollowed
{mso-style-priority:99;
color:purple;
text-decoration:underline;}
pre
{mso-style-priority:99;
mso-style-link:"HTML con formato previo Car";
margin:0cm;
margin-bottom:.0001pt;
font-size:10.0pt;
font-family:"Courier New","serif";
color:black;}
p.MsoAcetate, li.MsoAcetate, div.MsoAcetate
{mso-style-priority:99;
mso-style-link:"Texto de globo Car";
margin:0cm;
margin-bottom:.0001pt;
font-size:8.0pt;
font-family:"Tahoma","sans-serif";
color:black;}
span.EstiloCorreo17
{mso-style-type:personal;
font-family:"Calibri","sans-serif";
color:#1F497D;}
span.HTMLconformatoprevioCar
{mso-style-name:"HTML con formato previo Car";
mso-style-priority:99;
mso-style-link:"HTML con formato previo";
font-family:Consolas;
color:black;}
span.TextodegloboCar
{mso-style-name:"Texto de globo Car";
mso-style-priority:99;
mso-style-link:"Texto de globo";
font-family:"Tahoma","sans-serif";
color:black;}
span.EstiloCorreo22
{mso-style-type:personal-reply;
font-family:"Calibri","sans-serif";
color:#1F497D;}
.MsoChpDefault
{mso-style-type:export-only;
font-size:10.0pt;}
@page WordSection1
{size:612.0pt 792.0pt;
margin:70.85pt 3.0cm 70.85pt 3.0cm;}
div.WordSection1
{page:WordSection1;}
--></style></head><body bgcolor="white" lang="ES-CL" link="blue" vlink="purple"><div class="WordSection1"><p class="MsoNormal"><span style="font-size:11.0pt;font-family:"Calibri","sans-serif";color:#1f497d">Hi Daniel.</span></p>
<p class="MsoNormal"><span lang="EN-US" style="font-size:11.0pt;font-family:"Calibri","sans-serif";color:#1f497d">THanks for your answer. Can you guide where to patch the radius module. I’ve been looking the module misc_radius but I can’t find where to put more debug…..</span></p>
<p class="MsoNormal"><span style="font-size:11.0pt;font-family:"Calibri","sans-serif";color:#1f497d">Thanks again.</span></p><p class="MsoNormal"><span style="font-size:11.0pt;font-family:"Calibri","sans-serif";color:#1f497d"> </span></p>
<p class="MsoNormal"><span style="font-size:11.0pt;font-family:"Calibri","sans-serif";color:#1f497d">Ricardo.-</span></p><p class="MsoNormal"><span style="font-size:11.0pt;font-family:"Calibri","sans-serif";color:#1f497d"> </span></p>
<div><div style="border:none;border-top:solid #b5c4df 1.0pt;padding:3.0pt 0cm 0cm 0cm"><p class="MsoNormal"><b><span style="font-size:10.0pt;font-family:"Tahoma","sans-serif";color:windowtext">De:</span></b><span style="font-size:10.0pt;font-family:"Tahoma","sans-serif";color:windowtext"> Daniel-Constantin Mierla [mailto:<a href="mailto:miconda@gmail.com">miconda@gmail.com</a>] <br>
<b>Enviado el:</b> jueves, </span><span lang="ES" style="font-size:10.0pt;font-family:"Tahoma","sans-serif";color:windowtext">13 de septiembre de 2012 16:19<br><b>Para:</b> SIP Router - Kamailio (OpenSER) and SIP Express Router (SER) - Users Mailing List<br>
<b>CC:</b> Ricardo Martinez<br><b>Asunto:</b> Re: [SR-Users] avp_radius load time high</span></p></div></div><p class="MsoNormal"> </p><p class="MsoNormal" style="margin-bottom:12.0pt">Hello,</p><div><p class="MsoNormal">
On 9/13/12 9:22 PM, Ricardo Martinez wrote:</p></div><blockquote style="margin-top:5.0pt;margin-bottom:5.0pt"><p class="MsoNormal"><span lang="EN-US" style="font-size:11.0pt;font-family:"Calibri","sans-serif";color:#1f497d">Hello.</span></p>
<p class="MsoNormal"><span lang="EN-US" style="font-size:11.0pt;font-family:"Calibri","sans-serif";color:#1f497d">Could it be that this number maybe represent a failed connection to the radius server?</span></p>
</blockquote><p class="MsoNormal">I am not using radius myself, but I would try some generic troubleshooting:<br>- watch the network traffic between with the radius server to see if there are delays between the requests and responses<br>
- if you do also user authentication with radius, do you notice same problems?<br>- if you run with debug 3, can you spot the delays in debug messages? Maybe you can patch the radius module to print more log messages around the code that sends the radius requests and waits for response<br>
<br>Cheers,<br>Daniel<br><br></p><p class="MsoNormal"><span lang="EN-US" style="font-size:11.0pt;font-family:"Calibri","sans-serif";color:#1f497d"> </span></p><p class="MsoNormal"><span style="font-size:11.0pt;font-family:"Calibri","sans-serif";color:#1f497d">Any help please?</span></p>
<p class="MsoNormal"><span style="font-size:11.0pt;font-family:"Calibri","sans-serif";color:#1f497d"> </span></p><p class="MsoNormal"><span style="font-size:11.0pt;font-family:"Calibri","sans-serif";color:#1f497d">Regards,</span></p>
<p class="MsoNormal"><span style="font-size:11.0pt;font-family:"Calibri","sans-serif";color:#1f497d">Ricardo.-</span></p><p class="MsoNormal"><span style="font-size:11.0pt;font-family:"Calibri","sans-serif";color:#1f497d"> </span></p>
<p class="MsoNormal"><span style="font-size:11.0pt;font-family:"Calibri","sans-serif";color:#1f497d"> </span></p><p class="MsoNormal"><b><span lang="ES" style="font-size:10.0pt;font-family:"Tahoma","sans-serif"">De:</span></b><span lang="ES" style="font-size:10.0pt;font-family:"Tahoma","sans-serif""> Ricardo Martinez [mailto:<a href="mailto:rmartinez@redvoiss.net">rmartinez@redvoiss.net</a>] <br>
<b>Enviado el:</b> miércoles, 12 de septiembre de 2012 22:43<br><b>Para:</b> <a href="mailto:sr-users@lists.sip-router.org">sr-users@lists.sip-router.org</a><br><b>Asunto:</b> avp_radius load time high</span></p><p class="MsoNormal">
</p><blockquote style="border:none;border-left:solid #cccccc 1.0pt;padding:0cm 0cm 0cm 6.0pt;margin-left:4.8pt;margin-top:5.0pt;margin-right:0cm;margin-bottom:5.0pt"><p class="MsoNormal"> </p><div><div><p class="MsoNormal">
Hello List.</p><p class="MsoNormal" style="margin-bottom:12.0pt"><span lang="EN-US">I’m having the next issue. I have a kamailio v3.2 working with a Radius server as a backend. All the INVITE’s coming to the kamailio server are challenged against the Radius server and then avp_load is called from Radius server too. I’m having excessive delay times when I have near 10 call per second. So I find it very weird. I have made a benchmark for the avp_load :</span></p>
<p class="MsoNormal" style="text-indent:35.4pt"><span lang="EN-US" style="font-size:9.0pt;font-family:"Courier New","serif"">bm_start_timer("timer-tranum");</span></p><p class="MsoNormal" style="margin-left:35.4pt;text-indent:35.4pt">
<span lang="EN-US" style="font-size:9.0pt;font-family:"Courier New","serif"">if( !radius_load_caller_avps("$fU@$fd")) {</span></p><p class="MsoNormal" style="margin-left:70.8pt;text-indent:35.4pt">
<span lang="EN-US" style="font-size:9.0pt;font-family:"Courier New","serif"">sl_send_reply("403","Forbidden - Estamos experimentando problemas");</span></p><p class="MsoNormal" style="margin-left:70.8pt;text-indent:35.4pt">
<span lang="EN-US" style="font-size:9.0pt;font-family:"Courier New","serif"">exit; </span></p><p class="MsoNormal" style="margin-left:35.4pt;text-indent:35.4pt"><span lang="EN-US" style="font-size:9.0pt;font-family:"Courier New","serif"">} else {</span></p>
<p class="MsoNormal"><span lang="EN-US" style="font-size:9.0pt;font-family:"Courier New","serif""> xlog("L_INFO", "[$ci]:[AUTH_REQUEST]: ok");</span></p><p class="MsoNormal">
<span lang="EN-US" style="font-size:9.0pt;font-family:"Courier New","serif""> };</span></p><p class="MsoNormal" style="margin-left:35.4pt"><span lang="EN-US" style="font-size:9.0pt;font-family:"Courier New","serif"">bm_log_timer("timer-tranum");</span></p>
<p class="MsoNormal"><span lang="EN-US"> </span></p><p class="MsoNormal"><span lang="EN-US">and this is the output : </span></p><p class="MsoNormal"><span lang="EN-US"> </span></p><p class="MsoNormal"><span lang="EN-US">Sep 12 18:26:07 benchmark (timer timer-tranum [1]): 112441 [ msgs/total/min/max/avg - LR: 100/18446744073695545751/23297/18446744073709236247/184467440736955456.000000 | GB: 2100/18446744073708471097/10746/18446744073709542058/8784163844623081.000000]</span></p>
<p class="MsoNormal"><span lang="EN-US">Sep 12 18:26:55 benchmark (timer timer-tranum [1]): 280543 [ msgs/total/min/max/avg - LR: 100/10238598/21317/18446744073708596212/102385.980000 | GB: 2200/9158079/10746/18446744073709542058/4162.763182]</span></p>
<p class="MsoNormal"><span lang="EN-US">Sep 12 18:28:20 benchmark (timer timer-tranum [1]): 312902 [ msgs/total/min/max/avg - LR: 100/5048656/15491/18446744073709546022/50486.560000 | GB: 2300/14206735/10746/18446744073709546022/6176.841304]</span></p>
<p class="MsoNormal"><span lang="EN-US">Sep 12 18:28:31 benchmark (timer timer-tranum [1]): 301818 [ msgs/total/min/max/avg - LR: 100/5622716/43785/18446744073708810522/56227.160000 | GB: 2400/19829451/10746/18446744073709546022/8262.271250]</span></p>
<p class="MsoNormal"><span lang="EN-US">Sep 12 18:28:44 benchmark (timer timer-tranum [1]): 18446744073708689124 [ msgs/total/min/max/avg - LR: 100/1329199/59661/18446744073709167366/13291.990000 | GB: 2500/21158650/10746/18446744073709546022/8463.460000]</span></p>
<p class="MsoNormal"><span lang="EN-US">Sep 12 18:29:26 benchmark (timer timer-tranum [1]): 44160 [ msgs/total/min/max/avg - LR: 100/18446744073701320457/19576/18446744073708922050/184467440737013216.000000 | GB: 2600/12927491/10746/18446744073709546022/4972.111923]</span></p>
<p class="MsoNormal"><span lang="EN-US">Sep 12 18:30:18 benchmark (timer timer-tranum [1]): 218573 [ msgs/total/min/max/avg - LR: 100/18446744073707306935/17459/18446744073708876520/184467440737073056.000000 | GB: 2700/10682810/10746/18446744073709546022/3956.596296]</span></p>
<p class="MsoNormal"><span lang="EN-US">Sep 12 18:31:06 benchmark (timer timer-tranum [1]): 132751 [ msgs/total/min/max/avg - LR: 100/9611955/17057/18446744073708726431/96119.550000 | GB: 2800/20294765/10746/18446744073709546022/7248.130357]</span></p>
<p class="MsoNormal"><span lang="EN-US">Sep 12 18:31:55 benchmark (timer timer-tranum [1]): 18859 [ msgs/total/min/max/avg - LR: 100/18446744073705270953/18859/18446744073708747515/184467440737052704.000000 | GB: 2900/16014102/10746/18446744073709546022/5522.104138]</span></p>
<p class="MsoNormal"><span lang="EN-US">Sep 12 18:32:48 benchmark (timer timer-tranum [1]): 61954 [ msgs/total/min/max/avg - LR: 100/7124234/18036/18446744073708596768/71242.340000 | GB: 3000/23138336/10746/18446744073709546022/7712.778667]</span></p>
<p class="MsoNormal"><span lang="EN-US">Sep 12 18:33:39 benchmark (timer timer-tranum [1]): 53489 [ msgs/total/min/max/avg - LR: 100/18446744073707180114/18177/18446744073708790040/184467440737071808.000000 | GB: 3100/20766834/10746/18446744073709546022/6698.978710]</span></p>
<p class="MsoNormal"><span lang="EN-US">Sep 12 18:34:35 benchmark (timer timer-tranum [1]): 60604 [ msgs/total/min/max/avg - LR: 100/18446744073701108277/33983/18446744073708839351/184467440737011072.000000 | GB: 3200/12323495/10746/18446744073709546022/3851.092187]</span></p>
<p class="MsoNormal"><span lang="EN-US">Sep 12 18:35:24 benchmark (timer timer-tranum [1]): 54705 [ msgs/total/min/max/avg - LR: 100/7185862/15880/18446744073708608536/71858.620000 | GB: 3300/19509357/10746/18446744073709546022/5911.926364]</span></p>
<p class="MsoNormal"><span lang="EN-US">Sep 12 18:36:21 benchmark (timer timer-tranum [1]): 60356 [ msgs/total/min/max/avg - LR: 100/18446744073705699677/19466/18446744073708844524/184467440737056992.000000 | GB: 3400/15657418/10746/18446744073709546022/4605.122941]</span></p>
<p class="MsoNormal"><span lang="EN-US">Sep 12 18:37:14 benchmark (timer timer-tranum [1]): 18446744073708679441 [ msgs/total/min/max/avg - LR: 100/3506212/16102/18446744073708791471/35062.120000 | GB: 3500/19163630/10746/18446744073709546022/5475.322857]</span></p>
<p class="MsoNormal"><span lang="EN-US">Sep 12 18:38:07 benchmark (timer timer-tranum [1]): 93933 [ msgs/total/min/max/avg - LR: 100/18446744073704680760/17569/18446744073708741284/184467440737046816.000000 | GB: 3600/14292774/10746/18446744073709546022/3970.215000]</span></p>
<p class="MsoNormal"><span lang="EN-US">Sep 12 18:38:58 benchmark (timer timer-tranum [1]): 142777 [ msgs/total/min/max/avg - LR: 100/681953/15933/18446744073708708694/6819.530000 | GB: 3700/14974727/10746/18446744073709546022/4047.223514]</span></p>
<p class="MsoNormal"><span lang="EN-US">Sep 12 18:39:44 benchmark (timer timer-tranum [1]): 165921 [ msgs/total/min/max/avg - LR: 100/5153736/15749/18446744073708657622/51537.360000 | GB: 3800/20128463/10746/18446744073709546022/5296.963947]</span></p>
<p class="MsoNormal"><span lang="EN-US">Sep 12 18:40:31 benchmark (timer timer-tranum [1]): 127615 [ msgs/total/min/max/avg - LR: 100/18446744073709161716/20690/18446744073708793559/184467440737091616.000000 | GB: 3900/19738563/10746/18446744073709546022/5061.170000]</span></p>
<p class="MsoNormal"><span lang="EN-US">Sep 12 18:41:21 benchmark (timer timer-tranum [1]): 47762 [ msgs/total/min/max/avg - LR: 100/9001175/18909/18446744073708632234/90011.750000 | GB: 4000/28739738/10746/18446744073709546022/7184.934500]</span></p>
<p class="MsoNormal"><span lang="EN-US">Sep 12 18:42:11 benchmark (timer timer-tranum [1]): 62944 [ msgs/total/min/max/avg - LR: 100/18446744073708163674/17934/18446744073708825788/184467440737081632.000000 | GB: 4100/27351796/10746/18446744073709546022/6671.169756]</span></p>
<p class="MsoNormal"><span lang="EN-US"> </span></p><p class="MsoNormal"><span lang="EN-US"> </span></p><p class="MsoNormal"><span lang="EN-US">If the output is in microseconds and I have from time to time (for the last 100 messages) values like 184467440737081632.000000 microsecs</span></p>
<p class="MsoNormal"><span lang="EN-US">IS THIS NORMAL?</span></p><p class="MsoNormal"><span lang="EN-US">Then it backs to a more rational value : 90011.750000 microsecs.</span></p><p class="MsoNormal"><span lang="EN-US">I also made measures in my Radius Server and is answering with average time around 0.01 secs.</span></p>
<p class="MsoNormal"><span lang="EN-US">So… what could it be the problem?.. Could be the RadiusClient-ng ?</span></p><p class="MsoNormal"><span lang="EN-US">In my attempt to solve the issue I increased the childrens for the kamailio server from 16 to 60, but the problem persists. </span></p>
<p class="MsoNormal"><span lang="EN-US">Can someone help me here?</span></p><p class="MsoNormal"><span lang="EN-US"> </span></p><p class="MsoNormal"><span lang="EN-US">Best Regards,</span></p><p class="MsoNormal"><span lang="EN-US">Ricardo Martinez.-</span></p>
<p class="MsoNormal"><span lang="EN-US"> </span></p><p class="MsoNormal"><span lang="EN-US"> </span></p><p class="MsoNormal"><span lang="EN-US"> </span></p></div></div></blockquote><p class="MsoNormal"><br><br><br></p><pre>
_______________________________________________</pre><pre>SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list</pre><pre><a href="mailto:sr-users@lists.sip-router.org">sr-users@lists.sip-router.org</a></pre>
<pre><a href="http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users">http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users</a></pre><p class="MsoNormal"><br><br></p><pre>-- </pre><pre>Daniel-Constantin Mierla - <a href="http://www.asipto.com">http://www.asipto.com</a></pre>
<pre><a href="http://twitter.com/#!/miconda">http://twitter.com/#!/miconda</a> - <a href="http://www.linkedin.com/in/miconda">http://www.linkedin.com/in/miconda</a></pre><pre>Kamailio Advanced Training, Berlin, Nov 5-8, 2012 - <a href="http://asipto.com/u/kat">http://asipto.com/u/kat</a></pre>
<pre>Kamailio Advanced Training, Miami, USA, Nov 12-14, 2012 - <a href="http://asipto.com/u/katu">http://asipto.com/u/katu</a></pre></div></body></html>