Снял сегодня трассы параллельно с WTIC2 и с системы (см. файл).
И возникли вопросы к знающим людям по трассе с WTICa.
Звоню с № 2100 (DECT ID 56) получаю следующее:
16:16:05
Inst Dev Bmc Slt Frq RqT Typ Adpcm Llme TmStamp
-----------------------------------------------
0 38 6 0 8 0 3 ff 2 ae9709
##### Diff Adpcmslot bp->speechAddr(ff) DevAdpcmSlot(0)

Dev 38 - это я (56 = 38НЕХ).

Всего у меня DECT абонентов 74.

Тогда, что означает след сообщение:
13:21:64
Inst Dev Bmc Slt Frq RqT Typ Adpcm Llme TmStamp
-----------------------------------------------
0 18 5 2 2 0 3 0 2 afd70a
1 ff 7 6 6 0 3 ff ff 0
2 de 7 0 3 0 3 ff 1 afec0d

Откуда взялись Dev ff (255) и de (222).

И этот абонент (Dev de) слишком "часто" звонит.

Снимая инфу с СОМ порта платы WTIC2 получил ранее не виданные сообщения.

15.10.2016
12:15:30
Inst Dev Bmc Slt Frq RqT Typ Adpcm Llme TmStamp
-----------------------------------------------
0 28 7 0 5 0 3 0 1 f8e105
1 de 7 8 5 1 3 ff 0 f9c506
##### Diff Adpcmslot bp->speechAddr(ff) DevAdpcmSlot(3)
[BmcRxMtInd] testmode = 37

Трубки не работают
13:39:31
Inst Dev Bmc Slt Frq RqT Typ Adpcm Llme TmStamp
-----------------------------------------------
0 de 7 2 7 0 3 ff 0 75360d
##### Diff Adpcmslot bp->speechAddr(ff) DevAdpcmSlot(85)
dev(2b) evt(e8) No llme
dev(21) evt(e8) No llme
dev(6) evt(e8) No llme
[BmcRxMtInd] testmode = 37
[BmcRxMtInd] testmode = 37
++co_bho_speech(e:70) b:4, s:8, adpcm=0 (mfc=a0 b, fc=a)
++co_bho_speech(e:70) b:4, s:2, adpcm=0 (mfc=a0 f5, fc=2)
[BmcRxMtInd] testmode = 37
[BmcRxMtInd] testmode = 37
dev(1) evt(e8) No llme

Перезагрузка плат WTIC2.

16.10.2016

Всегда было так
9:14:20
TxQ=13 0 9 85 57 f0 f0 f0 c6 6d
RxQ=Empty RxQ !!!

а в выходные 2 или 3 раза так
19:19:37
TxQ=13 0 9 85 57 f0 f0 f0 c6 6d
RxQ=5 54 5 a 80 c0 10 1 5b 9c 6f de 0 12 6 7 81 a8 10 9 9f fa 4 7 1 5f 63 3 c2 82 84 78 3 2 83 3b

20:12:18
Inst Dev Bmc Slt Frq RqT Typ Adpcm Llme TmStamp
-----------------------------------------------
0 de 4 2 0 0 3 ff 0 61c105
##### Diff Adpcmslot bp->speechAddr(ff) DevAdpcmSlot(85)
[INFO_IND] Unknown MULTI_KEYPAD Key value : 8f
[INFO_IND] Unknown MULTI_KEYPAD Key value : 1
[INFO_IND] Unknown MULTI_KEYPAD Key value : c0
[INFO_IND] Unknown MULTI_KEYPAD Key value : 8f
[INFO_IND] Unknown MULTI_KEYPAD Key value : 1
[INFO_IND] Unknown MULTI_KEYPAD Key value : c0

Трубки не работают
20:48:35
Inst Dev Bmc Slt Frq RqT Typ Adpcm Llme TmStamp
-----------------------------------------------
0 de 4 0 7 0 3 ff 0 d4a605
##### Diff Adpcmslot bp->speechAddr(ff) DevAdpcmSlot(85)
Invalid lce after getlcefromllme lce(ff) llme (0)
[nwerr] UnrecognisedMsgErr!
[RcvMessageProc] Error detected.

Перезагрузка плат.

17.10.2016

"Призрачный" абонент за первый час звонил 95 раз.
00:01:11
Inst Dev Bmc Slt Frq RqT Typ Adpcm Llme TmStamp
-----------------------------------------------
0 de 7 a 8 0 3 ff 0 608f06
##### Diff Adpcmslot bp->speechAddr(ff) DevAdpcmSlot(85)

06:19:44
Inst Dev Bmc Slt Frq RqT Typ Adpcm Llme TmStamp
-----------------------------------------------
0 de 7 4 2 0 3 ff 0 8a7e07
##### Diff Adpcmslot bp->speechAddr(ff) DevAdpcmSlot(85)
No Empty LCE instance in GetEmptyLce
EP(dev:0 e:44 s:2a)

No Empty LCE instance in GetEmptyLce
EP(dev:0 e:44 s:2a) начало появляться чаще.

Потом появилось такое

08:09:12
Inst Dev Bmc Slt Frq RqT Typ Adpcm Llme TmStamp
-----------------------------------------------
0 de 7 4 4 0 3 ff 0 2aaa0f
##### Diff Adpcmslot bp->speechAddr(ff) DevAdpcmSlot(85)
No Empty LCE instance in GetEmptyLce
EP(dev:0 e:44 s:2a)
No Empty LCE instance in GetEmptyLce
No Empty LCE instance PreProcLceEvents
No Empty LCE instance in GetEmptyLce
EP(dev:0 e:44 s:2a)
Invalid lce after getlcefromllme lce(ff) llme (0)
No Empty LCE instance in GetEmptyLce
No Empty LCE instance PreProcLceEvents

С 9-00 начались жалобы, на не работающие трубки в цоколе. У меня на 4 этаже всё работало.
В цоколе трубки работали "хаотично" - в кабинете 1 работает, 2 не работают.

Сообщения в файле.

В 9-30 всё совсем померло и перезагрузил платы.

Сегодня увидел вот такие сообщения.
Вроде всё как обычно - "фантом" названивает, но "убило" время...

05:01:63
Inst Dev Bmc Slt Frq RqT Typ Adpcm Llme TmStamp
-----------------------------------------------
0 de 2 8 7 1 3 ff 0 8fe704
##### Diff Adpcmslot bp->speechAddr(ff) DevAdpcmSlot(85)
05:09:63
Inst Dev Bmc Slt Frq RqT Typ Adpcm Llme TmStamp
-----------------------------------------------
0 de 2 4 7 0 3 ff 0 9ad307
##### Diff Adpcmslot bp->speechAddr(ff) DevAdpcmSlot(85)
[BmcRxMtInd] testmode = 37

Сегодня попробовал команду CTIME, вот что выдало (телефоны работают):

Делал звонок с № 2112 (трубка) на № 2101 (СТА) (не уверен, что все относится к звонку)
Призрачный абонент (de) тоже засветился.

LGE:WTiC2> CTIME 1
Call On/Off time print Enabled
LGE:WTiC2> BrInd(0): Rf(6,a,7) p(0041) T(0) (a4 af 6)
BrCfm: Rf(6,a 7) p(0041) T(0) b:0 (a4 af a)
l(0) 16:29:05
BrInd(0): Rf(4,0,8) p(e6fde) T(0) (a4 b0 0)
BrCfm: Rf(4,0 8) p(e6fde) T(0) b:1 (a4 b0 4)
l(1) 16:29:06
[SetSpeechOpen] SUCCESS...Dev(065), ADPCM(00)
[ConnectDev] Device connected.
dis_ind: Rf(4,0,8) p(e6fde) S(20) (a4 b2 6)
>dis_ind Rf(4,0) p(e6fde) r=0 F=2 (a4 b2 7) 16:29:06
BrInd(0): Rf(4,2,5) p(e6fde) T(0) (a4 b7 5)
dis_ind: Rf(4,2,5) p(ffffff) S(10) (a4 b7 9)
>dis_ind_op Rf(4,2) p(ffffff) r=0 F=42 (a4 b7 a) 16:29:07
MAC Normal Mode : CO Release Bearer
BrInd(0): Rf(4,a,7) p(e6fde) T(0) (a4 b8 c)
BrCfm: Rf(4,a 7) p(e6fde) T(0) b:1 (a4 b8 e)
Invalid Access_connect mac(1)
mac_inst(1) - llme(ff) ==> released 16:29:07
[mfasub] inv inst! e:73 b:4 s:a
[mfasub] inv inst! e:73 b:4 s:a
BrInd(0): Rf(4,2,2) p(e6fde) T(0) (a4 ba 4)
BrCfm: Rf(4,2 2) p(e6fde) T(0) b:1 (a4 ba 8)
Invalid Access_connect mac(1)
mac_inst(1) - llme(ff) ==> released 16:29:07
[mfasub] inv inst! e:73 b:4 s:2
[mfasub] inv inst! e:73 b:4 s:2
BrInd(0): Rf(4,4,8) p(e6fde) T(0) (a4 bb f)
BrCfm: Rf(4,4 8) p(e6fde) T(0) b:1 (a4 bc 1)
Invalid Access_connect mac(1)
mac_inst(1) - llme(ff) ==> released 16:29:07
[mfasub] inv inst! e:73 b:4 s:4
[mfasub] inv inst! e:73 b:4 s:4
DL05TimeOut(dev:12, llme:1)
InvalidSendToMac e(6a) d(12) llme(1) mcei1(ffffff) mcei2(ffffff)
ClrLlme: l(1),d(12)
BrInd(0): Rf(4,8,0) p(e6fde) T(0) (a4 c7 f)
BrCfm: Rf(4,8 0) p(e6fde) T(0) b:1 (a4 c8 2)
l(1) 16:29:09
dis_ind: Rf(4,8,0) p(e6fde) S(20) (a4 ca 1)
>dis_ind Rf(4,8) p(e6fde) r=0 F=2 (a4 ca 2) 16:29:10
BrInd(0): Rf(4,2,5) p(e6fde) T(0) (a4 cb 5)
dis_ind: Rf(4,2,5) p(ffffff) S(10) (a4 cb 7)
>dis_ind_op Rf(4,2) p(ffffff) r=0 F=42 (a4 cb 8) 16:29:10
MAC Normal Mode : CO Release Bearer
BrInd(0): Rf(4,a,0) p(e6fde) T(0) (a4 d2 9)
BrCfm: Rf(4,a 0) p(e6fde) T(0) b:1 (a4 d2 c)
Invalid Access_connect mac(1)
mac_inst(1) - llme(ff) ==> released 16:29:11
[mfasub] inv inst! e:73 b:4 s:a
[mfasub] inv inst! e:73 b:4 s:a
DL05TimeOut(dev:12, llme:1)
InvalidSendToMac e(6a) d(12) llme(1) mcei1(ffffff) mcei2(ffffff)
ClrLlme: l(1),d(12)
BrInd(0): Rf(4,a,7) p(e6fde) T(0) (a4 d6 c)
BrCfm: Rf(4,a 7) p(e6fde) T(0) b:1 (a4 d7 0)
l(1) 16:29:12
dis_ind: Rf(4,a,7) p(e6fde) S(20) (a4 d9 3)
>dis_ind Rf(4,a) p(e6fde) r=0 F=2 (a4 d9 4) 16:29:12
BrInd(0): Rf(4,4,7) p(e6fde) T(0) (a4 da 8)
dis_ind: Rf(4,4,7) p(ffffff) S(10) (a4 da 9)
>dis_ind_op Rf(4,4) p(ffffff) r=0 F=42 (a4 da a) 16:29:12
MAC Normal Mode : CO Release Bearer
BrInd(0): Rf(4,0,5) p(e6fde) T(0) (a4 dc d)
dis_ind: Rf(4,0,5) p(ffffff) S(10) (a4 dd 2)
>dis_ind_op Rf(4,0) p(ffffff) r=0 F=42 (a4 dd 3) 16:29:13
MAC Normal Mode : CO Release Bearer
BrInd(0): Rf(4,2,5) p(e6fde) T(0) (a4 e1 d)
dis_ind: Rf(4,2,5) p(ffffff) S(10) (a4 e2 f)
>dis_ind_op Rf(4,2) p(ffffff) r=0 F=42 (a4 e2 0) 16:29:13
MAC Normal Mode : CO Release Bearer
BrInd(0): Rf(4,0,6) p(e6fde) T(0) (a4 e3 2)
BrCfm: Rf(4,0 6) p(e6fde) T(0) b:1 (a4 e3 5)
Invalid Access_connect mac(1)
mac_inst(1) - llme(ff) ==> released 16:29:14
[mfasub] inv inst! e:81 b:4 s:0
[mfasub] inv inst! e:81 b:4 s:0
DL05TimeOut(dev:12, llme:1)
InvalidSendToMac e(6a) d(12) llme(1) mcei1(ffffff) mcei2(ffffff)
ClrLlme: l(1),d(12)
BrInd(0): Rf(4,0,0) p(e6fde) T(0) (a5 c 0)
BrCfm: Rf(4,0 0) p(e6fde) T(0) b:1 (a5 c 3)
l(1) 16:29:20
dis_ind: Rf(4,0,0) p(e6fde) S(20) (a5 e 2)
>dis_ind Rf(4,0) p(e6fde) r=0 F=2 (a5 e 3) 16:29:21
BrInd(0): Rf(4,2,5) p(e6fde) T(0) (a5 f 8)
dis_ind: Rf(4,2,5) p(ffffff) S(10) (a5 f
>dis_ind_op Rf(4,2) p(ffffff) r=0 F=42 (a5 f c) 16:29:21
MAC Normal Mode : CO Release Bearer
BrInd(0): Rf(4,4,7) p(e6fde) T(0) (a5 10 d)
dis_ind: Rf(4,4,7) p(ffffff) S(10) (a5 11 1)
>dis_ind_op Rf(4,4) p(ffffff) r=0 F=42 (a5 11 2) 16:29:21
MAC Normal Mode : CO Release Bearer
BrInd(0): Rf(4,a,0) p(e6fde) T(0) (a5 14 d)
BrCfm: Rf(4,a 0) p(e6fde) T(0) b:1 (a5 15 0)
Invalid Access_connect mac(1)
mac_inst(1) - llme(ff) ==> released 16:29:22
[mfasub] inv inst! e:73 b:4 s:a
BrInd(0): Rf(4,4,7) p(e6fde) T(0) (a5 19 0)
BrCfm: Rf(4,4 7) p(e6fde) T(0) b:1 (a5 19 4)
Invalid Access_connect mac(1)
mac_inst(1) - llme(ff) ==> released 16:29:22
[mfasub] inv inst! e:73 b:4 s:4
[mfasub] inv inst! e:73 b:4 s:4
BrInd(0): Rf(4,a,7) p(e6fde) T(0) (a5 1a 4)
DL05TimeOut(dev:12, llme:1)
InvalidSendToMac e(6a) d(12) llme(1) mcei1(ffffff) mcei2(ffffff)
BrCfm: Rf(4,a 7) p(e6fde) T(0) b:1 (a5 1a 7)
l(2) 16:29:23
ClrLlme: l(1),d(12)
==2_sec: b:4 r:a dev:de (a5 26 c)
[dltmr:04] d(12: 2) 1 --->ReT to m1(121) m2(ffffff) 16:29:25
BrInd(0): Rf(4,2,1) p(e6fde) T(0) (a5 29 8)
BrCfm: Rf(4,2 1) p(e6fde) T(0) b:2 (a5 29 c)
Invalid Access_connect mac(2)
mac_inst(2) - llme(ff) ==> released 16:29:25
[mfasub] inv inst! e:73 b:4 s:2
[mfasub] inv inst! e:73 b:4 s:2
BrInd(0): Rf(4,0,8) p(e6fde) T(0) (a5 2b 2)
dis_ind: Rf(4,0,8) p(ffffff) S(10) (a5 2b 6)
>dis_ind_op Rf(4,0) p(ffffff) r=0 F=42 (a5 2b 7) 16:29:25
MAC Normal Mode : CO Release Bearer
DIS_REQ: b(6) i(0) s(20)
--dis_speech(e:6a) b:6, s:a adpcm=0 (mfc=a5 2b, fc=c)
ClrLlme: l(0),d(41)
BrInd(0): Rf(4,2,1) p(e6fde) T(0) (a5 2c 9)
BrCfm: Rf(4,2 1) p(e6fde) T(0) b:0 (a5 2c d)
Invalid Access_connect mac(0)
mac_inst(0) - llme(ff) ==> released 16:29:25
[mfasub] inv inst! e:73 b:4 s:2
[mfasub] inv inst! e:73 b:4 s:2
==3_sec: b:4 r:a dev:de (a5 2d 2)
BrInd(0): Rf(4,0,9) p(e6fde) T(0) (a5 2e 5)
dis_ind: Rf(4,0,9) p(ffffff) S(10) (a5 2e a)
>dis_ind_op Rf(4,0) p(ffffff) r=0 F=42 (a5 2e 16:29:26
MAC Normal Mode : CO Release Bearer
==4_sec: b:4 r:a dev:de (a5 33 4)
[dltmr:04] d(12: 2) 2 --->ReT to m1(121) m2(ffffff)
==5_sec_TO(1st) -> b:4 r:a dev:de (a5 39 8) 16:29:27
Inst Dev Bmc Slt Frq RqT Typ Adpcm Llme TmStamp
-----------------------------------------------
1 de 4 a 7 0 3 ff 2 a51a07
[dltmr:04] d(12: 2) 3 --->ReT to m1(121) m2(ffffff)
BrInd(0): Rf(4,2,3) p(e6fde) T(0) (a5 42 9)
----- new ACCESS req when URGENT, dev=de, urgent(4,a), new_br_ind(4,ff)
[mfasub] inv inst! e:74 b:4 s:a
dis_ind: Rf(4,2,3) p(ffffff) S(10) (a5 42 e)
>dis_ind_op Rf(4,2) p(ffffff) r=0 F=42 (a5 42 f) 16:29:29
MAC Normal Mode : CO Release Bearer
*DisInd by RFPI HANDSHAKE ERROR or NEW_ACCESS_REQUEST r(1), llme(2)
ClrLlme: l(2),d(12)
BrInd(0): Rf(4,6,0) p(e6fde) T(0) (a5 53 f)
BrCfm: Rf(4,6 0) p(e6fde) T(0) b:0 (a5 54 2)
l(0) 16:29:32
dis_ind: Rf(4,6,0) p(e6fde) S(20) (a5 56 0)
>dis_ind Rf(4,6) p(e6fde) r=0 F=2 (a5 56 1) 16:29:32
BrInd(0): Rf(4,8,4) p(e6fde) T(0) (a5 57 5)
BrCfm: Rf(4,8 4) p(e6fde) T(0) b:0 (a5 57 8)
Invalid Access_connect mac(0)
mac_inst(0) - llme(ff) ==> released 16:29:32
[mfasub] inv inst! e:73 b:4 s:8
[mfasub] inv inst! e:73 b:4 s:8
BrInd(0): Rf(4,8,0) p(e6fde) T(0) (a5 5b 7)
BrCfm: Rf(4,8 0) p(e6fde) T(0) b:0 (a5 5b a)
Invalid Access_connect mac(0)
mac_inst(0) - llme(ff) ==> released 16:29:33
[mfasub] inv inst! e:73 b:4 s:8
[mfasub] inv inst! e:73 b:4 s:8
DL05TimeOut(dev:12, llme:0)
InvalidSendToMac e(6a) d(12) llme(0) mcei1(ffffff) mcei2(ffffff)
ClrLlme: l(0),d(12)

LGE:WTiC2> CTIME 0
Call On/Off time print Disabled

Сегодня снял трассу (команда CTIME) при совсем (не звонят, не набирают) не работающих трубках (пытался звонить с 2112 на 2100).
В конце файла, после перезагрузки плат, звонок с 2112 на 2101.

Сегодня увидел новые "интересные" надписи:

No Empty LCE instance in GetEmptyLce
EP(dev:0 e:44 s:2a)
No Empty LCE instance in GetEmptyLce
EP(dev:0 e:44 s:2a)

при не работающем DECTe такая надпись выдается когда вызываемый абонент не ответил.

dev:0 - не существует вообще.

Решил зарег-ть трубу на места dev:0 и dev:de на что было получено сообщение об ошибке:

[ DECT Information ]
Error Item : DECT ID
Error Define : DECT ID Boundary Error

PS Да уж, сам себя запутал, во втором посте сообщение про dev:0 присутствует.

Новое сообщение:

$$$$ can't clear dummy b:4, s:8 DummyRefnr=a, br_st:0 dummy_br_Info:5a

02/12/16

Новое сообщение (никогда раньще не было этих сообщений подряд):
16:01:28
TxQ=13 20 9d 3 5 5 a 80 c0 10 2 42 dd 43 84 0 18 6 6 a0 a0 10 9 9f fa e0 80 6c d 21 80 30 33 35 31 32 36 35 30 31 38 39 f0 1b 18
RxQ=Empty RxQ !!!
>>>DLC_STATE_VAR =S(OPEN) V(S) = 1, V® = 1, V(A) = 0

16:02:17
TxQ=13 20 9d 3 5 5 a 80 c0 10 2 42 dd 43 84 0 18 6 6 a0 a0 10 9 9f fa e0 80 6c d 21 80 30 33 35 31 32 36 35 30 31 38 39 f0 1b 18
RxQ=Empty RxQ !!!
>>>DLC_STATE_VAR =S(RELEASE_PENDING) V(S) = 1, V® = 1, V(A) = 0

16:02:51
TxQ=13 20 9d 3 5 5 a 80 c0 10 2 42 dd 43 84 0 18 6 6 a0 a0 10 9 9f fa e0 80 6c d 21 80 30 33 35 31 32 36 35 30 31 38 39 f0 1b 18
RxQ=Empty RxQ !!!
>>>DLC_STATE_VAR =S(OPEN) V(S) = 1, V® = 1, V(A) = 0

16:03:52
TxQ=13 20 9d 3 5 5 a 80 c0 10 2 42 dd 43 84 0 18 6 6 a0 a0 10 9 9f fa e0 80 6c d 21 80 30 33 35 31 32 36 35 30 31 38 39 f0 1b 18
RxQ=Empty RxQ !!!
>>>DLC_STATE_VAR =S(OPEN) V(S) = 1, V® = 1, V(A) = 0

Трубки не работают.

На команду CTIME 1 - никаких сообщений.
На команду TRACE 41 (звоню с № 2101 на № 2112):

TRACE Version 1.0 1998.04.28
<< DEVICE 41 >>
Dv No I/O StartTime CS Conn.Time CELL RI END Time ES RR
41 3 IN 10:14:05 03,Dec W
41 3 IN 10:14:05 03,Dec W.....................FT 10:14:14 A 2(00)

Трубки работают (после перезагрузки).

На команду TRACE 41 (звоню с № 2101 на № 2112):

TRACE Version 1.0 1998.04.28
<< DEVICE 41 >>
Dv No I/O StartTime CS Conn.Time CELL RI END Time ES RR
41 1 IN 10:26:59 03,Dec W
41 1 IN 10:26:59 03,Dec W.................... FT 10:26:59 N 0(00)