[asterisk-r2] Protocol error. Reason = Invalid CAS

Thu Oct 25 18:29:53 CDT 2012

Hola Estimado,

Es posible que sea problemas en el sincronismo, verifica que la señal
del clock la tome desde la operadora. Si tienes acceso a un analizador
de protocolo, o pedirle que lo conecten la gente de telefonica a ver
si aparecen errores de deslizamiento en la trama.

Tambien puedes revisar la asignacion de IRQs en el computador, trata
de que no se compartan recursos con la tarjeta. Que tipo de tarjeta
madre / procesador / discos estas utilizando?

Revisa en el dahdi_tool, el contador de irq_misses, deberia mantenerse en 0.

Es lo que revisaria primero, por la naturaleza intermitente del error,
y que por lo que dices que funcionan las llamandas.

Saludos desde Venezuela.

-- 

Atentamente,
Ing. Ettore Eliseo Pelliccioni Monrroy

Tlf.:+58.212.7626555
Móvil:+58.414.1111330
Skype:ettore.pelliccioni
eMail/msn: ettore.pelliccioni at techniclite.com
Web site: www.techniclite.com

2012/10/25 Diego G. Perez <diegoperez891 at gmail.com>:
> Si, perdón. Acá va:
>
> /etc/dahdi/system.conf:
>
> span=1,1,0,cas,hdb3
> cas=1-15:1101
> #echocanceller=mg2,1-15,17-31
>
> # Global data
>
> loadzone    = ar
> defaultzone    = ar
>
> /etc/asterisk/chan_dahdi.conf:
>
> [trunkgroups]
> [channels]
> language=es
> usecallerid=yes
> hidecallerid=no
> callwaiting=yes
> usecallingpres=yes
> callwaitingcallerid=yes
> threewaycalling=yes
> transfer=yes
> cancallforward=yes
> callreturn=yes
> echocancel=yes
> echocancelwhenbridged=yes
> relaxdtmf=yes
> inmediate=no
> resetinterval=never
>
> ; ---------------- Options for use with signalling=mfcr2 --------------
> signalling=mfcr2
> mfcr2_variant=ar
> mfcr2_max_ani=10
> mfcr2_max_dnis=4
> mfcr2_get_ani_first=no
> mfcr2_category=national_subscriber
> mfcr2_logdir=telco
> mfcr2_call_files=yes
> mfcr2_logging=all
>
> ; mfcr2_mfback_timeout=-1
> ; mfcr2_metering_pulse_timeout=-1
>
> ; ---------------- END of options to be used with signalling=mfcr2
>
> context=from-telco
> group=0
> channel => 1-15
>
> Gracias
>
> El 25/10/12 10:31, Nacho miguel escribió:
>
> Como tenes configurada la trama ? falta ese archivo.
>
> chan_dahdi.conf
> /etc/dahdi/system.conf
>
>> Date: Thu, 25 Oct 2012 10:06:58 -0300
>> From: diegoperez891 at gmail.com
>> To: asterisk-r2 at lists.digium.com
>> Subject: [asterisk-r2] Protocol error. Reason = Invalid CAS
>>
>> Buenos dias,
>>
>> Tengo media trama(15 canales) contratados con Telefónica Argentina, las
>> llamadas funcionan bien.
>>
>> Asterisk: 1.8.11.1
>> Dahdi: 2.6.0
>> OpenR2 version: 1.3.2, revision: exportado
>> Placa digium TE121
>>
>> Pero aleatoriamente durante el día obtengo alrededor de 10 veces este
>> error en el log de asterisk::
>>
>> [Oct 24 21:53:06] VERBOSE[15083] app_dial.c: -- Called Dahdi/r0/4429682
>> [Oct 24 21:53:12] VERBOSE[15083] chan_dahdi.c: MFC/R2 call has been
>> accepted on forward channel 6
>> [Oct 24 21:53:12] VERBOSE[15083] app_dial.c: -- DAHDI/6-1 is ringing
>> [Oct 24 21:53:12] VERBOSE[15083] app_dial.c: -- DAHDI/6-1 is making
>> progress passing it to SIP/12720-00000d91
>> [Oct 24 21:53:25] VERBOSE[15083] chan_dahdi.c: MFC/R2 call has been
>> answered on channel 6
>> [Oct 24 21:53:25] VERBOSE[15083] app_dial.c: -- DAHDI/6-1 answered
>> SIP/12720-00000d91
>> [Oct 24 21:56:38] VERBOSE[15083] chan_dahdi.c: -- Hungup 'DAHDI/6-1'
>> [Oct 24 21:56:38] VERBOSE[15083] pbx.c: == Spawn extension
>> (user-locales, 4429682, 5) exited non-zero on 'SIP/12720-00000d91'
>> [Oct 24 21:59:29] ERROR[2066] chan_dahdi.c: Chan 6 - Protocol error.
>> Reason = Invalid CAS, R2 State = Clear Back After Clear Forward
>> Received,MF state = MF Engine Off, MF Group = Forward Group II, CAS = 0x0C
>> DNIS = 4429682, ANI = 12720, MF = 0x20
>> [Oct 24 21:59:29] ERROR[2066] chan_dahdi.c: MFC/R2 protocol error on
>> chan 6: Invalid CAS
>> [Oct 24 21:59:32] NOTICE[2066] chan_dahdi.c: Far end unblocked on chan 6
>>
>>
>> Y acá esta el .call de la llamada:
>>
>> [21:53:06:796] [Thread: 140321340434176] [Chan 6] - Call started at Wed
>> Oct 24 21:53:06 2012 on chan 6 [openr2 version 1.3.2, revision exportado]
>> [21:53:06:796] [Thread: 140321340434176] [Chan 6] - Outgoing call
>> proceeding: ANI=12720, DNIS=4429682, Category=National Subscriber
>> [21:53:06:796] [Thread: 140321340434176] [Chan 6] - CAS Tx >> [SEIZE] 0x00
>> [21:53:06:796] [Thread: 140321340434176] [Chan 6] - CAS Raw Tx >> 0x01
>> [21:53:06:796] [Thread: 140321340434176] [Chan 6] - scheduled timer id 2
>> (r2_seize)
>> [21:53:07:002] [Thread: 140321340434176] [Chan 6] - Bits changed from
>> 0x08 to 0x0C
>> [21:53:07:002] [Thread: 140321340434176] [Chan 6] - CAS Rx << [SEIZE
>> ACK] 0x0C
>> [21:53:07:002] [Thread: 140321340434176] [Chan 6] - Attempting to cancel
>> timer timer 2
>> [21:53:07:002] [Thread: 140321340434176] [Chan 6] - timer id 2 found,
>> cancelling it now
>> [21:53:07:002] [Thread: 140321340434176] [Chan 6] - MFC/R2 call
>> acknowledge!
>> [21:53:07:002] [Thread: 140321340434176] [Chan 6] - Sending DNIS digit 4
>> [21:53:07:002] [Thread: 140321340434176] [Chan 6] - MF Tx >> 4 [ON]
>> [21:53:07:095] [Thread: 140321340434176] [Chan 6] - MF Rx << 5 [ON]
>> [21:53:07:095] [Thread: 140321340434176] [Chan 6] - Attempting to cancel
>> timer timer 0
>> [21:53:07:095] [Thread: 140321340434176] [Chan 6] - Cannot cancel timer 0
>> [21:53:07:095] [Thread: 140321340434176] [Chan 6] - MF Tx >> 4 [OFF]
>> [21:53:07:155] [Thread: 140321340434176] [Chan 6] - MF Rx << 5 [OFF]
>> [21:53:07:155] [Thread: 140321340434176] [Chan 6] - Sending category
>> National Subscriber
>> [21:53:07:155] [Thread: 140321340434176] [Chan 6] - MF Tx >> 1 [ON]
>> [21:53:07:235] [Thread: 140321340434176] [Chan 6] - MF Rx << 5 [ON]
>> [21:53:07:235] [Thread: 140321340434176] [Chan 6] - Attempting to cancel
>> timer timer 0
>> [21:53:07:235] [Thread: 140321340434176] [Chan 6] - Cannot cancel timer 0
>> [21:53:07:235] [Thread: 140321340434176] [Chan 6] - MF Tx >> 1 [OFF]
>> [21:53:07:295] [Thread: 140321340434176] [Chan 6] - MF Rx << 5 [OFF]
>> [21:53:07:295] [Thread: 140321340434176] [Chan 6] - Sending ANI digit 1
>> [21:53:07:295] [Thread: 140321340434176] [Chan 6] - MF Tx >> 1 [ON]
>> [21:53:07:395] [Thread: 140321340434176] [Chan 6] - MF Rx << 5 [ON]
>> [21:53:07:395] [Thread: 140321340434176] [Chan 6] - Attempting to cancel
>> timer timer 0
>> [21:53:07:395] [Thread: 140321340434176] [Chan 6] - Cannot cancel timer 0
>> [21:53:07:395] [Thread: 140321340434176] [Chan 6] - MF Tx >> 1 [OFF]
>> [21:53:07:475] [Thread: 140321340434176] [Chan 6] - MF Rx << 5 [OFF]
>> [21:53:07:475] [Thread: 140321340434176] [Chan 6] - Sending ANI digit 2
>> [21:53:07:475] [Thread: 140321340434176] [Chan 6] - MF Tx >> 2 [ON]
>> [21:53:07:555] [Thread: 140321340434176] [Chan 6] - MF Rx << 5 [ON]
>> [21:53:07:555] [Thread: 140321340434176] [Chan 6] - Attempting to cancel
>> timer timer 0
>> [21:53:07:555] [Thread: 140321340434176] [Chan 6] - Cannot cancel timer 0
>> [21:53:07:555] [Thread: 140321340434176] [Chan 6] - MF Tx >> 2 [OFF]
>> [21:53:07:615] [Thread: 140321340434176] [Chan 6] - MF Rx << 5 [OFF]
>> [21:53:07:615] [Thread: 140321340434176] [Chan 6] - Sending ANI digit 7
>> [21:53:07:615] [Thread: 140321340434176] [Chan 6] - MF Tx >> 7 [ON]
>> [21:53:07:695] [Thread: 140321340434176] [Chan 6] - MF Rx << 5 [ON]
>> [21:53:07:695] [Thread: 140321340434176] [Chan 6] - Attempting to cancel
>> timer timer 0
>> [21:53:07:695] [Thread: 140321340434176] [Chan 6] - Cannot cancel timer 0
>> [21:53:07:695] [Thread: 140321340434176] [Chan 6] - MF Tx >> 7 [OFF]
>> [21:53:07:775] [Thread: 140321340434176] [Chan 6] - MF Rx << 5 [OFF]
>> [21:53:07:775] [Thread: 140321340434176] [Chan 6] - Sending ANI digit 2
>> [21:53:07:775] [Thread: 140321340434176] [Chan 6] - MF Tx >> 2 [ON]
>> [21:53:07:854] [Thread: 140321340434176] [Chan 6] - MF Rx << 5 [ON]
>> [21:53:07:854] [Thread: 140321340434176] [Chan 6] - Attempting to cancel
>> timer timer 0
>> [21:53:07:854] [Thread: 140321340434176] [Chan 6] - Cannot cancel timer 0
>> [21:53:07:854] [Thread: 140321340434176] [Chan 6] - MF Tx >> 2 [OFF]
>> [21:53:07:915] [Thread: 140321340434176] [Chan 6] - MF Rx << 5 [OFF]
>> [21:53:07:915] [Thread: 140321340434176] [Chan 6] - Sending ANI digit 0
>> [21:53:07:915] [Thread: 140321340434176] [Chan 6] - MF Tx >> 0 [ON]
>> [21:53:07:995] [Thread: 140321340434176] [Chan 6] - MF Rx << 5 [ON]
>> [21:53:07:995] [Thread: 140321340434176] [Chan 6] - Attempting to cancel
>> timer timer 0
>> [21:53:07:995] [Thread: 140321340434176] [Chan 6] - Cannot cancel timer 0
>> [21:53:07:995] [Thread: 140321340434176] [Chan 6] - MF Tx >> 0 [OFF]
>> [21:53:08:055] [Thread: 140321340434176] [Chan 6] - MF Rx << 5 [OFF]
>> [21:53:08:055] [Thread: 140321340434176] [Chan 6] - Sending more ANI
>> unavailable
>> [21:53:08:055] [Thread: 140321340434176] [Chan 6] - MF Tx >> C [ON]
>> [21:53:08:155] [Thread: 140321340434176] [Chan 6] - MF Rx << 1 [ON]
>> [21:53:08:155] [Thread: 140321340434176] [Chan 6] - Attempting to cancel
>> timer timer 0
>> [21:53:08:155] [Thread: 140321340434176] [Chan 6] - Cannot cancel timer 0
>> [21:53:08:155] [Thread: 140321340434176] [Chan 6] - MF Tx >> C [OFF]
>> [21:53:08:215] [Thread: 140321340434176] [Chan 6] - MF Rx << 1 [OFF]
>> [21:53:08:215] [Thread: 140321340434176] [Chan 6] - Sending DNIS digit 4
>> [21:53:08:215] [Thread: 140321340434176] [Chan 6] - MF Tx >> 4 [ON]
>> [21:53:08:215] [Thread: 140321340434176] [Chan 6] - Group A DNIS request
>> handled
>> [21:53:08:315] [Thread: 140321340434176] [Chan 6] - MF Rx << 1 [ON]
>> [21:53:08:315] [Thread: 140321340434176] [Chan 6] - Attempting to cancel
>> timer timer 0
>> [21:53:08:315] [Thread: 140321340434176] [Chan 6] - Cannot cancel timer 0
>> [21:53:08:315] [Thread: 140321340434176] [Chan 6] - MF Tx >> 4 [OFF]
>> [21:53:08:375] [Thread: 140321340434176] [Chan 6] - MF Rx << 1 [OFF]
>> [21:53:08:375] [Thread: 140321340434176] [Chan 6] - Sending DNIS digit 2
>> [21:53:08:375] [Thread: 140321340434176] [Chan 6] - MF Tx >> 2 [ON]
>> [21:53:08:375] [Thread: 140321340434176] [Chan 6] - Group A DNIS request
>> handled
>> [21:53:08:475] [Thread: 140321340434176] [Chan 6] - MF Rx << 1 [ON]
>> [21:53:08:475] [Thread: 140321340434176] [Chan 6] - Attempting to cancel
>> timer timer 0
>> [21:53:08:475] [Thread: 140321340434176] [Chan 6] - Cannot cancel timer 0
>> [21:53:08:475] [Thread: 140321340434176] [Chan 6] - MF Tx >> 2 [OFF]
>> [21:53:08:555] [Thread: 140321340434176] [Chan 6] - MF Rx << 1 [OFF]
>> [21:53:08:555] [Thread: 140321340434176] [Chan 6] - Sending DNIS digit 9
>> [21:53:08:555] [Thread: 140321340434176] [Chan 6] - MF Tx >> 9 [ON]
>> [21:53:08:555] [Thread: 140321340434176] [Chan 6] - Group A DNIS request
>> handled
>> [21:53:08:635] [Thread: 140321340434176] [Chan 6] - MF Rx << 1 [ON]
>> [21:53:08:635] [Thread: 140321340434176] [Chan 6] - Attempting to cancel
>> timer timer 0
>> [21:53:08:635] [Thread: 140321340434176] [Chan 6] - Cannot cancel timer 0
>> [21:53:08:635] [Thread: 140321340434176] [Chan 6] - MF Tx >> 9 [OFF]
>> [21:53:08:695] [Thread: 140321340434176] [Chan 6] - MF Rx << 1 [OFF]
>> [21:53:08:695] [Thread: 140321340434176] [Chan 6] - Sending DNIS digit 6
>> [21:53:08:695] [Thread: 140321340434176] [Chan 6] - MF Tx >> 6 [ON]
>> [21:53:08:695] [Thread: 140321340434176] [Chan 6] - Group A DNIS request
>> handled
>> [21:53:08:775] [Thread: 140321340434176] [Chan 6] - MF Rx << 1 [ON]
>> [21:53:08:775] [Thread: 140321340434176] [Chan 6] - Attempting to cancel
>> timer timer 0
>> [21:53:08:775] [Thread: 140321340434176] [Chan 6] - Cannot cancel timer 0
>> [21:53:08:775] [Thread: 140321340434176] [Chan 6] - MF Tx >> 6 [OFF]
>> [21:53:08:835] [Thread: 140321340434176] [Chan 6] - MF Rx << 1 [OFF]
>> [21:53:08:835] [Thread: 140321340434176] [Chan 6] - Sending DNIS digit 8
>> [21:53:08:835] [Thread: 140321340434176] [Chan 6] - MF Tx >> 8 [ON]
>> [21:53:08:835] [Thread: 140321340434176] [Chan 6] - Group A DNIS request
>> handled
>> [21:53:08:975] [Thread: 140321340434176] [Chan 6] - MF Rx << 1 [ON]
>> [21:53:08:975] [Thread: 140321340434176] [Chan 6] - Attempting to cancel
>> timer timer 0
>> [21:53:08:975] [Thread: 140321340434176] [Chan 6] - Cannot cancel timer 0
>> [21:53:08:975] [Thread: 140321340434176] [Chan 6] - MF Tx >> 8 [OFF]
>> [21:53:09:054] [Thread: 140321340434176] [Chan 6] - MF Rx << 1 [OFF]
>> [21:53:09:054] [Thread: 140321340434176] [Chan 6] - Sending DNIS digit 2
>> [21:53:09:054] [Thread: 140321340434176] [Chan 6] - MF Tx >> 2 [ON]
>> [21:53:09:054] [Thread: 140321340434176] [Chan 6] - Group A DNIS request
>> handled
>> [21:53:09:374] [Thread: 140321340434176] [Chan 6] - MF Rx << 1 [ON]
>> [21:53:09:374] [Thread: 140321340434176] [Chan 6] - Attempting to cancel
>> timer timer 0
>> [21:53:09:374] [Thread: 140321340434176] [Chan 6] - Cannot cancel timer 0
>> [21:53:09:374] [Thread: 140321340434176] [Chan 6] - MF Tx >> 2 [OFF]
>> [21:53:09:435] [Thread: 140321340434176] [Chan 6] - MF Rx << 1 [OFF]
>> [21:53:09:435] [Thread: 140321340434176] [Chan 6] - No more DNIS. Doing
>> nothing, waiting for timeout.
>> [21:53:09:435] [Thread: 140321340434176] [Chan 6] - scheduled timer id 3
>> (mf_fwd_safety)
>> [21:53:09:435] [Thread: 140321340434176] [Chan 6] - Group A DNIS request
>> handled
>> [21:53:12:315] [Thread: 140321340434176] [Chan 6] - MF Rx << 3 [ON]
>> [21:53:12:315] [Thread: 140321340434176] [Chan 6] - Attempting to cancel
>> timer timer 3
>> [21:53:12:315] [Thread: 140321340434176] [Chan 6] - timer id 3 found,
>> cancelling it now
>> [21:53:12:435] [Thread: 140321340434176] [Chan 6] - MF Rx << 3 [OFF]
>> [21:53:12:435] [Thread: 140321340434176] [Chan 6] - Sending category
>> National Subscriber
>> [21:53:12:435] [Thread: 140321340434176] [Chan 6] - MF Tx >> 1 [ON]
>> [21:53:12:515] [Thread: 140321340434176] [Chan 6] - MF Rx << 6 [ON]
>> [21:53:12:515] [Thread: 140321340434176] [Chan 6] - Attempting to cancel
>> timer timer 0
>> [21:53:12:515] [Thread: 140321340434176] [Chan 6] - Cannot cancel timer 0
>> [21:53:12:515] [Thread: 140321340434176] [Chan 6] - MF Tx >> 1 [OFF]
>> [21:53:12:595] [Thread: 140321340434176] [Chan 6] - MF Rx << 6 [OFF]
>> [21:53:12:595] [Thread: 140321340434176] [Chan 6] - scheduled timer id 4
>> (r2_answer)
>> [21:53:25:091] [Thread: 140321340434176] [Chan 6] - Bits changed from
>> 0x0C to 0x04
>> [21:53:25:091] [Thread: 140321340434176] [Chan 6] - CAS Rx << [ANSWER]
>> 0x04
>> [21:53:25:091] [Thread: 140321340434176] [Chan 6] - Attempting to cancel
>> timer timer 4
>> [21:53:25:091] [Thread: 140321340434176] [Chan 6] - timer id 4 found,
>> cancelling it now
>> [21:53:25:091] [Thread: 140321340434176] [Chan 6] - Attempting to cancel
>> timer timer 0
>> [21:53:25:091] [Thread: 140321340434176] [Chan 6] - Cannot cancel timer 0
>> [21:56:38:607] [Thread: 140321340434176] [Chan 6] - Attempting to cancel
>> timer timer 0
>> [21:56:38:607] [Thread: 140321340434176] [Chan 6] - Cannot cancel timer 0
>> [21:56:38:607] [Thread: 140321340434176] [Chan 6] - CAS Tx >> [CLEAR
>> FORWARD] 0x08
>> [21:56:38:607] [Thread: 140321340434176] [Chan 6] - CAS Raw Tx >> 0x09
>> [21:56:38:960] [Thread: 140321482045184] [Chan 6] - Bits changed from
>> 0x04 to 0x00
>> [21:56:38:960] [Thread: 140321482045184] [Chan 6] - CAS Rx << [FORCED
>> RELEASE] 0x00
>> [21:59:29:138] [Thread: 140321482045184] [Chan 6] - Bits changed from
>> 0x00 to 0x0C
>> [21:59:29:138] [Thread: 140321482045184] [Chan 6] - CAS Rx << [0x0C] 0x0C
>> [21:59:29:138] [Thread: 140321482045184] [Chan 6] - Protocol error.
>> Reason = Invalid CAS, R2 State = Clear Back After Clear Forward
>> Received, MF state = MF Engine Off, MF Group = Forwar$
>> DNIS = 4429682, ANI = 12720, MF = 0x20
>> [21:59:29:138] [Thread: 140321482045184] [Chan 6] - Attempting to cancel
>> timer timer 0
>> [21:59:29:138] [Thread: 140321482045184] [Chan 6] - Cannot cancel timer 0
>>
>> Cambié los BALUN y conectores pero sigue fallando.
>>
>> Muchas Gracias!
>>
>> Saludos
>>
>> Diego
>>
>>
>>
>> --
>> _____________________________________________________________________
>> -- Bandwidth and Colocation Provided by http://www.api-digital.com --
>>
>> asterisk-r2 mailing list
>> To UNSUBSCRIBE or update options visit:
>> http://lists.digium.com/mailman/listinfo/asterisk-r2
>
>
> --
> _____________________________________________________________________
> -- Bandwidth and Colocation Provided by http://www.api-digital.com --
>
> asterisk-r2 mailing list
> To UNSUBSCRIBE or update options visit:
>    http://lists.digium.com/mailman/listinfo/asterisk-r2
>
>
>
> --
> _____________________________________________________________________
> -- Bandwidth and Colocation Provided by http://www.api-digital.com --
>
> asterisk-r2 mailing list
> To UNSUBSCRIBE or update options visit:
>    http://lists.digium.com/mailman/listinfo/asterisk-r2

--