Ok, here goes the results:
When I used a , (comma) this is what I got out of the trace:
UNICODE-UTF8
enu
4200590097mS CMExtnRx: v=RAS, p1=0
CMFacility
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[CLAIM] Type=ACD (103) Reason=CMDRdirect
4200590108mS CD: CALL: 9.20.1 BState=Connected Cut=3 Music=0.0 Aend="Line 9" (5.2) Bend="Confluence Main Route(Confluence Main Route)" [VoiceMail] (21.9) CalledNum=Confluence Main Route () CallingNum=93016703228 (BENCOMM) Internal=0 Time=8169 AState=Connec4200590109mS CMExtnRx: v=RAS, p1=0
4200590109mS CMExtnRx: v=RAS, p1=0
CMFacility
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[CLAIM] Type=ACD (103) Reason=CMDRdirect
4200590109mS CMExtnRx: v=RAS, p1=0
CMTransfer
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[84] Type=Default (100) Reason=CMDRdirect SndComp
4200590109mS CMCallEvt: 0.122583.0 33472 RAS.0: Transfer CMCauseTransfer
4200590110mS CMTARGET: 9.20.1 33472 Q931 Trunk:9 CHAN=1: ADD TARGET (N): number=84 type=100 depth=1 nobar=1 setorig=1 ses=0
4200590110mS CMTARGET: 9.20.1 33472 Q931 Trunk:9 CHAN=1: SET USER: Joe Tenne orig=1
4200590110mS CMTARGET: 9.20.1 33472 Q931 Trunk:9 CHAN=1: ADD USER: Joe Tenne depth=2 disallow_cw=0 dnd=0 real_call=1 type(CMNTypeDefault) incl(0x0) excpt(0x0), allow_redir(1) remote=00000000
4200590111mS CMTARGET: 9.20.1 33472 Q931 Trunk:9 CHAN=1: ADD TARGET (N): number=*671 type=100 depth=3 nobar=1 setorig=0 ses=0
4200590111mS CMTARGET: 9.20.1 33472 Q931 Trunk:9 CHAN=1: SYS SC: *671 4 sc=type=Dial code=*671, num=13018006939,4412 callinfop->sending_complete=1 secondary_dialtone=
4200590112mS CMARS: CMARSHandler::FindActiveARSByGroupID GroupID=1
4200590112mS CMLRQ: CMLRQHandler::FindActiveLRQByGroupID GroupID=1
4200590112mS CMCallEvt: 0.122584.0 -1 BaseEP: NEW CMEndpoint f554b1a0 TOTAL NOW=9 CALL_LIST=4
4200590115mS CMTARGET: DIAL LINE: 33472 GROUP = 1 SUCCESS = f554b1a0
4200590115mS CMTARGET: 9.20.1 33472 Q931 Trunk:9 CHAN=1: PrepareTransferTargets Found 1 target
4200590115mS CMTARGET: 9.20.1 33472 Q931 Trunk:9 CHAN=1: GetNoAnswerTimer:15
4200590116mS CMCallEvt: 0.122585.0 -1 BaseEP: NEW CMEndpoint f550794c TOTAL NOW=10 CALL_LIST=4
4200590117mS CMExtnEvt: RAS: CALL LOST (CMCauseTransfer)
4200590117mS CMCallEvt: 0.122583.0 -1 RAS.0: StateChange: END=X CMCSConnected->CMCSCompleted
4200590117mS CMExtnEvt: v=1008 State, new=CMESCompleted old=Connected,0,0,RAS
4200590118mS CMExtnTx: v=RAS, p1=0
CMReleaseComp
Line: type=RAS 1 Call: lid=0 id=1008 in=0
Called[Confluence Main Route] Type=Voicemail (102) Reason=CMDRX_Attendant Calling[93016703228] Type=Unknown Plan=ISDN Pres=Allowed (0)
BChan: slot=21 chan=9
Cause=126, Transfer(IPO)
4200590118mS CMMap: a=21.9 b=0.0 T0
4200590119mS CMExtnEvt: RAS: CMExtnHandler::SetCurrent( id: 122583->0 )
4200590119mS CMCallEvt: 0.122583.0 -1 RAS.-1: StateChange: END=X CMCSCompleted->CMCSDelete
4200590119mS CMExtnEvt: v=1008 State, new=Idle old=CMESCompleted,0,0,RAS
4200590119mS CMExtnTx: v=RAS, p1=0
CMReleaseComp
Line: type=RAS 1 Call: lid=0 id=1008 in=0
BChan: slot=21 chan=9
Cause=126, Transfer(IPO)
4200590119mS CMCallEvt: 0.122585.0 33472 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
4200590121mS CMCallEvt: 0.122584.0 33472 Q931 Trunk:9 CHAN=20: StateChange: END=T CMCSIdle->CMCSOffering
4200590121mS PRN: Setting configured voice gain for ch 20.
4200590121mS CMLineTx: v=9
CMSetup
Line: type=Q931Line 9 Call: lid=0 id=122584 in=0
Called[13018006939] Type=National (2) Reason=CMDRdirect Calling[] Type=National Plan=ISDN Pres=Allowed (0)
BC: CMTC=3K1Audio CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
BChan: slot=0 chan=20
IE CMIEDIDNumber (245)(P:100 S:100 T:0 N:0 R:4) number=4065
Timed: 27/03/12 14:08
Locale: enu
4200590123mS CMCallEvt: 0.122583.0 -1 BaseEP: DELETE CMEndpoint f55171dc TOTAL NOW=9 CALL_LIST=4
4200590123mS CMMap: PCG::UnmapBChan pcp[41]b1r0 cp_b f59a4554 other_cp_b f5967aa4
4200590123mS CMMap: a=5.2 b=21.9 M0
4200590124mS CMMap: PCG::UnmapBChan pcp[98]b1r0 cp_b f5967aa4 other_cp_b 0
4200590124mS CD: CALL: 9.20.1 BState=Idle Cut=1 Music=0.0 Aend="Line 9" (5.2) Bend="Joe Tenne(84)" [Line 9] (0.0) CalledNum=84 (Joe Tenne) CallingNum=93016703228 (BENCOMM) Internal=0 Time=8185 AState=Connected
4200590126mS ISDNL3Evt: v=9 stacknum=9 State, new=Initiated, old=NullState id=122584
4200590187mS ISDNL3Evt: v=9 stacknum=9 State, new=Proceeding, old=Initiated id=122584
4200590188mS CMLineRx: v=9
CMProceeding
Line: type=Q931Line 9 Call: lid=0 id=122584 in=0
BChan: slot=0 chan=20
4200590188mS CMCallEvt: 0.122584.0 33472 Q931 Trunk:9 CHAN=20: StateChange: END=T CMCSOffering->CMCSAccept
4200590189mS CMCallEvt: 0.122585.0 33472 TargetingEP: StateChange: END=B CMCSOffering->CMCSAccept
4200590189mS CD: CALL: 9.20.1 BState=Ringing Cut=1 Music=0.0 Aend="Line 9" (5.2) Bend="Joe Tenne(84)" [Line 9] (0.0) CalledNum=84 (Joe Tenne) CallingNum=93016703228 (BENCOMM) Internal=0 Time=8250 AState=Connected
4200590368mS CMLineRx: v=9
CMProgress
Line: type=Q931Line 9 Call: lid=0 id=122584 in=0
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLPublicNetLocalUser (2), pd=CMPDNotISDN (1)
Cause=170, Interworking Unspecified(IPO)
4200590369mS CMCallEvt: 0.122584.0 33472 Q931 Trunk:9 CHAN=20: StateChange: END=T CMCSAccept->CMCSRinging
4200590369mS CMCallEvt: 0.122585.0 33472 TargetingEP: StateChange: END=B CMCSAccept->CMCSRinging
4200590370mS CD: CALL: 9.20.1 BState=Ringing Cut=1 Music=2.0 Aend="Line 9" (5.2) Bend="Joe Tenne(84)" [Line 9] (0.0) CalledNum=84 (Joe Tenne) CallingNum=93016703228 (BENCOMM) Internal=0 Time=8431 AState=Connected
4200590371mS CMMap: a=5.2 b=0.0 R1
4200590420mS RES: Tue 27/3/2012 14:08:37 FreeMem=74180656(1) CMMsg=6 (8) Buff=200 965 999 7414 5 Links=12916
4200590420mS RES2: RTEngine=0, CMRTEngine=0, Timer=62, Poll=0, Ready=0, CMReady=0, CMQueue=0, VPNNQueue=0
4200598739mS PRN: ConferDSP is alive
4200605115mS CMTARGET: 9.20.1 33472 Q931 Trunk:9 CHAN=1: TimerExpired cause=CMTCNoAnswerTimeout
4200605115mS CMTARGET: 9.20.1 33472 Q931 Trunk:9 CHAN=1: Retarget NOANSWER EXCEPTED=00000008 ValidTargets=8
4200605115mS CMTARGET: 9.20.1 33472 Q931 Trunk:9 CHAN=1: Retarget on target_cfg_user=Joe Tenne
4200605116mS CMTARGET: 9.20.1 33472 Q931 Trunk:9 CHAN=1: ADD USER: Joe Tenne depth=1 disallow_cw=0 dnd=0 real_call=1 type(CMNTypeDefault) incl(0x8) excpt(0x8), allow_redir(1) remote=00000000
4200605116mS CMTARGET: 9.20.1 33472 Q931 Trunk:9 CHAN=1: SELECT: TRY VOICEMAIL orig_hg() orig_user(84)
4200605116mS CMTARGET: 9.20.1 33472 Q931 Trunk:9 CHAN=1: ADD VM TARGET
4200605116mS CMCallEvt: 0.122586.0 -1 BaseEP: NEW CMEndpoint f55171dc TOTAL NOW=10 CALL_LIST=4
4200605117mS CMTARGET: 0.122586.0 33472 RAS.0: ADD PRIMARY
4200605117mS CMTARGET: 9.20.1 33472 Q931 Trunk:9 CHAN=1: ADD VM TARGET: SUCCEEDED
4200605117mS CMTARGET: 9.20.1 33472 Q931 Trunk:9 CHAN=1: GetNoAnswerTimer:15
4200605118mS CMCallEvt: 0.122586.0 33472 RAS.0: StateChange: END=T CMCSIdle->CMCSOffering
4200605118mS CMExtnEvt: RAS: CMExtnHandler::SetCurrent( id: 0->122586 )
4200605118mS CMExtnTx: v=RAS, p1=0
CMSetup
Line: type=RAS 1 Call: lid=0 id=1008 in=0
Called[#Joe Tenne] Type=Voicemail (102) Reason=CMDRX_MailboxAccess SndComp Calling[93016703228] Type=Unknown Plan=ISDN Pres=Allowed (0)
BC: CMTC=3K1Audio CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
BChan: slot=21 chan=9
IE CMIECalledPartyName (224) Joe Tenne
IE CMIECalledPartyKName (225) Joe Tenne
IE CMIECallingPartyName (110) BENCOMM
IE CMIEIcrPriorityDetail (239) Priority = 1
IE CMIEDIDNumber (245)(P:100 S:100 T:0 N:0 R:4) number=4065
IE CMIEMohSourceId (247) MOH Source = 1
IE CMIEOriginalCalledPartyName (236) Joe Tenne
IE CMIEOriginalCalledPartyKName (237) Joe Tenne
IE CMIEOriginalCalledPartyNumber (238)(P:100 S:100 T:101 N:100 R:3) number=84
IE CMIERedirectingPartyName (232) Joe Tenne
IE CMIERedirectingPartyKName (233) Joe Tenne
IE CMIERedirectingPartyNumber (234)(P:100 S:100 T:101 N:100 R:3) number=84
IE CMIERespondingPartyName (228) BENCOMM
IE CMIERespondingPartyNumber (230)(P:0 S:0 T:0 N:1 R:4) number=93016703228
IE CMIEDeviceDetail (231) LOCALE=enu HW=8 VER=4 class=CMDeviceISDNTrunk type=2 number=9 channel=1 rx_gain=32 tx_gain=32 ep_callid=122581 ipaddr=192.168.0.221 apps=0
Display [BENCOMM>Joe Tenne]
Timed: 27/03/12 14:08
Locale: enu
4200605119mS CMMap: a=21.9 b=1.254 T
4200605120mS CMExtnRx: v=RAS, p1=0
CMConnect
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
IE CMIERespondingPartyName (228) #Joe Tenne
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:102 N:100 R:4) number=
IE CMIEDeviceDetail (231) LOCALE=enu HW=8 VER=4 class=CMDeviceVoicemail type=0 number=0 channel=9 rx_gain=32 tx_gain=32 ep_callid=122586 ipaddr=192.168.0.221 apps=0
IE CMIERedirectingPartyName (232) Joe Tenne
IE CMIERedirectingPartyKName (233) Joe Tenne
IE CMIERedirectingPartyNumber (234)(P:100 S:100 T:101 N:100 R:3) number=84
4200605120mS CMCallEvt: 0.122586.0 33472 RAS.0: StateChange: END=T CMCSOffering->CMCSConnReq
4200605120mS CMCallEvt: 0.122585.0 33472 TargetingEP: RequestEnd 0.122586.0 33472 RAS.0
4200605120mS CMTARGET: 9.20.1 33472 Q931 Trunk:9 CHAN=1: CancelTimer CMTCNoAnswerTimeout
4200605123mS CMLineTx: v=9
CMDisconnect
Line: type=Q931Line 9 Call: lid=0 id=122584 in=0
Cause=123, Forward To Voicemail(IPO)
4200605123mS CMCallEvt: 0.122584.0 -1 Q931 Trunk:9 CHAN=20: StateChange: END=X CMCSRinging->CMCSCompleted
4200605124mS CMExtnEvt: v=1008 State, new=Connected old=Idle,0,0,RAS
4200605124mS CMCallEvt: 0.122586.0 33472 RAS.0: StateChange: END=B CMCSConnReq->CMCSConnected
4200605124mS CMTARGET: 9.20.1 33472 Q931 Trunk:9 CHAN=1: ~CMTargetHandler
4200605125mS CMExtnTx: v=RAS, p1=0
CMConnectAck
Line: type=RAS 1 Call: lid=0 id=1008 in=0
BChan: slot=21 chan=9
IE CMIERespondingPartyName (228) BENCOMM
IE CMIERespondingPartyNumber (230)(P:0 S:0 T:0 N:1 R:4) number=93016703228
IE CMIEDeviceDetail (231) LOCALE=enu HW=8 VER=4 class=CMDeviceISDNTrunk type=2 number=9 channel=1 rx_gain=32 tx_gain=32 ep_callid=122581 ipaddr=192.168.0.221 apps=0
IE CMIERedirectingPartyName (232) Joe Tenne
IE CMIERedirectingPartyKName (233) Joe Tenne
IE CMIERedirectingPartyNumber (234)(P:100 S:100 T:101 N:100 R:3) number=84
4200605126mS CMCallEvt: 0.122585.0 -1 BaseEP: DELETE CMEndpoint f550794c TOTAL NOW=9 CALL_LIST=4
4200605126mS CD: CALL: 9.20.1 BState=Connected Cut=3 Music=0.0 Aend="Line 9" (5.2) Bend="Joe Tenne(84)" [VoiceMail] (21.9) CalledNum=#Joe Tenne (Joe Tenne) CallingNum=93016703228 (BENCOMM) Internal=0 Time=23187 AState=Connected
4200605127mS CMMap: a=5.2 b=0.0 R0
4200605128mS CMMap: PCG::MapBChan pcp[98]b1r0 cp_b f5967aa4 other_cp_b 0 type CGTypeSimple
4200605128mS CMMap: PCG::MapBChan pcp[41]b1r0 cp_b f59a4554 other_cp_b f5967aa4 type CGTypeSimple
4200605128mS CMMap: a=5.2 b=21.9 M1
4200605129mS ISDNL3Evt: v=9 stacknum=9 State, new=DiscReq, old=Proceeding id=122584
4200605153mS ISDNL3Evt: v=9 stacknum=9 State, new=NullState, old=DiscReq id=122584
4200605154mS CMLineRx: v=9
CMReleaseComp
Line: type=Q931Line 9 Call: lid=0 id=122584 in=0
BChan: slot=0 chan=20
4200605154mS CMCallEvt: 0.122584.0 -1 Q931 Trunk:9 CHAN=20: StateChange: END=X CMCSCompleted->CMCSDelete
4200605155mS CMCallEvt: 0.122584.0 -1 BaseEP: DELETE CMEndpoint f554b1a0 TOTAL NOW=8 CALL_LIST=4
4200605420mS RES: Tue 27/3/2012 14:08:52 FreeMem=74187772(1) CMMsg=6 (8) Buff=200 965 999 7407 5 Links=12909
4200605420mS RES2: RTEngine=0, CMRTEngine=0, Timer=60, Poll=0, Ready=0, CMReady=0, CMQueue=0, VPNNQueue=0
4200609682mS ISDNL3Evt: v=9 stacknum=9 State, new=ReleaseReq, old=Active id=20
4200609702mS ISDNL3Evt: v=9 stacknum=9 State, new=NullState, old=ReleaseReq id=20
4200609703mS CMLineRx: v=9
CMReleaseComp
Line: type=Q931Line 9 Call: lid=9 id=20 in=1
BChan: slot=0 chan=1
Cause=16, Normal call clearing
4200609703mS CMCallEvt: 9.20.1 33472 Q931 Trunk:9 CHAN=1: StateChange: END=A CMCSConnected->CMCSCompleted
4200609706mS CMLOGGING: CALL:2012/03/2714:08,00:00:27,014,93016703228,I,84,4065,BENCOMM,,,0,,""n/a,0
4200609706mS CD: CALL: 9.20.1 BState=Connected Cut=2 Music=0.0 Aend="Line 9" (5.2) Bend="Joe Tenne(84)" [VoiceMail] (21.9) CalledNum=#Joe Tenne (Joe Tenne) CallingNum=93016703228 (BENCOMM) Internal=0 Time=27767 AState=Idle
4200609706mS CD: CALL: 9.20.1 Deleted
4200609706mS CMCallEvt: 9.20.1 -1 Q931 Trunk:9 CHAN=1: StateChange: END=X CMCSCompleted->CMCSDelete
4200609707mS CMExtnEvt: RAS: CALL LOST (CMCauseNormal)
4200609707mS CMCallEvt: 0.122586.0 -1 RAS.0: StateChange: END=X CMCSConnected->CMCSCompleted
4200609707mS CMExtnEvt: v=1008 State, new=CMESCompleted old=Connected,0,0,RAS
4200609708mS CMExtnTx: v=RAS, p1=0
CMReleaseComp
Line: type=RAS 1 Call: lid=0 id=1008 in=0
Called[#Joe Tenne] Type=Voicemail (102) Reason=CMDRX_MailboxAccess Calling[93016703228] Type=Unknown Plan=ISDN Pres=Allowed (0)
BChan: slot=21 chan=9
Cause=16, Normal call clearing
4200609708mS CMMap: a=21.9 b=0.0 T0
4200609709mS CMExtnEvt: RAS: CMExtnHandler::SetCurrent( id: 122586->0 )
4200609709mS CMCallEvt: 0.122586.0 -1 RAS.-1: StateChange: END=X CMCSCompleted->CMCSDelete
4200609709mS CMExtnEvt: v=1008 State, new=Idle old=CMESCompleted,0,0,RAS
4200609709mS CMCallEvt: 0.122586.0 -1 BaseEP: DELETE CMEndpoint f55171dc TOTAL NOW=7 CALL_LIST=3
4200609710mS CMExtnTx: v=RAS, p1=0
CMReleaseComp
Line: type=RAS 1 Call: lid=0 id=1008 in=0
BChan: slot=21 chan=9
Cause=16, Normal call clearing
4200609710mS CMCallEvt: END CALL:33472 (f5578370)
4200609711mS CMCallEvt: 9.20.1 -1 BaseEP: DELETE CMEndpoint f557bf90 TOTAL NOW=6 CALL_LIST=3
4200609712mS CMMap: PCG::UnmapBChan pcp[41]b1r0 cp_b f59a4554 other_cp_b f5967aa4
4200609712mS CMMap: a=5.2 b=21.9 M0
4200609712mS CMMap: PCG::UnmapBChan pcp[98]b1r0 cp_b f5967aa4 other_cp_b 0
4200609734mS CMExtnTx: v=84, p1=0
CMVoiceMailStatus
Line: type=DigitalExtn 7 Call: lid=0 id=-1 in=0
Called[Joe Tenne Msgs=0 Old=3 Sav=0] Type=Default (100) Reason=CMDRdirect Calling[00000000] Type=Default Plan=Default
Display [Joe Tenne Msgs=0]
Timed: 27/03/12 14:08
********** Warning: Logging to Screen Stopped **********
I then used a Y in the short code and received this trace:
UNICODE-UTF8
enu
4200757344mS CMExtnRx: v=RAS, p1=0
CMFacility
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[CLAIM] Type=ACD (103) Reason=CMDRdirect
4200757354mS CD: CALL: 9.9.1 BState=Connected Cut=3 Music=0.0 Aend="Line 9" (5.2) Bend="Confluence Main Route(Confluence Main Route)" [VoiceMail] (21.9) CalledNum=Confluence Main Route () CallingNum=93016703228 (BENCOMM) Internal=0 Time=6537 AState=Connect4200757355mS CMExtnRx: v=RAS, p1=0
4200757355mS CMExtnRx: v=RAS, p1=0
CMFacility
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[CLAIM] Type=ACD (103) Reason=CMDRdirect
4200757356mS CMExtnRx: v=RAS, p1=0
CMTransfer
Line: type=NoLine 0 Call: lid=0 id=-1 in=0
Called[84] Type=Default (100) Reason=CMDRdirect SndComp
4200757356mS CMCallEvt: 0.122589.0 33473 RAS.0: Transfer CMCauseTransfer
4200757356mS CMTARGET: 9.9.1 33473 Q931 Trunk:9 CHAN=1: ADD TARGET (N): number=84 type=100 depth=1 nobar=1 setorig=1 ses=0
4200757356mS CMTARGET: 9.9.1 33473 Q931 Trunk:9 CHAN=1: SET USER: Joe Tenne orig=1
4200757357mS CMTARGET: 9.9.1 33473 Q931 Trunk:9 CHAN=1: ADD USER: Joe Tenne depth=2 disallow_cw=0 dnd=0 real_call=1 type(CMNTypeDefault) incl(0x0) excpt(0x0), allow_redir(1) remote=00000000
4200757357mS CMTARGET: 9.9.1 33473 Q931 Trunk:9 CHAN=1: ADD TARGET (N): number=*671 type=100 depth=3 nobar=1 setorig=0 ses=0
4200757357mS CMTARGET: 9.9.1 33473 Q931 Trunk:9 CHAN=1: SYS SC: *671 4 sc=type=Dial code=*671, num=13018006939Y4412 callinfop->sending_complete=1 secondary_dialtone=
4200757358mS CMARS: CMARSHandler::FindActiveARSByGroupID GroupID=1
4200757358mS CMLRQ: CMLRQHandler::FindActiveLRQByGroupID GroupID=1
4200757358mS CMCallEvt: 0.122590.0 -1 BaseEP: NEW CMEndpoint f554b1a0 TOTAL NOW=9 CALL_LIST=4
4200757360mS CMTARGET: DIAL LINE: 33473 GROUP = 1 SUCCESS = f554b1a0
4200757360mS CMTARGET: 9.9.1 33473 Q931 Trunk:9 CHAN=1: PrepareTransferTargets Found 1 target
4200757360mS CMTARGET: 9.9.1 33473 Q931 Trunk:9 CHAN=1: GetNoAnswerTimer:15
4200757361mS CMCallEvt: 0.122591.0 -1 BaseEP: NEW CMEndpoint f550794c TOTAL NOW=10 CALL_LIST=4
4200757361mS CMExtnEvt: RAS: CALL LOST (CMCauseTransfer)
4200757361mS CMCallEvt: 0.122589.0 -1 RAS.0: StateChange: END=X CMCSConnected->CMCSCompleted
4200757362mS CMExtnEvt: v=1008 State, new=CMESCompleted old=Connected,0,0,RAS
4200757362mS CMExtnTx: v=RAS, p1=0
CMReleaseComp
Line: type=RAS 1 Call: lid=0 id=1008 in=0
Called[Confluence Main Route] Type=Voicemail (102) Reason=CMDRX_Attendant Calling[93016703228] Type=Unknown Plan=ISDN Pres=Allowed (0)
BChan: slot=21 chan=9
Cause=126, Transfer(IPO)
4200757362mS CMMap: a=21.9 b=0.0 T0
4200757363mS CMExtnEvt: RAS: CMExtnHandler::SetCurrent( id: 122589->0 )
4200757363mS CMCallEvt: 0.122589.0 -1 RAS.-1: StateChange: END=X CMCSCompleted->CMCSDelete
4200757363mS CMExtnEvt: v=1008 State, new=Idle old=CMESCompleted,0,0,RAS
4200757364mS CMExtnTx: v=RAS, p1=0
CMReleaseComp
Line: type=RAS 1 Call: lid=0 id=1008 in=0
BChan: slot=21 chan=9
Cause=126, Transfer(IPO)
4200757364mS CMCallEvt: 0.122591.0 33473 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
4200757365mS CMCallEvt: 0.122590.0 33473 Q931 Trunk:9 CHAN=20: StateChange: END=T CMCSIdle->CMCSOffering
4200757365mS PRN: Setting configured voice gain for ch 20.
4200757365mS CMLineTx: v=9
CMSetup
Line: type=Q931Line 9 Call: lid=0 id=122590 in=0
Called[13018006939] Type=National (2) Reason=CMDRdirect Calling[] Type=National Plan=ISDN Pres=Allowed (0)
BC: CMTC=3K1Audio CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
BChan: slot=0 chan=20
IE CMIEDIDNumber (245)(P:100 S:100 T:0 N:0 R:4) number=4065
Timed: 27/03/12 14:11
Locale: enu
4200757366mS CMCallEvt: 0.122589.0 -1 BaseEP: DELETE CMEndpoint f55171dc TOTAL NOW=9 CALL_LIST=4
4200757367mS CMMap: PCG::UnmapBChan pcp[41]b1r0 cp_b f59a4554 other_cp_b f5967aa4
4200757367mS CMMap: a=5.2 b=21.9 M0
4200757367mS CMMap: PCG::UnmapBChan pcp[98]b1r0 cp_b f5967aa4 other_cp_b 0
4200757368mS CD: CALL: 9.9.1 BState=Idle Cut=1 Music=0.0 Aend="Line 9" (5.2) Bend="Joe Tenne(84)" [Line 9] (0.0) CalledNum=84 (Joe Tenne) CallingNum=93016703228 (BENCOMM) Internal=0 Time=6551 AState=Connected
4200757369mS ISDNL3Evt: v=9 stacknum=9 State, new=Initiated, old=NullState id=122590
4200757420mS RES: Tue 27/3/2012 14:11:24 FreeMem=74186476(1) CMMsg=6 (8) Buff=200 964 1000 7414 5 Links=12921
4200757420mS RES2: RTEngine=0, CMRTEngine=0, Timer=62, Poll=0, Ready=0, CMReady=0, CMQueue=0, VPNNQueue=0
4200757426mS ISDNL3Evt: v=9 stacknum=9 State, new=Proceeding, old=Initiated id=122590
4200757427mS CMLineRx: v=9
CMProceeding
Line: type=Q931Line 9 Call: lid=0 id=122590 in=0
BChan: slot=0 chan=20
4200757427mS CMCallEvt: 0.122591.0 33473 TargetingEP: RequestEnd 0.122590.0 33473 Q931 Trunk:9 CHAN=20
4200757427mS CMTARGET: 9.9.1 33473 Q931 Trunk:9 CHAN=1: CancelTimer CMTCNoAnswerTimeout
4200757428mS CMCallEvt: 0.122591.0 -1 BaseEP: DELETE CMEndpoint f550794c TOTAL NOW=8 CALL_LIST=4
4200757428mS CMCallEvt: 0.122590.0 33473 Q931 Trunk:9 CHAN=20: StateChange: END=B CMCSOffering->CMCSAccept
4200757429mS CD: CALL: 9.9.1 BState=Ringing Cut=3 Music=0.0 Aend="Line 9" (5.2) Bend="Joe Tenne(84)" [Line 9] (5.21) CalledNum=13018006939 (Joe Tenne) CallingNum=93016703228 (BENCOMM) Internal=0 Time=6612 AState=Connected
4200757430mS CMMap: PCG::MapBChan pcp[98]b1r0 cp_b f5967aa4 other_cp_b 0 type CGTypeSimple
4200757430mS CMMap: PCG::MapBChan pcp[117]b1r0 cp_b f59663c8 other_cp_b f5967aa4 type CGTypeSimple
4200757430mS CMMap: a=5.2 b=5.21 M1
4200757430mS CMMap: a=21.7 b=0.0 DTMF::AllocateRAS allocated CMRTTonegen resource busy 5, total 8
4200757431mS CMMap: a=21.7 b=1.255 T
4200757431mS CMMap: PCG::UnmapBChan pcp[117]b1r0 cp_b f59663c8 other_cp_b f5967aa4
4200757431mS CMMap: a=5.2 b=5.21 M0
4200757431mS CMMap: PCG::MapBChan pcp[117]b1r0 cp_b f59663c8 other_cp_b f59a5cb4 type CGTypeDTMF
4200757431mS CMMap: a=21.7 b=5.21 M2
4200757431mS CMMap: DTMF:

layTones g T[243] 4412
4200757432mS CMMap: Started playing tones, cp[117]b1r0 (from g G[242])
4200757432mS CMMap: cp[117]b1r0 SetOperGroup from g G[242] to g G[242] not executed, playing tones in progress 4412
4200757509mS PRN: ConferDSP is alive
4200757607mS CMLineRx: v=9
CMProgress
Line: type=Q931Line 9 Call: lid=0 id=122590 in=0
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLPublicNetLocalUser (2), pd=CMPDNotISDN (1)
Cause=170, Interworking Unspecified(IPO)
4200757607mS CMCallEvt: 0.122590.0 33473 Q931 Trunk:9 CHAN=20: StateChange: END=B CMCSAccept->CMCSRinging
4200757608mS CD: CALL: 9.9.1 BState=Ringing Cut=3 Music=0.0 Aend="Line 9" (5.2) Bend="Joe Tenne(84)" [Line 9] (5.21) CalledNum=13018006939 (Joe Tenne) CallingNum=93016703228 (BENCOMM) Internal=0 Time=6791 AState=Connected
4200757992mS CMMap: PCG::UnmapBChan pcp[117]b1r0 cp_b f59663c8 other_cp_b f59a5cb4
4200757992mS CMMap: a=21.7 b=5.21 M0
4200757992mS CMMap: a=21.7 b=0.0 T0
4200757992mS CMMap: a=21.7 b=0.0 DTMF::~DTMF freed CMRTTonegen resource busy 4, total 8
4200757993mS CMMap: PCG::MapBChan pcp[117]b1r0 cp_b f59663c8 other_cp_b f5967aa4 type CGTypeSimple
4200757993mS CMMap: a=5.2 b=5.21 M1
********** Warning: Logging to Screen Stopped **********