本文檔為成功通過傳真的一個呼叫提供了兩個debug vtsp all命令輸出捕獲。第一個用於T.38傳真,但它也與IP語音(VoIP)傳真中繼相關。 此輸出包含用於說明識別傳真編解碼器已下載並使用的過程的註釋。第二個解碼器用於幀中繼語音(VoFR),未被註釋。debug vtsp all輸出不包含來自T.30協定的大量資訊,但它確實提供了來自路由器的有用狀態資訊,例如:
確認路由器已進入傳真模式
傳真速率、編解碼器以及是否使用糾錯模式(ECM)
確認終端網關從終端傳真機接收到傳真音
如需文件慣例的詳細資訊,請參閱思科技術提示慣例。
本文件沒有特定先決條件。
本檔案中的資訊主要基於Cisco IOS軟體版本12.2(5),雖然大多數資訊也對其他Cisco IOS軟體版本可能有用。
本文中的資訊是根據特定實驗室環境內的裝置所建立。文中使用到的所有裝置皆從已清除(預設)的組態來啟動。如果您在即時網路中工作,請確保在使用任何命令之前瞭解其潛在影響。
對於T.38傳真中繼,在呼叫連線且路由器檢測到傳真音調試後,將顯示類似以下內容的消息。
debug vtsp all命令 |
---|
!--- Prior to the ccCallConnect message and during the capabilities !--- exchange phase, the fax_rate message may be displayed as follows: .Jun 4 21:06:43.677: cc_api_caps_ack (dstVdbPtr=0x62F07650, dstCallId=0x18, srcCallId=0x19, caps={codec=0x4, fax_rate=0x2, vad=0x2, modem=0x0 codec_bytes=20, signal_type=2}) !--- In this case the fax rate 0x02 refers to the voice rate, which !--- with this codec (g.729), is less than or equal to 8 kbps. !--- Listed below are the other possible fax rate values. !--- Below is a listing of fax rate values for Cisco IOS Software Release 12.2.x or earlier: !--- hex value fax rate value !--- 0x2 Voice !--- 0x4 14400 !--- 0x8 9600 !--- 0x10 7200 !--- 0x20 4800 !--- 0x40 2400 !--- 0x80 1200 !--- Below is a listing of new fax rate values for Cisco IOS Software Release 12.3.x or later: !--- Note the hex values now map to slightly different speeds than the list above. !--- /* FAX Capabilities Bits */ !--- #define CC_CAP_FAX_NONE 0x01 !--- #define CC_CAP_FAX_VOICE 0x02 !--- #define CC_CAP_FAX_24 0x04 !--- #define CC_CAP_FAX_48 0x08 !--- #define CC_CAP_FAX_72 0x10 !--- #define CC_CAP_FAX_96 0x20 !--- #define CC_CAP_FAX_120 0x40 !--- #define CC_CAP_FAX_144 0x80 !--- Usually, after the call is connected, the ccCallConnect debug !--- message is seen as follows: .Jun 4 21:06:44.841: ccCallConnect (callID=0x18), prog_ind = 0 .Jun 4 21:06:44.841: ssaFlushPeerTagQueue cid(24) peer list: (empty) .Jun 4 21:06:47.437: vtsp_process_dsp_message: MSG_TX_GET_TX_STAT: rtp_timestamp=0xD4D85071 .Jun 4 21:06:47.437: vtsp:[4/0:15 (25), S_CONNECT, E_DSP_GET_TX] .Jun 4 21:06:49.049: vtsp_process_dsp_message: MSG_TX_GET_TX_STAT: rtp_timestamp=0xD4D882D1 .Jun 4 21:06:49.049: vtsp:[4/0:15 (25), S_CONNECT, E_DSP_GET_TX] .Jun 4 21:06:50.129: vtsp_process_dsp_message: MSG_TX_TONE_DETECT: type=0 trigger=1 tone_id=0 .Jun 4 21:06:50.129: vtsp:[4/0:15 (25), S_CONNECT, E_DSP_TONE_DETECT] .Jun 4 21:06:50.129: vtsp_modem_proto_from_cdb: cap_modem_proto 0 .Jun 4 21:06:50.129: cc_api_call_feature: (vdbPtr=0x63387EDC, callID=0x19,feature_ind.type=1 .Jun 4 21:06:50.129: act_lfax_switch: cap_modem_proto=16, fax_relay_on=1, state=19 .Jun 4 21:06:50.129: vtsp_t38_switchover:2 - data_mode:1 !--- Note that 2 means T.38; 1 means Cisco proprietary. .Jun 4 21:06:50.129: cc_api_t38_fax_start (dstVdbPtr=0x62F07650, dstCallId=0x18, srcCallId=0x19, caps={codec=0x10000, fax_rate=0x2, vad=0x2, modem=0x0 codec_bytes=20, signal_type=2}) .Jun 4 21:06:50.129: vtsp_timer: 20362254 .Jun 4 21:06:50.129: sess_appl: ev(28=CC_EV_CALL_FEATURE), cid(25), disp(0) .Jun 4 21:06:50.129: cid(25)st(SSA_CS_ACTIVE)ev(SSA_EV_CALL_FEATURE) oldst(SSA_CS_CONFERENCED_ALERT)cfid(8)csize(0)in(0)fDest(0) .Jun 4 21:06:50.129: -cid2(24)st2(SSA_CS_ACTIVE)oldst2 (SSA_CS_CONFERENCING_ALERT) .Jun 4 21:06:50.129: ccCallFeature (callID=0x18, feature.type=1) .Jun 4 21:06:50.249: vtsp_process_dsp_message: MSG_TX_TONE_DETECT: type=0 trigger=0 tone_id=0 .Jun 4 21:06:50.249: vtsp:[4/0:15 (25), S_LFAX_WAIT_CAPS_ACK, E_DSP_TONE_DETECT] .Jun 4 21:06:50.249: vtsp_process_event(): prev_state = 0.11 , state = S_LFAX_WAIT_CAPS_ACK, event = E_DSP_TONE_DETECT .Jun 4 21:06:50.389: vtsp_process_dsp_message: MSG_TX_TONE_DETECT: type=0 trigger=1 tone_id=0 .Jun 4 21:06:50.389: vtsp:[4/0:15 (25), S_LFAX_WAIT_CAPS_ACK, E_DSP_TONE_DETECT] .Jun 4 21:06:50.389: vtsp_process_event(): prev_state = 0.11 , state = S_LFAX_WAIT_CAPS_ACK, event = E_DSP_TONE_DETECT .Jun 4 21:06:50.489: vtsp_process_dsp_message: MSG_TX_TONE_DETECT: type=0 trigger=0 tone_id=0 .Jun 4 21:06:50.489: vtsp:[4/0:15 (25), S_LFAX_WAIT_CAPS_ACK, E_DSP_TONE_DETECT] .Jun 4 21:06:50.489: vtsp_process_event(): prev_state = 0.11 , state = S_LFAX_WAIT_CAPS_ACK, event = E_DSP_TONE_DETECT Invalid FSM Input on channel 4/0:15 (25) .Jun 4 21:06:50.529: cc_api_t38_fax_start (dstVdbPtr=0x63387EDC, dstCallId=0x19, srcCallId=0x18, caps={codec=0x10000, fax_rate=0x2, vad=0x2, modem=0x0 codec_bytes=160, signal_type=2}) .Jun 4 21:06:50.529: vtsp:[4/0:15 (25), S_LFAX_WAIT_CAPS_ACK, E_CC_T38_START] .Jun 4 21:06:50.529: act_caps_ack_lfax_dnld .Jun 4 21:06:50.529: vtsp_timer_stop: 20362294 .Jun 4 21:06:50.529: dsp_idle_mode: [4/0:15 (25)] packet_len=8 channel_id=1 packet_id=68 .Jun 4 21:06:50.529: vtsp:[4/0:15 (25), S_LFAX_DOWNLOAD, E_DSPRM_PEND_SUCCESS] .Jun 4 21:06:50.529: act_lfax_mode .Jun 4 21:06:50.529: cc_api_local_codec_dnld_done (dstVdbPtr=0x62F07650, dstCallId=0x18, srcCallId=0x19) !--- The previous three messages confirm that the fax codec was successfully !--- downloaded into the DSP. You may not see all the messages above !--- and below. The important point is that you do not see error !--- messages saying that the fax codec was not downloaded correctly. .Jun 4 21:06:50.529: vtsp_timer: 20362294 .Jun 4 21:06:50.929: cc_api_t38_fax_start (dstVdbPtr=0x63387EDC, dstCallId=0x19, srcCallId=0x18, caps={codec=0x10000, fax_rate=0x2, vad=0x2, modem=0x0 codec_bytes=160, signal_type=2}) .Jun 4 21:06:50.929: cc_api_remote_codec_dnld_done (dstVdbPtr=0x63387EDC, dstCallId=0x19, srcCallId=0x18) .Jun 4 21:06:50.929: vtsp:[4/0:15 (25), S_LFAX_WAIT_FAX, E_CC_T38_START] .Jun 4 21:06:50.929: vtsp:[4/0:15 (25), S_LFAX_WAIT_FAX, E_CC_T30_CAP_ACK] .Jun 4 21:06:50.929: act_t38_lfax_mode .Jun 4 21:06:50.929: vtsp_timer_stop: 20362334 .Jun 4 21:06:50.929: dsp_idle_mode: [4/0:15 (25)] packet_len=8 channel_id=1 packet_id=68 .Jun 4 21:06:50.929: dsp_encap_config: T38 .Jun 4 21:06:50.929: dsp_fax_mode: [4/0:15 (25)] FaxRate 0x2, Codec 0x10000 dsp_fax_mode() ECM_DISABLE not set, debug_info requested .Jun 4 21:06:50.929: dsp_fax_mode: [] packet_len=28 channel_id=1 packet_id=69 max_trans=3 info_size=20, fax_protocol_type=3, ls_data_red=0, hs_data_red=0, tcf_handling=2, fax_relay_cntl=0x2 nsf_country = 0xAD, nsf_mfg = 0x0051 !--- During the fax transmission the Cisco IOS Software polls the DSP !--- statistics periodically, and the following message appears: .Jun 4 21:06:50.929: vtsp:[4/0:15 (25), S_FAX, E_DSP_GET_TX |
追蹤軌跡在不同的思科IOS軟體版本中可能不同,但您應該始終能夠瞭解傳真編解碼器是否正確載入,以及「FAX」關鍵字後面的輸出使用了哪個傳真協定。
如果傳真編解碼器未正確載入,則可能存在軟體問題。確保使用最新的維護版本,如果仍然出現問題,請向技術支援中心(TAC)提交案例。
debug vtsp all — 始發路由器 |
---|
vdtl-2600-2d# Jun 5 10:10:34.053: vtsp_tsp_call_setup_ind (sdb=0x81FD48DC, tdm_info=0x0, tsp_info=0x81FF74DC, calling_number= calling_oct3 = 0x0, called_number= called_oct3 = 0x81, oct3a=0x0): peer_tag=0 Jun 5 10:10:34.053: : ev.clg.clir is 0 ev.clg.clid_transparent is 0 ev.clg.null_orig_clg is 1 ev.clg.calling_translated is false Jun 5 10:10:34.057: vtsp_do_call_setup_ind Jun 5 10:10:34.057: vtsp_allocate_cdb,cdb 0x821D9344 Jun 5 10:10:34.057: vtsp_do_call_setup_ind: Call ID=65589, guid=821D9874 Jun 5 10:10:34.057: vtsp_do_call_setup_ind: type=0, under_spec=-2119571356, name=f<0HNhf< 1=@, id0=1, id1=1, id2=-32567, calling=, called= subscriber=RegularLine Jun 5 10:10:34.057: vtsp_do_normal_call_setup_ind Jun 5 10:10:34.057: vtsp_insert_cdb,cdb 0x821D9344 Jun 5 10:10:34.057: vtsp_open_voice_and_set_params Jun 5 10:10:34.057: dsp_close_voice_channel: [1/1:0:27] packet_len=8 channel_id=2 packet_id=75 Jun 5 10:10:34.057: dsp_open_voice_channel_20: [1/1:0:27] packet_len=16 channel_id=2 packet_id=74 alaw_ulaw_select=0 associated_signaling_channel=129 time_slot=1 serial_port=0 Jun 5 10:10:34.057: vtsp_modem_proto_from_cdb: cap_modem_proto 1073741824 Jun 5 10:10:34.057: vtsp_modem_proto_from_cdb: cap_modem_proto 1073741824 Jun 5 10:10:34.057: dsp_encap_config: [1/1:0:27] packet_len=30 channel_id=2 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=0x0, redundancy=0 Jun 5 10:10:34.061: dsp_set_playout_delay Jun 5 10:10:34.061: dsp_set_playout: [1/1:0:27] packet_len=18 channel_id=2 packet_id=76 mode=1 initial=60 min=40 max=200 fax_nom=300 dsp_set_playout_delay_config Jun 5 10:10:34.061: dsp_set_playout_config Jun 5 10:10:34.061: mode 0, init 60, min 40, max 200 playout default Jun 5 10:10:34.061: dsp_set_playout_config:mode 0, init 60, min 40, max 200 Jun 5 10:10:34.061: dsp_set_playout_config: [1/1:0:27] packet_len=18 channel_id=2 packet_id=76 mode=1 initial=60 min=40 max=200 fax_nom=300 Jun 5 10:10:34.061: dsp_echo_canceler_control: echo_cancel: 1 Jun 5 10:10:34.061: dsp_echo_canceler_control: [1/1:0:27] echo_cancel 1, disable_hpf 0, flags=0x0 Jun 5 10:10:34.061: dsp_echo_canceler_control: [1/1:0:27] packet_len=10 channel_id=2 packet_id=66 flags=0x0 Jun 5 10:10:34.061: sgf: FXx/E&M: msg->message.set_codec_gains.out_gain=0 Jun 5 10:10:34.061: dsp_set_gains: [1/1:0:27] packet_len=12 channel_id=2 packet_id=91 in_gain=0 out_gain=0 Jun 5 10:10:34.061: dsp_vad_enable: [1/1:0:27] enable: packet_len=12 channel_id=2 packet_id=78 thresh=-38 Jun 5 10:10:34.061: vtsp_report_digit_control: enable=1: digit reporting enabled Jun 5 10:10:34.061: : vtsp_get_digit_timeouts Jun 5 10:10:34.065: vtsp:[1/1:0:27, S_SETUP_INDICATED, E_CC_SETUP_ACK] Jun 5 10:10:34.065: act_setup_ind_ack Jun 5 10:10:34.065: vtsp_modem_proto_from_cdb: cap_modem_proto 0 Jun 5 10:10:34.065: vtsp_modem_proto_from_cdb: cap_modem_proto 0 Jun 5 10:10:34.065: dsp_encap_config: [1/1:0:27] packet_len=30 channel_id=2 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=0x0, redundancy=0 Jun 5 10:10:34.065: dsp_voice_mode: [1/1:0:27] cdb 821D9344, cdb->codec_params.modem 2, inband_detect flags 0x21 Jun 5 10:10:34.065: map_dtmf_relay_type--digit relay mode: 2 Jun 5 10:10:34.065: dsp_voice_mode: [1/1:0:27] packet_len=24 channel_id=2 packet_id=73 coding_type=1 voice_field_size=80 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 Jun 5 10:10:34.065: act_setup_ind_ack(): dsp_dtmf_mode()dsp_dtmf_mode(VTSP_TONE_DTMF_MODE) Jun 5 10:10:34.065: dsp_dtmf_mode: [1/1:0:27] packet_len=10 channel_id=2 packet_id=65 dtmf_or_mf=0 Jun 5 10:10:34.065: vtsp_timer: 43525550 Jun 5 10:10:34.065: vtsp:[1/1:0:27, S_DIGIT_COLLECT, E_CC_GEN_TONE] Jun 5 10:10:34.065: act_gen_tone Jun 5 10:10:34.065: dsp_cp_tone_off: [1/1:0:27] packet_len=8 channel_id=2 packet_id=71 Jun 5 10:10:34.065: dsp_cp_tone_on: [1/1:0:27] packet_len=38 channel_id=2 packet_id=72 tone_id=4 n_freq=2 freq_of_first=350 freq_of_second=440 amp_of_first=5514 amp_of_second=5514 direction=1 on_time_first=65535 off_time_first=0 on_time_second=0 off_time_second=0 Jun 5 10:10:34.065: vtsp:[1/1:0:27, S_DIGIT_COLLECT, E_CC_GEN_TONE] Jun 5 10:10:34.069: act_gen_tone Jun 5 10:10:34.069: dsp_cp_tone_off: [1/1:0:27] packet_len=8 channel_id=2 packet_id=71 Jun 5 10:10:34.069: dsp_cp_tone_on: [1/1:0:27] packet_len=38 channel_id=2 packet_id=72 tone_id=4 n_freq=2 freq_of_first=350 freq_of_second=440 amp_of_first=5514 amp_of_second=5514 direction=1 on_time_first=65535 off_time_first=0 on_time_second=0 off_time_second=0 Jun 5 10:10:35.544: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN: digit=4, rtp_timestamp=0xD455BA67 Jun 5 10:10:35.544: vtsp:[1/1:0:27, S_DIGIT_COLLECT, E_DSP_DTMF_DIGIT_BEGIN] Jun 5 10:10:35.544: act_report_digit_begin Jun 5 10:10:35.612: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF: digit=4, duration=120 Jun 5 10:10:35.616: vtsp:[1/1:0:27, S_DIGIT_COLLECT, E_DSP_DTMF_DIGIT] Jun 5 10:10:35.616: act_report_digit_end Jun 5 10:10:35.616: vtsp_timer_stop: 43525705 Jun 5 10:10:35.616: dsp_cp_tone_off: [1/1:0:27] packet_len=8 channel_id=2 packet_id=71 Jun 5 10:10:35.616: vtsp_timer: 43525705 Jun 5 10:10:35.732: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN: digit=0, rtp_timestamp=0xD455BA67 Jun 5 10:10:35.732: vtsp:[1/1:0:27, S_DIGIT_COLLECT, E_DSP_DTMF_DIGIT_BEGIN] Jun 5 10:10:35.732: act_report_digit_begin Jun 5 10:10:35.792: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF: digit=0, duration=110 Jun 5 10:10:35.792: vtsp:[1/1:0:27, S_DIGIT_COLLECT, E_DSP_DTMF_DIGIT] Jun 5 10:10:35.792: act_report_digit_end Jun 5 10:10:35.792: vtsp_timer_stop: 43525722 Jun 5 10:10:35.796: dsp_cp_tone_off: [1/1:0:27] packet_len=8 channel_id=2 packet_id=71 Jun 5 10:10:35.796: vtsp_timer: 43525723 Jun 5 10:10:35.933: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN: digit=0, rtp_timestamp=0xD455BA67 Jun 5 10:10:35.933: vtsp:[1/1:0:27, S_DIGIT_COLLECT, E_DSP_DTMF_DIGIT_BEGIN] Jun 5 10:10:35.933: act_report_digit_begin Jun 5 10:10:36.005: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF: digit=0, duration=120 Jun 5 10:10:36.005: vtsp:[1/1:0:27, S_DIGIT_COLLECT, E_DSP_DTMF_DIGIT] Jun 5 10:10:36.005: act_report_digit_end Jun 5 10:10:36.005: vtsp_timer_stop: 43525744 Jun 5 10:10:36.005: dsp_cp_tone_off: [1/1:0:27] packet_len=8 channel_id=2 packet_id=71 Jun 5 10:10:36.005: vtsp_timer: 43525744 Jun 5 10:10:36.133: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN: digit=1, rtp_timestamp=0xD455BA67 Jun 5 10:10:36.133: vtsp:[1/1:0:27, S_DIGIT_COLLECT, E_DSP_DTMF_DIGIT_BEGIN] Jun 5 10:10:36.133: act_report_digit_begin Jun 5 10:10:36.193: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF: digit=1, duration=110 Jun 5 10:10:36.193: vtsp:[1/1:0:27, S_DIGIT_COLLECT, E_DSP_DTMF_DIGIT] Jun 5 10:10:36.193: act_report_digit_end Jun 5 10:10:36.193: vtsp_timer_stop: 43525762 Jun 5 10:10:36.193: dsp_cp_tone_off: [1/1:0:27] packet_len=8 channel_id=2 packet_id=71 Jun 5 10:10:36.193: vtsp_timer: 43525762 Jun 5 10:10:36.197: vtsp_report_digit_control: enable=0: digit reporting disabled Jun 5 10:10:36.197: : vtsp_get_digit_timeouts Jun 5 10:10:36.197: vtsp_save_dialpeer_tag: tag = 4001 Jun 5 10:10:36.197: vtsp:[1/1:0:27, S_DIGIT_COLLECT, E_CC_PROCEEDING] Jun 5 10:10:36.197: act_dcollect_proc Jun 5 10:10:36.205: vtsp_get_dialpeer_tag: tag = 4001 Jun 5 10:10:36.890: vtsp_get_dialpeer_tag: tag = 4001 Jun 5 10:10:36.890: vtsp:[1/1:0:27, S_PROCEEDING, E_CC_PROGRESS] Jun 5 10:10:36.890: act_progress Jun 5 10:10:36.890: vtsp_timer_stop: 43525832 Jun 5 10:10:36.890: vtsp:[1/1:0:27, S_PROCEEDING, E_CC_BRIDGE] Jun 5 10:10:36.890: act_bridge Jun 5 10:10:36.890: vtsp:[1/1:0:27, S_PROCEEDING, E_CC_CAPS_IND] Jun 5 10:10:36.890: act_caps_ind Jun 5 10:10:36.890: act_caps_ind: passthrough: cap_modem_proto 0, cap_modem_codec 0, cap_modem_redundancy 0, payload 0 Jun 5 10:10:36.890: act_caps_ind:CC_CAP_ENCAP_FRF11 Encap 2, Vad 2, Codec 0x4, CodecBytes 30, FaxRate 2, FaxBytes 30, FaxNsf 0xAD0051 Sub-channel 8, Bitmask 0x0 SignalType 2, SeqNumStart 0x0 Jun 5 10:10:36.890: act_caps_ind: [ mode:0,init:60, min:40, max:200] Jun 5 10:10:36.890: vtsp:[1/1:0:27, S_PROCEEDING, E_CC_CAPS_ACK] Jun 5 10:10:36.890: act_caps_ack Jun 5 10:10:36.894: act_caps_ack: passthrough: cap_modem_proto 0, cap_modem_codec 0, cap_modem_redundancy 0, payload 0 Jun 5 10:10:36.894: dsp_idle_mode: [1/1:0:27] packet_len=8 channel_id=2 packet_id=68 Jun 5 10:10:36.894: act_caps_ack: codec = 16, ret = 2 Jun 5 10:10:36.894: vtsp_timer: 43525833 Jun 5 10:10:36.894: vtsp:[1/1:0:27, S_NULL, E_DSPRM_PEND_SUCCESS] Jun 5 10:10:36.894: act_pend_codec_success Jun 5 10:10:36.894: vtsp_timer_stop: 43525833 Jun 5 10:10:36.894: vtsp_open_voice_and_set_params Jun 5 10:10:36.894: dsp_close_voice_channel: [1/1:0:27] packet_len=8 channel_id=2 packet_id=75 Jun 5 10:10:36.894: dsp_open_voice_channel_20: [1/1:0:27] packet_len=16 channel_id=2 packet_id=74 alaw_ulaw_select=0 associated_signaling_channel=129 time_slot=1 serial_port=0 Jun 5 10:10:36.894: dsp_encap_config: [1/1:0:27] packet_len=18 channel_id=2 packet_id=92 TransportProtocol 3 SID_support=0 sequence_number=0 rotate_flag=0 header_bytes 0x80 Jun 5 10:10:36.894: dsp_set_playout_delay Jun 5 10:10:36.894: dsp_set_playout: [1/1:0:27] packet_len=18 channel_id=2 packet_id=76 mode=1 initial=60 min=40 max=200 fax_nom=300 dsp_set_playout_delay_config Jun 5 10:10:36.894: dsp_set_playout_config Jun 5 10:10:36.894: mode 0, init 60, min 40, max 200 playout default Jun 5 10:10:36.894: dsp_set_playout_config:mode 0, init 60, min 40, max 200 Jun 5 10:10:36.894: dsp_set_playout_config: [1/1:0:27] packet_len=18 channel_id=2 packet_id=76 mode=1 initial=60 min=40 max=200 fax_nom=300 Jun 5 10:10:36.894: dsp_echo_canceler_control: echo_cancel: 1 Jun 5 10:10:36.894: dsp_echo_canceler_control: [1/1:0:27] echo_cancel 1, disable_hpf 0, flags=0x0 Jun 5 10:10:36.898: dsp_echo_canceler_control: [1/1:0:27] packet_len=10 channel_id=2 packet_id=66 flags=0x0 Jun 5 10:10:36.898: sgf: FXx/E&M: msg->message.set_codec_gains.out_gain=0 Jun 5 10:10:36.898: dsp_set_gains: [1/1:0:27] packet_len=12 channel_id=2 packet_id=91 in_gain=0 out_gain=0 Jun 5 10:10:36.898: dsp_vad_enable: [1/1:0:27] enable: packet_len=12 channel_id=2 packet_id=78 thresh=-38 Jun 5 10:10:36.898: dsp_voice_mode: [1/1:0:27] cdb 821D9344, cdb->codec_params.modem 0, inband_detect flags 0x1 Jun 5 10:10:36.898: map_dtmf_relay_type--digit relay mode: 2 Jun 5 10:10:36.898: dsp_voice_mode: [1/1:0:27] packet_len=24 channel_id=2 packet_id=73 coding_type=19 voice_field_size=30 VAD_flag=250 echo_length=64 comfort_noise=1 inband_detect=1 digit_relay_mode=2 AGC_flag=0 Jun 5 10:10:43.024: vtsp_get_dialpeer_tag: tag = 4001 Jun 5 10:10:43.024: vtsp:[1/1:0:27, S_PROCEEDING, E_CC_CONNECT] Jun 5 10:10:43.024: act_connect Jun 5 10:10:43.024: vtsp_ring_noan_timer_stop: 43526446 Jun 5 10:10:48.710: vtsp:[1/1:0:27, S_CONNECT, E_PH_CODEC_FAX] Jun 5 10:10:48.710: act_rfax_switch Jun 5 10:10:48.710: dsp_idle_mode: [1/1:0:27] packet_len=8 channel_id=2 packet_id=68 Jun 5 10:10:48.710: vtsp_timer_stop: 43527014 Jun 5 10:10:48.910: vtsp:[1/1:0:27, S_RFAX_DOWNLOAD, E_DSPRM_PEND_SUCCESS] Jun 5 10:10:48.910: act_rfax_mode Jun 5 10:10:48.910: vtsp:[1/1:0:27, S_RFAX_WAIT_ACK, E_PH_CODEC_ACK] Jun 5 10:10:48.910: act_wait_ack_ack Jun 5 10:10:48.910: vtsp_timer_stop: 43527034 Jun 5 10:10:48.914: dsp_fax_mode: [1/1:0:27] FaxRate 0x2, Codec 0x4 dsp_fax_mode() ECM_DISABLE not set, debug_info not requested Jun 5 10:10:48.914: dsp_fax_mode: [1/1:0:27] packet_len=28 channel_id=2 packet_id=69 max_trans=3 info_size=30, fax_protocol_type=2, hs_data_len=0, ls_data_red=0, hs_data_red=0, tcf_handling=0, fax_relay_cntl=0x0 nsf_country = 0xAD, nsf_mfg = 0x0051 !--- fax codecs: enum { !--- DSP_TELOGY_FAX = 1, !--- DSP_FRF11_FAX, !--- DSP_T38_FAX vdtl-2600-2d# vdtl-2600-2d# vdtl-2600-2d# Jun 5 10:11:21.516: vtsp_process_dsp_message: MSG_TX_FAX_CLEARDOWN: Jun 5 10:11:21.516: vtsp:[1/1:0:27, S_FAX, E_DSP_FAX_CLEARDOWN] Jun 5 10:11:21.516: act_fax_to_voice Jun 5 10:11:21.516: vtsp_timer_stop: 43530295 Jun 5 10:11:21.520: dsp_idle_mode: [1/1:0:27] packet_len=8 channel_id=2 packet_id=68 Jun 5 10:11:21.520: dsp_close_voice_channel: [1/1:0:27] packet_len=8 channel_id=2 packet_id=75act_fax_to_voice codec= 16 Jun 5 10:11:21.520: vtsp_timer: 43530295 Jun 5 10:11:21.520: vtsp:[1/1:0:27, S_FAX_TERM, E_DSPRM_PEND_SUCCESS] Jun 5 10:11:21.520: vtsp_timer_stop: 43530295 Jun 5 10:11:21.520: act_fax_complete Jun 5 10:11:21.520: vtsp_open_voice_and_set_params Jun 5 10:11:21.520: dsp_close_voice_channel: [1/1:0:27] packet_len=8 channel_id=2 packet_id=75 Jun 5 10:11:21.520: dsp_open_voice_channel_20: [1/1:0:27] packet_len=16 channel_id=2 packet_id=74 alaw_ulaw_select=0 associated_signaling_channel=129 time_slot=1 serial_port=0 Jun 5 10:11:21.520: dsp_encap_config: [1/1:0:27] packet_len=18 channel_id=2 packet_id=92 TransportProtocol 3 SID_support=0 sequence_number=0 rotate_flag=0 header_bytes 0x80 Jun 5 10:11:21.520: dsp_set_playout_delay Jun 5 10:11:21.520: dsp_set_playout: [1/1:0:27] packet_len=18 channel_id=2 packet_id=76 mode=1 initial=60 min=40 max=200 fax_nom=300 dsp_set_playout_delay_config Jun 5 10:11:21.520: dsp_set_playout_config Jun 5 10:11:21.520: mode 0, init 60, min 40, max 200 playout default Jun 5 10:11:21.520: dsp_set_playout_config:mode 0, init 60, min 40, max 200 Jun 5 10:11:21.520: dsp_set_playout_config: [1/1:0:27] packet_len=18 channel_id=2 packet_id=76 mode=1 initial=60 min=40 max=200 fax_nom=300 Jun 5 10:11:21.520: dsp_echo_canceler_control: echo_cancel: 1 Jun 5 10:11:21.520: dsp_echo_canceler_control: [1/1:0:27] echo_cancel 1, disable_hpf 0, flags=0x0 Jun 5 10:11:21.525: dsp_echo_canceler_control: [1/1:0:27] packet_len=10 channel_id=2 packet_id=66 flags=0x0 Jun 5 10:11:21.525: sgf: FXx/E&M: msg->message.set_codec_gains.out_gain=0 Jun 5 10:11:21.525: dsp_set_gains: [1/1:0:27] packet_len=12 channel_id=2 packet_id=91 in_gain=0 out_gain=0 Jun 5 10:11:21.525: dsp_vad_enable: [1/1:0:27] enable: packet_len=12 channel_id=2 packet_id=78 thresh=-38 Jun 5 10:11:21.525: dsp_voice_mode: [1/1:0:27] cdb 821D9344, cdb->codec_params.modem 0, inband_detect flags 0x1 Jun 5 10:11:21.525: map_dtmf_relay_type--digit relay mode: 2 Jun 5 10:11:21.525: dsp_voice_mode: [1/1:0:27] packet_len=24 channel_id=2 packet_id=73 coding_type=19 voice_field_size=30 VAD_flag=250 echo_length=64 comfort_noise=1 inband_detect=1 digit_relay_mode=2 AGC_flag=0 Jun 5 10:11:24.033: vtsp:[1/1:0:27, S_CONNECT, E_TSP_DISCONNECT_IND] Jun 5 10:11:24.033: act_generate_disc Jun 5 10:11:24.033: vtsp_ring_noan_timer_stop: 43530546 Jun 5 10:11:24.033: vtsp_timer_stop: 43530546 Jun 5 10:11:24.033: vtsp_pcm_tone_detect_timer_stop: 43530546 Jun 5 10:11:24.033: vtsp_pcm_switchover_timer_stop: 43530546 Jun 5 10:11:24.033: vtsp:[1/1:0:27, S_CONNECT, E_CC_BRIDGE_DROP] Jun 5 10:11:24.033: act_bdrop Jun 5 10:11:24.033: vtsp:[1/1:0:27, S_CONNECT, E_CC_DISCONNECT] Jun 5 10:11:24.033: act_disconnect Jun 5 10:11:24.033: vtsp_ring_noan_timer_stop: 43530546 Jun 5 10:11:24.033: vtsp_pcm_tone_detect_timer_stop: 43530546 Jun 5 10:11:24.033: vtsp_pcm_switchover_timer_stop: 43530546 Jun 5 10:11:24.033: vtsp_cot_timer_stop: 43530546 Jun 5 10:11:24.033: vtsp_timer_stop: 43530546 Jun 5 10:11:24.033: vtsp_timer: 43530546 Jun 5 10:11:24.037: vtsp:[1/1:0:27, S_WAIT_STATS, E_DSP_GET_ERROR] Jun 5 10:11:24.037: act_get_error Jun 5 10:11:24.037: 1/1:0:27: rx_dropped=0 tx_dropped=0 rx_control=51 tx_control=14 tx_control_dropped=0 dsp_mode_channel_1=0 dsp_mode_channel_2=2 c[0]=68 c[1]=3 c[2]=10 c[3]=69 c[4]=68 c[5]=75 c[6]=75 c[7]=74 c[8]=92 c[9]=76 c[10]=76 c[11]=66 c[12]=91 c[13]=78 c[14]=73 c[15]=6 Jun 5 10:11:24.037: dsp_get_levels: [1/1:0:27] packet_len=8 channel_id=2 packet_id=89 Jun 5 10:11:24.041: vtsp:[1/1:0:27, S_WAIT_STATS, E_DSP_GET_LEVELS] Jun 5 10:11:24.041: act_get_levels Jun 5 10:11:24.045: vtsp_process_dsp_message: MSG_TX_GET_TX_STAT: rtp_timestamp=0xFD908919 Jun 5 10:11:24.045: vtsp:[1/1:0:27, S_WAIT_STATS, E_DSP_GET_TX] Jun 5 10:11:24.049: act_stats_complete Jun 5 10:11:24.049: vtsp_timer_stop: 43530548 Jun 5 10:11:24.049: vtsp_ring_noan_timer_stop: 43530548 Jun 5 10:11:24.049: dsp_idle_mode: [1/1:0:27] packet_len=8 channel_id=2 packet_id=68 Jun 5 10:11:24.049: vtsp_timer: 43530548 Jun 5 10:11:24.850: vtsp:[1/1:0:27, S_WAIT_RELEASE, E_TSP_CALL_FEATURE_IND] Jun 5 10:11:24.850: act_call_feature_ind Jun 5 10:11:24.850: vtsp:[1/1:0:27, S_WAIT_RELEASE, E_TSP_DISCONNECT_CONF] Jun 5 10:11:24.850: act_wrelease_release Jun 5 10:11:24.850: vtsp_timer_stop: 43530628 Jun 5 10:11:24.854: dsp_cp_tone_off: [1/1:0:27] packet_len=8 channel_id=2 packet_id=71 Jun 5 10:11:24.854: dsp_idle_mode: [1/1:0:27] packet_len=8 channel_id=2 packet_id=68 Jun 5 10:11:24.854: dsp_close_voice_channel: [1/1:0:27] packet_len=8 channel_id=2 packet_id=75vtsp_do_call_historyvtsp_do_call_history CoderRate 20 Jun 5 10:11:24.854: vtsp:[1/1:0:27, S_CLOSE_DSPRM, E_DSPRM_CLOSE_COMPLETE] Jun 5 10:11:24.854: act_terminate Jun 5 10:11:24.854: vtsp_free_cdb,cdb 0x821D9344 vdtl-2600-2d# |
debug vtsp all — 終端路由器 |
---|
vdtl-7200-2c# Jun 5 10:10:36.200: vtsp_do_call_setup_req Jun 5 10:10:36.200: vtsp_allocate_cdb,cdb 0x620F01FC Jun 5 10:10:36.200: vtsp_insert_cdb,cdb 0x620F01FC Jun 5 10:10:36.200: vtsp_do_call_setup_req calling oct3 0x0, called oct3 0x0 Jun 5 10:10:36.200: vtsp_do_call_setup_req: Call ID=55, guid=62F8AC6C Jun 5 10:10:36.200: digit_strip:1, pcn:4001, poa:4001 Jun 5 10:10:36.200: pcn:, poa: Jun 5 10:10:36.200: Final pcn:, poa:, dial_string: Jun 5 10:10:36.200: calling oct3 0x0, called oct3 0x0 Jun 5 10:10:36.200: vtsp:[2/1:0 (39), S_SETUP_REQUEST, E_TSP_PROCEEDING] Jun 5 10:10:36.200: act_setup_pend_proceeding Jun 5 10:10:36.200: vtsp_open_voice_and_set_params Jun 5 10:10:36.200: dsp_close_voice_channel: [2/1:0 (39)] packet_len=8 channel_id=1 packet_id=75 Jun 5 10:10:36.200: dsp_open_voice_channel_20: [2/1:0 (39)] packet_len=16 channel_id=1 packet_id=74 alaw_ulaw_select=0 associated_signaling_channel=128 time_slot=0 serial_port=0 Jun 5 10:10:36.200: vtsp_modem_proto_from_cdb: cap_modem_proto 1073741824 Jun 5 10:10:36.204: vtsp_modem_proto_from_cdb: cap_modem_proto 1073741824 Jun 5 10:10:36.204: dsp_encap_config: [2/1:0 (39)] 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=0x0, redundancy=0 Jun 5 10:10:36.204: dsp_set_playout_delay Jun 5 10:10:36.204: dsp_set_playout: [2/1:0 (39)] 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 Jun 5 10:10:36.204: dsp_set_playout_config Jun 5 10:10:36.204: mode 0, init 60, min 40, max 200 playout default Jun 5 10:10:36.204: dsp_set_playout_config:mode 0, init 60, min 40, max 200 Jun 5 10:10:36.204: dsp_set_playout_config: [2/1:0 (39)] packet_len=18 channel_id=1 packet_id=76 mode=1 initial=60 min=40 max=200 fax_nom=300 Jun 5 10:10:36.204: dsp_echo_canceler_control: echo_cancel: 1 Jun 5 10:10:36.204: dsp_echo_canceler_control: [2/1:0 (39)] echo_cancel 1, disable_hpf 0, flags=0x0 Jun 5 10:10:36.204: dsp_echo_canceler_control: [2/1:0 (39)] packet_len=10 channel_id=1 packet_id=66 flags=0x0 Jun 5 10:10:36.204: sgf: FXx/E&M: msg->message.set_codec_gains.out_gain=0 Jun 5 10:10:36.204: dsp_set_gains: [2/1:0 (39)] packet_len=12 channel_id=1 packet_id=91 in_gain=0 out_gain=0 Jun 5 10:10:36.204: dsp_vad_enable: [2/1:0 (39)] enable: packet_len=12 channel_id=1 packet_id=78 thresh=-38 Jun 5 10:10:36.888: vtsp:[2/1:0 (39), S_SETUP_REQ_PROC, E_TSP_PROGRESS] Jun 5 10:10:36.888: act_setup_pend_progress Jun 5 10:10:36.888: vtsp:[2/1:0 (39), S_SETUP_REQ_PROC, E_CC_BRIDGE] Jun 5 10:10:36.888: act_bridge Jun 5 10:10:36.888: vtsp:[2/1:0 (39), S_SETUP_REQ_PROC, E_CC_CAPS_IND] Jun 5 10:10:36.888: act_caps_ind Jun 5 10:10:36.888: act_caps_ind: passthrough: cap_modem_proto 0, cap_modem_codec 0, cap_modem_redundancy 0, payload 0 Jun 5 10:10:36.888: act_caps_ind:CC_CAP_ENCAP_FRF11 Encap 2, Vad 2, Codec 0x4, CodecBytes 30, FaxRate 2, FaxBytes 30, FaxNsf 0xAD0051 Sub-channel 8, Bitmask 0x0 SignalType 2, SeqNumStart 0x0 Jun 5 10:10:36.888: act_caps_ind: [ mode:0,init:60, min:40, max:200] Jun 5 10:10:36.888: vtsp:[2/1:0 (39), S_SETUP_REQ_PROC, E_CC_CAPS_ACK] Jun 5 10:10:36.888: act_caps_ack Jun 5 10:10:36.888: act_caps_ack: passthrough: cap_modem_proto 0, cap_modem_codec 0, cap_modem_redundancy 0, payload 0 Jun 5 10:10:36.888: dsp_idle_mode: [2/1:0 (39)] packet_len=8 channel_id=1 packet_id=68 Jun 5 10:10:36.888: act_caps_ack: codec = 16, ret = 2 Jun 5 10:10:36.888: vtsp_timer: 94714681 Jun 5 10:10:36.888: vtsp:[2/1:0 (39), S_NULL, E_DSPRM_PEND_SUCCESS] Jun 5 10:10:36.888: act_pend_codec_success Jun 5 10:10:36.888: vtsp_timer_stop: 94714681 Jun 5 10:10:36.888: vtsp_open_voice_and_set_params Jun 5 10:10:36.888: dsp_close_voice_channel: [2/1:0 (39)] packet_len=8 channel_id=1 packet_id=75 Jun 5 10:10:36.888: dsp_open_voice_channel_20: [2/1:0 (39)] packet_len=16 channel_id=1 packet_id=74 alaw_ulaw_select=0 associated_signaling_channel=128 time_slot=0 serial_port=0 Jun 5 10:10:36.888: dsp_encap_config: [2/1:0 (39)] packet_len=18 channel_id=1 packet_id=92 TransportProtocol 3 SID_support=0 sequence_number=0 rotate_flag=0 header_bytes 0x80 Jun 5 10:10:36.888: dsp_set_playout_delay Jun 5 10:10:36.888: dsp_set_playout: [2/1:0 (39)] 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 Jun 5 10:10:36.888: dsp_set_playout_config Jun 5 10:10:36.888: mode 0, init 60, min 40, max 200 playout default Jun 5 10:10:36.888: dsp_set_playout_config:mode 0, init 60, min 40, max 200 Jun 5 10:10:36.888: dsp_set_playout_config: [2/1:0 (39)] packet_len=18 channel_id=1 packet_id=76 mode=1 initial=60 min=40 max=200 fax_nom=300 Jun 5 10:10:36.888: dsp_echo_canceler_control: echo_cancel: 1 Jun 5 10:10:36.888: dsp_echo_canceler_control: [2/1:0 (39)] echo_cancel 1, disable_hpf 0, flags=0x0 Jun 5 10:10:36.888: dsp_echo_canceler_control: [2/1:0 (39)] packet_len=10 channel_id=1 packet_id=66 flags=0x0 Jun 5 10:10:36.888: sgf: FXx/E&M: msg->message.set_codec_gains.out_gain=0 Jun 5 10:10:36.888: dsp_set_gains: [2/1:0 (39)] packet_len=12 channel_id=1 packet_id=91 in_gain=0 out_gain=0 Jun 5 10:10:36.888: dsp_vad_enable: [2/1:0 (39)] enable: packet_len=12 channel_id=1 packet_id=78 thresh=-38 Jun 5 10:10:36.888: dsp_voice_mode: [2/1:0 (39)] cdb 620F01FC, cdb->codec_params.modem 0, inband_detect flags 0x1 Jun 5 10:10:36.888: map_dtmf_relay_type--digit relay mode: 2 Jun 5 10:10:36.888: dsp_voice_mode: [2/1:0 (39)] packet_len=24 channel_id=1 packet_id=73 coding_type=19 voice_field_size=30 VAD_flag=250 echo_length=64 comfort_noise=1 inband_detect=1 digit_relay_mode=2 AGC_flag=0 Jun 5 10:10:43.024: vtsp:[2/1:0 (39), S_SETUP_REQ_PROC, E_TSP_CONNECT] Jun 5 10:10:43.024: act_setup_pend_connect Jun 5 10:10:43.024: vtsp_ring_noan_timer_stop: 94715294 Jun 5 10:10:43.024: dsp_cp_tone_off: [2/1:0 (39)] packet_len=8 channel_id=1 packet_id=71 Jun 5 10:10:48.492: vtsp_process_dsp_message: MSG_TX_TONE_DETECT: type=0 trigger=1 tone_id=0 Jun 5 10:10:48.492: vtsp:[2/1:0 (39), S_CONNECT, E_DSP_TONE_DETECT] Jun 5 10:10:48.492: vtsp_modem_proto_from_cdb: cap_modem_proto 0 Jun 5 10:10:48.492: act_lfax_switch: cap_modem_proto=16, fax_relay_on=1, state=19 !--- sys/if/dsp_cntl_msgs.h * Definitions for the tone detect !--- */ !--- #define TONE_TYPE_V_21 0x0000 !--- #define TONE_TYPE_CED 0x0001 /* CED 2100Hz */ !--- #define TONE_TYPE_CNG 0x0002 /* CNG 1100Hz */ !--- #define TONE_SDT_DISC 0x0003 !--- #define TONE_TYPE_COT 0x0004 /* COT tone detected */ !--- #define TONE_TYPE_MODEM 0x0005 /* Modem answer signal detected */ !--- #define SILENCE_DETECTED 0x0006 /* Silence detection */ !--- #define VOICE_DETECTED 0x0007 /* Voice detection */ !--- #define DUAL_TONE_DETECTED 0x0008 /* configurable dual tone detection */ !--- #define SEQ_TONE_DETECTED 0x0009 /* configurable seq tone detection */ !--- #define TONE_DETECT_ON 0x0001 !--- #define TONE_DETECT_OFF ~TONE_DETECT_ Jun 5 10:10:48.492: vtsp_timer: 94715841 Jun 5 10:10:48.492: vtsp:[2/1:0 (39), S_LFAX_WAIT_ACK, E_PH_CODEC_ACK] Jun 5 10:10:48.492: act_lfax_download Jun 5 10:10:48.492: vtsp_timer_stop: 94715841 Jun 5 10:10:48.492: dsp_idle_mode: [2/1:0 (39)] packet_len=8 channel_id=1 packet_id=68 Jun 5 10:10:48.492: vtsp:[2/1:0 (39), S_LFAX_DOWNLOAD, E_DSPRM_PEND_SUCCESS] Jun 5 10:10:48.492: act_lfax_mode Jun 5 10:10:48.492: vtsp:[2/1:0 (39), S_LFAX_WAIT_FAX, E_PH_CODEC_FAX] Jun 5 10:10:48.492: act_wait_fax_fax ph_set_codec_ack Jun 5 10:10:48.492: dsp_fax_mode: [2/1:0 (39)] FaxRate 0x2, Codec 0x4 dsp_fax_mode() ECM_DISABLE not set, debug_info not requested Jun 5 10:10:48.492: dsp_fax_mode: [2/1:0 (39)] packet_len=28 channel_id=1 packet_id=69 max_trans=3 info_size=30, fax_protocol_type=2, hs_data_len=0, ls_data_red=0, hs_data_red=0, tcf_handling=0, fax_relay_cntl=0x0 nsf_country = 0xAD, nsf_mfg = 0x0051 vdtl-7200-2c# vdtl-7200-2c# vdtl-7200-2c# Jun 5 10:11:21.736: vtsp_process_dsp_message: MSG_TX_FAX_CLEARDOWN: Jun 5 10:11:21.740: vtsp:[2/1:0 (39), S_FAX, E_DSP_FAX_CLEARDOWN] Jun 5 10:11:21.740: act_fax_to_voice Jun 5 10:11:21.740: vtsp_timer_stop: 94719166 Jun 5 10:11:21.740: dsp_idle_mode: [2/1:0 (39)] packet_len=8 channel_id=1 packet_id=68 Jun 5 10:11:21.740: dsp_close_voice_channel: [2/1:0 (39)] packet_len=8 channel_id=1 packet_id=75act_fax_to_voice codec= 16 Jun 5 10:11:21.740: vtsp_timer: 94719166 Jun 5 10:11:21.740: vtsp:[2/1:0 (39), S_FAX_TERM, E_DSPRM_PEND_SUCCESS] Jun 5 10:11:21.740: vtsp_timer_stop: 94719166 Jun 5 10:11:21.740: act_fax_complete Jun 5 10:11:21.740: vtsp_open_voice_and_set_params Jun 5 10:11:21.740: dsp_close_voice_channel: [2/1:0 (39)] packet_len=8 channel_id=1 packet_id=75 Jun 5 10:11:21.740: dsp_open_voice_channel_20: [2/1:0 (39)] packet_len=16 channel_id=1 packet_id=74 alaw_ulaw_select=0 associated_signaling_channel=128 time_slot=0 serial_port=0 Jun 5 10:11:21.740: dsp_encap_config: [2/1:0 (39)] packet_len=18 channel_id=1 packet_id=92 TransportProtocol 3 SID_support=0 sequence_number=0 rotate_flag=0 header_bytes 0x80 Jun 5 10:11:21.740: dsp_set_playout_delay Jun 5 10:11:21.740: dsp_set_playout: [2/1:0 (39)] 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 Jun 5 10:11:21.740: dsp_set_playout_config Jun 5 10:11:21.740: mode 0, init 60, min 40, max 200 playout default Jun 5 10:11:21.740: dsp_set_playout_config:mode 0, init 60, min 40, max 200 Jun 5 10:11:21.740: dsp_set_playout_config: [2/1:0 (39)] packet_len=18 channel_id=1 packet_id=76 mode=1 initial=60 min=40 max=200 fax_nom=300 Jun 5 10:11:21.740: dsp_echo_canceler_control: echo_cancel: 1 Jun 5 10:11:21.740: dsp_echo_canceler_control: [2/1:0 (39)] echo_cancel 1, disable_hpf 0, flags=0x0 Jun 5 10:11:21.740: dsp_echo_canceler_control: [2/1:0 (39)] packet_len=10 channel_id=1 packet_id=66 flags=0x0 Jun 5 10:11:21.740: sgf: FXx/E&M: msg->message.set_codec_gains.out_gain=0 Jun 5 10:11:21.740: dsp_set_gains: [2/1:0 (39)] packet_len=12 channel_id=1 packet_id=91 in_gain=0 out_gain=0 Jun 5 10:11:21.740: dsp_vad_enable: [2/1:0 (39)] enable: packet_len=12 channel_id=1 packet_id=78 thresh=-38 Jun 5 10:11:21.740: dsp_voice_mode: [2/1:0 (39)] cdb 620F01FC, cdb->codec_params.modem 0, inband_detect flags 0x1 Jun 5 10:11:21.740: map_dtmf_relay_type--digit relay mode: 2 Jun 5 10:11:21.740: dsp_voice_mode: [2/1:0 (39)] packet_len=24 channel_id=1 packet_id=73 coding_type=19 voice_field_size=30 VAD_flag=250 echo_length=64 comfort_noise=1 inband_detect=1 digit_relay_mode=2 AGC_flag=0 Jun 5 10:11:24.036: vtsp:[2/1:0 (39), S_CONNECT, E_CC_BRIDGE_DROP] Jun 5 10:11:24.036: act_bdrop Jun 5 10:11:24.036: vtsp:[2/1:0 (39), S_CONNECT, E_CC_DISCONNECT] Jun 5 10:11:24.036: act_disconnect Jun 5 10:11:24.036: vtsp_ring_noan_timer_stop: 94719396 Jun 5 10:11:24.036: vtsp_pcm_tone_detect_timer_stop: 94719396 Jun 5 10:11:24.036: vtsp_pcm_switchover_timer_stop: 94719396 Jun 5 10:11:24.036: vtsp_cot_timer_stop: 94719396 Jun 5 10:11:24.036: vtsp_timer_stop: 94719396 Jun 5 10:11:24.036: vtsp_timer: 94719396 Jun 5 10:11:24.036: vtsp:[2/1:0 (39), S_WAIT_STATS, E_DSP_GET_ERROR] Jun 5 10:11:24.036: act_get_error Jun 5 10:11:24.036: 2/1:0 (39): rx_dropped=1 tx_dropped=0 rx_control=39 tx_control=5 tx_control_dropped=0 dsp_mode_channel_1=2 dsp_mode_channel_2=0 c[0]=0 c[1]=0 c[2]=73 c[3]=71 c[4]=68 c[5]=69 c[6]=68 c[7]=75 c[8]=75 c[9]=74 c[10]=92 c[11]=76 c[12]=76 c[13]=66 c[14]=91 c[15]=78 Jun 5 10:11:24.036: dsp_get_levels: [2/1:0 (39)] packet_len=8 channel_id=1 packet_id=89 Jun 5 10:11:24.036: vtsp:[2/1:0 (39), S_WAIT_STATS, E_DSP_GET_LEVELS] Jun 5 10:11:24.036: act_get_levels Jun 5 10:11:24.040: vtsp_process_dsp_message: MSG_TX_GET_TX_STAT: rtp_timestamp=0x94D00079 Jun 5 10:11:24.040: vtsp:[2/1:0 (39), S_WAIT_STATS, E_DSP_GET_TX] Jun 5 10:11:24.040: act_stats_complete Jun 5 10:11:24.040: vtsp_timer_stop: 94719396 Jun 5 10:11:24.040: vtsp_ring_noan_timer_stop: 94719396 Jun 5 10:11:24.040: dsp_idle_mode: [2/1:0 (39)] packet_len=8 channel_id=1 packet_id=68 Jun 5 10:11:24.040: vtsp_timer: 94719396 Jun 5 10:11:24.840: vtsp:[2/1:0 (39), S_WAIT_RELEASE, E_TSP_CALL_FEATURE_IND] Jun 5 10:11:24.840: act_call_feature_ind Jun 5 10:11:24.840: vtsp:[2/1:0 (39), S_WAIT_RELEASE, E_TSP_DISCONNECT_CONF] Jun 5 10:11:24.840: act_wrelease_release Jun 5 10:11:24.840: vtsp_timer_stop: 94719476 Jun 5 10:11:24.840: dsp_cp_tone_off: [2/1:0 (39)] packet_len=8 channel_id=1 packet_id=71 Jun 5 10:11:24.840: dsp_idle_mode: [2/1:0 (39)] packet_len=8 channel_id=1 packet_id=68 Jun 5 10:11:24.840: dsp_close_voice_channel: [2/1:0 (39)] packet_len=8 channel_id=1 packet_id=75vtsp_do_call_historyvtsp_do_call_history CoderRate 20 Jun 5 10:11:24.840: vtsp:[2/1:0 (39), S_CLOSE_DSPRM, E_DSPRM_CLOSE_COMPLETE] Jun 5 10:11:24.840: act_terminate Jun 5 10:11:24.840: vtsp_free_cdb,cdb 0x620F01FC |