Strange DECT Problem. (OxE)

[stefanc]

Hi !

The customers system has worked perfectly over the years but...... it is always a "but"

Now when I try to call a Dect set I hear a call tone and after two secs. disconnect tone. Backtrace shows ...

==============================
There is a new exception. Its address is : 0X08E0F636. Monitel time : 3388226. Date : Thu Aug 12 21:23:04 2021
Application-exception no 5, thd 3949, PC=0x08e0f636:148960822, eqt=30764, serv=0 --> broadcast_dect_msg_by_INTB
Bad equipment number. MAX_NB_EQT = 31169
* Backtrace: 0x08e0fb3c:148962108 EBP 0x01816660 --> broadcast_ipui_dect_cpl
* Backtrace: 0x08dff1e3:148894179 EBP 0x01816b3c --> broadcast_ipui
* Backtrace: 0x08dff5e2:148895202 EBP 0x01816b78 --> page_this_handset_in_this_area
* Backtrace: 0x08dff931:148896049 EBP 0x01816ba8 --> page_this_handset
* Backtrace: 0x08df544f:148853839 EBP 0x01816be0 --> dect_link_setup
* Backtrace: 0x0932e8a2:154331298 EBP 0x01816ec0 --> real_main
GS=00000000 FS=00000000 ES=0000002b DS=0000002b
EDI=00000000 ESI=0000000b EBP=01816660 ESP0=00000000
EBX=000000ff EDX=000000ff ECX=507a7c14 EAX=00000003
EIP=08e0f636 CS=00000023 ESP3=018165d8 EFLAGS=00010206
B(44784:001) Eqt=02524 Emi=30982 {00000, 06207, 0x8e1e104} wait=0x000000,0x000000
Restarting at PC=0x0932de88:154328712, with stack=0x01817ff8:25264120

Exception again. Monitel time : 3388236. Date : Thu Aug 12 21:23:05 2021. Eqt=30764. Serv=0-> bad neqt
Exception again. Monitel time : 3388246. Date : Thu Aug 12 21:23:06 2021. Eqt=30764. Serv=0-> bad neqt
Exception again. Monitel time : 3388256. Date : Thu Aug 12 21:23:07 2021. Eqt=30764. Serv=0-> bad neqt
Exception again. Monitel time : 3388266. Date : Thu Aug 12 21:23:08 2021. Eqt=30764. Serv=0-> bad neqt
Exception again. Monitel time : 3388276. Date : Thu Aug 12 21:23:09 2021. Eqt=30764. Serv=0-> bad neqt
Exception again. Monitel time : 3388286. Date : Thu Aug 12 21:23:10 2021. Eqt=30764. Serv=0-> bad neqt

mtracer shows ...


(390023:001647) Application-exception no 5, thd 3951, PC=broadcast_dect_msg_by_INTB(int, g_cpu_cpl_msg_head_dect_dl_udat_rq_s, unsigned char, unsigned char), eqt=30764, serv=0
(390023:001648) * Backtrace: 0x08e0fb3c:148962108 EBP 0x01836660 --> broadcast_ipui_dect_cpl(short, unsigned char, unsigned char) (+672) 97%
(390023:001649) * Backtrace: 0x08dff1e3:148894179 EBP 0x01836b3c --> broadcast_ipui(t_paging_request, short) (+207) 27%
(390023:001650) * Backtrace: 0x08dff5e2:148895202 EBP 0x01836b78 --> page_this_handset_in_this_area(t_paging_request, short) (+474) 68%
(390023:001651) * Backtrace: 0x08dff931:148896049 EBP 0x01836ba8 --> page_this_handset(short, unsigned char) (+629) 77%
(390023:001652) * Backtrace: 0x08df544f:148853839 EBP 0x01836be0 --> dect_link_setup(void) (+1083) 83%
(390023:001653) * Backtrace: 0x0932e8a2:154331298 EBP 0x01836ec0 --> real_main (+2586) 83%


and incvisu shows dectsystem crash and restart ...

12/08/21 21:26:11 000001M|---/--/-/---|=0:1721=Phone exc 5, PC 0x08e0f636 neqt 30764
12/08/21 21:26:12 000001M|---/--/-/---|=5:1367=DECT network initialization



This happens on every call to all dect sets.

So what is: => Exception again. Monitel time : 3388286. Date : Thu Aug 12 21:23:10 2021. Eqt=30764. Serv=0-> bad neqt


I banged my head on the office desk, I can not find the cause of the problem ... so any ideas guys ...

Regards ...

/S

[stefanc]

Found the strange neqt. it was the:

| NEQT_DECT_NWK_LAYER | 30764 |


But here is more info from tracing ...

(442497:000006) DECT: display_lang for hotel application. result 1
(442497:000007) >> TINY : aff_ua_en_son : set INCOMING_CALL(default)
(442497:000008) decauto_possible result=0 neqt=2528 pb_tandem=0
(442497:000009) decauto_possible result=0 neqt=2528 pb_tandem=0
(442497:000010) >>> DECT: stock_msg_ua : (save) t_msf->index = 0 length = 5 opcode = 41
(442497:000011) DECT: DectLinkSetupReq : neqt = 2528
(442497:000012) DECTNWK>> allocate_lcei_by_ch : lcei = 300
(442497:000013) DECT : Allocation : lcei_by_ch = 300
(442497:000014) DECT: send EVT_DECT_LINK_SETUP_REQ lcei = 300 size 23 IPUI 10.00.00.00.00.00.47.A5
(442497:000015) >>> GAP : add_clip_to_link_setup_request : neqt = 2344 4834 (0x49-0x81)
(442497:000016) DECT: DectRoutingTone
(442497:000017) DECT: DectLinkSetupReq : neqt = 2528 result = 1
(442497:000018) >>> DECT: stock_msg_ua : (restitution) t_msf->index = 0 lcei = 300
(442497:000019) DECT: dect_add_on_analog_config
(442497:000020) DECT: SendUa -> on est cordless
(442497:000021) >>> GAP : SendUa on CC-GAP.
(442497:000022) >>> GAP : gap_link_setup_req_idle : neqt = 2528
(442497:000023) >>> GAP : init_cc_gap_half_com : lcei = 300
(442497:000024) DECTSEC>> update_stby_eho_abc : neqt = 2528 app_id 2
(442497:000025) DECTDump> .00.00.43.00.00.0f.00.1c.08.00.55
(442497:000026) DECTDump> .06.00.00.00.03.70.fc.a7.b7.00.00.00.04.07.0a.05.00.00.00.00
(442497:000027) DECTDump> .00.00.00.00.00.00.00.00.00.00.00.00.01.01.00.00.00.00.00.00
(442497:000028) DECTDump> .ff.ff.ff.ff.00.00.00.00.ec.65.85.01.41.ec.3c.09
(442497:000029) event_init_screen_mem : line 1 tscreen 'Carlsson Stefan_'
(442497:000030) DECTNWK>> dect_link_setup : src_id = 4 lcei = 300 neqt = 2528
(442497:000031) DECTDump> .04.00.2c.01.e0.09.00.00.05.00.00.00.10.00.00.00.00.00.47.a5
(442497:000032) DECTDump> .6c.06.49.81.34.38.33.34.00.00.00
(442497:000033) DECTNWK>> get_inst_nbr_from_ipui : No link !
(442497:000034) DECTNWK>> allocate_instance : link = 3
(442497:000035) DECTNWK>> new_dect_link_setup : cc_active = 1 mm_active = 0
(442497:000036) DECTNWK>> update_instance_from_lcei : IPUI = 10.00.00.00.00.00.47.A5
(442497:000037) DECTNWK>> page_this_handset : link_nbr = 3 nb_attempts = 5
(442497:000038) DECTNWK>> get_neqt_from_ipui : neqt = 2528 position = 11
(442497:000039) DECTNWK>> check_pari_and_area_consistency : 0-00 ok.
(442497:000040) DECTNWK>> pari_and_area_to_general_area : 0-00 -> 000
(442497:000041) DECTNWK>> page_this_handset_in_this_area : link_nbr = 3 area = 0
(442497:000042) DECTNWK>> page_this_handset_in_this_area : index = 0
(442497:000043) DECTNWK>> general_area_to_pari_and_area : 000 -> 0-00
(442497:000044) DECTNWK>> broadcast_ipui : link = 3 pari = 0 area = 0
(442497:000045) DECTNWK>> broadcast_ipui_dect_cpl : link = 3 pari = 0 area = 0
(442497:000046) DECTNWK>> construct_paging_msg : link = 3 neqt = 2528
(442497:000047) DECTNWK>> broadcast_dect_msg_by_INTB : cr = 11 area = 0
(442497:000048) INIT : get_intip_fictive CMIP_INTIP cr 19 cpl 1
(442497:000049) Application-exception no 5, thd 3953, PC=broadcast_dect_msg_by_INTB(int, g_cpu_cpl_msg_head_dect_dl_udat_rq_s, unsigned char, unsigned char), eqt=30764, serv=0
(442497:000050) * Backtrace: 0x08e0fb3c:148962108 EBP 0x01856650 --> broadcast_ipui_dect_cpl(short, unsigned char, unsigned char) (+672) 97%
(442497:000051) * Backtrace: 0x08dff1e3:148894179 EBP 0x01856b2c --> broadcast_ipui(t_paging_request, short) (+207) 27%
(442497:000052) * Backtrace: 0x08dff5e2:148895202 EBP 0x01856b68 --> page_this_handset_in_this_area(t_paging_request, short) (+474) 68%
(442497:000053) * Backtrace: 0x08dff985:148896133 EBP 0x01856b98 --> page_this_handset(short, unsigned char) (+713) 87%
(442497:000054) * Backtrace: 0x08df544f:148853839 EBP 0x01856be0 --> dect_link_setup(void) (+1083) 83%
(442497:000055) * Backtrace: 0x0932e8a2:154331298 EBP 0x01856ec0 --> real_main (+2586) 83%
(442497:000056) GS=00000000 FS=00000000 ES=0000002b DS=0000002b
(442497:000057) EDI=00000000 ESI=0000000b EBP=01856650 ESP0=00000000
(442497:000058) EBX=000000ff EDX=000000ff ECX=507a7c14 EAX=00000003
(442497:000059) EIP=08e0f636 CS=00000023 ESP3=018565c8 EFLAGS=00010202
(442497:000060) B(33513:001) Eqt=02528 Emi=00000 {00000, 00270, 0x8697550} wait=0x8a0e904,0x000000
(442497:000061) B(33513:003) Eqt=02528 Emi=02344 {31502, 00039, 0x8a0eeb8} wait=0x000000,0x000000
(442497:000062) B(33513:004) Eqt=02344 Emi=00000 {00000, 00003, 0x8a2b9b4} wait=0x8a2b990,0x000000
(442497:000063) B(33308:015) Eqt=02344 Emi=02344 {00000, 00002, 0x8a52b0c} wait=0x8c0f1f0,0x000000
(442497:000064) B(32925:027) Eqt=02528 Emi=30764 {00000, 06201, 0x8e1adac} wait=0x000000,0x000000
(442497:000065) Monitel: fault=1721 lev=1 {0x0005,0x08e0,0xf636,0x782c}
(442497:000066) Restarting at PC=real_main, with stack=0x01857ff8:25526264
(442497:000067) >>> GAP : gap_receive_ua_msg : neqt = 2528 cc_state = 20 restart = 0
(442497:000068) >>> GAP : translate_ua_into_dect_message : Voice mode : ringing.
(442497:000069) >>> GAP : translate_ua_into_dect_message : Line 1 : clear & write.



And why shows the INTIP link " -X- "

--- Inter Crystal Topology ---

+-------------------------------------------------------------------------+
| CR | CPL Type Role Free/Tot Role Type CPL | CR |
|-------------------------------------------------------------------------|
|019 | 01 -INTIP3A (INT_A ) === 8/8 === ( MAIN) INTIPB - 01 |010 |
|-------------------------------------------------------------------------|
|019 | 01 -INTIP3A (INT_A ) === 8/8 === ( MAIN) INTIPB - 20 |012 |
|-------------------------------------------------------------------------|
|019 | 01 -INTIP3A (INT_HS ) -X- -X- ( MAIN) INTIPB - 20 |014 |
|-------------------------------------------------------------------------|


but ...


--- Inter Crystal Topology ---

+-------------------------------------------------------------------------+
| CR | CPL Type Role Free/Tot Role Type CPL | CR |
|-------------------------------------------------------------------------|
|014 | 20 -INTIPB (MAIN ) --- 32/32 --- ( INT_HS) INTIP3A - 01 |019 |
|-------------------------------------------------------------------------|

strange ....

[stefanc]

Did a bascul and both the faulty virtual link and the DECT problem went away ... I think the problem was that the "get_intip_fictive CMIP_INTIP cr 19 cpl 1" was OOS. Something was messed up when we restarted the system after maintenance and "main" role was on the other CPU.

/S