What svn revision is this on? Does it work with 9467? Mike
On Sep 8, 2008, at 4:15 PM, Cesar Cepeda wrote: > Hi Brian, > >> Have you looked at these examples: >> http://wiki.freeswitch.org/wiki/Misc._Dialplan_Tools_tone_detect > > Actually I based my dialplan on that specific example. > >> Can you provide a console log with debug output would help see what >> is >> going on. > > Here is an example, it happens the same no matter if I record or not > the > session. I know that the audio is interrupted because I'm tapping the > analog channel of the fax machine and hearing what happens. > > The interruption of the audio comes almost as the same time as the > line: > 2008-09-08 14:27:35 [DEBUG] switch_core_io.c:365 > switch_core_session_read_frame() Engaging Read Buffer at 320 bytes > vs 1 > > ------------------------- > > 2008-09-08 14:27:24 [DEBUG] switch_ivr_originate.c:664 > switch_ivr_originate() variable string 0 = [ignore_early_media=true] > 2008-09-08 14:27:24 [NOTICE] switch_channel.c:538 > switch_channel_set_name() > New Channel sofia/auronix/[EMAIL PROTECTED] > [e19ba58a-95ba-fd49-972a-30824b45daf6] > 2008-09-08 14:27:24 [DEBUG] mod_sofia.c:2020 sofia_outgoing_channel() > sofia/auronix/[EMAIL PROTECTED] State Change CS_NEW -> CS_INIT > 2008-09-08 14:27:24 [DEBUG] switch_core_session.c:727 > switch_core_session_signal_state_change() Kill > sofia/auronix/[EMAIL PROTECTED] [BREAK] > 2008-09-08 14:27:24 [DEBUG] switch_core_state_machine.c:365 > switch_core_session_run() sofia/auronix/[EMAIL PROTECTED] Running State > Change CS_INIT > 2008-09-08 14:27:24 [DEBUG] switch_core_state_machine.c:415 > switch_core_session_run() (sofia/auronix/[EMAIL PROTECTED]) State INIT > 2008-09-08 14:27:24 [DEBUG] mod_sofia.c:80 sofia_on_init() > sofia/auronix/[EMAIL PROTECTED] SOFIA INIT > 2008-09-08 14:27:24 [DEBUG] mod_sofia.c:107 sofia_on_init() > sofia/auronix/[EMAIL PROTECTED] State Change CS_INIT -> CS_ROUTING > 2008-09-08 14:27:24 [DEBUG] switch_core_session.c:727 > switch_core_session_signal_state_change() Kill > sofia/auronix/[EMAIL PROTECTED] [BREAK] > 2008-09-08 14:27:24 [DEBUG] switch_core_state_machine.c:415 > switch_core_session_run() (sofia/auronix/[EMAIL PROTECTED]) State > INIT going > to sleep > 2008-09-08 14:27:24 [DEBUG] switch_core_state_machine.c:365 > switch_core_session_run() sofia/auronix/[EMAIL PROTECTED] Running State > Change CS_ROUTING > 2008-09-08 14:27:24 [DEBUG] switch_core_state_machine.c:420 > switch_core_session_run() (sofia/auronix/[EMAIL PROTECTED]) State > ROUTING > 2008-09-08 14:27:24 [DEBUG] mod_sofia.c:119 sofia_on_routing() > sofia/auronix/[EMAIL PROTECTED] SOFIA ROUTING > 2008-09-08 14:27:24 [DEBUG] switch_ivr_originate.c:57 > originate_on_routing() > sofia/auronix/[EMAIL PROTECTED] State Change CS_ROUTING -> > CS_CONSUME_MEDIA > 2008-09-08 14:27:24 [DEBUG] switch_core_session.c:727 > switch_core_session_signal_state_change() Kill > sofia/auronix/[EMAIL PROTECTED] [BREAK] > 2008-09-08 14:27:24 [DEBUG] switch_core_state_machine.c:420 > switch_core_session_run() (sofia/auronix/[EMAIL PROTECTED]) State > ROUTING > going to sleep > 2008-09-08 14:27:24 [DEBUG] switch_core_state_machine.c:365 > switch_core_session_run() sofia/auronix/[EMAIL PROTECTED] Running State > Change CS_CONSUME_MEDIA > 2008-09-08 14:27:24 [DEBUG] switch_core_state_machine.c:442 > switch_core_session_run() (sofia/auronix/[EMAIL PROTECTED]) State > CONSUME_MEDIA > 2008-09-08 14:27:24 [DEBUG] sofia.c:200 sofia_event_callback() event > [nua_i_state] status [0][INVITE sent] session: > sofia/auronix/[EMAIL PROTECTED] > 2008-09-08 14:27:24 [DEBUG] sofia.c:2159 sofia_handle_sip_i_state() > Channel > sofia/auronix/[EMAIL PROTECTED] entering state [calling] > 2008-09-08 14:27:24 [DEBUG] sofia.c:200 sofia_event_callback() event > [nua_r_invite] status [183][Session Progress] session: > sofia/auronix/[EMAIL PROTECTED] > 2008-09-08 14:27:24 [DEBUG] sofia.c:200 sofia_event_callback() event > [nua_i_state] status [183][Session Progress] session: > sofia/auronix/[EMAIL PROTECTED] > 2008-09-08 14:27:24 [DEBUG] sofia.c:2159 sofia_handle_sip_i_state() > Channel > sofia/auronix/[EMAIL PROTECTED] entering state [proceeding] > 2008-09-08 14:27:24 [DEBUG] sofia.c:2163 sofia_handle_sip_i_state() > Remote > SDP: > v=0 > o=AudiocodesGW 679202607 679202491 IN IP4 192.168.1.16 > s=Phone-Call > c=IN IP4 192.168.1.16 > t=0 0 > m=audio 6000 RTP/AVP 0 101 > a=rtpmap:0 PCMU/8000 > a=rtpmap:101 telephone-event/8000 > a=fmtp:101 0-15 > a=ptime:20 > > 2008-09-08 14:27:24 [DEBUG] sofia_glue.c:2303 > sofia_glue_negotiate_sdp() > Audio Codec Compare [PCMU:0:8000]/[PCMU:0:8000] > 2008-09-08 14:27:24 [DEBUG] sofia_glue.c:1548 > sofia_glue_tech_set_codec() > Set Codec sofia/auronix/[EMAIL PROTECTED] PCMU/8000 20 ms 160 samples > 2008-09-08 14:27:24 [DEBUG] sofia_glue.c:2266 > sofia_glue_negotiate_sdp() Set > 2833 dtmf payload to 101 > 2008-09-08 14:27:24 [DEBUG] sofia_glue.c:1757 > sofia_glue_activate_rtp() > AUDIO RTP [sofia/auronix/[EMAIL PROTECTED] 192.168.1.1 port 25268 -> > 192.168.1.16 port 6000 codec: 0 ms: 20 > 2008-09-08 14:27:24 [DEBUG] switch_rtp.c:818 switch_rtp_create() > Starting > timer [soft] 160 bytes per 20000ms > 2008-09-08 14:27:24 [NOTICE] switch_channel.c:1413 > switch_channel_perform_mark_pre_answered() Ring-Ready > sofia/auronix/[EMAIL PROTECTED] > 2008-09-08 14:27:24 [NOTICE] sofia_glue.c:2032 sofia_glue_tech_media() > Pre-Answer sofia/auronix/[EMAIL PROTECTED] > 2008-09-08 14:27:24 [DEBUG] sofia.c:332 sofia_event_callback() > nua_r_prack: > unknown event 39: 200 OK > 2008-09-08 14:27:27 [DEBUG] sofia.c:2159 sofia_handle_sip_i_state() > Channel > sofia/auronix/[EMAIL PROTECTED] entering state [ready] > 2008-09-08 14:27:27 [DEBUG] switch_ivr_originate.c:1380 > switch_ivr_originate() Originate Resulted in Success: > [sofia/auronix/[EMAIL PROTECTED] > 2008-09-08 14:27:27 [NOTICE] sofia.c:2474 sofia_handle_sip_i_state() > Channel > [sofia/auronix/[EMAIL PROTECTED] has been answered > 2008-09-08 14:27:27 [DEBUG] switch_ivr.c:1092 > switch_ivr_session_transfer() > sofia/auronix/[EMAIL PROTECTED] State Change CS_CONSUME_MEDIA -> > CS_ROUTING > 2008-09-08 14:27:27 [DEBUG] switch_core_session.c:727 > switch_core_session_signal_state_change() Kill > sofia/auronix/[EMAIL PROTECTED] [BREAK] > 2008-09-08 14:27:27 [DEBUG] switch_core_session.c:435 > switch_core_session_receive_message() Kill sofia/auronix/[EMAIL PROTECTED] > [BREAK] > 2008-09-08 14:27:27 [NOTICE] switch_ivr.c:1098 > switch_ivr_session_transfer() > Transfer sofia/auronix/[EMAIL PROTECTED] to [EMAIL PROTECTED] > 2008-09-08 14:27:27 [DEBUG] switch_core_state_machine.c:442 > switch_core_session_run() (sofia/auronix/[EMAIL PROTECTED]) State > CONSUME_MEDIA going to sleep > 2008-09-08 14:27:27 [DEBUG] switch_core_state_machine.c:365 > switch_core_session_run() sofia/auronix/[EMAIL PROTECTED] Running State > Change CS_ROUTING > 2008-09-08 14:27:27 [DEBUG] switch_core_state_machine.c:420 > switch_core_session_run() (sofia/auronix/[EMAIL PROTECTED]) State > ROUTING > 2008-09-08 14:27:27 [DEBUG] mod_sofia.c:119 sofia_on_routing() > sofia/auronix/[EMAIL PROTECTED] SOFIA ROUTING > 2008-09-08 14:27:27 [DEBUG] switch_core_state_machine.c:64 > switch_core_standard_on_routing() Standard ROUTING > sofia/auronix/[EMAIL PROTECTED] > 2008-09-08 14:27:27 [INFO] mod_dialplan_xml.c:228 dialplan_hunt() > Processing > FreeSWITCH->detecta_fax in context default > 2008-09-08 14:27:27 [DEBUG] mod_dialplan_xml.c:113 parse_exten() test > conditions destination_number(detecta_fax) =~ /detecta_fax/ > 2008-09-08 14:27:27 [DEBUG] switch_core_state_machine.c:97 > switch_core_standard_on_routing() sofia/auronix/[EMAIL PROTECTED] State > Change CS_ROUTING -> CS_EXECUTE > 2008-09-08 14:27:27 [DEBUG] switch_core_session.c:727 > switch_core_session_signal_state_change() Kill > sofia/auronix/[EMAIL PROTECTED] [BREAK] > 2008-09-08 14:27:27 [DEBUG] switch_core_state_machine.c:420 > switch_core_session_run() (sofia/auronix/[EMAIL PROTECTED]) State > ROUTING > going to sleep > 2008-09-08 14:27:27 [DEBUG] switch_core_state_machine.c:365 > switch_core_session_run() sofia/auronix/[EMAIL PROTECTED] Running State > Change CS_EXECUTE > 2008-09-08 14:27:27 [DEBUG] switch_core_state_machine.c:430 > switch_core_session_run() (sofia/auronix/[EMAIL PROTECTED]) State > EXECUTE > 2008-09-08 14:27:27 [DEBUG] mod_sofia.c:156 sofia_on_execute() > sofia/auronix/[EMAIL PROTECTED] SOFIA EXECUTE > 2008-09-08 14:27:27 [DEBUG] switch_core_state_machine.c:129 > switch_core_standard_on_execute() Standard EXECUTE > 2008-09-08 14:27:27 [DEBUG] switch_core_state_machine.c:140 > switch_core_standard_on_execute() sofia/auronix/[EMAIL PROTECTED] > Execute > record_session(C:\\borrame\\sesion.wav) > 2008-09-08 14:27:27 [DEBUG] switch_core_media_bug.c:227 > switch_core_media_bug_add() Attaching BUG to sofia/auronix/[EMAIL PROTECTED] > 2008-09-08 14:27:27 [DEBUG] switch_core_state_machine.c:140 > switch_core_standard_on_execute() sofia/auronix/[EMAIL PROTECTED] > Execute > tone_detect(fax 1100 r +5000 transfer fax_detectado XML default) > 2008-09-08 14:27:27 [NOTICE] mod_dptools.c:1228 > tone_detect_session_function() Enabling tone detection 'fax' '1100' > 2008-09-08 14:27:27 [DEBUG] switch_ivr_async.c:1271 > switch_ivr_tone_detect_session() Adding tone spec 1100 index 0 > 2008-09-08 14:27:27 [DEBUG] switch_core_media_bug.c:227 > switch_core_media_bug_add() Attaching BUG to sofia/auronix/[EMAIL PROTECTED] > 2008-09-08 14:27:27 [DEBUG] switch_core_state_machine.c:140 > switch_core_standard_on_execute() sofia/auronix/[EMAIL PROTECTED] > Execute > playback(C:\\Auronix\\OpenSource\\Freeswitch\\audios\ > \_retencionAgente.WAV) > 2008-09-08 14:27:27 [DEBUG] switch_ivr_play_say.c:917 > switch_ivr_play_file() > Codec Activated [EMAIL PROTECTED] 1 channels 20ms > 2008-09-08 14:27:27 [DEBUG] switch_core_session.c:435 > switch_core_session_receive_message() Kill sofia/auronix/[EMAIL PROTECTED] > [BREAK] > 2008-09-08 14:27:35 [DEBUG] switch_core_io.c:365 > switch_core_session_read_frame() Engaging Read Buffer at 320 bytes > vs 1 > 2008-09-08 14:28:12 [DEBUG] sofia.c:2159 sofia_handle_sip_i_state() > Channel > sofia/auronix/[EMAIL PROTECTED] entering state [received] > 2008-09-08 14:28:12 [DEBUG] sofia.c:2163 sofia_handle_sip_i_state() > Remote > SDP: > v=0 > o=AudiocodesGW 679202607 679202491 IN IP4 192.168.1.16 > s=Phone-Call > c=IN IP4 192.168.1.16 > t=0 0 > m=audio 6000 RTP/AVP 0 101 > a=rtpmap:0 PCMU/8000 > a=rtpmap:101 telephone-event/8000 > a=fmtp:101 0-15 > a=ptime:20 > > 2008-09-08 14:28:12 [DEBUG] sofia_glue.c:2240 > sofia_glue_negotiate_sdp() Our > existing sdp is still good [PCMU 192.168.1.16:6000], let's keep it. > 2008-09-08 14:28:12 [DEBUG] sofia_glue.c:2266 > sofia_glue_negotiate_sdp() Set > 2833 dtmf payload to 101 > 2008-09-08 14:28:12 [DEBUG] sofia_glue.c:1751 > sofia_glue_activate_rtp() > Audio params are unchanged. > 2008-09-08 14:28:12 [DEBUG] sofia.c:2433 sofia_handle_sip_i_state() > Processing Reinvite > 2008-09-08 14:28:12 [DEBUG] sofia.c:2159 sofia_handle_sip_i_state() > Channel > sofia/auronix/[EMAIL PROTECTED] entering state [completed] > 2008-09-08 14:28:13 [DEBUG] sofia.c:2159 sofia_handle_sip_i_state() > Channel > sofia/auronix/[EMAIL PROTECTED] entering state [ready] > 2008-09-08 14:28:56 [DEBUG] switch_ivr_play_say.c:1207 > switch_ivr_play_file() done playing file > 2008-09-08 14:28:56 [DEBUG] switch_core_state_machine.c:140 > switch_core_standard_on_execute() sofia/auronix/[EMAIL PROTECTED] > Execute > hangup(NORMAL_CLEARING) > 2008-09-08 14:28:56 [NOTICE] mod_dptools.c:593 hangup_function() > Hangup > sofia/auronix/[EMAIL PROTECTED] [CS_EXECUTE] [NORMAL_CLEARING] > 2008-09-08 14:28:56 [DEBUG] switch_channel.c:1368 > switch_channel_perform_hangup() Kill sofia/auronix/[EMAIL PROTECTED] > [KILL] > 2008-09-08 14:28:56 [DEBUG] switch_core_session.c:727 > switch_core_session_signal_state_change() Kill > sofia/auronix/[EMAIL PROTECTED] [BREAK] > 2008-09-08 14:28:56 [DEBUG] switch_core_state_machine.c:430 > switch_core_session_run() (sofia/auronix/[EMAIL PROTECTED]) State > EXECUTE > going to sleep > 2008-09-08 14:28:56 [DEBUG] switch_core_state_machine.c:365 > switch_core_session_run() sofia/auronix/[EMAIL PROTECTED] Running State > Change CS_HANGUP > 2008-09-08 14:28:56 [DEBUG] switch_core_state_machine.c:393 > switch_core_session_run() (sofia/auronix/[EMAIL PROTECTED]) State > HANGUP > 2008-09-08 14:28:56 [DEBUG] mod_sofia.c:264 sofia_on_hangup() Channel > sofia/auronix/[EMAIL PROTECTED] hanging up, cause: NORMAL_CLEARING > 2008-09-08 14:28:56 [DEBUG] mod_sofia.c:321 sofia_on_hangup() > Sending BYE to > sofia/auronix/[EMAIL PROTECTED] > 2008-09-08 14:28:56 [DEBUG] switch_core_state_machine.c:46 > switch_core_standard_on_hangup() Standard HANGUP > sofia/auronix/[EMAIL PROTECTED], cause: NORMAL_CLEARING > 2008-09-08 14:28:56 [DEBUG] switch_core_state_machine.c:393 > switch_core_session_run() (sofia/auronix/[EMAIL PROTECTED]) State > HANGUP > going to sleep > 2008-09-08 14:28:56 [DEBUG] switch_core_media_bug.c:284 > switch_core_media_bug_remove_all() Removing BUG from > sofia/auronix/[EMAIL PROTECTED] > 2008-09-08 14:28:56 [DEBUG] switch_core_media_bug.c:284 > switch_core_media_bug_remove_all() Removing BUG from > sofia/auronix/[EMAIL PROTECTED] > 2008-09-08 14:28:56 [DEBUG] switch_core_session.c:794 > switch_core_session_thread() Session 9 (sofia/auronix/ > [EMAIL PROTECTED]) > Locked, Waiting on external entities > 2008-09-08 14:28:56 [NOTICE] switch_core_session.c:812 > switch_core_session_thread() Session 9 (sofia/auronix/ > [EMAIL PROTECTED]) > Ended > 2008-09-08 14:28:56 [NOTICE] switch_core_session.c:814 > switch_core_session_thread() Close Channel sofia/auronix/[EMAIL PROTECTED] > [CS_HANGUP] > >> Please do not hijack threads. Click new message and input the list >> address yourself or from your address book. > > Sorry about that, I thought that just by setting a new subject would > be OK. > Won't happen again. > > Cesar Cepeda. > > > _______________________________________________ > Freeswitch-dev mailing list > [email protected] > http://lists.freeswitch.org/mailman/listinfo/freeswitch-dev > UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-dev > http://www.freeswitch.org _______________________________________________ Freeswitch-dev mailing list [email protected] http://lists.freeswitch.org/mailman/listinfo/freeswitch-dev UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-dev http://www.freeswitch.org
