IP406 Busy out going Calls

[motch6]

IP406 3.2 (53)running IP400 Analog unit 5.2 (53)

Can't get any incomeing calls to route and when we dial out we get a dial tone but then when we dial out it gives us a fast busy signal and phone says Disconnected.

Not sure if the analog unit has gone out because it GREENS up. It also still shows in the Control Unit list. ALTHOUGH, when you go to click on File/ advanced/ Upgrade...It does NOT show in this list... find it to be really weird.

Have rebooted whole unit including Computer running software. Have resent the config file to the unit.

At loss... any Help?

 

[motch6]

monitor of outgoing call: can't make much sense of it

2330979mS CMTARGET: LOOKUP CALL ROUTE:5 type=100 called_party=8015589178 sub= calling=128 in=0 complete=0
2330979mS CMTARGET: ADD TARGET:5 number=8015589178 type=100 depth=1 nobar=1 setorig=1
2330980mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:5 returned 0
2334980mS CMTARGET: LOOKUP CALL ROUTE:5 type=100 called_party=8015589178 sub= calling=128 in=0 complete=1
2334980mS CMTARGET: ADD TARGET:5 number=8015589178 type=100 depth=1 nobar=1 setorig=1
2334980mS CMTARGET: SYS SC:5 8015589178 11 8015589178 sc=type=Dial3K1 code=[9]xxxxxxxxxx;, num=N
2334981mS CMTARGET: LCR NOT MATCHED:5 (cpn=8015589178)
2334981mS CMTARGET: DIAL LINE:5 GROUP=5 SUCCESS=2
2334981mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:5 returned 1
2334982mS CD: CALL: 0.1009.0 BState=Idle Cut=1 Music=0.0 Aend="NateC(128)" (1.7) Bend="" [] (0.0) CalledNum=8015589178 () CallingNum=128 () Internal=1 Time=11865 AState=Dialling
2334983mS CMExtnTx: v=51, p1=5
CMSetupAck
Line: type=DigitalExtn 3
Call: lid=0 id=1009 in=0
Called[8015589178] Type=Default (100)
BChan: slot=1 chan=7
Product Unknown
Display [8015589178]
Timed: 02/11/11 19:49
2334984mS CMTARGET: SELECT:5 1 0 TGHG=00000000 TGUSER=00000000 INCL=00000000 EXCL=00000000
2334984mS CMTARGET: SELECT:5 NO TARGETS, TRY VOICEMAIL
2334985mS PRN: CALL: 0.1009.0 Deleted leaving 0 CMCall objects
2334985mS CALL:2011/11/0219:49,00:00:00,000,128,O,8015589178,98015589178,NateC,,,1,,""n/a,0
2334986mS CD: CALL: 0.1009.0 BState=Idle Cut=0 Music=0.1 Aend="NateC(128)" (1.7) Bend="" [] (0.0) CalledNum=8015589178 () CallingNum=128 () Internal=1 Time=2 AState=Idle
2334987mS CMExtnTx: v=51, p1=5
CMInbandTone
Line: type=DigitalExtn 3
Call: lid=0 id=1009 in=0
Product Unknown
UUI type=User2User [TB2\r\n] [0x54 0x42 0x32 0x0d 0x0a ]
Cause=34, No cct/chan available
Timed: 02/11/11 19:49
2334988mS CD: CALL: 0.1009.0 Deleted
2334994mS PRN: ProcessInbandTone noChannel
2334997mS RES: Wed 2/11/2011 19:49:31 FreeMem=3618304(4) CMMsg=5 (6) Buff=98 593 798 1100 5 Links=8913 Elements=0
2335184mS CMExtnRx: v=51, p1=5
CMShortCode
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
ShortCode GetCallInfo (108) = []
Product Unknown
2335184mS CMExtnTx: v=51, p1=5
CMShortCode
Line: type=DigitalExtn 3
Call: lid=0 id=-1 in=0
ShortCode GetCallInfo (108) = []
BChan: slot=1 chan=7
Product Unknown
Timed: 02/11/11 19:49
2338556mS CMExtnRx: v=51, p1=5
CMRelease
Line: type=NoLine 0
Call: lid=0 id=1009 in=0
Product Unknown
2338556mS CMExtnTx: v=51, p1=5
CMInbandTone
Line: type=DigitalExtn 3
Call: lid=0 id=-1 in=0
Product Unknown
UUI type=User2User [TB0\r\n] [0x54 0x42 0x30 0x0d 0x0a ]
Timed: 02/11/11 19:49
2338557mS CMExtnTx: v=51, p1=5
CMReleaseComp
Line: type=DigitalExtn 3
Call: lid=0 id=1009 in=0
Product Unknown
UUI type=Local [....] [0x03 0x00 0x11 0x0e ]
Timed: 02/11/11 19:49
2344510mS PRN: Monitor Status IP 406 DS 3.2(53)
2344511mS PRN: LAW=U PRI=1, BRI=0, ALOG=0, ADSL=0 VCOMP=5, MDM=0, WAN=0, MODU=1 LANM=0 CkSRC=0 VMAIL=1(VER=2 TYP=1) CALLS=0(TOT=5)

********** SysMonitor v5.2 (53) [connected to 192.168.0.90 (ChemDry)] **********

2504134mS PRN: Monitor Status IP 406 DS 3.2(53)
2504135mS PRN: LAW=U PRI=1, BRI=0, ALOG=0, ADSL=0 VCOMP=5, MDM=0, WAN=0, MODU=1 LANM=0 CkSRC=0 VMAIL=1(VER=2 TYP=1) CALLS=0(TOT=5)

 

[motch6]

The only error i get is at the top of this monitor list:

after a reboot this is what I get:

57mS ERR: TDMLink 1 reports CMmsg error at other end
59mS ERR: DTExtn Line Up 4

491mS RES: Wed 2/11/2011 18:52:22 FreeMem=3818824(1) CMMsg=2 (3) Buff=100 607 798 1100 5 Links=9320 Elements=0
1022mS PRN: Sorting User List...
1023mS PRN: User List Sorted
1023mS LIC: Added token 00:e0:07:01:a7:20 (never expires)
1027mS PRN: Sorting Hunt Group List...
1027mS PRN: Hunt Group List Sorted
1030mS PRN: Sorting Directory List...
1030mS PRN: Sorted Directory List.
1035mS PRN: Config Write Completed
1159mS LIC: Received rainbow token from 192.168.0.95
2184mS LIC: Success. Adding token to list.
2184mS LIC: Added rainbow token 00:44:e8:af (never expires)
2185mS LIC: Licence for "Voicemail Pro (4 Ports)" is valid
2185mS LIC: Licence for "CCC Server" is valid
2186mS LIC: Licence for "CCC PC Wallboards" is valid
2186mS LIC: Licence for "CCC Agents" is valid
2187mS LIC: Licence for "CCC Agents" is valid
2187mS LIC: Licence for "Phone Manager Pro (per seat)" is valid
2187mS LIC: Licence for "CCC Supervisors" is valid
2188mS LIC: Licence for "VMPro Recordings Administrators" is valid
2188mS LIC: Licence for "Additional Voicemail Pro (ports)" is valid
3001mS PRN: +++ START OF ALARM LOG DUMP +++
3001mS PRN: ALARM: 13/08/2010 12:01:11 IP 406 DS 3.2(53) <TLB Data Error> CRIT RAISED addr=00000000 d=16 pc=ff6a00ac ff54a254 ff6a0a28 ff7eea00 ff7ef3d8 ff7c1488
3001mS PRN: +++ END OF ALARM LOG DUMP +++
3662mS PRN: TFTPServer::RRQ(from 192.168.0.95) nasystem/who_is
4163mS PRN: TFTPServer::RRQ(from 192.168.0.95) nasystem/licence_list
4663mS PRN: TFTPServer::RRQ(from 192.168.0.95) config/$t%$'~ q
4665mS PRN: Config Write Wake Up
5165mS PRN: IO List Size 1
5165mS PRN: Sending Config out to ffe8f9ac started
5661mS PRN: Sending Config out to ffe8f9ac finished
5661mS PRN: Config Write Completed
5986mS RES: Wed 2/11/2011 18:52:28 FreeMem=3689144(5) CMMsg=2 (3) Buff=100 610 798 1100 5 Links=9148 Elements=0
6172mS PRN: TFTPServer::RRQ(from 192.168.0.95) nasystem/user_list6
6700mS PRN: TFTPServer::RRQ(from 192.168.0.95) nasystem/call_list2/$t%$'~ q/CCC_DS_V5_CHEMDRYSERVER
6701mS CD: CALLSYNC: CCC_DS_V5_CHEMDRYSERVER

 

[AACon]

Yeah definitely check your trunks. Cause 34 I believe is a no channel available code...so its trying to go out...then dies. Make sure your 9N is going to the right trunk, then check for dialtone on all the trunks external to the IP Office (pull em out, throw a buttset on it). If they're good, could be the module itself.

-Austin
ACE: Implement IP Office
I show people how to use this stuff sometimes...

 

[IPGuru]

The system is using PRI not analog lines.

Clear cause 34 indicates to me that this is a line issue & not a fault with the IPO report to your line provider.

Computers are like Air conditioners:-
Both stop working when you open Windows

 

[motch6]

I noticed the PRI notes as well. There was a PRI installed on this unit years ago, but we've been using Analog for a couple years now. The PRI still shows in the Manager along with the Analog trunks. Not sure why the PRI kicked it self on, if that is the case, HOW do you turn it off so it is using the Analog Trunk unit??

PS: also, we did test each individual line outside of the IP Unit.

Thanks for any more help.

 

[amriddle01]

Put the PRI into an unused outgoing line group like 10 or something

http://www.ipoffice.tel

 

[motch6]

I went in and made all the PRI lines out of Service... there were 8 that were in service. Not sure if that has helped yet, won't be able to test outgoing phone call until i'm in the office.

The 9N shortcodes look all normal.

 

[amriddle01]

I would still put them into a different line group, it's what we call "belt and braces"

http://www.ipoffice.tel

 

[motch6]

K, so i did what you suggested.

Still no go. This is the report of what happens when a call out is made:

150357mS CMExtnRx: v=69, p1=6
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[8] Type=Default (100)
Product Unknown
150357mS CMTARGET: LOOKUP CALL ROUTE:1 type=100 called_party=18015589178 sub= calling=113 in=0 complete=0
150358mS CMTARGET: ADD TARGET:1 number=18015589178 type=100 depth=1 nobar=1 setorig=1
150358mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:1 returned 0
154357mS CMTARGET: LOOKUP CALL ROUTE:1 type=100 called_party=18015589178 sub= calling=113 in=0 complete=1
154357mS CMTARGET: ADD TARGET:1 number=18015589178 type=100 depth=1 nobar=1 setorig=1
154358mS CMTARGET: SYS SC:1 18015589178 12 8015589178 sc=type=Dial3K1 code=[9]1xxxxxxxxxx;, num=1N
154358mS CMTARGET: LCR NOT MATCHED:1 (cpn=18015589178)
154358mS CMTARGET: DIAL LINE:1 GROUP=5 SUCCESS=2
154359mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:1 returned 1
154359mS CD: CALL: 0.1001.0 BState=Idle Cut=1 Music=0.0 Aend="ChrissyW (113)" (10.8) Bend="" [] (0.0) CalledNum=18015589178 () CallingNum=113 () Internal=1 Time=8116 AState=Dialling
154360mS CMExtnTx: v=69, p1=6
CMSetupAck
Line: type=DigitalExtn 4
Call: lid=0 id=1001 in=0
Called[18015589178] Type=Default (100)
BChan: slot=10 chan=8
Product Unknown
Display [18015589178]
Timed: 03/11/11 08:14
154361mS CMTARGET: SELECT:1 1 0 TGHG=00000000 TGUSER=00000000 INCL=00000000 EXCL=00000000
154361mS CMTARGET: SELECT:1 NO TARGETS, TRY VOICEMAIL
154361mS PRN: CALL: 0.1001.0 Deleted leaving 0 CMCall objects
154362mS CALL:2011/11/0308:14,00:00:00,000,113,O,18015589178,918015589178,ChrissyW,,,1,,""n/a,0
154362mS CD: CALL: 0.1001.0 BState=Idle Cut=0 Music=0.1 Aend="ChrissyW (113)" (10.8) Bend="" [] (0.0) CalledNum=18015589178 () CallingNum=113 () Internal=1 Time=1 AState=Idle
154363mS CMExtnTx: v=69, p1=6
CMInbandTone
Line: type=DigitalExtn 4
Call: lid=0 id=1001 in=0
Product Unknown
UUI type=User2User [TB2\r\n] [0x54 0x42 0x32 0x0d 0x0a ]
Cause=34, No cct/chan available
Timed: 03/11/11 08:14
154364mS CD: CALL: 0.1001.0 Deleted
154560mS CMExtnRx: v=69, p1=6
CMShortCode
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
ShortCode GetCallInfo (108) = []
Product Unknown
154560mS CMExtnTx: v=69, p1=6
CMShortCode
Line: type=DigitalExtn 4
Call: lid=0 id=-1 in=0
ShortCode GetCallInfo (108) = []
BChan: slot=10 chan=8
Product Unknown
Timed: 03/11/11 08:14
154725mS RES: Thu 3/11/2011 08:14:35 FreeMem=3627968(4) CMMsg=5 (6) Buff=100 595 798 1100 5 Links=8906 Elements=0
156762mS CMExtnRx: v=69, p1=6
CMRelease
Line: type=NoLine 0
Call: lid=0 id=1001 in=0
Product Unknown
156763mS CMExtnTx: v=69, p1=6
CMInbandTone
Line: type=DigitalExtn 4
Call: lid=0 id=-1 in=0
Product Unknown
UUI type=User2User [TB0\r\n] [0x54 0x42 0x30 0x0d 0x0a ]
Timed: 03/11/11 08:14
156763mS CMExtnTx: v=69, p1=6
CMReleaseComp
Line: type=DigitalExtn 4
Call: lid=0 id=1001 in=0
Product Unknown
UUI type=Local [....] [0x03 0x00 0x00 0x0e ]
Timed: 03/11/11 08:14
158765mS CMExtnTx: v=69, p1=6
CMVoiceMailStatus
Line: type=DigitalExtn 4
Call: lid=0 id=-1 in=0
Called[ChrissyW Msgs=0 Old=0 Sav=0] Type=Default (100) Calling[00000000] Type=Default (100)
Product Unknown
UUI type=Local [....] [0x03 0x00 0x00 0x00 ]
Display [ChrissyW Msgs=0]
Timed: 03/11/11 08:14
158766mS CMExtnTx: v=69, p1=6
CMVoiceMailStatus
Line: type=DigitalExtn 4
Call: lid=0 id=-1 in=0
Called[Disaster Msgs=0 Old=0 Sav=0] Type=Default (100) Calling[00000000] Type=Default (100)
Product Unknown
UUI type=Local [....] [0x03 0x00 0x00 0x00 ]
Display [Disaster Msgs=0]
Timed: 03/11/11 08:14
158766mS CMExtnTx: v=69, p1=6
CMVoiceMailStatus
Line: type=DigitalExtn 4
Call: lid=0 id=-1 in=0
Called[ChemDry Msgs=0 Old=0 Sav=0] Type=Default (100) Calling[00000000] Type=Default (100)
Product Unknown
UUI type=Local [....] [0x03 0x00 0x00 0x00 ]
Display [ChemDry Msgs=0]
Timed: 03/11/11 08:14
455225mS RES: Thu 3/11/2011 08:19:36 FreeMem=3627768(4) CMMsg=5 (6) Buff=100 598 798 1100 5 Links=8906 Elements=0

********** SysMonitor v5.2 (53) [connected to 192.168.0.90 (ChemDry)] **********

529216mS PRN: Monitor Status IP 406 DS 3.2(53)
529216mS PRN: LAW=U PRI=1, BRI=0, ALOG=0, ADSL=0 VCOMP=5, MDM=0, WAN=0, MODU=1 LANM=0 CkSRC=0 VMAIL=1(VER=2 TYP=1) CALLS=0(TOT=1)
755225mS RES: Thu 3/11/2011 08:24:36 FreeMem=3627768(4) CMMsg=5 (6) Buff=100 598 798 1100 5 Links=8906 Elements=0

 

[motch6]

at the bottom of my Monitor window i'm getting this error:

"received BOOTP request for 0019db627782, 192.168.0.3:68, unable to process"

What's going on here? anyone know?

 

[motch6]

sorry, my "Manager" window... not monitor window.

 

[motch6]

IPguru...

Just to clarify... are you saying i should get my Line Provider involved?

I did some more searches on Cause 34 and it sounds like an error that may be caused by the Line Provider... not my IPOffice system... am i correct?

Thanks

 

[amriddle01]

Ignore the BOOTP requests, varios network devices send out those broadcasts and manager detects them and brings up that error, it can be ignored

http://www.ipoffice.tel

 

[motch6]

Amriddle, Ok.

Now, i just noticed, that one of the BOOTP files is missing... there were TWO files now there is only one. (I noticed this in the Manager, 2 files were previously there, now only one).

Not sure where to go or how to get this missing file back.

 

[motch6]

Wondering if that missing BOOTP files is from the IP400 Analog 16 trunk unit? If so, guess that would explain that it isn't working. ???

 

[motch6]

Again, noone has answered why the IP400 analog 16 unit doesn't show up in the "UPGRADE" list...

is it really not working even though it has a GREEN light?

 

[motch6]

Issue Resolved...

For us uneducated people here is the run down:

1) Because the IP400 Analog unit was not listed in the "Upgrade" menu in the Manager software this was one clue.
2) Because there wasn't a light "on" on the front of the IP406 Unit under "expansion" this was a 2nd clue.
3) Communcation "cause 34" was a third clue.
4) After trying several different Expansion ports on the back of the IP406 and still no connection status... this was a the FINAL clue.

The IP400 Analog 16 Unit is DEAD... even though it has a Green Active light!

PS: thank you for those of you that actually left helpful comments!

 

[motch6]

PSS:

Forgot a 5th Clue... It was ACTUALLY helpful to see the BOOTP error at the bottom of the page of the Manager... This was another clue that something was missing! It was trying to find the BOOTP file from the Analog UNIT... Could not find it since it was also not listed the the list of Devises!