[m[33m[44m.=======================================================. | _____ ____ ____ _ ___ | | | ___/ ___| / ___| | |_ _| | | | |_ \___ \ | | | | | | | | | _| ___) | | |___| |___ | | | | |_| |____/ \____|_____|___| | | | .=======================================================. | Anthony Minessale II, Ken Rice, | | Michael Jerris, Travis Cross | | FreeSWITCH (http://www.freeswitch.org) | | Paypal Donations Appreciated: paypal@freeswitch.org | | Brought to you by ClueCon http://www.cluecon.com/ | .=======================================================. .===============================================================. | _ | | ___| |_ _ ___ ___ ___ _ __ ___ ___ _ __ ___ | | / __| | | | |/ _ \/ __/ _ \| '_ \ / __/ _ \| '_ ` _ \ | | | (__| | |_| | __/ (_| (_) | | | | _ | (_| (_) | | | | | | | | \___|_|\__,_|\___|\___\___/|_| |_| (_) \___\___/|_| |_| |_| | | | .===============================================================. [m Type /help to see a list of commands [m [This app Best viewed at 160x60 or more..] +OK log level 7 [7] freeswitch@FusionPBX> Invalid Profile [internal] freeswitch@FusionPBX> 2017-03-30 19:20:25.320953 [WARNING] sofia_reg.c:1791 SIP auth challenge (REGISTER) on sofia profile 'internal_old' for [14440@fs.mindc.co] from ip 81.218.146.180 2017-03-30 19:20:30.620935 [NOTICE] switch_channel.c:1104 New Channel sofia/internal_old/14451@fs.mindc.co [131b4280-8834-4deb-923d-afca926d4463] 2017-03-30 19:20:30.620935 [DEBUG] switch_core_state_machine.c:584 (sofia/internal_old/14451@fs.mindc.co) Running State Change CS_NEW 2017-03-30 19:20:30.620935 [DEBUG] sofia.c:9603 sofia/internal_old/14451@fs.mindc.co receiving invite from 81.218.146.180:53449 version: 1.6.12 -20-b91a0a6 64bit 2017-03-30 19:20:30.620935 [DEBUG] sofia.c:9770 IP 81.218.146.180 Rejected by acl "domains". Falling back to Digest auth. 2017-03-30 19:20:30.620935 [WARNING] sofia_reg.c:1791 SIP auth challenge (INVITE) on sofia profile 'internal_old' for [0523838030@fs.mindc.co] from ip 81.218.146.180 2017-03-30 19:20:30.620935 [DEBUG] switch_core_state_machine.c:603 (sofia/internal_old/14451@fs.mindc.co) State NEW 2017-03-30 19:20:30.620935 [DEBUG] sofia.c:2276 detaching session 131b4280-8834-4deb-923d-afca926d4463 2017-03-30 19:20:30.640941 [DEBUG] sofia.c:2384 Re-attaching to session 131b4280-8834-4deb-923d-afca926d4463 2017-03-30 19:20:30.660965 [DEBUG] sofia.c:9603 sofia/internal_old/14451@fs.mindc.co receiving invite from 81.218.146.180:53449 version: 1.6.12 -20-b91a0a6 64bit 2017-03-30 19:20:30.660965 [DEBUG] sofia.c:9770 IP 81.218.146.180 Rejected by acl "domains". Falling back to Digest auth. 2017-03-30 19:20:30.680946 [DEBUG] sofia.c:10906 Setting NAT mode based on via received 2017-03-30 19:20:30.680946 [DEBUG] sofia.c:6965 Channel sofia/internal_old/14451@fs.mindc.co entering state [received][100] 2017-03-30 19:20:30.680946 [DEBUG] sofia.c:6975 Remote SDP: v=0 o=- 2239406885585055500 2 IN IP4 127.0.0.1 s=Doubango Telecom - chrome t=0 0 a=group:BUNDLE audio a=msid-semantic: WMS 8bg48LRrdKoskspjDM176L5o4u9v9FKh0Jrr m=audio 55975 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 126 c=IN IP4 81.218.146.180 a=rtpmap:111 opus/48000/2 a=fmtp:111 minptime=10;useinbandfec=1 a=rtpmap:103 ISAC/16000 a=rtpmap:104 ISAC/32000 a=rtpmap:9 G722/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:106 CN/32000 a=rtpmap:105 CN/16000 a=rtpmap:13 CN/8000 a=rtpmap:126 telephone-event/8000 a=rtcp:55979 IN IP4 81.218.146.180 a=candidate:3836812040 1 udp 2122255103 2001::9d38:6abd:30cb:32b4:f5ff:2f 55973 typ host generation 0 network-id 1 network-cost 50 a=candidate:495521287 1 udp 2122194687 192.168.217.1 55974 typ host generation 0 network-id 4 a=candidate:1877284270 1 udp 2122129151 10.0.255.208 55975 typ host generation 0 network-id 3 a=candidate:812160150 1 udp 2122063615 192.168.148.1 55976 typ host generation 0 network-id 2 a=candidate:3836812040 2 udp 2122255102 2001::9d38:6abd:30cb:32b4:f5ff:2f 55977 typ host generation 0 network-id 1 network-cost 50 a=candidate:495521287 2 udp 2122194686 192.168.217.1 55978 typ host generation 0 network-id 4 a=candidate:1877284270 2 udp 2122129150 10.0.255.208 55979 typ host generation 0 network-id 3 a=candidate:812160150 2 udp 2122063614 192.168.148.1 55980 typ host generation 0 network-id 2 a=candidate:2855462904 1 tcp 1518275327 2001::9d38:6abd:30cb:32b4:f5ff:2f 9 typ host tcptype active generation 0 network-id 1 network-cost 50 a=candidate:1393226487 1 tcp 1518214911 192.168.217.1 9 typ host tcptype active generation 0 network-id 4 a=candidate:560392542 1 tcp 1518149375 10.0.255.208 9 typ host tcptype active generation 0 network-id 3 a=candidate:2129356902 1 tcp 1518083839 192.168.148.1 9 typ host tcptype active generation 0 network-id 2 a=candidate:2855462904 2 tcp 1518275326 2001::9d38:6abd:30cb:32b4:f5ff:2f 9 typ host tcptype active generation 0 network-id 1 network-cost 50 a=candidate:1393226487 2 tcp 1518214910 192.168.217.1 9 typ host tcptype active generation 0 network-id 4 a=candidate:560392542 2 tcp 1518149374 10.0.255.208 9 typ host tcptype active generation 0 network-id 3 a=candidate:2129356902 2 tcp 1518083838 192.168.148.1 9 typ host tcptype active generation 0 network-id 2 a=candidate:2582998138 1 udp 1685921535 81.218.146.180 55975 typ srflx raddr 10.0.255.208 rport 55975 generation 0 network-id 3 a=candidate:2582998138 2 udp 1685921534 81.218.146.180 55979 typ srflx raddr 10.0.255.208 rport 55979 generation 0 network-id 3 a=ice-ufrag:NsA1 a=ice-pwd:okXubah6rhTy9OSZiWz0YCDB a=fingerprint:sha-256 14:FC:E0:7D:79:58:42:BA:17:AA:A2:85:27:8B:CE:9A:C8:CA:D8:2A:65:2E:09:E7:85:56:1F:6B:20:38:90:DE a=setup:actpass a=mid:audio a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level a=rtcp-mux a=rtcp-fb:111 transport-cc a=ssrc:601562311 cname:8DQ5W+vGA5FKjF1K a=ssrc:601562311 msid:8bg48LRrdKoskspjDM176L5o4u9v9FKh0Jrr 8dd1b9ab-fa3b-45e6-a1d6-9628bf7fb8d2 a=ssrc:601562311 mslabel:8bg48LRrdKoskspjDM176L5o4u9v9FKh0Jrr a=ssrc:601562311 label:8dd1b9ab-fa3b-45e6-a1d6-9628bf7fb8d2 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [opus:111:48000:20:0:2]/[PCMU:0:8000:20:64000:1] 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [opus:111:48000:20:0:2]/[PCMA:8:8000:20:64000:1] 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [ISAC:103:16000:30:32000:1]/[PCMU:0:8000:20:64000:1] 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [ISAC:103:16000:30:32000:1]/[PCMA:8:8000:20:64000:1] 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [ISAC:104:32000:30:32000:1]/[PCMU:0:8000:20:64000:1] 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [ISAC:104:32000:30:32000:1]/[PCMA:8:8000:20:64000:1] 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMU:0:8000:20:64000:1] 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMA:8:8000:20:64000:1] 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1] 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4366 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1] 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1] 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1] 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4366 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [CN:105:16000:20:0:1]/[PCMU:0:8000:20:64000:1] 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [CN:105:16000:20:0:1]/[PCMA:8:8000:20:64000:1] 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [CN:13:8000:20:0:1]/[PCMU:0:8000:20:64000:1] 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [CN:13:8000:20:0:1]/[PCMA:8:8000:20:64000:1] 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4227 Set telephone-event payload to 126@8000 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3021 Set Codec sofia/internal_old/14451@fs.mindc.co PCMU/8000 20 ms 160 samples 64000 bits 1 channels 2017-03-30 19:20:30.680946 [DEBUG] switch_core_codec.c:111 sofia/internal_old/14451@fs.mindc.co Original read codec set to PCMU:0 2017-03-30 19:20:30.680946 [WARNING] switch_core_media.c:3395 NO candidate ACL defined, Defaulting to wan.auto 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3419 Drop audio Candidate cid: 1 proto: udp type: host addr: 2001::9d38:6abd:30cb:32b4:f5ff:2f:55973 (no network path) 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3425 Save audio Candidate cid: 1 proto: udp type: host addr: 192.168.217.1:55974 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3425 Save audio Candidate cid: 1 proto: udp type: host addr: 10.0.255.208:55975 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3425 Save audio Candidate cid: 1 proto: udp type: host addr: 192.168.148.1:55976 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3419 Drop audio Candidate cid: 2 proto: udp type: host addr: 2001::9d38:6abd:30cb:32b4:f5ff:2f:55977 (no network path) 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3425 Save audio Candidate cid: 2 proto: udp type: host addr: 192.168.217.1:55978 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3425 Save audio Candidate cid: 2 proto: udp type: host addr: 10.0.255.208:55979 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3425 Save audio Candidate cid: 2 proto: udp type: host addr: 192.168.148.1:55980 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3425 Save audio Candidate cid: 1 proto: udp type: srflx addr: 81.218.146.180:55975 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3425 Save audio Candidate cid: 2 proto: udp type: srflx addr: 81.218.146.180:55979 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3467 Searching for rtp candidate. 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3472 Choose rtp candidate, index 3, 81.218.146.180:55975 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3250 sofia/internal_old/14451@fs.mindc.co choosing family v4 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3483 Choose same candidate, index 4, for rtcp based on rtcp-mux attribute 81.218.146.180:55975 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3528 setting remote audio ice addr to index 3 81.218.146.180:55975 based on candidate 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:3549 Setting remote rtcp audio addr to 81.218.146.180:55975 based on candidate 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4572 Set telephone-event payload to 126@8000 2017-03-30 19:20:30.680946 [DEBUG] switch_core_media.c:4631 sofia/internal_old/14451@fs.mindc.co Set 2833 dtmf send payload to 126 recv payload to 126 2017-03-30 19:20:30.680946 [DEBUG] sofia.c:7364 (sofia/internal_old/14451@fs.mindc.co) State Change CS_NEW -> CS_INIT 2017-03-30 19:20:30.680946 [DEBUG] switch_core_state_machine.c:584 (sofia/internal_old/14451@fs.mindc.co) Running State Change CS_INIT 2017-03-30 19:20:30.680946 [DEBUG] switch_core_state_machine.c:627 (sofia/internal_old/14451@fs.mindc.co) State INIT 2017-03-30 19:20:30.680946 [DEBUG] mod_sofia.c:90 sofia/internal_old/14451@fs.mindc.co SOFIA INIT 2017-03-30 19:20:30.680946 [DEBUG] switch_core_state_machine.c:40 sofia/internal_old/14451@fs.mindc.co Standard INIT 2017-03-30 19:20:30.680946 [DEBUG] switch_core_state_machine.c:48 (sofia/internal_old/14451@fs.mindc.co) State Change CS_INIT -> CS_ROUTING 2017-03-30 19:20:30.680946 [DEBUG] switch_core_state_machine.c:627 (sofia/internal_old/14451@fs.mindc.co) State INIT going to sleep 2017-03-30 19:20:30.680946 [DEBUG] switch_core_state_machine.c:584 (sofia/internal_old/14451@fs.mindc.co) Running State Change CS_ROUTING 2017-03-30 19:20:30.680946 [DEBUG] switch_channel.c:2249 (sofia/internal_old/14451@fs.mindc.co) Callstate Change DOWN -> RINGING 2017-03-30 19:20:30.680946 [DEBUG] switch_core_state_machine.c:643 (sofia/internal_old/14451@fs.mindc.co) State ROUTING 2017-03-30 19:20:30.680946 [DEBUG] mod_sofia.c:143 sofia/internal_old/14451@fs.mindc.co SOFIA ROUTING 2017-03-30 19:20:30.680946 [DEBUG] switch_core_state_machine.c:236 sofia/internal_old/14451@fs.mindc.co Standard ROUTING 2017-03-30 19:20:30.680946 [INFO] mod_dialplan_xml.c:637 Processing 14451 <14451>->0523838030 in context fs.mindc.co Dialplan: sofia/internal_old/14451@fs.mindc.co parsing [fs.mindc.co->user_exists] continue=true Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (PASS) [user_exists] () =~ // break=on-false Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(user_exists=${user_exists id ${destination_number} ${domain_name}}) INLINE 2017-03-30 19:20:30.680946 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7f5710040a50 Connected. 2017-03-30 19:20:30.680946 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7f5710040a50 released. EXECUTE sofia/internal_old/14451@fs.mindc.co set(user_exists=false) 2017-03-30 19:20:30.680946 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [user_exists]=[false] Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_exists] ${user_exists}(false) =~ /^true$/ break=on-false Dialplan: sofia/internal_old/14451@fs.mindc.co parsing [fs.mindc.co->variables] continue=true Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (PASS) [variables] () =~ // break=on-false Dialplan: sofia/internal_old/14451@fs.mindc.co Action export(origination_callee_id_name=${destination_number}) Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)}) Dialplan: sofia/internal_old/14451@fs.mindc.co parsing [fs.mindc.co->call-direction] continue=true Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [call-direction] ${call_direction}() =~ /^(inbound|outbound|local)$/ break=never Dialplan: sofia/internal_old/14451@fs.mindc.co ANTI-Action set(call_direction=local) Dialplan: sofia/internal_old/14451@fs.mindc.co parsing [fs.mindc.co->chanspy] continue=false Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [chanspy] destination_number(0523838030) =~ /^\*33(\d{2,7})$/ break=on-false Dialplan: sofia/internal_old/14451@fs.mindc.co parsing [fs.mindc.co->user_record] continue=true Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (PASS) [user_record] () =~ // break=on-false Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(user_record=${user_data ${destination_number}@${domain_name} var user_record}) INLINE 2017-03-30 19:20:30.680946 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7f5710040a50 Connected. 2017-03-30 19:20:30.680946 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7f5710040a50 released. 2017-03-30 19:20:30.680946 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7f5710040a50 Connected. 2017-03-30 19:20:30.680946 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7f5710040a50 released. EXECUTE sofia/internal_old/14451@fs.mindc.co set(user_record=) 2017-03-30 19:20:30.680946 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [user_record]=[UNDEF] Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(from_user_exists=${user_exists id ${sip_from_user} ${sip_from_host}}) INLINE EXECUTE sofia/internal_old/14451@fs.mindc.co set(from_user_exists=true) 2017-03-30 19:20:30.700944 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [from_user_exists]=[true] Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${user_record}() =~ /^all$/ break=never Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${call_direction}() =~ /^inbound$/ break=never Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${user_record}() =~ /^inbound$/ break=never Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${call_direction}() =~ /^outbound$/ break=never Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${user_record}() =~ /^outbound$/ break=never Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${call_direction}() =~ /^local$/ break=never Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${user_record}() =~ /^local$/ break=never Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(from_user_record=${user_data ${sip_from_user}@${sip_from_host} var user_record}) INLINE EXECUTE sofia/internal_old/14451@fs.mindc.co set(from_user_record=all) 2017-03-30 19:20:30.700944 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [from_user_record]=[all] Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (PASS) [user_record] ${from_user_record}(all) =~ /^all$/ break=never Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(record_session=true) INLINE EXECUTE sofia/internal_old/14451@fs.mindc.co set(record_session=true) 2017-03-30 19:20:30.700944 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [record_session]=[true] Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${call_direction}() =~ /^inbound$/ break=never Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${from_user_record}(all) =~ /^inbound$/ break=never Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${call_direction}() =~ /^outbound$/ break=never Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${from_user_record}(all) =~ /^outbound$/ break=never Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${call_direction}() =~ /^local$/ break=never Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [user_record] ${from_user_record}(all) =~ /^local$/ break=never Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (PASS) [user_record] ${record_session}(true) =~ /^true$/ break=on-false Dialplan: sofia/internal_old/14451@fs.mindc.co Action export(nolocal:api_on_answer=uuid_record ${uuid} start ${recordings_dir}/${domain_name}/archive/${strftime(%Y)}/${strftime(%b)}/${strftime(%d)}/${uuid}.${record_ext}) Dialplan: sofia/internal_old/14451@fs.mindc.co parsing [fs.mindc.co->redial] continue=true Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [redial] destination_number(0523838030) =~ /^(redial|\*870)$/ break=on-true Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [redial] destination_number(0523838030) =~ /^(redial|\*870)$/ break=on-true Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (PASS) [redial] () =~ // break=never Dialplan: sofia/internal_old/14451@fs.mindc.co Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number}) Dialplan: sofia/internal_old/14451@fs.mindc.co parsing [fs.mindc.co->local_numbers] continue=false Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (FAIL) [local_numbers] destination_number(0523838030) =~ //0(2|3|4|8|9)(\d{7})// break=on-false Dialplan: sofia/internal_old/14451@fs.mindc.co parsing [fs.mindc.co->mobile_numbers] continue=false Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (PASS) [mobile_numbers] context(fs.mindc.co) =~ /fs.mindc.co/ break=on-false Dialplan: sofia/internal_old/14451@fs.mindc.co Regex (PASS) [mobile_numbers] destination_number(0523838030) =~ /^0([5]\d{8})$/ break=on-false Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(sip_h_X-accountcode=${accountcode}) Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(call_direction=outbound) Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(hangup_after_bridge=true) Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(_effective_caller_id_name=${effective_caller_id_name}) Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(effective_caller_id_number=0737392826) Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(inherit_codec=true) Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(ignore_display_updates=true) Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(callee_id_number=0523838030) Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(continue_on_fail=true) Dialplan: sofia/internal_old/14451@fs.mindc.co Action set(hangup_after_bridge=true) Dialplan: sofia/internal_old/14451@fs.mindc.co Action sched_hangup(+1800 allotted_timeout) Dialplan: sofia/internal_old/14451@fs.mindc.co Action export(_sip_from_uri=${outbound_caller_id_number}@${external_sip_ip}) Dialplan: sofia/internal_old/14451@fs.mindc.co Action bridge(sofia/gateway/0882e632-95b7-44f7-a7a1-75a7e638f2df/0523838030) Dialplan: sofia/internal_old/14451@fs.mindc.co Action bridge(sofia/gateway/6a14be4d-af77-4d45-9796-7aedad6185a4/0523838030) 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:286 (sofia/internal_old/14451@fs.mindc.co) State Change CS_ROUTING -> CS_EXECUTE 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:643 (sofia/internal_old/14451@fs.mindc.co) State ROUTING going to sleep 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:584 (sofia/internal_old/14451@fs.mindc.co) Running State Change CS_EXECUTE 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:650 (sofia/internal_old/14451@fs.mindc.co) State EXECUTE 2017-03-30 19:20:30.700944 [DEBUG] mod_sofia.c:198 sofia/internal_old/14451@fs.mindc.co SOFIA EXECUTE 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:328 sofia/internal_old/14451@fs.mindc.co Standard EXECUTE EXECUTE sofia/internal_old/14451@fs.mindc.co export(origination_callee_id_name=0523838030) 2017-03-30 19:20:30.700944 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [origination_callee_id_name]=[0523838030] EXECUTE sofia/internal_old/14451@fs.mindc.co set(RFC2822_DATE=Thu, 30 Mar 2017 19:20:30 +0300) 2017-03-30 19:20:30.700944 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [RFC2822_DATE]=[Thu, 30 Mar 2017 19:20:30 +0300] EXECUTE sofia/internal_old/14451@fs.mindc.co set(call_direction=local) 2017-03-30 19:20:30.700944 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [call_direction]=[local] EXECUTE sofia/internal_old/14451@fs.mindc.co export(nolocal:api_on_answer=uuid_record 131b4280-8834-4deb-923d-afca926d4463 start /var/lib/freeswitch/recordings/fs.mindc.co/archive/2017/Mar/30/131b4280-8834-4deb-923d-afca926d4463.mp3) 2017-03-30 19:20:30.700944 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) (REMOTE ONLY) [api_on_answer]=[uuid_record 131b4280-8834-4deb-923d-afca926d4463 start /var/lib/freeswitch/recordings/fs.mindc.co/archive/2017/Mar/30/131b4280-8834-4deb-923d-afca926d4463.mp3] EXECUTE sofia/internal_old/14451@fs.mindc.co hash(insert/fs.mindc.co-last_dial/14451/0523838030) EXECUTE sofia/internal_old/14451@fs.mindc.co set(sip_h_X-accountcode=fs.mindc.co) 2017-03-30 19:20:30.700944 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [sip_h_X-accountcode]=[fs.mindc.co] EXECUTE sofia/internal_old/14451@fs.mindc.co set(call_direction=outbound) 2017-03-30 19:20:30.700944 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [call_direction]=[outbound] EXECUTE sofia/internal_old/14451@fs.mindc.co set(hangup_after_bridge=true) 2017-03-30 19:20:30.700944 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [hangup_after_bridge]=[true] EXECUTE sofia/internal_old/14451@fs.mindc.co set(_effective_caller_id_name=) 2017-03-30 19:20:30.700944 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [_effective_caller_id_name]=[UNDEF] EXECUTE sofia/internal_old/14451@fs.mindc.co set(effective_caller_id_number=0737392826) 2017-03-30 19:20:30.700944 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [effective_caller_id_number]=[0737392826] EXECUTE sofia/internal_old/14451@fs.mindc.co set(inherit_codec=true) 2017-03-30 19:20:30.700944 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [inherit_codec]=[true] EXECUTE sofia/internal_old/14451@fs.mindc.co set(ignore_display_updates=true) 2017-03-30 19:20:30.700944 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [ignore_display_updates]=[true] EXECUTE sofia/internal_old/14451@fs.mindc.co set(callee_id_number=0523838030) 2017-03-30 19:20:30.700944 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [callee_id_number]=[0523838030] EXECUTE sofia/internal_old/14451@fs.mindc.co set(continue_on_fail=true) 2017-03-30 19:20:30.700944 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [continue_on_fail]=[true] EXECUTE sofia/internal_old/14451@fs.mindc.co set(hangup_after_bridge=true) 2017-03-30 19:20:30.700944 [DEBUG] mod_dptools.c:1519 SET sofia/internal_old/14451@fs.mindc.co [hangup_after_bridge]=[true] EXECUTE sofia/internal_old/14451@fs.mindc.co sched_hangup(+1800 allotted_timeout) 2017-03-30 19:20:30.700944 [DEBUG] switch_scheduler.c:249 Added task 27477 switch_ivr_schedule_hangup (131b4280-8834-4deb-923d-afca926d4463) to run at 1490892630 EXECUTE sofia/internal_old/14451@fs.mindc.co export(_sip_from_uri=@199.203.140.46) 2017-03-30 19:20:30.700944 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [_sip_from_uri]=[@199.203.140.46] EXECUTE sofia/internal_old/14451@fs.mindc.co bridge(sofia/gateway/0882e632-95b7-44f7-a7a1-75a7e638f2df/0523838030) 2017-03-30 19:20:30.700944 [DEBUG] switch_channel.c:1250 sofia/internal_old/14451@fs.mindc.co EXPORTING[export_vars] [domain_name]=[fs.mindc.co] to event 2017-03-30 19:20:30.700944 [DEBUG] switch_channel.c:1250 sofia/internal_old/14451@fs.mindc.co EXPORTING[export_vars] [origination_callee_id_name]=[0523838030] to event 2017-03-30 19:20:30.700944 [DEBUG] switch_channel.c:1250 sofia/internal_old/14451@fs.mindc.co EXPORTING[export_vars] [api_on_answer]=[uuid_record 131b4280-8834-4deb-923d-afca926d4463 start /var/lib/freeswitch/recordings/fs.mindc.co/archive/2017/Mar/30/131b4280-8834-4deb-923d-afca926d4463.mp3] to event 2017-03-30 19:20:30.700944 [DEBUG] switch_channel.c:1250 sofia/internal_old/14451@fs.mindc.co EXPORTING[export_vars] [_sip_from_uri]=[@199.203.140.46] to event 2017-03-30 19:20:30.700944 [DEBUG] switch_ivr_originate.c:2138 Parsing global variables 2017-03-30 19:20:30.700944 [NOTICE] switch_channel.c:1104 New Channel sofia/external/0523838030 [c1b3d560-4342-4c15-bc5f-782d594616ad] 2017-03-30 19:20:30.700944 [DEBUG] mod_sofia.c:4753 (sofia/external/0523838030) State Change CS_NEW -> CS_INIT 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:584 (sofia/external/0523838030) Running State Change CS_INIT 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:627 (sofia/external/0523838030) State INIT 2017-03-30 19:20:30.700944 [DEBUG] mod_sofia.c:90 sofia/external/0523838030 SOFIA INIT 2017-03-30 19:20:30.700944 [DEBUG] sofia_glue.c:1282 sofia/external/0523838030 sending invite version: 1.6.12 -20-b91a0a6 64bit Local SDP: v=0 o=FreeSWITCH 1490864090 1490864091 IN IP4 199.203.140.46 s=FreeSWITCH c=IN IP4 199.203.140.46 t=0 0 m=audio 26740 RTP/AVP 0 8 101 13 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 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:40 sofia/external/0523838030 Standard INIT 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:48 (sofia/external/0523838030) State Change CS_INIT -> CS_ROUTING 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:627 (sofia/external/0523838030) State INIT going to sleep 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:584 (sofia/external/0523838030) Running State Change CS_ROUTING 2017-03-30 19:20:30.700944 [DEBUG] sofia.c:6965 Channel sofia/external/0523838030 entering state [calling][0] 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:643 (sofia/external/0523838030) State ROUTING 2017-03-30 19:20:30.700944 [DEBUG] mod_sofia.c:143 sofia/external/0523838030 SOFIA ROUTING 2017-03-30 19:20:30.700944 [DEBUG] switch_ivr_originate.c:67 (sofia/external/0523838030) State Change CS_ROUTING -> CS_CONSUME_MEDIA 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:643 (sofia/external/0523838030) State ROUTING going to sleep 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:584 (sofia/external/0523838030) Running State Change CS_CONSUME_MEDIA 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:662 (sofia/external/0523838030) State CONSUME_MEDIA 2017-03-30 19:20:30.700944 [DEBUG] switch_core_state_machine.c:662 (sofia/external/0523838030) State CONSUME_MEDIA going to sleep 2017-03-30 19:20:31.680945 [DEBUG] sofia.c:6965 Channel sofia/external/0523838030 entering state [proceeding][183] 2017-03-30 19:20:31.680945 [DEBUG] sofia.c:6975 Remote SDP: v=0 o=Sonus_UAC 26586 18988 IN IP4 82.166.66.43 s=SIP Media Capabilities c=IN IP4 82.166.66.33 t=0 0 m=audio 7554 RTP/AVP 0 101 a=rtpmap:0 PCMU/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 2017-03-30 19:20:31.680945 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1] 2017-03-30 19:20:31.680945 [DEBUG] switch_core_media.c:4366 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match 2017-03-30 19:20:31.680945 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1] 2017-03-30 19:20:31.680945 [DEBUG] switch_core_media.c:4227 Set telephone-event payload to 101@8000 2017-03-30 19:20:31.680945 [DEBUG] switch_core_media.c:3021 Set Codec sofia/external/0523838030 PCMU/8000 20 ms 160 samples 64000 bits 1 channels 2017-03-30 19:20:31.680945 [DEBUG] switch_core_codec.c:111 sofia/external/0523838030 Original read codec set to PCMU:0 2017-03-30 19:20:31.680945 [DEBUG] switch_core_media.c:4572 Set telephone-event payload to 101@8000 2017-03-30 19:20:31.680945 [DEBUG] switch_core_media.c:4631 sofia/external/0523838030 Set 2833 dtmf send payload to 101 recv payload to 101 2017-03-30 19:20:31.680945 [DEBUG] switch_core_media.c:6588 AUDIO RTP [sofia/external/0523838030] 10.0.0.46 port 26740 -> 82.166.66.33 port 7554 codec: 0 ms: 20 2017-03-30 19:20:31.680945 [DEBUG] switch_rtp.c:3875 Starting timer [soft] 160 bytes per 20ms 2017-03-30 19:20:31.680945 [DEBUG] switch_core_media.c:6887 sofia/external/0523838030 Set 2833 dtmf send payload to 101 2017-03-30 19:20:31.680945 [DEBUG] switch_core_media.c:6894 sofia/external/0523838030 Set 2833 dtmf receive payload to 101 2017-03-30 19:20:31.680945 [DEBUG] switch_core_media.c:6917 sofia/external/0523838030 Set rtp dtmf delay to 40 2017-03-30 19:20:31.680945 [NOTICE] sofia_media.c:92 Pre-Answer sofia/external/0523838030! 2017-03-30 19:20:31.680945 [DEBUG] switch_channel.c:3471 (sofia/external/0523838030) Callstate Change DOWN -> EARLY 2017-03-30 19:20:31.680945 [DEBUG] switch_ivr_originate.c:410 Setting codec string on sofia/internal_old/14451@fs.mindc.co to PCMU@8000h@20i 2017-03-30 19:20:31.740945 [INFO] switch_ivr_originate.c:3635 Sending early media 2017-03-30 19:20:31.740945 [DEBUG] switch_core_media.c:6588 AUDIO RTP [sofia/internal_old/14451@fs.mindc.co] 10.0.0.46 port 17294 -> 81.218.146.180 port 55975 codec: 0 ms: 20 2017-03-30 19:20:31.740945 [DEBUG] switch_rtp.c:3875 Starting timer [soft] 160 bytes per 20ms 2017-03-30 19:20:31.740945 [INFO] switch_core_media.c:6763 Activating Audio ICE 2017-03-30 19:20:31.740945 [NOTICE] switch_rtp.c:4364 Activating RTP audio ICE: NsA1:plI0Yryx91mbOYFX 81.218.146.180:55975 2017-03-30 19:20:31.740945 [DEBUG] switch_core_media.c:6806 Activating RTCP PORT 55975 2017-03-30 19:20:31.740945 [DEBUG] switch_rtp.c:4261 RTCP send rate is: 5000 and packet rate is: 20000 Remote Port: 55975 2017-03-30 19:20:31.740945 [INFO] switch_core_media.c:6814 Skipping RTCP ICE (Same as RTP) 2017-03-30 19:20:31.740945 [INFO] switch_rtp.c:3368 Activate RTP/RTCP audio DTLS client 2017-03-30 19:20:31.740945 [INFO] switch_rtp.c:3502 Changing audio DTLS state from OFF to HANDSHAKE 2017-03-30 19:20:31.740945 [DEBUG] switch_core_media.c:6887 sofia/internal_old/14451@fs.mindc.co Set 2833 dtmf send payload to 126 2017-03-30 19:20:31.740945 [DEBUG] switch_core_media.c:6894 sofia/internal_old/14451@fs.mindc.co Set 2833 dtmf receive payload to 126 2017-03-30 19:20:31.740945 [DEBUG] switch_core_media.c:6917 sofia/internal_old/14451@fs.mindc.co Set rtp dtmf delay to 40 2017-03-30 19:20:31.740945 [DEBUG] switch_core_media.c:6923 Set comfort noise payload to 13 2017-03-30 19:20:31.740945 [DEBUG] mod_sofia.c:2307 Ring SDP: v=0 o=FreeSWITCH 1490873537 1490873538 IN IP4 199.203.140.46 s=FreeSWITCH c=IN IP4 199.203.140.46 t=0 0 a=msid-semantic: WMS AvlxU2WxDvwlo5kdXT6mLMSHIRDYcXMD m=audio 17294 UDP/TLS/RTP/SAVPF 0 126 13 a=rtpmap:0 PCMU/8000 a=rtpmap:126 telephone-event/8000 a=rtpmap:13 CN/8000 a=ptime:20 a=sendrecv a=fingerprint:sha-256 DA:15:3C:2F:CC:74:4A:10:20:11:B4:90:59:E6:71:77:7A:91:98:93:78:0B:96:A3:FF:22:2A:19:43:11:BA:08 a=setup:active a=rtcp-mux a=rtcp:17294 IN IP4 199.203.140.46 a=ice-ufrag:plI0Yryx91mbOYFX a=ice-pwd:MvQr87B6KWijsyFHKeyzvWXu a=candidate:7171139242 1 udp 659136 199.203.140.46 17294 typ host generation 0 a=end-of-candidates a=ssrc:3571550670 cname:iX03PMqj7NvmIFpw a=ssrc:3571550670 msid:AvlxU2WxDvwlo5kdXT6mLMSHIRDYcXMD a0 a=ssrc:3571550670 mslabel:AvlxU2WxDvwlo5kdXT6mLMSHIRDYcXMD a=ssrc:3571550670 label:AvlxU2WxDvwlo5kdXT6mLMSHIRDYcXMDa0 2017-03-30 19:20:31.740945 [NOTICE] mod_sofia.c:2310 Pre-Answer sofia/internal_old/14451@fs.mindc.co! 2017-03-30 19:20:31.740945 [DEBUG] switch_channel.c:3471 (sofia/internal_old/14451@fs.mindc.co) Callstate Change RINGING -> EARLY 2017-03-30 19:20:31.740945 [DEBUG] switch_ivr_originate.c:3686 Originate Resulted in Success: [sofia/external/0523838030] 2017-03-30 19:20:31.740945 [DEBUG] sofia.c:6965 Channel sofia/internal_old/14451@fs.mindc.co entering state [early][183] 2017-03-30 19:20:31.740945 [DEBUG] switch_ivr_bridge.c:1522 (sofia/external/0523838030) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA 2017-03-30 19:20:31.740945 [DEBUG] switch_core_state_machine.c:584 (sofia/external/0523838030) Running State Change CS_EXCHANGE_MEDIA 2017-03-30 19:20:31.740945 [DEBUG] switch_core_state_machine.c:653 (sofia/external/0523838030) State EXCHANGE_MEDIA 2017-03-30 19:20:31.740945 [DEBUG] mod_sofia.c:631 SOFIA EXCHANGE_MEDIA 2017-03-30 19:20:31.780945 [DEBUG] switch_rtp.c:6963 Correct audio ip/port confirmed. 2017-03-30 19:20:31.900952 [INFO] switch_rtp.c:3159 Changing audio DTLS state from HANDSHAKE to SETUP 2017-03-30 19:20:31.900952 [INFO] switch_rtp.c:3068 audio Fingerprint Verified. 2017-03-30 19:20:31.900952 [INFO] switch_rtp.c:3687 Activating Audio Secure RTP SEND 2017-03-30 19:20:31.900952 [INFO] switch_rtp.c:3665 Activating Audio Secure RTP RECV 2017-03-30 19:20:31.900952 [INFO] switch_rtp.c:3108 Changing audio DTLS state from SETUP to READY 2017-03-30 19:20:31.900952 [DEBUG] switch_core_sqldb.c:2612 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80 2017-03-30 19:20:31.900952 [DEBUG] switch_core_sqldb.c:2612 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80 2017-03-30 19:20:31.980945 [DEBUG] switch_rtp.c:1875 rtcp_stats_init: audio ssrc[601562311] base_seq[19018] 2017-03-30 19:20:33.640971 [DEBUG] sofia.c:6965 Channel sofia/external/0523838030 entering state [proceeding][183] 2017-03-30 19:20:33.640971 [DEBUG] sofia.c:6972 Duplicate SDP v=0 o=Sonus_UAC 26586 18988 IN IP4 82.166.66.43 s=SIP Media Capabilities c=IN IP4 82.166.66.33 t=0 0 m=audio 7554 RTP/AVP 0 101 a=rtpmap:0 PCMU/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 2017-03-30 19:20:33.640971 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1] 2017-03-30 19:20:33.640971 [DEBUG] switch_core_media.c:4366 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match 2017-03-30 19:20:33.640971 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1] 2017-03-30 19:20:33.640971 [DEBUG] switch_core_media.c:4227 Set telephone-event payload to 101@8000 2017-03-30 19:20:33.640971 [DEBUG] switch_core_media.c:4572 Set telephone-event payload to 101@8000 2017-03-30 19:20:33.640971 [DEBUG] switch_core_media.c:4631 sofia/external/0523838030 Set 2833 dtmf send payload to 101 recv payload to 101 2017-03-30 19:20:33.640971 [DEBUG] switch_core_media.c:6571 Audio params are unchanged for sofia/external/0523838030. 2017-03-30 19:20:33.640971 [DEBUG] sofia.c:6965 Channel sofia/external/0523838030 entering state [proceeding][180] 2017-03-30 19:20:33.640971 [DEBUG] sofia.c:6972 Duplicate SDP v=0 o=Sonus_UAC 26586 18988 IN IP4 82.166.66.43 s=SIP Media Capabilities c=IN IP4 82.166.66.33 t=0 0 m=audio 7554 RTP/AVP 0 101 a=rtpmap:0 PCMU/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 2017-03-30 19:20:33.640971 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1] 2017-03-30 19:20:33.640971 [DEBUG] switch_core_media.c:4366 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match 2017-03-30 19:20:33.640971 [DEBUG] switch_core_media.c:4311 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1] 2017-03-30 19:20:33.640971 [DEBUG] switch_core_media.c:4227 Set telephone-event payload to 101@8000 2017-03-30 19:20:33.640971 [DEBUG] switch_core_media.c:4572 Set telephone-event payload to 101@8000 2017-03-30 19:20:33.640971 [DEBUG] switch_core_media.c:4631 sofia/external/0523838030 Set 2833 dtmf send payload to 101 recv payload to 101 2017-03-30 19:20:33.640971 [DEBUG] switch_core_media.c:6571 Audio params are unchanged for sofia/external/0523838030.