Having an issue... Once in a while throughout the day, you will try to call one of our branch offices and every extension you try will say "Number Busy" immediately and nobody can call. Then if you wait like 5-10 minutes the problem will go away for a while then come back. I'm trying to figure out why. We just installed 10 VOIP (5610) IP phones into that office, we are running IP 403 3.2 (53) control units. I recorded the monitor logs from where I made the call, and the one from the other end unit during the problem. (I am extension 971 trying to call ext 950 for the most part) I will put both logs below:
From my own unit:
2986mS CMExtnRx: v=971, p1=6
CMRelease
Line: type=NoLine 0
Call: lid=0 id=5375 in=0
Product Unknown
2987mS CMExtnCopyProcessMsg: v=6
CMRelease
Line: type=NoLine 0
Call: lid=0 id=5375 in=0
BChan: slot=2 chan=23
Product Unknown
2988mS CMExtnTx: v=971, p1=6
CMInbandTone
Line: type=DigitalExtn 3
Call: lid=0 id=-1 in=0
Product Unknown
UUI type=User2User [TD0\r\n] [0x54 0x44 0x30 0x0d 0x0a ]
Timed: 01/09/10 10:26
2988mS CMExtnTxP: v=6
CMInbandTone
Line: type=DigitalExtn 3
Call: lid=0 id=5375 in=0
Product Unknown
UUI type=User2User [TD0\r\n] [0x54 0x44 0x30 0x0d 0x0a ]
Timed: 01/09/10 10:26
2989mS PRN: CALL: 0.5375.0 Deleted leaving 4 CMCall objects
2989mS CMMap: a=2.23 b=0.0 D0
2990mS CALL:2010/09/0110:26,00:00:00,000,971,O,,,TylerH,,,1,,""n/a,0
2991mS CMExtnCopyCallLostMsg: v=6
CMReleaseComp
Line: type=NoLine 0
Call: lid=0 id=5375 in=0
Product Unknown
Cause=16, Normal call clearing
2992mS CMExtnTx: v=971, p1=6
CMReleaseComp
Line: type=DigitalExtn 3
Call: lid=0 id=5375 in=0
Product Unknown
UUI type=Local [....] [0x03 0x00 0x00 0x02 ]
Cause=16, Normal call clearing
Timed: 01/09/10 10:26
2993mS CMExtnTxP: v=6
CMReleaseComp
Line: type=DigitalExtn 3
Call: lid=0 id=-1 in=0
Product Unknown
UUI type=Local [....] [0x03 0x00 0x00 0x02 ]
Cause=16, Normal call clearing
Timed: 01/09/10 10:26
2994mS CD: CALL: 0.5375.0 Deleted
2994mS CMExtnTx: v=971, p1=6
CMReleaseComp
Line: type=DigitalExtn 3
Call: lid=0 id=5375 in=0
Product Unknown
UUI type=Local [....] [0x03 0x00 0x00 0x0e ]
Timed: 01/09/10 10:26
2995mS CMExtnTxP: v=6
CMReleaseComp
Line: type=DigitalExtn 3
Call: lid=0 id=-1 in=0
Product Unknown
UUI type=Local [....] [0x03 0x00 0x00 0x0e ]
Timed: 01/09/10 10:26
3002mS PRN: +++ START OF ALARM LOG DUMP +++
3002mS PRN: ALARM: 21/04/2008 09:24:01 IP 403 3.2(53) <TLB Data Error> CRIT RAISED addr=3ade6abb d=16 pc=ff52a63c ff50b104 ff52a8cc ff5c0bf4 ff58c554 ff78f63c
3003mS PRN: ALARM: 15/04/2009 15:16:31 IP 403 3.2(53) <TLB Data Error> CRIT RAISED addr=3cb98b6a d=7 pc=ff50ed6c aaaaaaaa ff50d910 ff50ab8c ff50ac2c ff6aaedc
3003mS PRN: ALARM: 16/06/2009 09:55:08 IP 403 3.2(53) <WATCHDOG> CRIT RAISED addr=00000000 d=0 pc=ff50f568 ff506d58 ff506d84 ff50ce70 ff67bf24 ff452f48
3003mS PRN: +++ END OF ALARM LOG DUMP +++
3192mS CMExtnCopyProcessMsg: v=6
CMShortCode
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
ShortCode GetCallInfo (108) = []
BChan: slot=2 chan=23
Product Unknown
3371mS CMExtnRx: v=971, p1=6
CMSetup
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
Product Unknown
3371mS CMExtnCopyProcessMsg: v=6
CMSetup
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
BChan: slot=2 chan=23
Product Unknown
3373mS CMTARGET: LOOKUP CALL ROUTE:2482 type=100 called_party= sub= calling=971 in=0 complete=0
3373mS CMTARGET: ADD TARGET:2482 number= type=100 depth=1 nobar=1 setorig=1
3374mS CMTARGET: LOOKUP CALL ROUTE:2482 returned 0
3374mS CD: CALL: 0.5377.0 BState=Idle Cut=0 Music=0.0 Aend="Tyler H(971)" (2.23) Bend="" [] (0.0) CalledNum= () CallingNum=971 () Internal=1 Time=2 AState=Dialling
3375mS CMExtnCopyProcessCallMsg: v=6
CMSetupAck
Line: type=NoLine 0
Call: lid=0 id=5377 in=0
BChan: slot=2 chan=23
Product Unknown
3375mS CMExtnTx: v=971, p1=6
CMInbandTone
Line: type=DigitalExtn 3
Call: lid=0 id=-1 in=0
Product Unknown
UUI type=User2User [TD1\r\n] [0x54 0x44 0x31 0x0d 0x0a ]
Timed: 01/09/10 10:26
3376mS CMExtnTxP: v=6
CMInbandTone
Line: type=DigitalExtn 3
Call: lid=0 id=5377 in=0
Product Unknown
UUI type=User2User [TD1\r\n] [0x54 0x44 0x31 0x0d 0x0a ]
Timed: 01/09/10 10:26
3376mS CMExtnTx: v=971, p1=6
CMSetupAck
Line: type=DigitalExtn 3
Call: lid=0 id=5377 in=0
BChan: slot=2 chan=23
Product Unknown
Timed: 01/09/10 10:26
3377mS CMExtnTxP: v=6
CMSetupAck
Line: type=DigitalExtn 3
Call: lid=0 id=5377 in=0
BChan: slot=2 chan=23
Product Unknown
Timed: 01/09/10 10:26
3378mS CD: CALL: 0.5377.0 BState=Idle Cut=0 Music=0.0 Aend="Tyler H(971)" (2.23) Bend="" [] (0.0) CalledNum= () CallingNum=971 () Internal=1 Time=6 AState=LocalDial
3378mS CMMap: a=2.23 b=0.0 D1
3415mS PRN: TFTPServer::RRQ(from 131.131.1.112) nasystem/call_info/0.5377.0
3575mS CMExtnCopyProcessMsg: v=6
CMShortCode
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
ShortCode GetCallInfo (108) = []
BChan: slot=2 chan=23
Product Unknown
3616mS CMExtnRx: v=971, p1=6
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[9] Type=Default (100)
Product Unknown
3616mS CMExtnCopyProcessMsg: v=6
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[9] Type=Default (100)
BChan: slot=2 chan=23
Product Unknown
3617mS CMExtnTx: v=971, p1=6
CMInbandTone
Line: type=DigitalExtn 3
Call: lid=0 id=-1 in=0
Product Unknown
UUI type=User2User [TD0\r\n] [0x54 0x44 0x30 0x0d 0x0a ]
Timed: 01/09/10 10:26
3617mS CMExtnTxP: v=6
CMInbandTone
Line: type=DigitalExtn 3
Call: lid=0 id=5377 in=0
Product Unknown
UUI type=User2User [TD0\r\n] [0x54 0x44 0x30 0x0d 0x0a ]
Timed: 01/09/10 10:26
3618mS CMMap: a=2.23 b=0.0 D0
3618mS CMTARGET: LOOKUP CALL ROUTE:2482 type=100 called_party=9 sub= calling=971 in=0 complete=0
3619mS CMTARGET: ADD TARGET:2482 number=9 type=100 depth=1 nobar=1 setorig=1
3620mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:2482 returned 0
3818mS CMExtnRx: v=971, p1=6
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[5] Type=Default (100)
Product Unknown
3818mS CMExtnCopyProcessMsg: v=6
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[5] Type=Default (100)
BChan: slot=2 chan=23
Product Unknown
3819mS CMTARGET: LOOKUP CALL ROUTE:2482 type=100 called_party=95 sub= calling=971 in=0 complete=0
3819mS CMTARGET: ADD TARGET:2482 number=95 type=100 depth=1 nobar=1 setorig=1
3821mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:2482 returned 0
3994mS CMExtnRx: v=971, p1=6
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[0] Type=Default (100)
Product Unknown
3994mS CMExtnCopyProcessMsg: v=6
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[0] Type=Default (100)
BChan: slot=2 chan=23
Product Unknown
3995mS CMTARGET: LOOKUP CALL ROUTE:2482 type=100 called_party=950 sub= calling=971 in=0 complete=0
3996mS CMTARGET: ADD TARGET:2482 number=950 type=100 depth=1 nobar=1 setorig=1
3996mS CMTARGET: SET USER:2482 Michelle S orig=1
3997mS CMTARGET: ADD USER:2482 Michelle S(950, state=Idle) (depth=2 B=0) cw=0
3997mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:2482 returned 1
3998mS CD: CALL: 0.5377.0 BState=Idle Cut=1 Music=0.0 Aend="Tyler H(971)" (2.23) Bend="Michelle S(950)" [Line 16] (0.0) CalledNum=950 () CallingNum=971 () Internal=0 Time=626 AState=Dialling
3999mS CMExtnCopyProcessCallMsg: v=6
CMSetupAck
Line: type=NoLine 0
Call: lid=0 id=5377 in=0
Called[950] Type=Default (100)
BChan: slot=2 chan=23
Product Unknown
Display [Michelle S]
3999mS CMExtnTx: v=971, p1=6
CMSetupAck
Line: type=DigitalExtn 3
Call: lid=0 id=5377 in=0
Called[950] Type=Default (100)
BChan: slot=2 chan=23
Product Unknown
Display [Michelle S]
Timed: 01/09/10 10:26
4000mS CMExtnTxP: v=6
CMSetupAck
Line: type=DigitalExtn 3
Call: lid=0 id=5377 in=0
Called[950] Type=Default (100)
BChan: slot=2 chan=23
Product Unknown
Display [Michelle S]
Timed: 01/09/10 10:26
4001mS CD: CALL: 0.5377.0 BState=Idle Cut=1 Music=0.0 Aend="Tyler H(971)" (2.23) Bend="Michelle S(950)" [Line 16] (0.0) CalledNum=950 () CallingNum=971 () Internal=0 Time=628 AState=Dialled
4004mS CMLineTx: v=16
CMSetup
Line: type=IPLine 16
Call: lid=0 id=5378 in=0
Called[950] Type=Default (100) Calling[971] Type=Internal (101)
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
BChan: slot=250 chan=9012
Product Unknown
IE CMIETxChannelAudio (1) comptype=Ulaw64K (5) pktsize=160 ipaddr=131.131.2.193 port=0
IE CMIERxChannelAudio (2) comptype=Ulaw64K (5) pktsize=160 ipaddr=131.131.1.193 port=49832
Display [Tyler H>Michelle S]
Cause=16, Normal call clearing
Locale: enu
4064mS PRN: TFTPServer::RRQ(from 131.131.1.112) nasystem/call_info/0.5377.0
4172mS CMLineRx: v=16
CMReleaseComp
Line: type=IPLine 16
Call: lid=0 id=5378 in=0
Product Unknown
Cause=17, User busy
4174mS CD: CALL: 0.5377.0 BState=ReDialling Cut=1 Music=0.0 Aend="Tyler H(971)" (2.23) Bend="Michelle S(950)" [] (0.0) CalledNum=950 () CallingNum=971 () Internal=1 Time=801 AState=Dialled
4174mS CMExtnTx: v=, p1=1037
CMReleaseComp
Line: type=RAS 1
Call: lid=0 id=1037 in=0
BChan: slot=3 chan=14
Product Unknown
4198mS CMExtnCopyProcessMsg: v=6
CMShortCode
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
ShortCode GetCallInfo (108) = []
BChan: slot=2 chan=23
Product Unknown
4426mS CMExtnRx: v=930, p1=2
CMSetup
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
Product Unknown
4427mS CMExtnCopyProcessMsg: v=2
CMSetup
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
BChan: slot=2 chan=7
Product Unknown
4428mS CMTARGET: LOOKUP CALL ROUTE:2483 type=100 called_party= sub= calling=930 in=0 complete=0
4428mS CMTARGET: ADD TARGET:2483 number= type=100 depth=1 nobar=1 setorig=1
4429mS CMTARGET: LOOKUP CALL ROUTE:2483 returned 0
4430mS CD: CALL: 0.5380.0 BState=Idle Cut=0 Music=0.0 Aend="Debbe C(930)" (2.7) Bend="" [] (0.0) CalledNum= () CallingNum=930 () Internal=1 Time=2 AState=Dialling
4430mS CMExtnCopyProcessCallMsg: v=2
CMSetupAck
Line: type=NoLine 0
Call: lid=0 id=5380 in=0
BChan: slot=2 chan=7
Product Unknown
4431mS CMExtnTx: v=930, p1=2
CMInbandTone
Line: type=DigitalExtn 3
Call: lid=0 id=-1 in=0
Product Unknown
UUI type=User2User [TD1\r\n] [0x54 0x44 0x31 0x0d 0x0a ]
Timed: 01/09/10 10:26
4431mS CMExtnTxP: v=2
CMInbandTone
Line: type=DigitalExtn 3
Call: lid=0 id=5380 in=0
Product Unknown
UUI type=User2User [TD1\r\n] [0x54 0x44 0x31 0x0d 0x0a ]
Timed: 01/09/10 10:26
4432mS CMExtnTx: v=930, p1=2
CMSetupAck
Line: type=DigitalExtn 3
Call: lid=0 id=5380 in=0
BChan: slot=2 chan=7
Product Unknown
Timed: 01/09/10 10:26
4432mS CMExtnTxP: v=2
CMSetupAck
Line: type=DigitalExtn 3
Call: lid=0 id=5380 in=0
BChan: slot=2 chan=7
Product Unknown
Timed: 01/09/10 10:26
4433mS CD: CALL: 0.5380.0 BState=Idle Cut=0 Music=0.0 Aend="Debbe C(930)" (2.7) Bend="" [] (0.0) CalledNum= () CallingNum=930 () Internal=1 Time=6 AState=LocalDial
4434mS CMMap: a=2.7 b=0.0 D1
4472mS PRN: TFTPServer::RRQ(from 131.131.1.54) nasystem/call_info/0.5380.0
4631mS CMExtnCopyProcessMsg: v=2
CMShortCode
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
ShortCode GetCallInfo (108) = []
BChan: slot=2 chan=7
Product Unknown
5162mS CMTARGET: SELECT:2482 0 0 TGHG=00000000 TGUSER=ffcf395c INCL=00000001 EXCL=00000001
5162mS CMTARGET: ADD USER:2482 Michelle S(950, state=Idle) (depth=1 B=13) cw=0
5163mS CMTARGET: SELECT:2482 NO TARGETS, TRY VOICEMAIL
5163mS CMTARGET: LCR NOT MATCHED:2482 (cpn=950)
5163mS CMTARGET: SELECT:2482 BUSY
5164mS PRN: CALL: 0.5377.0 Deleted leaving 5 CMCall objects
5165mS CALL:2010/09/0110:26,00:00:00,000,971,O,950,950,TylerH,,,1,,""n/a,0
5165mS CMExtnCopyCallLostMsg: v=6
CMReleaseComp
Line: type=NoLine 0
Call: lid=0 id=5377 in=0
Called[950] Type=Default (100)
Product Unknown
Display [950]
Cause=17, User busy
5166mS CD: CALL: 0.5377.0 BState=Idle Cut=0 Music=0.1 Aend="Tyler H(971)" (2.23) Bend="Michelle S(950)" [] (0.0) CalledNum=950 () CallingNum=971 () Internal=1 Time=1794 AState=Idle
5167mS CMExtnTx: v=971, p1=6
CMInbandTone
Line: type=DigitalExtn 3
Call: lid=0 id=5377 in=0
Product Unknown
UUI type=User2User [TB1\r\n] [0x54 0x42 0x31 0x0d 0x0a ]
Cause=17, User busy
Timed: 01/09/10 10:26
5168mS CMExtnTxP: v=6
CMInbandTone
Line: type=DigitalExtn 3
Call: lid=0 id=-1 in=0
Product Unknown
UUI type=User2User [TB1\r\n] [0x54 0x42 0x31 0x0d 0x0a ]
Cause=17, User busy
Timed: 01/09/10 10:26
5169mS CD: CALL: 0.5377.0 Deleted
5184mS RES: Wed 1/9/2010 10:26:53 FreeMem=3375772(14) CMMsg=6 (7) Buff=98 522 497 1390 3 Links=6156 Elements=166
5223mS PRN: TFTPServer::RRQ(from 131.131.1.112) nasystem/call_info/0.5377.0
5367mS CMExtnCopyProcessMsg: v=6
CMShortCode
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
ShortCode GetCallInfo (108) = []
BChan: slot=2 chan=23
Product Unknown
5559mS CMExtnRx: v=930, p1=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[5] Type=Default (100)
Product Unknown
5559mS CMExtnCopyProcessMsg: v=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[5] Type=Default (100)
BChan: slot=2 chan=7
Product Unknown
5560mS CMExtnTx: v=930, p1=2
CMInbandTone
Line: type=DigitalExtn 3
Call: lid=0 id=-1 in=0
Product Unknown
UUI type=User2User [TD0\r\n] [0x54 0x44 0x30 0x0d 0x0a ]
Timed: 01/09/10 10:26
5561mS CMExtnTxP: v=2
CMInbandTone
Line: type=DigitalExtn 3
Call: lid=0 id=5380 in=0
Product Unknown
UUI type=User2User [TD0\r\n] [0x54 0x44 0x30 0x0d 0x0a ]
Timed: 01/09/10 10:26
5561mS CMMap: a=2.7 b=0.0 D0
5562mS CMTARGET: LOOKUP CALL ROUTE:2483 type=100 called_party=5 sub= calling=930 in=0 complete=0
5562mS CMTARGET: ADD TARGET:2483 number=5 type=100 depth=1 nobar=1 setorig=1
5563mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:2483 returned 0
5769mS CMExtnRx: v=930, p1=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[4] Type=Default (100)
Product Unknown
5769mS CMExtnCopyProcessMsg: v=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[4] Type=Default (100)
BChan: slot=2 chan=7
Product Unknown
5770mS CMTARGET: LOOKUP CALL ROUTE:2483 type=100 called_party=54 sub= calling=930 in=0 complete=0
5770mS CMTARGET: ADD TARGET:2483 number=54 type=100 depth=1 nobar=1 setorig=1
5771mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:2483 returned 0
5944mS CMExtnRx: v=930, p1=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[1] Type=Default (100)
Product Unknown
5944mS CMExtnCopyProcessMsg: v=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[1] Type=Default (100)
BChan: slot=2 chan=7
Product Unknown
5945mS CMTARGET: LOOKUP CALL ROUTE:2483 type=100 called_party=541 sub= calling=930 in=0 complete=0
5946mS CMTARGET: ADD TARGET:2483 number=541 type=100 depth=1 nobar=1 setorig=1
5947mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:2483 returned 0
6033mS CMExtnRxP: v=8
CMShortCode
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
ShortCode GetSystemInfo (99) = []
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
Product Unknown
6034mS CMExtnTxP: v=8
CMShortCode
Line: type=DigitalExtn 5
Call: lid=0 id=-1 in=0
ShortCode GetSystemInfo (99) = [3.2 (53)] Calling[LinnCo_Leb] Type=Default (100)
Product Unknown
Display [IP 403]
Tag type=Text [1,1,2,1,0,0,0.] [0x31 0x2c 0x31 0x2c 0x32 0x2c 0x31 0x2c 0x30 0x2c 0x30 0x2c 0x30 0x00 ]
Timed: 01/09/10 10:26
6051mS CMExtnRxP: v=8
CMShortCode
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
ShortCode IVRMessage (70) = []
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
Product Unknown
Tag type=Text [VMM$SENDMSGD$902$%] [0x56 0x4d 0x4d 0x24 0x53 0x45 0x4e 0x44 0x4d 0x53 0x47 0x44 0x24 0x39 0x30 0x32 0x24 0x25 ]
6051mS PRN: VMAIL - Send IVR Message VMM$SENDMSGD$902$% vmail_server=ffe557ac
6072mS CMExtnTxP: v=8
CMVoiceMailStatus
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[902] Type=Default (100)
Product Unknown
Tag type=Binary [VMS$MBXSUCCESS$40422$%] [0x56 0x4d 0x53 0x24 0x4d 0x42 0x58 0x53 0x55 0x43 0x43 0x45 0x53 0x53 0x24 0x34 0x30 0x34 0x32 0x32 0x24 0x25 ]
6073mS CMExtnTxP: v=8
CMVoiceMailStatus
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[902] Type=Default (100)
Product Unknown
Tag type=Binary [VMM$MSG00462$O$2010/8/26 13:14$5419295061$21$0$0$%] [0x56 0x4d 0x4d 0x24 0x4d 0x53 0x47 0x30 0x30 0x34 0x36 0x32 0x24 0x4f 0x24 0x32 0x30 0x31 0x30 0x2f 0x38 0x2f 0x32 0x36 0x20 0x31 0x33 0x3a 0x31 0x34 ]
6075mS CMExtnTxP: v=8
CMVoiceMailStatus
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[902] Type=Default (100)
Product Unknown
Tag type=Binary [VMM$MSG00463$O$2010/8/26 15:21$5415705063$21$0$0$%] [0x56 0x4d 0x4d 0x24 0x4d 0x53 0x47 0x30 0x30 0x34 0x36 0x33 0x24 0x4f 0x24 0x32 0x30 0x31 0x30 0x2f 0x38 0x2f 0x32 0x36 0x20 0x31 0x35 0x3a 0x32 0x31 ]
6076mS CMExtnTxP: v=8
CMVoiceMailStatus
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[902] Type=Default (100)
Product Unknown
Tag type=Binary [VMM$MSG00465$O$2010/8/27 13:32$5414013585$9$0$0$%] [0x56 0x4d 0x4d 0x24 0x4d 0x53 0x47 0x30 0x30 0x34 0x36 0x35 0x24 0x4f 0x24 0x32 0x30 0x31 0x30 0x2f 0x38 0x2f 0x32 0x37 0x20 0x31 0x33 0x3a 0x33 0x32 0]
6078mS CMExtnTxP: v=8
CMVoiceMailStatus
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[902] Type=Default (100)
Product Unknown
Tag type=Binary [VMM$MSG00466$O$2010/8/30 10:04$5038052253$16$0$0$%] [0x56 0x4d 0x4d 0x24 0x4d 0x53 0x47 0x30 0x30 0x34 0x36 0x36 0x24 0x4f 0x24 0x32 0x30 0x31 0x30 0x2f 0x38 0x2f 0x33 0x30 0x20 0x31 0x30 0x3a 0x30 0x34 ]
6493mS CMExtnRx: v=930, p1=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[4] Type=Default (100)
Product Unknown
6493mS CMExtnCopyProcessMsg: v=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[4] Type=Default (100)
BChan: slot=2 chan=7
Product Unknown
6494mS CMTARGET: LOOKUP CALL ROUTE:2483 type=100 called_party=5414 sub= calling=930 in=0 complete=0
6494mS CMTARGET: ADD TARGET:2483 number=5414 type=100 depth=1 nobar=1 setorig=1
6495mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:2483 returned 0
6722mS CMExtnRx: v=930, p1=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[0] Type=Default (100)
Product Unknown
6722mS CMExtnCopyProcessMsg: v=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[0] Type=Default (100)
BChan: slot=2 chan=7
Product Unknown
6723mS CMTARGET: LOOKUP CALL ROUTE:2483 type=100 called_party=54140 sub= calling=930 in=0 complete=0
6723mS CMTARGET: ADD TARGET:2483 number=54140 type=100 depth=1 nobar=1 setorig=1
6725mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:2483 returned 0
6949mS CMExtnRx: v=930, p1=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[5] Type=Default (100)
Product Unknown
6949mS CMExtnCopyProcessMsg: v=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[5] Type=Default (100)
BChan: slot=2 chan=7
Product Unknown
6950mS CMTARGET: LOOKUP CALL ROUTE:2483 type=100 called_party=541405 sub= calling=930 in=0 complete=0
6950mS CMTARGET: ADD TARGET:2483 number=541405 type=100 depth=1 nobar=1 setorig=1
6951mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:2483 returned 0
7362mS CMExtnRx: v=930, p1=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[6] Type=Default (100)
Product Unknown
7362mS CMExtnCopyProcessMsg: v=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[6] Type=Default (100)
BChan: slot=2 chan=7
Product Unknown
7363mS CMTARGET: LOOKUP CALL ROUTE:2483 type=100 called_party=5414056 sub= calling=930 in=0 complete=0
7363mS CMTARGET: ADD TARGET:2483 number=5414056 type=100 depth=1 nobar=1 setorig=1
7364mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:2483 returned 0
7560mS CMExtnRx: v=930, p1=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[8] Type=Default (100)
Product Unknown
7560mS CMExtnCopyProcessMsg: v=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[8] Type=Default (100)
BChan: slot=2 chan=7
Product Unknown
7561mS CMTARGET: LOOKUP CALL ROUTE:2483 type=100 called_party=54140568 sub= calling=930 in=0 complete=0
7561mS CMTARGET: ADD TARGET:2483 number=54140568 type=100 depth=1 nobar=1 setorig=1
7562mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:2483 returned 0
7813mS CMExtnRxP: v=14
CMShortCode
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
ShortCode GetSystemInfo (99) = []
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
Product Unknown
7814mS CMExtnTxP: v=14
CMShortCode
Line: type=DigitalExtn 5
Call: lid=0 id=-1 in=0
ShortCode GetSystemInfo (99) = [3.2 (53)] Calling[LinnCo_Leb] Type=Default (100)
Product Unknown
Display [IP 403]
Tag type=Text [1,1,2,1,0,0,0.] [0x31 0x2c 0x31 0x2c 0x32 0x2c 0x31 0x2c 0x30 0x2c 0x30 0x2c 0x30 0x00 ]
Timed: 01/09/10 10:26
7831mS CMExtnRxP: v=14
CMShortCode
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
ShortCode IVRMessage (70) = []
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
Product Unknown
Tag type=Text [VMM$SENDMSGD$905$%] [0x56 0x4d 0x4d 0x24 0x53 0x45 0x4e 0x44 0x4d 0x53 0x47 0x44 0x24 0x39 0x30 0x35 0x24 0x25 ]
7832mS PRN: VMAIL - Send IVR Message VMM$SENDMSGD$905$% vmail_server=ffe557ac
7851mS CMExtnTxP: v=14
CMVoiceMailStatus
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[905] Type=Default (100)
Product Unknown
Tag type=Binary [VMS$MBXSUCCESS$40422$%] [0x56 0x4d 0x53 0x24 0x4d 0x42 0x58 0x53 0x55 0x43 0x43 0x45 0x53 0x53 0x24 0x34 0x30 0x34 0x32 0x32 0x24 0x25 ]
7857mS CMExtnRx: v=930, p1=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[1] Type=Default (100)
Product Unknown
7857mS CMExtnCopyProcessMsg: v=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[1] Type=Default (100)
BChan: slot=2 chan=7
Product Unknown
7858mS CMTARGET: LOOKUP CALL ROUTE:2483 type=100 called_party=541405681 sub= calling=930 in=0 complete=0
7858mS CMTARGET: ADD TARGET:2483 number=541405681 type=100 depth=1 nobar=1 setorig=1
7859mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:2483 returned 0
8086mS CMExtnRx: v=930, p1=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[7] Type=Default (100)
Product Unknown
8086mS CMExtnCopyProcessMsg: v=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[7] Type=Default (100)
BChan: slot=2 chan=7
Product Unknown
8087mS CMTARGET: LOOKUP CALL ROUTE:2483 type=100 called_party=5414056817 sub= calling=930 in=0 complete=0
8087mS CMTARGET: ADD TARGET:2483 number=5414056817 type=100 depth=1 nobar=1 setorig=1
8089mS CMTARGET: SYS SC:2483 5414056817 10 4056817 sc=type=Dial code=541xxxxxxx, num=541N
8089mS CMTARGET: LCR NOT MATCHED:2483 (cpn=5414056817)
8090mS CMTARGET: DIAL LINE:2483 GROUP=15 SUCCESS=1
8090mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:2483 returned 1
8090mS CD: CALL: 0.5380.0 BState=Idle Cut=1 Music=0.0 Aend="Debbe C(930)" (2.7) Bend="Line 15" [Line 15] (0.0) CalledNum=5414056817 () CallingNum=930 () Internal=0 Time=3663 AState=Dialling
8091mS CMExtnCopyProcessCallMsg: v=2
CMSetupAck
Line: type=NoLine 0
Call: lid=0 id=5380 in=0
Called[5414056817] Type=Default (100)
BChan: slot=2 chan=7
Product Unknown
Display [5414056817]
8092mS CMExtnTx: v=930, p1=2
CMSetupAck
Line: type=DigitalExtn 3
Call: lid=0 id=5380 in=0
Called[5414056817] Type=Default (100)
BChan: slot=2 chan=7
Product Unknown
Display [5414056817]
Timed: 01/09/10 10:26
8093mS CMExtnTxP: v=2
CMSetupAck
Line: type=DigitalExtn 3
Call: lid=0 id=5380 in=0
Called[5414056817] Type=Default (100)
BChan: slot=2 chan=7
Product Unknown
Display [5414056817]
Timed: 01/09/10 10:26
8094mS CD: CALL: 0.5380.0 BState=Idle Cut=1 Music=0.0 Aend="Debbe C(930)" (2.7) Bend="Line 15" [Line 15] (0.0) CalledNum=5414056817 () CallingNum=930 () Internal=0 Time=3666 AState=Dialled
8096mS CMLineTx: v=15
CMSetup
Line: type=IPLine 15
Call: lid=0 id=5381 in=0
Called[5414056817] Type=Default (100) Calling[930] Type=Internal (101)
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
BChan: slot=250 chan=9013
Product Unknown
IE CMIETxChannelAudio (1) comptype=G729A8K (6) pktsize=20 ipaddr=131.131.3.193 port=0
IE CMIERxChannelAudio (2) comptype=G729A8K (6) pktsize=20 ipaddr=131.131.1.193 port=49834
Display [Debbe Cross]
Cause=16, Normal call clearing
Locale: enu
8156mS PRN: TFTPServer::RRQ(from 131.131.1.54) nasystem/call_info/0.5380.0
8241mS CMLineRx: v=15
CMFacility
Line: type=IPLine 15
Call: lid=0 id=5381 in=0
Product Unknown
UUI type=User2User [turn h323setuptimer off] [0x74 0x75 0x72 0x6e 0x20 0x68 0x33 0x32 0x33 0x73 0x65 0x74 0x75 0x70 0x74 0x69 0x6d 0x65 0x72 0x20 0x6f 0x66 0x66 ]
8291mS CMExtnCopyProcessMsg: v=2
CMShortCode
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
ShortCode GetCallInfo (108) = []
BChan: slot=2 chan=7
Product Unknown
8310mS CMLineRx: v=15
CMFacility
Line: type=IPLine 15
Call: lid=0 id=5381 in=0
Product Unknown
UUI type=User2User [SC=VPN_CAN_TERMINATE_FALSE...] [0x53 0x43 0x3d 0x56 0x50 0x4e 0x5f 0x43 0x41 0x4e 0x5f 0x54 0x45 0x52 0x4d 0x49 0x4e 0x41 0x54 0x45 0x5f 0x46 0x41 0x4c 0x53 0x45 0x00 0x00 0x00 ]
8334mS CMLineRx: v=15
CMProceeding
Line: type=IPLine 15
Call: lid=0 id=5381 in=0
BChan: slot=250 chan=9013
Product Standard
IE CMIETxChannelAudio (1) comptype=G729A8K (6) pktsize=20 ipaddr=131.131.3.193 port=49640
IE CMIERxChannelAudio (2) comptype=G729A8K (6) pktsize=20 ipaddr=131.131.1.193 port=49834
8335mS CMMap: a=2.7 b=250.9013 M1
8335mS PRN: Converted to:
8336mS CMMap: a=2.7 b=3.14 M1
8336mS CD: CALL: 0.5380.0 BState=Idle Cut=3 Music=0.0 Aend="Debbe C(930)" (2.7) Bend="Line 15" [Line 15] (250.9013) CalledNum=5414056817 () CallingNum=930 () Internal=0 Time=3909 AState=Dialled
8337mS CD: CALL: 0.5380.0 BState=Dialled Cut=3 Music=0.0 Aend="Debbe C(930)" (2.7) Bend="Line 15" [Line 15] (250.9013) CalledNum=5414056817 () CallingNum=930 () Internal=0 Time=3910 AState=Dialled
8337mS CMExtnCopyProcessCallMsg: v=2
CMProceeding
Line: type=IPLine 15
Call: lid=0 id=5380 in=0
Called[5414056817] Type=Default (100)
BChan: slot=2 chan=7
Product Standard
IE CMIETxChannelAudio (1) comptype=G729A8K (6) pktsize=20 ipaddr=131.131.3.193 port=49640
IE CMIERxChannelAudio (2) comptype=G729A8K (6) pktsize=20 ipaddr=131.131.1.193 port=49834
Display [5414056817]
8338mS CMExtnTx: v=930, p1=2
CMProceeding
Line: type=DigitalExtn 3
Call: lid=0 id=5380 in=0
Called[5414056817] Type=Default (100)
BChan: slot=2 chan=7
Product Standard
IE CMIETxChannelAudio (1) comptype=G729A8K (6) pktsize=20 ipaddr=131.131.3.193 port=49640
IE CMIERxChannelAudio (2) comptype=G729A8K (6) pktsize=20 ipaddr=131.131.1.193 port=49834
Display [5414056817]
Timed: 01/09/10 10:26
8339mS CMExtnTxP: v=2
CMProceeding
Line: type=DigitalExtn 3
Call: lid=0 id=5380 in=0
Called[5414056817] Type=Default (100)
BChan: slot=2 chan=7
Product Standard
IE CMIETxChannelAudio (1) comptype=G729A8K (6) pktsize=20 ipaddr=131.131.3.193 port=49640
IE CMIERxChannelAudio (2) comptype=G729A8K (6) pktsize=20 ipaddr=131.131.1.193 port=49834
Display [5414056817]
Timed: 01/09/10 10:26
8345mS PRN: TFTPServer::RRQ(from 131.131.1.54) nasystem/call_info/0.5380.0
8537mS CMExtnCopyProcessMsg: v=2
CMShortCode
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
ShortCode GetCallInfo (108) = []
BChan: slot=2 chan=7
Product Unknown
10207mS RES: Wed 1/9/2010 10:26:58 FreeMem=3363040(11) CMMsg=5 (7) Buff=98 523 498 1388 3 Links=6147 Elements=166
10212mS CMLineRx: v=15
CMAlerting
Line: type=IPLine 15
Call: lid=0 id=5381 in=0
Product Standard
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLPublicNetRemoteUser (4), pd=CMPDInbandPattern (8)
10212mS CD: CALL: 0.5380.0 BState=Ringing Cut=3 Music=0.0 Aend="Debbe C(930)" (2.7) Bend="Line 15" [Line 15] (250.9013) CalledNum=5414056817 () CallingNum=930 () Internal=0 Time=5785 AState=Dialled
10213mS CD: CALL: 0.5380.0 BState=Ringing Cut=3 Music=0.0 Aend="Debbe C(930)" (2.7) Bend="Line 15" [Line 15] (250.9013) CalledNum=5414056817 () CallingNum=930 () Internal=0 Time=5786 AState=Ringing
10214mS CMExtnCopyProcessCallMsg: v=2
CMAlerting
Line: type=IPLine 15
Call: lid=0 id=5380 in=0
Called[5414056817] Type=Default (100)
BChan: slot=2 chan=7
Product Standard
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLPublicNetRemoteUser (4), pd=CMPDInbandPattern (8)
Display [5414056817]
10214mS CMExtnTx: v=930, p1=2
CMAlerting
Line: type=DigitalExtn 3
Call: lid=0 id=5380 in=0
Called[5414056817] Type=Default (100)
BChan: slot=2 chan=7
Product Standard
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLPublicNetRemoteUser (4), pd=CMPDInbandPattern (8)
Display [5414056817]
Timed: 01/09/10 10:26
10216mS CMExtnTxP: v=2
CMAlerting
Line: type=DigitalExtn 3
Call: lid=0 id=5380 in=0
Called[5414056817] Type=Default (100)
BChan: slot=2 chan=7
Product Standard
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLPublicNetRemoteUser (4), pd=CMPDInbandPattern (8)
Display [5414056817]
Timed: 01/09/10 10:26
10243mS PRN: TFTPServer::RRQ(from 131.131.1.54) nasystem/call_info/0.5380.0
10414mS CMExtnCopyProcessMsg: v=2
CMShortCode
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
ShortCode GetCallInfo (108) = []
BChan: slot=2 chan=7
Product Unknown
17011mS CMExtnRx: v=850, p1=5
CMReleaseComp
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Product Unknown
17011mS CMExtnTx: v=850, p1=5
CMReleaseComp
Line: type=AnalogueExtn 6
Call: lid=0 id=5355 in=0
BChan: slot=6 chan=7
Product Unknown
UUI type=Local [......2Pd] [0x01 0x03 0x00 0x00 0x01 0x02 0x32 0x50 0x64 ]
Timed: 01/09/10 10:27
17253mS RES: Wed 1/9/2010 10:27:06 FreeMem=3363060(13) CMMsg=6 (7) Buff=98 525 498 1388 3 Links=6147 Elements=166
********** Warning: Logging to Screen Stopped **********
Log from the other end unit where extension 950 is:
Log from the other end unit where extension 950 is:
Log from the other end unit where extension 950 is:
********** SysMonitor v5.2 (69) **********
********** contact made with 131.131.2.193 at 10:26:21 1/9/2010 **********
********** System (131.131.2.193) has been up and running for 1day, 12hrs, 25mins and 47secs(131147880mS) **********
********** Warning: TEXT File Logging selected **********
********** Warning: TEXT Logging to File STOPPED on 1/9/2010 10:26:21 **********
0mS PRN: Monitor Started IP=131.131.1.112 IP 403 3.2(53) LinnCo_SHome
1mS PRN: LAW=U PRI=0, BRI=0, ALOG=4, ADSL=0 VCOMP=5, MDM=0, WAN=0, MODU=0 LANM=0 CkSRC=0 VMAIL=1(VER=2 TYP=2) CALLS=2(TOT=334)
3395mS CMLineRx: v=21
CMSetup
Line: type=IPLine 21
Call: lid=21 id=3 in=2
Called[950] Type=Unknown (0) Calling[971] Type=Unknown (0)
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
BChan: slot=250 chan=20003
Product Standard
IE CMIETxChannelAudio (1) comptype=Ulaw64K (5) pktsize=160 ipaddr=131.131.1.193 port=49826
IE CMIESupplementaryService (5)
Network Facility Extension
sourceEntity: 0
destinationEntity: 0
Interpretation APDU
rejectAnyUnrecognisedInvokePdu
CallingName.Invoke
invokeId 18893
Display [Tyler H>Michelle S]
3396mS CD: CALL: 21.3.2 BState=Idle Cut=1 Music=0.0 Aend="Line 21" (250.20003) Bend="" [] (0.0) CalledNum=950 () CallingNum=971 () Internal=0 Time=1 AState=Idle
3397mS CMTARGET: LOOKUP CALL ROUTE:335 type=0 called_party=950 sub= calling=971 in=2 complete=0
3398mS CMTARGET: ADD TARGET:335 number=950 type=0 depth=1 nobar=1 setorig=1
3398mS CMTARGET: SET USER:335 Michelle S orig=1
3399mS CMTARGET: ADD USER:335 Michelle S(950, state=Idle) (depth=2 B=0) cw=0
3399mS PRN: Not enough (2) vocoders for the call: Line (21) -> Extn (950)
3400mS CMTARGET: LOOKUP CALL ROUTE:335 returned 1
3400mS CMTARGET: SELECT:335 1 0 TGHG=00000000 TGUSER=ffe2a278 INCL=00000000 EXCL=00000000
3401mS CMTARGET: ADD USER:335 Michelle S(950, state=Idle) (depth=1 B=0) cw=0
3401mS PRN: Not enough (2) vocoders for the call: Line (21) -> Extn (950)
3402mS CMTARGET: SELECT:335 NO TARGETS, TRY VOICEMAIL
3403mS PRN: Not enough (2) vocoders for the call: Line (21) -> Line (21)
3405mS CMLineTx: v=21
CMOpenLogicalChan
Line: type=IPLine 21
Call: lid=0 id=3 in=2
Called[950] Type=Default (100)
BChan: slot=250 chan=3
Product Unknown
IE CMIETxChannelAudio (1) comptype=Ulaw64K (5) pktsize=160 ipaddr=131.131.1.193 port=49826
IE CMIERxChannelAudio (2) comptype=Ulaw64K (5) pktsize=160 ipaddr=131.131.2.193 port=50276
Display [Michelle S]
3407mS PRN: CALL: 21.3.2 Deleted leaving 2 CMCall objects
3407mS CALL:2010/09/0110:26,00:00:00,000,971,I,950,950,To_LEB,,,0,,""n/a,0
3408mS CMLineTx: v=21
CMReleaseComp
Line: type=IPLine 21
Call: lid=0 id=3 in=2
Product Unknown
Cause=17, User busy
3409mS CMExtnTx: v=, p1=1033
CMReleaseComp
Line: type=RAS 1
Call: lid=0 id=1033 in=0
BChan: slot=3 chan=1
Product Unknown
3410mS CD: CALL: 21.3.2 Deleted
3538mS RES: Wed 1/9/2010 10:26:26 FreeMem=3555760(18) CMMsg=7 (8) Buff=100 630 498 1436 3 Links=6975 Elements=372
8538mS RES: Wed 1/9/2010 10:26:31 FreeMem=3557464(18) CMMsg=7 (8) Buff=100 630 498 1436 3 Links=6976 Elements=372
10654mS PRN: Loading holdmusic.wav from ipad=255.255.255.255
12920mS CMExtnRxP: v=3
CMShortCode
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
ShortCode GetSystemInfo (99) = []
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
Product Unknown
12921mS CMExtnTxP: v=3
CMShortCode
Line: type=IPLine 250
Call: lid=0 id=-1 in=0
ShortCode GetSystemInfo (99) = [3.2 (53)] Calling[LinnCo_SHome] Type=Default (100)
Product Unknown
Display [IP 403]
Tag type=Text [1,1,2,1,0,1,0.] [0x31 0x2c 0x31 0x2c 0x32 0x2c 0x31 0x2c 0x30 0x2c 0x31 0x2c 0x30 0x00 ]
Timed: 01/09/10 10:26
14390mS CMExtnRxP: v=5
CMShortCode
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
ShortCode GetSystemInfo (99) = []
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
Product Unknown
14391mS CMExtnTxP: v=5
CMShortCode
Line: type=IPLine 250
Call: lid=0 id=1558 in=0
ShortCode GetSystemInfo (99) = [3.2 (53)] Calling[LinnCo_SHome] Type=Default (100)
Product Unknown
Display [IP 403]
Tag type=Text [1,1,2,1,0,1,0.] [0x31 0x2c 0x31 0x2c 0x32 0x2c 0x31 0x2c 0x30 0x2c 0x31 0x2c 0x30 0x00 ]
Timed: 01/09/10 10:26
19537mS RES: Wed 1/9/2010 10:26:42 FreeMem=3544884(17) CMMsg=7 (8) Buff=100 630 498 1436 3 Links=6972 Elements=372
25539mS RES: Wed 1/9/2010 10:26:48 FreeMem=3557004(18) CMMsg=7 (8) Buff=100 630 498 1436 3 Links=6974 Elements=372
30365mS CMLineRx: v=21
CMSetup
Line: type=IPLine 21
Call: lid=21 id=3 in=2
Called[950] Type=Unknown (0) Calling[971] Type=Unknown (0)
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
BChan: slot=250 chan=20003
Product Standard
IE CMIETxChannelAudio (1) comptype=Ulaw64K (5) pktsize=160 ipaddr=131.131.1.193 port=49832
IE CMIESupplementaryService (5)
Network Facility Extension
sourceEntity: 0
destinationEntity: 0
Interpretation APDU
rejectAnyUnrecognisedInvokePdu
CallingName.Invoke
invokeId 18899
Display [Tyler H>Michelle S]
30366mS CD: CALL: 21.3.2 BState=Idle Cut=1 Music=0.0 Aend="Line 21" (250.20003) Bend="" [] (0.0) CalledNum=950 () CallingNum=971 () Internal=0 Time=1 AState=Idle
30367mS CMTARGET: LOOKUP CALL ROUTE:336 type=0 called_party=950 sub= calling=971 in=2 complete=0
30368mS CMTARGET: ADD TARGET:336 number=950 type=0 depth=1 nobar=1 setorig=1
30368mS CMTARGET: SET USER:336 Michelle S orig=1
30368mS CMTARGET: ADD USER:336 Michelle S(950, state=Idle) (depth=2 B=0) cw=0
30369mS PRN: Not enough (2) vocoders for the call: Line (21) -> Extn (950)
30370mS CMTARGET: LOOKUP CALL ROUTE:336 returned 1
30370mS CMTARGET: SELECT:336 1 0 TGHG=00000000 TGUSER=ffe2a278 INCL=00000000 EXCL=00000000
30370mS CMTARGET: ADD USER:336 Michelle S(950, state=Idle) (depth=1 B=0) cw=0
30371mS PRN: Not enough (2) vocoders for the call: Line (21) -> Extn (950)
30372mS CMTARGET: SELECT:336 NO TARGETS, TRY VOICEMAIL
30372mS PRN: Not enough (2) vocoders for the call: Line (21) -> Line (21)
30375mS CMLineTx: v=21
CMOpenLogicalChan
Line: type=IPLine 21
Call: lid=0 id=3 in=2
Called[950] Type=Default (100)
BChan: slot=250 chan=3
Product Unknown
IE CMIETxChannelAudio (1) comptype=Ulaw64K (5) pktsize=160 ipaddr=131.131.1.193 port=49832
IE CMIERxChannelAudio (2) comptype=Ulaw64K (5) pktsize=160 ipaddr=131.131.2.193 port=50278
Display [Michelle S]
30377mS PRN: CALL: 21.3.2 Deleted leaving 2 CMCall objects
30377mS CALL:2010/09/0110:26,00:00:00,000,971,I,950,950,To_LEB,,,0,,""n/a,0
30378mS CMLineTx: v=21
CMReleaseComp
Line: type=IPLine 21
Call: lid=0 id=3 in=2
Product Unknown
Cause=17, User busy
30379mS CMExtnTx: v=, p1=1033
CMReleaseComp
Line: type=RAS 1
Call: lid=0 id=1033 in=0
BChan: slot=3 chan=1
Product Unknown
30380mS CD: CALL: 21.3.2 Deleted
35538mS RES: Wed 1/9/2010 10:26:58 FreeMem=3557004(18) CMMsg=7 (8) Buff=100 630 498 1437 3 Links=6974 Elements=372
44037mS RES: Wed 1/9/2010 10:27:07 FreeMem=3556836(16) CMMsg=7 (8) Buff=100 630 498 1437 3 Links=6974 Elements=372
********** Warning: Logging to Screen Stopped **********
From my own unit:
2986mS CMExtnRx: v=971, p1=6
CMRelease
Line: type=NoLine 0
Call: lid=0 id=5375 in=0
Product Unknown
2987mS CMExtnCopyProcessMsg: v=6
CMRelease
Line: type=NoLine 0
Call: lid=0 id=5375 in=0
BChan: slot=2 chan=23
Product Unknown
2988mS CMExtnTx: v=971, p1=6
CMInbandTone
Line: type=DigitalExtn 3
Call: lid=0 id=-1 in=0
Product Unknown
UUI type=User2User [TD0\r\n] [0x54 0x44 0x30 0x0d 0x0a ]
Timed: 01/09/10 10:26
2988mS CMExtnTxP: v=6
CMInbandTone
Line: type=DigitalExtn 3
Call: lid=0 id=5375 in=0
Product Unknown
UUI type=User2User [TD0\r\n] [0x54 0x44 0x30 0x0d 0x0a ]
Timed: 01/09/10 10:26
2989mS PRN: CALL: 0.5375.0 Deleted leaving 4 CMCall objects
2989mS CMMap: a=2.23 b=0.0 D0
2990mS CALL:2010/09/0110:26,00:00:00,000,971,O,,,TylerH,,,1,,""n/a,0
2991mS CMExtnCopyCallLostMsg: v=6
CMReleaseComp
Line: type=NoLine 0
Call: lid=0 id=5375 in=0
Product Unknown
Cause=16, Normal call clearing
2992mS CMExtnTx: v=971, p1=6
CMReleaseComp
Line: type=DigitalExtn 3
Call: lid=0 id=5375 in=0
Product Unknown
UUI type=Local [....] [0x03 0x00 0x00 0x02 ]
Cause=16, Normal call clearing
Timed: 01/09/10 10:26
2993mS CMExtnTxP: v=6
CMReleaseComp
Line: type=DigitalExtn 3
Call: lid=0 id=-1 in=0
Product Unknown
UUI type=Local [....] [0x03 0x00 0x00 0x02 ]
Cause=16, Normal call clearing
Timed: 01/09/10 10:26
2994mS CD: CALL: 0.5375.0 Deleted
2994mS CMExtnTx: v=971, p1=6
CMReleaseComp
Line: type=DigitalExtn 3
Call: lid=0 id=5375 in=0
Product Unknown
UUI type=Local [....] [0x03 0x00 0x00 0x0e ]
Timed: 01/09/10 10:26
2995mS CMExtnTxP: v=6
CMReleaseComp
Line: type=DigitalExtn 3
Call: lid=0 id=-1 in=0
Product Unknown
UUI type=Local [....] [0x03 0x00 0x00 0x0e ]
Timed: 01/09/10 10:26
3002mS PRN: +++ START OF ALARM LOG DUMP +++
3002mS PRN: ALARM: 21/04/2008 09:24:01 IP 403 3.2(53) <TLB Data Error> CRIT RAISED addr=3ade6abb d=16 pc=ff52a63c ff50b104 ff52a8cc ff5c0bf4 ff58c554 ff78f63c
3003mS PRN: ALARM: 15/04/2009 15:16:31 IP 403 3.2(53) <TLB Data Error> CRIT RAISED addr=3cb98b6a d=7 pc=ff50ed6c aaaaaaaa ff50d910 ff50ab8c ff50ac2c ff6aaedc
3003mS PRN: ALARM: 16/06/2009 09:55:08 IP 403 3.2(53) <WATCHDOG> CRIT RAISED addr=00000000 d=0 pc=ff50f568 ff506d58 ff506d84 ff50ce70 ff67bf24 ff452f48
3003mS PRN: +++ END OF ALARM LOG DUMP +++
3192mS CMExtnCopyProcessMsg: v=6
CMShortCode
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
ShortCode GetCallInfo (108) = []
BChan: slot=2 chan=23
Product Unknown
3371mS CMExtnRx: v=971, p1=6
CMSetup
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
Product Unknown
3371mS CMExtnCopyProcessMsg: v=6
CMSetup
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
BChan: slot=2 chan=23
Product Unknown
3373mS CMTARGET: LOOKUP CALL ROUTE:2482 type=100 called_party= sub= calling=971 in=0 complete=0
3373mS CMTARGET: ADD TARGET:2482 number= type=100 depth=1 nobar=1 setorig=1
3374mS CMTARGET: LOOKUP CALL ROUTE:2482 returned 0
3374mS CD: CALL: 0.5377.0 BState=Idle Cut=0 Music=0.0 Aend="Tyler H(971)" (2.23) Bend="" [] (0.0) CalledNum= () CallingNum=971 () Internal=1 Time=2 AState=Dialling
3375mS CMExtnCopyProcessCallMsg: v=6
CMSetupAck
Line: type=NoLine 0
Call: lid=0 id=5377 in=0
BChan: slot=2 chan=23
Product Unknown
3375mS CMExtnTx: v=971, p1=6
CMInbandTone
Line: type=DigitalExtn 3
Call: lid=0 id=-1 in=0
Product Unknown
UUI type=User2User [TD1\r\n] [0x54 0x44 0x31 0x0d 0x0a ]
Timed: 01/09/10 10:26
3376mS CMExtnTxP: v=6
CMInbandTone
Line: type=DigitalExtn 3
Call: lid=0 id=5377 in=0
Product Unknown
UUI type=User2User [TD1\r\n] [0x54 0x44 0x31 0x0d 0x0a ]
Timed: 01/09/10 10:26
3376mS CMExtnTx: v=971, p1=6
CMSetupAck
Line: type=DigitalExtn 3
Call: lid=0 id=5377 in=0
BChan: slot=2 chan=23
Product Unknown
Timed: 01/09/10 10:26
3377mS CMExtnTxP: v=6
CMSetupAck
Line: type=DigitalExtn 3
Call: lid=0 id=5377 in=0
BChan: slot=2 chan=23
Product Unknown
Timed: 01/09/10 10:26
3378mS CD: CALL: 0.5377.0 BState=Idle Cut=0 Music=0.0 Aend="Tyler H(971)" (2.23) Bend="" [] (0.0) CalledNum= () CallingNum=971 () Internal=1 Time=6 AState=LocalDial
3378mS CMMap: a=2.23 b=0.0 D1
3415mS PRN: TFTPServer::RRQ(from 131.131.1.112) nasystem/call_info/0.5377.0
3575mS CMExtnCopyProcessMsg: v=6
CMShortCode
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
ShortCode GetCallInfo (108) = []
BChan: slot=2 chan=23
Product Unknown
3616mS CMExtnRx: v=971, p1=6
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[9] Type=Default (100)
Product Unknown
3616mS CMExtnCopyProcessMsg: v=6
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[9] Type=Default (100)
BChan: slot=2 chan=23
Product Unknown
3617mS CMExtnTx: v=971, p1=6
CMInbandTone
Line: type=DigitalExtn 3
Call: lid=0 id=-1 in=0
Product Unknown
UUI type=User2User [TD0\r\n] [0x54 0x44 0x30 0x0d 0x0a ]
Timed: 01/09/10 10:26
3617mS CMExtnTxP: v=6
CMInbandTone
Line: type=DigitalExtn 3
Call: lid=0 id=5377 in=0
Product Unknown
UUI type=User2User [TD0\r\n] [0x54 0x44 0x30 0x0d 0x0a ]
Timed: 01/09/10 10:26
3618mS CMMap: a=2.23 b=0.0 D0
3618mS CMTARGET: LOOKUP CALL ROUTE:2482 type=100 called_party=9 sub= calling=971 in=0 complete=0
3619mS CMTARGET: ADD TARGET:2482 number=9 type=100 depth=1 nobar=1 setorig=1
3620mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:2482 returned 0
3818mS CMExtnRx: v=971, p1=6
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[5] Type=Default (100)
Product Unknown
3818mS CMExtnCopyProcessMsg: v=6
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[5] Type=Default (100)
BChan: slot=2 chan=23
Product Unknown
3819mS CMTARGET: LOOKUP CALL ROUTE:2482 type=100 called_party=95 sub= calling=971 in=0 complete=0
3819mS CMTARGET: ADD TARGET:2482 number=95 type=100 depth=1 nobar=1 setorig=1
3821mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:2482 returned 0
3994mS CMExtnRx: v=971, p1=6
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[0] Type=Default (100)
Product Unknown
3994mS CMExtnCopyProcessMsg: v=6
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[0] Type=Default (100)
BChan: slot=2 chan=23
Product Unknown
3995mS CMTARGET: LOOKUP CALL ROUTE:2482 type=100 called_party=950 sub= calling=971 in=0 complete=0
3996mS CMTARGET: ADD TARGET:2482 number=950 type=100 depth=1 nobar=1 setorig=1
3996mS CMTARGET: SET USER:2482 Michelle S orig=1
3997mS CMTARGET: ADD USER:2482 Michelle S(950, state=Idle) (depth=2 B=0) cw=0
3997mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:2482 returned 1
3998mS CD: CALL: 0.5377.0 BState=Idle Cut=1 Music=0.0 Aend="Tyler H(971)" (2.23) Bend="Michelle S(950)" [Line 16] (0.0) CalledNum=950 () CallingNum=971 () Internal=0 Time=626 AState=Dialling
3999mS CMExtnCopyProcessCallMsg: v=6
CMSetupAck
Line: type=NoLine 0
Call: lid=0 id=5377 in=0
Called[950] Type=Default (100)
BChan: slot=2 chan=23
Product Unknown
Display [Michelle S]
3999mS CMExtnTx: v=971, p1=6
CMSetupAck
Line: type=DigitalExtn 3
Call: lid=0 id=5377 in=0
Called[950] Type=Default (100)
BChan: slot=2 chan=23
Product Unknown
Display [Michelle S]
Timed: 01/09/10 10:26
4000mS CMExtnTxP: v=6
CMSetupAck
Line: type=DigitalExtn 3
Call: lid=0 id=5377 in=0
Called[950] Type=Default (100)
BChan: slot=2 chan=23
Product Unknown
Display [Michelle S]
Timed: 01/09/10 10:26
4001mS CD: CALL: 0.5377.0 BState=Idle Cut=1 Music=0.0 Aend="Tyler H(971)" (2.23) Bend="Michelle S(950)" [Line 16] (0.0) CalledNum=950 () CallingNum=971 () Internal=0 Time=628 AState=Dialled
4004mS CMLineTx: v=16
CMSetup
Line: type=IPLine 16
Call: lid=0 id=5378 in=0
Called[950] Type=Default (100) Calling[971] Type=Internal (101)
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
BChan: slot=250 chan=9012
Product Unknown
IE CMIETxChannelAudio (1) comptype=Ulaw64K (5) pktsize=160 ipaddr=131.131.2.193 port=0
IE CMIERxChannelAudio (2) comptype=Ulaw64K (5) pktsize=160 ipaddr=131.131.1.193 port=49832
Display [Tyler H>Michelle S]
Cause=16, Normal call clearing
Locale: enu
4064mS PRN: TFTPServer::RRQ(from 131.131.1.112) nasystem/call_info/0.5377.0
4172mS CMLineRx: v=16
CMReleaseComp
Line: type=IPLine 16
Call: lid=0 id=5378 in=0
Product Unknown
Cause=17, User busy
4174mS CD: CALL: 0.5377.0 BState=ReDialling Cut=1 Music=0.0 Aend="Tyler H(971)" (2.23) Bend="Michelle S(950)" [] (0.0) CalledNum=950 () CallingNum=971 () Internal=1 Time=801 AState=Dialled
4174mS CMExtnTx: v=, p1=1037
CMReleaseComp
Line: type=RAS 1
Call: lid=0 id=1037 in=0
BChan: slot=3 chan=14
Product Unknown
4198mS CMExtnCopyProcessMsg: v=6
CMShortCode
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
ShortCode GetCallInfo (108) = []
BChan: slot=2 chan=23
Product Unknown
4426mS CMExtnRx: v=930, p1=2
CMSetup
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
Product Unknown
4427mS CMExtnCopyProcessMsg: v=2
CMSetup
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
BChan: slot=2 chan=7
Product Unknown
4428mS CMTARGET: LOOKUP CALL ROUTE:2483 type=100 called_party= sub= calling=930 in=0 complete=0
4428mS CMTARGET: ADD TARGET:2483 number= type=100 depth=1 nobar=1 setorig=1
4429mS CMTARGET: LOOKUP CALL ROUTE:2483 returned 0
4430mS CD: CALL: 0.5380.0 BState=Idle Cut=0 Music=0.0 Aend="Debbe C(930)" (2.7) Bend="" [] (0.0) CalledNum= () CallingNum=930 () Internal=1 Time=2 AState=Dialling
4430mS CMExtnCopyProcessCallMsg: v=2
CMSetupAck
Line: type=NoLine 0
Call: lid=0 id=5380 in=0
BChan: slot=2 chan=7
Product Unknown
4431mS CMExtnTx: v=930, p1=2
CMInbandTone
Line: type=DigitalExtn 3
Call: lid=0 id=-1 in=0
Product Unknown
UUI type=User2User [TD1\r\n] [0x54 0x44 0x31 0x0d 0x0a ]
Timed: 01/09/10 10:26
4431mS CMExtnTxP: v=2
CMInbandTone
Line: type=DigitalExtn 3
Call: lid=0 id=5380 in=0
Product Unknown
UUI type=User2User [TD1\r\n] [0x54 0x44 0x31 0x0d 0x0a ]
Timed: 01/09/10 10:26
4432mS CMExtnTx: v=930, p1=2
CMSetupAck
Line: type=DigitalExtn 3
Call: lid=0 id=5380 in=0
BChan: slot=2 chan=7
Product Unknown
Timed: 01/09/10 10:26
4432mS CMExtnTxP: v=2
CMSetupAck
Line: type=DigitalExtn 3
Call: lid=0 id=5380 in=0
BChan: slot=2 chan=7
Product Unknown
Timed: 01/09/10 10:26
4433mS CD: CALL: 0.5380.0 BState=Idle Cut=0 Music=0.0 Aend="Debbe C(930)" (2.7) Bend="" [] (0.0) CalledNum= () CallingNum=930 () Internal=1 Time=6 AState=LocalDial
4434mS CMMap: a=2.7 b=0.0 D1
4472mS PRN: TFTPServer::RRQ(from 131.131.1.54) nasystem/call_info/0.5380.0
4631mS CMExtnCopyProcessMsg: v=2
CMShortCode
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
ShortCode GetCallInfo (108) = []
BChan: slot=2 chan=7
Product Unknown
5162mS CMTARGET: SELECT:2482 0 0 TGHG=00000000 TGUSER=ffcf395c INCL=00000001 EXCL=00000001
5162mS CMTARGET: ADD USER:2482 Michelle S(950, state=Idle) (depth=1 B=13) cw=0
5163mS CMTARGET: SELECT:2482 NO TARGETS, TRY VOICEMAIL
5163mS CMTARGET: LCR NOT MATCHED:2482 (cpn=950)
5163mS CMTARGET: SELECT:2482 BUSY
5164mS PRN: CALL: 0.5377.0 Deleted leaving 5 CMCall objects
5165mS CALL:2010/09/0110:26,00:00:00,000,971,O,950,950,TylerH,,,1,,""n/a,0
5165mS CMExtnCopyCallLostMsg: v=6
CMReleaseComp
Line: type=NoLine 0
Call: lid=0 id=5377 in=0
Called[950] Type=Default (100)
Product Unknown
Display [950]
Cause=17, User busy
5166mS CD: CALL: 0.5377.0 BState=Idle Cut=0 Music=0.1 Aend="Tyler H(971)" (2.23) Bend="Michelle S(950)" [] (0.0) CalledNum=950 () CallingNum=971 () Internal=1 Time=1794 AState=Idle
5167mS CMExtnTx: v=971, p1=6
CMInbandTone
Line: type=DigitalExtn 3
Call: lid=0 id=5377 in=0
Product Unknown
UUI type=User2User [TB1\r\n] [0x54 0x42 0x31 0x0d 0x0a ]
Cause=17, User busy
Timed: 01/09/10 10:26
5168mS CMExtnTxP: v=6
CMInbandTone
Line: type=DigitalExtn 3
Call: lid=0 id=-1 in=0
Product Unknown
UUI type=User2User [TB1\r\n] [0x54 0x42 0x31 0x0d 0x0a ]
Cause=17, User busy
Timed: 01/09/10 10:26
5169mS CD: CALL: 0.5377.0 Deleted
5184mS RES: Wed 1/9/2010 10:26:53 FreeMem=3375772(14) CMMsg=6 (7) Buff=98 522 497 1390 3 Links=6156 Elements=166
5223mS PRN: TFTPServer::RRQ(from 131.131.1.112) nasystem/call_info/0.5377.0
5367mS CMExtnCopyProcessMsg: v=6
CMShortCode
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
ShortCode GetCallInfo (108) = []
BChan: slot=2 chan=23
Product Unknown
5559mS CMExtnRx: v=930, p1=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[5] Type=Default (100)
Product Unknown
5559mS CMExtnCopyProcessMsg: v=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[5] Type=Default (100)
BChan: slot=2 chan=7
Product Unknown
5560mS CMExtnTx: v=930, p1=2
CMInbandTone
Line: type=DigitalExtn 3
Call: lid=0 id=-1 in=0
Product Unknown
UUI type=User2User [TD0\r\n] [0x54 0x44 0x30 0x0d 0x0a ]
Timed: 01/09/10 10:26
5561mS CMExtnTxP: v=2
CMInbandTone
Line: type=DigitalExtn 3
Call: lid=0 id=5380 in=0
Product Unknown
UUI type=User2User [TD0\r\n] [0x54 0x44 0x30 0x0d 0x0a ]
Timed: 01/09/10 10:26
5561mS CMMap: a=2.7 b=0.0 D0
5562mS CMTARGET: LOOKUP CALL ROUTE:2483 type=100 called_party=5 sub= calling=930 in=0 complete=0
5562mS CMTARGET: ADD TARGET:2483 number=5 type=100 depth=1 nobar=1 setorig=1
5563mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:2483 returned 0
5769mS CMExtnRx: v=930, p1=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[4] Type=Default (100)
Product Unknown
5769mS CMExtnCopyProcessMsg: v=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[4] Type=Default (100)
BChan: slot=2 chan=7
Product Unknown
5770mS CMTARGET: LOOKUP CALL ROUTE:2483 type=100 called_party=54 sub= calling=930 in=0 complete=0
5770mS CMTARGET: ADD TARGET:2483 number=54 type=100 depth=1 nobar=1 setorig=1
5771mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:2483 returned 0
5944mS CMExtnRx: v=930, p1=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[1] Type=Default (100)
Product Unknown
5944mS CMExtnCopyProcessMsg: v=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[1] Type=Default (100)
BChan: slot=2 chan=7
Product Unknown
5945mS CMTARGET: LOOKUP CALL ROUTE:2483 type=100 called_party=541 sub= calling=930 in=0 complete=0
5946mS CMTARGET: ADD TARGET:2483 number=541 type=100 depth=1 nobar=1 setorig=1
5947mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:2483 returned 0
6033mS CMExtnRxP: v=8
CMShortCode
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
ShortCode GetSystemInfo (99) = []
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
Product Unknown
6034mS CMExtnTxP: v=8
CMShortCode
Line: type=DigitalExtn 5
Call: lid=0 id=-1 in=0
ShortCode GetSystemInfo (99) = [3.2 (53)] Calling[LinnCo_Leb] Type=Default (100)
Product Unknown
Display [IP 403]
Tag type=Text [1,1,2,1,0,0,0.] [0x31 0x2c 0x31 0x2c 0x32 0x2c 0x31 0x2c 0x30 0x2c 0x30 0x2c 0x30 0x00 ]
Timed: 01/09/10 10:26
6051mS CMExtnRxP: v=8
CMShortCode
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
ShortCode IVRMessage (70) = []
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
Product Unknown
Tag type=Text [VMM$SENDMSGD$902$%] [0x56 0x4d 0x4d 0x24 0x53 0x45 0x4e 0x44 0x4d 0x53 0x47 0x44 0x24 0x39 0x30 0x32 0x24 0x25 ]
6051mS PRN: VMAIL - Send IVR Message VMM$SENDMSGD$902$% vmail_server=ffe557ac
6072mS CMExtnTxP: v=8
CMVoiceMailStatus
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[902] Type=Default (100)
Product Unknown
Tag type=Binary [VMS$MBXSUCCESS$40422$%] [0x56 0x4d 0x53 0x24 0x4d 0x42 0x58 0x53 0x55 0x43 0x43 0x45 0x53 0x53 0x24 0x34 0x30 0x34 0x32 0x32 0x24 0x25 ]
6073mS CMExtnTxP: v=8
CMVoiceMailStatus
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[902] Type=Default (100)
Product Unknown
Tag type=Binary [VMM$MSG00462$O$2010/8/26 13:14$5419295061$21$0$0$%] [0x56 0x4d 0x4d 0x24 0x4d 0x53 0x47 0x30 0x30 0x34 0x36 0x32 0x24 0x4f 0x24 0x32 0x30 0x31 0x30 0x2f 0x38 0x2f 0x32 0x36 0x20 0x31 0x33 0x3a 0x31 0x34 ]
6075mS CMExtnTxP: v=8
CMVoiceMailStatus
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[902] Type=Default (100)
Product Unknown
Tag type=Binary [VMM$MSG00463$O$2010/8/26 15:21$5415705063$21$0$0$%] [0x56 0x4d 0x4d 0x24 0x4d 0x53 0x47 0x30 0x30 0x34 0x36 0x33 0x24 0x4f 0x24 0x32 0x30 0x31 0x30 0x2f 0x38 0x2f 0x32 0x36 0x20 0x31 0x35 0x3a 0x32 0x31 ]
6076mS CMExtnTxP: v=8
CMVoiceMailStatus
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[902] Type=Default (100)
Product Unknown
Tag type=Binary [VMM$MSG00465$O$2010/8/27 13:32$5414013585$9$0$0$%] [0x56 0x4d 0x4d 0x24 0x4d 0x53 0x47 0x30 0x30 0x34 0x36 0x35 0x24 0x4f 0x24 0x32 0x30 0x31 0x30 0x2f 0x38 0x2f 0x32 0x37 0x20 0x31 0x33 0x3a 0x33 0x32 0]
6078mS CMExtnTxP: v=8
CMVoiceMailStatus
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[902] Type=Default (100)
Product Unknown
Tag type=Binary [VMM$MSG00466$O$2010/8/30 10:04$5038052253$16$0$0$%] [0x56 0x4d 0x4d 0x24 0x4d 0x53 0x47 0x30 0x30 0x34 0x36 0x36 0x24 0x4f 0x24 0x32 0x30 0x31 0x30 0x2f 0x38 0x2f 0x33 0x30 0x20 0x31 0x30 0x3a 0x30 0x34 ]
6493mS CMExtnRx: v=930, p1=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[4] Type=Default (100)
Product Unknown
6493mS CMExtnCopyProcessMsg: v=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[4] Type=Default (100)
BChan: slot=2 chan=7
Product Unknown
6494mS CMTARGET: LOOKUP CALL ROUTE:2483 type=100 called_party=5414 sub= calling=930 in=0 complete=0
6494mS CMTARGET: ADD TARGET:2483 number=5414 type=100 depth=1 nobar=1 setorig=1
6495mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:2483 returned 0
6722mS CMExtnRx: v=930, p1=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[0] Type=Default (100)
Product Unknown
6722mS CMExtnCopyProcessMsg: v=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[0] Type=Default (100)
BChan: slot=2 chan=7
Product Unknown
6723mS CMTARGET: LOOKUP CALL ROUTE:2483 type=100 called_party=54140 sub= calling=930 in=0 complete=0
6723mS CMTARGET: ADD TARGET:2483 number=54140 type=100 depth=1 nobar=1 setorig=1
6725mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:2483 returned 0
6949mS CMExtnRx: v=930, p1=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[5] Type=Default (100)
Product Unknown
6949mS CMExtnCopyProcessMsg: v=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[5] Type=Default (100)
BChan: slot=2 chan=7
Product Unknown
6950mS CMTARGET: LOOKUP CALL ROUTE:2483 type=100 called_party=541405 sub= calling=930 in=0 complete=0
6950mS CMTARGET: ADD TARGET:2483 number=541405 type=100 depth=1 nobar=1 setorig=1
6951mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:2483 returned 0
7362mS CMExtnRx: v=930, p1=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[6] Type=Default (100)
Product Unknown
7362mS CMExtnCopyProcessMsg: v=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[6] Type=Default (100)
BChan: slot=2 chan=7
Product Unknown
7363mS CMTARGET: LOOKUP CALL ROUTE:2483 type=100 called_party=5414056 sub= calling=930 in=0 complete=0
7363mS CMTARGET: ADD TARGET:2483 number=5414056 type=100 depth=1 nobar=1 setorig=1
7364mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:2483 returned 0
7560mS CMExtnRx: v=930, p1=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[8] Type=Default (100)
Product Unknown
7560mS CMExtnCopyProcessMsg: v=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[8] Type=Default (100)
BChan: slot=2 chan=7
Product Unknown
7561mS CMTARGET: LOOKUP CALL ROUTE:2483 type=100 called_party=54140568 sub= calling=930 in=0 complete=0
7561mS CMTARGET: ADD TARGET:2483 number=54140568 type=100 depth=1 nobar=1 setorig=1
7562mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:2483 returned 0
7813mS CMExtnRxP: v=14
CMShortCode
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
ShortCode GetSystemInfo (99) = []
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
Product Unknown
7814mS CMExtnTxP: v=14
CMShortCode
Line: type=DigitalExtn 5
Call: lid=0 id=-1 in=0
ShortCode GetSystemInfo (99) = [3.2 (53)] Calling[LinnCo_Leb] Type=Default (100)
Product Unknown
Display [IP 403]
Tag type=Text [1,1,2,1,0,0,0.] [0x31 0x2c 0x31 0x2c 0x32 0x2c 0x31 0x2c 0x30 0x2c 0x30 0x2c 0x30 0x00 ]
Timed: 01/09/10 10:26
7831mS CMExtnRxP: v=14
CMShortCode
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
ShortCode IVRMessage (70) = []
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
Product Unknown
Tag type=Text [VMM$SENDMSGD$905$%] [0x56 0x4d 0x4d 0x24 0x53 0x45 0x4e 0x44 0x4d 0x53 0x47 0x44 0x24 0x39 0x30 0x35 0x24 0x25 ]
7832mS PRN: VMAIL - Send IVR Message VMM$SENDMSGD$905$% vmail_server=ffe557ac
7851mS CMExtnTxP: v=14
CMVoiceMailStatus
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[905] Type=Default (100)
Product Unknown
Tag type=Binary [VMS$MBXSUCCESS$40422$%] [0x56 0x4d 0x53 0x24 0x4d 0x42 0x58 0x53 0x55 0x43 0x43 0x45 0x53 0x53 0x24 0x34 0x30 0x34 0x32 0x32 0x24 0x25 ]
7857mS CMExtnRx: v=930, p1=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[1] Type=Default (100)
Product Unknown
7857mS CMExtnCopyProcessMsg: v=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[1] Type=Default (100)
BChan: slot=2 chan=7
Product Unknown
7858mS CMTARGET: LOOKUP CALL ROUTE:2483 type=100 called_party=541405681 sub= calling=930 in=0 complete=0
7858mS CMTARGET: ADD TARGET:2483 number=541405681 type=100 depth=1 nobar=1 setorig=1
7859mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:2483 returned 0
8086mS CMExtnRx: v=930, p1=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[7] Type=Default (100)
Product Unknown
8086mS CMExtnCopyProcessMsg: v=2
CMInformation
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Called[7] Type=Default (100)
BChan: slot=2 chan=7
Product Unknown
8087mS CMTARGET: LOOKUP CALL ROUTE:2483 type=100 called_party=5414056817 sub= calling=930 in=0 complete=0
8087mS CMTARGET: ADD TARGET:2483 number=5414056817 type=100 depth=1 nobar=1 setorig=1
8089mS CMTARGET: SYS SC:2483 5414056817 10 4056817 sc=type=Dial code=541xxxxxxx, num=541N
8089mS CMTARGET: LCR NOT MATCHED:2483 (cpn=5414056817)
8090mS CMTARGET: DIAL LINE:2483 GROUP=15 SUCCESS=1
8090mS CMTARGET: OVERLAP LOOKUP CALL ROUTE:2483 returned 1
8090mS CD: CALL: 0.5380.0 BState=Idle Cut=1 Music=0.0 Aend="Debbe C(930)" (2.7) Bend="Line 15" [Line 15] (0.0) CalledNum=5414056817 () CallingNum=930 () Internal=0 Time=3663 AState=Dialling
8091mS CMExtnCopyProcessCallMsg: v=2
CMSetupAck
Line: type=NoLine 0
Call: lid=0 id=5380 in=0
Called[5414056817] Type=Default (100)
BChan: slot=2 chan=7
Product Unknown
Display [5414056817]
8092mS CMExtnTx: v=930, p1=2
CMSetupAck
Line: type=DigitalExtn 3
Call: lid=0 id=5380 in=0
Called[5414056817] Type=Default (100)
BChan: slot=2 chan=7
Product Unknown
Display [5414056817]
Timed: 01/09/10 10:26
8093mS CMExtnTxP: v=2
CMSetupAck
Line: type=DigitalExtn 3
Call: lid=0 id=5380 in=0
Called[5414056817] Type=Default (100)
BChan: slot=2 chan=7
Product Unknown
Display [5414056817]
Timed: 01/09/10 10:26
8094mS CD: CALL: 0.5380.0 BState=Idle Cut=1 Music=0.0 Aend="Debbe C(930)" (2.7) Bend="Line 15" [Line 15] (0.0) CalledNum=5414056817 () CallingNum=930 () Internal=0 Time=3666 AState=Dialled
8096mS CMLineTx: v=15
CMSetup
Line: type=IPLine 15
Call: lid=0 id=5381 in=0
Called[5414056817] Type=Default (100) Calling[930] Type=Internal (101)
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
BChan: slot=250 chan=9013
Product Unknown
IE CMIETxChannelAudio (1) comptype=G729A8K (6) pktsize=20 ipaddr=131.131.3.193 port=0
IE CMIERxChannelAudio (2) comptype=G729A8K (6) pktsize=20 ipaddr=131.131.1.193 port=49834
Display [Debbe Cross]
Cause=16, Normal call clearing
Locale: enu
8156mS PRN: TFTPServer::RRQ(from 131.131.1.54) nasystem/call_info/0.5380.0
8241mS CMLineRx: v=15
CMFacility
Line: type=IPLine 15
Call: lid=0 id=5381 in=0
Product Unknown
UUI type=User2User [turn h323setuptimer off] [0x74 0x75 0x72 0x6e 0x20 0x68 0x33 0x32 0x33 0x73 0x65 0x74 0x75 0x70 0x74 0x69 0x6d 0x65 0x72 0x20 0x6f 0x66 0x66 ]
8291mS CMExtnCopyProcessMsg: v=2
CMShortCode
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
ShortCode GetCallInfo (108) = []
BChan: slot=2 chan=7
Product Unknown
8310mS CMLineRx: v=15
CMFacility
Line: type=IPLine 15
Call: lid=0 id=5381 in=0
Product Unknown
UUI type=User2User [SC=VPN_CAN_TERMINATE_FALSE...] [0x53 0x43 0x3d 0x56 0x50 0x4e 0x5f 0x43 0x41 0x4e 0x5f 0x54 0x45 0x52 0x4d 0x49 0x4e 0x41 0x54 0x45 0x5f 0x46 0x41 0x4c 0x53 0x45 0x00 0x00 0x00 ]
8334mS CMLineRx: v=15
CMProceeding
Line: type=IPLine 15
Call: lid=0 id=5381 in=0
BChan: slot=250 chan=9013
Product Standard
IE CMIETxChannelAudio (1) comptype=G729A8K (6) pktsize=20 ipaddr=131.131.3.193 port=49640
IE CMIERxChannelAudio (2) comptype=G729A8K (6) pktsize=20 ipaddr=131.131.1.193 port=49834
8335mS CMMap: a=2.7 b=250.9013 M1
8335mS PRN: Converted to:
8336mS CMMap: a=2.7 b=3.14 M1
8336mS CD: CALL: 0.5380.0 BState=Idle Cut=3 Music=0.0 Aend="Debbe C(930)" (2.7) Bend="Line 15" [Line 15] (250.9013) CalledNum=5414056817 () CallingNum=930 () Internal=0 Time=3909 AState=Dialled
8337mS CD: CALL: 0.5380.0 BState=Dialled Cut=3 Music=0.0 Aend="Debbe C(930)" (2.7) Bend="Line 15" [Line 15] (250.9013) CalledNum=5414056817 () CallingNum=930 () Internal=0 Time=3910 AState=Dialled
8337mS CMExtnCopyProcessCallMsg: v=2
CMProceeding
Line: type=IPLine 15
Call: lid=0 id=5380 in=0
Called[5414056817] Type=Default (100)
BChan: slot=2 chan=7
Product Standard
IE CMIETxChannelAudio (1) comptype=G729A8K (6) pktsize=20 ipaddr=131.131.3.193 port=49640
IE CMIERxChannelAudio (2) comptype=G729A8K (6) pktsize=20 ipaddr=131.131.1.193 port=49834
Display [5414056817]
8338mS CMExtnTx: v=930, p1=2
CMProceeding
Line: type=DigitalExtn 3
Call: lid=0 id=5380 in=0
Called[5414056817] Type=Default (100)
BChan: slot=2 chan=7
Product Standard
IE CMIETxChannelAudio (1) comptype=G729A8K (6) pktsize=20 ipaddr=131.131.3.193 port=49640
IE CMIERxChannelAudio (2) comptype=G729A8K (6) pktsize=20 ipaddr=131.131.1.193 port=49834
Display [5414056817]
Timed: 01/09/10 10:26
8339mS CMExtnTxP: v=2
CMProceeding
Line: type=DigitalExtn 3
Call: lid=0 id=5380 in=0
Called[5414056817] Type=Default (100)
BChan: slot=2 chan=7
Product Standard
IE CMIETxChannelAudio (1) comptype=G729A8K (6) pktsize=20 ipaddr=131.131.3.193 port=49640
IE CMIERxChannelAudio (2) comptype=G729A8K (6) pktsize=20 ipaddr=131.131.1.193 port=49834
Display [5414056817]
Timed: 01/09/10 10:26
8345mS PRN: TFTPServer::RRQ(from 131.131.1.54) nasystem/call_info/0.5380.0
8537mS CMExtnCopyProcessMsg: v=2
CMShortCode
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
ShortCode GetCallInfo (108) = []
BChan: slot=2 chan=7
Product Unknown
10207mS RES: Wed 1/9/2010 10:26:58 FreeMem=3363040(11) CMMsg=5 (7) Buff=98 523 498 1388 3 Links=6147 Elements=166
10212mS CMLineRx: v=15
CMAlerting
Line: type=IPLine 15
Call: lid=0 id=5381 in=0
Product Standard
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLPublicNetRemoteUser (4), pd=CMPDInbandPattern (8)
10212mS CD: CALL: 0.5380.0 BState=Ringing Cut=3 Music=0.0 Aend="Debbe C(930)" (2.7) Bend="Line 15" [Line 15] (250.9013) CalledNum=5414056817 () CallingNum=930 () Internal=0 Time=5785 AState=Dialled
10213mS CD: CALL: 0.5380.0 BState=Ringing Cut=3 Music=0.0 Aend="Debbe C(930)" (2.7) Bend="Line 15" [Line 15] (250.9013) CalledNum=5414056817 () CallingNum=930 () Internal=0 Time=5786 AState=Ringing
10214mS CMExtnCopyProcessCallMsg: v=2
CMAlerting
Line: type=IPLine 15
Call: lid=0 id=5380 in=0
Called[5414056817] Type=Default (100)
BChan: slot=2 chan=7
Product Standard
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLPublicNetRemoteUser (4), pd=CMPDInbandPattern (8)
Display [5414056817]
10214mS CMExtnTx: v=930, p1=2
CMAlerting
Line: type=DigitalExtn 3
Call: lid=0 id=5380 in=0
Called[5414056817] Type=Default (100)
BChan: slot=2 chan=7
Product Standard
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLPublicNetRemoteUser (4), pd=CMPDInbandPattern (8)
Display [5414056817]
Timed: 01/09/10 10:26
10216mS CMExtnTxP: v=2
CMAlerting
Line: type=DigitalExtn 3
Call: lid=0 id=5380 in=0
Called[5414056817] Type=Default (100)
BChan: slot=2 chan=7
Product Standard
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLPublicNetRemoteUser (4), pd=CMPDInbandPattern (8)
Display [5414056817]
Timed: 01/09/10 10:26
10243mS PRN: TFTPServer::RRQ(from 131.131.1.54) nasystem/call_info/0.5380.0
10414mS CMExtnCopyProcessMsg: v=2
CMShortCode
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
ShortCode GetCallInfo (108) = []
BChan: slot=2 chan=7
Product Unknown
17011mS CMExtnRx: v=850, p1=5
CMReleaseComp
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
Product Unknown
17011mS CMExtnTx: v=850, p1=5
CMReleaseComp
Line: type=AnalogueExtn 6
Call: lid=0 id=5355 in=0
BChan: slot=6 chan=7
Product Unknown
UUI type=Local [......2Pd] [0x01 0x03 0x00 0x00 0x01 0x02 0x32 0x50 0x64 ]
Timed: 01/09/10 10:27
17253mS RES: Wed 1/9/2010 10:27:06 FreeMem=3363060(13) CMMsg=6 (7) Buff=98 525 498 1388 3 Links=6147 Elements=166
********** Warning: Logging to Screen Stopped **********
Log from the other end unit where extension 950 is:
Log from the other end unit where extension 950 is:
Log from the other end unit where extension 950 is:
********** SysMonitor v5.2 (69) **********
********** contact made with 131.131.2.193 at 10:26:21 1/9/2010 **********
********** System (131.131.2.193) has been up and running for 1day, 12hrs, 25mins and 47secs(131147880mS) **********
********** Warning: TEXT File Logging selected **********
********** Warning: TEXT Logging to File STOPPED on 1/9/2010 10:26:21 **********
0mS PRN: Monitor Started IP=131.131.1.112 IP 403 3.2(53) LinnCo_SHome
1mS PRN: LAW=U PRI=0, BRI=0, ALOG=4, ADSL=0 VCOMP=5, MDM=0, WAN=0, MODU=0 LANM=0 CkSRC=0 VMAIL=1(VER=2 TYP=2) CALLS=2(TOT=334)
3395mS CMLineRx: v=21
CMSetup
Line: type=IPLine 21
Call: lid=21 id=3 in=2
Called[950] Type=Unknown (0) Calling[971] Type=Unknown (0)
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
BChan: slot=250 chan=20003
Product Standard
IE CMIETxChannelAudio (1) comptype=Ulaw64K (5) pktsize=160 ipaddr=131.131.1.193 port=49826
IE CMIESupplementaryService (5)
Network Facility Extension
sourceEntity: 0
destinationEntity: 0
Interpretation APDU
rejectAnyUnrecognisedInvokePdu
CallingName.Invoke
invokeId 18893
Display [Tyler H>Michelle S]
3396mS CD: CALL: 21.3.2 BState=Idle Cut=1 Music=0.0 Aend="Line 21" (250.20003) Bend="" [] (0.0) CalledNum=950 () CallingNum=971 () Internal=0 Time=1 AState=Idle
3397mS CMTARGET: LOOKUP CALL ROUTE:335 type=0 called_party=950 sub= calling=971 in=2 complete=0
3398mS CMTARGET: ADD TARGET:335 number=950 type=0 depth=1 nobar=1 setorig=1
3398mS CMTARGET: SET USER:335 Michelle S orig=1
3399mS CMTARGET: ADD USER:335 Michelle S(950, state=Idle) (depth=2 B=0) cw=0
3399mS PRN: Not enough (2) vocoders for the call: Line (21) -> Extn (950)
3400mS CMTARGET: LOOKUP CALL ROUTE:335 returned 1
3400mS CMTARGET: SELECT:335 1 0 TGHG=00000000 TGUSER=ffe2a278 INCL=00000000 EXCL=00000000
3401mS CMTARGET: ADD USER:335 Michelle S(950, state=Idle) (depth=1 B=0) cw=0
3401mS PRN: Not enough (2) vocoders for the call: Line (21) -> Extn (950)
3402mS CMTARGET: SELECT:335 NO TARGETS, TRY VOICEMAIL
3403mS PRN: Not enough (2) vocoders for the call: Line (21) -> Line (21)
3405mS CMLineTx: v=21
CMOpenLogicalChan
Line: type=IPLine 21
Call: lid=0 id=3 in=2
Called[950] Type=Default (100)
BChan: slot=250 chan=3
Product Unknown
IE CMIETxChannelAudio (1) comptype=Ulaw64K (5) pktsize=160 ipaddr=131.131.1.193 port=49826
IE CMIERxChannelAudio (2) comptype=Ulaw64K (5) pktsize=160 ipaddr=131.131.2.193 port=50276
Display [Michelle S]
3407mS PRN: CALL: 21.3.2 Deleted leaving 2 CMCall objects
3407mS CALL:2010/09/0110:26,00:00:00,000,971,I,950,950,To_LEB,,,0,,""n/a,0
3408mS CMLineTx: v=21
CMReleaseComp
Line: type=IPLine 21
Call: lid=0 id=3 in=2
Product Unknown
Cause=17, User busy
3409mS CMExtnTx: v=, p1=1033
CMReleaseComp
Line: type=RAS 1
Call: lid=0 id=1033 in=0
BChan: slot=3 chan=1
Product Unknown
3410mS CD: CALL: 21.3.2 Deleted
3538mS RES: Wed 1/9/2010 10:26:26 FreeMem=3555760(18) CMMsg=7 (8) Buff=100 630 498 1436 3 Links=6975 Elements=372
8538mS RES: Wed 1/9/2010 10:26:31 FreeMem=3557464(18) CMMsg=7 (8) Buff=100 630 498 1436 3 Links=6976 Elements=372
10654mS PRN: Loading holdmusic.wav from ipad=255.255.255.255
12920mS CMExtnRxP: v=3
CMShortCode
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
ShortCode GetSystemInfo (99) = []
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
Product Unknown
12921mS CMExtnTxP: v=3
CMShortCode
Line: type=IPLine 250
Call: lid=0 id=-1 in=0
ShortCode GetSystemInfo (99) = [3.2 (53)] Calling[LinnCo_SHome] Type=Default (100)
Product Unknown
Display [IP 403]
Tag type=Text [1,1,2,1,0,1,0.] [0x31 0x2c 0x31 0x2c 0x32 0x2c 0x31 0x2c 0x30 0x2c 0x31 0x2c 0x30 0x00 ]
Timed: 01/09/10 10:26
14390mS CMExtnRxP: v=5
CMShortCode
Line: type=NoLine 0
Call: lid=0 id=-1 in=0
ShortCode GetSystemInfo (99) = []
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
Product Unknown
14391mS CMExtnTxP: v=5
CMShortCode
Line: type=IPLine 250
Call: lid=0 id=1558 in=0
ShortCode GetSystemInfo (99) = [3.2 (53)] Calling[LinnCo_SHome] Type=Default (100)
Product Unknown
Display [IP 403]
Tag type=Text [1,1,2,1,0,1,0.] [0x31 0x2c 0x31 0x2c 0x32 0x2c 0x31 0x2c 0x30 0x2c 0x31 0x2c 0x30 0x00 ]
Timed: 01/09/10 10:26
19537mS RES: Wed 1/9/2010 10:26:42 FreeMem=3544884(17) CMMsg=7 (8) Buff=100 630 498 1436 3 Links=6972 Elements=372
25539mS RES: Wed 1/9/2010 10:26:48 FreeMem=3557004(18) CMMsg=7 (8) Buff=100 630 498 1436 3 Links=6974 Elements=372
30365mS CMLineRx: v=21
CMSetup
Line: type=IPLine 21
Call: lid=21 id=3 in=2
Called[950] Type=Unknown (0) Calling[971] Type=Unknown (0)
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
BChan: slot=250 chan=20003
Product Standard
IE CMIETxChannelAudio (1) comptype=Ulaw64K (5) pktsize=160 ipaddr=131.131.1.193 port=49832
IE CMIESupplementaryService (5)
Network Facility Extension
sourceEntity: 0
destinationEntity: 0
Interpretation APDU
rejectAnyUnrecognisedInvokePdu
CallingName.Invoke
invokeId 18899
Display [Tyler H>Michelle S]
30366mS CD: CALL: 21.3.2 BState=Idle Cut=1 Music=0.0 Aend="Line 21" (250.20003) Bend="" [] (0.0) CalledNum=950 () CallingNum=971 () Internal=0 Time=1 AState=Idle
30367mS CMTARGET: LOOKUP CALL ROUTE:336 type=0 called_party=950 sub= calling=971 in=2 complete=0
30368mS CMTARGET: ADD TARGET:336 number=950 type=0 depth=1 nobar=1 setorig=1
30368mS CMTARGET: SET USER:336 Michelle S orig=1
30368mS CMTARGET: ADD USER:336 Michelle S(950, state=Idle) (depth=2 B=0) cw=0
30369mS PRN: Not enough (2) vocoders for the call: Line (21) -> Extn (950)
30370mS CMTARGET: LOOKUP CALL ROUTE:336 returned 1
30370mS CMTARGET: SELECT:336 1 0 TGHG=00000000 TGUSER=ffe2a278 INCL=00000000 EXCL=00000000
30370mS CMTARGET: ADD USER:336 Michelle S(950, state=Idle) (depth=1 B=0) cw=0
30371mS PRN: Not enough (2) vocoders for the call: Line (21) -> Extn (950)
30372mS CMTARGET: SELECT:336 NO TARGETS, TRY VOICEMAIL
30372mS PRN: Not enough (2) vocoders for the call: Line (21) -> Line (21)
30375mS CMLineTx: v=21
CMOpenLogicalChan
Line: type=IPLine 21
Call: lid=0 id=3 in=2
Called[950] Type=Default (100)
BChan: slot=250 chan=3
Product Unknown
IE CMIETxChannelAudio (1) comptype=Ulaw64K (5) pktsize=160 ipaddr=131.131.1.193 port=49832
IE CMIERxChannelAudio (2) comptype=Ulaw64K (5) pktsize=160 ipaddr=131.131.2.193 port=50278
Display [Michelle S]
30377mS PRN: CALL: 21.3.2 Deleted leaving 2 CMCall objects
30377mS CALL:2010/09/0110:26,00:00:00,000,971,I,950,950,To_LEB,,,0,,""n/a,0
30378mS CMLineTx: v=21
CMReleaseComp
Line: type=IPLine 21
Call: lid=0 id=3 in=2
Product Unknown
Cause=17, User busy
30379mS CMExtnTx: v=, p1=1033
CMReleaseComp
Line: type=RAS 1
Call: lid=0 id=1033 in=0
BChan: slot=3 chan=1
Product Unknown
30380mS CD: CALL: 21.3.2 Deleted
35538mS RES: Wed 1/9/2010 10:26:58 FreeMem=3557004(18) CMMsg=7 (8) Buff=100 630 498 1437 3 Links=6974 Elements=372
44037mS RES: Wed 1/9/2010 10:27:07 FreeMem=3556836(16) CMMsg=7 (8) Buff=100 630 498 1437 3 Links=6974 Elements=372
********** Warning: Logging to Screen Stopped **********
