Hi,
here are the results
send 352 bytes to udp/[81.84.244.106]:49152 at 16:02:39.659927:
------------------------------------------------------------------------
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 81.84.244.106:49152;branch=z9hG4bK-d8754z-
d0483d7f0e4f375c-1---d8754z-;rport=49152
From: "Luis"<
sip:10...@lazedo.sip.2600hz.com:5060>;tag=810be01c
To: <
sip:10...@lazedo.sip.2600hz.com:5060>
Call-ID: NTZiYzRkMTE3YTdiOGE2YzJkMjNiMjE2MDE0MDc1Y2Q.
CSeq: 2 INVITE
User-Agent: The 2600hz Project
Content-Length: 0
------------------------------------------------------------------------
2012-01-08 16:02:59.677337 [DEBUG] sofia.c:7452 1 acls to check for
proxy
2012-01-08 16:02:59.677337 [DEBUG] sofia.c:7457 checking 81.84.244.106
against acl authoritative
2012-01-08 16:02:59.677337 [DEBUG] sofia.c:7493 IP 81.84.244.106
Rejected by acl "authoritative". Falling back to Digest auth.
2012-01-08 16:02:59.677337 [DEBUG] mod_erlang_event.c:378 looking for
bindings
2012-01-08 16:02:59.677337 [DEBUG] mod_erlang_event.c:400 binding for
domain in section directory with key name and value lazedo.sip.
2600hz.com requested from node
ecal...@hz2600-06.90e9.com
2012-01-08 16:02:59.696903 [DEBUG] handle_msg.c:192 Got reply for
db33bc12-a28a-4851-a526-d493220463c5
2012-01-08 16:02:59.696903 [DEBUG] mod_erlang_event.c:473 got data
<document type="freeswitch/xml">
<section name="directory">
<domain name="
lazedo.sip.2600hz.com">
<user id="1003">
<params>
<param name="password" value="tty123"/>
</params>
<variables>
<variable name="ecallmgr_Username" value="1003" />
<variable name="ecallmgr_Realm" value="lazedo.sip.
2600hz.com" />
<variable name="ecallmgr_Account-ID"
value="b3abc655608bb6b1bab0a777e63424c1" />
<variable name="ecallmgr_Inception" value="on-net" />
<variable name="ecallmgr_Authorizing-ID"
value="6a8748295d940f0626319b9e480375f9" />
</variables>
</user>
</domain>
</section>
</document> after 19 milliseconds from
ecal...@hz2600-06.90e9.com for
db33bc12-a28a-4851-a526-d493220463c5!
2012-01-08 16:02:59.696903 [DEBUG] mod_erlang_event.c:480 XML parsed
OK!
2012-01-08 16:02:59.696903 [NOTICE] switch_channel.c:924 New Channel
sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060
[NTZiYzRkMTE3YTdiOGE2YzJkMjNiMjE2MDE0MDc1Y2Q.]
2012-01-08 16:02:59.696903 [DEBUG] sofia.c:5464 Channel sofia/
sipinterface_1/
10...@lazedo.sip.2600hz.com:5060 entering state
[received][100]
2012-01-08 16:02:59.696903 [DEBUG] sofia.c:5475 Remote SDP:
v=0
o=3cxVCE 174434850 223876575 IN IP4 81.84.244.106
s=3cxVCE Audio Call
c=IN IP4 81.84.244.106
t=0 0
m=audio 10116 RTP/AVP 0 8 3 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:3 GSM/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20
m=video 10036 RTP/AVP 34
c=IN IP4 81.84.244.106
a=rtpmap:34 H263/90000
a=fmtp:34 QCIF=1;CIF=1;SQCIF=1;CIF4=1;
2012-01-08 16:02:59.696903 [DEBUG] sofia.c:5667 (sofia/
sipinterface_1/
10...@lazedo.sip.2600hz.com:5060) State Change CS_NEW ->
CS_INIT
2012-01-08 16:02:59.696903 [DEBUG] switch_core_session.c:1180 Send
signal sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060 [BREAK]
2012-01-08 16:02:59.696903 [DEBUG] switch_core_state_machine.c:362
(sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060) Running State
Change CS_INIT
2012-01-08 16:02:59.696903 [DEBUG] switch_core_state_machine.c:401
(sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060) State INIT
2012-01-08 16:02:59.696903 [DEBUG] mod_sofia.c:85 sofia/
sipinterface_1/
10...@lazedo.sip.2600hz.com:5060 SOFIA INIT
2012-01-08 16:02:59.696903 [DEBUG] mod_sofia.c:125 (sofia/
sipinterface_1/
10...@lazedo.sip.2600hz.com:5060) State Change CS_INIT -
> CS_ROUTING
2012-01-08 16:02:59.696903 [DEBUG] switch_core_session.c:1180 Send
signal sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060 [BREAK]
2012-01-08 16:02:59.696903 [DEBUG] switch_core_state_machine.c:401
(sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060) State INIT
going to sleep
2012-01-08 16:02:59.696903 [DEBUG] switch_core_state_machine.c:362
(sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060) Running State
Change CS_ROUTING
2012-01-08 16:02:59.696903 [DEBUG] switch_channel.c:1884 (sofia/
sipinterface_1/
10...@lazedo.sip.2600hz.com:5060) Callstate Change DOWN -
> RINGING
2012-01-08 16:02:59.696903 [DEBUG] switch_core_state_machine.c:410
(sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060) State ROUTING
2012-01-08 16:02:59.696903 [DEBUG] mod_sofia.c:148 sofia/
sipinterface_1/
10...@lazedo.sip.2600hz.com:5060 SOFIA ROUTING
2012-01-08 16:02:59.696903 [DEBUG] switch_core_state_machine.c:104
sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060 Standard ROUTING
2012-01-08 16:02:59.696903 [INFO] mod_dialplan_xml.c:481 Processing
Luis <1003>->1002 in context context_2
2012-01-08 16:02:59.696903 [DEBUG] mod_erlang_event.c:378 looking for
bindings
2012-01-08 16:02:59.696903 [DEBUG] mod_erlang_event.c:400 binding for
(null) in section dialplan with key (null) and value (null) requested
from node
ecal...@hz2600-06.90e9.com
2012-01-08 16:03:04.541127 [WARNING] mod_erlang_event.c:446 Timed out
after 4844 milliseconds when waiting for XML fetch response for
2619fbac-e607-406b-9b2a-d1db09ffb315
2012-01-08 16:03:04.541127 [WARNING] mod_dialplan_xml.c:511 Context
context_2 not found
2012-01-08 16:03:04.541127 [INFO] switch_core_state_machine.c:177 No
Route, Aborting
2012-01-08 16:03:04.541127 [DEBUG] switch_channel.c:2846 (sofia/
sipinterface_1/
10...@lazedo.sip.2600hz.com:5060) Callstate Change
RINGING -> HANGUP
2012-01-08 16:03:04.541127 [NOTICE] switch_core_state_machine.c:178
Hangup sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060
[CS_ROUTING] [NO_ROUTE_DESTINATION]
2012-01-08 16:03:04.541127 [DEBUG] switch_channel.c:2869 Send signal
sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060 [KILL]
2012-01-08 16:03:04.541127 [DEBUG] switch_core_session.c:1180 Send
signal sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060 [BREAK]
2012-01-08 16:03:04.541127 [DEBUG] switch_core_state_machine.c:410
(sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060) State ROUTING
going to sleep
2012-01-08 16:03:04.541127 [DEBUG] switch_core_state_machine.c:362
(sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060) Running State
Change CS_HANGUP
2012-01-08 16:03:04.541127 [DEBUG] switch_core_state_machine.c:602
(sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060) State HANGUP
2012-01-08 16:03:04.541127 [DEBUG] mod_sofia.c:469 Channel sofia/
sipinterface_1/
10...@lazedo.sip.2600hz.com:5060 hanging up, cause:
NO_ROUTE_DESTINATION
2012-01-08 16:03:04.541127 [DEBUG] mod_sofia.c:534 Responding to
INVITE with: 404
2012-01-08 16:03:04.541127 [DEBUG] switch_core_state_machine.c:47
sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060 Standard HANGUP,
cause: NO_ROUTE_DESTINATION
2012-01-08 16:03:04.541127 [DEBUG] switch_core_state_machine.c:602
(sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060) State HANGUP
going to sleep
2012-01-08 16:03:04.541127 [DEBUG] switch_core_state_machine.c:393
(sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060) State Change
CS_HANGUP -> CS_REPORTING
2012-01-08 16:03:04.541127 [DEBUG] switch_core_session.c:1180 Send
signal sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060 [BREAK]
2012-01-08 16:03:04.541127 [DEBUG] switch_core_state_machine.c:362
(sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060) Running State
Change CS_REPORTING
2012-01-08 16:03:04.541127 [DEBUG] switch_core_state_machine.c:662
(sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060) State REPORTING
2012-01-08 16:03:04.541127 [DEBUG] switch_core_state_machine.c:79
sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060 Standard
REPORTING, cause: NO_ROUTE_DESTINATION
2012-01-08 16:03:04.541127 [DEBUG] switch_core_state_machine.c:662
(sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060) State REPORTING
going to sleep
2012-01-08 16:03:04.541127 [DEBUG] switch_core_state_machine.c:387
(sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060) State Change
CS_REPORTING -> CS_DESTROY
2012-01-08 16:03:04.541127 [DEBUG] switch_core_session.c:1180 Send
signal sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060 [BREAK]
2012-01-08 16:03:04.541127 [DEBUG] switch_core_session.c:1380 Session
17 (sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060) Locked,
Waiting on external entities
2012-01-08 16:03:04.541127 [NOTICE] switch_core_session.c:1398 Session
17 (sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060) Ended
2012-01-08 16:03:04.541127 [NOTICE] switch_core_session.c:1400 Close
Channel sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060
[CS_DESTROY]
2012-01-08 16:03:04.541127 [DEBUG] switch_core_state_machine.c:491
(sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060) Callstate
Change HANGUP -> DOWN
2012-01-08 16:03:04.541127 [DEBUG] switch_core_state_machine.c:494
(sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060) Running State
Change CS_DESTROY
2012-01-08 16:03:04.541127 [DEBUG] switch_core_state_machine.c:504
(sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060) State DESTROY
2012-01-08 16:03:04.541127 [DEBUG] mod_sofia.c:374 sofia/
sipinterface_1/
10...@lazedo.sip.2600hz.com:5060 SOFIA DESTROY
2012-01-08 16:03:04.541127 [DEBUG] switch_core_state_machine.c:86
sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060 Standard DESTROY
2012-01-08 16:03:04.541127 [DEBUG] switch_core_state_machine.c:504
(sofia/sipinterface_1/
10...@lazedo.sip.2600hz.com:5060) State DESTROY
going to sleep
send 784 bytes to udp/[81.84.244.106]:49152 at 16:02:44.515903:
------------------------------------------------------------------------
SIP/2.0 404 Not Found
Via: SIP/2.0/UDP 81.84.244.106:49152;branch=z9hG4bK-d8754z-
d0483d7f0e4f375c-1---d8754z-;rport=49152
From: "Luis"<
sip:10...@lazedo.sip.2600hz.com:5060>;tag=810be01c
To: <
sip:10...@lazedo.sip.2600hz.com:5060>;tag=8Byv4FNaQ7jgK
Call-ID: NTZiYzRkMTE3YTdiOGE2YzJkMjNiMjE2MDE0MDc1Y2Q.
CSeq: 2 INVITE
User-Agent: The 2600hz Project
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO,
REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: precondition, path, replaces
Allow-Events: talk, hold, presence, dialog, line-seize, call-info,
sla, include-session-description, presence.winfo, message-summary,
refer
Content-Length: 0
Remote-Party-ID: "1002" <sip:10...@lazedo.sip.
2600hz.com>;party=calling;privacy=off;screen=no
------------------------------------------------------------------------
recv 376 bytes from udp/[81.84.244.106]:49152 at 16:02:44.527142:
------------------------------------------------------------------------
ACK
sip:10...@lazedo.sip.2600hz.com:5060 SIP/2.0
Via: SIP/2.0/UDP 81.84.244.106:49152;branch=z9hG4bK-d8754z-
d0483d7f0e4f375c-1---d8754z-;rport
Max-Forwards: 70
To: <
sip:10...@lazedo.sip.2600hz.com:5060>;tag=8Byv4FNaQ7jgK
From: "Luis"<
sip:10...@lazedo.sip.2600hz.com:5060>;tag=810be01c
Call-ID: NTZiYzRkMTE3YTdiOGE2YzJkMjNiMjE2MDE0MDc1Y2Q.
CSeq: 2 ACK
Content-Length: 0
------------------------------------------------------------------------
On Jan 8, 3:11 pm, Darren Schreiber <
dar...@2600hz.com> wrote:
> Please paste the results when you do this from the FreeSWITCH CLI
>
> Go into a FreeSWITCH box, type "cli". Then make the calls and paste the
> results
>
> --
> Darren Schreiber
> CEO / Co-Founder
>
> >> > > > > > > >> To be clear on what this is all about©