IP500v2 keeps giving waiting for line

[ipandy]

I've got an IPO500v2 (8.0.66) with 16 channels of a PRI and 10 IP9608 telephones. All my licensing is valid. The system keeps saying "Waiting for Line" but the smart jack shows no LOS. I am currently running a trace, not really sure what filters I need to set to get a good handle on what's happening. When I got on site today I didn't even have intercom DT. After a reboot it seems to work but this is not a viable option for the customer. Any ideas or questions that may give me an idea as to WTF is going on with this system. Thanks in advance.

 

[Telecomboy]

I forget if R8.0.66 runs impedence match automatically or not. If you look under each line, see if the impedence match is set or not. If it is default, run it for each line. This is important to do for each POT line. It requires a reboot when finished. I would also make sure the system is properly grounded in case it is an issue with static/surge/etc.

 

[tlpeter]

He has a PRI
Post a monitor trace here.


BAZINGA!

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

 

[Gunnaro]

And for the question on Monitor Filters settings:

Monitor PRI Troubleshooting

Kind regards

Gunnar
__________________________________________________________________
Hippos have bad eyesight, but considering their weight, it’s hardly their problem

 

[IPGuru]

Once you have your monitor trace, report to your line provider because it is almost certainly them

A Maintenance contract is essential, not a Luxury.
Do things on the cheap & it will cost you dear

 

[ipandy]

319095267mS CMARS: FORM: Main - Received Number: 4048210
319095267mS CMARS: CMARSTargetingPending
319096366mS H323Evt: Recv: RegistrationRequest 10.44.43.13; Endpoints registered: 10; Endpoints in registration: 0
319096412mS H323Evt: Recv: RegistrationRequest 10.44.43.22; Endpoints registered: 10; Endpoints in registration: 0
319096834mS PRN: Line 1: Inband: Line Loopback Active
319097404mS H323Evt: Recv: RegistrationRequest 10.44.43.32; Endpoints registered: 10; Endpoints in registration: 0
319099507mS CMARS: Case 1 - dial_delay_time: 4000 has expired - Resolve what we might have - Called Number: 4048210 Addr: f4eec224
319099507mS CMARS: FORM: Main - Received Number: 4048210
319099507mS CMARS: FOUND A SHORT CODE - short_code: N; - Tel: Ns - Called_Party: 4048210 - Line Group Id: 0
319099508mS CMARS: FindActiveARSByGroupID GroupID=0 - Not Found
319099508mS CMLRQ: FindActiveLRQByGroupID GroupID=0 - Not Found
319099508mS CMMap: a=0.1 b=0.0 Mapper::AllocateCodec allocated CMRTVocoder resource busy 1, total 42
319099509mS CMARS: LINE with group ID: 0 HAS NO CHANNEL: 34 - ATTEMPT OTHER TARGETS
319099510mS CMARS: No Alternate ARS Or User Priority lower than ARS Priority - Remain on the Current Form: Main
319099510mS CMARS: CMARSTargetingBusy
319099510mS CMCallEvt: 0.2040.0 289 ARS for Main: StateChange: END=B CMCSOverlapRecv->CMCSAccept
319099511mS CMCallEvt: 251.2038.0 289 FrontDesk1.0: StateChange: END=A CMCSDialling->CMCSRingBack
319099511mS CMExtnEvt: v=2 State, new=Alerting old=Dialling,0,0,FrontDesk1
319099512mS CMExtnTx: v=3801, p1=0
CMProgress
Line: type=IPLine 250 Call: lid=251 id=2038 in=0
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLUser (0), pd=CMPDInbandPattern (8)
Display [WAITING_FOR_LINE]
Timed: 11/11/13 08:20
319099512mS CD: CALL: 251.2038.0 BState=Ringing Cut=3 Music=0.0 Aend="FrontDesk1(3801)" (0.0) Bend="" [] (0.0) CalledNum=94048210 () CallingNum=3801 (FrontDesk1) Internal=1 Time=8506 AState=Ringing
319099513mS CMMap: a=21.39 b=0.0 DTMF::AllocateRAS allocated CMRTTonegen resource busy 6, total 8
319099513mS CMMap: a=21.39 b=1.255 T
319099513mS CMMap: PCG::AddToneGenerator g T[889] for cp[741]b0r1 append pcp[743]b0r1 (total 1)
319099514mS CMMap: a=0.17 b=0.0 IP::ReserveCodec pcp[743]b0r1 allocated CMRTVocoder resource busy 2, total 42, codec type 5
319099514mS CMMap: a=21.39 b=0.17 M2
319099514mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[743]b0r1 Configure 0.17
319099514mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[743]b0r1 ConnectIndication 0.17
319099514mS CMMap: PCG::MapBChan pcp[741]b0r1 cp_b 0 other_cp_b 0 type CGTypeDTMF
319099515mS CMMap: DTMF:layTones g T[889] ,EEEEE
319099515mS CMMap: Started playing tones, cp[741]b0r1 (from g null)
319099515mS CMMap: cp[741]b0r1 SetOperGroup from g null to g null not executed, playing tones in progress ,EEEEE
319099766mS RES: Mon 11/11/2013 08:20:34 FreeMem=58421824 57820992(1) CachedMem=600832 CMMsg=9(10) Buff=5200 959 1000 7423 5 Links=6164
319099767mS RES2: IP 500 V2 8.0(66) Tasks=48 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=72 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=1 SSA=0 TCP=34 TAPI=0 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
319100507mS CMARS: Retarget existing BUSY targets - Num of Busy Targets: 1 - Current Form: Main
319101336mS CMMap: PCG::UnmapBChan pcp[741]b0r1 cp_b 0 other_cp_b 0
319101336mS CMMap: PCG::UnmapBChan pcp[743]b0r1 cp_b f56bca90 other_cp_b f56b47e8
319101336mS CMMap: a=21.39 b=0.17 M0
319101336mS CMMap: a=21.39 b=0.0 T0
319101337mS CMMap: a=21.39 b=0.0 DTMF::~DTMF freed CMRTTonegen resource busy 5, total 8
319101337mS CMMap: a=21.39 b=0.0 DTMF::AllocateRAS allocated CMRTTonegen resource busy 6, total 8
319101337mS CMMap: a=21.39 b=1.255 T
319101337mS CMMap: PCG::AddToneGenerator g T[890] for cp[741]b0r1 append pcp[744]b0r1 (total 1)
319101338mS CMMap: a=0.18 b=0.0 IP::ReserveCodec pcp[744]b0r1 allocated CMRTVocoder resource busy 3, total 42, codec type 5
319101338mS CMMap: a=21.39 b=0.18 M2
319101338mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[744]b0r1 Configure 0.18
319101338mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[744]b0r1 ConnectIndication 0.18
319101338mS CMMap: PCG::MapBChan pcp[741]b0r1 cp_b 0 other_cp_b 0 type CGTypeDTMF
319101339mS CMMap: DTMF:layTones g T[890] ,EEEEE
319101339mS CMMap: Started playing tones, cp[741]b0r1 (from g null)
319101339mS CMMap: cp[741]b0r1 SetOperGroup from g null to g null not executed, playing tones in progress ,EEEEE
319101339mS CMMap: a=0.17 b=0.0 IP::FreeCodec pcp[743]b0r1 freed CMRTVocoder resource busy 3, total 42
319101886mS CMExtnTx: v=3801, p1=8000
CMFacility
Line: type=IPLine 250 Call: lid=251 id=2 in=1
IE CMIEFastStartInfoData (6) 2 item(s)
319101886mS CMExtnRx: v=3801, p1=0
CMReleaseComp
Line: type=IPLine 250 Call: lid=251 id=2038 in=0
319101886mS CMCallEvt: 251.2038.0 289 FrontDesk1.0: StateChange: END=A CMCSRingBack->CMCSCompleted
319101887mS CMExtnEvt: v=2 State, new=PortRecoverDelay old=Alerting,0,0,FrontDesk1
319101888mS CMLOGGING: CALL:2013/11/1108:20,00:00:00,000,3801,O,94048210,94048210,FrontDesk1,,,1,,""n/a,0
319101888mS CD: CALL: 251.2038.0 BState=Ringing Cut=2 Music=0.0 Aend="FrontDesk1(3801)" (0.0) Bend="" [] (0.0) CalledNum=94048210 () CallingNum=3801 (FrontDesk1) Internal=1 Time=10882 AState=Idle
319101888mS CD: CALL: 251.2038.0 Deleted
319101888mS CMExtnEvt: FrontDesk1: CALL LOST (CMCauseNormal)
319101888mS CMExtnEvt: FrontDesk1: Extn(3801) Calling Party Number(3801) Type(CMNTypeInternal)
319101889mS CMExtnEvt: FrontDesk1: CMExtnHandler::SetCurrent( id: 2038->0 )
319101890mS CMCallEvt: 251.2038.0 -1 FrontDesk1.-1: StateChange: END=X CMCSCompleted->CMCSDelete
319101890mS CMARS: CMARSEndpoint::CallLost(cause=16) - Address: 0.2040.0 289 ARS for Main - Call State: CMCSAccept
319101891mS CMCallEvt: 0.2040.0 -1 ARS for Main: StateChange: END=X CMCSAccept->CMCSDelete
319101891mS CMCallEvt: 0.2040.0 -1 BaseEP: DELETE CMEndpoint f4eec224 TOTAL NOW=1 CALL_LIST=0

 

[ipandy]

I'm hoping this is enough but not too much info. Don't want to get flamed for too much of a trace. The users are also reporting that they are not even getting dial tone when they try to dial extensions. I'm wondering if this is a bad box.

 

[amriddle01]

Are you sure you have 16 channels? the system is reporting there are non free

319099509mS CMARS: LINE with group ID: 0 HAS NO CHANNEL: 34 - ATTEMPT OTHER TARGETS

 

[Telecomboy]

Or is your outgoing line group ID for the PRI not 0?

 

[ipandy]

Yes. AT&T has a full PRI hitting the switch but it is only licensed for 16. All licenses are valid as well. And I'm not sure why I can make an intercom call either.

 

[Gunnaro]

NO CHANNEL: 34", that's ISDN Cause code 34 = No circuit/channel available.
Could be several things, like broken ISDN modem, channels set to 0 in the Line 1 config, even a lose cable from PRI to ISDN.

You have 16 licenses for PRI channels, is that including the 8 that comes with the PRI card? If not, you could have a problem with the PRI modem being programmed for 24 (or 30 if you are in Europe) Some ISDN modems must have a matching set of channels vs. channels programmed in the IPO to work properly, especially for outbound calls.

And you say you can't even get dial tone internally, sounds like bad hardware to me.
Lightning strikes/power surge lately?

I would start with the following (in that order):
- Check channels programmed on LIME NUMBER 1, and that the LINE ID is 0.
- Unplug/Plug cable from the ISDN modem (does the lines come back then? Any alarms on the modem?)
- Upgrade the IPO again, you might have missed some of the cards last time.
- Change the VCM/PRI to another slot in the chassis, you will have to program the LINE 1 again.



Kind regards

Gunnar
__________________________________________________________________
Hippos have bad eyesight, but considering their weight, it’s hardly their problem