hello i'm invoking a javascript script in my dialplan when i call my DID number.
I've loaded the mod_javascript module
Edit a javascript file in /usr/local/src/freeswitch/scripts
var languageCode = "en";
var soundDir = "sound/";
function playFile(fileName, callBack, callBackArgs)
{
session.streamFile(soundDir + languageCode + "/" + fileName, callBack, callBackArgs);
}
session.answer();
//playFile("HelloWorld.wav");
playFile("/usr/local/freeswitch/sounds/en/us/callie/ivr/16000/ivr-welcome_to_freeswitch.wav");
exit();
~
Edit a dialplan in /usr/local/freeswitch/conf/dialplan/public
root@back-1:/usr/local/freeswitch/conf/dialplan/public# vi javas.xml
<include>
<extension name="public_did">
<condition field="${sip_to_user}" expression="(972550428)$">
<action application="set" data="group_confirm_file=javascript ivrmenu.js" />
</condition>
</extension>
</include>
It rings three time and then get busy. I've noticed the error "Responding to INVITE with 480.
But when i dial dial directly my DID number without a javascript or othe script file in the dialplan, that works fine.
Can someone help me understand what's going on and how to solve it.
Thank you
2016-05-05 14:13:02.268768 [NOTICE] switch_channel.c:1104 New Channel sofia/external/anonymous@anonymous.invalid [7a68f854-12cb-11e6-b68f-75ea2a7b416e]
2016-05-05 14:13:02.268768 [DEBUG] switch_core_state_machine.c:543 (sofia/external/anonymous@anonymous.invalid) Running State Change CS_NEW
2016-05-05 14:13:02.268768 [DEBUG] sofia.c:9376 sofia/external/anonymous@anonymous.invalid receiving invite from
10.0.0.4:5060 version: 1.7.0 git 6fc6efa 2016-05-03 02:03:34Z 64bit
2016-05-05 14:13:02.268768 [DEBUG] sofia.c:6858 Channel sofia/external/anonymous@anonymous.invalid entering state [received][100]
2016-05-05 14:13:02.268768 [DEBUG] sofia.c:6868 Remote SDP:
v=0
o=cp10 146245758317 146245758317 IN IP4 10.7.1.9
s=SIP Call
c=IN IP4 91.121.129.146
t=0 0
m=audio 36336 RTP/AVP 18 4 0 8 125 111 101
b=AS:21
a=rtpmap:18 G729/8000/1
a=fmtp:18 annexb=no
a=rtpmap:4 G723/8000/1
a=fmtp:4 annexa=no
a=rtpmap:0 PCMU/8000/1
a=rtpmap:8 PCMA/8000/1
a=rtpmap:125 CLEARMODE/8000/1
a=rtpmap:111 iLBC/8000/1
a=fmtp:111 mode=30
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:30
2016-05-05 14:13:02.268768 [DEBUG] sofia.c:7227 (sofia/external/anonymous@anonymous.invalid) State Change CS_NEW -> CS_INIT
2016-05-05 14:13:02.268768 [DEBUG] switch_core_state_machine.c:562 (sofia/external/anonymous@anonymous.invalid) State NEW
2016-05-05 14:13:02.268768 [DEBUG] switch_core_state_machine.c:543 (sofia/external/anonymous@anonymous.invalid) Running State Change CS_INIT
2016-05-05 14:13:02.268768 [DEBUG] switch_core_state_machine.c:586 (sofia/external/anonymous@anonymous.invalid) State INIT
2016-05-05 14:13:02.268768 [DEBUG] mod_sofia.c:89 sofia/external/anonymous@anonymous.invalid SOFIA INIT
2016-05-05 14:13:02.268768 [DEBUG] switch_core_state_machine.c:40 sofia/external/anonymous@anonymous.invalid Standard INIT
2016-05-05 14:13:02.268768 [DEBUG] switch_core_state_machine.c:48 (sofia/external/anonymous@anonymous.invalid) State Change CS_INIT -> CS_ROUTING
2016-05-05 14:13:02.268768 [DEBUG] switch_core_state_machine.c:586 (sofia/external/anonymous@anonymous.invalid) State INIT going to sleep
2016-05-05 14:13:02.268768 [DEBUG] switch_core_state_machine.c:543 (sofia/external/anonymous@anonymous.invalid) Running State Change CS_ROUTING
2016-05-05 14:13:02.268768 [DEBUG] switch_channel.c:2249 (sofia/external/anonymous@anonymous.invalid) Callstate Change DOWN -> RINGING
2016-05-05 14:13:02.268768 [DEBUG] switch_core_state_machine.c:602 (sofia/external/anonymous@anonymous.invalid) State ROUTING
2016-05-05 14:13:02.268768 [DEBUG] mod_sofia.c:142 sofia/external/anonymous@anonymous.invalid SOFIA ROUTING
2016-05-05 14:13:02.268768 [DEBUG] switch_core_state_machine.c:236 sofia/external/anonymous@anonymous.invalid Standard ROUTING
2016-05-05 14:13:02.268768 [INFO] mod_dialplan_xml.c:637 Processing Anonymous <anonymous>->opensips in context public
Dialplan: sofia/external/anonymous@anonymous.invalid parsing [public->unloop] continue=false
Dialplan: sofia/external/anonymous@anonymous.invalid Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
Dialplan: sofia/external/anonymous@anonymous.invalid Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
Dialplan: sofia/external/anonymous@anonymous.invalid parsing [public->outside_call] continue=true
Dialplan: sofia/external/anonymous@anonymous.invalid Absolute Condition [outside_call]
Dialplan: sofia/external/anonymous@anonymous.invalid Action set(outside_call=true)
Dialplan: sofia/external/anonymous@anonymous.invalid Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
Dialplan: sofia/external/anonymous@anonymous.invalid parsing [public->call_debug] continue=true
Dialplan: sofia/external/anonymous@anonymous.invalid Regex (FAIL) [call_debug] ${call_debug}(false) =~ /^true$/ break=never
Dialplan: sofia/external/anonymous@anonymous.invalid parsing [public->public_extensions] continue=false
Dialplan: sofia/external/anonymous@anonymous.invalid Regex (FAIL) [public_extensions] destination_number(opensips) =~ /^(10[01][0-9])$/ break=on-false
Dialplan: sofia/external/anonymous@anonymous.invalid parsing [public->public_did] continue=false
Dialplan: sofia/external/anonymous@anonymous.invalid Regex (PASS) [public_did] ${sip_to_user}(0972550428) =~ /(972550428)$/ break=on-false
Dialplan: sofia/external/anonymous@anonymous.invalid Action set(group_confirm_file=javascript monScript.js)
2016-05-05 14:13:02.268768 [DEBUG] switch_core_state_machine.c:286 (sofia/external/anonymous@anonymous.invalid) State Change CS_ROUTING -> CS_EXECUTE
2016-05-05 14:13:02.268768 [DEBUG] switch_core_state_machine.c:602 (sofia/external/anonymous@anonymous.invalid) State ROUTING going to sleep
2016-05-05 14:13:02.268768 [DEBUG] switch_core_state_machine.c:543 (sofia/external/anonymous@anonymous.invalid) Running State Change CS_EXECUTE
2016-05-05 14:13:02.268768 [DEBUG] switch_core_state_machine.c:609 (sofia/external/anonymous@anonymous.invalid) State EXECUTE
2016-05-05 14:13:02.268768 [DEBUG] mod_sofia.c:197 sofia/external/anonymous@anonymous.invalid SOFIA EXECUTE
2016-05-05 14:13:02.268768 [DEBUG] switch_core_state_machine.c:328 sofia/external/anonymous@anonymous.invalid Standard EXECUTE
EXECUTE sofia/external/anonymous@anonymous.invalid set(outside_call=true)
2016-05-05 14:13:02.268768 [DEBUG] mod_dptools.c:1519 SET sofia/external/anonymous@anonymous.invalid [outside_call]=[true]
EXECUTE sofia/external/anonymous@anonymous.invalid export(RFC2822_DATE=Thu, 05 May 2016 14:13:02 +0000)
2016-05-05 14:13:02.268768 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [RFC2822_DATE]=[Thu, 05 May 2016 14:13:02 +0000]
EXECUTE sofia/external/anonymous@anonymous.invalid set(group_confirm_file=javascript monScript.js)
2016-05-05 14:13:02.268768 [DEBUG] mod_dptools.c:1519 SET sofia/external/anonymous@anonymous.invalid [group_confirm_file]=[javascript monScript.js]
2016-05-05 14:13:02.268768 [NOTICE] switch_core_state_machine.c:385 sofia/external/anonymous@anonymous.invalid has executed the last dialplan instruction, hanging up.
2016-05-05 14:13:02.268768 [NOTICE] switch_core_state_machine.c:387 Hangup sofia/external/anonymous@anonymous.invalid [CS_EXECUTE] [NORMAL_CLEARING]
2016-05-05 14:13:02.268768 [DEBUG] switch_core_state_machine.c:609 (sofia/external/anonymous@anonymous.invalid) State EXECUTE going to sleep
2016-05-05 14:13:02.268768 [DEBUG] switch_core_state_machine.c:543 (sofia/external/anonymous@anonymous.invalid) Running State Change CS_HANGUP
2016-05-05 14:13:02.268768 [DEBUG] switch_core_state_machine.c:809 (sofia/external/anonymous@anonymous.invalid) Callstate Change RINGING -> HANGUP
2016-05-05 14:13:02.268768 [DEBUG] switch_core_state_machine.c:811 (sofia/external/anonymous@anonymous.invalid) State HANGUP
2016-05-05 14:13:02.268768 [DEBUG] mod_sofia.c:437 Channel sofia/external/anonymous@anonymous.invalid hanging up, cause: NORMAL_CLEARING
2016-05-05 14:13:02.268768 [DEBUG] mod_sofia.c:574
Responding to INVITE with: 4802016-05-05 14:13:02.268768 [DEBUG] switch_core_state_machine.c:60 sofia/external/anonymous@anonymous.invalid Standard HANGUP, cause: NORMAL_CLEARING
2016-05-05 14:13:02.268768 [DEBUG] switch_core_state_machine.c:811 (sofia/external/anonymous@anonymous.invalid) State HANGUP going to sleep
2016-05-05 14:13:02.268768 [DEBUG] switch_core_state_machine.c:578 (sofia/external/anonymous@anonymous.invalid) State Change CS_HANGUP -> CS_REPORTING
2016-05-05 14:13:02.268768 [DEBUG] switch_core_state_machine.c:543 (sofia/external/anonymous@anonymous.invalid) Running State Change CS_REPORTING
2016-05-05 14:13:02.268768 [DEBUG] switch_core_state_machine.c:897 (sofia/external/anonymous@anonymous.invalid) State REPORTING
2016-05-05 14:13:02.268768 [DEBUG] switch_core_state_machine.c:174 sofia/external/anonymous@anonymous.invalid Standard REPORTING, cause: NORMAL_CLEARING
2016-05-05 14:13:02.268768 [DEBUG] switch_core_state_machine.c:897 (sofia/external/anonymous@anonymous.invalid) State REPORTING going to sleep
2016-05-05 14:13:02.268768 [DEBUG] switch_core_state_machine.c:569 (sofia/external/anonymous@anonymous.invalid) State Change CS_REPORTING -> CS_DESTROY
2016-05-05 14:13:02.268768 [DEBUG] switch_core_session.c:1646 Session 48 (sofia/external/anonymous@anonymous.invalid) Locked, Waiting on external entities
2016-05-05 14:13:02.268768 [NOTICE] switch_core_session.c:1664 Session 48 (sofia/external/anonymous@anonymous.invalid) Ended
2016-05-05 14:13:02.268768 [NOTICE] switch_core_session.c:1668 Close Channel sofia/external/anonymous@anonymous.invalid [CS_DESTROY]
2016-05-05 14:13:02.268768 [DEBUG] switch_core_state_machine.c:700 (sofia/external/anonymous@anonymous.invalid) Running State Change CS_DESTROY
2016-05-05 14:13:02.268768 [DEBUG] switch_core_state_machine.c:710 (sofia/external/anonymous@anonymous.invalid) State DESTROY
2016-05-05 14:13:02.268768 [DEBUG] mod_sofia.c:342 sofia/external/anonymous@anonymous.invalid SOFIA DESTROY
2016-05-05 14:13:02.268768 [DEBUG] switch_core_state_machine.c:181 sofia/external/anonymous@anonymous.invalid Standard DESTROY
2016-05-05 14:13:02.268768 [DEBUG] switch_core_state_machine.c:710 (sofia/external/anonymous@anonymous.invalid) State DESTROY going to sleep
2016-05-05 14:13:03.108776 [WARNING] sofia.c:5912 Ping succeeded OpenSIPS-Front-2 with code 484 - count 1/1/1, state UP
2016-05-05 14:13:03.108776 [WARNING] sofia.c:5912 Ping succeeded OpenSIPS-Front-1 with code 484 - count 1/1/1, state UP
2016-05-05 14:13:05.148771 [NOTICE] switch_channel.c:1104 New Channel sofia/external/anonymous@anonymous.invalid [7c23a432-12cb-11e6-b694-75ea2a7b416e]
2016-05-05 14:13:05.148771 [DEBUG] switch_core_state_machine.c:543 (sofia/external/anonymous@anonymous.invalid) Running State Change CS_NEW
2016-05-05 14:13:05.148771 [DEBUG] sofia.c:9376 sofia/external/anonymous@anonymous.invalid receiving invite from
10.0.0.4:5060 version: 1.7.0 git 6fc6efa 2016-05-03 02:03:34Z 64bit
2016-05-05 14:13:05.148771 [DEBUG] sofia.c:6858 Channel sofia/external/anonymous@anonymous.invalid entering state [received][100]
2016-05-05 14:13:05.148771 [DEBUG] sofia.c:6868 Remote SDP:
v=0
o=cp10 146245758681 146245758681 IN IP4 10.7.16.156
s=SIP Call
c=IN IP4 91.121.129.144
t=0 0
m=audio 35112 RTP/AVP 18 0 8 101
b=AS:21
a=rtpmap:18 G729/8000/1
a=fmtp:18 annexb=no
a=rtpmap:0 PCMU/8000/1
a=rtpmap:8 PCMA/8000/1
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:30
2016-05-05 14:13:05.148771 [DEBUG] sofia.c:7227 (sofia/external/anonymous@anonymous.invalid) State Change CS_NEW -> CS_INIT
2016-05-05 14:13:05.148771 [DEBUG] switch_core_state_machine.c:562 (sofia/external/anonymous@anonymous.invalid) State NEW
2016-05-05 14:13:05.148771 [DEBUG] switch_core_state_machine.c:543 (sofia/external/anonymous@anonymous.invalid) Running State Change CS_INIT
2016-05-05 14:13:05.148771 [DEBUG] switch_core_state_machine.c:586 (sofia/external/anonymous@anonymous.invalid) State INIT
2016-05-05 14:13:05.148771 [DEBUG] mod_sofia.c:89 sofia/external/anonymous@anonymous.invalid SOFIA INIT
2016-05-05 14:13:05.148771 [DEBUG] switch_core_state_machine.c:40 sofia/external/anonymous@anonymous.invalid Standard INIT
2016-05-05 14:13:05.148771 [DEBUG] switch_core_state_machine.c:48 (sofia/external/anonymous@anonymous.invalid) State Change CS_INIT -> CS_ROUTING
2016-05-05 14:13:05.148771 [DEBUG] switch_core_state_machine.c:586 (sofia/external/anonymous@anonymous.invalid) State INIT going to sleep
2016-05-05 14:13:05.148771 [DEBUG] switch_core_state_machine.c:543 (sofia/external/anonymous@anonymous.invalid) Running State Change CS_ROUTING
2016-05-05 14:13:05.148771 [DEBUG] switch_channel.c:2249 (sofia/external/anonymous@anonymous.invalid) Callstate Change DOWN -> RINGING
2016-05-05 14:13:05.148771 [DEBUG] switch_core_state_machine.c:602 (sofia/external/anonymous@anonymous.invalid) State ROUTING
2016-05-05 14:13:05.148771 [DEBUG] mod_sofia.c:142 sofia/external/anonymous@anonymous.invalid SOFIA ROUTING
2016-05-05 14:13:05.148771 [DEBUG] switch_core_state_machine.c:236 sofia/external/anonymous@anonymous.invalid Standard ROUTING
2016-05-05 14:13:05.148771 [INFO] mod_dialplan_xml.c:637 Processing Anonymous <anonymous>->opensips in context public
Dialplan: sofia/external/anonymous@anonymous.invalid parsing [public->unloop] continue=false
Dialplan: sofia/external/anonymous@anonymous.invalid Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
Dialplan: sofia/external/anonymous@anonymous.invalid Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
Dialplan: sofia/external/anonymous@anonymous.invalid parsing [public->outside_call] continue=true
Dialplan: sofia/external/anonymous@anonymous.invalid Absolute Condition [outside_call]
Dialplan: sofia/external/anonymous@anonymous.invalid Action set(outside_call=true)
Dialplan: sofia/external/anonymous@anonymous.invalid Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
Dialplan: sofia/external/anonymous@anonymous.invalid parsing [public->call_debug] continue=true
Dialplan: sofia/external/anonymous@anonymous.invalid Regex (FAIL) [call_debug] ${call_debug}(false) =~ /^true$/ break=never
Dialplan: sofia/external/anonymous@anonymous.invalid parsing [public->public_extensions] continue=false
Dialplan: sofia/external/anonymous@anonymous.invalid Regex (FAIL) [public_extensions] destination_number(opensips) =~ /^(10[01][0-9])$/ break=on-false
Dialplan: sofia/external/anonymous@anonymous.invalid parsing [public->public_did] continue=false
Dialplan: sofia/external/anonymous@anonymous.invalid Regex (PASS) [public_did] ${sip_to_user}(0972550428) =~ /(972550428)$/ break=on-false
Dialplan: sofia/external/anonymous@anonymous.invalid Action set(group_confirm_file=javascript monScript.js)
2016-05-05 14:13:05.148771 [DEBUG] switch_core_state_machine.c:286 (sofia/external/anonymous@anonymous.invalid) State Change CS_ROUTING -> CS_EXECUTE
2016-05-05 14:13:05.148771 [DEBUG] switch_core_state_machine.c:602 (sofia/external/anonymous@anonymous.invalid) State ROUTING going to sleep
2016-05-05 14:13:05.148771 [DEBUG] switch_core_state_machine.c:543 (sofia/external/anonymous@anonymous.invalid) Running State Change CS_EXECUTE
2016-05-05 14:13:05.148771 [DEBUG] switch_core_state_machine.c:609 (sofia/external/anonymous@anonymous.invalid) State EXECUTE
2016-05-05 14:13:05.148771 [DEBUG] mod_sofia.c:197 sofia/external/anonymous@anonymous.invalid SOFIA EXECUTE
2016-05-05 14:13:05.148771 [DEBUG] switch_core_state_machine.c:328 sofia/external/anonymous@anonymous.invalid Standard EXECUTE
EXECUTE sofia/external/anonymous@anonymous.invalid set(outside_call=true)
2016-05-05 14:13:05.148771 [DEBUG] mod_dptools.c:1519 SET sofia/external/anonymous@anonymous.invalid [outside_call]=[true]
EXECUTE sofia/external/anonymous@anonymous.invalid export(RFC2822_DATE=Thu, 05 May 2016 14:13:05 +0000)
2016-05-05 14:13:05.148771 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [RFC2822_DATE]=[Thu, 05 May 2016 14:13:05 +0000]
EXECUTE sofia/external/anonymous@anonymous.invalid set(group_confirm_file=javascript monScript.js)
2016-05-05 14:13:05.148771 [DEBUG] mod_dptools.c:1519 SET sofia/external/anonymous@anonymous.invalid [group_confirm_file]=[javascript monScript.js]
2016-05-05 14:13:05.148771 [NOTICE] switch_core_state_machine.c:385 sofia/external/anonymous@anonymous.invalid has executed the last dialplan instruction, hanging up.
2016-05-05 14:13:05.148771 [NOTICE] switch_core_state_machine.c:387 Hangup sofia/external/anonymous@anonymous.invalid [CS_EXECUTE] [NORMAL_CLEARING]
2016-05-05 14:13:05.148771 [DEBUG] switch_core_state_machine.c:609 (sofia/external/anonymous@anonymous.invalid) State EXECUTE going to sleep
2016-05-05 14:13:05.148771 [DEBUG] switch_core_state_machine.c:543 (sofia/external/anonymous@anonymous.invalid) Running State Change CS_HANGUP
2016-05-05 14:13:05.148771 [DEBUG] switch_core_state_machine.c:809 (sofia/external/anonymous@anonymous.invalid) Callstate Change RINGING -> HANGUP
2016-05-05 14:13:05.148771 [DEBUG] switch_core_state_machine.c:811 (sofia/external/anonymous@anonymous.invalid) State HANGUP
2016-05-05 14:13:05.148771 [DEBUG] mod_sofia.c:437 Channel sofia/external/anonymous@anonymous.invalid hanging up, cause: NORMAL_CLEARING
2016-05-05 14:13:05.148771 [DEBUG] mod_sofia.c:574
Responding to INVITE with: 4802016-05-05 14:13:05.148771 [DEBUG] switch_core_state_machine.c:60 sofia/external/anonymous@anonymous.invalid Standard HANGUP, cause: NORMAL_CLEARING
2016-05-05 14:13:05.148771 [DEBUG] switch_core_state_machine.c:811 (sofia/external/anonymous@anonymous.invalid) State HANGUP going to sleep
2016-05-05 14:13:05.148771 [DEBUG] switch_core_state_machine.c:578 (sofia/external/anonymous@anonymous.invalid) State Change CS_HANGUP -> CS_REPORTING
2016-05-05 14:13:05.148771 [DEBUG] switch_core_state_machine.c:543 (sofia/external/anonymous@anonymous.invalid) Running State Change CS_REPORTING
2016-05-05 14:13:05.148771 [DEBUG] switch_core_state_machine.c:897 (sofia/external/anonymous@anonymous.invalid) State REPORTING
2016-05-05 14:13:05.148771 [DEBUG] switch_core_state_machine.c:174 sofia/external/anonymous@anonymous.invalid Standard REPORTING, cause: NORMAL_CLEARING
2016-05-05 14:13:05.148771 [DEBUG] switch_core_state_machine.c:897 (sofia/external/anonymous@anonymous.invalid) State REPORTING going to sleep
2016-05-05 14:13:05.148771 [DEBUG] switch_core_state_machine.c:569 (sofia/external/anonymous@anonymous.invalid) State Change CS_REPORTING -> CS_DESTROY
2016-05-05 14:13:05.148771 [DEBUG] switch_core_session.c:1646 Session 49 (sofia/external/anonymous@anonymous.invalid) Locked, Waiting on external entities
2016-05-05 14:13:05.148771 [NOTICE] switch_core_session.c:1664 Session 49 (sofia/external/anonymous@anonymous.invalid) Ended
2016-05-05 14:13:05.148771 [NOTICE] switch_core_session.c:1668 Close Channel sofia/external/anonymous@anonymous.invalid [CS_DESTROY]
2016-05-05 14:13:05.148771 [DEBUG] switch_core_state_machine.c:700 (sofia/external/anonymous@anonymous.invalid) Running State Change CS_DESTROY
2016-05-05 14:13:05.148771 [DEBUG] switch_core_state_machine.c:710 (sofia/external/anonymous@anonymous.invalid) State DESTROY
2016-05-05 14:13:05.148771 [DEBUG] mod_sofia.c:342 sofia/external/anonymous@anonymous.invalid SOFIA DESTROY
2016-05-05 14:13:05.148771 [DEBUG] switch_core_state_machine.c:181 sofia/external/anonymous@anonymous.invalid Standard DESTROY
2016-05-05 14:13:05.148771 [DEBUG] switch_core_state_machine.c:710 (sofia/external/anonymous@anonymous.invalid) State DESTROY going to sleep
2016-05-05 14:13:07.828788 [NOTICE] switch_channel.c:1104 New Channel sofia/external/anonymous@anonymous.invalid [7db92498-12cb-11e6-b699-75ea2a7b416e]
2016-05-05 14:13:07.828788 [DEBUG] switch_core_state_machine.c:543 (sofia/external/anonymous@anonymous.invalid) Running State Change CS_NEW
2016-05-05 14:13:07.828788 [DEBUG] sofia.c:9376 sofia/external/anonymous@anonymous.invalid receiving invite from
10.0.0.4:5060 version: 1.7.0 git 6fc6efa 2016-05-03 02:03:34Z 64bit
2016-05-05 14:13:07.828788 [DEBUG] sofia.c:6858 Channel sofia/external/anonymous@anonymous.invalid entering state [received][100]
2016-05-05 14:13:07.828788 [DEBUG] sofia.c:6868 Remote SDP:
v=0
o=cp10 146245758905 146245758905 IN IP4 10.7.1.121
s=SIP Call
c=IN IP4 91.121.129.155
t=0 0
m=audio 35684 RTP/AVP 18 4 0 8 125 111 101
b=AS:21
a=rtpmap:18 G729/8000/1
a=fmtp:18 annexb=no
a=rtpmap:4 G723/8000/1
a=fmtp:4 annexa=no
a=rtpmap:0 PCMU/8000/1
a=rtpmap:8 PCMA/8000/1
a=rtpmap:125 CLEARMODE/8000/1
a=rtpmap:111 iLBC/8000/1
a=fmtp:111 mode=30
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:30
2016-05-05 14:13:07.828788 [DEBUG] sofia.c:7227 (sofia/external/anonymous@anonymous.invalid) State Change CS_NEW -> CS_INIT
2016-05-05 14:13:07.828788 [DEBUG] switch_core_state_machine.c:562 (sofia/external/anonymous@anonymous.invalid) State NEW
2016-05-05 14:13:07.828788 [DEBUG] switch_core_state_machine.c:543 (sofia/external/anonymous@anonymous.invalid) Running State Change CS_INIT
2016-05-05 14:13:07.828788 [DEBUG] switch_core_state_machine.c:586 (sofia/external/anonymous@anonymous.invalid) State INIT
2016-05-05 14:13:07.828788 [DEBUG] mod_sofia.c:89 sofia/external/anonymous@anonymous.invalid SOFIA INIT
2016-05-05 14:13:07.828788 [DEBUG] switch_core_state_machine.c:40 sofia/external/anonymous@anonymous.invalid Standard INIT
2016-05-05 14:13:07.828788 [DEBUG] switch_core_state_machine.c:48 (sofia/external/anonymous@anonymous.invalid) State Change CS_INIT -> CS_ROUTING
2016-05-05 14:13:07.828788 [DEBUG] switch_core_state_machine.c:586 (sofia/external/anonymous@anonymous.invalid) State INIT going to sleep
2016-05-05 14:13:07.828788 [DEBUG] switch_core_state_machine.c:543 (sofia/external/anonymous@anonymous.invalid) Running State Change CS_ROUTING
2016-05-05 14:13:07.828788 [DEBUG] switch_channel.c:2249 (sofia/external/anonymous@anonymous.invalid) Callstate Change DOWN -> RINGING
2016-05-05 14:13:07.828788 [DEBUG] switch_core_state_machine.c:602 (sofia/external/anonymous@anonymous.invalid) State ROUTING
2016-05-05 14:13:07.828788 [DEBUG] mod_sofia.c:142 sofia/external/anonymous@anonymous.invalid SOFIA ROUTING
2016-05-05 14:13:07.828788 [DEBUG] switch_core_state_machine.c:236 sofia/external/anonymous@anonymous.invalid Standard ROUTING
2016-05-05 14:13:07.828788 [INFO] mod_dialplan_xml.c:637 Processing Anonymous <anonymous>->opensips in context public
Dialplan: sofia/external/anonymous@anonymous.invalid parsing [public->unloop] continue=false
Dialplan: sofia/external/anonymous@anonymous.invalid Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
Dialplan: sofia/external/anonymous@anonymous.invalid Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
Dialplan: sofia/external/anonymous@anonymous.invalid parsing [public->outside_call] continue=true
Dialplan: sofia/external/anonymous@anonymous.invalid Absolute Condition [outside_call]
Dialplan: sofia/external/anonymous@anonymous.invalid Action set(outside_call=true)
Dialplan: sofia/external/anonymous@anonymous.invalid Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
Dialplan: sofia/external/anonymous@anonymous.invalid parsing [public->call_debug] continue=true
Dialplan: sofia/external/anonymous@anonymous.invalid Regex (FAIL) [call_debug] ${call_debug}(false) =~ /^true$/ break=never
Dialplan: sofia/external/anonymous@anonymous.invalid parsing [public->public_extensions] continue=false
Dialplan: sofia/external/anonymous@anonymous.invalid Regex (FAIL) [public_extensions] destination_number(opensips) =~ /^(10[01][0-9])$/ break=on-false
Dialplan: sofia/external/anonymous@anonymous.invalid parsing [public->public_did] continue=false
Dialplan: sofia/external/anonymous@anonymous.invalid Regex (PASS) [public_did] ${sip_to_user}(0972550428) =~ /(972550428)$/ break=on-false
Dialplan: sofia/external/anonymous@anonymous.invalid Action set(group_confirm_file=javascript monScript.js)
2016-05-05 14:13:07.828788 [DEBUG] switch_core_state_machine.c:286 (sofia/external/anonymous@anonymous.invalid) State Change CS_ROUTING -> CS_EXECUTE
2016-05-05 14:13:07.828788 [DEBUG] switch_core_state_machine.c:602 (sofia/external/anonymous@anonymous.invalid) State ROUTING going to sleep
2016-05-05 14:13:07.828788 [DEBUG] switch_core_state_machine.c:543 (sofia/external/anonymous@anonymous.invalid) Running State Change CS_EXECUTE
2016-05-05 14:13:07.828788 [DEBUG] switch_core_state_machine.c:609 (sofia/external/anonymous@anonymous.invalid) State EXECUTE
2016-05-05 14:13:07.828788 [DEBUG] mod_sofia.c:197 sofia/external/anonymous@anonymous.invalid SOFIA EXECUTE
2016-05-05 14:13:07.828788 [DEBUG] switch_core_state_machine.c:328 sofia/external/anonymous@anonymous.invalid Standard EXECUTE
EXECUTE sofia/external/anonymous@anonymous.invalid set(outside_call=true)
2016-05-05 14:13:07.828788 [DEBUG] mod_dptools.c:1519 SET sofia/external/anonymous@anonymous.invalid [outside_call]=[true]
EXECUTE sofia/external/anonymous@anonymous.invalid export(RFC2822_DATE=Thu, 05 May 2016 14:13:07 +0000)
2016-05-05 14:13:07.828788 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [RFC2822_DATE]=[Thu, 05 May 2016 14:13:07 +0000]
EXECUTE sofia/external/anonymous@anonymous.invalid set(group_confirm_file=javascript monScript.js)
2016-05-05 14:13:07.828788 [DEBUG] mod_dptools.c:1519 SET sofia/external/anonymous@anonymous.invalid [group_confirm_file]=[javascript monScript.js]
2016-05-05 14:13:07.828788 [NOTICE] switch_core_state_machine.c:385 sofia/external/anonymous@anonymous.invalid has executed the last dialplan instruction, hanging up.
2016-05-05 14:13:07.828788 [NOTICE] switch_core_state_machine.c:387 Hangup sofia/external/anonymous@anonymous.invalid [CS_EXECUTE] [NORMAL_CLEARING]
2016-05-05 14:13:07.828788 [DEBUG] switch_core_state_machine.c:609 (sofia/external/anonymous@anonymous.invalid) State EXECUTE going to sleep
2016-05-05 14:13:07.828788 [DEBUG] switch_core_state_machine.c:543 (sofia/external/anonymous@anonymous.invalid) Running State Change CS_HANGUP
2016-05-05 14:13:07.828788 [DEBUG] switch_core_state_machine.c:809 (sofia/external/anonymous@anonymous.invalid) Callstate Change RINGING -> HANGUP
2016-05-05 14:13:07.828788 [DEBUG] switch_core_state_machine.c:811 (sofia/external/anonymous@anonymous.invalid) State HANGUP
2016-05-05 14:13:07.828788 [DEBUG] mod_sofia.c:437 Channel sofia/external/anonymous@anonymous.invalid hanging up, cause: NORMAL_CLEARING
2016-05-05 14:13:07.828788 [DEBUG] mod_sofia.c:574
Responding to INVITE with: 4802016-05-05 14:13:07.828788 [DEBUG] switch_core_state_machine.c:60 sofia/external/anonymous@anonymous.invalid Standard HANGUP, cause: NORMAL_CLEARING
2016-05-05 14:13:07.828788 [DEBUG] switch_core_state_machine.c:811 (sofia/external/anonymous@anonymous.invalid) State HANGUP going to sleep
2016-05-05 14:13:07.828788 [DEBUG] switch_core_state_machine.c:578 (sofia/external/anonymous@anonymous.invalid) State Change CS_HANGUP -> CS_REPORTING
2016-05-05 14:13:07.828788 [DEBUG] switch_core_state_machine.c:543 (sofia/external/anonymous@anonymous.invalid) Running State Change CS_REPORTING
2016-05-05 14:13:07.828788 [DEBUG] switch_core_state_machine.c:897 (sofia/external/anonymous@anonymous.invalid) State REPORTING
2016-05-05 14:13:07.828788 [DEBUG] switch_core_state_machine.c:174 sofia/external/anonymous@anonymous.invalid Standard REPORTING, cause: NORMAL_CLEARING
2016-05-05 14:13:07.828788 [DEBUG] switch_core_state_machine.c:897 (sofia/external/anonymous@anonymous.invalid) State REPORTING going to sleep
2016-05-05 14:13:07.828788 [DEBUG] switch_core_state_machine.c:569 (sofia/external/anonymous@anonymous.invalid) State Change CS_REPORTING -> CS_DESTROY
2016-05-05 14:13:07.828788 [DEBUG] switch_core_session.c:1646 Session 50 (sofia/external/anonymous@anonymous.invalid) Locked, Waiting on external entities
2016-05-05 14:13:07.828788 [NOTICE] switch_core_session.c:1664 Session 50 (sofia/external/anonymous@anonymous.invalid) Ended
2016-05-05 14:13:07.828788 [NOTICE] switch_core_session.c:1668 Close Channel sofia/external/anonymous@anonymous.invalid [CS_DESTROY]
2016-05-05 14:13:07.828788 [DEBUG] switch_core_state_machine.c:700 (sofia/external/anonymous@anonymous.invalid) Running State Change CS_DESTROY
2016-05-05 14:13:07.828788 [DEBUG] switch_core_state_machine.c:710 (sofia/external/anonymous@anonymous.invalid) State DESTROY
2016-05-05 14:13:07.828788 [DEBUG] mod_sofia.c:342 sofia/external/anonymous@anonymous.invalid SOFIA DESTROY
2016-05-05 14:13:07.828788 [DEBUG] switch_core_state_machine.c:181 sofia/external/anonymous@anonymous.invalid Standard DESTROY
2016-05-05 14:13:07.828788 [DEBUG] switch_core_state_machine.c:710 (sofia/external/anonymous@anonymous.invalid) State DESTROY going to sleep
freeswitch@back-1>
root@back-1:/usr/local/freeswitch/bin# ./fs_cl