<html>
<head>
<meta http-equiv="content-type" content="text/html; charset=ISO-8859-1">
</head>
<body bgcolor="#FFFFFF" text="#000000">
hi,<br>
I have successfully installed freeswitch and it is working fine
while calling from one sip device to other.<br>
but I face problem when I make a outbound call using gateway.<br>
<br>
According to freeswitch log I can see that freeswitch is getting
gateway configuration and it is suppose to send INVITE to the
gateway,but the problem is that freeswitch is not sending any INVITE
to the gateway.<br>
<br>
these are the fs_cli logs<br>
<br>
INVITE <a href="mailto:sip%3A%2B918146234576@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:sip%3A%2B918146234576@sip.test.com';return
true;"
onclick="this.href='mailto:sip%3A%2B918146234576@sip.test.com';return
true;">sip:+918146234576@sip.test.com</a> SIP/2.0<br>
Record-Route: <sip:88.80.160.31;lr=on;ftag=
<div dir="ltr"><wbr>aW0i4G-.<wbr>8DI9G4pbsNbl8EWP1fY76mxz><br>
Via: SIP/2.0/UDP 88.80.160.31;branch=<wbr>z9hG4bKd602.9af44717.0<br>
Via: SIP/2.0/UDP 112.196.33.74:11220;rport=<wbr>62926;branch=z9hG4bKPj.<wbr>w0giarvUkQ67HPw3uK5Z6NsdtAUWvE<wbr>V<br>
From: <<a href="mailto:sip%3Auser1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:sip%3Auser1@sip.test.com';return
true;"
onclick="this.href='mailto:sip%3Auser1@sip.test.com';return
true;">sip:user1@sip.test.com</a>>;tag=<wbr>aW0i4G-.<wbr>8DI9G4pbsNbl8EWP1fY76mxz<br>
To: <<a href="mailto:sip%3A%2B918146234576@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:sip%3A%2B918146234576@sip.test.com';return
true;"
onclick="this.href='mailto:sip%3A%2B918146234576@sip.test.com';return
true;">sip:+918146234576@sip.test.<wbr>com</a>><br>
Contact: <<a class="moz-txt-link-abbreviated" href="mailto:sip:user1@112.196.33.74:62926">sip:user1@112.196.33.74:62926</a><wbr>;ob><br>
Call-ID: 0v4twiSX8ZbXhaUtGh2KBbEpHgQyJm<wbr>qO<br>
CSeq: 26826 INVITE<br>
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO,
SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS<br>
Supported: replaces, 100rel, timer, norefersub<br>
Session-Expires: 1800<br>
Min-SE: 90<br>
User-Agent: CSipSimple_A89-15/r2330<br>
Proxy-Authorization: Digest username="user1", realm="<a
href="http://sip.test.com" target="_blank"
onmousedown="this.href='http://www.google.com/url?q\75http%3A%2F%2Fsip.test.com\46sa\75D\46sntz\0751\46usg\75AFQjCNEwb3yaHhEOFiwV3G4j19E5WOSHOA';return
true;"
onclick="this.href='http://www.google.com/url?q\75http%3A%2F%2Fsip.test.com\46sa\75D\46sntz\0751\46usg\75AFQjCNEwb3yaHhEOFiwV3G4j19E5WOSHOA';return
true;">sip.test.com</a>", nonce="2da67792-9ddb-11e3-<wbr>ae8b-69d00812b6c2",
uri="<a href="mailto:sip%3A%2B918146234576@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:sip%3A%2B918146234576@sip.test.com';return
true;"
onclick="this.href='mailto:sip%3A%2B918146234576@sip.test.com';return
true;">sip:+918146234576@sip.<wbr>test.com</a>", response="<wbr>894cfec80fc7a1c04b2ad7b46eb1c4<wbr>c5",
algorithm=MD5, cnonce="<wbr>y6HH8DROqT9Ue8iZVcHNFRyB.<wbr>LGnEDII",
qop=auth, nc=00000001<br>
Content-Type: application/sdp<br>
Content-Length: 344<br>
X-AUTH-IP: 112.196.33.74<br>
<br>
v=0<br>
o=- 3602293864 3602293864 IN IP4 112.196.33.74<br>
s=pjmedia<br>
c=IN IP4 112.196.33.74<br>
t=0 0<br>
m=audio 4226 RTP/AVP 99 0 8 101<br>
c=IN IP4 112.196.33.74<br>
a=rtcp:9246 IN IP4 112.196.33.74<br>
a=sendrecv<br>
a=rtpmap:99 SILK/24000<br>
a=fmtp:99 useinbandfec=0<br>
a=rtpmap:0 PCMU/8000<br>
a=rtpmap:8 PCMA/8000<br>
a=rtpmap:101 telephone-event/8000<br>
a=fmtp:101 0-15<br>
------------------------------<wbr>------------------------------<wbr>------------<br>
send 469 bytes to udp/[88.80.160.31]:5060 at 05:10:44.257584:<br>
------------------------------<wbr>------------------------------<wbr>------------<br>
SIP/2.0 100 Trying<br>
Via: SIP/2.0/UDP 88.80.160.31;branch=<wbr>z9hG4bKd602.9af44717.0<br>
Via: SIP/2.0/UDP 112.196.33.74:11220;rport=<wbr>62926;branch=z9hG4bKPj.<wbr>w0giarvUkQ67HPw3uK5Z6NsdtAUWvE<wbr>V<br>
Record-Route: <sip:88.80.160.31;lr=on;ftag=<wbr>aW0i4G-.<wbr>8DI9G4pbsNbl8EWP1fY76mxz><br>
From: <<a href="mailto:sip%3Auser1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:sip%3Auser1@sip.test.com';return
true;"
onclick="this.href='mailto:sip%3Auser1@sip.test.com';return
true;">sip:user1@sip.test.com</a>>;tag=<wbr>aW0i4G-.<wbr>8DI9G4pbsNbl8EWP1fY76mxz<br>
To: <<a href="mailto:sip%3A%2B918146234576@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:sip%3A%2B918146234576@sip.test.com';return
true;"
onclick="this.href='mailto:sip%3A%2B918146234576@sip.test.com';return
true;">sip:+918146234576@sip.test.<wbr>com</a>><br>
Call-ID: 0v4twiSX8ZbXhaUtGh2KBbEpHgQyJm<wbr>qO<br>
CSeq: 26826 INVITE<br>
User-Agent: 2600hz<br>
Content-Length: 0<br>
<br>
------------------------------<wbr>------------------------------<wbr>------------<br>
2014-02-25 00:10:44.243689 [DEBUG] sofia.c:1937 Re-attaching
to session 0v4twiSX8ZbXhaUtGh2KBbEpHgQyJm<wbr>qO<br>
2014-02-25 00:10:44.243689 [DEBUG] switch_core_session.c:1048
Send signal sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
[BREAK]<br>
2014-02-25 00:10:44.243689 [DEBUG] switch_core_session.c:1048
Send signal sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
[BREAK]<br>
2014-02-25 00:10:44.263688 [DEBUG] sofia.c:8156 1 acls to
check for proxy<br>
2014-02-25 00:10:44.263688 [DEBUG] sofia.c:8161 checking
88.80.160.31 against acl authoritative<br>
2014-02-25 00:10:44.263688 [INFO] sofia.c:8163 88.80.160.31 is
a proxy according to the authoritative acl<br>
2014-02-25 00:10:44.263688 [DEBUG] sofia.c:8173 network ip is
a proxy<br>
2014-02-25 00:10:44.263688 [DEBUG] sofia.c:8177 found auth ip
[X-AUTH-IP] header of [112.196.33.74]<br>
2014-02-25 00:10:44.263688 [DEBUG] sofia.c:8201 IP
88.80.160.31 Rejected by acl "trusted". Falling back to Digest
auth.<br>
2014-02-25 00:10:44.263688 [DEBUG] kazoo_fetch_agent.c:216
Sending directory XML request (2dc8752c-9ddb-11e3-ae8c-<wbr>69d00812b6c2)
to <a href="mailto:ecallmgr@kaz2.test.nl" target="_blank"
onmousedown="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;" onclick="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;">ecallmgr@kaz2.test.nl</a> <2.1184.0><br>
2014-02-25 00:10:44.263688 [DEBUG] kazoo_node.c:1091 Sent
erlang message to <a href="mailto:ecallmgr@kaz2.test.nl"
target="_blank"
onmousedown="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;" onclick="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;">ecallmgr@kaz2.test.nl</a> <2.1184.0><br>
2014-02-25 00:10:44.383689 [DEBUG] kazoo_fetch_agent.c:277
Received directory XML (2dc8752c-9ddb-11e3-ae8c-<wbr>69d00812b6c2)
after 120ms: <document type="freeswitch/xml"><section
name="directory"><domain name="<a href="http://sip.test.com"
target="_blank"
onmousedown="this.href='http://www.google.com/url?q\75http%3A%2F%2Fsip.test.com\46sa\75D\46sntz\0751\46usg\75AFQjCNEwb3yaHhEOFiwV3G4j19E5WOSHOA';return
true;"
onclick="this.href='http://www.google.com/url?q\75http%3A%2F%2Fsip.test.com\46sa\75D\46sntz\0751\46usg\75AFQjCNEwb3yaHhEOFiwV3G4j19E5WOSHOA';return
true;">sip.test.com</a>"><user
id="user1"><variables><<wbr>variable
name="ecallmgr_Inception" value="on-net"/><variable
name="ecallmgr_Authorizing-<wbr>Type"
value="device"/><variable name="ecallmgr_Authorizing-ID"
value="<wbr>3b46b4ceec6bb18dd8985792d7b569<wbr>3e"/><variable
name="ecallmgr_Account-ID" value="<wbr>502cc62fa8097dd6d753fea7c7ef91<wbr>a1"/><variable
name="ecallmgr_Realm" value="<a href="http://sip.test.com"
target="_blank"
onmousedown="this.href='http://www.google.com/url?q\75http%3A%2F%2Fsip.test.com\46sa\75D\46sntz\0751\46usg\75AFQjCNEwb3yaHhEOFiwV3G4j19E5WOSHOA';return
true;"
onclick="this.href='http://www.google.com/url?q\75http%3A%2F%2Fsip.test.com\46sa\75D\46sntz\0751\46usg\75AFQjCNEwb3yaHhEOFiwV3G4j19E5WOSHOA';return
true;">sip.test.com</a>"/><<wbr>variable
name="ecallmgr_Username" value="user1"/></variables><<wbr>params><param
name="password" value="user1"/></params></<wbr>user></domain></section></<wbr>document><br>
2014-02-25 00:10:44.383689 [DEBUG] sofia.c:5889 Channel
sofia/sipinterface_1/<a href="mailto:user1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
entering state [received][100]<br>
2014-02-25 00:10:44.383689 [DEBUG] sofia.c:5899 Remote SDP:<br>
v=0<br>
o=- 3602293864 3602293864 IN IP4 112.196.33.74<br>
s=pjmedia<br>
c=IN IP4 112.196.33.74<br>
t=0 0<br>
m=audio 4226 RTP/AVP 99 0 8 101<br>
c=IN IP4 112.196.33.74<br>
a=rtpmap:99 SILK/24000<br>
a=fmtp:99 useinbandfec=0<br>
a=rtpmap:0 PCMU/8000<br>
a=rtpmap:8 PCMA/8000<br>
a=rtpmap:101 telephone-event/8000<br>
a=fmtp:101 0-15<br>
a=rtcp:9246 IN IP4 112.196.33.74<br>
<br>
2014-02-25 00:10:44.383689 [DEBUG] sofia.c:6144
(sofia/sipinterface_1/<a href="mailto:user1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>)
State Change CS_NEW -> CS_INIT<br>
2014-02-25 00:10:44.383689 [DEBUG] switch_core_session.c:1383
Send signal sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
[BREAK]<br>
2014-02-25 00:10:44.383689 [DEBUG]
switch_core_state_machine.c:<wbr>467 (sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>)
Running State Change CS_INIT<br>
2014-02-25 00:10:44.383689 [DEBUG]
switch_core_state_machine.c:<wbr>507 (sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>)
State INIT<br>
2014-02-25 00:10:44.383689 [DEBUG] mod_sofia.c:87
sofia/sipinterface_1/<a href="mailto:user1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
SOFIA INIT<br>
2014-02-25 00:10:44.383689 [DEBUG]
switch_core_state_machine.c:40 sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
Standard INIT<br>
2014-02-25 00:10:44.383689 [DEBUG]
switch_core_state_machine.c:48 (sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>)
State Change CS_INIT -> CS_ROUTING<br>
2014-02-25 00:10:44.383689 [DEBUG] switch_core_session.c:1383
Send signal sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
[BREAK]<br>
2014-02-25 00:10:44.383689 [DEBUG]
switch_core_state_machine.c:<wbr>507 (sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>)
State INIT going to sleep<br>
2014-02-25 00:10:44.383689 [DEBUG]
switch_core_state_machine.c:<wbr>467 (sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>)
Running State Change CS_ROUTING<br>
2014-02-25 00:10:44.383689 [DEBUG] switch_channel.c:2179
(sofia/sipinterface_1/<a href="mailto:user1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>)
Callstate Change DOWN -> RINGING<br>
2014-02-25 00:10:44.383689 [DEBUG]
switch_core_state_machine.c:<wbr>523 (sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>)
State ROUTING<br>
2014-02-25 00:10:44.383689 [DEBUG] mod_sofia.c:123
sofia/sipinterface_1/<a href="mailto:user1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
SOFIA ROUTING<br>
2014-02-25 00:10:44.383689 [DEBUG]
switch_core_state_machine.c:<wbr>164 sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
Standard ROUTING<br>
2014-02-25 00:10:44.383689 [INFO] mod_dialplan_xml.c:558
Processing user1 <user1>->+918146234576 in context
context_2<br>
2014-02-25 00:10:44.383689 [DEBUG] kazoo_fetch_agent.c:216
Sending dialplan XML request (2ddb9918-9ddb-11e3-ae8e-<wbr>69d00812b6c2)
to <a href="mailto:ecallmgr@kaz2.test.nl" target="_blank"
onmousedown="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;" onclick="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;">ecallmgr@kaz2.test.nl</a> <2.1185.0><br>
2014-02-25 00:10:44.403683 [DEBUG] kazoo_node.c:1091 Sent
erlang message to <a href="mailto:ecallmgr@kaz2.test.nl"
target="_blank"
onmousedown="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;" onclick="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;">ecallmgr@kaz2.test.nl</a> <2.1185.0><br>
2014-02-25 00:10:44.543689 [DEBUG] kazoo_fetch_agent.c:277
Received dialplan XML (2ddb9918-9ddb-11e3-ae8e-<wbr>69d00812b6c2)
after 160ms: <document type="freeswitch/xml"><section
name="dialplan" description="Route Park Response"><context
name="context_2"><extension
name="park"><condition><action application="log"
data="NOTICE log|${uuid}|<a href="mailto:ecallmgr@kaz2.test.nl"
target="_blank"
onmousedown="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;" onclick="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;">ecallmgr@kaz2.<wbr>test.nl</a> won call
control"/><action application="export"
data="ecallmgr_Ecallmgr-Node=<a
href="mailto:ecallmgr@kaz2.test.nl" target="_blank"
onmousedown="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;" onclick="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;">e<wbr>callmgr@kaz2.test.nl</a>"/><<wbr>condition
field="variable_ecallmgr_<wbr>Bridge-ID"
expression="^$"><action application="export"
data="ecallmgr_Bridge-ID=${<wbr>UUID}"/></condition><action
application="set" data="ringback=%(2000,4000,<wbr>440,480)"/><action
application="set" data="transfer_ringback=%(<wbr>2000,4000,440,480)"/><action
application="park"/></<wbr>condition></extension></<wbr>context></section></document><br>
Dialplan: sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
parsing [context_2->park] continue=false<br>
|--- Dialplan: Processing recursive conditions level:1
[park_recur_1] require-nested=TRUE<br>
|--- Dialplan: sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
Regex (PASS) [park_recur_1] variable_ecallmgr_Bridge-ID() =~ /^$/
break=on-false<br>
|--- Dialplan: sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
Action export(ecallmgr_Bridge-ID=${<wbr>UUID})<br>
Dialplan: sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
Absolute Condition [park]<br>
Dialplan: sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
Action log(NOTICE log|${uuid}|<a
href="mailto:ecallmgr@kaz2.test.nl" target="_blank"
onmousedown="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;" onclick="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;">ecallmgr@kaz2.<wbr>test.nl</a> won call control)<br>
Dialplan: sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
Action export(ecallmgr_Ecallmgr-Node=<a
href="mailto:ecallmgr@kaz2.test.nl" target="_blank"
onmousedown="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;" onclick="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;"><wbr>ecallmgr@kaz2.test.nl</a>)<br>
Dialplan: sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
Action set(ringback=%(2000,4000,440,<wbr>480))<br>
Dialplan: sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
Action set(transfer_ringback=%(2000,<wbr>4000,440,480))<br>
Dialplan: sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
Action park()<br>
2014-02-25 00:10:44.543689 [DEBUG]
switch_core_state_machine.c:<wbr>214 (sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>)
State Change CS_ROUTING -> CS_EXECUTE<br>
2014-02-25 00:10:44.543689 [DEBUG] switch_core_session.c:1383
Send signal sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
[BREAK]<br>
2014-02-25 00:10:44.543689 [DEBUG]
switch_core_state_machine.c:<wbr>523 (sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>)
State ROUTING going to sleep<br>
2014-02-25 00:10:44.543689 [DEBUG]
switch_core_state_machine.c:<wbr>467 (sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>)
Running State Change CS_EXECUTE<br>
2014-02-25 00:10:44.543689 [DEBUG]
switch_core_state_machine.c:<wbr>530 (sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>)
State EXECUTE<br>
2014-02-25 00:10:44.543689 [DEBUG] mod_sofia.c:178
sofia/sipinterface_1/<a href="mailto:user1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
SOFIA EXECUTE<br>
2014-02-25 00:10:44.543689 [DEBUG]
switch_core_state_machine.c:<wbr>256 sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
Standard EXECUTE<br>
EXECUTE sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
export(ecallmgr_Bridge-ID=<wbr>0v4twiSX8ZbXhaUtGh2KBbEpHgQyJm<wbr>qO)<br>
2014-02-25 00:10:44.543689 [DEBUG] switch_channel.c:1247
EXPORT (export_vars) [ecallmgr_Bridge-ID]=[<wbr>0v4twiSX8ZbXhaUtGh2KBbEpHgQyJm<wbr>qO]<br>
EXECUTE sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
log(NOTICE log|<wbr>0v4twiSX8ZbXhaUtGh2KBbEpHgQyJm<wbr>qO|<a
href="mailto:ecallmgr@kaz2.test.nl" target="_blank"
onmousedown="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;" onclick="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;">ecallmgr@kaz2.test.nl</a> won call control)<br>
2014-02-25 00:10:44.543689 [NOTICE] mod_dptools.c:1634 log|<wbr>0v4twiSX8ZbXhaUtGh2KBbEpHgQyJm<wbr>qO|<a
href="mailto:ecallmgr@kaz2.test.nl" target="_blank"
onmousedown="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;" onclick="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;">ecallmgr@kaz2.test.nl</a> won call control<br>
EXECUTE sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
export(ecallmgr_Ecallmgr-Node=<a
href="mailto:ecallmgr@kaz2.test.nl" target="_blank"
onmousedown="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;" onclick="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;"><wbr>ecallmgr@kaz2.test.nl</a>)<br>
2014-02-25 00:10:44.543689 [DEBUG] switch_channel.c:1247
EXPORT (export_vars) [ecallmgr_Ecallmgr-Node]=[<a
href="mailto:ecallmgr@kaz2.test.nl" target="_blank"
onmousedown="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;" onclick="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;">ecal<wbr>lmgr@kaz2.test.nl</a>]<br>
EXECUTE sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
set(ringback=%(2000,4000,440,<wbr>480))<br>
2014-02-25 00:10:44.543689 [DEBUG] mod_dptools.c:1402
sofia/sipinterface_1/<a href="mailto:user1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
SET [ringback]=[%(2000,4000,440,<wbr>480)]<br>
EXECUTE sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
set(transfer_ringback=%(2000,<wbr>4000,440,480))<br>
2014-02-25 00:10:44.543689 [DEBUG] mod_dptools.c:1402
sofia/sipinterface_1/<a href="mailto:user1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
SET [transfer_ringback]=[%(2000,<wbr>4000,440,480)]<br>
EXECUTE sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
park()<br>
2014-02-25 00:10:44.543689 [DEBUG] kazoo_node.c:1091 Sent
erlang message to <a href="mailto:ecallmgr@kaz2.test.nl"
target="_blank"
onmousedown="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;" onclick="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;">ecallmgr@kaz2.test.nl</a> <2.11883.4><br>
2014-02-25 00:10:44.563813 [INFO] kazoo_node.c:627 exec:
uuid_setvar_multi(<wbr>0v4twiSX8ZbXhaUtGh2KBbEpHgQyJm<wbr>qO
ecallmgr_Channel-Authorized=<wbr>true;ecallmgr_Account-ID=<wbr>502cc62fa8097dd6d753fea7c7ef91<wbr>a1)<br>
2014-02-25 00:10:44.563813 [DEBUG] kazoo_node.c:1091 Sent
erlang message to <a href="mailto:ecallmgr@kaz2.test.nl"
target="_blank"
onmousedown="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;" onclick="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;">ecallmgr@kaz2.test.nl</a> <2.11883.4><br>
2014-02-25 00:10:44.723684 [INFO] kazoo_node.c:627 exec:
uuid_setvar_multi(<wbr>0v4twiSX8ZbXhaUtGh2KBbEpHgQyJm<wbr>qO
effective_caller_id_name=<wbr>Martin;effective_caller_id_<wbr>number=+xxxxxxxxxxx;ecallmgr_<wbr>Channel-Authorized=true;<wbr>ecallmgr_Username=user1;<wbr>ecallmgr_Realm=<a
href="http://sip.test.com" target="_blank"
onmousedown="this.href='http://www.google.com/url?q\75http%3A%2F%2Fsip.test.com\46sa\75D\46sntz\0751\46usg\75AFQjCNEwb3yaHhEOFiwV3G4j19E5WOSHOA';return
true;"
onclick="this.href='http://www.google.com/url?q\75http%3A%2F%2Fsip.test.com\46sa\75D\46sntz\0751\46usg\75AFQjCNEwb3yaHhEOFiwV3G4j19E5WOSHOA';return
true;">sip.test.com</a>;<wbr>ecallmgr_Account-ID=<wbr>502cc62fa8097dd6d753fea7c7ef91<wbr>a1;ecallmgr_Authorizing-ID=<wbr>3b46b4ceec6bb18dd8985792d7b569<wbr>3e;ecallmgr_Authorizing-Type=<wbr>device;ecallmgr_Inception=on-<wbr>net;ecallmgr_Fetch-ID=<wbr>2ddb9918-9ddb-11e3-ae8e-<wbr>69d00812b6c2)<br>
2014-02-25 00:10:44.723684 [DEBUG] kazoo_node.c:1091 Sent
erlang message to <a href="mailto:ecallmgr@kaz2.test.nl"
target="_blank"
onmousedown="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;" onclick="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;">ecallmgr@kaz2.test.nl</a> <2.11912.4><br>
freeswitch@internal><br>
2014-02-25 00:10:45.043686 [NOTICE] kazoo_node.c:302 log|<wbr>0v4twiSX8ZbXhaUtGh2KBbEpHgQyJm<wbr>qO|building
xferext extension: set ignore_display_updates=true<br>
2014-02-25 00:10:45.043686 [NOTICE] kazoo_node.c:302 log|<wbr>0v4twiSX8ZbXhaUtGh2KBbEpHgQyJm<wbr>qO|building
xferext extension: set continue_on_fail=true<br>
2014-02-25 00:10:45.043686 [NOTICE] kazoo_node.c:302 log|<wbr>0v4twiSX8ZbXhaUtGh2KBbEpHgQyJm<wbr>qO|building
xferext extension: export sip_redirect_context=context_2<br>
2014-02-25 00:10:45.043686 [NOTICE] kazoo_node.c:302 log|<wbr>0v4twiSX8ZbXhaUtGh2KBbEpHgQyJm<wbr>qO|building
xferext extension: bridge {ignore_display_updates='true'<wbr>,ecallmgr_Account-ID='<wbr>502cc62fa8097dd6d753fea7c7ef91<wbr>a1',ecallmgr_Reseller-ID='<wbr>cf9c1c7b7a5d5894bc0c0fbc9420c4<wbr>03',effective_caller_id_<wbr>number='+xxxxxxxxxxx',<wbr>effective_caller_id_name='<wbr>Martin',origination_caller_id_<wbr>number='+xxxxxxxxxxx',<wbr>origination_caller_id_name='<wbr>Martin',ignore_early_media='<wbr>false',local_var_clobber='<wbr>true'}[sip_auth_password='<wbr>xxxxxxxxxxxx',sip_auth_<wbr>username='xxxxxxxxxxx',<wbr>ecallmgr_Global-Resource='<wbr>false',ecallmgr_Resource-ID='<wbr>b50436c83efa77bb94e1241c872fa7<wbr>c0',absolute_codec_string='^^:<wbr>PCMU:PCMA:G722:G7221@16000h:<wbr>G7221@32000h',leg_progress_<wbr>timeout='60',effective_callee_<wbr>id_number='+918146234576',<wbr>effective_callee_id_name='<wbr>918146234576']sofia/<wbr>sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">918146234576@<wbr>sip.sipnl.net</a><br>
2014-02-25 00:10:45.043686 [NOTICE] kazoo_node.c:302 log|<wbr>0v4twiSX8ZbXhaUtGh2KBbEpHgQyJm<wbr>qO|building
xferext extension: event Event-Name=CUSTOM,Event-<wbr>Subclass=whistle::masquerade,<wbr>whistle_event_name=CHANNEL_<wbr>EXECUTE_COMPLETE,whistle_<wbr>application_name=bridge<br>
2014-02-25 00:10:45.043686 [NOTICE] kazoo_node.c:302 log|<wbr>0v4twiSX8ZbXhaUtGh2KBbEpHgQyJm<wbr>qO|building
xferext extension: park<br>
2014-02-25 00:10:45.043686 [NOTICE] kazoo_node.c:305 log|<wbr>0v4twiSX8ZbXhaUtGh2KBbEpHgQyJm<wbr>qO|transfered
call to xferext extension<br>
2014-02-25 00:10:45.043686 [DEBUG] switch_core_session.c:1183
Send signal sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
[BREAK]<br>
2014-02-25 00:10:45.043686 [DEBUG] switch_channel.c:3098
(sofia/sipinterface_1/<a href="mailto:user1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>)
State Change CS_EXECUTE -> CS_ROUTING<br>
2014-02-25 00:10:45.043686 [DEBUG] switch_core_session.c:1383
Send signal sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
[BREAK]<br>
2014-02-25 00:10:45.063687 [DEBUG]
switch_core_state_machine.c:<wbr>530 (sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>)
State EXECUTE going to sleep<br>
2014-02-25 00:10:45.063687 [DEBUG]
switch_core_state_machine.c:<wbr>467 (sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>)
Running State Change CS_ROUTING<br>
2014-02-25 00:10:45.063687 [DEBUG]
switch_core_state_machine.c:<wbr>523 (sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>)
State ROUTING<br>
2014-02-25 00:10:45.063687 [DEBUG] mod_sofia.c:123
sofia/sipinterface_1/<a href="mailto:user1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
SOFIA ROUTING<br>
2014-02-25 00:10:45.063687 [DEBUG]
switch_core_state_machine.c:<wbr>164 sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
Standard ROUTING<br>
2014-02-25 00:10:45.063687 [DEBUG]
switch_core_state_machine.c:<wbr>184 (sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>)
State Change CS_ROUTING -> CS_EXECUTE<br>
2014-02-25 00:10:45.063687 [DEBUG] switch_core_session.c:1383
Send signal sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
[BREAK]<br>
2014-02-25 00:10:45.063687 [DEBUG]
switch_core_state_machine.c:<wbr>523 (sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>)
State ROUTING going to sleep<br>
2014-02-25 00:10:45.063687 [DEBUG]
switch_core_state_machine.c:<wbr>467 (sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>)
Running State Change CS_EXECUTE<br>
2014-02-25 00:10:45.063687 [DEBUG]
switch_core_state_machine.c:<wbr>530 (sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>)
State EXECUTE<br>
2014-02-25 00:10:45.063687 [DEBUG] mod_sofia.c:178
sofia/sipinterface_1/<a href="mailto:user1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
SOFIA EXECUTE<br>
2014-02-25 00:10:45.063687 [DEBUG]
switch_core_state_machine.c:<wbr>256 sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
Standard EXECUTE<br>
EXECUTE sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
set(ignore_display_updates=<wbr>true)<br>
2014-02-25 00:10:45.063687 [DEBUG] mod_dptools.c:1402
sofia/sipinterface_1/<a href="mailto:user1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
SET [ignore_display_updates]=[<wbr>true]<br>
EXECUTE sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
set(continue_on_fail=true)<br>
2014-02-25 00:10:45.063687 [DEBUG] mod_dptools.c:1402
sofia/sipinterface_1/<a href="mailto:user1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
SET [continue_on_fail]=[true]<br>
EXECUTE sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
export(sip_redirect_context=<wbr>context_2)<br>
2014-02-25 00:10:45.063687 [DEBUG] switch_channel.c:1247
EXPORT (export_vars) [sip_redirect_context]=[<wbr>context_2]<br>
EXECUTE sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
bridge({ignore_display_<wbr>updates='true',ecallmgr_<wbr>Account-ID='<wbr>502cc62fa8097dd6d753fea7c7ef91<wbr>a1',ecallmgr_Reseller-ID='<wbr>cf9c1c7b7a5d5894bc0c0fbc9420c4<wbr>03',effective_caller_id_<wbr>number='+xxxxxxxxxxx',<wbr>effective_caller_id_name='<wbr>Martin',origination_caller_id_<wbr>number='+xxxxxxxxxxx',<wbr>origination_caller_id_name='<wbr>Martin',ignore_early_media='<wbr>false',local_var_clobber='<wbr>true'}[sip_auth_password='<wbr>xxxxxxxxxxxx',sip_auth_<wbr>username='xxxxxxxxxxx',<wbr>ecallmgr_Global-Resource='<wbr>false',ecallmgr_Resource-ID='<wbr>b50436c83efa77bb94e1241c872fa7<wbr>c0',absolute_codec_string='^^:<wbr>PCMU:PCMA:G722:G7221@16000h:<wbr>G7221@32000h',leg_progress_<wbr>timeout='60',effective_callee_<wbr>id_number='+918146234576',<wbr>effective_callee_id_name='<wbr>918146234576']sofia/<wbr>sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">918146234576@<wbr>sip.sipnl.net</a>)<br>
2014-02-25 00:10:45.083685 [DEBUG] switch_channel.c:1201
sofia/sipinterface_1/<a href="mailto:user1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
EXPORTING[export_vars] [ecallmgr_Bridge-ID]=[<wbr>0v4twiSX8ZbXhaUtGh2KBbEpHgQyJm<wbr>qO]
to event<br>
2014-02-25 00:10:45.083685 [DEBUG] switch_channel.c:1201
sofia/sipinterface_1/<a href="mailto:user1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
EXPORTING[export_vars] [ecallmgr_Ecallmgr-Node]=[<a
href="mailto:ecallmgr@kaz2.test.nl" target="_blank"
onmousedown="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;" onclick="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;">ecal<wbr>lmgr@kaz2.test.nl</a>] to event<br>
2014-02-25 00:10:45.083685 [DEBUG] switch_channel.c:1201
sofia/sipinterface_1/<a href="mailto:user1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
EXPORTING[export_vars] [sip_redirect_context]=[<wbr>context_2] to
event<br>
2014-02-25 00:10:45.083685 [DEBUG] switch_ivr_originate.c:2071
Parsing global variables<br>
2014-02-25 00:10:45.083685 [DEBUG] switch_event.c:1687 Parsing
variable [ignore_display_updates]=[<wbr>true]<br>
2014-02-25 00:10:45.083685 [DEBUG] switch_event.c:1687 Parsing
variable [ecallmgr_Account-ID]=[<wbr>502cc62fa8097dd6d753fea7c7ef91<wbr>a1]<br>
2014-02-25 00:10:45.083685 [DEBUG] switch_event.c:1687 Parsing
variable [ecallmgr_Reseller-ID]=[<wbr>cf9c1c7b7a5d5894bc0c0fbc9420c4<wbr>03]<br>
2014-02-25 00:10:45.083685 [DEBUG] switch_event.c:1687 Parsing
variable [effective_caller_id_number]=[<wbr>+xxxxxxxxxxx]<br>
2014-02-25 00:10:45.083685 [DEBUG] switch_event.c:1687 Parsing
variable [effective_caller_id_name]=[<wbr>Martin]<br>
2014-02-25 00:10:45.083685 [DEBUG] switch_event.c:1687 Parsing
variable [origination_caller_id_number]<wbr>=[+xxxxxxxxxxx]<br>
2014-02-25 00:10:45.083685 [DEBUG] switch_event.c:1687 Parsing
variable [origination_caller_id_name]=[<wbr>Martin]<br>
2014-02-25 00:10:45.083685 [DEBUG] switch_event.c:1687 Parsing
variable [ignore_early_media]=[false]<br>
2014-02-25 00:10:45.083685 [DEBUG] switch_event.c:1687 Parsing
variable [local_var_clobber]=[true]<br>
2014-02-25 00:10:45.083685 [DEBUG] switch_ivr_originate.c:2518
Parsing session specific variables<br>
2014-02-25 00:10:45.083685 [DEBUG] switch_event.c:1687 Parsing
variable [sip_auth_password]=[<wbr>xxxxxxxxxxxx]<br>
2014-02-25 00:10:45.083685 [DEBUG] switch_event.c:1687 Parsing
variable [sip_auth_username]=[<wbr>xxxxxxxxxxx]<br>
2014-02-25 00:10:45.083685 [DEBUG] switch_event.c:1687 Parsing
variable [ecallmgr_Global-Resource]=[<wbr>false]<br>
2014-02-25 00:10:45.083685 [DEBUG] switch_event.c:1687 Parsing
variable [ecallmgr_Resource-ID]=[<wbr>b50436c83efa77bb94e1241c872fa7<wbr>c0]<br>
2014-02-25 00:10:45.083685 [DEBUG] switch_event.c:1687 Parsing
variable [absolute_codec_string]=[^^:<wbr>PCMU:PCMA:G722:G7221@16000h:<wbr>G7221@32000h]<br>
2014-02-25 00:10:45.083685 [DEBUG] switch_event.c:1687 Parsing
variable [leg_progress_timeout]=[60]<br>
2014-02-25 00:10:45.083685 [DEBUG] switch_event.c:1687 Parsing
variable [effective_callee_id_number]=[<wbr>+918146234576]<br>
2014-02-25 00:10:45.083685 [DEBUG] switch_event.c:1687 Parsing
variable [effective_callee_id_name]=[<wbr>918146234576]<br>
2014-02-25 00:10:45.083685 [NOTICE] switch_channel.c:1055 New
Channel sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">91814623<wbr>4576@sip.sipnl.net</a>
[2e446736-9ddb-11e3-ae9b-<wbr>69d00812b6c2]<br>
2014-02-25 00:10:45.083685 [DEBUG] mod_sofia.c:4456
(sofia/sipinterface_1/+<a href="mailto:918146234576@sip.sipnl.net"
target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">9181462<wbr>34576@sip.sipnl.net</a>) State Change CS_NEW
-> CS_INIT<br>
2014-02-25 00:10:45.083685 [DEBUG] switch_core_session.c:1383
Send signal sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">91814623<wbr>4576@sip.sipnl.net</a> [BREAK]<br>
2014-02-25 00:10:45.083685 [DEBUG] switch_ivr_originate.c:2821
sofia/sipinterface_1/+<a href="mailto:918146234576@sip.sipnl.net"
target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">91814623<wbr>4576@sip.sipnl.net</a> Setting leg progress
timeout to 60<br>
2014-02-25 00:10:45.083685 [DEBUG]
switch_core_state_machine.c:<wbr>467 (sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">9181462<wbr>34576@sip.sipnl.net</a>) Running State Change
CS_INIT<br>
2014-02-25 00:10:45.083685 [DEBUG]
switch_core_state_machine.c:<wbr>507 (sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">9181462<wbr>34576@sip.sipnl.net</a>) State INIT<br>
2014-02-25 00:10:45.083685 [DEBUG] mod_sofia.c:87
sofia/sipinterface_1/+<a href="mailto:918146234576@sip.sipnl.net"
target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">91814623<wbr>4576@sip.sipnl.net</a> SOFIA INIT<br>
2014-02-25 00:10:45.083685 [INFO] switch_nat.c:590 NAT port
mapping disabled<br>
2014-02-25 00:10:45.083685 [DEBUG] sofia_glue.c:1225 Local
SDP:<br>
v=0<br>
o=FreeSWITCH 1393277355 1393277356 IN IP4 31.220.27.158<br>
s=FreeSWITCH<br>
c=IN IP4 31.220.27.158<br>
t=0 0<br>
m=audio 27690 RTP/AVP 0 8 9 98 99 101 13<br>
a=rtpmap:98 G7221/16000<br>
a=fmtp:98 bitrate=32000<br>
a=rtpmap:99 G7221/32000<br>
a=fmtp:99 bitrate=48000<br>
a=rtpmap:101 telephone-event/8000<br>
a=fmtp:101 0-16<br>
a=ptime:20<br>
a=sendrecv<br>
<br>
2014-02-25 00:10:45.083685 [DEBUG]
switch_core_state_machine.c:40 sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">91814623<wbr>4576@sip.sipnl.net</a> Standard INIT<br>
2014-02-25 00:10:45.083685 [DEBUG]
switch_core_state_machine.c:48 (sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">9181462<wbr>34576@sip.sipnl.net</a>) State Change CS_INIT
-> CS_ROUTING<br>
2014-02-25 00:10:45.083685 [DEBUG] switch_core_session.c:1383
Send signal sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">91814623<wbr>4576@sip.sipnl.net</a> [BREAK]<br>
2014-02-25 00:10:45.083685 [DEBUG]
switch_core_state_machine.c:<wbr>507 (sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">9181462<wbr>34576@sip.sipnl.net</a>) State INIT going to
sleep<br>
2014-02-25 00:10:45.083685 [DEBUG]
switch_core_state_machine.c:<wbr>467 (sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">9181462<wbr>34576@sip.sipnl.net</a>) Running State Change
CS_ROUTING<br>
2014-02-25 00:10:45.083685 [DEBUG]
switch_core_state_machine.c:<wbr>523 (sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">9181462<wbr>34576@sip.sipnl.net</a>) State ROUTING<br>
2014-02-25 00:10:45.083685 [DEBUG] mod_sofia.c:123
sofia/sipinterface_1/+<a href="mailto:918146234576@sip.sipnl.net"
target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">91814623<wbr>4576@sip.sipnl.net</a> SOFIA ROUTING<br>
2014-02-25 00:10:45.083685 [DEBUG] switch_ivr_originate.c:67
(sofia/sipinterface_1/+<a href="mailto:918146234576@sip.sipnl.net"
target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">9181462<wbr>34576@sip.sipnl.net</a>) State Change
CS_ROUTING -> CS_CONSUME_MEDIA<br>
2014-02-25 00:10:45.083685 [DEBUG] switch_core_session.c:1383
Send signal sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">91814623<wbr>4576@sip.sipnl.net</a> [BREAK]<br>
2014-02-25 00:10:45.083685 [DEBUG]
switch_core_state_machine.c:<wbr>523 (sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">9181462<wbr>34576@sip.sipnl.net</a>) State ROUTING going
to sleep<br>
2014-02-25 00:10:45.083685 [DEBUG]
switch_core_state_machine.c:<wbr>467 (sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">9181462<wbr>34576@sip.sipnl.net</a>) Running State Change
CS_CONSUME_MEDIA<br>
2014-02-25 00:10:45.083685 [DEBUG]
switch_core_state_machine.c:<wbr>542 (sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">9181462<wbr>34576@sip.sipnl.net</a>) State CONSUME_MEDIA<br>
2014-02-25 00:10:45.083685 [DEBUG]
switch_core_state_machine.c:<wbr>542 (sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">9181462<wbr>34576@sip.sipnl.net</a>) State CONSUME_MEDIA
going to sleep<br>
2014-02-25 00:10:45.083685 [INFO] kazoo_node.c:627 exec:
uuid_setvar_multi(2e446736-<wbr>9ddb-11e3-ae9b-69d00812b6c2
ecallmgr_Channel-Authorized=<wbr>true;ecallmgr_Global-Resource=<wbr>false;ecallmgr_Reseller-ID=<wbr>cf9c1c7b7a5d5894bc0c0fbc9420c4<wbr>03;ecallmgr_Account-ID=<wbr>502cc62fa8097dd6d753fea7c7ef91<wbr>a1)<br>
2014-02-25 00:10:45.083685 [DEBUG] kazoo_node.c:1091 Sent
erlang message to <a href="mailto:ecallmgr@kaz2.test.nl"
target="_blank"
onmousedown="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;" onclick="this.href='mailto:ecallmgr@kaz2.test.nl';return
true;">ecallmgr@kaz2.test.nl</a> <2.11955.4><br>
2014-02-25 00:10:45.103685 [DEBUG] switch_core_session.c:1048
Send signal sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">91814623<wbr>4576@sip.sipnl.net</a> [BREAK]<br>
2014-02-25 00:10:45.103685 [DEBUG] sofia.c:5889 Channel
sofia/sipinterface_1/+<a href="mailto:918146234576@sip.sipnl.net"
target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">91814623<wbr>4576@sip.sipnl.net</a> entering state
[calling][0]<br>
2014-02-25 00:10:45.103685 [DEBUG] switch_core_session.c:1048
Send signal sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">91814623<wbr>4576@sip.sipnl.net</a> [BREAK]<br>
2014-02-25 00:10:45.103685 [DEBUG] switch_core_session.c:1048
Send signal sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">91814623<wbr>4576@sip.sipnl.net</a> [BREAK]<br>
2014-02-25 00:10:45.103685 [DEBUG] switch_core_session.c:1048
Send signal sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">91814623<wbr>4576@sip.sipnl.net</a> [BREAK]<br>
2014-02-25 00:10:45.103685 [DEBUG] sofia.c:5889 Channel
sofia/sipinterface_1/+<a href="mailto:918146234576@sip.sipnl.net"
target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">91814623<wbr>4576@sip.sipnl.net</a> entering state
[terminated][503]<br>
2014-02-25 00:10:45.103685 [NOTICE] sofia.c:6733 Hangup
sofia/sipinterface_1/+<a href="mailto:918146234576@sip.sipnl.net"
target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">91814623<wbr>4576@sip.sipnl.net</a> [CS_CONSUME_MEDIA]
[NORMAL_TEMPORARY_FAILURE]<br>
2014-02-25 00:10:45.103685 [DEBUG] switch_channel.c:3212 Send
signal sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">91814623<wbr>4576@sip.sipnl.net</a> [KILL]<br>
2014-02-25 00:10:45.103685 [DEBUG] switch_core_session.c:1383
Send signal sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">91814623<wbr>4576@sip.sipnl.net</a> [BREAK]<br>
2014-02-25 00:10:45.103685 [DEBUG]
switch_core_state_machine.c:<wbr>467 (sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">9181462<wbr>34576@sip.sipnl.net</a>) Running State Change
CS_HANGUP<br>
2014-02-25 00:10:45.103685 [DEBUG]
switch_core_state_machine.c:<wbr>731 (sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">9181462<wbr>34576@sip.sipnl.net</a>) State HANGUP<br>
2014-02-25 00:10:45.103685 [DEBUG] mod_sofia.c:413 Channel
sofia/sipinterface_1/+<a href="mailto:918146234576@sip.sipnl.net"
target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">91814623<wbr>4576@sip.sipnl.net</a> hanging up, cause:
NORMAL_TEMPORARY_FAILURE<br>
2014-02-25 00:10:45.103685 [DEBUG]
switch_core_state_machine.c:58 sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">91814623<wbr>4576@sip.sipnl.net</a> Standard HANGUP,
cause: NORMAL_TEMPORARY_FAILURE<br>
2014-02-25 00:10:45.103685 [DEBUG]
switch_core_state_machine.c:<wbr>731 (sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">9181462<wbr>34576@sip.sipnl.net</a>) State HANGUP going
to sleep<br>
2014-02-25 00:10:45.103685 [DEBUG]
switch_core_state_machine.c:<wbr>744 (sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">9181462<wbr>34576@sip.sipnl.net</a>) Callstate Change
DOWN -> HANGUP<br>
2014-02-25 00:10:45.103685 [DEBUG]
switch_core_state_machine.c:<wbr>499 (sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">9181462<wbr>34576@sip.sipnl.net</a>) State Change
CS_HANGUP -> CS_REPORTING<br>
2014-02-25 00:10:45.103685 [DEBUG] switch_core_session.c:1383
Send signal sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">91814623<wbr>4576@sip.sipnl.net</a> [BREAK]<br>
2014-02-25 00:10:45.103685 [DEBUG]
switch_core_state_machine.c:<wbr>467 (sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">9181462<wbr>34576@sip.sipnl.net</a>) Running State Change
CS_REPORTING<br>
2014-02-25 00:10:45.103685 [DEBUG]
switch_core_state_machine.c:<wbr>816 (sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">9181462<wbr>34576@sip.sipnl.net</a>) State REPORTING<br>
2014-02-25 00:10:45.103685 [DEBUG]
switch_core_state_machine.c:<wbr>102 sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">91814623<wbr>4576@sip.sipnl.net</a> Standard REPORTING,
cause: NORMAL_TEMPORARY_FAILURE<br>
2014-02-25 00:10:45.103685 [DEBUG]
switch_core_state_machine.c:<wbr>816 (sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">9181462<wbr>34576@sip.sipnl.net</a>) State REPORTING
going to sleep<br>
2014-02-25 00:10:45.103685 [DEBUG]
switch_core_state_machine.c:<wbr>493 (sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">9181462<wbr>34576@sip.sipnl.net</a>) State Change
CS_REPORTING -> CS_DESTROY<br>
2014-02-25 00:10:45.103685 [DEBUG] switch_core_session.c:1383
Send signal sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">91814623<wbr>4576@sip.sipnl.net</a> [BREAK]<br>
2014-02-25 00:10:45.103685 [DEBUG] switch_core_session.c:1591
Session 15 (sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">9181462<wbr>34576@sip.sipnl.net</a>) Locked, Waiting on
external entities<br>
2014-02-25 00:10:45.123885 [DEBUG] switch_ivr_originate.c:3678
Originate Resulted in Error Cause: 41 [NORMAL_TEMPORARY_FAILURE]<br>
2014-02-25 00:10:45.123885 [INFO] mod_dptools.c:3244 Originate
Failed. Cause: NORMAL_TEMPORARY_FAILURE<br>
EXECUTE sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
event(Event-Name=CUSTOM,Event-<wbr>Subclass=whistle::masquerade,<wbr>whistle_event_name=CHANNEL_<wbr>EXECUTE_COMPLETE,whistle_<wbr>application_name=bridge)<br>
EXECUTE sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
park()<br>
2014-02-25 00:10:45.123885 [NOTICE] switch_core_session.c:1609
Session 15 (sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">9181462<wbr>34576@sip.sipnl.net</a>) Ended<br>
2014-02-25 00:10:45.123885 [NOTICE] switch_core_session.c:1613
Close Channel sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">91814623<wbr>4576@sip.sipnl.net</a> [CS_DESTROY]<br>
2014-02-25 00:10:45.123885 [DEBUG]
switch_core_state_machine.c:<wbr>618 (sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">9181462<wbr>34576@sip.sipnl.net</a>) Callstate Change
HANGUP -> DOWN<br>
2014-02-25 00:10:45.123885 [DEBUG]
switch_core_state_machine.c:<wbr>621 (sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">9181462<wbr>34576@sip.sipnl.net</a>) Running State Change
CS_DESTROY<br>
2014-02-25 00:10:45.123885 [DEBUG]
switch_core_state_machine.c:<wbr>631 (sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">9181462<wbr>34576@sip.sipnl.net</a>) State DESTROY<br>
2014-02-25 00:10:45.123885 [DEBUG] mod_sofia.c:323
sofia/sipinterface_1/+<a href="mailto:918146234576@sip.sipnl.net"
target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">91814623<wbr>4576@sip.sipnl.net</a> SOFIA DESTROY<br>
2014-02-25 00:10:45.123885 [DEBUG]
switch_core_state_machine.c:<wbr>109 sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">91814623<wbr>4576@sip.sipnl.net</a> Standard DESTROY<br>
2014-02-25 00:10:45.123885 [DEBUG]
switch_core_state_machine.c:<wbr>631 (sofia/sipinterface_1/+<a
href="mailto:918146234576@sip.sipnl.net" target="_blank"
onmousedown="this.href='mailto:918146234576@sip.sipnl.net';return
true;"
onclick="this.href='mailto:918146234576@sip.sipnl.net';return
true;">9181462<wbr>34576@sip.sipnl.net</a>) State DESTROY going
to sleep<br>
2014-02-25 00:10:45.183685 [NOTICE] kazoo_node.c:285 log|<wbr>0v4twiSX8ZbXhaUtGh2KBbEpHgQyJm<wbr>qO|executing
pre_answer <br>
2014-02-25 00:10:45.183685 [DEBUG] switch_core_session.c:1183
Send signal sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
[BREAK]<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_ivr.c:615
sofia/sipinterface_1/<a href="mailto:user1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
Command Execute pre_answer()<br>
EXECUTE sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
pre_answer()<br>
2014-02-25 00:10:45.183685 [INFO] mod_dptools.c:1260 Sending
early media<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_core_media.c:3166
Audio Codec Compare [SILK:99:24000:20:0]/[G7221:<wbr>115:32000:20:48000]<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_core_media.c:3166
Audio Codec Compare [SILK:99:24000:20:0]/[G7221:<wbr>107:16000:20:32000]<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_core_media.c:3166
Audio Codec Compare [SILK:99:24000:20:0]/[G722:9:<wbr>8000:20:64000]<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_core_media.c:3166
Audio Codec Compare [SILK:99:24000:20:0]/[PCMU:0:<wbr>8000:20:64000]<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_core_media.c:3166
Audio Codec Compare [SILK:99:24000:20:0]/[PCMA:8:<wbr>8000:20:64000]<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_core_media.c:3166
Audio Codec Compare [SILK:99:24000:20:0]/[GSM:3:<wbr>8000:20:13200]<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_core_media.c:3166
Audio Codec Compare [PCMU:0:8000:20:64000]/[G7221:<wbr>115:32000:20:48000]<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_core_media.c:3166
Audio Codec Compare [PCMU:0:8000:20:64000]/[G7221:<wbr>107:16000:20:32000]<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_core_media.c:3166
Audio Codec Compare [PCMU:0:8000:20:64000]/[G722:<wbr>9:8000:20:64000]<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_core_media.c:3166
Audio Codec Compare [PCMU:0:8000:20:64000]/[PCMU:<wbr>0:8000:20:64000]<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_core_media.c:3220
Audio Codec Compare [PCMU:0:8000:20:64000] ++++ is saved as a
match<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_core_media.c:3166
Audio Codec Compare [PCMU:0:8000:20:64000]/[PCMA:<wbr>8:8000:20:64000]<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_core_media.c:3166
Audio Codec Compare [PCMU:0:8000:20:64000]/[GSM:3:<wbr>8000:20:13200]<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_core_media.c:3166
Audio Codec Compare [PCMA:8:8000:20:64000]/[G7221:<wbr>115:32000:20:48000]<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_core_media.c:3166
Audio Codec Compare [PCMA:8:8000:20:64000]/[G7221:<wbr>107:16000:20:32000]<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_core_media.c:3166
Audio Codec Compare [PCMA:8:8000:20:64000]/[G722:<wbr>9:8000:20:64000]<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_core_media.c:3166
Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMU:<wbr>0:8000:20:64000]<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_core_media.c:3166
Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMA:<wbr>8:8000:20:64000]<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_core_media.c:3220
Audio Codec Compare [PCMA:8:8000:20:64000] ++++ is saved as a
match<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_core_media.c:3166
Audio Codec Compare [PCMA:8:8000:20:64000]/[GSM:3:<wbr>8000:20:13200]<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_core_media.c:3092
Set telephone-event payload to 101<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_core_media.c:2125
Set Codec sofia/sipinterface_1/<a href="mailto:user1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
PCMU/8000 20 ms 160 samples 64000 bits<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_core_codec.c:111
sofia/sipinterface_1/<a href="mailto:user1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
Original read codec set to PCMU:0<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_core_media.c:3398
Set 2833 dtmf send/recv payload to 101<br>
2014-02-25 00:10:45.183685 [INFO] switch_nat.c:590 NAT port
mapping disabled<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_core_media.c:4586
AUDIO RTP [sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>]
31.220.27.158 port 20696 -> 112.196.33.74 port 4226 codec: 0
ms: 20<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_rtp.c:3068 Starting
timer [soft] 160 bytes per 20ms<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_core_media.c:4930
Set 2833 dtmf send payload to 101<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_core_media.c:4936
Set 2833 dtmf receive payload to 101<br>
2014-02-25 00:10:45.183685 [NOTICE] sofia_media.c:92
Pre-Answer sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>!<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_channel.c:3405
(sofia/sipinterface_1/<a href="mailto:user1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>)
Callstate Change RINGING -> EARLY<br>
2014-02-25 00:10:45.183685 [DEBUG] mod_sofia.c:2099 Ring SDP:<br>
v=0<br>
o=FreeSWITCH 1393284349 1393284350 IN IP4 31.220.27.158<br>
s=FreeSWITCH<br>
c=IN IP4 31.220.27.158<br>
t=0 0<br>
m=audio 20696 RTP/AVP 0 101<br>
a=rtpmap:0 PCMU/8000<br>
a=rtpmap:101 telephone-event/8000<br>
a=fmtp:101 0-16<br>
a=ptime:20<br>
a=sendrecv<br>
<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_core_session.c:903
Send signal sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
[BREAK]<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_ivr.c:959 Codec
Activated L16@8000hz 1 channels 20ms<br>
send 1297 bytes to udp/[88.80.160.31]:5060 at 05:10:45.197608:<br>
------------------------------<wbr>------------------------------<wbr>------------<br>
SIP/2.0 183 Session Progress<br>
Via: SIP/2.0/UDP 88.80.160.31;branch=<wbr>z9hG4bKd602.9af44717.0<br>
Via: SIP/2.0/UDP 112.196.33.74:11220;rport=<wbr>62926;branch=z9hG4bKPj.<wbr>w0giarvUkQ67HPw3uK5Z6NsdtAUWvE<wbr>V<br>
Record-Route: <sip:88.80.160.31;lr=on;ftag=<wbr>aW0i4G-.<wbr>8DI9G4pbsNbl8EWP1fY76mxz><br>
From: <<a href="mailto:sip%3Auser1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:sip%3Auser1@sip.test.com';return
true;"
onclick="this.href='mailto:sip%3Auser1@sip.test.com';return
true;">sip:user1@sip.test.com</a>>;tag=<wbr>aW0i4G-.<wbr>8DI9G4pbsNbl8EWP1fY76mxz<br>
To: <<a href="mailto:sip%3A%2B918146234576@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:sip%3A%2B918146234576@sip.test.com';return
true;"
onclick="this.href='mailto:sip%3A%2B918146234576@sip.test.com';return
true;">sip:+918146234576@sip.test.<wbr>com</a>>;tag=0KtN4j4SvttFc<br>
Call-ID: 0v4twiSX8ZbXhaUtGh2KBbEpHgQyJm<wbr>qO<br>
CSeq: 26826 INVITE<br>
Contact: <<a class="moz-txt-link-abbreviated" href="mailto:sip:+918146234576@31.220.27">sip:+918146234576@31.220.27</a>.<wbr>158:11000;transport=udp><br>
User-Agent: 2600hz<br>
Accept: application/sdp<br>
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO,
UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE<br>
Supported: precondition, path, replaces<br>
Allow-Events: talk, hold, conference, presence,
as-feature-event, dialog, line-seize, call-info, sla,
include-session-description, presence.winfo, message-summary,
refer<br>
Content-Type: application/sdp<br>
Content-Disposition: session<br>
Content-Length: 222<br>
Remote-Party-ID: "+918146234576" <<a
href="mailto:sip%3A%2B918146234576@sip.test.com" target="_blank"
onmousedown="this.href='mailto:sip%3A%2B918146234576@sip.test.com';return
true;"
onclick="this.href='mailto:sip%3A%2B918146234576@sip.test.com';return
true;">sip:+918146234576@sip.test.<wbr>com</a>>;party=calling;privacy=<wbr>off;screen=no<br>
<br>
v=0<br>
o=FreeSWITCH 1393284349 1393284350 IN IP4 31.220.27.158<br>
s=FreeSWITCH<br>
c=IN IP4 31.220.27.158<br>
t=0 0<br>
m=audio 20696 RTP/AVP 0 101<br>
a=rtpmap:0 PCMU/8000<br>
a=rtpmap:101 telephone-event/8000<br>
a=fmtp:101 0-16<br>
a=ptime:20<br>
------------------------------<wbr>------------------------------<wbr>------------<br>
2014-02-25 00:10:45.183685 [DEBUG] switch_core_session.c:1048
Send signal sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
[BREAK]<br>
2014-02-25 00:10:45.183685 [DEBUG] sofia.c:5889 Channel
sofia/sipinterface_1/<a href="mailto:user1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
entering state [early][183]<br>
2014-02-25 00:10:45.303686 [NOTICE] kazoo_node.c:285 log|<wbr>0v4twiSX8ZbXhaUtGh2KBbEpHgQyJm<wbr>qO|executing
playback ${http_get(<a
href="http://127.0.0.1:15984/system_media/fault-can_not_be_completed_at_this_time/fault-can_not_be_completed_at_this_time.wav"
target="_blank"
onmousedown="this.href='http://www.google.com/url?q\75http%3A%2F%2F127.0.0.1%3A15984%2Fsystem_media%2Ffault-can_not_be_completed_at_this_time%2Ffault-can_not_be_completed_at_this_time.wav\46sa\75D\46sntz\0751\46usg\75AFQjCNFrXctgoidxXU2HiFX_f0USKswP_w';return
true;"
onclick="this.href='http://www.google.com/url?q\75http%3A%2F%2F127.0.0.1%3A15984%2Fsystem_media%2Ffault-can_not_be_completed_at_this_time%2Ffault-can_not_be_completed_at_this_time.wav\46sa\75D\46sntz\0751\46usg\75AFQjCNFrXctgoidxXU2HiFX_f0USKswP_w';return
true;">http://127.0.0.1:<wbr>15984/system_media/fault-can_<wbr>not_be_completed_at_this_time/<wbr>fault-can_not_be_completed_at_<wbr>this_time.wav</a>)}<br>
2014-02-25 00:10:45.303686 [DEBUG] switch_core_session.c:1183
Send signal sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
[BREAK]<br>
2014-02-25 00:10:45.303686 [DEBUG] switch_ivr.c:615
sofia/sipinterface_1/<a href="mailto:user1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
Command Execute playback(${http_get(<a
href="http://127.0.0.1:15984/system_media/fault-can_not_be_completed_at_this_time/fault-can_not_be_completed_at_this_time.wav%29"
target="_blank"
onmousedown="this.href='http://www.google.com/url?q\75http%3A%2F%2F127.0.0.1%3A15984%2Fsystem_media%2Ffault-can_not_be_completed_at_this_time%2Ffault-can_not_be_completed_at_this_time.wav)\46sa\75D\46sntz\0751\46usg\75AFQjCNFEro7nmxFtoDFSw4-9j0Y-rZe1lQ';return
true;"
onclick="this.href='http://www.google.com/url?q\75http%3A%2F%2F127.0.0.1%3A15984%2Fsystem_media%2Ffault-can_not_be_completed_at_this_time%2Ffault-can_not_be_completed_at_this_time.wav)\46sa\75D\46sntz\0751\46usg\75AFQjCNFEro7nmxFtoDFSw4-9j0Y-rZe1lQ';return
true;">http://<wbr>127.0.0.1:15984/system_media/<wbr>fault-can_not_be_completed_at_<wbr>this_time/fault-can_not_be_<wbr>completed_at_this_time.wav)</a>})<br>
2014-02-25 00:10:45.323688 [DEBUG] mod_http_cache.c:523 Locked
cache<br>
2014-02-25 00:10:45.323688 [DEBUG] mod_http_cache.c:651 Cache
HIT: size = 1 (0 MB), hit ratio = 8/9<br>
2014-02-25 00:10:45.323688 [DEBUG] mod_http_cache.c:534
Unlocked cache<br>
EXECUTE sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
playback(/usr/share/<wbr>freeswitch/http_cache/39/<wbr>6c5fb6-9d53-11e3-adae-<wbr>69d00812b6c2.wav)<br>
2014-02-25 00:10:45.323688 [DEBUG] switch_core_file.c:216 File
/usr/share/freeswitch/http_<wbr>cache/39/6c5fb6-9d53-11e3-<wbr>adae-69d00812b6c2.wav
sample rate 16000 doesn't match requested rate 8000<br>
2014-02-25 00:10:45.323688 [DEBUG] switch_ivr_play_say.c:1315
Codec Activated L16@8000hz 1 channels 20ms<br>
2014-02-25 00:10:46.603692 [INFO] switch_rtp.c:5174 Auto
Changing port from <a href="http://112.196.33.74:4226"
target="_blank"
onmousedown="this.href='http://www.google.com/url?q\75http%3A%2F%2F112.196.33.74%3A4226\46sa\75D\46sntz\0751\46usg\75AFQjCNFrb-OLZxq6Y4XNnhl9lIvw6c5zBw';return
true;"
onclick="this.href='http://www.google.com/url?q\75http%3A%2F%2F112.196.33.74%3A4226\46sa\75D\46sntz\0751\46usg\75AFQjCNFrb-OLZxq6Y4XNnhl9lIvw6c5zBw';return
true;">112.196.33.74:4226</a> to <a
href="http://112.196.33.74:62840" target="_blank"
onmousedown="this.href='http://www.google.com/url?q\75http%3A%2F%2F112.196.33.74%3A62840\46sa\75D\46sntz\0751\46usg\75AFQjCNHzjKTFM4_TumYRdS5PxzL6mOTfRQ';return
true;"
onclick="this.href='http://www.google.com/url?q\75http%3A%2F%2F112.196.33.74%3A62840\46sa\75D\46sntz\0751\46usg\75AFQjCNHzjKTFM4_TumYRdS5PxzL6mOTfRQ';return
true;">112.196.33.74:62840</a><br>
2014-02-25 00:10:49.503708 [DEBUG] switch_ivr_play_say.c:1719
done playing file /usr/share/freeswitch/http_<wbr>cache/39/6c5fb6-9d53-11e3-<wbr>adae-69d00812b6c2.wav<br>
2014-02-25 00:10:49.503708 [NOTICE] kazoo_node.c:285 log|<wbr>0v4twiSX8ZbXhaUtGh2KBbEpHgQyJm<wbr>qO|executing
respond 503 Normal temporary failure<br>
2014-02-25 00:10:49.503708 [DEBUG] switch_core_session.c:1183
Send signal sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
[BREAK]<br>
2014-02-25 00:10:49.543698 [DEBUG] switch_ivr.c:615
sofia/sipinterface_1/<a href="mailto:user1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
Command Execute respond(503 Normal temporary failure)<br>
EXECUTE sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
respond(503 Normal temporary failure)<br>
2014-02-25 00:10:49.543698 [DEBUG] mod_sofia.c:1919 Responding
with 503 [Normal temporary failure]<br>
2014-02-25 00:10:49.543698 [NOTICE] mod_sofia.c:1978 Hangup
sofia/sipinterface_1/<a href="mailto:user1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
[CS_EXECUTE] [NORMAL_TEMPORARY_FAILURE]<br>
2014-02-25 00:10:49.543698 [DEBUG] switch_channel.c:3212 Send
signal sofia/sipinterface_1/<a href="mailto:user1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
[KILL]<br>
2014-02-25 00:10:49.543698 [DEBUG] switch_core_session.c:1383
Send signal sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
[BREAK]<br>
2014-02-25 00:10:49.543698 [DEBUG] switch_core_session.c:2852
sofia/sipinterface_1/<a href="mailto:user1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
skip receive message [APPLICATION_EXEC_COMPLETE] (channel is
hungup already)<br>
2014-02-25 00:10:49.543698 [DEBUG] switch_ivr.c:658
sofia/sipinterface_1/<a href="mailto:user1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
skip receive message [AUDIO_SYNC] (channel is hungup already)<br>
2014-02-25 00:10:49.543698 [DEBUG] switch_core_session.c:2852
sofia/sipinterface_1/<a href="mailto:user1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
skip receive message [APPLICATION_EXEC_COMPLETE] (channel is
hungup already)<br>
2014-02-25 00:10:49.543698 [DEBUG]
switch_core_state_machine.c:<wbr>530 (sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>)
State EXECUTE going to sleep<br>
2014-02-25 00:10:49.543698 [DEBUG]
switch_core_state_machine.c:<wbr>467 (sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>)
Running State Change CS_HANGUP<br>
2014-02-25 00:10:49.543698 [DEBUG]
switch_core_state_machine.c:<wbr>731 (sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>)
State HANGUP<br>
2014-02-25 00:10:49.543698 [DEBUG] mod_sofia.c:407
sofia/sipinterface_1/<a href="mailto:user1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
Overriding SIP cause 503 with 503 from the other leg<br>
2014-02-25 00:10:49.543698 [DEBUG] mod_sofia.c:413 Channel
sofia/sipinterface_1/<a href="mailto:user1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
hanging up, cause: NORMAL_TEMPORARY_FAILURE<br>
2014-02-25 00:10:49.543698 [DEBUG] mod_sofia.c:553 Responding
to INVITE with: 503<br>
2014-02-25 00:10:49.543698 [DEBUG]
switch_core_state_machine.c:58 sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
Standard HANGUP, cause: NORMAL_TEMPORARY_FAILURE<br>
2014-02-25 00:10:49.543698 [DEBUG]
switch_core_state_machine.c:<wbr>731 (sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>)
State HANGUP going to sleep<br>
2014-02-25 00:10:49.543698 [DEBUG]
switch_core_state_machine.c:<wbr>744 (sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>)
Callstate Change EARLY -> HANGUP<br>
2014-02-25 00:10:49.543698 [DEBUG]
switch_core_state_machine.c:<wbr>499 (sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>)
State Change CS_HANGUP -> CS_REPORTING<br>
2014-02-25 00:10:49.543698 [DEBUG] switch_core_session.c:1383
Send signal sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>
[BREAK]<br>
send 910 bytes to udp/[88.80.160.31]:5060 at 05:10:49.558765:<br>
------------------------------<wbr>------------------------------<wbr>------------<br>
SIP/2.0 503 Normal temporary failure<br>
Via: SIP/2.0/UDP 88.80.160.31;branch=<wbr>z9hG4bKd602.9af44717.0<br>
Via: SIP/2.0/UDP 112.196.33.74:11220;rport=<wbr>62926;branch=z9hG4bKPj.<wbr>w0giarvUkQ67HPw3uK5Z6NsdtAUWvE<wbr>V<br>
From: <<a href="mailto:sip%3Auser1@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:sip%3Auser1@sip.test.com';return
true;"
onclick="this.href='mailto:sip%3Auser1@sip.test.com';return
true;">sip:user1@sip.test.com</a>>;tag=<wbr>aW0i4G-.<wbr>8DI9G4pbsNbl8EWP1fY76mxz<br>
To: <<a href="mailto:sip%3A%2B918146234576@sip.test.com"
target="_blank"
onmousedown="this.href='mailto:sip%3A%2B918146234576@sip.test.com';return
true;"
onclick="this.href='mailto:sip%3A%2B918146234576@sip.test.com';return
true;">sip:+918146234576@sip.test.<wbr>com</a>>;tag=0KtN4j4SvttFc<br>
Call-ID: 0v4twiSX8ZbXhaUtGh2KBbEpHgQyJm<wbr>qO<br>
CSeq: 26826 INVITE<br>
User-Agent: 2600hz2014-02-25 00:10:49.543698 [DEBUG]
switch_core_state_machine.c:<wbr>467 (sofia/sipinterface_1/<a
href="mailto:user1@sip.test.com" target="_blank"
onmousedown="this.href='mailto:user1@sip.test.com';return true;"
onclick="this.href='mailto:user1@sip.test.com';return true;">user1@<wbr>sip.test.com</a>)
Running State Change CS_REPORTING<br>
<br>
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO,
UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE<br>
Supported: precondition, path, replaces<br>
Allow-Events: talk, hold, conference, presence,
as-feature-event, dialog, line-seize, call-info, sla,
include-session-description, presence.winfo, message-summary,
refer<br>
Reason: Q.850;cause=41;text="NORMAL_<wbr>TEMPORARY_FAILURE"<br>
Content-Length: 0<br>
Remote-Party-ID: "+918146234576" <<a
href="mailto:sip%3A%2B918146234576@sip.test.com" target="_blank"
onmousedown="this.href='mailto:sip%3A%2B918146234576@sip.test.com';return
true;"
onclick="this.href='mailto:sip%3A%2B918146234576@sip.test.com';return
true;">sip:+918146234576@sip.test.<wbr>com</a>>;party=calling;privacy=<wbr>off;screen=no<br>
<br>
<br>
<br>
<br>
can anyone tell me what is the problem and how to solve it.<br>
<br>
<br>
<br>
regards,<br>
vinay<br>
<br>
<br>
</div>
<br>
</body>
</html>