freeswitch
freeswitch copied to clipboard
the channels often not destroyed
Freeswitch version 1.10.7 (the latest version of Git is the same). ESL connection control is adopted. When the call is connected, if uuid_record is sent to record and send uuid_kill immediately to hangs up. In this case, the channels often not destroyed. You can see it in "show channels".
Trace code discovery, recording_thread does not exit (the code position is not fixed), so the state machine cannot do destroy. Whether there are such problems, thank you!
log: 2022-06-01 20:18:47.269469 98.83% [NOTICE] mod_commands.c:3867 Channel [sofia/external/[email protected]:15580] has been answered 2022-06-01 20:18:47.269469 98.83% [DEBUG] switch_channel.c:3950 (sofia/external/[email protected]:15580) Callstate Change EARLY -> ACTIVE 2022-06-01 20:18:47.269469 98.83% [DEBUG] sofia.c:7499 Channel sofia/external/[email protected]:15580 entering state [completed][200] 2022-06-01 20:18:47.289464 98.83% [DEBUG] sofia.c:7499 Channel sofia/external/[email protected]:15580 entering state [ready][200]
2022-06-01 20:18:47.369468 98.83% [NOTICE] switch_ivr.c:4403 Hangup sofia/external/[email protected]:15580 [CS_EXECUTE] [NORMAL_CLEARING] 2022-06-01 20:18:47.369468 98.83% [DEBUG] switch_core_session.c:2983 sofia/external/[email protected]:15580 skip receive message [PHONE_EVENT] (channel is hungup already) 2022-06-01 20:18:47.369468 98.83% [DEBUG] switch_core_state_machine.c:647 (sofia/external/[email protected]:15580) State EXECUTE going to sleep 2022-06-01 20:18:47.369468 98.83% [DEBUG] switch_core_state_machine.c:581 (sofia/external/[email protected]:15580) Running State Change CS_HANGUP (Cur 2 Tot 8) 2022-06-01 20:18:47.369468 98.83% [DEBUG] switch_core_state_machine.c:844 (sofia/external/[email protected]:15580) Callstate Change ACTIVE -> HANGUP 2022-06-01 20:18:47.369468 98.83% [DEBUG] switch_core_state_machine.c:846 (sofia/external/[email protected]:15580) State HANGUP 2022-06-01 20:18:47.369468 98.83% [DEBUG] mod_sofia.c:468 Channel sofia/external/[email protected]:15580 hanging up, cause: NORMAL_CLEARING 2022-06-01 20:18:47.369468 98.83% [DEBUG] mod_sofia.c:522 Sending BYE to sofia/external/[email protected]:15580 2022-06-01 20:18:47.369468 98.83% [DEBUG] switch_core_state_machine.c:59 sofia/external/[email protected]:15580 Standard HANGUP, cause: NORMAL_CLEARING 2022-06-01 20:18:47.369468 98.83% [DEBUG] switch_core_state_machine.c:846 (sofia/external/[email protected]:15580) State HANGUP going to sleep 2022-06-01 20:18:47.369468 98.83% [DEBUG] switch_core_state_machine.c:616 (sofia/external/[email protected]:15580) State Change CS_HANGUP -> CS_REPORTING 2022-06-01 20:18:47.369468 98.83% [DEBUG] switch_core_state_machine.c:581 (sofia/external/[email protected]:15580) Running State Change CS_REPORTING (Cur 2 Tot 8) 2022-06-01 20:18:47.369468 98.83% [DEBUG] switch_core_state_machine.c:932 (sofia/external/[email protected]:15580) State REPORTING 2022-06-01 20:18:47.369468 98.83% [DEBUG] switch_core_state_machine.c:168 sofia/external/[email protected]:15580 Standard REPORTING, cause: NORMAL_CLEARING 2022-06-01 20:18:47.369468 98.83% [DEBUG] switch_core_state_machine.c:932 (sofia/external/[email protected]:15580) State REPORTING going to sleep 2022-06-01 20:18:47.369468 98.83% [DEBUG] switch_core_state_machine.c:607 (sofia/external/[email protected]:15580) State Change CS_REPORTING -> CS_DESTROY 2022-06-01 20:18:47.369468 98.83% [DEBUG] switch_core_session.c:1753 Session 8 (sofia/external/[email protected]:15580) Locked, Waiting on external entities 2022-06-01 20:18:47.369468 98.83% [DEBUG] switch_ivr_async.c:1503 Record session sample rate: 8000 -> 8000 2022-06-01 20:18:47.369468 98.83% [DEBUG] switch_core_media_bug.c:978 Attaching BUG to sofia/external/[email protected]:15580
Can you attach a test case that can be ran to recreate this on demand?
Sorry, I don't have a demo program. The program I tested needs other environments and can't be run directly!
After testing, Using "bgapi uuid_record ..." will have problems, but using "api uuid_record ..." is normal.
I ran into the same issue and i can repeat the case.It's a lock issue.
hangup function call list: 1、switch_channel_perform_hangup 2、switch_core_session_thread_launch 3、switch_thread_create 4、switch_core_session_thread 5、switch_core_media_bug_remove_all 6、switch_core_session_write_lock
uuid_record function call list: 1、switch_ivr_record_session_event 2、switch_core_media_bug_add 3、switch_thread_rwlock_wrlock
repeat cause: when after switch_core_media_bug_remove_all(hangup function call list) call switch_core_media_bug_add(uuid_record function call list),will be block at switch_core_session_write_lock(hangup function call list)
@406112767 Can you provide us the steps on how to reproduce it?
@greenbea I can't reproduce the issue 100%, but there is a good chance that I will reproduce the problem by following the steps below in caller, I use ESL connection listen CHANNEL_PROGRESS_MEDIA event, when receive CHANNEL_PROGRESS_MEDIA event perform uuid_record. use commands in fs_cli: originate {return_ring_ready=true}sofia/gateway/pressure/787675 &park()
and I use another freeswitch as the callee; callee freeswitch has diaplan:
<extension name="testesl765"> <condition field="destination_number" expression="^787675$"> <action application="sleep" data="5000"/> <action application="pre_answer"/> <action application="sleep" data="1"/> <action application="hangup"/> </condition> </extension>
@greenbea
Compare log discovery, have a deadlock. the following logs: 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_ivr_async.c:1275 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [ERR] switch_core_session.c:1755 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Write lock ACQUIRED
exception case log: 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [NOTICE] switch_channel.c:1123 New Channel sofia/external/787675 [766fe459-d040-441b-91e5-07052eb23ad5] 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [DEBUG] mod_sofia.c:5121 (sofia/external/787675) State Change CS_NEW -> CS_INIT 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [ERR] switch_ivr_originate.c:3063 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [DEBUG] switch_core_state_machine.c:581 (sofia/external/787675) Running State Change CS_INIT (Cur 7 Tot 9) 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [DEBUG] switch_core_state_machine.c:624 (sofia/external/787675) State INIT 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [ERR] switch_ivr.c:4022 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [DEBUG] mod_sofia.c:97 sofia/external/787675 SOFIA INIT 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [ERR] switch_ivr.c:4023 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [INFO] sofia_glue.c:1651 sofia/external/787675 sending invite call-id: (null) 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [DEBUG] sofia_glue.c:1654 sofia/external/787675 sending invite version: 1.10.7-release 64bit 766fe459-d040-441b-91e5-07052eb23ad5 Local SDP: 766fe459-d040-441b-91e5-07052eb23ad5 v=0 766fe459-d040-441b-91e5-07052eb23ad5 o=FreeSWITCH 1669846615 1669846616 IN IP4 192.168.31.232 766fe459-d040-441b-91e5-07052eb23ad5 s=FreeSWITCH 766fe459-d040-441b-91e5-07052eb23ad5 c=IN IP4 192.168.31.232 766fe459-d040-441b-91e5-07052eb23ad5 t=0 0 766fe459-d040-441b-91e5-07052eb23ad5 m=audio 26974 RTP/AVP 8 0 101 766fe459-d040-441b-91e5-07052eb23ad5 a=rtpmap:8 PCMA/8000 766fe459-d040-441b-91e5-07052eb23ad5 a=rtpmap:0 PCMU/8000 766fe459-d040-441b-91e5-07052eb23ad5 a=rtpmap:101 telephone-event/8000 766fe459-d040-441b-91e5-07052eb23ad5 a=fmtp:101 0-15 766fe459-d040-441b-91e5-07052eb23ad5 a=rtcp:26975 IN IP4 192.168.31.232 766fe459-d040-441b-91e5-07052eb23ad5 a=ptime:20 766fe459-d040-441b-91e5-07052eb23ad5 a=sendrecv 766fe459-d040-441b-91e5-07052eb23ad5 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [DEBUG] switch_core_state_machine.c:40 sofia/external/787675 Standard INIT 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [DEBUG] switch_core_state_machine.c:48 (sofia/external/787675) State Change CS_INIT -> CS_ROUTING 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [DEBUG] switch_core_state_machine.c:624 (sofia/external/787675) State INIT going to sleep 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [ERR] switch_ivr.c:4022 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [ERR] switch_ivr.c:4023 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [DEBUG] switch_core_state_machine.c:581 (sofia/external/787675) Running State Change CS_ROUTING (Cur 7 Tot 9) 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [DEBUG] switch_core_state_machine.c:640 (sofia/external/787675) State ROUTING 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [ERR] switch_ivr.c:4022 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [DEBUG] mod_sofia.c:158 sofia/external/787675 SOFIA ROUTING 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [ERR] switch_ivr.c:4023 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [DEBUG] switch_ivr_originate.c:67 (sofia/external/787675) State Change CS_ROUTING -> CS_CONSUME_MEDIA 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [DEBUG] switch_core_state_machine.c:640 (sofia/external/787675) State ROUTING going to sleep 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [DEBUG] switch_core_state_machine.c:581 (sofia/external/787675) Running State Change CS_CONSUME_MEDIA (Cur 7 Tot 9) 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [ERR] switch_ivr.c:4022 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [ERR] switch_ivr.c:4023 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [DEBUG] switch_core_state_machine.c:659 (sofia/external/787675) State CONSUME_MEDIA 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [DEBUG] switch_core_state_machine.c:659 (sofia/external/787675) State CONSUME_MEDIA going to sleep 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [ERR] switch_ivr.c:4022 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [ERR] switch_ivr.c:4023 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [ERR] sofia.c:2636 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [ERR] sofia.c:2638 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:29.994188 90.53% [DEBUG] sofia.c:7499 Channel sofia/external/787675 entering state [calling][0] 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] sofia.c:2636 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] sofia.c:2638 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] sofia.c:2636 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] sofia.c:2638 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] sofia.c:7499 Channel sofia/external/787675 entering state [proceeding][183] 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] sofia.c:7509 Remote SDP: 766fe459-d040-441b-91e5-07052eb23ad5 v=0 766fe459-d040-441b-91e5-07052eb23ad5 o=FreeSWITCH 1669854793 1669854794 IN IP4 172.17.0.2 766fe459-d040-441b-91e5-07052eb23ad5 s=FreeSWITCH 766fe459-d040-441b-91e5-07052eb23ad5 c=IN IP4 172.17.0.2 766fe459-d040-441b-91e5-07052eb23ad5 t=0 0 766fe459-d040-441b-91e5-07052eb23ad5 m=audio 18802 RTP/AVP 8 101 766fe459-d040-441b-91e5-07052eb23ad5 a=rtpmap:8 PCMA/8000 766fe459-d040-441b-91e5-07052eb23ad5 a=rtpmap:101 telephone-event/8000 766fe459-d040-441b-91e5-07052eb23ad5 a=fmtp:101 0-15 766fe459-d040-441b-91e5-07052eb23ad5 a=ptime:20 766fe459-d040-441b-91e5-07052eb23ad5 a=rtcp:18803 IN IP4 172.17.0.2 766fe459-d040-441b-91e5-07052eb23ad5 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [NOTICE] sofia.c:7512 Pre-Answer sofia/external/787675! 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_ivr.c:4022 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_ivr.c:4023 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] switch_channel.c:3622 (sofia/external/787675) Callstate Change DOWN -> EARLY 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_core_session.c:865 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_ivr.c:4022 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_core_session.c:1009 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_ivr.c:4023 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1] 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] switch_core_media.c:5705 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] switch_core_media.c:5650 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1] 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] switch_core_media.c:5566 Set telephone-event payload to 101@8000 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] switch_core_media.c:3870 Set Codec sofia/external/787675 PCMA/8000 20 ms 160 samples 64000 bits 1 channels 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] switch_core_codec.c:111 sofia/external/787675 Original read codec set to PCMA:8 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] switch_core_media.c:5915 Set telephone-event payload to 101@8000 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] switch_core_media.c:5973 sofia/external/787675 Set 2833 dtmf send payload to 101 recv payload to 101 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] switch_core_media.c:8776 AUDIO RTP [sofia/external/787675] 192.168.31.232 port 26974 -> 172.17.0.2 port 18802 codec: 8 ms: 20 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] switch_rtp.c:4619 Starting timer [soft] 160 bytes per 20ms 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] switch_core_media.c:8996 Activating RTCP PORT 18803 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] switch_rtp.c:5017 RTCP send rate is: 5000 and packet rate is: 20000 Remote Port: 18803 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] switch_rtp.c:2776 Setting RTCP remote addr to 172.17.0.2:18803 2 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] switch_core_media.c:9088 sofia/external/787675 Set 2833 dtmf send payload to 101 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] switch_core_media.c:9095 sofia/external/787675 Set 2833 dtmf receive payload to 101 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] switch_core_media.c:9118 sofia/external/787675 Set rtp dtmf delay to 40 2022-12-01 13:46:35.034223 90.27% [DEBUG] switch_ivr_originate.c:3892 Originate Resulted in Success: [sofia/external/787675] Peer UUID: 766fe459-d040-441b-91e5-07052eb23ad5 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_core_session.c:865 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_core_session.c:1009 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] switch_ivr.c:2289 (sofia/external/787675) State Change CS_CONSUME_MEDIA -> CS_ROUTING 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_core_session.c:865 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_core_session.c:1009 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [NOTICE] switch_ivr.c:2296 Transfer sofia/external/787675 to XML[899987788@default] 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_core_session.c:865 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] mod_commands.c:5178 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_core_session.c:1009 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] switch_core_state_machine.c:581 (sofia/external/787675) Running State Change CS_ROUTING (Cur 3 Tot 10) 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] switch_core_state_machine.c:640 (sofia/external/787675) State ROUTING 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] mod_sofia.c:158 sofia/external/787675 SOFIA ROUTING 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_ivr.c:4022 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] switch_core_state_machine.c:230 sofia/external/787675 Standard ROUTING 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_ivr.c:4023 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [INFO] mod_dialplan_xml.c:639 Processing <0000000000>->899987788 in context default 766fe459-d040-441b-91e5-07052eb23ad5 Dialplan: sofia/external/787675 parsing [default->testesl] continue=false 766fe459-d040-441b-91e5-07052eb23ad5 Dialplan: sofia/external/787675 Regex (FAIL) [testesl] destination_number(899987788) =~ /^89998$/ break=on-false 766fe459-d040-441b-91e5-07052eb23ad5 Dialplan: sofia/external/787675 parsing [default->latest] continue=false 766fe459-d040-441b-91e5-07052eb23ad5 Dialplan: sofia/external/787675 Regex (PASS) [latest] destination_number(899987788) =~ /^899987788$/ break=on-false 766fe459-d040-441b-91e5-07052eb23ad5 Dialplan: sofia/external/787675 Action export(fire_asr_events=true) 766fe459-d040-441b-91e5-07052eb23ad5 Dialplan: sofia/external/787675 Action set(playback_terminators=none) 766fe459-d040-441b-91e5-07052eb23ad5 Dialplan: sofia/external/787675 Action park() 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [INFO] switch_channel.c:3270 sofia/external/787675 Flipping CID from "" <0000000000> to "787675" <787675> 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] switch_core_state_machine.c:281 (sofia/external/787675) State Change CS_ROUTING -> CS_EXECUTE 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] switch_core_state_machine.c:640 (sofia/external/787675) State ROUTING going to sleep 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] switch_core_state_machine.c:581 (sofia/external/787675) Running State Change CS_EXECUTE (Cur 3 Tot 10) 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_ivr.c:4022 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_ivr.c:4023 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] switch_core_state_machine.c:647 (sofia/external/787675) State EXECUTE 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_ivr.c:4022 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] mod_sofia.c:213 sofia/external/787675 SOFIA EXECUTE 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_ivr.c:4023 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] switch_core_state_machine.c:323 sofia/external/787675 Standard EXECUTE 766fe459-d040-441b-91e5-07052eb23ad5 EXECUTE [depth=0] sofia/external/787675 export(fire_asr_events=true) 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_core_session.c:865 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_ivr.c:4022 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_ivr.c:4023 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_core_session.c:1009 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] switch_channel.c:1315 EXPORT (export_vars) [fire_asr_events]=[true] 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_core_session.c:865 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_core_session.c:1009 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 EXECUTE [depth=0] sofia/external/787675 set(playback_terminators=none) 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_core_session.c:865 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_ivr.c:4022 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_ivr.c:4023 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_core_session.c:1009 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [DEBUG] mod_dptools.c:1698 SET sofia/external/787675 [playback_terminators]=[none] 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_core_session.c:865 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_core_session.c:1009 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 EXECUTE [depth=0] sofia/external/787675 park() 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_core_session.c:865 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_ivr.c:4022 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_ivr.c:4023 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_core_session.c:1009 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] mod_commands.c:4766 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] switch_ivr_async.c:1275 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] sofia.c:2636 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] sofia.c:2638 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] sofia.c:2636 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] sofia.c:2638 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] sofia.c:2636 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] sofia.c:2638 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] mod_event_socket.c:2214 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.034223 90.27% [ERR] mod_event_socket.c:2220 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [DEBUG] sofia.c:6678 Remote Reason: 16 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [DEBUG] sofia.c:7499 Channel sofia/external/787675 entering state [terminated][480] 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [NOTICE] sofia.c:8738 Hangup sofia/external/787675 [CS_EXECUTE] [NORMAL_CLEARING] 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [ERR] switch_core_session.c:865 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [DEBUG] switch_core_state_machine.c:337 sofia/external/787675 skip receive message [VIDEO_SYNC] (channel is hungup already) 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [ERR] switch_core_session.c:1009 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [ERR] switch_core_session.c:865 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [DEBUG] switch_core_state_machine.c:338 sofia/external/787675 skip receive message [REQUEST_IMAGE_MEDIA] (channel is hungup already) 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [ERR] switch_core_session.c:1009 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [DEBUG] switch_ivr.c:632 sofia/external/787675 Command Execute [depth=1] playback(/startRing.wav) 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [DEBUG] switch_core_session.c:2760 sofia/external/787675 Channel is hungup and application playback does not have the zombie_exec flag. 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [ERR] switch_core_session.c:865 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [DEBUG] switch_core_session.c:2985 sofia/external/787675 skip receive message [PHONE_EVENT] (channel is hungup already) 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [ERR] switch_core_session.c:1009 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [DEBUG] switch_core_state_machine.c:647 (sofia/external/787675) State EXECUTE going to sleep 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [DEBUG] switch_core_state_machine.c:581 (sofia/external/787675) Running State Change CS_HANGUP (Cur 3 Tot 10) 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [ERR] switch_core_session.c:865 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [DEBUG] switch_ivr.c:679 sofia/external/787675 skip receive message [VIDEO_SYNC] (channel is hungup already) 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [ERR] switch_core_session.c:1009 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [ERR] switch_ivr.c:4022 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock FAIL 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [DEBUG] switch_core_state_machine.c:844 (sofia/external/787675) Callstate Change EARLY -> HANGUP 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [DEBUG] switch_core_state_machine.c:846 (sofia/external/787675) State HANGUP 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [ERR] switch_ivr.c:4022 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock FAIL 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [DEBUG] mod_sofia.c:468 Channel sofia/external/787675 hanging up, cause: NORMAL_CLEARING 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [DEBUG] switch_core_state_machine.c:59 sofia/external/787675 Standard HANGUP, cause: NORMAL_CLEARING 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [DEBUG] switch_core_state_machine.c:846 (sofia/external/787675) State HANGUP going to sleep 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [DEBUG] switch_core_state_machine.c:616 (sofia/external/787675) State Change CS_HANGUP -> CS_REPORTING 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [DEBUG] switch_core_state_machine.c:581 (sofia/external/787675) Running State Change CS_REPORTING (Cur 3 Tot 10) 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [ERR] switch_ivr.c:4022 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock FAIL 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [DEBUG] switch_core_state_machine.c:932 (sofia/external/787675) State REPORTING 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [DEBUG] switch_core_state_machine.c:168 sofia/external/787675 Standard REPORTING, cause: NORMAL_CLEARING 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [DEBUG] switch_core_state_machine.c:932 (sofia/external/787675) State REPORTING going to sleep 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [DEBUG] switch_core_state_machine.c:607 (sofia/external/787675) State Change CS_REPORTING -> CS_DESTROY 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [DEBUG] switch_core_session.c:1753 Session 9 (sofia/external/787675) Locked, Waiting on external entities 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [ERR] switch_core_session.c:1755 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Write lock ACQUIRED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [DEBUG] switch_ivr_async.c:1503 Record session sample rate: 8000 -> 8000 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [DEBUG] switch_core_media_bug.c:978 Attaching BUG to sofia/external/787675 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [ERR] switch_core_session.c:865 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock FAIL 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.054186 90.27% [ERR] mod_commands.c:4823 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read/Write lock CLEARED 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.074185 90.27% [ERR] mod_event_socket.c:2214 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock FAIL 766fe459-d040-441b-91e5-07052eb23ad5 2022-12-01 13:46:35.074185 90.27% [ERR] switch_ivr.c:4399 766fe459-d040-441b-91e5-07052eb23ad5 sofia/external/787675 Read lock FAIL
I just had a similar issue on my server where my system crashed with abort. In the trace file I see
Thread 1 (Thread 0x7f98dc2b4700 (LWP 25848)):
#0 __GI_raise (sig=sig@entry=6) at ../sysdeps/unix/sysv/linux/raise.c:50
#1 0x00007f9a330d4535 in __GI_abort () at abort.c:79
#2 0x00007f9a330d440f in __assert_fail_base (fmt=0x7f9a33236ee0 "%s%s%s:%u: %s%sAssertion `%s' failed.\n%n", assertion=0x7f9a33a2d222 "buffer->data != ((void *)0)", file=0x7f9a33a2d20e "src/switch_buffer.c", line=304, function=<optimized out>) at assert.c:92
#3 0x00007f9a330e2102 in __GI___assert_fail (assertion=assertion@entry=0x7f9a33a2d222 "buffer->data != ((void *)0)", file=file@entry=0x7f9a33a2d20e "src/switch_buffer.c", line=line@entry=304, function=function@entry=0x7f9a33a2d260 <__PRETTY_FUNCTION__.21464> "switch_buffer_write") at assert.c:101
#4 0x00007f9a336b612e in switch_buffer_write (buffer=0x7f99cdeb8770, data=data@entry=0x7f9932c84b98, datalen=5376) at src/switch_buffer.c:315
#5 0x00007f9a336d6d98 in switch_core_file_write (fh=0x7f99ce1fb848, data=data@entry=0x7f9932c84b98, len=len@entry=0x7f98dc2b3bb8) at src/switch_core_file.c:665
#6 0x00007f9a3377ea1e in recording_thread (thread=<optimized out>, obj=<optimized out>) at src/switch_ivr_async.c:1285
#7 0x00007f9a33a1d94c in dummy_worker (opaque=0x7f99cd982058) at threadproc/unix/thread.c:151
#8 0x00007f9a335f7fa3 in start_thread (arg=<optimized out>) at pthread_create.c:486
#9 0x00007f9a331ab4cf in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:95
The last log before the crash I got
6d11fc7a-7bd6-11ed-8ed8-3b5d8b1522b7 2022-12-14 12:44:40.000657 [DEBUG] switch_core_session.c:1726 Session 3721783 (sofia/Internal2/9999@domain) Locked, Waiting on external entities
This is a freeswitch version 1.10.3, so I cannot say that it's a bug that exists also on 1.10.7