Tek-Tips is the largest IT community on the Internet today!

Members share and learn making Tek-Tips Forums the best source of peer-reviewed technical information on the Internet!

Register Log in
  • Congratulations Mike Lewis on being selected by the Tek-Tips community for having the most helpful posts in the forums last week. Way to Go!

ISDN BRI - clock changing & out of service alarms

Status
Not open for further replies.
FredisRed2

FredisRed2

Programmer
Dec 31, 2010
13
AU
I setup a bunch of IPO’s to email the IT department when trunks go down.

Well this opened a can of worms at 2 of their sites, a constant flood of trunk out of service & then cleared trunk out of service emails.
In system status I see lots of “8khz clock source changed” & “trunk out of service” errors on all trunks that have an NTU connected.

I tried a bunch of clock quality settings but no change. They never complain about call quality or dropouts.

I’m not good at reading the Monitor trace below, can anyone help? I have taken a snap shot of 3 errors in a row for each site.



Site 1 IP500 V2 8.1 (63) 2x BRI Combo cards (getting about 50 errors per hour)
3x BRI’s set point to point, Clock Quality, BRI1 Network & BRI2 & 3 set as Fallback

13:08:02 2196073mS CMTARGET: CMQ931Trunk::preprocessInboundMsg - failure_timer
13:08:02 2196075mS ISDNL1Evt: v=2 peb=2,F4 F3
13:08:02 2196200mS ISDNL1Evt: v=2 peb=2,F5 F4
13:08:02 2196201mS ISDNL1Evt: v=2 peb=2,F6 F5
13:08:02 2196261mS ISDNL1Evt: v=2 peb=2,F7 F6
13:08:02 2196261mS ISDNL1Evt: v=2 peb=2,PHAI
13:08:02 2196261mS ISDNL2Tx: v=2 peb=2
0000 00 01 7f ...
13:08:02 2196264mS ISDNL1Tx: v=2 peb=2
0000 00 01 7f ...
13:08:02 2196273mS ISDNL1Rx: v=2 peb=2
0000 00 01 73 ..s
13:08:02 2196273mS ISDNL2Rx: v=2 peb=2
0000 00 01 73 ..s
13:08:02 2196273mS ISDNL3Evt: v=2 p1=2,p2=1000,p3=0,p4=0,s1=
13:08:02 2196273mS CMLineRx: v=2
CMLineUp
Line: type=Q931Line 2 Call: lid=0 id=-1 in=0
13:08:02 2196276mS CMLineRx: v=2
CMRestartAck
Line: type=Q931Line 2 Call: lid=0 id=-1 in=0
13:08:02 2196306mS RES: Sun 17/11/2013 13:08:02 FreeMem=60874100(1) CMMsg=2 (2) Buff=5200 962 999 12447 5 Links=8826 BTree=0 CPU=2/5/7239/18390/18587/2
13:08:02 2196306mS RES2: IP 500 V2 8.1(63) Tasks=48 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=48 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=3 SSA=1 TCP=16 TAPI=0 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
13:08:02 2196306mS RES4: XML MemObjs=45 PoolMem=2097152(1) FreeMem=2082064(1)
13:08:02 2196673mS ISDNL1Evt: v=1 peb=1,F3 F7
13:08:02 2196673mS PRN: T4 Started
13:08:02 2196678mS ISDNL1Evt: v=1 peb=1,UnLocked
13:08:02 2196678mS ISDNL1Evt: v=5 peb=5,Locked
13:08:02 2196678mS PRN: BRI: LockToPeb 4
13:08:03 2197423mS ISDNL1Evt: v=1 peb=1,PHDI
13:08:03 2197423mS ISDNL3Evt: v=1 p1=1,p2=1001,p3=4,p4=127,s1=
13:08:03 2197423mS PRN: T4 Timeout
13:08:03 2197423mS CMLineRx: v=1
CMLineDown
Line: type=Q931Line 1 Call: lid=0 id=-1 in=0
13:08:03 2197424mS CMLineTx: v=1
CMRestart
Line: type=Q931Line 1 Call: lid=0 id=-1 in=0
13:08:03 2197424mS CMTARGET: CMQ931Trunk::preprocessInboundMsg - failure_timer set
13:08:03 2197425mS ISDNL1Evt: v=1 peb=1,F4 F3
13:08:03 2197519mS ISDNL1Evt: v=5 peb=5,F3 F7
13:08:03 2197519mS PRN: T4 Started
13:08:03 2197524mS ISDNL1Evt: v=5 peb=5,UnLocked
13:08:03 2197524mS PRN: Lock To Internal Clock, FPGA_REC_CLK_SELECT = 0x00
13:08:03 2197555mS ISDNL1Evt: v=1 peb=1,F5 F4
13:08:03 2197557mS ISDNL1Evt: v=1 peb=1,F6 F5
13:08:03 2197615mS ISDNL1Evt: v=1 peb=1,F7 F6
13:08:03 2197615mS ISDNL1Evt: v=1 peb=1,PHAI
13:08:03 2197616mS ISDNL2Tx: v=1 peb=1
0000 00 01 7f ...
13:08:03 2197619mS ISDNL1Tx: v=1 peb=1
0000 00 01 7f ...
13:08:03 2197628mS ISDNL1Rx: v=1 peb=1
0000 00 01 73 ..s
13:08:03 2197628mS ISDNL2Rx: v=1 peb=1
0000 00 01 73 ..s
13:08:03 2197628mS ISDNL3Evt: v=1 p1=1,p2=1000,p3=0,p4=0,s1=
13:08:03 2197629mS CMLineRx: v=1
CMLineUp
Line: type=Q931Line 1 Call: lid=0 id=-1 in=0
13:08:03 2197725mS CMLineRx: v=1
CMRestartAck
Line: type=Q931Line 1 Call: lid=0 id=-1 in=0
13:08:04 2198269mS ISDNL1Evt: v=5 peb=5,PHDI
13:08:04 2198269mS ISDNL3Evt: v=5 p1=5,p2=1001,p3=4,p4=127,s1=
13:08:04 2198269mS PRN: T4 Timeout
13:08:04 2198269mS CMLineRx: v=5
CMLineDown
Line: type=Q931Line 5 Call: lid=0 id=-1 in=0
13:08:04 2198270mS CMLineTx: v=5
CMRestart
Line: type=Q931Line 5 Call: lid=0 id=-1 in=0
13:08:04 2198270mS CMTARGET: CMQ931Trunk::preprocessInboundMsg - failure_timer set




Site 2 IP500 V2 9.0 (build 829) 2x BRI Combo cards (getting about 600 errors per hour)
3x BRI’s set point to point, Clock Quality, BRI1 Network & BRI2 & 3 set as Fallback

13:17:24 68700591mS CMTARGET: CMQ931Trunk::preprocessInboundMsg - failure_timer set
13:17:24 68700593mS ISDNL1Evt: v=1 peb=1,F4 F3
13:17:24 68700730mS ISDNL1Evt: v=1 peb=1,F5 F4
13:17:24 68700734mS ISDNL1Evt: v=1 peb=1,F6 F5
13:17:24 68700815mS ISDNL1Evt: v=1 peb=1,F7 F6
13:17:24 68700815mS ISDNL1Evt: v=1 peb=1,PHAI
13:17:24 68700815mS ISDNL2Tx: v=1 peb=1
0000 00 01 7f ...
13:17:24 68700818mS ISDNL1Tx: v=1 peb=1
0000 00 01 7f ...
13:17:24 68700827mS ISDNL1Rx: v=1 peb=1
0000 00 01 73 ..s
13:17:24 68700827mS ISDNL2Rx: v=1 peb=1
0000 00 01 73 ..s
13:17:24 68700827mS ISDNL3Evt: v=1 p1=1,p2=1000,p3=0,p4=0,s1=
13:17:24 68700827mS CMLineRx: v=1
CMLineUp
Line: type=Q931Line 1 Call: lid=0 id=-1 in=0
13:17:24 68700893mS CMLineRx: v=1
CMRestartAck
Line: type=Q931Line 1 Call: lid=0 id=-1 in=0
13:17:24 68701209mS RES: Sun 17/11/2013 13:17:24 FreeMem=55505392 55039832(1) CachedMem=465560 CMMsg=4(4) Buff=5200 1366 999 7447 5 Links=12305 BTree=14663 CPU=07.39% CPUStats=2/7/4578/12964/16419/0/0 MCR=0 MCW=0
13:17:24 68701209mS RES2: IP 500 V2 9.0.0.0 build 829 Tasks=50 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=50 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=3 SSA=1 TCP=17(TLS=4) TAPI=0 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
13:17:24 68701210mS RES4: XML MemObjs=56 PoolMem=2097152(1) FreeMem=2081932(1)

********** SysMonitor v9.0.0.0 build 829 [connected to 192.168.7.240 ] **********
13:17:27 68704222mS PRN: Monitor Status IP 500 V2 9.0.0.0 build 829
13:17:27 68704223mS PRN: LAW=A PRI=0, BRI=4, ALOG=0, VCOMP=20, MDM=0, WAN=0, MODU=0 LANM=0 CkSRC=2 VMAIL=1(VER=2 TYP=3) 1-X=0 CALLS=0(TOT=31)
13:17:31 68707659mS ISDNL1Evt: v=2 peb=2,F3 F7
13:17:31 68707659mS PRN: T4 Started
13:17:31 68707664mS ISDNL1Evt: v=2 peb=2,UnLocked
13:17:31 68707664mS ISDNL1Evt: v=5 peb=5,Locked
13:17:31 68707664mS PRN: BRI: LockToPeb 4
13:17:32 68708409mS ISDNL1Evt: v=2 peb=2,PHDI
13:17:32 68708409mS ISDNL3Evt: v=2 p1=2,p2=1001,p3=4,p4=127,s1=
13:17:32 68708409mS PRN: T4 Timeout
13:17:32 68708409mS CMLineRx: v=2
CMLineDown
Line: type=Q931Line 2 Call: lid=0 id=-1 in=0
13:17:32 68708409mS CMLineTx: v=2
CMRestart
Line: type=Q931Line 2 Call: lid=0 id=-1 in=0
13:17:32 68708410mS CMTARGET: CMQ931Trunk::preprocessInboundMsg - failure_timer set
13:17:32 68708411mS ISDNL1Evt: v=2 peb=2,F4 F3
13:17:32 68708561mS ISDNL1Evt: v=2 peb=2,F5 F4
13:17:32 68708564mS ISDNL1Evt: v=2 peb=2,F6 F5
13:17:32 68708622mS ISDNL1Evt: v=2 peb=2,F7 F6
13:17:32 68708622mS ISDNL1Evt: v=2 peb=2,PHAI
13:17:32 68708622mS ISDNL2Tx: v=2 peb=2
0000 00 01 7f ...
13:17:32 68708625mS ISDNL1Tx: v=2 peb=2
0000 00 01 7f ...
13:17:32 68708634mS ISDNL1Rx: v=2 peb=2
0000 00 01 73 ..s
13:17:32 68708634mS ISDNL2Rx: v=2 peb=2
0000 00 01 73 ..s
13:17:32 68708634mS ISDNL3Evt: v=2 p1=2,p2=1000,p3=0,p4=0,s1=
13:17:32 68708634mS CMLineRx: v=2
CMLineUp
Line: type=Q931Line 2 Call: lid=0 id=-1 in=0
13:17:32 68708712mS RES: Sun 17/11/2013 13:17:32 FreeMem=55510704 55039832(1) CachedMem=470872 CMMsg=4(4) Buff=5200 1367 999 7446 5 Links=12315 BTree=14663 CPU=07.19% CPUStats=1/5/4578/13093/16419/0/0 MCR=0 MCW=0
13:17:32 68708712mS RES2: IP 500 V2 9.0.0.0 build 829 Tasks=50 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=52 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=3 SSA=1 TCP=17(TLS=4) TAPI=0 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
13:17:32 68708712mS RES4: XML MemObjs=56 PoolMem=2097152(1) FreeMem=2081932(1)
13:17:32 68708714mS CMLineRx: v=2
CMRestartAck
Line: type=Q931Line 2 Call: lid=0 id=-1 in=0
13:17:33 68709481mS ISDNL1Evt: v=5 peb=5,F3 F7
13:17:33 68709481mS PRN: T4 Started
13:17:33 68709486mS ISDNL1Evt: v=5 peb=5,UnLocked
13:17:33 68709486mS PRN: Lock To Internal Clock, FPGA_REC_CLK_SELECT = 0x00
13:17:34 68710231mS ISDNL1Evt: v=5 peb=5,PHDI
13:17:34 68710231mS ISDNL3Evt: v=5 p1=5,p2=1001,p3=4,p4=127,s1=
13:17:34 68710231mS PRN: T4 Timeout
13:17:34 68710231mS CMLineRx: v=5
CMLineDown
Line: type=Q931Line 5 Call: lid=0 id=-1 in=0
13:17:34 68710231mS CMLineTx: v=5
CMRestart
Line: type=Q931Line 5 Call: lid=0 id=-1 in=0
13:17:34 68710232mS CMTARGET: CMQ931Trunk::preprocessInboundMsg - failure_timer set

 
Sort by date Sort by votes
I saw that too and there is nothing you can do about it.
So don't use it for BRI trunks as it will flood your mailbox.
The trunk is not down but it looks like it re-syncs and then gives the PHDI (line down) and then a PHAI (line up)


BAZINGA!

I'm not insane, my mother had me tested!

 
Upvote 0 Downvote
If its UK this is normal as the provider shuts down the 2 channels to save power.

Robb
 
Upvote 0 Downvote
Status
Not open for further replies.

Similar threads

S
  • Question
How to configure ISDN Dialup BRI and PRI both in Avaya IPoffice
Replies
5
Views
400
skjaiswal
S
CPM86
  • Locked
  • Question
IP 500 bri 4 and 8 Trunk card for old ISDN phone use?
Replies
4
Views
150
derfloh
derfloh
William C290
  • Solved
The clock on Secreensaver is not updated
Replies
2
Views
343
William C290
William C290
Arun Neelambaran
  • Locked
  • Question
Set Out of Hours in PRI line
Replies
1
Views
123
derfloh
derfloh
AldoLT
  • Locked
Avaya Mobile Push Notification Service
Replies
3
Views
405
derfloh
derfloh

Part and Inventory Search

Sponsor

Back
Top