Incoming calls to IVR/Ring group re-routed to outbound route

Status
Not open for further replies.
R

route_different

New Member
Jul 21, 2020
2
0
1
IT
Hello,

this is my first post (after presentation).

As subject says: if an incoming call is tranfserred to IVR (or Ring Group), this is resubmitted on the same trunk (outgoing) by assigning the extension number of the IVR/RG as the caller.


Premise:
all incoming calls, when tranfserred directly to extension (my SNOMs), work properly.
Instead of destination_number variable, due to trunk settings, I must use ${sip_to_user}


A log is worth a thousand words.

In this log (IVR only):

800 -> IVR extension number
sip.mytrunkservice.net with ip 2.3.4.5/3.4.5.6/4.5.6.7 -> the gateway for incoming calls
my.fusionpbx.tenant.domain.net with ip 1.2.3.4 is my FusionPBX tenant
+393921234567 -> my mobile phone that initiates the call (callee)
02345678900 -> FusionPBX DID/caller_destination
5600112 -> sip.mytrunkservice.net username

Code: 
recv 1262 bytes from udp/[2.3.4.5]:5060 at 10:47:40.182532:
------------------------------------------------------------------------
INVITE sip:5600112@1.2.3.4:5080;transport=udp;gw=26f512af-78ae-4331-b7da-708d6342eca1 SIP/2.0
Record-Route: <sip:2.3.4.5;lr=on;ftag=as428d35cb;rpp=np>
Via: SIP/2.0/UDP 2.3.4.5;branch=z9hG4bK21a3.4fa98061.0
Via: SIP/2.0/UDP 3.4.5.6:5060;branch=z9hG4bK0c76c2bd
Max-Forwards: 69
From: "+393921234567" <sip:+393921234567@sip.mytrunkservice.net>;tag=as428d35cb
To: <sip:02345678900@2.3.4.5>
Contact: <sip:+393921234567@3.4.5.6:5060>
Call-ID: 5595bbc8323c60aa2b721dd613a0afaa@sip.mytrunkservice.net
CSeq: 102 INVITE
User-Agent: romeo
Date: Fri, 24 Jul 2020 08:47:40 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
X-Mnet-InLeg: 1:romeo:1595580460.18174064:0;8aIW1MSDWHUPPOWOfbVzlkKfFWATZaMQEMFXKBBZMMUJexvE9JK+0OiblpnZpPcF
Content-Type: application/sdp
Content-Length: 376

v=0
o=root 18629923 18629923 IN IP4 4.5.6.7
s=romeo
c=IN IP4 4.5.6.7
t=0 0
m=audio 59780 RTP/AVP 18 8 3 0 97 101
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:8 PCMA/8000
a=rtpmap:3 GSM/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:97 iLBC/8000
a=fmtp:97 mode=30
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=maxptime:150
a=sendrecv
2020-07-24 10:47:40.172458 [NOTICE] switch_channel.c:1118 New Channel sofia/external/+393921234567@sip.mytrunkservice.net [d027b373-82ca-4f6b-b70c-fc49ff6cb36f]
2020-07-24 10:47:40.172458 [DEBUG] switch_core_state_machine.c:585 (sofia/external/+393921234567@sip.mytrunkservice.net) Running State Change CS_NEW (Cur 1 Tot 12)
2020-07-24 10:47:40.172458 [DEBUG] sofia.c:10279 sofia/external/+393921234567@sip.mytrunkservice.net receiving invite from 2.3.4.5:5060 version: 1.10.3 -release-15-129de34d84 64bit
2020-07-24 10:47:40.172458 [DEBUG] sofia.c:10373 verifying acl "domains" for ip/port 2.3.4.5:0.
2020-07-24 10:47:40.172458 [DEBUG] sofia.c:10402 IP 2.3.4.5 Approved by acl "domains[]". Access Granted.
2020-07-24 10:47:40.172458 [DEBUG] sofia.c:7325 Channel sofia/external/+393921234567@sip.mytrunkservice.net entering state [received][100]
2020-07-24 10:47:40.172458 [DEBUG] sofia.c:7335 Remote SDP:
v=0
o=root 18629923 18629923 IN IP4 4.5.6.7
s=romeo
c=IN IP4 4.5.6.7
t=0 0
m=audio 59780 RTP/AVP 18 8 3 0 97 101
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:8 PCMA/8000
a=rtpmap:3 GSM/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:97 iLBC/8000
a=fmtp:97 mode=30
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=maxptime:150

2020-07-24 10:47:40.172458 [DEBUG] switch_core_media.c:5592 Audio Codec Compare [G729:18:8000:20:8000:1]/[G722:9:8000:20:64000:1]
2020-07-24 10:47:40.172458 [DEBUG] switch_core_media.c:5592 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
2020-07-24 10:47:40.172458 [DEBUG] switch_core_media.c:5592 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
2020-07-24 10:47:40.172458 [DEBUG] switch_core_media.c:5592 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
2020-07-24 10:47:40.172458 [DEBUG] switch_core_media.c:5592 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2020-07-24 10:47:40.172458 [DEBUG] switch_core_media.c:5592 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
2020-07-24 10:47:40.172458 [DEBUG] switch_core_media.c:5647 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
2020-07-24 10:47:40.172458 [DEBUG] switch_core_media.c:5592 Audio Codec Compare [GSM:3:8000:20:13200:1]/[G722:9:8000:20:64000:1]
2020-07-24 10:47:40.172458 [DEBUG] switch_core_media.c:5592 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMU:0:8000:20:64000:1]
2020-07-24 10:47:40.172458 [DEBUG] switch_core_media.c:5592 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMA:8:8000:20:64000:1]
2020-07-24 10:47:40.172458 [DEBUG] switch_core_media.c:5592 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
2020-07-24 10:47:40.172458 [DEBUG] switch_core_media.c:5592 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2020-07-24 10:47:40.172458 [DEBUG] switch_core_media.c:5647 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
2020-07-24 10:47:40.172458 [DEBUG] switch_core_media.c:5592 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
2020-07-24 10:47:40.172458 [DEBUG] switch_core_media.c:5592 Audio Codec Compare [iLBC:97:8000:20:0:1]/[G722:9:8000:20:64000:1]
2020-07-24 10:47:40.172458 [DEBUG] switch_core_media.c:5592 Audio Codec Compare [iLBC:97:8000:20:0:1]/[PCMU:0:8000:20:64000:1]
2020-07-24 10:47:40.172458 [DEBUG] switch_core_media.c:5592 Audio Codec Compare [iLBC:97:8000:20:0:1]/[PCMA:8:8000:20:64000:1]
2020-07-24 10:47:40.172458 [DEBUG] switch_core_media.c:5508 Set telephone-event payload to 101@8000
2020-07-24 10:47:40.172458 [DEBUG] switch_core_media.c:3837 Set Codec sofia/external/+393921234567@sip.mytrunkservice.net PCMA/8000 20 ms 160 samples 64000 bits 1 channels
2020-07-24 10:47:40.172458 [DEBUG] switch_core_codec.c:111 sofia/external/+393921234567@sip.mytrunkservice.net Original read codec set to PCMA:8
2020-07-24 10:47:40.172458 [DEBUG] switch_core_media.c:5851 Set telephone-event payload to 101@8000
2020-07-24 10:47:40.172458 [DEBUG] switch_core_media.c:5909 sofia/external/+393921234567@sip.mytrunkservice.net Set 2833 dtmf send payload to 101 recv payload to 101
2020-07-24 10:47:40.172458 [DEBUG] sofia.c:7759 (sofia/external/+393921234567@sip.mytrunkservice.net) State Change CS_NEW -> CS_INIT
2020-07-24 10:47:40.172458 [DEBUG] switch_core_state_machine.c:604 (sofia/external/+393921234567@sip.mytrunkservice.net) State NEW
2020-07-24 10:47:40.172458 [DEBUG] switch_core_state_machine.c:585 (sofia/external/+393921234567@sip.mytrunkservice.net) Running State Change CS_INIT (Cur 1 Tot 12)
2020-07-24 10:47:40.172458 [DEBUG] switch_core_state_machine.c:628 (sofia/external/+393921234567@sip.mytrunkservice.net) State INIT
2020-07-24 10:47:40.172458 [DEBUG] mod_sofia.c:93 sofia/external/+393921234567@sip.mytrunkservice.net SOFIA INIT
2020-07-24 10:47:40.172458 [DEBUG] switch_core_state_machine.c:40 sofia/external/+393921234567@sip.mytrunkservice.net Standard INIT
2020-07-24 10:47:40.172458 [DEBUG] switch_core_state_machine.c:48 (sofia/external/+393921234567@sip.mytrunkservice.net) State Change CS_INIT -> CS_ROUTING
2020-07-24 10:47:40.172458 [DEBUG] switch_core_state_machine.c:628 (sofia/external/+393921234567@sip.mytrunkservice.net) State INIT going to sleep
2020-07-24 10:47:40.172458 [DEBUG] switch_core_state_machine.c:585 (sofia/external/+393921234567@sip.mytrunkservice.net) Running State Change CS_ROUTING (Cur 1 Tot 12)
2020-07-24 10:47:40.172458 [DEBUG] switch_channel.c:2332 (sofia/external/+393921234567@sip.mytrunkservice.net) Callstate Change DOWN -> RINGING
2020-07-24 10:47:40.172458 [DEBUG] switch_core_state_machine.c:644 (sofia/external/+393921234567@sip.mytrunkservice.net) State ROUTING
send 317 bytes to udp/[2.3.4.5]:5060 at 10:47:40.184149:
------------------------------------------------------------------------
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 2.3.4.5;branch=z9hG4bK21a3.4fa98061.0
From: "+393921234567" <sip:+393921234567@sip.mytrunkservice.net>;tag=as428d35cb
To: <sip:02345678900@2.3.4.5>
Call-ID: 5595bbc8323c60aa2b721dd613a0afaa@sip.mytrunkservice.net
CSeq: 102 INVITE
User-Agent: FreeSWITCH
Content-Length: 0

2020-07-24 10:47:40.172458 [DEBUG] mod_sofia.c:154 sofia/external/+393921234567@sip.mytrunkservice.net SOFIA ROUTING
2020-07-24 10:47:40.172458 [DEBUG] switch_core_state_machine.c:236 sofia/external/+393921234567@sip.mytrunkservice.net Standard ROUTING
2020-07-24 10:47:40.172458 [INFO] mod_dialplan_xml.c:637 Processing +393921234567 <+393921234567>->5600112 in context public
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net parsing [public->caller-details] continue=true
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (PASS) [caller-details] () =~ // break=never
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action export(call_direction=inbound) INLINE
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net export(call_direction=inbound)
2020-07-24 10:47:40.212413 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [call_direction]=[inbound]
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action set(caller_destination=${sip_to_user}) INLINE
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net set(caller_destination=02345678900)
2020-07-24 10:47:40.212413 [DEBUG] mod_dptools.c:1672 SET sofia/external/+393921234567@sip.mytrunkservice.net [caller_destination]=[02345678900]
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action set(caller_id_name=${caller_id_name}) INLINE
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net set(caller_id_name=+393921234567)
2020-07-24 10:47:40.212413 [DEBUG] mod_dptools.c:1672 SET sofia/external/+393921234567@sip.mytrunkservice.net [caller_id_name]=[+393921234567]
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action set(caller_id_number=${caller_id_number})
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net parsing [public->02345678900] continue=false
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (PASS) [02345678900] ${sip_to_user}(02345678900) =~ /^(02345678900)$/ break=on-false
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action export(call_direction=inbound) INLINE
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net export(call_direction=inbound)
2020-07-24 10:47:40.212413 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [call_direction]=[inbound]
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action set(domain_uuid=27601438-9b0b-4950-839f-07d764a85d52) INLINE
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net set(domain_uuid=27601438-9b0b-4950-839f-07d764a85d52)
2020-07-24 10:47:40.212413 [DEBUG] mod_dptools.c:1672 SET sofia/external/+393921234567@sip.mytrunkservice.net [domain_uuid]=[27601438-9b0b-4950-839f-07d764a85d52]
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action set(domain_name=my.fusionpbx.tenant.domain.net) INLINE
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net set(domain_name=my.fusionpbx.tenant.domain.net)
2020-07-24 10:47:40.212413 [DEBUG] mod_dptools.c:1672 SET sofia/external/+393921234567@sip.mytrunkservice.net [domain_name]=[my.fusionpbx.tenant.domain.net]
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action set(hangup_after_bridge=true) INLINE
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net set(hangup_after_bridge=true)
2020-07-24 10:47:40.212413 [DEBUG] mod_dptools.c:1672 SET sofia/external/+393921234567@sip.mytrunkservice.net [hangup_after_bridge]=[true]
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action set(continue_on_fail=true) INLINE
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net set(continue_on_fail=true)
2020-07-24 10:47:40.212413 [DEBUG] mod_dptools.c:1672 SET sofia/external/+393921234567@sip.mytrunkservice.net [continue_on_fail]=[true]
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action transfer(800 XML my.fusionpbx.tenant.domain.net)
2020-07-24 10:47:40.212413 [DEBUG] switch_core_state_machine.c:287 (sofia/external/+393921234567@sip.mytrunkservice.net) State Change CS_ROUTING -> CS_EXECUTE
2020-07-24 10:47:40.212413 [DEBUG] switch_core_state_machine.c:644 (sofia/external/+393921234567@sip.mytrunkservice.net) State ROUTING going to sleep
2020-07-24 10:47:40.212413 [DEBUG] switch_core_state_machine.c:585 (sofia/external/+393921234567@sip.mytrunkservice.net) Running State Change CS_EXECUTE (Cur 1 Tot 12)
2020-07-24 10:47:40.212413 [DEBUG] switch_core_state_machine.c:651 (sofia/external/+393921234567@sip.mytrunkservice.net) State EXECUTE
2020-07-24 10:47:40.212413 [DEBUG] mod_sofia.c:209 sofia/external/+393921234567@sip.mytrunkservice.net SOFIA EXECUTE
2020-07-24 10:47:40.212413 [DEBUG] switch_core_state_machine.c:329 sofia/external/+393921234567@sip.mytrunkservice.net Standard EXECUTE
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net set(caller_id_number=+393921234567)
2020-07-24 10:47:40.212413 [DEBUG] mod_dptools.c:1672 SET sofia/external/+393921234567@sip.mytrunkservice.net [caller_id_number]=[+393921234567]
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net transfer(800 XML my.fusionpbx.tenant.domain.net)
2020-07-24 10:47:40.212413 [DEBUG] switch_ivr.c:2243 (sofia/external/+393921234567@sip.mytrunkservice.net) State Change CS_EXECUTE -> CS_ROUTING
2020-07-24 10:47:40.212413 [NOTICE] switch_ivr.c:2250 Transfer sofia/external/+393921234567@sip.mytrunkservice.net to XML[800@my.fusionpbx.tenant.domain.net]
2020-07-24 10:47:40.212413 [DEBUG] switch_core_state_machine.c:651 (sofia/external/+393921234567@sip.mytrunkservice.net) State EXECUTE going to sleep
2020-07-24 10:47:40.212413 [DEBUG] switch_core_state_machine.c:585 (sofia/external/+393921234567@sip.mytrunkservice.net) Running State Change CS_ROUTING (Cur 1 Tot 12)
2020-07-24 10:47:40.212413 [DEBUG] switch_core_state_machine.c:644 (sofia/external/+393921234567@sip.mytrunkservice.net) State ROUTING
2020-07-24 10:47:40.212413 [DEBUG] mod_sofia.c:145 Call appears to be already acknowledged
2020-07-24 10:47:40.212413 [DEBUG] mod_sofia.c:154 sofia/external/+393921234567@sip.mytrunkservice.net SOFIA ROUTING
2020-07-24 10:47:40.212413 [DEBUG] switch_core_state_machine.c:236 sofia/external/+393921234567@sip.mytrunkservice.net Standard ROUTING
2020-07-24 10:47:40.212413 [INFO] mod_dialplan_xml.c:637 Processing +393921234567 <+393921234567>->800 in context my.fusionpbx.tenant.domain.net
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net parsing [my.fusionpbx.tenant.domain.net->user_exists] continue=true
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (FAIL) [user_exists] ${loopback_leg}() =~ /^B$/ break=never
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (PASS) [user_exists] () =~ // break=on-false
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action set(user_exists=${user_exists id ${destination_number} ${domain_name}}) INLINE
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net set(user_exists=false)
2020-07-24 10:47:40.212413 [DEBUG] mod_dptools.c:1672 SET sofia/external/+393921234567@sip.mytrunkservice.net [user_exists]=[false]
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action set(from_user_exists=${user_exists id ${sip_from_user} ${sip_from_host}}) INLINE
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net set(from_user_exists=false)
2020-07-24 10:47:40.232411 [DEBUG] mod_dptools.c:1672 SET sofia/external/+393921234567@sip.mytrunkservice.net [from_user_exists]=[false]
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (FAIL) [user_exists] ${user_exists}(false) =~ /^true$/ break=on-false
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net parsing [my.fusionpbx.tenant.domain.net->call-direction] continue=true
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (PASS) [call-direction] ${call_direction}(inbound) =~ /^(inbound|outbound|local)$/ break=never
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net parsing [my.fusionpbx.tenant.domain.net->caller-details] continue=true
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (FAIL) [caller-details] ${caller_destination}(02345678900) =~ /^$/ break=never
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net parsing [my.fusionpbx.tenant.domain.net->global-variables] continue=true
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (PASS) [global-variables] () =~ // break=on-false
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action set(timezone=Europe/Rome) INLINE
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net set(timezone=Europe/Rome)
2020-07-24 10:47:40.232411 [DEBUG] mod_dptools.c:1672 SET sofia/external/+393921234567@sip.mytrunkservice.net [timezone]=[Europe/Rome]
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net parsing [my.fusionpbx.tenant.domain.net->domain-variables] continue=true
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (PASS) [domain-variables] () =~ // break=on-false
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action export(origination_callee_id_name=${destination_number})
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net parsing [my.fusionpbx.tenant.domain.net->is_loopback] continue=true
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (FAIL) [is_loopback] ${is_follow_me_loopback}() =~ /true/ break=on-false
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net parsing [my.fusionpbx.tenant.domain.net->user_record] continue=true
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (FAIL) [user_record] ${user_record}() =~ /^all$/ break=never
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (PASS) [user_record] ${call_direction}(inbound) =~ /^inbound$/ break=never
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (FAIL) [user_record] ${user_record}() =~ /^inbound$/ break=never
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^outbound$/ break=never
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (FAIL) [user_record] ${user_record}() =~ /^outbound$/ break=never
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^local$/ break=never
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (FAIL) [user_record] ${user_record}() =~ /^local$/ break=never
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (FAIL) [user_record] ${from_user_record}() =~ /^all$/ break=never
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (PASS) [user_record] ${call_direction}(inbound) =~ /^inbound$/ break=never
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (FAIL) [user_record] ${from_user_record}() =~ /^inbound$/ break=never
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^outbound$/ break=never
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (FAIL) [user_record] ${from_user_record}() =~ /^outbound$/ break=never
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^local$/ break=never
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (FAIL) [user_record] ${from_user_record}() =~ /^local$/ break=never
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (FAIL) [user_record] ${record_session}() =~ /^true$/ break=on-false
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net parsing [my.fusionpbx.tenant.domain.net->redial] continue=true
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (FAIL) [redial] destination_number(800) =~ /^(redial|\*870)$/ break=on-true
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (PASS) [redial] () =~ // break=never
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net parsing [my.fusionpbx.tenant.domain.net->speed_dial] continue=false
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (FAIL) [speed_dial] destination_number(800) =~ /^\*0(.*)$/ break=on-false
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net parsing [my.fusionpbx.tenant.domain.net->user_hold_music] continue=true
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (FAIL) [user_hold_music] ${hold_music}(local_stream://default) =~ /^$/ break=never
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (FAIL) [user_hold_music] ${user_exists}(false) =~ /true/ break=on-false
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net parsing [my.fusionpbx.tenant.domain.net->default_caller_id] continue=true
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (PASS) [default_caller_id] ${emergency_caller_id_number}() =~ /^$/ break=never
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action set(emergency_caller_id_name=${default_emergency_caller_id_name}) INLINE
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net set(emergency_caller_id_name=)
2020-07-24 10:47:40.232411 [DEBUG] mod_dptools.c:1672 SET sofia/external/+393921234567@sip.mytrunkservice.net [emergency_caller_id_name]=[UNDEF]
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action set(emergency_caller_id_number=${default_emergency_caller_id_number}) INLINE
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net set(emergency_caller_id_number=)
2020-07-24 10:47:40.232411 [DEBUG] mod_dptools.c:1672 SET sofia/external/+393921234567@sip.mytrunkservice.net [emergency_caller_id_number]=[UNDEF]
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (PASS) [default_caller_id] ${outbound_caller_id_number}() =~ /^$/ break=never
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action set(outbound_caller_id_name=${default_outbound_caller_id_name}) INLINE
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net set(outbound_caller_id_name=)
2020-07-24 10:47:40.232411 [DEBUG] mod_dptools.c:1672 SET sofia/external/+393921234567@sip.mytrunkservice.net [outbound_caller_id_name]=[UNDEF]
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action set(outbound_caller_id_number=${default_outbound_caller_id_number}) INLINE
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net set(outbound_caller_id_number=)
2020-07-24 10:47:40.232411 [DEBUG] mod_dptools.c:1672 SET sofia/external/+393921234567@sip.mytrunkservice.net [outbound_caller_id_number]=[UNDEF]
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net parsing [my.fusionpbx.tenant.domain.net->mytrunk.d3] continue=false
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (PASS) [mytrunk.d3] ${user_exists}(false) =~ /false/ break=on-false
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Regex (PASS) [mytrunk.d3] destination_number(800) =~ /^(\d{3,})$/ break=on-false
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action export(call_direction=outbound)
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action unset(call_timeout)
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action set(hangup_after_bridge=true)
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action set(effective_caller_id_name=${outbound_caller_id_name})
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action set(effective_caller_id_number=5600112)
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action set(inherit_codec=true)
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action set(ignore_display_updates=true)
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action set(callee_id_number=800)
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action set(continue_on_fail=true)
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action set(sip_copy_custom_headers=false)
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action limit(hash ${domain_name} outbound 1 !USER_BUSY)
Dialplan: sofia/external/+393921234567@sip.mytrunkservice.net Action bridge(sofia/gateway/26f512af-78ae-4331-b7da-708d6342eca1/800)
2020-07-24 10:47:40.232411 [DEBUG] switch_core_state_machine.c:287 (sofia/external/+393921234567@sip.mytrunkservice.net) State Change CS_ROUTING -> CS_EXECUTE
2020-07-24 10:47:40.232411 [DEBUG] switch_core_state_machine.c:644 (sofia/external/+393921234567@sip.mytrunkservice.net) State ROUTING going to sleep
2020-07-24 10:47:40.232411 [DEBUG] switch_core_state_machine.c:585 (sofia/external/+393921234567@sip.mytrunkservice.net) Running State Change CS_EXECUTE (Cur 1 Tot 12)
2020-07-24 10:47:40.232411 [DEBUG] switch_core_state_machine.c:651 (sofia/external/+393921234567@sip.mytrunkservice.net) State EXECUTE
2020-07-24 10:47:40.232411 [DEBUG] mod_sofia.c:209 sofia/external/+393921234567@sip.mytrunkservice.net SOFIA EXECUTE
2020-07-24 10:47:40.232411 [DEBUG] switch_core_state_machine.c:329 sofia/external/+393921234567@sip.mytrunkservice.net Standard EXECUTE
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net set(RFC2822_DATE=Fri, 24 Jul 2020 10:47:40 +0200)
2020-07-24 10:47:40.232411 [DEBUG] mod_dptools.c:1672 SET sofia/external/+393921234567@sip.mytrunkservice.net [RFC2822_DATE]=[Fri, 24 Jul 2020 10:47:40 +0200]
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net export(origination_callee_id_name=800)
2020-07-24 10:47:40.232411 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [origination_callee_id_name]=[800]
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net hash(insert/my.fusionpbx.tenant.domain.net-last_dial/+393921234567/800)
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net export(call_direction=outbound)
2020-07-24 10:47:40.232411 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [call_direction]=[outbound]
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net unset(call_timeout)
2020-07-24 10:47:40.232411 [DEBUG] mod_dptools.c:1817 UNSET [call_timeout]
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net set(hangup_after_bridge=true)
2020-07-24 10:47:40.232411 [DEBUG] mod_dptools.c:1672 SET sofia/external/+393921234567@sip.mytrunkservice.net [hangup_after_bridge]=[true]
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net set(effective_caller_id_name=)
2020-07-24 10:47:40.232411 [DEBUG] mod_dptools.c:1672 SET sofia/external/+393921234567@sip.mytrunkservice.net [effective_caller_id_name]=[UNDEF]
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net set(effective_caller_id_number=5600112)
2020-07-24 10:47:40.232411 [DEBUG] mod_dptools.c:1672 SET sofia/external/+393921234567@sip.mytrunkservice.net [effective_caller_id_number]=[5600112]
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net set(inherit_codec=true)
2020-07-24 10:47:40.232411 [DEBUG] mod_dptools.c:1672 SET sofia/external/+393921234567@sip.mytrunkservice.net [inherit_codec]=[true]
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net set(ignore_display_updates=true)
2020-07-24 10:47:40.232411 [DEBUG] mod_dptools.c:1672 SET sofia/external/+393921234567@sip.mytrunkservice.net [ignore_display_updates]=[true]
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net set(callee_id_number=800)
2020-07-24 10:47:40.232411 [DEBUG] mod_dptools.c:1672 SET sofia/external/+393921234567@sip.mytrunkservice.net [callee_id_number]=[800]
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net set(continue_on_fail=true)
2020-07-24 10:47:40.232411 [DEBUG] mod_dptools.c:1672 SET sofia/external/+393921234567@sip.mytrunkservice.net [continue_on_fail]=[true]
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net set(sip_copy_custom_headers=false)
2020-07-24 10:47:40.232411 [DEBUG] mod_dptools.c:1672 SET sofia/external/+393921234567@sip.mytrunkservice.net [sip_copy_custom_headers]=[false]
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net limit(hash my.fusionpbx.tenant.domain.net outbound 1 !USER_BUSY)
2020-07-24 10:47:40.232411 [DEBUG] switch_limit.c:124 incr called: my.fusionpbx.tenant.domain.net_outbound max:1, interval:0
2020-07-24 10:47:40.232411 [DEBUG] mod_hash.c:196 Usage for my.fusionpbx.tenant.domain.net_outbound is now 1/1
EXECUTE [depth=0] sofia/external/+393921234567@sip.mytrunkservice.net bridge(sofia/gateway/26f512af-78ae-4331-b7da-708d6342eca1/800)
2020-07-24 10:47:40.232411 [DEBUG] switch_channel.c:1264 sofia/external/+393921234567@sip.mytrunkservice.net EXPORTING[export_vars] [call_direction]=[outbound] to event
2020-07-24 10:47:40.232411 [DEBUG] switch_channel.c:1264 sofia/external/+393921234567@sip.mytrunkservice.net EXPORTING[export_vars] [call_direction]=[outbound] to event
2020-07-24 10:47:40.232411 [DEBUG] switch_channel.c:1264 sofia/external/+393921234567@sip.mytrunkservice.net EXPORTING[export_vars] [origination_callee_id_name]=[800] to event
2020-07-24 10:47:40.232411 [DEBUG] switch_channel.c:1264 sofia/external/+393921234567@sip.mytrunkservice.net EXPORTING[export_vars] [call_direction]=[outbound] to event
2020-07-24 10:47:40.232411 [DEBUG] switch_ivr_originate.c:2242 Parsing global variables
2020-07-24 10:47:40.232411 [NOTICE] switch_channel.c:1118 New Channel sofia/external/800 [d2e5331d-9ce9-40eb-90f9-6073a665ffec]
2020-07-24 10:47:40.232411 [DEBUG] mod_sofia.c:5089 (sofia/external/800) State Change CS_NEW -> CS_INIT
2020-07-24 10:47:40.252406 [DEBUG] switch_core_state_machine.c:585 (sofia/external/800) Running State Change CS_INIT (Cur 2 Tot 13)
2020-07-24 10:47:40.252406 [DEBUG] switch_core_state_machine.c:628 (sofia/external/800) State INIT
2020-07-24 10:47:40.252406 [DEBUG] mod_sofia.c:93 sofia/external/800 SOFIA INIT
2020-07-24 10:47:40.252406 [DEBUG] sofia_glue.c:1618 sofia/external/800 sending invite version: 1.10.3 -release-15-129de34d84 64bit
Local SDP:
v=0
o=FreeSWITCH 1595548584 1595548585 IN IP4 1.2.3.4
s=FreeSWITCH
c=IN IP4 1.2.3.4
t=0 0
m=audio 31876 RTP/AVP 8 18 0 101
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
a=sendrecv

send 1087 bytes to udp/[2.3.4.5]:5060 at 10:47:40.255524:
------------------------------------------------------------------------
INVITE sip:800@sip.mytrunkservice.net SIP/2.0
Via: SIP/2.0/UDP 1.2.3.4:5080;rport;branch=z9hG4bKgFrg0XK8FDKme
Max-Forwards: 67
From: "+393921234567" <sip:5600112@sip.mytrunkservice.net>;tag=Bjt7HacgFF5Ua
To: <sip:800@sip.mytrunkservice.net>
Call-ID: 2c505812-482d-1239-a1ae-00505637f1d4
CSeq: 23236438 INVITE
Contact: <sip:5600112@1.2.3.4:5080;transport=udp;gw=26f512af-78ae-4331-b7da-708d6342eca1>
User-Agent: FreeSWITCH
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
Supported: timer, path, replaces
Allow-Events: talk, hold, conference, refer
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 301
Remote-Party-ID: "+393921234567" <sip:5600112@sip.mytrunkservice.net>;party=calling;screen=yes;privacy=off

v=0
o=FreeSWITCH 1595548584 1595548585 IN IP4 1.2.3.4
s=FreeSWITCH
c=IN IP4 1.2.3.4
t=0 0
m=audio 31876 RTP/AVP 8 18 0 101
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
2020-07-24 10:47:40.252406 [DEBUG] switch_core_state_machine.c:40 sofia/external/800 Standard INIT
2020-07-24 10:47:40.252406 [DEBUG] switch_core_state_machine.c:48 (sofia/external/800) State Change CS_INIT -> CS_ROUTING
2020-07-24 10:47:40.252406 [DEBUG] switch_core_state_machine.c:628 (sofia/external/800) State INIT going to sleep
2020-07-24 10:47:40.252406 [DEBUG] switch_core_state_machine.c:585 (sofia/external/800) Running State Change CS_ROUTING (Cur 2 Tot 13)
2020-07-24 10:47:40.252406 [DEBUG] sofia.c:7325 Channel sofia/external/800 entering state [calling][0]
2020-07-24 10:47:40.252406 [DEBUG] switch_core_state_machine.c:644 (sofia/external/800) State ROUTING
2020-07-24 10:47:40.252406 [DEBUG] mod_sofia.c:154 sofia/external/800 SOFIA ROUTING
2020-07-24 10:47:40.252406 [DEBUG] switch_ivr_originate.c:67 (sofia/external/800) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2020-07-24 10:47:40.252406 [DEBUG] switch_core_state_machine.c:644 (sofia/external/800) State ROUTING going to sleep
2020-07-24 10:47:40.252406 [DEBUG] switch_core_state_machine.c:585 (sofia/external/800) Running State Change CS_CONSUME_MEDIA (Cur 2 Tot 13)
2020-07-24 10:47:40.252406 [DEBUG] switch_core_state_machine.c:663 (sofia/external/800) State CONSUME_MEDIA
2020-07-24 10:47:40.252406 [DEBUG] switch_core_state_machine.c:663 (sofia/external/800) State CONSUME_MEDIA going to sleep
recv 722 bytes from udp/[2.3.4.5]:5060 at 10:47:40.272501:
------------------------------------------------------------------------
SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.0/UDP 1.2.3.4:5080;rport=5080;branch=z9hG4bKgFrg0XK8FDKme
From: "+393921234567" <sip:5600112@sip.mytrunkservice.net>;tag=Bjt7HacgFF5Ua
To: <sip:800@sip.mytrunkservice.net>;tag=ac2f3091de46227321b1af258e10b75e-59f4
Call-ID: 2c505812-482d-1239-a1ae-00505637f1d4
CSeq: 23236438 INVITE
Proxy-Authenticate: Digest realm="sip.mytrunkservice.net", nonce="XxqhVl8aoCrpe0MfVXqU8VaoCkTGlJYp6fsFaix+E31FbVplWHnQu+qpsqGA", qop="auth"
Server: sip.mytrunkservice.net SIP Proxy
Content-Length: 0
Warning: 392 2.3.4.5:5060 "Noisy feedback tells:  pid=126333 req_src_ip=1.2.3.4 req_src_port=5080 in_uri=sip:800@sip.mytrunkservice.net out_uri=sip:800@sip.mytrunkservice.net via_cnt==1"

send 365 bytes to udp/[2.3.4.5]:5060 at 10:47:40.272610:
------------------------------------------------------------------------
ACK sip:800@sip.mytrunkservice.net SIP/2.0
Via: SIP/2.0/UDP 1.2.3.4:5080;rport;branch=z9hG4bKgFrg0XK8FDKme
Max-Forwards: 67
From: "+393921234567" <sip:5600112@sip.mytrunkservice.net>;tag=Bjt7HacgFF5Ua
To: <sip:800@sip.mytrunkservice.net>;tag=ac2f3091de46227321b1af258e10b75e-59f4
Call-ID: 2c505812-482d-1239-a1ae-00505637f1d4
CSeq: 23236438 ACK
Content-Length: 0

send 1381 bytes to udp/[2.3.4.5]:5060 at 10:47:40.272901:
------------------------------------------------------------------------
INVITE sip:800@sip.mytrunkservice.net SIP/2.0
Via: SIP/2.0/UDP 1.2.3.4:5080;rport;branch=z9hG4bKHrH91r4BDp96S
Max-Forwards: 67
From: "+393921234567" <sip:5600112@sip.mytrunkservice.net>;tag=Bjt7HacgFF5Ua
To: <sip:800@sip.mytrunkservice.net>
Call-ID: 2c505812-482d-1239-a1ae-00505637f1d4
CSeq: 23236439 INVITE
Contact: <sip:5600112@1.2.3.4:5080;transport=udp;gw=26f512af-78ae-4331-b7da-708d6342eca1>
User-Agent: FreeSWITCH
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
Supported: timer, path, replaces
Allow-Events: talk, hold, conference, refer
Proxy-Authorization: Digest username="5600112", realm="sip.mytrunkservice.net", nonce="XxqhVl8aoCrpe0MfVXqU8VaoCkTGlJYp6fsFaix+E31FbVplWHnQu+qpsqGA", cnonce="LFL6FUgtEjmuoQBQVjfx1A", algorithm=MD5, uri="sip:800@sip.mytrunkservice.net", response="dfaa05854bae0c00940492ffcbe7b84a", qop=auth, nc=00000001
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 301
Remote-Party-ID: "+393921234567" <sip:5600112@sip.mytrunkservice.net>;party=calling;screen=yes;privacy=off

v=0
o=FreeSWITCH 1595548584 1595548585 IN IP4 1.2.3.4
s=FreeSWITCH
c=IN IP4 1.2.3.4
t=0 0
m=audio 31876 RTP/AVP 8 18 0 101
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
a=ptime:20
2020-07-24 10:47:40.272462 [DEBUG] sofia.c:7325 Channel sofia/external/800 entering state [calling][0]
recv 580 bytes from udp/[2.3.4.5]:5060 at 10:47:40.290723:
------------------------------------------------------------------------
SIP/2.0 403 No Route To Destination
Via: SIP/2.0/UDP 1.2.3.4:5080;rport=5080;branch=z9hG4bKHrH91r4BDp96S
From: "+393921234567" <sip:5600112@sip.mytrunkservice.net>;tag=Bjt7HacgFF5Ua
To: <sip:800@sip.mytrunkservice.net>;tag=ac2f3091de46227321b1af258e10b75e-0e53
Call-ID: 2c505812-482d-1239-a1ae-00505637f1d4
CSeq: 23236439 INVITE
Server: sip.mytrunkservice.net SIP Proxy
Content-Length: 0
Warning: 392 2.3.4.5:5060 "Noisy feedback tells:  pid=126333 req_src_ip=1.2.3.4 req_src_port=5080 in_uri=sip:800@sip.mytrunkservice.net out_uri=sip:800@sip.mytrunkservice.net via_cnt==1"

send 365 bytes to udp/[2.3.4.5]:5060 at 10:47:40.290809:
------------------------------------------------------------------------
ACK sip:800@sip.mytrunkservice.net SIP/2.0
Via: SIP/2.0/UDP 1.2.3.4:5080;rport;branch=z9hG4bKHrH91r4BDp96S
Max-Forwards: 67
From: "+393921234567" <sip:5600112@sip.mytrunkservice.net>;tag=Bjt7HacgFF5Ua
To: <sip:800@sip.mytrunkservice.net>;tag=ac2f3091de46227321b1af258e10b75e-0e53
Call-ID: 2c505812-482d-1239-a1ae-00505637f1d4
CSeq: 23236439 ACK
Content-Length: 0

2020-07-24 10:47:40.272462 [DEBUG] sofia.c:7325 Channel sofia/external/800 entering state [terminated][403]
2020-07-24 10:47:40.272462 [NOTICE] sofia.c:8558 Hangup sofia/external/800 [CS_CONSUME_MEDIA] [CALL_REJECTED]
2020-07-24 10:47:40.272462 [DEBUG] switch_core_state_machine.c:585 (sofia/external/800) Running State Change CS_HANGUP (Cur 2 Tot 13)
2020-07-24 10:47:40.272462 [DEBUG] switch_core_state_machine.c:848 (sofia/external/800) Callstate Change DOWN -> HANGUP
2020-07-24 10:47:40.272462 [DEBUG] switch_core_state_machine.c:850 (sofia/external/800) State HANGUP
2020-07-24 10:47:40.272462 [DEBUG] mod_sofia.c:453 Channel sofia/external/800 hanging up, cause: CALL_REJECTED
2020-07-24 10:47:40.272462 [DEBUG] switch_core_state_machine.c:60 sofia/external/800 Standard HANGUP, cause: CALL_REJECTED
2020-07-24 10:47:40.272462 [DEBUG] switch_core_state_machine.c:850 (sofia/external/800) State HANGUP going to sleep
2020-07-24 10:47:40.272462 [DEBUG] switch_core_state_machine.c:620 (sofia/external/800) State Change CS_HANGUP -> CS_REPORTING
2020-07-24 10:47:40.272462 [DEBUG] switch_core_state_machine.c:585 (sofia/external/800) Running State Change CS_REPORTING (Cur 2 Tot 13)
2020-07-24 10:47:40.272462 [DEBUG] switch_core_state_machine.c:936 (sofia/external/800) State REPORTING
2020-07-24 10:47:40.272462 [DEBUG] switch_core_state_machine.c:174 sofia/external/800 Standard REPORTING, cause: CALL_REJECTED
2020-07-24 10:47:40.272462 [DEBUG] switch_core_state_machine.c:936 (sofia/external/800) State REPORTING going to sleep
2020-07-24 10:47:40.272462 [DEBUG] switch_core_state_machine.c:611 (sofia/external/800) State Change CS_REPORTING -> CS_DESTROY
2020-07-24 10:47:40.272462 [DEBUG] switch_core_session.c:1726 Session 13 (sofia/external/800) Locked, Waiting on external entities
2020-07-24 10:47:40.292410 [DEBUG] switch_ivr_originate.c:3995 Originate Resulted in Error Cause: 21 [CALL_REJECTED]
2020-07-24 10:47:40.292410 [INFO] mod_dptools.c:3631 Originate Failed.  Cause: CALL_REJECTED
2020-07-24 10:47:40.292410 [NOTICE] switch_core_state_machine.c:386 sofia/external/+393921234567@sip.mytrunkservice.net has executed the last dialplan instruction, hanging up.
2020-07-24 10:47:40.292410 [NOTICE] switch_core_state_machine.c:388 Hangup sofia/external/+393921234567@sip.mytrunkservice.net [CS_EXECUTE] [NORMAL_CLEARING]
2020-07-24 10:47:40.292410 [DEBUG] mod_hash.c:296 Usage for my.fusionpbx.tenant.domain.net_outbound is now 0
2020-07-24 10:47:40.292410 [DEBUG] switch_core_state_machine.c:651 (sofia/external/+393921234567@sip.mytrunkservice.net) State EXECUTE going to sleep
2020-07-24 10:47:40.292410 [DEBUG] switch_core_state_machine.c:585 (sofia/external/+393921234567@sip.mytrunkservice.net) Running State Change CS_HANGUP (Cur 2 Tot 13)
2020-07-24 10:47:40.292410 [DEBUG] switch_core_state_machine.c:848 (sofia/external/+393921234567@sip.mytrunkservice.net) Callstate Change RINGING -> HANGUP
2020-07-24 10:47:40.292410 [DEBUG] switch_core_state_machine.c:850 (sofia/external/+393921234567@sip.mytrunkservice.net) State HANGUP
2020-07-24 10:47:40.292410 [DEBUG] mod_sofia.c:447 sofia/external/+393921234567@sip.mytrunkservice.net Overriding SIP cause 480 with 403 from the other leg
2020-07-24 10:47:40.292410 [DEBUG] mod_sofia.c:453 Channel sofia/external/+393921234567@sip.mytrunkservice.net hanging up, cause: NORMAL_CLEARING
2020-07-24 10:47:40.292410 [DEBUG] mod_sofia.c:598 Responding to INVITE with: 403
send 658 bytes to udp/[2.3.4.5]:5060 at 10:47:40.297156:
------------------------------------------------------------------------
SIP/2.0 403 Forbidden
Via: SIP/2.0/UDP 2.3.4.5;branch=z9hG4bK21a3.4fa98061.0
Via: SIP/2.0/UDP 3.4.5.6:5060;branch=z9hG4bK0c76c2bd
Max-Forwards: 68
From: "+393921234567" <sip:+393921234567@sip.mytrunkservice.net>;tag=as428d35cb
To: <sip:02345678900@2.3.4.5>;tag=a90egFUcj6e9e
Call-ID: 5595bbc8323c60aa2b721dd613a0afaa@sip.mytrunkservice.net
CSeq: 102 INVITE
User-Agent: FreeSWITCH
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
Supported: timer, path, replaces
Allow-Events: talk, hold, conference, refer
Reason: Q.850;cause=16;text="NORMAL_CLEARING"
Content-Length: 0

2020-07-24 10:47:40.292410 [DEBUG] switch_core_state_machine.c:60 sofia/external/+393921234567@sip.mytrunkservice.net Standard HANGUP, cause: NORMAL_CLEARING
2020-07-24 10:47:40.292410 [DEBUG] switch_core_state_machine.c:850 (sofia/external/+393921234567@sip.mytrunkservice.net) State HANGUP going to sleep
2020-07-24 10:47:40.292410 [DEBUG] switch_core_state_machine.c:620 (sofia/external/+393921234567@sip.mytrunkservice.net) State Change CS_HANGUP -> CS_REPORTING
2020-07-24 10:47:40.292410 [DEBUG] switch_core_state_machine.c:585 (sofia/external/+393921234567@sip.mytrunkservice.net) Running State Change CS_REPORTING (Cur 2 Tot 13)
2020-07-24 10:47:40.292410 [DEBUG] switch_core_state_machine.c:936 (sofia/external/+393921234567@sip.mytrunkservice.net) State REPORTING
2020-07-24 10:47:40.292410 [NOTICE] switch_core_session.c:1744 Session 13 (sofia/external/800) Ended
2020-07-24 10:47:40.292410 [NOTICE] switch_core_session.c:1748 Close Channel sofia/external/800 [CS_DESTROY]
2020-07-24 10:47:40.292410 [DEBUG] switch_core_state_machine.c:739 (sofia/external/800) Running State Change CS_DESTROY (Cur 1 Tot 13)
2020-07-24 10:47:40.292410 [DEBUG] switch_core_state_machine.c:749 (sofia/external/800) State DESTROY
2020-07-24 10:47:40.292410 [DEBUG] mod_sofia.c:364 sofia/external/800 SOFIA DESTROY
2020-07-24 10:47:40.292410 [DEBUG] switch_core_state_machine.c:181 sofia/external/800 Standard DESTROY
2020-07-24 10:47:40.292410 [DEBUG] switch_core_state_machine.c:749 (sofia/external/800) State DESTROY going to sleep
recv 405 bytes from udp/[2.3.4.5]:5060 at 10:47:40.313511:
------------------------------------------------------------------------
ACK sip:5600112@1.2.3.4:5080;transport=udp;gw=26f512af-78ae-4331-b7da-708d6342eca1 SIP/2.0
Via: SIP/2.0/UDP 2.3.4.5;branch=z9hG4bK21a3.4fa98061.0
Max-Forwards: 69
From: "+393921234567" <sip:+393921234567@sip.mytrunkservice.net>;tag=as428d35cb
To: <sip:02345678900@2.3.4.5>;tag=a90egFUcj6e9e
Call-ID: 5595bbc8323c60aa2b721dd613a0afaa@sip.mytrunkservice.net
CSeq: 102 ACK
Content-Length: 0

2020-07-24 10:47:40.412417 [DEBUG] switch_core_state_machine.c:174 sofia/external/+393921234567@sip.mytrunkservice.net Standard REPORTING, cause: NORMAL_CLEARING
2020-07-24 10:47:40.412417 [DEBUG] switch_core_state_machine.c:936 (sofia/external/+393921234567@sip.mytrunkservice.net) State REPORTING going to sleep
2020-07-24 10:47:40.412417 [DEBUG] switch_core_state_machine.c:611 (sofia/external/+393921234567@sip.mytrunkservice.net) State Change CS_REPORTING -> CS_DESTROY
2020-07-24 10:47:40.412417 [DEBUG] switch_core_session.c:1726 Session 12 (sofia/external/+393921234567@sip.mytrunkservice.net) Locked, Waiting on external entities
2020-07-24 10:47:40.412417 [NOTICE] switch_core_session.c:1744 Session 12 (sofia/external/+393921234567@sip.mytrunkservice.net) Ended
2020-07-24 10:47:40.412417 [NOTICE] switch_core_session.c:1748 Close Channel sofia/external/+393921234567@sip.mytrunkservice.net [CS_DESTROY]
2020-07-24 10:47:40.412417 [DEBUG] switch_core_state_machine.c:739 (sofia/external/+393921234567@sip.mytrunkservice.net) Running State Change CS_DESTROY (Cur 0 Tot 13)
2020-07-24 10:47:40.412417 [DEBUG] switch_core_state_machine.c:749 (sofia/external/+393921234567@sip.mytrunkservice.net) State DESTROY
2020-07-24 10:47:40.412417 [DEBUG] mod_sofia.c:364 sofia/external/+393921234567@sip.mytrunkservice.net SOFIA DESTROY
2020-07-24 10:47:40.412417 [DEBUG] switch_core_state_machine.c:181 sofia/external/+393921234567@sip.mytrunkservice.net Standard DESTROY
2020-07-24 10:47:40.412417 [DEBUG] switch_core_state_machine.c:749 (sofia/external/+393921234567@sip.mytrunkservice.net) State DESTROY going to sleep


INBOUND ROUTE XML

XML: 
<extension name="02345678900" continue="false" uuid="aab169ec-38b4-4716-a41a-576f73585fde">

    <condition field="${sip_to_user}" expression="^(02345678900)$">

        <action application="export" data="call_direction=inbound" inline="true"/>

        <action application="set" data="domain_uuid=27601438-9b0b-4950-839f-07d764a85d52" inline="true"/>

        <action application="set" data="domain_name=my.fusionpbx.tenant.domain.net" inline="true"/>

        <action application="set" data="hangup_after_bridge=true" inline="true"/>

        <action application="set" data="continue_on_fail=true" inline="true"/>

        <action application="transfer" data="800 XML my.fusionpbx.tenant.domain.net"/>

    </condition>

</extension>

if, on last line
XML: 
<action application="transfer" data="800 XML my.fusionpbx.tenant.domain.net"/>
I use 001 (my Snom device) instead of 800 (IVR), my Snom rings

Thank for your support
 
Status
Not open for further replies.
Top Bottom