Inbound call not work, only with use one domain and use context public. If i use domain sub.domain.com not work. Only inbound not work.
If i call between extensions work fine and outbound work too. Other detail, if redirect inbound call to ring group work. Only not work with inbound redirect to extension direct.
My log
2019-05-29 15:40:35.750532 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/XXXXX0166@Y.Y.Y.Y [3f46864a-8241-11e9-bc3f-91bf451741b2]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/XXXXX0166@Y.Y.Y.Y) Running State Change CS_NEW (Cur 2 Tot 493)
2019-05-29 15:40:35.750532 [DEBUG] sofia.c:9873 sofia/internal/XXXXX0166@Y.Y.Y.Y receiving invite from Z.Z.Z.Z:5060 version: 1.6.20 64bit
2019-05-29 15:40:35.750532 [DEBUG] sofia.c:9989 IP Z.Z.Z.Z Approved by acl "domains[]". Access Granted.
2019-05-29 15:40:35.750532 [DEBUG] sofia.c:10721 sofia/internal/XXXXX0166@Y.Y.Y.Y setting variable [sip_cid_type]=[pid]
2019-05-29 15:40:35.750532 [DEBUG] sofia.c:11168 Setting NAT mode based on via received
2019-05-29 15:40:35.750532 [DEBUG] sofia.c:7084 Channel sofia/internal/XXXXX0166@Y.Y.Y.Y entering state [received][100]
2019-05-29 15:40:35.750532 [DEBUG] sofia.c:7094 Remote SDP:
v=0
o=root 3399 3399 IN IP4 Y.Y.Y.Y
s=session
c=IN IP4 Y.Y.Y.Y
t=0 0
m=audio 11086 RTP/AVP 0 8 97 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:97 iLBC/8000
a=fmtp:97 mode=30
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp
ff - - - -
a=ptime:20
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G7221:115:32000:20:48000:1]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G7221:107:16000:20:32000:1]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G7221:115:32000:20:48000:1]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G7221:107:16000:20:32000:1]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [iLBC:97:8000:20:0:1]/[G7221:115:32000:20:48000:1]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [iLBC:97:8000:20:0:1]/[G7221:107:16000:20:32000:1]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [iLBC:97:8000:20:0:1]/[G722:9:8000:20:64000:1]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [iLBC:97:8000:20:0:1]/[PCMU:0:8000:20:64000:1]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [iLBC:97:8000:20:0:1]/[PCMA:8:8000:20:64000:1]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4365 Set telephone-event payload to 101@8000
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:3061 Set Codec sofia/internal/XXXXX0166@Y.Y.Y.Y PCMU/8000 20 ms 160 samples 64000 bits 1 channels
2019-05-29 15:40:35.750532 [DEBUG] switch_core_codec.c:111 sofia/internal/XXXXX0166@Y.Y.Y.Y Original read codec set to PCMU:0
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4708 Set telephone-event payload to 101@8000
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4767 sofia/internal/XXXXX0166@Y.Y.Y.Y Set 2833 dtmf send payload to 101 recv payload to 101
2019-05-29 15:40:35.750532 [DEBUG] sofia.c:7507 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State Change CS_NEW -> CS_INIT
2019-05-29 15:40:35.750532 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State NEW
2019-05-29 15:40:35.750532 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/XXXXX0166@Y.Y.Y.Y) Running State Change CS_INIT (Cur 2 Tot 493)
2019-05-29 15:40:35.750532 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State INIT
2019-05-29 15:40:35.750532 [DEBUG] mod_sofia.c:90 sofia/internal/XXXXX0166@Y.Y.Y.Y SOFIA INIT
2019-05-29 15:40:35.750532 [DEBUG] switch_core_state_machine.c:40 sofia/internal/XXXXX0166@Y.Y.Y.Y Standard INIT
2019-05-29 15:40:35.750532 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State Change CS_INIT -> CS_ROUTING
2019-05-29 15:40:35.750532 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State INIT going to sleep
2019-05-29 15:40:35.750532 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/XXXXX0166@Y.Y.Y.Y) Running State Change CS_ROUTING (Cur 2 Tot 493)
2019-05-29 15:40:35.750532 [DEBUG] switch_channel.c:2249 (sofia/internal/XXXXX0166@Y.Y.Y.Y) Callstate Change DOWN -> RINGING
2019-05-29 15:40:35.750532 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State ROUTING
2019-05-29 15:40:35.750532 [DEBUG] mod_sofia.c:143 sofia/internal/XXXXX0166@Y.Y.Y.Y SOFIA ROUTING
2019-05-29 15:40:35.750532 [DEBUG] switch_core_state_machine.c:236 sofia/internal/XXXXX0166@Y.Y.Y.Y Standard ROUTING
2019-05-29 15:40:35.750532 [INFO] mod_dialplan_xml.c:637 Processing Ramal 104 <XXXXX0166>->2115001588 in context sub.domain.com.br
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->caller-details] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->user_exists] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [user_exists] () =~ // break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(user_exists=${user_exists id ${destination_number} ${domain_name}}) INLINE
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(user_exists=false)
2019-05-29 15:40:35.750532 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [user_exists]=[false]
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_exists] ${user_exists}(false) =~ /^true$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->variables] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [variables] () =~ // break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action export(origination_callee_id_name=${destination_number})
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->call-direction] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [call-direction] ${call_direction}() =~ /^(inbound|outbound|local)$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y ANTI-Action export(call_direction=local) INLINE
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y export(call_direction=local)
2019-05-29 15:40:35.750532 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [call_direction]=[local]
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->user_record] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [user_record] () =~ // break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(from_user_exists=${user_exists id ${sip_from_user} ${sip_from_host}}) INLINE
2019-05-29 15:40:35.770533 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7fe85816c860 Connected.
2019-05-29 15:40:35.770533 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7fe85816c860 released.
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(from_user_exists=false)
2019-05-29 15:40:35.770533 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [from_user_exists]=[false]
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_record}() =~ /^all$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${call_direction}(local) =~ /^inbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_record}() =~ /^inbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${call_direction}(local) =~ /^outbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_record}() =~ /^outbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [user_record] ${call_direction}(local) =~ /^local$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_record}() =~ /^local$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_record}() =~ /^all$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${call_direction}(local) =~ /^inbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_record}() =~ /^inbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${call_direction}(local) =~ /^outbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_record}() =~ /^outbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [user_record] ${call_direction}(local) =~ /^local$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_record}() =~ /^local$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${record_session}() =~ /^true$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->redial] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [redial] destination_number(2115001588) =~ /^(redial|\*870)$/ break=on-true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [redial] () =~ // break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->speed_dial] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [speed_dial] destination_number(2115001588) =~ /^\*0(.*)$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->default_caller_id] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [default_caller_id] ${emergency_caller_id_number}() =~ /^$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(emergency_caller_id_name=${default_emergency_caller_id_name}) INLINE
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(emergency_caller_id_name=)
2019-05-29 15:40:35.770533 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [emergency_caller_id_name]=[UNDEF]
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(emergency_caller_id_number=${default_emergency_caller_id_number}) INLINE
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(emergency_caller_id_number=)
2019-05-29 15:40:35.770533 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [emergency_caller_id_number]=[UNDEF]
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [default_caller_id] ${outbound_caller_id_number}() =~ /^$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(outbound_caller_id_name=${default_outbound_caller_id_name}) INLINE
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(outbound_caller_id_name=)
2019-05-29 15:40:35.770533 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [outbound_caller_id_name]=[UNDEF]
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(outbound_caller_id_number=${default_outbound_caller_id_number}) INLINE
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(outbound_caller_id_number=)
2019-05-29 15:40:35.770533 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [outbound_caller_id_number]=[UNDEF]
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->2115001588] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [2115001588] destination_number(2115001588) =~ /^(2115001588)$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(hangup_after_bridge=true)
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(continue_on_fail=true)
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action transfer(1204 XML sub.domain.com.br)
2019-05-29 15:40:35.770533 [DEBUG] switch_core_state_machine.c:286 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State Change CS_ROUTING -> CS_EXECUTE
2019-05-29 15:40:35.770533 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State ROUTING going to sleep
2019-05-29 15:40:35.770533 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/XXXXX0166@Y.Y.Y.Y) Running State Change CS_EXECUTE (Cur 2 Tot 493)
2019-05-29 15:40:35.770533 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State EXECUTE
2019-05-29 15:40:35.770533 [DEBUG] mod_sofia.c:198 sofia/internal/XXXXX0166@Y.Y.Y.Y SOFIA EXECUTE
2019-05-29 15:40:35.770533 [DEBUG] switch_core_state_machine.c:328 sofia/internal/XXXXX0166@Y.Y.Y.Y Standard EXECUTE
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y export(origination_callee_id_name=2115001588)
2019-05-29 15:40:35.770533 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [origination_callee_id_name]=[2115001588]
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(RFC2822_DATE=Wed, 29 May 2019 15:40:35 -0300)
2019-05-29 15:40:35.770533 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [RFC2822_DATE]=[Wed, 29 May 2019 15:40:35 -0300]
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y hash(insert/-last_dial/XXXXX0166/2115001588)
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(hangup_after_bridge=true)
2019-05-29 15:40:35.770533 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [hangup_after_bridge]=[true]
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(continue_on_fail=true)
2019-05-29 15:40:35.770533 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [continue_on_fail]=[true]
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y transfer(1204 XML sub.domain.com.br)
2019-05-29 15:40:35.770533 [DEBUG] switch_ivr.c:2165 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State Change CS_EXECUTE -> CS_ROUTING
2019-05-29 15:40:35.770533 [NOTICE] switch_ivr.c:2172 Transfer sofia/internal/XXXXX0166@Y.Y.Y.Y to XML[1204@sub.domain.com.br]
2019-05-29 15:40:35.770533 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State EXECUTE going to sleep
2019-05-29 15:40:35.770533 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/XXXXX0166@Y.Y.Y.Y) Running State Change CS_ROUTING (Cur 2 Tot 493)
2019-05-29 15:40:35.770533 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State ROUTING
2019-05-29 15:40:35.770533 [DEBUG] mod_sofia.c:143 sofia/internal/XXXXX0166@Y.Y.Y.Y SOFIA ROUTING
2019-05-29 15:40:35.770533 [DEBUG] switch_core_state_machine.c:236 sofia/internal/XXXXX0166@Y.Y.Y.Y Standard ROUTING
2019-05-29 15:40:35.770533 [INFO] mod_dialplan_xml.c:637 Processing Ramal 104 <XXXXX0166>->1204 in context sub.domain.com.br
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->caller-details] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->user_exists] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [user_exists] () =~ // break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(user_exists=${user_exists id ${destination_number} ${domain_name}}) INLINE
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(user_exists=false)
2019-05-29 15:40:35.770533 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [user_exists]=[false]
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_exists] ${user_exists}(false) =~ /^true$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->variables] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [variables] () =~ // break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action export(origination_callee_id_name=${destination_number})
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->call-direction] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [call-direction] ${call_direction}(local) =~ /^(inbound|outbound|local)$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->user_record] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [user_record] () =~ // break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(from_user_exists=${user_exists id ${sip_from_user} ${sip_from_host}}) INLINE
2019-05-29 15:40:35.790541 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7fe85816c860 Connected.
2019-05-29 15:40:35.790541 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7fe85816c860 released.
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(from_user_exists=false)
2019-05-29 15:40:35.790541 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [from_user_exists]=[false]
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_record}() =~ /^all$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${call_direction}(local) =~ /^inbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_record}() =~ /^inbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${call_direction}(local) =~ /^outbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_record}() =~ /^outbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [user_record] ${call_direction}(local) =~ /^local$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_record}() =~ /^local$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_record}() =~ /^all$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${call_direction}(local) =~ /^inbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_record}() =~ /^inbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${call_direction}(local) =~ /^outbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_record}() =~ /^outbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [user_record] ${call_direction}(local) =~ /^local$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_record}() =~ /^local$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${record_session}() =~ /^true$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->redial] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [redial] destination_number(1204) =~ /^(redial|\*870)$/ break=on-true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [redial] () =~ // break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->speed_dial] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [speed_dial] destination_number(1204) =~ /^\*0(.*)$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->default_caller_id] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [default_caller_id] ${emergency_caller_id_number}() =~ /^$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(emergency_caller_id_name=${default_emergency_caller_id_name}) INLINE
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(emergency_caller_id_name=)
2019-05-29 15:40:35.790541 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [emergency_caller_id_name]=[UNDEF]
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(emergency_caller_id_number=${default_emergency_caller_id_number}) INLINE
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(emergency_caller_id_number=)
2019-05-29 15:40:35.790541 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [emergency_caller_id_number]=[UNDEF]
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [default_caller_id] ${outbound_caller_id_number}() =~ /^$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(outbound_caller_id_name=${default_outbound_caller_id_name}) INLINE
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(outbound_caller_id_name=)
2019-05-29 15:40:35.790541 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [outbound_caller_id_name]=[UNDEF]
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(outbound_caller_id_number=${default_outbound_caller_id_number}) INLINE
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(outbound_caller_id_number=)
2019-05-29 15:40:35.790541 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [outbound_caller_id_number]=[UNDEF]
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->2115001588] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [2115001588] destination_number(1204) =~ /^(2115001588)$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->UPLINK_IC.9d] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [UPLINK_IC.9d] ${user_exists}(false) =~ /false/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [UPLINK_IC.9d] destination_number(1204) =~ /^(\d{9})$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->ring group] continue=
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [ring group] destination_number(1204) =~ /^801$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->agent_status] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [agent_status] destination_number(1204) =~ /^\*22$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->agent_status_id] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [agent_status_id] destination_number(1204) =~ /^\*23$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->group-intercept] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [group-intercept] destination_number(1204) =~ /^\*8$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->page-extension] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [page-extension] destination_number(1204) =~ /^\*8(\d{2,7})$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->eavesdrop] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [eavesdrop] destination_number(1204) =~ /^\*33(\d{2,7})$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->call_privacy] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [call_privacy] destination_number(1204) =~ /^\*67(\d+)$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->call_return] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [call_return] destination_number(1204) =~ /^\*69$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->intercept-ext] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [intercept-ext] destination_number(1204) =~ /^\*\*(\d+)$/ break=on-true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [intercept-ext] destination_number(1204) =~ /^\*\*$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->extension_queue] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [extension_queue] destination_number(1204) =~ /^\*800(.*)$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->intercept-ext-polycom] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [intercept-ext-polycom] destination_number(1204) =~ /^\*97(\d+)$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->dx] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [dx] destination_number(1204) =~ /^dx$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->send_to_voicemail] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [send_to_voicemail] destination_number(1204) =~ /^\*99(\d{2,10})$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->att_xfer] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [att_xfer] destination_number(1204) =~ /^att_xfer$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->extension-to-voicemail] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [extension-to-voicemail] ${user_exists}(false) =~ /^true$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->xfer_vm] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [xfer_vm] destination_number(1204) =~ /^xfer_vm$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->vmain] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [vmain] destination_number(1204) =~ /^vmain$|^\*4000$|^\*98$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [vmain] destination_number(1204) =~ /^(vmain$|^\*4000$|^\*98)(\d{2,12})$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->vmain_user] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [vmain_user] destination_number(1204) =~ /^\*97$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->is_transfer] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [is_transfer] destination_number(1204) =~ /^is_transfer$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->delay_echo] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [delay_echo] destination_number(1204) =~ /^\*9195$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->cf] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [cf] destination_number(1204) =~ /^cf$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->echo] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [echo] destination_number(1204) =~ /^\*9196$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->milliwatt] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [milliwatt] destination_number(1204) =~ /^\*9197$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->is_zrtp_secure] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [is_zrtp_secure] ${zrtp_secure_media_confirmed}() =~ /^true$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y ANTI-Action eval(not_secure)
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->is_secure] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [is_secure] ${sip_via_protocol}(udp) =~ /tls/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->tone_stream] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [tone_stream] destination_number(1204) =~ /^\*9198$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->hold_music] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [hold_music] destination_number(1204) =~ /^\*9664$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->recordings] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [recordings] destination_number(1204) =~ /^\*(732)$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->directory] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [directory] destination_number(1204) =~ /^\*411$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->wake-up] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [wake-up] destination_number(1204) =~ /^\*(925)$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->valet_park] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [valet_park] destination_number(1204) =~ /^(park\+)?\*(59[0-9][0-9])$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [valet_park] ${sip_h_Referred-By}() =~ /sip.*)@.*/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [valet_park] destination_number(1204) =~ /^(park\+)?\*(59[0-9][0-9])$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [valet_park] destination_number(1204) =~ /^(park\+)?\*(59[0-9][0-9])$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->operator] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [operator] destination_number(1204) =~ /^0$|^operator$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->operator-forward] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [operator-forward] destination_number(1204) =~ /^\*000$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->do-not-disturb] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [do-not-disturb] destination_number(1204) =~ /^\*77$/ break=on-true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [do-not-disturb] destination_number(1204) =~ /^\*78$|\*363$/ break=on-true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [do-not-disturb] destination_number(1204) =~ /^\*79$/ break=on-true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [do-not-disturb] destination_number(1204) =~ /^dnd\+XXXXX0166$/ break=on-true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->call-forward] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [call-forward] destination_number(1204) =~ /^\*72$/ break=on-true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [call-forward] destination_number(1204) =~ /^\*73$/ break=on-true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [call-forward] destination_number(1204) =~ /^\*74$/ break=on-true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [call-forward] destination_number(1204) =~ /^forward\+(\QXXXXX0166\E)(?:\/(\d+))?$/ break=on-true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->call forward all] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [call forward all] ${user_exists}(false) =~ /true/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->follow-me] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [follow-me] destination_number(1204) =~ /^\*21$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->clear_sip_auto_answer] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [clear_sip_auto_answer] ${click_to_call}() =~ /true/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->talking clock date and time] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [talking clock date and time] destination_number(1204) =~ /^\*9172$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->talking clock time] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [talking clock time] destination_number(1204) =~ /^\*9170$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->talking clock date] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [talking clock date] destination_number(1204) =~ /^\*9171$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->call_screen] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [call_screen] ${call_screen_enabled}() =~ /^true$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->local_extension] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [local_extension] ${user_exists}(false) =~ /true/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->voicemail] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [voicemail] ${user_exists}(false) =~ /true/ break=on-false
2019-05-29 15:40:35.790541 [DEBUG] switch_core_state_machine.c:286 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State Change CS_ROUTING -> CS_EXECUTE
2019-05-29 15:40:35.790541 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State ROUTING going to sleep
2019-05-29 15:40:35.790541 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/XXXXX0166@Y.Y.Y.Y) Running State Change CS_EXECUTE (Cur 2 Tot 493)
2019-05-29 15:40:35.790541 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State EXECUTE
2019-05-29 15:40:35.790541 [DEBUG] mod_sofia.c:198 sofia/internal/XXXXX0166@Y.Y.Y.Y SOFIA EXECUTE
2019-05-29 15:40:35.790541 [DEBUG] switch_core_state_machine.c:328 sofia/internal/XXXXX0166@Y.Y.Y.Y Standard EXECUTE
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y export(origination_callee_id_name=1204)
2019-05-29 15:40:35.790541 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [origination_callee_id_name]=[1204]
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(RFC2822_DATE=Wed, 29 May 2019 15:40:35 -0300)
2019-05-29 15:40:35.790541 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [RFC2822_DATE]=[Wed, 29 May 2019 15:40:35 -0300]
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y hash(insert/-last_dial/XXXXX0166/1204)
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y eval(not_secure)
2019-05-29 15:40:35.790541 [NOTICE] switch_core_state_machine.c:385 sofia/internal/XXXXX0166@Y.Y.Y.Y has executed the last dialplan instruction, hanging up.
2019-05-29 15:40:35.790541 [NOTICE] switch_core_state_machine.c:387 Hangup sofia/internal/XXXXX0166@Y.Y.Y.Y [CS_EXECUTE] [NORMAL_CLEARING]
2019-05-29 15:40:35.790541 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State EXECUTE going to sleep
2019-05-29 15:40:35.790541 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/XXXXX0166@Y.Y.Y.Y) Running State Change CS_HANGUP (Cur 2 Tot 493)
2019-05-29 15:40:35.790541 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/XXXXX0166@Y.Y.Y.Y) Callstate Change RINGING -> HANGUP
2019-05-29 15:40:35.790541 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State HANGUP
2019-05-29 15:40:35.790541 [DEBUG] mod_sofia.c:438 Channel sofia/internal/XXXXX0166@Y.Y.Y.Y hanging up, cause: NORMAL_CLEARING
2019-05-29 15:40:35.790541 [DEBUG] mod_sofia.c:577 Responding to INVITE with: 480
2019-05-29 15:40:35.790541 [DEBUG] switch_core_state_machine.c:60 sofia/internal/XXXXX0166@Y.Y.Y.Y Standard HANGUP, cause: NORMAL_CLEARING
2019-05-29 15:40:35.790541 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State HANGUP going to sleep
2019-05-29 15:40:35.790541 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State Change CS_HANGUP -> CS_REPORTING
2019-05-29 15:40:35.790541 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/XXXXX0166@Y.Y.Y.Y) Running State Change CS_REPORTING (Cur 2 Tot 493)
2019-05-29 15:40:35.790541 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State REPORTING
2019-05-29 15:40:35.850533 [DEBUG] switch_core_state_machine.c:174 sofia/internal/XXXXX0166@Y.Y.Y.Y Standard REPORTING, cause: NORMAL_CLEARING
2019-05-29 15:40:35.850533 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State REPORTING going to sleep
2019-05-29 15:40:35.850533 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State Change CS_REPORTING -> CS_DESTROY
2019-05-29 15:40:35.850533 [DEBUG] switch_core_session.c:1665 Session 493 (sofia/internal/XXXXX0166@Y.Y.Y.Y) Locked, Waiting on external entities
2019-05-29 15:40:35.850533 [NOTICE] switch_core_session.c:1683 Session 493 (sofia/internal/XXXXX0166@Y.Y.Y.Y) Ended
2019-05-29 15:40:35.850533 [NOTICE] switch_core_session.c:1687 Close Channel sofia/internal/XXXXX0166@Y.Y.Y.Y [CS_DESTROY]
2019-05-29 15:40:35.850533 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/XXXXX0166@Y.Y.Y.Y) Running State Change CS_DESTROY (Cur 1 Tot 493)
2019-05-29 15:40:35.850533 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State DESTROY
2019-05-29 15:40:35.850533 [DEBUG] mod_sofia.c:343 sofia/internal/XXXXX0166@Y.Y.Y.Y SOFIA DESTROY
2019-05-29 15:40:35.850533 [DEBUG] switch_core_state_machine.c:181 sofia/internal/XXXXX0166@Y.Y.Y.Y Standard DESTROY
2019-05-29 15:40:35.850533 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State DESTROY going to sleep
If i call between extensions work fine and outbound work too. Other detail, if redirect inbound call to ring group work. Only not work with inbound redirect to extension direct.
My log
2019-05-29 15:40:35.750532 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/XXXXX0166@Y.Y.Y.Y [3f46864a-8241-11e9-bc3f-91bf451741b2]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/XXXXX0166@Y.Y.Y.Y) Running State Change CS_NEW (Cur 2 Tot 493)
2019-05-29 15:40:35.750532 [DEBUG] sofia.c:9873 sofia/internal/XXXXX0166@Y.Y.Y.Y receiving invite from Z.Z.Z.Z:5060 version: 1.6.20 64bit
2019-05-29 15:40:35.750532 [DEBUG] sofia.c:9989 IP Z.Z.Z.Z Approved by acl "domains[]". Access Granted.
2019-05-29 15:40:35.750532 [DEBUG] sofia.c:10721 sofia/internal/XXXXX0166@Y.Y.Y.Y setting variable [sip_cid_type]=[pid]
2019-05-29 15:40:35.750532 [DEBUG] sofia.c:11168 Setting NAT mode based on via received
2019-05-29 15:40:35.750532 [DEBUG] sofia.c:7084 Channel sofia/internal/XXXXX0166@Y.Y.Y.Y entering state [received][100]
2019-05-29 15:40:35.750532 [DEBUG] sofia.c:7094 Remote SDP:
v=0
o=root 3399 3399 IN IP4 Y.Y.Y.Y
s=session
c=IN IP4 Y.Y.Y.Y
t=0 0
m=audio 11086 RTP/AVP 0 8 97 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:97 iLBC/8000
a=fmtp:97 mode=30
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp
ff - - - -a=ptime:20
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G7221:115:32000:20:48000:1]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G7221:107:16000:20:32000:1]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G7221:115:32000:20:48000:1]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G7221:107:16000:20:32000:1]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [iLBC:97:8000:20:0:1]/[G7221:115:32000:20:48000:1]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [iLBC:97:8000:20:0:1]/[G7221:107:16000:20:32000:1]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [iLBC:97:8000:20:0:1]/[G722:9:8000:20:64000:1]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [iLBC:97:8000:20:0:1]/[PCMU:0:8000:20:64000:1]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [iLBC:97:8000:20:0:1]/[PCMA:8:8000:20:64000:1]
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4365 Set telephone-event payload to 101@8000
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:3061 Set Codec sofia/internal/XXXXX0166@Y.Y.Y.Y PCMU/8000 20 ms 160 samples 64000 bits 1 channels
2019-05-29 15:40:35.750532 [DEBUG] switch_core_codec.c:111 sofia/internal/XXXXX0166@Y.Y.Y.Y Original read codec set to PCMU:0
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4708 Set telephone-event payload to 101@8000
2019-05-29 15:40:35.750532 [DEBUG] switch_core_media.c:4767 sofia/internal/XXXXX0166@Y.Y.Y.Y Set 2833 dtmf send payload to 101 recv payload to 101
2019-05-29 15:40:35.750532 [DEBUG] sofia.c:7507 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State Change CS_NEW -> CS_INIT
2019-05-29 15:40:35.750532 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State NEW
2019-05-29 15:40:35.750532 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/XXXXX0166@Y.Y.Y.Y) Running State Change CS_INIT (Cur 2 Tot 493)
2019-05-29 15:40:35.750532 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State INIT
2019-05-29 15:40:35.750532 [DEBUG] mod_sofia.c:90 sofia/internal/XXXXX0166@Y.Y.Y.Y SOFIA INIT
2019-05-29 15:40:35.750532 [DEBUG] switch_core_state_machine.c:40 sofia/internal/XXXXX0166@Y.Y.Y.Y Standard INIT
2019-05-29 15:40:35.750532 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State Change CS_INIT -> CS_ROUTING
2019-05-29 15:40:35.750532 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State INIT going to sleep
2019-05-29 15:40:35.750532 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/XXXXX0166@Y.Y.Y.Y) Running State Change CS_ROUTING (Cur 2 Tot 493)
2019-05-29 15:40:35.750532 [DEBUG] switch_channel.c:2249 (sofia/internal/XXXXX0166@Y.Y.Y.Y) Callstate Change DOWN -> RINGING
2019-05-29 15:40:35.750532 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State ROUTING
2019-05-29 15:40:35.750532 [DEBUG] mod_sofia.c:143 sofia/internal/XXXXX0166@Y.Y.Y.Y SOFIA ROUTING
2019-05-29 15:40:35.750532 [DEBUG] switch_core_state_machine.c:236 sofia/internal/XXXXX0166@Y.Y.Y.Y Standard ROUTING
2019-05-29 15:40:35.750532 [INFO] mod_dialplan_xml.c:637 Processing Ramal 104 <XXXXX0166>->2115001588 in context sub.domain.com.br
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->caller-details] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->user_exists] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [user_exists] () =~ // break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(user_exists=${user_exists id ${destination_number} ${domain_name}}) INLINE
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(user_exists=false)
2019-05-29 15:40:35.750532 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [user_exists]=[false]
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_exists] ${user_exists}(false) =~ /^true$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->variables] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [variables] () =~ // break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action export(origination_callee_id_name=${destination_number})
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->call-direction] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [call-direction] ${call_direction}() =~ /^(inbound|outbound|local)$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y ANTI-Action export(call_direction=local) INLINE
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y export(call_direction=local)
2019-05-29 15:40:35.750532 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [call_direction]=[local]
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->user_record] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [user_record] () =~ // break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(from_user_exists=${user_exists id ${sip_from_user} ${sip_from_host}}) INLINE
2019-05-29 15:40:35.770533 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7fe85816c860 Connected.
2019-05-29 15:40:35.770533 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7fe85816c860 released.
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(from_user_exists=false)
2019-05-29 15:40:35.770533 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [from_user_exists]=[false]
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_record}() =~ /^all$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${call_direction}(local) =~ /^inbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_record}() =~ /^inbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${call_direction}(local) =~ /^outbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_record}() =~ /^outbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [user_record] ${call_direction}(local) =~ /^local$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_record}() =~ /^local$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_record}() =~ /^all$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${call_direction}(local) =~ /^inbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_record}() =~ /^inbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${call_direction}(local) =~ /^outbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_record}() =~ /^outbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [user_record] ${call_direction}(local) =~ /^local$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_record}() =~ /^local$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${record_session}() =~ /^true$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->redial] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [redial] destination_number(2115001588) =~ /^(redial|\*870)$/ break=on-true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [redial] () =~ // break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->speed_dial] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [speed_dial] destination_number(2115001588) =~ /^\*0(.*)$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->default_caller_id] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [default_caller_id] ${emergency_caller_id_number}() =~ /^$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(emergency_caller_id_name=${default_emergency_caller_id_name}) INLINE
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(emergency_caller_id_name=)
2019-05-29 15:40:35.770533 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [emergency_caller_id_name]=[UNDEF]
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(emergency_caller_id_number=${default_emergency_caller_id_number}) INLINE
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(emergency_caller_id_number=)
2019-05-29 15:40:35.770533 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [emergency_caller_id_number]=[UNDEF]
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [default_caller_id] ${outbound_caller_id_number}() =~ /^$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(outbound_caller_id_name=${default_outbound_caller_id_name}) INLINE
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(outbound_caller_id_name=)
2019-05-29 15:40:35.770533 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [outbound_caller_id_name]=[UNDEF]
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(outbound_caller_id_number=${default_outbound_caller_id_number}) INLINE
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(outbound_caller_id_number=)
2019-05-29 15:40:35.770533 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [outbound_caller_id_number]=[UNDEF]
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->2115001588] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [2115001588] destination_number(2115001588) =~ /^(2115001588)$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(hangup_after_bridge=true)
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(continue_on_fail=true)
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action transfer(1204 XML sub.domain.com.br)
2019-05-29 15:40:35.770533 [DEBUG] switch_core_state_machine.c:286 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State Change CS_ROUTING -> CS_EXECUTE
2019-05-29 15:40:35.770533 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State ROUTING going to sleep
2019-05-29 15:40:35.770533 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/XXXXX0166@Y.Y.Y.Y) Running State Change CS_EXECUTE (Cur 2 Tot 493)
2019-05-29 15:40:35.770533 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State EXECUTE
2019-05-29 15:40:35.770533 [DEBUG] mod_sofia.c:198 sofia/internal/XXXXX0166@Y.Y.Y.Y SOFIA EXECUTE
2019-05-29 15:40:35.770533 [DEBUG] switch_core_state_machine.c:328 sofia/internal/XXXXX0166@Y.Y.Y.Y Standard EXECUTE
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y export(origination_callee_id_name=2115001588)
2019-05-29 15:40:35.770533 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [origination_callee_id_name]=[2115001588]
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(RFC2822_DATE=Wed, 29 May 2019 15:40:35 -0300)
2019-05-29 15:40:35.770533 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [RFC2822_DATE]=[Wed, 29 May 2019 15:40:35 -0300]
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y hash(insert/-last_dial/XXXXX0166/2115001588)
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(hangup_after_bridge=true)
2019-05-29 15:40:35.770533 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [hangup_after_bridge]=[true]
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(continue_on_fail=true)
2019-05-29 15:40:35.770533 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [continue_on_fail]=[true]
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y transfer(1204 XML sub.domain.com.br)
2019-05-29 15:40:35.770533 [DEBUG] switch_ivr.c:2165 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State Change CS_EXECUTE -> CS_ROUTING
2019-05-29 15:40:35.770533 [NOTICE] switch_ivr.c:2172 Transfer sofia/internal/XXXXX0166@Y.Y.Y.Y to XML[1204@sub.domain.com.br]
2019-05-29 15:40:35.770533 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State EXECUTE going to sleep
2019-05-29 15:40:35.770533 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/XXXXX0166@Y.Y.Y.Y) Running State Change CS_ROUTING (Cur 2 Tot 493)
2019-05-29 15:40:35.770533 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State ROUTING
2019-05-29 15:40:35.770533 [DEBUG] mod_sofia.c:143 sofia/internal/XXXXX0166@Y.Y.Y.Y SOFIA ROUTING
2019-05-29 15:40:35.770533 [DEBUG] switch_core_state_machine.c:236 sofia/internal/XXXXX0166@Y.Y.Y.Y Standard ROUTING
2019-05-29 15:40:35.770533 [INFO] mod_dialplan_xml.c:637 Processing Ramal 104 <XXXXX0166>->1204 in context sub.domain.com.br
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->caller-details] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->user_exists] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [user_exists] () =~ // break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(user_exists=${user_exists id ${destination_number} ${domain_name}}) INLINE
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(user_exists=false)
2019-05-29 15:40:35.770533 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [user_exists]=[false]
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_exists] ${user_exists}(false) =~ /^true$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->variables] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [variables] () =~ // break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action export(origination_callee_id_name=${destination_number})
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->call-direction] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [call-direction] ${call_direction}(local) =~ /^(inbound|outbound|local)$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->user_record] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [user_record] () =~ // break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(from_user_exists=${user_exists id ${sip_from_user} ${sip_from_host}}) INLINE
2019-05-29 15:40:35.790541 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7fe85816c860 Connected.
2019-05-29 15:40:35.790541 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7fe85816c860 released.
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(from_user_exists=false)
2019-05-29 15:40:35.790541 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [from_user_exists]=[false]
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_record}() =~ /^all$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${call_direction}(local) =~ /^inbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_record}() =~ /^inbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${call_direction}(local) =~ /^outbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_record}() =~ /^outbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [user_record] ${call_direction}(local) =~ /^local$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${user_record}() =~ /^local$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_record}() =~ /^all$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${call_direction}(local) =~ /^inbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_record}() =~ /^inbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${call_direction}(local) =~ /^outbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_record}() =~ /^outbound$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [user_record] ${call_direction}(local) =~ /^local$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${from_user_record}() =~ /^local$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [user_record] ${record_session}() =~ /^true$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->redial] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [redial] destination_number(1204) =~ /^(redial|\*870)$/ break=on-true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [redial] () =~ // break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->speed_dial] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [speed_dial] destination_number(1204) =~ /^\*0(.*)$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->default_caller_id] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [default_caller_id] ${emergency_caller_id_number}() =~ /^$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(emergency_caller_id_name=${default_emergency_caller_id_name}) INLINE
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(emergency_caller_id_name=)
2019-05-29 15:40:35.790541 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [emergency_caller_id_name]=[UNDEF]
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(emergency_caller_id_number=${default_emergency_caller_id_number}) INLINE
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(emergency_caller_id_number=)
2019-05-29 15:40:35.790541 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [emergency_caller_id_number]=[UNDEF]
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [default_caller_id] ${outbound_caller_id_number}() =~ /^$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(outbound_caller_id_name=${default_outbound_caller_id_name}) INLINE
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(outbound_caller_id_name=)
2019-05-29 15:40:35.790541 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [outbound_caller_id_name]=[UNDEF]
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Action set(outbound_caller_id_number=${default_outbound_caller_id_number}) INLINE
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(outbound_caller_id_number=)
2019-05-29 15:40:35.790541 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [outbound_caller_id_number]=[UNDEF]
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->2115001588] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [2115001588] destination_number(1204) =~ /^(2115001588)$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->UPLINK_IC.9d] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (PASS) [UPLINK_IC.9d] ${user_exists}(false) =~ /false/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [UPLINK_IC.9d] destination_number(1204) =~ /^(\d{9})$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->ring group] continue=
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [ring group] destination_number(1204) =~ /^801$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->agent_status] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [agent_status] destination_number(1204) =~ /^\*22$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->agent_status_id] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [agent_status_id] destination_number(1204) =~ /^\*23$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->group-intercept] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [group-intercept] destination_number(1204) =~ /^\*8$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->page-extension] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [page-extension] destination_number(1204) =~ /^\*8(\d{2,7})$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->eavesdrop] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [eavesdrop] destination_number(1204) =~ /^\*33(\d{2,7})$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->call_privacy] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [call_privacy] destination_number(1204) =~ /^\*67(\d+)$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->call_return] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [call_return] destination_number(1204) =~ /^\*69$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->intercept-ext] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [intercept-ext] destination_number(1204) =~ /^\*\*(\d+)$/ break=on-true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [intercept-ext] destination_number(1204) =~ /^\*\*$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->extension_queue] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [extension_queue] destination_number(1204) =~ /^\*800(.*)$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->intercept-ext-polycom] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [intercept-ext-polycom] destination_number(1204) =~ /^\*97(\d+)$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->dx] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [dx] destination_number(1204) =~ /^dx$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->send_to_voicemail] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [send_to_voicemail] destination_number(1204) =~ /^\*99(\d{2,10})$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->att_xfer] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [att_xfer] destination_number(1204) =~ /^att_xfer$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->extension-to-voicemail] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [extension-to-voicemail] ${user_exists}(false) =~ /^true$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->xfer_vm] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [xfer_vm] destination_number(1204) =~ /^xfer_vm$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->vmain] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [vmain] destination_number(1204) =~ /^vmain$|^\*4000$|^\*98$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [vmain] destination_number(1204) =~ /^(vmain$|^\*4000$|^\*98)(\d{2,12})$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->vmain_user] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [vmain_user] destination_number(1204) =~ /^\*97$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->is_transfer] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [is_transfer] destination_number(1204) =~ /^is_transfer$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->delay_echo] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [delay_echo] destination_number(1204) =~ /^\*9195$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->cf] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [cf] destination_number(1204) =~ /^cf$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->echo] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [echo] destination_number(1204) =~ /^\*9196$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->milliwatt] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [milliwatt] destination_number(1204) =~ /^\*9197$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->is_zrtp_secure] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [is_zrtp_secure] ${zrtp_secure_media_confirmed}() =~ /^true$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y ANTI-Action eval(not_secure)
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->is_secure] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [is_secure] ${sip_via_protocol}(udp) =~ /tls/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->tone_stream] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [tone_stream] destination_number(1204) =~ /^\*9198$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->hold_music] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [hold_music] destination_number(1204) =~ /^\*9664$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->recordings] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [recordings] destination_number(1204) =~ /^\*(732)$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->directory] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [directory] destination_number(1204) =~ /^\*411$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->wake-up] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [wake-up] destination_number(1204) =~ /^\*(925)$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->valet_park] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [valet_park] destination_number(1204) =~ /^(park\+)?\*(59[0-9][0-9])$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [valet_park] ${sip_h_Referred-By}() =~ /sip
.*)@.*/ break=neverDialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [valet_park] destination_number(1204) =~ /^(park\+)?\*(59[0-9][0-9])$/ break=never
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [valet_park] destination_number(1204) =~ /^(park\+)?\*(59[0-9][0-9])$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->operator] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [operator] destination_number(1204) =~ /^0$|^operator$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->operator-forward] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [operator-forward] destination_number(1204) =~ /^\*000$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->do-not-disturb] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [do-not-disturb] destination_number(1204) =~ /^\*77$/ break=on-true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [do-not-disturb] destination_number(1204) =~ /^\*78$|\*363$/ break=on-true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [do-not-disturb] destination_number(1204) =~ /^\*79$/ break=on-true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [do-not-disturb] destination_number(1204) =~ /^dnd\+XXXXX0166$/ break=on-true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->call-forward] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [call-forward] destination_number(1204) =~ /^\*72$/ break=on-true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [call-forward] destination_number(1204) =~ /^\*73$/ break=on-true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [call-forward] destination_number(1204) =~ /^\*74$/ break=on-true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [call-forward] destination_number(1204) =~ /^forward\+(\QXXXXX0166\E)(?:\/(\d+))?$/ break=on-true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->call forward all] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [call forward all] ${user_exists}(false) =~ /true/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->follow-me] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [follow-me] destination_number(1204) =~ /^\*21$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->clear_sip_auto_answer] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [clear_sip_auto_answer] ${click_to_call}() =~ /true/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->talking clock date and time] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [talking clock date and time] destination_number(1204) =~ /^\*9172$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->talking clock time] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [talking clock time] destination_number(1204) =~ /^\*9170$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->talking clock date] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [talking clock date] destination_number(1204) =~ /^\*9171$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->call_screen] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [call_screen] ${call_screen_enabled}() =~ /^true$/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->local_extension] continue=true
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [local_extension] ${user_exists}(false) =~ /true/ break=on-false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y parsing [sub.domain.com.br->voicemail] continue=false
Dialplan: sofia/internal/XXXXX0166@Y.Y.Y.Y Regex (FAIL) [voicemail] ${user_exists}(false) =~ /true/ break=on-false
2019-05-29 15:40:35.790541 [DEBUG] switch_core_state_machine.c:286 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State Change CS_ROUTING -> CS_EXECUTE
2019-05-29 15:40:35.790541 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State ROUTING going to sleep
2019-05-29 15:40:35.790541 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/XXXXX0166@Y.Y.Y.Y) Running State Change CS_EXECUTE (Cur 2 Tot 493)
2019-05-29 15:40:35.790541 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State EXECUTE
2019-05-29 15:40:35.790541 [DEBUG] mod_sofia.c:198 sofia/internal/XXXXX0166@Y.Y.Y.Y SOFIA EXECUTE
2019-05-29 15:40:35.790541 [DEBUG] switch_core_state_machine.c:328 sofia/internal/XXXXX0166@Y.Y.Y.Y Standard EXECUTE
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y export(origination_callee_id_name=1204)
2019-05-29 15:40:35.790541 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [origination_callee_id_name]=[1204]
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y set(RFC2822_DATE=Wed, 29 May 2019 15:40:35 -0300)
2019-05-29 15:40:35.790541 [DEBUG] mod_dptools.c:1548 SET sofia/internal/XXXXX0166@Y.Y.Y.Y [RFC2822_DATE]=[Wed, 29 May 2019 15:40:35 -0300]
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y hash(insert/-last_dial/XXXXX0166/1204)
EXECUTE sofia/internal/XXXXX0166@Y.Y.Y.Y eval(not_secure)
2019-05-29 15:40:35.790541 [NOTICE] switch_core_state_machine.c:385 sofia/internal/XXXXX0166@Y.Y.Y.Y has executed the last dialplan instruction, hanging up.
2019-05-29 15:40:35.790541 [NOTICE] switch_core_state_machine.c:387 Hangup sofia/internal/XXXXX0166@Y.Y.Y.Y [CS_EXECUTE] [NORMAL_CLEARING]
2019-05-29 15:40:35.790541 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State EXECUTE going to sleep
2019-05-29 15:40:35.790541 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/XXXXX0166@Y.Y.Y.Y) Running State Change CS_HANGUP (Cur 2 Tot 493)
2019-05-29 15:40:35.790541 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/XXXXX0166@Y.Y.Y.Y) Callstate Change RINGING -> HANGUP
2019-05-29 15:40:35.790541 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State HANGUP
2019-05-29 15:40:35.790541 [DEBUG] mod_sofia.c:438 Channel sofia/internal/XXXXX0166@Y.Y.Y.Y hanging up, cause: NORMAL_CLEARING
2019-05-29 15:40:35.790541 [DEBUG] mod_sofia.c:577 Responding to INVITE with: 480
2019-05-29 15:40:35.790541 [DEBUG] switch_core_state_machine.c:60 sofia/internal/XXXXX0166@Y.Y.Y.Y Standard HANGUP, cause: NORMAL_CLEARING
2019-05-29 15:40:35.790541 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State HANGUP going to sleep
2019-05-29 15:40:35.790541 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State Change CS_HANGUP -> CS_REPORTING
2019-05-29 15:40:35.790541 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/XXXXX0166@Y.Y.Y.Y) Running State Change CS_REPORTING (Cur 2 Tot 493)
2019-05-29 15:40:35.790541 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State REPORTING
2019-05-29 15:40:35.850533 [DEBUG] switch_core_state_machine.c:174 sofia/internal/XXXXX0166@Y.Y.Y.Y Standard REPORTING, cause: NORMAL_CLEARING
2019-05-29 15:40:35.850533 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State REPORTING going to sleep
2019-05-29 15:40:35.850533 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State Change CS_REPORTING -> CS_DESTROY
2019-05-29 15:40:35.850533 [DEBUG] switch_core_session.c:1665 Session 493 (sofia/internal/XXXXX0166@Y.Y.Y.Y) Locked, Waiting on external entities
2019-05-29 15:40:35.850533 [NOTICE] switch_core_session.c:1683 Session 493 (sofia/internal/XXXXX0166@Y.Y.Y.Y) Ended
2019-05-29 15:40:35.850533 [NOTICE] switch_core_session.c:1687 Close Channel sofia/internal/XXXXX0166@Y.Y.Y.Y [CS_DESTROY]
2019-05-29 15:40:35.850533 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/XXXXX0166@Y.Y.Y.Y) Running State Change CS_DESTROY (Cur 1 Tot 493)
2019-05-29 15:40:35.850533 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State DESTROY
2019-05-29 15:40:35.850533 [DEBUG] mod_sofia.c:343 sofia/internal/XXXXX0166@Y.Y.Y.Y SOFIA DESTROY
2019-05-29 15:40:35.850533 [DEBUG] switch_core_state_machine.c:181 sofia/internal/XXXXX0166@Y.Y.Y.Y Standard DESTROY
2019-05-29 15:40:35.850533 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/XXXXX0166@Y.Y.Y.Y) State DESTROY going to sleep