音声 : Fax / Modem over IP

音声テレフォニーのサービス プロバイダーによるデバッグ

2015 年 11 月 26 日 - 機械翻訳について
その他のバージョン: PDFpdf | ライター翻訳版 (2003 年 2 月 26 日) | 英語版 (2015 年 8 月 22 日) | フィードバック


目次


概要

この文書では、ファックスを正常に通過させた 1 つのコールに対する debug vtsp all コマンド出力の 2 つのキャプチャを紹介します。 最初のキャプチャは T.38 ファックスに対する出力ですが、これは Voice over IP(VoIP)のファックス リレーにも関係しています。 この出力結果には、ファックス コーデックがダウンロードされて使用されたかどうかを確認するプロセスを説明するコメントが含まれています。 2 番目のデコードは Voice over Frame Relay(VoFR)に対する出力で、コメントはありません。 debug vtsp all の出力結果には、T.30 プロトコル側から見た情報の多くは含まれませんが、ルータからの有用な状態情報が提供されます。たとえば次のような情報です。

  • ルータがファックス モードになったという確認

  • ファックス レート、コーデック、および Error Correction Mode(ECM)が使用されたかどうか

  • 終端のゲートウェイが、終端ファックス マシンからのファックス音を受信したことの確認

はじめに

表記法

ドキュメントの表記法の詳細は、『シスコ テクニカル ティップスの表記法』を参照してください。

前提条件

このドキュメントに関する固有の要件はありません。

使用するコンポーネント

この文書の情報は主に Cisco IOS ソフトウェア リリース 12.2(5) に基づいていますが、ほとんどの情報は他の Cisco IOS ソフトウェア リリースにも役立ちます。

このドキュメントの情報は、特定のラボ環境にあるデバイスに基づいて作成されたものです。 このドキュメントで使用するすべてのデバイスは、クリアな(デフォルト)設定で作業を開始しています。 対象のネットワークが実稼働中である場合には、どのような作業についても、その潜在的な影響について確実に理解しておく必要があります。

ファックス コーデックのダウンロードを示す T.38 の debug vtsp all コマンド

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

トレースの表示は、Cisco IOS ソフトウェアのバージョンごとに異なる場合がありますが、ファックス コーデックが正しくロードされたかどうか、そしてキーワード「FAX」の後の出力にどのファックス プロトコルが使用されたかは常にわかるようになっています。

ファックス コーデックが正しくロードされなかった場合は、おそらくソフトウェアに障害があります。 最新のメンテナンス リリースが使用されているかどうかを確認し、問題が依然として解決しない場合は、Technical Assistance Center(TAC)でケースをオープンしてください。

VoFR の debug vtsp all コマンドの動作例

発信側ルータ

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

関連するシスコ サポート コミュニティ ディスカッション

シスコ サポート コミュニティは、どなたでも投稿や回答ができる情報交換スペースです。


関連情報


Document ID: 40624