2019-01-09 13:07:54.635896 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/5615103060@208.103.145.20 [10217f06-6de9-43ad-8438-1db43e301a8c]
2019-01-09 13:07:54.635896 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5615103060@208.103.145.20) Running State Change CS_NEW (Cur 5 Tot 41238)
2019-01-09 13:07:54.635896 [DEBUG] sofia.c:10080 sofia/internal/5615103060@208.103.145.20 receiving invite from 208.103.145.20:5060 version: 1.8.2 -3-a98a958ac3 64bit
2019-01-09 13:07:54.635896 [DEBUG] sofia.c:10196 IP 208.103.145.20 Approved by acl "domains[]". Access Granted.
2019-01-09 13:07:54.655898 [DEBUG] sofia.c:7291 Channel sofia/internal/5615103060@208.103.145.20 entering state [received][100]
2019-01-09 13:07:54.655898 [DEBUG] sofia.c:7301 Remote SDP:
v=0
o=Sonus_UAC 773979 840865 IN IP4 67.231.1.184
s=SIP Media Capabilities
c=IN IP4 67.231.0.16
t=0 0
m=audio 10130 RTP/AVP 0 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20

2019-01-09 13:07:54.655898 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2019-01-09 13:07:54.655898 [DEBUG] switch_core_media.c:5533 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
2019-01-09 13:07:54.655898 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
2019-01-09 13:07:54.655898 [DEBUG] switch_core_media.c:5394 Set telephone-event payload to 101@8000
2019-01-09 13:07:54.655898 [DEBUG] switch_core_media.c:3781 Set Codec sofia/internal/5615103060@208.103.145.20 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
2019-01-09 13:07:54.655898 [DEBUG] switch_core_codec.c:111 sofia/internal/5615103060@208.103.145.20 Original read codec set to PCMU:0
2019-01-09 13:07:54.655898 [DEBUG] switch_core_media.c:5737 Set telephone-event payload to 101@8000
2019-01-09 13:07:54.655898 [DEBUG] switch_core_media.c:5795 sofia/internal/5615103060@208.103.145.20 Set 2833 dtmf send payload to 101 recv payload to 101
2019-01-09 13:07:54.655898 [DEBUG] sofia.c:7716 (sofia/internal/5615103060@208.103.145.20) State Change CS_NEW -> CS_INIT
2019-01-09 13:07:54.655898 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/5615103060@208.103.145.20) State NEW
2019-01-09 13:07:54.655898 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5615103060@208.103.145.20) Running State Change CS_INIT (Cur 5 Tot 41238)
2019-01-09 13:07:54.655898 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/5615103060@208.103.145.20) State INIT
2019-01-09 13:07:54.655898 [DEBUG] mod_sofia.c:93 sofia/internal/5615103060@208.103.145.20 SOFIA INIT
2019-01-09 13:07:54.655898 [DEBUG] switch_core_state_machine.c:40 sofia/internal/5615103060@208.103.145.20 Standard INIT
2019-01-09 13:07:54.655898 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/5615103060@208.103.145.20) State Change CS_INIT -> CS_ROUTING
2019-01-09 13:07:54.655898 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/5615103060@208.103.145.20) State INIT going to sleep
2019-01-09 13:07:54.655898 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5615103060@208.103.145.20) Running State Change CS_ROUTING (Cur 5 Tot 41238)
2019-01-09 13:07:54.655898 [DEBUG] switch_channel.c:2249 (sofia/internal/5615103060@208.103.145.20) Callstate Change DOWN -> RINGING
2019-01-09 13:07:54.655898 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/5615103060@208.103.145.20) State ROUTING
2019-01-09 13:07:54.655898 [DEBUG] mod_sofia.c:154 sofia/internal/5615103060@208.103.145.20 SOFIA ROUTING
2019-01-09 13:07:54.655898 [DEBUG] switch_core_state_machine.c:236 sofia/internal/5615103060@208.103.145.20 Standard ROUTING
2019-01-09 13:07:54.655898 [INFO] mod_dialplan_xml.c:637 Processing 5615103060 <5615103060>->5615107191 in context public
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->Strip1] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [Strip1] destination_number(5615107191) =~ /^\+?1(\d{10})$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->caller-details] continue=true
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [caller-details] () =~ // break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Action export(call_direction=inbound) INLINE
EXECUTE sofia/internal/5615103060@208.103.145.20 export(call_direction=inbound)
2019-01-09 13:07:54.675881 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [call_direction]=[inbound]
Dialplan: sofia/internal/5615103060@208.103.145.20 Action set(caller_destination=${destination_number}) INLINE
EXECUTE sofia/internal/5615103060@208.103.145.20 set(caller_destination=5615107191)
2019-01-09 13:07:54.675881 [DEBUG] mod_dptools.c:1598 SET sofia/internal/5615103060@208.103.145.20 [caller_destination]=[5615107191]
Dialplan: sofia/internal/5615103060@208.103.145.20 Action set(caller_id_name=${caller_id_name}) INLINE
EXECUTE sofia/internal/5615103060@208.103.145.20 set(caller_id_name=5615103060)
2019-01-09 13:07:54.675881 [DEBUG] mod_dptools.c:1598 SET sofia/internal/5615103060@208.103.145.20 [caller_id_name]=[5615103060]
Dialplan: sofia/internal/5615103060@208.103.145.20 Action set(caller_id_number=${caller_id_number}) INLINE
EXECUTE sofia/internal/5615103060@208.103.145.20 set(caller_id_number=5615103060)
2019-01-09 13:07:54.675881 [DEBUG] mod_dptools.c:1598 SET sofia/internal/5615103060@208.103.145.20 [caller_id_number]=[5615103060]
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->3126101974] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [3126101974] destination_number(5615107191) =~ /^(3126101974)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->3126101975] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [3126101975] destination_number(5615107191) =~ /^(3126101975)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5616895539] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5616895539] destination_number(5615107191) =~ /^(5616895539)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->2143795209] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [2143795209] destination_number(5615107191) =~ /^(2143795209)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->2143754283] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [2143754283] context(public) =~ /public/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [2143754283] destination_number(5615107191) =~ /2143754283/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->2143754522] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [2143754522] context(public) =~ /public/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [2143754522] destination_number(5615107191) =~ /2143754522/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5616159327] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5616159327] destination_number(5615107191) =~ /^(5616159327)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->2143963501] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [2143963501] context(public) =~ /public/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [2143963501] destination_number(5615107191) =~ /2143963501/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->2143963502] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [2143963502] context(public) =~ /public/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [2143963502] destination_number(5615107191) =~ /2143963502/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->4049903292] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [4049903292] context(public) =~ /public/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [4049903292] destination_number(5615107191) =~ /4049903292/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5612707222] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5612707222] destination_number(5615107191) =~ /^(5612707222)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->7722063310] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [7722063310] destination_number(5615107191) =~ /^(7722063310)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->4074391110] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [4074391110] destination_number(5615107191) =~ /^(4074391110)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->9729150256] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [9729150256] destination_number(5615107191) =~ /9729150256/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->9729153669] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [9729153669] destination_number(5615107191) =~ /9729153669/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->9042670830] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [9042670830] destination_number(5615107191) =~ /^(9042670830)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->8442091600] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [8442091600] destination_number(5615107191) =~ /^(8442091600)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->9547732237] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [9547732237] destination_number(5615107191) =~ /^(9547732237)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->8886683002] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [8886683002] destination_number(5615107191) =~ /^(8886683002)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5619038023] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5619038023] destination_number(5615107191) =~ /^(5619038023)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->2143795211] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [2143795211] destination_number(5615107191) =~ /^(2143795211)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5612210577] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5612210577] destination_number(5615107191) =~ /^(5612210577)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->2143795200] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [2143795200] destination_number(5615107191) =~ /^(2143795200)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5616896465] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5616896465] destination_number(5615107191) =~ /^(5616896465)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->3126101966] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [3126101966] destination_number(5615107191) =~ /^(3126101966)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->3126101976] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [3126101976] destination_number(5615107191) =~ /^(3126101976)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->3126101977] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [3126101977] destination_number(5615107191) =~ /^(3126101977)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5616973114] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5616973114] destination_number(5615107191) =~ /^(5616973114)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5616973815] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5616973815] destination_number(5615107191) =~ /^(5616978315)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5616974714] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5616974714] destination_number(5615107191) =~ /^(5616974714)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5616977712] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5616977712] destination_number(5615107191) =~ /^(5616977712)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->6093852005] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [6093852005] destination_number(5615107191) =~ /^(6093852005)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->8172955322] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [8172955322] destination_number(5615107191) =~ /^(8172955322)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->8442734500] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [8442734500] destination_number(5615107191) =~ /^(8442734500)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5612212683] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5612212683] destination_number(5615107191) =~ /^(5612212683)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->6099644227] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [6099644227] destination_number(5615107191) =~ /^(6099644227)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->6096434227] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [6096434227] destination_number(5615107191) =~ /^(6096434227)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->2057781056] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [2057781056] destination_number(5615107191) =~ /^(2057781056)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->3233912190] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [3233912190] destination_number(5615107191) =~ /^(3233912190)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5615012195] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5615012195] destination_number(5615107191) =~ /^(5615012195)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->9043234108] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [9043234108] destination_number(5615107191) =~ /^(9043234108)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->8135185370] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [8135185370] destination_number(5615107191) =~ /^(8135185370)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->6197710870] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [6197710870] destination_number(5615107191) =~ /^(6197710870)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->2027505070] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [2027505070] destination_number(5615107191) =~ /^(2027505070)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->2036538124] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [2036538124] destination_number(5615107191) =~ /^(2036538124)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->3015495139] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [3015495139] destination_number(5615107191) =~ /^(3015495139)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->3026088210] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [3026088210] destination_number(5615107191) =~ /^(3026088210)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->3036320348] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [3036320348] destination_number(5615107191) =~ /^(3036320348)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->6178298052] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [6178298052] destination_number(5615107191) =~ /^(6178298052)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->6037829338] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [6037829338] destination_number(5615107191) =~ /^(6037829338)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->3129670945] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [3129670945] destination_number(5615107191) =~ /^(3129670945)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->3144926281] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [3144926281] destination_number(5615107191) =~ /^(3144926281)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->3162269059] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [3162269059] destination_number(5615107191) =~ /^(3162269059)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->4029941152] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [4029941152] destination_number(5615107191) =~ /^(4029941152)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->4133380762] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [4133380762] destination_number(5615107191) =~ /^(4133380762)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5042268640] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5042268640] destination_number(5615107191) =~ /^(5042268640)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5153484266] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5153484266] destination_number(5615107191) =~ /^(5153484266)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->6098089024] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [6098089024] destination_number(5615107191) =~ /^(6098089024)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->2015824897] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [2015824897] destination_number(5615107191) =~ /^(2015824897)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->2152546485] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [2152546485] destination_number(5615107191) =~ /^(2152546485)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->4014065053] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [4014065053] destination_number(5615107191) =~ /^(4014065053)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->4054938264] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [4054938264] destination_number(5615107191) =~ /^(4054938264)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->4122478030] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [4122478030] destination_number(5615107191) =~ /^(4122478030)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5052747244] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5052747244] destination_number(5615107191) =~ /^(5052747244)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5163094156] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5163094156] destination_number(5615107191) =~ /^(5163094156)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5188701720] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5188701720] destination_number(5615107191) =~ /^(5188701720)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->9152013757] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [9152013757] destination_number(5615107191) =~ /^(9152013757)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->8024482722] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [8024482722] destination_number(5615107191) =~ /^(8024482722)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->7038260079] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [7038260079] destination_number(5615107191) =~ /^(7038260079)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->2062603558] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [2062603558] destination_number(5615107191) =~ /^(2062603558)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->2817693212] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [2817693212] destination_number(5615107191) =~ /^(2817693212)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->3047699047] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [3047699047] destination_number(5615107191) =~ /^(3047699047)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->4692498581] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [4692498581] destination_number(5615107191) =~ /^(4692498581)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5129801039] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5129801039] destination_number(5615107191) =~ /^(5129801039)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5618921821] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5618921821] destination_number(5615107191) =~ /^(5618921821)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5619105870] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5619105870] destination_number(5615107191) =~ /^(5619105870)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5614030949] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5614030949] destination_number(5615107191) =~ /^(5614030949)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5612886116] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5612886116] destination_number(5615107191) =~ /^(5612886116)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5615717845] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5615717845] destination_number(5615107191) =~ /^(5615717845)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5619238029] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5619238029] destination_number(5615107191) =~ /^(5619238029)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5612886171] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5612886171] destination_number(5615107191) =~ /^(5612886171)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5027711448] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5027711448] destination_number(5615107191) =~ /^(5027711448)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5618155060] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5618155060] destination_number(5615107191) =~ /^(5618155060)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->2162394389] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [2162394389] destination_number(5615107191) =~ /^(2162394389)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->7024460961] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [7024460961] destination_number(5615107191) =~ /^(7024460961)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5618155665] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5618155665] destination_number(5615107191) =~ /^(5618155665)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5619038016] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5619038016] destination_number(5615107191) =~ /^(5619038016)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5619038017] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5619038017] destination_number(5615107191) =~ /^(5619038017)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->7046261394] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [7046261394] destination_number(5615107191) =~ /^(7046261394)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->6155703001] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [6155703001] destination_number(5615107191) =~ /^(6155703001)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5615107191] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [5615107191] destination_number(5615107191) =~ /^(5615107191)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 Action export(call_direction=inbound) INLINE
EXECUTE sofia/internal/5615103060@208.103.145.20 export(call_direction=inbound)
2019-01-09 13:07:54.675881 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [call_direction]=[inbound]
Dialplan: sofia/internal/5615103060@208.103.145.20 Action set(domain_uuid=5a8591c8-67c6-4bc6-bb0d-264045139762) INLINE
EXECUTE sofia/internal/5615103060@208.103.145.20 set(domain_uuid=5a8591c8-67c6-4bc6-bb0d-264045139762)
2019-01-09 13:07:54.675881 [DEBUG] mod_dptools.c:1598 SET sofia/internal/5615103060@208.103.145.20 [domain_uuid]=[5a8591c8-67c6-4bc6-bb0d-264045139762]
Dialplan: sofia/internal/5615103060@208.103.145.20 Action set(domain_name=safebound.cust.tellarc.com) INLINE
EXECUTE sofia/internal/5615103060@208.103.145.20 set(domain_name=safebound.cust.tellarc.com)
2019-01-09 13:07:54.675881 [DEBUG] mod_dptools.c:1598 SET sofia/internal/5615103060@208.103.145.20 [domain_name]=[safebound.cust.tellarc.com]
Dialplan: sofia/internal/5615103060@208.103.145.20 Action set(hangup_after_bridge=true)
Dialplan: sofia/internal/5615103060@208.103.145.20 Action set(continue_on_fail=true)
Dialplan: sofia/internal/5615103060@208.103.145.20 Action transfer(7601 XML safebound.cust.tellarc.com)
2019-01-09 13:07:54.675881 [DEBUG] switch_core_state_machine.c:286 (sofia/internal/5615103060@208.103.145.20) State Change CS_ROUTING -> CS_EXECUTE
2019-01-09 13:07:54.675881 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/5615103060@208.103.145.20) State ROUTING going to sleep
2019-01-09 13:07:54.675881 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5615103060@208.103.145.20) Running State Change CS_EXECUTE (Cur 5 Tot 41238)
2019-01-09 13:07:54.675881 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/5615103060@208.103.145.20) State EXECUTE
2019-01-09 13:07:54.675881 [DEBUG] mod_sofia.c:209 sofia/internal/5615103060@208.103.145.20 SOFIA EXECUTE
2019-01-09 13:07:54.675881 [DEBUG] switch_core_state_machine.c:328 sofia/internal/5615103060@208.103.145.20 Standard EXECUTE
EXECUTE sofia/internal/5615103060@208.103.145.20 set(hangup_after_bridge=true)
2019-01-09 13:07:54.675881 [DEBUG] mod_dptools.c:1598 SET sofia/internal/5615103060@208.103.145.20 [hangup_after_bridge]=[true]
EXECUTE sofia/internal/5615103060@208.103.145.20 set(continue_on_fail=true)
2019-01-09 13:07:54.675881 [DEBUG] mod_dptools.c:1598 SET sofia/internal/5615103060@208.103.145.20 [continue_on_fail]=[true]
EXECUTE sofia/internal/5615103060@208.103.145.20 transfer(7601 XML safebound.cust.tellarc.com)
2019-01-09 13:07:54.675881 [DEBUG] switch_ivr.c:2207 (sofia/internal/5615103060@208.103.145.20) State Change CS_EXECUTE -> CS_ROUTING
2019-01-09 13:07:54.675881 [NOTICE] switch_ivr.c:2214 Transfer sofia/internal/5615103060@208.103.145.20 to XML[7601@safebound.cust.tellarc.com]
2019-01-09 13:07:54.675881 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/5615103060@208.103.145.20) State EXECUTE going to sleep
2019-01-09 13:07:54.675881 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5615103060@208.103.145.20) Running State Change CS_ROUTING (Cur 5 Tot 41238)
2019-01-09 13:07:54.675881 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/5615103060@208.103.145.20) State ROUTING
2019-01-09 13:07:54.675881 [DEBUG] mod_sofia.c:145 Call appears to be already acknowledged
2019-01-09 13:07:54.675881 [DEBUG] mod_sofia.c:154 sofia/internal/5615103060@208.103.145.20 SOFIA ROUTING
2019-01-09 13:07:54.675881 [DEBUG] switch_core_state_machine.c:236 sofia/internal/5615103060@208.103.145.20 Standard ROUTING
2019-01-09 13:07:54.675881 [INFO] mod_dialplan_xml.c:637 Processing 5615103060 <5615103060>->7601 in context safebound.cust.tellarc.com
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [safebound.cust.tellarc.com->user_exists] continue=true
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [user_exists] () =~ // break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 Action set(user_exists=${user_exists id ${destination_number} ${domain_name}}) INLINE
EXECUTE sofia/internal/5615103060@208.103.145.20 set(user_exists=false)
2019-01-09 13:07:54.695903 [DEBUG] mod_dptools.c:1598 SET sofia/internal/5615103060@208.103.145.20 [user_exists]=[false]
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_exists] ${user_exists}(false) =~ /^true$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [safebound.cust.tellarc.com->caller-details] continue=true
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [caller-details] ${caller_destination}(5615107191) =~ /^$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [safebound.cust.tellarc.com->call-direction] continue=true
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [call-direction] ${call_direction}(inbound) =~ /^(inbound|outbound|local)$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [safebound.cust.tellarc.com->variables] continue=true
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [variables] () =~ // break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 Action export(origination_callee_id_name=${destination_number})
Dialplan: sofia/internal/5615103060@208.103.145.20 Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [safebound.cust.tellarc.com->user_record] continue=true
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [user_record] () =~ // break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 Action set(user_record=${user_data ${destination_number}@${domain_name} var user_record}) INLINE
EXECUTE sofia/internal/5615103060@208.103.145.20 set(user_record=)
2019-01-09 13:07:54.715825 [DEBUG] mod_dptools.c:1598 SET sofia/internal/5615103060@208.103.145.20 [user_record]=[UNDEF]
Dialplan: sofia/internal/5615103060@208.103.145.20 Action set(from_user_exists=${user_exists id ${sip_from_user} ${sip_from_host}}) INLINE
EXECUTE sofia/internal/5615103060@208.103.145.20 set(from_user_exists=false)
2019-01-09 13:07:54.715825 [DEBUG] mod_dptools.c:1598 SET sofia/internal/5615103060@208.103.145.20 [from_user_exists]=[false]
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${user_record}() =~ /^all$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [user_record] ${call_direction}(inbound) =~ /^inbound$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${user_record}() =~ /^inbound$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^outbound$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${user_record}() =~ /^outbound$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^local$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${user_record}() =~ /^local$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${from_user_record}() =~ /^all$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [user_record] ${call_direction}(inbound) =~ /^inbound$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${from_user_record}() =~ /^inbound$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^outbound$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${from_user_record}() =~ /^outbound$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^local$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${from_user_record}() =~ /^local$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${record_session}() =~ /^true$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [safebound.cust.tellarc.com->redial] continue=true
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [redial] destination_number(7601) =~ /^(redial|\*870)$/ break=on-true
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [redial] () =~ // break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [safebound.cust.tellarc.com->speed_dial] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [speed_dial] destination_number(7601) =~ /^\*0(.*)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [safebound.cust.tellarc.com->default_caller_id] continue=true
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [default_caller_id] ${emergency_caller_id_number}() =~ /^$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Action set(emergency_caller_id_name=${default_emergency_caller_id_name}) INLINE
EXECUTE sofia/internal/5615103060@208.103.145.20 set(emergency_caller_id_name=)
2019-01-09 13:07:54.715825 [DEBUG] mod_dptools.c:1598 SET sofia/internal/5615103060@208.103.145.20 [emergency_caller_id_name]=[UNDEF]
Dialplan: sofia/internal/5615103060@208.103.145.20 Action set(emergency_caller_id_number=${default_emergency_caller_id_number}) INLINE
EXECUTE sofia/internal/5615103060@208.103.145.20 set(emergency_caller_id_number=)
2019-01-09 13:07:54.715825 [DEBUG] mod_dptools.c:1598 SET sofia/internal/5615103060@208.103.145.20 [emergency_caller_id_number]=[UNDEF]
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [default_caller_id] ${outbound_caller_id_number}() =~ /^$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Action set(outbound_caller_id_name=${default_outbound_caller_id_name}) INLINE
EXECUTE sofia/internal/5615103060@208.103.145.20 set(outbound_caller_id_name=)
2019-01-09 13:07:54.715825 [DEBUG] mod_dptools.c:1598 SET sofia/internal/5615103060@208.103.145.20 [outbound_caller_id_name]=[UNDEF]
Dialplan: sofia/internal/5615103060@208.103.145.20 Action set(outbound_caller_id_number=${default_outbound_caller_id_number}) INLINE
EXECUTE sofia/internal/5615103060@208.103.145.20 set(outbound_caller_id_number=)
2019-01-09 13:07:54.715825 [DEBUG] mod_dptools.c:1598 SET sofia/internal/5615103060@208.103.145.20 [outbound_caller_id_number]=[UNDEF]
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [safebound.cust.tellarc.com->disable-103-109] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [disable-103-109] ${user_exists}(false) =~ /false/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [disable-103-109] ${caller_id_number}(5615103060) =~ /(103)/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 Action hangup()
2019-01-09 13:07:54.715825 [DEBUG] switch_core_state_machine.c:286 (sofia/internal/5615103060@208.103.145.20) State Change CS_ROUTING -> CS_EXECUTE
2019-01-09 13:07:54.715825 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/5615103060@208.103.145.20) State ROUTING going to sleep
2019-01-09 13:07:54.715825 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5615103060@208.103.145.20) Running State Change CS_EXECUTE (Cur 5 Tot 41238)
2019-01-09 13:07:54.715825 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/5615103060@208.103.145.20) State EXECUTE
2019-01-09 13:07:54.715825 [DEBUG] mod_sofia.c:209 sofia/internal/5615103060@208.103.145.20 SOFIA EXECUTE
2019-01-09 13:07:54.715825 [DEBUG] switch_core_state_machine.c:328 sofia/internal/5615103060@208.103.145.20 Standard EXECUTE
EXECUTE sofia/internal/5615103060@208.103.145.20 export(origination_callee_id_name=7601)
2019-01-09 13:07:54.715825 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [origination_callee_id_name]=[7601]
EXECUTE sofia/internal/5615103060@208.103.145.20 set(RFC2822_DATE=Wed, 09 Jan 2019 13:07:54 -0500)
2019-01-09 13:07:54.715825 [DEBUG] mod_dptools.c:1598 SET sofia/internal/5615103060@208.103.145.20 [RFC2822_DATE]=[Wed, 09 Jan 2019 13:07:54 -0500]
EXECUTE sofia/internal/5615103060@208.103.145.20 hash(insert/safebound.cust.tellarc.com-last_dial/5615103060/7601)
EXECUTE sofia/internal/5615103060@208.103.145.20 hangup()
2019-01-09 13:07:54.715825 [NOTICE] mod_dptools.c:1334 Hangup sofia/internal/5615103060@208.103.145.20 [CS_EXECUTE] [NORMAL_CLEARING]
2019-01-09 13:07:54.715825 [DEBUG] switch_core_session.c:2886 sofia/internal/5615103060@208.103.145.20 skip receive message [PHONE_EVENT] (channel is hungup already)
2019-01-09 13:07:54.715825 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/5615103060@208.103.145.20) State EXECUTE going to sleep
2019-01-09 13:07:54.715825 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5615103060@208.103.145.20) Running State Change CS_HANGUP (Cur 5 Tot 41238)
2019-01-09 13:07:54.715825 [DEBUG] switch_core_state_machine.c:847 (sofia/internal/5615103060@208.103.145.20) Callstate Change RINGING -> HANGUP
2019-01-09 13:07:54.715825 [DEBUG] switch_core_state_machine.c:849 (sofia/internal/5615103060@208.103.145.20) State HANGUP
2019-01-09 13:07:54.715825 [DEBUG] mod_sofia.c:449 Channel sofia/internal/5615103060@208.103.145.20 hanging up, cause: NORMAL_CLEARING
2019-01-09 13:07:54.715825 [DEBUG] mod_sofia.c:588 Responding to INVITE with: 480
2019-01-09 13:07:54.715825 [DEBUG] switch_core_state_machine.c:60 sofia/internal/5615103060@208.103.145.20 Standard HANGUP, cause: NORMAL_CLEARING
2019-01-09 13:07:54.715825 [DEBUG] switch_core_state_machine.c:849 (sofia/internal/5615103060@208.103.145.20) State HANGUP going to sleep
2019-01-09 13:07:54.715825 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/5615103060@208.103.145.20) State Change CS_HANGUP -> CS_REPORTING
2019-01-09 13:07:54.715825 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5615103060@208.103.145.20) Running State Change CS_REPORTING (Cur 5 Tot 41238)
2019-01-09 13:07:54.715825 [DEBUG] switch_core_state_machine.c:935 (sofia/internal/5615103060@208.103.145.20) State REPORTING
2019-01-09 13:07:54.775917 [DEBUG] switch_core_state_machine.c:174 sofia/internal/5615103060@208.103.145.20 Standard REPORTING, cause: NORMAL_CLEARING
2019-01-09 13:07:54.775917 [DEBUG] switch_core_state_machine.c:935 (sofia/internal/5615103060@208.103.145.20) State REPORTING going to sleep
2019-01-09 13:07:54.775917 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/5615103060@208.103.145.20) State Change CS_REPORTING -> CS_DESTROY
2019-01-09 13:07:54.775917 [DEBUG] switch_core_session.c:1714 Session 41238 (sofia/internal/5615103060@208.103.145.20) Locked, Waiting on external entities
2019-01-09 13:07:54.775917 [NOTICE] switch_core_session.c:1732 Session 41238 (sofia/internal/5615103060@208.103.145.20) Ended
2019-01-09 13:07:54.775917 [NOTICE] switch_core_session.c:1736 Close Channel sofia/internal/5615103060@208.103.145.20 [CS_DESTROY]
2019-01-09 13:07:54.775917 [DEBUG] switch_core_state_machine.c:738 (sofia/internal/5615103060@208.103.145.20) Running State Change CS_DESTROY (Cur 4 Tot 41238)
2019-01-09 13:07:54.775917 [DEBUG] switch_core_state_machine.c:748 (sofia/internal/5615103060@208.103.145.20) State DESTROY
2019-01-09 13:07:54.775917 [DEBUG] mod_sofia.c:354 sofia/internal/5615103060@208.103.145.20 SOFIA DESTROY
2019-01-09 13:07:54.775917 [DEBUG] switch_core_state_machine.c:181 sofia/internal/5615103060@208.103.145.20 Standard DESTROY
2019-01-09 13:07:54.775917 [DEBUG] switch_core_state_machine.c:748 (sofia/internal/5615103060@208.103.145.20) State DESTROY going to sleep
2019-01-09 13:07:54.895917 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/5615103060@208.103.145.20 [c53f1c97-5462-46a1-8708-6118c64781c3]
2019-01-09 13:07:54.895917 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5615103060@208.103.145.20) Running State Change CS_NEW (Cur 5 Tot 41239)
2019-01-09 13:07:54.895917 [DEBUG] sofia.c:10080 sofia/internal/5615103060@208.103.145.20 receiving invite from 208.103.145.20:5060 version: 1.8.2 -3-a98a958ac3 64bit
2019-01-09 13:07:54.895917 [DEBUG] sofia.c:10196 IP 208.103.145.20 Approved by acl "domains[]". Access Granted.
2019-01-09 13:07:54.915831 [DEBUG] sofia.c:7291 Channel sofia/internal/5615103060@208.103.145.20 entering state [received][100]
2019-01-09 13:07:54.915831 [DEBUG] sofia.c:7301 Remote SDP:
v=0
o=Sonus_UAC 983743 88188 IN IP4 67.231.4.151
s=SIP Media Capabilities
c=IN IP4 67.231.4.11
t=0 0
m=audio 14112 RTP/AVP 0 18 101
a=rtpmap:0 PCMU/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20

2019-01-09 13:07:54.915831 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2019-01-09 13:07:54.915831 [DEBUG] switch_core_media.c:5533 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
2019-01-09 13:07:54.915831 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
2019-01-09 13:07:54.915831 [DEBUG] switch_core_media.c:5394 Set telephone-event payload to 101@8000
2019-01-09 13:07:54.915831 [DEBUG] switch_core_media.c:3781 Set Codec sofia/internal/5615103060@208.103.145.20 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
2019-01-09 13:07:54.915831 [DEBUG] switch_core_codec.c:111 sofia/internal/5615103060@208.103.145.20 Original read codec set to PCMU:0
2019-01-09 13:07:54.915831 [DEBUG] switch_core_media.c:5737 Set telephone-event payload to 101@8000
2019-01-09 13:07:54.915831 [DEBUG] switch_core_media.c:5795 sofia/internal/5615103060@208.103.145.20 Set 2833 dtmf send payload to 101 recv payload to 101
2019-01-09 13:07:54.915831 [DEBUG] sofia.c:7716 (sofia/internal/5615103060@208.103.145.20) State Change CS_NEW -> CS_INIT
2019-01-09 13:07:54.915831 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/5615103060@208.103.145.20) State NEW
2019-01-09 13:07:54.915831 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5615103060@208.103.145.20) Running State Change CS_INIT (Cur 5 Tot 41239)
2019-01-09 13:07:54.915831 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/5615103060@208.103.145.20) State INIT
2019-01-09 13:07:54.915831 [DEBUG] mod_sofia.c:93 sofia/internal/5615103060@208.103.145.20 SOFIA INIT
2019-01-09 13:07:54.915831 [DEBUG] switch_core_state_machine.c:40 sofia/internal/5615103060@208.103.145.20 Standard INIT
2019-01-09 13:07:54.915831 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/5615103060@208.103.145.20) State Change CS_INIT -> CS_ROUTING
2019-01-09 13:07:54.915831 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/5615103060@208.103.145.20) State INIT going to sleep
2019-01-09 13:07:54.915831 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5615103060@208.103.145.20) Running State Change CS_ROUTING (Cur 5 Tot 41239)
2019-01-09 13:07:54.915831 [DEBUG] switch_channel.c:2249 (sofia/internal/5615103060@208.103.145.20) Callstate Change DOWN -> RINGING
2019-01-09 13:07:54.915831 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/5615103060@208.103.145.20) State ROUTING
2019-01-09 13:07:54.915831 [DEBUG] mod_sofia.c:154 sofia/internal/5615103060@208.103.145.20 SOFIA ROUTING
2019-01-09 13:07:54.915831 [DEBUG] switch_core_state_machine.c:236 sofia/internal/5615103060@208.103.145.20 Standard ROUTING
2019-01-09 13:07:54.915831 [INFO] mod_dialplan_xml.c:637 Processing 5615103060 <5615103060>->5615107191 in context public
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->Strip1] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [Strip1] destination_number(5615107191) =~ /^\+?1(\d{10})$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->caller-details] continue=true
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [caller-details] () =~ // break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Action export(call_direction=inbound) INLINE
EXECUTE sofia/internal/5615103060@208.103.145.20 export(call_direction=inbound)
2019-01-09 13:07:54.915831 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [call_direction]=[inbound]
Dialplan: sofia/internal/5615103060@208.103.145.20 Action set(caller_destination=${destination_number}) INLINE
EXECUTE sofia/internal/5615103060@208.103.145.20 set(caller_destination=5615107191)
2019-01-09 13:07:54.915831 [DEBUG] mod_dptools.c:1598 SET sofia/internal/5615103060@208.103.145.20 [caller_destination]=[5615107191]
Dialplan: sofia/internal/5615103060@208.103.145.20 Action set(caller_id_name=${caller_id_name}) INLINE
EXECUTE sofia/internal/5615103060@208.103.145.20 set(caller_id_name=5615103060)
2019-01-09 13:07:54.915831 [DEBUG] mod_dptools.c:1598 SET sofia/internal/5615103060@208.103.145.20 [caller_id_name]=[5615103060]
Dialplan: sofia/internal/5615103060@208.103.145.20 Action set(caller_id_number=${caller_id_number}) INLINE
EXECUTE sofia/internal/5615103060@208.103.145.20 set(caller_id_number=5615103060)
2019-01-09 13:07:54.915831 [DEBUG] mod_dptools.c:1598 SET sofia/internal/5615103060@208.103.145.20 [caller_id_number]=[5615103060]
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->3126101974] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [3126101974] destination_number(5615107191) =~ /^(3126101974)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->3126101975] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [3126101975] destination_number(5615107191) =~ /^(3126101975)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5616895539] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5616895539] destination_number(5615107191) =~ /^(5616895539)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->2143795209] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [2143795209] destination_number(5615107191) =~ /^(2143795209)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->2143754283] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [2143754283] context(public) =~ /public/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [2143754283] destination_number(5615107191) =~ /2143754283/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->2143754522] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [2143754522] context(public) =~ /public/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [2143754522] destination_number(5615107191) =~ /2143754522/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5616159327] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5616159327] destination_number(5615107191) =~ /^(5616159327)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->2143963501] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [2143963501] context(public) =~ /public/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [2143963501] destination_number(5615107191) =~ /2143963501/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->2143963502] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [2143963502] context(public) =~ /public/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [2143963502] destination_number(5615107191) =~ /2143963502/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->4049903292] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [4049903292] context(public) =~ /public/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [4049903292] destination_number(5615107191) =~ /4049903292/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5612707222] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5612707222] destination_number(5615107191) =~ /^(5612707222)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->7722063310] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [7722063310] destination_number(5615107191) =~ /^(7722063310)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->4074391110] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [4074391110] destination_number(5615107191) =~ /^(4074391110)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->9729150256] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [9729150256] destination_number(5615107191) =~ /9729150256/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->9729153669] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [9729153669] destination_number(5615107191) =~ /9729153669/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->9042670830] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [9042670830] destination_number(5615107191) =~ /^(9042670830)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->8442091600] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [8442091600] destination_number(5615107191) =~ /^(8442091600)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->9547732237] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [9547732237] destination_number(5615107191) =~ /^(9547732237)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->8886683002] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [8886683002] destination_number(5615107191) =~ /^(8886683002)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5619038023] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5619038023] destination_number(5615107191) =~ /^(5619038023)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->2143795211] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [2143795211] destination_number(5615107191) =~ /^(2143795211)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5612210577] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5612210577] destination_number(5615107191) =~ /^(5612210577)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->2143795200] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [2143795200] destination_number(5615107191) =~ /^(2143795200)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5616896465] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5616896465] destination_number(5615107191) =~ /^(5616896465)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->3126101966] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [3126101966] destination_number(5615107191) =~ /^(3126101966)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->3126101976] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [3126101976] destination_number(5615107191) =~ /^(3126101976)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->3126101977] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [3126101977] destination_number(5615107191) =~ /^(3126101977)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5616973114] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5616973114] destination_number(5615107191) =~ /^(5616973114)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5616973815] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5616973815] destination_number(5615107191) =~ /^(5616978315)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5616974714] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5616974714] destination_number(5615107191) =~ /^(5616974714)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5616977712] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5616977712] destination_number(5615107191) =~ /^(5616977712)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->6093852005] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [6093852005] destination_number(5615107191) =~ /^(6093852005)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->8172955322] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [8172955322] destination_number(5615107191) =~ /^(8172955322)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->8442734500] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [8442734500] destination_number(5615107191) =~ /^(8442734500)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5612212683] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5612212683] destination_number(5615107191) =~ /^(5612212683)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->6099644227] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [6099644227] destination_number(5615107191) =~ /^(6099644227)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->6096434227] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [6096434227] destination_number(5615107191) =~ /^(6096434227)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->2057781056] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [2057781056] destination_number(5615107191) =~ /^(2057781056)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->3233912190] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [3233912190] destination_number(5615107191) =~ /^(3233912190)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5615012195] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5615012195] destination_number(5615107191) =~ /^(5615012195)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->9043234108] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [9043234108] destination_number(5615107191) =~ /^(9043234108)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->8135185370] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [8135185370] destination_number(5615107191) =~ /^(8135185370)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->6197710870] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [6197710870] destination_number(5615107191) =~ /^(6197710870)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->2027505070] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [2027505070] destination_number(5615107191) =~ /^(2027505070)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->2036538124] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [2036538124] destination_number(5615107191) =~ /^(2036538124)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->3015495139] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [3015495139] destination_number(5615107191) =~ /^(3015495139)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->3026088210] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [3026088210] destination_number(5615107191) =~ /^(3026088210)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->3036320348] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [3036320348] destination_number(5615107191) =~ /^(3036320348)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->6178298052] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [6178298052] destination_number(5615107191) =~ /^(6178298052)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->6037829338] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [6037829338] destination_number(5615107191) =~ /^(6037829338)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->3129670945] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [3129670945] destination_number(5615107191) =~ /^(3129670945)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->3144926281] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [3144926281] destination_number(5615107191) =~ /^(3144926281)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->3162269059] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [3162269059] destination_number(5615107191) =~ /^(3162269059)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->4029941152] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [4029941152] destination_number(5615107191) =~ /^(4029941152)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->4133380762] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [4133380762] destination_number(5615107191) =~ /^(4133380762)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5042268640] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5042268640] destination_number(5615107191) =~ /^(5042268640)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5153484266] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5153484266] destination_number(5615107191) =~ /^(5153484266)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->6098089024] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [6098089024] destination_number(5615107191) =~ /^(6098089024)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->2015824897] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [2015824897] destination_number(5615107191) =~ /^(2015824897)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->2152546485] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [2152546485] destination_number(5615107191) =~ /^(2152546485)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->4014065053] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [4014065053] destination_number(5615107191) =~ /^(4014065053)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->4054938264] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [4054938264] destination_number(5615107191) =~ /^(4054938264)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->4122478030] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [4122478030] destination_number(5615107191) =~ /^(4122478030)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5052747244] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5052747244] destination_number(5615107191) =~ /^(5052747244)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5163094156] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5163094156] destination_number(5615107191) =~ /^(5163094156)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5188701720] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5188701720] destination_number(5615107191) =~ /^(5188701720)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->9152013757] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [9152013757] destination_number(5615107191) =~ /^(9152013757)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->8024482722] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [8024482722] destination_number(5615107191) =~ /^(8024482722)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->7038260079] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [7038260079] destination_number(5615107191) =~ /^(7038260079)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->2062603558] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [2062603558] destination_number(5615107191) =~ /^(2062603558)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->2817693212] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [2817693212] destination_number(5615107191) =~ /^(2817693212)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->3047699047] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [3047699047] destination_number(5615107191) =~ /^(3047699047)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->4692498581] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [4692498581] destination_number(5615107191) =~ /^(4692498581)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5129801039] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5129801039] destination_number(5615107191) =~ /^(5129801039)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5618921821] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5618921821] destination_number(5615107191) =~ /^(5618921821)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5619105870] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5619105870] destination_number(5615107191) =~ /^(5619105870)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5614030949] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5614030949] destination_number(5615107191) =~ /^(5614030949)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5612886116] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5612886116] destination_number(5615107191) =~ /^(5612886116)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5615717845] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5615717845] destination_number(5615107191) =~ /^(5615717845)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5619238029] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5619238029] destination_number(5615107191) =~ /^(5619238029)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5612886171] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5612886171] destination_number(5615107191) =~ /^(5612886171)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5027711448] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5027711448] destination_number(5615107191) =~ /^(5027711448)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5618155060] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5618155060] destination_number(5615107191) =~ /^(5618155060)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->2162394389] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [2162394389] destination_number(5615107191) =~ /^(2162394389)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->7024460961] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [7024460961] destination_number(5615107191) =~ /^(7024460961)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5618155665] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5618155665] destination_number(5615107191) =~ /^(5618155665)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5619038016] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5619038016] destination_number(5615107191) =~ /^(5619038016)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5619038017] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [5619038017] destination_number(5615107191) =~ /^(5619038017)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->7046261394] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [7046261394] destination_number(5615107191) =~ /^(7046261394)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->6155703001] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [6155703001] destination_number(5615107191) =~ /^(6155703001)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [public->5615107191] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [5615107191] destination_number(5615107191) =~ /^(5615107191)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 Action export(call_direction=inbound) INLINE
EXECUTE sofia/internal/5615103060@208.103.145.20 export(call_direction=inbound)
2019-01-09 13:07:54.915831 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [call_direction]=[inbound]
Dialplan: sofia/internal/5615103060@208.103.145.20 Action set(domain_uuid=5a8591c8-67c6-4bc6-bb0d-264045139762) INLINE
EXECUTE sofia/internal/5615103060@208.103.145.20 set(domain_uuid=5a8591c8-67c6-4bc6-bb0d-264045139762)
2019-01-09 13:07:54.915831 [DEBUG] mod_dptools.c:1598 SET sofia/internal/5615103060@208.103.145.20 [domain_uuid]=[5a8591c8-67c6-4bc6-bb0d-264045139762]
Dialplan: sofia/internal/5615103060@208.103.145.20 Action set(domain_name=safebound.cust.tellarc.com) INLINE
EXECUTE sofia/internal/5615103060@208.103.145.20 set(domain_name=safebound.cust.tellarc.com)
2019-01-09 13:07:54.915831 [DEBUG] mod_dptools.c:1598 SET sofia/internal/5615103060@208.103.145.20 [domain_name]=[safebound.cust.tellarc.com]
Dialplan: sofia/internal/5615103060@208.103.145.20 Action set(hangup_after_bridge=true)
Dialplan: sofia/internal/5615103060@208.103.145.20 Action set(continue_on_fail=true)
Dialplan: sofia/internal/5615103060@208.103.145.20 Action transfer(7601 XML safebound.cust.tellarc.com)
2019-01-09 13:07:54.915831 [DEBUG] switch_core_state_machine.c:286 (sofia/internal/5615103060@208.103.145.20) State Change CS_ROUTING -> CS_EXECUTE
2019-01-09 13:07:54.915831 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/5615103060@208.103.145.20) State ROUTING going to sleep
2019-01-09 13:07:54.915831 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5615103060@208.103.145.20) Running State Change CS_EXECUTE (Cur 5 Tot 41239)
2019-01-09 13:07:54.915831 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/5615103060@208.103.145.20) State EXECUTE
2019-01-09 13:07:54.915831 [DEBUG] mod_sofia.c:209 sofia/internal/5615103060@208.103.145.20 SOFIA EXECUTE
2019-01-09 13:07:54.915831 [DEBUG] switch_core_state_machine.c:328 sofia/internal/5615103060@208.103.145.20 Standard EXECUTE
EXECUTE sofia/internal/5615103060@208.103.145.20 set(hangup_after_bridge=true)
2019-01-09 13:07:54.915831 [DEBUG] mod_dptools.c:1598 SET sofia/internal/5615103060@208.103.145.20 [hangup_after_bridge]=[true]
EXECUTE sofia/internal/5615103060@208.103.145.20 set(continue_on_fail=true)
2019-01-09 13:07:54.915831 [DEBUG] mod_dptools.c:1598 SET sofia/internal/5615103060@208.103.145.20 [continue_on_fail]=[true]
EXECUTE sofia/internal/5615103060@208.103.145.20 transfer(7601 XML safebound.cust.tellarc.com)
2019-01-09 13:07:54.915831 [DEBUG] switch_ivr.c:2207 (sofia/internal/5615103060@208.103.145.20) State Change CS_EXECUTE -> CS_ROUTING
2019-01-09 13:07:54.915831 [NOTICE] switch_ivr.c:2214 Transfer sofia/internal/5615103060@208.103.145.20 to XML[7601@safebound.cust.tellarc.com]
2019-01-09 13:07:54.915831 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/5615103060@208.103.145.20) State EXECUTE going to sleep
2019-01-09 13:07:54.915831 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5615103060@208.103.145.20) Running State Change CS_ROUTING (Cur 5 Tot 41239)
2019-01-09 13:07:54.915831 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/5615103060@208.103.145.20) State ROUTING
2019-01-09 13:07:54.915831 [DEBUG] mod_sofia.c:145 Call appears to be already acknowledged
2019-01-09 13:07:54.915831 [DEBUG] mod_sofia.c:154 sofia/internal/5615103060@208.103.145.20 SOFIA ROUTING
2019-01-09 13:07:54.915831 [DEBUG] switch_core_state_machine.c:236 sofia/internal/5615103060@208.103.145.20 Standard ROUTING
2019-01-09 13:07:54.915831 [INFO] mod_dialplan_xml.c:637 Processing 5615103060 <5615103060>->7601 in context safebound.cust.tellarc.com
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [safebound.cust.tellarc.com->user_exists] continue=true
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [user_exists] () =~ // break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 Action set(user_exists=${user_exists id ${destination_number} ${domain_name}}) INLINE
EXECUTE sofia/internal/5615103060@208.103.145.20 set(user_exists=false)
2019-01-09 13:07:54.935915 [DEBUG] mod_dptools.c:1598 SET sofia/internal/5615103060@208.103.145.20 [user_exists]=[false]
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_exists] ${user_exists}(false) =~ /^true$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [safebound.cust.tellarc.com->caller-details] continue=true
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [caller-details] ${caller_destination}(5615107191) =~ /^$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [safebound.cust.tellarc.com->call-direction] continue=true
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [call-direction] ${call_direction}(inbound) =~ /^(inbound|outbound|local)$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [safebound.cust.tellarc.com->variables] continue=true
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [variables] () =~ // break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 Action export(origination_callee_id_name=${destination_number})
Dialplan: sofia/internal/5615103060@208.103.145.20 Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [safebound.cust.tellarc.com->user_record] continue=true
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [user_record] () =~ // break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 Action set(user_record=${user_data ${destination_number}@${domain_name} var user_record}) INLINE
EXECUTE sofia/internal/5615103060@208.103.145.20 set(user_record=)
2019-01-09 13:07:54.955886 [DEBUG] mod_dptools.c:1598 SET sofia/internal/5615103060@208.103.145.20 [user_record]=[UNDEF]
Dialplan: sofia/internal/5615103060@208.103.145.20 Action set(from_user_exists=${user_exists id ${sip_from_user} ${sip_from_host}}) INLINE
EXECUTE sofia/internal/5615103060@208.103.145.20 set(from_user_exists=false)
2019-01-09 13:07:54.955886 [DEBUG] mod_dptools.c:1598 SET sofia/internal/5615103060@208.103.145.20 [from_user_exists]=[false]
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${user_record}() =~ /^all$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [user_record] ${call_direction}(inbound) =~ /^inbound$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${user_record}() =~ /^inbound$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^outbound$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${user_record}() =~ /^outbound$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^local$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${user_record}() =~ /^local$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${from_user_record}() =~ /^all$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [user_record] ${call_direction}(inbound) =~ /^inbound$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${from_user_record}() =~ /^inbound$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^outbound$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${from_user_record}() =~ /^outbound$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^local$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${from_user_record}() =~ /^local$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [user_record] ${record_session}() =~ /^true$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [safebound.cust.tellarc.com->redial] continue=true
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [redial] destination_number(7601) =~ /^(redial|\*870)$/ break=on-true
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [redial] () =~ // break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [safebound.cust.tellarc.com->speed_dial] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (FAIL) [speed_dial] destination_number(7601) =~ /^\*0(.*)$/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [safebound.cust.tellarc.com->default_caller_id] continue=true
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [default_caller_id] ${emergency_caller_id_number}() =~ /^$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Action set(emergency_caller_id_name=${default_emergency_caller_id_name}) INLINE
EXECUTE sofia/internal/5615103060@208.103.145.20 set(emergency_caller_id_name=)
2019-01-09 13:07:54.955886 [DEBUG] mod_dptools.c:1598 SET sofia/internal/5615103060@208.103.145.20 [emergency_caller_id_name]=[UNDEF]
Dialplan: sofia/internal/5615103060@208.103.145.20 Action set(emergency_caller_id_number=${default_emergency_caller_id_number}) INLINE
EXECUTE sofia/internal/5615103060@208.103.145.20 set(emergency_caller_id_number=)
2019-01-09 13:07:54.955886 [DEBUG] mod_dptools.c:1598 SET sofia/internal/5615103060@208.103.145.20 [emergency_caller_id_number]=[UNDEF]
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [default_caller_id] ${outbound_caller_id_number}() =~ /^$/ break=never
Dialplan: sofia/internal/5615103060@208.103.145.20 Action set(outbound_caller_id_name=${default_outbound_caller_id_name}) INLINE
EXECUTE sofia/internal/5615103060@208.103.145.20 set(outbound_caller_id_name=)
2019-01-09 13:07:54.955886 [DEBUG] mod_dptools.c:1598 SET sofia/internal/5615103060@208.103.145.20 [outbound_caller_id_name]=[UNDEF]
Dialplan: sofia/internal/5615103060@208.103.145.20 Action set(outbound_caller_id_number=${default_outbound_caller_id_number}) INLINE
EXECUTE sofia/internal/5615103060@208.103.145.20 set(outbound_caller_id_number=)
2019-01-09 13:07:54.955886 [DEBUG] mod_dptools.c:1598 SET sofia/internal/5615103060@208.103.145.20 [outbound_caller_id_number]=[UNDEF]
Dialplan: sofia/internal/5615103060@208.103.145.20 parsing [safebound.cust.tellarc.com->disable-103-109] continue=false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [disable-103-109] ${user_exists}(false) =~ /false/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 Regex (PASS) [disable-103-109] ${caller_id_number}(5615103060) =~ /(103)/ break=on-false
Dialplan: sofia/internal/5615103060@208.103.145.20 Action hangup()
2019-01-09 13:07:54.955886 [DEBUG] switch_core_state_machine.c:286 (sofia/internal/5615103060@208.103.145.20) State Change CS_ROUTING -> CS_EXECUTE
2019-01-09 13:07:54.955886 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/5615103060@208.103.145.20) State ROUTING going to sleep
2019-01-09 13:07:54.955886 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5615103060@208.103.145.20) Running State Change CS_EXECUTE (Cur 5 Tot 41239)
2019-01-09 13:07:54.955886 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/5615103060@208.103.145.20) State EXECUTE
2019-01-09 13:07:54.955886 [DEBUG] mod_sofia.c:209 sofia/internal/5615103060@208.103.145.20 SOFIA EXECUTE
2019-01-09 13:07:54.955886 [DEBUG] switch_core_state_machine.c:328 sofia/internal/5615103060@208.103.145.20 Standard EXECUTE
EXECUTE sofia/internal/5615103060@208.103.145.20 export(origination_callee_id_name=7601)
2019-01-09 13:07:54.955886 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [origination_callee_id_name]=[7601]
EXECUTE sofia/internal/5615103060@208.103.145.20 set(RFC2822_DATE=Wed, 09 Jan 2019 13:07:54 -0500)
2019-01-09 13:07:54.975876 [DEBUG] mod_dptools.c:1598 SET sofia/internal/5615103060@208.103.145.20 [RFC2822_DATE]=[Wed, 09 Jan 2019 13:07:54 -0500]
EXECUTE sofia/internal/5615103060@208.103.145.20 hash(insert/safebound.cust.tellarc.com-last_dial/5615103060/7601)
EXECUTE sofia/internal/5615103060@208.103.145.20 hangup()
2019-01-09 13:07:54.975876 [NOTICE] mod_dptools.c:1334 Hangup sofia/internal/5615103060@208.103.145.20 [CS_EXECUTE] [NORMAL_CLEARING]
2019-01-09 13:07:54.975876 [DEBUG] switch_core_session.c:2886 sofia/internal/5615103060@208.103.145.20 skip receive message [PHONE_EVENT] (channel is hungup already)
2019-01-09 13:07:54.975876 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/5615103060@208.103.145.20) State EXECUTE going to sleep
2019-01-09 13:07:54.975876 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5615103060@208.103.145.20) Running State Change CS_HANGUP (Cur 5 Tot 41239)
2019-01-09 13:07:54.975876 [DEBUG] switch_core_state_machine.c:847 (sofia/internal/5615103060@208.103.145.20) Callstate Change RINGING -> HANGUP
2019-01-09 13:07:54.975876 [DEBUG] switch_core_state_machine.c:849 (sofia/internal/5615103060@208.103.145.20) State HANGUP
2019-01-09 13:07:54.975876 [DEBUG] mod_sofia.c:449 Channel sofia/internal/5615103060@208.103.145.20 hanging up, cause: NORMAL_CLEARING
2019-01-09 13:07:54.975876 [DEBUG] mod_sofia.c:588 Responding to INVITE with: 480
2019-01-09 13:07:54.975876 [DEBUG] switch_core_state_machine.c:60 sofia/internal/5615103060@208.103.145.20 Standard HANGUP, cause: NORMAL_CLEARING
2019-01-09 13:07:54.975876 [DEBUG] switch_core_state_machine.c:849 (sofia/internal/5615103060@208.103.145.20) State HANGUP going to sleep
2019-01-09 13:07:54.975876 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/5615103060@208.103.145.20) State Change CS_HANGUP -> CS_REPORTING
2019-01-09 13:07:54.975876 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5615103060@208.103.145.20) Running State Change CS_REPORTING (Cur 5 Tot 41239)
2019-01-09 13:07:54.975876 [DEBUG] switch_core_state_machine.c:935 (sofia/internal/5615103060@208.103.145.20) State REPORTING
2019-01-09 13:07:55.015848 [DEBUG] switch_core_state_machine.c:174 sofia/internal/5615103060@208.103.145.20 Standard REPORTING, cause: NORMAL_CLEARING
2019-01-09 13:07:55.015848 [DEBUG] switch_core_state_machine.c:935 (sofia/internal/5615103060@208.103.145.20) State REPORTING going to sleep
2019-01-09 13:07:55.015848 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/5615103060@208.103.145.20) State Change CS_REPORTING -> CS_DESTROY
2019-01-09 13:07:55.015848 [DEBUG] switch_core_session.c:1714 Session 41239 (sofia/internal/5615103060@208.103.145.20) Locked, Waiting on external entities
2019-01-09 13:07:55.015848 [NOTICE] switch_core_session.c:1732 Session 41239 (sofia/internal/5615103060@208.103.145.20) Ended
2019-01-09 13:07:55.015848 [NOTICE] switch_core_session.c:1736 Close Channel sofia/internal/5615103060@208.103.145.20 [CS_DESTROY]
2019-01-09 13:07:55.015848 [DEBUG] switch_core_state_machine.c:738 (sofia/internal/5615103060@208.103.145.20) Running State Change CS_DESTROY (Cur 4 Tot 41239)
2019-01-09 13:07:55.015848 [DEBUG] switch_core_state_machine.c:748 (sofia/internal/5615103060@208.103.145.20) State DESTROY
2019-01-09 13:07:55.015848 [DEBUG] mod_sofia.c:354 sofia/internal/5615103060@208.103.145.20 SOFIA DESTROY
2019-01-09 13:07:55.015848 [DEBUG] switch_core_state_machine.c:181 sofia/internal/5615103060@208.103.145.20 Standard DESTROY
2019-01-09 13:07:55.015848 [DEBUG] switch_core_state_machine.c:748 (sofia/internal/5615103060@208.103.145.20) State DESTROY going to sleep
2019-01-09 13:08:01.355949 [DEBUG] sofia.c:7291 Channel sofia/internal/9253390851 entering state [completing][200]
2019-01-09 13:08:01.355949 [DEBUG] sofia.c:7298 Duplicate SDP
v=0
o=Sonus_UAC 539626 956559 IN IP4 207.223.67.69
s=SIP Media Capabilities
c=IN IP4 207.223.67.30
t=0 0
m=audio 18026 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:20

2019-01-09 13:08:01.395870 [DEBUG] sofia.c:7291 Channel sofia/internal/9253390851 entering state [ready][200]
2019-01-09 13:08:01.395870 [NOTICE] sofia.c:8370 Channel [sofia/internal/9253390851] has been answered
2019-01-09 13:08:01.395870 [DEBUG] switch_channel.c:3781 (sofia/internal/9253390851) Callstate Change EARLY -> ACTIVE
2019-01-09 13:08:01.455912 [DEBUG] switch_rtp.c:7550 Correct audio ip/port confirmed.