d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [NOTICE] switch_channel.c:1104 New Channel sofia/Telkom/+27678243030@196.25.241.86 [d11234e3-4e6b-46d4-a4fb-a324ac2eb585]
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] switch_core_state_machine.c:584 (sofia/Telkom/+27678243030@196.25.241.86) Running State Change CS_NEW (Cur 5 Tot 418171)
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] sofia.c:10092 sofia/Telkom/+27678243030@196.25.241.86 receiving invite from 196.25.241.86:5060 version: 1.8.5  64bit
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] sofia.c:7291 Channel sofia/Telkom/+27678243030@196.25.241.86 entering state [received][100]
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] sofia.c:7301 Remote SDP:
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 v=0
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 o=- 2008196400 1836580979 IN IP4 196.25.241.86
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 s=-
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 c=IN IP4 196.25.241.86
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 t=0 0
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 m=audio 57578 RTP/AVP 18 4 8 100 118
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 a=rtpmap:18 G729/8000
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 a=fmtp:18 annexb=no
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 a=rtpmap:4 G723/8000
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 a=fmtp:4 annexa=no
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 a=rtpmap:8 PCMA/8000
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 a=rtpmap:100 telephone-event/8000
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 a=fmtp:100 0-15
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 a=rtpmap:118 PCMA/8000
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 a=gpmd:118 vbd=yes
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 a=gpmd:110 vbd=yes
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 a=pmft: T38
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [G729:18:8000:20:8000:1]/[G729:18:8000:20:8000:1]
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] switch_core_media.c:5507 Bah HUMBUG! Sticking with G729@8000h@20i
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] switch_core_media.c:5533 Audio Codec Compare [G729:18:8000:20:8000:1] ++++ is saved as a match
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [G723:4:8000:30:6300:1]/[G729:18:8000:20:8000:1]
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [G723:4:8000:30:6300:1]/[PCMA:8:8000:20:64000:1]
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G729:18:8000:20:8000:1]
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] switch_core_media.c:5507 Bah HUMBUG! Sticking with PCMA@8000h@20i
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] switch_core_media.c:5533 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] switch_core_media.c:5394 Set telephone-event payload to 100@8000
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [PCMA:118:8000:20:0:1]/[G729:18:8000:20:8000:1]
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] switch_core_media.c:5478 Audio Codec Compare [PCMA:118:8000:20:0:1]/[PCMA:8:8000:20:64000:1]
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] switch_core_media.c:3781 Set Codec sofia/Telkom/+27678243030@196.25.241.86 G729/8000 20 ms 160 samples 8000 bits 1 channels
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] switch_core_codec.c:111 sofia/Telkom/+27678243030@196.25.241.86 Original read codec set to G729:18
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] switch_core_media.c:5737 Set telephone-event payload to 100@8000
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] switch_core_media.c:5795 sofia/Telkom/+27678243030@196.25.241.86 Set 2833 dtmf send payload to 100 recv payload to 100
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] sofia.c:7716 (sofia/Telkom/+27678243030@196.25.241.86) State Change CS_NEW -> CS_INIT
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] switch_core_state_machine.c:603 (sofia/Telkom/+27678243030@196.25.241.86) State NEW
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] switch_core_state_machine.c:584 (sofia/Telkom/+27678243030@196.25.241.86) Running State Change CS_INIT (Cur 5 Tot 418171)
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] switch_core_state_machine.c:627 (sofia/Telkom/+27678243030@196.25.241.86) State INIT
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] mod_sofia.c:93 sofia/Telkom/+27678243030@196.25.241.86 SOFIA INIT
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] switch_core_state_machine.c:40 sofia/Telkom/+27678243030@196.25.241.86 Standard INIT
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] switch_core_state_machine.c:48 (sofia/Telkom/+27678243030@196.25.241.86) State Change CS_INIT -> CS_ROUTING
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] switch_core_state_machine.c:627 (sofia/Telkom/+27678243030@196.25.241.86) State INIT going to sleep
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] switch_core_state_machine.c:584 (sofia/Telkom/+27678243030@196.25.241.86) Running State Change CS_ROUTING (Cur 5 Tot 418171)
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] switch_channel.c:2249 (sofia/Telkom/+27678243030@196.25.241.86) Callstate Change DOWN -> RINGING
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] switch_core_state_machine.c:643 (sofia/Telkom/+27678243030@196.25.241.86) State ROUTING
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] mod_sofia.c:154 sofia/Telkom/+27678243030@196.25.241.86 SOFIA ROUTING
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [DEBUG] switch_core_state_machine.c:236 sofia/Telkom/+27678243030@196.25.241.86 Standard ROUTING
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.593417 [INFO] mod_dialplan_xml.c:637 Processing +27678243030 <+27678243030>->D8990105901300 in context public
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->caller-details] continue=true
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (PASS) [caller-details] () =~ // break=never
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Action export(call_direction=inbound) INLINE
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 EXECUTE sofia/Telkom/+27678243030@196.25.241.86 export(call_direction=inbound)
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.613376 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [call_direction]=[inbound]
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Action set(caller_destination=${destination_number}) INLINE
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 EXECUTE sofia/Telkom/+27678243030@196.25.241.86 set(caller_destination=D8990105901300)
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.613376 [DEBUG] mod_dptools.c:1598 SET sofia/Telkom/+27678243030@196.25.241.86 [caller_destination]=[D8990105901300]
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Action set(caller_id_name=${caller_id_name}) INLINE
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 EXECUTE sofia/Telkom/+27678243030@196.25.241.86 set(caller_id_name=+27678243030)
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.613376 [DEBUG] mod_dptools.c:1598 SET sofia/Telkom/+27678243030@196.25.241.86 [caller_id_name]=[+27678243030]
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Action set(caller_id_number=${caller_id_number}) INLINE
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 EXECUTE sofia/Telkom/+27678243030@196.25.241.86 set(caller_id_number=+27678243030)
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.613376 [DEBUG] mod_dptools.c:1598 SET sofia/Telkom/+27678243030@196.25.241.86 [caller_id_number]=[+27678243030]
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->Broll] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [Broll] destination_number(D8990105901300) =~ /^(\D8990514303187)$/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->PIM001] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [PIM001] destination_number(D8990105901300) =~ /^(\D8990126567877)$/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->PIM001] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [PIM001] chan_name(sofia/Telkom/+27678243030@196.25.241.86) =~ /sofia/Converged/0126567877@sbc.convergedgroup.co.za/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->Wurth] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [Wurth] chan_name(sofia/Telkom/+27678243030@196.25.241.86) =~ /sofia/Converged/0119746169@sbc.convergedgroup.co.za/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->Leer_Imports] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [Leer_Imports] chan_name(sofia/Telkom/+27678243030@196.25.241.86) =~ /sofia/Converged/0114401164@sbc.convergedgroup.co.za/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->Emalahleni] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [Emalahleni] chan_name(sofia/Telkom/+27678243030@196.25.241.86) =~ /sofia/Converged/0176486284@sbc.convergedgroup.co.za/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->Broll] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [Broll] chan_name(sofia/Telkom/+27678243030@196.25.241.86) =~ /sofia/Converged/0514303187@sbc.convergedgroup.co.za/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->Leer_Imports] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [Leer_Imports] destination_number(D8990105901300) =~ /^(\D8990114401164)$/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->Emalahleni] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [Emalahleni] destination_number(D8990105901300) =~ /^(\D8990176486284)$/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->APM] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [APM] chan_name(sofia/Telkom/+27678243030@196.25.241.86) =~ /sofia/Converged/0116138129@sbc.convergedgroup.co.za/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->Wurth] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [Wurth] destination_number(D8990105901300) =~ /^(\D8990113927132)$/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->Wurth] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [Wurth] chan_name(sofia/Telkom/+27678243030@196.25.241.86) =~ /sofia/Converged/0105914624@sbc.convergedgroup.co.za/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->CCD] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [CCD] chan_name(sofia/Telkom/+27678243030@196.25.241.86) =~ /sofia/Converged/0117995239@sbc.convergedgroup.co.za/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->PBSA] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [PBSA] destination_number(D8990105901300) =~ /^(\D8990115169414)$/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->CCD] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [CCD] destination_number(D8990105901300) =~ /^(\D8990117995239)$/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->KMD] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [KMD] chan_name(sofia/Telkom/+27678243030@196.25.241.86) =~ /sofia/Converged/0105919960@sbc.convergedgroup.co.za/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->KMD] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [KMD] destination_number(D8990105901300) =~ /^(\D8990105919960)$/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->PBSA] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [PBSA] chan_name(sofia/Telkom/+27678243030@196.25.241.86) =~ /sofia/Converged/0115169414@sbc.convergedgroup.co.za/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->PBSA] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [PBSA] chan_name(sofia/Telkom/+27678243030@196.25.241.86) =~ /sofia/Converged/0114662678@sbc.convergedgroup.co.za/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->PBSA] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [PBSA] destination_number(D8990105901300) =~ /^(\D8990114662678)$/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->APM] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [APM] chan_name(sofia/Telkom/+27678243030@196.25.241.86) =~ /sofia/Converged/0116131600@sbc.convergedgroup.co.za/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->APM] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [APM] destination_number(D8990105901300) =~ /^(\D8990116131600)$/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->APM] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [APM] destination_number(D8990105901300) =~ /^(\D8990116138129)$/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->Wurth] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [Wurth] destination_number(D8990105901300) =~ /^(\D8990119743836)$/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->APM] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [APM] chan_name(sofia/Telkom/+27678243030@196.25.241.86) =~ /sofia/Converged/0116138402@sbc.convergedgroup.co.za/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->Wurth] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [Wurth] destination_number(D8990105901300) =~ /^(\D8990119741284)$/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->APM] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [APM] destination_number(D8990105901300) =~ /^(\D8990116138402)$/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->Wurth] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [Wurth] chan_name(sofia/Telkom/+27678243030@196.25.241.86) =~ /sofia/Converged/0119743836@sbc.convergedgroup.co.za/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->Wurth] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [Wurth] destination_number(D8990105901300) =~ /^(\D8990119748908)$/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->Wurth] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [Wurth] destination_number(D8990105901300) =~ /^(\D8990119746605)$/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->Wurth] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [Wurth] chan_name(sofia/Telkom/+27678243030@196.25.241.86) =~ /sofia/Converged/0119741284@sbc.convergedgroup.co.za/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->Wurth] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [Wurth] destination_number(D8990105901300) =~ /^(\D8990119749423)$/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->Wurth] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [Wurth] destination_number(D8990105901300) =~ /^(\D8990119746169)$/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->Wurth] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [Wurth] destination_number(D8990105901300) =~ /^(\D8990119744369)$/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->Wurth] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [Wurth] chan_name(sofia/Telkom/+27678243030@196.25.241.86) =~ /sofia/Converged/0119746605@sbc.convergedgroup.co.za/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->Wurth] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [Wurth] chan_name(sofia/Telkom/+27678243030@196.25.241.86) =~ /sofia/Converged/0119748908@sbc.convergedgroup.co.za/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->Wurth] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [Wurth] chan_name(sofia/Telkom/+27678243030@196.25.241.86) =~ /sofia/Converged/0119749423@sbc.convergedgroup.co.za/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->Wurth] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [Wurth] chan_name(sofia/Telkom/+27678243030@196.25.241.86) =~ /sofia/Converged/0119744369@sbc.convergedgroup.co.za/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->^(D[0-9][0-9][0-8]\d+|D9[0-9][0-9]\d+|)$] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (FAIL) [^(D[0-9][0-9][0-8]\d+|D9[0-9][0-9]\d+|)$] destination_number(D8990105901300) =~ /^(D[0-9][0-9][0-8]\d+|D9[0-9][0-9]\d+|)$/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 parsing [public->^(\D899\d+)$] continue=false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Regex (PASS) [^(\D899\d+)$] destination_number(D8990105901300) =~ /^(\D899\d+)$/ break=on-false
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Action export(call_direction=inbound) INLINE
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 EXECUTE sofia/Telkom/+27678243030@196.25.241.86 export(call_direction=inbound)
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.613376 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [call_direction]=[inbound]
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Action set(domain_uuid=b0b3e4f0-a9a4-434a-83e7-7f5723fd0938) INLINE
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 EXECUTE sofia/Telkom/+27678243030@196.25.241.86 set(domain_uuid=b0b3e4f0-a9a4-434a-83e7-7f5723fd0938)
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.613376 [DEBUG] mod_dptools.c:1598 SET sofia/Telkom/+27678243030@196.25.241.86 [domain_uuid]=[b0b3e4f0-a9a4-434a-83e7-7f5723fd0938]
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Action set(domain_name=10.254.1.91) INLINE
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 EXECUTE sofia/Telkom/+27678243030@196.25.241.86 set(domain_name=10.254.1.91)
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.613376 [DEBUG] mod_dptools.c:1598 SET sofia/Telkom/+27678243030@196.25.241.86 [domain_name]=[10.254.1.91]
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Action set(hangup_after_bridge=true)
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Action set(continue_on_fail=true)
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Action export(t38_passthru=true)
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 Dialplan: sofia/Telkom/+27678243030@196.25.241.86 Action bridge(sofia/Converged/D8990105901300@154.118.252.35:5060)
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.613376 [DEBUG] switch_core_state_machine.c:286 (sofia/Telkom/+27678243030@196.25.241.86) State Change CS_ROUTING -> CS_EXECUTE
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.613376 [DEBUG] switch_core_state_machine.c:643 (sofia/Telkom/+27678243030@196.25.241.86) State ROUTING going to sleep
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.613376 [DEBUG] switch_core_state_machine.c:584 (sofia/Telkom/+27678243030@196.25.241.86) Running State Change CS_EXECUTE (Cur 5 Tot 418171)
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.613376 [DEBUG] switch_core_state_machine.c:650 (sofia/Telkom/+27678243030@196.25.241.86) State EXECUTE
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.613376 [DEBUG] mod_sofia.c:209 sofia/Telkom/+27678243030@196.25.241.86 SOFIA EXECUTE
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.613376 [DEBUG] switch_core_state_machine.c:328 sofia/Telkom/+27678243030@196.25.241.86 Standard EXECUTE
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 EXECUTE sofia/Telkom/+27678243030@196.25.241.86 set(hangup_after_bridge=true)
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.613376 [DEBUG] mod_dptools.c:1598 SET sofia/Telkom/+27678243030@196.25.241.86 [hangup_after_bridge]=[true]
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 EXECUTE sofia/Telkom/+27678243030@196.25.241.86 set(continue_on_fail=true)
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.613376 [DEBUG] mod_dptools.c:1598 SET sofia/Telkom/+27678243030@196.25.241.86 [continue_on_fail]=[true]
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 EXECUTE sofia/Telkom/+27678243030@196.25.241.86 export(t38_passthru=true)
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.613376 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [t38_passthru]=[true]
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 EXECUTE sofia/Telkom/+27678243030@196.25.241.86 bridge(sofia/Converged/D8990105901300@154.118.252.35:5060)
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.613376 [DEBUG] switch_channel.c:1250 sofia/Telkom/+27678243030@196.25.241.86 EXPORTING[export_vars] [call_direction]=[inbound] to event
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.613376 [DEBUG] switch_channel.c:1250 sofia/Telkom/+27678243030@196.25.241.86 EXPORTING[export_vars] [call_direction]=[inbound] to event
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.613376 [DEBUG] switch_channel.c:1250 sofia/Telkom/+27678243030@196.25.241.86 EXPORTING[export_vars] [t38_passthru]=[true] to event
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:07.613376 [DEBUG] switch_ivr_originate.c:2204 Parsing global variables
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:09.153402 [INFO] switch_ivr_originate.c:1246 Sending early media
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:09.153402 [DEBUG] switch_core_media.c:8511 AUDIO RTP [sofia/Telkom/+27678243030@196.25.241.86] 154.118.252.38 port 23166 -> 196.25.241.86 port 57578 codec: 18 ms: 20
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:09.153402 [DEBUG] switch_rtp.c:4300 Starting timer [soft] 160 bytes per 20ms
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:09.153402 [DEBUG] switch_core_media.c:8815 sofia/Telkom/+27678243030@196.25.241.86 Set 2833 dtmf send payload to 100
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:09.153402 [DEBUG] switch_core_media.c:8822 sofia/Telkom/+27678243030@196.25.241.86 Set 2833 dtmf receive payload to 100
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:09.153402 [DEBUG] switch_core_media.c:8845 sofia/Telkom/+27678243030@196.25.241.86 Set rtp dtmf delay to 40
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:09.153402 [DEBUG] mod_sofia.c:2505 Ring SDP:
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 v=0
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 o=FreeSWITCH 1563077043 1563077044 IN IP4 154.118.252.38
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 s=FreeSWITCH
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 c=IN IP4 154.118.252.38
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 t=0 0
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 m=audio 23166 RTP/AVP 18 100
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 a=rtpmap:18 G729/8000
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 a=fmtp:18 annexb=no
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 a=rtpmap:100 telephone-event/8000
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 a=fmtp:100 0-16
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 a=ptime:20
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 a=sendrecv
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:09.153402 [NOTICE] mod_sofia.c:2508 Pre-Answer sofia/Telkom/+27678243030@196.25.241.86!
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:09.153402 [DEBUG] switch_channel.c:3482 (sofia/Telkom/+27678243030@196.25.241.86) Callstate Change RINGING -> EARLY
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:09.153402 [DEBUG] switch_ivr_originate.c:1304 Raw Codec Activation Success L16@8000hz 1 channel 20ms
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:09.153402 [DEBUG] switch_core_codec.c:223 sofia/Telkom/+27678243030@196.25.241.86 Push codec L16:100
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:09.153402 [DEBUG] switch_ivr_originate.c:1373 Play Ringback Tone [%(2000,4000,440,480)]
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:09.173385 [DEBUG] sofia.c:7291 Channel sofia/Telkom/+27678243030@196.25.241.86 entering state [early][183]
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:09.193381 [DEBUG] switch_core_codec.c:248 sofia/Telkom/+27678243030@196.25.241.86 Restore previous codec G729:18.
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:09.193381 [DEBUG] switch_core_media.c:8494 Audio params are unchanged for sofia/Telkom/+27678243030@196.25.241.86.
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:09.193381 [DEBUG] mod_sofia.c:882 Local SDP sofia/Telkom/+27678243030@196.25.241.86:
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 v=0
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 o=FreeSWITCH 1563077043 1563077045 IN IP4 154.118.252.38
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 s=FreeSWITCH
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 c=IN IP4 154.118.252.38
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 t=0 0
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 m=audio 23166 RTP/AVP 18 100
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 a=rtpmap:18 G729/8000
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 a=fmtp:18 annexb=no
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 a=rtpmap:100 telephone-event/8000
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 a=fmtp:100 0-16
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 a=ptime:20
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 a=sendrecv
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:09.193381 [NOTICE] switch_ivr_originate.c:3740 Channel [sofia/Telkom/+27678243030@196.25.241.86] has been answered
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:09.193381 [DEBUG] switch_channel.c:3781 (sofia/Telkom/+27678243030@196.25.241.86) Callstate Change EARLY -> ACTIVE
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:09.193381 [DEBUG] sofia.c:7291 Channel sofia/Telkom/+27678243030@196.25.241.86 entering state [completed][200]
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:09.193381 [DEBUG] switch_ivr_originate.c:3798 Originate Resulted in Success: [sofia/Converged/D8990105901300@154.118.252.35:5060]
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:09.213387 [DEBUG] sofia.c:7291 Channel sofia/Telkom/+27678243030@196.25.241.86 entering state [ready][200]
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:09.433412 [DEBUG] switch_rtp.c:7550 Correct audio ip/port confirmed.
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:09.853413 [WARNING] switch_core_media.c:3136 [CBR]: Asynchronous PTIME not supported, changing our end from 20 to 60
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:09.873376 [DEBUG] switch_core_media.c:3679 Changing Codec from G729@20ms@8000hz to G729@60ms@8000hz
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:09.913404 [DEBUG] switch_rtp.c:4175 RE-Starting timer [soft] 480 bytes per 60ms
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:09.913404 [DEBUG] switch_core_media.c:3781 Set Codec sofia/Telkom/+27678243030@196.25.241.86 G729/8000 60 ms 480 samples 8000 bits 1 channels
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:09.913404 [DEBUG] switch_core_codec.c:123 sofia/Telkom/+27678243030@196.25.241.86 Original read codec replaced with G729:18
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:09.933375 [DEBUG] switch_core_media.c:15824 Engaging Write Buffer at 960 bytes to accommodate 320->960
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:22.273408 [DEBUG] switch_rtp.c:7789 RTP RECV DTMF 2:800
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:22.273408 [INFO] switch_channel.c:515 RECV DTMF 2:800
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:24.433374 [DEBUG] switch_ivr.c:625 sofia/Telkom/+27678243030@196.25.241.86 Command Execute playback(local_stream://default)
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 EXECUTE sofia/Telkom/+27678243030@196.25.241.86 playback(local_stream://default)
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:24.653402 [DEBUG] switch_core_media.c:15824 Engaging Write Buffer at 960 bytes to accommodate 320->960
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:47.473403 [DEBUG] switch_rtp.c:7789 RTP RECV DTMF 2:840
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:47.473403 [INFO] switch_channel.c:515 RECV DTMF 2:840
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:49.573405 [DEBUG] switch_ivr.c:625 sofia/Telkom/+27678243030@196.25.241.86 Command Execute playback(local_stream://default)
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 EXECUTE sofia/Telkom/+27678243030@196.25.241.86 playback(local_stream://default)
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:49.793414 [DEBUG] switch_core_media.c:15824 Engaging Write Buffer at 960 bytes to accommodate 320->960
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:53.973417 [ERR] switch_core_media.c:15839 Write Buffer 0 bytes Failed!
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:54.013403 [DEBUG] switch_ivr_bridge.c:825 sofia/Converged/D8990105901300@154.118.252.35:5060 ending bridge by request from write function
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:54.013403 [DEBUG] switch_ivr_bridge.c:917 BRIDGE THREAD DONE [sofia/Telkom/+27678243030@196.25.241.86]
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:54.013403 [NOTICE] switch_ivr_bridge.c:1933 Hangup sofia/Telkom/+27678243030@196.25.241.86 [CS_EXECUTE] [NORMAL_CLEARING]
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:54.013403 [DEBUG] switch_core_session.c:2887 sofia/Telkom/+27678243030@196.25.241.86 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:54.013403 [DEBUG] switch_core_state_machine.c:650 (sofia/Telkom/+27678243030@196.25.241.86) State EXECUTE going to sleep
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:54.013403 [DEBUG] switch_core_state_machine.c:584 (sofia/Telkom/+27678243030@196.25.241.86) Running State Change CS_HANGUP (Cur 7 Tot 418176)
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:54.013403 [DEBUG] switch_core_state_machine.c:847 (sofia/Telkom/+27678243030@196.25.241.86) Callstate Change ACTIVE -> HANGUP
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:54.013403 [DEBUG] switch_core_state_machine.c:849 (sofia/Telkom/+27678243030@196.25.241.86) State HANGUP
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:54.013403 [DEBUG] mod_sofia.c:449 Channel sofia/Telkom/+27678243030@196.25.241.86 hanging up, cause: NORMAL_CLEARING
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:54.013403 [DEBUG] mod_sofia.c:502 Sending BYE to sofia/Telkom/+27678243030@196.25.241.86
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:54.013403 [DEBUG] switch_core_state_machine.c:60 sofia/Telkom/+27678243030@196.25.241.86 Standard HANGUP, cause: NORMAL_CLEARING
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:54.013403 [DEBUG] switch_core_state_machine.c:849 (sofia/Telkom/+27678243030@196.25.241.86) State HANGUP going to sleep
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:54.013403 [DEBUG] switch_core_state_machine.c:619 (sofia/Telkom/+27678243030@196.25.241.86) State Change CS_HANGUP -> CS_REPORTING
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:54.013403 [DEBUG] switch_core_state_machine.c:584 (sofia/Telkom/+27678243030@196.25.241.86) Running State Change CS_REPORTING (Cur 7 Tot 418176)
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:54.013403 [DEBUG] switch_core_state_machine.c:935 (sofia/Telkom/+27678243030@196.25.241.86) State REPORTING
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:54.013403 [DEBUG] switch_core_state_machine.c:174 sofia/Telkom/+27678243030@196.25.241.86 Standard REPORTING, cause: NORMAL_CLEARING
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:54.013403 [DEBUG] switch_core_state_machine.c:935 (sofia/Telkom/+27678243030@196.25.241.86) State REPORTING going to sleep
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:54.013403 [DEBUG] switch_core_state_machine.c:610 (sofia/Telkom/+27678243030@196.25.241.86) State Change CS_REPORTING -> CS_DESTROY
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:54.013403 [DEBUG] switch_core_session.c:1715 Session 418171 (sofia/Telkom/+27678243030@196.25.241.86) Locked, Waiting on external entities
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:54.013403 [NOTICE] switch_core_session.c:1733 Session 418171 (sofia/Telkom/+27678243030@196.25.241.86) Ended
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:54.013403 [NOTICE] switch_core_session.c:1737 Close Channel sofia/Telkom/+27678243030@196.25.241.86 [CS_DESTROY]
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:54.033404 [DEBUG] switch_core_state_machine.c:738 (sofia/Telkom/+27678243030@196.25.241.86) Running State Change CS_DESTROY (Cur 6 Tot 418176)
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:54.033404 [DEBUG] switch_core_state_machine.c:748 (sofia/Telkom/+27678243030@196.25.241.86) State DESTROY
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:54.033404 [DEBUG] mod_sofia.c:354 sofia/Telkom/+27678243030@196.25.241.86 SOFIA DESTROY
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:54.033404 [DEBUG] switch_core_state_machine.c:181 sofia/Telkom/+27678243030@196.25.241.86 Standard DESTROY
d11234e3-4e6b-46d4-a4fb-a324ac2eb585 2019-07-14 12:30:54.033404 [DEBUG] switch_core_state_machine.c:748 (sofia/Telkom/+27678243030@196.25.241.86) State DESTROY going to sleep