em 03-14-2013 07:05 AM
Pessoal tenho uma dúvida sobre como funciona o desvio de chamadas no CME.
Tenho um case de ISR com E1 R2 digital em que ativei um redirecionamento externo de uma chamada partindo da operadora usando call-forward all.
A chamada é desconectada pela operadora por temporização (a chamada leva mais de 20 segundos para redirecionar).
Como funciona o CME nestes casos? o CME recebe a chamada da pública. Vai para um DN, ele atende a chamada e gera uma nova chamada e depois faz o redirecionamento ou é diferente?
digo isso pois foi o que a operadora me recomendou. Disse que devo configurar o CME para que ele atenda a chamada antes de redirecionar e não sei como fazer isso.
Obrigado a quem puder me ajudar.
em 03-14-2013 09:38 AM
Boa tarde Jonas,
Na verdade, depois que a chamada entra pelo (incoming called-number .), ela da match no DN (direct inward dial) que por sua vez (feature de cfw anable) redireciona a chamada para o tronco ocupando um dos timeslots do E1 via outbound dial-peer.
O possível delay por esta relacionado a diversos causas, como por exemplo, rotas pouco especificas, ou por conta de algum problema na troca de sinalização do E1.
O que te recomento é fazer testes especifico para o desvio e ativar o debug no CME para pegar a troca de sinalizações. Verifique também via show dialplan number
Para mais referencias de troubleshooting: http://www.cisco.com/en/US/tech/tk1077/technologies_tech_note09186a0080094045.shtml
Attn
Daniel Sobrinho
em 03-14-2013 12:45 PM
Boa Tarde dsobrinho e obrigado pelo rápido retorno;
acredito que a questão seja a demora mesmo de ocorrer a transferência conforme debug abaixo:
Mar 14 19:25:22.580: htsp_process_event: [0/0/0:1(10), R2_Q421_IDLE, E_DSP_SIG_0000]
Mar 14 19:25:22.580: r2_q421_ic_seize(0/0/0:1(10)) Rx SEIZURE
Mar 14 19:25:22.580: r2_reg_start_digit_collection(0/0/0:1(10))
Mar 14 19:25:22.580: r2_q421_ic_seize(0/0/0:1(10)) Tx SEIZE ACK (with 100ms delay)vnm_dsp_set_sig_state:[R2 Q.421 0/0/0:1(10)] set signal state = 0x8vnm_dsp_set_sig_state:[R2 Q.421 0/0/0:1(10)] set signal state = 0xC
Mar 14 19:25:22.580: htsp_timer - 2000 msec
Mar 14 19:25:22.580: r2_reg_process_event: [0/0/0:1(10), R2_REG_IDLE, E_R2_REG_START_COLLECTION(94)]
Mar 14 19:25:22.580: r2_reg_start_collecting(0/0/0:1(10))
Mar 14 19:25:22.580: r2_reg_timer_stop(0/0/0:1(10))
Mar 14 19:25:22.584: htsp_process_event: [0/0/0:1(10), R2_Q421_IC_SEIZE, E_HTSP_SETUP_ACK]
Mar 14 19:25:22.584: r2_q421_ic_setup(0/0/0:1(10)) E_HTSP_SETUP_ACK
Mar 14 19:25:22.584: htsp_timer_stop
Mar 14 19:25:22.584: r2_reg_offhook(0/0/0:1(10))
Mar 14 19:25:22.584: r2_reg_process_event: [0/0/0:1(10), R2_REG_COLLECTING, E_R2_REG_OFFHOOK(95)]
Mar 14 19:25:22.584: r2_reg_ic_offhook(0/0/0:1(10))
Mar 14 19:25:22.584: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_IDLE R2 Got Event R2_START
Mar 14 19:25:22.896: htsp_digit_ready_up(0/0/0:1(10)): Rx digit='4'
Mar 14 19:25:22.896: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_PRE_CALLERID R2 Got Event 4
Mar 14 19:25:22.896: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '5'
Mar 14 19:25:23.096: htsp_digit_ready(0/0/0:1(10)): Rx digit='#'
Mar 14 19:25:23.096: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_CALLERID R2 Got Event R2_TONE_OFF
Mar 14 19:25:23.096: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '#'
Mar 14 19:25:23.296: htsp_dialing_done(0/0/0:1(10))
Mar 14 19:25:23.332: htsp_digit_ready_up(0/0/0:1(10)): Rx digit='1'
Mar 14 19:25:23.336: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_CALLERID R2 Got Event 1
Mar 14 19:25:23.336: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '5'
Mar 14 19:25:23.592: htsp_digit_ready(0/0/0:1(10)): Rx digit='#'
Mar 14 19:25:23.592: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_CALLERID R2 Got Event R2_TONE_OFF
Mar 14 19:25:23.592: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '#'
Mar 14 19:25:23.844: htsp_digit_ready_up(0/0/0:1(10)): Rx digit='5'
Mar 14 19:25:23.844: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_CALLERID R2 Got Event 5
Mar 14 19:25:23.844: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '5'
Mar 14 19:25:24.096: htsp_digit_ready(0/0/0:1(10)): Rx digit='#'
Mar 14 19:25:24.096: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_CALLERID R2 Got Event R2_TONE_OFF
Mar 14 19:25:24.096: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '#'
Mar 14 19:25:24.332: htsp_digit_ready_up(0/0/0:1(10)): Rx digit='1'
Mar 14 19:25:24.332: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_CALLERID R2 Got Event 1
Mar 14 19:25:24.332: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '5'
Mar 14 19:25:24.596: htsp_digit_ready(0/0/0:1(10)): Rx digit='#'
Mar 14 19:25:24.596: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_CALLERID R2 Got Event R2_TONE_OFF
Mar 14 19:25:24.596: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '#'
Mar 14 19:25:24.836: htsp_digit_ready_up(0/0/0:1(10)): Rx digit='3'
Mar 14 19:25:24.836: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_CALLERID R2 Got Event 3
Mar 14 19:25:24.836: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '5'
Mar 14 19:25:25.092: htsp_digit_ready(0/0/0:1(10)): Rx digit='#'
Mar 14 19:25:25.092: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_CALLERID R2 Got Event R2_TONE_OFF
Mar 14 19:25:25.092: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '#'
Mar 14 19:25:25.336: htsp_digit_ready_up(0/0/0:1(10)): Rx digit='0'
Mar 14 19:25:25.336: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_CALLERID R2 Got Event 10
Mar 14 19:25:25.336: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '5'
Mar 14 19:25:25.596: htsp_digit_ready(0/0/0:1(10)): Rx digit='#'
Mar 14 19:25:25.596: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_CALLERID R2 Got Event R2_TONE_OFF
Mar 14 19:25:25.596: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '#'
Mar 14 19:25:25.844: htsp_digit_ready_up(0/0/0:1(10)): Rx digit='2'
Mar 14 19:25:25.844: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_CALLERID R2 Got Event 2
Mar 14 19:25:25.844: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '5'
Mar 14 19:25:26.096: htsp_digit_ready(0/0/0:1(10)): Rx digit='#'
Mar 14 19:25:26.096: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_CALLERID R2 Got Event R2_TONE_OFF
Mar 14 19:25:26.096: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '#'
Mar 14 19:25:26.344: htsp_digit_ready_up(0/0/0:1(10)): Rx digit='4'
Mar 14 19:25:26.344: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_CALLERID R2 Got Event 4
Mar 14 19:25:26.344: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '5'
Mar 14 19:25:26.476: htsp_digit_ready(0/0/0:1(10)): Rx digit='#'
Mar 14 19:25:26.476: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_CALLERID R2 Got Event R2_TONE_OFF
Mar 14 19:25:26.476: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '#'
Mar 14 19:25:26.652: htsp_digit_ready_up(0/0/0:1(10)): Rx digit='1'
Mar 14 19:25:26.656: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_CALLERID R2 Got Event 1
Mar 14 19:25:26.656: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '5'
Mar 14 19:25:26.772: htsp_digit_ready(0/0/0:1(10)): Rx digit='#'
Mar 14 19:25:26.772: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_CALLERID R2 Got Event R2_TONE_OFF
Mar 14 19:25:26.772: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '#'
Mar 14 19:25:26.956: htsp_digit_ready_up(0/0/0:1(10)): Rx digit='7'
Mar 14 19:25:26.956: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_CALLERID R2 Got Event 7
Mar 14 19:25:26.956: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '5'
Mar 14 19:25:27.076: htsp_digit_ready(0/0/0:1(10)): Rx digit='#'
Mar 14 19:25:27.076: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_CALLERID R2 Got Event R2_TONE_OFF
Mar 14 19:25:27.076: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '#'
Mar 14 19:25:27.264: htsp_digit_ready_up(0/0/0:1(10)): Rx digit='5'
Mar 14 19:25:27.264: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_CALLERID R2 Got Event 5
Mar 14 19:25:27.264: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '5'
Mar 14 19:25:27.512: htsp_digit_ready(0/0/0:1(10)): Rx digit='#'
Mar 14 19:25:27.512: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_CALLERID R2 Got Event R2_TONE_OFF
Mar 14 19:25:27.512: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '#'
Mar 14 19:25:27.764: htsp_digit_ready_up(0/0/0:1(10)): Rx digit='2'
Mar 14 19:25:27.764: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_CALLERID R2 Got Event 2
Mar 14 19:25:27.764: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '5'
Mar 14 19:25:28.016: htsp_digit_ready(0/0/0:1(10)): Rx digit='#'
Mar 14 19:25:28.016: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_CALLERID R2 Got Event R2_TONE_OFF
Mar 14 19:25:28.016: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '#'
Mar 14 19:25:28.256: htsp_digit_ready_up(0/0/0:1(10)): Rx digit='*'
Mar 14 19:25:28.256: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_CALLERID R2 Got Event 15
Mar 14 19:25:28.256: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '1'
Mar 14 19:25:28.516: htsp_digit_ready(0/0/0:1(10)): Rx digit='#'
Mar 14 19:25:28.516: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_COLLECT_DNIS R2 Got Event R2_TONE_OFF
Mar 14 19:25:28.516: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '#'
Mar 14 19:25:28.764: htsp_digit_ready_up(0/0/0:1(10)): Rx digit='5'
Mar 14 19:25:28.764: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_COLLECT_DNIS R2 Got Event 5
Mar 14 19:25:28.764: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '1'
Mar 14 19:25:29.036: htsp_digit_ready(0/0/0:1(10)): Rx digit='#'
Mar 14 19:25:29.036: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_COLLECT_DNIS R2 Got Event R2_TONE_OFF
Mar 14 19:25:29.036: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '#'
Mar 14 19:25:29.272: htsp_digit_ready_up(0/0/0:1(10)): Rx digit='0'
Mar 14 19:25:29.272: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_COLLECT_DNIS R2 Got Event 10
Mar 14 19:25:29.272: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '1'
Mar 14 19:25:29.536: htsp_digit_ready(0/0/0:1(10)): Rx digit='#'
Mar 14 19:25:29.536: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_COLLECT_DNIS R2 Got Event R2_TONE_OFF
Mar 14 19:25:29.536: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '#'
Mar 14 19:25:29.784: htsp_digit_ready_up(0/0/0:1(10)): Rx digit='5'
Mar 14 19:25:29.784: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_COLLECT_DNIS R2 Got Event 5
Mar 14 19:25:29.784: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '1'
Mar 14 19:25:30.056: htsp_digit_ready(0/0/0:1(10)): Rx digit='#'
Mar 14 19:25:30.056: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_COLLECT_DNIS R2 Got Event R2_TONE_OFF
Mar 14 19:25:30.056: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '#'
Mar 14 19:25:32.784: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_COLLECT_DNIS R2 Got Event R2_TONE_TIMER
Mar 14 19:25:32.784: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '3#'
Mar 14 19:25:33.036: htsp_digit_ready_up(0/0/0:1(10)): Rx digit='1'
Mar 14 19:25:33.036: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_CATEGORY R2 Got Event 1
Mar 14 19:25:33.036: Enter r2_comp_category
Mar 14 19:25:33.036: R2 Event : 1
Mar 14 19:25:33.036: ####### collect_call_enable = 0
Mar 14 19:25:33.036: ######## Not Sending B7 ##################
Mar 14 19:25:33.036: r2_reg_event_proc(0/0/0:1(10)) ADDR_INFO_COLLECTED (DNIS=4505, ANI=5130241752)
Mar 14 19:25:33.036: r2_reg_process_event: [0/0/0:1(10), R2_REG_COLLECTING, E_R2_REG_ADDR_COLLECTED(89)]
Mar 14 19:25:33.036: r2_reg_ic_addr_collected(0/0/0:1(10))htsp_switch_ind
Mar 14 19:25:33.040: //-1/C61982979873/CCAPI/cc_api_display_ie_subfields:
cc_api_call_setup_ind_common:
cisco-username=
----- ccCallInfo IE subfields -----
cisco-ani=5130241752
cisco-anitype=0
cisco-aniplan=1
cisco-anipi=0
cisco-anisi=0
dest=4505
cisco-desttype=0
cisco-destplan=0
cisco-rdie=FFFFFFFF
cisco-rdn=
cisco-rdntype=0
cisco-rdnplan=0
cisco-rdnpi=0
cisco-rdnsi=0
cisco-redirectreason=0 fwd_final_type =0
final_redirectNumber =
hunt_group_timeout =0
Mar 14 19:25:33.040: //-1/C61982979873/CCAPI/cc_api_call_setup_ind_common:
Interface=0x4BEF14E0, Call Info(
Calling Number=5130241752,(Calling Name=)(TON=Unknown, NPI=ISDN, Screening=Not Screened, Presentation=Allowed),
Called Number=4505(TON=Unknown, NPI=Unknown),
Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE,
Incoming Dial-peer=501, Progress Indication=ORIGINATING SIDE IS NON ISDN(3), Calling IE Present=TRUE,
Source Trkgrp Route Label=1, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=-1
Sub Calling(TON=Network, NPI=Data, Data=, Length=54)
Sub Called(TON=Subscriber, NPI=Unknown, DataK}IDJ@>o@<
, Length=14)
Mar 14 19:25:33.040: //-1/C61982979873/CCAPI/ccCheckClipClir:
In: Calling Number=5130241752(TON=Unknown, NPI=ISDN, Screening=Not Screened, Presentation=Allowed)
Mar 14 19:25:33.040: //-1/C61982979873/CCAPI/ccCheckClipClir:
Out: Calling Number=5130241752(TON=Unknown, NPI=ISDN, Screening=Not Screened, Presentation=Allowed)
Mar 14 19:25:33.040: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 14 19:25:33.040: :cc_get_feature_vsa malloc success
Mar 14 19:25:33.040: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 14 19:25:33.040: cc_get_feature_vsa count is 1
Mar 14 19:25:33.040: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 14 19:25:33.040: :FEATURE_VSA attributes are: feature_name:0,feature_time:1336075776,feature_id:3481
Mar 14 19:25:33.040: //2659/C61982979873/CCAPI/cc_api_call_setup_ind_common:
Set Up Event Sent;
Call Info(Calling Number=5130241752(TON=Unknown, NPI=ISDN, Screening=Not Screened, Presentation=Allowed),
Called Number=4505(TON=Unknown, NPI=Unknown))
Mar 14 19:25:33.040: htsp_process_event: [0/0/0:1(10), R2_Q421_IC_WAIT_ANSWER, E_HTSP_SETUP_ACK]
Mar 14 19:25:33.040: r2_q421_ic_setup_ack(0/0/0:1(10)) E_HTSP_SETUP_ACK
Mar 14 19:25:33.040: r2_reg_switch(0/0/0:1(10))
Mar 14 19:25:33.040: //2659/C61982979873/CCAPI/cc_process_call_setup_ind:
Event=0x4B664B70
Mar 14 19:25:33.044: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:
Try with the demoted called number 4505
Mar 14 19:25:33.044: //2659/C61982979873/CCAPI/ccCallSetContext:
Context=0x4FA4D2A8
Mar 14 19:25:33.044: //2659/C61982979873/CCAPI/cc_process_call_setup_ind:
>>>>CCAPI handed cid 2659 with tag 501 to app "_ManagedAppProcess_Default"
Mar 14 19:25:33.044: htsp_process_event: [0/0/0:1(10), R2_Q421_IC_WAIT_ANSWER, E_DSP_SIG_0000]
Mar 14 19:25:33.044: r2_reg_process_event: [0/0/0:1(10), R2_REG_WAIT_FOR_SWITCH, E_R2_REG_SWITCH(96)]
Mar 14 19:25:33.044: r2_reg_ic_switched(0/0/0:1(10))
Mar 14 19:25:33.044: //2659/C61982979873/CCAPI/ccCallProceeding:
Progress Indication=NULL(0)
Mar 14 19:25:33.048: //-1/xxxxxxxxxxxx/CCAPI/ccUpdateRedirectingNumber:
type=6 redirecting_number=4505
Mar 14 19:25:33.048: //-1/xxxxxxxxxxxx/CCAPI/ccUpdateRedirectNumber:
type=6 Original Called Number=4505, Called Number=4505, Calling Number=5130241752, Calling DN=4 Calling Id=2659,
Redirect Number=0151130402227, Redirect Reason=15
Mar 14 19:25:33.048: //-1/xxxxxxxxxxxx/CCAPI/ccUpdateRedirectingNumber:
type=6 redirecting_number=4505
Mar 14 19:25:33.052: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 14 19:25:33.052: :cc_get_feature_vsa malloc success
Mar 14 19:25:33.052: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 14 19:25:33.052: cc_get_feature_vsa count is 2
Mar 14 19:25:33.052: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 14 19:25:33.052: :FEATURE_VSA attributes are: feature_name:0,feature_time:1336077568,feature_id:3482
Mar 14 19:25:33.052: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:
Mar 14 19:25:33.052: feature_vsa is 4FA2E5F8,featname is 0
Mar 14 19:25:33.052: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 14 19:25:33.052: :cc_get_feature_vsa malloc success
Mar 14 19:25:33.052: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 14 19:25:33.052: cc_get_feature_vsa count is 3
Mar 14 19:25:33.052: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 14 19:25:33.052: :FEATURE_VSA attributes are: feature_name:0,feature_time:1336072192,feature_id:3483
Mar 14 19:25:33.052: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:
Mar 14 19:25:33.052: : Generating new featurevsa,inserting it
Mar 14 19:25:33.052: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:
Mar 14 19:25:33.052: feature call forward featname is 1
Mar 14 19:25:33.052: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
Mar 14 19:25:33.052: :cc_free_feature_vsa freeing 4FA2ECF8
Mar 14 19:25:33.052: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
Mar 14 19:25:33.052: vsacount in free is 2
Mar 14 19:25:33.052: htsp_process_event: [0/0/0:1(10), R2_Q421_IC_WAIT_ANSWER, E_HTSP_PROCEEDING]
Mar 14 19:25:33.052: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 14 19:25:33.052: :cc_get_feature_vsa malloc success
Mar 14 19:25:33.052: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 14 19:25:33.052: cc_get_feature_vsa count is 3
Mar 14 19:25:33.052: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 14 19:25:33.052: :FEATURE_VSA attributes are: feature_name:0,feature_time:1336077568,feature_id:3484
Mar 14 19:25:33.052: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:
Mar 14 19:25:33.052: feature call forward featname is 1
Mar 14 19:25:33.052: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
Mar 14 19:25:33.052: :cc_free_feature_vsa freeing 4FA2ECF8
Mar 14 19:25:33.052: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
Mar 14 19:25:33.052: vsacount in free is 2
Mar 14 19:25:33.056: //-1/xxxxxxxxxxxx/CCAPI/ccUpdateCallingNumber:
(calling_number=4505$,peer_tag=20131
Mar 14 19:25:33.056: //2659/C61982979873/CCAPI/ccCallSetupRequest:
Destination=, Calling IE Present=TRUE, Mode=0,
Outgoing Dial-peer=900, Params=0x4FA46B38, Progress Indication=ORIGINATING SIDE IS NON ISDN(3)
Mar 14 19:25:33.056: //2659/C61982979873/CCAPI/cc_fill_tg_params:
Not a cic call
Mar 14 19:25:33.056: //2659/C61982979873/CCAPI/ccCallSetupRequest:
Trunk Group Select Interface Success;
Interface=0x4BEF14E0, Selected Interface=14, Selected DSL=-1
Mar 14 19:25:33.056: //2659/C61982979873/CCAPI/ccCheckClipClir:
In: Calling Number=4505(TON=Unknown, NPI=ISDN, Screening=Not Screened, Presentation=Allowed)
Mar 14 19:25:33.056: //2659/C61982979873/CCAPI/ccCheckClipClir:
Out: Calling Number=4505(TON=Unknown, NPI=ISDN, Screening=Not Screened, Presentation=Allowed)
Mar 14 19:25:33.056: //2659/C61982979873/CCAPI/ccCallSetupRequest:
Destination Pattern=0151130402227, Called Number=0151130402227, Digit Strip=TRUE
Mar 14 19:25:33.056: //2659/C61982979873/CCAPI/ccCallSetupRequest:
Calling Number=4505(TON=Unknown, NPI=ISDN, Screening=Not Screened, Presentation=Allowed),
Called Number=0151130402227(TON=Unknown, NPI=Unknown),
Redirect Number=4505, Display Info=
Account Number=, Final Destination Flag=TRUE,
Guid=C61C8FF8-8C13-11E2-9877-9FA9DE67F424, Outgoing Dial-peer=900
Mar 14 19:25:33.056: //2659/C61982979873/CCAPI/cc_api_display_ie_subfields:
ccCallSetupRequest:
cisco-username=
----- ccCallInfo IE subfields -----
cisco-ani=4505
cisco-anitype=0
cisco-aniplan=1
cisco-anipi=0
cisco-anisi=0
dest=0151130402227
cisco-desttype=0
cisco-destplan=0
cisco-rdie=73
cisco-rdn=4505
cisco-rdntype=0
cisco-rdnplan=0
cisco-rdnpi=0
cisco-rdnsi=0
cisco-redirectreason=15 fwd_final_type =0
final_redirectNumber =
hunt_group_timeout =0
Mar 14 19:25:33.056: //2659/C61982979873/CCAPI/ccIFCallSetupRequestPrivate:
Interface=0x4BEF14E0, Interface Type=6, Destination=, Mode=0x0,
Call Params(Calling Number=4505,(Calling Name=)(TON=Unknown, NPI=ISDN, Screening=Not Screened, Presentation=Allowed),
Called Number=0151130402227(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing Dial-peer=900, Call Count On=FALSE,
Source Trkgrp Route Label=1, Target Trkgrp Route Label=1, tg_label_flag=2, Application Call Id=)
Mar 14 19:25:33.060: //2659/C61982979873/CCAPI/ccIFCallSetupRequestPrivate:
Sub Calling(TON=Network, NPI=Data, Data=, Length=54)
Mar 14 19:25:33.060: //2659/C61982979873/CCAPI/ccIFCallSetupRequestPrivate:
Sub Called(TON=Subscriber, NPI=Unknown, DataK}IDJ@>o@<
, Length=14)
Mar 14 19:25:33.060: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 14 19:25:33.060: :cc_get_feature_vsa malloc success
Mar 14 19:25:33.060: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 14 19:25:33.060: cc_get_feature_vsa count is 3
Mar 14 19:25:33.060: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 14 19:25:33.060: :FEATURE_VSA attributes are: feature_name:0,feature_time:1336077568,feature_id:3485
Mar 14 19:25:33.060: //2660/C61982979873/CCAPI/ccIFCallSetupRequestPrivate:
SPI Call Setup Request Is Success; Interface Type=6, FlowMode=1
Mar 14 19:25:33.060: //2659/C61982979873/CCAPI/ccCallSetupRequest:
Trunk Group Call Setting;
Call Entry(Retry Count=0, Voice Class Cause Code=0)
Mar 14 19:25:33.060: //2660/C61982979873/CCAPI/ccCallSetContext:
Context=0x4FA46AE8
Mar 14 19:25:33.060: //2659/C61982979873/CCAPI/ccSaveDialpeerTag:
Outgoing Dial-peer=900
Mar 14 19:25:33.060: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:
Mar 14 19:25:33.060: feature call forward featname is 1
Mar 14 19:25:33.060: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:
Mar 14 19:25:33.060: feature_vsa is 4FA2ECF8,featname is 0
Mar 14 19:25:33.060: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 14 19:25:33.060: :cc_get_feature_vsa malloc success
Mar 14 19:25:33.060: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 14 19:25:33.060: cc_get_feature_vsa count is 4
Mar 14 19:25:33.060: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 14 19:25:33.060: :FEATURE_VSA attributes are: feature_name:0,feature_time:1336075104,feature_id:3486
Mar 14 19:25:33.060: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:
Mar 14 19:25:33.060: : Generating new featurevsa,inserting it
Mar 14 19:25:33.060: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:
Mar 14 19:25:33.060: feature call forward featname is 1
Mar 14 19:25:33.060: //2659/C61982979873/CCAPI/cc_api_modify_tgt_cid_call_active_record:
Target Trkgrp Route Label=1, tg_label_flag=TRUE, Call Id=0xA63
Mar 14 19:25:33.060: htsp_timer_stop3 htsp_setup_req
Mar 14 19:25:33.064: htsp_process_event: [0/0/0:1(14), R2_Q421_IDLE, E_HTSP_SETUP_REQ]
Mar 14 19:25:33.064: r2_q421_seize(0/0/0:1(14)) E_HTSP_SETUP_REQ DNIS=0151130402227 ANI=4505
Mar 14 19:25:33.064: r2_q421_seize(0/0/0:1(14)) Tx SEIZUREvnm_dsp_set_sig_state:[R2 Q.421 0/0/0:1(14)] set signal state = 0x0
Mar 14 19:25:33.064: htsp_timer - 5000 msec
Mar 14 19:25:33.220: htsp_process_event: [0/0/0:1(14), R2_Q421_OG_SEIZE, E_DSP_SIG_1100]
Mar 14 19:25:33.220: r2_q421_seize_ack(0/0/0:1(14)) Rx SEIZE ACK
Mar 14 19:25:33.220: htsp_timer_stop
Mar 14 19:25:33.220: r2_reg_start_dialing(0/0/0:1(14))
Mar 14 19:25:33.220: r2_reg_process_event: [0/0/0:1(14), R2_REG_IDLE, E_R2_REG_START_DIAL(93)]
Mar 14 19:25:33.220: r2_reg_start_dial_delay(0/0/0:1(14)) dialout delay 200
Mar 14 19:25:33.220: r2_reg_timer(0/0/0:1(14)) 200 msec
Mar 14 19:25:33.420: r2_reg_process_event: [0/0/0:1(14), R2_REG_IDLE, E_R2_REG_EVENT_TIMER(86)]
Mar 14 19:25:33.420: r2_reg_start_dial(0/0/0:1(14))
Mar 14 19:25:33.420: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_IDLE R2 Got Event R2_START
Mar 14 19:25:33.420: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '#'
Mar 14 19:25:33.420: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '0'
Mar 14 19:25:33.420: //2660/C61982979873/CCAPI/cc_api_call_proceeding:
Interface=0x4BEF14E0, Progress Indication=NULL(0)
Mar 14 19:25:33.584: htsp_digit_ready_up(0/0/0:1(14)): Rx digit='5'
Mar 14 19:25:33.584: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event 5
Mar 14 19:25:33.584: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '#'
Mar 14 19:25:33.772: htsp_digit_ready(0/0/0:1(14)): Rx digit='#'
Mar 14 19:25:33.772: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 14 19:25:33.772: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '2'
Mar 14 19:25:33.784: htsp_dialing_done(0/0/0:1(14))
Mar 14 19:25:33.904: htsp_digit_ready_up(0/0/0:1(14)): Rx digit='5'
Mar 14 19:25:33.904: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event 5
Mar 14 19:25:33.904: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '#'
Mar 14 19:25:34.076: htsp_digit_ready(0/0/0:1(14)): Rx digit='#'
Mar 14 19:25:34.076: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 14 19:25:34.076: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '4'
Mar 14 19:25:34.204: htsp_digit_ready_up(0/0/0:1(14)): Rx digit='5'
Mar 14 19:25:34.204: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event 5
Mar 14 19:25:34.204: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '#'
Mar 14 19:25:34.372: htsp_digit_ready(0/0/0:1(14)): Rx digit='#'
Mar 14 19:25:34.372: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 14 19:25:34.372: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '5'
Mar 14 19:25:34.504: htsp_digit_ready_up(0/0/0:1(14)): Rx digit='5'
Mar 14 19:25:34.504: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event 5
Mar 14 19:25:34.504: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '#'
Mar 14 19:25:34.672: htsp_digit_ready(0/0/0:1(14)): Rx digit='#'
Mar 14 19:25:34.676: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 14 19:25:34.676: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '0'
Mar 14 19:25:34.804: htsp_digit_ready_up(0/0/0:1(14)): Rx digit='5'
Mar 14 19:25:34.804: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event 5
Mar 14 19:25:34.804: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '#'
Mar 14 19:25:35.004: htsp_dialing_done(0/0/0:1(14))
Mar 14 19:25:35.052: htsp_digit_ready(0/0/0:1(14)): Rx digit='#'
Mar 14 19:25:35.052: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 14 19:25:35.052: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '5'
Mar 14 19:25:35.184: htsp_digit_ready_up(0/0/0:1(14)): Rx digit='5'
Mar 14 19:25:35.184: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event 5
Mar 14 19:25:35.184: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '#'
Mar 14 19:25:35.384: htsp_dialing_done(0/0/0:1(14))
Mar 14 19:25:35.432: htsp_digit_ready(0/0/0:1(14)): Rx digit='#'
Mar 14 19:25:35.432: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 14 19:25:35.432: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '*'
Mar 14 19:25:35.556: htsp_digit_ready_up(0/0/0:1(14)): Rx digit='1'
Mar 14 19:25:35.556: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 14 19:25:35.556: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '#'
Mar 14 19:25:35.752: htsp_dialing_done(0/0/0:1(14))
Mar 14 19:25:35.792: htsp_digit_ready(0/0/0:1(14)): Rx digit='#'
Mar 14 19:25:35.792: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 14 19:25:35.792: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '1'
Mar 14 19:25:35.912: htsp_digit_ready_up(0/0/0:1(14)): Rx digit='1'
Mar 14 19:25:35.912: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 14 19:25:35.912: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '#'
Mar 14 19:25:36.112: htsp_dialing_done(0/0/0:1(14))
Mar 14 19:25:36.152: htsp_digit_ready(0/0/0:1(14)): Rx digit='#'
Mar 14 19:25:36.152: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 14 19:25:36.152: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '5'
Mar 14 19:25:36.272: htsp_digit_ready_up(0/0/0:1(14)): Rx digit='1'
Mar 14 19:25:36.272: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 14 19:25:36.272: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '#'
Mar 14 19:25:36.452: htsp_digit_ready(0/0/0:1(14)): Rx digit='#'
Mar 14 19:25:36.452: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 14 19:25:36.452: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '1'
Mar 14 19:25:36.572: htsp_digit_ready_up(0/0/0:1(14)): Rx digit='1'
Mar 14 19:25:36.572: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 14 19:25:36.572: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '#'
Mar 14 19:25:36.752: htsp_digit_ready(0/0/0:1(14)): Rx digit='#'
Mar 14 19:25:36.752: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 14 19:25:36.752: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '1'
Mar 14 19:25:36.872: htsp_digit_ready_up(0/0/0:1(14)): Rx digit='1'
Mar 14 19:25:36.872: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 14 19:25:36.872: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '#'
Mar 14 19:25:37.052: htsp_digit_ready(0/0/0:1(14)): Rx digit='#'
Mar 14 19:25:37.052: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 14 19:25:37.052: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '3'
Mar 14 19:25:37.172: htsp_digit_ready_up(0/0/0:1(14)): Rx digit='1'
Mar 14 19:25:37.176: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 14 19:25:37.176: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '#'
Mar 14 19:25:37.352: htsp_digit_ready(0/0/0:1(14)): Rx digit='#'
Mar 14 19:25:37.352: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 14 19:25:37.352: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '0'
Mar 14 19:25:37.472: htsp_digit_ready_up(0/0/0:1(14)): Rx digit='1'
Mar 14 19:25:37.472: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 14 19:25:37.472: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '#'
Mar 14 19:25:37.652: htsp_digit_ready(0/0/0:1(14)): Rx digit='#'
Mar 14 19:25:37.652: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 14 19:25:37.652: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '4'
Mar 14 19:25:37.784: htsp_digit_ready_up(0/0/0:1(14)): Rx digit='1'
Mar 14 19:25:37.784: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 14 19:25:37.784: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '#'
Mar 14 19:25:37.952: htsp_digit_ready(0/0/0:1(14)): Rx digit='#'
Mar 14 19:25:37.952: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 14 19:25:37.952: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '0'
Mar 14 19:25:38.072: htsp_digit_ready_up(0/0/0:1(14)): Rx digit='1'
Mar 14 19:25:38.072: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 14 19:25:38.072: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '#'
Mar 14 19:25:38.252: htsp_digit_ready(0/0/0:1(14)): Rx digit='#'
Mar 14 19:25:38.256: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 14 19:25:38.256: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '2'
Mar 14 19:25:38.372: htsp_digit_ready_up(0/0/0:1(14)): Rx digit='1'
Mar 14 19:25:38.372: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 14 19:25:38.372: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '#'
Mar 14 19:25:38.572: htsp_dialing_done(0/0/0:1(14))
Mar 14 19:25:38.612: htsp_digit_ready(0/0/0:1(14)): Rx digit='#'
Mar 14 19:25:38.612: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 14 19:25:38.612: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '2'
Mar 14 19:25:38.736: htsp_digit_ready_up(0/0/0:1(14)): Rx digit='1'
Mar 14 19:25:38.736: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 14 19:25:38.736: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '#'
Mar 14 19:25:38.932: htsp_dialing_done(0/0/0:1(14))
Mar 14 19:25:38.972: htsp_digit_ready(0/0/0:1(14)): Rx digit='#'
Mar 14 19:25:38.972: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 14 19:25:38.972: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '2'
Mar 14 19:25:39.092: htsp_digit_ready_up(0/0/0:1(14)): Rx digit='1'
Mar 14 19:25:39.092: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 14 19:25:39.092: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '#'
Mar 14 19:25:39.292: htsp_dialing_done(0/0/0:1(14))
Mar 14 19:25:39.332: htsp_digit_ready(0/0/0:1(14)): Rx digit='#'
Mar 14 19:25:39.332: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 14 19:25:39.332: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '7'
Mar 14 19:25:39.452: htsp_digit_ready_up(0/0/0:1(14)): Rx digit='1'
Mar 14 19:25:39.452: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 14 19:25:39.452: r2_reg_generate_digits(0/0/0:1(14)): Tx digit '#'
Mar 14 19:25:39.652: htsp_dialing_done(0/0/0:1(14))
Mar 14 19:25:39.692: htsp_digit_ready(0/0/0:1(14)): Rx digit='#'
Mar 14 19:25:39.692: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 14 19:25:39.692: r2_restart_timer: timer interdigit outgoing = 24000 ms
Mar 14 19:25:40.036: htsp_process_event: [0/0/0:1(10), R2_Q421_IC_WAIT_ANSWER, E_DSP_SIG_1000]
Mar 14 19:25:40.036: r2_q421_ic_clr_fwd_idle(0/0/0:1(10)) Rx CLEAR FWD
Mar 14 19:25:40.036: r2_reg_channel_disconnected(0/0/0:1(10))
Mar 14 19:25:40.036: htsp_timer - 2000 msec
Mar 14 19:25:40.036: //2659/C61982979873/CCAPI/cc_api_call_disconnected:
Cause Value=16, Interface=0x4BEF14E0, Call Id=2659
Mar 14 19:25:40.036: //2659/C61982979873/CCAPI/cc_api_call_disconnected:
Call Entry(Responsed=FALSE, Cause Value=16, Retry Count=0)
Mar 14 19:25:40.036: r2_reg_process_event: [0/0/0:1(10), R2_REG_WAIT_FOR_CONNECT, E_R2_REG_DISCONNECT(91)]
Mar 14 19:25:40.036: r2_reg_disconnect_idle(0/0/0:1(10))
Mar 14 19:25:40.036: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_WAIT_REMOTE_ALERT R2 Got Event R2_STOP
Mar 14 19:25:40.036: r2_reg_generate_digits(0/0/0:1(10)): Tx digit '#'
Mar 14 19:25:40.036: r2_reg_timer_stop(0/0/0:1(10))
Mar 14 19:25:40.036: //2660/C61982979873/CCAPI/ccCallDisconnect:
Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
Mar 14 19:25:40.036: //2660/C61982979873/CCAPI/ccCallDisconnect:
Cause Value=16, Call Entry(Responsed=FALSE, Cause Value=16)
Mar 14 19:25:40.036: //2660/C61982979873/CCAPI/cc_api_get_transfer_info:
Transfer Number Is Null
Mar 14 19:25:40.040: htsp_timer_stop3
Mar 14 19:25:40.040: htsp_process_event: [0/0/0:1(14), R2_Q421_OG_SEIZE_ACK, E_DSP_DIALING_DONE]
Mar 14 19:25:40.040: r2_q421_dial_done(0/0/0:1(14)) E_HTSP_RELEASE_REQ
Mar 14 19:25:40.040: r2_reg_dial_done(0/0/0:1(14))
Mar 14 19:25:40.040: //2659/C61982979873/CCAPI/ccCallDisconnect:
Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=16)
Mar 14 19:25:40.040: //2659/C61982979873/CCAPI/ccCallDisconnect:
Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
Mar 14 19:25:40.040: //2659/C61982979873/CCAPI/cc_api_get_transfer_info:
Transfer Number Is Null
Mar 14 19:25:40.040: htsp_process_event: [0/0/0:1(14), R2_Q421_OG_SEIZE_ACK, E_HTSP_RELEASE_REQ]
Mar 14 19:25:40.040: r2_q421_clr_fwd(0/0/0:1(14)) E_HTSP_RELEASE_REQ
Mar 14 19:25:40.040: r2_reg_channel_disconnected(0/0/0:1(14))
Mar 14 19:25:40.040: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_PROCESS_A R2 Got Event R2_STOP
Mar 14 19:25:40.040: r2_q421_clr_fwd(0/0/0:1(14)) Tx CLEAR FWDvnm_dsp_set_sig_state:[R2 Q.421 0/0/0:1(14)] set signal state = 0x8
Mar 14 19:25:40.040: htsp_timer - 1000 msec
Mar 14 19:25:40.040: r2_reg_process_event: [0/0/0:1(14), R2_REG_DIALING, E_R2_REG_DISCONNECT(91)]
Mar 14 19:25:40.040: r2_reg_disconnect_dial(0/0/0:1(14))
Mar 14 19:25:40.044: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_IDLE R2 Got Event R2_STOP
Mar 14 19:25:40.044: r2_reg_timer_stop(0/0/0:1(14))
Mar 14 19:25:40.044: htsp_process_event: [0/0/0:1(10), R2_Q421_IC_CLR_FWD, E_HTSP_RELEASE_REQ]
Mar 14 19:25:40.044: r2_q421_null_release(0/0/0:1(10)) E_HTSP_RELEASE_REQ
Mar 14 19:25:40.464: htsp_process_event: [0/0/0:1(14), R2_Q421_OG_CLR_FWD, E_DSP_SIG_1000]
Mar 14 19:25:40.468: r2_q421_clr_fwd_idle(0/0/0:1(14)) Rx IDLE
Mar 14 19:25:40.468: htsp_timer_stop
Mar 14 19:25:40.468: r2_q421_clr_fwd_idle(0/0/0:1(14)) Tx IDLEvnm_dsp_set_sig_state:[R2 Q.421 0/0/0:1(14)] set signal state = 0x8
Mar 14 19:25:40.468: r2_reg_channel_disconnected(0/0/0:1(14))
Mar 14 19:25:40.468: r2_reg_process_event: [0/0/0:1(14), R2_REG_IDLE, E_R2_REG_DISCONNECT(91)]
Mar 14 19:25:40.468: r2_reg_disconnect_idle(0/0/0:1(14))
Mar 14 19:25:40.468: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:13): STATE: R2_OUT_IDLE R2 Got Event R2_STOP
Mar 14 19:25:40.468: r2_reg_timer_stop(0/0/0:1(14))
Mar 14 19:25:40.468: //2660/C61982979873/CCAPI/cc_api_call_disconnect_done:
Disposition=0, Interface=0x4BEF14E0, Tag=0x0, Call Id=2660,
Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
Mar 14 19:25:40.468: //2660/C61982979873/CCAPI/cc_api_call_disconnect_done:
tg for this call is 1 success/fail is 1
Mar 14 19:25:40.472: //2660/C61982979873/CCAPI/cc_api_call_disconnect_done:
Call Disconnect Event Sent
Mar 14 19:25:40.472: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
Mar 14 19:25:40.472: :cc_free_feature_vsa freeing 4FA2E358
Mar 14 19:25:40.472: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
Mar 14 19:25:40.472: vsacount in free is 3
Mar 14 19:25:40.472: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
Mar 14 19:25:40.472: vsacount in free is 2
Mar 14 19:25:42.036: htsp_process_event: [0/0/0:1(10), R2_Q421_IC_CLR_FWD, E_HTSP_EVENT_TIMER]
Mar 14 19:25:42.036: htsp_timer_stop
Mar 14 19:25:42.036: r2_q421_clr_fwd_idle(0/0/0:1(10)) Tx IDLEvnm_dsp_set_sig_state:[R2 Q.421 0/0/0:1(10)] set signal state = 0x8
Mar 14 19:25:42.036: r2_reg_channel_disconnected(0/0/0:1(10))
Mar 14 19:25:42.036: r2_reg_process_event: [0/0/0:1(10), R2_REG_IDLE, E_R2_REG_DISCONNECT(91)]
Mar 14 19:25:42.036: r2_reg_disconnect_idle(0/0/0:1(10))
Mar 14 19:25:42.036: R2 Incoming Voice(0/0): DSX (E1 0/0/0:9): STATE: R2_IN_IDLE R2 Got Event R2_STOP
Mar 14 19:25:42.036: r2_reg_timer_stop(0/0/0:1(10))
Mar 14 19:25:42.036: //2659/C61982979873/CCAPI/cc_api_call_disconnect_done:
Disposition=0, Interface=0x4BEF14E0, Tag=0x0, Call Id=2659,
Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
Mar 14 19:25:42.036: //2659/C61982979873/CCAPI/cc_api_call_disconnect_done:
Call Disconnect Event Sent
Mar 14 19:25:42.036: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
Mar 14 19:25:42.036: :cc_free_feature_vsa freeing 4FA2D7F8
Mar 14 19:25:42.036: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
Mar 14 19:25:42.036: vsacount in free is 1
Mar 14 19:25:42.036: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
Mar 14 19:25:42.036: vsacount in free is 0
Onde está em negrito, mostra o tempo de toda a chamada que está em 24000 ms (24s). O tempo do debug foi menor do que isso, mas algo está apontando essa instrução.
A chamada é feita de fora para um DDR específico. A operadora manda o MCDU deste DDR (4505) para o CME.
No CME, tenho configurado um call-forward all para 0151130402227 no dn que tem o número especificado (4505).
O CME chega a fazer a segunda chamada, mas recebe aquela mensagem em negrito e derruba as duas.
segue dados de configuração do encaminhamento:
ephone-dn 279 dual-line
number 4505
call-forward all 0151130402227
call-forward busy 0151130402227 primary dialplan-pattern
call-forward noan 0151130402227 timeout 3 primary dialplan-pattern
corlist incoming TELEFONISTA
huntstop channel
transfer-mode blind
dial-peer voice 501 pots
trunkgroup 1
description PSTN-IN
translation-profile incoming 400
incoming called-number .+
direct-inward-dial
dial-peer voice 900 pots
trunkgroup 1
corlist outgoing TELEFONISTA
destination-pattern 0151130402227
forward-digits all
voice translation-rule 400
rule 1 /4500/ /0103/
rule 2 /4501/ /0102/
rule 3 /4502/ /0113/
rule 4 /4503/ /0100/
rule 5 /4504/ /3017/
rule 6 /4507/ /0022/
rule 7 /4508/ /0105/
controller E1 0/0/0
framing NO-CRC4
ds0-group 1 timeslots 1-15 type r2-digital r2-compelled ani
cas-custom 1
country brazil use-defaults
metering
category 2
answer-signal group-b 1
trunk-group 1
description E1-PSTN
em 03-14-2013 01:32 PM
Boa tarde Jonas,
Somente o cfw apresenta esse problema? As chamadas que você executa via ip phone demoram também?
Pergunto isso pois ja vivenciei algo parecido, mas preciso saber antes, se ocorre com as chamadas normais que vc executa.
---------------------------
Outra informação:
Esta translation esta ativa ?
voice translation-rule 400
rule 1 /4500/ /0103/
---------------------------
Me manda o show voice call summ
E o show dial-peer voice summ.
Attn,
Daniel Sobrinho
em 03-15-2013 04:45 AM
Mais uma vez, obrigado pelo rápido retorno
As chamadas em geral são lentas, mas acredito que é um fator normal quando se usa link R2 digital.
Mas no Cfw a lentidão é muito alta (contei 16s para fazer o encaminhamento) o que é anormal.
Sim, a rule 1 da translation 400 está ativa. é um redirecionamento do número principal para um ramal.
Dial-peer voice Summary:
dial-peer hunt 0
AD PRE PASS OUT
TAG TYPE MIN OPER PREFIX DEST-PATTERN FER THRU SESS-TARGET STAT PORT KEEPALIVE
AD PRE PASS OUT
TAG TYPE MIN OPER PREFIX DEST-PATTERN FER THRU SESS-TARGET STAT PORT KEEPALIVE
600 pots up up 4[789]....... 0 up trunkgroup 2
501 pots up up 0 down trunkgroup 1
502 pots up up 0 40[38]00T 0 up trunkgroup 1
504 pots up up 40[1-9][1-9][2-6- 0 up trunkgroup 1
].......
503 pots up up 40[2-9][1-9][789- 0 up trunkgroup 2
].......
555 pots up up 0015 400.T 0 up trunkgroup 1
41 pots up up 410[63].. 0 up trunkgroup 1
40 pots up up 419. 0 up trunkgroup 1
506 pots up up 5100 0 up trunkgroup 1
AD PRE PASS OUT
TAG TYPE MIN OPER PREFIX DEST-PATTERN FER THRU SESS-TARGET STAT PORT KEEPALIVE
507 pots up up 11.. 0 up trunkgroup 1
505 pots up up 40119[5-9]......- 0 up trunkgroup 2
.
800 pots up up 0 041........ 0 up trunkgroup 1
404 pots up up 9090 0 up 0/1/1
405 pots up up 9091 0 up 0/1/0
508 pots up up 40117....... 0 up trunkgroup 2
500 pots up up 4[2-6]....... 0 up trunkgroup 1
900 pots up up 0151130402227 0 up trunkgroup 1
20001 pots up up 0107$ 0 50/0/1
20002 pots up up 0051$ 0 50/0/2
20003 pots up down 0 50/0/3
AD PRE PASS OUT
TAG TYPE MIN OPER PREFIX DEST-PATTERN FER THRU SESS-TARGET STAT PORT KEEPALIVE
20004 pots up down 0 50/0/7
20005 pots up up 0062$ 0 50/0/8
20006 pots up up 0058$ 0 50/0/9
20007 pots up up 0078$ 0 50/0/10
20008 pots up up 0087$ 0 50/0/11
20009 pots up up 0084$ 0 50/0/12
20010 pots up up 0031$ 0 50/0/14
20011 pots up up 0028$ 0 50/0/15
20012 pots up up 0001$ 0 50/0/16
20013 pots up up 0002$ 0 50/0/17
20014 pots up up 0076$ 0 50/0/18
AD PRE PASS OUT
TAG TYPE MIN OPER PREFIX DEST-PATTERN FER THRU SESS-TARGET STAT PORT KEEPALIVE
20015 pots up up 0004$ 0 50/0/19
20016 pots up up 0090$ 0 50/0/20
20017 pots up up 0006$ 0 50/0/21
20018 pots up up 0022$ 0 50/0/22
20019 pots up up 0092$ 0 50/0/23
20020 pots up up 0064$ 0 50/0/25
20021 pots up up 0009$ 0 50/0/26
20022 pots up up 0053$ 0 50/0/27
20023 pots up up 0011$ 0 50/0/28
20024 pots up up 0059$ 0 50/0/29
20025 pots up up 0082$ 0 50/0/30
AD PRE PASS OUT
TAG TYPE MIN OPER PREFIX DEST-PATTERN FER THRU SESS-TARGET STAT PORT KEEPALIVE
20026 pots up up 0056$ 0 50/0/31
20027 pots up up 0065$ 0 50/0/32
20028 pots up up 0069$ 0 50/0/33
20029 pots up up 0015$ 0 50/0/34
20030 pots up up 0063$ 0 50/0/35
20031 pots up up 0075$ 0 50/0/36
20032 pots up up 0072$ 0 50/0/37
20033 pots up up 0074$ 0 50/0/38
20034 pots up up 0070$ 0 50/0/39
20035 pots up up 0068$ 0 50/0/40
20036 pots up up 0020$ 0 50/0/42
AD PRE PASS OUT
TAG TYPE MIN OPER PREFIX DEST-PATTERN FER THRU SESS-TARGET STAT PORT KEEPALIVE
20037 pots up up 0021$ 0 50/0/43
20038 pots up up 0055$ 0 50/0/44
20039 pots up up 0033$ 0 50/0/45
20040 pots up up 0054$ 0 50/0/46
20041 pots up up 0057$ 0 50/0/47
20042 pots up up 0029$ 0 50/0/48
20043 pots up up 0089$ 0 50/0/49
20044 pots up up 0094$ 0 50/0/50
20045 pots up up 0079$ 0 50/0/51
20046 pots up up 0060$ 0 50/0/52
20047 pots up up 0023$ 0 50/0/53
AD PRE PASS OUT
TAG TYPE MIN OPER PREFIX DEST-PATTERN FER THRU SESS-TARGET STAT PORT KEEPALIVE
20048 pots up up 0025$ 0 50/0/54
20049 pots up up 0093$ 0 50/0/55
20050 pots up up 0035$ 0 50/0/57
20051 pots up up 0032$ 0 50/0/58
20052 pots up up 0052$ 0 50/0/59
20053 pots up up 0062$ 0 50/0/62
20054 pots up up 0037$ 0 50/0/65
20055 pots up up 0088$ 0 50/0/66
20056 pots up up 0067$ 0 50/0/67
20057 pots up up 0071$ 0 50/0/68
20058 pots up up 0017$ 0 50/0/69
AD PRE PASS OUT
TAG TYPE MIN OPER PREFIX DEST-PATTERN FER THRU SESS-TARGET STAT PORT KEEPALIVE
20059 pots up up 0085$ 0 50/0/70
20060 pots up up 0040$ 0 50/0/71
20061 pots up up 0041$ 0 50/0/72
20062 pots up up 0095$ 0 50/0/73
20063 pots up up 0081$ 0 50/0/74
20064 pots up up 0096$ 0 50/0/75
20065 pots up up 0080$ 0 50/0/76
20066 pots up up 0083$ 0 50/0/77
20067 pots up up 0050$ 0 50/0/78
20068 pots up up 0091$ 0 50/0/79
20069 pots up up 0005$ 0 50/0/80
AD PRE PASS OUT
TAG TYPE MIN OPER PREFIX DEST-PATTERN FER THRU SESS-TARGET STAT PORT KEEPALIVE
20070 pots up up 0008$ 0 50/0/81
20071 pots up up 0010$ 0 50/0/82
20072 pots up up 0013$ 0 50/0/83
20073 pots up up 0061$ 0 50/0/84
20074 pots up up 0026$ 0 50/0/85
20075 pots up up 0027$ 0 50/0/86
20076 pots up up 0030$ 0 50/0/87
20077 pots up up 0097$ 0 50/0/88
20078 pots up up 0016$ 0 50/0/89
20079 pots up up 0022$ 0 50/0/90
20080 pots up up 0042$ 0 50/0/92
AD PRE PASS OUT
TAG TYPE MIN OPER PREFIX DEST-PATTERN FER THRU SESS-TARGET STAT PORT KEEPALIVE
20081 pots up up 0043$ 0 50/0/93
20082 pots up up 0044$ 0 50/0/94
20083 pots up up 0045$ 0 50/0/95
20084 pots up up 0014$ 0 50/0/96
20085 pots up up 0003$ 0 50/0/97
20086 pots up up 0007$ 0 50/0/98
20087 pots up up 0099$ 0 50/0/99
20088 pots up up 0100$ 0 50/0/100
20089 pots up up 0102$ 0 50/0/102
20090 pots up up 0103$ 0 50/0/103
20091 pots up up 0104$ 0 50/0/104
AD PRE PASS OUT
TAG TYPE MIN OPER PREFIX DEST-PATTERN FER THRU SESS-TARGET STAT PORT KEEPALIVE
20092 pots up up 0105$ 0 50/0/105
20093 pots up up 0106$ 0 50/0/106
20094 pots up up 0107$ 0 50/0/107
20095 pots up up 0108$ 0 50/0/108
20096 pots up up 0109$ 0 50/0/109
20097 pots up up 0120$ 0 50/0/110
20098 pots up up 0199$ 0 50/0/112
20099 pots up up 0112$ 0 50/0/113
20100 pots up up 0113$ 0 50/0/114
20101 pots up up 0114$ 0 50/0/115
20102 pots up up 0116$ 0 50/0/116
AD PRE PASS OUT
TAG TYPE MIN OPER PREFIX DEST-PATTERN FER THRU SESS-TARGET STAT PORT KEEPALIVE
20103 pots up up 0119$ 0 50/0/119
20104 pots up up 0198$ 0 50/0/120
20105 pots up up 0121$ 0 50/0/121
20106 pots up up 0098$ 0 50/0/122
20107 pots up up 0118$ 0 50/0/123
20108 pots up up 0073$ 0 50/0/198
20109 pots up up 3000$ 0 50/0/270
20110 pots up up 3001$ 0 50/0/271
20111 pots up up 3002$ 0 50/0/272
20112 pots up up 3003$ 0 50/0/273
20114 pots up up 8889$ 6 50/0/280
AD PRE PASS OUT
TAG TYPE MIN OPER PREFIX DEST-PATTERN FER THRU SESS-TARGET STAT PORT KEEPALIVE
20115 pots up up 8889$ 5 50/0/281
20116 pots up up 8889$ 4 50/0/282
20117 pots up up 8889$ 3 50/0/283
20118 pots up up 8889$ 2 50/0/284
20119 pots up up 8889$ 1 50/0/285
20120 pots up up 8889$ 0 50/0/286
20121 pots up up 3073$ 0 50/0/287
20122 pots up up 0066$ 0 50/0/288
40001 voip up up 3022 0 syst ipv4:
:
40002 voip up up 3023 0 syst ipv4:
:
40003 voip up up 0086 0 syst ipv4:
:
40004 voip up up 0012 0 syst ipv4:
:
40005 voip up up 0110 0 syst ipv4:
:
40006 voip up up 0111 0 syst ipv4:
:
AD PRE PASS OUT
TAG TYPE MIN OPER PREFIX DEST-PATTERN FER THRU SESS-TARGET STAT PORT KEEPALIVE
20126 pots up up A9099A0000 0 50/0/22
20127 pots down down A9099A0000 0 50/0/90
20128 pots up up 9099 0 50/0/0
20129 pots up up A9099A0001 0 50/0/2
20131 pots up up 4505$ 0 50/0/279
40008 voip up up 3018 0 syst ipv4:
40007 voip up up 3017 0 syst ipv4:
Voice Call Summary:
PORT CODEC VAD VTSP STATE VPM STATE
============== ========= === ==================== ======================
0/0/0:1.1 - - - R2_Q421_IDLE
0/0/0:1.2 - - - R2_Q421_IDLE
0/0/0:1.3 - - - R2_Q421_IDLE
0/0/0:1.4 - - - R2_Q421_IDLE
0/0/0:1.5 - - - R2_Q421_IDLE
0/0/0:1.6 g711ulaw n S_CONNECT R2_Q421_OG_ANSWER
0/0/0:1.7 - - - R2_Q421_IDLE
0/0/0:1.8 - - - R2_Q421_IDLE
0/0/0:1.9 - - - R2_Q421_IDLE
0/0/0:1.10 - - - R2_Q421_IDLE
0/0/0:1.11 - - - R2_Q421_IDLE
0/0/0:1.12 - - - R2_Q421_IDLE
0/0/0:1.13 - - - R2_Q421_IDLE
0/0/0:1.14 - - - R2_Q421_IDLE
0/0/0:1.15 - - - R2_Q421_IDLE
0/1/0 - - - FXOLS_ONHOOK
0/1/1 - - - FXOLS_ONHOOK
50/0/1 .1 - - - EFXS_ONHOOK
50/0/1 .2 - - - EFXS_ONHOOK
50/0/2 .1 - - - EFXS_ONHOOK
50/0/2 .2 - - - EFXS_ONHOOK
50/0/3 .1 - - - EFXS_INIT
50/0/3 .2 - - - EFXS_INIT
50/0/7 .1 - - - EFXS_INIT
50/0/7 .2 - - - EFXS_INIT
50/0/8 .1 - - - EFXS_INIT
50/0/8 .2 - - - EFXS_INIT
50/0/9 .1 - - - EFXS_INIT
50/0/9 .2 - - - EFXS_INIT
50/0/10 .1 - - - EFXS_INIT
50/0/10 .2 - - - EFXS_INIT
50/0/11 .1 - - - EFXS_INIT
50/0/11 .2 - - - EFXS_INIT
50/0/12 .1 - - - EFXS_INIT
50/0/12 .2 - - - EFXS_INIT
50/0/14 .1 - - - EFXS_INIT
50/0/14 .2 - - - EFXS_INIT
50/0/15 .1 - - - EFXS_INIT
50/0/15 .2 - - - EFXS_INIT
50/0/16 .1 - - - EFXS_INIT
50/0/16 .2 - - - EFXS_INIT
50/0/17 .1 - - - EFXS_INIT
50/0/17 .2 - - - EFXS_INIT
50/0/18 .1 - - - EFXS_INIT
50/0/18 .2 - - - EFXS_INIT
50/0/19 .1 - - - EFXS_INIT
50/0/19 .2 - - - EFXS_INIT
50/0/20 .1 - - - EFXS_INIT
50/0/20 .2 - - - EFXS_INIT
50/0/21 .1 - - - EFXS_INIT
50/0/21 .2 - - - EFXS_INIT
50/0/22 .1 - - - EFXS_ONHOOK
50/0/22 .2 - - - EFXS_ONHOOK
50/0/23 .1 - - - EFXS_ONHOOK
50/0/23 .2 - - - EFXS_ONHOOK
50/0/25 .1 - - - EFXS_ONHOOK
50/0/25 .2 - - - EFXS_ONHOOK
50/0/26 .1 - - - EFXS_INIT
50/0/26 .2 - - - EFXS_INIT
50/0/27 .1 - - - EFXS_INIT
50/0/27 .2 - - - EFXS_INIT
50/0/28 .1 - - - EFXS_INIT
50/0/28 .2 - - - EFXS_INIT
50/0/29 .1 - - - EFXS_ONHOOK
50/0/29 .2 - - - EFXS_ONHOOK
50/0/30 .1 - - - EFXS_ONHOOK
50/0/30 .2 - - - EFXS_ONHOOK
50/0/31 .1 - - - EFXS_INIT
50/0/31 .2 - - - EFXS_INIT
50/0/32 .1 - - - EFXS_ONHOOK
50/0/32 .2 - - - EFXS_ONHOOK
50/0/33 .1 - - - EFXS_INIT
50/0/33 .2 - - - EFXS_INIT
50/0/34 .1 - - - EFXS_INIT
50/0/34 .2 - - - EFXS_INIT
50/0/35 .1 - - - EFXS_INIT
50/0/35 .2 - - - EFXS_INIT
50/0/36 .1 - - - EFXS_ONHOOK
50/0/36 .2 - - - EFXS_ONHOOK
50/0/37 .1 - - - EFXS_INIT
50/0/37 .2 - - - EFXS_INIT
50/0/38 .1 - - - EFXS_ONHOOK
50/0/38 .2 - - - EFXS_ONHOOK
50/0/39 .1 - - - EFXS_INIT
50/0/39 .2 - - - EFXS_INIT
50/0/40 .1 - - - EFXS_INIT
50/0/40 .2 - - - EFXS_INIT
50/0/42 .1 - - - EFXS_INIT
50/0/42 .2 - - - EFXS_INIT
50/0/43 .1 - - - EFXS_INIT
50/0/43 .2 - - - EFXS_INIT
50/0/44 .1 g711ulaw n S_CONNECT EFXS_CONNECT
50/0/44 .2 - - - EFXS_ONHOOK
50/0/44 .3 - - - EFXS_ONHOOK
50/0/44 .4 - - - EFXS_ONHOOK
50/0/44 .5 - - - EFXS_ONHOOK
50/0/44 .6 - - - EFXS_ONHOOK
50/0/44 .7 - - - EFXS_ONHOOK
50/0/44 .8 - - - EFXS_ONHOOK
50/0/45 .1 - - - EFXS_INIT
50/0/45 .2 - - - EFXS_INIT
50/0/46 .1 - - - EFXS_ONHOOK
50/0/46 .2 - - - EFXS_ONHOOK
50/0/47 .1 - - - EFXS_INIT
50/0/47 .2 - - - EFXS_INIT
50/0/48 .1 - - - EFXS_INIT
50/0/48 .2 - - - EFXS_INIT
50/0/49 .1 - - - EFXS_ONHOOK
50/0/49 .2 - - - EFXS_ONHOOK
50/0/50 .1 - - - EFXS_INIT
50/0/50 .2 - - - EFXS_INIT
50/0/51 .1 - - - EFXS_ONHOOK
50/0/51 .2 - - - EFXS_ONHOOK
50/0/52 .1 - - - EFXS_ONHOOK
50/0/52 .2 - - - EFXS_ONHOOK
50/0/53 .1 - - - EFXS_ONHOOK
50/0/53 .2 - - - EFXS_ONHOOK
50/0/54 .1 - - - EFXS_INIT
50/0/54 .2 - - - EFXS_INIT
50/0/55 .1 - - - EFXS_ONHOOK
50/0/55 .2 - - - EFXS_ONHOOK
50/0/57 .1 - - - EFXS_INIT
50/0/57 .2 - - - EFXS_INIT
50/0/58 .1 - - - EFXS_ONHOOK
50/0/58 .2 - - - EFXS_ONHOOK
50/0/59 .1 - - - EFXS_INIT
50/0/59 .2 - - - EFXS_INIT
50/0/62 .1 - - - EFXS_INIT
50/0/62 .2 - - - EFXS_INIT
50/0/65 .1 - - - EFXS_ONHOOK
50/0/65 .2 - - - EFXS_ONHOOK
50/0/66 .1 - - - EFXS_INIT
50/0/66 .2 - - - EFXS_INIT
50/0/67 .1 - - - EFXS_ONHOOK
50/0/67 .2 - - - EFXS_ONHOOK
50/0/68 .1 - - - EFXS_INIT
50/0/68 .2 - - - EFXS_INIT
50/0/69 .1 - - - EFXS_INIT
50/0/69 .2 - - - EFXS_INIT
50/0/70 .1 - - - EFXS_INIT
50/0/70 .2 - - - EFXS_INIT
50/0/71 .1 - - - EFXS_INIT
50/0/71 .2 - - - EFXS_INIT
50/0/72 .1 - - - EFXS_INIT
50/0/72 .2 - - - EFXS_INIT
50/0/73 .1 - - - EFXS_INIT
50/0/73 .2 - - - EFXS_INIT
50/0/74 .1 - - - EFXS_INIT
50/0/74 .2 - - - EFXS_INIT
50/0/75 .1 - - - EFXS_INIT
50/0/75 .2 - - - EFXS_INIT
50/0/76 .1 - - - EFXS_ONHOOK
50/0/76 .2 - - - EFXS_ONHOOK
50/0/77 .1 - - - EFXS_INIT
50/0/77 .2 - - - EFXS_INIT
50/0/78 .1 - - - EFXS_INIT
50/0/78 .2 - - - EFXS_INIT
50/0/79 .1 - - - EFXS_ONHOOK
50/0/79 .2 - - - EFXS_ONHOOK
50/0/80 .1 - - - EFXS_INIT
50/0/80 .2 - - - EFXS_INIT
50/0/81 .1 - - - EFXS_INIT
50/0/81 .2 - - - EFXS_INIT
50/0/82 .1 - - - EFXS_INIT
50/0/82 .2 - - - EFXS_INIT
50/0/83 .1 - - - EFXS_INIT
50/0/83 .2 - - - EFXS_INIT
50/0/84 .1 - - - EFXS_INIT
50/0/84 .2 - - - EFXS_INIT
50/0/85 .1 - - - EFXS_INIT
50/0/85 .2 - - - EFXS_INIT
50/0/86 .1 - - - EFXS_INIT
50/0/86 .2 - - - EFXS_INIT
50/0/87 .1 - - - EFXS_INIT
50/0/87 .2 - - - EFXS_INIT
50/0/88 .1 - - - EFXS_INIT
50/0/88 .2 - - - EFXS_INIT
50/0/89 .1 - - - EFXS_INIT
50/0/89 .2 - - - EFXS_INIT
50/0/90 .1 - - - EFXS_ONHOOK
50/0/90 .2 - - - EFXS_ONHOOK
50/0/92 .1 - - - EFXS_INIT
50/0/92 .2 - - - EFXS_INIT
50/0/93 .1 - - - EFXS_INIT
50/0/93 .2 - - - EFXS_INIT
50/0/94 .1 - - - EFXS_INIT
50/0/94 .2 - - - EFXS_INIT
50/0/95 .1 - - - EFXS_ONHOOK
50/0/95 .2 - - - EFXS_ONHOOK
50/0/96 .1 - - - EFXS_INIT
50/0/96 .2 - - - EFXS_INIT
50/0/97 .1 - - - EFXS_INIT
50/0/97 .2 - - - EFXS_INIT
50/0/98 .1 - - - EFXS_INIT
50/0/98 .2 - - - EFXS_INIT
50/0/99 .1 - - - EFXS_INIT
50/0/99 .2 - - - EFXS_INIT
50/0/100.1 - - - EFXS_ONHOOK
50/0/100.2 - - - EFXS_ONHOOK
50/0/102.1 - - - EFXS_ONHOOK
50/0/102.2 - - - EFXS_ONHOOK
50/0/103.1 - - - EFXS_ONHOOK
50/0/103.2 - - - EFXS_ONHOOK
50/0/104.1 - - - EFXS_INIT
50/0/104.2 - - - EFXS_INIT
50/0/105.1 - - - EFXS_ONHOOK
50/0/105.2 - - - EFXS_ONHOOK
50/0/106.1 - - - EFXS_ONHOOK
50/0/106.2 - - - EFXS_ONHOOK
50/0/107.1 - - - EFXS_INIT
50/0/107.2 - - - EFXS_INIT
50/0/108.1 - - - EFXS_ONHOOK
50/0/108.2 - - - EFXS_ONHOOK
50/0/109.1 - - - EFXS_ONHOOK
50/0/109.2 - - - EFXS_ONHOOK
50/0/110.1 - - - EFXS_INIT
50/0/110.2 - - - EFXS_INIT
50/0/112.1 - - - EFXS_ONHOOK
50/0/112.2 - - - EFXS_ONHOOK
50/0/113.1 - - - EFXS_INIT
50/0/113.2 - - - EFXS_INIT
50/0/114.1 - - - EFXS_ONHOOK
50/0/114.2 - - - EFXS_ONHOOK
50/0/115.1 - - - EFXS_INIT
50/0/115.2 - - - EFXS_INIT
50/0/116.1 - - - EFXS_INIT
50/0/116.2 - - - EFXS_INIT
50/0/119.1 - - - EFXS_ONHOOK
50/0/119.2 - - - EFXS_ONHOOK
50/0/120.1 - - - EFXS_INIT
50/0/120.2 - - - EFXS_INIT
50/0/121.1 - - - EFXS_INIT
50/0/121.2 - - - EFXS_INIT
50/0/122.1 - - - EFXS_ONHOOK
50/0/122.2 - - - EFXS_ONHOOK
50/0/123.1 - - - EFXS_INIT
50/0/123.2 - - - EFXS_INIT
50/0/198.1 - - - EFXS_INIT
50/0/198.2 - - - EFXS_INIT
50/0/270.1 - - - EFXS_ONHOOK
50/0/271.1 - - - EFXS_ONHOOK
50/0/272.1 - - - EFXS_ONHOOK
50/0/273.1 - - - EFXS_ONHOOK
50/0/280.1 - - - EFXS_ONHOOK
50/0/280.2 - - - EFXS_ONHOOK
50/0/281.1 - - - EFXS_ONHOOK
50/0/281.2 - - - EFXS_ONHOOK
50/0/282.1 - - - EFXS_ONHOOK
50/0/282.2 - - - EFXS_ONHOOK
50/0/283.1 - - - EFXS_ONHOOK
50/0/283.2 - - - EFXS_ONHOOK
50/0/284.1 - - - EFXS_ONHOOK
50/0/284.2 - - - EFXS_ONHOOK
50/0/285.1 - - - EFXS_ONHOOK
50/0/285.2 - - - EFXS_ONHOOK
50/0/286.1 - - - EFXS_ONHOOK
50/0/286.2 - - - EFXS_ONHOOK
50/0/287.1 - - - EFXS_INIT
50/0/288.1 - - - EFXS_INIT
50/0/288.2 - - - EFXS_INIT
50/0/0 .1 - - - S_OPEN_PEND
50/0/279.1 - - - EFXS_ONHOOK
50/0/279.2 - - - EFXS_ONHOOK
em 03-15-2013 06:55 AM
Poderia postar um debug voice ccapi inout de uma chamada normal e de uma chamada com CFW.
Att
Leonardo Santana
em 03-15-2013 09:41 AM
Debug de uma chamada vinda de um ramal interno para o destino:
Mar 15 16:35:23.655: htsp_process_event: [50/0/112.1, EFXS_ONHOOK, E_DSP_SIG_1100]efxs_onhook_offhook htsp_setup_ind
Mar 15 16:35:23.655: [50/0/112.1] get_local_station_id calling num=0199 calling name=testeeee calling time=03/15 13:35 orig called=
Mar 15 16:35:23.659: //-1/2B3F4E06A2B7/CCAPI/cc_api_display_ie_subfields:
cc_api_call_setup_ind_common:
cisco-username=
----- ccCallInfo IE subfields -----
cisco-ani=0199
cisco-anitype=0
cisco-aniplan=0
cisco-anipi=0
cisco-anisi=0
dest=
cisco-desttype=0
cisco-destplan=0
cisco-rdie=FFFFFFFF
cisco-rdn=
cisco-rdntype=0
cisco-rdnplan=0
cisco-rdnpi=0
cisco-rdnsi=0
cisco-redirectreason=0 fwd_final_type =0
final_redirectNumber =
hunt_group_timeout =0
Mar 15 16:35:23.659: //-1/2B3F4E06A2B7/CCAPI/cc_api_call_setup_ind_common:
Interface=0x4E68BAA0, Call Info(
Calling Number=0199,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
Called Number=(TON=Unknown, NPI=Unknown),
Calling Translated=FALSE, Subscriber Type Str=RegularLine, FinalDestinationFlag=FALSE,
Incoming Dial-peer=20098, Progress Indication=ORIGINATING SIDE IS NON ISDN(3), Calling IE Present=TRUE,
Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=-1
Mar 15 16:35:23.659: //-1/2B3F4E06A2B7/CCAPI/ccCheckClipClir:
In: Calling Number=0199(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Mar 15 16:35:23.659: //-1/2B3F4E06A2B7/CCAPI/ccCheckClipClir:
Out: Calling Number=0199(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Mar 15 16:35:23.659: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 15 16:35:23.659: :cc_get_feature_vsa malloc success
Mar 15 16:35:23.659: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 15 16:35:23.659: cc_get_feature_vsa count is 1
Mar 15 16:35:23.659: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 15 16:35:23.659: :FEATURE_VSA attributes are: feature_name:0,feature_time:1336077344,feature_id:4985
Mar 15 16:35:23.659: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_setup_ind_common:
Set Up Event Sent;
Call Info(Calling Number=0199(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
Called Number=(TON=Unknown, NPI=Unknown))
Mar 15 16:35:23.659: //3870/2B3F4E06A2B7/CCAPI/cc_process_call_setup_ind:
Event=0x4B662A88
Mar 15 16:35:23.659: //3870/2B3F4E06A2B7/CCAPI/ccCallSetContext:
Context=0x4FA510E8
Mar 15 16:35:23.659: //3870/2B3F4E06A2B7/CCAPI/cc_process_call_setup_ind:
>>>>CCAPI handed cid 3870 with tag 20098 to app "_ManagedAppProcess_Default"
Mar 15 16:35:23.663: //3870/2B3F4E06A2B7/CCAPI/ccCallSetupAck:
Call Id=3870
Mar 15 16:35:23.663: //3870/2B3F4E06A2B7/CCAPI/cc_api_set_transfer_info:
Transfer Number=, Transfer Reason=0x0
Mar 15 16:35:23.663: //3870/2B3F4E06A2B7/CCAPI/ccGenerateToneInfo:
Stop Tone On Digit=TRUE, Tone=Dial Tone,
Tone Direction=Network, Params=0x0, Call Id=3870
Mar 15 16:35:23.663: //3870/2B3F4E06A2B7/CCAPI/ccSetDigitTimeouts:
Initial Digit Timeout=-1000(ms), Inter Digit Timeout=-1000(ms)
Mar 15 16:35:23.663: //3870/2B3F4E06A2B7/CCAPI/ccSetDigitTimeouts:
Call Entry(Inter Digit Timeout=10000(ms), Initial Digit Timeout=10000(ms))
Mar 15 16:35:23.663: //3870/2B3F4E06A2B7/CCAPI/ccCallReportDigits:
(callID=0xF1E, digit_event=0x1, enable=TRUE, consume=FALSE)
Mar 15 16:35:23.663: //3870/2B3F4E06A2B7/CCAPI/ccCallReportDigits:
Enabled=TRUE, Call Id=3870
Mar 15 16:35:23.663: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_report_digits_done:
(vdbPtr=0x4E68BAA0, callID=0xF1E, disp=0, digit_event=0x1, enable=TRUE, consume=FALSE)
Mar 15 16:35:23.663: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_report_digits_done:
Enabled=TRUE, Disposition=0x0, Interface=0x4E68BAA0, Call Id=3870
Mar 15 16:35:23.663: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_report_digits_done:
Call Entry(Initial Digit Timeout=15000(ms), Inter Digit Timeout=10000(ms))
Mar 15 16:35:23.663: htsp_process_event: [50/0/112.1, EFXS_WAIT_SETUP_ACK, E_HTSP_SETUP_ACK]efxs_check_auto_call
Mar 15 16:35:23.863: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_begin:
Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
Source Call Id=3870, Digit=0, DigitBeginFlags=0x0,
Rtp Timestamp=0x6AFAB8, Rtp Expiration=0x0
Mar 15 16:35:23.863: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_end:
Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
Source Call Id=3870, Digit=0, Duration=100,
Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF
Mar 15 16:35:23.863: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_end:
Call Entry(Handoff Depth=0)
Mar 15 16:35:23.863: htsp_digit_ready(50/0/112.1): digit = 0
Mar 15 16:35:24.063: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_begin:
Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
Source Call Id=3870, Digit=1, DigitBeginFlags=0x0,
Rtp Timestamp=0x6B77B8, Rtp Expiration=0x0
Mar 15 16:35:24.063: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_end:
Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
Source Call Id=3870, Digit=1, Duration=100,
Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF
Mar 15 16:35:24.063: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_end:
Call Entry(Handoff Depth=0)
Mar 15 16:35:24.063: htsp_digit_ready(50/0/112.1): digit = 1
Mar 15 16:35:24.263: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_begin:
Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
Source Call Id=3870, Digit=5, DigitBeginFlags=0x0,
Rtp Timestamp=0x6BF4B8, Rtp Expiration=0x0
Mar 15 16:35:24.263: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_end:
Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
Source Call Id=3870, Digit=5, Duration=100,
Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF
Mar 15 16:35:24.263: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_end:
Call Entry(Handoff Depth=0)
Mar 15 16:35:24.263: htsp_digit_ready(50/0/112.1): digit = 5
Mar 15 16:35:24.463: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_begin:
Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
Source Call Id=3870, Digit=1, DigitBeginFlags=0x0,
Rtp Timestamp=0x6C71B8, Rtp Expiration=0x0
Mar 15 16:35:24.463: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_end:
Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
Source Call Id=3870, Digit=1, Duration=100,
Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF
Mar 15 16:35:24.463: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_end:
Call Entry(Handoff Depth=0)
Mar 15 16:35:24.463: htsp_digit_ready(50/0/112.1): digit = 1
Mar 15 16:35:24.663: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_begin:
Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
Source Call Id=3870, Digit=1, DigitBeginFlags=0x0,
Rtp Timestamp=0x6CEEB8, Rtp Expiration=0x0
Mar 15 16:35:24.663: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_end:
Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
Source Call Id=3870, Digit=1, Duration=100,
Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF
Mar 15 16:35:24.663: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_end:
Call Entry(Handoff Depth=0)
Mar 15 16:35:24.663: htsp_digit_ready(50/0/112.1): digit = 1
Mar 15 16:35:24.863: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_begin:
Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
Source Call Id=3870, Digit=3, DigitBeginFlags=0x0,
Rtp Timestamp=0x6D6BB8, Rtp Expiration=0x0
Mar 15 16:35:24.863: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_end:
Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
Source Call Id=3870, Digit=3, Duration=100,
Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF
Mar 15 16:35:24.863: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_end:
Call Entry(Handoff Depth=0)
Mar 15 16:35:24.863: htsp_digit_ready(50/0/112.1): digit = 3
Mar 15 16:35:25.063: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_begin:
Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
Source Call Id=3870, Digit=0, DigitBeginFlags=0x0,
Rtp Timestamp=0x6DE8B8, Rtp Expiration=0x0
Mar 15 16:35:25.063: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_end:
Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
Source Call Id=3870, Digit=0, Duration=100,
Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF
Mar 15 16:35:25.063: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_end:
Call Entry(Handoff Depth=0)
Mar 15 16:35:25.063: htsp_digit_ready(50/0/112.1): digit = 0
Mar 15 16:35:25.263: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_begin:
Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
Source Call Id=3870, Digit=4, DigitBeginFlags=0x0,
Rtp Timestamp=0x6E65B8, Rtp Expiration=0x0
Mar 15 16:35:25.263: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_end:
Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
Source Call Id=3870, Digit=4, Duration=100,
Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF
Mar 15 16:35:25.263: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_end:
Call Entry(Handoff Depth=0)
Mar 15 16:35:25.263: htsp_digit_ready(50/0/112.1): digit = 4
Mar 15 16:35:25.463: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_begin:
Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
Source Call Id=3870, Digit=0, DigitBeginFlags=0x0,
Rtp Timestamp=0x6EE2B8, Rtp Expiration=0x0
Mar 15 16:35:25.463: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_end:
Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
Source Call Id=3870, Digit=0, Duration=100,
Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF
Mar 15 16:35:25.463: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_end:
Call Entry(Handoff Depth=0)
Mar 15 16:35:25.463: htsp_digit_ready(50/0/112.1): digit = 0
Mar 15 16:35:25.663: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_begin:
Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
Source Call Id=3870, Digit=2, DigitBeginFlags=0x0,
Rtp Timestamp=0x6F5FB8, Rtp Expiration=0x0
Mar 15 16:35:25.663: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_end:
Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
Source Call Id=3870, Digit=2, Duration=100,
Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF
Mar 15 16:35:25.663: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_end:
Call Entry(Handoff Depth=0)
Mar 15 16:35:25.663: htsp_digit_ready(50/0/112.1): digit = 2
Mar 15 16:35:25.863: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_begin:
Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
Source Call Id=3870, Digit=2, DigitBeginFlags=0x0,
Rtp Timestamp=0x6FDCB8, Rtp Expiration=0x0
Mar 15 16:35:25.863: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_end:
Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
Source Call Id=3870, Digit=2, Duration=100,
Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF
Mar 15 16:35:25.863: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_end:
Call Entry(Handoff Depth=0)
Mar 15 16:35:25.863: htsp_digit_ready(50/0/112.1): digit = 2
Mar 15 16:35:26.063: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_begin:
Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
Source Call Id=3870, Digit=2, DigitBeginFlags=0x0,
Rtp Timestamp=0x7059B8, Rtp Expiration=0x0
Mar 15 16:35:26.063: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_end:
Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
Source Call Id=3870, Digit=2, Duration=100,
Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF
Mar 15 16:35:26.063: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_end:
Call Entry(Handoff Depth=0)
Mar 15 16:35:26.063: htsp_digit_ready(50/0/112.1): digit = 2
Mar 15 16:35:26.263: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_begin:
Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
Source Call Id=3870, Digit=7, DigitBeginFlags=0x0,
Rtp Timestamp=0x70D6B8, Rtp Expiration=0x0
Mar 15 16:35:26.263: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_end:
Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1,
Source Call Id=3870, Digit=7, Duration=100,
Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF
Mar 15 16:35:26.263: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_digit_end:
Call Entry(Handoff Depth=0)
Mar 15 16:35:26.263: htsp_digit_ready(50/0/112.1): digit = 7
Mar 15 16:35:26.263: //3870/2B3F4E06A2B7/CCAPI/ccCallReportDigits:
(callID=0xF1E, digit_event=0x0, enable=FALSE, consume=FALSE)
Mar 15 16:35:26.263: //3870/2B3F4E06A2B7/CCAPI/ccCallReportDigits:
Enabled=TRUE, Call Id=3870
Mar 15 16:35:26.263: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_report_digits_done:
(vdbPtr=0x4E68BAA0, callID=0xF1E, disp=0, digit_event=0x0, enable=FALSE, consume=FALSE)
Mar 15 16:35:26.263: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_report_digits_done:
Enabled=TRUE, Disposition=0x0, Interface=0x4E68BAA0, Call Id=3870
Mar 15 16:35:26.263: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_report_digits_done:
Call Entry(Initial Digit Timeout=15000(ms), Inter Digit Timeout=10000(ms))
Mar 15 16:35:26.267: //3870/2B3F4E06A2B7/CCAPI/ccCallProceeding:
Progress Indication=NULL(0)
Mar 15 16:35:26.271: //3870/2B3F4E06A2B7/CCAPI/ccCallSetupRequest:
Destination=, Calling IE Present=TRUE, Mode=0,
Outgoing Dial-peer=900, Params=0x4FA494B8, Progress Indication=ORIGINATING SIDE IS NON ISDN(3)
Mar 15 16:35:26.271: //3870/2B3F4E06A2B7/CCAPI/cc_fill_tg_params:
Not a cic call
Mar 15 16:35:26.271: //3870/2B3F4E06A2B7/CCAPI/ccCallSetupRequest:
Trunk Group Select Interface Success;
Interface=0x4BEF14E0, Selected Interface=6, Selected DSL=-1
Mar 15 16:35:26.271: //3870/2B3F4E06A2B7/CCAPI/ccCheckClipClir:
In: Calling Number=0199(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Mar 15 16:35:26.271: //3870/2B3F4E06A2B7/CCAPI/ccCheckClipClir:
Out: Calling Number=0199(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Mar 15 16:35:26.271: //3870/2B3F4E06A2B7/CCAPI/ccCallSetupRequest:
Destination Pattern=0151130402227, Called Number=0151130402227, Digit Strip=TRUE
Mar 15 16:35:26.271: //3870/2B3F4E06A2B7/CCAPI/ccCallSetupRequest:
Calling Number=0199(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
Called Number=0151130402227(TON=Unknown, NPI=Unknown),
Redirect Number=, Display Info=testeeee
Account Number=, Final Destination Flag=FALSE,
Guid=2B3F4E06-8CC5-11E2-A2B7-9FA9DE67F424, Outgoing Dial-peer=900
Mar 15 16:35:26.271: //3870/2B3F4E06A2B7/CCAPI/cc_api_display_ie_subfields:
ccCallSetupRequest:
cisco-username=
----- ccCallInfo IE subfields -----
cisco-ani=0199
cisco-anitype=0
cisco-aniplan=0
cisco-anipi=0
cisco-anisi=0
dest=0151130402227
cisco-desttype=0
cisco-destplan=0
cisco-rdie=FFFFFFFF
cisco-rdn=
cisco-rdntype=0
cisco-rdnplan=0
cisco-rdnpi=0
cisco-rdnsi=0
cisco-redirectreason=0 fwd_final_type =0
final_redirectNumber =
hunt_group_timeout =0
Mar 15 16:35:26.271: //3870/2B3F4E06A2B7/CCAPI/ccIFCallSetupRequestPrivate:
Interface=0x4BEF14E0, Interface Type=6, Destination=, Mode=0x0,
Call Params(Calling Number=0199,(Calling Name=testeeee)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
Called Number=0151130402227(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
Subscriber Type Str=RegularLine, FinalDestinationFlag=FALSE, Outgoing Dial-peer=900, Call Count On=FALSE,
Source Trkgrp Route Label=, Target Trkgrp Route Label=1, tg_label_flag=2, Application Call Id=)
Mar 15 16:35:26.271: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 15 16:35:26.271: :cc_get_feature_vsa malloc success
Mar 15 16:35:26.271: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 15 16:35:26.271: cc_get_feature_vsa count is 2
Mar 15 16:35:26.271: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 15 16:35:26.271: :FEATURE_VSA attributes are: feature_name:0,feature_time:1336068608,feature_id:4986
Mar 15 16:35:26.271: //3871/2B3F4E06A2B7/CCAPI/ccIFCallSetupRequestPrivate:
SPI Call Setup Request Is Success; Interface Type=6, FlowMode=1
Mar 15 16:35:26.271: //3870/2B3F4E06A2B7/CCAPI/ccCallSetupRequest:
Trunk Group Call Setting;
Call Entry(Retry Count=0, Voice Class Cause Code=0)
Mar 15 16:35:26.271: //3871/2B3F4E06A2B7/CCAPI/ccCallSetContext:
Context=0x4FA49468
Mar 15 16:35:26.271: //3870/2B3F4E06A2B7/CCAPI/ccSaveDialpeerTag:
Outgoing Dial-peer=900
Mar 15 16:35:26.271: //3870/2B3F4E06A2B7/CCAPI/cc_api_modify_tgt_cid_call_active_record:
Target Trkgrp Route Label=1, tg_label_flag=TRUE, Call Id=0xF1E
Mar 15 16:35:26.275: htsp_timer_stop3
Mar 15 16:35:26.275: htsp_process_event: [50/0/112.1, EFXS_OFFHOOK, E_HTSP_PROCEEDING]efxs_offhook_proceeding
Mar 15 16:35:26.275: [50/0/112.1] set signal state = 0x8 timestamp = 0htsp_setup_req
Mar 15 16:35:26.279: htsp_process_event: [0/0/0:1(6), R2_Q421_IDLE, E_HTSP_SETUP_REQ]
Mar 15 16:35:26.279: r2_q421_seize(0/0/0:1(6)) E_HTSP_SETUP_REQ DNIS=0151130402227 ANI=0199
Mar 15 16:35:26.279: r2_q421_seize(0/0/0:1(6)) Tx SEIZUREvnm_dsp_set_sig_state:[R2 Q.421 0/0/0:1(6)] set signal state = 0x0
Mar 15 16:35:26.279: htsp_timer - 5000 msec
Mar 15 16:35:26.459: htsp_process_event: [0/0/0:1(6), R2_Q421_OG_SEIZE, E_DSP_SIG_1100]
Mar 15 16:35:26.459: r2_q421_seize_ack(0/0/0:1(6)) Rx SEIZE ACK
Mar 15 16:35:26.459: htsp_timer_stop
Mar 15 16:35:26.459: r2_reg_start_dialing(0/0/0:1(6))
Mar 15 16:35:26.459: r2_reg_process_event: [0/0/0:1(6), R2_REG_IDLE, E_R2_REG_START_DIAL(93)]
Mar 15 16:35:26.459: r2_reg_start_dial_delay(0/0/0:1(6)) dialout delay 200
Mar 15 16:35:26.459: r2_reg_timer(0/0/0:1(6)) 200 msec
Mar 15 16:35:26.659: r2_reg_process_event: [0/0/0:1(6), R2_REG_IDLE, E_R2_REG_EVENT_TIMER(86)]
Mar 15 16:35:26.659: r2_reg_start_dial(0/0/0:1(6))
Mar 15 16:35:26.659: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_IDLE R2 Got Event R2_START
Mar 15 16:35:26.659: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '#'
Mar 15 16:35:26.659: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '0'
Mar 15 16:35:26.659: //3871/2B3F4E06A2B7/CCAPI/cc_api_call_proceeding:
Interface=0x4BEF14E0, Progress Indication=NULL(0)
Mar 15 16:35:26.811: htsp_digit_ready_up(0/0/0:1(6)): Rx digit='5'
Mar 15 16:35:26.811: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event 5
Mar 15 16:35:26.811: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '#'
Mar 15 16:35:27.003: htsp_digit_ready(0/0/0:1(6)): Rx digit='#'
Mar 15 16:35:27.003: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:35:27.003: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '2'
Mar 15 16:35:27.011: htsp_dialing_done(0/0/0:1(6))
Mar 15 16:35:27.131: htsp_digit_ready_up(0/0/0:1(6)): Rx digit='5'
Mar 15 16:35:27.131: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event 5
Mar 15 16:35:27.131: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '#'
Mar 15 16:35:27.303: htsp_digit_ready(0/0/0:1(6)): Rx digit='#'
Mar 15 16:35:27.303: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:35:27.303: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '0'
Mar 15 16:35:27.431: htsp_digit_ready_up(0/0/0:1(6)): Rx digit='5'
Mar 15 16:35:27.435: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event 5
Mar 15 16:35:27.435: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '#'
Mar 15 16:35:27.603: htsp_digit_ready(0/0/0:1(6)): Rx digit='#'
Mar 15 16:35:27.603: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:35:27.603: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '1'
Mar 15 16:35:27.731: htsp_digit_ready_up(0/0/0:1(6)): Rx digit='5'
Mar 15 16:35:27.731: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event 5
Mar 15 16:35:27.731: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '#'
Mar 15 16:35:27.903: htsp_digit_ready(0/0/0:1(6)): Rx digit='#'
Mar 15 16:35:27.903: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:35:27.903: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '9'
Mar 15 16:35:28.031: htsp_digit_ready_up(0/0/0:1(6)): Rx digit='5'
Mar 15 16:35:28.031: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event 5
Mar 15 16:35:28.031: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '#'
Mar 15 16:35:28.239: htsp_dialing_done(0/0/0:1(6))
Mar 15 16:35:28.283: htsp_digit_ready(0/0/0:1(6)): Rx digit='#'
Mar 15 16:35:28.283: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:35:28.283: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '9'
Mar 15 16:35:28.411: htsp_digit_ready_up(0/0/0:1(6)): Rx digit='5'
Mar 15 16:35:28.411: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event 5
Mar 15 16:35:28.411: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '#'
Mar 15 16:35:28.611: htsp_dialing_done(0/0/0:1(6))
Mar 15 16:35:28.659: htsp_digit_ready(0/0/0:1(6)): Rx digit='#'
Mar 15 16:35:28.659: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:35:28.659: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '*'
Mar 15 16:35:28.783: htsp_digit_ready_up(0/0/0:1(6)): Rx digit='1'
Mar 15 16:35:28.783: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 15 16:35:28.783: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '#'
Mar 15 16:35:28.983: htsp_dialing_done(0/0/0:1(6))
Mar 15 16:35:29.023: htsp_digit_ready(0/0/0:1(6)): Rx digit='#'
Mar 15 16:35:29.023: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:35:29.023: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '1'
Mar 15 16:35:29.139: htsp_digit_ready_up(0/0/0:1(6)): Rx digit='1'
Mar 15 16:35:29.139: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 15 16:35:29.139: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '#'
Mar 15 16:35:29.339: htsp_dialing_done(0/0/0:1(6))
Mar 15 16:35:29.383: htsp_digit_ready(0/0/0:1(6)): Rx digit='#'
Mar 15 16:35:29.383: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:35:29.383: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '5'
Mar 15 16:35:29.503: htsp_digit_ready_up(0/0/0:1(6)): Rx digit='1'
Mar 15 16:35:29.503: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 15 16:35:29.503: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '#'
Mar 15 16:35:29.703: htsp_dialing_done(0/0/0:1(6))
Mar 15 16:35:29.739: htsp_digit_ready(0/0/0:1(6)): Rx digit='#'
Mar 15 16:35:29.739: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:35:29.739: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '1'
Mar 15 16:35:29.863: htsp_digit_ready_up(0/0/0:1(6)): Rx digit='1'
Mar 15 16:35:29.863: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 15 16:35:29.863: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '#'
Mar 15 16:35:30.063: htsp_dialing_done(0/0/0:1(6))
Mar 15 16:35:30.103: htsp_digit_ready(0/0/0:1(6)): Rx digit='#'
Mar 15 16:35:30.103: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:35:30.103: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '1'
Mar 15 16:35:30.219: htsp_digit_ready_up(0/0/0:1(6)): Rx digit='1'
Mar 15 16:35:30.219: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 15 16:35:30.223: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '#'
Mar 15 16:35:30.419: htsp_dialing_done(0/0/0:1(6))
Mar 15 16:35:30.463: htsp_digit_ready(0/0/0:1(6)): Rx digit='#'
Mar 15 16:35:30.463: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:35:30.463: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '3'
Mar 15 16:35:30.583: htsp_digit_ready_up(0/0/0:1(6)): Rx digit='1'
Mar 15 16:35:30.583: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 15 16:35:30.583: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '#'
Mar 15 16:35:30.759: htsp_digit_ready(0/0/0:1(6)): Rx digit='#'
Mar 15 16:35:30.763: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:35:30.763: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '0'
Mar 15 16:35:30.879: htsp_digit_ready_up(0/0/0:1(6)): Rx digit='1'
Mar 15 16:35:30.879: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 15 16:35:30.879: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '#'
Mar 15 16:35:31.063: htsp_digit_ready(0/0/0:1(6)): Rx digit='#'
Mar 15 16:35:31.063: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:35:31.063: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '4'
Mar 15 16:35:31.183: htsp_digit_ready_up(0/0/0:1(6)): Rx digit='1'
Mar 15 16:35:31.183: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 15 16:35:31.183: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '#'
Mar 15 16:35:31.359: htsp_digit_ready(0/0/0:1(6)): Rx digit='#'
Mar 15 16:35:31.359: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:35:31.359: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '0'
Mar 15 16:35:31.483: htsp_digit_ready_up(0/0/0:1(6)): Rx digit='1'
Mar 15 16:35:31.483: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 15 16:35:31.483: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '#'
Mar 15 16:35:31.683: htsp_dialing_done(0/0/0:1(6))
Mar 15 16:35:31.723: htsp_digit_ready(0/0/0:1(6)): Rx digit='#'
Mar 15 16:35:31.723: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:35:31.723: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '2'
Mar 15 16:35:31.839: htsp_digit_ready_up(0/0/0:1(6)): Rx digit='1'
Mar 15 16:35:31.843: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 15 16:35:31.843: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '#'
Mar 15 16:35:32.039: htsp_dialing_done(0/0/0:1(6))
Mar 15 16:35:32.083: htsp_digit_ready(0/0/0:1(6)): Rx digit='#'
Mar 15 16:35:32.083: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:35:32.083: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '2'
Mar 15 16:35:32.203: htsp_digit_ready_up(0/0/0:1(6)): Rx digit='1'
Mar 15 16:35:32.203: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 15 16:35:32.203: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '#'
Mar 15 16:35:32.403: htsp_dialing_done(0/0/0:1(6))
Mar 15 16:35:32.439: htsp_digit_ready(0/0/0:1(6)): Rx digit='#'
Mar 15 16:35:32.439: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:35:32.439: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '2'
Mar 15 16:35:32.563: htsp_digit_ready_up(0/0/0:1(6)): Rx digit='1'
Mar 15 16:35:32.563: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 15 16:35:32.563: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '#'
Mar 15 16:35:32.763: htsp_dialing_done(0/0/0:1(6))
Mar 15 16:35:32.803: htsp_digit_ready(0/0/0:1(6)): Rx digit='#'
Mar 15 16:35:32.803: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:35:32.803: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '7'
Mar 15 16:35:32.923: htsp_digit_ready_up(0/0/0:1(6)): Rx digit='1'
Mar 15 16:35:32.923: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 15 16:35:32.923: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '#'
Mar 15 16:35:33.119: htsp_dialing_done(0/0/0:1(6))
Mar 15 16:35:33.163: htsp_digit_ready(0/0/0:1(6)): Rx digit='#'
Mar 15 16:35:33.163: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:35:33.163: r2_restart_timer: timer interdigit outgoing = 24000 ms
Mar 15 16:35:40.243: htsp_digit_ready_up(0/0/0:1(6)): Rx digit='3'
Mar 15 16:35:40.243: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_A R2 Got Event 3
Mar 15 16:35:40.243: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '#'
Mar 15 16:35:40.399: htsp_digit_ready(0/0/0:1(6)): Rx digit='#'
Mar 15 16:35:40.399: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_B R2 Got Event R2_TONE_OFF
Mar 15 16:35:40.399: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '2'
Mar 15 16:35:40.523: htsp_digit_ready_up(0/0/0:1(6)): Rx digit='1'
Mar 15 16:35:40.523: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_PROCESS_B R2 Got Event 1
Mar 15 16:35:40.523: r2_reg_generate_digits(0/0/0:1(6)): Tx digit '#'
Mar 15 16:35:40.723: htsp_dialing_done(0/0/0:1(6))
Mar 15 16:35:40.739: htsp_digit_ready(0/0/0:1(6)): Rx digit='#'
Mar 15 16:35:40.739: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_WAIT_IDLE R2 Got Event R2_TONE_OFF
Mar 15 16:35:40.739: r2_reg_event_proc(0/0/0:1(6)) ADDR_INFO_COLLECTED (DNIS=0151130402227, ANI=0199)
Mar 15 16:35:40.739: r2_reg_end_dial(0/0/0:1(6))
Mar 15 16:35:40.743: htsp_process_event: [0/0/0:1(6), R2_Q421_OG_SEIZE_ACK, E_DSP_DIALING_DONE]
Mar 15 16:35:40.743: r2_q421_dial_done(0/0/0:1(6)) E_HTSP_RELEASE_REQ
Mar 15 16:35:40.743: r2_reg_dial_done(0/0/0:1(6))
Mar 15 16:35:40.743: r2_reg_process_event: [0/0/0:1(6), R2_REG_DIALING, E_R2_REG_ADDR_COLLECTED(89)]
Mar 15 16:35:40.743: r2_reg_addr_collected(0/0/0:1(6))
Mar 15 16:35:40.743: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_IDLE R2 Got Event R2_STOP
Mar 15 16:35:40.743: r2_reg_timer(0/0/0:1(6)) 300 msec
Mar 15 16:35:41.043: r2_reg_process_event: [0/0/0:1(6), R2_REG_DIALING, E_R2_REG_EVENT_TIMER(86)]
Mar 15 16:35:41.043: r2_reg_addr_collect_to(0/0/0:1(6))htsp_alert
Mar 15 16:35:41.043: //3871/2B3F4E06A2B7/CCAPI/cc_api_call_alert:
Interface=0x4BEF14E0, Progress Indication=INBAND(8), Signal Indication=SIGNAL RINGBACK(1)
Mar 15 16:35:41.043: //3871/2B3F4E06A2B7/CCAPI/cc_api_call_alert:
Call Entry(Retry Count=0, Responsed=TRUE)
Mar 15 16:35:41.043: //3870/2B3F4E06A2B7/CCAPI/ccCallAlert:
Progress Indication=INBAND(8), Signal Indication=SIGNAL RINGBACK(1)
Mar 15 16:35:41.043: //3870/2B3F4E06A2B7/CCAPI/ccCallAlert:
Call Entry(Responsed=TRUE, Alert Sent=TRUE)
Mar 15 16:35:41.043: //3870/2B3F4E06A2B7/CCAPI/ccConferenceCreate:
(confID=0x4FCD517C, callID1=0xF1E, gcid=2B3F4E06-8CC511E2-A2B79FA9-DE67F424, tag=0x0)
Mar 15 16:35:41.043: //3871/2B3F4E06A2B7/CCAPI/ccConferenceCreate:
(confID=0x4FCD517C, callID2=0xF1F, gcid=2B3F4E06-8CC511E2-A2B79FA9-DE67F424, tag=0x0)
Mar 15 16:35:41.043: //3870/2B3F4E06A2B7/CCAPI/ccConferenceCreate:
Conference Id=0x4FCD517C, Call Id1=3870, Call Id2=3871, Tag=0x0
Mar 15 16:35:41.043: htsp_call_bridged invoked
Mar 15 16:35:41.043: //3870/2B3F4E06A2B7/CCAPI/cc_api_bridge_done:
Conference Id=0x39D, Source Interface=0x4E68BAA0, Source Call Id=3870,
Destination Call Id=3871, Disposition=0x0, Tag=0xFFFFFFFF
Mar 15 16:35:41.043: htsp_call_bridged invoked
Mar 15 16:35:41.043: r2_reg_event_proc(0/0/0:1(6)) ALERTING RECEIVED
Mar 15 16:35:41.043: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_IDLE R2 Got Event R2_ALERTING
Mar 15 16:35:41.047: //3871/2B3F4E06A2B7/CCAPI/cc_api_bridge_done:
Conference Id=0x39D, Source Interface=0x4BEF14E0, Source Call Id=3871,
Destination Call Id=3870, Disposition=0x0, Tag=0xFFFFFFFF
Mar 15 16:35:41.047: //3870/2B3F4E06A2B7/CCAPI/cc_generic_bridge_done:
Conference Id=0x39D, Source Interface=0x4BEF14E0, Source Call Id=3871,
Destination Call Id=3870, Disposition=0x0, Tag=0xFFFFFFFF
Mar 15 16:35:41.047: //3870/2B3F4E06A2B7/CCAPI/ccConferenceCreate:
Call Entry(Conference Id=0x39D, Destination Call Id=3871)
Mar 15 16:35:41.047: //3871/2B3F4E06A2B7/CCAPI/ccConferenceCreate:
Call Entry(Conference Id=0x39D, Destination Call Id=3870)htsp_alert_notify
Mar 15 16:35:41.047: //3870/2B3F4E06A2B7/CCAPI/cc_api_caps_ind:
Destination Interface=0x4BEF14E0, Destination Call Id=3871, Source Call Id=3870,
Caps(Codec=0x1, Fax Rate=0x2, Vad=0x1,
Modem=0x2, Codec Bytes=160, Signal Type=2)
Mar 15 16:35:41.047: //3870/2B3F4E06A2B7/CCAPI/cc_api_caps_ind:
Caps(Playout Mode=1, Playout Initial=60(ms), Playout Min=40(ms),
Playout Max=1000(ms), Fax Nom=300(ms))
Mar 15 16:35:41.047: //3871/2B3F4E06A2B7/CCAPI/cc_api_caps_ind:
Destination Interface=0x4E68BAA0, Destination Call Id=3870, Source Call Id=3871,
Caps(Codec=0x1, Fax Rate=0x1, Vad=0x1,
Modem=0x2, Codec Bytes=160, Signal Type=2)
Mar 15 16:35:41.047: //3871/2B3F4E06A2B7/CCAPI/cc_api_caps_ind:
Caps(Playout Mode=1, Playout Initial=60(ms), Playout Min=40(ms),
Playout Max=1000(ms), Fax Nom=300(ms))
Mar 15 16:35:41.047: //3871/2B3F4E06A2B7/CCAPI/cc_api_caps_ack:
Destination Interface=0x4E68BAA0, Destination Call Id=3870, Source Call Id=3871,
Caps(Codec=g711ulaw(0x1), Fax Rate=FAX_RATE_VOICE(0x2), Vad=OFF(0x1),
Modem=ON(0x2), Codec Bytes=160, Signal Type=2, Seq Num Start=1110)
Mar 15 16:35:41.047: //3870/2B3F4E06A2B7/CCAPI/cc_api_caps_ack:
Destination Interface=0x4BEF14E0, Destination Call Id=3871, Source Call Id=3870,
Caps(Codec=g711ulaw(0x1), Fax Rate=FAX_RATE_NONE(0x1), Vad=OFF(0x1),
Modem=ON(0x2), Codec Bytes=160, Signal Type=2, Seq Num Start=4865)
Mar 15 16:35:41.051: //3870/2B3F4E06A2B7/CCAPI/ccCallFeature:
Feature Type=25, Call Id=3870htsp_call_feature:feature 25
htsp_call_feature: caller id enable 0x3 call_connected 0
Mar 15 16:35:41.051: htsp_process_event: [50/0/112.1, EFXS_OFFHOOK, E_HTSP_CALLERID_WAITING]
Mar 15 16:35:41.051: efxs_callerid_update
Mar 15 16:35:41.051: efxs_callerid_update process caller_id_string
Mar 15 16:35:41.051: efxs_callerid_update process caller_id_string OK
Mar 15 16:35:41.051: efxs_callerid_update number= [0151130402227] name= []
Mar 15 16:35:41.051: //3870/2B3F4E06A2B7/CCAPI/cc_process_notify_bridge_done:
Conference Id=0x39D, Call Id1=3870, Call Id2=3871
Mar 15 16:35:41.051: //3870/2B3F4E06A2B7/CCAPI/cc_api_voice_mode_event:
Call Id=3870
Mar 15 16:35:41.051: //3870/2B3F4E06A2B7/CCAPI/cc_api_voice_mode_event:
Call Entry(Context=0x4FA510E8)
Mar 15 16:35:41.055: //3871/2B3F4E06A2B7/CCAPI/cc_api_voice_mode_event:
Call Id=3871
Mar 15 16:35:41.055: //3871/2B3F4E06A2B7/CCAPI/cc_api_voice_mode_event:
Call Entry(Context=0x4FA49468)
Mar 15 16:35:41.055: htsp_process_event: [50/0/112.1, EFXS_OFFHOOK, E_HTSP_VOICE_CUT_THROUGH]efxs_offhook_cutthru
Mar 15 16:35:41.055: [50/0/112.1] set signal state = 0x7 timestamp = 0
Mar 15 16:35:41.055: htsp_process_event: [0/0/0:1(6), R2_Q421_OG_SEIZE_ACK, E_HTSP_VOICE_CUT_THROUGH]
Mar 15 16:35:46.379: htsp_process_event: [50/0/112.1, EFXS_OFFHOOK, E_DSP_SIG_0100]efxs_offhook_onhook
Mar 15 16:35:46.379: htsp_timer - 10 msec
Mar 15 16:35:46.391: htsp_process_event: [50/0/112.1, EFXS_OFFHOOK, E_HTSP_EVENT_TIMER]efxs_offhook_timer
Mar 15 16:35:46.391: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_disconnected:
Cause Value=16, Interface=0x4E68BAA0, Call Id=3870
Mar 15 16:35:46.391: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_disconnected:
Call Entry(Responsed=TRUE, Cause Value=16, Retry Count=0)
Mar 15 16:35:46.391: //3870/2B3F4E06A2B7/CCAPI/ccConferenceDestroy:
Conference Id=0x39D, Tag=0x0
Mar 15 16:35:46.391: //3870/2B3F4E06A2B7/CCAPI/cc_api_bridge_drop_done:
Conference Id=0x39D, Source Interface=0x4E68BAA0, Source Call Id=3870,
Destination Call Id=3871, Disposition=0x0, Tag=0x0
Mar 15 16:35:46.391: //3871/2B3F4E06A2B7/CCAPI/cc_api_bridge_drop_done:
Conference Id=0x39D, Source Interface=0x4BEF14E0, Source Call Id=3871,
Destination Call Id=3870, Disposition=0x0, Tag=0x0
Mar 15 16:35:46.391: //3870/2B3F4E06A2B7/CCAPI/cc_generic_bridge_done:
Conference Id=0x39D, Source Interface=0x4BEF14E0, Source Call Id=3871,
Destination Call Id=3870, Disposition=0x0, Tag=0x0
Mar 15 16:35:46.391: //3871/2B3F4E06A2B7/CCAPI/ccCallDisconnect:
Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
Mar 15 16:35:46.391: //3871/2B3F4E06A2B7/CCAPI/ccCallDisconnect:
Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
Mar 15 16:35:46.395: //3871/2B3F4E06A2B7/CCAPI/cc_api_get_transfer_info:
Transfer Number Is Null
Mar 15 16:35:46.395: htsp_timer_stop3
Mar 15 16:35:46.395: //3870/2B3F4E06A2B7/CCAPI/ccCallDisconnect:
Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=16)
Mar 15 16:35:46.395: //3870/2B3F4E06A2B7/CCAPI/ccCallDisconnect:
Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
Mar 15 16:35:46.395: //3870/2B3F4E06A2B7/CCAPI/cc_api_get_transfer_info:
Transfer Number Is Null
Mar 15 16:35:46.399: htsp_process_event: [50/0/112.1, EFXS_ONHOOK, E_HTSP_RELEASE_REQ]efxs_onhook_release
Mar 15 16:35:46.399: htsp_timer_stop
Mar 15 16:35:46.399: [50/0/112.1] set signal state = 0x4 timestamp = 0
Mar 15 16:35:46.399: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_disconnect_done:
Disposition=0, Interface=0x4E68BAA0, Tag=0x0, Call Id=3870,
Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
Mar 15 16:35:46.399: //3870/2B3F4E06A2B7/CCAPI/cc_api_call_disconnect_done:
Call Disconnect Event Sent
Mar 15 16:35:46.399: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
Mar 15 16:35:46.399: :cc_free_feature_vsa freeing 4FA2EC18
Mar 15 16:35:46.399: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
Mar 15 16:35:46.399: vsacount in free is 1
Mar 15 16:35:46.415: htsp_process_event: [0/0/0:1(6), R2_Q421_OG_SEIZE_ACK, E_HTSP_RELEASE_REQ]
Mar 15 16:35:46.415: r2_q421_clr_fwd(0/0/0:1(6)) E_HTSP_RELEASE_REQ
Mar 15 16:35:46.415: r2_reg_channel_disconnected(0/0/0:1(6))
Mar 15 16:35:46.415: r2_q421_clr_fwd(0/0/0:1(6)) Tx CLEAR FWDvnm_dsp_set_sig_state:[R2 Q.421 0/0/0:1(6)] set signal state = 0x8
Mar 15 16:35:46.415: htsp_timer - 1000 msec
Mar 15 16:35:46.415: r2_reg_process_event: [0/0/0:1(6), R2_REG_WAIT_FOR_CONNECT, E_R2_REG_DISCONNECT(91)]
Mar 15 16:35:46.415: r2_reg_disconnect_idle(0/0/0:1(6))
Mar 15 16:35:46.415: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_IDLE R2 Got Event R2_STOP
Mar 15 16:35:46.415: r2_reg_timer_stop(0/0/0:1(6))
Mar 15 16:35:46.939: htsp_process_event: [0/0/0:1(6), R2_Q421_OG_CLR_FWD, E_DSP_SIG_1000]
Mar 15 16:35:46.943: r2_q421_clr_fwd_idle(0/0/0:1(6)) Rx IDLE
Mar 15 16:35:46.943: htsp_timer_stop
Mar 15 16:35:46.943: r2_q421_clr_fwd_idle(0/0/0:1(6)) Tx IDLEvnm_dsp_set_sig_state:[R2 Q.421 0/0/0:1(6)] set signal state = 0x8
Mar 15 16:35:46.943: r2_reg_channel_disconnected(0/0/0:1(6))
Mar 15 16:35:46.943: r2_reg_process_event: [0/0/0:1(6), R2_REG_IDLE, E_R2_REG_DISCONNECT(91)]
Mar 15 16:35:46.943: r2_reg_disconnect_idle(0/0/0:1(6))
Mar 15 16:35:46.943: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:5): STATE: R2_OUT_IDLE R2 Got Event R2_STOP
Mar 15 16:35:46.943: r2_reg_timer_stop(0/0/0:1(6))
Mar 15 16:35:46.943: //3871/2B3F4E06A2B7/CCAPI/cc_api_call_disconnect_done:
Disposition=0, Interface=0x4BEF14E0, Tag=0x0, Call Id=3871,
Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
Mar 15 16:35:46.943: //3871/2B3F4E06A2B7/CCAPI/cc_api_call_disconnect_done:
tg for this call is 1 success/fail is 1
Mar 15 16:35:46.943: //3871/2B3F4E06A2B7/CCAPI/cc_api_call_disconnect_done:
Call Disconnect Event Sent
Mar 15 16:35:46.943: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
Mar 15 16:35:46.943: :cc_free_feature_vsa freeing 4FA2C9F8
Mar 15 16:35:46.943: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
Mar 15 16:35:46.943: vsacount in free is 0
Chamada vinda de um número externo para um ramal interno, que redireciona para outro número externo:
Mar 15 16:37:33.223: htsp_process_event: [0/0/0:1(3), R2_Q421_IDLE, E_DSP_SIG_0000]
Mar 15 16:37:33.227: r2_q421_ic_seize(0/0/0:1(3)) Rx SEIZURE
Mar 15 16:37:33.227: r2_reg_start_digit_collection(0/0/0:1(3))
Mar 15 16:37:33.227: r2_q421_ic_seize(0/0/0:1(3)) Tx SEIZE ACK (with 100ms delay)vnm_dsp_set_sig_state:[R2 Q.421 0/0/0:1(3)] set signal state = 0x8vnm_dsp_set_sig_state:[R2 Q.421 0/0/0:1(3)] set signal state = 0xC
Mar 15 16:37:33.227: htsp_timer - 2000 msec
Mar 15 16:37:33.227: r2_reg_process_event: [0/0/0:1(3), R2_REG_IDLE, E_R2_REG_START_COLLECTION(94)]
Mar 15 16:37:33.227: r2_reg_start_collecting(0/0/0:1(3))
Mar 15 16:37:33.227: r2_reg_timer_stop(0/0/0:1(3))
Mar 15 16:37:33.227: htsp_process_event: [0/0/0:1(3), R2_Q421_IC_SEIZE, E_HTSP_SETUP_ACK]
Mar 15 16:37:33.231: r2_q421_ic_setup(0/0/0:1(3)) E_HTSP_SETUP_ACK
Mar 15 16:37:33.231: htsp_timer_stop
Mar 15 16:37:33.231: r2_reg_offhook(0/0/0:1(3))
Mar 15 16:37:33.231: r2_reg_process_event: [0/0/0:1(3), R2_REG_COLLECTING, E_R2_REG_OFFHOOK(95)]
Mar 15 16:37:33.231: r2_reg_ic_offhook(0/0/0:1(3))
Mar 15 16:37:33.231: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_IDLE R2 Got Event R2_START
Mar 15 16:37:33.579: htsp_digit_ready_up(0/0/0:1(3)): Rx digit='4'
Mar 15 16:37:33.579: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_PRE_CALLERID R2 Got Event 4
Mar 15 16:37:33.579: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '5'
Mar 15 16:37:33.767: htsp_digit_ready(0/0/0:1(3)): Rx digit='#'
Mar 15 16:37:33.767: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_CALLERID R2 Got Event R2_TONE_OFF
Mar 15 16:37:33.767: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '#'
Mar 15 16:37:33.967: htsp_dialing_done(0/0/0:1(3))
Mar 15 16:37:34.011: htsp_digit_ready_up(0/0/0:1(3)): Rx digit='1'
Mar 15 16:37:34.011: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_CALLERID R2 Got Event 1
Mar 15 16:37:34.011: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '5'
Mar 15 16:37:34.279: htsp_digit_ready(0/0/0:1(3)): Rx digit='#'
Mar 15 16:37:34.279: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_CALLERID R2 Got Event R2_TONE_OFF
Mar 15 16:37:34.279: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '#'
Mar 15 16:37:34.539: htsp_digit_ready_up(0/0/0:1(3)): Rx digit='5'
Mar 15 16:37:34.539: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_CALLERID R2 Got Event 5
Mar 15 16:37:34.539: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '5'
Mar 15 16:37:34.691: htsp_digit_ready(0/0/0:1(3)): Rx digit='#'
Mar 15 16:37:34.691: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_CALLERID R2 Got Event R2_TONE_OFF
Mar 15 16:37:34.691: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '#'
Mar 15 16:37:34.891: htsp_digit_ready_up(0/0/0:1(3)): Rx digit='1'
Mar 15 16:37:34.891: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_CALLERID R2 Got Event 1
Mar 15 16:37:34.891: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '5'
Mar 15 16:37:35.031: htsp_digit_ready(0/0/0:1(3)): Rx digit='#'
Mar 15 16:37:35.031: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_CALLERID R2 Got Event R2_TONE_OFF
Mar 15 16:37:35.031: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '#'
Mar 15 16:37:35.187: htsp_digit_ready_up(0/0/0:1(3)): Rx digit='3'
Mar 15 16:37:35.187: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_CALLERID R2 Got Event 3
Mar 15 16:37:35.187: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '5'
Mar 15 16:37:35.371: htsp_digit_ready(0/0/0:1(3)): Rx digit='#'
Mar 15 16:37:35.371: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_CALLERID R2 Got Event R2_TONE_OFF
Mar 15 16:37:35.371: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '#'
Mar 15 16:37:35.611: htsp_digit_ready_up(0/0/0:1(3)): Rx digit='0'
Mar 15 16:37:35.611: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_CALLERID R2 Got Event 10
Mar 15 16:37:35.611: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '5'
Mar 15 16:37:35.867: htsp_digit_ready(0/0/0:1(3)): Rx digit='#'
Mar 15 16:37:35.867: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_CALLERID R2 Got Event R2_TONE_OFF
Mar 15 16:37:35.867: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '#'
Mar 15 16:37:36.119: htsp_digit_ready_up(0/0/0:1(3)): Rx digit='2'
Mar 15 16:37:36.123: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_CALLERID R2 Got Event 2
Mar 15 16:37:36.123: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '5'
Mar 15 16:37:36.403: htsp_digit_ready(0/0/0:1(3)): Rx digit='#'
Mar 15 16:37:36.403: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_CALLERID R2 Got Event R2_TONE_OFF
Mar 15 16:37:36.403: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '#'
Mar 15 16:37:36.659: htsp_digit_ready_up(0/0/0:1(3)): Rx digit='4'
Mar 15 16:37:36.663: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_CALLERID R2 Got Event 4
Mar 15 16:37:36.663: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '5'
Mar 15 16:37:36.931: htsp_digit_ready(0/0/0:1(3)): Rx digit='#'
Mar 15 16:37:36.931: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_CALLERID R2 Got Event R2_TONE_OFF
Mar 15 16:37:36.931: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '#'
Mar 15 16:37:37.171: htsp_digit_ready_up(0/0/0:1(3)): Rx digit='1'
Mar 15 16:37:37.171: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_CALLERID R2 Got Event 1
Mar 15 16:37:37.171: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '5'
Mar 15 16:37:37.439: htsp_digit_ready(0/0/0:1(3)): Rx digit='#'
Mar 15 16:37:37.439: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_CALLERID R2 Got Event R2_TONE_OFF
Mar 15 16:37:37.439: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '#'
Mar 15 16:37:37.699: htsp_digit_ready_up(0/0/0:1(3)): Rx digit='7'
Mar 15 16:37:37.699: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_CALLERID R2 Got Event 7
Mar 15 16:37:37.699: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '5'
Mar 15 16:37:37.979: htsp_digit_ready(0/0/0:1(3)): Rx digit='#'
Mar 15 16:37:37.979: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_CALLERID R2 Got Event R2_TONE_OFF
Mar 15 16:37:37.979: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '#'
Mar 15 16:37:38.239: htsp_digit_ready_up(0/0/0:1(3)): Rx digit='5'
Mar 15 16:37:38.239: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_CALLERID R2 Got Event 5
Mar 15 16:37:38.239: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '5'
Mar 15 16:37:38.519: htsp_digit_ready(0/0/0:1(3)): Rx digit='#'
Mar 15 16:37:38.519: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_CALLERID R2 Got Event R2_TONE_OFF
Mar 15 16:37:38.519: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '#'
Mar 15 16:37:38.779: htsp_digit_ready_up(0/0/0:1(3)): Rx digit='2'
Mar 15 16:37:38.779: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_CALLERID R2 Got Event 2
Mar 15 16:37:38.779: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '5'
Mar 15 16:37:38.911: htsp_digit_ready(0/0/0:1(3)): Rx digit='#'
Mar 15 16:37:38.911: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_CALLERID R2 Got Event R2_TONE_OFF
Mar 15 16:37:38.911: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '#'
Mar 15 16:37:39.091: htsp_digit_ready_up(0/0/0:1(3)): Rx digit='*'
Mar 15 16:37:39.091: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_CALLERID R2 Got Event 15
Mar 15 16:37:39.091: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '1'
Mar 15 16:37:39.359: htsp_digit_ready(0/0/0:1(3)): Rx digit='#'
Mar 15 16:37:39.359: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_COLLECT_DNIS R2 Got Event R2_TONE_OFF
Mar 15 16:37:39.359: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '#'
Mar 15 16:37:39.619: htsp_digit_ready_up(0/0/0:1(3)): Rx digit='5'
Mar 15 16:37:39.619: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_COLLECT_DNIS R2 Got Event 5
Mar 15 16:37:39.619: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '1'
Mar 15 16:37:39.899: htsp_digit_ready(0/0/0:1(3)): Rx digit='#'
Mar 15 16:37:39.899: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_COLLECT_DNIS R2 Got Event R2_TONE_OFF
Mar 15 16:37:39.899: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '#'
Mar 15 16:37:40.147: htsp_digit_ready_up(0/0/0:1(3)): Rx digit='0'
Mar 15 16:37:40.147: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_COLLECT_DNIS R2 Got Event 10
Mar 15 16:37:40.147: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '1'
Mar 15 16:37:40.311: htsp_digit_ready(0/0/0:1(3)): Rx digit='#'
Mar 15 16:37:40.311: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_COLLECT_DNIS R2 Got Event R2_TONE_OFF
Mar 15 16:37:40.311: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '#'
Mar 15 16:37:40.519: htsp_digit_ready_up(0/0/0:1(3)): Rx digit='5'
Mar 15 16:37:40.519: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_COLLECT_DNIS R2 Got Event 5
Mar 15 16:37:40.519: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '1'
Mar 15 16:37:40.799: htsp_digit_ready(0/0/0:1(3)): Rx digit='#'
Mar 15 16:37:40.803: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_COLLECT_DNIS R2 Got Event R2_TONE_OFF
Mar 15 16:37:40.803: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '#'
Mar 15 16:37:43.519: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_COLLECT_DNIS R2 Got Event R2_TONE_TIMER
Mar 15 16:37:43.519: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '3#'
Mar 15 16:37:43.767: htsp_digit_ready_up(0/0/0:1(3)): Rx digit='1'
Mar 15 16:37:43.767: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_CATEGORY R2 Got Event 1
Mar 15 16:37:43.767: Enter r2_comp_category
Mar 15 16:37:43.767: R2 Event : 1
Mar 15 16:37:43.767: ####### collect_call_enable = 0
Mar 15 16:37:43.767: ######## Not Sending B7 ##################
Mar 15 16:37:43.767: r2_reg_event_proc(0/0/0:1(3)) ADDR_INFO_COLLECTED (DNIS=4505, ANI=5130241752)
Mar 15 16:37:43.771: r2_reg_process_event: [0/0/0:1(3), R2_REG_COLLECTING, E_R2_REG_ADDR_COLLECTED(89)]
Mar 15 16:37:43.771: r2_reg_ic_addr_collected(0/0/0:1(3))htsp_switch_ind
Mar 15 16:37:43.771: //-1/7EC34EF0A2CA/CCAPI/cc_api_display_ie_subfields:
cc_api_call_setup_ind_common:
cisco-username=
----- ccCallInfo IE subfields -----
cisco-ani=5130241752
cisco-anitype=0
cisco-aniplan=1
cisco-anipi=0
cisco-anisi=0
dest=4505
cisco-desttype=0
cisco-destplan=0
cisco-rdie=FFFFFFFF
cisco-rdn=
cisco-rdntype=0
cisco-rdnplan=0
cisco-rdnpi=0
cisco-rdnsi=0
cisco-redirectreason=0 fwd_final_type =0
final_redirectNumber =
hunt_group_timeout =0
Mar 15 16:37:43.771: //-1/7EC34EF0A2CA/CCAPI/cc_api_call_setup_ind_common:
Interface=0x4BEF14E0, Call Info(
Calling Number=5130241752,(Calling Name=)(TON=Unknown, NPI=ISDN, Screening=Not Screened, Presentation=Allowed),
Called Number=4505(TON=Unknown, NPI=Unknown),
Calling Translated=FALSE, Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE,
Incoming Dial-peer=501, Progress Indication=ORIGINATING SIDE IS NON ISDN(3), Calling IE Present=TRUE,
Source Trkgrp Route Label=1, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=-1
Sub Calling(TON=Network, NPI=Unknown, Data=7, Length=49)
Sub Called(TON=Subscriber, NPI=Unknown, DataKy&,J@>o@<
, Length=14)
Mar 15 16:37:43.771: //-1/7EC34EF0A2CA/CCAPI/ccCheckClipClir:
In: Calling Number=5130241752(TON=Unknown, NPI=ISDN, Screening=Not Screened, Presentation=Allowed)
Mar 15 16:37:43.771: //-1/7EC34EF0A2CA/CCAPI/ccCheckClipClir:
Out: Calling Number=5130241752(TON=Unknown, NPI=ISDN, Screening=Not Screened, Presentation=Allowed)
Mar 15 16:37:43.771: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 15 16:37:43.771: :cc_get_feature_vsa malloc success
Mar 15 16:37:43.771: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 15 16:37:43.771: cc_get_feature_vsa count is 1
Mar 15 16:37:43.771: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 15 16:37:43.771: :FEATURE_VSA attributes are: feature_name:0,feature_time:1336068608,feature_id:4993
Mar 15 16:37:43.771: //3876/7EC34EF0A2CA/CCAPI/cc_api_call_setup_ind_common:
Set Up Event Sent;
Call Info(Calling Number=5130241752(TON=Unknown, NPI=ISDN, Screening=Not Screened, Presentation=Allowed),
Called Number=4505(TON=Unknown, NPI=Unknown))
Mar 15 16:37:43.775: htsp_process_event: [0/0/0:1(3), R2_Q421_IC_WAIT_ANSWER, E_HTSP_SETUP_ACK]
Mar 15 16:37:43.775: r2_q421_ic_setup_ack(0/0/0:1(3)) E_HTSP_SETUP_ACK
Mar 15 16:37:43.775: r2_reg_switch(0/0/0:1(3))
Mar 15 16:37:43.775: //3876/7EC34EF0A2CA/CCAPI/cc_process_call_setup_ind:
Event=0x4B664B70
Mar 15 16:37:43.775: //-1/xxxxxxxxxxxx/CCAPI/cc_setupind_match_search:
Try with the demoted called number 4505
Mar 15 16:37:43.775: htsp_process_event: [0/0/0:1(3), R2_Q421_IC_WAIT_ANSWER, E_DSP_SIG_0000]
Mar 15 16:37:43.775: //3876/7EC34EF0A2CA/CCAPI/ccCallSetContext:
Context=0x4FA5A228
Mar 15 16:37:43.775: //3876/7EC34EF0A2CA/CCAPI/cc_process_call_setup_ind:
>>>>CCAPI handed cid 3876 with tag 501 to app "_ManagedAppProcess_Default"
Mar 15 16:37:43.775: r2_reg_process_event: [0/0/0:1(3), R2_REG_WAIT_FOR_SWITCH, E_R2_REG_SWITCH(96)]
Mar 15 16:37:43.775: r2_reg_ic_switched(0/0/0:1(3))
Mar 15 16:37:43.779: //3876/7EC34EF0A2CA/CCAPI/ccCallProceeding:
Progress Indication=NULL(0)
Mar 15 16:37:43.779: //-1/xxxxxxxxxxxx/CCAPI/ccUpdateRedirectingNumber:
type=6 redirecting_number=4505
Mar 15 16:37:43.783: //-1/xxxxxxxxxxxx/CCAPI/ccUpdateRedirectNumber:
type=6 Original Called Number=4505, Called Number=4505, Calling Number=5130241752, Calling DN=4 Calling Id=3876,
Redirect Number=0151130402227, Redirect Reason=15
Mar 15 16:37:43.783: //-1/xxxxxxxxxxxx/CCAPI/ccUpdateRedirectingNumber:
type=6 redirecting_number=4505
Mar 15 16:37:43.783: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 15 16:37:43.783: :cc_get_feature_vsa malloc success
Mar 15 16:37:43.783: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 15 16:37:43.783: cc_get_feature_vsa count is 2
Mar 15 16:37:43.783: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 15 16:37:43.783: :FEATURE_VSA attributes are: feature_name:0,feature_time:1336073984,feature_id:4994
Mar 15 16:37:43.783: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:
Mar 15 16:37:43.783: feature_vsa is 4FA2C9F8,featname is 0
Mar 15 16:37:43.783: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 15 16:37:43.783: :cc_get_feature_vsa malloc success
Mar 15 16:37:43.783: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 15 16:37:43.783: cc_get_feature_vsa count is 3
Mar 15 16:37:43.783: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 15 16:37:43.783: :FEATURE_VSA attributes are: feature_name:0,feature_time:1336077344,feature_id:4995
Mar 15 16:37:43.783: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:
Mar 15 16:37:43.783: : Generating new featurevsa,inserting it
Mar 15 16:37:43.783: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:
Mar 15 16:37:43.783: feature call forward featname is 1
Mar 15 16:37:43.783: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
Mar 15 16:37:43.783: :cc_free_feature_vsa freeing 4FA2DEF8
Mar 15 16:37:43.783: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
Mar 15 16:37:43.783: vsacount in free is 2
Mar 15 16:37:43.787: htsp_process_event: [0/0/0:1(3), R2_Q421_IC_WAIT_ANSWER, E_HTSP_PROCEEDING]
Mar 15 16:37:43.787: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 15 16:37:43.787: :cc_get_feature_vsa malloc success
Mar 15 16:37:43.787: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 15 16:37:43.787: cc_get_feature_vsa count is 3
Mar 15 16:37:43.787: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 15 16:37:43.787: :FEATURE_VSA attributes are: feature_name:0,feature_time:1336073984,feature_id:4996
Mar 15 16:37:43.787: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:
Mar 15 16:37:43.787: feature call forward featname is 1
Mar 15 16:37:43.787: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
Mar 15 16:37:43.787: :cc_free_feature_vsa freeing 4FA2DEF8
Mar 15 16:37:43.787: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
Mar 15 16:37:43.787: vsacount in free is 2
Mar 15 16:37:43.787: //-1/xxxxxxxxxxxx/CCAPI/ccUpdateCallingNumber:
(calling_number=4505$,peer_tag=20131
Mar 15 16:37:43.791: //3876/7EC34EF0A2CA/CCAPI/ccCallSetupRequest:
Destination=, Calling IE Present=TRUE, Mode=0,
Outgoing Dial-peer=900, Params=0x4FA4BE38, Progress Indication=ORIGINATING SIDE IS NON ISDN(3)
Mar 15 16:37:43.791: //3876/7EC34EF0A2CA/CCAPI/cc_fill_tg_params:
Not a cic call
Mar 15 16:37:43.791: //3876/7EC34EF0A2CA/CCAPI/ccCallSetupRequest:
Trunk Group Select Interface Success;
Interface=0x4BEF14E0, Selected Interface=8, Selected DSL=-1
Mar 15 16:37:43.791: //3876/7EC34EF0A2CA/CCAPI/ccCheckClipClir:
In: Calling Number=4505(TON=Unknown, NPI=ISDN, Screening=Not Screened, Presentation=Allowed)
Mar 15 16:37:43.791: //3876/7EC34EF0A2CA/CCAPI/ccCheckClipClir:
Out: Calling Number=4505(TON=Unknown, NPI=ISDN, Screening=Not Screened, Presentation=Allowed)
Mar 15 16:37:43.791: //3876/7EC34EF0A2CA/CCAPI/ccCallSetupRequest:
Destination Pattern=0151130402227, Called Number=0151130402227, Digit Strip=TRUE
Mar 15 16:37:43.791: //3876/7EC34EF0A2CA/CCAPI/ccCallSetupRequest:
Calling Number=4505(TON=Unknown, NPI=ISDN, Screening=Not Screened, Presentation=Allowed),
Called Number=0151130402227(TON=Unknown, NPI=Unknown),
Redirect Number=4505, Display Info=
Account Number=, Final Destination Flag=TRUE,
Guid=7EC5C028-8CC5-11E2-A2CE-9FA9DE67F424, Outgoing Dial-peer=900
Mar 15 16:37:43.791: //3876/7EC34EF0A2CA/CCAPI/cc_api_display_ie_subfields:
ccCallSetupRequest:
cisco-username=
----- ccCallInfo IE subfields -----
cisco-ani=4505
cisco-anitype=0
cisco-aniplan=1
cisco-anipi=0
cisco-anisi=0
dest=0151130402227
cisco-desttype=0
cisco-destplan=0
cisco-rdie=73
cisco-rdn=4505
cisco-rdntype=0
cisco-rdnplan=0
cisco-rdnpi=0
cisco-rdnsi=0
cisco-redirectreason=15 fwd_final_type =0
final_redirectNumber =
hunt_group_timeout =0
Mar 15 16:37:43.791: //3876/7EC34EF0A2CA/CCAPI/ccIFCallSetupRequestPrivate:
Interface=0x4BEF14E0, Interface Type=6, Destination=, Mode=0x0,
Call Params(Calling Number=4505,(Calling Name=)(TON=Unknown, NPI=ISDN, Screening=Not Screened, Presentation=Allowed),
Called Number=0151130402227(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
Subscriber Type Str=Unknown, FinalDestinationFlag=TRUE, Outgoing Dial-peer=900, Call Count On=FALSE,
Source Trkgrp Route Label=1, Target Trkgrp Route Label=1, tg_label_flag=2, Application Call Id=)
Mar 15 16:37:43.791: //3876/7EC34EF0A2CA/CCAPI/ccIFCallSetupRequestPrivate:
Sub Calling(TON=Network, NPI=Unknown, Data=7, Length=49)
Mar 15 16:37:43.791: //3876/7EC34EF0A2CA/CCAPI/ccIFCallSetupRequestPrivate:
Sub Called(TON=Subscriber, NPI=Unknown, DataKy&,J@>o@<
, Length=14)
Mar 15 16:37:43.791: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 15 16:37:43.791: :cc_get_feature_vsa malloc success
Mar 15 16:37:43.791: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 15 16:37:43.791: cc_get_feature_vsa count is 3
Mar 15 16:37:43.791: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 15 16:37:43.791: :FEATURE_VSA attributes are: feature_name:0,feature_time:1336073984,feature_id:4997
Mar 15 16:37:43.791: //3877/7EC34EF0A2CA/CCAPI/ccIFCallSetupRequestPrivate:
SPI Call Setup Request Is Success; Interface Type=6, FlowMode=1
Mar 15 16:37:43.791: //3876/7EC34EF0A2CA/CCAPI/ccCallSetupRequest:
Trunk Group Call Setting;
Call Entry(Retry Count=0, Voice Class Cause Code=0)
Mar 15 16:37:43.791: //3877/7EC34EF0A2CA/CCAPI/ccCallSetContext:
Context=0x4FA4BDE8
Mar 15 16:37:43.791: //3876/7EC34EF0A2CA/CCAPI/ccSaveDialpeerTag:
Outgoing Dial-peer=900
Mar 15 16:37:43.791: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:
Mar 15 16:37:43.791: feature call forward featname is 1
Mar 15 16:37:43.791: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:
Mar 15 16:37:43.791: feature_vsa is 4FA2DEF8,featname is 0
Mar 15 16:37:43.791: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 15 16:37:43.791: :cc_get_feature_vsa malloc success
Mar 15 16:37:43.791: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 15 16:37:43.791: cc_get_feature_vsa count is 4
Mar 15 16:37:43.791: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
Mar 15 16:37:43.791: :FEATURE_VSA attributes are: feature_name:0,feature_time:1336070400,feature_id:4998
Mar 15 16:37:43.791: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:
Mar 15 16:37:43.791: : Generating new featurevsa,inserting it
Mar 15 16:37:43.791: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa:
Mar 15 16:37:43.791: feature call forward featname is 1
Mar 15 16:37:43.795: //3876/7EC34EF0A2CA/CCAPI/cc_api_modify_tgt_cid_call_active_record:
Target Trkgrp Route Label=1, tg_label_flag=TRUE, Call Id=0xF24
Mar 15 16:37:43.795: htsp_timer_stop3 htsp_setup_req
Mar 15 16:37:43.795: htsp_process_event: [0/0/0:1(8), R2_Q421_IDLE, E_HTSP_SETUP_REQ]
Mar 15 16:37:43.795: r2_q421_seize(0/0/0:1(8)) E_HTSP_SETUP_REQ DNIS=0151130402227 ANI=4505
Mar 15 16:37:43.795: r2_q421_seize(0/0/0:1(8)) Tx SEIZUREvnm_dsp_set_sig_state:[R2 Q.421 0/0/0:1(8)] set signal state = 0x0
Mar 15 16:37:43.795: htsp_timer - 5000 msec
Mar 15 16:37:43.979: htsp_process_event: [0/0/0:1(8), R2_Q421_OG_SEIZE, E_DSP_SIG_1100]
Mar 15 16:37:43.979: r2_q421_seize_ack(0/0/0:1(8)) Rx SEIZE ACK
Mar 15 16:37:43.979: htsp_timer_stop
Mar 15 16:37:43.979: r2_reg_start_dialing(0/0/0:1(8))
Mar 15 16:37:43.979: r2_reg_process_event: [0/0/0:1(8), R2_REG_IDLE, E_R2_REG_START_DIAL(93)]
Mar 15 16:37:43.979: r2_reg_start_dial_delay(0/0/0:1(8)) dialout delay 200
Mar 15 16:37:43.979: r2_reg_timer(0/0/0:1(8)) 200 msec
Mar 15 16:37:44.179: r2_reg_process_event: [0/0/0:1(8), R2_REG_IDLE, E_R2_REG_EVENT_TIMER(86)]
Mar 15 16:37:44.179: r2_reg_start_dial(0/0/0:1(8))
Mar 15 16:37:44.179: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_IDLE R2 Got Event R2_START
Mar 15 16:37:44.179: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '#'
Mar 15 16:37:44.179: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '0'
Mar 15 16:37:44.179: //3877/7EC34EF0A2CA/CCAPI/cc_api_call_proceeding:
Interface=0x4BEF14E0, Progress Indication=NULL(0)
Mar 15 16:37:44.343: htsp_digit_ready_up(0/0/0:1(8)): Rx digit='5'
Mar 15 16:37:44.343: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event 5
Mar 15 16:37:44.343: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '#'
Mar 15 16:37:44.543: htsp_dialing_done(0/0/0:1(8))
Mar 15 16:37:44.551: htsp_digit_ready(0/0/0:1(8)): Rx digit='#'
Mar 15 16:37:44.551: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:37:44.551: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '2'
Mar 15 16:37:44.679: htsp_digit_ready_up(0/0/0:1(8)): Rx digit='5'
Mar 15 16:37:44.679: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event 5
Mar 15 16:37:44.679: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '#'
Mar 15 16:37:44.851: htsp_digit_ready(0/0/0:1(8)): Rx digit='#'
Mar 15 16:37:44.851: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:37:44.851: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '4'
Mar 15 16:37:44.983: htsp_digit_ready_up(0/0/0:1(8)): Rx digit='5'
Mar 15 16:37:44.983: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event 5
Mar 15 16:37:44.983: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '#'
Mar 15 16:37:45.155: htsp_digit_ready(0/0/0:1(8)): Rx digit='#'
Mar 15 16:37:45.155: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:37:45.155: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '5'
Mar 15 16:37:45.283: htsp_digit_ready_up(0/0/0:1(8)): Rx digit='5'
Mar 15 16:37:45.283: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event 5
Mar 15 16:37:45.283: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '#'
Mar 15 16:37:45.451: htsp_digit_ready(0/0/0:1(8)): Rx digit='#'
Mar 15 16:37:45.451: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:37:45.451: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '0'
Mar 15 16:37:45.583: htsp_digit_ready_up(0/0/0:1(8)): Rx digit='5'
Mar 15 16:37:45.583: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event 5
Mar 15 16:37:45.583: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '#'
Mar 15 16:37:45.779: htsp_dialing_done(0/0/0:1(8))
Mar 15 16:37:45.831: htsp_digit_ready(0/0/0:1(8)): Rx digit='#'
Mar 15 16:37:45.831: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:37:45.831: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '5'
Mar 15 16:37:45.963: htsp_digit_ready_up(0/0/0:1(8)): Rx digit='5'
Mar 15 16:37:45.963: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event 5
Mar 15 16:37:45.963: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '#'
Mar 15 16:37:46.163: htsp_dialing_done(0/0/0:1(8))
Mar 15 16:37:46.211: htsp_digit_ready(0/0/0:1(8)): Rx digit='#'
Mar 15 16:37:46.211: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:37:46.211: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '*'
Mar 15 16:37:46.331: htsp_digit_ready_up(0/0/0:1(8)): Rx digit='1'
Mar 15 16:37:46.331: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 15 16:37:46.331: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '#'
Mar 15 16:37:46.531: htsp_dialing_done(0/0/0:1(8))
Mar 15 16:37:46.591: htsp_digit_ready(0/0/0:1(8)): Rx digit='#'
Mar 15 16:37:46.591: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:37:46.591: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '1'
Mar 15 16:37:46.711: htsp_digit_ready_up(0/0/0:1(8)): Rx digit='1'
Mar 15 16:37:46.711: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 15 16:37:46.711: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '#'
Mar 15 16:37:46.911: htsp_dialing_done(0/0/0:1(8))
Mar 15 16:37:46.975: htsp_digit_ready(0/0/0:1(8)): Rx digit='#'
Mar 15 16:37:46.975: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:37:46.975: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '5'
Mar 15 16:37:47.091: htsp_digit_ready_up(0/0/0:1(8)): Rx digit='1'
Mar 15 16:37:47.091: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 15 16:37:47.091: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '#'
Mar 15 16:37:47.291: htsp_dialing_done(0/0/0:1(8))
Mar 15 16:37:47.351: htsp_digit_ready(0/0/0:1(8)): Rx digit='#'
Mar 15 16:37:47.351: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:37:47.351: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '1'
Mar 15 16:37:47.471: htsp_digit_ready_up(0/0/0:1(8)): Rx digit='1'
Mar 15 16:37:47.471: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 15 16:37:47.471: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '#'
Mar 15 16:37:47.671: htsp_dialing_done(0/0/0:1(8))
Mar 15 16:37:47.731: htsp_digit_ready(0/0/0:1(8)): Rx digit='#'
Mar 15 16:37:47.731: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:37:47.731: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '1'
Mar 15 16:37:47.855: htsp_digit_ready_up(0/0/0:1(8)): Rx digit='1'
Mar 15 16:37:47.855: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 15 16:37:47.855: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '#'
Mar 15 16:37:48.055: htsp_dialing_done(0/0/0:1(8))
Mar 15 16:37:48.111: htsp_digit_ready(0/0/0:1(8)): Rx digit='#'
Mar 15 16:37:48.111: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:37:48.111: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '3'
Mar 15 16:37:48.231: htsp_digit_ready_up(0/0/0:1(8)): Rx digit='1'
Mar 15 16:37:48.231: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 15 16:37:48.231: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '#'
Mar 15 16:37:48.431: htsp_dialing_done(0/0/0:1(8))
Mar 15 16:37:48.491: htsp_digit_ready(0/0/0:1(8)): Rx digit='#'
Mar 15 16:37:48.491: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:37:48.491: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '0'
Mar 15 16:37:48.611: htsp_digit_ready_up(0/0/0:1(8)): Rx digit='1'
Mar 15 16:37:48.611: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 15 16:37:48.611: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '#'
Mar 15 16:37:48.811: htsp_dialing_done(0/0/0:1(8))
Mar 15 16:37:48.871: htsp_digit_ready(0/0/0:1(8)): Rx digit='#'
Mar 15 16:37:48.871: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:37:48.871: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '4'
Mar 15 16:37:48.991: htsp_digit_ready_up(0/0/0:1(8)): Rx digit='1'
Mar 15 16:37:48.991: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 15 16:37:48.995: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '#'
Mar 15 16:37:49.191: htsp_dialing_done(0/0/0:1(8))
Mar 15 16:37:49.275: htsp_digit_ready(0/0/0:1(8)): Rx digit='#'
Mar 15 16:37:49.275: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:37:49.275: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '0'
Mar 15 16:37:49.391: htsp_digit_ready_up(0/0/0:1(8)): Rx digit='1'
Mar 15 16:37:49.391: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 15 16:37:49.391: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '#'
Mar 15 16:37:49.591: htsp_dialing_done(0/0/0:1(8))
Mar 15 16:37:49.651: htsp_digit_ready(0/0/0:1(8)): Rx digit='#'
Mar 15 16:37:49.651: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:37:49.651: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '2'
Mar 15 16:37:49.771: htsp_digit_ready_up(0/0/0:1(8)): Rx digit='1'
Mar 15 16:37:49.771: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 15 16:37:49.771: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '#'
Mar 15 16:37:49.971: htsp_dialing_done(0/0/0:1(8))
Mar 15 16:37:50.031: htsp_digit_ready(0/0/0:1(8)): Rx digit='#'
Mar 15 16:37:50.031: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:37:50.031: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '2'
Mar 15 16:37:50.151: htsp_digit_ready_up(0/0/0:1(8)): Rx digit='1'
Mar 15 16:37:50.151: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 15 16:37:50.151: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '#'
Mar 15 16:37:50.355: htsp_dialing_done(0/0/0:1(8))
Mar 15 16:37:50.415: htsp_digit_ready(0/0/0:1(8)): Rx digit='#'
Mar 15 16:37:50.415: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event R2_TONE_OFF
Mar 15 16:37:50.415: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '2'
Mar 15 16:37:50.531: htsp_digit_ready_up(0/0/0:1(8)): Rx digit='1'
Mar 15 16:37:50.531: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event 1
Mar 15 16:37:50.531: r2_reg_generate_digits(0/0/0:1(8)): Tx digit '#'
Mar 15 16:37:50.731: htsp_dialing_done(0/0/0:1(8))
Mar 15 16:37:50.779: htsp_process_event: [0/0/0:1(3), R2_Q421_IC_WAIT_ANSWER, E_DSP_SIG_1000]
Mar 15 16:37:50.783: r2_q421_ic_clr_fwd_idle(0/0/0:1(3)) Rx CLEAR FWD
Mar 15 16:37:50.783: r2_reg_channel_disconnected(0/0/0:1(3))
Mar 15 16:37:50.783: htsp_timer - 2000 msec
Mar 15 16:37:50.783: //3876/7EC34EF0A2CA/CCAPI/cc_api_call_disconnected:
Cause Value=16, Interface=0x4BEF14E0, Call Id=3876
Mar 15 16:37:50.783: //3876/7EC34EF0A2CA/CCAPI/cc_api_call_disconnected:
Call Entry(Responsed=FALSE, Cause Value=16, Retry Count=0)
Mar 15 16:37:50.783: r2_reg_process_event: [0/0/0:1(3), R2_REG_WAIT_FOR_CONNECT, E_R2_REG_DISCONNECT(91)]
Mar 15 16:37:50.783: r2_reg_disconnect_idle(0/0/0:1(3))
Mar 15 16:37:50.783: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_WAIT_REMOTE_ALERT R2 Got Event R2_STOP
Mar 15 16:37:50.783: r2_reg_generate_digits(0/0/0:1(3)): Tx digit '#'
Mar 15 16:37:50.783: r2_reg_timer_stop(0/0/0:1(3))
Mar 15 16:37:50.783: //3877/7EC34EF0A2CA/CCAPI/ccCallDisconnect:
Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
Mar 15 16:37:50.783: //3877/7EC34EF0A2CA/CCAPI/ccCallDisconnect:
Cause Value=16, Call Entry(Responsed=FALSE, Cause Value=16)
Mar 15 16:37:50.783: //3877/7EC34EF0A2CA/CCAPI/cc_api_get_transfer_info:
Transfer Number Is Null
Mar 15 16:37:50.783: htsp_timer_stop3
Mar 15 16:37:50.783: htsp_process_event: [0/0/0:1(8), R2_Q421_OG_SEIZE_ACK, E_DSP_DIALING_DONE]
Mar 15 16:37:50.783: r2_q421_dial_done(0/0/0:1(8)) E_HTSP_RELEASE_REQ
Mar 15 16:37:50.783: r2_reg_dial_done(0/0/0:1(8))
Mar 15 16:37:50.787: //3876/7EC34EF0A2CA/CCAPI/ccCallDisconnect:
Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=16)
Mar 15 16:37:50.787: //3876/7EC34EF0A2CA/CCAPI/ccCallDisconnect:
Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
Mar 15 16:37:50.787: //3876/7EC34EF0A2CA/CCAPI/cc_api_get_transfer_info:
Transfer Number Is Null
Mar 15 16:37:50.787: htsp_process_event: [0/0/0:1(8), R2_Q421_OG_SEIZE_ACK, E_HTSP_RELEASE_REQ]
Mar 15 16:37:50.787: r2_q421_clr_fwd(0/0/0:1(8)) E_HTSP_RELEASE_REQ
Mar 15 16:37:50.787: r2_reg_channel_disconnected(0/0/0:1(8))
Mar 15 16:37:50.787: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_PROCESS_A R2 Got Event R2_STOP
Mar 15 16:37:50.787: r2_q421_clr_fwd(0/0/0:1(8)) Tx CLEAR FWDvnm_dsp_set_sig_state:[R2 Q.421 0/0/0:1(8)] set signal state = 0x8
Mar 15 16:37:50.787: htsp_timer - 1000 msec
Mar 15 16:37:50.787: r2_reg_process_event: [0/0/0:1(8), R2_REG_DIALING, E_R2_REG_DISCONNECT(91)]
Mar 15 16:37:50.787: r2_reg_disconnect_dial(0/0/0:1(8))
Mar 15 16:37:50.787: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_IDLE R2 Got Event R2_STOP
Mar 15 16:37:50.787: r2_reg_timer_stop(0/0/0:1(8))
Mar 15 16:37:50.787: htsp_process_event: [0/0/0:1(3), R2_Q421_IC_CLR_FWD, E_HTSP_RELEASE_REQ]
Mar 15 16:37:50.787: r2_q421_null_release(0/0/0:1(3)) E_HTSP_RELEASE_REQ
Mar 15 16:37:51.231: htsp_process_event: [0/0/0:1(8), R2_Q421_OG_CLR_FWD, E_DSP_SIG_1000]
Mar 15 16:37:51.231: r2_q421_clr_fwd_idle(0/0/0:1(8)) Rx IDLE
Mar 15 16:37:51.231: htsp_timer_stop
Mar 15 16:37:51.231: r2_q421_clr_fwd_idle(0/0/0:1(8)) Tx IDLEvnm_dsp_set_sig_state:[R2 Q.421 0/0/0:1(8)] set signal state = 0x8
Mar 15 16:37:51.231: r2_reg_channel_disconnected(0/0/0:1(8))
Mar 15 16:37:51.231: r2_reg_process_event: [0/0/0:1(8), R2_REG_IDLE, E_R2_REG_DISCONNECT(91)]
Mar 15 16:37:51.231: r2_reg_disconnect_idle(0/0/0:1(8))
Mar 15 16:37:51.231: R2 Outgoing Voice(0/0): DSX (E1 0/0/0:7): STATE: R2_OUT_IDLE R2 Got Event R2_STOP
Mar 15 16:37:51.231: r2_reg_timer_stop(0/0/0:1(8))
Mar 15 16:37:51.231: //3877/7EC34EF0A2CA/CCAPI/cc_api_call_disconnect_done:
Disposition=0, Interface=0x4BEF14E0, Tag=0x0, Call Id=3877,
Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
Mar 15 16:37:51.235: //3877/7EC34EF0A2CA/CCAPI/cc_api_call_disconnect_done:
tg for this call is 1 success/fail is 1
Mar 15 16:37:51.235: //3877/7EC34EF0A2CA/CCAPI/cc_api_call_disconnect_done:
Call Disconnect Event Sent
Mar 15 16:37:51.235: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
Mar 15 16:37:51.235: :cc_free_feature_vsa freeing 4FA2D0F8
Mar 15 16:37:51.235: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
Mar 15 16:37:51.235: vsacount in free is 3
Mar 15 16:37:51.235: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
Mar 15 16:37:51.235: vsacount in free is 2
Mar 15 16:37:52.783: htsp_process_event: [0/0/0:1(3), R2_Q421_IC_CLR_FWD, E_HTSP_EVENT_TIMER]
Mar 15 16:37:52.783: htsp_timer_stop
Mar 15 16:37:52.783: r2_q421_clr_fwd_idle(0/0/0:1(3)) Tx IDLEvnm_dsp_set_sig_state:[R2 Q.421 0/0/0:1(3)] set signal state = 0x8
Mar 15 16:37:52.783: r2_reg_channel_disconnected(0/0/0:1(3))
Mar 15 16:37:52.783: r2_reg_process_event: [0/0/0:1(3), R2_REG_IDLE, E_R2_REG_DISCONNECT(91)]
Mar 15 16:37:52.783: r2_reg_disconnect_idle(0/0/0:1(3))
Mar 15 16:37:52.783: R2 Incoming Voice(0/0): DSX (E1 0/0/0:2): STATE: R2_IN_IDLE R2 Got Event R2_STOP
Mar 15 16:37:52.783: r2_reg_timer_stop(0/0/0:1(3))
Mar 15 16:37:52.783: //3876/7EC34EF0A2CA/CCAPI/cc_api_call_disconnect_done:
Disposition=0, Interface=0x4BEF14E0, Tag=0x0, Call Id=3876,
Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
Mar 15 16:37:52.783: //3876/7EC34EF0A2CA/CCAPI/cc_api_call_disconnect_done:
Call Disconnect Event Sent
Mar 15 16:37:52.783: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
Mar 15 16:37:52.783: :cc_free_feature_vsa freeing 4FA2EC18
Mar 15 16:37:52.783: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
Mar 15 16:37:52.783: vsacount in free is 1
Mar 15 16:37:52.783: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
Mar 15 16:37:52.783: vsacount in free is 0
em 03-15-2013 07:03 AM
Ola Jonas,
Se puder gostaria de pedir que voce fizesse esse testes. Acho que voce vai precisar de uma janela para executar isso.
Dentro das configuraçoes do seu E1 mude de r2-compelled ani para R2-Non-Compelled
controller E1 0/0/0
framing NO-CRC4
ds0-group 1 timeslots 1-15,17-31 type r2-digital r2-compelled ani
cas-custom 1
country telmex use-defaults
category 2
answer-signal group-b 1
--------------------------------------------------------------------
Refaça os testes novamente
attn
Daniel Sobrinho
em 03-15-2013 07:39 AM
Olá dsobrinho;
Já havia feito este teste com todas as opções disponíveis e o link para de funcionar se eu os selecionar. Somente funciona com r2-compelled ani.
em 03-15-2013 11:11 AM
Jonas este caller id que vc encaminha a chamada é valido para PSTN?
em 03-15-2013 11:49 AM
Sim, é válido, pois respeita a regra nacional de discagem: 0 + Código da Operadora + Código da Cidade (DDD) + telefone de destino.
em 03-15-2013 11:31 AM
Jonas poderia colocar um debug de uma chamada por exemplo, vc discando do telefone IP para um telefone da PSTN (Celular, local).
Att
em 03-15-2013 11:50 AM
As chamadas para telefones celulares saem por uma interface celular. No teste que fiz funciona normalmente a transferência se o destino não for o Link E1.
O debug é igual ao que informei anteriormente só mudando o caller-id.
Obrigado pela ajuda pessoal.
em 03-15-2013 11:51 AM
Jonas seria o caller ID (Cisco-ANI) o seu numero de origem quando a chamada é estabelecida.
se vc olhar um debug ccapi inout, fazendo uma chamada o ANI é igual?
quando vc faz CFW ALL para um celular funciona ?
Att
em 03-15-2013 11:54 AM
Ahh entendi.
Sim o ANI é compatível, pois o plano de ramais da Central é o MCDU enviado pela operadora. A operadora me envia o ANI MCDU 4505 e eu tenho no CME o DN number 4505 que deve receber a chamada e encaminhar para o número que especifiquei. Quando utilizo interface celular funciona normalmente, mas não posso aplicar essa solução, pois a tarifa será bem mais alta.
Encontre respostas, faça perguntas e conecte-se com nossa comunidade de especialistas da Cisco de todo o mundo.
Estamos felizes por você estar aqui! Participe de conversas e conecte-se com sua comunidade.
Navegue pelos links rápidos da Comunidade e usufrua de um conteúdo personalizado e em seu idioma nativo: