[Freeswitch-users] INCOMPATIBLE_DESTINATION

Thu Jun 5 17:59:42 MSD 2014

strangely enough, it doesn't seem like a client issue.
I have registered an IP phone, ekiga on pc, and csipsimple, and tried
making calls from each to each, all showing the same behavior.
for instance, from ip phone(1005) to ekiga(1009)
*2014-06-05 13:58:00.462309 [NOTICE] sofia.c:6296 Ring-Ready
sofia/internal/sip:1009 at 10.0.1.14:5060 <http://sip:1009@10.0.1.14:5060>!*
*2014-06-05 13:58:00.462309 [DEBUG] switch_channel.c:3271
(sofia/internal/sip:1009 at 10.0.1.14:5060 <http://sip:1009@10.0.1.14:5060>)
Callstate Change DOWN -> RINGING*
*2014-06-05 13:58:00.462309 [INFO] switch_ivr_originate.c:1191 Sending
early media*
*2014-06-05 13:58:00.462309 [DEBUG] switch_core_media.c:3383 Audio Codec
Compare [PCMU:0:8000:30:32000]/[G722:9:8000:20:64000]*
*2014-06-05 13:58:00.462309 [DEBUG] switch_core_media.c:3383 Audio Codec
Compare [PCMU:0:8000:30:32000]/[PCMU:0:8000:20:64000]*
*2014-06-05 13:58:00.462309 [DEBUG] switch_core_media.c:3383 Audio Codec
Compare [PCMU:0:8000:30:32000]/[PCMA:8:8000:20:64000]*
*2014-06-05 13:58:00.462309 [DEBUG] switch_core_media.c:3383 Audio Codec
Compare [PCMU:0:8000:30:32000]/[GSM:3:8000:20:13200]*
*2014-06-05 13:58:00.462309 [DEBUG] switch_core_media.c:3383 Audio Codec
Compare [PCMA:8:8000:30:32000]/[G722:9:8000:20:64000]*
*2014-06-05 13:58:00.462309 [DEBUG] switch_core_media.c:3383 Audio Codec
Compare [PCMA:8:8000:30:32000]/[PCMU:0:8000:20:64000]*
*2014-06-05 13:58:00.462309 [DEBUG] switch_core_media.c:3383 Audio Codec
Compare [PCMA:8:8000:30:32000]/[PCMA:8:8000:20:64000]*
*2014-06-05 13:58:00.462309 [DEBUG] switch_core_media.c:3383 Audio Codec
Compare [PCMA:8:8000:30:32000]/[GSM:3:8000:20:13200]*
*2014-06-05 13:58:00.462309 [DEBUG] switch_core_media.c:3383 Audio Codec
Compare [G729:18:8000:30:32000]/[G722:9:8000:20:64000]*
*2014-06-05 13:58:00.462309 [DEBUG] switch_core_media.c:3383 Audio Codec
Compare [G729:18:8000:30:32000]/[PCMU:0:8000:20:64000]*
*2014-06-05 13:58:00.462309 [DEBUG] switch_core_media.c:3383 Audio Codec
Compare [G729:18:8000:30:32000]/[PCMA:8:8000:20:64000]*
*2014-06-05 13:58:00.462309 [DEBUG] switch_core_media.c:3383 Audio Codec
Compare [G729:18:8000:30:32000]/[GSM:3:8000:20:13200]*
*2014-06-05 13:58:00.462309 [DEBUG] switch_core_media.c:3383 Audio Codec
Compare [G723:4:8000:30:32000]/[G722:9:8000:20:64000]*
*2014-06-05 13:58:00.462309 [DEBUG] switch_core_media.c:3383 Audio Codec
Compare [G723:4:8000:30:32000]/[PCMU:0:8000:20:64000]*
*2014-06-05 13:58:00.462309 [DEBUG] switch_core_media.c:3383 Audio Codec
Compare [G723:4:8000:30:32000]/[PCMA:8:8000:20:64000]*
*2014-06-05 13:58:00.462309 [DEBUG] switch_core_media.c:3383 Audio Codec
Compare [G723:4:8000:30:32000]/[GSM:3:8000:20:13200]*
*2014-06-05 13:58:00.462309 [DEBUG] switch_core_media.c:3383 Audio Codec
Compare [G726-32:2:8000:30:32000]/[G722:9:8000:20:64000]*
*2014-06-05 13:58:00.462309 [DEBUG] switch_core_media.c:3383 Audio Codec
Compare [G726-32:2:8000:30:32000]/[PCMU:0:8000:20:64000]*
*2014-06-05 13:58:00.462309 [DEBUG] switch_core_media.c:3383 Audio Codec
Compare [G726-32:2:8000:30:32000]/[PCMA:8:8000:20:64000]*
*2014-06-05 13:58:00.462309 [DEBUG] switch_core_media.c:3383 Audio Codec
Compare [G726-32:2:8000:30:32000]/[GSM:3:8000:20:13200]*
*2014-06-05 13:58:00.462309 [DEBUG] switch_core_media.c:3383 Audio Codec
Compare [G722:9:16000:30:32000]/[G722:9:8000:20:64000]*
*2014-06-05 13:58:00.462309 [DEBUG] switch_core_media.c:3383 Audio Codec
Compare [G722:9:16000:30:32000]/[PCMU:0:8000:20:64000]*
*2014-06-05 13:58:00.462309 [DEBUG] switch_core_media.c:3383 Audio Codec
Compare [G722:9:16000:30:32000]/[PCMA:8:8000:20:64000]*
*2014-06-05 13:58:00.462309 [DEBUG] switch_core_media.c:3383 Audio Codec
Compare [G722:9:16000:30:32000]/[GSM:3:8000:20:13200]*
*2014-06-05 13:58:00.482314 [DEBUG] switch_core_media.c:3309 Set
telephone-event payload to 101*
*2014-06-05 13:58:00.482314 [DEBUG] switch_core_media.c:3626 Set 2833 dtmf
send/recv payload to 101*
*2014-06-05 13:58:00.482314 [ERR] mod_sofia.c:2201 CODEC NEGOTIATION ERROR.
 SDP:*
*v=0*
*o=1005 75411051 19394211 IN IP4 10.0.4.4*
*s=A conversation*
*c=IN IP4 10.0.4.4*
*t=0 0*
*m=audio 10136 RTP/AVP 0 8 18 4 2 9 101*
*a=rtpmap:0 PCMU/8000*
*a=rtpmap:8 PCMA/8000*
*a=rtpmap:18 G729/8000*
*a=rtpmap:4 G723/8000*
*a=rtpmap:2 G726-32/8000*
*a=rtpmap:9 G722/16000*
*a=rtpmap:101 telephone-event/8000*
*a=fmtp:101 0-15*

On Thu, Jun 5, 2014 at 3:26 PM, Steven Ayre <steveayre at gmail.com> wrote:

> Looks like a ptime mismatch, can you set the phone to use 20ms?
>
>
> On 5 June 2014 10:06, Shlomi Agiv <shlomi.agiv at cell-buddy.com> wrote:
>
>> Hi,
>> I'm running freswitch version 1.4.4 and getting a strange codec error
>>
>> when i call from a phone running CSIPSIMPLE(registered as user 1000) to
>> 1005, the call hangs up and I get:
>> *2014-06-05 08:31:59.168784 [INFO] switch_ivr_originate.c:1191 Sending
>> early media*
>> *2014-06-05 08:31:59.168784 [DEBUG] switch_core_media.c:3383 Audio Codec
>> Compare [SILK:99:24000:20:0]/[G722:9:8000:20:64000]*
>> *2014-06-05 08:31:59.168784 [DEBUG] switch_core_media.c:3383 Audio Codec
>> Compare [SILK:99:24000:20:0]/[PCMU:0:8000:20:64000]*
>> *2014-06-05 08:31:59.168784 [DEBUG] switch_core_media.c:3383 Audio Codec
>> Compare [SILK:99:24000:20:0]/[PCMA:8:8000:20:64000]*
>> *2014-06-05 08:31:59.168784 [DEBUG] switch_core_media.c:3383 Audio Codec
>> Compare [SILK:99:24000:20:0]/[GSM:3:8000:20:13200]*
>> *2014-06-05 08:31:59.168784 [DEBUG] switch_core_media.c:3383 Audio Codec
>> Compare [PCMU:0:8000:30:32000]/[G722:9:8000:20:64000]*
>> *2014-06-05 08:31:59.168784 [DEBUG] switch_core_media.c:3383 Audio Codec
>> Compare [PCMU:0:8000:30:32000]/[PCMU:0:8000:20:64000]*
>> *2014-06-05 08:31:59.168784 [DEBUG] switch_core_media.c:3383 Audio Codec
>> Compare [PCMU:0:8000:30:32000]/[PCMA:8:8000:20:64000]*
>> *2014-06-05 08:31:59.168784 [DEBUG] switch_core_media.c:3383 Audio Codec
>> Compare [PCMU:0:8000:30:32000]/[GSM:3:8000:20:13200]*
>> *2014-06-05 08:31:59.168784 [DEBUG] switch_core_media.c:3383 Audio Codec
>> Compare [PCMA:8:8000:30:32000]/[G722:9:8000:20:64000]*
>> *2014-06-05 08:31:59.168784 [DEBUG] switch_core_media.c:3383 Audio Codec
>> Compare [PCMA:8:8000:30:32000]/[PCMU:0:8000:20:64000]*
>> *2014-06-05 08:31:59.168784 [DEBUG] switch_core_media.c:3383 Audio Codec
>> Compare [PCMA:8:8000:30:32000]/[PCMA:8:8000:20:64000]*
>> *2014-06-05 08:31:59.168784 [DEBUG] switch_core_media.c:3383 Audio Codec
>> Compare [PCMA:8:8000:30:32000]/[GSM:3:8000:20:13200]*
>> *2014-06-05 08:31:59.168784 [DEBUG] switch_core_media.c:3309 Set
>> telephone-event payload to 101*
>> *2014-06-05 08:31:59.168784 [DEBUG] switch_core_media.c:3626 Set 2833
>> dtmf send/recv payload to 101*
>> *2014-06-05 08:31:59.168784 [ERR] mod_sofia.c:2201 CODEC NEGOTIATION
>> ERROR.  SDP:*
>> *v=0*
>> *o=- 3610945918 3610945918 IN IP4 10.0.1.46*
>> *s=pjmedia*
>> *c=IN IP4 10.0.1.46*
>> *t=0 0*
>> *m=audio 4020 RTP/AVP 99 0 8 101*
>> *c=IN IP4 10.0.1.46*
>> *a=rtpmap:99 SILK/24000*
>> *a=fmtp:99 useinbandfec=0*
>> *a=rtpmap:0 PCMU/8000*
>> *a=rtpmap:8 PCMA/8000*
>> *a=rtpmap:101 telephone-event/8000*
>> *a=fmtp:101 0-15*
>> *a=rtcp:4021 IN IP4 10.0.1.46*
>>
>> *2014-06-05 08:31:59.168784 [DEBUG] switch_core_session.c:907 Send signal
>> sofia/internal/1000 at 10.0.1.233 <1000 at 10.0.1.233> [BREAK]*
>> *2014-06-05 08:31:59.168784 [NOTICE] switch_channel.c:3432 Hangup
>> sofia/internal/1000 at 10.0.1.233 <1000 at 10.0.1.233> [CS_EXECUTE]
>> [INCOMPATIBLE_DESTINATION]*
>>
>>
>> when i call using cmd 'originate user/1005 &bridge(user/1000)' The call
>> goes through and I get:
>>
>> *2014-06-05 08:25:18.073562 [DEBUG] switch_core_media.c:3383 Audio Codec
>> Compare [PCMU:0:8000:20:64000]/[PCMU:0:8000:20:64000]*
>> *2014-06-05 08:25:18.073562 [DEBUG] switch_core_media.c:3437 Audio Codec
>> Compare [PCMU:0:8000:20:64000] ++++ is saved as a match*
>> *2014-06-05 08:25:18.073562 [DEBUG] switch_core_media.c:3383 Audio Codec
>> Compare [PCMU:0:8000:20:64000]/[G722:9:8000:20:64000]*
>> *2014-06-05 08:25:18.073562 [DEBUG] switch_core_media.c:3383 Audio Codec
>> Compare [PCMU:0:8000:20:64000]/[PCMA:8:8000:20:64000]*
>> *2014-06-05 08:25:18.073562 [DEBUG] switch_core_media.c:3383 Audio Codec
>> Compare [PCMU:0:8000:20:64000]/[GSM:3:8000:20:13200]*
>> *2014-06-05 08:25:18.073562 [DEBUG] switch_core_media.c:3309 Set
>> telephone-event payload to 101*
>> *2014-06-05 08:25:18.073562 [DEBUG] switch_core_media.c:2343 Set Codec
>> sofia/internal/sip:1000 at 10.0.1.46:51113 <http://sip:1000@10.0.1.46:51113>
>> PCMU/8000 20 ms 160 samples 64000 bits*
>> *2014-06-05 08:25:18.073562 [DEBUG] switch_core_codec.c:111
>> sofia/internal/sip:1000 at 10.0.1.46:51113 <http://sip:1000@10.0.1.46:51113>
>> Original read codec set to PCMU:0*
>>  *2014-06-05 08:25:18.093570 [DEBUG] switch_core_media.c:3617 Set 2833
>> dtmf send payload to 101*
>> *2014-06-05 08:25:18.093570 [DEBUG] switch_core_media.c:4841 AUDIO RTP
>> [sofia/internal/sip:1000 at 10.0.1.46:51113 <http://sip:1000@10.0.1.46:51113>]
>> 10.0.1.233 port 32636 -> 10.0.1.46 port 4016 codec: 0 ms: 20*
>> *2014-06-05 08:25:18.093570 [DEBUG] switch_rtp.c:3349 Starting timer
>> [soft] 160 bytes per 20ms*
>> *2014-06-05 08:25:18.113587 [INFO] switch_core_media.c:5053 Activating
>> RTCP PORT 4017*
>>
>>
>> Even stranger, when I call using the same configuration under 1.2.17, the
>> call goes through:
>> *2014-06-05 08:43:39.400774 [DEBUG] sofia_glue.c:5278 Audio Codec Compare
>> [SILK:99:24000:20:0]/[G722:9:8000:20:64000]*
>> *2014-06-05 08:43:39.400774 [DEBUG] sofia_glue.c:5278 Audio Codec Compare
>> [SILK:99:24000:20:0]/[PCMU:0:8000:20:64000]*
>> *2014-06-05 08:43:39.400774 [DEBUG] sofia_glue.c:5278 Audio Codec Compare
>> [SILK:99:24000:20:0]/[PCMA:8:8000:20:64000]*
>> *2014-06-05 08:43:39.400774 [DEBUG] sofia_glue.c:5278 Audio Codec Compare
>> [SILK:99:24000:20:0]/[GSM:3:8000:20:13200]*
>> *2014-06-05 08:43:39.400774 [DEBUG] sofia_glue.c:5278 Audio Codec Compare
>> [PCMU:0:8000:20:64000]/[G722:9:8000:20:64000]*
>> *2014-06-05 08:43:39.400774 [DEBUG] sofia_glue.c:5278 Audio Codec Compare
>> [PCMU:0:8000:20:64000]/[PCMU:0:8000:20:64000]*
>> *2014-06-05 08:43:39.400774 [DEBUG] sofia_glue.c:3186 Set Codec
>> sofia/internal/1000 at 10.0.1.233 <1000 at 10.0.1.233> PCMU/8000 20 ms 160
>> samples 64000 bits*
>> *2014-06-05 08:43:39.400774 [DEBUG] switch_core_codec.c:111
>> sofia/internal/1000 at 10.0.1.233 <1000 at 10.0.1.233> Original read codec set to
>> PCMU:0*
>> *2014-06-05 08:43:39.400774 [DEBUG] sofia_glue.c:5446 Set 2833 dtmf
>> send/recv payload to 101*
>> *2014-06-05 08:43:39.400774 [DEBUG] sofia_glue.c:3445 AUDIO RTP
>> [sofia/internal/1000 at 10.0.1.233 <1000 at 10.0.1.233>] 10.0.1.233 port 23172 ->
>> 10.0.1.46 port 4004 codec: 0 ms: 20*
>>
>>
>> what could possibly be the reason for that? I have little understanding
>> of codecs handling.
>> Thanks,
>> Shlomi Agiv
>>
>>
>> _________________________________________________________________________
>> Professional FreeSWITCH Consulting Services:
>> consulting at freeswitch.org
>> http://www.freeswitchsolutions.com
>>
>> 
>> 
>>
>> Official FreeSWITCH Sites
>> http://www.freeswitch.org
>> http://wiki.freeswitch.org
>> http://www.cluecon.com
>>
>> FreeSWITCH-users mailing list
>> FreeSWITCH-users at lists.freeswitch.org
>> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
>> UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
>> http://www.freeswitch.org
>>
>>
>
> _________________________________________________________________________
> Professional FreeSWITCH Consulting Services:
> consulting at freeswitch.org
> http://www.freeswitchsolutions.com
>
> 
> 
>
> Official FreeSWITCH Sites
> http://www.freeswitch.org
> http://wiki.freeswitch.org
> http://www.cluecon.com
>
> FreeSWITCH-users mailing list
> FreeSWITCH-users at lists.freeswitch.org
> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
> UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
> http://www.freeswitch.org
>
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20140605/3e73a0b4/attachment-0001.html 