[cisco-voip] Cisco 5400 Outdialing problem.

Joseph Mays mays at win.net
Wed Aug 12 16:51:26 EDT 2009


Show debug vtsp output. Section of output before the gap was when I was dialing 5678800 to dial in to the unit and get the dialtone.

Section after the gap is when I had the dialtone from the AS5400 and was dialing out - 93876800.

I have highlighted what seems like an important point in red, but I'm not sure.

voiptrunks#debug vtsp all
Voice telephony call control all debugging is on

voiptrunks#term mon
voiptrunks#
069793: Aug 12 16:23:00.000: //-1/xxxxxxxxxxxx/VTSP:():-1:-1:-1/vtsp_do_regxrule_translate: calling_number(original)= calling_number(xlated)=5028157000 called_number(original)= called_number(xlated)=5025678800 redirectNumber(original)= redirectNumber(xlated)=
069794: Aug 12 16:23:00.000: //-1/xxxxxxxxxxxx/VTSP:():-1:-1:-1/vtsp_tsp_call_setup_ind: (sdb=0x647DC7F0, tdm_info=0x63C35990, tsp_info=0x648788C4, calling_number=5028157000 calling_oct3 = 0xA1, called_number=5025678800 called_oct3 = 0xA1, oct3a=0x0): peer_tag=5678800
069795: Aug 12 16:23:00.004: //-1/xxxxxxxxxxxx/VTSP:():-1:-1:-1/vtsp_tsp_fill_setup_ind: ev.clg.clir is 0  ev.clg.clid_transparent is 0
 ev.clg.null_orig_clg is 0  ev.clg.calling_translated is false
069796: Aug 12 16:23:00.004: //-1/xxxxxxxxxxxx/VTSP:():-1:-1:-1/vtsp_do_call_setup_ind: .
069797: Aug 12 16:23:00.004: //-1/xxxxxxxxxxxx/VTSP:():-1:-1:-1/vtsp_allocate_cdb: cdb 0x650D2070
069798: Aug 12 16:23:00.004: //-1/xxxxxxxxxxxx/VTSP:():-1:-1:-1/vtsp_do_call_setup_ind: source route label
069799: Aug 12 16:23:00.004: //-1/C38296D8816B/VTSP:(1/0:D):-1:-1:-1/vtsp_do_call_setup_ind: Call ID=98667, guid=650E0220
069800: Aug 12 16:23:00.004: //-1/C38296D8816B/VTSP:(1/0:D):2:-1:-1/vtsp_do_call_setup_ind: type=0, under_spec=808464432, name=, id0=3, id1=0, id2=12336, calling=5028157000, called=5025678800, subscriber=RegularLine, callingIE=1redirect DN =  reason = -1
069801: Aug 12 16:23:00.004: //-1/xxxxxxxxxxxx/VTSP:():-1:-1:-1/vtsp_do_normal_call_setup_ind: .
069802: Aug 12 16:23:00.004: //-1/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_start_basic_sm: dsp resource manager opened. ret 4
069803: Aug 12 16:23:00.004: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_insert_cdb: cdb 0x650D2070, CallID=222
069804: Aug 12 16:23:00.004: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_report_digit_control: digit reporting enabled
069805: Aug 12 16:23:00.004: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsp_stream_mgr_register_disposition: Ev: E_DSM_DSP_DTMF_DIGIT_BEGIN Disp: DSM_DISP_REPORT
069806: Aug 12 16:23:00.004: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsp_stream_mgr_register_disposition: Ev: E_DSM_DSP_DTMF_DIGIT Disp: DSM_DISP_REPORT
069807: Aug 12 16:23:00.004: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_get_digit_timeouts: Inter digit = 10, Initial digit = 10
069808: Aug 12 16:23:00.004: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_process_event: vtsp:[1/0:D:222, S_SETUP_INDICATED, E_CC_SETUP_ACK]
069809: Aug 12 16:23:00.008: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/act_setup_ind_ack: .
069810: Aug 12 16:23:00.008: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsp_stream_mgr_set_digit_mode: .
069811: Aug 12 16:23:00.008: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_exec: [Feat SM: S:NONE B SM: S:S_DSM_INIT E:E_DSM_CC_DIGIT]
069812: Aug 12 16:23:00.008: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_act_digit: Set digit mode to 0
069813: Aug 12 16:23:00.008: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsp_stream_mgr_pak_control: .
069814: Aug 12 16:23:00.008: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_exec: [Feat SM: S:NONE B SM: S:S_DSM_INIT E:E_DSM_PAK_CONTROL]
069815: Aug 12 16:23:00.008: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_act_pak_control: .
069816: Aug 12 16:23:00.008: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_exec: [Feat SM: S:NONE B SM: S:S_DSM_INIT E:E_DSM_CC_GEN_TONE]
069817: Aug 12 16:23:00.008: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_act_gen_tone: Tone Dial generated in direction Network
069818: Aug 12 16:23:00.008: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_dsp_cp_tone_on: cpPtr->off_time_third: 0, dmgr->sl_delay: 0
069819: Aug 12 16:23:00.056: %MODEMCALLRECORD-6-PM_TERSE_CALL_FAILED_RECORD: DS0 slot/contr/chan=1/0/2, slot/port=2/19, call_id=1AFF, calling=8286384849, called=5028464093, time=0, finl-state=Link, disc(modem)=1F06 <unknown>/Requested by host/network indicated disconnect
voiptrunks#
voiptrunks#
voiptrunks#
voiptrunks#
voiptrunks#
voiptrunks#
voiptrunks#
voiptrunks#
069820: Aug 12 16:23:05.704: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_exec: [Feat SM: S:NONE B SM: S:S_DSM_INIT E:E_DSM_DSP_DTMF_DIGIT_BEGIN]
069821: Aug 12 16:23:05.704: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_dsm_digit_begin_cb: Digit begin: 9
069822: Aug 12 16:23:05.788: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_exec: [Feat SM: S:NONE B SM: S:S_DSM_INIT E:E_DSM_DSP_DTMF_DIGIT]
069823: Aug 12 16:23:05.788: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_timer_stop: 45868785
069824: Aug 12 16:23:05.788: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsp_stream_mgr_play_tone: .
069825: Aug 12 16:23:05.788: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_exec: [Feat SM: S:NONE B SM: S:S_DSM_INIT E:E_DSM_CC_GEN_TONE]
069826: Aug 12 16:23:05.788: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_act_gen_tone: Request to turn off tone
069827: Aug 12 16:23:05.788: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_dsm_digit_end_cb: Digit end: 9
069828: Aug 12 16:23:06.104: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_exec: [Feat SM: S:NONE B SM: S:S_DSM_INIT E:E_DSM_DSP_DTMF_DIGIT_BEGIN]
069829: Aug 12 16:23:06.104: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_dsm_digit_begin_cb: Digit begin: 3
069830: Aug 12 16:23:06.188: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_exec: [Feat SM: S:NONE B SM: S:S_DSM_INIT E:E_DSM_DSP_DTMF_DIGIT]
069831: Aug 12 16:23:06.188: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_timer_stop: 45868825
069832: Aug 12 16:23:06.188: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsp_stream_mgr_play_tone: .
069833: Aug 12 16:23:06.188: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_exec: [Feat SM: S:NONE B SM: S:S_DSM_INIT E:E_DSM_CC_GEN_TONE]
069834: Aug 12 16:23:06.188: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_act_gen_tone: Tone is not on, ignoring
069835: Aug 12 16:23:06.188: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_dsm_digit_end_cb: Digit end: 3
069836: Aug 12 16:23:06.392: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_exec: [Feat SM: S:NONE B SM: S:S_DSM_INIT E:E_DSM_DSP_DTMF_DIGIT_BEGIN]
069837: Aug 12 16:23:06.392: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_dsm_digit_begin_cb: Digit begin: 8
069838: Aug 12 16:23:06.480: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_exec: [Feat SM: S:NONE B SM: S:S_DSM_INIT E:E_DSM_DSP_DTMF_DIGIT]
069839: Aug 12 16:23:06.480: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_timer_stop: 45868854
069840: Aug 12 16:23:06.480: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsp_stream_mgr_play_tone: .
069841: Aug 12 16:23:06.480: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_exec: [Feat SM: S:NONE B SM: S:S_DSM_INIT E:E_DSM_CC_GEN_TONE]
069842: Aug 12 16:23:06.480: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_act_gen_tone: Tone is not on, ignoring
069843: Aug 12 16:23:06.480: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_dsm_digit_end_cb: Digit end: 8
069844: Aug 12 16:23:06.712: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_exec: [Feat SM: S:NONE B SM: S:S_DSM_INIT E:E_DSM_DSP_DTMF_DIGIT_BEGIN]
069845: Aug 12 16:23:06.712: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_dsm_digit_begin_cb: Digit begin: 7
069846: Aug 12 16:23:06.800: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_exec: [Feat SM: S:NONE B SM: S:S_DSM_INIT E:E_DSM_DSP_DTMF_DIGIT]
069847: Aug 12 16:23:06.800: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_timer_stop: 45868886
069848: Aug 12 16:23:06.800: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsp_stream_mgr_play_tone: .
069849: Aug 12 16:23:06.800: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_exec: [Feat SM: S:NONE B SM: S:S_DSM_INIT E:E_DSM_CC_GEN_TONE]
069850: Aug 12 16:23:06.800: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_act_gen_tone: Tone is not on, ignoring
069851: Aug 12 16:23:06.800: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_dsm_digit_end_cb: Digit end: 7
069852: Aug 12 16:23:07.104: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_exec: [Feat SM: S:NONE B SM: S:S_DSM_INIT E:E_DSM_DSP_DTMF_DIGIT_BEGIN]
069853: Aug 12 16:23:07.104: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_dsm_digit_begin_cb: Digit begin: 6
069854: Aug 12 16:23:07.196: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_exec: [Feat SM: S:NONE B SM: S:S_DSM_INIT E:E_DSM_DSP_DTMF_DIGIT]
069855: Aug 12 16:23:07.196: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_timer_stop: 45868926
069856: Aug 12 16:23:07.196: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsp_stream_mgr_play_tone: .
069857: Aug 12 16:23:07.196: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_exec: [Feat SM: S:NONE B SM: S:S_DSM_INIT E:E_DSM_CC_GEN_TONE]
069858: Aug 12 16:23:07.196: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_act_gen_tone: Tone is not on, ignoring
069859: Aug 12 16:23:07.196: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_dsm_digit_end_cb: Digit end: 6
069860: Aug 12 16:23:07.356: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_exec: [Feat SM: S:NONE B SM: S:S_DSM_INIT E:E_DSM_DSP_DTMF_DIGIT_BEGIN]
069861: Aug 12 16:23:07.356: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_dsm_digit_begin_cb: Digit begin: 8
069862: Aug 12 16:23:07.440: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_exec: [Feat SM: S:NONE B SM: S:S_DSM_INIT E:E_DSM_DSP_DTMF_DIGIT]
069863: Aug 12 16:23:07.440: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_timer_stop: 45868950
069864: Aug 12 16:23:07.440: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsp_stream_mgr_play_tone: .
069865: Aug 12 16:23:07.440: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_exec: [Feat SM: S:NONE B SM: S:S_DSM_INIT E:E_DSM_CC_GEN_TONE]
069866: Aug 12 16:23:07.440: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_act_gen_tone: Tone is not on, ignoring
069867: Aug 12 16:23:07.440: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_dsm_digit_end_cb: Digit end: 8
069868: Aug 12 16:23:07.568: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_exec: [Feat SM: S:NONE B SM: S:S_DSM_INIT E:E_DSM_DSP_DTMF_DIGIT_BEGIN]
069869: Aug 12 16:23:07.568: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_dsm_digit_begin_cb: Digit begin: 0
069870: Aug 12 16:23:07.652: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_exec: [Feat SM: S:NONE B SM: S:S_DSM_INIT E:E_DSM_DSP_DTMF_DIGIT]
069871: Aug 12 16:23:07.652: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_timer_stop: 45868971
069872: Aug 12 16:23:07.652: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsp_stream_mgr_play_tone: .
069873: Aug 12 16:23:07.652: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_exec: [Feat SM: S:NONE B SM: S:S_DSM_INIT E:E_DSM_CC_GEN_TONE]
069874: Aug 12 16:23:07.652: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_act_gen_tone: Tone is not on, ignoring
069875: Aug 12 16:23:07.652: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_dsm_digit_end_cb: Digit end: 0
069876: Aug 12 16:23:07.728: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_exec: [Feat SM: S:NONE B SM: S:S_DSM_INIT E:E_DSM_DSP_DTMF_DIGIT_BEGIN]
069877: Aug 12 16:23:07.728: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_dsm_digit_begin_cb: Digit begin: 0
069878: Aug 12 16:23:07.820: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_exec: [Feat SM: S:NONE B SM: S:S_DSM_INIT E:E_DSM_DSP_DTMF_DIGIT]
069879: Aug 12 16:23:07.820: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_timer_stop: 45868988
069880: Aug 12 16:23:07.820: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsp_stream_mgr_play_tone: .
069881: Aug 12 16:23:07.820: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_exec: [Feat SM: S:NONE B SM: S:S_DSM_INIT E:E_DSM_CC_GEN_TONE]
069882: Aug 12 16:23:07.820: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_act_gen_tone: Tone is not on, ignoring
069883: Aug 12 16:23:07.820: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_dsm_digit_end_cb: Digit end: 0
069884: Aug 12 16:23:07.820: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_report_digit_control: digit reporting disabled
069885: Aug 12 16:23:07.820: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsp_stream_mgr_register_disposition: Ev: E_DSM_DSP_DTMF_DIGIT_BEGIN Disp: DSM_DISP_IGNORE
069886: Aug 12 16:23:07.820: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsp_stream_mgr_register_disposition: Ev: E_DSM_DSP_DTMF_DIGIT Disp: DSM_DISP_IGNORE
069887: Aug 12 16:23:07.820: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_get_digit_timeouts: Inter digit = 10, Initial digit = 10
069888: Aug 12 16:23:07.820: //-1/xxxxxxxxxxxx/VTSP:():-1:-1:-1/vtsp_allocate_cdb: cdb 0x6508D6B0
069889: Aug 12 16:23:07.820: //-1/xxxxxxxxxxxx/VTSP:(1/1:D):-1:-1:-1/vtsp_insert_cdb: cdb 0x6508D6B0, CallID=223
069890: Aug 12 16:23:07.820: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_save_dialpeer_tag: tag = 3876800
069891: Aug 12 16:23:07.820: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_process_event: vtsp:[1/0:D:222, S_DIGIT_COLLECT, E_CC_PROCEEDING]
069892: Aug 12 16:23:07.820: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/act_dcollect_proc: .
069893: Aug 12 16:23:07.820: //-1/xxxxxxxxxxxx/VTSP:():-1:-1:-1/vtsp_og_call_req: .
069894: Aug 12 16:23:07.820: //-1/xxxxxxxxxxxx/VTSP:():-1:-1:-1/vtsp_og_call_req:  trunk group call, target route label: OutTrunkGroup
069895: Aug 12 16:23:07.820: //223/C38296D8816B/VTSP:(1/1:D):-1:-1:-1/vtsp_og_call_req:  calling oct3 0xA1, called oct3 0xA1
069896: Aug 12 16:23:07.820: //223/C38296D8816B/VTSP:(1/1:D):-1:-1:-1/vtsp_og_call_req: Call ID=33131, guid=650D3A90
069897: Aug 12 16:23:07.820: //223/C38296D8816B/VTSP:(1/1:D):-1:-1:-1/vtsp_dump_debugs_setup_req: type=0, under_spec=1, name=, ds0=0, ds1=-1, echo_cancel=1, gain_control 0, auto_gain_control 0, dual_tone_detect 0, seq_tone_detect 0, calling=5028157000, called=5023876800, playout mode=0,playout_init = 0, playout_min = 0, playout_max = 0
 playout_fax_nom = 0
redirect DN:  reason: -1
069898: Aug 12 16:23:07.824: //223/C38296D8816B/DSM:(1/1:D):-1:0:0/dsm_start_basic_sm: cannot open dsp resource manager. cause 47
069899: Aug 12 16:23:07.824: //-1/xxxxxxxxxxxx/VTSP:():-1:-1:-1/vtsp_dsp_stream_mgr_create: DSM create failed : 7
069900: Aug 12 16:23:07.824: //223/C38296D8816B/VTSP:(1/1:D):-1:-1:-1/vtsp_cc_call_disconnected:
069901: Aug 12 16:23:07.824: vtsp_cc_call_disconnected :callId[223], cause[63], rel_dir[2]

069902: Aug 12 16:23:07.824: //223/C38296D8816B/VTSP:(1/1:D):-1:-1:-1/vtsp_set_release_source: rel_src[5]
069903: Aug 12 16:23:07.824: //223/C38296D8816B/VTSP:(1/1:D):-1:-1:-1/vtsp_process_event: vtsp:[1/1:D (223), S_SETUP_REQ_FAIL_NO_DSP, E_CC_DISCONNECT]
069904: Aug 12 16:23:07.824: //223/C38296D8816B/VTSP:(1/1:D):-1:-1:-1/act_setup_req_fail_no_dsp: .
069905: Aug 12 16:23:07.824: //223/C38296D8816B/VTSP:(1/1:D):-1:-1:-1/vtsp_do_call_history: .
069906: Aug 12 16:23:07.824: //-1/C38296D8816B/VTSP:(1/1:D):-1:-1:-1/act_terminate: .
069907: Aug 12 16:23:07.824: //-1/C38296D8816B/VTSP:(1/1:D):-1:-1:-1/vtsp_timer_stop: 45868988
069908: Aug 12 16:23:07.824: //-1/C38296D8816B/VTSP:(1/1:D):-1:-1:-1/vtsp_free_cdb: ,cdb 0x6508D6B0
069909: Aug 12 16:23:07.824: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_process_event: vtsp:[1/0:D:222, S_PROCEEDING, E_CC_DISCONNECT]
069910: Aug 12 16:23:07.824: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/act_pre_con_disconnect: .
069911: Aug 12 16:23:07.824: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_ring_noan_timer_stop: 45868988
069912: Aug 12 16:23:07.824: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsp_stream_mgr_play_tone: .
069913: Aug 12 16:23:07.824: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_exec: [Feat SM: S:NONE B SM: S:S_DSM_INIT E:E_DSM_CC_GEN_TONE]
069914: Aug 12 16:23:07.824: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_act_gen_tone: Tone Fast Busy generated in direction Network
069915: Aug 12 16:23:07.824: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_dsp_cp_tone_on: cpPtr->off_time_third: 0, dmgr->sl_delay: 0
069916: Aug 12 16:23:07.824: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_timer_stop: 45868988
069917: Aug 12 16:23:07.824: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_play_busy_timer_start: 45868988
069923: Aug 12 16:23:14.944: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_process_event: vtsp:[1/0:D:222, S_WAIT_RELEASE_NC, E_TSP_DISCONNECT_IND]
069924: Aug 12 16:23:14.944: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/act_pre_con_disc_rel: .
069925: Aug 12 16:23:14.944: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsp_stream_mgr_play_tone: .
069926: Aug 12 16:23:14.944: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_exec: [Feat SM: S:NONE B SM: S:S_DSM_INIT E:E_DSM_CC_GEN_TONE]
069927: Aug 12 16:23:14.944: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_act_gen_tone: Request to turn off tone
069928: Aug 12 16:23:14.944: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_process_event: vtsp:[1/0:D:222, S_WAIT_RELEASE_RESP, E_TSP_DISCONNECT_CONF]
069929: Aug 12 16:23:14.944: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/act_wrelease_release: .
069930: Aug 12 16:23:14.944: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_play_busy_timer_stop: 45869700
069931: Aug 12 16:23:14.944: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_timer_stop: 45869700
069932: Aug 12 16:23:14.944: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_do_call_history: .
069933: Aug 12 16:23:14.944: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_do_call_history: src carrier id
069934: Aug 12 16:23:14.948: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_do_call_history: tgt carrier id
069935: Aug 12 16:23:14.948: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_do_call_history: CoderRate -1
069936: Aug 12 16:23:14.948: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_exec_cleanup: [Feat SM: S:NONE B SM: S:S_DSM_INIT E:E_DSM_CLEANUP]
069937: Aug 12 16:23:14.948: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_act_cleanup: .
069938: Aug 12 16:23:14.948: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsp_stream_mgr_destroy: dsm_exec status: DSM_PENDING
069939: Aug 12 16:23:14.948: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_exec: [Feat SM: S:NONE B SM: S:S_DSM_CLOSE E:E_DSM_DSPRM_CLOSE_COMPLETE]
069940: Aug 12 16:23:14.948: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_act_terminate: .
069941: Aug 12 16:23:14.948: //222/C38296D8816B/VTSP:(1/0:D):2:12562:0/vtsp_dsm_closed_cb: .
069942: Aug 12 16:23:14.948: //222/C38296D8816B/DSM:(1/0:D):2:12562:0/dsm_cleanup_handle: .
069943: Aug 12 16:23:14.948: //222/C38296D8816B/VTSP:(1/0:D):2:-1:-1/vtsp_process_event: vtsp:[1/0:D:222, S_CLOSE_DSPRM, E_VTSP_DSM_CLOSE_COMPLETE]
069944: Aug 12 16:23:14.948: //222/C38296D8816B/VTSP:(1/0:D):2:-1:-1/act_terminate: .
069945: Aug 12 16:23:14.948: //222/C38296D8816B/VTSP:(1/0:D):2:-1:-1/vtsp_timer_stop: 45869701
voiptrunks#ter
069946: Aug 12 16:23:14.948: //-1/C38296D8816B/VTSP:(1/0:D):2:-1:-1/vtsp_free_cdb: ,cdb 0x650D2070m no mon
voiptrunks#
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <https://puck.nether.net/pipermail/cisco-voip/attachments/20090812/de8fb1eb/attachment.html>


More information about the cisco-voip mailing list