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

Michael Jerris mike at jerris.com
Wed Oct 21 17:36:04 MSD 2015


Might want vp8 in there.  Those browser endpoint a do not support h264.

On Wednesday, October 21, 2015, Denis Jakovlev <yadenis at seznam.cz> wrote:

> 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at sip1.applicloud.com');> parsing
> [centos->from-centos] continue=false
> 8ddd4064-6865-450e-95e3-cf868f9fffc2 Dialplan: sofia/internal/
> 1004 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at sip1.applicloud.com');> Regex (FAIL)
> [from-centos] destination_number(6083) =~ /^(onops)$/ break=on-false
> 8ddd4064-6865-450e-95e3-cf868f9fffc2 Dialplan: sofia/internal/
> 1004 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at sip1.applicloud.com');> parsing
> [centos->test1] continue=false
> 8ddd4064-6865-450e-95e3-cf868f9fffc2 Dialplan: sofia/internal/
> 1004 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at sip1.applicloud.com');> Regex (FAIL)
> [test1] destination_number(6083) =~ /^(6080)$/ break=on-false
> 8ddd4064-6865-450e-95e3-cf868f9fffc2 Dialplan: sofia/internal/
> 1004 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at sip1.applicloud.com');> parsing
> [centos->test2] continue=false
> 8ddd4064-6865-450e-95e3-cf868f9fffc2 Dialplan: sofia/internal/
> 1004 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at sip1.applicloud.com');> Regex (FAIL)
> [test2] destination_number(6083) =~ /^(6081)$/ break=on-false
> 8ddd4064-6865-450e-95e3-cf868f9fffc2 Dialplan: sofia/internal/
> 1004 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at sip1.applicloud.com');> parsing
> [centos->test2] continue=false
> 8ddd4064-6865-450e-95e3-cf868f9fffc2 Dialplan: sofia/internal/
> 1004 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at sip1.applicloud.com');> Regex (FAIL)
> [test2] destination_number(6083) =~ /^(6082)$/ break=on-false
> 8ddd4064-6865-450e-95e3-cf868f9fffc2 Dialplan: sofia/internal/
> 1004 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at sip1.applicloud.com');> parsing
> [centos->test4] continue=false
> 8ddd4064-6865-450e-95e3-cf868f9fffc2 Dialplan: sofia/internal/
> 1004 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at sip1.applicloud.com');> Regex (PASS)
> [test4] destination_number(6083) =~ /^(6083)$/ break=on-false
> 8ddd4064-6865-450e-95e3-cf868f9fffc2 Dialplan: sofia/internal/
> 1004 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at sip1.applicloud.com');> Action
> export(nolocal:absolute_codec_string=OPUS,H264)
> 8ddd4064-6865-450e-95e3-cf868f9fffc2 Dialplan: sofia/internal/
> 1004 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at sip1.applicloud.com');> Action
> set(hangup_after_bridge=true)
> 8ddd4064-6865-450e-95e3-cf868f9fffc2 Dialplan: sofia/internal/
> 1004 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at sip1.applicloud.com');> Action
> export(RECORD_TOGGLE_ON_REPEAT=true)
> 8ddd4064-6865-450e-95e3-cf868f9fffc2 Dialplan: sofia/internal/
> 1004 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at sip1.applicloud.com');> Action
> export(record_concat_video=true)
> 8ddd4064-6865-450e-95e3-cf868f9fffc2 Dialplan: sofia/internal/
> 1004 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at sip1.applicloud.com');> Standard
> EXECUTE
> 8ddd4064-6865-450e-95e3-cf868f9fffc2 EXECUTE sofia/internal/
> 1004 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at sip1.applicloud.com');>
> [hangup_after_bridge]=[true]
> 8ddd4064-6865-450e-95e3-cf868f9fffc2 EXECUTE sofia/internal/
> 1004 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at 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 at 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 at 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 at 9dogu3h38qnf.invalid) State INIT
> 9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:29.707419 [DEBUG]
> mod_sofia.c:88 sofia/internal/qech467q at 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 at 84.242.71.194:55211;transport=wss Setting
> proxy route to sofia/internal/qech467q at 9dogu3h38qnf.invalid
> 9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:29.707419 [DEBUG]
> sofia_glue.c:1257 sofia/internal/qech467q at 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 at 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 at 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 at 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 at 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 at 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 at 9dogu3h38qnf.invalid) State ROUTING
> 9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:29.707419 [DEBUG]
> mod_sofia.c:141 sofia/internal/qech467q at 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 at 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 at 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 at 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 at 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 at 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 at 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 at 9dogu3h38qnf.invalid!
> 9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:29.747419 [DEBUG]
> switch_channel.c:3330 (sofia/internal/qech467q at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at sip1.applicloud.com');>!
> 8ddd4064-6865-450e-95e3-cf868f9fffc2 2015-10-21 10:37:29.747419 [DEBUG]
> sofia.c:6750 Channel sofia/internal/1004 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at sip1.applicloud.com');>!
> 9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:31.747418 [DEBUG]
> sofia.c:6750 Channel sofia/internal/qech467q at 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 at 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 at 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 at 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 at 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 at 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 at 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 at 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 at 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 at 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 at 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 at 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 at 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 at 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 at 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 at 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 at 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 at 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 at 9dogu3h38qnf.invalid) State DESTROY
> 9fbad6e6-d26f-47ef-b270-c1a3c070f2ba 2015-10-21 10:37:31.767420 [DEBUG]
> mod_sofia.c:341 sofia/internal/qech467q at 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 at 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 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at 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 at sip1.applicloud.com
> <javascript:_e(%7B%7D,'cvml','1004 at sip1.applicloud.com');>) State DESTROY
> going to sleep
>
>
>
>
>
>
> *-- S pozdravem, Ing.Denis Jakovlev                           mob.tel
> <http://mob.tel>. 775-415-382 * <http://www.freeswitch.org>
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20151021/d9aaf757/attachment-0001.html 


Join us at ClueCon 2016 Aug 8-12, 2016
More information about the FreeSWITCH-users mailing list