[Freeswitch-users] ITSP outbound call gets 503 unavailable

David Ponzone david.ponzone at ipeva.fr
Tue Sep 21 01:29:47 PDT 2010 

Can you send us the output of:
sofia status profile <profile>
on all the profiles you used to register to your ITSPs

David Ponzone  Direction Technique
email: david.ponzone at ipeva.fr
tel:      01 74 03 18 97
gsm:   06 66 98 76 34

Service Client IPeva
tel:      0811 46 26 26
www.ipeva.fr  -   www.ipeva-studio.com

Ce message et toutes les pièces jointes sont confidentiels et établis  
à l'intention exclusive de ses destinataires. Toute utilisation ou  
diffusion non autorisée est interdite. Tout message électronique est  
susceptible d'altération. IPeva décline toute responsabilité au  
titre de ce message s'il a été altéré, déformé ou falsifié. Si  
vous n'êtes pas destinataire de ce message, merci de le détruire  
immédiatement et d'avertir l'expéditeur.




Le 21/09/2010 à 01:58, Mario a écrit :

> Appreciate anyone who can point me to the right direction. Here is  
> more
> info from logelevel 9 trace. I ran a test with the working ITSP and
> non-working ITSP and compared the trace. They are below and it is  
> clear
> where things are different. Unfortunately, I don't see how to solve  
> the
> problem. At first I thought it was the "Auth Required" messages but I
> see them in the ITSP1 trace that works also. So I don't know if that's
> the problem. Eve if it is I don't see how to fix it since the gateway
> parms look good. This is my only major problem with FS at this  
> point, I
> am new to FS but have most things working based on the new book.
>
> --------------- ITSP2 that does NOT work -----------------------------
> nta: sent 100 Trying for INVITE (101)
> nua(0xb67056e0): event i_invite 100 Trying
> nua(0xb67056e0): call state changed: init -> received, received offer
> soa_get_remote_sdp(static::0xb67048e0, [0xb5373cac], [0xb5373ca8],
> [(nil)]) called
> nua(0xb67056e0): event i_state 100 Trying
> nua: nua_application_event: entering
> nua: nua_respond: entering
> nua(0xb67056e0): sent signal r_respond
> nua: nua_handle_magic: entering
> nua: nua_handle_destroy: entering            <------- DIFFERENCE BELOW
> nua(0xb67056e0): sent signal r_destroy
> nua: nua_application_event: entering
> nua(0xb67056e0): event i_state dropped
> nua(0xb67056e0): recv signal r_respond 407 Proxy Authentication  
> Required
> nua: nua_stack_set_params: entering
> soa_set_params(static::0xb67048e0, ...) called
> nua: nua_invite_server_respond: entering
> soa_clear_remote_sdp(static::0xb67048e0) called
> tport_tsend(0x81c1870) tpn = UDP/10.246.1.27:5060
> tport_resolve addrinfo = 10.246.1.27:5060
> tport_by_addrinfo(0x81c1870): not found by name UDP/10.246.1.27:5060
> tport_vsend(0x81c1870): 813 bytes of 813 to udp/10.246.1.27:5060
> tport_vsend returned 813
> nta: sent 407 Proxy Authentication Required for INVITE (101)
>
> --------------- ITSP1 that works ----------------------------------
> nta: sent 100 Trying for INVITE (102)
> nua(0x827cc00): event i_invite 100 Trying
> nua(0x827cc00): call state changed: init -> received, received offer
> soa_get_remote_sdp(static::0x827d0b8, [0xb53a9cac], [0xb53a9ca8],
> [(nil)]) called
> nua(0x827cc00): event i_state 100 Trying
> nua: nua_application_event: entering
> nta: timer set next to 4910 ms
> 2010-09-20 16:34:40.367812 [NOTICE] switch_channel.c:779 New Channel
> sofia/internal/200 at 10.246.1.37 [39ddcdbe-2f0e-4c58-a492-707c04baec1e]
> nua: nua_handle_bind: entering
>
>
> nua: nua_handle_magic: entering
> nua: nua_application_event: entering      <- DIFFERENCE FROM ABOVE
> nua: nua_handle_magic: entering
> 2010-09-20 16:34:40.520174 [INFO] mod_dialplan_xml.c:331 Processing  
> 200
> <200>->714082558194 in context default
> 2010-09-20 16:34:40.531634 [NOTICE] switch_channel.c:779 New Channel
> sofia/external/14082558194 at callcentric.com
> [8011f48a-3494-4e92-a5c3-eadc7139530d]
> nua: nh_create_handle: entering
>
>
> nua: nua_handle_bind: entering
> nua: nua_invite: entering
> nua(0x83e2a68): sent signal r_invite
> nua(0x83e2a68): recv signal r_invite
> nua: nua_stack_set_params: entering
> soa_clone(static::0x81799a0, 0x82d6048, 0x83e2a68) called
> soa_set_params(static::0x82081a8, ...) called
> soa_set_params(static::0x82081a8, ...) called
>
>
> On 09/20/10 15:47, Mario wrote:
>> This ITSP account is working for 2 years on a linksys/CICS PBX,  
>> SPA962
>> phones, and any softphone. It works now. One other ITSP works fine in
>> and out, Only on FS do I have the problem with this ITSP. I have 2  
>> new
>> items after talking to the ITSP:
>>
>> 1. I noticed I am getting 407 Proxy Authentication Required messages
>> when I try to make a call. Inbound ok.
>>
>> 2. The ITSP says he sees no return IP address for the call. I am  
>> behind
>> a firewall with NAT and all ports open for testing. The Linksys PBX  
>> and
>> other phones work fine. The other ITSP also works fine with FS. It's
>> only this one ITSP. I am trying to find keywords on authentication  
>> for
>> the gateway parms if there are any.
>> Mario
>>
>> On 09/20/10 15:31, David Ponzone wrote:
>>> Test the SIP account with a softphone or something.
>>>
>>> David Ponzone  Direction Technique
>>> email: david.ponzone at ipeva.fr <mailto:david.ponzone at ipeva.fr>
>>> tel:      01 74 03 18 97
>>> gsm:   06 66 98 76 34
>>>
>>> Service Client IPeva
>>> tel:      0811 46 26 26
>>> www.ipeva.fr <BLOCKED::http://www.ipeva.fr/>  -   www.ipeva-studio.com
>>> <BLOCKED::http://www.ipeva-studio.com/>
>>>
>>> /Ce message et toutes les pièces jointes sont confidentiels et  
>>> établis à
>>> l'intention exclusive de ses destinataires. Toute utilisation ou
>>> diffusion non autorisée est interdite. Tout message électronique  
>>> est
>>> susceptible d'altération. /*/IPeva/*/ décline toute  
>>> responsabilité au
>>> titre de ce message s'il a été altéré, déformé ou falsifié.  
>>> Si vous
>>> n'êtes pas destinataire de ce message, merci de le détruire
>>> immédiatement et d'avertir l'expéditeur./
>>> /
>>> /
>>>
>>>
>>>
>>> Le 20/09/2010 à 23:42, Mario a écrit :
>>>
>>>> Brand new FS user here. Here is an additional info for my issue  
>>>> of not
>>>> being able to make outbound calls. I searched and found a "sofia
>>>> loglevel all 9" command and found that when I make a call I get  
>>>> the 503
>>>> service not available message. Inbound works fine. Anyone have an  
>>>> idea?
>>>> Many thanks!
>>>>
>>>> nua(0x8135520): recv signal r_respond 503 Service Unavailable
>>>>
>>>>
>>>> nua: nua_stack_set_params: entering
>>>> soa_set_params(static::0x812ecc8, ...) called
>>>> nua: nua_invite_server_respond: entering
>>>> soa_clear_remote_sdp(static::0x812ecc8) called
>>>> tport_tsend(0x817aa88) tpn = UDP/10.246.1.27:5060
>>>> tport_resolve addrinfo = 10.246.1.27:5060
>>>> tport_by_addrinfo(0x817aa88): not found by name UDP/ 
>>>> 10.246.1.27:5060
>>>> tport_vsend(0x817aa88): 838 bytes of 838 to udp/10.246.1.27:5060
>>>> tport_vsend returned 838
>>>> nta: sent 503 Service Unavailable for INVITE (102)
>>>> nta: timer shortened to 500 ms
>>>> nua(0x8135520): removing session usage
>>>> nua(0x8135520): call state changed: received -> terminated
>>>> nua(0x8135520): event i_state 503 Service Unavailable
>>>> nua(0x8135520): event i_terminated 503 Service Unavailable
>>>> soa_destroy(static::0x812ecc8) called
>>>> nta_leg_destroy(0x81325f0)
>>>> nua: nua_application_event: entering
>>>> nua: nua_handle_magic: entering
>>>> nua: nua_handle_bind: entering
>>>> nua: nua_application_event: entering
>>>> nua: nua_handle_magic: entering
>>>> nua: nua_handle_destroy: entering
>>>> nua(0x8135520): sent signal r_destroy
>>>> nua(0x8135520): recv signal r_destroy
>>>> nta_leg_destroy((nil))
>>>> tport_wakeup_pri(0x817aa88): events IN
>>>> tport_recv_event(0x817aa88)
>>>> tport_recv_iovec(0x817aa88) msg 0x81715a8 from (udp/ 
>>>> 10.246.1.37:5060)
>>>> has 638 bytes, veclen = 1
>>>> tport_deliver(0x817aa88): msg 0x81715a8 (638 bytes) from
>>>> udp/10.246.1.27:5060/sip next=(nil)
>>>> nta: received ACK sip:914082558194 at 10.246.1.37 SIP/2.0 (CSeq 102)
>>>> nta: ACK (102) is going to INVITE (102)
>>>> nta: timer set next to 2305 ms
>>>> nta: timer I fired, terminate 407 response
>>>> incoming_reclaim_all((nil), (nil), 0xb54550ec)
>>>> nta_incoming_timer: 0/0 resent, 0/0 tout, 1/3 term, 1/3 free
>>>> nta: timer set next to 2206 ms
>>>> nta: timer I fired, terminate 503 response
>>>> incoming_reclaim_all((nil), (nil), 0xb54550ec)
>>>> nta_incoming_timer: 0/0 resent, 0/0 tout, 1/2 term, 1/2 free
>>>>
>>>>
>>>> On 09/20/10 14:18, Mario wrote:
>>>>> For this ITSP, registration is ok and inbound calls work. But when
>>>>> making an outbound call the call is sent to the itsp but then  
>>>>> gets a
>>>>> fast busy. From what I see in the trace the itsp uses asterisk.  
>>>>> I sent a
>>>>> trace in a previous email but it shows nothing I could see  
>>>>> missing or in
>>>>> error. The itsp sent the config info below but I have been using  
>>>>> them
>>>>> without a STUN server fine on my old PBX. Is there anything that  
>>>>> looks
>>>>> like it is out of sync with defaults (like port?). Also, the SIP  
>>>>> and DP
>>>>> are below but since the call is sent the DP must be ok. Thanks  
>>>>> for any
>>>>> help/suggestions!
>>>>>
>>>>>
>>>>> From the ITSP:>
>>>>> Sip Proxy - sip.voipyourphone.com
>>>>> STN Server - stun.voipyourphone.com
>>>>> Registration Port - any one port between 5060 and 5069
>>>>> DTMF port 5004
>>>>> RTP ports 16384 to 16482
>>>>> Audio Codecs G711u (account default), G711a, G729a and iLbc
>>>>> DTMF rfc2833 (default), inband, SIP-INFO
>>>>>
>>>>>
>>>>> SIP:
>>>>>    <gateway name="uid1">
>>>>>     <param name="proxy" value="sip.voipyourphone.com"/>
>>>>>     <param name="username" value="uid1"/>
>>>>>     <param name="from-user" value="uid1"/>
>>>>>     <param name="password" value="pwd1"/>
>>>>>     <param name="expire-seconds" value="600"/>
>>>>>     <param name="register" value="true"/>
>>>>>     <param name="retry-seconds" value="30"/>
>>>>>
>>>>> DP
>>>>> <extension name="local.uid1">
>>>>>   <condition field="${toll_allow}" expression="local"/>
>>>>>   <condition field="destination_number" expression="^9(\d{7})$">
>>>>>     <action application="set"
>>>>> data="effective_caller_id_number=${outbound_caller_id_number}"/>
>>>>>     <action application="set"
>>>>> data="effective_caller_id_name=${outbound_caller_id_name}"/>
>>>>>     <action application="bridge"
>>>>> data="sofia/gateway/uid1/1${default_areacode}$1 at sip.voipyourlife.com
>>>>> <mailto:sofia/gateway/uid1/1${default_areacode}$1 at sip.voipyourlife.com 
>>>>> >"/>
>>>>>   </condition>
>>>>> </extension>
>>>>>
>>>>
>>>> _______________________________________________
>>>> FreeSWITCH-users mailing list
>>>> FreeSWITCH-users at lists.freeswitch.org
>>>> <mailto: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
>>>
>>>
>>>
>>> _______________________________________________
>>> 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
>
> _______________________________________________
> 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/20100921/425f6bcb/attachment-0001.html

More information about the FreeSWITCH-users mailing list