<div dir="ltr"><div><div>Looks like a device is misbehaving and violating RFC3711. Fortunately you can explicitly allow this behavior:<br><br><a href="http://wiki.freeswitch.org/wiki/NDLB#NDLB-allow-crypto-in-avp">http://wiki.freeswitch.org/wiki/NDLB#NDLB-allow-crypto-in-avp</a><br>
<br></div>Let us know if that works.<br><br></div>-MC<br></div><div class="gmail_extra"><br><br><div class="gmail_quote">On Tue, May 21, 2013 at 9:11 AM, JohnGalt1717 <span dir="ltr"><<a href="mailto:jrlh@outlook.com" target="_blank">jrlh@outlook.com</a>></span> wrote:<br>
<blockquote class="gmail_quote" style="margin:0 0 0 .8ex;border-left:1px #ccc solid;padding-left:1ex">Hi there, I'm a newbee, but I've been reading everything I can and I can't<br>
find anything that assists with this.<br>
<br>
I have a UCMA app that is internal that communicates on the internal sip<br>
port (set to 5042) and it bridges with dialplan to the external sip trunk<br>
(trying 2, one of which is siproutes).<br>
<br>
If I enable proxy, the call rings out and I get dead air on the other side,<br>
but it won't ever properly establish the call in the UCMA app because of<br>
some issue with codecs from what I can tell.<br>
<br>
Obviously I don't want to use proxy mode, what I really want to do is use it<br>
straight up and have FS do the transcoding etc.<br>
<br>
The problem is that once I do this I get a Codec Negotiation error and I<br>
can't figure out why. Anyone have any ideas as to why it's freaking out like<br>
this? (log below) Thanks!<br>
<br>
2013-05-21 12:09:41.570884 [DEBUG] sofia_glue.c:1219 Local SDP:<br>
v=0<br>
o=FreeSWITCH 1369129003 1369129004 IN IP4 10.8.0.158<br>
s=FreeSWITCH<br>
c=IN IP4 10.8.0.158<br>
t=0 0<br>
m=audio 23578 RTP/AVP 9 0 8 101 13<br>
a=rtpmap:9 G722/8000<br>
a=rtpmap:0 PCMU/8000<br>
a=rtpmap:8 PCMA/8000<br>
a=rtpmap:101 telephone-event/8000<br>
a=fmtp:101 0-16<br>
a=ptime:20<br>
a=sendrecv<br>
<br>
2013-05-21 12:09:41.570884 [DEBUG] mod_sofia.c:114<br>
(sofia/external/+16032897972) State Change CS_INIT -> CS_ROUTING<br>
2013-05-21 12:09:41.570884 [DEBUG] switch_core_session.c:1340 Send signal<br>
sofia/external/+16032897972 [BREAK]<br>
2013-05-21 12:09:41.570884 [DEBUG] switch_core_state_machine.c:454<br>
(sofia/external/+16032897972) State INIT going to sleep<br>
2013-05-21 12:09:41.570884 [DEBUG] switch_core_state_machine.c:415<br>
(sofia/external/+16032897972) Running State Change CS_ROUTING<br>
2013-05-21 12:09:41.570884 [DEBUG] switch_core_state_machine.c:470<br>
(sofia/external/+16032897972) State ROUTING<br>
2013-05-21 12:09:41.570884 [DEBUG] mod_sofia.c:137<br>
sofia/external/+16032897972 SOFIA ROUTING<br>
2013-05-21 12:09:41.570884 [DEBUG] switch_ivr_originate.c:67<br>
(sofia/external/+16032897972) State Change CS_ROUTING -> CS_CONSUME_MEDIA<br>
2013-05-21 12:09:41.570884 [DEBUG] switch_core_session.c:1340 Send signal<br>
sofia/external/+16032897972 [BREAK]<br>
2013-05-21 12:09:41.570884 [DEBUG] switch_core_state_machine.c:470<br>
(sofia/external/+16032897972) State ROUTING going to sleep<br>
2013-05-21 12:09:41.570884 [DEBUG] switch_core_state_machine.c:415<br>
(sofia/external/+16032897972) Running State Change CS_CONSUME_MEDIA<br>
2013-05-21 12:09:41.570884 [DEBUG] switch_core_state_machine.c:489<br>
(sofia/external/+16032897972) State CONSUME_MEDIA<br>
2013-05-21 12:09:41.570884 [DEBUG] switch_core_state_machine.c:489<br>
(sofia/external/+16032897972) State CONSUME_MEDIA going to sleep<br>
2013-05-21 12:09:41.570884 [DEBUG] switch_core_session.c:1005 Send signal<br>
sofia/external/+16032897972 [BREAK]<br>
2013-05-21 12:09:41.570884 [DEBUG] sofia.c:5742 Channel<br>
sofia/external/+16032897972 entering state [calling][0]<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_core_session.c:1005 Send signal<br>
sofia/external/+16032897972 [BREAK]<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_core_session.c:1005 Send signal<br>
sofia/external/+16032897972 [BREAK]<br>
2013-05-21 12:09:43.891308 [INFO] sofia.c:966 sofia/external/+16032897972<br>
Update Callee ID to "+16032897972" <<a href="mailto:sip%3A%2B16032897972@4.30.136.195">sip:+16032897972@4.30.136.195</a>><br>
2013-05-21 12:09:43.891308 [DEBUG] sofia.c:5742 Channel<br>
sofia/external/<a href="tel:%2B16032897972" value="+16032897972">+16032897972</a> entering state [proceeding][183]<br>
2013-05-21 12:09:43.891308 [DEBUG] sofia.c:5751 Remote SDP:<br>
v=0<br>
o=Sonus_UAC 10608 14579 IN IP4 207.239.33.59<br>
s=SIP Media Capabilities<br>
c=IN IP4 207.239.33.59<br>
t=0 0<br>
m=audio 10460 RTP/AVP 0 101<br>
a=rtpmap:0 PCMU/8000<br>
a=rtpmap:101 telephone-event/8000<br>
a=fmtp:101 0-15<br>
a=maxptime:20<br>
<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_core_media.c:2714 Audio Codec<br>
Compare [PCMU:0:8000:20:64000]/[G722:9:8000:20:64000]<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_core_media.c:2714 Audio Codec<br>
Compare [PCMU:0:8000:20:64000]/[PCMU:0:8000:20:64000]<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_core_media.c:1813 Set Codec<br>
sofia/external/+16032897972 PCMU/8000 20 ms 160 samples 64000 bits<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_core_codec.c:111<br>
sofia/external/+16032897972 Original read codec set to PCMU:0<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_core_media.c:2876 Set 2833 dtmf<br>
send payload to 101<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_core_media.c:3800 AUDIO RTP<br>
[sofia/external/+16032897972] 10.8.0.158 port 23578 -> 207.239.33.59 port<br>
10460 codec: 0 m<br>
s: 20<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_rtp.c:2659 Starting timer [soft]<br>
160 bytes per 20ms<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_rtp.c:1231 [ zrtp main]: START<br>
SESSION INITIALIZATION. sID=4.<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_rtp.c:1231 [ zrtp main]:<br>
ZID=306130383030396530393363.<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_rtp.c:1231 [ zrtp main]:<br>
Loading User's profile:<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_rtp.c:1231 [ zrtp main]:<br>
allowclear: OFF<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_rtp.c:1231 [ zrtp main]:<br>
autosecure: ON<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_rtp.c:1231 [ zrtp main]:<br>
disclose_bit: OFF<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_rtp.c:1231 [ zrtp main]:<br>
signal. role: Initiator<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_rtp.c:1231 [ zrtp main]:<br>
TTL: 4294967295<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_rtp.c:1231 [ zrtp main]: SAS<br>
schemes: 2013-05-21 12:09:43.891308 [DEBUG] switch_rtp.c:1231 B256<br>
2013-05-21 12:09:<br>
43.891308 [DEBUG] switch_rtp.c:1231 B32 2013-05-21 12:09:43.891308 [DEBUG]<br>
switch_rtp.c:1231<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_rtp.c:1231 [ zrtp main]:<br>
Ciphers: 2013-05-21 12:09:43.891308 [DEBUG] switch_rtp.c:1231 AES3<br>
2013-05-21 12:09:4<br>
3.891308 [DEBUG] switch_rtp.c:1231 AES1 2013-05-21 12:09:43.891308 [DEBUG]<br>
switch_rtp.c:1231<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_rtp.c:1231 [ zrtp main]: PK<br>
schemes: 2013-05-21 12:09:43.891308 [DEBUG] switch_rtp.c:1231 EC25<br>
2013-05-21 12:09:<br>
43.891308 [DEBUG] switch_rtp.c:1231 DH3k 2013-05-21 12:09:43.891308 [DEBUG]<br>
switch_rtp.c:1231 DH2k 2013-05-21 12:09:43.891308 [DEBUG] switch_rtp.c:1231<br>
Mult 201<br>
3-05-21 12:09:43.891308 [DEBUG] switch_rtp.c:1231<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_rtp.c:1231 [ zrtp main]:<br>
ATL: 2013-05-21 12:09:43.891308 [DEBUG] switch_rtp.c:1231 HS32 2013-05-21<br>
12:09:<br>
43.891308 [DEBUG] switch_rtp.c:1231<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_rtp.c:1231 [ zrtp main]:<br>
Hashes: 2013-05-21 12:09:43.891308 [DEBUG] switch_rtp.c:1231 S256 2013-05-21<br>
12:09:4<br>
3.891308 [DEBUG] switch_rtp.c:1231<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_rtp.c:1231 [ zrtp main]:<br>
Session initialization - DONE. sID=4.<br>
<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_rtp.c:1231 [ zrtp main]: ATTACH<br>
NEW STREAM to sID=4:<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_rtp.c:1231 [ zrtp]:<br>
Stream ID=0 UNKNOWN switching <NONE> ---> <ACTIVE>.<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_rtp.c:1231 [ zrtp main]:<br>
Empty slot was found - initializing new stream with ID=4.<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_rtp.c:1231 [ zrtp main]:<br>
Preparing ZRTP Hello according to the Session profile.<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_rtp.c:1231 [ zrtp main]: ATTACH<br>
NEW STREAM - DONE.<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_rtp.c:1231 [ zrtp engine]: START<br>
STREAM ID=4 mode=CLEAR state=ACTIVE.<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_rtp.c:1231 [ zrtp]:<br>
Stream ID=4 CLEAR switching <ACTIVE> ---> <START>.<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_rtp.c:1231 [ zrtp utils]: Send<br>
<HELLO> ssrc=1428962591 seq=54611 size=144. Stream 4:CLEAR:START<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_core_media.c:4145 Set 2833 dtmf<br>
send payload to 101<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_core_media.c:4151 Set 2833 dtmf<br>
receive payload to 101<br>
2013-05-21 12:09:43.891308 [NOTICE] sofia_media.c:92 Pre-Answer<br>
sofia/external/+16032897972!<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_channel.c:3273 Send signal<br>
sofia/internal/+<a href="mailto:16032897972@173.255.174.20">16032897972@173.255.174.20</a> [BREAK]<br>
2013-05-21 12:09:43.891308 [DEBUG] switch_channel.c:3277<br>
(sofia/external/<a href="tel:%2B16032897972" value="+16032897972">+16032897972</a>) Callstate Change DOWN -> EARLY<br>
2013-05-21 12:09:43.911297 [DEBUG] switch_ivr_originate.c:411 Setting codec<br>
string on sofia/internal/+<a href="mailto:16032897972@173.255.174.20">16032897972@173.255.174.20</a> to PCMU@8000h@20i<br>
2013-05-21 12:09:43.911297 [INFO] switch_ivr_originate.c:3416 Sending early<br>
media<br>
2013-05-21 12:09:43.911297 [ERR] switch_core_media.c:2549 a=crypto in<br>
RTP/AVP, refer to rfc3711<br>
2013-05-21 12:09:43.911297 [ERR] mod_sofia.c:2081 CODEC NEGOTIATION ERROR.<br>
SDP:<br>
v=0<br>
o=- 1 0 IN IP4 10.8.0.158<br>
s=session<br>
c=IN IP4 10.8.0.158<br>
b=CT:10000<br>
t=0 0<br>
m=audio 2908 RTP/AVP 9 112 111 0 8 116 13 118 97 101<br>
c=IN IP4 10.8.0.158<br>
a=rtpmap:9 G722/8000<br>
a=rtpmap:112 G7221/16000<br>
a=fmtp:112 bitrate=24000<br>
a=rtpmap:111 SIREN/16000<br>
a=fmtp:111 bitrate=16000<br>
a=rtpmap:0 PCMU/8000<br>
a=rtpmap:8 PCMA/8000<br>
a=rtpmap:116 AAL2-G726-32/8000<br>
a=rtpmap:13 CN/8000<br>
a=rtpmap:118 CN/16000<br>
a=rtpmap:97 RED/8000<br>
a=rtpmap:101 telephone-event/8000<br>
a=fmtp:101 0-16,36<br>
a=rtcp:2909<br>
a=label:main-audio<br>
a=crypto:1 AES_CM_128_HMAC_SHA1_80<br>
inline:BqtEfRv/sMasd3GS0I4FJRX5hh7BKVt+r8/vKbOk<br>
<br>
<br>
<br>
<br>
<br>
<br>
--<br>
View this message in context: <a href="http://freeswitch-users.2379917.n2.nabble.com/Codec-Negotiation-Error-Lync-UCMA-external-provider-tp7590911.html" target="_blank">http://freeswitch-users.2379917.n2.nabble.com/Codec-Negotiation-Error-Lync-UCMA-external-provider-tp7590911.html</a><br>
Sent from the freeswitch-users mailing list archive at Nabble.com.<br>
<br>
_________________________________________________________________________<br>
Professional FreeSWITCH Consulting Services:<br>
<a href="mailto:consulting@freeswitch.org">consulting@freeswitch.org</a><br>
<a href="http://www.freeswitchsolutions.com" target="_blank">http://www.freeswitchsolutions.com</a><br>
<br>
FreeSWITCH-powered IP PBX: The CudaTel Communication Server<br>
<a href="http://www.cudatel.com" target="_blank">http://www.cudatel.com</a><br>
<br>
Official FreeSWITCH Sites<br>
<a href="http://www.freeswitch.org" target="_blank">http://www.freeswitch.org</a><br>
<a href="http://wiki.freeswitch.org" target="_blank">http://wiki.freeswitch.org</a><br>
<a href="http://www.cluecon.com" target="_blank">http://www.cluecon.com</a><br>
<br>
FreeSWITCH-users mailing list<br>
<a href="mailto:FreeSWITCH-users@lists.freeswitch.org">FreeSWITCH-users@lists.freeswitch.org</a><br>
<a href="http://lists.freeswitch.org/mailman/listinfo/freeswitch-users" target="_blank">http://lists.freeswitch.org/mailman/listinfo/freeswitch-users</a><br>
UNSUBSCRIBE:<a href="http://lists.freeswitch.org/mailman/options/freeswitch-users" target="_blank">http://lists.freeswitch.org/mailman/options/freeswitch-users</a><br>
<a href="http://www.freeswitch.org" target="_blank">http://www.freeswitch.org</a><br>
</blockquote></div><br><br clear="all"><br>-- <br>Michael S Collins<br>Twitter: @mercutioviz<br><a href="http://www.FreeSWITCH.org" target="_blank">http://www.FreeSWITCH.org</a><br><a href="http://www.ClueCon.com" target="_blank">http://www.ClueCon.com</a><br>
<a href="http://www.OSTAG.org" target="_blank">http://www.OSTAG.org</a><br><br>
</div>