Ce document fournit deux captures de la sortie de la commande debug vtsp all pour un seul appel qui a réussi à passer une télécopie. La première concerne les télécopies T.38, mais elle est également pertinente pour les relais de télécopie sur VoIP (Voice over IP). Ce résultat contient des commentaires illustrant le processus d'identification du téléchargement et de l'utilisation du codec de télécopie. Le deuxième décodage concerne la voix sur relais de trames (VoFR) et n'est pas commenté. La sortie debug vtsp all ne contient pas beaucoup d'informations du point de vue du protocole T.30, mais elle fournit des informations d'état utiles du routeur, telles que :
Confirmation que le routeur est entré en mode télécopie
Taux de télécopie, codec et utilisation du mode de correction des erreurs (ECM)
Confirmation que la passerelle de terminaison a reçu une tonalité de télécopie du télécopieur de terminaison
Pour plus d'informations sur les conventions des documents, référez-vous aux Conventions utilisées pour les conseils techniques de Cisco.
Aucune condition préalable spécifique n'est requise pour ce document.
Les informations de ce document sont principalement basées sur le logiciel Cisco IOS Version 12.2(5), bien que la plupart des informations doivent également être utiles pour d'autres versions du logiciel Cisco IOS.
Les informations présentées dans ce document ont été créées à partir de périphériques dans un environnement de laboratoire spécifique. All of the devices used in this document started with a cleared (default) configuration. Si vous travaillez dans un réseau opérationnel, assurez-vous de bien comprendre l'impact potentiel de toute commande avant de l'utiliser.
Pour le relais de télécopie T.38, une fois l'appel connecté et que le routeur détecte le débogage de la tonalité de télécopie, des messages similaires à ceux qui suivent s'affichent.
debug vtsp all, commande |
---|
!--- 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 |
La trace peut être différente dans différentes versions du logiciel Cisco IOS, mais vous devez toujours être en mesure de comprendre si le codec de télécopie a été chargé correctement et quel protocole de télécopie a été utilisé par le résultat suivant le mot clé « FAX ».
Si le codec de télécopie n'a pas été chargé correctement, il y a probablement un problème logiciel. Assurez-vous que la dernière version de maintenance est utilisée et, en cas de problème, ouvrez un dossier auprès du centre d'assistance technique (TAC).
debug vtsp all - Routeur d'origine |
---|
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 - Terminating Router |
---|
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 |