Voz : Sinalização de telefonia

Solução de Problemas e Configuração de Sinalização E1 R2

7 Abril 2008 - Tradução Manual
Outras Versões: Versão em PDFpdf | Tradução por Computador (29 Julho 2013) | Inglês (2 Fevereiro 2006) | Feedback


Índice

Introdução
Pré-requisitos
     Requisitos
     Componentes usados
     Convenções
Configurar
     AS5300: Cisco IOS - Compatibilidade de Software de Placa de Recurso de Voz (VFC)
     Configurar E1 R2
     Diagrama de Rede
     Configurações
Verificação
Solução de Problemas
     Solução de Problemas de Falhas E1 R2
     comandos debug e show
     Exemplo de saída de depuração
Discussões relacionadas da comunidade de suporte da Cisco
Informações Relacionadas

Introdução

Este documento oferece entradas de comando progressivas necessárias para a implementação da sinalização E1 R2. Este documento também contém informações sobre a solução de problemas de comandos debug.

Observação: Antes de utilizar o documento, recomenda-se a leitura de Teoria de Sinalização E1 R2.

Pré-requisitos

Requisitos

Antes de tentar essa configuração, verifique se estes pré-requisitos são atendidos:

  • A sinalização R2 se aplica apenas a E1.

  • A sinalização R2 não é suportada no router Cisco MC3810.

  • Para executar a sinalização R2 no Cisco 2600/3600 Series Routers, este hardware é necessário.

    VWIC-1MFT-E1 ou VWIC-2MFT-E1 ou VWIC-2MFT-E1-DI juntamente com um destes módulos de densidade de voz: NM-HDV (Módulo de Rede de Voz de Alta Densidade) ou NM-HD-2VE (módulo de rede de fax/voz de comunicação por IP com 2 slots) .

  • Defina o comando ds0-group (ou cas-group, com base na versão do Cisco IOS®) nos controladores E1 (roteadores Cisco 2600/3600, AS5x00).

  • Utilize o comando cas-custom para personalizar as variantes de E1 R2 para os diferentes países ou regiões.

Componentes usados

As informações neste documento são baseadas nesta versão de hardware e software:

  • Cisco AS5300 com Cisco IOS Software Release 12.0.7T

Observação: A sinalização E1 R2 foi apresentada ao Cisco 2600/3600 Series Routers nas versões Cisco IOS Software Releases 12.1.2XH e 12.1(3)T.

As informações apresentadas neste documento foram criadas a partir dos dispositivos em um ambiente de laboratório específico. Todos os dispositivos usados neste documento começaram com uma configuração vazia (padrão). Se a sua rede estiver ativa, certifique-se de entender o impacto potencial de todos os comandos.

Convenções

Consulte Convenções de Dicas Técnicas da Cisco para obter mais informações sobres as convenções de documentos.

Configurar

Esta seção apresenta informações que podem ser usadas para configurar o E1 R2.

Observação: Para encontrar informações adicionais sobre os comandos usados neste documento, use a Ferramenta de Consulta de Comandos (clientes registrados somente) .

AS5300: Cisco IOS - Compatibilidade de Software de Placa de Recurso de Voz (VFC)

Antes de implementar a sinalização E1 R2 em um router Cisco AS5300, certifique-se de que sua versão do Cisco IOS Software seja compatível com o Cisco VCware no módulo E1. Para verificar a compatibilidade do Cisco IOS Software, consulte a Matriz de compatibilidade Cisco VCWare para o Cisco AS5300. Se as versões forem incompatíveis, os módulos do Digital Signal Processor (DSP) da placa de voz não carregarão e o processamento de sinal de voz não ocorrerá.

Normalmente, se a versão do Cisco VCWare for incompatível com o Cisco IOS Software, você poderá digitar o comando show vfc slot_number interface como mostrado no exemplo.

eefje#show vfc 1 interface 
Rx: in ptr 18, outptr 0
Tx: in ptr 14  outptr  14
0 in hw queue, 0 queue head , 0 queue tail
Hardware is VFC out-of-band channel
Interface : state RESET DSP instance (0x61048284)
dsp_number 0, Channel ID 0
TX outstanding 0, max TX outstanding 0
Received 18 packets, 1087 bytes, 0 giant packets
0 drops, 0 no buffers, 0 input errors
121 bytes output, 14 frames output
0 bounce errors 0

DSP module 1 is not installed
DSP module 2 is not installed
DSP module 3 is not installed
DSP module 4 is not installed
DSP module 5 is not installed

No primeiro exemplo de saída do comando show vfc slot_number interface, o número do módulo DSP não está instalado instruções mostram que as versões são incompatíveis para o número do módulo.

O segundo conjunto de saída é um exemplo dos módulos DSP que possuem a versão correta do Cisco VCWare carregada:

eefje#show vfc 1 interface
Rx: in ptr 24, outptr 0
TX: in ptr 15  outptr  15
0 in hw queue, 0 queue head , 0 queue tail
Hardware is VFC out-of-band channel
Interface : state RESET DSP instance (0x618C6088)
dsp_number 0, Channel ID 0
TX outstanding 0, max TX outstanding 0
Received 283288 packets, 15864278 bytes, 0 giant packets
0 drops, 0 no buffers, 0 input errors
1416459 bytes output,  141647 frames output
0 bounce errors 0

Slot 1, DSPM 1 (C542), DSP 1, Channel 1
State RESET, DSP instance (0x61914BDC)
TX outstanding 0, max TX outstanding 8
Received 0 packets, 0 bytes, 0 giant packets
0 drops, 0 no buffers, 0 input errors
0 bytes output,  0 frames output
0 bounce errors 0

Slot 1, DSPM 1 (C542), DSP 2, Channel 1
State RESET, DSP instance (0x6191510C)
TX outstanding 0, max TX outstanding 8
Received 0 packets, 0 bytes, 0 giant packets
0 drops, 0 no buffers, 0 input errors
0 bytes output,  0 frames output
0 bounce errors 0

Para verificar a versão instalada do Cisco VCWare, digite o comando show vfc slot_number version vcware, conforme especificado neste exemplo:

eefje#show vfc 1 version vcware
Voice Feature Card in Slot 1:

VCware Version : 4.10
ROM Monitor Version : 1.2
DSPware Version :
Technology :  C542

Observação: Certifique-se de que a versão de tecnologia do Cisco VCWare (c549 ou c542) corresponda à tecnologia VFC DSP instalada (DSPM-542: suporte de voz de densidade única ou DSPM-549: suporte de voz de alta densidade).

Configurar E1 R2

Conclua essas etapas para configurar o E1 R2:

  1. Configure o controlador E1 que se conecta à central telefônica privada (PBX) ou ao switch.

    Verifique se o enquadramento e a codificação de linha do E1 foram definidos corretamente.

  2. Para enquadramento do E1, escolha CRC ou não-CRC.

  3. Para codificação de linha, escolha HDB3 ou AMI.

  4. Para a fonte de tempo E1, escolha interno ou linha. Lembre-se de que diferentes PBXs possuem diferentes requisitos na fonte de tempo.

  5. Configure a sinalização de linha.

  6. Configure a sinalização entre registros.

  7. Personalize a configuração com o comando cas-custom.

Configure a Sinalização de Linha.

Use a seguinte seqüência de comando para definir a sinalização de linha.

 eefje(config)#controller E1 0
 eefje(config-controller)#
               ds0-group 1 timeslots 1-15 type ?
...
r2-analog        R2 ITU Q411
r2-digital       R2 ITU Q421
r2-pulse         R2 ITU Supplement 7
...

Esta é a seqüência de comandos para o Cisco IOS Software Release 11.3.

 eefje(config)#controller E1 0
 eefje(config-controller)#cas-group 1 timeslot 1-15 type ?
...

Observação: Se você melhorar o Cisco IOS Software Release 11.3 para a versão 12.0, o novo comando substituirá o antigo automaticamente.

Configure a sinalização entre registros.

Esta seqüência de comando ilustra como configurar os diferentes tipos de sinalização entre registros:

 eefje(config)#controller E1 0
 eefje(config-controller)#ds0-group 1 timeslots 1-15 type r2-digital ?
dtmf               DTMF tone signaling
r2-compelled       R2 Compelled Register Signaling
r2-non-compelled   R2 Non Compelled Register Signaling
r2-semi-compelled  R2 Semi Compelled Register Signaling

A implementação Cisco da sinalização R2 possui suporte a Serviço de Identificação de Número Discado (DNIS) habilitada por padrão. Se você habilitar a opção de identificação automática de número (ANI), a coleta de informações de DNIS continuará sendo executada. A especificação da opção ANI não desativa a coleta de DNIS. DNIS é o número chamado. ANI corresponde ao número de quem efetua a chamada. Por exemplo, se você configurar um router A para chamar um router B, o número de DNIS será atribuído ao router B e o número de ANI será atribuído ao router A. O ANI é semelhante à identificação de chamada.

Personalização E1 R2 com o Comando cas-custom

Os subcomandos sob o comando cas-custom podem ser usados para acomodar variantes de país. Eles também são utilizados para personalizar os parâmetros de sinalização associada a canal (CAS). Esta seqüência de comando ilustra como podem ser visualizadas todas as opções de comandos cas-custom:

eefje(config)#controller E1 0
eefje(config-controller)#
               cas-custom 1
eefje(config-ctrl-cas)#?
CAS custom commands:
  ani-digits           Expected number of ANI digits
  ani-timeout          Timeout for ANI digits
  answer-guard-time    Wait Between Group-B Answer Signal And Line Answer
  answer-signal        Answer signal to be used
  caller-digits        Digits to be collected before requesting CallerID
  category             Category signal
  country              Country Name
  debounce-time        Debounce Timer
  default              Set a command to its defaults
  dnis-complete        Send I-15 after DNIS digits for dial-out
  dnis-digits          Expected number of DNIS digits
  exit                 Exit from cas custom mode
  groupa-callerid-end  Send Group-A Caller ID End
  invert-abcd          invert the ABCD bits before TX and after rx
  ka                   kA Signal
  kd                   KD Signal
  metering             R2 network is sending metering signal
  nc-congestion        Non Compelled Congestion signal
  no                   Negate a command or set its defaults
  proceed-to-send      Suppress proceed-to-send signal for pulsed line signaling
  release-ack          Send Release Acknowledgment to Clear Forward
  release-guard-time   Release Guard Timer
  request-category     DNIS Digits to be collected before requesting category
  seizure-ack-time     Seizure to Acknowledge timer
  unused-abcd          Unused ABCD bit values

Para obter informações adicionais sobre o comando cas-custom, consulte Personalização do E1 R2 com o comandocas-custom .

Diagrama de Rede

Este documento usa esta configuração de rede.

e1_r2_sig_fig4.gif

Configurações

Para este documento, há três configurações diferentes de R2, que são mostradas na interface E1:

As configurações foram modificadas para mostrar apenas as informações analisadas neste documento.

eefje Configurado para R2 Digital Não forçada

hostname eefje
!
controller E1 0
 clock source line primary
 dso-group 1 timeslots 1-15 type r2-digital r2-non-compelled
 cas-custom 1

                     !---Para obter mais informações sobre estes comandos
!--- consulte 
                           ds0-group
                         e 
                           cas-custom.
                        
                     
                  
!
voice-port 0:1
 cptone BE

                     !--- O comando cptone é específico para cada país. Para obter mais
!--- informações sobre este comando,  consulte 
                           cptone
                        .
                  
!
dial-peer voice 123 pots
 destination-pattern 123
 direct-inward-dial
 port 0:1
 prefix 123
!
dial-peer voice 567 voip
 destination-pattern 567
 session target ipv4:2.0.0.2
!

eefje Configurado para R2 Digital Semi-Forçada

hostname eefje
!
controller E1 0
 clock source line primary
 ds0-group 1 timeslots 1-15 type r2-digital r2-semi-compelled
 cas-custom 1

                     !---Para obter mais informações sobre estes comandos
!---  consulte 
                           ds0-group
                         e 
                           cas-custom
                        . 
                  
!
voice-port 0:1
 cptone BE

                     !--- O comando cptone é específico para cada país. Para obter mais
!--- informações sobre este comando, consulte 
                           cptone
                        .
                  
dial-peer voice 123 pots
 destination-pattern 123
 direct-inward-dial
 port 0:1
 prefix 123
!
dial-peer voice 567 voip
 destination-pattern 567
 session target ipv4:2.0.0.2
!

eefje Configurado para R2 Digital Forçada ANI

hostname eefje
! controller E1 0 clock source line primary ds0-group
1 timeslots 1-15 type r2-digital r2-compelled ani cas-custom 1

                     !---Para obter mais informações sobre estes comandos
!---  consulte 
                           ds0-group
                         e 
                           cas-custom
                        . 
                  
voice-port 0:1 cptone BE

                     !--- O comando cptone é específico para cada país. Para obter mais
!--- informações sobre este comando, consulte 
                           cptone
                        .
                  
dial-peer voice 123 pots destination-pattern 123 direct-inward-dial port
0:1 prefix 123
!
dial-peer voice 567 voip destination-pattern 567 session
target ipv4:2.0.0.2
!

Verificação

No momento, não existe um procedimento de verificação disponível para esta configuração.

Solução de Problemas

Esta seção fornece informações que podem ser usadas para solucionar problemas da configuração.

Solução de Problemas de Falhas E1 R2

Estas informações de solução de problemas são relevantes para esta configuração. Siga as instruções para solucionar o problema da configuração.

  1. Verifique se o controlador E1 0 está ativo.

    Se estiver fora do ar, verifique os quadros, a codificação das linhas, a fonte de tempo, os alarmes, substitua o cabo, encaixe novamente a placa de linha e assim por diante. Utilize o documento Personalização do E1 R2 com o Comando cas-custom como referência.

  2. Se você utilizar um AS5300, verifique se os DSPs estão instalados corretamente com o comandoshow vfc slot number interface .

  3. Configure o Direct Inward Dial (DID) no peer de serviço de telefonia tradicional (POTS) de modo que os dígitos recebidos sejam usados para escolher um peer enviado.

  4. Especifique cptone (cptone específico para o seu país) nas portas de voz.

    Um comando cptonecountry deve ser configurado para corresponder ao comando cas-custom country . O parâmetro cptone define os tons de progresso da chamada para um determinado país e, mais importante, define a codificação de a-law ou u-law, que depende do país. A codificação padrão dos EUA é u-law.

  5. Corresponda as provisões de sinalização de linha e registro para a configuração do switch.

  6. Ative alguns dos debugs mostrados neste documento e analise as saídas.

  7. Verifique a comunicação entre o router e o PBX ou switch:

    • A linha está capturada?

    • O router recebe/envia dígitos?

    • Descubra que lado limpa a chamada.

    Se possível, use as versões mais recentes do Cisco IOS Software disponíveis em Cisco.com.

comandos debug e show

Alguns show comandos são suportados pela Output Interpreter Tool (clientes registrados somente) , que permite que você veja uma análise da saída do comandoshow.

Observação: Antes de executar comandos debug, consulte Informações Importantes sobre Comandos de Depuração.

Observação: Para o Cisco IOS Software Release 12.0, utilize estes debugs:

  • debug cas - Para sinalização de linha.

  • debug csm voice - Para sinalização entre registros.

  • debug vtsp all - para ter a saída de toda as mensagens (dígitos) trocadas entre o PBX e o router.

Para o Cisco IOS Software Release 11.3, utilize estes comandos:

  • modem-mgmt csm debug-rbs - Para sinalização de linha (Você primeiro deve especificar service internal no modo de configuração.).

  • debug csm voice - Para sinalização entre registros.

  • debug vtsp all - para ter a saída de toda as mensagens (dígitos) trocadas entre o PBX e o router.

Para as plataformas AS5400 e AS5350, utilize estes comandos de depuração:

  • debug sigsm r2 - Para sinalização entre registros

  • debug vtsp all - para ter a saída de toda as mensagens (dígitos) trocadas entre o PBX e o router.

Exemplo de saída de depuração

Como há diferentes configurações mostradas previamente neste documento, aqui há três debugs diferentes:

R2 Digital não forçada: Chamada recebida para 567

Para entender melhor esta saída de debug, consulte Teoria de Sinalização E1 R2 .

eefje#show debug 
CAS:
 Channel Associated Signaling debugging is on
CSM Voice:
Voice Call Switching Module debugging is on
Voice Telephony session debugging is on
Voice Telephony dsp debugging is on
Voice Telephony error debugging is on
eefje#
eefje#
eefje#
Jan 6 10:41:28.677: from NEAT(0): (0/0): CAPTURA Rx (ABCD=0001)
Jan 6 10:41:28.717: VDEV_ALLOCATE: failed to allocate a device
Jan 6 10:41:28.717: VDEV_ALLOCATE: 1/28 is allocated
Jan 6 10:41:28.721: csm_vtsp_init_tdm (voice_vdev=0x620BF874)
Jan 6 10:41:28.721: csm_vtsp_init_tdm: dsprm_tdm_allocate: tdm slot 2,
dspm 1, dsp 5, dsp_channel 1
Jan 6 10:41:28.721: csm_vtsp_init_tdm: dsprm_tdm_allocate: tdm stream 5,
channel 3, bank 1, bp_channel 4, BP_stream 255
Jan 6 10:41:28.721: CSM_RX_CAS_EVENT_FROM_NEAT:(cid0018): EVENT_CALL_DIAL_IN
at slot 2 and port 16
Jan 6 10:41:28.721: CSM_PROC_IDLE: CSM_EVENT_START_DIGIT_COLLECT at slot 2,
 port 16
Jan 6 10:41:28.721: csm_vtsp_start_digit_collect (voice_vdev=0x620BF874)
Jan 6 10:41:28.721:  Enter csm_connect_pri_vdev function
Jan 6 10:41:28.721: csm_connect_pri_vdev:tdm_allocate_BP_ts()call. BP TS allocated
 at BP_stream0, BP_Ch28,vdev_common 0x6 20BF8E4
Jan 6 10:41:28.721: to NEAT:(cid0018) EVENT_CHANNEL_LOCK for slot0 ctlr0 chan0
Jan 6 10:41:28.721: vtsp_do_call_setup_ind
Jan 6 10:41:28.721: vtsp_do_call_setup_ind: Call ID=65681, guid=61FAF610
Jan 6 10:41:28.721: vtsp_do_call_setup_ind: type=0, under_spec=0, name=, id0=0,
id1=0, id2=0, calling=, called=
Jan 6 10:41:28.721: vtsp_do_call_setup_ind: redirect DN = reason =
 0vtsp_open_voice_and_set_params
Jan 6 10:41:28.721: dsp_close_voice_channel: [0:1:0] packet_len=8 channel_id
 =8529 packet_id=75
Jan 6 10:41:28.721: dsp_open_voice_channel_20: [0:1:0] packet_Len=16 channel_id
 =8529 packet_id=74 alaw_ulaw_select=1 associated_signaling_channel=0 time_slot=0
 serial_port=0
Jan 6 10:41:28.721: dsp_encap_config_20: [0:1:0] packet_Len=24 channel_id=8529
 packet_id=92 TransportProtocol 2 t_ssrc=0x0 r_ssrc=0x0 t_vpxcc=0x0 r_vpxcc=0x0
Jan 6 10:41:28.721: dsp_set_playout: [0:1:0] packet_Len=18 channel_id=8529
 packet_id=76 mode=1 initial=60 min=4 max=200 fax_nom=300
Jan 6 10:41:28.721: dsp_echo_canceller_control: [0:1:0] packet_Len=10
channel_id=8529 packet_id=66 flags=0x0
Jan 6 10:41:28.721: dsp_set_gains: [0:1:0] packet_Len=12 channel_id=8529
packet_id=91 in_gain=0 out_gain=0
Jan 6 10:41:28.721: dsp_vad_enable: [0:1:0] packet_Len=10 channel_id=8529
packet_id=78 thresh=-38
Jan 6 10:41:28.721: dsp_voice_mode: [0:1:0] packet_Len=24 channel_id=8529
packet_id=73 coding_type=1 voice_field_size=80 V AD_flag=0 echo_length=64
comfort_noise=1 inband_detect=1 digit_relay=2
AGC_flag=0vtsp_do_r2_start_digit(): dsp_dtmf_mode()
 dsp_dtmf_mode(VTSP_TONE_R2_MF_FORWARD_MODE)
Jan 6 10:41:28.725: dsp_dtmf_mode: [0:1:0] packet_Len=10 channel_id=8529
 packet_id=65 dtmf_or_mf=1vtsp_do_r2_start_digit():fsm_push(vtsp_r2_state_table)
Jan 6 10:41:28.725: csm_vtsp_call_setup_resp (vdev_info=0x620BF874,
vtsp_cdb=0x621C5F3C)
Jan 6 10:41:28.725: csm_vtsp_call_setup_resp:vdev_common BP TS allocatedat
BP_stream0,BP_Ch28
Jan 6 10:41:28.725: csm_vtsp_call_setup_resp:dst_tdm_chnl call. BP TS allocatedat
 stream 5, chan 3,BP_stream 255, BP_ch 4
Jan 6 10:41:28.725: csm_vtsp_call_setup_resp:DST_tdm_chnl call. BP TS allocatedat
 stream 5, chan 3,BP_stream 0, BP_ch 28
Jan 6 10:41:28.725: CSM_PROC_IC1_COLLECT_ADDR_INFO: CSM_EVENT_MODEM_OFFHOOK
 (DNIS=, ANI=) at slot 2, port 16
Jan 6 10:41:28.725: R2 Incoming Voice(2/16): DSX (E1 0:0): STATE: R2_IN_IDLE R2
 Got Event R2_START
Jan 6 10:41:28.821: CSM_RX_CAS_EVENT_FROM_NEAT:(0018):EVENT_START_RX_TONE at slot 2
 and port 16
Jan 6 10:41:28.821: from NEAT(0): (0/0): TX SEIZURE_ACK (ABCD=1101)

               !--- Dígito 5 enviado: Encaminhar sinal Group I-5.
            
Jan 6 10:41:29.233: vtsp_process_dsp_message:
MSG_TX_DTMF_DIGIT_BEGIN: digit=5,
 rtp_timestamp=0x0CA95D43 dc_digit_up
Jan 6 10:41:29.233: csm_vtsp_digit_ready_up (vtsp_cdb=0x621C5F3C) received digit (5)
Jan 6 10:41:29.233: CSM voice (2/16): Rcvd Digit detected(5)
Jan 6 10:41:29.233: R2 Incoming Voice(2/16): DSX (E1 0:0):
STATE: R2_IN_COLLECT_DNIS R2
 Got Event 5
Jan 6 10:41:29.365: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF: digit=5,
 duration=8321dc_digit
Jan 6 10:41:29.365: csm_vtsp_digit_ready (vtsp_cdb=0x621C5F3C) received digit (5)
Jan 6 10:41:29.365: CSM voice (2/16): Rcvd Digit detected(5)
Jan 6 10:41:29.365: R2 Incoming Voice(2/16): DSX (E1 0:0):
STATE:R2_IN_COLLECT_DNIS R2
            Got Event R2_TONE_OFF
            
               !--- Dígito 6 enviado: Encaminhar sinal Group I-6.
            
Jan 6 10:41:29.593: vtsp_process_dsp_message:
MSG_TX_DTMF_DIGIT_BEGIN: digit=6,
 rtp_timestamp=0x0CA95D43 dc_digit_up
Jan 6 10:41:29.593: csm_vtsp_digit_ready_up (vtsp_cdb=0x621C5F3C) received digit (6)
Jan 6 10:41:29.593: CSM voice (2/16): Rcvd Digit detected(6)
Jan 6 10:41:29.593: R2 Incoming Voice(2/16): DSX (E1 0:0):
STATE: R2_IN_COLLECT_DNIS R2
 Got Event 6
Jan 6 10:41:29.725: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF: digit=6,
 duration=8321dc_digit
Jan 6 10:41:29.725: csm_vtsp_digit_ready (vtsp_cdb=0x621C5F3C) received digit (6)
Jan 6 10:41:29.725: CSM voice (2/16): Rcvd Digit detected(6)
Jan 6 10:41:29.725: R2 Incoming Voice(2/16): DSX (E1 0:0):
STATE: R2_IN_COLLECT_DNIS R2
            Got Event R2_TONE_OFF
            
               !--- Dígito 7 enviado: Encaminhar sinal Group I-7.
            
Jan 6 10:41:29.953: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN:
digit=7, rtp_timestamp=0x0CA95D43 dc_digit_up
Jan 6 10:41:29.953: csm_vtsp_digit_ready_up (vtsp_cdb=0x621C5F3C)
received digit (7)
Jan 6 10:41:29.953: CSM voice (2/16): Rcvd Digit detected(7)
Jan 6 10:41:29.953: R2 Incoming Voice(2/16): DSX (E1 0:0):
STATE:R2_IN_COLLECT_DNIS R2
 Got Event 7
Jan 6 10:41:30.085: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF:
digit=7, duration=8321dc_digit
Jan 6 10:41:30.085: csm_vtsp_digit_ready (vtsp_cdb=0x621C5F3C)received digit (7)
Jan 6 10:41:30.085: CSM voice (2/16): Rcvd Digit detected(7)
Jan 6 10:41:30.085: R2 Incoming Voice(2/16): DSX (E1 0:0):
STATE: R2_IN_COLLECT_DNIS R2
 Got Event R2_TONE_OFF
            
               !--- Expiração: 3 segundos (temporizador padrão - AS5300 presume que DNIS está finalizado).
            
Jan 6 10:41:32.953: R2 Incoming Voice(2/16): DSX (E1 0:0):
STATE: R2_IN_COLLECT_DNIS R2
 Got Event R2_TONE_TIMER
            
               !--- Enviar dígito 6: Sinal inverso Group B-6  (linha de assinante gratuita).
            
Jan 6 10:41:32.953: vtsp_r2_generate_digits: vdev_common=0x620BF8E4,
string=567dc_dial()
 vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = 6#

Jan 6 10:41:32.953: dsp_dtmf_dialing: [0:1:0] packet_Len=36 channel_id=8529
packet_id=90 string=6# digits=2, time_on=150, time_off=30
Jan 6 10:41:32.953:&   digit=e, components=2, freq_of_first=900,
freq_of_second=780, amp_of_first=8192, amp_of_second=8192
Jan 6 10:41:32.953:    digit=o, components=2, freq_of_first=0,
freq_of_second=0, amp_of_first=1, amp_of_second=1
Jan 6 10:41:33.313: vtsp_process_dsp_message:
MSG_TX_DIALING_DONE dc_dialing_done()
Jan 6 10:41:33.313: R2 Incoming Voice(2/16): DSX (E1 0:0):
STATE:R2_IN_ANSWER_PULSE R2
 Got Event R2_DIGITS_GENR2_ALERTING
Jan 6 10:41:34.313: R2 Incoming Voice(2/16): DSX (E1 0:0):
STATE: R2_IN_ANSWER_PULSE R2
 Got Event R2_TONE_TIMER
Jan 6 10:41:34.313:  R2_IN_IDLE:2 r2_in_connect called
Jan 6 10:41:34.313: CSM_PROC_IC1_COLLECT_ADDR_INFO:
 CSM_EVENT_ADDR_INFO_COLLECTED (DNIS=567, ANI=) at slot 2, port 16
Jan 6 10:41:34.313: vtsp_tsp_call_accept_check (sdb=0x61B8F0E0, calling_number=
 called_number=567): peer_tag=0
Jan 6 10:41:34.313: VDEV_ALLOCATE: failed to allocate a device
Jan 6 10:41:34.313: VDEV_ALLOCATE_ALMOST_READY: failed to allocate a non-idle modem
Jan 6 10:41:34.313: VDEV_ALLOCATE: failed to allocate a device
Jan 6 10:41:34.313: VDEV_ALLOCATE_ALMOST_READY: failed to allocate a non-idle modem
Jan 6 10:41:34.313: VDEV_ALLOCATE: failed to allocate a device
Jan 6 10:41:34.313: VDEV_ALLOCATE_ALMOST_READY: failed to allocate a non-idle modem
Jan 6 10:41:34.313: CSM_PROC_IC3_WAIT_FOR_RES_RESP: CSM_EVENT_RESOURCE_OK at slot 2,
 port 16
Jan 6 10:41:34.313: vtsp_ic_switch : (voice_vdev= 0x620BF874)
Jan 6 10:41:34.313: vtsp_tsp_call_switch_ind (cdb=0x621C5F3C, tsp_info=0x620BF874,
 calling_number= called_number=567 redir ect_number=):
peer_tag=123dc_switch: fsm_pop()
Jan 6 10:41:34.313: vtsp_do_call_setup_ind
Jan 6 10:41:34.313: vtsp_do_call_setup_ind: Call ID=65683, guid=61FAF610
Jan 6 10:41:34.313: vtsp_do_call_setup_ind: type=0, under_spec=0,
 name=ab^Lx, id0=1, id1=0, id2=0, calling=123, called=567
Jan 6 10:41:34.317: dsp_cp_tone_off: [] packet_Len=8 channel_id=8529 packet_id=71
Jan 6 10:41:34.317: dsp_idle_mode: [] packet_Len=8 channel_id=8529 packet_id=68
Jan 6 10:41:34.317: dsp_close_voice_channel: [] packet_Len=8 channel_id=8529
packet_id=75
Jan 6 10:41:34.317: vtsp_timer_stop: 67475758
Jan 6 10:41:34.317: csm_vtsp_call_setup_resp (vdev_info=0x620BF874,
 vtsp_cdb=0x621C5F3C)
Jan 6 10:41:34.317: csm_vtsp_call_setup_resp:vdev_common
BP TS allocatedat BP_stream0,
 BP_Ch28
Jan 6 10:41:34.317: csm_vtsp_call_setup_resp:DST_tdm_chnl call. BP TS allocatedat
 stream 5, chan 3,BP_stream 0, BP_ch 28
Jan 6 10:41:34.317: csm_vtsp_call_setup_resp:DST_tdm_chnl call. BP TS allocatedat
 stream 5, chan 3,BP_stream 0, BP_ch 28vt sp_open_voice_and_set_params
Jan 6 10:41:34.317: dsp_close_voice_channel: [0:1 (54)] packet_Len=8 channel_id=8529
 packet_id=75
Jan 6 10:41:34.317: dsp_open_voice_channel_20: [0:1 (54)] packet_Len=16
channel_id=8529
 packet_id=74 alaw_ulaw_select=1 associated_signaling_channel=0 time_slot=0
serial_port=0
Jan 6 10:41:34.317: dsp_encap_config_20: [0:1 (54)] packet_Len=24 channel_id=8529
 packet_id=92 TransportProtocol 2 t_ssrc=0x0 r_ssrc=0x0 t_vpxcc=0x0 r_vpxcc=0x0
Jan 6 10:41:34.317: dsp_set_playout: [0:1 (54)] packet_Len=18 channel_id=8529
 packet_id=76 mode=1 initial=60 min=4 max=200 fax_nom=300
Jan 6 10:41:34.317: dsp_echo_canceller_control: [0:1 (54)] packet_Len=10
channel_id=8529
 packet_id=66 flags=0x0
Jan 6 10:41:34.317: dsp_set_gains: [0:1 (54)] packet_Len=12
channel_id=8529 packet_id=91
 in_gain=0 out_gain=0
Jan 6 10:41:34.317: dsp_vad_enable: [0:1 (54)] packet_Len=10
channel_id=8529 packet_id=78
 thresh=-38act_proceeding
Jan 6 10:41:34.321: csm_vtsp_call_proceeding:DST_tdm_chnl call.
BP TS allocatedstream 5,
 chan 3,BP_stream 0, BP_ch 28act_alert
Jan 6 10:41:34.345: vtsp_ring_noan_timer_start: 67475761
Jan 6 10:41:34.345: csm_vtsp_call_alert (vtsp_cdb=0x621C5F3C)act_bridge act_caps_ind
Jan 6 10:41:34.589: act_caps_ind:Encap 1, Vad 2, Codec 0x4, CodecBytes 20,
    FaxRate 2, FaxBytes 20 SignalType 0
    DtmfRelay 1, Modem 1act_caps_ack
Jan 6 10:41:34.589: dsp_idle_mode: [0:1 (54)] packet_Len=8
channel_id=8529 packet_id=68
Jan 6 10:41:34.589: act_caps_ack: codec = 15, ret = 1
Jan 6 10:41:34.589: dsp_cp_tone_off: [0:1 (54)] packet_Len=8 channel_id=8529
  packet_id=71
Jan 6 10:41:34.589: dsp_idle_mode: [0:1 (54)] packet_Len=8
channel_id=8529 packet_id=68
Jan 6 10:41:34.589: dsp_encap_config_20: [0:1 (54)] packet_Len=24 channel_id=8529
  packet_id=92 TransportProtocol 2 t_ssrc=0x0 r_ssrc=0x0 t_vpxcc=0x0 r_vpxcc=0x0
Jan 6 10:41:34.589: dsp_voice_mode: [0:1 (54)] packet_Len=24 channel_id=8529
 packet_id=73 coding_type=20 voice_field_size=20 VAD_flag=1 echo_length=64
 comfort_noise=1 inband_detect=1 digit_relay=2 AGC_flag=0act_alert_connect
Jan 6 10:41:36.857: vtsp_ring_noan_timer_stop: 67476012
Jan 6 10:41:36.857: dsp_cp_tone_off: [0:1 (54)] packet_Len=8 channel_id=8529
  packet_id=71
Jan 6 10:41:36.857: csm_vtsp_call_connect (vtsp_cdb=0x621C5F3C,
voice_vdev=0x620BF874)
Jan 6 10:41:36.857: CSM_IC5_WAIT_FOR_SWITCH_OVER: CSM_EVENT_MODEM_OFFHOOK
  at slot 2, port 16
Jan 6 10:41:36.917: CSM_RX_CAS_EVENT_FROM_NEAT:(0018):  EVENT_CHANNEL_CONNECTED
  at slot 2 and port 16
Jan 6 10:41:36.917: CSM_PROC_IC6_WAIT_FOR_CONNECT: CSM_EVENT_DSX0_CONNECTED
  at slot 2, port 16
Jan 6 10:41:36.921: from NEAT(0): (0/0): TX ANSWERED(ABCD=0101)
eefje#

R2 Digital Semi-forçada: Chamada recebida para 567

Para entender melhor esta debug output, consulte Teoria de Sinalização E1 R2 .

eefje#show debug 
CAS:
 Channel Associated Signaling debugging is on
CSM Voice:
Voice Call Switching Module debugging is on
Voice Telephony session debugging is on
Voice Telephony dsp debugging is on
Voice Telephony error debugging is on
eefje#
eefje#
eefje#
Jan  6 09:53:42.389: from NEAT(0): (0/2): CAPTURA Rx(ABCD=0001)
Jan 6 09:53:42.433: VDEV_ALLOCATE: failed to allocate a device
Jan 6 09:53:42.433: VDEV_ALLOCATE: 1/27 is allocated
Jan 6 09:53:42.433: csm_vtsp_init_tdm (voice_vdev=0x620BF320)
Jan 6 09:53:42.433: csm_vtsp_init_tdm: dsprm_tdm_allocate: tdm slot 2, dspm 1,
 dsp 4, dsp_channel 4
Jan 6 09:53:42.433: csm_vtsp_init_tdm: dsprm_tdm_allocate: tdm stream 7, channel 0,
 bank 4, BP_channel 3, BP_stream 255
Jan 6 09:53:42.433: CSM_RX_CAS_EVENT_FROM_NEAT:(cid0017): EVENT_CALL_DIAL_IN
 at slot 2 and port 15
Jan 6 09:53:42.433: CSM_PROC_IDLE: CSM_EVENT_START_DIGIT_COLLECT
 at slot 2, port 15
Jan 6 09:53:42.433: csm_vtsp_start_digit_collect (voice_vdev=0x620BF320)
Jan 6 09:53:42.433:  Enter csm_connect_pri_vdev function
Jan 6 09:53:42.433: csm_connect_pri_vdev:tdm_allocate_BP_Ts()call. BP TS allocated
 at BP_stream0, BP_Ch27,vdev_common 0x6 20BF390
Jan 6 09:53:42.433: to NEAT:(cid0017) EVENT_CHANNEL_LOCK for slot0 ctlr0 chan2
Jan 6 09:53:42.433: vtsp_do_call_setup_ind
Jan 6 09:53:42.433: vtsp_do_call_setup_ind: Call ID=65675, guid=61FAF610
Jan 6 09:53:42.433: vtsp_do_call_setup_ind: type=0, under_spec=0, name=, id0=0,
 id1=0, id2=0, calling=, called=
Jan 6 09:53:42.433: vtsp_do_call_setup_ind: redirect DN = reason =
 0vtsp_open_voice_and_set_params
Jan 6 09:53:42.433: dsp_close_voice_channel: [0:1:2] packet_Len=8 channel_id=8516
 packet_id=75
Jan 6 09:53:42.433: dsp_open_voice_channel_20: [0:1:2] packet_Len=16
channel_id=8516
 packet_id=74 alaw_ulaw_select=1 associated_signaling_channel=0
time_slot=1 serial_port=1
Jan 6 09:53:42.433: dsp_encap_config_20: [0:1:2] packet_Len=24 channel_id=8516
 packet_id=92 TransportProtocol 2 t_ssrc=0x0 r_ssrc=0x0 t_vpxcc=0x0 r_vpxcc=0x0
Jan 6 09:53:42.433: dsp_set_playout: [0:1:2] packet_Len=18 channel_id=8516
 packet_id=76 mode=1 initial=60 min=4 max=200 fax_nom=300
Jan 6 09:53:42.433: dsp_echo_canceller_control: [0:1:2]
packet_Len=10 channel_id=8516
 packet_id=66 flags=0x0
Jan 6 09:53:42.437: dsp_set_gains:[0:1:2] packet_Len=12
channel_id=8516 packet_id=91
 in_gain=0 out_gain=0
Jan 6 09:53:42.437: dsp_vad_enable: [0:1:2] packet_Len=10 channel_id=8516
 packet_id=78 thresh=-38
Jan 6 09:53:42.437: dsp_voice_mode: [0:1:2] packet_Len=24 channel_id=8516
 packet_id=73 coding_type=1 voice_field_size=80 VAD_flag=0 echo_length=64
 comfort_noise=1 inband_detect=1 digit_relay=2 AGC_flag=0vtsp_do_r2_start_digit():
 dsp_dtmf_mode() dsp_dtmf_mode(VTSP_TONE_R2_MF_FORWARD_MODE)
Jan 6 09:53:42.437: dsp_dtmf_mode: [0:1:2] packet_Len=10 channel_id=8516
 packet_id=65 dtmf_or_mf=1vtsp_do_r2_start_digit(): fsm_push(vtsp_r2_state_table)
Jan 6 09:53:42.437: csm_vtsp_call_setup_resp (vdev_info=0x620BF320,
vtsp_cdb=0x621C5F3C)
Jan 6 09:53:42.437: csm_vtsp_call_setup_resp:vdev_common BP
TS allocatedat BP_stream0,
 BP_Ch27
Jan 6 09:53:42.437: csm_vtsp_call_setup_resp:DST_tdm_chnl call. BP TS allocatedat
 stream 7, chan 0,BP_stream 255, BP_ch 3
Jan 6 09:53:42.437: csm_vtsp_call_setup_resp:DST_tdm_chnl call. BP TS allocatedat
 stream 7, chan 0,BP_stream 0, BP_ch 27
Jan 6 09:53:42.437: CSM_PROC_IC1_COLLECT_ADDR_INFO: CSM_EVENT_MODEM_OFFHOOK
 (DNIS=, ANI=) at slot 2, port 15
Jan 6 09:53:42.437: R2 Incoming Voice(2/15): DSX (E1 0:2): STATE:R2_IN_IDLE R2
 Got Event R2_START
Jan 6 09:53:42.533: CSM_RX_CAS_EVENT_FROM_NEAT:(0017):EVENT_START_RX_TONE
 at slot 2 and port 15
Jan 6 09:53:42.533: from NEAT(0): (0/2): TX SEIZURE_ACK (ABCD=1101)
            
               !--- Dígito 5 enviado: Encaminhar sinal Group I-5.
            
Jan 6 09:53:42.641: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN:
 digit=5, rtp_timestamp=0x9330B42B dc_digit_up
Jan 6 09:53:42.641: csm_vtsp_digit_ready_up (vtsp_cdb=0x621C5F3C) received digit (5)
Jan 6 09:53:42.641: CSM voice (2/15): Rcvd Digit detected(5)
Jan 6 09:53:42.641: R2 Incoming Voice(2/15): DSX (E1 0:2):
STATE:R2_IN_COLLECT_DNIS R2
            Got Event 5
            
               !--- Dígito 1 enviado (pulso): Sinal invertido Group A-1  (enviar próximo dígito)
!--- "#" isto indica que é um pulso). 
            
Jan 6 09:53:42.641: vtsp_r2_generate_digits: vdev_common=0x620BF390,
string=5dc_dial()
 vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = 1#

Jan 6 09:53:42.641: dsp_dtmf_dialing: [0:1:2] packet_Len=36 channel_id=8516
 packet_id=90 string=1# digits=2, time_on=150, time_off=30
Jan 6 09:53:42.641:    digit=`, components=2, freq_of_first=1020,
freq_of_second=1140,
 amp_of_first=8192, amp_of_second=8192
Jan 6 09:53:42.641:    digit=o, components=2, freq_of_first=0, freq_of_second=0,
 amp_of_first=1, amp_of_second=1
Jan 6 09:53:42.741: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF: digit=5,
 duration=8291dc_digit
Jan 6 09:53:42.741: csm_vtsp_digit_ready (vtsp_cdb=0x621C5F3C) received digit (5)
Jan 6 09:53:42.741: CSM voice (2/15): Rcvd Digit detected(5)
Jan 6 09:53:42.741: R2 Incoming Voice(2/15): DSX (E1 0:2):
STATE:R2_IN_COLLECT_DNIS R2
            Got Event R2_TONE_OFF
            
               !--- Dígito 6 enviado: Encaminhar sinal Group I.
            
Jan 6 09:53:42.881: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN:
digit=6, rtp_timestamp=0x9330B42B dc_digit_up
Jan 6 09:53:42.881: csm_vtsp_digit_ready_up (vtsp_cdb=0x621C5F3C)received digit (6)
Jan 6 09:53:42.881: CSM voice (2/15): Rcvd Digit detected(6)
Jan 6 09:53:42.881: R2 Incoming Voice(2/15): DSX (E1 0:2):
 STATE:R2_IN_COLLECT_DNIS R2
 Got Event 6
            
               !--- Dígito 1 enviado (pulso): Sinal invertido Group A-1. (enviar próximo dígito)
            
Jan 6 09:53:42.881: vtsp_r2_generate_digits: vdev_common=0x620BF390,
string=56dc_dial()
 vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = 1#

Jan 6 09:53:42.881: dsp_dtmf_dialing: [0:1:2] packet_Len=36 channel_id=8516
 packet_id=90 string=1# digits=2, time_on=150, time_off=30
Jan 6 09:53:42.881:    digit=`, components=2, freq_of_first=1020,
freq_of_second=1140,
 amp_of_first=8192, amp_of_second=8192
Jan 6 09:53:42.881:    digit=o, components=2, freq_of_first=0, freq_of_second=0,
 amp_of_first=1, amp_of_second=1
Jan 6 09:53:42.981: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF: digit=6,
 duration=8291dc_digit
Jan 6 09:53:42.981: csm_vtsp_digit_ready (vtsp_cdb=0x621C5F3C) received digit (6)
Jan 6 09:53:42.981: CSM voice (2/15): Rcvd Digit detected(6)
Jan 6 09:53:42.981: R2 Incoming Voice(2/15): DSX (E1 0:2):
STATE:R2_IN_COLLECT_DNIS R2
            Got Event R2_TONE_OFF
            
               !--- Dígito 7 enviado: Encaminhar sinal Group I-7.
            
Jan 6 09:53:43.121: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN:
            digit=7, rtp_timestamp=0x9330B42B dc_digit_up
Jan 6 09:53:43.121: csm_vtsp_digit_ready_up (vtsp_cdb=0x621C5F3C)received digit (7)
Jan 6 09:53:43.121: CSM voice (2/15): Rcvd Digit detected(7)
Jan 6 09:53:43.121: R2 Incoming Voice(2/15): DSX (E1 0:2):
STATE:R2_IN_COLLECT_DNIS R2
 Got Event 7
            
               !--- Enviar dígito 1 (pulso): Sinal invertido Group I-1.
            
Jan 6 09:53:43.121: vtsp_r2_generate_digits: vdev_common=0x620BF390,
string=567dc_dial()
 vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = 1#

Jan 6 09:53:43.121: dsp_dtmf_dialing: [0:1:2] packet_Len=36 channel_id=8516
 packet_id=90 string=1# digits=2, time_on=150, time_off=30
Jan 6 09:53:43.121:    digit=`, components=2, freq_of_first=1020,
freq_of_second=1140,
 amp_of_first=8192, amp_of_second=8192
Jan 6 09:53:43.121:    digit=o, components=2, freq_of_first=0, freq_of_second=0,
 amp_of_first=1, amp_of_second=1
Jan 6 09:53:43.221: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF: digit=7,
 duration=8291dc_digit
Jan 6 09:53:43.221: csm_vtsp_digit_ready (vtsp_cdb=0x621C5F3C) received digit (7)
Jan 6 09:53:43.221: CSM voice (2/15): Rcvd Digit detected(7)
Jan 6 09:53:43.221: R2 Incoming Voice(2/15): DSX (E1 0:2):
STATE:R2_IN_COLLECT_DNIS R2
            Got Event R2_TONE_OFF
Jan 6 09:53:43.489: vtsp_process_dsp_message: MSG_TX_DIALING_DONEdc_dialing_done()

               !--- Expiração é de 3 segundos.
            
Jan 6 09:53:46.121: R2 Incoming Voice(2/15): DSX (E1 0:2):
STATE:R2_IN_COLLECT_DNIS R2
            Got Event R2_TONE_TIMER
            
               !--- Dígito 3 enviado (pulso): Sinal invertido Group I-3.
!--- (Endereço completo, mudança para recepção dos sinais Group-B).
            
Jan 6 09:53:46.121: vtsp_r2_generate_digits: vdev_common=0x620BF390,
 string=567dc_dial()
 vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = 3#
Jan 6 09:53:46.121: dsp_dtmf_dialing: [0:1:2] packet_Len=36 channel_id=8516
 packet_id=90 string=3# digits=2, time_on=150, time_off=30
Jan 6 09:53:46.121:    digit=b, components=2, freq_of_first=1020,
freq_of_second=900,
 amp_of_first=8192, amp_of_second=8192
Jan 6 09:53:46.121:    digit=o, components=2, freq_of_first=0,
freq_of_second=0, amp_of_first=1, amp_of_second=1

               !--- Dígito 1 enviado: Encaminhar sinal Group II-1.
!--- (assinante sem prioridade).
            
Jan 6 09:53:46.361: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN:
            digit=1, rtp_timestamp=0x9330B42B dc_digit_up
Jan 6 09:53:46.361: csm_vtsp_digit_ready_up (vtsp_cdb=0x621C5F3C)
received digit (1)
Jan 6 09:53:46.361: CSM voice (2/15): Rcvd Digit detected(1)
Jan 6 09:53:46.361: R2 Incoming Voice(2/15): DSX (E1 0:2):
STATE:R2_IN_CATEGORY R2
            Got Event 1
Jan 6 09:53:46.361:  r2_comp_category:R2_ALERTING

               !--- Dígito 6 enviado (pulso): Sinal invertido Group B-6.
!--- (linha de assinante gratuita).
            
Jan 6 09:53:46.361: vtsp_r2_generate_digits: vdev_common=0x620BF390,
string=567dc_dial()
 vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = 6#

Jan  6 09:53:46.361: dsp_dtmf_dialing: [0:1:2] packet_Len=36 channel_id=8516
 packet_id=90 string=6# digits=2, time_on=150, time_off=30
Jan 6 09:53:46.361:    digit=e, components=2, freq_of_first=900,
freq_of_second=780,
 amp_of_first=8192, amp_of_second=8192
Jan 6 09:53:46.361:    digit=o, components=2, freq_of_first=0, freq_of_second=0,
 amp_of_first=1, amp_of_second=1
Jan 6 09:53:46.461: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF:digit=1,
 duration=8291dc_digit
Jan 6 09:53:46.461: csm_vtsp_digit_ready (vtsp_cdb=0x621C5F3C)received digit (1)
Jan 6 09:53:46.461: CSM voice (2/15): Rcvd Digit detected(1)
Jan 6 09:53:46.461: R2 Incoming Voice(2/15): DSX (E1 0:2): STATE:R2_IN_COMPLETE R2
 Got Event R2_TONE_OFF
Jan 6 09:53:46.729: vtsp_process_dsp_message: MSG_TX_DIALING_DONEdc_dialing_done()
Jan 6 09:53:47.461: R2 Incoming Voice(2/15): DSX (E1 0:2):
STATE:R2_IN_WAIT_GUARD R2
 Got Event R2_TONE_TIMER
Jan 6 09:53:47.461:  R2_IN_IDLE:2 r2_in_connect called
Jan 6 09:53:47.461: CSM_PROC_IC1_COLLECT_ADDR_INFO: CSM_EVENT_ADDR_INFO_COLLECTED
(DNIS=567, ANI=) at slot 2, port 15
Jan 6 09:53:47.461: vtsp_tsp_call_accept_check (sdb=0x61B8F0E0,calling_number=
 called_number=567): peer_tag=0
Jan 6 09:53:47.461: VDEV_ALLOCATE: failed to allocate a device
Jan 6 09:53:47.461: VDEV_ALLOCATE_ALMOST_READY: failed to allocate a non-idle modem
Jan 6 09:53:47.461: VDEV_ALLOCATE: failed to allocate a device
Jan 6 09:53:47.461: VDEV_ALLOCATE_ALMOST_READY: failed to allocate a non-idle modem
Jan 6 09:53:47.461: VDEV_ALLOCATE: failed to allocate a device
Jan 6 09:53:47.461: VDEV_ALLOCATE_ALMOST_READY: failed to allocate a non-idle modem
Jan 6 09:53:47.461: CSM_PROC_IC3_WAIT_FOR_RES_RESP: CSM_EVENT_RESOURCE_OK at slot 2,
 port 15
Jan 6 09:53:47.461: vtsp_IC_switch : (voice_vdev= 0x620BF320)
Jan 6 09:53:47.461: vtsp_tsp_call_switch_ind (cdb=0x621C5F3C,tsp_info=0x620BF320,
 calling_number= called_number=567 redirect_number=):
peer_tag=123dc_switch: fsm_pop()
Jan 6 09:53:47.461: vtsp_do_call_setup_ind
Jan 6 09:53:47.461: vtsp_do_call_setup_ind: Call ID=65677, guid=61FAF610
Jan 6 09:53:47.461: vtsp_do_call_setup_ind: type=0, under_spec=0, name=AB^Lo, id0=3,
 id1=0, id2=0, calling=123, called=567
Jan 6 09:53:47.465: dsp_cp_tone_off: [] packet_Len=8 channel_id=8516 packet_id=71
Jan 6 09:53:47.465: dsp_idle_mode: [] packet_Len=8 channel_id=8516 packet_id=68
Jan 6 09:53:47.465: dsp_close_voice_channel: [] packet_Len=8 channel_id=8516
packet_id=75
Jan 6 09:53:47.465: vtsp_timer_stop: 67189073
Jan 6 09:53:47.465: csm_vtsp_call_setup_resp (vdev_info=0x620BF320,
 vtsp_cdb=0x621C5F3C)
Jan 6 09:53:47.465: csm_vtsp_call_setup_resp:vdev_common
BP TS allocatedat BP_stream0,
 BP_Ch27
Jan 6 09:53:47.465: csm_vtsp_call_setup_resp:DST_tdm_chnl call. BP TS allocatedat
 stream 7, chan 0,BP_stream 0, BP_ch 27
Jan 6 09:53:47.465: csm_vtsp_call_setup_resp:DST_tdm_chnl call. BP TS allocatedat
 stream 7, chan 0,BP_stream 0, BP_ch 27vtsp_open_voice_and_set_params
Jan 6 09:53:47.465: dsp_close_voice_channel: [0:1 (52)] packet_Len=8 channel_id=8516
 packet_id=75
Jan 6 09:53:47.465: dsp_open_voice_channel_20: [0:1 (52)]
packet_Len=16 channel_id=8516
 packet_id=74 alaw_ulaw_select=1 associated_signaling_channel=0
time_slot=1 serial_port=1
Jan 6 09:53:47.465: dsp_encap_config_20: [0:1 (52)] packet_Len=24
channel_id=8516
 packet_id=92 TransportProtocol 2 t_ssrc=0x0 r_ssrc=0x0 t_vpxcc=0x0 r_vpxcc=0x0
Jan 6 09:53:47.465: dsp_set_playout: [0:1 (52)] packet_Len=18 channel_id=8516
 packet_id=76 mode=1 initial=60 min=4 max=200  fax_nom=300
Jan& 6 09:53:47.465: dsp_echo_canceller_control: [0:1 (52)] packet_Len=10
channel_id=8516
 packet_id=66 flags=0x0
Jan 6 09:53:47.465: dsp_set_gains: [0:1 (52)] packet_Len=12 channel_id=8516
 packet_id=91 in_gain=0 out_gain=0
Jan 6 09:53:47.465: dsp_vad_enable: [0:1 (52)] packet_Len=10 channel_id=8516
 packet_id=78 thresh=-38act_proceeding
Jan 6 09:53:47.469: csm_vtsp_call_proceeding:DST_tdm_chnl call. BP TS
allocatedstream 7,
 chan 0,BP_stream 0, BP_ch 27act_alert
Jan 6 09:53:47.493: vtsp_ring_noan_timer_start: 67189076
Jan 6 09:53:47.493: csm_vtsp_call_alert (vtsp_cdb=0x621C5F3C)
act_bridge act_caps_ind
Jan 6 09:53:47.737: act_caps_ind:Encap 1, Vad 2, Codec 0x4, CodecBytes 20,
 FaxRate 2, FaxBytes 20 SignalType 0
 DtmfRelay 1, Modem 1act_caps_ack
Jan 6 09:53:47.737: dsp_idle_mode: [0:1 (52)] packet_Len=8 channel_id=8516
packet_id=68
Jan 6 09:53:47.737: act_caps_ack: codec = 15, ret = 1
Jan 6 09:53:47.737: dsp_cp_tone_off: [0:1 (52)] packet_Len=8 channel_id=8516
 packet_id=71
Jan 6 09:53:47.737: dsp_idle_mode: [0:1 (52)] packet_Len=8 channel_id=8516
 packet_id=68
Jan 6 09:53:47.737: dsp_encap_config_20: [0:1 (52)] packet_Len=24 channel_id=8516
 packet_id=92 TransportProtocol 2 t_ssrc=0x0 r_ssrc=0x0 t_vpxcc=0x0 r_vpxcc=0x0
Jan 6 09:53:47.737: dsp_voice_mode: [0:1 (52)] packet_Len=24 channel_id=8516
 packet_id=73 coding_type=20 voice_field_size= 20 VAD_flag=1 echo_length=64
 comfort_noise=1 inband_detect=1 digit_relay=2 AGC_flag=0act_alert_connect
Jan 6 09:53:49.461: vtsp_ring_noan_timer_stop: 67189273
Jan 6 09:53:49.461: dsp_cp_tone_off: [0:1 (52)] packet_Len=8 channel_id=8516
  packet_id=71
Jan 6 09:53:49.461: csm_vtsp_call_connect (vtsp_cdb=0x621C5F3C,
voice_vdev=0x620BF320)
Jan 6 09:53:49.461: CSM_IC5_WAIT_FOR_SWITCH_OVER: CSM_EVENT_MODEM_OFFHOOK
  at slot 2, port 15
Jan 6 09:53:49.617: CSM_RX_CAS_EVENT_FROM_NEAT:(0017):  EVENT_CHANNEL_CONNECTED
  at slot 2 and port 15
Jan 6 09:53:49.617: CSM_PROC_IC6_WAIT_FOR_CONNECT: CSM_EVENT_DSX0_CONNECTED
  at slot 2, port 15
Jan 6 09:53:49.621: from NEAT(0): (0/2): TX ANSWERED(ABCD=0101)
eefje#
eefje#

R2 Digital Forçado ANI: Chamada recebida para 567

Para entender melhor esta saída de debug, consulte Teoria de Sinalização E1 R2 .

eefje#debug csm voice
Voice Call Switching Module debugging is on
eefje#debug cas
Channel Associated Signaling debugging is on
Jan 7 10:00:02.907: from NEAT(0): debug-cas is on
Jan 7 10:00:02.907: from NEAT(0): special debug-cas is offg vtsp all
Voice telephony call control all debugging is on
eefje#
eefje#
Jan 7 10:00:23.883: from NEAT(0): (0/8): CAPTURA Rx (ABCD=0001)
Jan 7 10:00:23.927: VDEV_ALLOCATE: failed to allocate a device
Jan 7 10:00:23.927: VDEV_ALLOCATE: 1/2 is allocated
Jan 7 10:00:23.927: csm_vtsp_init_tdm (voice_vdev=0x61F19688)
Jan 7 10:00:23.927: csm_vtsp_init_tdm: dsprm_tdm_allocate: tdm slot 1,
dspm 3, dsp 4,
 dsp_channel 1
Jan 7 10:00:23.927: csm_vtsp_init_tdm: dsprm_tdm_allocate: tdm stream 5,
channel 13,
 bank 0, BP_channel 15, BP_stream 255
Jan 7 10:00:23.927: CSM_RX_CAS_EVENT_FROM_NEAT:(cid0007):
EVENT_CALL_DIAL_IN at slot 1
 and port 60
Jan 7 10:00:23.927: CSM_PROC_IDLE: CSM_EVENT_START_DIGIT_COLLECT at slot 1, port 60
Jan 7 10:00:23.927: csm_vtsp_start_digit_collect (voice_vdev=0x61F19688)
Jan 7 10:00:23.927:  Enter csm_connect_pri_vdev function
Jan 7 10:00:23.927: csm_connect_pri_vdev:tdm_allocate_BP_Ts() call. BP
TS allocated at BP_stream0, BP_Ch8,vdev_common 0x6205E5F8
Jan 7 10:00:23.927: to NEAT:(cid0007) EVENT_CHANNEL_LOCK for slot0 ctlr0 chan8
Jan 7 10:00:23.927: vtsp_do_call_setup_ind
Jan 7 10:00:23.927: vtsp_do_call_setup_ind: Call ID=65579, guid=62031A88
Jan 7 10:00:23.927: vtsp_do_call_setup_ind: type=0, under_spec=0,
name=, id0=0, id1=0,id2=0, calling=, called=
Jan 7 10:00:23.927: vtsp_do_call_setup_ind: redirect DN =  reason =
 0vtsp_do_r2_start_digit(): fsm_push(vtsp_r2_state_table)

Jan 7 10:00:23.927: csm_vtsp_call_setup_resp (vdev_info=0x61F19688,
vtsp_cdb=0x61B5BFF8)
Jan 7 10:00:23.927: csm_vtsp_call_setup_resp:vdev_common
BP TS allocatedat BP_stream0,
 BP_Ch8
Jan 7 10:00:23.927: csm_vtsp_call_setup_resp:DST_tdm_chnl call.
BP TS allocatedat stream
 5, chan 13,BP_stream 255, BP_ch 15
Jan 7 10:00:23.927: csm_vtsp_call_setup_resp:DST_tdm_chnl call.
BP TS allocatedat stream
 5, chan 13,BP_stream 0, BP_ch 8
Jan 7 10:00:23.927: CSM_PROC_IC1_COLLECT_ADDR_INFO: CSM_EVENT_MODEM_OFFHOOK
(DNIS=, ANI=) at slot 1, port 60

Jan 7 10:00:23.931: R2 Incoming Voice(1/60): DSX (E1 0:8): STATE: R2_IN_IDLE
R2 Got Event R2_START
Jan 7 10:00:24.027: CSM_RX_CAS_EVENT_FROM_NEAT:(0007):  EVENT_START_RX_TONE
at slot 1 and port 60
Jan 7 10:00:24.027: from NEAT(0): (0/8): TX SEIZURE_ACK
(ABCD=1101)dc_init_dsp
 vtsp_open_voice_and_set_params
Jan 7 10:00:24.151: dsp_close_voice_channel: [0:1:8] packet_Len=8 channel_id=4929
 packet_id=75
Jan 7 10:00:24.151: dsp_open_voice_channel_20: [0:1:8] packet_Len=16
channel_id=4929
 packet_id=74 alaw_ulaw_select=1 associated_signaling_channel=0
time_slot=0 serial_port=0
Jan 7 10:00:24.151: dsp_encap_config_20: [0:1:8] packet_Len=24 channel_id=4929
 packet_id=92 TransportProtocol 2 t_ssrc=0x0 r_ssrc=0x0 t_vpxcc=0x0 r_vpxcc=0x0
Jan 7 10:00:24.151: dsp_set_playout: [0:1:8] packet_Len=18 channel_id=4929
 packet_id=76 mode=1 initial=60 min=4 max=200 fax_nom=300
Jan 7 10:00:24.151: dsp_echo_canceller_control: [0:1:8]
packet_Len=10 channel_id=4929
 packet_id=66 flags=0x0
Jan 7 10:00:24.151: dsp_set_gains: [0:1:8] packet_Len=12
channel_id=4929 packet_id=91
 in_gain=0 out_gain=0
Jan 7 10:00:24.151: dsp_vad_enable: [0:1:8] packet_Len=10
channel_id=4929 packet_id=78
 thresh=-38
Jan 7 10:00:24.151: dsp_voice_mode: [0:1:8] packet_Len=24
channel_id=4929 packet_id=73
 coding_type=1 voice_field_size=80 VAD_flag=0 echo_length=64
comfort_noise=1
inband_detect=1 digit_relay=2 AGC_flag=0dsp_dtmf_mode
(VTSP_TONE_R2_MF_FORWARD_MODE)

Jan 7 10:00:24.151: dsp_dtmf_mode: [0:1:8] packet_Len=10 channel_id=4929
packet_id=65dtmf_or_mf=1

               !--- Dígito 5 enviado: Encaminhar sinal Group I-5. (Primeiro dígito DNIS)
            
Jan 7 10:00:24.203: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN: digit=5,
 rtp_timestamp=0x04030000 dc_digit_up
Jan 7 10:00:24.203: csm_vtsp_digit_ready_up (vtsp_cdb=0x61B5BFF8)received digit (5)
Jan 7 10:00:24.203: CSM voice (1/60): Rcvd Digit detected(5)
Jan 7 10:00:24.203: R2 Incoming Voice(1/60): DSX (E1 0:8):
STATE:R2_IN_PRE_CALLERID R2
            Got Event 5
            
               !--- Enviar Sinal Invertido Group A-5 (solicitação de categoria de chamador).
            
Jan 7 10:00:24.203: vtsp_r2_generate_digits: vdev_common=0x6205E5F8,
 string=5dc_dial()vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = 5
Jan 7 10:00:24.203: dsp_dtmf_dialing: [0:1:8] packet_Len=24
channel_id=4929packet_id=90
 string=5 digits=1, time_on=65435, time_off=30
Jan 7 10:00:24.203:    digit=, components=2, freq_of_first=1020,
freq_of_second=780,
 amp_of_first=8192, amp_of_second=8192
Jan 7 10:00:24.303: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF:digit=5,
 duration=30dc_digit
Jan 7 10:00:24.303: csm_vtsp_digit_ready (vtsp_cdb=0x61B5BFF8) received digit (5)
Jan 7 10:00:24.303: CSM voice (1/60): Rcvd Digit detected(5)
Jan 7 10:00:24.303: R2 Incoming Voice(1/60): DSX (E1 0:8):
STATE:R2_IN_CALLERID R2
            Got Event R2_TONE_OFF

Jan 7 10:00:24.303: vtsp_r2_generate_digits: vdev_common=0x6205E5F8,
string=5dc_dial()
 vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = #
Jan 7 10:00:24.303: dsp_dtmf_dialing: [0:1:8] packet_Len=24 channel_id=4929
 packet_id=90 string=# digits=1, time_on=150, time_off=30
Jan 7 10:00:24.303:    digit=, components=2, freq_of_first=0, freq_of_second=0,
 amp_of_first=1, amp_of_second=1

               !--- Sinal de Encaminhamento de Categoria de Chamador Group A-1 enviado.
            
Jan 7 10:00:24.403: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN: digit=1,
 rtp_timestamp=0x001E0010 dc_digit_up
Jan 7 10:00:24.403: csm_vtsp_digit_ready_up (vtsp_cdb=0x61B5BFF8)received
digit (1)
Jan 7 10:00:24.403: CSM voice (1/60): Rcvd Digit detected(1)
Jan 7 10:00:24.403: R2 Incoming Voice(1/60): DSX (E1 0:8): STATE:R2_IN_CALLERID R2
 Got Event 1
            
               !--- Enviar Sinal Invertido Group A-5 (solicitação de identificação de chamador).
            
Jan 7 10:00:24.403: vtsp_r2_generate_digits: vdev_common=0x6205E5F8,
string=5dc_dial()
 vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = 5
Jan 7 10:00:24.403: dsp_dtmf_dialing: [0:1:8] packet_Len=24
channel_id=4929 packet_id=90
 string=5 digits=1, time_on=65435, time_off=30
Jan 7 10:00:24.403:    digit=, components=2, freq_of_first=1020, freq_of_second=780,
 amp_of_first=8192, amp_of_second=8192
Jan 7 10:00:24.503: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF: digit=1,
 duration=30dc_digit
Jan 7 10:00:24.503: csm_vtsp_digit_ready (vtsp_cdb=0x61B5BFF8) received digit (1)
Jan 7 10:00:24.503: CSM voice (1/60): Rcvd Digit detected(1)
Jan 7 10:00:24.503: R2 Incoming Voice(1/60): DSX (E1 0:8):
STATE:R2_IN_CALLERID R2
            Got Event R2_TONE_OFF
Jan 7 10:00:24.503: vtsp_r2_generate_digits: vdev_common=0x6205E5F8,
string=5dc_dial()
 vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = #
Jan 7 10:00:24.503: dsp_dtmf_dialing: [0:1:8] packet_Len=24
channel_id=4929 packet_id=90
 string=# digits=1, time_on=150, time_off=30
Jan 7 10:00:24.503:    digit=, components=2, freq_of_first=0, freq_of_second=0,
 amp_of_first=1, amp_of_second=1

               !--- Primeiro dígito ANI foi enviado: Encaminhar sinal Group I-1.
            
Jan  7 10:00:24.603: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN:
            digit=1, rtp_timestamp=0x001E0010 dc_digit_up
Jan 7 10:00:24.603: csm_vtsp_digit_ready_up (vtsp_cdb=0x61B5BFF8) received digit (1)
Jan 7 10:00:24.603: CSM voice (1/60): Rcvd Digit detected(1)
Jan 7 10:00:24.603: R2 Incoming Voice(1/60): DSX (E1 0:8):
STATE:R2_IN_CALLERID R2
             Got Event 1
            
               !--- Enviar Sinal Invertido Group A-5 (solicitação de identificação de chamador).
            
Jan 7 10:00:24.603: vtsp_r2_generate_digits: vdev_common=0x6205E5F8,
 string=5dc_dial()vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = 5

Jan 7 10:00:24.603: dsp_dtmf_dialing: [0:1:8] packet_Len=24
channel_id=4929 packet_id=90
 string=5 digits=1, time_on=65435, time_off=30
Jan 7 10:00:24.603:    digit=, components=2, freq_of_first=1020,
freq_of_second=780,
 amp_of_first=8192, amp_of_second=8192
Jan 7 10:00:24.703: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF: digit=1,
 duration=30dc_digit
Jan 7 10:00:24.703: csm_vtsp_digit_ready (vtsp_cdb=0x61B5BFF8) received digit (1)
Jan 7 10:00:24.703: CSM voice (1/60): Rcvd Digit detected(1)
Jan 7 10:00:24.703: R2 Incoming Voice(1/60): DSX (E1 0:8):
STATE:R2_IN_CALLERID R2
            Got Event R2_TONE_OFF
Jan 7 10:00:24.703: vtsp_r2_generate_digits: vdev_common=0x6205E5F8,
 string=5dc_dial()vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = #
Jan 7 10:00:24.703: dsp_dtmf_dialing: [0:1:8] packet_Len=24
channel_id=4929 packet_id=90
 string=# digits=1, time_on=150, time_off=30
Jan 7 10:00:24.703:    digit=, components=2, freq_of_first=0, freq_of_second=0,
 amp_of_first=1, amp_of_second=1

               !--- Segundo dígito ANI foi enviado: Encaminhar sinal Group I-2.
            
Jan 7 10:00:24.803: vtsp_process_dsp_message:
MSG_TX_DTMF_DIGIT_BEGIN:digit=2,
 rtp_timestamp=0x001E0010 dc_digit_up
Jan 7 10:00:24.803: csm_vtsp_digit_ready_up (vtsp_cdb=0x61B5BFF8)
received digit (2)
Jan 7 10:00:24.803: CSM voice (1/60): Rcvd Digit detected(2)
Jan 7 10:00:24.803: R2 Incoming Voice(1/60): DSX (E1 0:8):
STATE:R2_IN_CALLERID R2
            Got Event 2
            
               !--- Enviar Sinal Invertido Group A-5 (solicitação de identificação de chamador).
            
Jan 7 10:00:24.803: vtsp_r2_generate_digits: vdev_common=0x6205E5F8,
 string=5dc_dial()vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = 5

Jan 7 10:00:24.803: dsp_dtmf_dialing: [0:1:8] packet_Len=24
channel_id=4929packet_id=90
 string=5 digits=1, time_on=65435, time_off=30
Jan 7 10:00:24.803:    digit=, components=2, freq_of_first=1020,
freq_of_second=780,
 amp_of_first=8192, amp_of_second=8192
Jan 7 10:00:24.903: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF: digit=2,
 duration=30dc_digit
Jan 7 10:00:24.903: csm_vtsp_digit_ready (vtsp_cdb=0x61B5BFF8) received digit (2)
Jan 7 10:00:24.903: CSM voice (1/60): Rcvd Digit detected(2)
Jan 7 10:00:24.903: R2 Incoming Voice(1/60): DSX (E1 0:8):
STATE:R2_IN_CALLERID
            R2 Got Event R2_TONE_OFF
Jan 7 10:00:24.903: vtsp_r2_generate_digits: vdev_common=0x6205E5F8,
 string=5dc_dial()vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = #
Jan 7 10:00:24.903: dsp_dtmf_dialing: [0:1:8] packet_Len=24
channel_id=4929 packet_id=90
 string=# digits=1, time_on=150, time_off=30
Jan 7 10:00:24.903:    digit=, components=2, freq_of_first=0,
freq_of_second=0,
 amp_of_first=1, amp_of_second=1

               !--- Terceiro dígito ANI foi enviado: Encaminhar sinal Group I-3.
            
Jan 7 10:00:25.003: vtsp_process_dsp_message:
MSG_TX_DTMF_DIGIT_BEGIN: digit=3,
 rtp_timestamp=0x001E0010 dc_digit_up
Jan 7 10:00:25.003: csm_vtsp_digit_ready_up (vtsp_cdb=0x61B5BFF8)
received digit (3)
Jan 7 10:00:25.003: CSM voice (1/60): Rcvd Digit detected(3)
Jan 7 10:00:25.003: R2 Incoming Voice(1/60): DSX (E1 0:8):
STATE:R2_IN_CALLERID R2
            Got Event 3
            
               !--- Enviar Sinal Invertido Group A-5 (solicitação de identificação de chamador).
            
Jan 7 10:00:25.003: vtsp_r2_generate_digits: vdev_common=0x6205E5F8,
 string=5dc_dial()vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = 5

Jan 7 10:00:25.003: dsp_dtmf_dialing: [0:1:8] packet_Len=24
channel_id=4929 packet_id=90
 string=5 digits=1, time_on=65435, time_off=30
Jan 7 10:00:25.003:    digit=, components=2, freq_of_first=1020,
freq_of_second=780,
 amp_of_first=8192, amp_of_second=8192
Jan 7 10:00:25.103: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF:digit=3,
 duration=30dc_digit
Jan 7 10:00:25.103: csm_vtsp_digit_ready (vtsp_cdb=0x61B5BFF8) received digit (3)
Jan 7 10:00:25.103: CSM voice (1/60): Rcvd Digit detected(3)
Jan 7 10:00:25.103: R2 Incoming Voice(1/60): DSX (E1 0:8):
STATE:R2_IN_CALLERID R2
 Got Event R2_TONE_OFF
Jan 7 10:00:25.103: vtsp_r2_generate_digits: vdev_common=0x6205E5F8,
 string=5dc_dial()vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = #
Jan 7 10:00:25.103: dsp_dtmf_dialing: [0:1:8] packet_Len=24
channel_id=4929 packet_id=90
 string=# digits=1, time_on=150, time_off=30
Jan 7 10:00:25.103:    digit=, components=2, freq_of_first=0,
freq_of_second=0,
 amp_of_first=1, amp_of_second=1

               !--- Dígito 15 enviado: Encaminhar sinal Group I-15. (fim do dígito DNIS)
            
Jan 7 10:00:25.203: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN:
digit=15,
 rtp_timestamp=0x001E0010 dc_digit_up
Jan 7 10:00:25.203: csm_vtsp_digit_ready_up (vtsp_cdb=0x61B5BFF8)
received digit (*)
Jan 7 10:00:25.203: CSM voice (1/60): Rcvd Digit detected(*)
Jan 7 10:00:25.203: R2 Incoming Voice(1/60): DSX (E1 0:8):
STATE:R2_IN_CALLERID R2
             Got Event 15
            
               !--- Enviar Sinal Invertido Group A-1. (próximo dígito DNIS).
            
Jan 7 10:00:25.203: vtsp_r2_generate_digits: vdev_common=0x6205E5F8,
 string=5dc_dial()vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = 1
Jan 7 10:00:25.203: dsp_dtmf_dialing: [0:1:8] packet_Len=24
channel_id=4929 packet_id=90
 string=1 digits=1, time_on=65435, time_off=30
Jan 7 10:00:25.203:    digit=, components=2, freq_of_first=1020,
freq_of_second=1140,
 amp_of_first=8192, amp_of_second=8192
Jan 7 10:00:25.303: vtsp_process_dsp_message:
MSG_TX_DTMF_DIGIT_OFF: digit=15,
 duration=30dc_digit
Jan 7 10:00:25.303: csm_vtsp_digit_ready (vtsp_cdb=0x61B5BFF8) received digit (*)
Jan 7 10:00:25.303: CSM voice (1/60): Rcvd Digit detected(*)
Jan 7 10:00:25.303: R2 Incoming Voice(1/60): DSX (E1 0:8):
 STATE:R2_IN_COLLECT_DNIS R2
            Got Event R2_TONE_OFF
Jan 7 10:00:25.303: vtsp_r2_generate_digits: vdev_common=0x6205E5F8,
 string=5dc_dial()vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = #
Jan 7 10:00:25.303: dsp_dtmf_dialing: [0:1:8] packet_Len=24 channel_id=4929
 packet_id=90 string=# digits=1, time_on=150, time_off=30
Jan 7 10:00:25.303:    digit=, components=2, freq_of_first=0, freq_of_second=0,
 amp_of_first=1, amp_of_second=1

               !--- Segundo dígito DNIS foi enviado: Encaminhar sinal Group I-6.
            
Jan  7 10:00:25.391: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN: digit=6,
 rtp_timestamp=0x001E0010 dc_digit_up
Jan 7 10:00:25.391: csm_vtsp_digit_ready_up (vtsp_cdb=0x61B5BFF8)
received digit (6)
Jan 7 10:00:25.391: CSM voice (1/60): Rcvd Digit detected(6)
Jan 7 10:00:25.391: R2 Incoming Voice(1/60): DSX (E1 0:8):
STATE:R2_IN_COLLECT_DNIS
 R2 Got Event 6
            
               !---  Enviar Sinal Invertido Group I-1.
            
Jan 7 10:00:25.391: vtsp_r2_generate_digits: vdev_common=0x6205E5F8,
string=56dc_dial()
 vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = 1

Jan 7 10:00:25.391: dsp_dtmf_dialing: [0:1:8] packet_Len=24
channel_id=4929 packet_id=90
 string=1 digits=1, time_on=65435, time_off=30
Jan 7 10:00:25.391:    digit=, components=2, freq_of_first=1020,
freq_of_second=1140,
 amp_of_first=8192, amp_of_second=8192
Jan 7 10:00:25.491: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF:digit=6,
 duration=30dc_digit
Jan 7 10:00:25.491: csm_vtsp_digit_ready (vtsp_cdb=0x61B5BFF8) received digit (6)
Jan 7 10:00:25.491: CSM voice (1/60): Rcvd Digit detected(6)
Jan 7 10:00:25.491: R2 Incoming Voice(1/60): DSX (E1 0:8):
STATE: R2_IN_COLLECT_DNIS R2
            Got Event R2_TONE_OFF
Jan 7 10:00:25.491: vtsp_r2_generate_digits: vdev_common=0x6205E5F8,
string=56dc_dial() vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = #
Jan 7 10:00:25.491: dsp_dtmf_dialing: [0:1:8] packet_Len=24
channel_id=4929 packet_id=90
 string=# digits=1, time_on=150, time_off=30
Jan 7 10:00:25.491:    digit=, components=2, freq_of_first=0,
freq_of_second=0,
 amp_of_first=1, amp_of_second=1

               !--- Terceiro dígito DNIS foi enviado: Encaminhar sinal Group I-7.
            
Jan 7 10:00:25.583: vtsp_process_dsp_message:
MSG_TX_DTMF_DIGIT_BEGIN: digit=7,
 rtp_timestamp=0x001E0010 dc_digit_up
Jan 7 10:00:25.583: csm_vtsp_digit_ready_up (vtsp_cdb=0x61B5BFF8)
received digit (7)
Jan 7 10:00:25.583: CSM voice (1/60): Rcvd Digit detected(7)
Jan 7 10:00:25.583: R2 Incoming Voice(1/60): DSX (E1 0:8):
STATE:R2_IN_COLLECT_DNIS R2
            Got Event 7
            
               !---  Enviar Sinal Invertido Group I-1.
            
Jan 7 10:00:25.583: vtsp_r2_generate_digits: vdev_common=0x6205E5F8,
 string=567dc_dial()vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = 1

Jan 7 10:00:25.583: dsp_dtmf_dialing: [0:1:8] packet_Len=24
channel_id=4929 packet_id=90
 string=1 digits=1, time_on=65435, time_off=30
Jan 7 10:00:25.583:    digit=, components=2, freq_of_first=1020,
freq_of_second=1140,
 amp_of_first=8192, amp_of_second=8192
Jan 7 10:00:25.683: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF: digit=7,
 duration=30dc_digit
Jan 7 10:00:25.683: csm_vtsp_digit_ready (vtsp_cdb=0x61B5BFF8)
received digit (7)
Jan 7 10:00:25.683: CSM voice (1/60): Rcvd Digit detected(7)
Jan 7 10:00:25.683: R2 Incoming Voice(1/60): DSX (E1 0:8):
STATE:R2_IN_COLLECT_DNIS R2
            Got Event R2_TONE_OFF
Jan 7 10:00:25.683: vtsp_r2_generate_digits: vdev_common=0x6205E5F8,
 string=567dc_dial()vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = #
Jan 7 10:00:25.683: dsp_dtmf_dialing: [0:1:8] packet_Len=24
channel_id=4929 packet_id=90
 string=# digits=1, time_on=150, time_off=30
Jan 7 10:00:25.683:    digit=, components=2, freq_of_first=0,
freq_of_second=0,
 amp_of_first=1, amp_of_second=1
Jan 7 10:00:25.835: vtsp_process_dsp_message: MSG_TX_DIALING_DONEdc_dialing_done()

               !--- Expiração é de 3 segundos.
            
Jan 7 10:00:28.583: R2 Incoming Voice(1/60): DSX (E1 0:8):
 STATE:R2_IN_COLLECT_DNIS R2
             Got Event R2_TONE_TIMER
            
               !---  Enviar Sinal Invertido Group A-3: endereço-completo, alteração
!--- para recepção de sinal group-B.
            
Jan 7 10:00:28.583: vtsp_r2_generate_digits: vdev_common=0x6205E5F8,
 string=567dc_dial()vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = 3#
Jan 7 10:00:28.583: dsp_dtmf_dialing: [0:1:8] packet_Len=36
channel_id=4929 packet_id=90
 string=3# digits=2, time_on=150, time_off=30
Jan 7 10:00:28.583:    digit=, components=2, freq_of_first=1020,
freq_of_second=900,
 amp_of_first=8192, amp_of_second=8192
Jan 7 10:00:28.583:    digit=, components=2, freq_of_first=0, freq_of_second=0,
 amp_of_first=1, amp_of_second=1

               !--- Sinal de Encaminhamento Group II-1é enviado:  assinante sem prioridade.
            
Jan 7 10:00:28.831: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN: digit=1,
 rtp_timestamp=0x001E0003 dc_digit_up
Jan 7 10:00:28.831: csm_vtsp_digit_ready_up (vtsp_cdb=0x61B5BFF8)
received digit (1)
Jan 7 10:00:28.831: CSM voice (1/60): Rcvd Digit detected(1)
Jan 7 10:00:28.831: R2 Incoming Voice(1/60): DSX (E1 0:8):
STATE:R2_IN_CATEGORY R2
 Got Event 1
Jan 7 10:00:28.831: CSM_PROC_IC1_COLLECT_ADDR_INFO:
CSM_EVENT_ADDR_INFO_COLLECTED
(DNIS=567, ANI=123) at slot 1, port 60
Jan 7 10:00:28.831: vtsp_tsp_call_accept_check (sdb=0x61DADEE0,
calling_number=123
 called_number=567): peer_tag=0
Jan 7 10:00:28.835: VDEV_ALLOCATE: failed to allocate a device
Jan 7 10:00:28.835: VDEV_ALLOCATE_ALMOST_READY: failed to allocate
 a non-idle modem
Jan 7 10:00:28.835: VDEV_ALLOCATE: failed to allocate a device
Jan 7 10:00:28.835: VDEV_ALLOCATE_ALMOST_READY: failed to allocate
a non-idle modem
Jan 7 10:00:28.835: VDEV_ALLOCATE: failed to allocate a device
Jan 7 10:00:28.835: VDEV_ALLOCATE_ALMOST_READY: failed to allocate
a non-idle modem
Jan 7 10:00:28.835: CSM_PROC_IC3_WAIT_FOR_RES_RESP: CSM_EVENT_RESOURCE_OK
at slot 1,
 port 60
Jan 7 10:00:28.835: vtsp_IC_switch : (voice_vdev= 0x61F19688)
Jan 7 10:00:28.835: vtsp_tsp_call_switch_ind (cdb=0x61B5BFF8,
tsp_info=0x61F19688,
 calling_number=123 called_number=567 redirect_number=):
peer_tag=123dc_switch: fsm_pop()
Jan 7 10:00:28.835: vtsp_do_call_setup_ind
Jan 7 10:00:28.835: vtsp_do_call_setup_ind: Call ID=65581,
guid=62031A88
Jan 7 10:00:28.835: vtsp_do_call_setup_ind: type=0, under_spec=0,
name=b`, id0=9,
 id1=0, id2=0, calling=123, called=567
Jan 7 10:00:28.835: dsp_cp_tone_off: [] packet_Len=8 channel_id=4929
packet_id=71
Jan 7 10:00:28.835: dsp_idle_mode: [] packet_Len=8 channel_id=4929
packet_id=68
Jan 7 10:00:28.835: dsp_close_voice_channel: [] packet_Len=8
channel_id=4929 packet_id=75
Jan 7 10:00:28.835: vtsp_timer_stop: 7063006
Jan 7 10:00:28.839: csm_vtsp_call_setup_resp (vdev_info=0x61F19688,
vtsp_cdb=0x61B5BFF8)
Jan 7 10:00:28.839: csm_vtsp_call_setup_resp:vdev_common BP TS
allocatedat BP_stream0,
 BP_Ch8
Jan 7 10:00:28.839: csm_vtsp_call_setup_resp:DST_tdm_chnl call.
 BP TS allocatedat stream 5, chan 13,BP_stream 0, BP_ch 8
Jan 7 10:00:28.839: csm_vtsp_call_setup_resp:DST_tdm_chnl call.
 BP TS allocatedat stream 5, chan 13,BP_stream 0, BP_ch
8vtsp_open_voice_and_set_params
Jan 7 10:00:28.839: dsp_close_voice_channel: [0:1 (17)]
packet_Len=8 channel_id=4929
 packet_id=75
Jan 7 10:00:28.839: dsp_open_voice_channel_20: [0:1 (17)] packet_Len=16
channel_id=4929
 packet_id=74 alaw_ulaw_select=1 associated_signaling_channel=0
time_slot=0 serial_port=0
Jan 7 10:00:28.839: dsp_encap_config_20: [0:1 (17)] packet_Len=24
channel_id=4929
 packet_id=92 TransportProtocol 2 t_ssrc=0x0 r_ssrc=0x0t_vpxcc=0x0
r_vpxcc=0x0
Jan 7 10:00:28.839: dsp_set_playout: [0:1 (17)] packet_Len=18
channel_id=4929 packet_id=76 mode=1 initial=60 min=4 max=200 fax_nom=300
Jan 7 10:00:28.839: dsp_echo_canceller_control: [0:1 (17)]
packet_Len=10 channel_id=4929
 packet_id=66 flags=0x0
Jan 7 10:00:28.839: dsp_set_gains: [0:1 (17)] packet_Len=12
channel_id=4929 packet_id=91
 in_gain=0 out_gain=0
Jan 7 10:00:28.839: dsp_vad_enable: [0:1 (17)] packet_Len=10
channel_id=4929 packet_id=78
 thresh=-38act_proceeding
Jan 7 10:00:28.839: csm_vtsp_call_proceeding:DST_tdm_chnl call.
BP TS allocatedstream 5,
 chan 13,BP_stream 0, BP_ch 8act_alert
Jan 7 10:00:28.867: vtsp_ring_noan_timer_start: 7063009
Jan 7 10:00:28.867: csm_vtsp_call_alert (vtsp_cdb=0x61B5BFF8)
Jan 7 10:00:28.867:  csm_vtsp_call_alert: CSM_EVENT_ALERTING_RECEIVED
Jan 7 10:00:28.867: CSM_IC5_WAIT_FOR_SWITCH_OVER:  at slot 1, port 60
Jan 7 10:00:28.867: CSM_EVENT_ALERTING_RECEIVED:
Jan 7 10:00:28.867:  calling alerting_start_event

               !--- Observação: Para modems, Sinal invertido
!--- Group B-6  (linha de assinante gratuita, cobrança).
!--- envio imediato.
!--- Para voz, há um retardo até o recebimento do alerta.
!--- Observe que é impresso "R2_REJECT" em vez de R2_ALERTING.
!--- Este problema de impressão foi resolvido no Cisco IOS Software Release 12.1T.
            
Jan 7 10:00:28.867: R2 Incoming Voice(1/60): DSX (E1 0:8):
STATE:R2_IN_IDLE R2
            Got Event R2_REJECT
Jan 7 10:00:28.867:  R2_ALERTING: r2_comp_idle
Jan 7 10:00:28.867: vtsp_r2_generate_digits: vdev_common=0x6205E5F8,
string=567act_bridge
Jan 7 10:00:28.867: dsp_voice_mode: [0:1 (17)] packet_Len=24
channel_id=4929 packet_id=73
 coding_type=1 voice_field_size=80 VAD_flag=0 echo_length=64
comfort_noise=1
 inband_detect=1 digit_relay=2 AGC_flag=0dsp_dtmf_mode
(VTSP_TONE_R2_MF_FORWARD_MODE)

               !--- O sinal de resposta (B-6) é enviado após o recebimento do alerta.
!--- Enviar Sinal Inverso Group B6  (linha de assinante gratuita, cobrança).
            
Jan 7 10:00:28.871: dsp_dtmf_mode: [0:1 (17)] packet_Len=10
channel_id=4929 packet_id=65
 dtmf_or_mf=1vtsp_r2_dial vtsp_r2_dial(): fsm_push(vtsp_r2_state_table)
 dsp_dtmf_dialing(): dial_string = 6

Jan 7 10:00:28.871: dsp_dtmf_dialing: [0:1 (17)] packet_Len=24
channel_id=4929
 packet_id=90 string=6 digits=1, time_on=65435, time_off=30
Jan 7 10:00:28.871:    digit=, components=2, freq_of_first=900,
freq_of_second=780,
 amp_of_first=8192, amp_of_second=8192
Jan 7 10:00:28.923: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_BEGIN: digit=1,
 rtp_timestamp=0x001E0006 dc_digit_up
Jan 7 10:00:28.923: csm_vtsp_digit_ready_up (vtsp_cdb=0x61B5BFF8)
received digit (1)
Jan 7 10:00:28.923: CSM voice (1/60): Rcvd Digit detected(1)
Jan 7 10:00:28.923: R2 Incoming Voice(1/60): DSX (E1 0:8):
STATE: R2_IN_COMPLETE
 R2 Got Event 1
Jan 7 10:00:28.971: vtsp_process_dsp_message: MSG_TX_DTMF_DIGIT_OFF: digit=1,
 duration=30dc_digit
Jan 7 10:00:28.971: csm_vtsp_digit_ready (vtsp_cdb=0x61B5BFF8)
received digit (1)
Jan 7 10:00:28.971: CSM voice (1/60): Rcvd Digit detected(1)
Jan 7 10:00:28.971: R2 Incoming Voice(1/60): DSX (E1 0:8):
STATE: R2_IN_COMPLETE R2
            Got Event R2_TONE_OFF
Jan 7 10:00:28.971: vtsp_r2_generate_digits: vdev_common=0x6205E5F8,
string=567dc_dial()
 vtsp_dial_nopush dsp_dtmf_dialing(): dial_string = #
Jan 7 10:00:28.971: dsp_dtmf_dialing: [0:1 (17)] packet_Len=24
channel_id=4929
 packet_id=90 string=# digits=1, time_on=150, time_off=30
Jan 7 10:00:28.975:    digit=, components=2, freq_of_first=0,
freq_of_second=0,
 amp_of_first=1, amp_of_second=1ds_dialing_defaultds_dialing_default
Jan 7 10:00:29.127: vtsp_process_dsp_message:
MSG_TX_DIALING_DONEdc_dialing_done()
Jan 7 10:00:29.971: R2 Incoming Voice(1/60): DSX (E1 0:8):
STATE: R2_IN_WAIT_GUARD R2
 Got Event R2_TONE_TIMER 
Jan 7 10:00:29.971:  R2_IN_IDLE:2 r2_in_connect called
Jan 7 10:00:29.971: R2_IN_CONNECT: call end dial
Jan 7 10:00:29.971:  pop the dial state machine
Jan 7 10:00:29.971: vtsp_r2_end_dial: vdev_common=0x6205E5F8,
string=567ds_end_dial():
 fsm_pop() act_caps_ind
Jan 7 10:00:29.971: act_caps_ind:Encap 1, Vad 2, Codec 0x4,
CodecBytes 20, FaxRate 2,
 FaxBytes 20 SignalType 0 DtmfRelay 1, Modem 1act_caps_ack
Jan 7 10:00:29.971: dsp_idle_mode: [0:1 (17)] packet_Len=8
channel_id=4929 packet_id=68
Jan 7 10:00:29.971: act_caps_ack: codec = 15, ret = 1
Jan 7 10:00:29.971: dsp_cp_tone_off: [0:1 (17)] packet_Len=8
channel_id=4929 packet_id=71
Jan 7 10:00:29.971: dsp_idle_mode: [0:1 (17)] packet_Len=8
channel_id=4929 packet_id=68
Jan 7 10:00:29.971: dsp_encap_config_20: [0:1 (17)] packet_Len=24
channel_id=4929
 packet_id=92 TransportProtocol 2 t_ssrc=0x0 r_ssrc=0x0 t_vpxcc=0x0
r_vpxcc=0x0
Jan 7 10:00:29.971: dsp_voice_mode: [0:1 (17)] packet_Len=24
channel_id=4929 packet_id=73
 coding_type=19 voice_field_size=20 VAD_flag=1 echo_length=64
comfort_noise=1
 inband_detect=1 digit_relay=2 AGC_flag=0act_alert_connect
Jan 7 10:00:30.255: vtsp_ring_noan_timer_stop: 7063148
Jan 7 10:00:30.255: dsp_cp_tone_off: [0:1 (17)] packet_Len=8
channel_id=4929 packet_id=71
Jan 7 10:00:30.255: csm_vtsp_call_connect (vtsp_cdb=0x61B5BFF8,
voice_vdev=0x61F19688)
Jan 7 10:00:30.255: CSM_IC5_WAIT_FOR_SWITCH_OVER:
CSM_EVENT_MODEM_OFFHOOK at slot 1,
 port 60
Jan 7 10:00:30.607: CSM_RX_CAS_EVENT_FROM_NEAT:(0007):
EVENT_CHANNEL_CONNECTED at slot 1
 and port 60
Jan 7 10:00:30.607: CSM_PROC_IC6_WAIT_FOR_CONNECT:
CSM_EVENT_DSX0_CONNECTED at slot 1,
 port 60
Jan 7 10:00:30.607: from NEAT(0): (0/8): TX ANSWERED (ABCD=0101)
eefje# 

Discussões relacionadas da comunidade de suporte da Cisco

A Comunidade de Suporte da Cisco é um fórum onde você pode perguntar e responder, oferecer sugestões e colaborar com colegas.


Informações Relacionadas


Document ID: 12154