Hi,
I'm using freeswitch as a glorified answering machine. FS registers with a
VOIP gateway and all calls into the gateway go through an ivr menu and are
allowed to leave a message which gets recorded to a file. The FS box is
behind a NAT firewall. Everything works fine except that intermittently,
calls keep getting cut off after a number of seconds.
I've attached a snapshot of the log at the point that the call gets cut off,
can anyone suggest why this is happening or how I can prevent it?
Many thanks
Andy
2009-03-30 11:14:43 [DEBUG] switch_ivr_play_say.c:272 switch_ivr_phrase_macro()
Handle play-file:[7-mono-8kHz.wav] (en:en)
2009-03-30 11:14:43 [DEBUG] switch_ivr_play_say.c:989 switch_ivr_play_file()
Codec Activated l...@8000hz 1 channels 20ms
2009-03-30 11:14:43 [DEBUG] switch_core_io.c:652
switch_core_session_write_frame() sofia/external/x...@xxx.xxx.xxx.xxx receive
message [TRANSCODING_NECESSARY]
2009-03-30 11:14:49 [DEBUG] switch_ivr_play_say.c:1279 switch_ivr_play_file()
done playing file
2009-03-30 11:14:49 [INFO] ivrmenu.js:36 console_log()
2009-03-30 11:14:49 [INFO] ivrmenu.js:36 console_log()
2009-03-30 11:14:49 [INFO] ivrmenu.js:36 console_log()
2009-03-30 11:14:49 [INFO] ivrmenu.js:36 console_log()
2009-03-30 11:14:49 [INFO] ivrmenu.js:36 console_log()
2009-03-30 11:14:49 [INFO] ivrmenu.js:36 console_log()
2009-03-30 11:14:49 [WARNING] mod_shout.c:1088 shout_file_set_string() Value
Ignored
2009-03-30 11:14:49 [DEBUG] switch_ivr_play_say.c:505 switch_ivr_record_file()
Raw Codec Activated
2009-03-30 11:14:49 [DEBUG] switch_core_io.c:234
switch_core_session_read_frame() sofia/external/x...@xxx.xxx.xxx.xxx receive
message [TRANSCODING_NECESSARY]
2009-03-30 11:14:53 [INFO] mod_shout.c:280 log_msg() LAME 3.97 32bits
(http://www.mp3dev.org/)
2009-03-30 11:14:53 [INFO] mod_shout.c:280 log_msg() polyphase lowpass filter
disabled
2009-03-30 11:15:24 [DEBUG] switch_core_io.c:403
switch_core_session_read_frame() Engaging Read Buffer at 320 bytes vs 40
2009-03-30 11:15:24 [DEBUG] switch_rtp.c:1767 switch_rtp_dequeue_dtmf() RTP
RECV DTMF #:2000
2009-03-30 11:15:43 [DEBUG] sofia.c:2728 sofia_handle_sip_i_state() Channel
sofia/external/x...@xxx.xxx.xxx.xxx entering state [received]
2009-03-30 11:15:43 [DEBUG] sofia.c:2732 sofia_handle_sip_i_state() Remote SDP:
v=0
o=root 3242 3244 IN IP4 194.145.190.143
s=session
c=IN IP4 194.145.190.143
t=0 0
m=audio 10314 RTP/AVP 8 101
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
2009-03-30 11:15:43 [DEBUG] sofia_glue.c:2549 sofia_glue_negotiate_sdp() Audio
Codec Compare [PCMA:8:8000:0]/[PCMU:0:8000:20]
2009-03-30 11:15:43 [DEBUG] sofia_glue.c:2549 sofia_glue_negotiate_sdp() Audio
Codec Compare [PCMA:8:8000:0]/[PCMA:8:8000:20]
2009-03-30 11:15:43 [DEBUG] sofia_glue.c:1635 sofia_glue_tech_set_codec()
Already using PCMA
2009-03-30 11:15:43 [DEBUG] sofia_glue.c:2509 sofia_glue_negotiate_sdp() Set
2833 dtmf payload to 101
2009-03-30 11:15:43 [DEBUG] sofia_glue.c:1901 sofia_glue_activate_rtp() Audio
params changed for sofia/external/x...@xxx.xxx.xxx.xxx from 213.166.5.140:17856
to 194.145.190.143:10314
2009-03-30 11:15:43 [DEBUG] sofia_glue.c:1908 sofia_glue_activate_rtp() AUDIO
RTP [sofia/external/x...@xxx.xxx.xxx.xxx] 192.168.4.2 port 27496 ->
194.145.190.143 port 10314 codec: 8 ms: 20
2009-03-30 11:15:43 [DEBUG] sofia_glue.c:1927 sofia_glue_activate_rtp() AUDIO
RTP CHANGING DEST TO: [194.145.190.143:10314]
2009-03-30 11:15:43 [DEBUG] sofia.c:3084 sofia_handle_sip_i_state() Processing
Reinvite
2009-03-30 11:15:43 [DEBUG] sofia.c:2728 sofia_handle_sip_i_state() Channel
sofia/external/x...@xxx.xxx.xxx.xxx entering state [completed]
2009-03-30 11:15:43 [DEBUG] sofia.c:2728 sofia_handle_sip_i_state() Channel
sofia/external/x...@xxx.xxx.xxx.xxx entering state [terminated]
2009-03-30 11:15:43 [NOTICE] sofia.c:3279 sofia_handle_sip_i_state() Hangup
sofia/external/x...@xxx.xxx.xxx.xxx [CS_EXECUTE] [NORMAL_CLEARING]
2009-03-30 11:15:43 [DEBUG] switch_channel.c:1566
switch_channel_perform_hangup() Send signal sofia/external/x...@xxx.xxx.xxx.xxx
[KILL]
2009-03-30 11:15:43 [DEBUG] switch_core_session.c:820
switch_core_session_signal_state_change() Send signal
sofia/external/x...@xxx.xxx.xxx.xxx [BREAK]
2009-03-30 11:15:43 [DEBUG] switch_core_codec.c:122
switch_core_session_set_read_codec() Restore original codec.
2009-03-30 11:15:43 [INFO] ivrmenu.js:36 console_log()
##IVR Message[07703345353]: Dropped out of record!
2009-03-30 11:15:43 [INFO] ivrmenu.js:36 console_log()
##IVR Message[07703345353]: Session no longer active!
2009-03-30 11:15:43 [INFO] ivrmenu.js:36 console_log()
2009-03-30 11:15:44 [DEBUG] mod_shout.c:620 write_stream_thread() Thread Done
2009-03-30 11:16:43 [ERR] mod_spidermonkey.c:2406 fetch_url_callback() Data do
not fit in the allocated buffer
2009-03-30 11:16:43 [ERR] ivrmenu.js:96 mod_spidermonkey() TypeError: st has
no properties
2009-03-30 11:16:43 [DEBUG] switch_core_state_machine.c:464
switch_core_session_run() (sofia/external/x...@xxx.xxx.xxx.xxx) State EXECUTE
going to sleep
2009-03-30 11:16:43 [DEBUG] switch_core_state_machine.c:383
switch_core_session_run() (sofia/external/x...@xxx.xxx.xxx.xxx) Running State
Change CS_HANGUP
2009-03-30 11:16:43 [DEBUG] switch_core_state_machine.c:414
switch_core_session_run() (sofia/external/x...@xxx.xxx.xxx.xxx) State HANGUP
2009-03-30 11:16:43 [DEBUG] mod_sofia.c:253 sofia_on_hangup()
sofia/external/x...@xxx.xxx.xxx.xxx Overriding SIP cause 480 with 200 from the
other leg
2009-03-30 11:16:43 [DEBUG] mod_sofia.c:287 sofia_on_hangup() Channel
sofia/external/x...@xxx.xxx.xxx.xxx hanging up, cause: NORMAL_CLEARING
2009-03-30 11:16:43 [DEBUG] switch_core_state_machine.c:46
switch_core_standard_on_hangup() sofia/external/x...@xxx.xxx.xxx.xxx Standard
HANGUP, cause: NORMAL_CLEARING
2009-03-30 11:16:43 [DEBUG] switch_core_state_machine.c:414
switch_core_session_run() (sofia/external/x...@xxx.xxx.xxx.xxx) State HANGUP
going to sleep
2009-03-30 11:16:43 [DEBUG] switch_core_session.c:952
switch_core_session_thread() Session 22 (sofia/external/x...@xxx.xxx.xxx.xxx)
Locked, Waiting on external entities
2009-03-30 11:16:43 [NOTICE] switch_core_session.c:970
switch_core_session_thread() Session 22 (sofia/external/x...@xxx.xxx.xxx.xxx)
Ended
2009-03-30 11:16:43 [NOTICE] switch_core_session.c:972
switch_core_session_thread() Close Channel sofia/external/x...@xxx.xxx.xxx.xxx
[CS_HANGUP]
_______________________________________________
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
