[Freeswitch-users] Getting NO_ROUTE_DESTINATION

Miha Zoubek miha at softnet.si
Fri Oct 28 15:46:14 MSD 2011


Hi @Michael,

sorry for spaming:) I figure it out.

Thanks a lot.

New verison from git helped:)

BR,
Miha

On 10/28/2011 12:34 PM, Miha Zoubek wrote:
> Please look at the newest file.
>
> Sorry for my mistake.
>
> BR,
> Miha
>
> On 10/28/2011 10:35 AM, Miha Zoubek wrote:
>> Hi @Michael,
>>
>> I have done as you said.
>>
>> http://pastebin.freeswitch.org/17628 (usr miha-)
>>
>> I have installed on new server (cenots) freeswitch (from git), as 
>> sofia global command was not recognised on version 1.0.6.
>>
>> I configured it like on previous freeswitch.
>>
>> Thank you!
>>
>> BR,
>> Miha
>>
>> On 10/27/2011 5:18 PM, Michael Collins wrote:
>>> Okay, a few things. First, let's use pastebin.freeswitch.org 
>>> <http://pastebin.freeswitch.org> since there is so much information. 
>>> Second, I recommend turning on sofia sip trace:
>>> sofia global siptrace on
>>>
>>> Make another test call and capture the output. Let's see what the 
>>> other side sends leading up to the no route message.
>>> -MC
>>>
>>> On Thu, Oct 27, 2011 at 6:45 AM, Miha Zoubek <miha at softnet.si 
>>> <mailto:miha at softnet.si>> wrote:
>>>
>>>     This log is from cli:
>>>
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Line] = [1164]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [User-Data] = [9240aaac-7466-4a4d-aded-e74998dfeb01]
>>>     [DEBUG] libs/esl/src/esl.c:1037 esl_recv_event() RECV MESSAGE
>>>     Event-Name: SOCKET_DATA
>>>     Content-Type: log/data
>>>     Content-Length: 136
>>>     Log-Level: 7
>>>     Text-Channel: 3
>>>     Log-File: switch_core_session.c
>>>     Log-Func: switch_core_session_thread
>>>     Log-Line: 1164
>>>     User-Data: 9240aaac-7466-4a4d-aded-e74998dfeb01
>>>
>>>
>>>     2011-10-27 15:45:39.325859 [DEBUG] switch_core_session.c:1164
>>>     Session 8 (sofia/external/051357952) Locked, Waiting on external
>>>     entities
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Type] = [log/data]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Length] = [106]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Level] = [5]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Text-Channel] = [3]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-File] = [switch_core_session.c]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Func] = [switch_core_session_thread]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Line] = [1182]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [User-Data] = [9240aaac-7466-4a4d-aded-e74998dfeb01]
>>>     [DEBUG] libs/esl/src/esl.c:1037 esl_recv_event() RECV MESSAGE
>>>     Event-Name: SOCKET_DATA
>>>     Content-Type: log/data
>>>     Content-Length: 106
>>>     Log-Level: 5
>>>     Text-Channel: 3
>>>     Log-File: switch_core_session.c
>>>     Log-Func: switch_core_session_thread
>>>     Log-Line: 1182
>>>     User-Data: 9240aaac-7466-4a4d-aded-e74998dfeb01
>>>
>>>
>>>     2011-10-27 15:45:39.325859 [NOTICE] switch_core_session.c:1182
>>>     Session 8 (sofia/external/051357952) Ended
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Type] = [log/data]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Length] = [115]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Level] = [5]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Text-Channel] = [0]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-File] = [switch_core_session.c]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Func] = [switch_core_session_thread]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Line] = [1184]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [User-Data] = [9240aaac-7466-4a4d-aded-e74998dfeb01]
>>>     [DEBUG] libs/esl/src/esl.c:1037 esl_recv_event() RECV MESSAGE
>>>     Event-Name: SOCKET_DATA
>>>     Content-Type: log/data
>>>     Content-Length: 115
>>>     Log-Level: 5
>>>     Text-Channel: 0
>>>     Log-File: switch_core_session.c
>>>     Log-Func: switch_core_session_thread
>>>     Log-Line: 1184
>>>     User-Data: 9240aaac-7466-4a4d-aded-e74998dfeb01
>>>
>>>
>>>     2011-10-27 15:45:39.325859 [NOTICE] switch_core_session.c:1184
>>>     Close Channel sofia/external/051357952 [CS_DESTROY]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Type] = [log/data]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Length] = [126]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Level] = [7]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Text-Channel] = [0]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-File] = [switch_core_state_machine.c]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Func] = [switch_core_session_destroy_state]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Line] = [428]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [User-Data] = [9240aaac-7466-4a4d-aded-e74998dfeb01]
>>>     [DEBUG] libs/esl/src/esl.c:1037 esl_recv_event() RECV MESSAGE
>>>     Event-Name: SOCKET_DATA
>>>     Content-Type: log/data
>>>     Content-Length: 126
>>>     Log-Level: 7
>>>     Text-Channel: 0
>>>     Log-File: switch_core_state_machine.c
>>>     Log-Func: switch_core_session_destroy_state
>>>     Log-Line: 428
>>>     User-Data: 9240aaac-7466-4a4d-aded-e74998dfeb01
>>>
>>>
>>>     2011-10-27 15:45:39.328931 [DEBUG]
>>>     switch_core_state_machine.c:428 (sofia/external/051357952)
>>>     Running State Change CS_DESTROY
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Type] = [log/data]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Length] = [108]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Level] = [7]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Text-Channel] = [3]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-File] = [switch_core_state_machine.c]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Func] = [switch_core_session_destroy_state]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Line] = [439]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [User-Data] = [9240aaac-7466-4a4d-aded-e74998dfeb01]
>>>     [DEBUG] libs/esl/src/esl.c:1037 esl_recv_event() RECV MESSAGE
>>>     Event-Name: SOCKET_DATA
>>>     Content-Type: log/data
>>>     Content-Length: 108
>>>     Log-Level: 7
>>>     Text-Channel: 3
>>>     Log-File: switch_core_state_machine.c
>>>     Log-Func: switch_core_session_destroy_state
>>>     Log-Line: 439
>>>     User-Data: 9240aaac-7466-4a4d-aded-e74998dfeb01
>>>
>>>
>>>     2011-10-27 15:45:39.328931 [DEBUG]
>>>     switch_core_state_machine.c:439 (sofia/external/051357952) State
>>>     DESTROY
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Type] = [log/data]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Length] = [90]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Level] = [7]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Text-Channel] = [3]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-File] = [mod_sofia.c]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Func] = [sofia_on_destroy]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Line] = [341]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [User-Data] = [9240aaac-7466-4a4d-aded-e74998dfeb01]
>>>     [DEBUG] libs/esl/src/esl.c:1037 esl_recv_event() RECV MESSAGE
>>>     Event-Name: SOCKET_DATA
>>>     Content-Type: log/data
>>>     Content-Length: 90
>>>     Log-Level: 7
>>>     Text-Channel: 3
>>>     Log-File: mod_sofia.c
>>>     Log-Func: sofia_on_destroy
>>>     Log-Line: 341
>>>     User-Data: 9240aaac-7466-4a4d-aded-e74998dfeb01
>>>
>>>
>>>     2011-10-27 15:45:39.328931 [DEBUG] mod_sofia.c:341
>>>     sofia/external/051357952 SOFIA DESTROY
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Type] = [log/data]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Length] = [108]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Level] = [7]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Text-Channel] = [3]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-File] = [switch_core_state_machine.c]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Func] = [switch_core_standard_on_destroy]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Line] = [60]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [User-Data] = [9240aaac-7466-4a4d-aded-e74998dfeb01]
>>>     [DEBUG] libs/esl/src/esl.c:1037 esl_recv_event() RECV MESSAGE
>>>     Event-Name: SOCKET_DATA
>>>     Content-Type: log/data
>>>     Content-Length: 108
>>>     Log-Level: 7
>>>     Text-Channel: 3
>>>     Log-File: switch_core_state_machine.c
>>>     Log-Func: switch_core_standard_on_destroy
>>>     Log-Line: 60
>>>     User-Data: 9240aaac-7466-4a4d-aded-e74998dfeb01
>>>
>>>
>>>     2011-10-27 15:45:39.328931 [DEBUG]
>>>     switch_core_state_machine.c:60 sofia/external/051357952 Standard
>>>     DESTROY
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Type] = [log/data]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Length] = [123]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Level] = [7]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Text-Channel] = [3]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-File] = [switch_core_state_machine.c]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Func] = [switch_core_session_destroy_state]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Line] = [439]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [User-Data] = [9240aaac-7466-4a4d-aded-e74998dfeb01]
>>>     [DEBUG] libs/esl/src/esl.c:1037 esl_recv_event() RECV MESSAGE
>>>     Event-Name: SOCKET_DATA
>>>     Content-Type: log/data
>>>     Content-Length: 123
>>>     Log-Level: 7
>>>     Text-Channel: 3
>>>     Log-File: switch_core_state_machine.c
>>>     Log-Func: switch_core_session_destroy_state
>>>     Log-Line: 439
>>>     User-Data: 9240aaac-7466-4a4d-aded-e74998dfeb01
>>>
>>>
>>>     2011-10-27 15:45:39.328931 [DEBUG]
>>>     switch_core_state_machine.c:439 (sofia/external/051357952) State
>>>     DESTROY going to sleep
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Type] = [log/data]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Length] = [82]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Level] = [7]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Text-Channel] = [3]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-File] = [mod_sofia.c]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Func] = [sofia_on_hangup]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Line] = [476]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [User-Data] = [962db612-d472-4f8b-88f9-5349f0034660]
>>>     [DEBUG] libs/esl/src/esl.c:1037 esl_recv_event() RECV MESSAGE
>>>     Event-Name: SOCKET_DATA
>>>     Content-Type: log/data
>>>     Content-Length: 82
>>>     Log-Level: 7
>>>     Text-Channel: 3
>>>     Log-File: mod_sofia.c
>>>     Log-Func: sofia_on_hangup
>>>     Log-Line: 476
>>>     User-Data: 962db612-d472-4f8b-88f9-5349f0034660
>>>
>>>
>>>     2011-10-27 15:45:39.355813 [DEBUG] mod_sofia.c:476 Responding to
>>>     INVITE with: 404
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Type] = [log/data]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Length] = [144]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Level] = [7]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Text-Channel] = [3]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-File] = [switch_core_state_machine.c]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Func] = [switch_core_standard_on_hangup]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Line] = [46]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [User-Data] = [962db612-d472-4f8b-88f9-5349f0034660]
>>>     [DEBUG] libs/esl/src/esl.c:1037 esl_recv_event() RECV MESSAGE
>>>     Event-Name: SOCKET_DATA
>>>     Content-Type: log/data
>>>     Content-Length: 144
>>>     Log-Level: 7
>>>     Text-Channel: 3
>>>     Log-File: switch_core_state_machine.c
>>>     Log-Func: switch_core_standard_on_hangup
>>>     Log-Line: 46
>>>     User-Data: 962db612-d472-4f8b-88f9-5349f0034660
>>>
>>>
>>>     2011-10-27 15:45:39.357844 [DEBUG]
>>>     switch_core_state_machine.c:46 sofia/internal/1030 at 172.31.1.192
>>>     <mailto:sofia/internal/1030 at 172.31.1.192> Standard HANGUP,
>>>     cause: NO_ROUTE_DESTINATION
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Type] = [log/data]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Length] = [130]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Level] = [7]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Text-Channel] = [3]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-File] = [switch_core_state_machine.c]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Func] = [switch_core_session_hangup_state]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Line] = [499]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [User-Data] = [962db612-d472-4f8b-88f9-5349f0034660]
>>>     [DEBUG] libs/esl/src/esl.c:1037 esl_recv_event() RECV MESSAGE
>>>     Event-Name: SOCKET_DATA
>>>     Content-Type: log/data
>>>     Content-Length: 130
>>>     Log-Level: 7
>>>     Text-Channel: 3
>>>     Log-File: switch_core_state_machine.c
>>>     Log-Func: switch_core_session_hangup_state
>>>     Log-Line: 499
>>>     User-Data: 962db612-d472-4f8b-88f9-5349f0034660
>>>
>>>
>>>     2011-10-27 15:45:39.357844 [DEBUG]
>>>     switch_core_state_machine.c:499
>>>     (sofia/internal/1030 at 172.31.1.192
>>>     <mailto:sofia/internal/1030 at 172.31.1.192>) State HANGUP going to
>>>     sleep
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Type] = [log/data]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Length] = [141]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Level] = [7]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Text-Channel] = [0]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-File] = [switch_core_state_machine.c]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Func] = [switch_core_session_run]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Line] = [333]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [User-Data] = [962db612-d472-4f8b-88f9-5349f0034660]
>>>     [DEBUG] libs/esl/src/esl.c:1037 esl_recv_event() RECV MESSAGE
>>>     Event-Name: SOCKET_DATA
>>>     Content-Type: log/data
>>>     Content-Length: 141
>>>     Log-Level: 7
>>>     Text-Channel: 0
>>>     Log-File: switch_core_state_machine.c
>>>     Log-Func: switch_core_session_run
>>>     Log-Line: 333
>>>     User-Data: 962db612-d472-4f8b-88f9-5349f0034660
>>>
>>>
>>>     2011-10-27 15:45:39.357844 [DEBUG]
>>>     switch_core_state_machine.c:333
>>>     (sofia/internal/1030 at 172.31.1.192
>>>     <mailto:sofia/internal/1030 at 172.31.1.192>) State Change
>>>     CS_HANGUP -> CS_REPORTING
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Type] = [log/data]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Length] = [115]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Level] = [7]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Text-Channel] = [0]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-File] = [switch_core_session.c]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Func] = [switch_core_session_signal_state_change]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Line] = [1021]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [User-Data] = [962db612-d472-4f8b-88f9-5349f0034660]
>>>     [DEBUG] libs/esl/src/esl.c:1037 esl_recv_event() RECV MESSAGE
>>>     Event-Name: SOCKET_DATA
>>>     Content-Type: log/data
>>>     Content-Length: 115
>>>     Log-Level: 7
>>>     Text-Channel: 0
>>>     Log-File: switch_core_session.c
>>>     Log-Func: switch_core_session_signal_state_change
>>>     Log-Line: 1021
>>>     User-Data: 962db612-d472-4f8b-88f9-5349f0034660
>>>
>>>
>>>     2011-10-27 15:45:39.357844 [DEBUG] switch_core_session.c:1021
>>>     Send signal sofia/internal/1030 at 172.31.1.192
>>>     <mailto:sofia/internal/1030 at 172.31.1.192> [BREAK]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Type] = [log/data]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Length] = [136]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Level] = [7]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Text-Channel] = [0]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-File] = [switch_core_state_machine.c]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Func] = [switch_core_session_run]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Line] = [314]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [User-Data] = [962db612-d472-4f8b-88f9-5349f0034660]
>>>     [DEBUG] libs/esl/src/esl.c:1037 esl_recv_event() RECV MESSAGE
>>>     Event-Name: SOCKET_DATA
>>>     Content-Type: log/data
>>>     Content-Length: 136
>>>     Log-Level: 7
>>>     Text-Channel: 0
>>>     Log-File: switch_core_state_machine.c
>>>     Log-Func: switch_core_session_run
>>>     Log-Line: 314
>>>     User-Data: 962db612-d472-4f8b-88f9-5349f0034660
>>>
>>>
>>>     2011-10-27 15:45:39.357844 [DEBUG]
>>>     switch_core_state_machine.c:314
>>>     (sofia/internal/1030 at 172.31.1.192
>>>     <mailto:sofia/internal/1030 at 172.31.1.192>) Running State Change
>>>     CS_REPORTING
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Type] = [log/data]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Length] = [118]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Level] = [7]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Text-Channel] = [3]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-File] = [switch_core_state_machine.c]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Func] = [switch_core_session_reporting_state]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Line] = [590]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [User-Data] = [962db612-d472-4f8b-88f9-5349f0034660]
>>>     [DEBUG] libs/esl/src/esl.c:1037 esl_recv_event() RECV MESSAGE
>>>     Event-Name: SOCKET_DATA
>>>     Content-Type: log/data
>>>     Content-Length: 118
>>>     Log-Level: 7
>>>     Text-Channel: 3
>>>     Log-File: switch_core_state_machine.c
>>>     Log-Func: switch_core_session_reporting_state
>>>     Log-Line: 590
>>>     User-Data: 962db612-d472-4f8b-88f9-5349f0034660
>>>
>>>
>>>     2011-10-27 15:45:39.357844 [DEBUG]
>>>     switch_core_state_machine.c:590
>>>     (sofia/internal/1030 at 172.31.1.192
>>>     <mailto:sofia/internal/1030 at 172.31.1.192>) State REPORTING
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Type] = [log/data]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Length] = [147]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Level] = [7]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Text-Channel] = [3]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-File] = [switch_core_state_machine.c]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Func] = [switch_core_standard_on_reporting]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Line] = [53]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [User-Data] = [962db612-d472-4f8b-88f9-5349f0034660]
>>>     [DEBUG] libs/esl/src/esl.c:1037 esl_recv_event() RECV MESSAGE
>>>     Event-Name: SOCKET_DATA
>>>     Content-Type: log/data
>>>     Content-Length: 147
>>>     Log-Level: 7
>>>     Text-Channel: 3
>>>     Log-File: switch_core_state_machine.c
>>>     Log-Func: switch_core_standard_on_reporting
>>>     Log-Line: 53
>>>     User-Data: 962db612-d472-4f8b-88f9-5349f0034660
>>>
>>>
>>>     2011-10-27 15:45:39.357844 [DEBUG]
>>>     switch_core_state_machine.c:53 sofia/internal/1030 at 172.31.1.192
>>>     <mailto:sofia/internal/1030 at 172.31.1.192> Standard REPORTING,
>>>     cause: NO_ROUTE_DESTINATION
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Type] = [log/data]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Length] = [133]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Level] = [7]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Text-Channel] = [3]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-File] = [switch_core_state_machine.c]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Func] = [switch_core_session_reporting_state]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Line] = [590]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [User-Data] = [962db612-d472-4f8b-88f9-5349f0034660]
>>>     [DEBUG] libs/esl/src/esl.c:1037 esl_recv_event() RECV MESSAGE
>>>     Event-Name: SOCKET_DATA
>>>     Content-Type: log/data
>>>     Content-Length: 133
>>>     Log-Level: 7
>>>     Text-Channel: 3
>>>     Log-File: switch_core_state_machine.c
>>>     Log-Func: switch_core_session_reporting_state
>>>     Log-Line: 590
>>>     User-Data: 962db612-d472-4f8b-88f9-5349f0034660
>>>
>>>
>>>     2011-10-27 15:45:39.357844 [DEBUG]
>>>     switch_core_state_machine.c:590
>>>     (sofia/internal/1030 at 172.31.1.192
>>>     <mailto:sofia/internal/1030 at 172.31.1.192>) State REPORTING going
>>>     to sleep
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Type] = [log/data]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Length] = [142]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Level] = [7]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Text-Channel] = [0]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-File] = [switch_core_state_machine.c]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Func] = [switch_core_session_run]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Line] = [327]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [User-Data] = [962db612-d472-4f8b-88f9-5349f0034660]
>>>     [DEBUG] libs/esl/src/esl.c:1037 esl_recv_event() RECV MESSAGE
>>>     Event-Name: SOCKET_DATA
>>>     Content-Type: log/data
>>>     Content-Length: 142
>>>     Log-Level: 7
>>>     Text-Channel: 0
>>>     Log-File: switch_core_state_machine.c
>>>     Log-Func: switch_core_session_run
>>>     Log-Line: 327
>>>     User-Data: 962db612-d472-4f8b-88f9-5349f0034660
>>>
>>>
>>>     2011-10-27 15:45:39.357844 [DEBUG]
>>>     switch_core_state_machine.c:327
>>>     (sofia/internal/1030 at 172.31.1.192
>>>     <mailto:sofia/internal/1030 at 172.31.1.192>) State Change
>>>     CS_REPORTING -> CS_DESTROY
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Type] = [log/data]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Length] = [115]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Level] = [7]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Text-Channel] = [0]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-File] = [switch_core_session.c]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Func] = [switch_core_session_signal_state_change]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Line] = [1021]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [User-Data] = [962db612-d472-4f8b-88f9-5349f0034660]
>>>     [DEBUG] libs/esl/src/esl.c:1037 esl_recv_event() RECV MESSAGE
>>>     Event-Name: SOCKET_DATA
>>>     Content-Type: log/data
>>>     Content-Length: 115
>>>     Log-Level: 7
>>>     Text-Channel: 0
>>>     Log-File: switch_core_session.c
>>>     Log-Func: switch_core_session_signal_state_change
>>>     Log-Line: 1021
>>>     User-Data: 962db612-d472-4f8b-88f9-5349f0034660
>>>
>>>
>>>     2011-10-27 15:45:39.357844 [DEBUG] switch_core_session.c:1021
>>>     Send signal sofia/internal/1030 at 172.31.1.192
>>>     <mailto:sofia/internal/1030 at 172.31.1.192> [BREAK]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Type] = [log/data]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Length] = [144]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Level] = [7]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Text-Channel] = [3]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-File] = [switch_core_session.c]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Func] = [switch_core_session_thread]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Line] = [1164]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [User-Data] = [962db612-d472-4f8b-88f9-5349f0034660]
>>>     [DEBUG] libs/esl/src/esl.c:1037 esl_recv_event() RECV MESSAGE
>>>     Event-Name: SOCKET_DATA
>>>     Content-Type: log/data
>>>     Content-Length: 144
>>>     Log-Level: 7
>>>     Text-Channel: 3
>>>     Log-File: switch_core_session.c
>>>     Log-Func: switch_core_session_thread
>>>     Log-Line: 1164
>>>     User-Data: 962db612-d472-4f8b-88f9-5349f0034660
>>>
>>>
>>>     2011-10-27 15:45:39.357844 [DEBUG] switch_core_session.c:1164
>>>     Session 7 (sofia/internal/1030 at 172.31.1.192
>>>     <mailto:sofia/internal/1030 at 172.31.1.192>) Locked, Waiting on
>>>     external entities
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Type] = [log/data]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Length] = [114]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Level] = [5]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Text-Channel] = [3]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-File] = [switch_core_session.c]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Func] = [switch_core_session_thread]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Line] = [1182]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [User-Data] = [962db612-d472-4f8b-88f9-5349f0034660]
>>>     [DEBUG] libs/esl/src/esl.c:1037 esl_recv_event() RECV MESSAGE
>>>     Event-Name: SOCKET_DATA
>>>     Content-Type: log/data
>>>     Content-Length: 114
>>>     Log-Level: 5
>>>     Text-Channel: 3
>>>     Log-File: switch_core_session.c
>>>     Log-Func: switch_core_session_thread
>>>     Log-Line: 1182
>>>     User-Data: 962db612-d472-4f8b-88f9-5349f0034660
>>>
>>>
>>>     2011-10-27 15:45:39.357844 [NOTICE] switch_core_session.c:1182
>>>     Session 7 (sofia/internal/1030 at 172.31.1.192
>>>     <mailto:sofia/internal/1030 at 172.31.1.192>) Ended
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Type] = [log/data]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Length] = [123]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Level] = [5]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Text-Channel] = [0]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-File] = [switch_core_session.c]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Func] = [switch_core_session_thread]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Line] = [1184]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [User-Data] = [962db612-d472-4f8b-88f9-5349f0034660]
>>>     [DEBUG] libs/esl/src/esl.c:1037 esl_recv_event() RECV MESSAGE
>>>     Event-Name: SOCKET_DATA
>>>     Content-Type: log/data
>>>     Content-Length: 123
>>>     Log-Level: 5
>>>     Text-Channel: 0
>>>     Log-File: switch_core_session.c
>>>     Log-Func: switch_core_session_thread
>>>     Log-Line: 1184
>>>     User-Data: 962db612-d472-4f8b-88f9-5349f0034660
>>>
>>>
>>>     2011-10-27 15:45:39.357844 [NOTICE] switch_core_session.c:1184
>>>     Close Channel sofia/internal/1030 at 172.31.1.192
>>>     <mailto:sofia/internal/1030 at 172.31.1.192> [CS_DESTROY]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Type] = [log/data]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Length] = [134]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Level] = [7]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Text-Channel] = [0]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-File] = [switch_core_state_machine.c]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Func] = [switch_core_session_destroy_state]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Line] = [428]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [User-Data] = [962db612-d472-4f8b-88f9-5349f0034660]
>>>     [DEBUG] libs/esl/src/esl.c:1037 esl_recv_event() RECV MESSAGE
>>>     Event-Name: SOCKET_DATA
>>>     Content-Type: log/data
>>>     Content-Length: 134
>>>     Log-Level: 7
>>>     Text-Channel: 0
>>>     Log-File: switch_core_state_machine.c
>>>     Log-Func: switch_core_session_destroy_state
>>>     Log-Line: 428
>>>     User-Data: 962db612-d472-4f8b-88f9-5349f0034660
>>>
>>>
>>>     2011-10-27 15:45:39.357844 [DEBUG]
>>>     switch_core_state_machine.c:428
>>>     (sofia/internal/1030 at 172.31.1.192
>>>     <mailto:sofia/internal/1030 at 172.31.1.192>) Running State Change
>>>     CS_DESTROY
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Type] = [log/data]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Length] = [116]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Level] = [7]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Text-Channel] = [3]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-File] = [switch_core_state_machine.c]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Func] = [switch_core_session_destroy_state]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Line] = [439]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [User-Data] = [962db612-d472-4f8b-88f9-5349f0034660]
>>>     [DEBUG] libs/esl/src/esl.c:1037 esl_recv_event() RECV MESSAGE
>>>     Event-Name: SOCKET_DATA
>>>     Content-Type: log/data
>>>     Content-Length: 116
>>>     Log-Level: 7
>>>     Text-Channel: 3
>>>     Log-File: switch_core_state_machine.c
>>>     Log-Func: switch_core_session_destroy_state
>>>     Log-Line: 439
>>>     User-Data: 962db612-d472-4f8b-88f9-5349f0034660
>>>
>>>
>>>     2011-10-27 15:45:39.357844 [DEBUG]
>>>     switch_core_state_machine.c:439
>>>     (sofia/internal/1030 at 172.31.1.192
>>>     <mailto:sofia/internal/1030 at 172.31.1.192>) State DESTROY
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Type] = [log/data]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Length] = [98]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Level] = [7]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Text-Channel] = [3]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-File] = [mod_sofia.c]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Func] = [sofia_on_destroy]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Line] = [341]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [User-Data] = [962db612-d472-4f8b-88f9-5349f0034660]
>>>     [DEBUG] libs/esl/src/esl.c:1037 esl_recv_event() RECV MESSAGE
>>>     Event-Name: SOCKET_DATA
>>>     Content-Type: log/data
>>>     Content-Length: 98
>>>     Log-Level: 7
>>>     Text-Channel: 3
>>>     Log-File: mod_sofia.c
>>>     Log-Func: sofia_on_destroy
>>>     Log-Line: 341
>>>     User-Data: 962db612-d472-4f8b-88f9-5349f0034660
>>>
>>>
>>>     2011-10-27 15:45:39.357844 [DEBUG] mod_sofia.c:341
>>>     sofia/internal/1030 at 172.31.1.192
>>>     <mailto:sofia/internal/1030 at 172.31.1.192> SOFIA DESTROY
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Type] = [log/data]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Length] = [116]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Level] = [7]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Text-Channel] = [3]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-File] = [switch_core_state_machine.c]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Func] = [switch_core_standard_on_destroy]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Line] = [60]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [User-Data] = [962db612-d472-4f8b-88f9-5349f0034660]
>>>     [DEBUG] libs/esl/src/esl.c:1037 esl_recv_event() RECV MESSAGE
>>>     Event-Name: SOCKET_DATA
>>>     Content-Type: log/data
>>>     Content-Length: 116
>>>     Log-Level: 7
>>>     Text-Channel: 3
>>>     Log-File: switch_core_state_machine.c
>>>     Log-Func: switch_core_standard_on_destroy
>>>     Log-Line: 60
>>>     User-Data: 962db612-d472-4f8b-88f9-5349f0034660
>>>
>>>
>>>     2011-10-27 15:45:39.357844 [DEBUG]
>>>     switch_core_state_machine.c:60 sofia/internal/1030 at 172.31.1.192
>>>     <mailto:sofia/internal/1030 at 172.31.1.192> Standard DESTROY
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Type] = [log/data]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Content-Length] = [131]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Level] = [7]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Text-Channel] = [3]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-File] = [switch_core_state_machine.c]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Func] = [switch_core_session_destroy_state]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [Log-Line] = [439]
>>>     [DEBUG] libs/esl/src/esl.c:918 esl_recv_event() RECV HEADER
>>>     [User-Data] = [962db612-d472-4f8b-88f9-5349f0034660]
>>>     [DEBUG] libs/esl/src/esl.c:1037 esl_recv_event() RECV MESSAGE
>>>     Event-Name: SOCKET_DATA
>>>     Content-Type: log/data
>>>     Content-Length: 131
>>>     Log-Level: 7
>>>     Text-Channel: 3
>>>     Log-File: switch_core_state_machine.c
>>>     Log-Func: switch_core_session_destroy_state
>>>     Log-Line: 439
>>>     User-Data: 962db612-d472-4f8b-88f9-5349f0034660
>>>
>>>
>>>     2011-10-27 15:45:39.357844 [DEBUG]
>>>     switch_core_state_machine.c:439
>>>     (sofia/internal/1030 at 172.31.1.192
>>>     <mailto:sofia/internal/1030 at 172.31.1.192>) State DESTROY going
>>>     to sleep
>>>
>>>
>>>
>>>     On 10/27/2011 2:57 PM, Miha Zoubek wrote:
>>>>     Hi,
>>>>
>>>>     path of my dialplan is:
>>>>     /usr/local/freeswitch/conf/dialplan/default/test.xml
>>>>
>>>>
>>>>
>>>>     I rename IP800 for innovaphone.
>>>>
>>>>     Here is my debugging log:
>>>>
>>>>     Dialplan: sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192> Regex (FAIL)
>>>>     [hold_music] destination_number(9051357952) =~ /^9999$/
>>>>     break=on-false
>>>>     Dialplan: sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192> parsing
>>>>     [default->Dial Out Custom Gateway] continue=false
>>>>     Dialplan: sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192> Regex (PASS) [Dial
>>>>     Out Custom Gateway] destination_number(9051357952) =~
>>>>     /^9(\d{9})$/ break=on-false
>>>>     Dialplan: sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192> Action
>>>>     bridge(sofia/gateway/innovaphone/051357952)
>>>>     2011-10-27 14:54:58.927692 [DEBUG]
>>>>     switch_core_state_machine.c:119
>>>>     (sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192>) State Change
>>>>     CS_ROUTING -> CS_EXECUTE
>>>>     2011-10-27 14:54:58.927692 [DEBUG] switch_core_session.c:1021
>>>>     Send signal sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192> [BREAK]
>>>>     2011-10-27 14:54:58.927692 [DEBUG]
>>>>     switch_core_state_machine.c:341
>>>>     (sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192>) State ROUTING going
>>>>     to sleep
>>>>     2011-10-27 14:54:58.927692 [DEBUG]
>>>>     switch_core_state_machine.c:314
>>>>     (sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192>) Running State Change
>>>>     CS_EXECUTE
>>>>     2011-10-27 14:54:58.927692 [DEBUG]
>>>>     switch_core_state_machine.c:348
>>>>     (sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192>) State EXECUTE
>>>>     2011-10-27 14:54:58.927692 [DEBUG] mod_sofia.c:226
>>>>     sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192> SOFIA EXECUTE
>>>>     2011-10-27 14:54:58.927692 [DEBUG]
>>>>     switch_core_state_machine.c:157
>>>>     sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192> Standard EXECUTE
>>>>     EXECUTE sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192> set(open=true)
>>>>     2011-10-27 14:54:58.927692 [DEBUG] mod_dptools.c:816
>>>>     sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192> SET [open]=[true]
>>>>     EXECUTE sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192>
>>>>     hash(insert/172.31.1.192-spymap/1030/147c8578-500d-4d91-bad5-9391c4400934)
>>>>     EXECUTE sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192>
>>>>     hash(insert/172.31.1.192-last_dial/1030/9051357952)
>>>>     EXECUTE sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192>
>>>>     hash(insert/172.31.1.192-last_dial/global/147c8578-500d-4d91-bad5-9391c4400934)
>>>>     EXECUTE sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192>
>>>>     bridge(sofia/gateway/innovaphone/051357952)
>>>>     2011-10-27 14:54:58.931685 [NOTICE] switch_channel.c:669 New
>>>>     Channel sofia/external/051357952
>>>>     [c4a81269-04e7-42db-aaf8-ecf528b74d68]
>>>>     2011-10-27 14:54:58.933717 [DEBUG] mod_sofia.c:3384
>>>>     (sofia/external/051357952) State Change CS_NEW -> CS_INIT
>>>>     2011-10-27 14:54:58.933717 [DEBUG] switch_core_session.c:1021
>>>>     Send signal sofia/external/051357952 [BREAK]
>>>>     2011-10-27 14:54:58.933717 [DEBUG]
>>>>     switch_core_state_machine.c:314 (sofia/external/051357952)
>>>>     Running State Change CS_INIT
>>>>     2011-10-27 14:54:58.933717 [DEBUG]
>>>>     switch_core_state_machine.c:338 (sofia/external/051357952)
>>>>     State INIT
>>>>     2011-10-27 14:54:58.933717 [DEBUG] mod_sofia.c:83
>>>>     sofia/external/051357952 SOFIA INIT
>>>>     2011-10-27 14:54:58.933717 [DEBUG] mod_sofia.c:117
>>>>     (sofia/external/051357952) State Change CS_INIT -> CS_ROUTING
>>>>     2011-10-27 14:54:58.933717 [DEBUG] switch_core_session.c:1021
>>>>     Send signal sofia/external/051357952 [BREAK]
>>>>     2011-10-27 14:54:58.933717 [DEBUG] sofia.c:4153 Channel
>>>>     sofia/external/051357952 entering state [calling][0]
>>>>     2011-10-27 14:54:58.933717 [DEBUG]
>>>>     switch_core_state_machine.c:338 (sofia/external/051357952)
>>>>     State INIT going to sleep
>>>>     2011-10-27 14:54:58.933717 [DEBUG]
>>>>     switch_core_state_machine.c:314 (sofia/external/051357952)
>>>>     Running State Change CS_ROUTING
>>>>     2011-10-27 14:54:58.933717 [DEBUG]
>>>>     switch_core_state_machine.c:341 (sofia/external/051357952)
>>>>     State ROUTING
>>>>     2011-10-27 14:54:58.933717 [DEBUG] mod_sofia.c:140
>>>>     sofia/external/051357952 SOFIA ROUTING
>>>>     2011-10-27 14:54:58.933717 [DEBUG] switch_ivr_originate.c:66
>>>>     (sofia/external/051357952) State Change CS_ROUTING ->
>>>>     CS_CONSUME_MEDIA
>>>>     2011-10-27 14:54:58.933717 [DEBUG] switch_core_session.c:1021
>>>>     Send signal sofia/external/051357952 [BREAK]
>>>>     2011-10-27 14:54:58.933717 [DEBUG]
>>>>     switch_core_state_machine.c:341 (sofia/external/051357952)
>>>>     State ROUTING going to sleep
>>>>     2011-10-27 14:54:58.933717 [DEBUG]
>>>>     switch_core_state_machine.c:314 (sofia/external/051357952)
>>>>     Running State Change CS_CONSUME_MEDIA
>>>>     2011-10-27 14:54:58.933717 [DEBUG]
>>>>     switch_core_state_machine.c:360 (sofia/external/051357952)
>>>>     State CONSUME_MEDIA
>>>>     2011-10-27 14:54:58.933717 [DEBUG]
>>>>     switch_core_state_machine.c:360 (sofia/external/051357952)
>>>>     State CONSUME_MEDIA going to sleep
>>>>     2011-10-27 14:54:58.937691 [DEBUG] sofia.c:4153 Channel
>>>>     sofia/external/051357952 entering state [calling][0]
>>>>     2011-10-27 14:54:59.062721 [DEBUG] sofia.c:4153 Channel
>>>>     sofia/external/051357952 entering state [terminated][404]
>>>>     2011-10-27 14:54:59.062721 [NOTICE] sofia.c:4789 Hangup
>>>>     sofia/external/051357952 [CS_CONSUME_MEDIA] [NO_ROUTE_DESTINATION]
>>>>     2011-10-27 14:54:59.062721 [DEBUG] switch_channel.c:2102 Send
>>>>     signal sofia/external/051357952 [KILL]
>>>>     2011-10-27 14:54:59.062721 [DEBUG] switch_core_session.c:1021
>>>>     Send signal sofia/external/051357952 [BREAK]
>>>>     2011-10-27 14:54:59.062721 [DEBUG]
>>>>     switch_core_state_machine.c:314 (sofia/external/051357952)
>>>>     Running State Change CS_HANGUP
>>>>     2011-10-27 14:54:59.064679 [DEBUG] switch_ivr_originate.c:3228
>>>>     Originate Resulted in Error Cause: 3 [NO_ROUTE_DESTINATION]
>>>>     2011-10-27 14:54:59.064679 [INFO] mod_dptools.c:2355 Originate
>>>>     Failed.  Cause: NO_ROUTE_DESTINATION
>>>>     2011-10-27 14:54:59.064679 [NOTICE] mod_dptools.c:2418 Hangup
>>>>     sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192> [CS_EXECUTE]
>>>>     [NO_ROUTE_DESTINATION]
>>>>     2011-10-27 14:54:59.064679 [DEBUG] switch_channel.c:2102 Send
>>>>     signal sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192> [KILL]
>>>>     2011-10-27 14:54:59.064679 [DEBUG] switch_core_session.c:1021
>>>>     Send signal sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192> [BREAK]
>>>>     2011-10-27 14:54:59.064679 [DEBUG]
>>>>     switch_core_state_machine.c:348
>>>>     (sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192>) State EXECUTE going
>>>>     to sleep
>>>>     2011-10-27 14:54:59.064679 [DEBUG]
>>>>     switch_core_state_machine.c:314
>>>>     (sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192>) Running State Change
>>>>     CS_HANGUP
>>>>     2011-10-27 14:54:59.064679 [DEBUG]
>>>>     switch_core_state_machine.c:499
>>>>     (sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192>) State HANGUP
>>>>     2011-10-27 14:54:59.064679 [DEBUG] mod_sofia.c:408
>>>>     sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192> Overriding SIP cause
>>>>     404 with 404 from the other leg
>>>>     2011-10-27 14:54:59.064679 [DEBUG] mod_sofia.c:414 Channel
>>>>     sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192> hanging up, cause:
>>>>     NO_ROUTE_DESTINATION
>>>>     2011-10-27 14:54:59.064679 [DEBUG]
>>>>     switch_core_state_machine.c:499 (sofia/external/051357952)
>>>>     State HANGUP
>>>>     2011-10-27 14:54:59.064679 [DEBUG] mod_sofia.c:408
>>>>     sofia/external/051357952 Overriding SIP cause 404 with 404 from
>>>>     the other leg
>>>>     2011-10-27 14:54:59.064679 [DEBUG] mod_sofia.c:414 Channel
>>>>     sofia/external/051357952 hanging up, cause: NO_ROUTE_DESTINATION
>>>>     2011-10-27 14:54:59.064679 [DEBUG]
>>>>     switch_core_state_machine.c:46 sofia/external/051357952
>>>>     Standard HANGUP, cause: NO_ROUTE_DESTINATION
>>>>     2011-10-27 14:54:59.064679 [DEBUG]
>>>>     switch_core_state_machine.c:499 (sofia/external/051357952)
>>>>     State HANGUP going to sleep
>>>>     2011-10-27 14:54:59.064679 [DEBUG]
>>>>     switch_core_state_machine.c:333 (sofia/external/051357952)
>>>>     State Change CS_HANGUP -> CS_REPORTING
>>>>     2011-10-27 14:54:59.064679 [DEBUG] switch_core_session.c:1021
>>>>     Send signal sofia/external/051357952 [BREAK]
>>>>     2011-10-27 14:54:59.064679 [DEBUG]
>>>>     switch_core_state_machine.c:314 (sofia/external/051357952)
>>>>     Running State Change CS_REPORTING
>>>>     2011-10-27 14:54:59.064679 [DEBUG]
>>>>     switch_core_state_machine.c:590 (sofia/external/051357952)
>>>>     State REPORTING
>>>>     2011-10-27 14:54:59.064679 [DEBUG]
>>>>     switch_core_state_machine.c:53 sofia/external/051357952
>>>>     Standard REPORTING, cause: NO_ROUTE_DESTINATION
>>>>     2011-10-27 14:54:59.064679 [DEBUG]
>>>>     switch_core_state_machine.c:590 (sofia/external/051357952)
>>>>     State REPORTING going to sleep
>>>>     2011-10-27 14:54:59.064679 [DEBUG]
>>>>     switch_core_state_machine.c:327 (sofia/external/051357952)
>>>>     State Change CS_REPORTING -> CS_DESTROY
>>>>     2011-10-27 14:54:59.064679 [DEBUG] switch_core_session.c:1021
>>>>     Send signal sofia/external/051357952 [BREAK]
>>>>     2011-10-27 14:54:59.064679 [DEBUG] switch_core_session.c:1164
>>>>     Session 4 (sofia/external/051357952) Locked, Waiting on
>>>>     external entities
>>>>     2011-10-27 14:54:59.064679 [NOTICE] switch_core_session.c:1182
>>>>     Session 4 (sofia/external/051357952) Ended
>>>>     2011-10-27 14:54:59.064679 [NOTICE] switch_core_session.c:1184
>>>>     Close Channel sofia/external/051357952 [CS_DESTROY]
>>>>     2011-10-27 14:54:59.064679 [DEBUG]
>>>>     switch_core_state_machine.c:428 (sofia/external/051357952)
>>>>     Running State Change CS_DESTROY
>>>>     2011-10-27 14:54:59.064679 [DEBUG]
>>>>     switch_core_state_machine.c:439 (sofia/external/051357952)
>>>>     State DESTROY
>>>>     2011-10-27 14:54:59.064679 [DEBUG] mod_sofia.c:341
>>>>     sofia/external/051357952 SOFIA DESTROY
>>>>     2011-10-27 14:54:59.066681 [DEBUG]
>>>>     switch_core_state_machine.c:60 sofia/external/051357952
>>>>     Standard DESTROY
>>>>     2011-10-27 14:54:59.066681 [DEBUG]
>>>>     switch_core_state_machine.c:439 (sofia/external/051357952)
>>>>     State DESTROY going to sleep
>>>>     2011-10-27 14:54:59.108644 [DEBUG] mod_sofia.c:476 Responding
>>>>     to INVITE with: 404
>>>>     2011-10-27 14:54:59.108644 [DEBUG]
>>>>     switch_core_state_machine.c:46 sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192> Standard HANGUP,
>>>>     cause: NO_ROUTE_DESTINATION
>>>>     2011-10-27 14:54:59.108644 [DEBUG]
>>>>     switch_core_state_machine.c:499
>>>>     (sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192>) State HANGUP going
>>>>     to sleep
>>>>     2011-10-27 14:54:59.110650 [DEBUG]
>>>>     switch_core_state_machine.c:333
>>>>     (sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192>) State Change
>>>>     CS_HANGUP -> CS_REPORTING
>>>>     2011-10-27 14:54:59.110650 [DEBUG] switch_core_session.c:1021
>>>>     Send signal sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192> [BREAK]
>>>>     2011-10-27 14:54:59.110650 [DEBUG]
>>>>     switch_core_state_machine.c:314
>>>>     (sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192>) Running State Change
>>>>     CS_REPORTING
>>>>     2011-10-27 14:54:59.110650 [DEBUG]
>>>>     switch_core_state_machine.c:590
>>>>     (sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192>) State REPORTING
>>>>     2011-10-27 14:54:59.110650 [DEBUG]
>>>>     switch_core_state_machine.c:53 sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192> Standard REPORTING,
>>>>     cause: NO_ROUTE_DESTINATION
>>>>     2011-10-27 14:54:59.110650 [DEBUG]
>>>>     switch_core_state_machine.c:590
>>>>     (sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192>) State REPORTING
>>>>     going to sleep
>>>>     2011-10-27 14:54:59.110650 [DEBUG]
>>>>     switch_core_state_machine.c:327
>>>>     (sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192>) State Change
>>>>     CS_REPORTING -> CS_DESTROY
>>>>     2011-10-27 14:54:59.110650 [DEBUG] switch_core_session.c:1021
>>>>     Send signal sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192> [BREAK]
>>>>     2011-10-27 14:54:59.110650 [DEBUG] switch_core_session.c:1164
>>>>     Session 3 (sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192>) Locked, Waiting on
>>>>     external entities
>>>>     2011-10-27 14:54:59.110650 [NOTICE] switch_core_session.c:1182
>>>>     Session 3 (sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192>) Ended
>>>>     2011-10-27 14:54:59.110650 [NOTICE] switch_core_session.c:1184
>>>>     Close Channel sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192> [CS_DESTROY]
>>>>     2011-10-27 14:54:59.110650 [DEBUG]
>>>>     switch_core_state_machine.c:428
>>>>     (sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192>) Running State Change
>>>>     CS_DESTROY
>>>>     2011-10-27 14:54:59.110650 [DEBUG]
>>>>     switch_core_state_machine.c:439
>>>>     (sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192>) State DESTROY
>>>>     2011-10-27 14:54:59.110650 [DEBUG] mod_sofia.c:341
>>>>     sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192> SOFIA DESTROY
>>>>     2011-10-27 14:54:59.110650 [DEBUG]
>>>>     switch_core_state_machine.c:60 sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192> Standard DESTROY
>>>>     2011-10-27 14:54:59.110650 [DEBUG]
>>>>     switch_core_state_machine.c:439
>>>>     (sofia/internal/1030 at 172.31.1.192
>>>>     <mailto:sofia/internal/1030 at 172.31.1.192>) State DESTROY going
>>>>     to slee
>>>>
>>>>
>>>>     BR,
>>>>     Miha
>>>>
>>>>     On 10/27/2011 2:15 PM, Nandy Dagondon wrote:
>>>>>     what is the full path/filename of your dialplan?
>>>>>     your debug level is not detailed enough.  set the log level to 7.
>>>>>     $fs_cli -l 7
>>>>>
>>>>>
>>>>>     On Thu, Oct 27, 2011 at 6:07 PM, Miha Zoubek <miha at softnet.si
>>>>>     <mailto:miha at softnet.si>> wrote:
>>>>>
>>>>>         Hi,
>>>>>
>>>>>         I have dialed 9051357952 <tel:9051357952>. IP800 is our
>>>>>         GW. I created on it one SIP account and connect freeswitch
>>>>>         with it.
>>>>>
>>>>>         BR,
>>>>>         Miha
>>>>>
>>>>>
>>>>>         On 10/27/2011 11:19 AM, Nandy Dagondon wrote:
>>>>>>         hi,
>>>>>>
>>>>>>         what is IP800? is this a FXO gateway? or a SIP provider?
>>>>>>
>>>>>>         u hv to dial 9051357952 <tel:9051357952> to match the
>>>>>>         dialplan.
>>>>>>
>>>>>>         -nandy
>>>>>>
>>>>>>         On Wed, Oct 26, 2011 at 9:34 PM, Miha Zoubek
>>>>>>         <miha at softnet.si <mailto:miha at softnet.si>> wrote:
>>>>>>
>>>>>>             Hi,
>>>>>>
>>>>>>             I am new Freeswitch user. I have read freeswitch
>>>>>>             book. I registered first few phones and make few
>>>>>>             inbound calls.
>>>>>>             I am trying to get outgoing calls working but having
>>>>>>             no luck.
>>>>>>             I have configured my gw and set up calling plan. When
>>>>>>             I try to dial number 051357952 I get this:
>>>>>>
>>>>>>             reeswitch at localhost.localdomain> 2011-10-26
>>>>>>             <tel:2011-10-26> 15:27:25.919562 <tel:25.919562>
>>>>>>             [NOTICE] switch_channel.c:669 New Channel
>>>>>>             sofia/internal/1030 at 172.31.1.157
>>>>>>             <mailto:1030 at 172.31.1.157>
>>>>>>             [f2132149-dc40-4601-bd34-c22e5b06b696]
>>>>>>             2011-10-26 <tel:2011-10-26> 15:27:25.955550
>>>>>>             <tel:25.955550> [INFO] mod_dialplan_xml.c:418
>>>>>>             Processing 1030->9051357952 <tel:9051357952> in
>>>>>>             context default
>>>>>>             2011-10-26 <tel:2011-10-26> 15:27:25.960548
>>>>>>             <tel:25.960548> [NOTICE] switch_channel.c:669 New
>>>>>>             Channel sofia/external/051357952
>>>>>>             [5ccfd0ae-1bcc-4f19-9ca1-e19f8808e6a4]
>>>>>>             2011-10-26 <tel:2011-10-26> 15:27:26.095518
>>>>>>             <tel:26.095518> [NOTICE] sofia.c:4789 Hangup
>>>>>>             sofia/external/051357952 [CS_CONSUME_MEDIA]
>>>>>>             [NO_ROUTE_DESTINATION]
>>>>>>             2011-10-26 <tel:2011-10-26> 15:27:26.098534
>>>>>>             <tel:26.098534> [INFO] mod_dptools.c:2355 Originate
>>>>>>             Failed.  Cause: NO_ROUTE_DESTINATION
>>>>>>             2011-10-26 <tel:2011-10-26> 15:27:26.098534
>>>>>>             <tel:26.098534> [NOTICE] mod_dptools.c:2418 Hangup
>>>>>>             sofia/internal/1030 at 172.31.1.157
>>>>>>             <mailto:1030 at 172.31.1.157> [CS_EXECUTE]
>>>>>>             [NO_ROUTE_DESTINATION]
>>>>>>             2011-10-26 <tel:2011-10-26> 15:27:26.098534
>>>>>>             <tel:26.098534> [NOTICE] switch_core_session.c:1182
>>>>>>             Session 49 (sofia/external/051357952) Ended
>>>>>>             2011-10-26 <tel:2011-10-26> 15:27:26.098534
>>>>>>             <tel:26.098534> [NOTICE] switch_core_session.c:1184
>>>>>>             Close Channel sofia/external/051357952 [CS_DESTROY]
>>>>>>             2011-10-26 <tel:2011-10-26> 15:27:26.140506
>>>>>>             <tel:26.140506> [NOTICE] switch_core_session.c:1182
>>>>>>             Session 48 (sofia/internal/1030 at 172.31.1.157
>>>>>>             <mailto:1030 at 172.31.1.157>) Ended
>>>>>>             2011-10-26 <tel:2011-10-26> 15:27:26.140506
>>>>>>             <tel:26.140506> [NOTICE] switch_core_session.c:1184
>>>>>>             Close Channel sofia/internal/1030 at 172.31.1.157
>>>>>>             <mailto:1030 at 172.31.1.157> [CS_DESTROY]
>>>>>>
>>>>>>             GW:
>>>>>>
>>>>>>             <include>
>>>>>>             <gateway name="IP800">
>>>>>>             <!-- Your username, which is not your DID -->
>>>>>>             <param name="username" value="Demo2"/>
>>>>>>             <param name="password" value="1234"/>
>>>>>>             <param name="register" value="true"/>
>>>>>>             <param name="realm" value="172.31.1.200"/>
>>>>>>             </gateway>
>>>>>>             </include>
>>>>>>
>>>>>>             This is my dial plan:
>>>>>>
>>>>>>             <include>
>>>>>>             <extension name="Dial Out Custom Gateway">
>>>>>>             <condition field="destination_number"
>>>>>>             expression="^9(\d{9})$">
>>>>>>             <action application="bridge"
>>>>>>             data="sofia/gateway/IP800/$1"/>
>>>>>>             </condition>
>>>>>>             </extension>
>>>>>>             </include>
>>>>>>
>>>>>>
>>>>>>             sofia status
>>>>>>
>>>>>>                                  Name         
>>>>>>             Type                                       Data     
>>>>>>             State
>>>>>>             =================================================================================================
>>>>>>                              external       profile
>>>>>>             sip:mod_sofia at 172.31.1.157:5080      RUNNING (0)
>>>>>>                 external::example.com <http://example.com>      
>>>>>>             gateway sip:joeuser at example.com      NOREG
>>>>>>                       external::IP800       gateway
>>>>>>             sip:Demo2 at 172.31.1.200      REGED
>>>>>>                              internal       profile
>>>>>>             sip:mod_sofia at 172.31.1.157:5060      RUNNING (0)
>>>>>>                          172.31.1.157        
>>>>>>             alias                                   internal     
>>>>>>             ALIASED
>>>>>>             =================================================================================================
>>>>>>             2 profiles 1 alias
>>>>>>
>>>>>>
>>>>>>             Please help me why I am getting not route to destination.
>>>>>>
>>>>>>             Thank you very much for all your help!
>>>>>>
>>>>>>             BR,
>>>>>>             Miha
>>>>>>
>>>>>>
>>>>>>             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  <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
>>>>>         <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  <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  <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
>>>     <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
>
>
>
> 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/20111028/1dce9b92/attachment-0001.html 


Join us at ClueCon 2011 Aug 9-11, 2011
More information about the FreeSWITCH-users mailing list