one remote phone unable to make external calls
Having an issue with a remote office phone being unable to make external calls. Any assistance on how to fix would be appreciated. The error I see in the log file are as follows: 34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_session.c:1053 Send signal sofia/external/15061239182 [BREAK] 34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_session.c:1053 Send signal sofia/external/15061239182 [BREAK] 34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_session.c:1053 Send signal sofia/external/15061239182 [BREAK] 34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] sofia.c:6423 Channel sofia/external/15061239182 entering state [terminated][408] 34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [NOTICE] sofia.c:7306 Hangup sofia/external/15061239182 [CS_CONSUME_MEDIA] [RECOVERY_ON_TIMER_EXPIRE] 34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_channel.c:3222 Send signal sofia/external/15061239182 [KILL] 34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_session.c:1388 Send signal sofia/external/15061239182 [BREAK] 34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_state_machine.c:472 (sofia/external/15061239182) Running State Change CS_HANGUP 34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_state_machine.c:735 (sofia/external/15061239182) Callstate Change DOWN -> HANGUP 34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_state_machine.c:737 (sofia/external/15061239182) State HANGUP 34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] mod_sofia.c:413 Channel sofia/external/15061239182 hanging up, cause: RECOVERY_ON_TIMER_EXPIRE 34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_state_machine.c:60 sofia/external/15061239182 Standard HANGUP, cause: RECOVERY_ON_TIMER_EXPIRE 34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_state_machine.c:737 (sofia/external/15061239182) State HANGUP going to sleep 34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_state_machine.c:504 (sofia/external/15061239182) State Change CS_HANGUP -> CS_REPORTING 34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_session.c:1388 Send signal sofia/external/15061239182 [BREAK] 34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_state_machine.c:472 (sofia/external/15061239182) Running State Change CS_REPORTING 34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_state_machine.c:823 (sofia/external/15061239182) State REPORTING 34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_state_machine.c:104 sofia/external/15061239182 Standard REPORTING, cause: RECOVERY_ON_TIMER_EXPIRE 34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_state_machine.c:823 (sofia/external/15061239182) State REPORTING going to sleep 34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_state_machine.c:498 (sofia/external/15061239182) State Change CS_REPORTING -> CS_DESTROY 34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_session.c:1388 Send signal sofia/external/15061239182 [BREAK] 34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_session.c:1615 Session 81 (sofia/external/15061239182) Locked, Waiting on external entities 659bd7ed-f8e8-4224-81d2-cf1d4669c7c6 2014-10-15 13:52:07.272796 [DEBUG] switch_ivr_originate.c:3695 Originate Resulted in Error Cause: 102 [RECOVERY_ON_TIMER_EXPIRE] 34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.272796 [NOTICE] switch_core_session.c:1633 Session 81 (sofia/external/15061239182) Ended 34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.272796 [NOTICE] switch_core_session.c:1637 Close Channel sofia/external/15061239182 [CS_DESTROY] 34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.272796 [DEBUG] switch_core_state_machine.c:626 (sofia/external/15061239182) Running State Change CS_DESTROY 34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.272796 [DEBUG] switch_core_state_machine.c:636 (sofia/external/15061239182) State DESTROY 34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.272796 [DEBUG] mod_sofia.c:323 sofia/external/15061239182 SOFIA DESTROY 34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.272796 [DEBUG] switch_core_state_machine.c:111 sofia/external/15061239182 Standard DESTROY 34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.272796 [DEBUG] switch_core_state_machine.c:636 (sofia/external/15061239182) State DESTROY going to sleep 659bd7ed-f8e8-4224-81d2-cf1d4669c7c6 2014-10-15 13:52:07.272796 [INFO] mod_dptools.c:3234 Originate Failed. Cause: RECOVERY_ON_TIMER_EXPIRE 659bd7ed-f8e8-4224-81d2-cf1d4669c7c6 2014-10-15 13:52:07.272796 [NOTICE] switch_channel.c:4681 Hangup sofia/internal/426@192.168.222.153 [CS_EXECUTE] [RECOVERY_ON_TIMER_EXPIRE] 659bd7ed-f8e8-4224-81d2-cf1d4669c7c6 2014-10-15 13:52:07.272796 [DEBUG] switch_channel.c:3222 Send signal sofia/internal/426@192.168.222.153 [KILL] 659bd7ed-f8e8-4224-81d2-cf1d4669c7c6 2014-10-15 13:52:07.272796 [DEBUG] switch_core_session.c:1388 Send signal sofia/internal/426@192.168.222.153 [BREAK] 659bd7ed-f8e8-4224-81d2-cf1d4669c7c6 2014-10-15 13:52:07.272796 [DEBUG] switch_core_session.c:2888 sofia/internal/426@192.168.222.153 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already) Thanks cjb
Have you reviewed the SIP traffic? Can the phone make calls but not receive calls or vice versa? Does the call work for 30 seconds and then stop? Reason I ask is that when I hear that a remote phone doesn't work and there's a recovery on timer expire I think of the dreaded four-letter word: NAT. I'd check out some of the NAT-related info on the wiki or in the FreeSWITCH 1.2 book. -MC On Wed, Oct 15, 2014 at 10:06 AM, Charles Bujold <cjbujold@accra.ca> wrote:
Having an issue with a remote office phone being unable to make external calls. Any assistance on how to fix would be appreciated.
The error I see in the log file are as follows:
34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_session.c:1053 Send signal sofia/external/15061239182 [BREAK]
34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_session.c:1053 Send signal sofia/external/15061239182 [BREAK]
34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_session.c:1053 Send signal sofia/external/15061239182 [BREAK]
34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] sofia.c:6423 Channel sofia/external/15061239182 entering state [terminated][408]
34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [NOTICE] sofia.c:7306 Hangup sofia/external/15061239182 [CS_CONSUME_MEDIA] [RECOVERY_ON_TIMER_EXPIRE]
34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_channel.c:3222 Send signal sofia/external/15061239182 [KILL]
34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_session.c:1388 Send signal sofia/external/15061239182 [BREAK]
34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_state_machine.c:472 (sofia/external/15061239182) Running State Change CS_HANGUP
34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_state_machine.c:735 (sofia/external/15061239182) Callstate Change DOWN -> HANGUP
34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_state_machine.c:737 (sofia/external/15061239182) State HANGUP
34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] mod_sofia.c:413 Channel sofia/external/15061239182 hanging up, cause: RECOVERY_ON_TIMER_EXPIRE
34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_state_machine.c:60 sofia/external/15061239182 Standard HANGUP, cause: RECOVERY_ON_TIMER_EXPIRE
34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_state_machine.c:737 (sofia/external/15061239182) State HANGUP going to sleep
34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_state_machine.c:504 (sofia/external/15061239182) State Change CS_HANGUP -> CS_REPORTING
34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_session.c:1388 Send signal sofia/external/15061239182 [BREAK]
34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_state_machine.c:472 (sofia/external/15061239182) Running State Change CS_REPORTING
34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_state_machine.c:823 (sofia/external/15061239182) State REPORTING
34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_state_machine.c:104 sofia/external/15061239182 Standard REPORTING, cause: RECOVERY_ON_TIMER_EXPIRE
34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_state_machine.c:823 (sofia/external/15061239182) State REPORTING going to sleep
34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_state_machine.c:498 (sofia/external/15061239182) State Change CS_REPORTING -> CS_DESTROY
34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_session.c:1388 Send signal sofia/external/15061239182 [BREAK]
34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.252830 [DEBUG] switch_core_session.c:1615 Session 81 (sofia/external/15061239182) Locked, Waiting on external entities
659bd7ed-f8e8-4224-81d2-cf1d4669c7c6 2014-10-15 13:52:07.272796 [DEBUG] switch_ivr_originate.c:3695 Originate Resulted in Error Cause: 102 [RECOVERY_ON_TIMER_EXPIRE]
34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.272796 [NOTICE] switch_core_session.c:1633 Session 81 (sofia/external/15061239182) Ended
34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.272796 [NOTICE] switch_core_session.c:1637 Close Channel sofia/external/15061239182 [CS_DESTROY]
34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.272796 [DEBUG] switch_core_state_machine.c:626 (sofia/external/15061239182) Running State Change CS_DESTROY
34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.272796 [DEBUG] switch_core_state_machine.c:636 (sofia/external/15061239182) State DESTROY
34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.272796 [DEBUG] mod_sofia.c:323 sofia/external/15061239182 SOFIA DESTROY
34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.272796 [DEBUG] switch_core_state_machine.c:111 sofia/external/15061239182 Standard DESTROY
34d6aa01-f403-400a-8f53-9f06d25ea74b 2014-10-15 13:52:07.272796 [DEBUG] switch_core_state_machine.c:636 (sofia/external/15061239182) State DESTROY going to sleep
659bd7ed-f8e8-4224-81d2-cf1d4669c7c6 2014-10-15 13:52:07.272796 [INFO] mod_dptools.c:3234 Originate Failed. Cause: RECOVERY_ON_TIMER_EXPIRE
659bd7ed-f8e8-4224-81d2-cf1d4669c7c6 2014-10-15 13:52:07.272796 [NOTICE] switch_channel.c:4681 Hangup sofia/internal/426@192.168.222.153 [CS_EXECUTE] [RECOVERY_ON_TIMER_EXPIRE]
659bd7ed-f8e8-4224-81d2-cf1d4669c7c6 2014-10-15 13:52:07.272796 [DEBUG] switch_channel.c:3222 Send signal sofia/internal/426@192.168.222.153 [KILL]
659bd7ed-f8e8-4224-81d2-cf1d4669c7c6 2014-10-15 13:52:07.272796 [DEBUG] switch_core_session.c:1388 Send signal sofia/internal/426@192.168.222.153 [BREAK]
659bd7ed-f8e8-4224-81d2-cf1d4669c7c6 2014-10-15 13:52:07.272796 [DEBUG] switch_core_session.c:2888 sofia/internal/426@192.168.222.153 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
Thanks
cjb
_________________________________________________________________________ Professional FreeSWITCH Consulting Services: consulting@freeswitch.org http://www.freeswitchsolutions.com
Official FreeSWITCH Sites http://www.freeswitch.org http://confluence.freeswitch.org http://www.cluecon.com
FreeSWITCH-powered IP PBX: The CudaTel Communication Server http://www.cudatel.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 http://www.freeswitch.org
participants (2)
-
Charles Bujold
-
Michael Collins