We have a strange situation; we have one extension that cannot make internal calls for longer than 32 seconds.

 

For example, if the extension tries to verify its voicemail they get cut off after 32 seconds. See log below:   Also if they try to call an extension same result.  Iif they make an outside call everything is OK.  If somebody, extension or outsides call them no issues.  The issue is only internally.  Any ideas on how to fix this would be appreciated.

 

Thanks

cjb

 


9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:15.397031 [DEBUG] switch_ivr_play_say.c:1747 done playing file /usr/local/freeswitch/sounds/en/us/callie/voicemail/vm-message_number.wav
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:15.517032 [DEBUG] switch_cpp.cpp:857 getDigits dtmf_buf:
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:15.517032 [DEBUG] switch_ivr.c:3033 No language specified - Using [en]
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:15.537009 [DEBUG] switch_ivr_play_say.c:1314 Codec Activated L16@8000hz 1 channels 20ms
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:16.217009 [DEBUG] switch_ivr_play_say.c:1747 done playing file file_string://digits/1.wav
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:16.217009 [DEBUG] switch_ivr.c:3033 No language specified - Using [en]
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:16.237030 [DEBUG] switch_ivr_play_say.c:1314 Codec Activated L16@8000hz 1 channels 20ms
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:21.277025 [DEBUG] switch_ivr_play_say.c:1747 done playing file file_string://time/mon-9.wav!digits/15.wav!digits/2.wav!digits/thousand.wav!digits/15.wav!time/at.wav!digits/10.wav!digits/40.wav!digits/2.wav!time/a-m.wav
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:21.277025 [DEBUG] switch_ivr_play_say.c:1314 Codec Activated L16@8000hz 1 channels 20ms
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.337022 [DEBUG] switch_core_session.c:1061 Send signal sofia/internal/200@192.168.20.153 [BREAK]
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.337022 [DEBUG] switch_core_session.c:1061 Send signal sofia/internal/200@192.168.20.153 [BREAK]
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.357018 [DEBUG] sofia.c:6627 Channel sofia/internal/200@192.168.20.153 entering state [terminating][0]
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.357018 [NOTICE] sofia.c:7543 Hangup sofia/internal/200@192.168.20.153 [CS_EXECUTE] [NORMAL_UNSPECIFIED]
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.357018 [DEBUG] switch_channel.c:3242 Send signal sofia/internal/200@192.168.20.153 [KILL]
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.357018 [DEBUG] switch_core_session.c:1396 Send signal sofia/internal/200@192.168.20.153 [BREAK]
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.357018 [DEBUG] switch_ivr_play_say.c:1747 done playing file /usr/local/freeswitch/storage/voicemail/default/192.168.20.153/200/msg_2f5fbb82-d178-499e-ba59-1adaad2452af.wav
2015-10-15 10:45:28.357018 [DEBUG] freeswitch_lua.cpp:377 DBH handle 0x7f50ac075ce0 released.
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.357018 [DEBUG] switch_cpp.cpp:1075 sofia/internal/200@192.168.20.153 destroy/unlink session from object
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.357018 [DEBUG] switch_core_session.c:2901 sofia/internal/200@192.168.20.153 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.357018 [DEBUG] switch_core_state_machine.c:535 (sofia/internal/200@192.168.20.153) State EXECUTE going to sleep
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.357018 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/200@192.168.20.153) Running State Change CS_HANGUP
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.357018 [DEBUG] switch_core_state_machine.c:735 (sofia/internal/200@192.168.20.153) Callstate Change ACTIVE -> HANGUP
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.357018 [DEBUG] switch_core_state_machine.c:737 (sofia/internal/200@192.168.20.153) State HANGUP
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.357018 [DEBUG] mod_sofia.c:413 Channel sofia/internal/200@192.168.20.153 hanging up, cause: NORMAL_UNSPECIFIED
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.357018 [DEBUG] switch_core_state_machine.c:60 sofia/internal/200@192.168.20.153 Standard HANGUP, cause: NORMAL_UNSPECIFIED
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.357018 [DEBUG] switch_core_state_machine.c:737 (sofia/internal/200@192.168.20.153) State HANGUP going to sleep
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.357018 [DEBUG] switch_core_state_machine.c:504 (sofia/internal/200@192.168.20.153) State Change CS_HANGUP -> CS_REPORTING
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.357018 [DEBUG] switch_core_session.c:1396 Send signal sofia/internal/200@192.168.20.153 [BREAK]
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.357018 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/200@192.168.20.153) Running State Change CS_REPORTING
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.357018 [DEBUG] switch_core_state_machine.c:823 (sofia/internal/200@192.168.20.153) State REPORTING
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.377019 [DEBUG] switch_core_state_machine.c:104 sofia/internal/200@192.168.20.153 Standard REPORTING, cause: NORMAL_UNSPECIFIED
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.377019 [DEBUG] switch_core_state_machine.c:823 (sofia/internal/200@192.168.20.153) State REPORTING going to sleep
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.377019 [DEBUG] switch_core_state_machine.c:498 (sofia/internal/200@192.168.20.153) State Change CS_REPORTING -> CS_DESTROY
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.377019 [DEBUG] switch_core_session.c:1396 Send signal sofia/internal/200@192.168.20.153 [BREAK]
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.377019 [DEBUG] switch_core_session.c:1623 Session 4 (sofia/internal/200@192.168.20.153) Locked, Waiting on external entities
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.377019 [NOTICE] switch_core_session.c:1641 Session 4 (sofia/internal/200@192.168.20.153) Ended
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.377019 [NOTICE] switch_core_session.c:1645 Close Channel sofia/internal/200@192.168.20.153 [CS_DESTROY]
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.377019 [DEBUG] switch_core_state_machine.c:626 (sofia/internal/200@192.168.20.153) Running State Change CS_DESTROY
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.377019 [DEBUG] switch_core_state_machine.c:636 (sofia/internal/200@192.168.20.153) State DESTROY
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.377019 [DEBUG] mod_sofia.c:323 sofia/internal/200@192.168.20.153 SOFIA DESTROY
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.377019 [DEBUG] switch_core_state_machine.c:111 sofia/internal/200@192.168.20.153 Standard DESTROY
9baee278-79fd-46fb-b945-ffd1035b75de 2015-10-15 10:45:28.377019 [DEBUG] switch_core_state_machine.c:636 (sofia/internal/200@192.168.20.153) State DESTROY going to sleep
2015-10-15 10:45:50.937001 [DEBUG] freeswitch_lua.cpp:360 DBH handle 0x7f50ac075ce0 Connected.
2015-10-15 10:45:50.937001 [NOTICE] switch_cpp.cpp:1328 [voicemail] mailbox: 200@192.168.20.153 messages: 1
2015-10-15 10:45:50.937001 [DEBUG] freeswitch_lua.cpp:377 DBH handle 0x7f50ac075ce0 released.
2015-10-15 10:45:53.677034 [DEBUG] freeswitch_lua.cpp:360 DBH handle 0x7f50ac075ce0 Connected.
2015-10-15 10:45:53.697001 [NOTICE] switch_cpp.cpp:1328 [voicemail] mailbox: 200@192.168.20.153 messages: 0 no messages
2015-10-15 10:45:53.697001 [DEBUG] freeswitch_lua.cpp:377 DBH handle 0x7f50ac075ce0 released.