Hi Guys,
I have a problem with an IP 500 4.1.15. The reception 201 has a BLF expansion module with user buttons. When i use the button to transfer a call to a user it doens't work. The button on the 4621 itself als doesn't work. When I use one of the buttons to call a user, it works!
Below a trace. You can actually see that I press the button but nothing happens, you just stay in the call you want to transfer. When I just use the transfer button the call is transfered.
1386922mS CMExtnRx: v=201, p1=0
CMSetup
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[201] Type=Internal Plan=Default
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ALaw
IE CMIECallingPartyName (110) Receptie
IE CMIEFastStartInfoData (6)
1386923mS CMTARGET: 251.1093.0 22 Receptie.0: LOOKUP CALL ROUTE: type=100 called_party= sub= calling=201 dir=out complete=0 ses=0
1386923mS CMTARGET: 251.1093.0 22 Receptie.0: ADD TARGET (N): number= type=100 depth=1 nobar=1 setorig=1 ses=0
1386926mS CMExtnTx: v=201, p1=0
CMFacility
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
IE CMIEFastStartInfoData (6)
Timed: 21/11/08 17:20
1386926mS CMExtnTx: v=201, p1=8000
CMFacility
Line: type=IPLine 250 Call: lid=251 id=2 in=1
IE CMIEFastStartInfoData (6)
1386927mS CMExtnTx: v=201, p1=0
CMSetupAck
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
Timed: 21/11/08 17:20
1386927mS CD: CALL: 251.1093.0 BState=Idle Cut=1 Music=3.0 Aend="Receptie(201)" (0.0) Bend="" [] (0.0) CalledNum= () CallingNum=201 (Receptie) Internal=1 Time=8 AState=DialInitiated
1386930mS CMMap: PCG::AddToneGenerator g D1[1] append pcp[149]b0r1 (total 1)
1386930mS CMMap: a=0.0 b=0.0 pcp[148]b0r1 RTPD1
1387274mS RES: Fri 21/11/2008 17:20:37 FreeMem=79348560(19) CMMsg=6 (6) Buff=200 954 1000 7149 4 Links=20429
1387756mS PRN: 201: Digit Pressed 0
1387757mS CMExtnRx: v=201, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
Called[0] Type=Default (100) Reason=CMDRdirect Keypad[0]
1387758mS CMMap: a=0.0 b=0.0 pcp[148]b0r1 RTPD0
1387995mS PRN: 201: Digit Pressed 6
1387996mS CMExtnRx: v=201, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
Called[6] Type=Default (100) Reason=CMDRdirect Keypad[6]
1388196mS PRN: 201: Digit Pressed 3
1388196mS CMExtnRx: v=201, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
Called[3] Type=Default (100) Reason=CMDRdirect Keypad[3]
1388456mS PRN: 201: Digit Pressed 0
1388456mS CMExtnRx: v=201, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
Called[0] Type=Default (100) Reason=CMDRdirect Keypad[0]
1388457mS CMTARGET: 251.1093.0 22 Receptie.0: CancelTimer CMTCDelayedProcessing
1388457mS CMTARGET: 251.1093.0 22 Receptie.0: LOOKUP CALL ROUTE: type=100 called_party=0630 sub= calling=201 dir=out complete=0 ses=0
1388457mS CMTARGET: 251.1093.0 22 Receptie.0: ADD TARGET (N): number=0630 type=100 depth=1 nobar=1 setorig=1 ses=0
1388598mS PRN: 201: Digit Pressed 0
1388598mS CMExtnRx: v=201, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
Called[0] Type=Default (100) Reason=CMDRdirect Keypad[0]
1388599mS CMTARGET: 251.1093.0 22 Receptie.0: LOOKUP CALL ROUTE: type=100 called_party=06300 sub= calling=201 dir=out complete=0 ses=0
1388599mS CMTARGET: 251.1093.0 22 Receptie.0: ADD TARGET (N): number=06300 type=100 depth=1 nobar=1 setorig=1 ses=0
1388826mS PRN: 201: Digit Pressed 5
1388827mS CMExtnRx: v=201, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
Called[5] Type=Default (100) Reason=CMDRdirect Keypad[5]
1388827mS CMTARGET: 251.1093.0 22 Receptie.0: LOOKUP CALL ROUTE: type=100 called_party=063005 sub= calling=201 dir=out complete=0 ses=0
1388827mS CMTARGET: 251.1093.0 22 Receptie.0: ADD TARGET (N): number=063005 type=100 depth=1 nobar=1 setorig=1 ses=0
1389056mS PRN: 201: Digit Pressed 0
1389056mS CMExtnRx: v=201, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
Called[0] Type=Default (100) Reason=CMDRdirect Keypad[0]
1389057mS CMTARGET: 251.1093.0 22 Receptie.0: LOOKUP CALL ROUTE: type=100 called_party=0630050 sub= calling=201 dir=out complete=0 ses=0
1389057mS CMTARGET: 251.1093.0 22 Receptie.0: ADD TARGET (N): number=0630050 type=100 depth=1 nobar=1 setorig=1 ses=0
1389198mS PRN: 201: Digit Pressed 0
1389198mS CMExtnRx: v=201, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
Called[0] Type=Default (100) Reason=CMDRdirect Keypad[0]
1389199mS CMTARGET: 251.1093.0 22 Receptie.0: LOOKUP CALL ROUTE: type=100 called_party=06300500 sub= calling=201 dir=out complete=0 ses=0
1389199mS CMTARGET: 251.1093.0 22 Receptie.0: ADD TARGET (N): number=06300500 type=100 depth=1 nobar=1 setorig=1 ses=0
1389416mS PRN: 201: Digit Pressed 3
1389416mS CMExtnRx: v=201, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
Called[3] Type=Default (100) Reason=CMDRdirect Keypad[3]
1389417mS CMTARGET: 251.1093.0 22 Receptie.0: LOOKUP CALL ROUTE: type=100 called_party=063005003 sub= calling=201 dir=out complete=0 ses=0
1389417mS CMTARGET: 251.1093.0 22 Receptie.0: ADD TARGET (N): number=063005003 type=100 depth=1 nobar=1 setorig=1 ses=0
1389656mS PRN: 201: Digit Pressed 0
1389656mS CMExtnRx: v=201, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
Called[0] Type=Default (100) Reason=CMDRdirect Keypad[0]
1389657mS CMTARGET: 251.1093.0 22 Receptie.0: LOOKUP CALL ROUTE: type=100 called_party=0630050030 sub= calling=201 dir=out complete=0 ses=0
1389657mS CMTARGET: 251.1093.0 22 Receptie.0: ADD TARGET (N): number=0630050030 type=100 depth=1 nobar=1 setorig=1 ses=0
1389657mS CMTARGET: 251.1093.0 22 Receptie.0: SYS SC: 0630050030 10 30050030 sc=type=Dial code=06XXXXXXXX, num=. callinfop->sending_complete=0 secondary_dialtone=
1389658mS CMARS: CMARSHandler::FindActiveARSByGroupID GroupID=51
1389658mS CMARS: CMARSHandler::MakeCallTarget - Called Number: 0630050030
1389658mS CMTARGET: 251.1093.0 22 Receptie.0: CancelTimer CMTCDialToneTimeout
1389658mS CMTARGET: 251.1093.0 22 Receptie.0: INITIAL TARGETING SUCCEEDED
1389659mS CMTARGET: 251.1093.0 22 Receptie.0: GetNoAnswerTimer:15
1389660mS CMTARGET: 251.1093.0 22 Receptie.0: CancelTimer CMTCNoAnswerTimeout
1389660mS CMARS: FORM: GSM - Received Number: 0630050030
1389660mS CMARS: FOUND A SHORT CODE - short_code: ? - Tel: , - Called_Party: 0630050030 - Line Group Id: 10
1389660mS CMARS: CMARSHandler::FindActiveARSByGroupID GroupID=10
1389661mS CMTARGET: Group Id: 10 has NOT been found in Line: 2
1389661mS CMTARGET: Group Id: 10 has NOT been found in Line: 3
1389661mS CMTARGET: Group Id: 10 has NOT been found in Line: 4
1389661mS CMTARGET: Group Id: 10 has NOT been found in Line: 5
1389661mS CMTARGET: Group Id: 10 has NOT been found in Line: 6
1389661mS CMMap: a=0.1 b=0.0 Mapper::AllocateCodec allocated CMRTVocoder resource busy 1, total 12
1389662mS CMARS: FOUND LINE - Line Id: 7 - using line group id: 10 - Called Number: 0630050030 - Calling Number: 201
1389662mS CMARS: SEND Setup TO LINE
1389663mS CMLineTx: v=7
CMSetup
Line: type=Q931Line 7 Call: lid=0 id=1096 in=0
Called[0630050030] Type=Unknown (0) Reason=CMDRdirect Calling[] Type=Unknown Plan=Default
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ALaw
Locale: nld
1389663mS CD: CALL: 251.1093.0 BState=Idle Cut=2 Music=0.0 Aend="Receptie(201)" (0.0) Bend="" [Line 7] (0.0) CalledNum=0630050030 () CallingNum=201 (Receptie) Internal=1 Time=2744 AState=Dialling
1389922mS CMLineRx: v=7
CMProceeding
Line: type=Q931Line 7 Call: lid=0 id=1096 in=0
BChan: slot=0 chan=1
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLNetBeyondIWPoint (10), pd=CMPDInbandPattern (8)
1389922mS CMARS: LINE ep Received: CMProceeding - child->state = CMCSOffering - ARS Call State = CMCSOverlapRecv
1389922mS CMARS: LINE IS NOW THE B END OF THE CALL - CMARSEndpoint::RequestEnd()
1389923mS CMARS: CMARSEndpoint::CallLost(cause=124) - Address: 0.1095.0 22 ARS for GSM - Call State: CMCSOverlapRecv
1389924mS CMExtnTx: v=201, p1=0
CMProceeding
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLNetBeyondIWPoint (10), pd=CMPDInbandPattern (8)
IE CMIEDeviceDetail (231) LOCALE=nld HW=8 VER=4 class=CMDeviceISDNTrunk type=0 number=7 channel=1 rx_gain=32 tx_gain=32
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=0630050030
Timed: 21/11/08 17:20
1389926mS CD: CALL: 251.1093.0 BState=Ringing Cut=3 Music=0.0 Aend="Receptie(201)" (0.0) Bend="Line 7" [Line 7] (3.9) CalledNum=0630050030 () CallingNum=201 (Receptie) Internal=0 Time=3006 AState=Dialled
1389927mS CMMap: PCG::MapBChan pcp[148]b0r1 cp_b 0 other_cp_b 0 type CGTypeSimple
1389927mS CMMap: PCGS CPReserveCodec for the other end (pcp[148]b0r1) true
1389927mS CMMap: PCG::MapBChan pcp[101]b1r0 cp_b f5a8b6f4 other_cp_b f5add89c type CGTypeSimple
1389927mS CMMap: a=0.1 b=3.9 M1
1390420mS H323Evt: RTP(50r): 192.168.20.10/49152 192.168.20.100/51258 CODEC 6 PKTSZ=20 RFC2833=off AGE=3490 SENT 58 (avg size=20) RECV 50 (avg size=20)
1396710mS CMLineRx: v=7
CMAlerting
Line: type=Q931Line 7 Call: lid=0 id=1096 in=0
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLNetBeyondIWPoint (10), pd=CMPDInbandPattern (8)
1396712mS CMExtnTx: v=201, p1=0
CMAlerting
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLNetBeyondIWPoint (10), pd=CMPDInbandPattern (8)
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=0630050030
IE CMIEDeviceDetail (231) LOCALE=nld HW=8 VER=4 class=CMDeviceISDNTrunk type=0 number=7 channel=1 rx_gain=32 tx_gain=32
Timed: 21/11/08 17:20
1396712mS CD: CALL: 251.1093.0 BState=Ringing Cut=3 Music=0.0 Aend="Receptie(201)" (0.0) Bend="Line 7" [Line 7] (3.9) CalledNum=0630050030 () CallingNum=201 (Receptie) Internal=0 Time=9793 AState=Ringing
1401259mS CMLineRx: v=7
CMConnect
Line: type=Q931Line 7 Call: lid=0 id=1096 in=0
BChan: slot=0 chan=1
1401259mS CMExtnTx: v=201, p1=0
CMConnect
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=0630050030
IE CMIEDeviceDetail (231) LOCALE=nld HW=8 VER=4 class=CMDeviceISDNTrunk type=0 number=7 channel=1 rx_gain=32 tx_gain=32
Timed: 21/11/08 17:20
1401260mS CMExtnRx: v=201, p1=0
CMConnectAck
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
1401260mS CMTARGET: 251.1093.0 22 Receptie.0: ~CMTargetHandler
1401262mS CMLineTx: v=7
CMConnectAck
Line: type=Q931Line 7 Call: lid=0 id=1096 in=0
BChan: slot=0 chan=1
1401262mS CD: CALL: 251.1093.0 BState=Connected Cut=3 Music=0.0 Aend="Receptie(201)" (0.0) Bend="Line 7" [Line 7] (3.9) CalledNum=0630050030 () CallingNum=201 (Receptie) Internal=0 Time=14343 AState=Connected
1401274mS RES: Fri 21/11/2008 17:20:51 FreeMem=79348232(19) CMMsg=6 (6) Buff=200 956 999 7149 4 Links=20420
1402565mS PRN: Receptie: DSS Emulation 45 Key Pressed 8
1402865mS PRN: Receptie: DSS Emulation 45 Key Pressed 8
1403126mS PRN: Receptie: DSS Emulation 45 Key Pressed 8
1403355mS PRN: Receptie: DSS Emulation 45 Key Pressed 8
1403555mS PRN: Receptie: DSS Emulation 45 Key Pressed 8
1403715mS PRN: Receptie: DSS Emulation 45 Key Pressed 8
1403886mS PRN: Receptie: DSS Emulation 45 Key Pressed 8
1404006mS PRN: Receptie: DSS Emulation 45 Key Pressed 8
1405703mS PRN: Receptie: DSS Emulation 45 Key Pressed 25
1405903mS PRN: Receptie: DSS Emulation 45 Key Pressed 25
1406114mS PRN: Receptie: DSS Emulation 45 Key Pressed 25
1406283mS PRN: Receptie: DSS Emulation 45 Key Pressed 25
1406423mS PRN: Receptie: DSS Emulation 45 Key Pressed 25
1406593mS PRN: Receptie: DSS Emulation 45 Key Pressed 25
1410885mS CMExtnRx: v=201, p1=0
CMTransfer
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
1410886mS CMExtnTx: v=201, p1=0
CMFacility
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
IE CMIEFastStartInfoData (6)
Timed: 21/11/08 17:21
1410886mS CMExtnTx: v=201, p1=8000
CMFacility
Line: type=IPLine 250 Call: lid=251 id=2 in=1
IE CMIEFastStartInfoData (6)
1410892mS CMExtnRx: v=201, p1=0
CMSetup
Line: type=IPLine 250 Call: lid=251 id=1097 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[0630050030] Type=Unknown Plan=Default
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ALaw
IE CMIERespondingPartyName (228) Receptie
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=201
IE CMIEDeviceDetail (231) LOCALE=nld HW=8 VER=4 class=CMDeviceH323Phone type=38 number=8000 channel=0 rx_gain=32 tx_gain=32
IE CMIEFastStartInfoData (6)
Locale: nld
1410892mS CMTARGET: 251.1097.0 23 Receptie.1: LOOKUP CALL ROUTE: type=100 called_party= sub= calling=0630050030 dir=out complete=0 ses=0
1410893mS CMTARGET: 251.1097.0 23 Receptie.1: ADD TARGET (N): number= type=100 depth=1 nobar=1 setorig=1 ses=0
1410895mS CMExtnTx: v=201, p1=0
CMFacility
Line: type=IPLine 250 Call: lid=251 id=1097 in=0
IE CMIEFastStartInfoData (6)
Timed: 21/11/08 17:21
1410896mS CMExtnTx: v=201, p1=8000
CMFacility
Line: type=IPLine 250 Call: lid=251 id=2 in=1
IE CMIEFastStartInfoData (6)
1410897mS CMExtnTx: v=201, p1=0
CMSetupAck
Line: type=IPLine 250 Call: lid=251 id=1097 in=0
Timed: 21/11/08 17:21
1410897mS CD: CALL: 251.1093.0 BState=Connected Cut=2 Music=0.1 Aend="Receptie(201)" (0.0) Bend="Line 7" [Line 7] (3.9) CalledNum=0630050030 () CallingNum=201 (Receptie) Internal=0 Time=23978 AState=Connected
1410898mS CD: CALL: 251.1097.0 BState=Idle Cut=1 Music=3.0 Aend="Receptie(201)" (0.0) Bend="" [] (0.0) CalledNum= () CallingNum=0630050030 () Internal=1 Time=9 AState=DialInitiated
1410899mS CMMap: PCG::UnmapBChan pcp[101]b1r0 cp_b f5a8b6f4 other_cp_b f5add89c
1410899mS CMMap: a=0.1 b=3.9 M0
1410899mS CMMap: PCG::UnmapBChan pcp[148]b0r1 cp_b 0 other_cp_b 0
1410900mS CMMap: a=3.9 b=0.0 H1
1410900mS CMMap: PCG::AddToneGenerator g D1[1] append pcp[151]b0r1 (total 1)
1410900mS CMMap: a=0.0 b=0.0 pcp[150]b0r1 RTPD1
1411274mS RES: Fri 21/11/2008 17:21:01 FreeMem=79321312(15) CMMsg=6 (6) Buff=200 958 1000 7149 4 Links=20360
1411285mS PRN: 201: Digit Pressed 2
1411285mS CMExtnRx: v=201, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=251 id=1097 in=0
Called[2] Type=Default (100) Reason=CMDRdirect Keypad[2]
1411287mS CMMap: a=0.0 b=0.0 pcp[150]b0r1 RTPD0
1411525mS PRN: 201: Digit Pressed 0
1411525mS CMExtnRx: v=201, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=251 id=1097 in=0
Called[0] Type=Default (100) Reason=CMDRdirect Keypad[0]
1411785mS PRN: 201: Digit Pressed 4
1411785mS CMExtnRx: v=201, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=251 id=1097 in=0
Called[4] Type=Default (100) Reason=CMDRdirect Keypad[4]
1412786mS CMTARGET: 251.1097.0 23 Receptie.1: TimerExpired cause=CMTCDelayedProcessing
1412786mS CMTARGET: 251.1097.0 23 Receptie.1: LOOKUP CALL ROUTE: type=100 called_party=204 sub= calling=0630050030 dir=out complete=0 ses=0
1412786mS CMTARGET: 251.1097.0 23 Receptie.1: ADD TARGET (N): number=204 type=100 depth=1 nobar=1 setorig=1 ses=0
1412786mS CMTARGET: 251.1097.0 23 Receptie.1: SET USER: Jan orig=1
1412787mS CMTARGET: 251.1097.0 23 Receptie.1: ADD USER: Jan depth=2 disallow_cw=0 dnd=0 real_call=1 type(CMNTypeDefault) incl(0x0) excpt(0x0), allow_redir(1) remote=00000000
1412788mS CMTARGET: 256.1099.0 23 Jan.0: ADD PRIMARY
1412788mS CMTARGET: 251.1097.0 23 Receptie.1: CancelTimer CMTCDialToneTimeout
1412788mS CMTARGET: 251.1097.0 23 Receptie.1: INITIAL TARGETING SUCCEEDED
1412788mS CMTARGET: 251.1097.0 23 Receptie.1: GetNoAnswerTimer:15
1412790mS CMExtnTx: v=204, p1=0
CMSetup
Line: type= 256 Call: lid=256 id=1099 in=0
Called[204] Type=Default (100) Reason=CMDRdirect Calling[0630050030] Type=Unknown Plan=Default
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ALaw
IE CMIECalledPartyName (224) Jan
IE CMIERespondingPartyName (228) Receptie
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=201
IE CMIEDeviceDetail (231) LOCALE=nld HW=8 VER=4 class=CMDeviceH323Phone type=38 number=8000 channel=0 rx_gain=32 tx_gain=32
IE CMIECallSignalChannelData (8) unknown
Display [0630050030(Receptie)>Jan]
Timed: 21/11/08 17:21
Locale: nld
1412790mS CD: CALL: 251.1097.0 BState=Idle Cut=0 Music=0.0 Aend="Receptie(201)" (0.0) Bend="Jan(204)" [Jan(204)] (0.0) CalledNum=204 (Jan) CallingNum=0630050030 () Internal=1 Time=1901 AState=Dialling
1412792mS H323Evt: v=0 stacknum=240 State, new=NullState, old=NullState id=-1
1412792mS H323Evt: v=0 stacknum=240 State, new=Initiated, old=NullState id=1099
1412827mS H323Evt: v=0 stacknum=240 State, new=Proceeding, old=Initiated id=1099
1412827mS CMExtnRx: v=204, p1=0
CMProceeding
Line: type= 256 Call: lid=256 id=1099 in=0
1412828mS CMExtnTx: v=201, p1=0
CMProceeding
Line: type=IPLine 250 Call: lid=251 id=1097 in=0
IE CMIERespondingPartyName (228) Jan
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=204
IE CMIEDeviceDetail (231) LOCALE=nld HW=8 VER=4 class=CMDeviceMobilityPhone type=52 number=8005 channel=0 rx_gain=32 tx_gain=32
Timed: 21/11/08 17:21
1412830mS CD: CALL: 251.1097.0 BState=Ringing Cut=1 Music=0.0 Aend="Receptie(201)" (0.0) Bend="Jan(204)" [Jan(204)] (0.0) CalledNum=204 (Jan) CallingNum=0630050030 () Internal=1 Time=1941 AState=Dialled
1414951mS H323Evt: v=0 stacknum=240 State, new=Delivered, old=Proceeding id=1099
1414952mS CMExtnRx: v=204, p1=0
CMAlerting
Line: type= 256 Call: lid=256 id=1099 in=0
1414954mS CMExtnTx: v=201, p1=0
CMAlerting
Line: type=IPLine 250 Call: lid=251 id=1097 in=0
IE CMIERespondingPartyName (228) Jan
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=204
IE CMIEDeviceDetail (231) LOCALE=nld HW=8 VER=4 class=CMDeviceMobilityPhone type=52 number=8005 channel=0 rx_gain=32 tx_gain=32
Timed: 21/11/08 17:21
1414955mS CD: CALL: 251.1097.0 BState=Ringing Cut=1 Music=2.0 Aend="Receptie(201)" (0.0) Bend="Jan(204)" [Jan(204)] (0.0) CalledNum=204 (Jan) CallingNum=0630050030 () Internal=1 Time=4066 AState=Ringing
1414956mS CMMap: PCG::AddToneGenerator g R1[3] append pcp[152]b0r1 (total 1)
1414956mS CMMap: a=0.0 b=0.0 pcp[150]b0r1 RTPR1
1415569mS H323Evt: RTP(50t): 192.168.20.10/49154 192.168.20.100/51258 CODEC 6 PKTSZ=20 RFC2833=off AGE=4669 SENT 50 (avg size=20) RECV 29 (avg size=20)
1416055mS CMExtnRx: v=201, p1=0
CMTransferComplete
Line: type=IPLine 250 Call: lid=251 id=1097 in=0
1416055mS CMTARGET: TransferProposal: X_call: ID=23 Aend=201 -> 204
1416056mS CMTARGET: TransferProposal: Y_call: ID=22 Aend=201 -> 0630050030
1416056mS CMTARGET: Surviving Call=22
1416056mS CMTARGET: Goodbying Call=23
1416056mS CMTARGET: AEND 0630050030 -> 204 BEND
1416058mS CMExtnTx: v=201, p1=0
CMFacility
Line: type=IPLine 250 Call: lid=251 id=1097 in=0
IE CMIEFastStartInfoData (6)
Timed: 21/11/08 17:21
1416058mS CMExtnTx: v=201, p1=8000
CMFacility
Line: type=IPLine 250 Call: lid=251 id=2 in=1
IE CMIEFastStartInfoData (6)
1416059mS CMExtnTx: v=201, p1=0
CMReleaseComp
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
Called[0630050030] Type=Default (100) Reason=CMDRdirect Calling[201] Type=Internal Plan=Default
Cause=126, Transfer(IPO)
Timed: 21/11/08 17:21
1416062mS CMTARGET: 251.1097.0 23 Receptie.0: ChangeOriginator: To 0.1096.0 22 Q931 Trunk:7 CHAN=1
1416063mS CMExtnTx: v=204, p1=0
CMFacility
Line: type= 256 Call: lid=256 id=1099 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[0630050030] Type=Unknown Plan=Default
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=0630050030
IE CMIEDeviceDetail (231) LOCALE=nld HW=8 VER=4 class=CMDeviceISDNTrunk type=0 number=7 channel=1 rx_gain=32 tx_gain=32
Timed: 21/11/08 17:21
1416064mS CD: CALL: 0.1094.0 BState=Ringing Cut=3 Music=2.0 Aend="Line 7" (3.9) Bend="Jan(204)" [Jan(204)] (0.0) CalledNum=0630050030 () CallingNum=204 (Jan) Internal=0 Time=29145 AState=Connected
1416065mS CMLOGGING: CALL:2008/11/2117:21,00:00:00,001,201,O,204,204,Receptie,,,1,,""n/a,0
1416065mS CD: CALL: 251.1097.0 BState=Idle Cut=3 Music=0.0 Aend="Receptie(201)" (0.0) Bend="Jan(204)" [] (0.0) CalledNum= () CallingNum=201 (Receptie) Internal=1 Time=5176 AState=Ringing
1416066mS CD: CALL: 251.1097.0 Deleted
1416067mS CMExtnTx: v=201, p1=0
CMReleaseComp
Line: type=IPLine 250 Call: lid=251 id=1097 in=0
Called[204] Type=Default (100) Reason=CMDRdirect Calling[201] Type=Internal Plan=Default
Cause=126, Transfer(IPO)
Timed: 21/11/08 17:21
1416067mS CMExtnTx: v=201, p1=8000
CMFacility
Line: type=IPLine 250 Call: lid=251 id=2 in=1
IE CMIEFastStartInfoData (6)
1416071mS CD: CALL: 0.1094.0 BState=Ringing Cut=3 Music=2.0 Aend="Line 7" (3.9) Bend="Jan(204)" [Jan(204)] (0.0) CalledNum=0630050030 () CallingNum=204 (Jan) Internal=0 Time=29152 AState=Connected
1416073mS CMMap: a=3.9 b=0.0 H0
1416073mS CMMap: a=3.9 b=0.0 R1
1416073mS H323Evt: RTP(END): 192.168.20.10/49152 192.168.20.100/51258 CODEC 6 PKTSZ=20 RFC2833=off AGE=29143 SENT 1082 RECV 484 RTdelay=0 jitter=0 loss=256 remotejitter=0 remoteloss=0
1416073mS CMMap: a=0.0 b=0.0 pcp[150]b0r1 RTPR0
1416074mS H323Evt: RTP(END): 192.168.20.10/49154 192.168.20.100/51258 CODEC 6 PKTSZ=20 RFC2833=off AGE=5174 SENT 75 RECV 54 RTdelay=144 jitter=7 loss=0 remotejitter=15 remoteloss=0
1416074mS CMMap: a=0.1 b=0.0 Mapper::FreeCodec freed CMRTVocoder resource busy 1, total 12
1416274mS RES: Fri 21/11/2008 17:21:06 FreeMem=79344372(40) CMMsg=6 (6) Buff=200 957 998 7149 4 Links=20480
1418068mS CMExtnTx: v=201, p1=0
CMVoiceMailStatus
Line: type=IPLine 250 Call: lid=0 id=-1 in=0
Called[Receptie Msgs=0 Old=0 Sav=0] Type=Default (100) Reason=CMDRdirect Calling[00000000] Type=Default Plan=Default
Display [Receptie Msgs=0]
Timed: 21/11/08 17:21
1419371mS H323Evt: Recv: RegistrationRequest c0a81464; Endpoints registered: 1; Endpoints in registration: 0
1421869mS H323Evt: v=0 stacknum=240 State, new=Active, old=Delivered id=1099
1421871mS CMExtnRx: v=204, p1=0
CMConnect
Line: type= 256 Call: lid=256 id=1099 in=0
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=H221
1421871mS CMTARGET: 0.1096.0 22 Q931 Trunk:7 CHAN=1: CancelTimer CMTCCoverageTimeout
1421873mS CMTARGET: 0.1096.0 22 Q931 Trunk:7 CHAN=1: ~CMTargetHandler
1421874mS CMExtnTx: v=204, p1=0
CMConnectAck
Line: type= 256 Call: lid=256 id=1099 in=0
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=0630050030
IE CMIEDeviceDetail (231) LOCALE=nld HW=8 VER=4 class=CMDeviceISDNTrunk type=0 number=7 channel=1 rx_gain=32 tx_gain=32
Timed: 21/11/08 17:21
1421876mS CMExtnTx: v=204, p1=0
CMFacility
Line: type= 256 Call: lid=256 id=1099 in=0
IE CMIEPrimitiveData (7)
Timed: 21/11/08 17:21
1421877mS CD: CALL: 0.1094.0 BState=Connected Cut=3 Music=0.0 Aend="Line 7" (3.9) Bend="Jan(204)" [Jan(204)] (0.0) CalledNum=0630050030 () CallingNum=204 (Jan) Internal=0 Time=34958 AState=Connected
1421878mS CMMap: a=3.9 b=0.0 R0
1421878mS CMMap: PCG::MapBChan pcp[101]b1r0 cp_b f5a8b6f4 other_cp_b 0 type CGTypeSimple
1421886mS CMExtnRx: v=204, p1=0
CMFacility
Line: type= 256 Call: lid=256 id=1099 in=0
IE CMIEPrimitiveData (7)
1421888mS CMExtnTx: v=204, p1=0
CMFacility
Line: type= 256 Call: lid=256 id=1099 in=0
IE CMIEPrimitiveData (7)
Timed: 21/11/08 17:21
1421889mS CMExtnRx: v=204, p1=0
CMFacility
Line: type= 256 Call: lid=256 id=1099 in=0
IE CMIEPrimitiveData (7)
1421890mS CMExtnTx: v=204, p1=0
CMFacility
Line: type= 256 Call: lid=256 id=1099 in=0
IE CMIEPrimitiveData (7)
Timed: 21/11/08 17:21
1421891mS CD: CALL: 0.1094.0 BState=Connected Cut=3 Music=0.0 Aend="Line 7" (3.9) Bend="Jan(204)" [Jan(204)] (0.0) CalledNum=0630050030 () CallingNum=204 (Jan) Internal=0 Time=34971 AState=Connected
1421929mS CMExtnRx: v=204, p1=0
CMFacility
Line: type= 256 Call: lid=256 id=1099 in=0
IE CMIEPrimitiveData (7)
1421930mS CD: CALL: 0.1094.0 BState=Connected Cut=3 Music=0.0 Aend="Line 7" (3.9) Bend="Jan(204)" [Jan(204)] (0.0) CalledNum=0630050030 () CallingNum=204 (Jan) Internal=0 Time=35011 AState=Connected
1421942mS CMExtnRx: v=204, p1=0
CMFacility
Line: type= 256 Call: lid=256 id=1099 in=0
IE CMIEPrimitiveData (7)
1421944mS CMMap: a=0.1 b=0.0 Mapper::AllocateCodec allocated CMRTVocoder resource busy 1, total 12
1421944mS CMExtnTx: v=204, p1=0
CMFacility
Line: type= 256 Call: lid=256 id=1099 in=0
IE CMIEPrimitiveData (7)
Timed: 21/11/08 17:21
1421945mS CD: CALL: 0.1094.0 BState=Connected Cut=3 Music=0.0 Aend="Line 7" (3.9) Bend="Jan(204)" [Jan(204)] (0.0) CalledNum=0630050030 () CallingNum=204 (Jan) Internal=0 Time=35026 AState=Connected
1421970mS CMExtnRx: v=204, p1=0
CMFacility
Line: type= 256 Call: lid=256 id=1099 in=0
IE CMIEPrimitiveData (7)
1421971mS CMExtnTx: v=204, p1=0
CMFacility
Line: type= 256 Call: lid=256 id=1099 in=0
IE CMIEPrimitiveData (7)
Timed: 21/11/08 17:21
1421972mS CD: CALL: 0.1094.0 BState=Connected Cut=3 Music=0.0 Aend="Line 7" (3.9) Bend="Jan(204)" [Jan(204)] (0.0) CalledNum=0630050030 () CallingNum=204 (Jan) Internal=0 Time=35053 AState=Connected
1422003mS CMExtnRx: v=204, p1=0
CMFacility
Line: type= 256 Call: lid=256 id=1099 in=0
IE CMIEPrimitiveData (7)
1422006mS CD: CALL: 0.1094.0 BState=Connected Cut=3 Music=0.0 Aend="Line 7" (3.9) Bend="Jan(204)" [Jan(204)] (0.0) CalledNum=0630050030 () CallingNum=204 (Jan) Internal=0 Time=35087 AState=Connected
1422007mS CMMap: a=3.9 b=0.0 PCGS CPReserveCodec (pcp[153]b0r1) true
1422007mS CMMap: PCG::MapBChan pcp[153]b0r1 cp_b f5add89c other_cp_b f5a8b6f4 type CGTypeSimple
1422008mS CMMap: a=3.9 b=0.1 M1
1422274mS RES: Fri 21/11/2008 17:21:12 FreeMem=79348464(32) CMMsg=6 (6) Buff=200 960 999 7149 4 Links=20425
1423113mS H323Evt: RTP(50t): 192.168.20.10/49152 192.168.20.202/1090 CODEC 6 PKTSZ=20 RFC2833=off AGE=1106 SENT 50 (avg size=20) RECV 53 (avg size=20)
1427309mS H323Evt: v=0 stacknum=240 State, new=NullState, old=Active id=1099
1427311mS CMExtnTx: v=204, p1=0
CMFacility
Line: type= 256 Call: lid=256 id=1099 in=0
IE CMIEPrimitiveData (7)
Timed: 21/11/08 17:21
1427312mS CMExtnRx: v=204, p1=0
CMReleaseComp
Line: type= 256 Call: lid=256 id=1099 in=0
Cause=16, Normal call clearing
1427314mS CMLOGGING: CALL:2008/11/2117:20,00:00:20,010,201,I,0630050030,,,,,0,,""n/a,0
1427314mS CD: CALL: 0.1094.0 BState=Disconnecting Cut=1 Music=0.0 Aend="Line 7" (3.9) Bend="Jan(204)" [Jan(204)] (0.0) CalledNum=0630050030 () CallingNum=204 (Jan) Internal=0 Time=40395 AState=Connected
1427315mS CD: CALL: 0.1094.0 Deleted
1427316mS CMLineTx: v=7
CMDisconnect
Line: type=Q931Line 7 Call: lid=0 id=1096 in=0
Cause=16, Normal call clearing
1427318mS CMMap: PCG::UnmapBChan pcp[101]b1r0 cp_b f5a8b6f4 other_cp_b f5add89c
1427318mS CMMap: a=0.1 b=3.9 M0
1427319mS CMMap: PCG::UnmapBChan pcp[153]b0r1 cp_b 0 other_cp_b 0
1427319mS H323Evt: RTP(END): 192.168.20.10/49152 192.168.20.202/1090 CODEC 6 PKTSZ=20 RFC2833=off AGE=5312 SENT 259 RECV 262 RTdelay=0 jitter=0 loss=0 remotejitter=0 remoteloss=0
1427319mS CMMap: a=0.1 b=0.0 Mapper::FreeCodec freed CMRTVocoder resource busy 1, total 12
1427774mS RES: Fri 21/11/2008 17:21:18 FreeMem=79365452(34) CMMsg=6 (6) Buff=200 958 1000 7149 4 Links=20482
1428294mS CMLineRx: v=7
CMReleaseComp
Line: type=Q931Line 7 Call: lid=0 id=1096 in=0
BChan: slot=0 chan=1
Cause=16, Normal call clearing
1429317mS CMExtnTx: v=204, p1=0
CMVoiceMailStatus
Line: type= 256 Call: lid=0 id=-1 in=0
Called[Jan Msgs=0 Old=0 Sav=0] Type=Default (100) Reason=CMDRdirect Calling[00000000] Type=Default Plan=Default
Display [Jan Msgs=0]
Timed: 21/11/08 17:21
********** Warning: Logging to Screen Stopped **********
I have a problem with an IP 500 4.1.15. The reception 201 has a BLF expansion module with user buttons. When i use the button to transfer a call to a user it doens't work. The button on the 4621 itself als doesn't work. When I use one of the buttons to call a user, it works!
Below a trace. You can actually see that I press the button but nothing happens, you just stay in the call you want to transfer. When I just use the transfer button the call is transfered.
1386922mS CMExtnRx: v=201, p1=0
CMSetup
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[201] Type=Internal Plan=Default
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ALaw
IE CMIECallingPartyName (110) Receptie
IE CMIEFastStartInfoData (6)
1386923mS CMTARGET: 251.1093.0 22 Receptie.0: LOOKUP CALL ROUTE: type=100 called_party= sub= calling=201 dir=out complete=0 ses=0
1386923mS CMTARGET: 251.1093.0 22 Receptie.0: ADD TARGET (N): number= type=100 depth=1 nobar=1 setorig=1 ses=0
1386926mS CMExtnTx: v=201, p1=0
CMFacility
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
IE CMIEFastStartInfoData (6)
Timed: 21/11/08 17:20
1386926mS CMExtnTx: v=201, p1=8000
CMFacility
Line: type=IPLine 250 Call: lid=251 id=2 in=1
IE CMIEFastStartInfoData (6)
1386927mS CMExtnTx: v=201, p1=0
CMSetupAck
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
Timed: 21/11/08 17:20
1386927mS CD: CALL: 251.1093.0 BState=Idle Cut=1 Music=3.0 Aend="Receptie(201)" (0.0) Bend="" [] (0.0) CalledNum= () CallingNum=201 (Receptie) Internal=1 Time=8 AState=DialInitiated
1386930mS CMMap: PCG::AddToneGenerator g D1[1] append pcp[149]b0r1 (total 1)
1386930mS CMMap: a=0.0 b=0.0 pcp[148]b0r1 RTPD1
1387274mS RES: Fri 21/11/2008 17:20:37 FreeMem=79348560(19) CMMsg=6 (6) Buff=200 954 1000 7149 4 Links=20429
1387756mS PRN: 201: Digit Pressed 0
1387757mS CMExtnRx: v=201, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
Called[0] Type=Default (100) Reason=CMDRdirect Keypad[0]
1387758mS CMMap: a=0.0 b=0.0 pcp[148]b0r1 RTPD0
1387995mS PRN: 201: Digit Pressed 6
1387996mS CMExtnRx: v=201, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
Called[6] Type=Default (100) Reason=CMDRdirect Keypad[6]
1388196mS PRN: 201: Digit Pressed 3
1388196mS CMExtnRx: v=201, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
Called[3] Type=Default (100) Reason=CMDRdirect Keypad[3]
1388456mS PRN: 201: Digit Pressed 0
1388456mS CMExtnRx: v=201, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
Called[0] Type=Default (100) Reason=CMDRdirect Keypad[0]
1388457mS CMTARGET: 251.1093.0 22 Receptie.0: CancelTimer CMTCDelayedProcessing
1388457mS CMTARGET: 251.1093.0 22 Receptie.0: LOOKUP CALL ROUTE: type=100 called_party=0630 sub= calling=201 dir=out complete=0 ses=0
1388457mS CMTARGET: 251.1093.0 22 Receptie.0: ADD TARGET (N): number=0630 type=100 depth=1 nobar=1 setorig=1 ses=0
1388598mS PRN: 201: Digit Pressed 0
1388598mS CMExtnRx: v=201, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
Called[0] Type=Default (100) Reason=CMDRdirect Keypad[0]
1388599mS CMTARGET: 251.1093.0 22 Receptie.0: LOOKUP CALL ROUTE: type=100 called_party=06300 sub= calling=201 dir=out complete=0 ses=0
1388599mS CMTARGET: 251.1093.0 22 Receptie.0: ADD TARGET (N): number=06300 type=100 depth=1 nobar=1 setorig=1 ses=0
1388826mS PRN: 201: Digit Pressed 5
1388827mS CMExtnRx: v=201, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
Called[5] Type=Default (100) Reason=CMDRdirect Keypad[5]
1388827mS CMTARGET: 251.1093.0 22 Receptie.0: LOOKUP CALL ROUTE: type=100 called_party=063005 sub= calling=201 dir=out complete=0 ses=0
1388827mS CMTARGET: 251.1093.0 22 Receptie.0: ADD TARGET (N): number=063005 type=100 depth=1 nobar=1 setorig=1 ses=0
1389056mS PRN: 201: Digit Pressed 0
1389056mS CMExtnRx: v=201, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
Called[0] Type=Default (100) Reason=CMDRdirect Keypad[0]
1389057mS CMTARGET: 251.1093.0 22 Receptie.0: LOOKUP CALL ROUTE: type=100 called_party=0630050 sub= calling=201 dir=out complete=0 ses=0
1389057mS CMTARGET: 251.1093.0 22 Receptie.0: ADD TARGET (N): number=0630050 type=100 depth=1 nobar=1 setorig=1 ses=0
1389198mS PRN: 201: Digit Pressed 0
1389198mS CMExtnRx: v=201, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
Called[0] Type=Default (100) Reason=CMDRdirect Keypad[0]
1389199mS CMTARGET: 251.1093.0 22 Receptie.0: LOOKUP CALL ROUTE: type=100 called_party=06300500 sub= calling=201 dir=out complete=0 ses=0
1389199mS CMTARGET: 251.1093.0 22 Receptie.0: ADD TARGET (N): number=06300500 type=100 depth=1 nobar=1 setorig=1 ses=0
1389416mS PRN: 201: Digit Pressed 3
1389416mS CMExtnRx: v=201, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
Called[3] Type=Default (100) Reason=CMDRdirect Keypad[3]
1389417mS CMTARGET: 251.1093.0 22 Receptie.0: LOOKUP CALL ROUTE: type=100 called_party=063005003 sub= calling=201 dir=out complete=0 ses=0
1389417mS CMTARGET: 251.1093.0 22 Receptie.0: ADD TARGET (N): number=063005003 type=100 depth=1 nobar=1 setorig=1 ses=0
1389656mS PRN: 201: Digit Pressed 0
1389656mS CMExtnRx: v=201, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
Called[0] Type=Default (100) Reason=CMDRdirect Keypad[0]
1389657mS CMTARGET: 251.1093.0 22 Receptie.0: LOOKUP CALL ROUTE: type=100 called_party=0630050030 sub= calling=201 dir=out complete=0 ses=0
1389657mS CMTARGET: 251.1093.0 22 Receptie.0: ADD TARGET (N): number=0630050030 type=100 depth=1 nobar=1 setorig=1 ses=0
1389657mS CMTARGET: 251.1093.0 22 Receptie.0: SYS SC: 0630050030 10 30050030 sc=type=Dial code=06XXXXXXXX, num=. callinfop->sending_complete=0 secondary_dialtone=
1389658mS CMARS: CMARSHandler::FindActiveARSByGroupID GroupID=51
1389658mS CMARS: CMARSHandler::MakeCallTarget - Called Number: 0630050030
1389658mS CMTARGET: 251.1093.0 22 Receptie.0: CancelTimer CMTCDialToneTimeout
1389658mS CMTARGET: 251.1093.0 22 Receptie.0: INITIAL TARGETING SUCCEEDED
1389659mS CMTARGET: 251.1093.0 22 Receptie.0: GetNoAnswerTimer:15
1389660mS CMTARGET: 251.1093.0 22 Receptie.0: CancelTimer CMTCNoAnswerTimeout
1389660mS CMARS: FORM: GSM - Received Number: 0630050030
1389660mS CMARS: FOUND A SHORT CODE - short_code: ? - Tel: , - Called_Party: 0630050030 - Line Group Id: 10
1389660mS CMARS: CMARSHandler::FindActiveARSByGroupID GroupID=10
1389661mS CMTARGET: Group Id: 10 has NOT been found in Line: 2
1389661mS CMTARGET: Group Id: 10 has NOT been found in Line: 3
1389661mS CMTARGET: Group Id: 10 has NOT been found in Line: 4
1389661mS CMTARGET: Group Id: 10 has NOT been found in Line: 5
1389661mS CMTARGET: Group Id: 10 has NOT been found in Line: 6
1389661mS CMMap: a=0.1 b=0.0 Mapper::AllocateCodec allocated CMRTVocoder resource busy 1, total 12
1389662mS CMARS: FOUND LINE - Line Id: 7 - using line group id: 10 - Called Number: 0630050030 - Calling Number: 201
1389662mS CMARS: SEND Setup TO LINE
1389663mS CMLineTx: v=7
CMSetup
Line: type=Q931Line 7 Call: lid=0 id=1096 in=0
Called[0630050030] Type=Unknown (0) Reason=CMDRdirect Calling[] Type=Unknown Plan=Default
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ALaw
Locale: nld
1389663mS CD: CALL: 251.1093.0 BState=Idle Cut=2 Music=0.0 Aend="Receptie(201)" (0.0) Bend="" [Line 7] (0.0) CalledNum=0630050030 () CallingNum=201 (Receptie) Internal=1 Time=2744 AState=Dialling
1389922mS CMLineRx: v=7
CMProceeding
Line: type=Q931Line 7 Call: lid=0 id=1096 in=0
BChan: slot=0 chan=1
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLNetBeyondIWPoint (10), pd=CMPDInbandPattern (8)
1389922mS CMARS: LINE ep Received: CMProceeding - child->state = CMCSOffering - ARS Call State = CMCSOverlapRecv
1389922mS CMARS: LINE IS NOW THE B END OF THE CALL - CMARSEndpoint::RequestEnd()
1389923mS CMARS: CMARSEndpoint::CallLost(cause=124) - Address: 0.1095.0 22 ARS for GSM - Call State: CMCSOverlapRecv
1389924mS CMExtnTx: v=201, p1=0
CMProceeding
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLNetBeyondIWPoint (10), pd=CMPDInbandPattern (8)
IE CMIEDeviceDetail (231) LOCALE=nld HW=8 VER=4 class=CMDeviceISDNTrunk type=0 number=7 channel=1 rx_gain=32 tx_gain=32
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=0630050030
Timed: 21/11/08 17:20
1389926mS CD: CALL: 251.1093.0 BState=Ringing Cut=3 Music=0.0 Aend="Receptie(201)" (0.0) Bend="Line 7" [Line 7] (3.9) CalledNum=0630050030 () CallingNum=201 (Receptie) Internal=0 Time=3006 AState=Dialled
1389927mS CMMap: PCG::MapBChan pcp[148]b0r1 cp_b 0 other_cp_b 0 type CGTypeSimple
1389927mS CMMap: PCGS CPReserveCodec for the other end (pcp[148]b0r1) true
1389927mS CMMap: PCG::MapBChan pcp[101]b1r0 cp_b f5a8b6f4 other_cp_b f5add89c type CGTypeSimple
1389927mS CMMap: a=0.1 b=3.9 M1
1390420mS H323Evt: RTP(50r): 192.168.20.10/49152 192.168.20.100/51258 CODEC 6 PKTSZ=20 RFC2833=off AGE=3490 SENT 58 (avg size=20) RECV 50 (avg size=20)
1396710mS CMLineRx: v=7
CMAlerting
Line: type=Q931Line 7 Call: lid=0 id=1096 in=0
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLNetBeyondIWPoint (10), pd=CMPDInbandPattern (8)
1396712mS CMExtnTx: v=201, p1=0
CMAlerting
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLNetBeyondIWPoint (10), pd=CMPDInbandPattern (8)
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=0630050030
IE CMIEDeviceDetail (231) LOCALE=nld HW=8 VER=4 class=CMDeviceISDNTrunk type=0 number=7 channel=1 rx_gain=32 tx_gain=32
Timed: 21/11/08 17:20
1396712mS CD: CALL: 251.1093.0 BState=Ringing Cut=3 Music=0.0 Aend="Receptie(201)" (0.0) Bend="Line 7" [Line 7] (3.9) CalledNum=0630050030 () CallingNum=201 (Receptie) Internal=0 Time=9793 AState=Ringing
1401259mS CMLineRx: v=7
CMConnect
Line: type=Q931Line 7 Call: lid=0 id=1096 in=0
BChan: slot=0 chan=1
1401259mS CMExtnTx: v=201, p1=0
CMConnect
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=0630050030
IE CMIEDeviceDetail (231) LOCALE=nld HW=8 VER=4 class=CMDeviceISDNTrunk type=0 number=7 channel=1 rx_gain=32 tx_gain=32
Timed: 21/11/08 17:20
1401260mS CMExtnRx: v=201, p1=0
CMConnectAck
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
1401260mS CMTARGET: 251.1093.0 22 Receptie.0: ~CMTargetHandler
1401262mS CMLineTx: v=7
CMConnectAck
Line: type=Q931Line 7 Call: lid=0 id=1096 in=0
BChan: slot=0 chan=1
1401262mS CD: CALL: 251.1093.0 BState=Connected Cut=3 Music=0.0 Aend="Receptie(201)" (0.0) Bend="Line 7" [Line 7] (3.9) CalledNum=0630050030 () CallingNum=201 (Receptie) Internal=0 Time=14343 AState=Connected
1401274mS RES: Fri 21/11/2008 17:20:51 FreeMem=79348232(19) CMMsg=6 (6) Buff=200 956 999 7149 4 Links=20420
1402565mS PRN: Receptie: DSS Emulation 45 Key Pressed 8
1402865mS PRN: Receptie: DSS Emulation 45 Key Pressed 8
1403126mS PRN: Receptie: DSS Emulation 45 Key Pressed 8
1403355mS PRN: Receptie: DSS Emulation 45 Key Pressed 8
1403555mS PRN: Receptie: DSS Emulation 45 Key Pressed 8
1403715mS PRN: Receptie: DSS Emulation 45 Key Pressed 8
1403886mS PRN: Receptie: DSS Emulation 45 Key Pressed 8
1404006mS PRN: Receptie: DSS Emulation 45 Key Pressed 8
1405703mS PRN: Receptie: DSS Emulation 45 Key Pressed 25
1405903mS PRN: Receptie: DSS Emulation 45 Key Pressed 25
1406114mS PRN: Receptie: DSS Emulation 45 Key Pressed 25
1406283mS PRN: Receptie: DSS Emulation 45 Key Pressed 25
1406423mS PRN: Receptie: DSS Emulation 45 Key Pressed 25
1406593mS PRN: Receptie: DSS Emulation 45 Key Pressed 25
1410885mS CMExtnRx: v=201, p1=0
CMTransfer
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
1410886mS CMExtnTx: v=201, p1=0
CMFacility
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
IE CMIEFastStartInfoData (6)
Timed: 21/11/08 17:21
1410886mS CMExtnTx: v=201, p1=8000
CMFacility
Line: type=IPLine 250 Call: lid=251 id=2 in=1
IE CMIEFastStartInfoData (6)
1410892mS CMExtnRx: v=201, p1=0
CMSetup
Line: type=IPLine 250 Call: lid=251 id=1097 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[0630050030] Type=Unknown Plan=Default
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ALaw
IE CMIERespondingPartyName (228) Receptie
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=201
IE CMIEDeviceDetail (231) LOCALE=nld HW=8 VER=4 class=CMDeviceH323Phone type=38 number=8000 channel=0 rx_gain=32 tx_gain=32
IE CMIEFastStartInfoData (6)
Locale: nld
1410892mS CMTARGET: 251.1097.0 23 Receptie.1: LOOKUP CALL ROUTE: type=100 called_party= sub= calling=0630050030 dir=out complete=0 ses=0
1410893mS CMTARGET: 251.1097.0 23 Receptie.1: ADD TARGET (N): number= type=100 depth=1 nobar=1 setorig=1 ses=0
1410895mS CMExtnTx: v=201, p1=0
CMFacility
Line: type=IPLine 250 Call: lid=251 id=1097 in=0
IE CMIEFastStartInfoData (6)
Timed: 21/11/08 17:21
1410896mS CMExtnTx: v=201, p1=8000
CMFacility
Line: type=IPLine 250 Call: lid=251 id=2 in=1
IE CMIEFastStartInfoData (6)
1410897mS CMExtnTx: v=201, p1=0
CMSetupAck
Line: type=IPLine 250 Call: lid=251 id=1097 in=0
Timed: 21/11/08 17:21
1410897mS CD: CALL: 251.1093.0 BState=Connected Cut=2 Music=0.1 Aend="Receptie(201)" (0.0) Bend="Line 7" [Line 7] (3.9) CalledNum=0630050030 () CallingNum=201 (Receptie) Internal=0 Time=23978 AState=Connected
1410898mS CD: CALL: 251.1097.0 BState=Idle Cut=1 Music=3.0 Aend="Receptie(201)" (0.0) Bend="" [] (0.0) CalledNum= () CallingNum=0630050030 () Internal=1 Time=9 AState=DialInitiated
1410899mS CMMap: PCG::UnmapBChan pcp[101]b1r0 cp_b f5a8b6f4 other_cp_b f5add89c
1410899mS CMMap: a=0.1 b=3.9 M0
1410899mS CMMap: PCG::UnmapBChan pcp[148]b0r1 cp_b 0 other_cp_b 0
1410900mS CMMap: a=3.9 b=0.0 H1
1410900mS CMMap: PCG::AddToneGenerator g D1[1] append pcp[151]b0r1 (total 1)
1410900mS CMMap: a=0.0 b=0.0 pcp[150]b0r1 RTPD1
1411274mS RES: Fri 21/11/2008 17:21:01 FreeMem=79321312(15) CMMsg=6 (6) Buff=200 958 1000 7149 4 Links=20360
1411285mS PRN: 201: Digit Pressed 2
1411285mS CMExtnRx: v=201, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=251 id=1097 in=0
Called[2] Type=Default (100) Reason=CMDRdirect Keypad[2]
1411287mS CMMap: a=0.0 b=0.0 pcp[150]b0r1 RTPD0
1411525mS PRN: 201: Digit Pressed 0
1411525mS CMExtnRx: v=201, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=251 id=1097 in=0
Called[0] Type=Default (100) Reason=CMDRdirect Keypad[0]
1411785mS PRN: 201: Digit Pressed 4
1411785mS CMExtnRx: v=201, p1=0
CMInformation
Line: type=IPLine 250 Call: lid=251 id=1097 in=0
Called[4] Type=Default (100) Reason=CMDRdirect Keypad[4]
1412786mS CMTARGET: 251.1097.0 23 Receptie.1: TimerExpired cause=CMTCDelayedProcessing
1412786mS CMTARGET: 251.1097.0 23 Receptie.1: LOOKUP CALL ROUTE: type=100 called_party=204 sub= calling=0630050030 dir=out complete=0 ses=0
1412786mS CMTARGET: 251.1097.0 23 Receptie.1: ADD TARGET (N): number=204 type=100 depth=1 nobar=1 setorig=1 ses=0
1412786mS CMTARGET: 251.1097.0 23 Receptie.1: SET USER: Jan orig=1
1412787mS CMTARGET: 251.1097.0 23 Receptie.1: ADD USER: Jan depth=2 disallow_cw=0 dnd=0 real_call=1 type(CMNTypeDefault) incl(0x0) excpt(0x0), allow_redir(1) remote=00000000
1412788mS CMTARGET: 256.1099.0 23 Jan.0: ADD PRIMARY
1412788mS CMTARGET: 251.1097.0 23 Receptie.1: CancelTimer CMTCDialToneTimeout
1412788mS CMTARGET: 251.1097.0 23 Receptie.1: INITIAL TARGETING SUCCEEDED
1412788mS CMTARGET: 251.1097.0 23 Receptie.1: GetNoAnswerTimer:15
1412790mS CMExtnTx: v=204, p1=0
CMSetup
Line: type= 256 Call: lid=256 id=1099 in=0
Called[204] Type=Default (100) Reason=CMDRdirect Calling[0630050030] Type=Unknown Plan=Default
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ALaw
IE CMIECalledPartyName (224) Jan
IE CMIERespondingPartyName (228) Receptie
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=201
IE CMIEDeviceDetail (231) LOCALE=nld HW=8 VER=4 class=CMDeviceH323Phone type=38 number=8000 channel=0 rx_gain=32 tx_gain=32
IE CMIECallSignalChannelData (8) unknown
Display [0630050030(Receptie)>Jan]
Timed: 21/11/08 17:21
Locale: nld
1412790mS CD: CALL: 251.1097.0 BState=Idle Cut=0 Music=0.0 Aend="Receptie(201)" (0.0) Bend="Jan(204)" [Jan(204)] (0.0) CalledNum=204 (Jan) CallingNum=0630050030 () Internal=1 Time=1901 AState=Dialling
1412792mS H323Evt: v=0 stacknum=240 State, new=NullState, old=NullState id=-1
1412792mS H323Evt: v=0 stacknum=240 State, new=Initiated, old=NullState id=1099
1412827mS H323Evt: v=0 stacknum=240 State, new=Proceeding, old=Initiated id=1099
1412827mS CMExtnRx: v=204, p1=0
CMProceeding
Line: type= 256 Call: lid=256 id=1099 in=0
1412828mS CMExtnTx: v=201, p1=0
CMProceeding
Line: type=IPLine 250 Call: lid=251 id=1097 in=0
IE CMIERespondingPartyName (228) Jan
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=204
IE CMIEDeviceDetail (231) LOCALE=nld HW=8 VER=4 class=CMDeviceMobilityPhone type=52 number=8005 channel=0 rx_gain=32 tx_gain=32
Timed: 21/11/08 17:21
1412830mS CD: CALL: 251.1097.0 BState=Ringing Cut=1 Music=0.0 Aend="Receptie(201)" (0.0) Bend="Jan(204)" [Jan(204)] (0.0) CalledNum=204 (Jan) CallingNum=0630050030 () Internal=1 Time=1941 AState=Dialled
1414951mS H323Evt: v=0 stacknum=240 State, new=Delivered, old=Proceeding id=1099
1414952mS CMExtnRx: v=204, p1=0
CMAlerting
Line: type= 256 Call: lid=256 id=1099 in=0
1414954mS CMExtnTx: v=201, p1=0
CMAlerting
Line: type=IPLine 250 Call: lid=251 id=1097 in=0
IE CMIERespondingPartyName (228) Jan
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=204
IE CMIEDeviceDetail (231) LOCALE=nld HW=8 VER=4 class=CMDeviceMobilityPhone type=52 number=8005 channel=0 rx_gain=32 tx_gain=32
Timed: 21/11/08 17:21
1414955mS CD: CALL: 251.1097.0 BState=Ringing Cut=1 Music=2.0 Aend="Receptie(201)" (0.0) Bend="Jan(204)" [Jan(204)] (0.0) CalledNum=204 (Jan) CallingNum=0630050030 () Internal=1 Time=4066 AState=Ringing
1414956mS CMMap: PCG::AddToneGenerator g R1[3] append pcp[152]b0r1 (total 1)
1414956mS CMMap: a=0.0 b=0.0 pcp[150]b0r1 RTPR1
1415569mS H323Evt: RTP(50t): 192.168.20.10/49154 192.168.20.100/51258 CODEC 6 PKTSZ=20 RFC2833=off AGE=4669 SENT 50 (avg size=20) RECV 29 (avg size=20)
1416055mS CMExtnRx: v=201, p1=0
CMTransferComplete
Line: type=IPLine 250 Call: lid=251 id=1097 in=0
1416055mS CMTARGET: TransferProposal: X_call: ID=23 Aend=201 -> 204
1416056mS CMTARGET: TransferProposal: Y_call: ID=22 Aend=201 -> 0630050030
1416056mS CMTARGET: Surviving Call=22
1416056mS CMTARGET: Goodbying Call=23
1416056mS CMTARGET: AEND 0630050030 -> 204 BEND
1416058mS CMExtnTx: v=201, p1=0
CMFacility
Line: type=IPLine 250 Call: lid=251 id=1097 in=0
IE CMIEFastStartInfoData (6)
Timed: 21/11/08 17:21
1416058mS CMExtnTx: v=201, p1=8000
CMFacility
Line: type=IPLine 250 Call: lid=251 id=2 in=1
IE CMIEFastStartInfoData (6)
1416059mS CMExtnTx: v=201, p1=0
CMReleaseComp
Line: type=IPLine 250 Call: lid=251 id=1093 in=0
Called[0630050030] Type=Default (100) Reason=CMDRdirect Calling[201] Type=Internal Plan=Default
Cause=126, Transfer(IPO)
Timed: 21/11/08 17:21
1416062mS CMTARGET: 251.1097.0 23 Receptie.0: ChangeOriginator: To 0.1096.0 22 Q931 Trunk:7 CHAN=1
1416063mS CMExtnTx: v=204, p1=0
CMFacility
Line: type= 256 Call: lid=256 id=1099 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[0630050030] Type=Unknown Plan=Default
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=0630050030
IE CMIEDeviceDetail (231) LOCALE=nld HW=8 VER=4 class=CMDeviceISDNTrunk type=0 number=7 channel=1 rx_gain=32 tx_gain=32
Timed: 21/11/08 17:21
1416064mS CD: CALL: 0.1094.0 BState=Ringing Cut=3 Music=2.0 Aend="Line 7" (3.9) Bend="Jan(204)" [Jan(204)] (0.0) CalledNum=0630050030 () CallingNum=204 (Jan) Internal=0 Time=29145 AState=Connected
1416065mS CMLOGGING: CALL:2008/11/2117:21,00:00:00,001,201,O,204,204,Receptie,,,1,,""n/a,0
1416065mS CD: CALL: 251.1097.0 BState=Idle Cut=3 Music=0.0 Aend="Receptie(201)" (0.0) Bend="Jan(204)" [] (0.0) CalledNum= () CallingNum=201 (Receptie) Internal=1 Time=5176 AState=Ringing
1416066mS CD: CALL: 251.1097.0 Deleted
1416067mS CMExtnTx: v=201, p1=0
CMReleaseComp
Line: type=IPLine 250 Call: lid=251 id=1097 in=0
Called[204] Type=Default (100) Reason=CMDRdirect Calling[201] Type=Internal Plan=Default
Cause=126, Transfer(IPO)
Timed: 21/11/08 17:21
1416067mS CMExtnTx: v=201, p1=8000
CMFacility
Line: type=IPLine 250 Call: lid=251 id=2 in=1
IE CMIEFastStartInfoData (6)
1416071mS CD: CALL: 0.1094.0 BState=Ringing Cut=3 Music=2.0 Aend="Line 7" (3.9) Bend="Jan(204)" [Jan(204)] (0.0) CalledNum=0630050030 () CallingNum=204 (Jan) Internal=0 Time=29152 AState=Connected
1416073mS CMMap: a=3.9 b=0.0 H0
1416073mS CMMap: a=3.9 b=0.0 R1
1416073mS H323Evt: RTP(END): 192.168.20.10/49152 192.168.20.100/51258 CODEC 6 PKTSZ=20 RFC2833=off AGE=29143 SENT 1082 RECV 484 RTdelay=0 jitter=0 loss=256 remotejitter=0 remoteloss=0
1416073mS CMMap: a=0.0 b=0.0 pcp[150]b0r1 RTPR0
1416074mS H323Evt: RTP(END): 192.168.20.10/49154 192.168.20.100/51258 CODEC 6 PKTSZ=20 RFC2833=off AGE=5174 SENT 75 RECV 54 RTdelay=144 jitter=7 loss=0 remotejitter=15 remoteloss=0
1416074mS CMMap: a=0.1 b=0.0 Mapper::FreeCodec freed CMRTVocoder resource busy 1, total 12
1416274mS RES: Fri 21/11/2008 17:21:06 FreeMem=79344372(40) CMMsg=6 (6) Buff=200 957 998 7149 4 Links=20480
1418068mS CMExtnTx: v=201, p1=0
CMVoiceMailStatus
Line: type=IPLine 250 Call: lid=0 id=-1 in=0
Called[Receptie Msgs=0 Old=0 Sav=0] Type=Default (100) Reason=CMDRdirect Calling[00000000] Type=Default Plan=Default
Display [Receptie Msgs=0]
Timed: 21/11/08 17:21
1419371mS H323Evt: Recv: RegistrationRequest c0a81464; Endpoints registered: 1; Endpoints in registration: 0
1421869mS H323Evt: v=0 stacknum=240 State, new=Active, old=Delivered id=1099
1421871mS CMExtnRx: v=204, p1=0
CMConnect
Line: type= 256 Call: lid=256 id=1099 in=0
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=H221
1421871mS CMTARGET: 0.1096.0 22 Q931 Trunk:7 CHAN=1: CancelTimer CMTCCoverageTimeout
1421873mS CMTARGET: 0.1096.0 22 Q931 Trunk:7 CHAN=1: ~CMTargetHandler
1421874mS CMExtnTx: v=204, p1=0
CMConnectAck
Line: type= 256 Call: lid=256 id=1099 in=0
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=0630050030
IE CMIEDeviceDetail (231) LOCALE=nld HW=8 VER=4 class=CMDeviceISDNTrunk type=0 number=7 channel=1 rx_gain=32 tx_gain=32
Timed: 21/11/08 17:21
1421876mS CMExtnTx: v=204, p1=0
CMFacility
Line: type= 256 Call: lid=256 id=1099 in=0
IE CMIEPrimitiveData (7)
Timed: 21/11/08 17:21
1421877mS CD: CALL: 0.1094.0 BState=Connected Cut=3 Music=0.0 Aend="Line 7" (3.9) Bend="Jan(204)" [Jan(204)] (0.0) CalledNum=0630050030 () CallingNum=204 (Jan) Internal=0 Time=34958 AState=Connected
1421878mS CMMap: a=3.9 b=0.0 R0
1421878mS CMMap: PCG::MapBChan pcp[101]b1r0 cp_b f5a8b6f4 other_cp_b 0 type CGTypeSimple
1421886mS CMExtnRx: v=204, p1=0
CMFacility
Line: type= 256 Call: lid=256 id=1099 in=0
IE CMIEPrimitiveData (7)
1421888mS CMExtnTx: v=204, p1=0
CMFacility
Line: type= 256 Call: lid=256 id=1099 in=0
IE CMIEPrimitiveData (7)
Timed: 21/11/08 17:21
1421889mS CMExtnRx: v=204, p1=0
CMFacility
Line: type= 256 Call: lid=256 id=1099 in=0
IE CMIEPrimitiveData (7)
1421890mS CMExtnTx: v=204, p1=0
CMFacility
Line: type= 256 Call: lid=256 id=1099 in=0
IE CMIEPrimitiveData (7)
Timed: 21/11/08 17:21
1421891mS CD: CALL: 0.1094.0 BState=Connected Cut=3 Music=0.0 Aend="Line 7" (3.9) Bend="Jan(204)" [Jan(204)] (0.0) CalledNum=0630050030 () CallingNum=204 (Jan) Internal=0 Time=34971 AState=Connected
1421929mS CMExtnRx: v=204, p1=0
CMFacility
Line: type= 256 Call: lid=256 id=1099 in=0
IE CMIEPrimitiveData (7)
1421930mS CD: CALL: 0.1094.0 BState=Connected Cut=3 Music=0.0 Aend="Line 7" (3.9) Bend="Jan(204)" [Jan(204)] (0.0) CalledNum=0630050030 () CallingNum=204 (Jan) Internal=0 Time=35011 AState=Connected
1421942mS CMExtnRx: v=204, p1=0
CMFacility
Line: type= 256 Call: lid=256 id=1099 in=0
IE CMIEPrimitiveData (7)
1421944mS CMMap: a=0.1 b=0.0 Mapper::AllocateCodec allocated CMRTVocoder resource busy 1, total 12
1421944mS CMExtnTx: v=204, p1=0
CMFacility
Line: type= 256 Call: lid=256 id=1099 in=0
IE CMIEPrimitiveData (7)
Timed: 21/11/08 17:21
1421945mS CD: CALL: 0.1094.0 BState=Connected Cut=3 Music=0.0 Aend="Line 7" (3.9) Bend="Jan(204)" [Jan(204)] (0.0) CalledNum=0630050030 () CallingNum=204 (Jan) Internal=0 Time=35026 AState=Connected
1421970mS CMExtnRx: v=204, p1=0
CMFacility
Line: type= 256 Call: lid=256 id=1099 in=0
IE CMIEPrimitiveData (7)
1421971mS CMExtnTx: v=204, p1=0
CMFacility
Line: type= 256 Call: lid=256 id=1099 in=0
IE CMIEPrimitiveData (7)
Timed: 21/11/08 17:21
1421972mS CD: CALL: 0.1094.0 BState=Connected Cut=3 Music=0.0 Aend="Line 7" (3.9) Bend="Jan(204)" [Jan(204)] (0.0) CalledNum=0630050030 () CallingNum=204 (Jan) Internal=0 Time=35053 AState=Connected
1422003mS CMExtnRx: v=204, p1=0
CMFacility
Line: type= 256 Call: lid=256 id=1099 in=0
IE CMIEPrimitiveData (7)
1422006mS CD: CALL: 0.1094.0 BState=Connected Cut=3 Music=0.0 Aend="Line 7" (3.9) Bend="Jan(204)" [Jan(204)] (0.0) CalledNum=0630050030 () CallingNum=204 (Jan) Internal=0 Time=35087 AState=Connected
1422007mS CMMap: a=3.9 b=0.0 PCGS CPReserveCodec (pcp[153]b0r1) true
1422007mS CMMap: PCG::MapBChan pcp[153]b0r1 cp_b f5add89c other_cp_b f5a8b6f4 type CGTypeSimple
1422008mS CMMap: a=3.9 b=0.1 M1
1422274mS RES: Fri 21/11/2008 17:21:12 FreeMem=79348464(32) CMMsg=6 (6) Buff=200 960 999 7149 4 Links=20425
1423113mS H323Evt: RTP(50t): 192.168.20.10/49152 192.168.20.202/1090 CODEC 6 PKTSZ=20 RFC2833=off AGE=1106 SENT 50 (avg size=20) RECV 53 (avg size=20)
1427309mS H323Evt: v=0 stacknum=240 State, new=NullState, old=Active id=1099
1427311mS CMExtnTx: v=204, p1=0
CMFacility
Line: type= 256 Call: lid=256 id=1099 in=0
IE CMIEPrimitiveData (7)
Timed: 21/11/08 17:21
1427312mS CMExtnRx: v=204, p1=0
CMReleaseComp
Line: type= 256 Call: lid=256 id=1099 in=0
Cause=16, Normal call clearing
1427314mS CMLOGGING: CALL:2008/11/2117:20,00:00:20,010,201,I,0630050030,,,,,0,,""n/a,0
1427314mS CD: CALL: 0.1094.0 BState=Disconnecting Cut=1 Music=0.0 Aend="Line 7" (3.9) Bend="Jan(204)" [Jan(204)] (0.0) CalledNum=0630050030 () CallingNum=204 (Jan) Internal=0 Time=40395 AState=Connected
1427315mS CD: CALL: 0.1094.0 Deleted
1427316mS CMLineTx: v=7
CMDisconnect
Line: type=Q931Line 7 Call: lid=0 id=1096 in=0
Cause=16, Normal call clearing
1427318mS CMMap: PCG::UnmapBChan pcp[101]b1r0 cp_b f5a8b6f4 other_cp_b f5add89c
1427318mS CMMap: a=0.1 b=3.9 M0
1427319mS CMMap: PCG::UnmapBChan pcp[153]b0r1 cp_b 0 other_cp_b 0
1427319mS H323Evt: RTP(END): 192.168.20.10/49152 192.168.20.202/1090 CODEC 6 PKTSZ=20 RFC2833=off AGE=5312 SENT 259 RECV 262 RTdelay=0 jitter=0 loss=0 remotejitter=0 remoteloss=0
1427319mS CMMap: a=0.1 b=0.0 Mapper::FreeCodec freed CMRTVocoder resource busy 1, total 12
1427774mS RES: Fri 21/11/2008 17:21:18 FreeMem=79365452(34) CMMsg=6 (6) Buff=200 958 1000 7149 4 Links=20482
1428294mS CMLineRx: v=7
CMReleaseComp
Line: type=Q931Line 7 Call: lid=0 id=1096 in=0
BChan: slot=0 chan=1
Cause=16, Normal call clearing
1429317mS CMExtnTx: v=204, p1=0
CMVoiceMailStatus
Line: type= 256 Call: lid=0 id=-1 in=0
Called[Jan Msgs=0 Old=0 Sav=0] Type=Default (100) Reason=CMDRdirect Calling[00000000] Type=Default Plan=Default
Display [Jan Msgs=0]
Timed: 21/11/08 17:21
********** Warning: Logging to Screen Stopped **********