2016-04-04 11:17:29.618618 [DEBUG] sofia.c:4236 debug [9] 2016-04-04 11:17:29.618624 [DEBUG] sofia.c:4236 sip-trace [no] 2016-04-04 11:17:29.618627 [DEBUG] sofia.c:4236 sip-capture [no] 2016-04-04 11:17:29.618630 [DEBUG] sofia.c:4236 watchdog-enabled [no] 2016-04-04 11:17:29.618634 [DEBUG] sofia.c:4236 watchdog-step-timeout [30000] 2016-04-04 11:17:29.618638 [DEBUG] sofia.c:4236 watchdog-event-timeout [30000] 2016-04-04 11:17:29.618642 [DEBUG] sofia.c:4236 log-auth-failures [true] 2016-04-04 11:17:29.618645 [DEBUG] sofia.c:4236 forward-unsolicited-mwi-notify [false] 2016-04-04 11:17:29.618648 [DEBUG] sofia.c:4236 context [public] 2016-04-04 11:17:29.618654 [DEBUG] sofia.c:4236 rfc2833-pt [101] 2016-04-04 11:17:29.618657 [DEBUG] sofia.c:4236 sip-port [5062] 2016-04-04 11:17:29.618661 [DEBUG] sofia.c:4236 dialplan [XML] 2016-04-04 11:17:29.618667 [DEBUG] sofia.c:4236 dtmf-duration [2000] 2016-04-04 11:17:29.618677 [DEBUG] sofia.c:4236 inbound-codec-prefs [OPUS] 2016-04-04 11:17:29.618684 [DEBUG] sofia.c:4236 outbound-codec-prefs [OPUS] 2016-04-04 11:17:29.618690 [DEBUG] sofia.c:4236 rtp-timer-name [soft] 2016-04-04 11:17:29.618694 [DEBUG] sofia.c:4236 rtp-ip [192.168.199.22] 2016-04-04 11:17:29.618698 [DEBUG] sofia.c:4236 sip-ip [192.168.199.22] 2016-04-04 11:17:29.618702 [DEBUG] sofia.c:4236 hold-music [local_stream://moh] 2016-04-04 11:17:29.618720 [DEBUG] sofia.c:4236 apply-nat-acl [nat.auto] 2016-04-04 11:17:29.618734 [ERR] sofia.c:5185 Not adding acl nat.auto because it's the local network 2016-04-04 11:17:29.618739 [DEBUG] sofia.c:4236 apply-inbound-acl [domains] 2016-04-04 11:17:29.618745 [DEBUG] sofia.c:4236 local-network-acl [localnet.auto] 2016-04-04 11:17:29.618749 [DEBUG] sofia.c:4236 record-path [/usr/local/freeswitch/recordings] 2016-04-04 11:17:29.618754 [DEBUG] sofia.c:4236 record-template [${caller_id_number}.${target_domain}.${strftime(%Y-%m-%d-%H-%M-%S)}.wav] 2016-04-04 11:17:29.618763 [DEBUG] sofia.c:4236 manage-presence [true] 2016-04-04 11:17:29.618768 [DEBUG] sofia.c:4236 presence-hosts [192.168.199.22,192.168.199.22] 2016-04-04 11:17:29.618774 [DEBUG] sofia.c:4236 presence-privacy [false] 2016-04-04 11:17:29.618778 [DEBUG] sofia.c:4236 inbound-codec-negotiation [generous] 2016-04-04 11:17:29.618783 [DEBUG] sofia.c:4236 tls [true] 2016-04-04 11:17:29.618791 [DEBUG] sofia.c:4236 tls-only [false] 2016-04-04 11:17:29.618798 [DEBUG] sofia.c:4236 tls-bind-params [transport=tls] 2016-04-04 11:17:29.618804 [DEBUG] sofia.c:4236 tls-sip-port [5063] 2016-04-04 11:17:29.618810 [DEBUG] sofia.c:4236 tls-passphrase [] 2016-04-04 11:17:29.618816 [DEBUG] sofia.c:4236 tls-verify-date [true] 2016-04-04 11:17:29.618822 [DEBUG] sofia.c:4236 tls-verify-policy [none] 2016-04-04 11:17:29.618829 [ERR] sofia_glue.c:329 Invalid tls-verify-policy value: none 2016-04-04 11:17:29.618835 [DEBUG] sofia.c:4236 tls-verify-depth [2] 2016-04-04 11:17:29.618844 [DEBUG] sofia.c:4236 tls-verify-in-subjects [] 2016-04-04 11:17:29.618850 [DEBUG] sofia.c:4236 tls-version [tlsv1,tlsv1.1,tlsv1.2] 2016-04-04 11:17:29.618860 [DEBUG] sofia.c:4236 tls-ciphers [ALL:!ADH:!LOW:!EXP:!MD5:@STRENGTH] 2016-04-04 11:17:29.618868 [DEBUG] sofia.c:4236 inbound-late-negotiation [true] 2016-04-04 11:17:29.618872 [DEBUG] sofia.c:4236 inbound-zrtp-passthru [true] 2016-04-04 11:17:29.618876 [DEBUG] sofia.c:4236 nonce-ttl [60] 2016-04-04 11:17:29.618881 [DEBUG] sofia.c:4236 auth-calls [true] 2016-04-04 11:17:29.618887 [DEBUG] sofia.c:4236 inbound-reg-force-matching-username [true] 2016-04-04 11:17:29.618893 [DEBUG] sofia.c:4236 auth-all-packets [false] 2016-04-04 11:17:29.618898 [DEBUG] sofia.c:4236 ext-rtp-ip [auto-nat] 2016-04-04 11:17:29.618902 [DEBUG] sofia.c:4236 ext-sip-ip [auto-nat] 2016-04-04 11:17:29.618908 [DEBUG] sofia.c:4236 rtp-timeout-sec [300] 2016-04-04 11:17:29.618913 [DEBUG] sofia.c:4236 rtp-hold-timeout-sec [1800] 2016-04-04 11:17:29.618917 [DEBUG] sofia.c:4236 force-register-domain [192.168.199.22] 2016-04-04 11:17:29.618922 [DEBUG] sofia.c:4236 force-subscription-domain [192.168.199.22] 2016-04-04 11:17:29.618927 [DEBUG] sofia.c:4236 force-register-db-domain [192.168.199.22] 2016-04-04 11:17:29.618933 [DEBUG] sofia.c:4236 ws-binding [:5066] 2016-04-04 11:17:29.618939 [DEBUG] sofia.c:4236 wss-binding [:7443] 2016-04-04 11:17:29.618945 [DEBUG] sofia.c:4236 challenge-realm [auto_from] 2016-04-04 11:17:29.618953 [INFO] sofia.c:5513 Setting MAX Auth Validity to 0 Attempts 2016-04-04 11:17:29.619091 [NOTICE] sofia.c:5680 Started Profile internal [sofia_reg_internal] 2016-04-04 11:24:00.891443 [DEBUG] switch_loadable_module.c:735 Chat Thread Started 2016-04-04 11:24:00.891453 [INFO] switch_core.c:2418 FreeSWITCH Version 1.6.5~64bit ( 64bit) @@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@ @@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@@ FreeSWITCH Started Max Sessions [1000] Session Rate [30] SQL [Enabled] 2016-04-04 11:24:00.891457 [DEBUG] switch_loadable_module.c:735 Chat Thread Started 2016-04-04 11:40:26.231645 [DEBUG] sofia_reg.c:1756 Send challenge for [anonymous@192.168.199.22] 2016-04-04 11:40:26.231645 [WARNING] sofia_reg.c:1760 SIP auth challenge (REGISTER) on sofia profile 'internal' for [anonymous@192.168.199.22] from ip 192.168.199.216 2016-04-04 11:40:26.291670 [DEBUG] sofia_reg.c:3139 event_add_header -> 'record_stereo' = 'true' 2016-04-04 11:40:26.291670 [DEBUG] sofia_reg.c:3139 event_add_header -> 'default_gateway' = 'example.com' 2016-04-04 11:40:26.291670 [DEBUG] sofia_reg.c:3139 event_add_header -> 'default_areacode' = '918' 2016-04-04 11:40:26.291670 [DEBUG] sofia_reg.c:3139 event_add_header -> 'transfer_fallback_extension' = 'operator' 2016-04-04 11:40:26.291670 [DEBUG] sofia_reg.c:3139 event_add_header -> 'user_context' = 'anonymous' 2016-04-04 11:40:26.291670 [DEBUG] sofia_reg.c:3139 event_add_header -> 'effective_caller_id_name' = 'Anonymous' 2016-04-04 11:40:26.291670 [DEBUG] sofia_reg.c:3139 event_add_header -> 'effective_caller_id_number' = 'anonymous' 2016-04-04 11:40:26.291670 [DEBUG] sofia_reg.c:3139 event_add_header -> 'outbound_caller_id_name' = '$${outbound_ caller_name}' 2016-04-04 11:40:26.291670 [DEBUG] sofia_reg.c:3139 event_add_header -> 'outbound_caller_id_number' = 'anonymous' 2016-04-04 11:40:26.291670 [DEBUG] sofia_reg.c:2001 Register: From: [anonymous@192.168.199.22] Contact: ["" ] Expires: [600] 2016-04-04 11:40:26.291670 [CONSOLE] mod_voicemail.c:4088 Event Thread Started 2016-04-04 11:41:04.251189 [DEBUG] sofia_reg.c:1756 Send challenge for [1010@192.168.199.22] 2016-04-04 11:41:04.251189 [WARNING] sofia_reg.c:1760 SIP auth challenge (REGISTER) on sofia profile 'internal' for [1010@192.168.199.22] from ip 192.168.199.216 2016-04-04 11:41:04.311264 [DEBUG] sofia_reg.c:3139 event_add_header -> 'record_stereo' = 'true' 2016-04-04 11:41:04.311264 [DEBUG] sofia_reg.c:3139 event_add_header -> 'default_gateway' = 'example.com' 2016-04-04 11:41:04.311264 [DEBUG] sofia_reg.c:3139 event_add_header -> 'default_areacode' = '918' 2016-04-04 11:41:04.311264 [DEBUG] sofia_reg.c:3139 event_add_header -> 'transfer_fallback_extension' = 'operator' 2016-04-04 11:41:04.311264 [DEBUG] sofia_reg.c:3139 event_add_header -> 'toll_allow' = 'domestic,international,local' 2016-04-04 11:41:04.311264 [DEBUG] sofia_reg.c:3139 event_add_header -> 'accountcode' = '1010' 2016-04-04 11:41:04.311264 [DEBUG] sofia_reg.c:3139 event_add_header -> 'user_context' = 'default' 2016-04-04 11:41:04.311264 [DEBUG] sofia_reg.c:3139 event_add_header -> 'effective_caller_id_name' = 'Extension 1010' 2016-04-04 11:41:04.311264 [DEBUG] sofia_reg.c:3139 event_add_header -> 'effective_caller_id_number' = '1010' 2016-04-04 11:41:04.311264 [DEBUG] sofia_reg.c:3139 event_add_header -> 'outbound_caller_id_name' = 'FreeSWITCH' 2016-04-04 11:41:04.311264 [DEBUG] sofia_reg.c:3139 event_add_header -> 'outbound_caller_id_number' = '0000000000' 2016-04-04 11:41:04.311264 [DEBUG] sofia_reg.c:3139 event_add_header -> 'callgroup' = 'techsupport' 2016-04-04 11:41:04.311264 [DEBUG] sofia_reg.c:2001 Register: From: [1010@192.168.199.22] Contact: ["" ] Expires: [600] 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [NOTICE] switch_channel.c:1091 New Channel sofia/internal/anonymous@192.168.199.22 [1709c7c4-fa17-11e5-9184-9d31ebce310e] 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/anonymous@192.168.199.22) Running State Change CS_NEW 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] sofia.c:9240 sofia/internal/anonymous@192.168.199.22 receiving invite from 192.168.199.216:1099 version: 1.6.5 64bit 2016-04-04 11:41:18.271147 [DEBUG] sofia.c:9352 IP 192.168.199.216 Approved by acl "domains[]". Access Granted. 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] sofia.c:10539 Setting NAT mode based on websockets 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] sofia.c:6750 Channel sofia/internal/anonymous@192.168.199.22 entering state [received][100] 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] sofia.c:6760 Remote SDP: 1709c7c4-fa17-11e5-9184-9d31ebce310e v=0 1709c7c4-fa17-11e5-9184-9d31ebce310e o=- 2269318439683772682 2 IN IP4 127.0.0.1 1709c7c4-fa17-11e5-9184-9d31ebce310e s=- 1709c7c4-fa17-11e5-9184-9d31ebce310e t=0 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=group:BUNDLE audio 1709c7c4-fa17-11e5-9184-9d31ebce310e a=msid-semantic: WMS rYj84RRd3TzyYFyEBpKbVkBuRetSSmtrlY3o 1709c7c4-fa17-11e5-9184-9d31ebce310e m=audio 1107 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 126 1709c7c4-fa17-11e5-9184-9d31ebce310e c=IN IP4 192.168.199.216 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtpmap:111 opus/48000/2 1709c7c4-fa17-11e5-9184-9d31ebce310e a=fmtp:111 minptime=10; useinbandfec=1 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtpmap:103 ISAC/16000 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtpmap:104 ISAC/32000 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtpmap:9 G722/8000 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtpmap:0 PCMU/8000 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtpmap:8 PCMA/8000 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtpmap:106 CN/32000 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtpmap:105 CN/16000 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtpmap:13 CN/8000 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtpmap:126 telephone-event/8000 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtcp:1110 IN IP4 192.168.199.216 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:2985945573 1 udp 2122260223 192.168.199.216 1107 typ host generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:2696558014 1 udp 2122194687 10.20.102.216 1108 typ host generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:1936642402 1 udp 2122129151 10.10.13.216 1109 typ host generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:2985945573 2 udp 2122260222 192.168.199.216 1110 typ host generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:2696558014 2 udp 2122194686 10.20.102.216 1111 typ host generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:1936642402 2 udp 2122129150 10.10.13.216 1112 typ host generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:4286190869 1 tcp 1518280447 192.168.199.216 0 typ host tcptype active generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:3996764494 1 tcp 1518214911 10.20.102.216 0 typ host tcptype active generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:1038953874 1 tcp 1518149375 10.10.13.216 0 typ host tcptype active generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:4286190869 2 tcp 1518280446 192.168.199.216 0 typ host tcptype active generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:3996764494 2 tcp 1518214910 10.20.102.216 0 typ host tcptype active generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:1038953874 2 tcp 1518149374 10.10.13.216 0 typ host tcptype active generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=ice-ufrag:4PWOC8zOrgkF0JcH 1709c7c4-fa17-11e5-9184-9d31ebce310e a=ice-pwd:KoIliPYZgGkk+b6K7bJDPVLK 1709c7c4-fa17-11e5-9184-9d31ebce310e a=fingerprint:sha-256 18:9D:FC:F1:74:38:63:AE:F1:F8:F0:26:F5:83:A8:41:97:53:67:F5:35:FB:7E:F3:06:BF:D5:71:FD:A2:F6:38 1709c7c4-fa17-11e5-9184-9d31ebce310e a=setup:actpass 1709c7c4-fa17-11e5-9184-9d31ebce310e a=mid:audio 1709c7c4-fa17-11e5-9184-9d31ebce310e a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level 1709c7c4-fa17-11e5-9184-9d31ebce310e a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtcp-mux 1709c7c4-fa17-11e5-9184-9d31ebce310e a=maxptime:60 1709c7c4-fa17-11e5-9184-9d31ebce310e a=ssrc:1463663134 cname:mrCkzHA0WH9Dd+8n 1709c7c4-fa17-11e5-9184-9d31ebce310e a=ssrc:1463663134 msid:rYj84RRd3TzyYFyEBpKbVkBuRetSSmtrlY3o 62a659a4-ef68-469a-871c-0e61ef3dd211 1709c7c4-fa17-11e5-9184-9d31ebce310e a=ssrc:1463663134 mslabel:rYj84RRd3TzyYFyEBpKbVkBuRetSSmtrlY3o 1709c7c4-fa17-11e5-9184-9d31ebce310e a=ssrc:1463663134 label:62a659a4-ef68-469a-871c-0e61ef3dd211 1709c7c4-fa17-11e5-9184-9d31ebce310e 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] sofia.c:7115 (sofia/internal/anonymous@192.168.199.22) State Change CS_NEW -> CS_INIT 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] switch_core_state_machine.c:492 (sofia/internal/anonymous@192.168.199.22) State NEW 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/anonymous@192.168.199.22) Running State Change CS_INIT 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] switch_core_state_machine.c:516 (sofia/internal/anonymous@192.168.199.22) State INIT 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] mod_sofia.c:88 sofia/internal/anonymous@192.168.199.22 SOFIA INIT 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] switch_core_state_machine.c:40 sofia/internal/anonymous@192.168.199.22 Standard INIT 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/anonymous@192.168.199.22) State Change CS_INIT -> CS_ROUTING 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] switch_core_state_machine.c:516 (sofia/internal/anonymous@192.168.199.22) State INIT going to sleep 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/anonymous@192.168.199.22) Running State Change CS_ROUTING 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] switch_channel.c:2239 (sofia/internal/anonymous@192.168.199.22) Callstate Change DOWN -> RINGING 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] switch_core_state_machine.c:532 (sofia/internal/anonymous@192.168.199.22) State ROUTING 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] mod_sofia.c:141 sofia/internal/anonymous@192.168.199.22 SOFIA ROUTING 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] switch_core_state_machine.c:166 sofia/internal/anonymous@192.168.199.22 Standard ROUTING 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [INFO] mod_dialplan_xml.c:637 Processing anonymous ->1010 in context public 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 parsing [public->unloop] continue=false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 parsing [public->outside_call] continue=true 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Absolute Condition [outside_call] 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action set(outside_call=true) 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)}) 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 parsing [public->call_debug] continue=true 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Regex (FAIL) [call_debug] ${call_debug}(false) =~ /^true$/ break=never 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 parsing [public->public_extensions] continue=false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Regex (PASS) [public_extensions] destination_number(1010) =~ /^(10[01][0-9])$/ break=on-false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action transfer(1010 XML default) 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] switch_core_state_machine.c:216 (sofia/internal/anonymous@192.168.199.22) State Change CS_ROUTING -> CS_EXECUTE 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] switch_core_state_machine.c:532 (sofia/internal/anonymous@192.168.199.22) State ROUTING going to sleep 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/anonymous@192.168.199.22) Running State Change CS_EXECUTE 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] switch_core_state_machine.c:539 (sofia/internal/anonymous@192.168.199.22) State EXECUTE 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] mod_sofia.c:196 sofia/internal/anonymous@192.168.199.22 SOFIA EXECUTE 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] switch_core_state_machine.c:258 sofia/internal/anonymous@192.168.199.22 Standard EXECUTE 1709c7c4-fa17-11e5-9184-9d31ebce310e EXECUTE sofia/internal/anonymous@192.168.199.22 set(outside_call=true) 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] mod_dptools.c:1498 SET sofia/internal/anonymous@192.168.199.22 [outside_call]=[true] 1709c7c4-fa17-11e5-9184-9d31ebce310e EXECUTE sofia/internal/anonymous@192.168.199.22 export(RFC2822_DATE=Mon, 04 Apr 2016 11:41:18 +0800) 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] switch_channel.c:1283 EXPORT (export_vars) [RFC2822_DATE]=[Mon, 04 Apr 2016 11:41:18 +0800] 1709c7c4-fa17-11e5-9184-9d31ebce310e EXECUTE sofia/internal/anonymous@192.168.199.22 transfer(1010 XML default) 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] switch_ivr.c:2085 (sofia/internal/anonymous@192.168.199.22) State Change CS_EXECUTE -> CS_ROUTING 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [NOTICE] switch_ivr.c:2092 Transfer sofia/internal/anonymous@192.168.199.22 to XML[1010@default] 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] switch_core_state_machine.c:539 (sofia/internal/anonymous@192.168.199.22) State EXECUTE going to sleep 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/anonymous@192.168.199.22) Running State Change CS_ROUTING 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] switch_core_state_machine.c:532 (sofia/internal/anonymous@192.168.199.22) State ROUTING 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] mod_sofia.c:141 sofia/internal/anonymous@192.168.199.22 SOFIA ROUTING 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] switch_core_state_machine.c:166 sofia/internal/anonymous@192.168.199.22 Standard ROUTING 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [INFO] mod_dialplan_xml.c:637 Processing anonymous ->1010 in context default 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 parsing [default->unloop] continue=false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 parsing [default->tod_example] continue=true 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Date/Time Match (PASS) [tod_example] break=on-false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action set(open=true) 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 parsing [default->holiday_example] continue=true 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Date/TimeMatch (FAIL) [holiday_example] break=on-false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 parsing [default->global-intercept] continue=false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Regex (FAIL) [global-intercept] destination_number(1010) =~ /^886$/ break=on-false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 parsing [default->group-intercept] continue=false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Regex (FAIL) [group-intercept] destination_number(1010) =~ /^\*8$/ break=on-false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 parsing [default->intercept-ext] continue=false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Regex (FAIL) [intercept-ext] destination_number(1010) =~ /^\*\*(\d+)$/ break=on-false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 parsing [default->redial] continue=false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Regex (FAIL) [redial] destination_number(1010) =~ /^(redial|870)$/ break=on-false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 parsing [default->global] continue=true 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Regex (PASS) [global] ${default_password}(1234) =~ /^1234$/ break=never 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action log(CRIT WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING ) 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action log(CRIT Open /usr/local/freeswitch/conf/vars.xml and change the default_password.) 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action log(CRIT Once changed type reloadxml at the console.) 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action log(CRIT WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING ) 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action sleep(10000) 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Regex (FAIL) [global] ${rtp_has_crypto}() =~ /^(AEAD_AES_256_GCM_8|AEAD_AES_128_GCM_8|AES_CM_256_HMAC_SHA1_80|AES_CM_192_HMAC_SHA1_80|AES_CM_128_HMAC_SHA1_80|AES_CM_256_HMAC_SHA1_32|AES_CM_192_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_32|AES_CM_128_NULL_AUTH)$/ break=never 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Regex (PASS) [global] ${endpoint_disposition}(DELAYED NEGOTIATION) =~ /^(DELAYED NEGOTIATION)/ break=on-false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Regex (FAIL) [global] ${switch_r_sdp}(v=0 1709c7c4-fa17-11e5-9184-9d31ebce310e o=- 2269318439683772682 2 IN IP4 127.0.0.1 1709c7c4-fa17-11e5-9184-9d31ebce310e s=- 1709c7c4-fa17-11e5-9184-9d31ebce310e t=0 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=group:BUNDLE audio 1709c7c4-fa17-11e5-9184-9d31ebce310e a=msid-semantic: WMS rYj84RRd3TzyYFyEBpKbVkBuRetSSmtrlY3o 1709c7c4-fa17-11e5-9184-9d31ebce310e m=audio 1107 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 126 1709c7c4-fa17-11e5-9184-9d31ebce310e c=IN IP4 192.168.199.216 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtpmap:111 opus/48000/2 1709c7c4-fa17-11e5-9184-9d31ebce310e a=fmtp:111 minptime=10; useinbandfec=1 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtpmap:103 ISAC/16000 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtpmap:104 ISAC/32000 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtpmap:9 G722/8000 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtpmap:0 PCMU/8000 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtpmap:8 PCMA/8000 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtpmap:106 CN/32000 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtpmap:105 CN/16000 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtpmap:13 CN/8000 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtpmap:126 telephone-event/8000 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtcp:1110 IN IP4 192.168.199.216 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:2985945573 1 udp 2122260223 192.168.199.216 1107 typ host generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:2696558014 1 udp 2122194687 10.20.102.216 1108 typ host generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:1936642402 1 udp 2122129151 10.10.13.216 1109 typ host generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:2985945573 2 udp 2122260222 192.168.199.216 1110 typ host generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:2696558014 2 udp 2122194686 10.20.102.216 1111 typ host generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:1936642402 2 udp 2122129150 10.10.13.216 1112 typ host generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:4286190869 1 tcp 1518280447 192.168.199.216 0 typ host tcptype active generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:3996764494 1 tcp 1518214911 10.20.102.216 0 typ host tcptype active generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:1038953874 1 tcp 1518149375 10.10.13.216 0 typ host tcptype active generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:4286190869 2 tcp 1518280446 192.168.199.216 0 typ host tcptype active generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:3996764494 2 tcp 1518214910 10.20.102.216 0 typ host tcptype active generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:1038953874 2 tcp 1518149374 10.10.13.216 0 typ host tcptype active generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=ice-ufrag:4PWOC8zOrgkF0JcH 1709c7c4-fa17-11e5-9184-9d31ebce310e a=ice-pwd:KoIliPYZgGkk+b6K7bJDPVLK 1709c7c4-fa17-11e5-9184-9d31ebce310e a=fingerprint:sha-256 18:9D:FC:F1:74:38:63:AE:F1:F8:F0:26:F5:83:A8:41:97:53:67:F5:35:FB:7E:F3:06:BF:D5:71:FD:A2:F6:38 1709c7c4-fa17-11e5-9184-9d31ebce310e a=setup:actpass 1709c7c4-fa17-11e5-9184-9d31ebce310e a=mid:audio 1709c7c4-fa17-11e5-9184-9d31ebce310e a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level 1709c7c4-fa17-11e5-9184-9d31ebce310e a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtcp-mux 1709c7c4-fa17-11e5-9184-9d31ebce310e a=maxptime:60 1709c7c4-fa17-11e5-9184-9d31ebce310e a=ssrc:1463663134 cname:mrCkzHA0WH9Dd+8n 1709c7c4-fa17-11e5-9184-9d31ebce310e a=ssrc:1463663134 msid:rYj84RRd3TzyYFyEBpKbVkBuRetSSmtrlY3o 62a659a4-ef68-469a-871c-0e61ef3dd211 1709c7c4-fa17-11e5-9184-9d31ebce310e a=ssrc:1463663134 mslabel:rYj84RRd3TzyYFyEBpKbVkBuRetSSmtrlY3o 1709c7c4-fa17-11e5-9184-9d31ebce310e a=ssrc:1463663134 label:62a659a4-ef68-469a-871c-0e61ef3dd211 1709c7c4-fa17-11e5-9184-9d31ebce310e ) =~ /(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)/ break=never 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Absolute Condition [global] 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid}) 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number}) 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action hash(insert/${domain_name}-last_dial/global/${uuid}) 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)}) 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 parsing [default->snom-demo-2] continue=false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Regex (FAIL) [snom-demo-2] destination_number(1010) =~ /^9001$/ break=on-false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 parsing [default->snom-demo-1] continue=false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Regex (FAIL) [snom-demo-1] destination_number(1010) =~ /^9000$/ break=on-false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 parsing [default->eavesdrop] continue=false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Regex (FAIL) [eavesdrop] destination_number(1010) =~ /^88(\d{4})$|^\*0(.*)$/ break=on-false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 parsing [default->eavesdrop] continue=false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Regex (FAIL) [eavesdrop] destination_number(1010) =~ /^779$/ break=on-false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 parsing [default->call_return] continue=false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Regex (FAIL) [call_return] destination_number(1010) =~ /^\*69$|^869$|^lcr$/ break=on-false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 parsing [default->del-group] continue=false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Regex (FAIL) [del-group] destination_number(1010) =~ /^80(\d{2})$/ break=on-false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 parsing [default->add-group] continue=false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Regex (FAIL) [add-group] destination_number(1010) =~ /^81(\d{2})$/ break=on-false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 parsing [default->call-group-simo] continue=false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Regex (FAIL) [call-group-simo] destination_number(1010) =~ /^82(\d{2})$/ break=on-false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 parsing [default->call-group-order] continue=false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Regex (FAIL) [call-group-order] destination_number(1010) =~ /^83(\d{2})$/ break=on-false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 parsing [default->extension-intercom] continue=false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Regex (FAIL) [extension-intercom] destination_number(1010) =~ /^8(10[01][0-9])$/ break=on-false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 parsing [default->Local_Extension] continue=false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Regex (PASS) [Local_Extension] destination_number(1010) =~ /^(10[01][0-9])$/ break=on-false 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action export(dialed_extension=1010) 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action bind_meta_app(1 b s execute_extension::dx XML features) 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action bind_meta_app(2 b s record_session::/usr/local/freeswitch/recordings/${caller_id_number}.${strftime(%Y-%m-%d-%H-%M-%S)}.wav) 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action bind_meta_app(3 b s execute_extension::cf XML features) 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action bind_meta_app(4 b s execute_extension::att_xfer XML features) 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action set(ringback=${us-ring}) 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action set(transfer_ringback=local_stream://moh) 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action set(call_timeout=30) 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action set(hangup_after_bridge=true) 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action set(continue_on_fail=true) 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action hash(insert/${domain_name}-call_return/${dialed_extension}/${caller_id_number}) 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action hash(insert/${domain_name}-last_dial_ext/${dialed_extension}/${uuid}) 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action set(called_party_callgroup=${user_data(${dialed_extension}@${domain_name} var callgroup)}) 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action hash(insert/${domain_name}-last_dial_ext/${called_party_callgroup}/${uuid}) 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action hash(insert/${domain_name}-last_dial_ext/global/${uuid}) 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action hash(insert/${domain_name}-last_dial/${called_party_callgroup}/${uuid}) 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action bridge(user/${dialed_extension}@${domain_name}) 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action answer() 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action sleep(1000) 1709c7c4-fa17-11e5-9184-9d31ebce310e Dialplan: sofia/internal/anonymous@192.168.199.22 Action bridge(loopback/app=voicemail:default ${domain_name} ${dialed_extension}) 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] switch_core_state_machine.c:216 (sofia/internal/anonymous@192.168.199.22) State Change CS_ROUTING -> CS_EXECUTE 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] switch_core_state_machine.c:532 (sofia/internal/anonymous@192.168.199.22) State ROUTING going to sleep 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/anonymous@192.168.199.22) Running State Change CS_EXECUTE 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] switch_core_state_machine.c:539 (sofia/internal/anonymous@192.168.199.22) State EXECUTE 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] mod_sofia.c:196 sofia/internal/anonymous@192.168.199.22 SOFIA EXECUTE 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] switch_core_state_machine.c:258 sofia/internal/anonymous@192.168.199.22 Standard EXECUTE 1709c7c4-fa17-11e5-9184-9d31ebce310e EXECUTE sofia/internal/anonymous@192.168.199.22 set(open=true) 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [DEBUG] mod_dptools.c:1498 SET sofia/internal/anonymous@192.168.199.22 [open]=[true] 1709c7c4-fa17-11e5-9184-9d31ebce310e EXECUTE sofia/internal/anonymous@192.168.199.22 log(CRIT WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING ) 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [CRIT] mod_dptools.c:1692 WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING 1709c7c4-fa17-11e5-9184-9d31ebce310e EXECUTE sofia/internal/anonymous@192.168.199.22 log(CRIT Open /usr/local/freeswitch/conf/vars.xml and change the default_password.) 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [CRIT] mod_dptools.c:1692 Open /usr/local/freeswitch/conf/vars.xml and change the default_password. 1709c7c4-fa17-11e5-9184-9d31ebce310e EXECUTE sofia/internal/anonymous@192.168.199.22 log(CRIT Once changed type reloadxml at the console.) 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [CRIT] mod_dptools.c:1692 Once changed type reloadxml at the console. 1709c7c4-fa17-11e5-9184-9d31ebce310e EXECUTE sofia/internal/anonymous@192.168.199.22 log(CRIT WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING ) 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:18.271147 [CRIT] mod_dptools.c:1692 WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING WARNING 1709c7c4-fa17-11e5-9184-9d31ebce310e EXECUTE sofia/internal/anonymous@192.168.199.22 sleep(10000) 1709c7c4-fa17-11e5-9184-9d31ebce310e EXECUTE sofia/internal/anonymous@192.168.199.22 hash(insert/192.168.199.22-spymap/anonymous/1709c7c4-fa17-11e5-9184-9d31ebce310e) 1709c7c4-fa17-11e5-9184-9d31ebce310e EXECUTE sofia/internal/anonymous@192.168.199.22 hash(insert/192.168.199.22-last_dial/anonymous/1010) 1709c7c4-fa17-11e5-9184-9d31ebce310e EXECUTE sofia/internal/anonymous@192.168.199.22 hash(insert/192.168.199.22-last_dial/global/1709c7c4-fa17-11e5-9184-9d31ebce310e) 1709c7c4-fa17-11e5-9184-9d31ebce310e EXECUTE sofia/internal/anonymous@192.168.199.22 export(RFC2822_DATE=Mon, 04 Apr 2016 11:41:28 +0800) 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.431159 [DEBUG] switch_channel.c:1283 EXPORT (export_vars) [RFC2822_DATE]=[Mon, 04 Apr 2016 11:41:28 +0800] 1709c7c4-fa17-11e5-9184-9d31ebce310e EXECUTE sofia/internal/anonymous@192.168.199.22 export(dialed_extension=1010) 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.431159 [DEBUG] switch_channel.c:1283 EXPORT (export_vars) [dialed_extension]=[1010] 1709c7c4-fa17-11e5-9184-9d31ebce310e EXECUTE sofia/internal/anonymous@192.168.199.22 bind_meta_app(1 b s execute_extension::dx XML features) 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.451191 [INFO] switch_ivr_async.c:4142 Bound B-Leg: *1 execute_extension::dx XML features 1709c7c4-fa17-11e5-9184-9d31ebce310e EXECUTE sofia/internal/anonymous@192.168.199.22 bind_meta_app(2 b s record_session::/usr/local/freeswitch/recordings/anonymous.2016-04-04-11-41-28.wav) 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.451191 [INFO] switch_ivr_async.c:4142 Bound B-Leg: *2 record_session::/usr/local/freeswitch/recordings/anonymous.2016-04-04-11-41-28.wav 1709c7c4-fa17-11e5-9184-9d31ebce310e EXECUTE sofia/internal/anonymous@192.168.199.22 bind_meta_app(3 b s execute_extension::cf XML features) 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.451191 [INFO] switch_ivr_async.c:4142 Bound B-Leg: *3 execute_extension::cf XML features 1709c7c4-fa17-11e5-9184-9d31ebce310e EXECUTE sofia/internal/anonymous@192.168.199.22 bind_meta_app(4 b s execute_extension::att_xfer XML features) 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.451191 [INFO] switch_ivr_async.c:4142 Bound B-Leg: *4 execute_extension::att_xfer XML features 1709c7c4-fa17-11e5-9184-9d31ebce310e EXECUTE sofia/internal/anonymous@192.168.199.22 set(ringback=%(2000,4000,440,480)) 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.471064 [DEBUG] mod_dptools.c:1498 SET sofia/internal/anonymous@192.168.199.22 [ringback]=[%(2000,4000,440,480)] 1709c7c4-fa17-11e5-9184-9d31ebce310e EXECUTE sofia/internal/anonymous@192.168.199.22 set(transfer_ringback=local_stream://moh) 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.471064 [DEBUG] mod_dptools.c:1498 SET sofia/internal/anonymous@192.168.199.22 [transfer_ringback]=[local_stream://moh] 1709c7c4-fa17-11e5-9184-9d31ebce310e EXECUTE sofia/internal/anonymous@192.168.199.22 set(call_timeout=30) 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.471064 [DEBUG] mod_dptools.c:1498 SET sofia/internal/anonymous@192.168.199.22 [call_timeout]=[30] 1709c7c4-fa17-11e5-9184-9d31ebce310e EXECUTE sofia/internal/anonymous@192.168.199.22 set(hangup_after_bridge=true) 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.471064 [DEBUG] mod_dptools.c:1498 SET sofia/internal/anonymous@192.168.199.22 [hangup_after_bridge]=[true] 1709c7c4-fa17-11e5-9184-9d31ebce310e EXECUTE sofia/internal/anonymous@192.168.199.22 set(continue_on_fail=true) 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.471064 [DEBUG] mod_dptools.c:1498 SET sofia/internal/anonymous@192.168.199.22 [continue_on_fail]=[true] 1709c7c4-fa17-11e5-9184-9d31ebce310e EXECUTE sofia/internal/anonymous@192.168.199.22 hash(insert/192.168.199.22-call_return/1010/anonymous) 1709c7c4-fa17-11e5-9184-9d31ebce310e EXECUTE sofia/internal/anonymous@192.168.199.22 hash(insert/192.168.199.22-last_dial_ext/1010/1709c7c4-fa17-11e5-9184-9d31ebce310e) 1709c7c4-fa17-11e5-9184-9d31ebce310e EXECUTE sofia/internal/anonymous@192.168.199.22 set(called_party_callgroup=techsupport) 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.471064 [DEBUG] mod_dptools.c:1498 SET sofia/internal/anonymous@192.168.199.22 [called_party_callgroup]=[techsupport] 1709c7c4-fa17-11e5-9184-9d31ebce310e EXECUTE sofia/internal/anonymous@192.168.199.22 hash(insert/192.168.199.22-last_dial_ext/techsupport/1709c7c4-fa17-11e5-9184-9d31ebce310e) 1709c7c4-fa17-11e5-9184-9d31ebce310e EXECUTE sofia/internal/anonymous@192.168.199.22 hash(insert/192.168.199.22-last_dial_ext/global/1709c7c4-fa17-11e5-9184-9d31ebce310e) 1709c7c4-fa17-11e5-9184-9d31ebce310e EXECUTE sofia/internal/anonymous@192.168.199.22 hash(insert/192.168.199.22-last_dial/techsupport/1709c7c4-fa17-11e5-9184-9d31ebce310e) 1709c7c4-fa17-11e5-9184-9d31ebce310e EXECUTE sofia/internal/anonymous@192.168.199.22 bridge(user/1010@192.168.199.22) 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.471064 [DEBUG] switch_channel.c:1237 sofia/internal/anonymous@192.168.199.22 EXPORTING[export_vars] [RFC2822_DATE]=[Mon, 04 Apr 2016 11:41:28 +0800] to event 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.471064 [DEBUG] switch_channel.c:1237 sofia/internal/anonymous@192.168.199.22 EXPORTING[export_vars] [RFC2822_DATE]=[Mon, 04 Apr 2016 11:41:28 +0800] to event 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.471064 [DEBUG] switch_channel.c:1237 sofia/internal/anonymous@192.168.199.22 EXPORTING[export_vars] [dialed_extension]=[1010] to event 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.471064 [DEBUG] switch_ivr_originate.c:2127 Parsing global variables 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.471064 [DEBUG] switch_channel.c:1237 sofia/internal/anonymous@192.168.199.22 EXPORTING[export_vars] [RFC2822_DATE]=[Mon, 04 Apr 2016 11:41:28 +0800] to event 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.471064 [DEBUG] switch_channel.c:1237 sofia/internal/anonymous@192.168.199.22 EXPORTING[export_vars] [RFC2822_DATE]=[Mon, 04 Apr 2016 11:41:28 +0800] to event 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.471064 [DEBUG] switch_channel.c:1237 sofia/internal/anonymous@192.168.199.22 EXPORTING[export_vars] [dialed_extension]=[1010] to event 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.471064 [DEBUG] switch_ivr_originate.c:2127 Parsing global variables 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.471064 [NOTICE] switch_channel.c:1091 New Channel sofia/internal/5shm6jpu@tibvb7p7p6od.invalid [1d260ca8-fa17-11e5-91a9-9d31ebce310e] 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.471064 [DEBUG] mod_sofia.c:4765 (sofia/internal/5shm6jpu@tibvb7p7p6od.invalid) State Change CS_NEW -> CS_INIT 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.471064 [NOTICE] switch_ivr_originate.c:2762 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED] 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.471064 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/5shm6jpu@tibvb7p7p6od.invalid) Running State Change CS_INIT 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.471064 [DEBUG] switch_core_state_machine.c:516 (sofia/internal/5shm6jpu@tibvb7p7p6od.invalid) State INIT 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.471064 [DEBUG] mod_sofia.c:88 sofia/internal/5shm6jpu@tibvb7p7p6od.invalid SOFIA INIT 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.491143 [DEBUG] sofia_glue.c:1228 sip:5shm6jpu@192.168.199.216:1106;transport=wss Setting proxy route to sofia/internal/5shm6jpu@tibvb7p7p6od.invalid 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.491143 [DEBUG] sofia_glue.c:1257 sofia/internal/5shm6jpu@tibvb7p7p6od.invalid sending invite version: 1.6.5 64bit 1d260ca8-fa17-11e5-91a9-9d31ebce310e Local SDP: 1d260ca8-fa17-11e5-91a9-9d31ebce310e v=0 1d260ca8-fa17-11e5-91a9-9d31ebce310e o=FreeSWITCH 1459715932 1459715933 IN IP4 192.168.199.22 1d260ca8-fa17-11e5-91a9-9d31ebce310e s=FreeSWITCH 1d260ca8-fa17-11e5-91a9-9d31ebce310e c=IN IP4 192.168.199.22 1d260ca8-fa17-11e5-91a9-9d31ebce310e t=0 0 1d260ca8-fa17-11e5-91a9-9d31ebce310e a=msid-semantic: WMS V1fI34R2wy02H1TiwvkVnMYDkt0mDXzp 1d260ca8-fa17-11e5-91a9-9d31ebce310e m=audio 25356 RTP/SAVPF 111 8 102 101 1d260ca8-fa17-11e5-91a9-9d31ebce310e a=rtpmap:111 opus/48000/2 1d260ca8-fa17-11e5-91a9-9d31ebce310e a=fmtp:111 minptime=10; useinbandfec=1 1d260ca8-fa17-11e5-91a9-9d31ebce310e a=rtpmap:8 PCMA/8000 1d260ca8-fa17-11e5-91a9-9d31ebce310e a=rtpmap:102 telephone-event/48000 1d260ca8-fa17-11e5-91a9-9d31ebce310e a=rtpmap:101 telephone-event/8000 1d260ca8-fa17-11e5-91a9-9d31ebce310e a=fingerprint:sha-256 E7:50:3F:56:DE:21:E5:17:DA:F7:3A:3F:28:F8:BC:2A:C6:E7:E0:67:5C:6C:61:39:00:6D:99:DE:A4:A2:8A:80 1d260ca8-fa17-11e5-91a9-9d31ebce310e a=setup:actpass 1d260ca8-fa17-11e5-91a9-9d31ebce310e a=rtcp-mux 1d260ca8-fa17-11e5-91a9-9d31ebce310e a=rtcp:25356 IN IP4 192.168.199.22 1d260ca8-fa17-11e5-91a9-9d31ebce310e a=ssrc:2533704824 cname:OFXIzFBV4sOBkyJG 1d260ca8-fa17-11e5-91a9-9d31ebce310e a=ssrc:2533704824 msid:V1fI34R2wy02H1TiwvkVnMYDkt0mDXzp a0 1d260ca8-fa17-11e5-91a9-9d31ebce310e a=ssrc:2533704824 mslabel:V1fI34R2wy02H1TiwvkVnMYDkt0mDXzp 1d260ca8-fa17-11e5-91a9-9d31ebce310e a=ssrc:2533704824 label:V1fI34R2wy02H1TiwvkVnMYDkt0mDXzpa0 1d260ca8-fa17-11e5-91a9-9d31ebce310e a=ice-ufrag:UUr7xgAHzqT3ejiT 1d260ca8-fa17-11e5-91a9-9d31ebce310e a=ice-pwd:O6reBS0vbEXl3xRNh8KFfbcE 1d260ca8-fa17-11e5-91a9-9d31ebce310e a=candidate:6905210039 1 udp 659136 192.168.199.22 25356 typ host generation 0 1d260ca8-fa17-11e5-91a9-9d31ebce310e a=candidate:6905210039 2 udp 659136 192.168.199.22 25356 typ host generation 0 1d260ca8-fa17-11e5-91a9-9d31ebce310e a=ptime:20 1d260ca8-fa17-11e5-91a9-9d31ebce310e a=sendrecv 1d260ca8-fa17-11e5-91a9-9d31ebce310e 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.491143 [DEBUG] switch_core_state_machine.c:40 sofia/internal/5shm6jpu@tibvb7p7p6od.invalid Standard INIT 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.491143 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/5shm6jpu@tibvb7p7p6od.invalid) State Change CS_INIT -> CS_ROUTING 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.491143 [DEBUG] switch_core_state_machine.c:516 (sofia/internal/5shm6jpu@tibvb7p7p6od.invalid) State INIT going to sleep 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.491143 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/5shm6jpu@tibvb7p7p6od.invalid) Running State Change CS_ROUTING 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.491143 [DEBUG] switch_core_state_machine.c:532 (sofia/internal/5shm6jpu@tibvb7p7p6od.invalid) State ROUTING 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.491143 [DEBUG] mod_sofia.c:141 sofia/internal/5shm6jpu@tibvb7p7p6od.invalid SOFIA ROUTING 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.491143 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/5shm6jpu@tibvb7p7p6od.invalid) State Change CS_ROUTING -> CS_CONSUME_MEDIA 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.491143 [DEBUG] switch_core_state_machine.c:532 (sofia/internal/5shm6jpu@tibvb7p7p6od.invalid) State ROUTING going to sleep 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.491143 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/5shm6jpu@tibvb7p7p6od.invalid) Running State Change CS_CONSUME_MEDIA 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.491143 [DEBUG] sofia.c:6750 Channel sofia/internal/5shm6jpu@tibvb7p7p6od.invalid entering state [calling][0] 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.491143 [DEBUG] switch_core_state_machine.c:551 (sofia/internal/5shm6jpu@tibvb7p7p6od.invalid) State CONSUME_MEDIA 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.491143 [DEBUG] switch_core_state_machine.c:551 (sofia/internal/5shm6jpu@tibvb7p7p6od.invalid) State CONSUME_MEDIA going to sleep 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.771176 [DEBUG] sofia.c:6750 Channel sofia/internal/5shm6jpu@tibvb7p7p6od.invalid entering state [proceeding][180] 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.771176 [NOTICE] sofia.c:6852 Ring-Ready sofia/internal/5shm6jpu@tibvb7p7p6od.invalid! 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.771176 [DEBUG] switch_channel.c:3332 (sofia/internal/5shm6jpu@tibvb7p7p6od.invalid) Callstate Change DOWN -> RINGING 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.791219 [INFO] switch_ivr_originate.c:1216 Sending early media 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.791219 [DEBUG] switch_core_media.c:4153 Audio Codec Compare [opus:111:48000:60:0:1]/[opus:116:48000:20:0:1] 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.791219 [DEBUG] switch_core_media.c:4208 Audio Codec Compare [opus:116:48000:20:0:1] ++++ is saved as a match 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.791219 [DEBUG] switch_core_media.c:4153 Audio Codec Compare [opus:111:48000:60:0:1]/[PCMA:8:8000:20:64000:1] 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.791219 [DEBUG] switch_core_media.c:4153 Audio Codec Compare [ISAC:103:16000:30:32000:1]/[opus:116:48000:20:0:1] 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.791219 [DEBUG] switch_core_media.c:4153 Audio Codec Compare [ISAC:103:16000:30:32000:1]/[PCMA:8:8000:20:64000:1] 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.791219 [DEBUG] switch_core_media.c:4153 Audio Codec Compare [ISAC:104:32000:30:32000:1]/[opus:116:48000:20:0:1] 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.791219 [DEBUG] switch_core_media.c:4153 Audio Codec Compare [ISAC:104:32000:30:32000:1]/[PCMA:8:8000:20:64000:1] 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.791219 [DEBUG] switch_core_media.c:4153 Audio Codec Compare [G722:9:8000:60:64000:1]/[opus:116:48000:20:0:1] 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.791219 [DEBUG] switch_core_media.c:4153 Audio Codec Compare [G722:9:8000:60:64000:1]/[PCMA:8:8000:20:64000:1] 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.791219 [DEBUG] switch_core_media.c:4153 Audio Codec Compare [PCMU:0:8000:60:64000:1]/[opus:116:48000:20:0:1] 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.791219 [DEBUG] switch_core_media.c:4153 Audio Codec Compare [PCMU:0:8000:60:64000:1]/[PCMA:8:8000:20:64000:1] 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.791219 [DEBUG] switch_core_media.c:4153 Audio Codec Compare [PCMA:8:8000:60:64000:1]/[opus:116:48000:20:0:1] 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.791219 [DEBUG] switch_core_media.c:4153 Audio Codec Compare [PCMA:8:8000:60:64000:1]/[PCMA:8:8000:20:64000:1] 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.791219 [DEBUG] switch_core_media.c:4208 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.791219 [DEBUG] switch_core_media.c:4153 Audio Codec Compare [CN:105:16000:60:0:1]/[opus:116:48000:20:0:1] 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.791219 [DEBUG] switch_core_media.c:4153 Audio Codec Compare [CN:105:16000:60:0:1]/[PCMA:8:8000:20:64000:1] 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.791219 [DEBUG] switch_core_media.c:4153 Audio Codec Compare [CN:13:8000:60:0:1]/[opus:116:48000:20:0:1] 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.791219 [DEBUG] switch_core_media.c:4153 Audio Codec Compare [CN:13:8000:60:0:1]/[PCMA:8:8000:20:64000:1] 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.791219 [DEBUG] switch_core_media.c:4069 Set telephone-event payload to 126@8000 2016-04-04 11:41:28.831214 [DEBUG] mod_opus.c:559 Opus encoder: set bitrate to local settings [72000bps] 2016-04-04 11:41:28.831214 [DEBUG] mod_opus.c:559 Opus encoder: set bitrate to local settings [72000bps] 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_media.c:2898 Set Codec sofia/internal/anonymous@192.168.199.22 opus/48000 20 ms 960 samples 0 bits 1 channels 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_codec.c:111 sofia/internal/anonymous@192.168.199.22 Original read codec set to opus:116 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [WARNING] switch_core_media.c:3266 NO candidate ACL defined, Defaulting to wan.auto 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_media.c:3296 Save audio Candidate cid: 1 proto: udp type: host addr: 192.168.199.216:1107 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_media.c:3296 Save audio Candidate cid: 1 proto: udp type: host addr: 10.20.102.216:1108 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_media.c:3296 Save audio Candidate cid: 1 proto: udp type: host addr: 10.10.13.216:1109 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_media.c:3296 Save audio Candidate cid: 2 proto: udp type: host addr: 192.168.199.216:1110 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_media.c:3296 Save audio Candidate cid: 2 proto: udp type: host addr: 10.20.102.216:1111 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_media.c:3296 Save audio Candidate cid: 2 proto: udp type: host addr: 10.10.13.216:1112 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_media.c:3336 Searching for rtp candidate. 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_media.c:3336 Searching for rtcp candidate. 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_media.c:3380 sofia/internal/anonymous@192.168.199.22 no suitable candidates found. 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_media.c:4473 sofia/internal/anonymous@192.168.199.22 Set 2833 dtmf send payload to 126 recv payload to 126 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [ERR] mod_sofia.c:2299 CODEC NEGOTIATION ERROR. SDP: 1709c7c4-fa17-11e5-9184-9d31ebce310e v=0 1709c7c4-fa17-11e5-9184-9d31ebce310e o=- 2269318439683772682 2 IN IP4 127.0.0.1 1709c7c4-fa17-11e5-9184-9d31ebce310e s=- 1709c7c4-fa17-11e5-9184-9d31ebce310e t=0 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=group:BUNDLE audio 1709c7c4-fa17-11e5-9184-9d31ebce310e a=msid-semantic: WMS rYj84RRd3TzyYFyEBpKbVkBuRetSSmtrlY3o 1709c7c4-fa17-11e5-9184-9d31ebce310e m=audio 1107 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 126 1709c7c4-fa17-11e5-9184-9d31ebce310e c=IN IP4 192.168.199.216 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtpmap:111 opus/48000/2 1709c7c4-fa17-11e5-9184-9d31ebce310e a=fmtp:111 minptime=10; useinbandfec=1 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtpmap:103 ISAC/16000 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtpmap:104 ISAC/32000 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtpmap:9 G722/8000 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtpmap:0 PCMU/8000 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtpmap:8 PCMA/8000 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtpmap:106 CN/32000 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtpmap:105 CN/16000 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtpmap:13 CN/8000 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtpmap:126 telephone-event/8000 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtcp:1110 IN IP4 192.168.199.216 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:2985945573 1 udp 2122260223 192.168.199.216 1107 typ host generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:2696558014 1 udp 2122194687 10.20.102.216 1108 typ host generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:1936642402 1 udp 2122129151 10.10.13.216 1109 typ host generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:2985945573 2 udp 2122260222 192.168.199.216 1110 typ host generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:2696558014 2 udp 2122194686 10.20.102.216 1111 typ host generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:1936642402 2 udp 2122129150 10.10.13.216 1112 typ host generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:4286190869 1 tcp 1518280447 192.168.199.216 0 typ host tcptype active generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:3996764494 1 tcp 1518214911 10.20.102.216 0 typ host tcptype active generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:1038953874 1 tcp 1518149375 10.10.13.216 0 typ host tcptype active generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:4286190869 2 tcp 1518280446 192.168.199.216 0 typ host tcptype active generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:3996764494 2 tcp 1518214910 10.20.102.216 0 typ host tcptype active generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=candidate:1038953874 2 tcp 1518149374 10.10.13.216 0 typ host tcptype active generation 0 1709c7c4-fa17-11e5-9184-9d31ebce310e a=ice-ufrag:4PWOC8zOrgkF0JcH 1709c7c4-fa17-11e5-9184-9d31ebce310e a=ice-pwd:KoIliPYZgGkk+b6K7bJDPVLK 1709c7c4-fa17-11e5-9184-9d31ebce310e a=fingerprint:sha-256 18:9D:FC:F1:74:38:63:AE:F1:F8:F0:26:F5:83:A8:41:97:53:67:F5:35:FB:7E:F3:06:BF:D5:71:FD:A2:F6:38 1709c7c4-fa17-11e5-9184-9d31ebce310e a=setup:actpass 1709c7c4-fa17-11e5-9184-9d31ebce310e a=mid:audio 1709c7c4-fa17-11e5-9184-9d31ebce310e a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level 1709c7c4-fa17-11e5-9184-9d31ebce310e a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time 1709c7c4-fa17-11e5-9184-9d31ebce310e a=rtcp-mux 1709c7c4-fa17-11e5-9184-9d31ebce310e a=maxptime:60 1709c7c4-fa17-11e5-9184-9d31ebce310e a=ssrc:1463663134 cname:mrCkzHA0WH9Dd+8n 1709c7c4-fa17-11e5-9184-9d31ebce310e a=ssrc:1463663134 msid:rYj84RRd3TzyYFyEBpKbVkBuRetSSmtrlY3o 62a659a4-ef68-469a-871c-0e61ef3dd211 1709c7c4-fa17-11e5-9184-9d31ebce310e a=ssrc:1463663134 mslabel:rYj84RRd3TzyYFyEBpKbVkBuRetSSmtrlY3o 1709c7c4-fa17-11e5-9184-9d31ebce310e a=ssrc:1463663134 label:62a659a4-ef68-469a-871c-0e61ef3dd211 1709c7c4-fa17-11e5-9184-9d31ebce310e 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [NOTICE] switch_channel.c:3501 Hangup sofia/internal/anonymous@192.168.199.22 [CS_EXECUTE] [INCOMPATIBLE_DESTINATION] 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_ivr_originate.c:1217 sofia/internal/anonymous@192.168.199.22 Media Establishment Failed. 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_ivr_originate.c:3750 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED] 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.831214 [NOTICE] switch_ivr_originate.c:3840 Hangup sofia/internal/5shm6jpu@tibvb7p7p6od.invalid [CS_CONSUME_MEDIA] [USER_NOT_REGISTERED] 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/5shm6jpu@tibvb7p7p6od.invalid) Running State Change CS_HANGUP 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_state_machine.c:739 (sofia/internal/5shm6jpu@tibvb7p7p6od.invalid) Callstate Change RINGING -> HANGUP 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [NOTICE] switch_ivr_originate.c:2762 Cannot create outgoing channel of type [user] cause: [USER_NOT_REGISTERED] 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_ivr_originate.c:3750 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED] 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/5shm6jpu@tibvb7p7p6od.invalid) State HANGUP 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] mod_sofia.c:431 Channel sofia/internal/5shm6jpu@tibvb7p7p6od.invalid hanging up, cause: USER_NOT_REGISTERED 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [INFO] mod_dptools.c:3379 Originate Failed. Cause: USER_NOT_REGISTERED 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_session.c:2796 sofia/internal/anonymous@192.168.199.22 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already) 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_state_machine.c:539 (sofia/internal/anonymous@192.168.199.22) State EXECUTE going to sleep 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/anonymous@192.168.199.22) Running State Change CS_HANGUP 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_state_machine.c:739 (sofia/internal/anonymous@192.168.199.22) Callstate Change RINGING -> HANGUP 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/anonymous@192.168.199.22) State HANGUP 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] mod_sofia.c:431 Channel sofia/internal/anonymous@192.168.199.22 hanging up, cause: INCOMPATIBLE_DESTINATION 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] mod_sofia.c:495 Sending CANCEL to sofia/internal/5shm6jpu@tibvb7p7p6od.invalid 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_state_machine.c:60 sofia/internal/5shm6jpu@tibvb7p7p6od.invalid Standard HANGUP, cause: USER_NOT_REGISTERED 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/5shm6jpu@tibvb7p7p6od.invalid) State HANGUP going to sleep 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_state_machine.c:508 (sofia/internal/5shm6jpu@tibvb7p7p6od.invalid) State Change CS_HANGUP -> CS_REPORTING 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] mod_sofia.c:568 Responding to INVITE with: 488 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_state_machine.c:60 sofia/internal/anonymous@192.168.199.22 Standard HANGUP, cause: INCOMPATIBLE_DESTINATION 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/anonymous@192.168.199.22) State HANGUP going to sleep 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_state_machine.c:508 (sofia/internal/anonymous@192.168.199.22) State Change CS_HANGUP -> CS_REPORTING 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/anonymous@192.168.199.22) Running State Change CS_REPORTING 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/5shm6jpu@tibvb7p7p6od.invalid) Running State Change CS_REPORTING 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_state_machine.c:827 (sofia/internal/5shm6jpu@tibvb7p7p6od.invalid) State REPORTING 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_state_machine.c:104 sofia/internal/5shm6jpu@tibvb7p7p6od.invalid Standard REPORTING, cause: USER_NOT_REGISTERED 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_state_machine.c:827 (sofia/internal/5shm6jpu@tibvb7p7p6od.invalid) State REPORTING going to sleep 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_state_machine.c:499 (sofia/internal/5shm6jpu@tibvb7p7p6od.invalid) State Change CS_REPORTING -> CS_DESTROY 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_session.c:1646 Session 2 (sofia/internal/5shm6jpu@tibvb7p7p6od.invalid) Locked, Waiting on external entities 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.831214 [NOTICE] switch_core_session.c:1664 Session 2 (sofia/internal/5shm6jpu@tibvb7p7p6od.invalid) Ended 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.831214 [NOTICE] switch_core_session.c:1668 Close Channel sofia/internal/5shm6jpu@tibvb7p7p6od.invalid [CS_DESTROY] 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_state_machine.c:630 (sofia/internal/5shm6jpu@tibvb7p7p6od.invalid) Running State Change CS_DESTROY 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_state_machine.c:640 (sofia/internal/5shm6jpu@tibvb7p7p6od.invalid) State DESTROY 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] mod_sofia.c:341 sofia/internal/5shm6jpu@tibvb7p7p6od.invalid SOFIA DESTROY 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_state_machine.c:111 sofia/internal/5shm6jpu@tibvb7p7p6od.invalid Standard DESTROY 1d260ca8-fa17-11e5-91a9-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_state_machine.c:640 (sofia/internal/5shm6jpu@tibvb7p7p6od.invalid) State DESTROY going to sleep 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.831214 [DEBUG] switch_core_state_machine.c:827 (sofia/internal/anonymous@192.168.199.22) State REPORTING 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.891192 [DEBUG] switch_core_state_machine.c:104 sofia/internal/anonymous@192.168.199.22 Standard REPORTING, cause: INCOMPATIBLE_DESTINATION 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.891192 [DEBUG] switch_core_state_machine.c:827 (sofia/internal/anonymous@192.168.199.22) State REPORTING going to sleep 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.891192 [DEBUG] switch_core_state_machine.c:499 (sofia/internal/anonymous@192.168.199.22) State Change CS_REPORTING -> CS_DESTROY 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.891192 [DEBUG] switch_core_session.c:1646 Session 1 (sofia/internal/anonymous@192.168.199.22) Locked, Waiting on external entities 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.891192 [NOTICE] switch_core_session.c:1664 Session 1 (sofia/internal/anonymous@192.168.199.22) Ended 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.891192 [NOTICE] switch_core_session.c:1668 Close Channel sofia/internal/anonymous@192.168.199.22 [CS_DESTROY] 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.891192 [DEBUG] switch_core_state_machine.c:630 (sofia/internal/anonymous@192.168.199.22) Running State Change CS_DESTROY 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.891192 [DEBUG] switch_core_state_machine.c:640 (sofia/internal/anonymous@192.168.199.22) State DESTROY 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.891192 [DEBUG] mod_sofia.c:341 sofia/internal/anonymous@192.168.199.22 SOFIA DESTROY 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.891192 [DEBUG] mod_opus.c:661 Opus decoder stats: Frames[0] PLC[0] FEC[0] 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.891192 [DEBUG] mod_opus.c:661 Opus decoder stats: Frames[0] PLC[0] FEC[0] 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.891192 [DEBUG] switch_core_state_machine.c:111 sofia/internal/anonymous@192.168.199.22 Standard DESTROY 1709c7c4-fa17-11e5-9184-9d31ebce310e 2016-04-04 11:41:28.891192 [DEBUG] switch_core_state_machine.c:640 (sofia/internal/anonymous@192.168.199.22) State DESTROY going to sleep