Hi,
since updating from FreeSWITCH 1.6.8 to FreeSWITCH 1.6.17 (Windows Server 2012 R2), the Event Socket Handler(inbound mode) sporadically stops sending Channel related Event Info.
Once in this situation, the Event Socket Handler does not recover until either reset of the ESL connection by the Host that established the ESL connection or reload of mod_event_socket.
Shortly before Event Socket connection drops it seems that there is a problem trying to close a channel.
Example Log for failure case: Channel with uuid d9be476b-6a9d-4c96-95fb-5d8728bcc08e is never closed after leavig the conference.
d9be476b-6a9d-4c96-95fb-5d8728bcc08e 2017-08-29 10:59:35.399989 [NOTICE] switch_channel.c:1104 New Channel sofia/external/149@dialin [d9be476b-6a9d-4c96-95fb-5d8728bcc08e]
d9be476b-6a9d-4c96-95fb-5d8728bcc08e 2017-08-29 10:59:35.399989 [INFO] mod_dialplan_xml.c:637 Processing 149 <149>->4600 in context public
d9be476b-6a9d-4c96-95fb-5d8728bcc08e 2017-08-29 10:59:35.399989 [NOTICE] switch_ivr.c:2172 Transfer sofia/external/149@dialin to XML[4600@default]
d9be476b-6a9d-4c96-95fb-5d8728bcc08e 2017-08-29 10:59:35.419958 [INFO] mod_dialplan_xml.c:637 Processing 149 <149>->4600 in context default
d9be476b-6a9d-4c96-95fb-5d8728bcc08e 2017-08-29 10:59:35.439966 [NOTICE] mod_dptools.c:1312 Channel [sofia/external/149@dialin] has been answered
d9be476b-6a9d-4c96-95fb-5d8728bcc08e 2017-08-29 10:59:55.940144 [NOTICE] sofia.c:1012 Hangup sofia/external/149@dialin [CS_EXECUTE] [NORMAL_CLEARING]
d9be476b-6a9d-4c96-95fb-5d8728bcc08e 2017-08-29 10:59:55.940144 [INFO] conference_loop.c:1469 Channel leaving conference, cause: NORMAL_CLEARING
Example Log for regular case: Channel with uuid 982453be-a321-4825-a944-ecfffa715914 is closed correctly after leaving the conference):
982453be-a321-4825-a944-ecfffa715914 2017-08-29 10:55:51.340132 [NOTICE] switch_channel.c:1104 New Channel sofia/external/149@dialin [982453be-a321-4825-a944-ecfffa715914]
982453be-a321-4825-a944-ecfffa715914 2017-08-29 10:55:51.340132 [INFO] mod_dialplan_xml.c:637 Processing 149 <149>->4600 in context public
982453be-a321-4825-a944-ecfffa715914 2017-08-29 10:55:51.360126 [NOTICE] switch_ivr.c:2172 Transfer sofia/external/149@dialin to XML[4600@default]
982453be-a321-4825-a944-ecfffa715914 2017-08-29 10:55:51.360126 [INFO] mod_dialplan_xml.c:637 Processing 149 <149>->4600 in context default
982453be-a321-4825-a944-ecfffa715914 2017-08-29 10:55:51.380148 [NOTICE] mod_dptools.c:1312 Channel [sofia/external/149@dialin] has been answered
982453be-a321-4825-a944-ecfffa715914 2017-08-29 10:56:11.900321 [NOTICE] sofia.c:1012 Hangup sofia/external/149@dialin [CS_EXECUTE] [NORMAL_CLEARING]
982453be-a321-4825-a944-ecfffa715914 2017-08-29 10:56:11.900321 [INFO] conference_loop.c:1469 Channel leaving conference, cause: NORMAL_CLEARING
982453be-a321-4825-a944-ecfffa715914 2017-08-29 10:56:11.900321 [NOTICE] switch_core_session.c:1683 Session 9744 (sofia/external/149@dialin) Ended
982453be-a321-4825-a944-ecfffa715914 2017-08-29 10:56:11.900321 [NOTICE] switch_core_session.c:1687 Close Channel sofia/external/149@dialin [CS_DESTROY]
The channel with uuid d9be476b-6a9d-4c96-95fb-5d8728bcc08e will still be displayed at fs_cli on request of “show channels”
freeswitch@1250-0110> show channels
uuid,direction,created,created_epoch,name,state,cid_name,cid_num,ip_addr,dest,application,application_data,dialplan,context,read_codec,read_rate,read_bit_rate,write_codec,write_rate,write_bit_rate,secure,hostname,presence_id,presence_data,accountcode,callstate,callee_name,callee_num,callee_direction,call_uuid,sent_callee_name,sent_callee_num,initial_cid_name,initial_cid_num,initial_ip_addr,initial_dest,initial_dialplan,initial_context
d9be476b-6a9d-4c96-95fb-5d8728bcc08e,inbound,2017-08-29 10:59:35,1503997175,sofia/external/149@dialin,CS_EXECUTE,149,149,dialin,4600,playback,{playBackId=2573}us/announcement.wav,XML,default,L16,8000,128000,PCMA,8000,64000,,1250-0110,,,,ACTIVE,,,,,,,149,149,dialin,4600,XML,public
1 total.
However, trying to retrieve the channel data for this channel e.g. "uuid_dump" fails.
freeswitch@1250-0110> uuid_dump d9be476b-6a9d-4c96-95fb-5d8728bcc08e
-ERR No such channel!
Same issue exists with FreeSWITCH 1.6.19.
We are continuously sending api commands to the channel.
Could this be a race condition, receiving an api, while the Channel is trying to close ?
Would bgapi help ?
Why is it not an issue with FreeSWITCH 1.6.8 ?
Regards,
Tobias