Cisco Support Community
cancel
Showing results for 
Search instead for 
Did you mean: 
Announcements

Welcome to Cisco Support Community. We would love to have your feedback.

For an introduction to the new site, click here. If you'd prefer to explore, try our test area to get started. And see here for current known issues.

New Member

R2 DTMF in a VG200

During Vg200 R2 debugs ,the message "Tx ANSWER seizure" never appears when the calling party answer. Why? This is generating never-ending ringbacks .

If I use a 1760 the "Tx ANSWER seizure" does appears in R2.

10 REPLIES
Silver

Re: R2 DTMF in a VG200

Can we see the configs and the log from 'debug vpm signal'.

Is this for an an inwards (POTS to router) call or outwards (router to POTS) call ?

Be sure to set the timestamps to the msec using the 'service time debug date local msec' config command.

New Member

Re: R2 DTMF in a VG200

*Mar 22 00:55:35.530: htsp_process_event: [1/0:1(3), R2_Q421_IDLE, E_DSP_SIG_0000]

*Mar 22 00:55:35.530: r2_q421_ic_seize(1/0:1(3)) Rx SEIZURE

*Mar 22 00:55:35.530: r2_reg_start_digit_collection(1/0:1(3))htsp_setup_ind

*Mar 22 00:55:35.534: [1/0:1(3)] get_local_station_id calling num= calling name= calling time=00/00 00:00

*Mar 22 00:55:35.534: vtsp_tsp_call_setup_ind (sdb=0x8146B068, tdm_info=0x0, tsp_info=0x81451270, calling_number= calling_oct3 = 0x0, called_number= called_oct3 = 0x81, oct3a=0x0): peer_tag=10

*Mar 22 00:55:35.534: vtsp_tsp_call_setup_ind--- CAS call callingnum callingIE_present 0

*Mar 22 00:55:35.534: : ev.clg.clir is 0

ev.clg.clid_transparent is

0

ev.clg.null_orig_clg is 1

ev.clg.calling_translated is false

*Mar 22 00:55:35.534: r2_q421_ic_seize(1/0:1(3)) Tx SEIZE ACK (with 100ms delay)[R2 Q.421 1/0:1(3)] set signal state = 0x8[R2 Q.421 1/0:1(3)] set signal state = 0xC

*Mar 22 00:55:35.538: vtsp_do_call_setup_ind

*Mar 22 00:55:35.538: vtsp_allocate_cdb,cdb 0x8145B0D8

*Mar 22 00:55:35.538: vtsp_do_call_setup_ind: Call ID=99014, guid=8145BB8C

*Mar 22 00:55:35.538: vtsp_do_call_setup_ind: type=0, under_spec=0, name=, id0=3, id1=0, id2=0, calling=, called= subscriber=RegularLine callingIE_present 0

*Mar 22 00:55:35.538: vtsp_do_normal_call_setup_ind

*Mar 22 00:55:35.538: cc_api_call_setup_ind (vdbPtr=0x812E9958, callInfo={called=,called_oct3=0x81,calling=,calling_oct3=0x0,calling_oct3a=0x0,calling_xlated=false,subscriber_type_str=RegularLine,fdest=0,peer_tag=10, prog_ind=3,callingIE_present 0},callID=0x8145BA38)

*Mar 22 00:55:35.538: cc_api_call_setup_ind calling number is null, answer addr dest pattern 9000T e164_ans_addr 0 e164_dest_pattern 0

*Mar 22 00:55:35.538: cc_api_call_setup_ind type 11 , prot 0

*Mar 22 00:55:35.542: vtsp_insert_cdb,cdb 0x8145B0D8

*Mar 22 00:55:35.542: vtsp_open_voice_and_set_params

*Mar 22 00:55:35.542: dsp_close_voice_channel: [1/0:1:443] packet_len=8 channel_id=1 packet_id=75

*Mar 22 00:55:35.542: dsp_open_voice_channel_20: [1/0:1:443] packet_len=16 channel_id=1 packet_id=74 alaw_ulaw_select=1 associated_signaling_channel=128 time_slot=0 serial_port=0

*Mar 22 00:55:35.542: vtsp_modem_proto_from_cdb: cap_modem_proto 1073741824

*Mar 22 00:55:35.546: vtsp_modem_proto_from_cdb: cap_modem_proto 1073741824

*Mar 22 00:55:35.546: dsp_encap_config: [1/0:1:443] packet_len=30 channel_id=1 packet_id=92

TransportProtocol 2 t_ssrc=0x0 r_ssrc=0x0 t_vpxcc=0x0 r_vpxcc=0x0

sid_support=1, tse_payload=65535, seq_num=0xE53, redundancy=0

*Mar 22 00:55:35.546: dsp_set_playout_delay

*Mar 22 00:55:35.546: dsp_set_playout: [1/0:1:443] packet_len=18 channel_id=1 packet_id=76 mode=1 initial=60 min=40 max=200 fax_nom=300 dsp_set_playout_delay_config

*Mar 22 00:55:35.546: dsp_set_playout_config

*Mar 22 00:55:35.546: mode 1, init 60, min 40, max 200 playout default

*Mar 22 00:55:35.546: dsp_set_playout_config:mode 1, init 60, min 40,

max 200

*Mar 22 00:55:35.546: dsp_set_playout_config: [1/0:1:443] packet_len=18 channel_id=1 packet_id=76 mode=1 initial=60 min=40 max=200 fax_nom=300

*Mar 22 00:55:35.550: dsp_echo_canceler_control: echo_cancel: 1

*Mar 22 00:55:35.550: dsp_echo_canceler_control: [1/0:1:443] echo_cancel 1, disable_hpf 0, flags=0x0, threshold=-21

*Mar 22 00:55:35.550: dsp_echo_canceler_control: [1/0:1:443] packet_len=14 channel_id=1 packet_id=66 flags=0x0, threshold=-21, suppressor coverage=7

*Mar 22 00:55:35.550: dsp_idle_code_det: [1/0:1:443] packet_len=14 channel_id=1 packet_id=116 enable=0, code=0, duration=6000

*Mar 22 00:55:35.550: dsp_set_gains: [1/0:1:443] packet_len=12 channel_id=1 packet_id=91 in_gain=0 out_gain=0

*Mar 22 00:55:35.550: dsp_vad_enable: [1/0:1:443] enable: packet_len=18 channel_id=1 packet_id=78 thresh=-38 vadtime=250 aggressive=0 noise=-62

*Mar 22 00:55:35.550: cc_process_call_setup_ind (event=0x8126D258)

*Mar 22 00:55:35.554: >>>>CCAPI handed cid 443 with tag 10 to app "DEFAULT"

*Mar 22 00:55:35.554: sess_appl: ev(24=CC_EV_CALL_SETUP_IND), cid(443), disp(0)

*Mar 22 00:55:35.554: sess_appl: ev(SSA_EV_CALL_SETUP_IND), cid(443), disp(0)

New Member

Re: R2 DTMF in a VG200

*Mar 22 00:55:35.554: ssaCallSetupInd

*Mar 22 00:55:35.554: ccCallSetContext (callID=0x1BB, context=0x812EFF88)

*Mar 22 00:55:35.554: ssaCallSetupInd cid(443), st(SSA_CS_MAPPING),oldst(0), ev(24)ev->e.evCallSetupInd.nCallInfo.finalDestFlag = 0

*Mar 22 00:55:35.554: ccCallSetupAck (callID=0x1BB)

*Mar 22 00:55:35.554: ccCallReportDigits (callID=0x1BB, enable=0x1)

*Mar 22 00:55:35.558: vtsp_report_digit_control: enable=1: digit reporting enabled

*Mar 22 00:55:35.558: cc_api_call_report_digits_done (vdbPtr=0x812E9958, callID=0x1BB, disp=0)

*Mar 22 00:55:35.558: : vtsp_get_digit_timeouts

*Mar 22 00:55:35.558: sess_appl: ev(53=CC_EV_CALL_REPORT_DIGITS_DONE), cid(443), disp(0)

*Mar 22 00:55:35.558: cid(443)st(SSA_CS_MAPPING)ev(SSA_EV_CALL_REPORT_DIGITS_DONE)

oldst(SSA_CS_MAPPING)cfid(-1)csize(0)in(1)fDest(0)

*Mar 22 00:55:35.558: ssaReportDigitsDone cid(443) peer list: (empty)

*Mar 22 00:55:35.558: ssaReportDigitsDone callid=443 Enable succeeded

*Mar 22 00:55:35.558: ccGenerateTone (callID=0x1BB tone=8)

*Mar 22 00:55:35.558: vtsp:[1/0:1:443, S_SETUP_INDICATED, E_CC_SETUP_ACK]

*Mar 22 00:55:35.562: act_setup_ind_ack

*Mar 22 00:55:35.562: vtsp_modem_proto_from_cdb: cap_modem_proto 0

*Mar 22 00:55:35.562: vtsp_modem_proto_from_cdb: cap_modem_proto 0

*Mar 22 00:55:35.562: dsp_encap_config: [1/0:1:443] packet_len=30 channel_id=1 packet_id=92

TransportProtocol 2 t_ssrc=0x0 r_ssrc=0x0 t_vpxcc=0x0 r_vpxcc=0x0

sid_support=1, tse_payload=65535, seq_num=0xE53, redundancy=0

*Mar 22 00:55:35.562: dsp_voice_mode: [1/0:1:443] cdb 8145B0D8, cdb->codec_params.modem 2, inband_detect flags 0x21

*Mar 22 00:55:35.562: map_dtmf_relay_type--digit relay mode: 2

*Mar 22 00:55:35.562: dsp_voice_mode: [1/0:1:443] packet_len=24 channel_id=1 packet_id=73 coding_type=1 voice_field_size=160 VAD_flag=0 echo_length=64 comfort_noise=1 inband_detect=33 digit_relay_mode=2 AGC_flag=0act_setup_ind_ack: modem_mode = 0, fax_relay_on = 1

*Mar 22 00:55:35.562: act_setup_ind_ack(): dsp_dtmf_mode()

dsp_dtmf_mode(VTSP_TONE_DTMF_MODE)

*Mar 22 00:55:35.566: dsp_dtmf_mode: [1/0:1:443] packet_len=10 channel_id=1 packet_id=65 dtmf_or_mf=0

*Mar 22 00:55:35.566: vtsp_timer: 181773569

*Mar 22 00:55:35.566: vtsp:[1/0:1:443, S_DIGIT_COLLECT, E_CC_GEN_TONE]

*Mar 22 00:55:35.566: act_gen_tone

*Mar 22 00:55:35.566: dsp_cp_tone_off: [1/0:1:443] packet_len=8 channel_id=1 packet_id=71

*Mar 22 00:55:35.566: dsp_cp_tone_on: [1/0:1:443] packet_len=38 channel_id=1 packet_id=72 tone_id=4 n_freq=2 freq_of_first=350 freq_of_second=440 amp_of_first=6942 amp_of_second=6942 direction=1 on_time_first=65535 off_time_first=0 on_time_second=0 off_time_second=0

*Mar 22 00:55:35.566: htsp_process_event: [1/0:1(3), R2_Q421_IC_SEIZE, E_HTSP_SETUP_ACK]

*Mar 22 00:55:35.566: r2_q421_ic_setup(1/0:1(3)) E_HTSP_SETUP_ACK

*Mar 22 00:55:35.570: r2_reg_offhook(1/0:1(3))

*Mar 22 00:55:38.114: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN: digit=8, rtp_timestamp=0xA4F5FA87

*Mar 22 00:55:38.114: vtsp:[1/0:1:443, S_DIGIT_COLLECT, E_DSP_DTMF_DIGIT_BEGIN]

*Mar 22 00:55:38.114: act_report_digit_begin

*Mar 22 00:55:38.114: cc_api_call_digit_begin (dstVdbPtr=0x0, dstCallId=0xFFFFFFFF, srcCallId=0x1BB,

digit=8, digit_begin_flags=0x1, rtp_timestamp=0xA4F5FA87

rtp_expiration=0x0, dest_mask=0x1)

*Mar 22 00:55:38.118: sess_appl: ev(10=CC_EV_CALL_DIGIT_BEGIN), cid(443), disp(0)

*Mar 22 00:55:38.118: cid(443)st(SSA_CS_MAPPING)ev(SSA_EV_DIGIT_BEGIN)

oldst(SSA_CS_MAPPING)cfid(-1)csize(0)in(1)fDest(0)

*Mar 22 00:55:38.118: ssaIgnore cid(443), st(SSA_CS_MAPPING),oldst(0), ev(10)

*Mar 22 00:55:38.214: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF: digit=8, duration=135

*Mar 22 00:55:38.214: vtsp:[1/0:1:443, S_DIGIT_COLLECT, E_DSP_DTMF_DIGIT]

*Mar 22 00:55:38.214: act_report_digit_end

*Mar 22 00:55:38.214: vtsp_timer_stop: 181773834

*Mar 22 00:55:38.218: dsp_cp_tone_off: [1/0:1:443] packet_len=8 channel_id=1 packet_id=71

*Mar 22 00:55:38.218: cc_api_call_digit_end (dstVdbPtr=0x0, dstCallId=0xFFFFFFFF, srcCallId=0x1BB,

digit=8,duration=135,xruleCallingTag=0,xruleCalledTag=0, dest_mask=0x1), digit_tone_mode=0

*Mar 22 00:55:38.218: vtsp_timer: 181773834

*Mar 22 00:55:38.218: sess_appl: ev(9=CC_EV_CALL_DIGIT_END), cid(443), disp(0)

*Mar 22 00:55:38.218: cid(443)st(SSA_CS_MAPPING)ev(SSA_EV_CALL_DIGIT)

oldst(SSA_CS_MAPPING)cfid(-1)csize(0)in(1)fDest(0)

*Mar 22 00:55:38.218: ssaDigit

*Mar 22 00:55:38.218: ssaDigit, 0. sct->digit , sct->digit len 0, usrDigit 8, digit_tone_mode=0

*Mar 22 00:55:38.218: ssaDigit,1. callinfo.called , digit 8, callinfo.calling , xrulecallingtag 0, xrulecalledtag 0

*Mar 22 00:55:38.222: ssaDigit, 7. callinfo.calling , sct->digit 8, result 1

*Mar 22 00:55:38.374: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN: digit=0, rtp_timestamp=0xA4F5FA87

New Member

Re: R2 DTMF in a VG200

*Mar 22 00:55:38.374: vtsp:[1/0:1:443, S_DIGIT_COLLECT, E_DSP_DTMF_DIGIT_BEGIN]

*Mar 22 00:55:38.374: act_report_digit_begin

*Mar 22 00:55:38.374: cc_api_call_digit_begin (dstVdbPtr=0x0, dstCallId=0xFFFFFFFF, srcCallId=0x1BB,

digit=0, digit_begin_flags=0x1, rtp_timestamp=0xA4F5FA87

rtp_expiration=0x0, dest_mask=0x1)

*Mar 22 00:55:38.378: sess_appl: ev(10=CC_EV_CALL_DIGIT_BEGIN), cid(443), disp(0)

*Mar 22 00:55:38.378: cid(443)st(SSA_CS_MAPPING)ev(SSA_EV_DIGIT_BEGIN)

oldst(SSA_CS_MAPPING)cfid(-1)csize(0)in(1)fDest(0)

*Mar 22 00:55:38.378: ssaIgnore cid(443), st(SSA_CS_MAPPING),oldst(0), ev(10)

*Mar 22 00:55:38.474: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF: digit=0, duration=135

*Mar 22 00:55:38.474: vtsp:[1/0:1:443, S_DIGIT_COLLECT, E_DSP_DTMF_DIGIT]

*Mar 22 00:55:38.474: act_report_digit_end

*Mar 22 00:55:38.474: vtsp_timer_stop: 181773860

*Mar 22 00:55:38.478: cc_api_call_digit_end (dstVdbPtr=0x0, dstCallId=0xFFFFFFFF, srcCallId=0x1BB,

digit=0,duration=135,xruleCallingTag=0,xruleCalledTag=0, dest_mask=0x1), digit_tone_mode=0

*Mar 22 00:55:38.478: vtsp_timer: 181773860

*Mar 22 00:55:38.478: sess_appl: ev(9=CC_EV_CALL_DIGIT_END), cid(443), disp(0)

*Mar 22 00:55:38.478: cid(443)st(SSA_CS_MAPPING)ev(SSA_EV_CALL_DIGIT)

oldst(SSA_CS_MAPPING)cfid(-1)csize(0)in(1)fDest(0)

*Mar 22 00:55:38.478: ssaDigit

*Mar 22 00:55:38.478: ssaDigit, 0. sct->digit 8, sct->digit len 1, usrDigit 0, digit_tone_mode=0

*Mar 22 00:55:38.478: ssaDigit,1. callinfo.called , digit 80, callinfo.calling , xrulecallingtag 0, xrulecalledtag 0

*Mar 22 00:55:38.478: ssaDigit, 7. callinfo.calling , sct->digit 80, result 1

*Mar 22 00:55:38.626: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN: digit=1, rtp_timestamp=0xA4F5FA87

*Mar 22 00:55:38.626: vtsp:[1/0:1:443, S_DIGIT_COLLECT, E_DSP_DTMF_DIGIT_BEGIN]

*Mar 22 00:55:38.626: act_report_digit_begin

*Mar 22 00:55:38.626: cc_api_call_digit_begin (dstVdbPtr=0x0, dstCallId=0xFFFFFFFF, srcCallId=0x1BB,

digit=1, digit_begin_flags=0x1, rtp_timestamp=0xA4F5FA87

rtp_expiration=0x0, dest_mask=0x1)

*Mar 22 00:55:38.626: sess_appl: ev(10=CC_EV_CALL_DIGIT_BEGIN), cid(443), disp(0)

*Mar 22 00:55:38.626: cid(443)st(SSA_CS_MAPPING)ev(SSA_EV_DIGIT_BEGIN)

oldst(SSA_CS_MAPPING)cfid(-1)csize(0)in(1)fDest(0)

*Mar 22 00:55:38.626: ssaIgnore cid(443), st(SSA_CS_MAPPING),oldst(0), ev(10)

*Mar 22 00:55:38.726: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF: digit=1, duration=135

*Mar 22 00:55:38.726: vtsp:[1/0:1:443, S_DIGIT_COLLECT, E_DSP_DTMF_DIGIT]

*Mar 22 00:55:38.726: act_report_digit_end

*Mar 22 00:55:38.726: vtsp_timer_stop: 181773885

*Mar 22 00:55:38.726: cc_api_call_digit_end (dstVdbPtr=0x0, dstCallId=0xFFFFFFFF, srcCallId=0x1BB,

digit=1,duration=135,xruleCallingTag=0,xruleCalledTag=0, dest_mask=0x1), digit_tone_mode=0

*Mar 22 00:55:38.726: vtsp_timer: 181773885

*Mar 22 00:55:38.726: sess_appl: ev(9=CC_EV_CALL_DIGIT_END), cid(443), disp(0)

*Mar 22 00:55:38.726: cid(443)st(SSA_CS_MAPPING)ev(SSA_EV_CALL_DIGIT)

oldst(SSA_CS_MAPPING)cfid(-1)csize(0)in(1)fDest(0)

*Mar 22 00:55:38.730: ssaDigit

*Mar 22 00:55:38.730: ssaDigit, 0. sct->digit 80, sct->digit len 2, usrDigit 1, digit_tone_mode=0

*Mar 22 00:55:38.730: ssaDigit,1. callinfo.called , digit 801, callinfo.calling , xrulecallingtag 0, xrulecalledtag 0

*Mar 22 00:55:38.730: ssaDigit, 7. callinfo.calling , sct->digit 801, result 1

*Mar 22 00:55:38.886: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN: digit=0, rtp_timestamp=0xA4F5FA87

*Mar 22 00:55:38.886: vtsp:[1/0:1:443, S_DIGIT_COLLECT, E_DSP_DTMF_DIGIT_BEGIN]

*Mar 22 00:55:38.886: act_report_digit_begin

*Mar 22 00:55:38.886: cc_api_call_digit_begin (dstVdbPtr=0x0, dstCallId=0xFFFFFFFF, srcCallId=0x1BB,

digit=0, digit_begin_flags=0x1, rtp_timestamp=0xA4F5FA87

rtp_expiration=0x0, dest_mask=0x1)

*Mar 22 00:55:38.886: sess_appl: ev(10=CC_EV_CALL_DIGIT_BEGIN), cid(443), disp(0)

*Mar 22 00:55:38.886: cid(443)st(SSA_CS_MAPPING)ev(SSA_EV_DIGIT_BEGIN)

oldst(SSA_CS_MAPPING)cfid(-1)csize(0)in(1)fDest(0)

*Mar 22 00:55:38.886: ssaIgnore cid(443), st(SSA_CS_MAPPING),oldst(0), ev(10)

*Mar 22 00:55:38.986: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF: digit=0, duration=135

*Mar 22 00:55:38.986: vtsp:[1/0:1:443, S_DIGIT_COLLECT, E_DSP_DTMF_DIGIT]

*Mar 22 00:55:38.986: act_report_digit_end

*Mar 22 00:55:38.986: vtsp_timer_stop: 181773911

*Mar 22 00:55:38.986: cc_api_call_digit_end (dstVdbPtr=0x0, dstCallId=0xFFFFFFFF, srcCallId=0x1BB,

digit=0,duration=135,xruleCallingTag=0,xruleCalledTag=0, dest_mask=0x1), digit_tone_mode=0

*Mar 22 00:55:38.986: vtsp_timer: 181773911

*Mar 22 00:55:38.986: sess_appl: ev(9=CC_EV_CALL_DIGIT_END), cid(443), disp(0)

*Mar 22 00:55:38.986: cid(443)st(SSA_CS_MAPPING)ev(SSA_EV_CALL_DIGIT)

oldst(SSA_CS_MAPPING)cfid(-1)csize(0)in(1)fDest(0)

*Mar 22 00:55:38.990: ssaDigit

*Mar 22 00:55:38.990: ssaDigit, 0. sct->digit 801, sct->digit len 3, usrDigit 0, digit_tone_mode=0

*Mar 22 00:55:38.990: ssaDigit,1. callinfo.called , digit 8010, callinfo.calling , xrulecallingtag 0, xrulecalledtag 0

*Mar 22 00:55:38.990: ssaDigit, 7. callinfo.calling , sct->digit 8010, result 1

*Mar 22 00:55:39.222: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN: digit=0, rtp_timestamp=0xA4F5FA87

*Mar 22 00:55:39.222: vtsp:[1/0:1:443, S_DIGIT_COLLECT, E_DSP_DTMF_DIGIT_BEGIN]

*Mar 22 00:55:39.222: act_report_digit_begin

*Mar 22 00:55:39.222: cc_api_call_digit_begin (dstVdbPtr=0x0, dstCallId=0xFFFFFFFF, srcCallId=0x1BB,

digit=0, digit_begin_flags=0x1, rtp_timestamp=0xA4F5FA87

rtp_expiration=0x0, dest_mask=0x1)

*Mar 22 00:55:39.226: sess_appl: ev(10=CC_EV_CALL_DIGIT_BEGIN), cid(443), disp(0)

*Mar 22 00:55:39.230: cid(443)st(SSA_CS_MAPPING)ev(SSA_EV_DIGIT_BEGIN)

oldst(SSA_CS_MAPPING)cfid(-1)csize(0)in(1)fDest(0)

*Mar 22 00:55:39.230: ssaIgnore cid(443), st(SSA_CS_MAPPING),oldst(0), ev(10)

*Mar 22 00:55:39.246: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF: digit=0, duration=135

*Mar 22 00:55:39.246: vtsp:[1/0:1:443, S_DIGIT_COLLECT, E_DSP_DTMF_DIGIT]

*Mar 22 00:55:39.246: act_report_digit_end

*Mar 22 00:55:39.246: vtsp_timer_stop: 181773937

*Mar 22 00:55:39.246: cc_api_call_digit_end (dstVdbPtr=0x0, dstCallId=0xFFFFFFFF, srcCallId=0x1BB,

digit=0,duration=135,xruleCallingTag=0,xruleCalledTag=0, dest_mask=0x1), digit_tone_mode=0

*Mar 22 00:55:39.246: vtsp_timer: 181773937

*Mar 22 00:55:39.246: sess_appl: ev(9=CC_EV_CALL_DIGIT_END), cid(443), disp(0)

*Mar 22 00:55:39.246: cid(443)st(SSA_CS_MAPPING)ev(SSA_EV_CALL_DIGIT)

oldst(SSA_CS_MAPPING)cfid(-1)csize(0)in(1)fDest(0)

*Mar 22 00:55:39.246: ssaDigit

*Mar 22 00:55:39.250: ssaDigit, 0. sct->digit 8010, sct->digit len 4, usrDigit 0, digit_tone_mode=0

*Mar 22 00:55:39.250: ssaDigit,1. callinfo.called , digit 80100, callinfo.calling , xrulecallingtag 0, xrulecalledtag 0

*Mar 22 00:55:39.250: ssaDigit, 7. callinfo.calling , sct->digit 80100, result 1

*Mar 22 00:55:49.246: vtsp_main: timer: 181774937

*Mar 22 00:55:49.246: vtsp:[1/0:1:443, S_DIGIT_COLLECT, E_TIMER]

*Mar 22 00:55:49.246: act_dcollect_timer

New Member

Re: R2 DTMF in a VG200

*Mar 22 00:55:49.246: sess_appl: ev(9=CC_EV_CALL_DIGIT_END), cid(443), disp(0)

*Mar 22 00:55:49.246: cid(443)st(SSA_CS_MAPPING)ev(SSA_EV_CALL_DIGIT)

oldst(SSA_CS_MAPPING)cfid(-1)csize(0)in(1)fDest(0)

*Mar 22 00:55:49.246: ssaDigit

*Mar 22 00:55:49.246: ssaDigit, 0. sct->digit 80100, sct->digit len 5, usrDigit T, digit_tone_mode=0

*Mar 22 00:55:49.246: ssaDigit,1. callinfo.called , digit 80100T, callinfo.calling , xrulecallingtag -1527383417, xrulecalledtag 0

*Mar 22 00:55:49.246: ssaDigit,3. calling , calllen 0, result -4

*Mar 22 00:55:49.250: ssaDigit, 7. callinfo.calling , sct->digit 80100, result 0

*Mar 22 00:55:49.250: ccCallReportDigits (callID=0x1BB, enable=0x0)

*Mar 22 00:55:49.250: vtsp_report_digit_control: enable=0: digit reporting disabled

*Mar 22 00:55:49.250: cc_api_call_report_digits_done (vdbPtr=0x812E9958, callID=0x1BB, disp=0)

*Mar 22 00:55:49.250: : vtsp_get_digit_timeouts

*Mar 22 00:55:49.250: ssaSetupPeer cid(443) peer list: tag(110) called number (900180100)

*Mar 22 00:55:49.254: ssaSetupPeer cid(443), destPat(900180100), matched(4), prefix(), peer(813EF15C), peer->encapType (2)

*Mar 22 00:55:49.254: ccCallProceeding (callID=0x1BB, prog_ind=0x0)

*Mar 22 00:55:49.254: ccCallSetupRequest (Inbound call = 0x1BB, outbound peer =110, dest=, params=0x8127A900 mode=0, *callID=0x8127AC70, prog_ind = 3) callingIE_present 0

*Mar 22 00:55:49.254: ccCallSetupRequest numbering_type 0x81

*Mar 22 00:55:49.254: ccCallSetupRequest encapType 2 clid_restrict_disable 1 null_orig_clg 1 clid_transparent 0 callingNumber

*Mar 22 00:55:49.254: dest pattern 9001T, called 900180100, digit_strip 0

*Mar 22 00:55:49.254: callingNumber=, calledNumber=900180100, redirectNumber= display_info= calling_oct3a=0

*Mar 22 00:55:49.254: accountNumber=, finalDestFlag=0,

guid=c69c.0fd4.2576.11cc.82c8.f5ea.c536.2011

*Mar 22 00:55:49.254: peer_tag=110

*Mar 22 00:55:49.254: ccIFCallSetupRequestPrivate: (vdbPtr=0x81213168, dest=, callParams={called=900180100,called_oct3=0x81, calling=,calling_oct3=0x0, calling_xlated=false, subscriber_type_str=RegularLine, fdest=0, voice_peer_tag=110},mode=0x0) vdbPtr type = 1

*Mar 22 00:55:49.258: ccIFCallSetupRequestPrivate: (vdbPtr=0x81213168, dest=, callParams={called=900180100, called_oct3 0x81, calling=,calling_oct3 0x0, calling_xlated=false, fdest=0, voice_peer_tag=110}, mode=0x0, xltrc=-5)

*Mar 22 00:55:49.258: ccSaveDialpeerTag (callID=0x1BB, dialpeer_tag=0x6E)

*Mar 22 00:55:49.258: vtsp_save_dialpeer_tag: tag = 110

*Mar 22 00:55:49.258: ccCallSetContext (callID=0x1BC, context=0x81483BE4)

*Mar 22 00:55:49.258: sess_appl: ev(53=CC_EV_CALL_REPORT_DIGITS_DONE), cid(443), disp(0)

*Mar 22 00:55:49.258: cid(443)st(SSA_CS_CALL_SETTING)ev(SSA_EV_CALL_REPORT_DIGITS_DONE)

oldst(SSA_CS_MAPPING)cfid(-1)csize(0)in(1)fDest(0)

*Mar 22 00:55:49.258: -cid2(444)st2(SSA_CS_CALL_SETTING)oldst2(SSA_CS_MAPPING)

*Mar 22 00:55:49.262: ssaReportDigitsDone cid(443) peer list: (empty)

*Mar 22 00:55:49.262: ssaReportDigitsDone callid=443 Reporting disabled.

*Mar 22 00:55:49.262: vtsp:[1/0:1:443, S_DIGIT_COLLECT, E_CC_PROCEEDING]

*Mar 22 00:55:49.262: act_dcollect_proc

*Mar 22 00:55:49.262: htsp_process_event: [1/0:1(3), R2_Q421_IC_WAIT_ANSWER, E_HTSP_PROCEEDING]

*Mar 22 00:55:49.274: H225 NONSTD OUTGOING PDU ::=

value H323_UU_NonStdInfo ::=

{

version 0

progIndParam progIndIEinfo :

{

progIndIE '00000003'H

}

}

*Mar 22 00:55:49.274: H225 NONSTD OUTGOING ENCODE BUFFER::= C00100028006000400000003

*Mar 22 00:55:49.278:

*Mar 22 00:55:49.278: H225.0 OUTGOING PDU ::=

value H323_UserInformation ::=

{

h323-uu-pdu

{

h323-message-body setup :

{

protocolIdentifier { 0 0 8 2250 0 2 }

sourceInfo

{

vendor

{

vendor

{

t35CountryCode 181

t35Extension 0

manufacturerCode 18

}

}

gateway

{

protocol

{

voice :

{

}

}

}

mc FALSE

undefinedNode FALSE

}

activeMC FALSE

conferenceID 'C69C0FD4257611CC82C8F5EAC5362011'H

conferenceGoal create : NULL

callType pointToPoint : NULL

sourceCallSignalAddress ipAddress :

{

ip 'AC103C0A'H

port 11188

}

callIdentifier

{

guid 'C69C0FD4257611CC82C9F5EAC5362011'H

}

fastStart

{

'0000000C6013800A04000100AC103C0A47E7'H,

'400000060401004C6013801114000100AC103C0A...'H,

'0000010D4001800A04000100AC103C0A47E7'H,

'400001060401004D4001801114000100AC103C0A...'H

}

mediaWaitForConnect FALSE

canOverlapSend FALSE

}

h245Tunneling TRUE

nonStandardControl

{

{

nonStandardIdentifier h221NonStandard :

{

t35CountryCode 181

t35Extension 0

manufacturerCode 18

}

data 'C00100028006000400000003'H

}

}

}

}

*Mar 22 00:55:49.314: H225.0 OUTGOING ENCODE BUFFER::= 2080060008914A00022800B500001240013800C69C0FD4257611CC82C8F5EAC536201100451C0700AC103C0A2BB41100C69C0FD4257611CC82C9F5EAC53620116304120000000C6013800A04000100AC103C0A47E71D400000060401004C6013801114000100AC103C0A47E600AC103C0A47E7120000010D4001800A04000100AC103C0A47E71D400001060401004D4001801114000100AC103C0A47E600AC103C0A47E70100010006A00180130140B50000120CC00100028006000400000003

*Mar 22 00:55:49.318:

*Mar 22 00:55:49.454: H225.0 INCOMING ENCODE BUFFER::= 2180060008914A00020201201100C69C0FD4257611CC82C9F5EAC536201106A001000E0140B50000120780440400010100

*Mar 22 00:55:49.458:

*Mar 22 00:55:49.458: H225.0 INCOMING PDU ::=

value H323_UserInformation ::=

{

h323-uu-pdu

{

h323-message-body callProceeding :

{

protocolIdentifier { 0 0 8 2250 0 2 }

destinationInfo

{

terminal

{

}

mc FALSE

undefinedNode FALSE

}

callIdentifier

{

guid 'C69C0FD4257611CC82C9F5EAC5362011'H

}

}

h245Tunneling FALSE

nonStandardControl

{

{

nonStandardIdentifier h221NonStandard :

{

t35CountryCode 181

t35Extension 0

manufacturerCode 18

}

data '80440400010100'H

}

}

}

}

*Mar 22 00:55:49.474: H225 NONSTD INCOMING ENCODE BUFFER::= 80440400010100

*Mar 22 00:55:49.474:

*Mar 22 00:55:49.474: H225 NONSTD INCOMING PDU ::=

value H323_UU_NonStdInfo ::=

{

}

*Mar 22 00:55:49.474: cc_api_call_proceeding(vdbPtr=0x81213168, callID=0x1BC,

prog_ind=0x0)

*Mar 22 00:55:49.478: H225.0 INCOMING ENCODE BUFFER::= 2380060008914A00020201201100C69C0FD4257611CC82C9F5EAC536201106A001000E0140B50000120780440400010100

*Mar 22 00:55:49.478:

*Mar 22 00:55:49.478: H225.0 INCOMING PDU ::=

value H323_UserInformation ::=

{

h323-uu-pdu

{

h323-message-body alerting :

{

protocolIdentifier { 0 0 8 2250 0 2 }

destinationInfo

{

terminal

{

}

mc FALSE

undefinedNode FALSE

}

callIdentifier

{

guid 'C69C0FD4257611CC82C9F5EAC5362011'H

}

}

h245Tunneling FALSE

nonStandardControl

{

{

nonStandardIdentifier h221NonStandard :

{

t35CountryCode 181

t35Extension 0

manufacturerCode 18

}

data '80440400010100'H

}

}

}

}

*Mar 22 00:55:49.494: H225 NONSTD INCOMING ENCODE BUFFER::= 80440400010100

*Mar 22 00:55:49.494:

*Mar 22 00:55:49.498: H225 NONSTD INCOMING PDU ::=

value H323_UU_NonStdInfo ::=

{

}

*Mar 22 00:55:49.498: cc_api_call_alert(vdbPtr=0x81213168, callID=0x1BC, prog_ind=0x0, sig_ind=0x1)

*Mar 22 00:55:49.502: sess_appl: ev(21=CC_EV_CALL_PROCEEDING), cid(444), disp(0)

*Mar 22 00:55:49.502: cid(444)st(SSA_CS_CALL_SETTING)ev(SSA_EV_CALL_PROCEEDING)

oldst(SSA_CS_MAPPING)cfid(-1)csize(0)in(0)fDest(0)

*Mar 22 00:55:49.502: -cid2(443)st2(SSA_CS_CALL_SETTING)oldst2(SSA_CS_CALL_SETTING)

*Mar 22 00:55:49.502: ssaCallProc

*Mar 22 00:55:49.502: ccGetDialpeerTag (callID=0x1BB)

*Mar 22 00:55:49.502: vtsp_get_dialpeer_tag: tag = 110

*Mar 22 00:55:49.502: ssaIgnore cid(444), st(SSA_CS_CALL_SETTING),oldst(1), ev(21)

*Mar 22 00:55:49.502: sess_appl: ev(7=CC_EV_CALL_ALERT), cid(444), disp(0)

*Mar 22 00:55:49.502: cid(444)st(SSA_CS_CALL_SETTING)ev(SSA_EV_CALL_ALERT)

oldst(SSA_CS_CALL_SETTING)cfid(-1)csize(0)in(0)fDest(0)

*Mar 22 00:55:49.502: -cid2(443)st2(SSA_CS_CALL_SETTING)oldst2(SSA_CS_CALL_SETTING)

*Mar 22 00:55:49.506: ssaAlert

*Mar 22 00:55:49.506: ccGetDialpeerTag (callID=0x1BB)

*Mar 22 00:55:49.506: vtsp_get_dialpeer_tag: tag = 110

*Mar 22 00:55:49.506: ccCallAlert (callID=0x1BB, prog_ind=0x0, sig_ind=0x1)

*Mar 22 00:55:49.506: vtsp:[1/0:1:443, S_PROCEEDING, E_CC_ALERT]

*Mar 22 00:55:49.506: act_alert

New Member

Re: R2 DTMF in a VG200

*Mar 22 00:55:49.506: vtsp_timer_stop: 181774963

*Mar 22 00:55:49.506: dsp_cp_tone_on: [1/0:1:443] packet_len=38 channel_id=1 packet_id=72 tone_id=1 n_freq=2 freq_of_first=440 freq_of_second=480 amp_of_first=7354 amp_of_second=7354 direction=1 on_time_first=2000 off_time_first=4000 on_time_second=0 off_time_second=0htsp_alert_notify

*Mar 22 00:55:51.798: H225.0 INCOMING ENCODE BUFFER::= 22C0060008914A000200AC103C0409150200C69C0FD4257611CC82C8F5EAC536201109001100C69C0FD4257611CC82C9F5EAC536201106A001000E0140B50000120780440400010100

*Mar 22 00:55:51.798:

*Mar 22 00:55:51.802: H225.0 INCOMING PDU ::=

value H323_UserInformation ::=

{

h323-uu-pdu

{

h323-message-body connect :

{

protocolIdentifier { 0 0 8 2250 0 2 }

h245Address ipAddress :

{

ip 'AC103C04'H

port 2325

}

destinationInfo

{

terminal

{

}

mc FALSE

undefinedNode FALSE

}

conferenceID 'C69C0FD4257611CC82C8F5EAC5362011'H

callIdentifier

{

guid 'C69C0FD4257611CC82C9F5EAC5362011'H

}

}

h245Tunneling FALSE

nonStandardControl

{

{

nonStandardIdentifier h221NonStandard :

{

t35CountryCode 181

t35Extension 0

manufacturerCode 18

}

data '80440400010100'H

}

}

}

}

*Mar 22 00:55:51.822: H225 NONSTD INCOMING ENCODE BUFFER::= 80440400010100

*Mar 22 00:55:51.822:

*Mar 22 00:55:51.822: H225 NONSTD INCOMING PDU ::=

value H323_UU_NonStdInfo ::=

{

}

*Mar 22 00:55:51.874: cc_api_call_connected(vdbPtr=0x81213168, callID=0x1BC), prog_ind = 0cc_api_call_connected: setting callEntry->connected to TRUE

*Mar 22 00:55:51.878: sess_appl: ev(8=CC_EV_CALL_CONNECTED), cid(444), disp(0)

*Mar 22 00:55:51.878: cid(444)st(SSA_CS_ALERT_RCVD)ev(SSA_EV_CALL_CONNECTED)

oldst(SSA_CS_CALL_SETTING)cfid(-1)csize(0)in(0)fDest(0)

*Mar 22 00:55:51.878: -cid2(443)st2(SSA_CS_ALERT_RCVD)oldst2(SSA_CS_CALL_SETTING)

*Mar 22 00:55:51.878: ssaConnect

*Mar 22 00:55:51.878: ccGetDialpeerTag (callID=0x1BB)

*Mar 22 00:55:51.878: vtsp_get_dialpeer_tag: tag = 110

*Mar 22 00:55:51.878: ccConferenceCreate (confID=0x8127B024, callID1=0x1BB, callID2=0x1BC, tag=0x0)

*Mar 22 00:55:51.878: cc_api_bridge_done (confID=0x71, srcIF=0x81213168, srcCallID=0x1BC, dstCallID=0x1BB, disposition=0, tag=0x0)

*Mar 22 00:55:51.878: vtsp:[1/0:1:443, S_ALERTING, E_CC_BRIDGE]

*Mar 22 00:55:51.878: act_bridge

*Mar 22 00:55:51.882: cc_api_bridge_done (confID=0x71, srcIF=0x812E9958, srcCallID=0x1BB, dstCallID=0x1BC, disposition=0, tag=0x0)

*Mar 22 00:55:51.882: cc_api_caps_ind (dstVdbPtr=0x81213168, dstCallId=0x1BC, srcCallId=0x1BB,

caps={codec=0x2887F, fax_rate=0x7F, vad=0x3, modem=0x2

codec_bytes=0, signal_type=3})

*Mar 22 00:55:51.882: cc_api_caps_ind (Playout: mode 1, initial 60,min 40, max 200)

*Mar 22 00:55:51.882: cc_api_caps_ind (dstVdbPtr=0x812E9958, dstCallId=0x1BB, srcCallId=0x1BC,

caps={codec=0x1, fax_rate=0x2, vad=0x1, modem=0x0

codec_bytes=160, signal_type=1})

*Mar 22 00:55:51.882: cc_api_caps_ind (Playout: mode 1, initial 60,min 40, max 200)

*Mar 22 00:55:51.882: cc_api_caps_ack (dstVdbPtr=0x812E9958, dstCallId=0x1BB, srcCallId=0x1BC,

caps={codec=0x1, fax_rate=0x2, vad=0x1, modem=0x0

codec_bytes=160, signal_type=1, seq_num_start=6838})

*Mar 22 00:55:51.882: vtsp:[1/0:1:443, S_ALERTING, E_CC_CAPS_IND]

*Mar 22 00:55:51.886: act_caps_ind

*Mar 22 00:55:51.886: act_caps_ind: passthrough: cap_modem_proto 0, cap_modem_codec 0, cap_modem_redundancy 0, payload 100

*Mar 22 00:55:51.886: act_caps_ind:CC_CAP_ENCAP_RTP Encap 1, Vad 1, Codec 0x1, CodecBytes 160,

FaxRate 2, FaxBytes 20, FaxNsf 0xAD0051

SignalType 1

DtmfRelay 32, Modem 0, SeqNumStart 0x1AB6

*Mar 22 00:55:51.886: cc_api_caps_ack (dstVdbPtr=0x81213168, dstCallId=0x1BC, srcCallId=0x1BB,

caps={codec=0x1, fax_rate=0x2, vad=0x1, modem=0x0

codec_bytes=160, signal_type=1, seq_num_start=6838})

*Mar 22 00:55:51.886: act_caps_ind: [ mode:1,init:60, min:40, max:200]

*Mar 22 00:55:51.886: vtsp:[1/0:1:443, S_ALERTING, E_CC_CAPS_ACK]

*Mar 22 00:55:51.886: act_caps_ack

*Mar 22 00:55:51.886: act_caps_ack: passthrough: cap_modem_proto 0, cap_modem_codec 0, cap_modem_redundancy 0, payload 100

*Mar 22 00:55:51.886: dsp_idle_mode: [1/0:1:443] packet_len=8 channel_id=1 packet_id=68

*Mar 22 00:55:51.890: act_caps_ack: codec = 5, ret = 2

*Mar 22 00:55:51.890: vtsp_timer: 181775201

*Mar 22 00:55:51.890: vtsp:[1/0:1:443, S_NULL, E_DSPRM_PEND_SUCCESS]

*Mar 22 00:55:51.890: act_pend_codec_success

*Mar 22 00:55:51.890: vtsp_timer_stop: 181775201

*Mar 22 00:55:51.890: vtsp_open_voice_and_set_params

*Mar 22 00:55:51.890: dsp_close_voice_channel: [1/0:1:443] packet_len=8 channel_id=1 packet_id=75

*Mar 22 00:55:51.890: dsp_open_voice_channel_20: [1/0:1:443] packet_len=16 channel_id=1 packet_id=74 alaw_ulaw_select=1 associated_signaling_channel=128 time_slot=0 serial_port=0

*Mar 22 00:55:51.890: vtsp_modem_proto_from_cdb: cap_modem_proto 0

*Mar 22 00:55:51.894: vtsp_modem_proto_from_cdb: cap_modem_proto 0

*Mar 22 00:55:51.894: dsp_encap_config: [1/0:1:443] packet_len=30 channel_id=1 packet_id=92

TransportProtocol 2 t_ssrc=0x0 r_ssrc=0x0 t_vpxcc=0x0 r_vpxcc=0x0

sid_support=1, tse_payload=65535, seq_num=0x1AB6, redundancy=0

*Mar 22 00:55:51.894: dsp_set_playout_delay

*Mar 22 00:55:51.894: dsp_set_playout: [1/0:1:443] packet_len=18 channel_id=1 packet_id=76 mode=1 initial=60 min=40 max=200 fax_nom=300 dsp_set_playout_delay_config

*Mar 22 00:55:51.894: dsp_set_playout_config

*Mar 22 00:55:51.894: mode 1, init 60, min 40, max 200 playout default

*Mar 22 00:55:51.894: dsp_set_playout_config:mode 1, init 60, min 40,

max 200

*Mar 22 00:55:51.894: dsp_set_playout_config: [1/0:1:443] packet_len=18 channel_id=1 packet_id=76 mode=1 initial=60 min=40 max=200 fax_nom=300

*Mar 22 00:55:51.894: dsp_echo_canceler_control: echo_cancel: 1

*Mar 22 00:55:51.898: dsp_echo_canceler_control: [1/0:1:443] echo_cancel 1, disable_hpf 0, flags=0x0, threshold=-21

*Mar 22 00:55:51.898: dsp_echo_canceler_control: [1/0:1:443] packet_len=14 channel_id=1 packet_id=66 flags=0x0, threshold=-21, suppressor coverage=7

*Mar 22 00:55:51.898: dsp_idle_code_det: [1/0:1:443] packet_len=14 channel_id=1 packet_id=116 enable=0, code=0, duration=6000

*Mar 22 00:55:51.898: dsp_set_gains: [1/0:1:443] packet_len=12 channel_id=1 packet_id=91 in_gain=0 out_gain=0

*Mar 22 00:55:51.898: dsp_vad_enable: [1/0:1:443] enable: packet_len=18 channel_id=1 packet_id=78 thresh=-38 vadtime=250 aggressive=0 noise=-62

*Mar 22 00:55:51.898: dsp_voice_mode: [1/0:1:443] cdb 8145B0D8, cdb->codec_params.modem 0, inband_detect flags 0x1

*Mar 22 00:55:51.898: map_dtmf_relay_type--digit relay mode: 3

*Mar 22 00:55:51.898: dsp_voice_mode: [1/0:1:443] packet_len=24 channel_id=1 packet_id=73 coding_type=1 voice_field_size=160 VAD_flag=0 echo_length=64 comfort_noise=1 inband_detect=1 digit_relay_mode=3 AGC_flag=0

*Mar 22 00:55:51.902: dsp_vad_enable: [1/0:1:443] disable: packet_len=8 channel_id=1 packet_id=77

*Mar 22 00:55:51.902: cc_api_voice_mode_event , callID=0x1BB

*Mar 22 00:55:51.902: Call Pointer =812EFF88

*Mar 22 00:55:51.902: htsp_process_event: [1/0:1(3), R2_Q421_IC_WAIT_ANSWER, E_HTSP_VOICE_CUT_THROUGH]

*Mar 22 00:55:51.902: sess_appl: ev(29=CC_EV_CONF_CREATE_DONE), cid(443), disp(0)

*Mar 22 00:55:51.902: cid(443)st(SSA_CS_CONFERENCING)ev(SSA_EV_CONF_CREATE_DONE)

oldst(SSA_CS_CALL_SETTING)cfid(113)csize(2)in(1)fDest(0)

*Mar 22 00:55:51.906: -cid2(444)st2(SSA_CS_CONFERENCING)oldst2(SSA_CS_ALERT_RCVD)

*Mar 22 00:55:51.906: ssaConfCreateDone

*Mar 22 00:55:51.906: ccCallConnect (callID=0x1BB), prog_ind = 0ccCallConnect: setting callEntry->connected to TRUE

New Member

Re: R2 DTMF in a VG200

*Mar 22 00:55:51.906: ssaFlushPeerTagQueue cid(443) peer list: (empty)

*Mar 22 00:55:51.906: sess_appl: ev(51=CC_EV_VOICE_MODE_DONE), cid(443), disp(0)

*Mar 22 00:55:51.906: cid(443)st(SSA_CS_ACTIVE)ev(SSA_EV_VOICE_MODE_DONE)

oldst(SSA_CS_CONFERENCING)cfid(113)csize(2)in(1)fDest(0)

*Mar 22 00:55:51.906: -cid2(444)st2(SSA_CS_ACTIVE)oldst2(SSA_CS_ALERT_RCVD)

*Mar 22 00:55:51.906: ssaIgnore cid(443), st(SSA_CS_ACTIVE),oldst(5), ev(51)

*Mar 22 00:55:51.906: vtsp:[1/0:1:443, S_ALERTING, E_CC_CONNECT]

*Mar 22 00:55:51.910: act_alert_connect

*Mar 22 00:55:51.910: cc_process_notify_bridge_done (event=0x8127268C)

*Mar 22 00:55:55.110: vtsp_process_dsp_message: MSG_TX_GET_TX_STAT: rtp_timestamp=0xB04CED82

*Mar 22 00:55:58.078: vtsp_process_dsp_message: MSG_TX_GET_TX_STAT: rtp_timestamp=0xB04D4A32

*Mar 22 00:55:59.394: H225.0 INCOMING ENCODE BUFFER::= 2580060008914A0002011100C69C0FD4257611CC82C9F5EAC536201106800100

*Mar 22 00:55:59.398:

*Mar 22 00:55:59.398: H225.0 INCOMING PDU ::=

value H323_UserInformation ::=

{

h323-uu-pdu

{

h323-message-body releaseComplete :

{

protocolIdentifier { 0 0 8 2250 0 2 }

callIdentifier

{

guid 'C69C0FD4257611CC82C9F5EAC5362011'H

}

}

h245Tunneling FALSE

}

}

*Mar 22 00:55:59.406: cc_api_call_disconnected(vdbPtr=0x81213168, callID=0x1BC, cause=0x10)

*Mar 22 00:55:59.410: sess_appl: ev(11=CC_EV_CALL_DISCONNECTED), cid(444), disp(0)

*Mar 22 00:55:59.410: cid(444)st(SSA_CS_ACTIVE)ev(SSA_EV_CALL_DISCONNECTED)

oldst(SSA_CS_ALERT_RCVD)cfid(113)csize(2)in(0)fDest(0)

*Mar 22 00:55:59.410: -cid2(443)st2(SSA_CS_ACTIVE)oldst2(SSA_CS_ACTIVE)

*Mar 22 00:55:59.410: ssa: Disconnected cid(444) state(5) cause(0x10)

*Mar 22 00:55:59.410: ccConferenceDestroy (confID=0x71, tag=0x0)

*Mar 22 00:55:59.410: cc_api_bridge_drop_done (confID=0x71, srcIF=0x81213168, srcCallID=0x1BC, dstCallID=0x1BB, disposition=0 tag=0x0)

*Mar 22 00:55:59.410: vtsp:[1/0:1:443, S_ALERTING, E_CC_BRIDGE_DROP]

*Mar 22 00:55:59.410: act_bdrop

*Mar 22 00:55:59.414: cc_api_bridge_drop_done (confID=0x71, srcIF=0x812E9958, srcCallID=0x1BB, dstCallID=0x1BC, disposition=0 tag=0x0)

*Mar 22 00:55:59.414: sess_appl: ev(30=CC_EV_CONF_DESTROY_DONE), cid(443), disp(0)

*Mar 22 00:55:59.414: cid(443)st(SSA_CS_CONF_DESTROYING)ev(SSA_EV_CONF_DESTROY_DONE)

oldst(SSA_CS_ACTIVE)cfid(113)csize(2)in(1)fDest(0)

*Mar 22 00:55:59.414: -cid2(444)st2(SSA_CS_CONF_DESTROYING)oldst2(SSA_CS_ACTIVE)

*Mar 22 00:55:59.414: ssaConfDestroyDone

*Mar 22 00:55:59.414: ccCallDisconnect (callID=0x1BB, cause=0x10 tag=0x0)

*Mar 22 00:55:59.414: ccCallDisconnect: existing_cause = 0x0, new_cause = 0x10

*Mar 22 00:55:59.414: ccCallDisconnect (callID=0x1BC, cause=0x10 tag=0x0)

*Mar 22 00:55:59.414: ccCallDisconnect: existing_cause = 0x0, new_cause = 0x10

*Mar 22 00:55:59.418: vtsp:[1/0:1:443, S_ALERTING, E_CC_DISCONNECT]

*Mar 22 00:55:59.418: act_pre_con_disconnect

*Mar 22 00:55:59.418: vtsp_ring_noan_timer_stop: 181775954

*Mar 22 00:55:59.418: dsp_cp_tone_off: [1/0:1:443] packet_len=8 channel_id=1 packet_id=71

*Mar 22 00:55:59.418: dsp_idle_mode: [1/0:1:443] packet_len=8 channel_id=1 packet_id=68

*Mar 22 00:55:59.418: dsp_voice_mode: [1/0:1:443] cdb 8145B0D8, cdb->codec_params.modem 0, inband_detect flags 0x1

*Mar 22 00:55:59.418: map_dtmf_relay_type--digit relay mode: 3

*Mar 22 00:55:59.418: dsp_voice_mode: [1/0:1:443] packet_len=24 channel_id=1 packet_id=73 coding_type=1 voice_field_size=160 VAD_flag=0 echo_length=64 comfort_noise=1 inband_detect=1 digit_relay_mode=3 AGC_flag=0

*Mar 22 00:55:59.422: dsp_cp_tone_on: [1/0:1:443] packet_len=38 channel_id=1 packet_id=72 tone_id=0 n_freq=2 freq_of_first=480 freq_of_second=620 amp_of_first=6554 amp_of_second=6554 direction=1 on_time_first=500 off_time_first=500 on_time_second=0 off_time_second=0

*Mar 22 00:55:59.422: vtsp_timer_stop: 181775954

*Mar 22 00:55:59.422: vtsp_play_busy_timer_start: 181775954

*Mar 22 00:55:59.422: cc_api_icpif: expect factor = 0

*Mar 22 00:55:59.426: cc_api_call_disconnect_done(vdbPtr=0x81213168, callID=0x1BC, disp=0, tag=0x0)

*Mar 22 00:55:59.426: sess_appl: ev(12=CC_EV_CALL_DISCONNECT_DONE), cid(444), disp(0)

*Mar 22 00:55:59.426: cid(444)st(SSA_CS_DISCONNECTING)ev(SSA_EV_CALL_DISCONNECT_DONE)

oldst(SSA_CS_ACTIVE)cfid(-1)csize(2)in(0)fDest(0)

*Mar 22 00:55:59.426: -cid2(443)st2(SSA_CS_DISCONNECTING)oldst2(SSA_CS_CONF_DESTROYING)

*Mar 22 00:55:59.430: ssaDisconnectDone

*Mar 22 00:56:00.738: htsp_process_event: [1/0:1(3), R2_Q421_IC_WAIT_ANSWER, E_DSP_SIG_1000]

*Mar 22 00:56:00.738: r2_q421_ic_clr_fwd_idle(1/0:1(3)) Rx CLEAR FWD

*Mar 22 00:56:00.738: r2_reg_channel_disconnected(1/0:1(3))

*Mar 22 00:56:00.738: htsp_timer - 2000 msec

*Mar 22 00:56:00.738: vtsp:[1/0:1:443, S_WAIT_RELEASE_NC, E_TSP_DISCONNECT_IND]

*Mar 22 00:56:00.738: act_pre_con_disc_rel

*Mar 22 00:56:00.738: vtsp_play_busy_timer_stop: 181776086

*Mar 22 00:56:00.738: dsp_cp_tone_off: [1/0:1:443] packet_len=8 channel_id=1 packet_id=71

*Mar 22 00:56:00.742: htsp_process_event: [1/0:1(3), R2_Q421_IC_CLR_FWD, E_HTSP_RELEASE_REQ]

*Mar 22 00:56:00.742: r2_q421_null_release(1/0:1(3)) E_HTSP_RELEASE_REQ

*Mar 22 00:56:02.738: htsp_process_event: [1/0:1(3), R2_Q421_IC_CLR_FWD, E_HTSP_EVENT_TIMER]

*Mar 22 00:56:02.738: htsp_timer_stop

*Mar 22 00:56:02.738: r2_q421_clr_fwd_idle(1/0:1(3)) Tx IDLE[R2 Q.421 1/0:1(3)] set signal state = 0x8

*Mar 22 00:56:02.738: r2_reg_channel_disconnected(1/0:1(3))

*Mar 22 00:56:02.738: vtsp:[1/0:1:443, S_WAIT_RELEASE_RESP, E_TSP_DISCONNECT_CONF]

*Mar 22 00:56:02.738: act_wrelease_release

*Mar 22 00:56:02.738: vtsp_play_busy_timer_stop: 181776286

*Mar 22 00:56:02.738: vtsp_timer_stop: 181776286

*Mar 22 00:56:02.738: dsp_cp_tone_off: [1/0:1:443] packet_len=8 channel_id=1 packet_id=71

*Mar 22 00:56:02.742: dsp_idle_mode: [1/0:1:443] packet_len=8 channel_id=1 packet_id=68

*Mar 22 00:56:02.742: dsp_close_voice_channel: [1/0:1:443] packet_len=8 channel_id=1 packet_id=75vtsp_do_call_historyvtsp_do_call_history CoderRate 5

*Mar 22 00:56:02.742: vtsp:[1/0:1:443, S_CLOSE_DSPRM, E_DSPRM_CLOSE_COMPLETE]

*Mar 22 00:56:02.746: act_terminate

*Mar 22 00:56:02.746: vtsp_timer_stop: 181776287

*Mar 22 00:56:02.746: cc_api_call_disconnect_done(vdbPtr=0x812E9958, callID=0x1BB, disp=0, tag=0x0)

*Mar 22 00:56:02.746: vtsp_free_cdb,cdb 0x8145B0D8

*Mar 22 00:56:02.746: sess_appl: ev(12=CC_EV_CALL_DISCONNECT_DONE), cid(443), disp(0)

*Mar 22 00:56:02.746: cid(443)st(SSA_CS_DISCONNECTING)ev(SSA_EV_CALL_DISCONNECT_DONE)

oldst(SSA_CS_CONF_DESTROYING)cfid(-1)csize(1)in(1)fDest(0)

*Mar 22 00:56:02.746: ssaDisconnectDone

*Mar 22 00:56:08.982: cc_handle_periodic_timer: Calling the callback, ccTimerctx - 0x80E78288

*Mar 22 00:56:08.982: ccTimerStart: ccTimerctx - 0x80E78288

This is an inward call (POTS to router)

Silver

Re: R2 DTMF in a VG200

The digits 801000 came into the router. A h225 call setup went out, it connected, stayed up for around 9 seconds then the device on the R2 trunk disconnected the call.

Silver

Re: R2 DTMF in a VG200

Need to see the configs and SH VER to confirm how the gateway is set up.

New Member

Re: R2 DTMF in a VG200

Hi Sr:

I found the problem. There is a bug in VG200 IOS version that does not allows process/generation of TX Answer.

With another IOS works fine and TX Answer appears.

Thanks for your help

Alex

165
Views
0
Helpful
10
Replies