FollowME doesn't ring external numbers

Status
Not open for further replies.

jlizzotte04

New Member
Dec 30, 2018
9
0
1
38
I setup my extension for Follow me. It doesnt ring my 207-313 number. If i change it from an external number to an internal extension, it works fine. Here is the debug. can anyone see something? It appears like its not allowing the call due to a CallID issue is what I thought. Thanks





a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv

2019-02-04 22:09:48.058375 [NOTICE] mod_dptools.c:1312 Channel [sofia/external/2075091121@67.231.1.110] has been answered
send 1150 bytes to udp/[63.247.69.226]:5060 at 22:09:48.064278:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/UDP 63.247.69.226;branch=z9hG4bK265e.7d69e9628a0ee504ddcf03c43cdb6a1f.0
Via: SIP/2.0/UDP 67.231.1.110:5060;branch=z9hG4bK0cB9c7ab92a3018f351
Record-Route: <sip:63.247.69.226;lr=on;ftag=gK0c1014c9;vsf=AAAAABkBBQUHDAEIAwByB3cYBR0DHQAAAB8BMTA-;dlgcor=6b01.a622>
From: "WIRELESS CALLER " <sip:2075091121@67.231.1.110>;tag=gK0c1014c9
To: <sip:+12078771600@63.247.69.226>;tag=rBU9mHKcteU8g
Call-ID: 1110183220_117387605@67.231.1.110
CSeq: 808221 INVITE
Contact: <sip:+12078771600@163.182.172.148:5080;transport=udp>
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: 226
Remote-Party-ID: "12078771600" <sip:12078771600@63.247.69.226>;party=calling;privacy=off;screen=no

v=0
o=FreeSWITCH 1549299838 1549299839 IN IP4 163.182.172.148
s=FreeSWITCH
c=IN IP4 163.182.172.148
t=0 0
m=audio 18350 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
------------------------------------------------------------------------
2019-02-04 22:09:48.058375 [DEBUG] switch_channel.c:3773 (sofia/external/2075091121@67.231.1.110) Callstate Change RINGING -> ACTIVE
2019-02-04 22:09:48.058375 [DEBUG] sofia.c:7084 Channel sofia/external/2075091121@67.231.1.110 entering state [completed][200]
EXECUTE sofia/external/2075091121@67.231.1.110 sleep(1000)
recv 430 bytes from udp/[63.247.69.226]:5060 at 22:09:48.108377:
------------------------------------------------------------------------
ACK sip:+12078771600@163.182.172.148:5080;transport=udp SIP/2.0
Via: SIP/2.0/UDP 63.247.69.226;branch=z9hG4bK265e.266df193a490e1807f7698f51e37d91c.0
Via: SIP/2.0/UDP 67.231.1.110:5060;branch=z9hG4bK0cB9c7fa50eb3eeddf5
From: <sip:2075091121@67.231.1.110>;tag=gK0c1014c9
To: <sip:+12078771600@63.247.69.226>;tag=rBU9mHKcteU8g
Call-ID: 1110183220_117387605@67.231.1.110
CSeq: 808221 ACK
Max-Forwards: 32
Content-Length: 0

------------------------------------------------------------------------
2019-02-04 22:09:48.118365 [DEBUG] sofia.c:7084 Channel sofia/external/2075091121@67.231.1.110 entering state [ready][200]
2019-02-04 22:09:48.198378 [DEBUG] switch_rtp.c:7308 Correct audio ip/port confirmed.
EXECUTE sofia/external/2075091121@67.231.1.110 set(hangup_after_bridge=true)
2019-02-04 22:09:49.058414 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [hangup_after_bridge]=[true]
EXECUTE sofia/external/2075091121@67.231.1.110 set(ringback=%(2000,4000,440,480))
2019-02-04 22:09:49.058414 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [ringback]=[%(2000,4000,440,480)]
EXECUTE sofia/external/2075091121@67.231.1.110 set(presence_id=800@vox.turnittech.com)
2019-02-04 22:09:49.058414 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [presence_id]=[800@vox.turnittech.com]
EXECUTE sofia/external/2075091121@67.231.1.110 set(default_language=)
2019-02-04 22:09:49.058414 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [default_language]=[UNDEF]
EXECUTE sofia/external/2075091121@67.231.1.110 set(default_dialect=)
2019-02-04 22:09:49.058414 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [default_dialect]=[UNDEF]
EXECUTE sofia/external/2075091121@67.231.1.110 set(default_voice=)
2019-02-04 22:09:49.058414 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [default_voice]=[UNDEF]
EXECUTE sofia/external/2075091121@67.231.1.110 set(transfer_ringback=%(2000,4000,440,480))
2019-02-04 22:09:49.058414 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [transfer_ringback]=[%(2000,4000,440,480)]
EXECUTE sofia/external/2075091121@67.231.1.110 set(ivr_menu_uuid=bcd3cb6d-b10d-4be7-8da8-5a135013b60d)
2019-02-04 22:09:49.058414 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [ivr_menu_uuid]=[bcd3cb6d-b10d-4be7-8da8-5a135013b60d]
EXECUTE sofia/external/2075091121@67.231.1.110 ivr(bcd3cb6d-b10d-4be7-8da8-5a135013b60d)
2019-02-04 22:09:49.078416 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7f6ea804be60 Connected.
2019-02-04 22:09:49.078416 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7f6ea804be60 released.
2019-02-04 22:09:49.078416 [DEBUG] switch_ivr_menu.c:743 switch_ivr_menu_stack_xml_add binding 'menu-exit'
2019-02-04 22:09:49.078416 [DEBUG] switch_ivr_menu.c:743 switch_ivr_menu_stack_xml_add binding 'menu-sub'
2019-02-04 22:09:49.078416 [DEBUG] switch_ivr_menu.c:743 switch_ivr_menu_stack_xml_add binding 'menu-exec-app'
2019-02-04 22:09:49.078416 [DEBUG] switch_ivr_menu.c:743 switch_ivr_menu_stack_xml_add binding 'menu-play-sound'
2019-02-04 22:09:49.078416 [DEBUG] switch_ivr_menu.c:743 switch_ivr_menu_stack_xml_add binding 'menu-back'
2019-02-04 22:09:49.078416 [DEBUG] switch_ivr_menu.c:743 switch_ivr_menu_stack_xml_add binding 'menu-top'
2019-02-04 22:09:49.078416 [DEBUG] switch_ivr_menu.c:880 building menu 'bcd3cb6d-b10d-4be7-8da8-5a135013b60d'
2019-02-04 22:09:49.078416 [DEBUG] switch_ivr_menu.c:964 binding menu action 'menu-exec-app' to '1'
2019-02-04 22:09:49.078416 [DEBUG] switch_ivr_menu.c:964 binding menu action 'menu-exec-app' to '2'
2019-02-04 22:09:49.078416 [DEBUG] switch_ivr_menu.c:964 binding menu action 'menu-exec-app' to '/^(\d{2,11})$/'
2019-02-04 22:09:49.078416 [DEBUG] switch_ivr_menu.c:964 binding menu action 'menu-exec-app' to '/^(\d{2,11})$/'
2019-02-04 22:09:49.078416 [DEBUG] switch_ivr_menu.c:964 binding menu action 'menu-exec-app' to '/^(\d{2,11})$/'
2019-02-04 22:09:49.078416 [DEBUG] switch_ivr_menu.c:483 Executing IVR menu bcd3cb6d-b10d-4be7-8da8-5a135013b60d
2019-02-04 22:09:49.078416 [DEBUG] switch_ivr_play_say.c:1498 Codec Activated L16@8000hz 1 channels 20ms
recv 491 bytes from tcp/[74.75.72.211]:30625 at 22:09:49.325641:
------------------------------------------------------------------------
NOTIFY sip:204@vox.turnittech.com:5060 SIP/2.0
Via: SIP/2.0/TCP 10.0.10.218:12569;branch=z9hG4bK3891457088;rport
From: "Jeremy - 204" <sip:204@vox.turnittech.com:5060>;tag=2057141559
To: <sip:204@vox.turnittech.com:5060>
Call-ID: 0_231987567@10.0.10.218
CSeq: 1 NOTIFY
Allow: INVITE, INFO, PRACK, ACK, BYE, CANCEL, OPTIONS, NOTIFY, REGISTER, SUBSCRIBE, REFER, PUBLISH, UPDATE, MESSAGE
Max-Forwards: 70
User-Agent: Yealink SIP-T46S 66.83.0.55
Event: keep-alive
Content-Length: 0

------------------------------------------------------------------------
send 681 bytes to tcp/[74.75.72.211]:30625 at 22:09:49.326193:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/TCP 10.0.10.218:12569;branch=z9hG4bK3891457088;rport=30625;received=74.75.72.211
From: "Jeremy - 204" <sip:204@vox.turnittech.com:5060>;tag=2057141559
To: <sip:204@vox.turnittech.com:5060>;tag=Uc3ZHrc4jv45D
Call-ID: 0_231987567@10.0.10.218
CSeq: 1 NOTIFY
Contact: <sip:163.182.172.148>
User-Agent: FreeSWITCH
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Content-Length: 0

------------------------------------------------------------------------
2019-02-04 22:09:52.118374 [DEBUG] switch_rtp.c:7534 RTP RECV DTMF 2:1600
2019-02-04 22:09:52.118374 [INFO] switch_channel.c:515 RECV DTMF 2:1600
2019-02-04 22:09:52.118374 [DEBUG] switch_ivr_play_say.c:1942 done playing file /var/lib/freeswitch/recordings/vox.turnittech.com/turnittechmain.wav
2019-02-04 22:09:52.118374 [DEBUG] switch_ivr_menu.c:377 waiting for 4/5 digits t/o 2000
2019-02-04 22:09:52.478405 [DEBUG] switch_rtp.c:7534 RTP RECV DTMF 0:1600
2019-02-04 22:09:52.478405 [INFO] switch_channel.c:515 RECV DTMF 0:1600
2019-02-04 22:09:52.878417 [DEBUG] switch_rtp.c:7534 RTP RECV DTMF 4:2240
2019-02-04 22:09:52.878417 [INFO] switch_channel.c:515 RECV DTMF 4:2240
2019-02-04 22:09:54.898399 [DEBUG] switch_ivr_menu.c:424 digits '204'
2019-02-04 22:09:54.898399 [DEBUG] switch_ivr_menu.c:559 action regex [204] [/^(\d{2,11})$/] [2]
2019-02-04 22:09:54.898399 [DEBUG] switch_ivr_menu.c:577 IVR action on menu 'bcd3cb6d-b10d-4be7-8da8-5a135013b60d' matched '204' param 'set ${cond(${user_exists id 204 vox.turnittech.com} == true ? user_exists=true : user_exists=false)}'
2019-02-04 22:09:54.898399 [DEBUG] switch_ivr_menu.c:581 switch_ivr_menu_execute todo=[2]
EXECUTE sofia/external/2075091121@67.231.1.110 set(user_exists=true)
2019-02-04 22:09:54.898399 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [user_exists]=[true]
2019-02-04 22:09:54.898399 [DEBUG] switch_ivr_menu.c:559 action regex [204] [/^(\d{2,11})$/] [2]
2019-02-04 22:09:54.898399 [DEBUG] switch_ivr_menu.c:577 IVR action on menu 'bcd3cb6d-b10d-4be7-8da8-5a135013b60d' matched '204' param 'playback ${cond(${user_exists} == true ? /usr/share/freeswitch/sounds/${default_language}/${default_dialect}/${default_voice}/ivr/ivr-call_being_transferred.wav : /usr/share/freeswitch/sounds/${default_language}/${default_dialect}/${default_voice}/ivr/ivr-that_was_an_invalid_entry.wav)}'
2019-02-04 22:09:54.898399 [DEBUG] switch_ivr_menu.c:581 switch_ivr_menu_execute todo=[2]
EXECUTE sofia/external/2075091121@67.231.1.110 playback(/usr/share/freeswitch/sounds/en/us/callie/ivr/ivr-call_being_transferred.wav)
2019-02-04 22:09:54.898399 [DEBUG] switch_ivr_play_say.c:1498 Codec Activated L16@8000hz 1 channels 20ms
2019-02-04 22:09:56.378380 [DEBUG] switch_ivr_play_say.c:1942 done playing file /usr/share/freeswitch/sounds/en/us/callie/ivr/ivr-call_being_transferred.wav
2019-02-04 22:09:56.378380 [DEBUG] switch_ivr_menu.c:559 action regex [204] [/^(\d{2,11})$/] [2]
2019-02-04 22:09:56.378380 [DEBUG] switch_ivr_menu.c:577 IVR action on menu 'bcd3cb6d-b10d-4be7-8da8-5a135013b60d' matched '204' param 'transfer ${cond(${user_exists} == true ? 204 XML vox.turnittech.com)}'
2019-02-04 22:09:56.378380 [DEBUG] switch_ivr_menu.c:581 switch_ivr_menu_execute todo=[2]
EXECUTE sofia/external/2075091121@67.231.1.110 transfer(204 XML vox.turnittech.com)
2019-02-04 22:09:56.378380 [DEBUG] switch_ivr.c:2165 (sofia/external/2075091121@67.231.1.110) State Change CS_EXECUTE -> CS_ROUTING
2019-02-04 22:09:56.378380 [NOTICE] switch_ivr.c:2172 Transfer sofia/external/2075091121@67.231.1.110 to XML[204@vox.turnittech.com]
2019-02-04 22:09:56.378380 [DEBUG] switch_ivr_menu.c:673 exit-sound '(null)'
2019-02-04 22:09:56.378380 [DEBUG] switch_core_state_machine.c:650 (sofia/external/2075091121@67.231.1.110) State EXECUTE going to sleep
2019-02-04 22:09:56.378380 [DEBUG] switch_core_state_machine.c:584 (sofia/external/2075091121@67.231.1.110) Running State Change CS_ROUTING (Cur 1 Tot 22)
2019-02-04 22:09:56.378380 [DEBUG] switch_channel.c:2249 (sofia/external/2075091121@67.231.1.110) Callstate Change ACTIVE -> RINGING
2019-02-04 22:09:56.378380 [DEBUG] switch_core_state_machine.c:643 (sofia/external/2075091121@67.231.1.110) State ROUTING
2019-02-04 22:09:56.378380 [DEBUG] mod_sofia.c:143 sofia/external/2075091121@67.231.1.110 SOFIA ROUTING
2019-02-04 22:09:56.378380 [DEBUG] switch_core_state_machine.c:236 sofia/external/2075091121@67.231.1.110 Standard ROUTING
2019-02-04 22:09:56.378380 [INFO] mod_dialplan_xml.c:637 Processing WIRELESS CALLER <2075091121>->204 in context vox.turnittech.com
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->user_exists] continue=true
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (PASS) [user_exists] () =~ // break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(user_exists=${user_exists id ${destination_number} ${domain_name}}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(user_exists=true)
2019-02-04 22:09:56.378380 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [user_exists]=[true]
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (PASS) [user_exists] ${user_exists}(true) =~ /^true$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(extension_uuid=${user_data ${destination_number}@${domain_name} var extension_uuid}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(extension_uuid=b1ac4c0a-8b47-44a6-aac0-879312f0f36b)
2019-02-04 22:09:56.378380 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [extension_uuid]=[b1ac4c0a-8b47-44a6-aac0-879312f0f36b]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(hold_music=${user_data ${destination_number}@${domain_name} var hold_music}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(hold_music=)
2019-02-04 22:09:56.398372 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [hold_music]=[UNDEF]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(forward_all_enabled=${user_data ${destination_number}@${domain_name} var forward_all_enabled}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(forward_all_enabled=false)
2019-02-04 22:09:56.398372 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [forward_all_enabled]=[false]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(forward_all_destination=${user_data ${destination_number}@${domain_name} var forward_all_destination}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(forward_all_destination=)
2019-02-04 22:09:56.398372 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [forward_all_destination]=[UNDEF]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(forward_busy_enabled=${user_data ${destination_number}@${domain_name} var forward_busy_enabled}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(forward_busy_enabled=false)
2019-02-04 22:09:56.398372 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [forward_busy_enabled]=[false]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(forward_busy_destination=${user_data ${destination_number}@${domain_name} var forward_busy_destination}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(forward_busy_destination=)
2019-02-04 22:09:56.398372 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [forward_busy_destination]=[UNDEF]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(forward_no_answer_enabled=${user_data ${destination_number}@${domain_name} var forward_no_answer_enabled}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(forward_no_answer_enabled=false)
2019-02-04 22:09:56.418372 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [forward_no_answer_enabled]=[false]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(forward_no_answer_destination=${user_data ${destination_number}@${domain_name} var forward_no_answer_destination}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(forward_no_answer_destination=)
2019-02-04 22:09:56.418372 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [forward_no_answer_destination]=[UNDEF]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(forward_user_not_registered_enabled=${user_data ${destination_number}@${domain_name} var forward_user_not_registered_enabled}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(forward_user_not_registered_enabled=false)
2019-02-04 22:09:56.418372 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [forward_user_not_registered_enabled]=[false]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(forward_user_not_registered_destination=${user_data ${destination_number}@${domain_name} var forward_user_not_registered_destination}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(forward_user_not_registered_destination=)
2019-02-04 22:09:56.418372 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [forward_user_not_registered_destination]=[UNDEF]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(forward_all_enabled=${user_data ${destination_number}@${domain_name} var forward_all_enabled}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(forward_all_enabled=false)
2019-02-04 22:09:56.418372 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [forward_all_enabled]=[false]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(follow_me_enabled=${user_data ${destination_number}@${domain_name} var follow_me_enabled}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(follow_me_enabled=true)
2019-02-04 22:09:56.438381 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [follow_me_enabled]=[true]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(follow_me_destinations=${user_data ${destination_number}@${domain_name} var follow_me_destinations}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(follow_me_destinations={ignore_early_media=true}[presence_id=[email]204@vox.turnittech.com[/email],fail_on_single_reject=USER_BUSY,sip_h_X-accountcode=${accountcode},instant_ringback=true,ignore_early_media=true,domain_uuid=13dbe4b6-fe12-494e-912f-dfa95174234d,sip_invite_domain=vox.turnittech.com,domain_name=vox.turnittech.com,domain=vox.turnittech.com,extension_uuid=b1ac4c0a-8b47-44a6-aac0-879312f0f36b,leg_delay_start=0,leg_timeout=30]user/204@vox.turnittech.com:_:loopback/export:presence_id=204@vox.turnittech.com\,export:sip_h_X-accountcode=${accountcode}\,export:fail_on_single_reject=USER_BUSY\,export:instant_ringback=true\,export:ignore_early_media=true\,export:domain_uuid=13dbe4b6-fe12-494e-912f-dfa95174234d\,export:sip_invite_domain=vox.turnittech.com\,export:domain_name=vox.turnittech.com\,export:domain=vox.turnittech.com\,export:extension_uuid=b1ac4c0a-8b47-44a6-aac0-879312f0f36b\,export:leg_delay_start=0\,export:eek:riginate_delay_start=0\,export:sleep=0\,export:leg_timeout=30\,transfer:12073131085/vox.turnittech.com/inline)
2019-02-04 22:09:56.438381 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [follow_me_destinations]=[{ignore_early_media=true}[presence_id=[email]204@vox.turnittech.com[/email],fail_on_single_reject=USER_BUSY,sip_h_X-accountcode=,instant_ringback=true,ignore_early_media=true,domain_uuid=13dbe4b6-fe12-494e-912f-dfa95174234d,sip_invite_domain=vox.turnittech.com,domain_name=vox.turnittech.com,domain=vox.turnittech.com,extension_uuid=b1ac4c0a-8b47-44a6-aac0-879312f0f36b,leg_delay_start=0,leg_timeout=30]user/204@vox.turnittech.com:_:loopback/export:presence_id=204@vox.turnittech.com\,export:sip_h_X-accountcode=\,export:fail_on_single_reject=USER_BUSY\,export:instant_ringback=true\,export:ignore_early_media=true\,export:domain_uuid=13dbe4b6-fe12-494e-912f-dfa95174234d\,export:sip_invite_domain=vox.turnittech.com\,export:domain_name=vox.turnittech.com\,export:domain=vox.turnittech.com\,export:extension_uuid=b1ac4c0a-8b47-44a6-aac0-879312f0f36b\,export:leg_delay_start=0\,export:eek:riginate_delay_start=0\,export:sleep=0\,export:leg_timeout=30\,transfer:12073131085/vox.turnittech.com/inline]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(do_not_disturb=${user_data ${destination_number}@${domain_name} var do_not_disturb}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(do_not_disturb=false)
2019-02-04 22:09:56.438381 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [do_not_disturb]=[false]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(call_timeout=${user_data ${destination_number}@${domain_name} var call_timeout}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(call_timeout=30)
2019-02-04 22:09:56.438381 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [call_timeout]=[30]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(missed_call_app=${user_data ${destination_number}@${domain_name} var missed_call_app}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(missed_call_app=)
2019-02-04 22:09:56.458379 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [missed_call_app]=[UNDEF]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(missed_call_data=${user_data ${destination_number}@${domain_name} var missed_call_data}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(missed_call_data=)
2019-02-04 22:09:56.458379 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [missed_call_data]=[UNDEF]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(toll_allow=${user_data ${destination_number}@${domain_name} var toll_allow}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(toll_allow=)
2019-02-04 22:09:56.458379 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [toll_allow]=[UNDEF]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(call_screen_enabled=${user_data ${destination_number}@${domain_name} var call_screen_enabled}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(call_screen_enabled=false)
2019-02-04 22:09:56.458379 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [call_screen_enabled]=[false]
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->user_exists] continue=true
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (PASS) [user_exists] () =~ // break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(user_exists=${user_exists id ${destination_number} ${domain_name}}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(user_exists=true)
2019-02-04 22:09:56.458379 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [user_exists]=[true]
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (PASS) [user_exists] ${user_exists}(true) =~ /^true$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(extension_uuid=${user_data ${destination_number}@${domain_name} var extension_uuid}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(extension_uuid=b1ac4c0a-8b47-44a6-aac0-879312f0f36b)
2019-02-04 22:09:56.458379 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [extension_uuid]=[b1ac4c0a-8b47-44a6-aac0-879312f0f36b]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(hold_music=${user_data ${destination_number}@${domain_name} var hold_music}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(hold_music=)
2019-02-04 22:09:56.478385 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [hold_music]=[UNDEF]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(forward_all_enabled=${user_data ${destination_number}@${domain_name} var forward_all_enabled}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(forward_all_enabled=false)
2019-02-04 22:09:56.478385 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [forward_all_enabled]=[false]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(forward_all_destination=${user_data ${destination_number}@${domain_name} var forward_all_destination}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(forward_all_destination=)
2019-02-04 22:09:56.478385 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [forward_all_destination]=[UNDEF]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(forward_busy_enabled=${user_data ${destination_number}@${domain_name} var forward_busy_enabled}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(forward_busy_enabled=false)
2019-02-04 22:09:56.478385 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [forward_busy_enabled]=[false]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(forward_busy_destination=${user_data ${destination_number}@${domain_name} var forward_busy_destination}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(forward_busy_destination=)
2019-02-04 22:09:56.478385 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [forward_busy_destination]=[UNDEF]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(forward_no_answer_enabled=${user_data ${destination_number}@${domain_name} var forward_no_answer_enabled}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(forward_no_answer_enabled=false)
2019-02-04 22:09:56.498375 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [forward_no_answer_enabled]=[false]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(forward_no_answer_destination=${user_data ${destination_number}@${domain_name} var forward_no_answer_destination}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(forward_no_answer_destination=)
2019-02-04 22:09:56.498375 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [forward_no_answer_destination]=[UNDEF]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(forward_user_not_registered_enabled=${user_data ${destination_number}@${domain_name} var forward_user_not_registered_enabled}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(forward_user_not_registered_enabled=false)
2019-02-04 22:09:56.498375 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [forward_user_not_registered_enabled]=[false]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(forward_user_not_registered_destination=${user_data ${destination_number}@${domain_name} var forward_user_not_registered_destination}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(forward_user_not_registered_destination=)
2019-02-04 22:09:56.498375 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [forward_user_not_registered_destination]=[UNDEF]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(do_not_disturb=${user_data ${destination_number}@${domain_name} var do_not_disturb}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(do_not_disturb=false)
2019-02-04 22:09:56.498375 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [do_not_disturb]=[false]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(call_timeout=${user_data ${destination_number}@${domain_name} var call_timeout}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(call_timeout=30)
2019-02-04 22:09:56.498375 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [call_timeout]=[30]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(missed_call_app=${user_data ${destination_number}@${domain_name} var missed_call_app}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(missed_call_app=)
2019-02-04 22:09:56.518380 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [missed_call_app]=[UNDEF]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(missed_call_data=${user_data ${destination_number}@${domain_name} var missed_call_data}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(missed_call_data=)
2019-02-04 22:09:56.518380 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [missed_call_data]=[UNDEF]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(toll_allow=${user_data ${destination_number}@${domain_name} var toll_allow}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(toll_allow=)
2019-02-04 22:09:56.518380 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [toll_allow]=[UNDEF]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(call_screen_enabled=${user_data ${destination_number}@${domain_name} var call_screen_enabled}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(call_screen_enabled=false)
2019-02-04 22:09:56.518380 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [call_screen_enabled]=[false]
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->caller-details] continue=true
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [caller-details] ${caller_destination}(12078771600) =~ /^$/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->call-direction] continue=true
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (PASS) [call-direction] ${call_direction}(inbound) =~ /^(inbound|outbound|local)$/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->variables] continue=true
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (PASS) [variables] () =~ // break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 Action export(origination_callee_id_name=${destination_number})
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->user_record] continue=true
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (PASS) [user_record] () =~ // break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(user_record=${user_data ${destination_number}@${domain_name} var user_record}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(user_record=)
2019-02-04 22:09:56.518380 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [user_record]=[UNDEF]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(from_user_exists=${user_exists id ${sip_from_user} ${sip_from_host}}) INLINE
2019-02-04 22:09:56.518380 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7f6ea804be60 Connected.
2019-02-04 22:09:56.538362 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7f6ea804be60 released.
EXECUTE sofia/external/2075091121@67.231.1.110 set(from_user_exists=false)
2019-02-04 22:09:56.538362 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [from_user_exists]=[false]
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (PASS) [user_record] ${user_exists}(true) =~ /^true$/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [user_record] ${user_record}() =~ /^all$/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (PASS) [user_record] ${user_exists}(true) =~ /^true$/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (PASS) [user_record] ${call_direction}(inbound) =~ /^inbound$/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [user_record] ${user_record}() =~ /^inbound$/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (PASS) [user_record] ${user_exists}(true) =~ /^true$/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^outbound$/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [user_record] ${user_record}() =~ /^outbound$/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (PASS) [user_record] ${user_exists}(true) =~ /^true$/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^local$/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [user_record] ${user_record}() =~ /^local$/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [user_record] ${from_user_record}() =~ /^all$/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (PASS) [user_record] ${call_direction}(inbound) =~ /^inbound$/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [user_record] ${from_user_record}() =~ /^inbound$/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^outbound$/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [user_record] ${from_user_record}() =~ /^outbound$/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^local$/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [user_record] ${from_user_record}() =~ /^local$/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [user_record] ${record_session}() =~ /^true$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->redial] continue=true
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [redial] destination_number(204) =~ /^(redial|\*870)$/ break=on-true
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (PASS) [redial] () =~ // break=never
Dialplan: sofia/external/2075091121@67.231.1.110 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->speed_dial] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [speed_dial] destination_number(204) =~ /^\*0(.*)$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->default_caller_id] continue=true
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (PASS) [default_caller_id] ${emergency_caller_id_number}() =~ /^$/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(emergency_caller_id_name=${default_emergency_caller_id_name}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(emergency_caller_id_name=)
2019-02-04 22:09:56.538362 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [emergency_caller_id_name]=[UNDEF]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(emergency_caller_id_number=${default_emergency_caller_id_number}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(emergency_caller_id_number=)
2019-02-04 22:09:56.538362 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [emergency_caller_id_number]=[UNDEF]
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (PASS) [default_caller_id] ${outbound_caller_id_number}() =~ /^$/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(outbound_caller_id_name=${default_outbound_caller_id_name}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(outbound_caller_id_name=)
2019-02-04 22:09:56.538362 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [outbound_caller_id_name]=[UNDEF]
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(outbound_caller_id_number=${default_outbound_caller_id_number}) INLINE
EXECUTE sofia/external/2075091121@67.231.1.110 set(outbound_caller_id_number=)
2019-02-04 22:09:56.538362 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [outbound_caller_id_number]=[UNDEF]
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->1.11d] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [1.11d] ${user_exists}(true) =~ /false/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->1.10d] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [1.10d] ${user_exists}(true) =~ /false/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->1.7d] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [1.7d] ${user_exists}(true) =~ /false/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->ring group] continue=
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [ring group] destination_number(204) =~ /^501$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->Main Greeting] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [Main Greeting] destination_number(204) =~ /^800$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->ring group] continue=
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [ring group] destination_number(204) =~ /^502$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->agent_status] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [agent_status] destination_number(204) =~ /^\*22$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->agent_status_id] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [agent_status_id] destination_number(204) =~ /^\*23$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->group-intercept] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [group-intercept] destination_number(204) =~ /^\*8$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->page-extension] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [page-extension] destination_number(204) =~ /^\*8(\d{2,7})$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->eavesdrop] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [eavesdrop] destination_number(204) =~ /^\*33(\d{2,7})$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->call_privacy] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [call_privacy] destination_number(204) =~ /^\*67(\d+)$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->call_return] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [call_return] destination_number(204) =~ /^\*69$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->extension_queue] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [extension_queue] destination_number(204) =~ /^\*800(.*)$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->intercept-ext-polycom] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [intercept-ext-polycom] destination_number(204) =~ /^\*97(\d+)$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->intercept-ext] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [intercept-ext] destination_number(204) =~ /^\*\*(\d+)$/ break=on-true
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [intercept-ext] destination_number(204) =~ /^\*\*$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->dx] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [dx] destination_number(204) =~ /^dx$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->extension-to-voicemail] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (PASS) [extension-to-voicemail] ${user_exists}(true) =~ /^true$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (PASS) [extension-to-voicemail] username(2075091121) =~ /^2075091121$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [extension-to-voicemail] destination_number(204) =~ /^2075091121$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->att_xfer] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [att_xfer] destination_number(204) =~ /^att_xfer$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->extension-to-voicemail] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (PASS) [extension-to-voicemail] ${user_exists}(true) =~ /^true$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (PASS) [extension-to-voicemail] username(2075091121) =~ /^2075091121$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [extension-to-voicemail] destination_number(204) =~ /^2075091121$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->send_to_voicemail] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [send_to_voicemail] destination_number(204) =~ /^\*99(\d{2,10})$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->xfer_vm] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [xfer_vm] destination_number(204) =~ /^xfer_vm$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->vmain] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [vmain] destination_number(204) =~ /^vmain$|^\*4000$|^\*98$/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [vmain] destination_number(204) =~ /^(vmain$|^\*4000$|^\*98)(\d{2,12})$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->is_transfer] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [is_transfer] destination_number(204) =~ /^is_transfer$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->vmain_user] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [vmain_user] destination_number(204) =~ /^\*97$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->cf] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [cf] destination_number(204) =~ /^cf$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->delay_echo] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [delay_echo] destination_number(204) =~ /^\*9195$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->echo] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [echo] destination_number(204) =~ /^\*9196$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->is_zrtp_secure] continue=true
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [is_zrtp_secure] ${zrtp_secure_media_confirmed}() =~ /^true$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 ANTI-Action eval(not_secure)
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->milliwatt] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [milliwatt] destination_number(204) =~ /^\*9197$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->tone_stream] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [tone_stream] destination_number(204) =~ /^\*9198$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->is_secure] continue=true
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [is_secure] ${sip_via_protocol}(udp) =~ /tls/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->hold_music] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [hold_music] destination_number(204) =~ /^\*9664$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->recordings] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [recordings] destination_number(204) =~ /^\*(732)$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->directory] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [directory] destination_number(204) =~ /^\*411$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->wake-up] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [wake-up] destination_number(204) =~ /^\*(925)$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->valet_park] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [valet_park] destination_number(204) =~ /^(park\+)?\*(59[0-9][0-9])$/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [valet_park] ${sip_h_Referred-By}() =~ /sip:(.*)@.*/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [valet_park] destination_number(204) =~ /^(park\+)?\*(59[0-9][0-9])$/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [valet_park] destination_number(204) =~ /^(park\+)?\*(59[0-9][0-9])$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->operator] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [operator] destination_number(204) =~ /^0$|^operator$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->operator-forward] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [operator-forward] destination_number(204) =~ /^\*000$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->do-not-disturb] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [do-not-disturb] destination_number(204) =~ /^\*77$/ break=on-true
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [do-not-disturb] destination_number(204) =~ /^\*78$|\*363$/ break=on-true
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [do-not-disturb] destination_number(204) =~ /^\*79$/ break=on-true
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [do-not-disturb] destination_number(204) =~ /^dnd\+2075091121$/ break=on-true
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->call-forward] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [call-forward] destination_number(204) =~ /^\*72$/ break=on-true
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [call-forward] destination_number(204) =~ /^\*73$/ break=on-true
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [call-forward] destination_number(204) =~ /^\*74$/ break=on-true
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [call-forward] destination_number(204) =~ /^forward\+(\Q2075091121\E)(?:\/(\d+))?$/ break=on-true
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->call forward all] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (PASS) [call forward all] ${user_exists}(true) =~ /true/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [call forward all] ${forward_all_enabled}(false) =~ /true/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->call forward not registered] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (PASS) [call forward not registered] ${user_exists}(true) =~ /true/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [call forward not registered] ${forward_user_not_registered_enabled}(false) =~ /true/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->follow-me] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [follow-me] destination_number(204) =~ /^\*21$/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 parsing [vox.turnittech.com->follow me bridge] continue=false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (PASS) [follow me bridge] ${user_exists}(true) =~ /true/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (PASS) [follow me bridge] ${follow_me_enabled}(true) =~ /true/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(hangup_after_bridge=true)
Dialplan: sofia/external/2075091121@67.231.1.110 Action set(continue_on_fail=true)
Dialplan: sofia/external/2075091121@67.231.1.110 Action bridge(${follow_me_destinations})
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (PASS) [follow me bridge] ${user_exists}(true) =~ /true/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (PASS) [follow me bridge] ${follow_me_enabled}(true) =~ /true/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (FAIL) [follow me bridge] ${forward_no_answer_enabled}(false) =~ /true/ break=never
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (PASS) [follow me bridge] ${user_exists}(true) =~ /true/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 Regex (PASS) [follow me bridge] ${follow_me_enabled}(true) =~ /true/ break=on-false
Dialplan: sofia/external/2075091121@67.231.1.110 Action transfer(*99${destination_number} XML ${domain_name})
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:286 (sofia/external/2075091121@67.231.1.110) State Change CS_ROUTING -> CS_EXECUTE
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:643 (sofia/external/2075091121@67.231.1.110) State ROUTING going to sleep
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:584 (sofia/external/2075091121@67.231.1.110) Running State Change CS_EXECUTE (Cur 1 Tot 22)
2019-02-04 22:09:56.538362 [DEBUG] switch_channel.c:2251 (sofia/external/2075091121@67.231.1.110) Callstate Change RINGING -> ACTIVE
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:650 (sofia/external/2075091121@67.231.1.110) State EXECUTE
2019-02-04 22:09:56.538362 [DEBUG] mod_sofia.c:198 sofia/external/2075091121@67.231.1.110 SOFIA EXECUTE
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:328 sofia/external/2075091121@67.231.1.110 Standard EXECUTE
EXECUTE sofia/external/2075091121@67.231.1.110 export(origination_callee_id_name=204)
2019-02-04 22:09:56.538362 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [origination_callee_id_name]=[204]
EXECUTE sofia/external/2075091121@67.231.1.110 set(RFC2822_DATE=Mon, 04 Feb 2019 22:09:56 +0000)
2019-02-04 22:09:56.538362 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [RFC2822_DATE]=[Mon, 04 Feb 2019 22:09:56 +0000]
EXECUTE sofia/external/2075091121@67.231.1.110 hash(insert/vox.turnittech.com-last_dial/2075091121/204)
EXECUTE sofia/external/2075091121@67.231.1.110 eval(not_secure)
EXECUTE sofia/external/2075091121@67.231.1.110 set(hangup_after_bridge=true)
2019-02-04 22:09:56.538362 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [hangup_after_bridge]=[true]
EXECUTE sofia/external/2075091121@67.231.1.110 set(continue_on_fail=true)
2019-02-04 22:09:56.538362 [DEBUG] mod_dptools.c:1548 SET sofia/external/2075091121@67.231.1.110 [continue_on_fail]=[true]
EXECUTE sofia/external/2075091121@67.231.1.110 bridge({ignore_early_media=true}[presence_id=[email]204@vox.turnittech.com[/email],fail_on_single_reject=USER_BUSY,sip_h_X-accountcode=,instant_ringback=true,ignore_early_media=true,domain_uuid=13dbe4b6-fe12-494e-912f-dfa95174234d,sip_invite_domain=vox.turnittech.com,domain_name=vox.turnittech.com,domain=vox.turnittech.com,extension_uuid=b1ac4c0a-8b47-44a6-aac0-879312f0f36b,leg_delay_start=0,leg_timeout=30]user/204@vox.turnittech.com:_:loopback/export:presence_id=204@vox.turnittech.com\,export:sip_h_X-accountcode=\,export:fail_on_single_reject=USER_BUSY\,export:instant_ringback=true\,export:ignore_early_media=true\,export:domain_uuid=13dbe4b6-fe12-494e-912f-dfa95174234d\,export:sip_invite_domain=vox.turnittech.com\,export:domain_name=vox.turnittech.com\,export:domain=vox.turnittech.com\,export:extension_uuid=b1ac4c0a-8b47-44a6-aac0-879312f0f36b\,export:leg_delay_start=0\,export:eek:riginate_delay_start=0\,export:sleep=0\,export:leg_timeout=30\,transfer:12073131085/vox.turnittech.com/inline)
2019-02-04 22:09:56.538362 [DEBUG] switch_channel.c:1250 sofia/external/2075091121@67.231.1.110 EXPORTING[export_vars] [call_direction]=[inbound] to event
2019-02-04 22:09:56.538362 [DEBUG] switch_channel.c:1250 sofia/external/2075091121@67.231.1.110 EXPORTING[export_vars] [call_direction]=[inbound] to event
2019-02-04 22:09:56.538362 [DEBUG] switch_channel.c:1250 sofia/external/2075091121@67.231.1.110 EXPORTING[export_vars] [origination_callee_id_name]=[204] to event
2019-02-04 22:09:56.538362 [DEBUG] switch_channel.c:1250 sofia/external/2075091121@67.231.1.110 EXPORTING[export_vars] [origination_callee_id_name]=[204] to event
2019-02-04 22:09:56.538362 [DEBUG] switch_ivr_originate.c:1548 Parsing ultra-global variables
2019-02-04 22:09:56.538362 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
2019-02-04 22:09:56.538362 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
2019-02-04 22:09:56.538362 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
2019-02-04 22:09:56.538362 [NOTICE] switch_channel.c:1104 New Channel loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in [a07d4b44-3810-412c-ad1f-124fdf0e9a55]
2019-02-04 22:09:56.538362 [DEBUG] mod_loopback.c:158 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in setup codec L16/8000/20
2019-02-04 22:09:56.538362 [NOTICE] switch_channel.c:1102 Rename Channel loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in->loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in [a07d4b44-3810-412c-ad1f-124fdf0e9a55]
2019-02-04 22:09:56.538362 [DEBUG] mod_loopback.c:1174 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State Change CS_NEW -> CS_INIT
2019-02-04 22:09:56.538362 [DEBUG] mod_loopback.c:601 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in CHANNEL KILL
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:584 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) Running State Change CS_INIT (Cur 2 Tot 23)
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:627 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State INIT
2019-02-04 22:09:56.538362 [NOTICE] switch_channel.c:1104 New Channel loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in [80cc4eb1-a780-4449-a16a-afc9902737f9]
2019-02-04 22:09:56.538362 [DEBUG] mod_loopback.c:158 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in setup codec L16/8000/20
2019-02-04 22:09:56.538362 [DEBUG] mod_loopback.c:276 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State Change CS_NEW -> CS_INIT
2019-02-04 22:09:56.538362 [DEBUG] mod_loopback.c:601 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in CHANNEL KILL
2019-02-04 22:09:56.538362 [DEBUG] mod_loopback.c:362 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State Change CS_INIT -> CS_ROUTING
2019-02-04 22:09:56.538362 [DEBUG] mod_loopback.c:601 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in CHANNEL KILL
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:627 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State INIT going to sleep
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:584 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) Running State Change CS_INIT (Cur 3 Tot 24)
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:627 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State INIT
2019-02-04 22:09:56.538362 [DEBUG] mod_loopback.c:362 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State Change CS_INIT -> CS_ROUTING
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:584 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) Running State Change CS_ROUTING (Cur 3 Tot 24)
2019-02-04 22:09:56.538362 [DEBUG] mod_loopback.c:601 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in CHANNEL KILL
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:627 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State INIT going to sleep
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:643 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State ROUTING
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:584 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) Running State Change CS_ROUTING (Cur 3 Tot 24)
2019-02-04 22:09:56.538362 [DEBUG] mod_loopback.c:394 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in CHANNEL ROUTING
2019-02-04 22:09:56.538362 [DEBUG] switch_channel.c:2249 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) Callstate Change DOWN -> RINGING
2019-02-04 22:09:56.538362 [DEBUG] switch_ivr_originate.c:67 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2019-02-04 22:09:56.538362 [DEBUG] mod_loopback.c:601 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in CHANNEL KILL
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:643 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State ROUTING going to sleep
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:584 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) Running State Change CS_CONSUME_MEDIA (Cur 3 Tot 24)
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:662 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State CONSUME_MEDIA
2019-02-04 22:09:56.538362 [DEBUG] mod_loopback.c:661 CHANNEL CONSUME_MEDIA
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:643 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State ROUTING
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:662 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State CONSUME_MEDIA going to sleep
2019-02-04 22:09:56.538362 [DEBUG] mod_loopback.c:394 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in CHANNEL ROUTING
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:236 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Standard ROUTING
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:286 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State Change CS_ROUTING -> CS_EXECUTE
2019-02-04 22:09:56.538362 [DEBUG] mod_loopback.c:601 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in CHANNEL KILL
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:643 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State ROUTING going to sleep
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:584 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) Running State Change CS_EXECUTE (Cur 3 Tot 24)
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:650 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State EXECUTE
2019-02-04 22:09:56.538362 [DEBUG] mod_loopback.c:436 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in CHANNEL EXECUTE
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:328 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Standard EXECUTE
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in export(presence_id=204@vox.turnittech.com)
2019-02-04 22:09:56.538362 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [presence_id]=[204@vox.turnittech.com]
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in export(sip_h_X-accountcode=)
2019-02-04 22:09:56.538362 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [sip_h_X-accountcode]=[UNDEF]
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in export(fail_on_single_reject=USER_BUSY)
2019-02-04 22:09:56.538362 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [fail_on_single_reject]=[USER_BUSY]
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in export(instant_ringback=true)
2019-02-04 22:09:56.538362 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [instant_ringback]=[true]
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in export(ignore_early_media=true)
2019-02-04 22:09:56.538362 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [ignore_early_media]=[true]
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in export(domain_uuid=13dbe4b6-fe12-494e-912f-dfa95174234d)
2019-02-04 22:09:56.538362 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [domain_uuid]=[13dbe4b6-fe12-494e-912f-dfa95174234d]
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in export(sip_invite_domain=vox.turnittech.com)
2019-02-04 22:09:56.538362 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [sip_invite_domain]=[vox.turnittech.com]
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in export(domain_name=vox.turnittech.com)
2019-02-04 22:09:56.538362 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [domain_name]=[vox.turnittech.com]
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in export(domain=vox.turnittech.com)
2019-02-04 22:09:56.538362 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [domain]=[vox.turnittech.com]
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in export(extension_uuid=b1ac4c0a-8b47-44a6-aac0-879312f0f36b)
2019-02-04 22:09:56.538362 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [extension_uuid]=[b1ac4c0a-8b47-44a6-aac0-879312f0f36b]
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in export(leg_delay_start=0)
2019-02-04 22:09:56.538362 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [leg_delay_start]=[0]
2019-02-04 22:09:56.538362 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in export(originate_delay_start=0)
2019-02-04 22:09:56.538362 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [originate_delay_start]=[0]
2019-02-04 22:09:56.538362 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/204@10.0.10.218:12569 [b5524be4-739f-413e-8c7e-672863fdd587]
2019-02-04 22:09:56.538362 [DEBUG] mod_sofia.c:4819 (sofia/internal/204@10.0.10.218:12569) State Change CS_NEW -> CS_INIT
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in export(sleep=0)
2019-02-04 22:09:56.538362 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [sleep]=[0]
2019-02-04 22:09:56.538362 [DEBUG] switch_ivr_originate.c:2963 sofia/internal/204@10.0.10.218:12569 Setting leg timeout to 30
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in export(leg_timeout=30)
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/204@10.0.10.218:12569) Running State Change CS_INIT (Cur 4 Tot 25)
2019-02-04 22:09:56.538362 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [leg_timeout]=[30]
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/204@10.0.10.218:12569) State INIT
2019-02-04 22:09:56.538362 [DEBUG] mod_sofia.c:90 sofia/internal/204@10.0.10.218:12569 SOFIA INIT
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in transfer(12073131085)
2019-02-04 22:09:56.538362 [DEBUG] sofia_glue.c:1264 sip:204@74.75.72.211:30625;transport=TCP Setting proxy route to sofia/internal/204@10.0.10.218:12569
2019-02-04 22:09:56.538362 [DEBUG] sofia_glue.c:1295 sofia/internal/204@10.0.10.218:12569 sending invite version: 1.6.20 -37-987c9b9 64bit
Local SDP:
v=0
o=FreeSWITCH 1549296422 1549296423 IN IP4 163.182.172.148
s=FreeSWITCH
c=IN IP4 163.182.172.148
t=0 0
m=audio 21774 RTP/AVP 9 0 8 101 13
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=rtpmap:13 CN/8000
a=ptime:20
a=sendrecv

2019-02-04 22:09:56.538362 [DEBUG] switch_ivr.c:2165 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State Change CS_EXECUTE -> CS_ROUTING
2019-02-04 22:09:56.538362 [DEBUG] mod_loopback.c:601 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in CHANNEL KILL
2019-02-04 22:09:56.538362 [DEBUG] mod_loopback.c:601 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in CHANNEL KILL
2019-02-04 22:09:56.538362 [NOTICE] switch_ivr.c:2172 Transfer loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in to XML[12073131085@vox.turnittech.com]
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:40 sofia/internal/204@10.0.10.218:12569 Standard INIT
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/204@10.0.10.218:12569) State Change CS_INIT -> CS_ROUTING
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/204@10.0.10.218:12569) State INIT going to sleep
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:650 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State EXECUTE going to sleep
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:584 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) Running State Change CS_ROUTING (Cur 4 Tot 25)
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:643 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State ROUTING
2019-02-04 22:09:56.538362 [DEBUG] mod_loopback.c:394 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in CHANNEL ROUTING
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:236 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Standard ROUTING
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/204@10.0.10.218:12569) Running State Change CS_ROUTING (Cur 4 Tot 25)
2019-02-04 22:09:56.538362 [INFO] mod_dialplan_xml.c:637 Processing WIRELESS CALLER <2075091121>->12073131085 in context vox.turnittech.com
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/204@10.0.10.218:12569) State ROUTING
2019-02-04 22:09:56.538362 [DEBUG] mod_sofia.c:143 sofia/internal/204@10.0.10.218:12569 SOFIA ROUTING
2019-02-04 22:09:56.538362 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/204@10.0.10.218:12569) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/204@10.0.10.218:12569) State ROUTING going to sleep
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/204@10.0.10.218:12569) Running State Change CS_CONSUME_MEDIA (Cur 4 Tot 25)
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/204@10.0.10.218:12569) State CONSUME_MEDIA
2019-02-04 22:09:56.538362 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/204@10.0.10.218:12569) State CONSUME_MEDIA going to sleep
send 1320 bytes to tcp/[74.75.72.211]:30625 at 22:09:56.552021:
------------------------------------------------------------------------
INVITE sip:204@10.0.10.218:12569;transport=TCP SIP/2.0
Via: SIP/2.0/TCP 163.182.172.148;rport;branch=z9hG4bKB6495U27B0r4j
Route: <sip:204@74.75.72.211:30625>;transport=TCP
Max-Forwards: 70
From: "WIRELESS CALLER " <sip:2075091121@vox.turnittech.com>;tag=vNvrKKX7F5trS
To: <sip:204@10.0.10.218:12569;transport=TCP>
Call-ID: 725e4748-a36c-1237-2e8f-00163c78a6b5
CSeq: 105306 INVITE
Contact: <sip:mod_sofia@163.182.172.148:5060;transport=tcp>
User-Agent: FreeSWITCH
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 298
X-FS-Support: update_display,send_info
Remote-Party-ID: "WIRELESS CALLER " <sip:2075091121@vox.turnittech.com>;party=calling;screen=yes;privacy=off

v=0
o=FreeSWITCH 1549296422 1549296423 IN IP4 163.182.172.148
s=FreeSWITCH
c=IN IP4 163.182.172.148
t=0 0
m=audio 21774 RTP/AVP 9 0 8 101 13
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=rtpmap:13 CN/8000
a=ptime:20
------------------------------------------------------------------------
2019-02-04 22:09:56.538362 [DEBUG] sofia.c:7084 Channel sofia/internal/204@10.0.10.218:12569 entering state [calling][0]
send 1470 bytes to tcp/[74.75.72.211]:59708 at 22:09:56.553063:
------------------------------------------------------------------------
NOTIFY sip:206@10.0.10.219:5060;transport=TCP SIP/2.0
Via: SIP/2.0/TCP 163.182.172.148;rport;branch=z9hG4bKcFy27pKB98eQe
Route: <sip:74.75.72.211:59708>;transport=TCP
Max-Forwards: 70
From: <sip:204@vox.turnittech.com:5060>;tag=wJLtUybjalf5
To: "Richard - 206" <sip:206@vox.turnittech.com:5060>;tag=808029337
Call-ID: 0_1097518684@10.0.10.219
CSeq: 150869801 NOTIFY
Contact: <sip:204@163.182.172.148:5060;transport=tcp>
User-Agent: FreeSWITCH
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Event: dialog
Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Subscription-State: active;expires=968
Content-Type: application/dialog-info+xml
Content-Length: 581

<?xml version="1.0"?>
<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="8" state="full" entity="sip:204@vox.turnittech.com">
<dialog id="b5524be4-739f-413e-8c7e-672863fdd587" direction="recipient">
<state>early</state>
<local>
<identity display="204">sip:204@vox.turnittech.com</identity>
<target uri="sip:204@vox.turnittech.com">
<param pname="+sip.rendering" pvalue="yes"/>
</target>
</local>
<remote>
<identity display="WIRELESS CALLER ">sip:2075091121@vox.turnittech.com</identity>
<target uri="sip:**204@vox.turnittech.com"/>
</remote>
</dialog>
</dialog-info>
------------------------------------------------------------------------
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in parsing [vox.turnittech.com->user_exists] continue=true
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (PASS) [user_exists] () =~ // break=on-false
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Action set(user_exists=${user_exists id ${destination_number} ${domain_name}}) INLINE
2019-02-04 22:09:56.558370 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7f6ea804be60 Connected.
2019-02-04 22:09:56.558370 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7f6ea804be60 released.
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in set(user_exists=false)
2019-02-04 22:09:56.558370 [DEBUG] mod_dptools.c:1548 SET loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in [user_exists]=[false]
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (FAIL) [user_exists] ${user_exists}(false) =~ /^true$/ break=on-false
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in parsing [vox.turnittech.com->user_exists] continue=true
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (PASS) [user_exists] () =~ // break=on-false
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Action set(user_exists=${user_exists id ${destination_number} ${domain_name}}) INLINE
2019-02-04 22:09:56.558370 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7f6ea804be60 Connected.
2019-02-04 22:09:56.558370 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7f6ea804be60 released.
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in set(user_exists=false)
2019-02-04 22:09:56.558370 [DEBUG] mod_dptools.c:1548 SET loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in [user_exists]=[false]
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (FAIL) [user_exists] ${user_exists}(false) =~ /^true$/ break=on-false
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in parsing [vox.turnittech.com->caller-details] continue=true
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (PASS) [caller-details] ${caller_destination}() =~ /^$/ break=never
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Action set(caller_destination=${destination_number}) INLINE
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in set(caller_destination=12073131085)
2019-02-04 22:09:56.558370 [DEBUG] mod_dptools.c:1548 SET loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in [caller_destination]=[12073131085]
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Action set(caller_id_name=${caller_id_name}) INLINE
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in set(caller_id_name=WIRELESS CALLER )
2019-02-04 22:09:56.558370 [DEBUG] mod_dptools.c:1548 SET loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in [caller_id_name]=[WIRELESS CALLER ]
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Action set(caller_id_number=${caller_id_number}) INLINE
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in set(caller_id_number=2075091121)
2019-02-04 22:09:56.558370 [DEBUG] mod_dptools.c:1548 SET loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in [caller_id_number]=[2075091121]
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in parsing [vox.turnittech.com->call-direction] continue=true
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (PASS) [call-direction] ${call_direction}(inbound) =~ /^(inbound|outbound|local)$/ break=never
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in parsing [vox.turnittech.com->variables] continue=true
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (PASS) [variables] () =~ // break=on-false
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Action export(origination_callee_id_name=${destination_number})
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in parsing [vox.turnittech.com->user_record] continue=true
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (PASS) [user_record] () =~ // break=on-false
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Action set(user_record=${user_data ${destination_number}@${domain_name} var user_record}) INLINE
2019-02-04 22:09:56.558370 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7f6ea804be60 Connected.
2019-02-04 22:09:56.558370 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7f6ea804be60 released.
2019-02-04 22:09:56.558370 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7f6ea804be60 Connected.
2019-02-04 22:09:56.558370 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7f6ea804be60 released.
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in set(user_record=)
2019-02-04 22:09:56.558370 [DEBUG] mod_dptools.c:1548 SET loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in [user_record]=[UNDEF]
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Action set(from_user_exists=${user_exists id ${sip_from_user} ${sip_from_host}}) INLINE
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in set(from_user_exists=false)
2019-02-04 22:09:56.558370 [DEBUG] mod_dptools.c:1548 SET loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in [from_user_exists]=[false]
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (FAIL) [user_record] ${user_record}() =~ /^all$/ break=never
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (PASS) [user_record] ${call_direction}(inbound) =~ /^inbound$/ break=never
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (FAIL) [user_record] ${user_record}() =~ /^inbound$/ break=never
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^outbound$/ break=never
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (FAIL) [user_record] ${user_record}() =~ /^outbound$/ break=never
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^local$/ break=never
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (FAIL) [user_record] ${user_record}() =~ /^local$/ break=never
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (FAIL) [user_record] ${from_user_record}() =~ /^all$/ break=never
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (PASS) [user_record] ${call_direction}(inbound) =~ /^inbound$/ break=never
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (FAIL) [user_record] ${from_user_record}() =~ /^inbound$/ break=never
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^outbound$/ break=never
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (FAIL) [user_record] ${from_user_record}() =~ /^outbound$/ break=never
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^local$/ break=never
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (FAIL) [user_record] ${from_user_record}() =~ /^local$/ break=never
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (FAIL) [user_record] ${record_session}() =~ /^true$/ break=on-false
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in parsing [vox.turnittech.com->redial] continue=true
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (FAIL) [redial] destination_number(12073131085) =~ /^(redial|\*870)$/ break=on-true
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (PASS) [redial] () =~ // break=never
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in parsing [vox.turnittech.com->speed_dial] continue=false
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (FAIL) [speed_dial] destination_number(12073131085) =~ /^\*0(.*)$/ break=on-false
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in parsing [vox.turnittech.com->default_caller_id] continue=true
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (PASS) [default_caller_id] ${emergency_caller_id_number}() =~ /^$/ break=never
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Action set(emergency_caller_id_name=${default_emergency_caller_id_name}) INLINE
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in set(emergency_caller_id_name=)
2019-02-04 22:09:56.578391 [DEBUG] mod_dptools.c:1548 SET loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in [emergency_caller_id_name]=[UNDEF]
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Action set(emergency_caller_id_number=${default_emergency_caller_id_number}) INLINE
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in set(emergency_caller_id_number=)
2019-02-04 22:09:56.578391 [DEBUG] mod_dptools.c:1548 SET loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in [emergency_caller_id_number]=[UNDEF]
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (PASS) [default_caller_id] ${outbound_caller_id_number}() =~ /^$/ break=never
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Action set(outbound_caller_id_name=${default_outbound_caller_id_name}) INLINE
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in set(outbound_caller_id_name=)
2019-02-04 22:09:56.578391 [DEBUG] mod_dptools.c:1548 SET loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in [outbound_caller_id_name]=[UNDEF]
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Action set(outbound_caller_id_number=${default_outbound_caller_id_number}) INLINE
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in set(outbound_caller_id_number=)
2019-02-04 22:09:56.578391 [DEBUG] mod_dptools.c:1548 SET loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in [outbound_caller_id_number]=[UNDEF]
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in parsing [vox.turnittech.com->1.11d] continue=false
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (PASS) [1.11d] ${user_exists}(false) =~ /false/ break=on-false
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Regex (PASS) [1.11d] destination_number(12073131085) =~ /^\+?(\d{11})$/ break=on-false
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Action set(sip_h_X-accountcode=${accountcode})
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Action export(call_direction=outbound)
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Action unset(call_timeout)
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Action set(hangup_after_bridge=true)
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Action set(effective_caller_id_name=${outbound_caller_id_name})
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Action set(effective_caller_id_number=${outbound_caller_id_number})
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Action set(inherit_codec=true)
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Action set(ignore_display_updates=true)
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Action set(callee_id_number=12073131085)
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Action set(continue_on_fail=true)
Dialplan: loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Action bridge(sofia/gateway/95b1c255-4646-4357-9b8a-2af0259a2780/12073131085)
2019-02-04 22:09:56.578391 [DEBUG] switch_core_state_machine.c:286 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State Change CS_ROUTING -> CS_EXECUTE
2019-02-04 22:09:56.578391 [DEBUG] mod_loopback.c:601 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in CHANNEL KILL
2019-02-04 22:09:56.578391 [DEBUG] switch_core_state_machine.c:643 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State ROUTING going to sleep
2019-02-04 22:09:56.578391 [DEBUG] switch_core_state_machine.c:584 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) Running State Change CS_EXECUTE (Cur 4 Tot 25)
2019-02-04 22:09:56.578391 [DEBUG] switch_core_state_machine.c:650 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State EXECUTE
2019-02-04 22:09:56.578391 [DEBUG] mod_loopback.c:436 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in CHANNEL EXECUTE
2019-02-04 22:09:56.578391 [DEBUG] switch_core_state_machine.c:328 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Standard EXECUTE
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in export(origination_callee_id_name=12073131085)
2019-02-04 22:09:56.578391 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [origination_callee_id_name]=[12073131085]
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in set(RFC2822_DATE=Mon, 04 Feb 2019 22:09:56 +0000)
2019-02-04 22:09:56.578391 [DEBUG] mod_dptools.c:1548 SET loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in [RFC2822_DATE]=[Mon, 04 Feb 2019 22:09:56 +0000]
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in hash(insert/vox.turnittech.com-last_dial/2075091121/12073131085)
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in set(sip_h_X-accountcode=)
2019-02-04 22:09:56.578391 [DEBUG] mod_dptools.c:1548 SET loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in [sip_h_X-accountcode]=[UNDEF]
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in export(call_direction=outbound)
2019-02-04 22:09:56.578391 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [call_direction]=[outbound]
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in unset(call_timeout)
2019-02-04 22:09:56.578391 [DEBUG] mod_dptools.c:1693 UNSET [call_timeout]
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in set(hangup_after_bridge=true)
send 1466 bytes to tcp/[74.75.72.211]:59708 at 22:09:56.581818:
------------------------------------------------------------------------
NOTIFY sip:206@10.0.10.219:5060;transport=TCP SIP/2.0
2019-02-04 22:09:56.578391 [DEBUG] mod_dptools.c:1548 SET loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in [hangup_after_bridge]=[true]
Via: SIP/2.0/TCP 163.182.172.148;rport;branch=z9hG4bKDrQU9H4e6H59S
Route: <sip:74.75.72.211:59708>;transport=TCP
Max-Forwards: 70
From: <sip:204@vox.turnittech.com:5060>;tag=wJLtUybjalf5
To: "Richard - 206" <sip:206@vox.turnittech.com:5060>;tag=808029337
Call-ID: 0_1097518684@10.0.10.219
CSeq: 150869802 NOTIFY
Contact: <sip:204@163.182.172.148:5060;transport=tcp>
User-Agent: FreeSWITCH
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Event: dialog
Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Subscription-State: active;expires=968
Content-Type: application/dialog-info+xml
Content-Length: 577

<?xml version="1.0"?>
<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="9" state="full" entity="sip:204@vox.turnittech.com">
<dialog id="80cc4eb1-a780-4449-a16a-afc9902737f9" direction="recipient">
<state>early</state>
<local>
<identity display="204">sip:204@vox.turnittech.com</identity>
<target uri="sip:204@vox.turnittech.com">
<param pname="+sip.rendering" pvalue="yes"/>
</target>
</local>
<remote>
<identity display="12073131085">sip:12073131085@vox.turnittech.com</identity>
<target uri="sip:**204@vox.turnittech.com"/>
</remote>
</dialog>
</dialog-info>
------------------------------------------------------------------------
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in set(effective_caller_id_name=)
2019-02-04 22:09:56.578391 [DEBUG] mod_dptools.c:1548 SET loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in [effective_caller_id_name]=[UNDEF]
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in set(effective_caller_id_number=)
2019-02-04 22:09:56.578391 [DEBUG] mod_dptools.c:1548 SET loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in [effective_caller_id_number]=[UNDEF]
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in set(inherit_codec=true)
2019-02-04 22:09:56.578391 [DEBUG] mod_dptools.c:1548 SET loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in [inherit_codec]=[true]
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in set(ignore_display_updates=true)
2019-02-04 22:09:56.578391 [DEBUG] mod_dptools.c:1548 SET loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in [ignore_display_updates]=[true]
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in set(callee_id_number=12073131085)
2019-02-04 22:09:56.578391 [DEBUG] mod_dptools.c:1548 SET loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in [callee_id_number]=[12073131085]
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in set(continue_on_fail=true)
2019-02-04 22:09:56.578391 [DEBUG] mod_dptools.c:1548 SET loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in [continue_on_fail]=[true]
EXECUTE loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in bridge(sofia/gateway/95b1c255-4646-4357-9b8a-2af0259a2780/12073131085)
2019-02-04 22:09:56.578391 [DEBUG] switch_channel.c:1250 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in EXPORTING[export_vars] [call_direction]=[outbound] to event
2019-02-04 22:09:56.578391 [DEBUG] switch_channel.c:1250 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in EXPORTING[export_vars] [call_direction]=[outbound] to event
2019-02-04 22:09:56.578391 [DEBUG] switch_channel.c:1250 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in EXPORTING[export_vars] [origination_callee_id_name]=[12073131085] to event
2019-02-04 22:09:56.578391 [DEBUG] switch_channel.c:1250 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in EXPORTING[export_vars] [origination_callee_id_name]=[12073131085] to event
2019-02-04 22:09:56.578391 [DEBUG] switch_channel.c:1250 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in EXPORTING[export_vars] [presence_id]=[204@vox.turnittech.com] to event
2019-02-04 22:09:56.578391 [DEBUG] switch_channel.c:1250 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in EXPORTING[export_vars] [fail_on_single_reject]=[USER_BUSY] to event
2019-02-04 22:09:56.578391 [DEBUG] switch_channel.c:1250 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in EXPORTING[export_vars] [instant_ringback]=[true] to event
2019-02-04 22:09:56.578391 [DEBUG] switch_channel.c:1250 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in EXPORTING[export_vars] [ignore_early_media]=[true] to event
2019-02-04 22:09:56.578391 [DEBUG] switch_channel.c:1250 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in EXPORTING[export_vars] [domain_uuid]=[13dbe4b6-fe12-494e-912f-dfa95174234d] to event
2019-02-04 22:09:56.578391 [DEBUG] switch_channel.c:1250 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in EXPORTING[export_vars] [sip_invite_domain]=[vox.turnittech.com] to event
2019-02-04 22:09:56.578391 [DEBUG] switch_channel.c:1250 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in EXPORTING[export_vars] [domain_name]=[vox.turnittech.com] to event
2019-02-04 22:09:56.578391 [DEBUG] switch_channel.c:1250 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in EXPORTING[export_vars] [domain]=[vox.turnittech.com] to event
2019-02-04 22:09:56.578391 [DEBUG] switch_channel.c:1250 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in EXPORTING[export_vars] [extension_uuid]=[b1ac4c0a-8b47-44a6-aac0-879312f0f36b] to event
2019-02-04 22:09:56.578391 [DEBUG] switch_channel.c:1250 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in EXPORTING[export_vars] [leg_delay_start]=[0] to event
2019-02-04 22:09:56.578391 [DEBUG] switch_channel.c:1250 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in EXPORTING[export_vars] [originate_delay_start]=[0] to event
2019-02-04 22:09:56.578391 [DEBUG] switch_channel.c:1250 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in EXPORTING[export_vars] [sleep]=[0] to event
2019-02-04 22:09:56.578391 [DEBUG] switch_channel.c:1250 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in EXPORTING[export_vars] [leg_timeout]=[30] to event
2019-02-04 22:09:56.578391 [DEBUG] switch_channel.c:1250 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in EXPORTING[export_vars] [origination_callee_id_name]=[12073131085] to event
2019-02-04 22:09:56.578391 [DEBUG] switch_channel.c:1250 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in EXPORTING[export_vars] [call_direction]=[outbound] to event
2019-02-04 22:09:56.578391 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
2019-02-04 22:09:56.578391 [NOTICE] switch_channel.c:1104 New Channel sofia/external/12073131085 [9357073f-a70d-4bc6-9f80-717758abaa1b]
2019-02-04 22:09:56.578391 [DEBUG] mod_sofia.c:4819 (sofia/external/12073131085) State Change CS_NEW -> CS_INIT
2019-02-04 22:09:56.578391 [DEBUG] switch_ivr_originate.c:2963 sofia/external/12073131085 Setting leg timeout to 30
2019-02-04 22:09:56.578391 [DEBUG] switch_core_state_machine.c:584 (sofia/external/12073131085) Running State Change CS_INIT (Cur 5 Tot 26)
2019-02-04 22:09:56.578391 [DEBUG] switch_core_state_machine.c:627 (sofia/external/12073131085) State INIT
2019-02-04 22:09:56.578391 [DEBUG] mod_sofia.c:90 sofia/external/12073131085 SOFIA INIT
2019-02-04 22:09:56.578391 [DEBUG] sofia_glue.c:1295 sofia/external/12073131085 sending invite version: 1.6.20 -37-987c9b9 64bit
Local SDP:
v=0
o=FreeSWITCH 1549301678 1549301679 IN IP4 163.182.172.148
s=FreeSWITCH
c=IN IP4 163.182.172.148
t=0 0
m=audio 16518 RTP/AVP 102 0 8 101 13
a=rtpmap:102 L16/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=rtpmap:13 CN/8000
a=ptime:20
a=sendrecv

2019-02-04 22:09:56.578391 [DEBUG] switch_core_state_machine.c:40 sofia/external/12073131085 Standard INIT
2019-02-04 22:09:56.578391 [DEBUG] switch_core_state_machine.c:48 (sofia/external/12073131085) State Change CS_INIT -> CS_ROUTING
2019-02-04 22:09:56.578391 [DEBUG] switch_core_state_machine.c:627 (sofia/external/12073131085) State INIT going to sleep
2019-02-04 22:09:56.578391 [DEBUG] switch_core_state_machine.c:584 (sofia/external/12073131085) Running State Change CS_ROUTING (Cur 5 Tot 26)
2019-02-04 22:09:56.578391 [DEBUG] switch_core_state_machine.c:643 (sofia/external/12073131085) State ROUTING
2019-02-04 22:09:56.578391 [DEBUG] mod_sofia.c:143 sofia/external/12073131085 SOFIA ROUTING
2019-02-04 22:09:56.578391 [DEBUG] switch_ivr_originate.c:67 (sofia/external/12073131085) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2019-02-04 22:09:56.578391 [DEBUG] switch_core_state_machine.c:643 (sofia/external/12073131085) State ROUTING going to sleep
2019-02-04 22:09:56.578391 [DEBUG] switch_core_state_machine.c:584 (sofia/external/12073131085) Running State Change CS_CONSUME_MEDIA (Cur 5 Tot 26)
2019-02-04 22:09:56.578391 [DEBUG] sofia.c:7084 Channel sofia/external/12073131085 entering state [calling][0]
2019-02-04 22:09:56.578391 [DEBUG] switch_core_state_machine.c:662 (sofia/external/12073131085) State CONSUME_MEDIA
2019-02-04 22:09:56.578391 [DEBUG] switch_core_state_machine.c:662 (sofia/external/12073131085) State CONSUME_MEDIA going to sleep
2019-02-04 22:09:56.578391 [NOTICE] mod_loopback.c:961 Pre-Answer loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in!
2019-02-04 22:09:56.578391 [DEBUG] switch_channel.c:3474 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) Callstate Change DOWN -> EARLY
2019-02-04 22:09:56.578391 [DEBUG] mod_loopback.c:601 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in CHANNEL KILL
2019-02-04 22:09:56.578391 [NOTICE] switch_ivr_originate.c:1215 Pre-Answer loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in!
2019-02-04 22:09:56.578391 [DEBUG] switch_channel.c:3474 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) Callstate Change RINGING -> EARLY
2019-02-04 22:09:56.578391 [DEBUG] mod_loopback.c:601 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in CHANNEL KILL
2019-02-04 22:09:56.578391 [DEBUG] switch_ivr_originate.c:1273 Raw Codec Activation Success L16@8000hz 1 channel 20ms
2019-02-04 22:09:56.578391 [DEBUG] switch_core_codec.c:223 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Push codec L16:100
2019-02-04 22:09:56.578391 [DEBUG] switch_ivr_originate.c:1342 Play Ringback Tone [%(2000,4000,440,480)]
send 1471 bytes to tcp/[74.75.72.211]:59708 at 22:09:56.586635:
------------------------------------------------------------------------
NOTIFY sip:206@10.0.10.219:5060;transport=TCP SIP/2.0
Via: SIP/2.0/TCP 163.182.172.148;rport;branch=z9hG4bKe1gmBDNj3tUvN
Route: <sip:74.75.72.211:59708>;transport=TCP
Max-Forwards: 70
From: <sip:204@vox.turnittech.com:5060>;tag=wJLtUybjalf5
To: "Richard - 206" <sip:206@vox.turnittech.com:5060>;tag=808029337
Call-ID: 0_1097518684@10.0.10.219
CSeq: 150869803 NOTIFY
Contact: <sip:204@163.182.172.148:5060;transport=tcp>
User-Agent: FreeSWITCH
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Event: dialog
Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Subscription-State: active;expires=968
Content-Type: application/dialog-info+xml
Content-Length: 582

<?xml version="1.0"?>
<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="10" state="full" entity="sip:204@vox.turnittech.com">
<dialog id="9357073f-a70d-4bc6-9f80-717758abaa1b" direction="recipient">
<state>early</state>
<local>
<identity display="204">sip:204@vox.turnittech.com</identity>
<target uri="sip:204@vox.turnittech.com">
<param pname="+sip.rendering" pvalue="yes"/>
</target>
</local>
<remote>
<identity display="WIRELESS CALLER ">sip:2075091121@vox.turnittech.com</identity>
<target uri="sip:**204@vox.turnittech.com"/>
</remote>
</dialog>
</dialog-info>
------------------------------------------------------------------------
recv 350 bytes from tcp/[74.75.72.211]:30625 at 22:09:56.606502:
------------------------------------------------------------------------
SIP/2.0 100 Trying
Via: SIP/2.0/TCP 163.182.172.148;rport=5060;branch=z9hG4bKB6495U27B0r4j
From: "WIRELESS CALLER " <sip:2075091121@vox.turnittech.com>;tag=vNvrKKX7F5trS
To: <sip:204@10.0.10.218:12569;transport=TCP>
Call-ID: 725e4748-a36c-1237-2e8f-00163c78a6b5
CSeq: 105306 INVITE
User-Agent: Yealink SIP-T46S 66.83.0.55
Content-Length: 0

------------------------------------------------------------------------
recv 388 bytes from tcp/[74.75.72.211]:59708 at 22:09:56.606618:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/TCP 163.182.172.148;rport=5060;branch=z9hG4bKcFy27pKB98eQe
From: <sip:204@vox.turnittech.com:5060>;tag=wJLtUybjalf5
To: "Richard - 206" <sip:206@vox.turnittech.com:5060>;tag=808029337
Call-ID: 0_1097518684@10.0.10.219
CSeq: 150869801 NOTIFY
Contact: <sip:206@10.0.10.219:5060;transport=TCP>
User-Agent: Yealink SIP-T52S 70.82.0.30
Content-Length: 0

------------------------------------------------------------------------
recv 588 bytes from tcp/[74.75.72.211]:30625 at 22:09:56.626559:
------------------------------------------------------------------------
SIP/2.0 180 Ringing
Via: SIP/2.0/TCP 163.182.172.148;rport=5060;branch=z9hG4bKB6495U27B0r4j
From: "WIRELESS CALLER " <sip:2075091121@vox.turnittech.com>;tag=vNvrKKX7F5trS
To: <sip:204@10.0.10.218:12569;transport=TCP>;tag=2133289916
Call-ID: 725e4748-a36c-1237-2e8f-00163c78a6b5
CSeq: 105306 INVITE
Contact: <sip:204@10.0.10.218:12569;transport=TCP>
Allow: INVITE, INFO, PRACK, ACK, BYE, CANCEL, OPTIONS, NOTIFY, REGISTER, SUBSCRIBE, REFER, PUBLISH, UPDATE, MESSAGE
User-Agent: Yealink SIP-T46S 66.83.0.55
Allow-Events: talk,hold,conference,refer,check-sync
Content-Length: 0

------------------------------------------------------------------------
2019-02-04 22:09:56.618375 [DEBUG] sofia.c:7084 Channel sofia/internal/204@10.0.10.218:12569 entering state [proceeding][180]
2019-02-04 22:09:56.618375 [NOTICE] sofia.c:7192 Ring-Ready sofia/internal/204@10.0.10.218:12569!
2019-02-04 22:09:56.618375 [DEBUG] switch_channel.c:3346 (sofia/internal/204@10.0.10.218:12569) Callstate Change DOWN -> RINGING
recv 388 bytes from tcp/[74.75.72.211]:59708 at 22:09:56.636531:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/TCP 163.182.172.148;rport=5060;branch=z9hG4bKDrQU9H4e6H59S
From: <sip:204@vox.turnittech.com:5060>;tag=wJLtUybjalf5
To: "Richard - 206" <sip:206@vox.turnittech.com:5060>;tag=808029337
Call-ID: 0_1097518684@10.0.10.219
CSeq: 150869802 NOTIFY
Contact: <sip:206@10.0.10.219:5060;transport=TCP>
User-Agent: Yealink SIP-T52S 70.82.0.30
Content-Length: 0

------------------------------------------------------------------------
recv 388 bytes from tcp/[74.75.72.211]:59708 at 22:09:56.642392:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/TCP 163.182.172.148;rport=5060;branch=z9hG4bKe1gmBDNj3tUvN
From: <sip:204@vox.turnittech.com:5060>;tag=wJLtUybjalf5
To: "Richard - 206" <sip:206@vox.turnittech.com:5060>;tag=808029337
Call-ID: 0_1097518684@10.0.10.219
CSeq: 150869803 NOTIFY
Contact: <sip:206@10.0.10.219:5060;transport=TCP>
User-Agent: Yealink SIP-T52S 70.82.0.30
Content-Length: 0

------------------------------------------------------------------------
send 1180 bytes to udp/[63.247.69.226]:5060 at 22:09:56.673147:
------------------------------------------------------------------------
INVITE sip:12073131085@gw.siptrunk.com SIP/2.0
Via: SIP/2.0/UDP 163.182.172.148:5080;rport;branch=z9hG4bK108B4v1v8e5UQ
Max-Forwards: 69
From: "WIRELESS CALLER " <sip:42376443@gw.siptrunk.com>;tag=Smm2pc4FQQHUc
To: <sip:12073131085@gw.siptrunk.com>
Call-ID: 72635a62-a36c-1237-2e8f-00163c78a6b5
CSeq: 105306 INVITE
Contact: <sip:gw+95b1c255-4646-4357-9b8a-2af0259a2780@163.182.172.148:5080;transport=udp;gw=95b1c255-4646-4357-9b8a-2af0259a2780>
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
X-FS-Support: update_display,send_info
Remote-Party-ID: "WIRELESS CALLER " <sip:2075091121@vox.turnittech.com>;party=calling;screen=yes;privacy=off

v=0
o=FreeSWITCH 1549301678 1549301679 IN IP4 163.182.172.148
s=FreeSWITCH
c=IN IP4 163.182.172.148
t=0 0
m=audio 16518 RTP/AVP 102 0 8 101 13
a=rtpmap:102 L16/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=rtpmap:13 CN/8000
a=ptime:20
------------------------------------------------------------------------
recv 326 bytes from udp/[63.247.69.226]:5060 at 22:09:56.695464:
------------------------------------------------------------------------
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 163.182.172.148:5080;rport=5080;branch=z9hG4bK108B4v1v8e5UQ;received=163.182.172.148
From: "WIRELESS CALLER " <sip:42376443@gw.siptrunk.com>;tag=Smm2pc4FQQHUc
To: <sip:12073131085@gw.siptrunk.com>
Call-ID: 72635a62-a36c-1237-2e8f-00163c78a6b5
CSeq: 105306 INVITE
Content-Length: 0

------------------------------------------------------------------------
recv 525 bytes from udp/[63.247.69.226]:5060 at 22:09:56.696279:
------------------------------------------------------------------------
SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.0/UDP 163.182.172.148:5080;rport=5080;branch=z9hG4bK108B4v1v8e5UQ;received=163.182.172.148
From: "WIRELESS CALLER " <sip:42376443@gw.siptrunk.com>;tag=Smm2pc4FQQHUc
To: <sip:12073131085@gw.siptrunk.com>;tag=14575c43173f48ab35024af4364ef5fa.2f11
Call-ID: 72635a62-a36c-1237-2e8f-00163c78a6b5
CSeq: 105306 INVITE
Proxy-Authenticate: Digest realm="gw.siptrunk.com", nonce="XFi6jFxYuDSOz0OaeOAhT5i93qqz2DJrX56arsP17wUsu628dcPX/xmL9q7B", qop="auth"
Content-Length: 0

------------------------------------------------------------------------
send 378 bytes to udp/[63.247.69.226]:5060 at 22:09:56.696431:
------------------------------------------------------------------------
ACK sip:12073131085@gw.siptrunk.com SIP/2.0
Via: SIP/2.0/UDP 163.182.172.148:5080;rport;branch=z9hG4bK108B4v1v8e5UQ
Max-Forwards: 69
From: "WIRELESS CALLER " <sip:42376443@gw.siptrunk.com>;tag=Smm2pc4FQQHUc
To: <sip:12073131085@gw.siptrunk.com>;tag=14575c43173f48ab35024af4364ef5fa.2f11
Call-ID: 72635a62-a36c-1237-2e8f-00163c78a6b5
CSeq: 105306 ACK
Content-Length: 0

------------------------------------------------------------------------
send 1479 bytes to udp/[63.247.69.226]:5060 at 22:09:56.696991:
------------------------------------------------------------------------
INVITE sip:12073131085@gw.siptrunk.com SIP/2.0
Via: SIP/2.0/UDP 163.182.172.148:5080;rport;branch=z9hG4bK29145Qj05QUeK
Max-Forwards: 69
From: "WIRELESS CALLER " <sip:42376443@gw.siptrunk.com>;tag=Smm2pc4FQQHUc
To: <sip:12073131085@gw.siptrunk.com>
Call-ID: 72635a62-a36c-1237-2e8f-00163c78a6b5
CSeq: 105307 INVITE
Contact: <sip:gw+95b1c255-4646-4357-9b8a-2af0259a2780@163.182.172.148:5080;transport=udp;gw=95b1c255-4646-4357-9b8a-2af0259a2780>
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="42376443", realm="gw.siptrunk.com", nonce="XFi6jFxYuDSOz0OaeOAhT5i93qqz2DJrX56arsP17wUsu628dcPX/xmL9q7B", cnonce="cnRdgqNsEjePLgAWPHimtQ", algorithm=MD5, uri="sip:12073131085@gw.siptrunk.com", response="d3423e8eea0037c69e36bb0c2875972a", qop=auth, nc=00000001
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 301
X-FS-Support: update_display,send_info
Remote-Party-ID: "WIRELESS CALLER " <sip:2075091121@vox.turnittech.com>;party=calling;screen=yes;privacy=off

v=0
o=FreeSWITCH 1549301678 1549301679 IN IP4 163.182.172.148
s=FreeSWITCH
c=IN IP4 163.182.172.148
t=0 0
m=audio 16518 RTP/AVP 102 0 8 101 13
a=rtpmap:102 L16/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=rtpmap:13 CN/8000
a=ptime:20
------------------------------------------------------------------------
2019-02-04 22:09:56.678371 [DEBUG] sofia.c:7084 Channel sofia/external/12073131085 entering state [calling][0]
send 1479 bytes to udp/[63.247.69.226]:5060 at 22:09:57.697578:
------------------------------------------------------------------------
INVITE sip:12073131085@gw.siptrunk.com SIP/2.0
Via: SIP/2.0/UDP 163.182.172.148:5080;rport;branch=z9hG4bK29145Qj05QUeK
Max-Forwards: 69
From: "WIRELESS CALLER " <sip:42376443@gw.siptrunk.com>;tag=Smm2pc4FQQHUc
To: <sip:12073131085@gw.siptrunk.com>
Call-ID: 72635a62-a36c-1237-2e8f-00163c78a6b5
CSeq: 105307 INVITE
Contact: <sip:gw+95b1c255-4646-4357-9b8a-2af0259a2780@163.182.172.148:5080;transport=udp;gw=95b1c255-4646-4357-9b8a-2af0259a2780>
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="42376443", realm="gw.siptrunk.com", nonce="XFi6jFxYuDSOz0OaeOAhT5i93qqz2DJrX56arsP17wUsu628dcPX/xmL9q7B", cnonce="cnRdgqNsEjePLgAWPHimtQ", algorithm=MD5, uri="sip:12073131085@gw.siptrunk.com", response="d3423e8eea0037c69e36bb0c2875972a", qop=auth, nc=00000001
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 301
X-FS-Support: update_display,send_info
Remote-Party-ID: "WIRELESS CALLER " <sip:2075091121@vox.turnittech.com>;party=calling;screen=yes;privacy=off

v=0
o=FreeSWITCH 1549301678 1549301679 IN IP4 163.182.172.148
s=FreeSWITCH
c=IN IP4 163.182.172.148
t=0 0
m=audio 16518 RTP/AVP 102 0 8 101 13
a=rtpmap:102 L16/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=rtpmap:13 CN/8000
a=ptime:20
------------------------------------------------------------------------
send 1479 bytes to udp/[63.247.69.226]:5060 at 22:09:59.697566:
------------------------------------------------------------------------
INVITE sip:12073131085@gw.siptrunk.com SIP/2.0
Via: SIP/2.0/UDP 163.182.172.148:5080;rport;branch=z9hG4bK29145Qj05QUeK
Max-Forwards: 69
From: "WIRELESS CALLER " <sip:42376443@gw.siptrunk.com>;tag=Smm2pc4FQQHUc
To: <sip:12073131085@gw.siptrunk.com>
Call-ID: 72635a62-a36c-1237-2e8f-00163c78a6b5
CSeq: 105307 INVITE
Contact: <sip:gw+95b1c255-4646-4357-9b8a-2af0259a2780@163.182.172.148:5080;transport=udp;gw=95b1c255-4646-4357-9b8a-2af0259a2780>
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="42376443", realm="gw.siptrunk.com", nonce="XFi6jFxYuDSOz0OaeOAhT5i93qqz2DJrX56arsP17wUsu628dcPX/xmL9q7B", cnonce="cnRdgqNsEjePLgAWPHimtQ", algorithm=MD5, uri="sip:12073131085@gw.siptrunk.com", response="d3423e8eea0037c69e36bb0c2875972a", qop=auth, nc=00000001
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 301
X-FS-Support: update_display,send_info
Remote-Party-ID: "WIRELESS CALLER " <sip:2075091121@vox.turnittech.com>;party=calling;screen=yes;privacy=off

v=0
o=FreeSWITCH 1549301678 1549301679 IN IP4 163.182.172.148
s=FreeSWITCH
c=IN IP4 163.182.172.148
t=0 0
m=audio 16518 RTP/AVP 102 0 8 101 13
a=rtpmap:102 L16/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=rtpmap:13 CN/8000
a=ptime:20
------------------------------------------------------------------------
send 1479 bytes to udp/[63.247.69.226]:5060 at 22:10:03.697619:
------------------------------------------------------------------------
INVITE sip:12073131085@gw.siptrunk.com SIP/2.0
Via: SIP/2.0/UDP 163.182.172.148:5080;rport;branch=z9hG4bK29145Qj05QUeK
Max-Forwards: 69
From: "WIRELESS CALLER " <sip:42376443@gw.siptrunk.com>;tag=Smm2pc4FQQHUc
To: <sip:12073131085@gw.siptrunk.com>
Call-ID: 72635a62-a36c-1237-2e8f-00163c78a6b5
CSeq: 105307 INVITE
Contact: <sip:gw+95b1c255-4646-4357-9b8a-2af0259a2780@163.182.172.148:5080;transport=udp;gw=95b1c255-4646-4357-9b8a-2af0259a2780>
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="42376443", realm="gw.siptrunk.com", nonce="XFi6jFxYuDSOz0OaeOAhT5i93qqz2DJrX56arsP17wUsu628dcPX/xmL9q7B", cnonce="cnRdgqNsEjePLgAWPHimtQ", algorithm=MD5, uri="sip:12073131085@gw.siptrunk.com", response="d3423e8eea0037c69e36bb0c2875972a", qop=auth, nc=00000001
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 301
X-FS-Support: update_display,send_info
Remote-Party-ID: "WIRELESS CALLER " <sip:2075091121@vox.turnittech.com>;party=calling;screen=yes;privacy=off

v=0
o=FreeSWITCH 1549301678 1549301679 IN IP4 163.182.172.148
s=FreeSWITCH
c=IN IP4 163.182.172.148
t=0 0
m=audio 16518 RTP/AVP 102 0 8 101 13
a=rtpmap:102 L16/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=rtpmap:13 CN/8000
a=ptime:20
------------------------------------------------------------------------
recv 488 bytes from tcp/[74.75.72.211]:59708 at 22:10:05.733466:
------------------------------------------------------------------------
NOTIFY sip:206@163.182.172.148:5060 SIP/2.0
Via: SIP/2.0/TCP 10.0.10.219:5060;branch=z9hG4bK844585120;rport
From: "Richard - 206" <sip:206@vox.turnittech.com:5060>;tag=3791625624
To: <sip:206@vox.turnittech.com:5060>
Call-ID: 0_3189260158@10.0.10.219
CSeq: 1 NOTIFY
Allow: INVITE, INFO, PRACK, ACK, BYE, CANCEL, OPTIONS, NOTIFY, REGISTER, SUBSCRIBE, REFER, PUBLISH, UPDATE, MESSAGE
Max-Forwards: 70
User-Agent: Yealink SIP-T52S 70.82.0.30
Event: keep-alive
Content-Length: 0

------------------------------------------------------------------------
send 681 bytes to tcp/[74.75.72.211]:59708 at 22:10:05.734154:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/TCP 10.0.10.219:5060;branch=z9hG4bK844585120;rport=59708;received=74.75.72.211
From: "Richard - 206" <sip:206@vox.turnittech.com:5060>;tag=3791625624
To: <sip:206@vox.turnittech.com:5060>;tag=XyNHNeeBDeHBN
Call-ID: 0_3189260158@10.0.10.219
CSeq: 1 NOTIFY
Contact: <sip:163.182.172.148>
User-Agent: FreeSWITCH
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Content-Length: 0

------------------------------------------------------------------------
recv 857 bytes from tcp/[74.75.72.211]:59708 at 22:10:08.240900:
------------------------------------------------------------------------
REGISTER sip:vox.turnittech.com:5060 SIP/2.0
Via: SIP/2.0/TCP 10.0.10.219:5060;branch=z9hG4bK4045799704;rport
From: "Richard - 206" <sip:206@vox.turnittech.com:5060>;tag=3328516356
To: "Richard - 206" <sip:206@vox.turnittech.com:5060>
Call-ID: 0_3406089158@10.0.10.219
CSeq: 36 REGISTER
Contact: <sip:206@10.0.10.219:5060;transport=TCP>
Authorization: Digest username="206", realm="vox.turnittech.com", nonce="41d3cac4-1c61-41e5-8be9-aecf95f89924", uri="sip:vox.turnittech.com:5060", response="7bcdc88753d6af2e96e9ee5b80f572f2", algorithm=MD5, cnonce="0a4f113b", qop=auth, nc=00000035
Allow: INVITE, INFO, PRACK, ACK, BYE, CANCEL, OPTIONS, NOTIFY, REGISTER, SUBSCRIBE, REFER, PUBLISH, UPDATE, MESSAGE
Max-Forwards: 70
User-Agent: Yealink SIP-T52S 70.82.0.30
Expires: 120
Allow-Events: talk,hold,conference,refer,check-sync
Content-Length: 0

------------------------------------------------------------------------
send 598 bytes to tcp/[74.75.72.211]:59708 at 22:10:08.268200:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/TCP 10.0.10.219:5060;branch=z9hG4bK4045799704;rport=59708;received=74.75.72.211
From: "Richard - 206" <sip:206@vox.turnittech.com:5060>;tag=3328516356
To: "Richard - 206" <sip:206@vox.turnittech.com:5060>;tag=y7eaQ9yeaQ7Xg
Call-ID: 0_3406089158@10.0.10.219
CSeq: 36 REGISTER
Contact: <sip:206@10.0.10.219:5060;transport=TCP>;expires=120
Date: Mon, 04 Feb 2019 22:10:08 GMT
User-Agent: FreeSWITCH
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Content-Length: 0

------------------------------------------------------------------------
send 1479 bytes to udp/[63.247.69.226]:5060 at 22:10:11.699605:
------------------------------------------------------------------------
INVITE sip:12073131085@gw.siptrunk.com SIP/2.0
Via: SIP/2.0/UDP 163.182.172.148:5080;rport;branch=z9hG4bK29145Qj05QUeK
Max-Forwards: 69
From: "WIRELESS CALLER " <sip:42376443@gw.siptrunk.com>;tag=Smm2pc4FQQHUc
To: <sip:12073131085@gw.siptrunk.com>
Call-ID: 72635a62-a36c-1237-2e8f-00163c78a6b5
CSeq: 105307 INVITE
Contact: <sip:gw+95b1c255-4646-4357-9b8a-2af0259a2780@163.182.172.148:5080;transport=udp;gw=95b1c255-4646-4357-9b8a-2af0259a2780>
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="42376443", realm="gw.siptrunk.com", nonce="XFi6jFxYuDSOz0OaeOAhT5i93qqz2DJrX56arsP17wUsu628dcPX/xmL9q7B", cnonce="cnRdgqNsEjePLgAWPHimtQ", algorithm=MD5, uri="sip:12073131085@gw.siptrunk.com", response="d3423e8eea0037c69e36bb0c2875972a", qop=auth, nc=00000001
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 301
X-FS-Support: update_display,send_info
Remote-Party-ID: "WIRELESS CALLER " <sip:2075091121@vox.turnittech.com>;party=calling;screen=yes;privacy=off

v=0
o=FreeSWITCH 1549301678 1549301679 IN IP4 163.182.172.148
s=FreeSWITCH
c=IN IP4 163.182.172.148
t=0 0
m=audio 16518 RTP/AVP 102 0 8 101 13
a=rtpmap:102 L16/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=rtpmap:13 CN/8000
a=ptime:20
------------------------------------------------------------------------
recv 492 bytes from tcp/[74.75.72.211]:30625 at 22:10:19.333072:
------------------------------------------------------------------------
NOTIFY sip:204@vox.turnittech.com:5060 SIP/2.0
Via: SIP/2.0/TCP 10.0.10.218:12569;branch=z9hG4bK1092189312;rport
From: "Jeremy - 204" <sip:204@vox.turnittech.com:5060>;tag=1757005599
To: <sip:204@vox.turnittech.com:5060>
Call-ID: 0_3400983066@10.0.10.218
CSeq: 1 NOTIFY
Allow: INVITE, INFO, PRACK, ACK, BYE, CANCEL, OPTIONS, NOTIFY, REGISTER, SUBSCRIBE, REFER, PUBLISH, UPDATE, MESSAGE
Max-Forwards: 70
User-Agent: Yealink SIP-T46S 66.83.0.55
Event: keep-alive
Content-Length: 0

------------------------------------------------------------------------
send 682 bytes to tcp/[74.75.72.211]:30625 at 22:10:19.333588:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/TCP 10.0.10.218:12569;branch=z9hG4bK1092189312;rport=30625;received=74.75.72.211
From: "Jeremy - 204" <sip:204@vox.turnittech.com:5060>;tag=1757005599
To: <sip:204@vox.turnittech.com:5060>;tag=Zg82r4Fj7ZXgc
Call-ID: 0_3400983066@10.0.10.218
CSeq: 1 NOTIFY
Contact: <sip:163.182.172.148>
User-Agent: FreeSWITCH
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Content-Length: 0

------------------------------------------------------------------------
recv 430 bytes from udp/[63.247.69.226]:5060 at 22:10:23.850455:
------------------------------------------------------------------------
BYE sip:+12078771600@163.182.172.148:5080;transport=udp SIP/2.0
Via: SIP/2.0/UDP 63.247.69.226;branch=z9hG4bKf55e.783e850cd4d3a016da26c0da2d4e2928.0
Via: SIP/2.0/UDP 67.231.1.110:5060;branch=z9hG4bK0cBa5e2b142b3eeddf5
From: <sip:2075091121@67.231.1.110>;tag=gK0c1014c9
To: <sip:+12078771600@63.247.69.226>;tag=rBU9mHKcteU8g
Call-ID: 1110183220_117387605@67.231.1.110
CSeq: 808222 BYE
Max-Forwards: 32
Content-Length: 0

------------------------------------------------------------------------
2019-02-04 22:10:23.838399 [NOTICE] sofia.c:1012 Hangup sofia/external/2075091121@67.231.1.110 [CS_EXECUTE] [NORMAL_CLEARING]
send 511 bytes to udp/[63.247.69.226]:5060 at 22:10:23.852383:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/UDP 63.247.69.226;branch=z9hG4bKf55e.783e850cd4d3a016da26c0da2d4e2928.0
Via: SIP/2.0/UDP 67.231.1.110:5060;branch=z9hG4bK0cBa5e2b142b3eeddf5
From: <sip:2075091121@67.231.1.110>;tag=gK0c1014c9
To: <sip:+12078771600@63.247.69.226>;tag=rBU9mHKcteU8g
Call-ID: 1110183220_117387605@67.231.1.110
CSeq: 808222 BYE
User-Agent: FreeSWITCH
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
Supported: timer, path, replaces
Content-Length: 0

------------------------------------------------------------------------
2019-02-04 22:10:23.858409 [NOTICE] switch_ivr_originate.c:3612 Hangup sofia/internal/204@10.0.10.218:12569 [CS_CONSUME_MEDIA] [LOSE_RACE]
2019-02-04 22:10:23.858409 [DEBUG] switch_ivr_originate.c:3837 Originate Cancelled by originator termination Cause: 487 [ORIGINATOR_CANCEL]
2019-02-04 22:10:23.858409 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/204@10.0.10.218:12569) Running State Change CS_HANGUP (Cur 5 Tot 26)
2019-02-04 22:10:23.858409 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [user] cause: [LOSE_RACE]
2019-02-04 22:10:23.858409 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 502 [LOSE_RACE]
2019-02-04 22:10:23.858409 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/204@10.0.10.218:12569) Callstate Change RINGING -> HANGUP
2019-02-04 22:10:23.858409 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/204@10.0.10.218:12569) State HANGUP
2019-02-04 22:10:23.858409 [DEBUG] mod_sofia.c:438 Channel sofia/internal/204@10.0.10.218:12569 hanging up, cause: LOSE_RACE
2019-02-04 22:10:23.858409 [DEBUG] mod_sofia.c:502 Sending CANCEL to sofia/internal/204@10.0.10.218:12569
2019-02-04 22:10:23.858409 [DEBUG] switch_core_state_machine.c:60 sofia/internal/204@10.0.10.218:12569 Standard HANGUP, cause: LOSE_RACE
2019-02-04 22:10:23.858409 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/204@10.0.10.218:12569) State HANGUP going to sleep
2019-02-04 22:10:23.858409 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/204@10.0.10.218:12569) State Change CS_HANGUP -> CS_REPORTING
2019-02-04 22:10:23.858409 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/204@10.0.10.218:12569) Running State Change CS_REPORTING (Cur 5 Tot 26)
2019-02-04 22:10:23.858409 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/204@10.0.10.218:12569) State REPORTING
send 464 bytes to tcp/[74.75.72.211]:30625 at 22:10:23.862306:
------------------------------------------------------------------------
CANCEL sip:204@10.0.10.218:12569;transport=TCP SIP/2.0
Via: SIP/2.0/TCP 163.182.172.148;rport;branch=z9hG4bKB6495U27B0r4j
Route: <sip:204@74.75.72.211:30625>;transport=TCP
Max-Forwards: 70
From: "WIRELESS CALLER " <sip:2075091121@vox.turnittech.com>;tag=vNvrKKX7F5trS
To: <sip:204@10.0.10.218:12569;transport=TCP>
Call-ID: 725e4748-a36c-1237-2e8f-00163c78a6b5
CSeq: 105306 CANCEL
Reason: SIP;cause=200;text="Call completed elsewhere"
Content-Length: 0

------------------------------------------------------------------------
send 1154 bytes to tcp/[74.75.72.211]:59708 at 22:10:23.863927:
------------------------------------------------------------------------
NOTIFY sip:206@10.0.10.219:5060;transport=TCP SIP/2.0
Via: SIP/2.0/TCP 163.182.172.148;rport;branch=z9hG4bKFaaDD85N03HFH
Route: <sip:74.75.72.211:59708>;transport=TCP
Max-Forwards: 70
From: <sip:204@vox.turnittech.com:5060>;tag=wJLtUybjalf5
To: "Richard - 206" <sip:206@vox.turnittech.com:5060>;tag=808029337
Call-ID: 0_1097518684@10.0.10.219
CSeq: 150871151 NOTIFY
Contact: <sip:204@163.182.172.148:5060;transport=tcp>
User-Agent: FreeSWITCH
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Event: dialog
Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Subscription-State: active;expires=941
Content-Type: application/dialog-info+xml
Content-Length: 265

<?xml version="1.0"?>
<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="11" state="full" entity="sip:204@vox.turnittech.com">
<dialog id="b5524be4-739f-413e-8c7e-672863fdd587" direction="recipient">
<state>terminated</state>
</dialog>
</dialog-info>
------------------------------------------------------------------------
2019-02-04 22:10:23.858409 [NOTICE] switch_ivr_originate.c:3612 Hangup loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in [CS_CONSUME_MEDIA] [LOSE_RACE]
2019-02-04 22:10:23.858409 [DEBUG] mod_loopback.c:601 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in CHANNEL KILL
2019-02-04 22:10:23.858409 [DEBUG] mod_loopback.c:601 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in CHANNEL KILL
2019-02-04 22:10:23.858409 [DEBUG] switch_ivr_originate.c:3837 Originate Cancelled by originator termination Cause: 487 [ORIGINATOR_CANCEL]
2019-02-04 22:10:23.858409 [DEBUG] switch_core_state_machine.c:584 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) Running State Change CS_HANGUP (Cur 5 Tot 26)
2019-02-04 22:10:23.858409 [INFO] mod_dptools.c:3436 Originate Failed. Cause: NONE
2019-02-04 22:10:23.858409 [DEBUG] switch_core_state_machine.c:850 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) Callstate Change EARLY -> HANGUP
2019-02-04 22:10:23.858409 [DEBUG] switch_core_state_machine.c:852 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State HANGUP
2019-02-04 22:10:23.858409 [DEBUG] mod_loopback.c:548 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in CHANNEL HANGUP
2019-02-04 22:10:23.858409 [NOTICE] mod_loopback.c:564 Hangup loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in [CS_EXECUTE] [LOSE_RACE]
2019-02-04 22:10:23.858409 [DEBUG] switch_core_session.c:2815 sofia/external/2075091121@67.231.1.110 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
2019-02-04 22:10:23.858409 [DEBUG] switch_core_state_machine.c:650 (sofia/external/2075091121@67.231.1.110) State EXECUTE going to sleep
2019-02-04 22:10:23.858409 [DEBUG] switch_core_state_machine.c:584 (sofia/external/2075091121@67.231.1.110) Running State Change CS_HANGUP (Cur 5 Tot 26)
2019-02-04 22:10:23.858409 [DEBUG] mod_loopback.c:601 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in CHANNEL KILL
2019-02-04 22:10:23.858409 [DEBUG] mod_loopback.c:601 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in CHANNEL KILL
2019-02-04 22:10:23.858409 [DEBUG] switch_core_state_machine.c:60 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Standard HANGUP, cause: LOSE_RACE
2019-02-04 22:10:23.858409 [DEBUG] switch_core_state_machine.c:852 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State HANGUP going to sleep
2019-02-04 22:10:23.858409 [DEBUG] switch_core_state_machine.c:619 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State Change CS_HANGUP -> CS_REPORTING
2019-02-04 22:10:23.858409 [DEBUG] mod_loopback.c:601 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in CHANNEL KILL
2019-02-04 22:10:23.858409 [DEBUG] switch_core_state_machine.c:584 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) Running State Change CS_REPORTING (Cur 5 Tot 26)
2019-02-04 22:10:23.858409 [DEBUG] switch_core_state_machine.c:850 (sofia/external/2075091121@67.231.1.110) Callstate Change ACTIVE -> HANGUP
2019-02-04 22:10:23.858409 [DEBUG] switch_core_state_machine.c:852 (sofia/external/2075091121@67.231.1.110) State HANGUP
2019-02-04 22:10:23.858409 [DEBUG] mod_sofia.c:438 Channel sofia/external/2075091121@67.231.1.110 hanging up, cause: NORMAL_CLEARING
2019-02-04 22:10:23.858409 [DEBUG] switch_core_state_machine.c:60 sofia/external/2075091121@67.231.1.110 Standard HANGUP, cause: NORMAL_CLEARING
2019-02-04 22:10:23.858409 [DEBUG] switch_core_state_machine.c:938 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State REPORTING
2019-02-04 22:10:23.858409 [DEBUG] switch_core_state_machine.c:852 (sofia/external/2075091121@67.231.1.110) State HANGUP going to sleep
2019-02-04 22:10:23.858409 [DEBUG] switch_core_state_machine.c:619 (sofia/external/2075091121@67.231.1.110) State Change CS_HANGUP -> CS_REPORTING
2019-02-04 22:10:23.858409 [DEBUG] switch_core_state_machine.c:584 (sofia/external/2075091121@67.231.1.110) Running State Change CS_REPORTING (Cur 5 Tot 26)
2019-02-04 22:10:23.858409 [DEBUG] switch_core_state_machine.c:938 (sofia/external/2075091121@67.231.1.110) State REPORTING
2019-02-04 22:10:23.878375 [DEBUG] switch_core_codec.c:248 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Restore previous codec L16:100.
2019-02-04 22:10:23.878375 [NOTICE] switch_ivr_originate.c:3612 Hangup sofia/external/12073131085 [CS_CONSUME_MEDIA] [ORIGINATOR_CANCEL]
2019-02-04 22:10:23.878375 [DEBUG] switch_ivr_originate.c:3837 Originate Cancelled by originator termination Cause: 487 [ORIGINATOR_CANCEL]
2019-02-04 22:10:23.878375 [DEBUG] switch_core_state_machine.c:584 (sofia/external/12073131085) Running State Change CS_HANGUP (Cur 5 Tot 26)
2019-02-04 22:10:23.878375 [DEBUG] switch_core_state_machine.c:850 (sofia/external/12073131085) Callstate Change DOWN -> HANGUP
2019-02-04 22:10:23.878375 [DEBUG] switch_core_state_machine.c:852 (sofia/external/12073131085) State HANGUP
2019-02-04 22:10:23.878375 [DEBUG] mod_sofia.c:438 Channel sofia/external/12073131085 hanging up, cause: ORIGINATOR_CANCEL
2019-02-04 22:10:23.878375 [INFO] mod_dptools.c:3436 Originate Failed. Cause: ORIGINATOR_CANCEL
2019-02-04 22:10:23.878375 [DEBUG] mod_sofia.c:502 Sending CANCEL to sofia/external/12073131085
2019-02-04 22:10:23.878375 [DEBUG] switch_core_state_machine.c:60 sofia/external/12073131085 Standard HANGUP, cause: ORIGINATOR_CANCEL
2019-02-04 22:10:23.878375 [DEBUG] switch_core_state_machine.c:852 (sofia/external/12073131085) State HANGUP going to sleep
2019-02-04 22:10:23.878375 [DEBUG] switch_core_state_machine.c:619 (sofia/external/12073131085) State Change CS_HANGUP -> CS_REPORTING
2019-02-04 22:10:23.878375 [DEBUG] switch_core_session.c:2815 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
2019-02-04 22:10:23.878375 [DEBUG] switch_core_state_machine.c:650 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State EXECUTE going to sleep
2019-02-04 22:10:23.878375 [DEBUG] switch_core_state_machine.c:584 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) Running State Change CS_HANGUP (Cur 5 Tot 26)
2019-02-04 22:10:23.878375 [DEBUG] switch_core_state_machine.c:584 (sofia/external/12073131085) Running State Change CS_REPORTING (Cur 5 Tot 26)
2019-02-04 22:10:23.878375 [DEBUG] switch_core_state_machine.c:938 (sofia/external/12073131085) State REPORTING
2019-02-04 22:10:23.878375 [DEBUG] switch_core_state_machine.c:174 sofia/external/12073131085 Standard REPORTING, cause: ORIGINATOR_CANCEL
2019-02-04 22:10:23.878375 [DEBUG] switch_core_state_machine.c:938 (sofia/external/12073131085) State REPORTING going to sleep
2019-02-04 22:10:23.878375 [DEBUG] switch_core_state_machine.c:850 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) Callstate Change EARLY -> HANGUP
2019-02-04 22:10:23.878375 [DEBUG] switch_core_state_machine.c:852 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State HANGUP
2019-02-04 22:10:23.878375 [DEBUG] mod_loopback.c:548 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in CHANNEL HANGUP
2019-02-04 22:10:23.878375 [DEBUG] switch_core_state_machine.c:60 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Standard HANGUP, cause: LOSE_RACE
2019-02-04 22:10:23.878375 [DEBUG] switch_core_state_machine.c:852 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State HANGUP going to sleep
2019-02-04 22:10:23.878375 [DEBUG] switch_core_state_machine.c:619 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State Change CS_HANGUP -> CS_REPORTING
2019-02-04 22:10:23.878375 [DEBUG] mod_loopback.c:601 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in CHANNEL KILL
2019-02-04 22:10:23.878375 [DEBUG] switch_core_state_machine.c:610 (sofia/external/12073131085) State Change CS_REPORTING -> CS_DESTROY
2019-02-04 22:10:23.878375 [DEBUG] switch_core_session.c:1665 Session 26 (sofia/external/12073131085) Locked, Waiting on external entities
2019-02-04 22:10:23.878375 [DEBUG] switch_core_state_machine.c:584 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) Running State Change CS_REPORTING (Cur 5 Tot 26)
2019-02-04 22:10:23.878375 [NOTICE] switch_core_session.c:1683 Session 26 (sofia/external/12073131085) Ended
2019-02-04 22:10:23.878375 [NOTICE] switch_core_session.c:1687 Close Channel sofia/external/12073131085 [CS_DESTROY]
2019-02-04 22:10:23.878375 [DEBUG] switch_core_state_machine.c:938 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State REPORTING
2019-02-04 22:10:23.878375 [DEBUG] switch_core_state_machine.c:741 (sofia/external/12073131085) Running State Change CS_DESTROY (Cur 4 Tot 26)
2019-02-04 22:10:23.878375 [DEBUG] switch_core_state_machine.c:751 (sofia/external/12073131085) State DESTROY
2019-02-04 22:10:23.878375 [DEBUG] mod_sofia.c:343 sofia/external/12073131085 SOFIA DESTROY
2019-02-04 22:10:23.878375 [DEBUG] switch_core_state_machine.c:181 sofia/external/12073131085 Standard DESTROY
2019-02-04 22:10:23.878375 [DEBUG] switch_core_state_machine.c:751 (sofia/external/12073131085) State DESTROY going to sleep
send 1154 bytes to tcp/[74.75.72.211]:59708 at 22:10:23.889971:
------------------------------------------------------------------------
NOTIFY sip:206@10.0.10.219:5060;transport=TCP SIP/2.0
Via: SIP/2.0/TCP 163.182.172.148;rport;branch=z9hG4bKgK35e3pSXc81c
Route: <sip:74.75.72.211:59708>;transport=TCP
Max-Forwards: 70
From: <sip:204@vox.turnittech.com:5060>;tag=wJLtUybjalf5
To: "Richard - 206" <sip:206@vox.turnittech.com:5060>;tag=808029337
Call-ID: 0_1097518684@10.0.10.219
CSeq: 150871152 NOTIFY
Contact: <sip:204@163.182.172.148:5060;transport=tcp>
User-Agent: FreeSWITCH
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Event: dialog
Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Subscription-State: active;expires=941
Content-Type: application/dialog-info+xml
Content-Length: 265

<?xml version="1.0"?>
<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="12" state="full" entity="sip:204@vox.turnittech.com">
<dialog id="9357073f-a70d-4bc6-9f80-717758abaa1b" direction="recipient">
<state>terminated</state>
</dialog>
</dialog-info>
------------------------------------------------------------------------
send 1154 bytes to tcp/[74.75.72.211]:59708 at 22:10:23.890868:
------------------------------------------------------------------------
NOTIFY sip:206@10.0.10.219:5060;transport=TCP SIP/2.0
Via: SIP/2.0/TCP 163.182.172.148;rport;branch=z9hG4bKHvvygy7vtNymr
Route: <sip:74.75.72.211:59708>;transport=TCP
Max-Forwards: 70
From: <sip:204@vox.turnittech.com:5060>;tag=wJLtUybjalf5
To: "Richard - 206" <sip:206@vox.turnittech.com:5060>;tag=808029337
Call-ID: 0_1097518684@10.0.10.219
CSeq: 150871153 NOTIFY
Contact: <sip:204@163.182.172.148:5060;transport=tcp>
User-Agent: FreeSWITCH
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
Supported: timer, path, replaces
Event: dialog
Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
Subscription-State: active;expires=941
Content-Type: application/dialog-info+xml
Content-Length: 265

<?xml version="1.0"?>
<dialog-info xmlns="urn:ietf:params:xml:ns:dialog-info" version="13" state="full" entity="sip:204@vox.turnittech.com">
<dialog id="80cc4eb1-a780-4449-a16a-afc9902737f9" direction="recipient">
<state>terminated</state>
</dialog>
</dialog-info>
------------------------------------------------------------------------
2019-02-04 22:10:23.898372 [DEBUG] switch_core_state_machine.c:174 sofia/internal/204@10.0.10.218:12569 Standard REPORTING, cause: LOSE_RACE
2019-02-04 22:10:23.898372 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/204@10.0.10.218:12569) State REPORTING going to sleep
2019-02-04 22:10:23.898372 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/204@10.0.10.218:12569) State Change CS_REPORTING -> CS_DESTROY
2019-02-04 22:10:23.898372 [DEBUG] switch_core_session.c:1665 Session 25 (sofia/internal/204@10.0.10.218:12569) Locked, Waiting on external entities
2019-02-04 22:10:23.898372 [NOTICE] switch_core_session.c:1683 Session 25 (sofia/internal/204@10.0.10.218:12569) Ended
2019-02-04 22:10:23.898372 [NOTICE] switch_core_session.c:1687 Close Channel sofia/internal/204@10.0.10.218:12569 [CS_DESTROY]
2019-02-04 22:10:23.898372 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/204@10.0.10.218:12569) Running State Change CS_DESTROY (Cur 3 Tot 26)
2019-02-04 22:10:23.898372 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/204@10.0.10.218:12569) State DESTROY
2019-02-04 22:10:23.898372 [DEBUG] mod_sofia.c:343 sofia/internal/204@10.0.10.218:12569 SOFIA DESTROY
2019-02-04 22:10:23.898372 [DEBUG] switch_core_state_machine.c:181 sofia/internal/204@10.0.10.218:12569 Standard DESTROY
2019-02-04 22:10:23.898372 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/204@10.0.10.218:12569) State DESTROY going to sleep
recv 361 bytes from tcp/[74.75.72.211]:30625 at 22:10:23.918528:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/TCP 163.182.172.148;rport=5060;branch=z9hG4bKB6495U27B0r4j
From: "WIRELESS CALLER " <sip:2075091121@vox.turnittech.com>;tag=vNvrKKX7F5trS
To: <sip:204@10.0.10.218:12569;transport=TCP>;tag=2133289916
Call-ID: 725e4748-a36c-1237-2e8f-00163c78a6b5
CSeq: 105306 CANCEL
User-Agent: Yealink SIP-T46S 66.83.0.55
Content-Length: 0

------------------------------------------------------------------------
recv 376 bytes from tcp/[74.75.72.211]:30625 at 22:10:23.918528:
------------------------------------------------------------------------
SIP/2.0 487 Request Cancelled
Via: SIP/2.0/TCP 163.182.172.148;rport=5060;branch=z9hG4bKB6495U27B0r4j
From: "WIRELESS CALLER " <sip:2075091121@vox.turnittech.com>;tag=vNvrKKX7F5trS
To: <sip:204@10.0.10.218:12569;transport=TCP>;tag=2133289916
Call-ID: 725e4748-a36c-1237-2e8f-00163c78a6b5
CSeq: 105306 INVITE
User-Agent: Yealink SIP-T46S 66.83.0.55
Content-Length: 0

------------------------------------------------------------------------
send 418 bytes to tcp/[74.75.72.211]:30625 at 22:10:23.918841:
------------------------------------------------------------------------
ACK sip:204@10.0.10.218:12569;transport=TCP SIP/2.0
Via: SIP/2.0/TCP 163.182.172.148;rport;branch=z9hG4bKB6495U27B0r4j
Route: <sip:204@74.75.72.211:30625>;transport=TCP
Max-Forwards: 70
From: "WIRELESS CALLER " <sip:2075091121@vox.turnittech.com>;tag=vNvrKKX7F5trS
To: <sip:204@10.0.10.218:12569;transport=TCP>;tag=2133289916
Call-ID: 725e4748-a36c-1237-2e8f-00163c78a6b5
CSeq: 105306 ACK
Content-Length: 0

------------------------------------------------------------------------
2019-02-04 22:10:23.919531 [DEBUG] switch_core_state_machine.c:174 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Standard REPORTING, cause: LOSE_RACE
2019-02-04 22:10:23.919531 [DEBUG] switch_core_state_machine.c:938 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State REPORTING going to sleep
2019-02-04 22:10:23.919531 [DEBUG] switch_core_state_machine.c:610 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State Change CS_REPORTING -> CS_DESTROY
2019-02-04 22:10:23.919531 [DEBUG] mod_loopback.c:601 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in CHANNEL KILL
2019-02-04 22:10:23.919531 [DEBUG] switch_core_session.c:1665 Session 23 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) Locked, Waiting on external entities
2019-02-04 22:10:23.919531 [NOTICE] switch_core_session.c:1683 Session 23 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) Ended
2019-02-04 22:10:23.919531 [NOTICE] switch_core_session.c:1687 Close Channel loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in [CS_DESTROY]
2019-02-04 22:10:23.919531 [DEBUG] switch_core_state_machine.c:741 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) Running State Change CS_DESTROY (Cur 2 Tot 26)
2019-02-04 22:10:23.919531 [DEBUG] switch_core_state_machine.c:751 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State DESTROY
2019-02-04 22:10:23.919531 [DEBUG] switch_core_state_machine.c:181 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Standard DESTROY
2019-02-04 22:10:23.919531 [DEBUG] switch_core_state_machine.c:751 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State DESTROY going to sleep
recv 388 bytes from tcp/[74.75.72.211]:59708 at 22:10:23.925110:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/TCP 163.182.172.148;rport=5060;branch=z9hG4bKFaaDD85N03HFH
From: <sip:204@vox.turnittech.com:5060>;tag=wJLtUybjalf5
To: "Richard - 206" <sip:206@vox.turnittech.com:5060>;tag=808029337
Call-ID: 0_1097518684@10.0.10.219
CSeq: 150871151 NOTIFY
Contact: <sip:206@10.0.10.219:5060;transport=TCP>
User-Agent: Yealink SIP-T52S 70.82.0.30
Content-Length: 0

------------------------------------------------------------------------
recv 388 bytes from tcp/[74.75.72.211]:59708 at 22:10:23.940175:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/TCP 163.182.172.148;rport=5060;branch=z9hG4bKgK35e3pSXc81c
From: <sip:204@vox.turnittech.com:5060>;tag=wJLtUybjalf5
To: "Richard - 206" <sip:206@vox.turnittech.com:5060>;tag=808029337
Call-ID: 0_1097518684@10.0.10.219
CSeq: 150871152 NOTIFY
Contact: <sip:206@10.0.10.219:5060;transport=TCP>
User-Agent: Yealink SIP-T52S 70.82.0.30
Content-Length: 0

------------------------------------------------------------------------
2019-02-04 22:10:23.919531 [DEBUG] switch_core_state_machine.c:174 sofia/external/2075091121@67.231.1.110 Standard REPORTING, cause: NORMAL_CLEARING
2019-02-04 22:10:23.919531 [DEBUG] switch_core_state_machine.c:938 (sofia/external/2075091121@67.231.1.110) State REPORTING going to sleep
2019-02-04 22:10:23.919531 [DEBUG] switch_core_state_machine.c:610 (sofia/external/2075091121@67.231.1.110) State Change CS_REPORTING -> CS_DESTROY
2019-02-04 22:10:23.919531 [DEBUG] switch_core_session.c:1665 Session 22 (sofia/external/2075091121@67.231.1.110) Locked, Waiting on external entities
2019-02-04 22:10:23.919531 [NOTICE] switch_core_session.c:1683 Session 22 (sofia/external/2075091121@67.231.1.110) Ended
2019-02-04 22:10:23.919531 [NOTICE] switch_core_session.c:1687 Close Channel sofia/external/2075091121@67.231.1.110 [CS_DESTROY]
2019-02-04 22:10:23.919531 [DEBUG] switch_core_state_machine.c:741 (sofia/external/2075091121@67.231.1.110) Running State Change CS_DESTROY (Cur 1 Tot 26)
2019-02-04 22:10:23.919531 [DEBUG] switch_core_state_machine.c:751 (sofia/external/2075091121@67.231.1.110) State DESTROY
2019-02-04 22:10:23.919531 [DEBUG] mod_sofia.c:343 sofia/external/2075091121@67.231.1.110 SOFIA DESTROY
2019-02-04 22:10:23.919531 [DEBUG] switch_core_state_machine.c:181 sofia/external/2075091121@67.231.1.110 Standard DESTROY
2019-02-04 22:10:23.919531 [DEBUG] switch_core_state_machine.c:751 (sofia/external/2075091121@67.231.1.110) State DESTROY going to sleep
recv 388 bytes from tcp/[74.75.72.211]:59708 at 22:10:23.946886:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/TCP 163.182.172.148;rport=5060;branch=z9hG4bKHvvygy7vtNymr
From: <sip:204@vox.turnittech.com:5060>;tag=wJLtUybjalf5
To: "Richard - 206" <sip:206@vox.turnittech.com:5060>;tag=808029337
Call-ID: 0_1097518684@10.0.10.219
CSeq: 150871153 NOTIFY
Contact: <sip:206@10.0.10.219:5060;transport=TCP>
User-Agent: Yealink SIP-T52S 70.82.0.30
Content-Length: 0

------------------------------------------------------------------------
2019-02-04 22:10:23.958375 [DEBUG] switch_core_state_machine.c:174 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Standard REPORTING, cause: LOSE_RACE
2019-02-04 22:10:23.958375 [DEBUG] switch_core_state_machine.c:938 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State REPORTING going to sleep
2019-02-04 22:10:23.958375 [DEBUG] switch_core_state_machine.c:610 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State Change CS_REPORTING -> CS_DESTROY
2019-02-04 22:10:23.958375 [DEBUG] mod_loopback.c:601 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in CHANNEL KILL
2019-02-04 22:10:23.958375 [DEBUG] switch_core_session.c:1665 Session 24 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) Locked, Waiting on external entities
2019-02-04 22:10:23.958375 [NOTICE] switch_core_session.c:1683 Session 24 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) Ended
2019-02-04 22:10:23.958375 [NOTICE] switch_core_session.c:1687 Close Channel loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in [CS_DESTROY]
2019-02-04 22:10:23.958375 [DEBUG] switch_core_state_machine.c:741 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) Running State Change CS_DESTROY (Cur 0 Tot 26)
2019-02-04 22:10:23.958375 [DEBUG] switch_core_state_machine.c:751 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State DESTROY
2019-02-04 22:10:23.958375 [DEBUG] switch_core_state_machine.c:181 loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in Standard DESTROY
2019-02-04 22:10:23.958375 [DEBUG] switch_core_state_machine.c:751 (loopback/export:presence_id=204@vox.turnittech.com,export:sip_h_X-accountcode=,export:fail_on_single_reject=USER_BUSY,export:in) State DESTROY going to sleep
send 1479 bytes to udp/[205.251.137.154]:5060 at 22:10:26.718398:
------------------------------------------------------------------------
INVITE sip:12073131085@gw.siptrunk.com SIP/2.0
Via: SIP/2.0/UDP 163.182.172.148:5080;rport;branch=z9hG4bK29145Qj05QUeK
Max-Forwards: 69
From: "WIRELESS CALLER " <sip:42376443@gw.siptrunk.com>;tag=Smm2pc4FQQHUc
To: <sip:12073131085@gw.siptrunk.com>
Call-ID: 72635a62-a36c-1237-2e8f-00163c78a6b5
CSeq: 105307 INVITE
Contact: <sip:gw+95b1c255-4646-4357-9b8a-2af0259a2780@163.182.172.148:5080;transport=udp;gw=95b1c255-4646-4357-9b8a-2af0259a2780>
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="42376443", realm="gw.siptrunk.com", nonce="XFi6jFxYuDSOz0OaeOAhT5i93qqz2DJrX56arsP17wUsu628dcPX/xmL9q7B", cnonce="cnRdgqNsEjePLgAWPHimtQ", algorithm=MD5, uri="sip:12073131085@gw.siptrunk.com", response="d3423e8eea0037c69e36bb0c2875972a", qop=auth, nc=00000001
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 301
X-FS-Support: update_display,send_info
Remote-Party-ID: "WIRELESS CALLER " <sip:2075091121@vox.turnittech.com>;party=calling;screen=yes;privacy=off

v=0
o=FreeSWITCH 1549301678 1549301679 IN IP4 163.182.172.148
s=FreeSWITCH
c=IN IP4 163.182.172.148
t=0 0
m=audio 16518 RTP/AVP 102 0 8 101 13
a=rtpmap:102 L16/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=rtpmap:13 CN/8000
a=ptime:20
------------------------------------------------------------------------
send 1479 bytes to udp/[205.251.137.154]:5060 at 22:10:27.718678:
------------------------------------------------------------------------
INVITE sip:12073131085@gw.siptrunk.com SIP/2.0
Via: SIP/2.0/UDP 163.182.172.148:5080;rport;branch=z9hG4bK29145Qj05QUeK
Max-Forwards: 69
From: "WIRELESS CALLER " <sip:42376443@gw.siptrunk.com>;tag=Smm2pc4FQQHUc
To: <sip:12073131085@gw.siptrunk.com>
Call-ID: 72635a62-a36c-1237-2e8f-00163c78a6b5
CSeq: 105307 INVITE
Contact: <sip:gw+95b1c255-4646-4357-9b8a-2af0259a2780@163.182.172.148:5080;transport=udp;gw=95b1c255-4646-4357-9b8a-2af0259a2780>
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="42376443", realm="gw.siptrunk.com", nonce="XFi6jFxYuDSOz0OaeOAhT5i93qqz2DJrX56arsP17wUsu628dcPX/xmL9q7B", cnonce="cnRdgqNsEjePLgAWPHimtQ", algorithm=MD5, uri="sip:12073131085@gw.siptrunk.com", response="d3423e8eea0037c69e36bb0c2875972a", qop=auth, nc=00000001
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 301
X-FS-Support: update_display,send_info
Remote-Party-ID: "WIRELESS CALLER " <sip:2075091121@vox.turnittech.com>;party=calling;screen=yes;privacy=off

v=0
o=FreeSWITCH 1549301678 1549301679 IN IP4 163.182.172.148
s=FreeSWITCH
c=IN IP4 163.182.172.148
t=0 0
m=audio 16518 RTP/AVP 102 0 8 101 13
a=rtpmap:102 L16/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=rtpmap:13 CN/8000
a=ptime:20
------------------------------------------------------------------------
freeswitch@vox.turnittech.com> sofia global siptrace off
 

DigitalDaz

Administrator
Staff member
Sep 29, 2016
3,077
579
113
It looks like you could possibly be getting UDP fragmentation there. Are you able to send as TCP to the carrier?
 

jlizzotte04

New Member
Dec 30, 2018
9
0
1
38
How would I change that in FusionPBX? To send as TCP? I thought the whole idea with UDP was so there was less overhead for re-transmissions
 
Status
Not open for further replies.