[asterisk-r2] Incoming Calls hungup using MFCR2 Protocol - unhandled 2nd category request ?

Sat Jun 6 11:34:41 CDT 2015

Hi,

incoming calls fails, it seems that openr2 hangup the call after
receive 0x31 after receive DNIS, when it send a category request (5) ?

[11:40:45:804] [Thread: 3062889360] [Chan 24] - M - Call started at
Sat Jun  6 11:40:45 2015 on chan 24 [openr2 version 1.3.3, revision
(release)]
[11:40:45:804] [Thread: 3062889360] [Chan 24] - M - Initialized R2 MF detector
[11:40:45:804] [Thread: 3062889360] [Chan 24] - M - CAS Tx >> [SEIZE ACK] 0x0C
[11:40:45:804] [Thread: 3062889360] [Chan 24] - M - CAS Raw Tx >> 0x0D
[11:40:45:868] [Thread: 3062889360] [Chan 24] - M - MF Rx << 4 [ON]
[11:40:45:868] [Thread: 3062889360] [Chan 24] - M - Attempting to
cancel timer timer 0
[11:40:45:868] [Thread: 3062889360] [Chan 24] - M - Cannot cancel timer 0
[11:40:45:868] [Thread: 3062889360] [Chan 24] - M - Getting DNIS digit 4
[11:40:45:868] [Thread: 3062889360] [Chan 24] - M - DNIS so far: 4,
expected length: 3
[11:40:45:868] [Thread: 3062889360] [Chan 24] - M - MF Tx >> 5 [ON]
[11:40:45:868] [Thread: 3062889360] [Chan 24] - M - scheduled timer id
2 (mf_back_cycle)
[11:40:45:927] [Thread: 3062889360] [Chan 24] - M - MF Rx << 4 [OFF]
[11:40:45:927] [Thread: 3062889360] [Chan 24] - M - MF Tx >> 5 [OFF]
[11:40:45:987] [Thread: 3062889360] [Chan 24] - M - MF Rx << 1 [ON]
[11:40:45:987] [Thread: 3062889360] [Chan 24] - M - Attempting to
cancel timer timer 2
[11:40:45:987] [Thread: 3062889360] [Chan 24] - M - timer id 2 found,
cancelling it now
[11:40:45:987] [Thread: 3062889360] [Chan 24] - M - MF Tx >> 9 [ON]
[11:40:45:987] [Thread: 3062889360] [Chan 24] - M - scheduled timer id
3 (mf_back_cycle)
[11:40:46:047] [Thread: 3062889360] [Chan 24] - M - MF Rx << 1 [OFF]
[11:40:46:047] [Thread: 3062889360] [Chan 24] - M - MF Tx >> 9 [OFF]
[11:40:46:108] [Thread: 3062889360] [Chan 24] - M - MF Rx << 2 [ON]
[11:40:46:108] [Thread: 3062889360] [Chan 24] - M - Attempting to
cancel timer timer 3
[11:40:46:108] [Thread: 3062889360] [Chan 24] - M - timer id 3 found,
cancelling it now
[11:40:46:108] [Thread: 3062889360] [Chan 24] - M - Getting ANI digit 2
[11:40:46:108] [Thread: 3062889360] [Chan 24] - M - ANI so far: 2,
expected length: 10
[11:40:46:108] [Thread: 3062889360] [Chan 24] - M - MF Tx >> 9 [ON]
[11:40:46:108] [Thread: 3062889360] [Chan 24] - M - scheduled timer id
4 (mf_back_cycle)
[11:40:46:168] [Thread: 3062889360] [Chan 24] - M - MF Rx << 2 [OFF]
[11:40:46:168] [Thread: 3062889360] [Chan 24] - M - MF Tx >> 9 [OFF]
[11:40:46:228] [Thread: 3062889360] [Chan 24] - M - MF Rx << 1 [ON]
[11:40:46:228] [Thread: 3062889360] [Chan 24] - M - Attempting to
cancel timer timer 4
[11:40:46:228] [Thread: 3062889360] [Chan 24] - M - timer id 4 found,
cancelling it now
[11:40:46:228] [Thread: 3062889360] [Chan 24] - M - Getting ANI digit 1
[11:40:46:228] [Thread: 3062889360] [Chan 24] - M - ANI so far: 21,
expected length: 10
[11:40:46:228] [Thread: 3062889360] [Chan 24] - M - MF Tx >> 9 [ON]
[11:40:46:228] [Thread: 3062889360] [Chan 24] - M - scheduled timer id
5 (mf_back_cycle)
[11:40:46:288] [Thread: 3062889360] [Chan 24] - M - MF Rx << 1 [OFF]
[11:40:46:288] [Thread: 3062889360] [Chan 24] - M - MF Tx >> 9 [OFF]
[11:40:46:348] [Thread: 3062889360] [Chan 24] - M - MF Rx << 2 [ON]
[11:40:46:348] [Thread: 3062889360] [Chan 24] - M - Attempting to
cancel timer timer 5
[11:40:46:348] [Thread: 3062889360] [Chan 24] - M - timer id 5 found,
cancelling it now
[11:40:46:348] [Thread: 3062889360] [Chan 24] - M - Getting ANI digit 2
[11:40:46:348] [Thread: 3062889360] [Chan 24] - M - ANI so far: 212,
expected length: 10
[11:40:46:348] [Thread: 3062889360] [Chan 24] - M - MF Tx >> 9 [ON]
[11:40:46:348] [Thread: 3062889360] [Chan 24] - M - scheduled timer id
6 (mf_back_cycle)
[11:40:46:387] [Thread: 3062889360] [Chan 24] - M - MF Rx << 2 [OFF]
[11:40:46:387] [Thread: 3062889360] [Chan 24] - M - MF Tx >> 9 [OFF]
[11:40:46:468] [Thread: 3062889360] [Chan 24] - M - MF Rx << 9 [ON]
[11:40:46:468] [Thread: 3062889360] [Chan 24] - M - Attempting to
cancel timer timer 6
[11:40:46:468] [Thread: 3062889360] [Chan 24] - M - timer id 6 found,
cancelling it now
[11:40:46:468] [Thread: 3062889360] [Chan 24] - M - Getting ANI digit 9
[11:40:46:468] [Thread: 3062889360] [Chan 24] - M - ANI so far: 2129,
expected length: 10
[11:40:46:468] [Thread: 3062889360] [Chan 24] - M - MF Tx >> 9 [ON]
[11:40:46:468] [Thread: 3062889360] [Chan 24] - M - scheduled timer id
7 (mf_back_cycle)
[11:40:46:508] [Thread: 3062889360] [Chan 24] - M - MF Rx << 9 [OFF]
[11:40:46:508] [Thread: 3062889360] [Chan 24] - M - MF Tx >> 9 [OFF]
[11:40:46:587] [Thread: 3062889360] [Chan 24] - M - MF Rx << 7 [ON]
[11:40:46:588] [Thread: 3062889360] [Chan 24] - M - Attempting to
cancel timer timer 7
[11:40:46:588] [Thread: 3062889360] [Chan 24] - M - timer id 7 found,
cancelling it now
[11:40:46:588] [Thread: 3062889360] [Chan 24] - M - Getting ANI digit 7
[11:40:46:588] [Thread: 3062889360] [Chan 24] - M - ANI so far: 21297,
expected length: 10
[11:40:46:588] [Thread: 3062889360] [Chan 24] - M - MF Tx >> 9 [ON]
[11:40:46:588] [Thread: 3062889360] [Chan 24] - M - scheduled timer id
8 (mf_back_cycle)
[11:40:46:648] [Thread: 3062889360] [Chan 24] - M - MF Rx << 7 [OFF]
[11:40:46:648] [Thread: 3062889360] [Chan 24] - M - MF Tx >> 9 [OFF]
[11:40:46:707] [Thread: 3062889360] [Chan 24] - M - MF Rx << 8 [ON]
[11:40:46:708] [Thread: 3062889360] [Chan 24] - M - Attempting to
cancel timer timer 8
[11:40:46:708] [Thread: 3062889360] [Chan 24] - M - timer id 8 found,
cancelling it now
[11:40:46:708] [Thread: 3062889360] [Chan 24] - M - Getting ANI digit 8
[11:40:46:708] [Thread: 3062889360] [Chan 24] - M - ANI so far:
212978, expected length: 10
[11:40:46:708] [Thread: 3062889360] [Chan 24] - M - MF Tx >> 9 [ON]
[11:40:46:708] [Thread: 3062889360] [Chan 24] - M - scheduled timer id
9 (mf_back_cycle)
[11:40:46:767] [Thread: 3062889360] [Chan 24] - M - MF Rx << 8 [OFF]
[11:40:46:768] [Thread: 3062889360] [Chan 24] - M - MF Tx >> 9 [OFF]
[11:40:46:828] [Thread: 3062889360] [Chan 24] - M - MF Rx << 5 [ON]
[11:40:46:828] [Thread: 3062889360] [Chan 24] - M - Attempting to
cancel timer timer 9
[11:40:46:828] [Thread: 3062889360] [Chan 24] - M - timer id 9 found,
cancelling it now
[11:40:46:828] [Thread: 3062889360] [Chan 24] - M - Getting ANI digit 5
[11:40:46:828] [Thread: 3062889360] [Chan 24] - M - ANI so far:
2129785, expected length: 10
[11:40:46:828] [Thread: 3062889360] [Chan 24] - M - MF Tx >> 9 [ON]
[11:40:46:828] [Thread: 3062889360] [Chan 24] - M - scheduled timer id
10 (mf_back_cycle)
[11:40:46:887] [Thread: 3062889360] [Chan 24] - M - MF Rx << 5 [OFF]
[11:40:46:888] [Thread: 3062889360] [Chan 24] - M - MF Tx >> 9 [OFF]
[11:40:46:947] [Thread: 3062889360] [Chan 24] - M - MF Rx << 4 [ON]
[11:40:46:947] [Thread: 3062889360] [Chan 24] - M - Attempting to
cancel timer timer 10
[11:40:46:947] [Thread: 3062889360] [Chan 24] - M - timer id 10 found,
cancelling it now
[11:40:46:947] [Thread: 3062889360] [Chan 24] - M - Getting ANI digit 4
[11:40:46:947] [Thread: 3062889360] [Chan 24] - M - ANI so far:
21297854, expected length: 10
[11:40:46:947] [Thread: 3062889360] [Chan 24] - M - MF Tx >> 9 [ON]
[11:40:46:947] [Thread: 3062889360] [Chan 24] - M - scheduled timer id
11 (mf_back_cycle)
[11:40:47:007] [Thread: 3062889360] [Chan 24] - M - MF Rx << 4 [OFF]
[11:40:47:007] [Thread: 3062889360] [Chan 24] - M - MF Tx >> 9 [OFF]
[11:40:47:067] [Thread: 3062889360] [Chan 24] - M - MF Rx << 2 [ON]
[11:40:47:067] [Thread: 3062889360] [Chan 24] - M - Attempting to
cancel timer timer 11
[11:40:47:068] [Thread: 3062889360] [Chan 24] - M - timer id 11 found,
cancelling it now
[11:40:47:068] [Thread: 3062889360] [Chan 24] - M - Getting ANI digit 2
[11:40:47:068] [Thread: 3062889360] [Chan 24] - M - ANI so far:
212978542, expected length: 10
[11:40:47:068] [Thread: 3062889360] [Chan 24] - M - MF Tx >> 9 [ON]
[11:40:47:068] [Thread: 3062889360] [Chan 24] - M - scheduled timer id
12 (mf_back_cycle)
[11:40:47:108] [Thread: 3062889360] [Chan 24] - M - MF Rx << 2 [OFF]
[11:40:47:108] [Thread: 3062889360] [Chan 24] - M - MF Tx >> 9 [OFF]
[11:40:47:167] [Thread: 3062889360] [Chan 24] - M - MF Rx << 3 [ON]
[11:40:47:167] [Thread: 3062889360] [Chan 24] - M - Attempting to
cancel timer timer 12
[11:40:47:168] [Thread: 3062889360] [Chan 24] - M - timer id 12 found,
cancelling it now
[11:40:47:168] [Thread: 3062889360] [Chan 24] - M - Getting ANI digit 3
[11:40:47:168] [Thread: 3062889360] [Chan 24] - M - ANI so far:
2129785423, expected length: 10
[11:40:47:168] [Thread: 3062889360] [Chan 24] - M - Done getting ANI!
[11:40:47:168] [Thread: 3062889360] [Chan 24] - M - Requesting next
DNIS with signal 0x31.
[11:40:47:168] [Thread: 3062889360] [Chan 24] - M - MF Tx >> 1 [ON]
[11:40:47:168] [Thread: 3062889360] [Chan 24] - M - scheduled timer id
13 (mf_back_cycle)
[11:40:47:247] [Thread: 3062889360] [Chan 24] - M - MF Rx << 3 [OFF]
[11:40:47:248] [Thread: 3062889360] [Chan 24] - M - MF Tx >> 1 [OFF]
[11:40:47:307] [Thread: 3062889360] [Chan 24] - M - MF Rx << 0 [ON]
[11:40:47:307] [Thread: 3062889360] [Chan 24] - M - Attempting to
cancel timer timer 13
[11:40:47:307] [Thread: 3062889360] [Chan 24] - M - timer id 13 found,
cancelling it now
[11:40:47:307] [Thread: 3062889360] [Chan 24] - M - Getting DNIS digit 0
[11:40:47:307] [Thread: 3062889360] [Chan 24] - M - DNIS so far: 40,
expected length: 3
[11:40:47:307] [Thread: 3062889360] [Chan 24] - M - Requesting next
DNIS with signal 0x31.
[11:40:47:308] [Thread: 3062889360] [Chan 24] - M - MF Tx >> 1 [ON]
[11:40:47:308] [Thread: 3062889360] [Chan 24] - M - scheduled timer id
14 (mf_back_cycle)
[11:40:47:367] [Thread: 3062889360] [Chan 24] - M - MF Rx << 0 [OFF]
[11:40:47:368] [Thread: 3062889360] [Chan 24] - M - MF Tx >> 1 [OFF]
[11:40:47:447] [Thread: 3062889360] [Chan 24] - M - MF Rx << 0 [ON]
[11:40:47:448] [Thread: 3062889360] [Chan 24] - M - Attempting to
cancel timer timer 14
[11:40:47:448] [Thread: 3062889360] [Chan 24] - M - timer id 14 found,
cancelling it now
[11:40:47:448] [Thread: 3062889360] [Chan 24] - M - Getting DNIS digit 0
[11:40:47:448] [Thread: 3062889360] [Chan 24] - M - DNIS so far: 400,
expected length: 3
[11:40:47:448] [Thread: 3062889360] [Chan 24] - M - Done getting DNIS!
[11:40:47:448] [Thread: 3062889360] [Chan 24] - M - By-passing B/II
signals, accept the call with signal 0x0
[11:40:47:448] [Thread: 3062889360] [Chan 24] - M - MF Tx >> 5 [ON]
[11:40:47:448] [Thread: 3062889360] [Chan 24] - M - scheduled timer id
15 (mf_back_cycle)
[11:40:47:507] [Thread: 3062889360] [Chan 24] - M - MF Rx << 0 [OFF]
[11:40:47:507] [Thread: 3062889360] [Chan 24] - M - MF Tx >> 5 [OFF]
[11:40:47:567] [Thread: 3062889360] [Chan 24] - M - MF Rx << 1 [ON]
[11:40:47:568] [Thread: 3062889360] [Chan 24] - M - Attempting to
cancel timer timer 15
[11:40:47:568] [Thread: 3062889360] [Chan 24] - M - timer id 15 found,
cancelling it now
[11:40:47:568] [Thread: 3062889360] [Chan 24] - M - Protocol error.
Reason = Invalid Multy Frequency State, R2 State = Seize ACK
Transmitted, MF state = Disconnect Tone Transmitted, MF Group =
Backward Group A, CAS = 0x00
DNIS = 400, ANI = 2129785423, MF = 0x31

equipment:

Xorcom equipment (astribank PRI E1-R2) / Elastix 2.5 with asterisk
11.17.1 / dahdi 2.10.0.1

; Span 3: XBUS-01/XPD-00 "Xorcom XPD #01/00: E1" ENTRANTES CANTV
group=13
; Sample for CANTV
signalling=mfcr2
mfcr2_variant=ve
mfcr2_get_ani_first=yes
mfcr2_immediate_accept=yes
mfcr2_max_ani=10
mfcr2_max_dnis=3
mfcr2_category=national_subscriber
mfcr2_mfback_timeout=-1

mfcr2_logdir=cantv
mfcr2_logging=all
mfcr2_call_files=yes

channel => 23-37,39-53
context = default
group = 63

-- 

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

This message may contain confidential information or privileged
material, and is intended only for the individual(s) named. If you are
not in the named address you should not disseminate, distribute or
copy this e-mail. Please notify the sender immediately by e-mail if
you have received this e-mail by mistake and delete this e-mail from
your system.
E-mail transmission cannot be guaranteed to be secure or error-free as
information could be intercepted, corrupted, lost, destroyed, arrive
late or incomplete, or contain viruses. The sender therefore does not
accept liability for any errors or omissions in the contents of this
message which arise as a result of e-mail transmission. If
verification is required please request a hard-copy version.