[Freeswitch-users] Problev with Video call and H264 codec

21 Oct 2015

      Hi All,

I have a problem with calls using h264 codec. 
mod_av is compiled and stored in the system. mod_vpx and mod_h26x IS NOT loaded. Adding "H264" in "global_codec_prefs" and "outbound_codec_prefs" in my vars.xml
for calls using jssip. 
In dialplan i have <action application="export" data="nolocal:absolute_codec_string=OPUS,H264"/>

But when I try to make a call, I get an error "INCOMPATIBLE_DESTINATION"

What am I doing wrong?

Debian 8.
FreeSWITCH Version 1.7.0+git~20151015T200018Z~c7d5d49ff6~64bit (git c7d5d49 2015-10-15 20:00:18Z 64bit)

FreeSWITCH Started
Max Sessions [1000]
Session Rate [30]
SQL [Enabled]
2015-10-21 10:36:25.127418 [DEBUG] sofia_reg.c:1756 Send challenge for [1004@sip1.applicloud.com]
2015-10-21 10:36:25.347419 [DEBUG] sofia_reg.c:3139 event_add_header -> 'record_stereo' = 'true'
2015-10-21 10:36:25.347419 [DEBUG] sofia_reg.c:3139 event_add_header -> 'default_gateway' = 'example.com'
2015-10-21 10:36:25.347419 [DEBUG] sofia_reg.c:3139 event_add_header -> 'default_areacode' = '918'
2015-10-21 10:36:25.347419 [DEBUG] sofia_reg.c:3139 event_add_header -> 'transfer_fallback_extension' = 'operator'
2015-10-21 10:36:25.347419 [DEBUG] sofia_reg.c:3139 event_add_header -> 'toll_allow' = 'domestic,international,local'
2015-10-21 10:36:25.347419 [DEBUG] sofia_reg.c:3139 event_add_header -> 'accountcode' = '1004'
2015-10-21 10:36:25.347419 [DEBUG] sofia_reg.c:3139 event_add_header -> 'user_context' = 'centos'
2015-10-21 10:36:25.347419 [DEBUG] sofia_reg.c:3139 event_add_header -> 'effective_caller_id_name' = 'Extension 1004'
2015-10-21 10:36:25.347419 [DEBUG] sofia_reg.c:3139 event_add_header -> 'effective_caller_id_number' = '1004'
2015-10-21 10:36:25.347419 [DEBUG] sofia_reg.c:3139 event_add_header -> 'outbound_caller_id_name' = 'FreeSWITCH'
2015-10-21 10:36:25.347419 [DEBUG] sofia_reg.c:3139 event_add_header -> 'outbound_caller_id_number' = '0000000000'
2015-10-21 10:36:25.347419 [DEBUG] sofia_reg.c:3139 event_add_header -> 'callgroup' = 'techsupport'
2015-10-21 10:36:30.307419 [DEBUG] sofia_reg.c:3139 event_add_header -> 'record_stereo' = 'true'
2015-10-21 10:36:30.307419 [DEBUG] sofia_reg.c:3139 event_add_header -> 'default_gateway' = 'example.com'
2015-10-21 10:36:30.307419 [DEBUG] sofia_reg.c:3139 event_add_header -> 'default_areacode' = '918'
2015-10-21 10:36:30.307419 [DEBUG] sofia_reg.c:3139 event_add_header -> 'transfer_fallback_extension' = 'operator'
2015-10-21 10:36:30.307419 [DEBUG] sofia_reg.c:3139 event_add_header -> 'toll_allow' = 'domestic,international,local'
2015-10-21 10:36:30.307419 [DEBUG] sofia_reg.c:3139 event_add_header -> 'accountcode' = '1003'
2015-10-21 10:36:30.307419 [DEBUG] sofia_reg.c:3139 event_add_header -> 'user_context' = 'default'
2015-10-21 10:36:30.307419 [DEBUG] sofia_reg.c:3139 event_add_header -> 'effective_caller_id_name' = 'Extension 1003'
2015-10-21 10:36:30.307419 [DEBUG] sofia_reg.c:3139 event_add_header -> 'effective_caller_id_number' = '1003'
2015-10-21 10:36:30.307419 [DEBUG] sofia_reg.c:3139 event_add_header -> 'outbound_caller_id_name' = 'FreeSWITCH'
2015-10-21 10:36:30.307419 [DEBUG] sofia_reg.c:3139 event_add_header -> 'outbound_caller_id_number' = '0000000000'
2015-10-21 10:36:30.307419 [DEBUG] sofia_reg.c:3139 event_add_header -> 'callgroup' = 'techsupport'
2015-10-21 10:37:29.267418 [DEBUG] sofia_reg.c:3139 event_add_header -> 'record_stereo' = 'true'
2015-10-21 10:37:29.267418 [DEBUG] sofia_reg.c:3139 event_add_header -> 'default_gateway' = 'example.com'
2015-10-21 10:37:29.267418 [DEBUG] sofia_reg.c:3139 event_add_header -> 'default_areacode' = '918'
2015-10-21 10:37:29.267418 [DEBUG] sofia_reg.c:3139 event_add_header -> 'transfer_fallback_extension' = 'operator'
2015-10-21 10:37:29.267418 [DEBUG] sofia_reg.c:3139 event_add_header -> 'toll_allow' = 'domestic,international,local'
2015-10-21 10:37:29.267418 [DEBUG] sofia_reg.c:3139 event_add_header -> 'accountcode' = '1004'
2015-10-21 10:37:29.267418 [DEBUG] sofia_reg.c:3139 event_add_header -> 'user_context' = 'centos'
2015-10-21 10:37:29.267418 [DEBUG] sofia_reg.c:3139 event_add_header -> 'effective_caller_id_name' = 'Extension 1004'
2015-10-21 10:37:29.267418 [DEBUG] sofia_reg.c:3139 event_add_header -> 'effective_caller_id_number' = '1004'
2015-10-21 10:37:29.267418 [DEBUG] sofia_reg.c:3139 event_add_header -> 'outbound_caller_id_name' = 'FreeSWITCH'
2015-10-21 10:37:29.267418 [DEBUG] sofia_reg.c:3139 event_add_header -> 'outbound_caller_id_number' = '0000000000'
2015-10-21 10:37:29.267418 [DEBUG] sofia_reg.c:3139 event_add_header -> 'callgroup' = 'techsupport'
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.267418 [DEBUG] sofia.c:10538 Setting NAT mode based on websockets
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.267418 [DEBUG] sofia.c:6750 Channel sofia/internal/1004@sip1.applicloud.com entering state [received][100]
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.267418 [DEBUG] sofia.c:6760 Remote SDP:
8ddd4064-6865-450e-95e3-cf868f9fffc2 v=0
8ddd4064-6865-450e-95e3-cf868f9fffc2 o=- 5885306416843972466 2 IN IP4 127.0.0.1
8ddd4064-6865-450e-95e3-cf868f9fffc2 s=-
8ddd4064-6865-450e-95e3-cf868f9fffc2 t=0 0
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=group:BUNDLE audio video
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=msid-semantic: WMS ERtTjd8zxf0evjMnlmvlKeMGMkaYlBTEqsoD
8ddd4064-6865-450e-95e3-cf868f9fffc2 m=audio 55127 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 126
8ddd4064-6865-450e-95e3-cf868f9fffc2 c=IN IP4 84.242.71.194
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=rtpmap:111 opus/48000/2
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=fmtp:111 minptime=10; useinbandfec=1
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=rtpmap:103 ISAC/16000
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=rtpmap:104 ISAC/32000
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=rtpmap:9 G722/8000
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=rtpmap:0 PCMU/8000
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=rtpmap:8 PCMA/8000
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=rtpmap:106 CN/32000
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=rtpmap:105 CN/16000
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=rtpmap:13 CN/8000
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=rtpmap:126 telephone-event/8000
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=rtcp:55130 IN IP4 84.242.71.194
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=candidate:1202345197 1 udp 2122260223 192.168.144.1 55125 typ host generation 0
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=candidate:1918330882 1 udp 2122194687 192.168.253.1 55126 typ host generation 0
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=candidate:2367656776 1 udp 2122129151 192.168.0.9 55127 typ host generation 0
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=candidate:1202345197 2 udp 2122260222 192.168.144.1 55128 typ host generation 0
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=candidate:1918330882 2 udp 2122194686 192.168.253.1 55129 typ host generation 0
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=candidate:2367656776 2 udp 2122129150 192.168.0.9 55130 typ host generation 0
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=candidate:608181405 2 udp 1685921534 84.242.71.194 55130 typ srflx raddr 192.168.0.9 rport 55130 generation 0
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=candidate:608181405 1 udp 1685921535 84.242.71.194 55127 typ srflx raddr 192.168.0.9 rport 55127 generation 0
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=candidate:153724957 1 tcp 1518280447 192.168.144.1 0 typ host tcptype active generation 0
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=candidate:1020564722 1 tcp 1518214911 192.168.253.1 0 typ host tcptype active generation 0
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=candidate:3281809336 1 tcp 1518149375 192.168.0.9 0 typ host tcptype active generation 0
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=candidate:153724957 2 tcp 1518280446 192.168.144.1 0 typ host tcptype active generation 0
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=candidate:1020564722 2 tcp 1518214910 192.168.253.1 0 typ host tcptype active generation 0
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=candidate:3281809336 2 tcp 1518149374 192.168.0.9 0 typ host tcptype active generation 0
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=ice-ufrag:QFnZCYR8pC4BNfeE
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=ice-pwd:1Qajnx2LeKy8EDJumNVUq3Vm
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=fingerprint:sha-256 B1:5C:99:B3:63:A6:FE:75:47:C2:27:41:1A:F4:4A:EB:7B:B9:85:F5:15:70:15:DE:77:8B:C0:00:F2:5C:A8:31
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=setup:actpass
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=mid:audio
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=rtcp-mux
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=maxptime:60
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=ssrc:2899339654 cname:FP7H8m/qQIL3yMMG
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=ssrc:2899339654 msid:ERtTjd8zxf0evjMnlmvlKeMGMkaYlBTEqsoD 35307edf-fb0d-4f2d-a4c6-72db590f0474
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=ssrc:2899339654 mslabel:ERtTjd8zxf0evjMnlmvlKeMGMkaYlBTEqsoD
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=ssrc:2899339654 label:35307edf-fb0d-4f2d-a4c6-72db590f0474
8ddd4064-6865-450e-95e3-cf868f9fffc2 m=video 55133 UDP/TLS/RTP/SAVPF 100 116 117 96
8ddd4064-6865-450e-95e3-cf868f9fffc2 c=IN IP4 84.242.71.194
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=rtpmap:100 VP8/90000
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=rtpmap:116 red/90000
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=rtpmap:117 ulpfec/90000
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=rtpmap:96 rtx/90000
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=fmtp:96 apt=100
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=rtcp:55136 IN IP4 84.242.71.194
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=candidate:1202345197 1 udp 2122260223 192.168.144.1 55131 typ host generation 0
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=candidate:1918330882 1 udp 2122194687 192.168.253.1 55132 typ host generation 0
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=candidate:2367656776 1 udp 2122129151 192.168.0.9 55133 typ host generation 0
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=candidate:1202345197 2 udp 2122260222 192.168.144.1 55134 typ host generation 0
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=candidate:1918330882 2 udp 2122194686 192.168.253.1 55135 typ host generation 0
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=candidate:2367656776 2 udp 2122129150 192.168.0.9 55136 typ host generation 0
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=candidate:608181405 1 udp 1685921535 84.242.71.194 55133 typ srflx raddr 192.168.0.9 rport 55133 generation 0
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=candidate:608181405 2 udp 1685921534 84.242.71.194 55136 typ srflx raddr 192.168.0.9 rport 55136 generation 0
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=candidate:153724957 1 tcp 1518280447 192.168.144.1 0 typ host tcptype active generation 0
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=candidate:1020564722 1 tcp 1518214911 192.168.253.1 0 typ host tcptype active generation 0
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=candidate:3281809336 1 tcp 1518149375 192.168.0.9 0 typ host tcptype active generation 0
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=candidate:153724957 2 tcp 1518280446 192.168.144.1 0 typ host tcptype active generation 0
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=candidate:1020564722 2 tcp 1518214910 192.168.253.1 0 typ host tcptype active generation 0
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=candidate:3281809336 2 tcp 1518149374 192.168.0.9 0 typ host tcptype active generation 0
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=ice-ufrag:QFnZCYR8pC4BNfeE
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=ice-pwd:1Qajnx2LeKy8EDJumNVUq3Vm
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=fingerprint:sha-256 B1:5C:99:B3:63:A6:FE:75:47:C2:27:41:1A:F4:4A:EB:7B:B9:85:F5:15:70:15:DE:77:8B:C0:00:F2:5C:A8:31
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=setup:actpass
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=mid:video
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=extmap:2 urn:ietf:params:rtp-hdrext:toffset
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=extmap:4 urn:3gpp:video-orientation
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=rtcp-mux
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=rtcp-fb:100 ccm fir
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=rtcp-fb:100 nack
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=rtcp-fb:100 nack pli
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=rtcp-fb:100 goog-remb
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=ssrc-group:FID 2967339795 4053929853
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=ssrc:2967339795 cname:FP7H8m/qQIL3yMMG
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=ssrc:2967339795 msid:ERtTjd8zxf0evjMnlmvlKeMGMkaYlBTEqsoD 3bb28563-a666-47c0-89d0-27bf9b75333a
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=ssrc:2967339795 mslabel:ERtTjd8zxf0evjMnlmvlKeMGMkaYlBTEqsoD
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=ssrc:2967339795 label:3bb28563-a666-47c0-89d0-27bf9b75333a
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=ssrc:4053929853 cname:FP7H8m/qQIL3yMMG
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=ssrc:4053929853 msid:ERtTjd8zxf0evjMnlmvlKeMGMkaYlBTEqsoD 3bb28563-a666-47c0-89d0-27bf9b75333a
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=ssrc:4053929853 mslabel:ERtTjd8zxf0evjMnlmvlKeMGMkaYlBTEqsoD
8ddd4064-6865-450e-95e3-cf868f9fffc2 a=ssrc:4053929853 label:3bb28563-a666-47c0-89d0-27bf9b75333a
8ddd4064-6865-450e-95e3-cf868f9fffc2 
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.267418 [DEBUG] sofia.c:7115 (sofia/internal/1004@sip1.applicloud.com) State Change CS_NEW -> CS_INIT
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.267418 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/1004@sip1.applicloud.com) Running State Change CS_INIT
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.267418 [DEBUG] switch_core_state_machine.c:516 (sofia/internal/1004@sip1.applicloud.com) State INIT
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.267418 [DEBUG] mod_sofia.c:88 sofia/internal/1004@sip1.applicloud.com SOFIA INIT
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.267418 [DEBUG] switch_core_state_machine.c:40 sofia/internal/1004@sip1.applicloud.com Standard INIT
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.267418 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/1004@sip1.applicloud.com) State Change CS_INIT -> CS_ROUTING
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.267418 [DEBUG] switch_core_state_machine.c:516 (sofia/internal/1004@sip1.applicloud.com) State INIT going to sleep
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.267418 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/1004@sip1.applicloud.com) Running State Change CS_ROUTING
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.267418 [DEBUG] switch_channel.c:2237 (sofia/internal/1004@sip1.applicloud.com) Callstate Change DOWN -> RINGING
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.267418 [DEBUG] switch_core_state_machine.c:532 (sofia/internal/1004@sip1.applicloud.com) State ROUTING
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.267418 [DEBUG] mod_sofia.c:141 sofia/internal/1004@sip1.applicloud.com SOFIA ROUTING
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.267418 [DEBUG] switch_core_state_machine.c:166 sofia/internal/1004@sip1.applicloud.com Standard ROUTING
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.267418 [INFO] mod_dialplan_xml.c:637 Processing 1004 <1004>->6083 in context centos

8ddd4064-6865-450e-95e3-cf868f9fffc2 Dialplan: sofia/internal/1004@sip1.applicloud.com parsing [centos->from-centos] continue=false
8ddd4064-6865-450e-95e3-cf868f9fffc2 Dialplan: sofia/internal/1004@sip1.applicloud.com Regex (FAIL) [from-centos] destination_number(6083) =~ /^(onops)$/ break=on-false
8ddd4064-6865-450e-95e3-cf868f9fffc2 Dialplan: sofia/internal/1004@sip1.applicloud.com parsing [centos->test1] continue=false
8ddd4064-6865-450e-95e3-cf868f9fffc2 Dialplan: sofia/internal/1004@sip1.applicloud.com Regex (FAIL) [test1] destination_number(6083) =~ /^(6080)$/ break=on-false
8ddd4064-6865-450e-95e3-cf868f9fffc2 Dialplan: sofia/internal/1004@sip1.applicloud.com parsing [centos->test2] continue=false
8ddd4064-6865-450e-95e3-cf868f9fffc2 Dialplan: sofia/internal/1004@sip1.applicloud.com Regex (FAIL) [test2] destination_number(6083) =~ /^(6081)$/ break=on-false
8ddd4064-6865-450e-95e3-cf868f9fffc2 Dialplan: sofia/internal/1004@sip1.applicloud.com parsing [centos->test2] continue=false
8ddd4064-6865-450e-95e3-cf868f9fffc2 Dialplan: sofia/internal/1004@sip1.applicloud.com Regex (FAIL) [test2] destination_number(6083) =~ /^(6082)$/ break=on-false
8ddd4064-6865-450e-95e3-cf868f9fffc2 Dialplan: sofia/internal/1004@sip1.applicloud.com parsing [centos->test4] continue=false
8ddd4064-6865-450e-95e3-cf868f9fffc2 Dialplan: sofia/internal/1004@sip1.applicloud.com Regex (PASS) [test4] destination_number(6083) =~ /^(6083)$/ break=on-false
8ddd4064-6865-450e-95e3-cf868f9fffc2 Dialplan: sofia/internal/1004@sip1.applicloud.com Action export(nolocal:absolute_codec_string=OPUS,H264)
8ddd4064-6865-450e-95e3-cf868f9fffc2 Dialplan: sofia/internal/1004@sip1.applicloud.com Action set(hangup_after_bridge=true)
8ddd4064-6865-450e-95e3-cf868f9fffc2 Dialplan: sofia/internal/1004@sip1.applicloud.com Action export(RECORD_TOGGLE_ON_REPEAT=true)
8ddd4064-6865-450e-95e3-cf868f9fffc2 Dialplan: sofia/internal/1004@sip1.applicloud.com Action export(record_concat_video=true)
8ddd4064-6865-450e-95e3-cf868f9fffc2 Dialplan: sofia/internal/1004@sip1.applicloud.com Action bind_meta_app(2 a i record_session::{vencspd=fast}/usr/local/freeswitch/recordings/${strftime(%Y%m%d_%H%M%S)}_${destination_number}_a.mp4)
8ddd4064-6865-450e-95e3-cf868f9fffc2 Dialplan: sofia/internal/1004@sip1.applicloud.com Action bind_meta_app(2 b i record_session::{vencspd=fast}/usr/local/freeswitch/recordings/${strftime(%Y%m%d_%H%M%S)}_${destination_number}_b.mp4)
8ddd4064-6865-450e-95e3-cf868f9fffc2 Dialplan: sofia/internal/1004@sip1.applicloud.com Action bridge(user/1003${sip_profile})
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.507419 [DEBUG] switch_core_state_machine.c:216 (sofia/internal/1004@sip1.applicloud.com) State Change CS_ROUTING -> CS_EXECUTE
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.507419 [DEBUG] switch_core_state_machine.c:532 (sofia/internal/1004@sip1.applicloud.com) State ROUTING going to sleep
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.507419 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/1004@sip1.applicloud.com) Running State Change CS_EXECUTE
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.507419 [DEBUG] switch_core_state_machine.c:539 (sofia/internal/1004@sip1.applicloud.com) State EXECUTE
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.507419 [DEBUG] mod_sofia.c:196 sofia/internal/1004@sip1.applicloud.com SOFIA EXECUTE
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.507419 [DEBUG] switch_core_state_machine.c:258 sofia/internal/1004@sip1.applicloud.com Standard EXECUTE
8ddd4064-6865-450e-95e3-cf868f9fffc2 EXECUTE sofia/internal/1004@sip1.applicloud.com export(nolocal:absolute_codec_string=OPUS,H264)
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.507419 [DEBUG] switch_channel.c:1281 EXPORT (export_vars) (REMOTE ONLY) [absolute_codec_string]=[OPUS,H264]
8ddd4064-6865-450e-95e3-cf868f9fffc2 EXECUTE sofia/internal/1004@sip1.applicloud.com set(hangup_after_bridge=true)
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.507419 [DEBUG] mod_dptools.c:1498 SET sofia/internal/1004@sip1.applicloud.com [hangup_after_bridge]=[true]
8ddd4064-6865-450e-95e3-cf868f9fffc2 EXECUTE sofia/internal/1004@sip1.applicloud.com export(RECORD_TOGGLE_ON_REPEAT=true)
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.507419 [DEBUG] switch_channel.c:1281 EXPORT (export_vars) [RECORD_TOGGLE_ON_REPEAT]=[true]
8ddd4064-6865-450e-95e3-cf868f9fffc2 EXECUTE sofia/internal/1004@sip1.applicloud.com export(record_concat_video=true)
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.507419 [DEBUG] switch_channel.c:1281 EXPORT (export_vars) [record_concat_video]=[true]
8ddd4064-6865-450e-95e3-cf868f9fffc2 EXECUTE sofia/internal/1004@sip1.applicloud.com bind_meta_app(2 a i record_session::{vencspd=fast}/usr/local/freeswitch/recordings/20151021_103729_6083_a.mp4)
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.507419 [INFO] switch_ivr_async.c:4133 Bound A-Leg: *2 record_session::{vencspd=fast}/usr/local/freeswitch/recordings/20151021_103729_6083_a.mp4
8ddd4064-6865-450e-95e3-cf868f9fffc2 EXECUTE sofia/internal/1004@sip1.applicloud.com bind_meta_app(2 b i record_session::{vencspd=fast}/usr/local/freeswitch/recordings/20151021_103729_6083_b.mp4)
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.507419 [INFO] switch_ivr_async.c:4141 Bound B-Leg: *2 record_session::{vencspd=fast}/usr/local/freeswitch/recordings/20151021_103729_6083_b.mp4
8ddd4064-6865-450e-95e3-cf868f9fffc2 EXECUTE sofia/internal/1004@sip1.applicloud.com bridge(user/1003)
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.507419 [DEBUG] switch_channel.c:1235 sofia/internal/1004@sip1.applicloud.com EXPORTING[export_vars] [absolute_codec_string]=[OPUS,H264] to event
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.507419 [DEBUG] switch_channel.c:1235 sofia/internal/1004@sip1.applicloud.com EXPORTING[export_vars] [RECORD_TOGGLE_ON_REPEAT]=[true] to event
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.507419 [DEBUG] switch_channel.c:1235 sofia/internal/1004@sip1.applicloud.com EXPORTING[export_vars] [record_concat_video]=[true] to event
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.507419 [DEBUG] switch_ivr_originate.c:2127 Parsing global variables
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.707419 [DEBUG] switch_channel.c:1235 sofia/internal/1004@sip1.applicloud.com EXPORTING[export_vars] [absolute_codec_string]=[OPUS,H264] to event
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.707419 [DEBUG] switch_channel.c:1235 sofia/internal/1004@sip1.applicloud.com EXPORTING[export_vars] [RECORD_TOGGLE_ON_REPEAT]=[true] to event
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.707419 [DEBUG] switch_channel.c:1235 sofia/internal/1004@sip1.applicloud.com EXPORTING[export_vars] [record_concat_video]=[true] to event
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.707419 [DEBUG] switch_ivr_originate.c:2127 Parsing global variables
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:29.707419 [NOTICE] switch_channel.c:1089 New Channel sofia/internal/qech467q@9dogu3h38qnf.invalid [9fbad6e6-d26f-47ef-b270-c1a3c070f2ba]
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:29.707419 [DEBUG] mod_sofia.c:4752 (sofia/internal/qech467q@9dogu3h38qnf.invalid) State Change CS_NEW -> CS_INIT
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:29.707419 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/qech467q@9dogu3h38qnf.invalid) Running State Change CS_INIT
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:29.707419 [DEBUG] switch_core_state_machine.c:516 (sofia/internal/qech467q@9dogu3h38qnf.invalid) State INIT
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:29.707419 [DEBUG] mod_sofia.c:88 sofia/internal/qech467q@9dogu3h38qnf.invalid SOFIA INIT
2015-10-21 10:37:29.707419 [DEBUG] switch_core_port_allocator.c:183 UDP port robustness check for port 32746 pass
2015-10-21 10:37:29.707419 [DEBUG] switch_core_media.c:5542 STUN Success [62.168.61.75]:[32746]
2015-10-21 10:37:29.707419 [DEBUG] switch_core_media.c:5546 STUN Not Required ip and port match. [62.168.61.75]:[32746]
2015-10-21 10:37:29.707419 [DEBUG] switch_core_port_allocator.c:183 UDP port robustness check for port 18456 pass
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:29.707419 [DEBUG] sofia_glue.c:1228 sip:qech467q@84.242.71.194:55211;transport=wss Setting proxy route to sofia/internal/qech467q@9dogu3h38qnf.invalid
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:29.707419 [DEBUG] sofia_glue.c:1257 sofia/internal/qech467q@9dogu3h38qnf.invalid sending invite version: 1.7.0 git c7d5d49 2015-10-15 20:00:18Z 64bit
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba Local SDP:
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba v=0
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba o=FreeSWITCH 1445383903 1445383904 IN IP4 62.168.61.75
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba s=FreeSWITCH
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba c=IN IP4 62.168.61.75
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba t=0 0
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=msid-semantic: WMS Ci0OlLpooM9oJO3Qt9ymeqRaQsSoN6of
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba m=audio 32746 RTP/SAVPF 111 101
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=rtpmap:111 opus/48000/2
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=fmtp:111 minptime=10; useinbandfec=1
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=rtpmap:101 telephone-event/48000
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=fingerprint:sha-256 62:D7:8C:08:DD:B3:CC:BC:D2:59:40:01:57:94:6A:FB:45:31:E1:1E:57:C6:A6:31:9F:2B:D8:23:FA:D3:61:17
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=setup:actpass
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=rtcp-mux
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=rtcp:32746 IN IP4 62.168.61.75
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=ssrc:1473765897 cname:ffUrQ9F4MFilkc2D
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=ssrc:1473765897 msid:Ci0OlLpooM9oJO3Qt9ymeqRaQsSoN6of a0
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=ssrc:1473765897 mslabel:Ci0OlLpooM9oJO3Qt9ymeqRaQsSoN6of
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=ssrc:1473765897 label:Ci0OlLpooM9oJO3Qt9ymeqRaQsSoN6ofa0
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=ice-ufrag:bqQgHygnQZBuVPA1
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=ice-pwd:UkiBkOvWkE7uGZYIgEON2V0J
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=candidate:1605410455 1 udp 659136 62.168.61.75 32746 typ host generation 0
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=candidate:1605410455 2 udp 659136 62.168.61.75 32746 typ host generation 0
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=ptime:20
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=sendrecv
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba m=video 18456 RTP/SAVPF 102
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=rtpmap:102 H264/90000
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=fingerprint:sha-256 62:D7:8C:08:DD:B3:CC:BC:D2:59:40:01:57:94:6A:FB:45:31:E1:1E:57:C6:A6:31:9F:2B:D8:23:FA:D3:61:17
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=setup:actpass
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=rtcp-mux
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=rtcp:18456 IN IP4 62.168.61.75
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba b=AS:500
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=rtcp-fb:102 ccm fir tmmbr
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=rtcp-fb:102 nack
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=rtcp-fb:102 nack pli
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=ssrc:751078444 cname:ffUrQ9F4MFilkc2D
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=ssrc:751078444 msid:Ci0OlLpooM9oJO3Qt9ymeqRaQsSoN6of v0
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=ssrc:751078444 mslabel:Ci0OlLpooM9oJO3Qt9ymeqRaQsSoN6of
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=ssrc:751078444 label:Ci0OlLpooM9oJO3Qt9ymeqRaQsSoN6ofv0
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=ice-ufrag:vSIZnL8EcEJHTVmm
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=ice-pwd:OVLIEfxSWKlP0ipm0XcezaIB
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=candidate:1414190369 1 udp 659136 62.168.61.75 18456 typ host generation 0
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba a=candidate:1414190369 2 udp 659135 62.168.61.75 18456 typ host generation 0
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:29.707419 [DEBUG] switch_core_state_machine.c:40 sofia/internal/qech467q@9dogu3h38qnf.invalid Standard INIT
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:29.707419 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/qech467q@9dogu3h38qnf.invalid) State Change CS_INIT -> CS_ROUTING
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:29.707419 [DEBUG] switch_core_state_machine.c:516 (sofia/internal/qech467q@9dogu3h38qnf.invalid) State INIT going to sleep
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:29.707419 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/qech467q@9dogu3h38qnf.invalid) Running State Change CS_ROUTING
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:29.707419 [DEBUG] sofia.c:6750 Channel sofia/internal/qech467q@9dogu3h38qnf.invalid entering state [calling][0]
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:29.707419 [DEBUG] switch_core_state_machine.c:532 (sofia/internal/qech467q@9dogu3h38qnf.invalid) State ROUTING
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:29.707419 [DEBUG] mod_sofia.c:141 sofia/internal/qech467q@9dogu3h38qnf.invalid SOFIA ROUTING
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:29.707419 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/qech467q@9dogu3h38qnf.invalid) State Change CS_ROUTING -> CS_CONSUME_MEDIA
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:29.707419 [DEBUG] switch_core_state_machine.c:532 (sofia/internal/qech467q@9dogu3h38qnf.invalid) State ROUTING going to sleep
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:29.707419 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/qech467q@9dogu3h38qnf.invalid) Running State Change CS_CONSUME_MEDIA
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:29.707419 [DEBUG] switch_core_state_machine.c:551 (sofia/internal/qech467q@9dogu3h38qnf.invalid) State CONSUME_MEDIA
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:29.707419 [DEBUG] switch_core_state_machine.c:551 (sofia/internal/qech467q@9dogu3h38qnf.invalid) State CONSUME_MEDIA going to sleep
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:29.747419 [DEBUG] sofia.c:6750 Channel sofia/internal/qech467q@9dogu3h38qnf.invalid entering state [proceeding][180]
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:29.747419 [NOTICE] sofia.c:6852 Ring-Ready sofia/internal/qech467q@9dogu3h38qnf.invalid!
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:29.747419 [DEBUG] switch_channel.c:3330 (sofia/internal/qech467q@9dogu3h38qnf.invalid) Callstate Change DOWN -> RINGING
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.747419 [NOTICE] mod_sofia.c:2146 Ring-Ready sofia/internal/1004@sip1.applicloud.com!
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.747419 [DEBUG] sofia.c:6750 Channel sofia/internal/1004@sip1.applicloud.com entering state [early][180]
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.747419 [NOTICE] switch_ivr_originate.c:528 Ring Ready sofia/internal/1004@sip1.applicloud.com!
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:31.747418 [DEBUG] sofia.c:6750 Channel sofia/internal/qech467q@9dogu3h38qnf.invalid entering state [terminated][488]
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:31.747418 [NOTICE] sofia.c:7769 Hangup sofia/internal/qech467q@9dogu3h38qnf.invalid [CS_CONSUME_MEDIA] [INCOMPATIBLE_DESTINATION]
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:31.747418 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/qech467q@9dogu3h38qnf.invalid) Running State Change CS_HANGUP
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:31.767420 [DEBUG] switch_core_state_machine.c:739 (sofia/internal/qech467q@9dogu3h38qnf.invalid) Callstate Change RINGING -> HANGUP
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:31.767420 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/qech467q@9dogu3h38qnf.invalid) State HANGUP
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:31.767420 [DEBUG] mod_sofia.c:431 Channel sofia/internal/qech467q@9dogu3h38qnf.invalid hanging up, cause: INCOMPATIBLE_DESTINATION
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:31.767420 [DEBUG] switch_core_state_machine.c:60 sofia/internal/qech467q@9dogu3h38qnf.invalid Standard HANGUP, cause: INCOMPATIBLE_DESTINATION
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:31.767420 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/qech467q@9dogu3h38qnf.invalid) State HANGUP going to sleep
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:31.767420 [DEBUG] switch_core_state_machine.c:508 (sofia/internal/qech467q@9dogu3h38qnf.invalid) State Change CS_HANGUP -> CS_REPORTING
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:31.767420 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/qech467q@9dogu3h38qnf.invalid) Running State Change CS_REPORTING
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:31.767420 [DEBUG] switch_core_state_machine.c:827 (sofia/internal/qech467q@9dogu3h38qnf.invalid) State REPORTING
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:31.767420 [DEBUG] switch_core_state_machine.c:104 sofia/internal/qech467q@9dogu3h38qnf.invalid Standard REPORTING, cause: INCOMPATIBLE_DESTINATION
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:31.767420 [DEBUG] switch_core_state_machine.c:827 (sofia/internal/qech467q@9dogu3h38qnf.invalid) State REPORTING going to sleep
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:31.767420 [DEBUG] switch_core_state_machine.c:499 (sofia/internal/qech467q@9dogu3h38qnf.invalid) State Change CS_REPORTING -> CS_DESTROY
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:31.767420 [DEBUG] switch_core_session.c:1646 Session 2 (sofia/internal/qech467q@9dogu3h38qnf.invalid) Locked, Waiting on external entities
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:31.767420 [DEBUG] switch_ivr_originate.c:3750 Originate Resulted in Error Cause: 88 [INCOMPATIBLE_DESTINATION]
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:31.767420 [NOTICE] switch_core_session.c:1664 Session 2 (sofia/internal/qech467q@9dogu3h38qnf.invalid) Ended
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:31.767420 [NOTICE] switch_core_session.c:1668 Close Channel sofia/internal/qech467q@9dogu3h38qnf.invalid [CS_DESTROY]
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:31.767420 [DEBUG] switch_core_state_machine.c:630 (sofia/internal/qech467q@9dogu3h38qnf.invalid) Running State Change CS_DESTROY
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:31.767420 [NOTICE] switch_ivr_originate.c:2762 Cannot create outgoing channel of type [user] cause: [INCOMPATIBLE_DESTINATION]
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:31.767420 [DEBUG] switch_core_state_machine.c:640 (sofia/internal/qech467q@9dogu3h38qnf.invalid) State DESTROY
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:31.767420 [DEBUG] mod_sofia.c:341 sofia/internal/qech467q@9dogu3h38qnf.invalid SOFIA DESTROY
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:31.767420 [DEBUG] switch_ivr_originate.c:3750 Originate Resulted in Error Cause: 88 [INCOMPATIBLE_DESTINATION]
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:31.767420 [DEBUG] switch_core_state_machine.c:111 sofia/internal/qech467q@9dogu3h38qnf.invalid Standard DESTROY
9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:31.767420 [DEBUG] switch_core_state_machine.c:640 (sofia/internal/qech467q@9dogu3h38qnf.invalid) State DESTROY going to sleep
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:31.767420 [INFO] mod_dptools.c:3379 Originate Failed.  Cause: INCOMPATIBLE_DESTINATION
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:31.767420 [NOTICE] switch_channel.c:4798 Hangup sofia/internal/1004@sip1.applicloud.com [CS_EXECUTE] [INCOMPATIBLE_DESTINATION]
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:31.767420 [DEBUG] switch_core_session.c:2796 sofia/internal/1004@sip1.applicloud.com skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:31.767420 [DEBUG] switch_core_state_machine.c:539 (sofia/internal/1004@sip1.applicloud.com) State EXECUTE going to sleep
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:31.767420 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/1004@sip1.applicloud.com) Running State Change CS_HANGUP
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:31.767420 [DEBUG] switch_core_state_machine.c:739 (sofia/internal/1004@sip1.applicloud.com) Callstate Change RINGING -> HANGUP
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:31.767420 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/1004@sip1.applicloud.com) State HANGUP
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:31.767420 [DEBUG] mod_sofia.c:425 sofia/internal/1004@sip1.applicloud.com Overriding SIP cause 488 with 488 from the other leg
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:31.767420 [DEBUG] mod_sofia.c:431 Channel sofia/internal/1004@sip1.applicloud.com hanging up, cause: INCOMPATIBLE_DESTINATION
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:31.767420 [DEBUG] mod_sofia.c:568 Responding to INVITE with: 488
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:31.767420 [DEBUG] switch_core_state_machine.c:60 sofia/internal/1004@sip1.applicloud.com Standard HANGUP, cause: INCOMPATIBLE_DESTINATION
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:31.767420 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/1004@sip1.applicloud.com) State HANGUP going to sleep
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:31.767420 [DEBUG] switch_core_state_machine.c:508 (sofia/internal/1004@sip1.applicloud.com) State Change CS_HANGUP -> CS_REPORTING
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:31.767420 [DEBUG] switch_core_state_machine.c:473 (sofia/internal/1004@sip1.applicloud.com) Running State Change CS_REPORTING
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:31.767420 [DEBUG] switch_core_state_machine.c:827 (sofia/internal/1004@sip1.applicloud.com) State REPORTING
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:31.767420 [DEBUG] switch_core_state_machine.c:104 sofia/internal/1004@sip1.applicloud.com Standard REPORTING, cause: INCOMPATIBLE_DESTINATION
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:31.767420 [DEBUG] switch_core_state_machine.c:827 (sofia/internal/1004@sip1.applicloud.com) State REPORTING going to sleep
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:31.767420 [DEBUG] switch_core_state_machine.c:499 (sofia/internal/1004@sip1.applicloud.com) State Change CS_REPORTING -> CS_DESTROY
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:31.767420 [DEBUG] switch_core_session.c:1646 Session 1 (sofia/internal/1004@sip1.applicloud.com) Locked, Waiting on external entities
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:31.767420 [NOTICE] switch_core_session.c:1664 Session 1 (sofia/internal/1004@sip1.applicloud.com) Ended
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:31.767420 [NOTICE] switch_core_session.c:1668 Close Channel sofia/internal/1004@sip1.applicloud.com [CS_DESTROY]
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:31.767420 [DEBUG] switch_core_state_machine.c:630 (sofia/internal/1004@sip1.applicloud.com) Running State Change CS_DESTROY
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:31.767420 [DEBUG] switch_core_state_machine.c:640 (sofia/internal/1004@sip1.applicloud.com) State DESTROY
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:31.767420 [DEBUG] mod_sofia.c:341 sofia/internal/1004@sip1.applicloud.com SOFIA DESTROY
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:31.767420 [DEBUG] switch_core_state_machine.c:111 sofia/internal/1004@sip1.applicloud.com Standard DESTROY
8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:31.767420 [DEBUG] switch_core_state_machine.c:640 (sofia/internal/1004@sip1.applicloud.com) State DESTROY going to sleep

-- 
S pozdravem,
Ing.Denis Jakovlev                           
mob.tel. 775-415-382