freeswitch@FusionPBX> 2017-07-12 20:47:56.192103 [NOTICE] switch_channel.c:1104 New Channel sofia/external/+447966199326@147.152.17.90 [dd919526-461b-4431-b986-ee8a5c9a4d13] 2017-07-12 20:47:56.192103 [DEBUG] switch_core_state_machine.c:584 (sofia/external/+447966199326@147.152.17.90) Running State Change CS_NEW (Cur 5 Tot 93175) 2017-07-12 20:47:56.192103 [DEBUG] sofia.c:9819 sofia/external/+447966199326@147.152.17.90 receiving invite from 172.20.1.21:5060 version: 1.6.15 -32-bec4538 64bit 2017-07-12 20:47:56.192103 [DEBUG] sofia.c:7042 Channel sofia/external/+447966199326@147.152.17.90 entering state [received][100] 2017-07-12 20:47:56.192103 [DEBUG] sofia.c:7052 Remote SDP: v=0 o=- 2181018976 1006 IN IP4 172.20.1.21 s=- c=IN IP4 172.20.1.21 t=0 0 m=audio 39730 RTP/AVP 8 a=rtpmap:8 PCMA/8000 a=ptime:20 2017-07-12 20:47:56.192103 [DEBUG] switch_core_media.c:4400 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1] 2017-07-12 20:47:56.192103 [DEBUG] switch_core_media.c:4400 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1] 2017-07-12 20:47:56.192103 [DEBUG] switch_core_media.c:4400 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1] 2017-07-12 20:47:56.192103 [DEBUG] switch_core_media.c:4455 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match 2017-07-12 20:47:56.192103 [DEBUG] switch_core_media.c:4400 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[GSM:3:8000:20:13200:1] 2017-07-12 20:47:56.192103 [DEBUG] switch_core_media.c:3047 Set Codec sofia/external/+447966199326@147.152.17.90 PCMA/8000 20 ms 160 samples 64000 bits 1 channels 2017-07-12 20:47:56.192103 [DEBUG] switch_core_codec.c:111 sofia/external/+447966199326@147.152.17.90 Original read codec set to PCMA:8 2017-07-12 20:47:56.192103 [DEBUG] switch_core_media.c:4725 No 2833 in SDP. Disable 2833 dtmf and switch to INFO 2017-07-12 20:47:56.192103 [DEBUG] sofia.c:7465 (sofia/external/+447966199326@147.152.17.90) State Change CS_NEW -> CS_INIT 2017-07-12 20:47:56.192103 [DEBUG] switch_core_state_machine.c:603 (sofia/external/+447966199326@147.152.17.90) State NEW 2017-07-12 20:47:56.192103 [DEBUG] switch_core_state_machine.c:584 (sofia/external/+447966199326@147.152.17.90) Running State Change CS_INIT (Cur 5 Tot 93175) 2017-07-12 20:47:56.192103 [DEBUG] switch_core_state_machine.c:627 (sofia/external/+447966199326@147.152.17.90) State INIT 2017-07-12 20:47:56.192103 [DEBUG] mod_sofia.c:90 sofia/external/+447966199326@147.152.17.90 SOFIA INIT 2017-07-12 20:47:56.192103 [DEBUG] switch_core_state_machine.c:40 sofia/external/+447966199326@147.152.17.90 Standard INIT 2017-07-12 20:47:56.192103 [DEBUG] switch_core_state_machine.c:48 (sofia/external/+447966199326@147.152.17.90) State Change CS_INIT -> CS_ROUTING 2017-07-12 20:47:56.192103 [DEBUG] switch_core_state_machine.c:627 (sofia/external/+447966199326@147.152.17.90) State INIT going to sleep 2017-07-12 20:47:56.192103 [DEBUG] switch_core_state_machine.c:584 (sofia/external/+447966199326@147.152.17.90) Running State Change CS_ROUTING (Cur 5 Tot 93175) 2017-07-12 20:47:56.192103 [DEBUG] switch_channel.c:2249 (sofia/external/+447966199326@147.152.17.90) Callstate Change DOWN -> RINGING 2017-07-12 20:47:56.192103 [DEBUG] switch_core_state_machine.c:643 (sofia/external/+447966199326@147.152.17.90) State ROUTING 2017-07-12 20:47:56.192103 [DEBUG] mod_sofia.c:143 sofia/external/+447966199326@147.152.17.90 SOFIA ROUTING 2017-07-12 20:47:56.192103 [DEBUG] switch_core_state_machine.c:236 sofia/external/+447966199326@147.152.17.90 Standard ROUTING 2017-07-12 20:47:56.192103 [INFO] mod_dialplan_xml.c:637 Processing +447966199326 <+447966199326>->442035518604 in context public Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [public->441254846319] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [441254846319] destination_number(442035518604) =~ /^(441254846319)$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [public->441254846561] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [441254846561] destination_number(442035518604) =~ /^(441254846561)$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [public->441313461991] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [441313461991] destination_number(442035518604) =~ /^(441313461991)$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [public->441491877961] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [441491877961] destination_number(442035518604) =~ /^(441491877961)$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [public->441753424245] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [441753424245] destination_number(442035518604) =~ /^(441753424245)$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [public->441753569041] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [441753569041] destination_number(442035518604) =~ /^(441753569041)$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [public->441753569056] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [441753569056] destination_number(442035518604) =~ /^(441753569056)$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [public->441753569057] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [441753569057] destination_number(442035518604) =~ /^(441753569057)$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [public->442035518604] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (PASS) [442035518604] destination_number(442035518604) =~ /^(442035518604)$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 Action set(call_direction=inbound) INLINE EXECUTE sofia/external/+447966199326@147.152.17.90 set(call_direction=inbound) 2017-07-12 20:47:56.192103 [DEBUG] mod_dptools.c:1527 SET sofia/external/+447966199326@147.152.17.90 [call_direction]=[inbound] Dialplan: sofia/external/+447966199326@147.152.17.90 Action set(domain_uuid=2d6ce0f1-2388-4ee5-8112-86c5877dd77b) INLINE EXECUTE sofia/external/+447966199326@147.152.17.90 set(domain_uuid=2d6ce0f1-2388-4ee5-8112-86c5877dd77b) 2017-07-12 20:47:56.192103 [DEBUG] mod_dptools.c:1527 SET sofia/external/+447966199326@147.152.17.90 [domain_uuid]=[2d6ce0f1-2388-4ee5-8112-86c5877dd77b] Dialplan: sofia/external/+447966199326@147.152.17.90 Action set(domain_name=tdl.xcesstelecom.com) INLINE EXECUTE sofia/external/+447966199326@147.152.17.90 set(domain_name=tdl.xcesstelecom.com) 2017-07-12 20:47:56.192103 [DEBUG] mod_dptools.c:1527 SET sofia/external/+447966199326@147.152.17.90 [domain_name]=[tdl.xcesstelecom.com] Dialplan: sofia/external/+447966199326@147.152.17.90 Action translate(${caller_id_name} e164_to_GB) Dialplan: sofia/external/+447966199326@147.152.17.90 Action set(effective_caller_id_name=DID#${translated}) Dialplan: sofia/external/+447966199326@147.152.17.90 Action set(effective_caller_id_number=${translated}) Dialplan: sofia/external/+447966199326@147.152.17.90 Action transfer(5000 XML tdl.xcesstelecom.com) 2017-07-12 20:47:56.192103 [DEBUG] switch_core_state_machine.c:286 (sofia/external/+447966199326@147.152.17.90) State Change CS_ROUTING -> CS_EXECUTE 2017-07-12 20:47:56.192103 [DEBUG] switch_core_state_machine.c:643 (sofia/external/+447966199326@147.152.17.90) State ROUTING going to sleep 2017-07-12 20:47:56.192103 [DEBUG] switch_core_state_machine.c:584 (sofia/external/+447966199326@147.152.17.90) Running State Change CS_EXECUTE (Cur 5 Tot 93175) 2017-07-12 20:47:56.192103 [DEBUG] switch_core_state_machine.c:650 (sofia/external/+447966199326@147.152.17.90) State EXECUTE 2017-07-12 20:47:56.192103 [DEBUG] mod_sofia.c:198 sofia/external/+447966199326@147.152.17.90 SOFIA EXECUTE 2017-07-12 20:47:56.192103 [DEBUG] switch_core_state_machine.c:328 sofia/external/+447966199326@147.152.17.90 Standard EXECUTE EXECUTE sofia/external/+447966199326@147.152.17.90 translate(+447966199326 e164_to_GB) 2017-07-12 20:47:56.192103 [DEBUG] mod_translate.c:128 translating [+447966199326] against [e164_to_GB] profile 2017-07-12 20:47:56.192103 [DEBUG] mod_translate.c:137 +447966199326 =~ /^(anonymous)$/ 2017-07-12 20:47:56.192103 [DEBUG] mod_translate.c:137 +447966199326 =~ /^44(\d{3,6})$/ 2017-07-12 20:47:56.192103 [DEBUG] mod_translate.c:137 +447966199326 =~ /^\+?44(\d+)$/ 2017-07-12 20:47:56.192103 [NOTICE] mod_translate.c:249 Translated: 07966199326 EXECUTE sofia/external/+447966199326@147.152.17.90 set(effective_caller_id_name=DID#07966199326) 2017-07-12 20:47:56.192103 [DEBUG] mod_dptools.c:1527 SET sofia/external/+447966199326@147.152.17.90 [effective_caller_id_name]=[DID#07966199326] EXECUTE sofia/external/+447966199326@147.152.17.90 set(effective_caller_id_number=07966199326) 2017-07-12 20:47:56.192103 [DEBUG] mod_dptools.c:1527 SET sofia/external/+447966199326@147.152.17.90 [effective_caller_id_number]=[07966199326] EXECUTE sofia/external/+447966199326@147.152.17.90 transfer(5000 XML tdl.xcesstelecom.com) 2017-07-12 20:47:56.192103 [DEBUG] switch_ivr.c:2160 (sofia/external/+447966199326@147.152.17.90) State Change CS_EXECUTE -> CS_ROUTING 2017-07-12 20:47:56.192103 [NOTICE] switch_ivr.c:2167 Transfer sofia/external/+447966199326@147.152.17.90 to XML[5000@tdl.xcesstelecom.com] 2017-07-12 20:47:56.192103 [DEBUG] switch_core_state_machine.c:650 (sofia/external/+447966199326@147.152.17.90) State EXECUTE going to sleep 2017-07-12 20:47:56.192103 [DEBUG] switch_core_state_machine.c:584 (sofia/external/+447966199326@147.152.17.90) Running State Change CS_ROUTING (Cur 5 Tot 93175) 2017-07-12 20:47:56.192103 [DEBUG] switch_core_state_machine.c:643 (sofia/external/+447966199326@147.152.17.90) State ROUTING 2017-07-12 20:47:56.192103 [DEBUG] mod_sofia.c:143 sofia/external/+447966199326@147.152.17.90 SOFIA ROUTING 2017-07-12 20:47:56.192103 [DEBUG] switch_core_state_machine.c:236 sofia/external/+447966199326@147.152.17.90 Standard ROUTING 2017-07-12 20:47:56.192103 [INFO] mod_dialplan_xml.c:637 Processing +447966199326 <+447966199326>->5000 in context tdl.xcesstelecom.com 2017-07-12 20:47:56.192103 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7f572809f810 Connected. 2017-07-12 20:47:56.252040 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7f572809f810 released. Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->user_exists] continue=true Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (PASS) [user_exists] () =~ // break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 Action set(user_exists=${user_exists id ${destination_number} ${domain_name}}) INLINE EXECUTE sofia/external/+447966199326@147.152.17.90 set(user_exists=true) 2017-07-12 20:47:56.252040 [DEBUG] mod_dptools.c:1527 SET sofia/external/+447966199326@147.152.17.90 [user_exists]=[true] Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (PASS) [user_exists] ${user_exists}(true) =~ /^true$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 Action set(extension_uuid=${user_data ${destination_number}@${domain_name} var extension_uuid}) Dialplan: sofia/external/+447966199326@147.152.17.90 Action set(hold_music=${user_data ${destination_number}@${domain_name} var hold_music}) Dialplan: sofia/external/+447966199326@147.152.17.90 Action set(forward_all_enabled=${user_data ${destination_number}@${domain_name} var forward_all_enabled}) Dialplan: sofia/external/+447966199326@147.152.17.90 Action set(forward_all_destination=${user_data ${destination_number}@${domain_name} var forward_all_destination}) Dialplan: sofia/external/+447966199326@147.152.17.90 Action set(forward_busy_enabled=${user_data ${destination_number}@${domain_name} var forward_busy_enabled}) Dialplan: sofia/external/+447966199326@147.152.17.90 Action set(forward_busy_destination=${user_data ${destination_number}@${domain_name} var forward_busy_destination}) Dialplan: sofia/external/+447966199326@147.152.17.90 Action set(forward_no_answer_enabled=${user_data ${destination_number}@${domain_name} var forward_no_answer_enabled}) Dialplan: sofia/external/+447966199326@147.152.17.90 Action set(forward_no_answer_destination=${user_data ${destination_number}@${domain_name} var forward_no_answer_destination}) Dialplan: sofia/external/+447966199326@147.152.17.90 Action set(forward_user_not_registered_enabled=${user_data ${destination_number}@${domain_name} var forward_user_not_registered_enabled}) Dialplan: sofia/external/+447966199326@147.152.17.90 Action set(forward_user_not_registered_destination=${user_data ${destination_number}@${domain_name} var forward_user_not_registered_destination}) Dialplan: sofia/external/+447966199326@147.152.17.90 Action set(do_not_disturb=${user_data ${destination_number}@${domain_name} var do_not_disturb}) Dialplan: sofia/external/+447966199326@147.152.17.90 Action set(call_timeout=${user_data ${destination_number}@${domain_name} var call_timeout}) Dialplan: sofia/external/+447966199326@147.152.17.90 Action set(missed_call_app=${user_data ${destination_number}@${domain_name} var missed_call_app}) Dialplan: sofia/external/+447966199326@147.152.17.90 Action set(missed_call_data=${user_data ${destination_number}@${domain_name} var missed_call_data}) Dialplan: sofia/external/+447966199326@147.152.17.90 Action set(call_screen_enabled=${user_data ${destination_number}@${domain_name} var call_screen_enabled}) INLINE EXECUTE sofia/external/+447966199326@147.152.17.90 set(call_screen_enabled=false) 2017-07-12 20:47:56.252040 [DEBUG] mod_dptools.c:1527 SET sofia/external/+447966199326@147.152.17.90 [call_screen_enabled]=[false] Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->call-direction] continue=true Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (PASS) [call-direction] ${call_direction}(inbound) =~ /^(inbound|outbound|local)$/ break=never Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->variables] continue=true Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (PASS) [variables] () =~ // break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 Action export(origination_callee_id_name=${destination_number}) Dialplan: sofia/external/+447966199326@147.152.17.90 Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)}) Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->user_record] continue=true Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (PASS) [user_record] () =~ // break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 Action set(user_record=${user_data ${destination_number}@${domain_name} var user_record}) INLINE EXECUTE sofia/external/+447966199326@147.152.17.90 set(user_record=) 2017-07-12 20:47:56.252040 [DEBUG] mod_dptools.c:1527 SET sofia/external/+447966199326@147.152.17.90 [user_record]=[UNDEF] Dialplan: sofia/external/+447966199326@147.152.17.90 Action set(from_user_exists=${user_exists id ${sip_from_user} ${sip_from_host}}) INLINE 2017-07-12 20:47:56.271967 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7f572809f810 Connected. 2017-07-12 20:47:56.271967 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7f572809f810 released. EXECUTE sofia/external/+447966199326@147.152.17.90 set(from_user_exists=false) 2017-07-12 20:47:56.271967 [DEBUG] mod_dptools.c:1527 SET sofia/external/+447966199326@147.152.17.90 [from_user_exists]=[false] Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (PASS) [user_record] ${user_exists}(true) =~ /^true$/ break=never Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [user_record] ${user_record}() =~ /^all$/ break=never Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (PASS) [user_record] ${user_exists}(true) =~ /^true$/ break=never Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (PASS) [user_record] ${call_direction}(inbound) =~ /^inbound$/ break=never Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [user_record] ${user_record}() =~ /^inbound$/ break=never Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (PASS) [user_record] ${user_exists}(true) =~ /^true$/ break=never Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^outbound$/ break=never Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [user_record] ${user_record}() =~ /^outbound$/ break=never Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (PASS) [user_record] ${user_exists}(true) =~ /^true$/ break=never Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^local$/ break=never Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [user_record] ${user_record}() =~ /^local$/ break=never Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [user_record] ${from_user_record}() =~ /^all$/ break=never Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (PASS) [user_record] ${call_direction}(inbound) =~ /^inbound$/ break=never Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [user_record] ${from_user_record}() =~ /^inbound$/ break=never Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^outbound$/ break=never Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [user_record] ${from_user_record}() =~ /^outbound$/ break=never Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^local$/ break=never Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [user_record] ${from_user_record}() =~ /^local$/ break=never Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [user_record] ${record_session}() =~ /^true$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->redial] continue=true Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [redial] destination_number(5000) =~ /^(redial|\*870)$/ break=on-true Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (PASS) [redial] () =~ // break=never Dialplan: sofia/external/+447966199326@147.152.17.90 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number}) Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->speed_dial] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [speed_dial] destination_number(5000) =~ /^\*0(.*)$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->141] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [141] destination_number(5000) =~ /^1410(\d{10})$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->Domestic] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [Domestic] destination_number(5000) =~ /^0(\d{7,10})$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->International] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [International] destination_number(5000) =~ /^00(.*)$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->Test_GCS_LKUP] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [Test_GCS_LKUP] destination_number(5000) =~ /^(833500.*)$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->TestRoute] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [TestRoute] destination_number(5000) =~ /^(8378.*)$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->TransferToKinetic] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [TransferToKinetic] destination_number(5000) =~ /^(30[0-2][1-9])$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->agent_status] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [agent_status] destination_number(5000) =~ /^\*22$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->agent_status_id] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [agent_status_id] destination_number(5000) =~ /^\*23$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->group-intercept] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [group-intercept] destination_number(5000) =~ /^\*8$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->page-extension] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [page-extension] destination_number(5000) =~ /^\*8(\d{2,7})$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->eavesdrop] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [eavesdrop] destination_number(5000) =~ /^\*33(\d{2,7})$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->call_privacy] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [call_privacy] destination_number(5000) =~ /^\*67(\d+)$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->call_return] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [call_return] destination_number(5000) =~ /^\*69$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->extension_queue] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [extension_queue] destination_number(5000) =~ /^\*800(.*)$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->intercept-ext] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [intercept-ext] destination_number(5000) =~ /^\*\*(\d+)$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->intercept-ext-polycom] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [intercept-ext-polycom] destination_number(5000) =~ /^\*97(\d+)$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->dx] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [dx] destination_number(5000) =~ /^dx$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->att_xfer] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [att_xfer] destination_number(5000) =~ /^att_xfer$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->extension-to-voicemail] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (PASS) [extension-to-voicemail] ${user_exists}(true) =~ /^true$/ break=on-false 2017-07-12 20:47:56.271967 [ERR] switch_regex.c:104 COMPILE ERROR: 1 [nothing to repeat][^+447966199326$] Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [extension-to-voicemail] username(+447966199326) =~ /^+447966199326$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->send_to_voicemail] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [send_to_voicemail] destination_number(5000) =~ /^\*99(\d{2,10})$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->vmain] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [vmain] destination_number(5000) =~ /^vmain$|^\*4000$|^\*98$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->xfer_vm] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [xfer_vm] destination_number(5000) =~ /^xfer_vm$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->is_transfer] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [is_transfer] destination_number(5000) =~ /^is_transfer$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->vmain_user] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [vmain_user] destination_number(5000) =~ /^\*97$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->Al Jannah] continue=true Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [Al Jannah] destination_number(5000) =~ /^100$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->demoQuran] continue= Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [demoQuran] destination_number(5000) =~ /^6000$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->MadinaMasjid] continue= Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [MadinaMasjid] destination_number(5000) =~ /^101$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->Ring5001] continue= Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [Ring5001] destination_number(5000) =~ /^12346$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->Ring5004] continue= Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [Ring5004] destination_number(5000) =~ /^12347$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->RingALL] continue= Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [RingALL] destination_number(5000) =~ /^12345$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->SBR_Divert] continue= Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [SBR_Divert] destination_number(5000) =~ /^502$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->TDL Main] continue= Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [TDL Main] destination_number(5000) =~ /^500$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->testing] continue= Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [testing] destination_number(5000) =~ /^4000$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->xcess_Demo_Intro.wav] continue= Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [xcess_Demo_Intro.wav] destination_number(5000) =~ /^102$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->XcessTelecom] continue= Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [XcessTelecom] destination_number(5000) =~ /^501$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->cf] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [cf] destination_number(5000) =~ /^cf$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->delay_echo] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [delay_echo] destination_number(5000) =~ /^\*9195$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->echo] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [echo] destination_number(5000) =~ /^\*9196$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->is_zrtp_secure] continue=true Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [is_zrtp_secure] ${zrtp_secure_media_confirmed}() =~ /^true$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 ANTI-Action eval(not_secure) Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->milliwatt] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [milliwatt] destination_number(5000) =~ /^\*9197$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->is_secure] continue=true Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [is_secure] ${sip_via_protocol}(udp) =~ /tls/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->tone_stream] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [tone_stream] destination_number(5000) =~ /^\*9198$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->hold_music] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [hold_music] destination_number(5000) =~ /^\*9664$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->recordings] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [recordings] destination_number(5000) =~ /^\*(732)$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->directory] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [directory] destination_number(5000) =~ /^\*411$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->wake-up] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [wake-up] destination_number(5000) =~ /^\*(925)$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->valet_park] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [valet_park] destination_number(5000) =~ /^(park\+)?(\*59[0-9][0-9])$/ break=never Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [valet_park] ${sip_h_Referred-By}() =~ /sip:(.*)@.*/ break=never Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [valet_park] destination_number(5000) =~ /^(park\+)?(\*59[0-9][0-9])$/ break=never Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [valet_park] destination_number(5000) =~ /^(park\+)?(\*59[0-9][0-9])$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->operator] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [operator] destination_number(5000) =~ /^0$|^operator$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->operator-forward] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [operator-forward] destination_number(5000) =~ /^\*000$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->do-not-disturb] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [do-not-disturb] destination_number(5000) =~ /^\*77$/ break=on-true Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [do-not-disturb] destination_number(5000) =~ /^\*78$|\*363$/ break=on-true Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [do-not-disturb] destination_number(5000) =~ /^\*79$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->call-forward] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [call-forward] destination_number(5000) =~ /^\*72$/ break=on-true Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [call-forward] destination_number(5000) =~ /^\*73$/ break=on-true Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [call-forward] destination_number(5000) =~ /^\*74$/ break=on-true Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->follow-me] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [follow-me] destination_number(5000) =~ /^\*21$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->clear_sip_auto_answer] continue=true Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [clear_sip_auto_answer] ${click_to_call}() =~ /true/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->talking clock date and time] continue=true Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [talking clock date and time] destination_number(5000) =~ /^\*9172$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->talking clock time] continue=true Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [talking clock time] destination_number(5000) =~ /^\*9170$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->talking clock date] continue=true Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [talking clock date] destination_number(5000) =~ /^\*9171$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->call_screen] continue=true Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [call_screen] ${call_screen_enabled}(false) =~ /^true$/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->local_extension] continue=true Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (PASS) [local_extension] ${user_exists}(true) =~ /true/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 Action export(dialed_extension=${destination_number}) INLINE EXECUTE sofia/external/+447966199326@147.152.17.90 export(dialed_extension=5000) 2017-07-12 20:47:56.271967 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [dialed_extension]=[5000] Dialplan: sofia/external/+447966199326@147.152.17.90 Action limit(hash ${domain_name} ${destination_number} ${limit_max} ${limit_destination}) Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (FAIL) [local_extension] ${sip_authorized}() =~ /true/ break=never Dialplan: sofia/external/+447966199326@147.152.17.90 ANTI-Action set(bind_target=peer) INLINE EXECUTE sofia/external/+447966199326@147.152.17.90 set(bind_target=peer) 2017-07-12 20:47:56.271967 [DEBUG] mod_dptools.c:1527 SET sofia/external/+447966199326@147.152.17.90 [bind_target]=[peer] Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (PASS) [local_extension] () =~ // break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 Action bind_digit_action(local,*1,exec:execute_extension,dx XML ${context},${bind_target}) Dialplan: sofia/external/+447966199326@147.152.17.90 Action bind_digit_action(local,*2,exec:record_session,${recordings_dir}/${domain_name}/archive/${strftime(%Y)}/${strftime(%b)}/${strftime(%d)}/${uuid}.${record_ext},${bind_target}) Dialplan: sofia/external/+447966199326@147.152.17.90 Action bind_digit_action(local,*3,exec:execute_extension,cf XML ${context},${bind_target}) Dialplan: sofia/external/+447966199326@147.152.17.90 Action bind_digit_action(local,*4,exec:execute_extension,att_xfer XML ${context},${bind_target}) Dialplan: sofia/external/+447966199326@147.152.17.90 Action digit_action_set_realm(local) Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (PASS) [local_extension] () =~ // break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 Action set(hangup_after_bridge=true) Dialplan: sofia/external/+447966199326@147.152.17.90 Action set(continue_on_fail=true) Dialplan: sofia/external/+447966199326@147.152.17.90 Action hash(insert/${domain_name}-call_return/${dialed_extension}/${caller_id_number}) Dialplan: sofia/external/+447966199326@147.152.17.90 Action hash(insert/${domain_name}-last_dial_ext/${dialed_extension}/${uuid}) Dialplan: sofia/external/+447966199326@147.152.17.90 Action set(called_party_call_group=${user_data(${dialed_extension}@${domain_name} var call_group)}) Dialplan: sofia/external/+447966199326@147.152.17.90 Action hash(insert/${domain_name}-last_dial/${called_party_call_group}/${uuid}) Dialplan: sofia/external/+447966199326@147.152.17.90 Action set(api_hangup_hook=lua app.lua hangup) Dialplan: sofia/external/+447966199326@147.152.17.90 Action export(domain_name=${context}) Dialplan: sofia/external/+447966199326@147.152.17.90 Action bridge(user/${destination_number}@${domain_name}) Dialplan: sofia/external/+447966199326@147.152.17.90 Action lua(app.lua failure_handler) Dialplan: sofia/external/+447966199326@147.152.17.90 parsing [tdl.xcesstelecom.com->voicemail] continue=false Dialplan: sofia/external/+447966199326@147.152.17.90 Regex (PASS) [voicemail] ${user_exists}(true) =~ /true/ break=on-false Dialplan: sofia/external/+447966199326@147.152.17.90 Action answer() Dialplan: sofia/external/+447966199326@147.152.17.90 Action sleep(1000) Dialplan: sofia/external/+447966199326@147.152.17.90 Action set(voicemail_action=save) Dialplan: sofia/external/+447966199326@147.152.17.90 Action set(voicemail_id=${destination_number}) Dialplan: sofia/external/+447966199326@147.152.17.90 Action set(voicemail_profile=default) Dialplan: sofia/external/+447966199326@147.152.17.90 Action lua(app.lua voicemail) 2017-07-12 20:47:56.271967 [DEBUG] switch_core_state_machine.c:286 (sofia/external/+447966199326@147.152.17.90) State Change CS_ROUTING -> CS_EXECUTE 2017-07-12 20:47:56.271967 [DEBUG] switch_core_state_machine.c:643 (sofia/external/+447966199326@147.152.17.90) State ROUTING going to sleep 2017-07-12 20:47:56.271967 [DEBUG] switch_core_state_machine.c:584 (sofia/external/+447966199326@147.152.17.90) Running State Change CS_EXECUTE (Cur 5 Tot 93175) 2017-07-12 20:47:56.271967 [DEBUG] switch_core_state_machine.c:650 (sofia/external/+447966199326@147.152.17.90) State EXECUTE 2017-07-12 20:47:56.271967 [DEBUG] mod_sofia.c:198 sofia/external/+447966199326@147.152.17.90 SOFIA EXECUTE 2017-07-12 20:47:56.271967 [DEBUG] switch_core_state_machine.c:328 sofia/external/+447966199326@147.152.17.90 Standard EXECUTE EXECUTE sofia/external/+447966199326@147.152.17.90 set(extension_uuid=373e27d9-c802-4f76-a388-b62b2365b958) 2017-07-12 20:47:56.271967 [DEBUG] mod_dptools.c:1527 SET sofia/external/+447966199326@147.152.17.90 [extension_uuid]=[373e27d9-c802-4f76-a388-b62b2365b958] EXECUTE sofia/external/+447966199326@147.152.17.90 set(hold_music=local_stream://default) 2017-07-12 20:47:56.291964 [DEBUG] mod_dptools.c:1527 SET sofia/external/+447966199326@147.152.17.90 [hold_music]=[local_stream://default] EXECUTE sofia/external/+447966199326@147.152.17.90 set(forward_all_enabled=true) 2017-07-12 20:47:56.291964 [DEBUG] mod_dptools.c:1527 SET sofia/external/+447966199326@147.152.17.90 [forward_all_enabled]=[true] EXECUTE sofia/external/+447966199326@147.152.17.90 set(forward_all_destination=5007) 2017-07-12 20:47:56.291964 [DEBUG] mod_dptools.c:1527 SET sofia/external/+447966199326@147.152.17.90 [forward_all_destination]=[5007] EXECUTE sofia/external/+447966199326@147.152.17.90 set(forward_busy_enabled=false) 2017-07-12 20:47:56.291964 [DEBUG] mod_dptools.c:1527 SET sofia/external/+447966199326@147.152.17.90 [forward_busy_enabled]=[false] EXECUTE sofia/external/+447966199326@147.152.17.90 set(forward_busy_destination=07966199326) 2017-07-12 20:47:56.311965 [DEBUG] mod_dptools.c:1527 SET sofia/external/+447966199326@147.152.17.90 [forward_busy_destination]=[07966199326] EXECUTE sofia/external/+447966199326@147.152.17.90 set(forward_no_answer_enabled=false) 2017-07-12 20:47:56.311965 [DEBUG] mod_dptools.c:1527 SET sofia/external/+447966199326@147.152.17.90 [forward_no_answer_enabled]=[false] EXECUTE sofia/external/+447966199326@147.152.17.90 set(forward_no_answer_destination=07966199326) 2017-07-12 20:47:56.311965 [DEBUG] mod_dptools.c:1527 SET sofia/external/+447966199326@147.152.17.90 [forward_no_answer_destination]=[07966199326] EXECUTE sofia/external/+447966199326@147.152.17.90 set(forward_user_not_registered_enabled=false) 2017-07-12 20:47:56.311965 [DEBUG] mod_dptools.c:1527 SET sofia/external/+447966199326@147.152.17.90 [forward_user_not_registered_enabled]=[false] EXECUTE sofia/external/+447966199326@147.152.17.90 set(forward_user_not_registered_destination=07966199326) 2017-07-12 20:47:56.331966 [DEBUG] mod_dptools.c:1527 SET sofia/external/+447966199326@147.152.17.90 [forward_user_not_registered_destination]=[07966199326] EXECUTE sofia/external/+447966199326@147.152.17.90 set(do_not_disturb=false) 2017-07-12 20:47:56.331966 [DEBUG] mod_dptools.c:1527 SET sofia/external/+447966199326@147.152.17.90 [do_not_disturb]=[false] EXECUTE sofia/external/+447966199326@147.152.17.90 set(call_timeout=30) 2017-07-12 20:47:56.331966 [DEBUG] mod_dptools.c:1527 SET sofia/external/+447966199326@147.152.17.90 [call_timeout]=[30] EXECUTE sofia/external/+447966199326@147.152.17.90 set(missed_call_app=email) 2017-07-12 20:47:56.331966 [DEBUG] mod_dptools.c:1527 SET sofia/external/+447966199326@147.152.17.90 [missed_call_app]=[email] EXECUTE sofia/external/+447966199326@147.152.17.90 set(missed_call_data=d.masood@tdl-uk.com) 2017-07-12 20:47:56.351964 [DEBUG] mod_dptools.c:1527 SET sofia/external/+447966199326@147.152.17.90 [missed_call_data]=[d.masood@tdl-uk.com] EXECUTE sofia/external/+447966199326@147.152.17.90 export(origination_callee_id_name=5000) 2017-07-12 20:47:56.351964 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [origination_callee_id_name]=[5000] EXECUTE sofia/external/+447966199326@147.152.17.90 set(RFC2822_DATE=Wed, 12 Jul 2017 20:47:56 +0100) 2017-07-12 20:47:56.351964 [DEBUG] mod_dptools.c:1527 SET sofia/external/+447966199326@147.152.17.90 [RFC2822_DATE]=[Wed, 12 Jul 2017 20:47:56 +0100] EXECUTE sofia/external/+447966199326@147.152.17.90 hash(insert/tdl.xcesstelecom.com-last_dial/+447966199326/5000) EXECUTE sofia/external/+447966199326@147.152.17.90 eval(not_secure) EXECUTE sofia/external/+447966199326@147.152.17.90 limit(hash tdl.xcesstelecom.com 5000 ) 2017-07-12 20:47:56.351964 [DEBUG] switch_limit.c:126 incr called: tdl.xcesstelecom.com_5000 max:-1, interval:0 2017-07-12 20:47:56.351964 [DEBUG] mod_hash.c:194 Usage for tdl.xcesstelecom.com_5000 is now 1 EXECUTE sofia/external/+447966199326@147.152.17.90 bind_digit_action(local,*1,exec:execute_extension,dx XML tdl.xcesstelecom.com,peer) 2017-07-12 20:47:56.351964 [INFO] switch_ivr_async.c:214 Digit parser DPTOOLS: Setting realm to 'local' 2017-07-12 20:47:56.351964 [DEBUG] switch_ivr_async.c:323 Digit parser DPTOOLS: binding *1/local/0 callback: 0x7f5755fc2c20 data: 0x7f57280b4328 EXECUTE sofia/external/+447966199326@147.152.17.90 bind_digit_action(local,*2,exec:record_session,/var/lib/freeswitch/recordings/tdl.xcesstelecom.com/archive/2017/Jul/12/dd919526-461b-4431-b986-ee8a5c9a4d13.wav,peer) 2017-07-12 20:47:56.351964 [DEBUG] switch_ivr_async.c:323 Digit parser DPTOOLS: binding *2/local/0 callback: 0x7f5755fc2c20 data: 0x7f57280b4578 EXECUTE sofia/external/+447966199326@147.152.17.90 bind_digit_action(local,*3,exec:execute_extension,cf XML tdl.xcesstelecom.com,peer) 2017-07-12 20:47:56.351964 [DEBUG] switch_ivr_async.c:323 Digit parser DPTOOLS: binding *3/local/0 callback: 0x7f5755fc2c20 data: 0x7f57280b4730 EXECUTE sofia/external/+447966199326@147.152.17.90 bind_digit_action(local,*4,exec:execute_extension,att_xfer XML tdl.xcesstelecom.com,peer) 2017-07-12 20:47:56.351964 [DEBUG] switch_ivr_async.c:323 Digit parser DPTOOLS: binding *4/local/0 callback: 0x7f5755fc2c20 data: 0x7f57280b4890 EXECUTE sofia/external/+447966199326@147.152.17.90 digit_action_set_realm(local) EXECUTE sofia/external/+447966199326@147.152.17.90 set(hangup_after_bridge=true) 2017-07-12 20:47:56.351964 [DEBUG] mod_dptools.c:1527 SET sofia/external/+447966199326@147.152.17.90 [hangup_after_bridge]=[true] EXECUTE sofia/external/+447966199326@147.152.17.90 set(continue_on_fail=true) 2017-07-12 20:47:56.351964 [DEBUG] mod_dptools.c:1527 SET sofia/external/+447966199326@147.152.17.90 [continue_on_fail]=[true] EXECUTE sofia/external/+447966199326@147.152.17.90 hash(insert/tdl.xcesstelecom.com-call_return/5000/+447966199326) EXECUTE sofia/external/+447966199326@147.152.17.90 hash(insert/tdl.xcesstelecom.com-last_dial_ext/5000/dd919526-461b-4431-b986-ee8a5c9a4d13) EXECUTE sofia/external/+447966199326@147.152.17.90 set(called_party_call_group=) 2017-07-12 20:47:56.351964 [DEBUG] mod_dptools.c:1527 SET sofia/external/+447966199326@147.152.17.90 [called_party_call_group]=[UNDEF] EXECUTE sofia/external/+447966199326@147.152.17.90 hash(insert/tdl.xcesstelecom.com-last_dial//dd919526-461b-4431-b986-ee8a5c9a4d13) EXECUTE sofia/external/+447966199326@147.152.17.90 set(api_hangup_hook=lua app.lua hangup) 2017-07-12 20:47:56.351964 [DEBUG] mod_dptools.c:1527 SET sofia/external/+447966199326@147.152.17.90 [api_hangup_hook]=[lua app.lua hangup] EXECUTE sofia/external/+447966199326@147.152.17.90 export(domain_name=tdl.xcesstelecom.com) 2017-07-12 20:47:56.351964 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [domain_name]=[tdl.xcesstelecom.com] EXECUTE sofia/external/+447966199326@147.152.17.90 bridge(user/5000@tdl.xcesstelecom.com) 2017-07-12 20:47:56.371963 [DEBUG] switch_channel.c:1250 sofia/external/+447966199326@147.152.17.90 EXPORTING[export_vars] [dialed_extension]=[5000] to event 2017-07-12 20:47:56.371963 [DEBUG] switch_channel.c:1250 sofia/external/+447966199326@147.152.17.90 EXPORTING[export_vars] [origination_callee_id_name]=[5000] to event 2017-07-12 20:47:56.371963 [DEBUG] switch_channel.c:1250 sofia/external/+447966199326@147.152.17.90 EXPORTING[export_vars] [domain_name]=[tdl.xcesstelecom.com] to event 2017-07-12 20:47:56.371963 [DEBUG] switch_ivr_originate.c:2138 Parsing global variables 2017-07-12 20:47:56.371963 [DEBUG] switch_channel.c:1250 sofia/external/+447966199326@147.152.17.90 EXPORTING[export_vars] [dialed_extension]=[5000] to event 2017-07-12 20:47:56.371963 [DEBUG] switch_channel.c:1250 sofia/external/+447966199326@147.152.17.90 EXPORTING[export_vars] [origination_callee_id_name]=[5000] to event 2017-07-12 20:47:56.371963 [DEBUG] switch_channel.c:1250 sofia/external/+447966199326@147.152.17.90 EXPORTING[export_vars] [domain_name]=[tdl.xcesstelecom.com] to event 2017-07-12 20:47:56.371963 [DEBUG] switch_ivr_originate.c:2138 Parsing global variables 2017-07-12 20:47:56.371963 [DEBUG] switch_channel.c:1250 sofia/external/+447966199326@147.152.17.90 EXPORTING[export_vars] [dialed_extension]=[5000] to event 2017-07-12 20:47:56.371963 [DEBUG] switch_channel.c:1250 sofia/external/+447966199326@147.152.17.90 EXPORTING[export_vars] [origination_callee_id_name]=[5000] to event 2017-07-12 20:47:56.371963 [DEBUG] switch_channel.c:1250 sofia/external/+447966199326@147.152.17.90 EXPORTING[export_vars] [domain_name]=[tdl.xcesstelecom.com] to event 2017-07-12 20:47:56.371963 [DEBUG] switch_ivr_originate.c:2138 Parsing global variables 2017-07-12 20:47:56.371963 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060 [5fab41fb-8aee-411f-91a4-a62c97ae618d] 2017-07-12 20:47:56.371963 [DEBUG] mod_sofia.c:4809 (sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060) State Change CS_NEW -> CS_INIT 2017-07-12 20:47:56.371963 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060) Running State Change CS_INIT (Cur 6 Tot 93176) 2017-07-12 20:47:56.371963 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060) State INIT 2017-07-12 20:47:56.371963 [DEBUG] mod_sofia.c:90 sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060 SOFIA INIT 2017-07-12 20:47:56.371963 [DEBUG] sofia_glue.c:1293 sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060 sending invite version: 1.6.15 -32-bec4538 64bit Local SDP: v=0 o=FreeSWITCH 1499869772 1499869773 IN IP4 172.20.1.40 s=FreeSWITCH c=IN IP4 172.20.1.40 t=0 0 m=audio 19104 RTP/AVP 8 9 0 3 101 13 a=rtpmap:8 PCMA/8000 a=rtpmap:9 G722/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:3 GSM/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=rtpmap:13 CN/8000 a=ptime:20 a=sendrecv 2017-07-12 20:47:56.371963 [DEBUG] switch_core_state_machine.c:40 sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060 Standard INIT 2017-07-12 20:47:56.371963 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060) State Change CS_INIT -> CS_ROUTING 2017-07-12 20:47:56.371963 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060) State INIT going to sleep 2017-07-12 20:47:56.371963 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060) Running State Change CS_ROUTING (Cur 6 Tot 93176) 2017-07-12 20:47:56.371963 [INFO] switch_ivr_originate.c:1215 Sending early media 2017-07-12 20:47:56.371963 [DEBUG] sofia.c:7042 Channel sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060 entering state [calling][0] 2017-07-12 20:47:56.371963 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060) State ROUTING 2017-07-12 20:47:56.371963 [DEBUG] mod_sofia.c:143 sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060 SOFIA ROUTING 2017-07-12 20:47:56.371963 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060) State Change CS_ROUTING -> CS_CONSUME_MEDIA 2017-07-12 20:47:56.371963 [DEBUG] switch_core_media.c:6732 AUDIO RTP [sofia/external/+447966199326@147.152.17.90] 172.20.1.40 port 21226 -> 172.20.1.21 port 39730 codec: 8 ms: 20 2017-07-12 20:47:56.371963 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060) State ROUTING going to sleep 2017-07-12 20:47:56.371963 [DEBUG] switch_rtp.c:3878 Starting timer [soft] 160 bytes per 20ms 2017-07-12 20:47:56.371963 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060) Running State Change CS_CONSUME_MEDIA (Cur 6 Tot 93176) 2017-07-12 20:47:56.371963 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060) State CONSUME_MEDIA 2017-07-12 20:47:56.371963 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060) State CONSUME_MEDIA going to sleep 2017-07-12 20:47:56.371963 [DEBUG] switch_core_media.c:7068 sofia/external/+447966199326@147.152.17.90 Set rtp dtmf delay to 40 2017-07-12 20:47:56.371963 [DEBUG] mod_sofia.c:2354 Ring SDP: v=0 o=FreeSWITCH 1499867650 1499867651 IN IP4 172.20.1.40 s=FreeSWITCH c=IN IP4 172.20.1.40 t=0 0 m=audio 21226 RTP/AVP 8 a=rtpmap:8 PCMA/8000 a=ptime:20 a=sendrecv 2017-07-12 20:47:56.371963 [NOTICE] mod_sofia.c:2357 Pre-Answer sofia/external/+447966199326@147.152.17.90! 2017-07-12 20:47:56.371963 [DEBUG] switch_channel.c:3473 (sofia/external/+447966199326@147.152.17.90) Callstate Change RINGING -> EARLY 2017-07-12 20:47:56.371963 [DEBUG] switch_ivr_originate.c:1273 Raw Codec Activation Success L16@8000hz 1 channel 20ms 2017-07-12 20:47:56.371963 [DEBUG] switch_core_codec.c:223 sofia/external/+447966199326@147.152.17.90 Push codec L16:100 2017-07-12 20:47:56.371963 [DEBUG] switch_ivr_originate.c:1342 Play Ringback Tone [%(400,200,400,450);%(400,2000,400,450)] 2017-07-12 20:47:56.391963 [DEBUG] sofia.c:7042 Channel sofia/external/+447966199326@147.152.17.90 entering state [early][183] 2017-07-12 20:47:56.631962 [DEBUG] sofia.c:7042 Channel sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060 entering state [proceeding][180] 2017-07-12 20:47:56.631962 [NOTICE] sofia.c:7150 Ring-Ready sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060! 2017-07-12 20:47:56.631962 [DEBUG] switch_channel.c:3345 (sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060) Callstate Change DOWN -> RINGING 2017-07-12 20:47:56.652130 [DEBUG] switch_rtp.c:6994 Correct audio ip/port confirmed. 2017-07-12 20:47:58.972086 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7f572809f810 Connected. 2017-07-12 20:47:58.972086 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7f572809f810 released. 2017-07-12 20:48:00.632075 [DEBUG] sofia.c:7042 Channel sofia/external/+447966199326@147.152.17.90 entering state [terminated][487] 2017-07-12 20:48:00.632075 [NOTICE] sofia.c:8216 Hangup sofia/external/+447966199326@147.152.17.90 [CS_EXECUTE] [ORIGINATOR_CANCEL] 2017-07-12 20:48:00.632075 [DEBUG] mod_hash.c:297 Usage for tdl.xcesstelecom.com_5000 is now 0 2017-07-12 20:48:00.632075 [DEBUG] switch_core_codec.c:248 sofia/external/+447966199326@147.152.17.90 Restore previous codec PCMA:8. 2017-07-12 20:48:00.632075 [NOTICE] switch_ivr_originate.c:3601 Hangup sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060 [CS_CONSUME_MEDIA] [ORIGINATOR_CANCEL] 2017-07-12 20:48:00.632075 [DEBUG] switch_ivr_originate.c:3818 Originate Cancelled by originator termination Cause: 487 [ORIGINATOR_CANCEL] 2017-07-12 20:48:00.632075 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060) Running State Change CS_HANGUP (Cur 6 Tot 93176) 2017-07-12 20:48:00.632075 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060) Callstate Change RINGING -> HANGUP 2017-07-12 20:48:00.632075 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060) State HANGUP 2017-07-12 20:48:00.632075 [DEBUG] mod_sofia.c:432 sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060 Overriding SIP cause 487 with 487 from the other leg 2017-07-12 20:48:00.632075 [DEBUG] mod_sofia.c:438 Channel sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060 hanging up, cause: ORIGINATOR_CANCEL 2017-07-12 20:48:00.632075 [DEBUG] mod_sofia.c:502 Sending CANCEL to sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060 2017-07-12 20:48:00.632075 [DEBUG] switch_core_state_machine.c:60 sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060 Standard HANGUP, cause: ORIGINATOR_CANCEL 2017-07-12 20:48:00.632075 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060) State HANGUP going to sleep 2017-07-12 20:48:00.632075 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060) State Change CS_HANGUP -> CS_REPORTING 2017-07-12 20:48:00.632075 [NOTICE] switch_ivr_originate.c:2841 Cannot create outgoing channel of type [user] cause: [ORIGINATOR_CANCEL] 2017-07-12 20:48:00.632075 [DEBUG] switch_ivr_originate.c:3829 Originate Resulted in Error Cause: 487 [ORIGINATOR_CANCEL] 2017-07-12 20:48:00.632075 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060) Running State Change CS_REPORTING (Cur 6 Tot 93176) 2017-07-12 20:48:00.632075 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060) State REPORTING 2017-07-12 20:48:00.632075 [DEBUG] switch_core_state_machine.c:174 sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060 Standard REPORTING, cause: ORIGINATOR_CANCEL 2017-07-12 20:48:00.632075 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060) State REPORTING going to sleep 2017-07-12 20:48:00.632075 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060) State Change CS_REPORTING -> CS_DESTROY 2017-07-12 20:48:00.632075 [DEBUG] switch_core_session.c:1664 Session 93176 (sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060) Locked, Waiting on external entities 2017-07-12 20:48:00.632075 [NOTICE] switch_core_session.c:1682 Session 93176 (sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060) Ended 2017-07-12 20:48:00.632075 [NOTICE] switch_core_session.c:1686 Close Channel sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060 [CS_DESTROY] 2017-07-12 20:48:00.632075 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060) Running State Change CS_DESTROY (Cur 5 Tot 93176) 2017-07-12 20:48:00.632075 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060) State DESTROY 2017-07-12 20:48:00.632075 [DEBUG] mod_sofia.c:343 sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060 SOFIA DESTROY 2017-07-12 20:48:00.632075 [NOTICE] switch_ivr_originate.c:2841 Cannot create outgoing channel of type [user] cause: [ORIGINATOR_CANCEL] 2017-07-12 20:48:00.632075 [DEBUG] switch_core_state_machine.c:181 sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060 Standard DESTROY 2017-07-12 20:48:00.632075 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/5007-kbruqb3mdm2bb@172.20.1.21:5060) State DESTROY going to sleep 2017-07-12 20:48:00.632075 [DEBUG] switch_ivr_originate.c:3829 Originate Resulted in Error Cause: 487 [ORIGINATOR_CANCEL] 2017-07-12 20:48:00.632075 [INFO] mod_dptools.c:3409 Originate Failed. Cause: ORIGINATOR_CANCEL 2017-07-12 20:48:00.632075 [DEBUG] switch_core_session.c:2814 sofia/external/+447966199326@147.152.17.90 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already) 2017-07-12 20:48:00.632075 [DEBUG] switch_core_state_machine.c:650 (sofia/external/+447966199326@147.152.17.90) State EXECUTE going to sleep 2017-07-12 20:48:00.632075 [DEBUG] switch_core_state_machine.c:584 (sofia/external/+447966199326@147.152.17.90) Running State Change CS_HANGUP (Cur 5 Tot 93176) 2017-07-12 20:48:00.632075 [DEBUG] switch_core_state_machine.c:850 (sofia/external/+447966199326@147.152.17.90) Callstate Change EARLY -> HANGUP 2017-07-12 20:48:00.632075 [DEBUG] switch_core_state_machine.c:852 (sofia/external/+447966199326@147.152.17.90) State HANGUP 2017-07-12 20:48:00.632075 [DEBUG] mod_sofia.c:438 Channel sofia/external/+447966199326@147.152.17.90 hanging up, cause: ORIGINATOR_CANCEL 2017-07-12 20:48:00.632075 [DEBUG] switch_core_state_machine.c:60 sofia/external/+447966199326@147.152.17.90 Standard HANGUP, cause: ORIGINATOR_CANCEL 2017-07-12 20:48:00.632075 [DEBUG] switch_core_state_machine.c:852 (sofia/external/+447966199326@147.152.17.90) State HANGUP going to sleep 2017-07-12 20:48:00.632075 [DEBUG] switch_core_state_machine.c:783 Hangup Command with no Session lua(app.lua hangup): 2017-07-12 20:48:00.632075 [DEBUG] switch_core_state_machine.c:619 (sofia/external/+447966199326@147.152.17.90) State Change CS_HANGUP -> CS_REPORTING 2017-07-12 20:48:00.632075 [DEBUG] switch_core_state_machine.c:584 (sofia/external/+447966199326@147.152.17.90) Running State Change CS_REPORTING (Cur 5 Tot 93176) 2017-07-12 20:48:00.632075 [DEBUG] switch_core_state_machine.c:938 (sofia/external/+447966199326@147.152.17.90) State REPORTING 2017-07-12 20:48:00.712095 [DEBUG] switch_core_state_machine.c:174 sofia/external/+447966199326@147.152.17.90 Standard REPORTING, cause: ORIGINATOR_CANCEL 2017-07-12 20:48:00.712095 [DEBUG] switch_core_state_machine.c:938 (sofia/external/+447966199326@147.152.17.90) State REPORTING going to sleep 2017-07-12 20:48:00.712095 [DEBUG] switch_core_state_machine.c:610 (sofia/external/+447966199326@147.152.17.90) State Change CS_REPORTING -> CS_DESTROY 2017-07-12 20:48:00.712095 [DEBUG] switch_core_session.c:1664 Session 93175 (sofia/external/+447966199326@147.152.17.90) Locked, Waiting on external entities 2017-07-12 20:48:00.712095 [NOTICE] switch_core_session.c:1682 Session 93175 (sofia/external/+447966199326@147.152.17.90) Ended 2017-07-12 20:48:00.712095 [NOTICE] switch_core_session.c:1686 Close Channel sofia/external/+447966199326@147.152.17.90 [CS_DESTROY] 2017-07-12 20:48:00.712095 [DEBUG] switch_core_state_machine.c:741 (sofia/external/+447966199326@147.152.17.90) Running State Change CS_DESTROY (Cur 4 Tot 93176) 2017-07-12 20:48:00.712095 [DEBUG] switch_core_state_machine.c:751 (sofia/external/+447966199326@147.152.17.90) State DESTROY 2017-07-12 20:48:00.712095 [DEBUG] mod_sofia.c:343 sofia/external/+447966199326@147.152.17.90 SOFIA DESTROY 2017-07-12 20:48:00.712095 [DEBUG] switch_core_state_machine.c:181 sofia/external/+447966199326@147.152.17.90 Standard DESTROY 2017-07-12 20:48:00.712095 [DEBUG] switch_core_state_machine.c:751 (sofia/external/+447966199326@147.152.17.90) State DESTROY going to sleep 2017-07-12 20:48:00.932083 [DEBUG] switch_utils.c:1182 Emailed data to [d.masood@tdl-uk.com] freeswitch@FusionPBX>