[Spce-user] RV: Vertical Service Codes (VSC)

JL . yacabreao at hotmail.com
Tue Dec 6 08:05:12 EST 2016


Hi,

This is the complete log:


Dec  6 13:51:00 spce proxy[3488]: NOTICE: <script>: New request on proxy - M=REGISTER R=sip:voz.grupowico.net;transport=UDP F=sip:34957000888 at voz.grupowico.net;transport=UDP T=sip:34957000888 at voz.grupowico.net;transport=UDP IP=154.56.131.130:32927 (127.0.0.1:5060) ID=iM3Zx8WFLBF-uTJpRpVL1Q.. UA='Zoiper rv2.8.23'
Dec  6 13:51:01 spce proxy[3488]: NOTICE: <core> [db_query.c:60]: db_do_submit_query(): alert - query execution too long [125 ms] for [update `location` set `expires`='2016-12-06 13:52:]
Dec  6 13:51:01 spce proxy[3488]: NOTICE: <core> [action.c:1560]: run_actions(): alert - action [save (25)] cfg [/etc/kamailio/proxy/registrar.cfg:159] took too long [125 ms]
Dec  6 13:51:01 spce proxy[3488]: NOTICE: <script>: Contacts successfully updated, expires in 60s - R=sip:voz.grupowico.net;transport=UDP ID=iM3Zx8WFLBF-uTJpRpVL1Q.. UA='Zoiper rv2.8.23'
Dec  6 13:51:21 spce proxy[3496]: NOTICE: <script>: New request on proxy - M=REGISTER R=sip:voz.grupowico.net F=sip:34957000999 at voz.grupowico.net T=sip:34957000999 at voz.grupowico.net IP=154.56.131.130:5060 (127.0.0.1:5060) ID=1476055169-5060-2 at BFE.FG.BDB.BDA UA='Grandstream HT701 1.0.8.2'
Dec  6 13:51:21 spce proxy[3496]: NOTICE: <core> [db_query.c:60]: db_do_submit_query(): alert - query execution too long [125 ms] for [update `location` set `expires`='2016-12-06 13:54:]
Dec  6 13:51:21 spce proxy[3496]: NOTICE: <core> [action.c:1560]: run_actions(): alert - action [save (25)] cfg [/etc/kamailio/proxy/registrar.cfg:159] took too long [125 ms]
Dec  6 13:51:21 spce proxy[3496]: NOTICE: <script>: Contacts successfully updated, expires in 180s - R=sip:voz.grupowico.net ID=1476055169-5060-2 at BFE.FG.BDB.BDA UA='Grandstream HT701 1.0.8.2'
Dec  6 13:51:21 spce proxy[3490]: NOTICE: <script>: New request on proxy - M=REGISTER R=sip:voz.grupowico.net;transport=UDP F=sip:34957000888 at voz.grupowico.net;transport=UDP T=sip:34957000888 at voz.grupowico.net;transport=UDP IP=154.56.131.130:32927 (127.0.0.1:5060) ID=iM3Zx8WFLBF-uTJpRpVL1Q.. UA='Zoiper rv2.8.23'
Dec  6 13:51:21 spce proxy[3490]: NOTICE: <core> [db_query.c:60]: db_do_submit_query(): alert - query execution too long [125 ms] for [delete from `location` where `ruid`='uloc-583d324c]
Dec  6 13:51:21 spce proxy[3490]: NOTICE: <core> [action.c:1560]: run_actions(): alert - action [save (25)] cfg [/etc/kamailio/proxy/registrar.cfg:159] took too long [125 ms]
Dec  6 13:51:21 spce proxy[3490]: NOTICE: <script>: Contacts successfully deleted - R=sip:voz.grupowico.net;transport=UDP ID=iM3Zx8WFLBF-uTJpRpVL1Q.. UA='Zoiper rv2.8.23'
Dec  6 13:51:23 spce proxy[3507]: NOTICE: <script>: New request on proxy - M=REGISTER R=sip:voz.grupowico.net F=sip:34957455117 at voz.grupowico.net T=sip:34957455117 at voz.grupowico.net IP=81.40.9.190:5060 (127.0.0.1:5060) ID=1854920815-5060-2 at IB.EA.H.BEC UA='Grandstream HT701 1.0.8.2'
Dec  6 13:51:23 spce proxy[3507]: NOTICE: <script>: Authentication failed, stale nonce - R=sip:voz.grupowico.net ID=1854920815-5060-2 at IB.EA.H.BEC UA='Grandstream HT701 1.0.8.2'
Dec  6 13:51:23 spce proxy[3504]: NOTICE: <script>: New request on proxy - M=REGISTER R=sip:voz.grupowico.net F=sip:34957455117 at voz.grupowico.net T=sip:34957455117 at voz.grupowico.net IP=81.40.9.190:5060 (127.0.0.1:5060) ID=1854920815-5060-2 at IB.EA.H.BEC UA='Grandstream HT701 1.0.8.2'
Dec  6 13:51:23 spce proxy[3504]: NOTICE: <core> [db_query.c:60]: db_do_submit_query(): alert - query execution too long [125 ms] for [update `location` set `expires`='2016-12-06 13:54:]
Dec  6 13:51:23 spce proxy[3504]: NOTICE: <core> [action.c:1560]: run_actions(): alert - action [save (25)] cfg [/etc/kamailio/proxy/registrar.cfg:159] took too long [125 ms]
Dec  6 13:51:23 spce proxy[3504]: NOTICE: <script>: Contacts successfully updated, expires in 180s - R=sip:voz.grupowico.net ID=1854920815-5060-2 at IB.EA.H.BEC UA='Grandstream HT701 1.0.8.2'
Dec  6 13:51:25 spce proxy[3499]: NOTICE: <script>: New request on proxy - M=REGISTER R=sip:voz.grupowico.net;transport=UDP F=sip:34957000888 at voz.grupowico.net;transport=UDP T=sip:34957000888 at voz.grupowico.net;transport=UDP IP=154.56.131.130:60823 (127.0.0.1:5060) ID=TShypKjcJoYAsPeOeJ3imA.. UA='Zoiper rv2.8.15'
Dec  6 13:51:25 spce proxy[3499]: NOTICE: <script>: Authentication failed, no credentials - R=sip:voz.grupowico.net;transport=UDP ID=TShypKjcJoYAsPeOeJ3imA.. UA='Zoiper rv2.8.15'
Dec  6 13:51:25 spce proxy[3501]: NOTICE: <script>: New request on proxy - M=REGISTER R=sip:voz.grupowico.net;transport=UDP F=sip:34957000888 at voz.grupowico.net;transport=UDP T=sip:34957000888 at voz.grupowico.net;transport=UDP IP=154.56.131.130:60823 (127.0.0.1:5060) ID=TShypKjcJoYAsPeOeJ3imA.. UA='Zoiper rv2.8.15'
Dec  6 13:51:25 spce proxy[3501]: NOTICE: <core> [db_query.c:60]: db_do_submit_query(): alert - query execution too long [125 ms] for [insert into `location` (`username`,`contact`,`expi]
Dec  6 13:51:25 spce proxy[3501]: NOTICE: <core> [action.c:1560]: run_actions(): alert - action [save (25)] cfg [/etc/kamailio/proxy/registrar.cfg:159] took too long [125 ms]
Dec  6 13:51:25 spce proxy[3501]: NOTICE: <script>: Contacts successfully saved, expires in 60s - R=sip:voz.grupowico.net;transport=UDP ID=TShypKjcJoYAsPeOeJ3imA.. UA='Zoiper rv2.8.15'
Dec  6 13:51:25 spce proxy[3496]: NOTICE: <script>: New request on proxy - M=REGISTER R=sip:voz.grupowico.net;transport=UDP F=sip:34957000888 at voz.grupowico.net;transport=UDP T=sip:34957000888 at voz.grupowico.net;transport=UDP IP=154.56.131.130:60823 (127.0.0.1:5060) ID=TShypKjcJoYAsPeOeJ3imA.. UA='Zoiper rv2.8.15'
Dec  6 13:51:25 spce proxy[3496]: NOTICE: <script>: Contacts successfully deleted - R=sip:voz.grupowico.net;transport=UDP ID=TShypKjcJoYAsPeOeJ3imA.. UA='Zoiper rv2.8.15'
Dec  6 13:51:25 spce proxy[3490]: NOTICE: <script>: New request on proxy - M=REGISTER R=sip:voz.grupowico.net;transport=UDP F=sip:34957000888 at voz.grupowico.net;transport=UDP T=sip:34957000888 at voz.grupowico.net;transport=UDP IP=154.56.131.130:60823 (127.0.0.1:5060) ID=VC18Fxr5Uksy0BPROUYbJg.. UA='Zoiper rv2.8.15'
Dec  6 13:51:25 spce proxy[3490]: NOTICE: <script>: Authentication failed, no credentials - R=sip:voz.grupowico.net;transport=UDP ID=VC18Fxr5Uksy0BPROUYbJg.. UA='Zoiper rv2.8.15'
Dec  6 13:51:25 spce proxy[3488]: NOTICE: <script>: New request on proxy - M=REGISTER R=sip:voz.grupowico.net;transport=UDP F=sip:34957000888 at voz.grupowico.net;transport=UDP T=sip:34957000888 at voz.grupowico.net;transport=UDP IP=154.56.131.130:60823 (127.0.0.1:5060) ID=VC18Fxr5Uksy0BPROUYbJg.. UA='Zoiper rv2.8.15'
Dec  6 13:51:25 spce proxy[3488]: NOTICE: <script>: Contacts successfully saved, expires in 60s - R=sip:voz.grupowico.net;transport=UDP ID=VC18Fxr5Uksy0BPROUYbJg.. UA='Zoiper rv2.8.15'
Dec  6 13:51:56 spce proxy[3488]: NOTICE: <script>: New request on proxy - M=INVITE R=sip:*72*34630552589 at voz.grupowico.net;transport=UDP F=sip:34957000888 at voz.grupowico.net;transport=UDP T=sip:*72*34630552589 at voz.grupowico.net;transport=UDP IP=154.56.131.130:60823 (127.0.0.1:5060) ID=4lXSV_2ej2WYFI85BUx4Qg.. UA='Zoiper rv2.8.15'
Dec  6 13:51:56 spce proxy[3488]: NOTICE: <script>: Authentication failed, no credentials - R=sip:*72*34630552589 at voz.grupowico.net;transport=UDP ID=4lXSV_2ej2WYFI85BUx4Qg.. UA='Zoiper rv2.8.15'
Dec  6 13:51:56 spce proxy[3507]: NOTICE: <script>: New request on proxy - M=INVITE R=sip:*72*34630552589 at voz.grupowico.net;transport=UDP F=sip:34957000888 at voz.grupowico.net;transport=UDP T=sip:*72*34630552589 at voz.grupowico.net;transport=UDP IP=154.56.131.130:60823 (127.0.0.1:5060) ID=4lXSV_2ej2WYFI85BUx4Qg.. UA='Zoiper rv2.8.15'
Dec  6 13:51:56 spce proxy[3507]: NOTICE: <script>: User-Provided CLI '34957000888' taken from From-User - R=sip:*72*34630552589 at voz.grupowico.net;transport=UDP ID=4lXSV_2ej2WYFI85BUx4Qg.. UA='Zoiper rv2.8.15'
Dec  6 13:51:56 spce proxy[3507]: NOTICE: <script>: Rewriting user-provided CLI '34957000888' to '34957000888' - R=sip:*72*34630552589 at voz.grupowico.net;transport=UDP ID=4lXSV_2ej2WYFI85BUx4Qg.. UA='Zoiper rv2.8.15'
Dec  6 13:51:56 spce proxy[3507]: NOTICE: <script>: User-provided CLI '34957000888' accepted (matched user preference) - R=sip:*72*34630552589 at voz.grupowico.net;transport=UDP ID=4lXSV_2ej2WYFI85BUx4Qg.. UA='Zoiper rv2.8.15'
Dec  6 13:51:56 spce proxy[3507]: NOTICE: <script>: Setting '34957000888 at voz.grupowico.net' as initiating user-provided CLI - R=sip:*72*34630552589 at voz.grupowico.net;transport=UDP ID=4lXSV_2ej2WYFI85BUx4Qg.. UA='Zoiper rv2.8.15'
Dec  6 13:51:56 spce proxy[3507]: NOTICE: <script>: Setting '34957000888 at voz.grupowico.net' as initiating network-provided CLI - R=sip:*72*34630552589 at voz.grupowico.net;transport=UDP ID=4lXSV_2ej2WYFI85BUx4Qg.. UA='Zoiper rv2.8.15'
Dec  6 13:51:56 spce proxy[3507]: NOTICE: <script>: VSC request - R=sip:*72*34630552589 at voz.grupowico.net;transport=UDP ID=4lXSV_2ej2WYFI85BUx4Qg.. UA='Zoiper rv2.8.15'
Dec  6 13:51:56 spce proxy[3507]: NOTICE: <script>: Call to Application Server - R=sip:*72*34630552589 at vsc.local;transport=UDP ID=4lXSV_2ej2WYFI85BUx4Qg.. UA='Zoiper rv2.8.15'
Dec  6 13:51:56 spce proxy[3507]: NOTICE: <script>: Setting acc source-leg for uuid '58672b88-e4fe-468d-9467-77360f87f028': '58672b88-e4fe-468d-9467-77360f87f028|34957000888|voz.grupowico.net|34957000888|||6|||<null>|call|154.56.131.130|1481028716.916923||||||||||||' - R=sip:*72*34630552589 at vsc.local;transport=UDP ID=4lXSV_2ej2WYFI85BUx4Qg.. UA='Zoiper rv2.8.15'
Dec  6 13:51:56 spce proxy[3507]: NOTICE: <script>: Setting acc destination-leg for uuid '58672b88-e4fe-468d-9467-77360f87f028': '0|||0|*72*34630552589|58672b88-e4fe-468d-9467-77360f87f028|*72*34630552589|vsc.local|*72*34630552589|voz.grupowico.net|0||||||||||||' - R=sip:*72*34630552589 at vsc.local;transport=UDP ID=4lXSV_2ej2WYFI85BUx4Qg.. UA='Zoiper rv2.8.15'
Dec  6 13:51:56 spce proxy[3507]: NOTICE: <script>: Setting From to '<sip:34957000888 at voz.grupowico.net>' - R=sip:*72*34630552589 at vsc.local;transport=UDP ID=4lXSV_2ej2WYFI85BUx4Qg.. UA='Zoiper rv2.8.15'
Dec  6 13:51:56 spce proxy[3507]: NOTICE: <script>: Request leaving server, D-URI='sip:127.0.0.1:5080' - R=sip:*72*34630552589 at vsc.local;transport=UDP ID=4lXSV_2ej2WYFI85BUx4Qg.. UA='Zoiper rv2.8.15'
Dec  6 13:51:56 spce proxy[3504]: NOTICE: <script>: NAT-Reply - S=500 - could not get failed announcement M=INVITE IP=154.56.131.130:60823 (127.0.0.1:5080) ID=4lXSV_2ej2WYFI85BUx4Qg.. UA='<null>'
Dec  6 13:51:56 spce proxy[3504]: NOTICE: <script>: Failure route for Application Server call - R=sip:*72*34630552589 at vsc.local;transport=UDP ID=4lXSV_2ej2WYFI85BUx4Qg.. UA='Zoiper rv2.8.15'
Dec  6 13:51:56 spce proxy[3504]: ERROR: <core> [usr_avp.c:424]: search_avp(): 0 ID or NULL NAME AVP!
Dec  6 13:51:56 spce proxy[3504]: ERROR: <script>: Failed to select next Application Server server - R=sip:*72*34630552589 at vsc.local;transport=UDP ID=4lXSV_2ej2WYFI85BUx4Qg.. UA='Zoiper rv2.8.15'
Dec  6 13:51:56 spce proxy[3499]: NOTICE: <script>: New request on proxy - M=ACK R=sip:*72*34630552589 at voz.grupowico.net;transport=UDP F=sip:34957000888 at voz.grupowico.net;transport=UDP T=sip:*72*34630552589 at voz.grupowico.net;transport=UDP IP=154.56.131.130:60823 (127.0.0.1:5060) ID=4lXSV_2ej2WYFI85BUx4Qg.. UA='<null>'
Dec  6 13:51:57 spce proxy[3504]: NOTICE: <core> [db_query.c:60]: db_do_submit_query(): alert - query execution too long [125 ms] for [insert into `acc` (`method`,`from_tag`,`to_tag`,`c]
Dec  6 13:52:02 spce proxy[3490]: NOTICE: <script>: New request on proxy - M=REGISTER R=sip:voz.grupowico.net F=sip:34957452207 at voz.grupowico.net T=sip:34957452207 at voz.grupowico.net IP=80.91.65.250:5061 (127.0.0.1:5060) ID=952162406-5061-2 at BJC.BGI.A.BGA UA='Grandstream HT701 1.0.8.2'
Dec  6 13:52:03 spce proxy[3490]: NOTICE: <core> [db_query.c:60]: db_do_submit_query(): alert - query execution too long [125 ms] for [update `location` set `expires`='2016-12-06 13:54:]
Dec  6 13:52:03 spce proxy[3490]: NOTICE: <core> [action.c:1560]: run_actions(): alert - action [save (25)] cfg [/etc/kamailio/proxy/registrar.cfg:159] took too long [125 ms]
Dec  6 13:52:03 spce proxy[3490]: NOTICE: <script>: Contacts successfully updated, expires in 180s - R=sip:voz.grupowico.net ID=952162406-5061-2 at BJC.BGI.A.BGA UA='Grandstream HT701 1.0.8.2'
Dec  6 13:52:10 spce proxy[3493]: NOTICE: <script>: New request on proxy - M=REGISTER R=sip:voz.grupowico.net F=sip:34957203281 at voz.grupowico.net T=sip:34957203281 at voz.grupowico.net IP=81.40.73.95:22421 (127.0.0.1:5060) ID=1176714455-35466-2 at IB.EA.HD.JF UA='Grandstream HT701 1.0.8.2'
Dec  6 13:52:10 spce proxy[3493]: NOTICE: <core> [db_query.c:60]: db_do_submit_query(): alert - query execution too long [375 ms] for [update `location` set `expires`='2016-12-06 13:54:]
Dec  6 13:52:10 spce proxy[3493]: NOTICE: <core> [action.c:1560]: run_actions(): alert - action [save (25)] cfg [/etc/kamailio/proxy/registrar.cfg:159] took too long [375 ms]
Dec  6 13:52:10 spce proxy[3493]: NOTICE: <script>: Contacts successfully updated, expires in 180s - R=sip:voz.grupowico.net ID=1176714455-35466-2 at IB.EA.HD.JF UA='Grandstream HT701 1.0.8.2'
Dec  6 13:52:18 spce proxy[3499]: NOTICE: <script>: New request on proxy - M=REGISTER R=sip:voz.grupowico.net F=sip:34957301964 at voz.grupowico.net T=sip:34957301964 at voz.grupowico.net IP=185.142.45.26:51603 (127.0.0.1:5060) ID=266776056-5060-2 at BIF.BEC.EF.CG UA='Grandstream HT701 1.0.8.2'
Dec  6 13:52:19 spce proxy[3499]: NOTICE: <core> [db_query.c:60]: db_do_submit_query(): alert - query execution too long [125 ms] for [update `location` set `expires`='2016-12-06 13:54:]
Dec  6 13:52:19 spce proxy[3499]: NOTICE: <core> [action.c:1560]: run_actions(): alert - action [save (25)] cfg [/etc/kamailio/proxy/registrar.cfg:159] took too long [125 ms]
Dec  6 13:52:19 spce proxy[3499]: NOTICE: <script>: Contacts successfully updated, expires in 180s - R=sip:voz.grupowico.net ID=266776056-5060-2 at BIF.BEC.EF.CG UA='Grandstream HT701 1.0.8.2'
Dec  6 13:52:19 spce proxy[3504]: NOTICE: <script>: New request on proxy - M=REGISTER R=sip:voz.grupowico.net;transport=UDP F=sip:34957000888 at voz.grupowico.net;transport=UDP T=sip:34957000888 at voz.grupowico.net;transport=UDP IP=154.56.131.130:60823 (127.0.0.1:5060) ID=VC18Fxr5Uksy0BPROUYbJg.. UA='Zoiper rv2.8.15'
Dec  6 13:52:19 spce proxy[3504]: NOTICE: <core> [db_query.c:60]: db_do_submit_query(): alert - query execution too long [125 ms] for [update `location` set `expires`='2016-12-06 13:53:]
Dec  6 13:52:19 spce proxy[3504]: NOTICE: <core> [action.c:1560]: run_actions(): alert - action [save (25)] cfg [/etc/kamailio/proxy/registrar.cfg:159] took too long [125 ms]
Dec  6 13:52:19 spce proxy[3504]: NOTICE: <script>: Contacts successfully updated, expires in 60s - R=sip:voz.grupowico.net;transport=UDP ID=VC18Fxr5Uksy0BPROUYbJg.. UA='Zoiper rv2.8.15'



________________________________
De: Walter Klomp <walter at myrepublic.net>
Enviado: martes, 6 de diciembre de 2016 8:58
Para: JL .
Cc: spce-user at lists.sipwise.com
Asunto: Re: [Spce-user] Vertical Service Codes (VSC)

Yes, and what happens after that?  Without every entry after that pertaining to this call, there is no way we can see what happens to it. This only shows that the call reached the server so you can exclude zoiper…

Walter



On 6 Dec 2016, at 1:57 AM, JL . <yacabreao at hotmail.com<mailto:yacabreao at hotmail.com>> wrote:


Hi Walter,

I am doing test with Zoiper Client.


In the portal show up nothing when I dial *72*number.

In the log I see this below:

Dec  5 18:26:21 spce proxy[3490]: NOTICE: <script>: New request on proxy - M=ACK R=sip:*72*957000100 at mydomain.com;transport=UDPF=sip:34957000111 at mydomain.com;transport=UDP T=sip:*72*957000100 at mydomain.com;transport=UDP IP=xxx.xxx.xxx.xxx:63324 (127.0.0.1:5060) ID=2qu4BB8Pj-3OsaYs-3nALQ.. UA='<null>'

I have changed the numbers, IP, and domain for security, but the original is well.

My number is 34957000111
Call forwading number: 34957000100


Regad



________________________________
De: Walter Klomp <walter at myrepublic.net<mailto:walter at myrepublic.net>>
Enviado: lunes, 5 de diciembre de 2016 2:42
Para: Spce-user at lists.sipwise.com<mailto:Spce-user at lists.sipwise.com>
Cc: JL .
Asunto: Re: [Spce-user] Vertical Service Codes (VSC)

Hi JL,

What shows up in the portal when you do the *72*number ?  If all works well you should see “number”.

What do you see in the logs?  (kamailio proxy logs)

Are you sure the IP phone you use supports this dial plan *xx*x.T ?

Walter




On 5 Dec 2016, at 4:21 AM, JL . <yacabreao at hotmail.com<mailto:yacabreao at hotmail.com>> wrote:


Hi,
I need to do a call forwading, but when I dial *<code>*<value>, it doesn't work.
I have normallized <value>, but it doesn't still work.

For example, if  I want to do an unconditional forwading I dial *72*34957000100, but it doesn't work.
If I open the NGCP dashboard and I write the destination number (34957000100) in suscriber/preferens/callforwarding/unconditionalforwarding, however it works.
Am I doing wrong something?
Can you help me, please?
Im wating for your news.
Thank you
_______________________________________________
Spce-user mailing list
Spce-user at lists.sipwise.com<mailto:Spce-user at lists.sipwise.com>
https://lists.sipwise.com/listinfo/spce-user

-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.sipwise.com/pipermail/spce-user_lists.sipwise.com/attachments/20161206/f7a6b605/attachment-0001.html>


More information about the Spce-user mailing list