Hi Mike,

Thanks for the reply.

yes, the negation codec is done correctly at least from the output messages in the logs.


I found the source of the problem, for some i have multiple FS pids, restarting solve my problem., now there is only one. No more drop calls.

The "defunct" happen because the g729 license-server wasn't fully started, this is a known issue, but the two main pid's no idea why.

Just in case i also set in switch.xml the parameter threaded-system-exec"  to "true".


Just for info, the output for "ps aux | grep freeswit" when the problem happen:

0  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     11741  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     11755  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     11756  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     11773  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     11803  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     11804  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     11838  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     12027  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     12194  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     12195  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     12232  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     13966  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     14562  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     14563  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     14564  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     14586  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     14590  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     14630  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     14652  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     14653  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     14670  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     14801  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     14802  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     16401  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     16792  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     16899  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     16900  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     16909  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     16910  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     16930  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     16931  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     17092  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     17093  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     17128  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     17301  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     17318  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     17319  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     17320  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     17321  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     17341  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     17342  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     17375  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     17376  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     17386  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     17387  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     17407  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     17461  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     17462  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     18870  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     18879  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     18905  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     18906  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     19084  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     19085  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     19332  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     19333  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     19334  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     19351  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     19352  0.0  0.0      0     0 ?        Z<   Oct07   0:00  \_ [freeswitch] <defunct>

root     24268  0.0  2.2 1259792 739152 ?      SN   Oct10   0:00  \_ /usr/bin/freeswitch -ncwait -nonat -scripts /opt/commsmundi/scripts/fs

root     24855  0.0  4.2 1920068 1397272 ?     SN   Oct23   0:00  \_ /usr/bin/freeswitch -ncwait -nonat -scripts /opt/commsmundi/scripts/fs


On 24/10/2019 20:35, Mike Jerris wrote:
Take a look at log with sip trace enabled but this usually happens when we can’t negotiate codecs.

On Oct 24, 2019, at 10:19 AM, António Silva via FreeSWITCH-users <freeswitch-users@lists.freeswitch.org> wrote:


From: António Silva <asilva@wirelessmundi.com>
Subject: call drop because of no write codec, incompatible_destination
Date: October 24, 2019 at 9:40:00 AM MDT
To: FreeSWITCH Users Help <freeswitch-users@lists.freeswitch.org>


Hi,

I'm seeing multiple calls drop with incompatible_destination, i try to call again the same destination and it works fine. it gets me crazy...

In logs i see the error, "has no write codec",  in the capture i see the negotiation both sides have codecs, they are correctly configure in directory.

what could be causing this? i'm using version 1.8.6


Part of the LOG where the error happens:

f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:37.694352 [ALERT] switch_core_state_machine.c:701 sofia/1-perfil-fija/sip:11@131.179.185.131:5112 session thread sleep state: CS_CONSUME_MEDIA!
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:41.794408 [ALERT] switch_core_session.c:1130 Send signal sofia/1-perfil-fija/sip:11@131.179.185.131:5112 [BREAK]
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:41.794408 [ALERT] switch_core_session.c:1130 Send signal sofia/1-perfil-fija/sip:11@131.179.185.131:5112 [BREAK]
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:41.794408 [ALERT] switch_core_state_machine.c:705 sofia/1-perfil-fija/sip:11@131.179.185.131:5112 session thread wake state: CS_CONSUME_MEDIA!
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:41.814367 [ALERT] switch_core_media.c:486 Looking for zrtp-hash
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:41.814367 [ALERT] switch_core_media.c:439 Deciding whether to pass zrtp-hash between legs
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:41.814367 [ALERT] switch_core_media.c:441 CF_ZRTP_PASSTHRU_REQ not set, so not propagating zrtp-hash
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:41.834519 [DEBUG] sofia.c:7325 Channel sofia/1-perfil-fija/sip:11@131.179.185.131:5112 entering state [completing][200]
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:41.834519 [DEBUG] sofia.c:7335 Remote SDP:
f39e569f-5184-481a-9f67-6185367e2829 v=0
f39e569f-5184-481a-9f67-6185367e2829 o=11 5008 38 IN IP4 192.168.100.11
f39e569f-5184-481a-9f67-6185367e2829 s=Mapping
f39e569f-5184-481a-9f67-6185367e2829 c=IN IP4 192.168.100.11
f39e569f-5184-481a-9f67-6185367e2829 t=0 0
f39e569f-5184-481a-9f67-6185367e2829 m=audio 5008 RTP/AVP 0 101
f39e569f-5184-481a-9f67-6185367e2829 a=rtpmap:0 PCMU/8000
f39e569f-5184-481a-9f67-6185367e2829 a=rtpmap:101 telephone-event/8000
f39e569f-5184-481a-9f67-6185367e2829 a=fmtp:101 0-16
f39e569f-5184-481a-9f67-6185367e2829 a=ptime:20
f39e569f-5184-481a-9f67-6185367e2829
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:41.834519 [NOTICE] sofia.c:7338 Pre-Answer sofia/1-perfil-fija/sip:11@131.179.185.131:5112!
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:41.934371 [ALERT] switch_core_session.c:2662 sofia/1-perfil-fija/sip:11@131.179.185.131:5112 Send KeyFrame
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:41.934371 [DEBUG] switch_core_session.c:2825 EXECUTE [depth=1] sofia/1-perfil-fija/sip:11@131.179.185.131:5112 lua(execute_on_ring_b.lua)
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:41.934371 [ALERT] switch_core_session.c:2889 sofia/1-perfil-fija/sip:11@131.179.185.131:5112 receive message [APPLICATION_EXEC]
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:41.934371 [ALERT] switch_core_session.c:1047 Send signal sofia/1-perfil-fija/sip:11@131.179.185.131:5112 [BREAK]
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:41.954358 [ALERT] switch_core_session.c:1047 Send signal sofia/1-perfil-fija/sip:11@131.179.185.131:5112 [BREAK]
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:41.954358 [ALERT] switch_ivr_originate.c:4136 sofia/1-perfil-fija/sip:11@131.179.185.131:5112 receive message [AUDIO_SYNC]
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:42.034370 [DEBUG] switch_cpp.cpp:1187 sofia/1-perfil-fija/sip:11@131.179.185.131:5112 destroy/unlink session from object
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:42.034370 [ALERT] switch_core_session.c:2905 sofia/1-perfil-fija/sip:11@131.179.185.131:5112 receive message [APPLICATION_EXEC_COMPLETE]
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:42.034370 [DEBUG] switch_channel.c:3537 (sofia/1-perfil-fija/sip:11@131.179.185.131:5112) Callstate Change RINGING -> EARLY
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:42.094512 [ALERT] sofia.c:7338 sofia/1-perfil-fija/sip:11@131.179.185.131:5112 receive message [PROGRESS_EVENT]
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:42.094512 [ALERT] switch_core_media.c:486 Looking for zrtp-hash
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:42.094512 [ALERT] switch_core_media.c:439 Deciding whether to pass zrtp-hash between legs
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:42.094512 [ALERT] switch_core_media.c:441 CF_ZRTP_PASSTHRU_REQ not set, so not propagating zrtp-hash
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:42.094512 [ALERT] switch_ivr_bridge.c:1650 sofia/1-perfil-fija/sip:11@131.179.185.131:5112 receive message [AUDIO_SYNC]
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:42.094512 [ALERT] switch_core_state_machine.c:701 sofia/1-perfil-fija/sip:11@131.179.185.131:5112 session thread sleep state: CS_CONSUME_MEDIA!
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:42.094512 [ALERT] switch_ivr_bridge.c:1751 sofia/1-perfil-fija/sip:11@131.179.185.131:5112 receive message [BRIDGE]
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:42.094512 [ALERT] switch_core_session.c:981 Send signal sofia/1-perfil-fija/sip:11@131.179.185.131:5112 [BREAK]
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:42.094512 [DEBUG] switch_ivr_bridge.c:1795 (sofia/1-perfil-fija/sip:11@131.179.185.131:5112) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:42.094512 [ALERT] switch_core_session.c:1480 Send signal sofia/1-perfil-fija/sip:11@131.179.185.131:5112 [BREAK]
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:42.114382 [ALERT] switch_core_state_machine.c:705 sofia/1-perfil-fija/sip:11@131.179.185.131:5112 session thread wake state: CS_CONSUME_MEDIA!
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:42.114382 [DEBUG] switch_core_state_machine.c:584 (sofia/1-perfil-fija/sip:11@131.179.185.131:5112) Running State Change CS_EXCHANGE_MEDIA (Cur 242 Tot 835614)
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:42.114382 [DEBUG] switch_core_state_machine.c:653 (sofia/1-perfil-fija/sip:11@131.179.185.131:5112) State EXCHANGE_MEDIA
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:42.114382 [ALERT] switch_core_state_machine.c:653 sofia/1-perfil-fija/sip:11@131.179.185.131:5112 Send KeyFrame
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:42.114382 [DEBUG] mod_sofia.c:657 SOFIA EXCHANGE_MEDIA
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:42.134357 [ERR] switch_core_media.c:15507 sofia/1-perfil-fija/sip:11@131.179.185.131:5112 has no write codec.
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:42.134357 [NOTICE] switch_core_media.c:15508 Hangup sofia/1-perfil-fija/sip:11@131.179.185.131:5112 [CS_EXCHANGE_MEDIA] [INCOMPATIBLE_DESTINATION]
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:42.134357 [ALERT] switch_channel.c:3346 Send signal sofia/1-perfil-fija/sip:11@131.179.185.131:5112 [KILL]
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:42.134357 [DEBUG] mod_hash.c:297 Usage for total_account:11@clinicalluch.daratel.com is now 0
f39e569f-5184-481a-9f67-6185367e2829 2019-10-21 11:50:42.134357 [ALERT] switch_core_session.c:1480 Send signal sofia/1-perfil-fija/sip:11@131.179.185.131:5112 [BREAK]



--
Saludos / Regards / Cumprimentos
António Silva




_________________________________________________________________________

The FreeSWITCH project is sponsored by SignalWire https://signalwire.com
Enhance your FreeSWITCH install with disruptive priced SMS and PSTN services.
Build your next product on our scalable cloud platform.

Join our online community to chat in real time https://signalwire.community

Professional FreeSWITCH Services
sales@freeswitch.com
https://freeswitch.com

Official FreeSWITCH Sites
https://freeswitch.com/oss
https://freeswitch.org/confluence
https://cluecon.com

FreeSWITCH-users mailing list
FreeSWITCH-users@lists.freeswitch.org
http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
https://freeswitch.com

-- 
Saludos / Regards / Cumprimentos
António Silva