outgoing call stop working, log file
2025-02-22 23:49:35.495953 95.80% [DEBUG] switch_core_state_machine.c:40 sofia/external/02825550755 Standard INIT
2025-02-22 23:49:35.495953 95.80% [DEBUG] switch_core_state_machine.c:48 (sofia/external/02825550755) State Change CS_INIT -> CS_ROUTING
2025-02-22 23:49:35.495953 95.80% [DEBUG] switch_core_state_machine.c:624 (sofia/external/02825550755) State INIT going to sleep
2025-02-22 23:49:35.515972 95.80% [DEBUG] switch_core_state_machine.c:581 (sofia/external/02825550755) Running State Change CS_ROUTING (Cur 2 Tot 154)
2025-02-22 23:49:35.515972 95.80% [DEBUG] switch_core_state_machine.c:640 (sofia/external/02825550755) State ROUTING
2025-02-22 23:49:35.515972 95.80% [DEBUG] mod_sofia.c:158 sofia/external/02825550755 SOFIA ROUTING
2025-02-22 23:49:35.515972 95.80% [DEBUG] switch_ivr_originate.c:67 (sofia/external/02825550755) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2025-02-22 23:49:35.515972 95.80% [DEBUG] switch_core_state_machine.c:640 (sofia/external/02825550755) State ROUTING going to sleep
2025-02-22 23:49:35.515972 95.80% [DEBUG] switch_core_state_machine.c:581 (sofia/external/02825550755) Running State Change CS_CONSUME_MEDIA (Cur 2 Tot 154)
2025-02-22 23:49:35.515972 95.80% [DEBUG] sofia.c:7493 Channel sofia/external/02825550755 entering state [calling][0]
2025-02-22 23:49:35.515972 95.80% [DEBUG] switch_core_state_machine.c:659 (sofia/external/02825550755) State CONSUME_MEDIA
2025-02-22 23:49:35.515972 95.80% [DEBUG] switch_core_state_machine.c:659 (sofia/external/02825550755) State CONSUME_MEDIA going to sleep
2025-02-22 23:49:35.536013 95.80% [DEBUG] sofia.c:7493 Channel sofia/external/02825550755 entering state [calling][0]
2025-02-22 23:50:07.535946 98.40% [DEBUG] sofia.c:7493 Channel sofia/external/02825550755 entering state [terminated][408]
2025-02-22 23:50:07.535946 98.40% [NOTICE] sofia.c:8736 Hangup sofia/external/02825550755 [CS_CONSUME_MEDIA] [RECOVERY_ON_TIMER_EXPIRE]
2025-02-22 23:50:07.535946 98.40% [DEBUG] switch_core_state_machine.c:581 (sofia/external/02825550755) Running State Change CS_HANGUP (Cur 2 Tot 154)
2025-02-22 23:50:07.535946 98.40% [DEBUG] switch_core_state_machine.c:844 (sofia/external/02825550755) Callstate Change DOWN -> HANGUP
2025-02-22 23:50:07.535946 98.40% [DEBUG] switch_core_state_machine.c:846 (sofia/external/02825550755) State HANGUP
2025-02-22 23:50:07.535946 98.40% [DEBUG] mod_sofia.c:469 Channel sofia/external/02825550755 hanging up, cause: RECOVERY_ON_TIMER_EXPIRE
2025-02-22 23:50:07.535946 98.40% [DEBUG] switch_core_state_machine.c:59 sofia/external/02825550755 Standard HANGUP, cause: RECOVERY_ON_TIMER_EXPIRE
2025-02-22 23:50:07.535946 98.40% [DEBUG] switch_core_state_machine.c:846 (sofia/external/02825550755) State HANGUP going to sleep
2025-02-22 23:50:07.535946 98.40% [DEBUG] switch_core_state_machine.c:616 (sofia/external/02825550755) State Change CS_HANGUP -> CS_REPORTING
2025-02-22 23:50:07.535946 98.40% [DEBUG] switch_core_state_machine.c:581 (sofia/external/02825550755) Running State Change CS_REPORTING (Cur 2 Tot 154)
2025-02-22 23:50:07.535946 98.40% [DEBUG] switch_core_state_machine.c:932 (sofia/external/02825550755) State REPORTING
2025-02-22 23:50:07.535946 98.40% [DEBUG] switch_core_state_machine.c:168 sofia/external/02825550755 Standard REPORTING, cause: RECOVERY_ON_TIMER_EXPIRE
2025-02-22 23:50:07.535946 98.40% [DEBUG] switch_core_state_machine.c:932 (sofia/external/02825550755) State REPORTING going to sleep
2025-02-22 23:50:07.535946 98.40% [DEBUG] switch_core_state_machine.c:607 (sofia/external/02825550755) State Change CS_REPORTING -> CS_DESTROY
2025-02-22 23:50:07.535946 98.40% [DEBUG] switch_core_session.c:1748 Session 154 (sofia/external/02825550755) Locked, Waiting on external entities
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_ivr_originate.c:4056 Originate Resulted in Error Cause: 102 [RECOVERY_ON_TIMER_EXPIRE]
2025-02-22 23:50:07.555952 98.40% [NOTICE] switch_core_session.c:1766 Session 154 (sofia/external/02825550755) Ended
2025-02-22 23:50:07.555952 98.40% [NOTICE] switch_core_session.c:1770 Close Channel sofia/external/02825550755 [CS_DESTROY]
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:735 (sofia/external/02825550755) Running State Change CS_DESTROY (Cur 1 Tot 154)
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:745 (sofia/external/02825550755) State DESTROY
2025-02-22 23:50:07.555952 98.40% [DEBUG] mod_sofia.c:380 sofia/external/02825550755 SOFIA DESTROY
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:175 sofia/external/02825550755 Standard DESTROY
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:745 (sofia/external/02825550755) State DESTROY going to sleep
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_channel.c:2197 (sofia/internal/100@192.168.178.104) Callstate Change RING_WAIT -> ACTIVE
025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:647 (sofia/internal/100@192.168.178.104) State EXECUTE going to sleep
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:581 (sofia/internal/100@192.168.178.104) Running State Change CS_HANGUP (Cur 1 Tot 154)
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:844 (sofia/internal/100@192.168.178.104) Callstate Change ACTIVE -> HANGUP
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:846 (sofia/internal/100@192.168.178.104) State HANGUP
2025-02-22 23:50:07.555952 98.40% [DEBUG] mod_sofia.c:463 sofia/internal/100@192.168.178.104 Overriding SIP cause 504 with 408 from the other leg
2025-02-22 23:50:07.555952 98.40% [DEBUG] mod_sofia.c:469 Channel sofia/internal/100@192.168.178.104 hanging up, cause: RECOVERY_ON_TIMER_EXPIRE
2025-02-22 23:50:07.555952 98.40% [DEBUG] mod_sofia.c:523 Sending BYE to sofia/internal/100@192.168.178.104
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:59 sofia/internal/100@192.168.178.104 Standard HANGUP, cause: RECOVERY_ON_TIMER_EXPIRE
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:846 (sofia/internal/100@192.168.178.104) State HANGUP going to sleep
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:616 (sofia/internal/100@192.168.178.104) State Change CS_HANGUP -> CS_REPORTING
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:581 (sofia/internal/100@192.168.178.104) Running State Change CS_REPORTING (Cur 1 Tot 154)
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:932 (sofia/internal/100@192.168.178.104) State REPORTING
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:168 sofia/internal/100@192.168.178.104 Standard REPORTING, cause: RECOVERY_ON_TIMER_EXPIRE
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:932 (sofia/internal/100@192.168.178.104) State REPORTING going to sleep
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:607 (sofia/internal/100@192.168.178.104) State Change CS_REPORTING -> CS_DESTROY
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_session.c:1748 Session 153 (sofia/internal/100@192.168.178.104) Locked, Waiting on external entities
2025-02-22 23:50:07.555952 98.40% [NOTICE] switch_core_session.c:1766 Session 153 (sofia/internal/100@192.168.178.104) Ended
2025-02-22 23:50:07.555952 98.40% [NOTICE] switch_core_session.c:1770 Close Channel sofia/internal/100@192.168.178.104 [CS_DESTROY]
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:735 (sofia/internal/100@192.168.178.104) Running State Change CS_DESTROY (Cur 0 Tot 154)
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:745 (sofia/internal/100@192.168.178.104) State DESTROY
2025-02-22 23:50:07.555952 98.40% [DEBUG] mod_sofia.c:380 sofia/internal/100@192.168.178.104 SOFIA DESTROY
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:175 sofia/internal/100@192.168.178.104 Standard DESTROY
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:745 (sofia/internal/100@192.168.178.104) State DESTROY going to sleep
2025-02-22 23:49:35.495953 95.80% [DEBUG] switch_core_state_machine.c:40 sofia/external/02825550755 Standard INIT
2025-02-22 23:49:35.495953 95.80% [DEBUG] switch_core_state_machine.c:48 (sofia/external/02825550755) State Change CS_INIT -> CS_ROUTING
2025-02-22 23:49:35.495953 95.80% [DEBUG] switch_core_state_machine.c:624 (sofia/external/02825550755) State INIT going to sleep
2025-02-22 23:49:35.515972 95.80% [DEBUG] switch_core_state_machine.c:581 (sofia/external/02825550755) Running State Change CS_ROUTING (Cur 2 Tot 154)
2025-02-22 23:49:35.515972 95.80% [DEBUG] switch_core_state_machine.c:640 (sofia/external/02825550755) State ROUTING
2025-02-22 23:49:35.515972 95.80% [DEBUG] mod_sofia.c:158 sofia/external/02825550755 SOFIA ROUTING
2025-02-22 23:49:35.515972 95.80% [DEBUG] switch_ivr_originate.c:67 (sofia/external/02825550755) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2025-02-22 23:49:35.515972 95.80% [DEBUG] switch_core_state_machine.c:640 (sofia/external/02825550755) State ROUTING going to sleep
2025-02-22 23:49:35.515972 95.80% [DEBUG] switch_core_state_machine.c:581 (sofia/external/02825550755) Running State Change CS_CONSUME_MEDIA (Cur 2 Tot 154)
2025-02-22 23:49:35.515972 95.80% [DEBUG] sofia.c:7493 Channel sofia/external/02825550755 entering state [calling][0]
2025-02-22 23:49:35.515972 95.80% [DEBUG] switch_core_state_machine.c:659 (sofia/external/02825550755) State CONSUME_MEDIA
2025-02-22 23:49:35.515972 95.80% [DEBUG] switch_core_state_machine.c:659 (sofia/external/02825550755) State CONSUME_MEDIA going to sleep
2025-02-22 23:49:35.536013 95.80% [DEBUG] sofia.c:7493 Channel sofia/external/02825550755 entering state [calling][0]
2025-02-22 23:50:07.535946 98.40% [DEBUG] sofia.c:7493 Channel sofia/external/02825550755 entering state [terminated][408]
2025-02-22 23:50:07.535946 98.40% [NOTICE] sofia.c:8736 Hangup sofia/external/02825550755 [CS_CONSUME_MEDIA] [RECOVERY_ON_TIMER_EXPIRE]
2025-02-22 23:50:07.535946 98.40% [DEBUG] switch_core_state_machine.c:581 (sofia/external/02825550755) Running State Change CS_HANGUP (Cur 2 Tot 154)
2025-02-22 23:50:07.535946 98.40% [DEBUG] switch_core_state_machine.c:844 (sofia/external/02825550755) Callstate Change DOWN -> HANGUP
2025-02-22 23:50:07.535946 98.40% [DEBUG] switch_core_state_machine.c:846 (sofia/external/02825550755) State HANGUP
2025-02-22 23:50:07.535946 98.40% [DEBUG] mod_sofia.c:469 Channel sofia/external/02825550755 hanging up, cause: RECOVERY_ON_TIMER_EXPIRE
2025-02-22 23:50:07.535946 98.40% [DEBUG] switch_core_state_machine.c:59 sofia/external/02825550755 Standard HANGUP, cause: RECOVERY_ON_TIMER_EXPIRE
2025-02-22 23:50:07.535946 98.40% [DEBUG] switch_core_state_machine.c:846 (sofia/external/02825550755) State HANGUP going to sleep
2025-02-22 23:50:07.535946 98.40% [DEBUG] switch_core_state_machine.c:616 (sofia/external/02825550755) State Change CS_HANGUP -> CS_REPORTING
2025-02-22 23:50:07.535946 98.40% [DEBUG] switch_core_state_machine.c:581 (sofia/external/02825550755) Running State Change CS_REPORTING (Cur 2 Tot 154)
2025-02-22 23:50:07.535946 98.40% [DEBUG] switch_core_state_machine.c:932 (sofia/external/02825550755) State REPORTING
2025-02-22 23:50:07.535946 98.40% [DEBUG] switch_core_state_machine.c:168 sofia/external/02825550755 Standard REPORTING, cause: RECOVERY_ON_TIMER_EXPIRE
2025-02-22 23:50:07.535946 98.40% [DEBUG] switch_core_state_machine.c:932 (sofia/external/02825550755) State REPORTING going to sleep
2025-02-22 23:50:07.535946 98.40% [DEBUG] switch_core_state_machine.c:607 (sofia/external/02825550755) State Change CS_REPORTING -> CS_DESTROY
2025-02-22 23:50:07.535946 98.40% [DEBUG] switch_core_session.c:1748 Session 154 (sofia/external/02825550755) Locked, Waiting on external entities
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_ivr_originate.c:4056 Originate Resulted in Error Cause: 102 [RECOVERY_ON_TIMER_EXPIRE]
2025-02-22 23:50:07.555952 98.40% [NOTICE] switch_core_session.c:1766 Session 154 (sofia/external/02825550755) Ended
2025-02-22 23:50:07.555952 98.40% [NOTICE] switch_core_session.c:1770 Close Channel sofia/external/02825550755 [CS_DESTROY]
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:735 (sofia/external/02825550755) Running State Change CS_DESTROY (Cur 1 Tot 154)
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:745 (sofia/external/02825550755) State DESTROY
2025-02-22 23:50:07.555952 98.40% [DEBUG] mod_sofia.c:380 sofia/external/02825550755 SOFIA DESTROY
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:175 sofia/external/02825550755 Standard DESTROY
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:745 (sofia/external/02825550755) State DESTROY going to sleep
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_channel.c:2197 (sofia/internal/100@192.168.178.104) Callstate Change RING_WAIT -> ACTIVE
025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:647 (sofia/internal/100@192.168.178.104) State EXECUTE going to sleep
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:581 (sofia/internal/100@192.168.178.104) Running State Change CS_HANGUP (Cur 1 Tot 154)
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:844 (sofia/internal/100@192.168.178.104) Callstate Change ACTIVE -> HANGUP
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:846 (sofia/internal/100@192.168.178.104) State HANGUP
2025-02-22 23:50:07.555952 98.40% [DEBUG] mod_sofia.c:463 sofia/internal/100@192.168.178.104 Overriding SIP cause 504 with 408 from the other leg
2025-02-22 23:50:07.555952 98.40% [DEBUG] mod_sofia.c:469 Channel sofia/internal/100@192.168.178.104 hanging up, cause: RECOVERY_ON_TIMER_EXPIRE
2025-02-22 23:50:07.555952 98.40% [DEBUG] mod_sofia.c:523 Sending BYE to sofia/internal/100@192.168.178.104
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:59 sofia/internal/100@192.168.178.104 Standard HANGUP, cause: RECOVERY_ON_TIMER_EXPIRE
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:846 (sofia/internal/100@192.168.178.104) State HANGUP going to sleep
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:616 (sofia/internal/100@192.168.178.104) State Change CS_HANGUP -> CS_REPORTING
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:581 (sofia/internal/100@192.168.178.104) Running State Change CS_REPORTING (Cur 1 Tot 154)
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:932 (sofia/internal/100@192.168.178.104) State REPORTING
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:168 sofia/internal/100@192.168.178.104 Standard REPORTING, cause: RECOVERY_ON_TIMER_EXPIRE
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:932 (sofia/internal/100@192.168.178.104) State REPORTING going to sleep
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:607 (sofia/internal/100@192.168.178.104) State Change CS_REPORTING -> CS_DESTROY
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_session.c:1748 Session 153 (sofia/internal/100@192.168.178.104) Locked, Waiting on external entities
2025-02-22 23:50:07.555952 98.40% [NOTICE] switch_core_session.c:1766 Session 153 (sofia/internal/100@192.168.178.104) Ended
2025-02-22 23:50:07.555952 98.40% [NOTICE] switch_core_session.c:1770 Close Channel sofia/internal/100@192.168.178.104 [CS_DESTROY]
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:735 (sofia/internal/100@192.168.178.104) Running State Change CS_DESTROY (Cur 0 Tot 154)
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:745 (sofia/internal/100@192.168.178.104) State DESTROY
2025-02-22 23:50:07.555952 98.40% [DEBUG] mod_sofia.c:380 sofia/internal/100@192.168.178.104 SOFIA DESTROY
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:175 sofia/internal/100@192.168.178.104 Standard DESTROY
2025-02-22 23:50:07.555952 98.40% [DEBUG] switch_core_state_machine.c:745 (sofia/internal/100@192.168.178.104) State DESTROY going to sleep