In fact following the logs:
16:52:31.398 Int 04543 Interaction message "RequestRouteCall" received from 484 ("UniversalRoutingServer")
Trying to reserve dn: <299109> agent: <299109> place: <S99_Place_299109> duration: 15000
Reservation request taken from client 0x00000005(UniversalRoutingServer)
@16:52:31.3980 [gctmi] Distributing request RequestUpdateUserData
@16:52:31.3980 [tout] Call [019901b45634d009/40013e4,sOG,tOG,l2] (reqChangeUserData)
@16:52:31.3980 [gctmi] request RequestUpdateUserData removed from reqMgr
@16:52:31.3980 [gctm] Sending queued request RequestUpdateUserData
@16:52:31.3980 [gctmi] Distributing request RequestUpdateUserData
@16:52:31.3980 [tout] Call [019901b45634d009/40013e4,sOG,tOG,l2] (reqChangeUserData)
@16:52:31.3980 [gctmi] request RequestUpdateUserData removed from reqMgr
Agent reservation: have 1 requests with priority [0, 0, 0, 0]
Reservation granted to client 0x00000005
@16:52:31.5070 [0] 7.6.007.01 distribute_event_except_one: message EventAgentReserved
AttributeTimeinuSecs 507000
AttributeTimeinSecs 1246546351 (16:52:31)
AttributeReason [14] 00 01 01 00..
'RTR' 110
AttributeThisDN '299109'
AttributeAgentID '299109'
AttributePlace 'S99_Place_299109'
AttributeTimeout 15000
AttributeEventSequenceNumber 00000000000001c9
@16:52:31.5070 [ISCC] Translate: '' -> ''; result 1 ()
16:52:31.507 Trc 04542 EventAgentReserved sent to [368] (0000000b StatServer_CCP 10.110.130.201:3167)
16:52:31.507 Trc 04542 EventAgentReserved sent to [508] (0000000a - SPv7203ST 10.110.153.82:2367)
16:52:31.507 Trc 04542 EventAgentReserved sent to [520] (00000008 StatServer_CCA 10.110.130.203:4224)
16:52:31.507 Trc 04542 EventAgentReserved sent to [392] (00000002 StatServer_GIS 10.110.130.203:4223)
16:52:31.507 Trc 04542 EventAgentReserved sent to [472] (00000004 StatServer_URS 10.110.130.202:4253)
@16:52:31.5070 [gctmi] Distributing request RequestRouteCall
@16:52:31.5070 [tout] Party [019901b45634d009:299748,s800,tRP,rDST,lINT] (reqRouteCall)
@16:52:31.5070 [tout] CcmRouteParty(299748:019901b45634d009) try routing call to 299109, _state:IDLE
@16:52:31.5070 [sm] CcmRouteParty::set_state: IDLE --> REDIRECTING
@16:52:31.5070 [tout] Routing call NOW to 299109, _state:REDIRECTING
@16:52:31.5070 [))1] Redirect 67113956 '299748' '299109' 1 2 0 ''
@16:52:31.5070 [((1] 1 105 S 9 'JSend>> redirect for party 299748:67113956. dest-opts:299109 - mode:1 css:2 cao:0 origCalledParty:'
@16:52:31.5070 [((1] 1 53 S 9 'getConnection for CallID:67113956 Party:299748'
@16:52:31.5070 [((1] 1 33 S 9 'ConnectionCallID: 67113956'
@16:52:31.5230 [((1] 1 178 S 9 'CallEv(0)=> Type=ConnCreatedEvent Cause=CAUSE_NORMAL CiscoCause=CAUSE_NOERROR Cid=67113956 MetaCode(true)=META_CALL_ADDITIONAL_PARTY Addr=299109 ConnReason=REASON_REDIRECT'
@16:52:31.5230 [((1] 1 14 I 32 67113956
@16:52:31.5230 [tout] Collected jtapi[1] tevent(20:CREATE_CALL)(

(40013e4:0) (:0).
@16:52:31.5230 [((1] 1 140 S 9 'CallEv(5)=> Type=CallActiveEvent Cause=CAUSE_NORMAL CiscoCause=CAUSE_NORMALUNSPECIFIED Cid=67113956 MetaCode(true)=META_CALL_STARTING'
@16:52:31.5230 [((1] 1 178 S 9 'CallEv(6)=> Type=ConnCreatedEvent Cause=CAUSE_NORMAL CiscoCause=CAUSE_NOERROR Cid=67113956 MetaCode(true)=META_CALL_ADDITIONAL_PARTY Addr=299109 ConnReason=REASON_REDIRECT'
@16:52:31.5230 [((1] 1 14 I 32 67113956
@16:52:31.5230 [tout] Collected jtapi[1] tevent(20:CREATE_CALL)(

(40013e4:0) (:0).
@16:52:31.5230 [((1] 1 155 S 9 'CallEv(0)=> Type=ConnInprogressEvent Cause=CAUSE_NORMAL CiscoCause=CAUSE_NOERROR Cid=67113956 MetaCode(false)=META_CALL_ADDITIONAL_PARTY Addr=299109'
@16:52:31.5230 [((1] 1 183 S 9 'CallEv(5)=> Type=ConnCreatedEvent Cause=CAUSE_NORMAL CiscoCause=CAUSE_NORMALUNSPECIFIED Cid=67113956 MetaCode(false)=META_CALL_STARTING Addr=299107 ConnReason=REASON_DIRECTCALL'
@16:52:31.5230 [((1] 1 14 I 32 67113956
@16:52:31.5230 [tout] Collected jtapi[1] tevent(20:CREATE_CALL)(

(40013e4:0) (:0).
@16:52:31.5230 [((1] 1 155 S 9 'CallEv(6)=> Type=ConnInprogressEvent Cause=CAUSE_NORMAL CiscoCause=CAUSE_NOERROR Cid=67113956 MetaCode(false)=META_CALL_ADDITIONAL_PARTY Addr=299109'
@16:52:31.5230 [((1] 1 160 S 9 'CallEv(0)=> Type=CallCtlConnOfferedEv Cause=CAUSE_REDIRECTED CiscoCause=CAUSE_NOERROR Cid=67113956 MetaCode(false)=META_CALL_ADDITIONAL_PARTY Addr=299109'
@16:52:31.5230 [((1] 1 156 S 9 'CallEv(5)=> Type=ConnConnectedEvent Cause=CAUSE_NORMAL CiscoCause=CAUSE_NORMALUNSPECIFIED Cid=67113956 MetaCode(false)=META_CALL_STARTING Addr=299107'
@16:52:31.5230 [((1] 1 160 S 9 'CallEv(6)=> Type=CallCtlConnOfferedEv Cause=CAUSE_REDIRECTED CiscoCause=CAUSE_NOERROR Cid=67113956 MetaCode(false)=META_CALL_ADDITIONAL_PARTY Addr=299109'
@16:52:31.5230 [((1] 1 162 S 9 'CallEv(5)=> Type=CallCtlConnEstablishedEv Cause=CAUSE_NORMAL CiscoCause=CAUSE_NORMALUNSPECIFIED Cid=67113956 MetaCode(false)=META_CALL_STARTING Addr=299107'
@16:52:31.5230 [((1] 1 179 S 9 'CallEv(5)=> Type=TermConnCreatedEvent Cause=CAUSE_NORMAL CiscoCause=CAUSE_NORMALUNSPECIFIED Cid=67113956 MetaCode(false)=META_CALL_STARTING Addr=299107 Term=SEP001DA2F3E526'
@16:52:31.5230 [((1] 1 178 S 9 'CallEv(5)=> Type=TermConnActiveEvent Cause=CAUSE_NORMAL CiscoCause=CAUSE_NORMALUNSPECIFIED Cid=67113956 MetaCode(false)=META_CALL_STARTING Addr=299107 Term=SEP001DA2F3E526'
@16:52:31.5230 [((1] 1 183 S 9 'CallEv(5)=> Type=CallCtlTermConnTalkingEv Cause=CAUSE_NORMAL CiscoCause=CAUSE_NORMALUNSPECIFIED Cid=67113956 MetaCode(false)=META_CALL_STARTING Addr=299107 Term=SEP001DA2F3E526'
@16:52:31.5230 [((1] 1 181 S 9 'CallEv(5)=> Type=ConnCreatedEvent Cause=CAUSE_NORMAL CiscoCause=CAUSE_NORMALUNSPECIFIED Cid=67113956 MetaCode(false)=META_CALL_STARTING Addr=299109 ConnReason=REASON_OUTBOUND'
@16:52:31.5230 [((1] 1 14 I 32 67113956
@16:52:31.5230 [tout] Collected jtapi[1] tevent(20:CREATE_CALL)(

(40013e4:0) (:0).
@16:52:31.5230 [((1] 1 157 S 9 'CallEv(5)=> Type=ConnInprogressEvent Cause=CAUSE_NORMAL CiscoCause=CAUSE_NORMALUNSPECIFIED Cid=67113956 MetaCode(false)=META_CALL_STARTING Addr=299109'
@16:52:31.5230 [((1] 1 158 S 9 'CallEv(5)=> Type=CallCtlConnOfferedEv Cause=CAUSE_NORMAL CiscoCause=CAUSE_NORMALUNSPECIFIED Cid=67113956 MetaCode(false)=META_CALL_STARTING Addr=299109'
@16:52:31.5230 [((1] 1 24 IS 29 67113956 '299109'
@16:52:31.5230 [tout] Collected jtapi[1] tevent(1d:OFFERED)(299109:) (40013e4:0) (:0).
@16:52:31.5230 [((1] 1 183 S 9 'CallEv(5)=> Type=ConnCreatedEvent Cause=CAUSE_NORMAL CiscoCause=CAUSE_NORMALUNSPECIFIED Cid=67113956 MetaCode(false)=META_CALL_STARTING Addr=299748 ConnReason=REASON_FORWARDALL'
@16:52:31.5230 [((1] 1 14 I 32 67113956
@16:52:31.5230 [tout] Collected jtapi[1] tevent(20:CREATE_CALL)(

(40013e4:0) (:0).
@16:52:31.5230 [((1] 1 157 S 9 'CallEv(5)=> Type=ConnInprogressEvent Cause=CAUSE_NORMAL CiscoCause=CAUSE_NORMALUNSPECIFIED Cid=67113956 MetaCode(false)=META_CALL_STARTING Addr=299748'
@16:52:31.5230 [((1] 1 158 S 9 'CallEv(5)=> Type=CallCtlConnOfferedEv Cause=CAUSE_NORMAL CiscoCause=CAUSE_NORMALUNSPECIFIED Cid=67113956 MetaCode(false)=META_CALL_STARTING Addr=299748'
@16:52:31.5230 [((1] 1 181 S 9 'CallEv(5)=> Type=ConnCreatedEvent Cause=CAUSE_NORMAL CiscoCause=CAUSE_NORMALUNSPECIFIED Cid=67113956 MetaCode(false)=META_CALL_STARTING Addr=299109 ConnReason=REASON_REDIRECT'
@16:52:31.5230 [((1] 1 14 I 32 67113956
@16:52:31.5230 [tout] Collected jtapi[1] tevent(20:CREATE_CALL)(

(40013e4:0) (:0).
@16:52:31.5230 [((1] 1 157 S 9 'CallEv(5)=> Type=ConnInprogressEvent Cause=CAUSE_NORMAL CiscoCause=CAUSE_NORMALUNSPECIFIED Cid=67113956 MetaCode(false)=META_CALL_STARTING Addr=299109'
@16:52:31.5230 [((1] 1 158 S 9 'CallEv(5)=> Type=CallCtlConnOfferedEv Cause=CAUSE_NORMAL CiscoCause=CAUSE_NORMALUNSPECIFIED Cid=67113956 MetaCode(false)=META_CALL_STARTING Addr=299109'
@16:52:31.5230 [((1] 1 24 IS 29 67113956 '299109'
@16:52:31.5230 [tout] Collected jtapi[1] tevent(1d:OFFERED)(299109:) (40013e4:0) (:0).
@16:52:31.5540 [((1] 1 144 S 9 'CallEv(0)=> Type=ConnAlertingEvent Cause=CAUSE_NORMAL CiscoCause=CAUSE_NOERROR Cid=67113956 MetaCode(true)=META_CALL_PROGRESS Addr=299109'
@16:52:31.5540 [((1] 1 144 S 9 'CallEv(5)=> Type=ConnAlertingEvent Cause=CAUSE_NORMAL CiscoCause=CAUSE_NOERROR Cid=67113956 MetaCode(true)=META_CALL_PROGRESS Addr=299109'
@16:52:31.5540 [((1] 1 144 S 9 'CallEv(6)=> Type=ConnAlertingEvent Cause=CAUSE_NORMAL CiscoCause=CAUSE_NOERROR Cid=67113956 MetaCode(true)=META_CALL_PROGRESS Addr=299109'
@16:52:31.5540 [((1] 1 149 S 9 'CallEv(0)=> Type=CallCtlConnAlertingEv Cause=CAUSE_NORMAL CiscoCause=CAUSE_NOERROR Cid=67113956 MetaCode(false)=META_CALL_PROGRESS Addr=299109'
@16:52:31.5540 [((1] 1 149 S 9 'CallEv(5)=> Type=CallCtlConnAlertingEv Cause=CAUSE_NORMAL CiscoCause=CAUSE_NOERROR Cid=67113956 MetaCode(false)=META_CALL_PROGRESS Addr=299109'
@16:52:31.5540 [((1] 1 149 S 9 'CallEv(6)=> Type=CallCtlConnAlertingEv Cause=CAUSE_NORMAL CiscoCause=CAUSE_NOERROR Cid=67113956 MetaCode(false)=META_CALL_PROGRESS Addr=299109'
@16:52:31.5540 [((1] 1 175 S 9 'CallEv(0)=> Type=TermConnCreatedEvent Cause=Other: 0 CiscoCause=CAUSE_INVALIDIECONTENTS Cid=67113956 MetaCode(false)=META_CALL_PROGRESS Addr=299109 Term=SEP001F6C7F5233'
@16:52:31.5540 [((1] 1 175 S 9 'CallEv(5)=> Type=TermConnCreatedEvent Cause=Other: 0 CiscoCause=CAUSE_INVALIDIECONTENTS Cid=67113956 MetaCode(false)=META_CALL_PROGRESS Addr=299109 Term=SEP001F6C7F5233'
@16:52:31.5540 [((1] 1 175 S 9 'CallEv(6)=> Type=TermConnCreatedEvent Cause=Other: 0 CiscoCause=CAUSE_INVALIDIECONTENTS Cid=67113956 MetaCode(false)=META_CALL_PROGRESS Addr=299109 Term=SEP001F6C7F5233'
@16:52:31.5540 [((1] 1 169 S 9 'CallEv(0)=> Type=TermConnRingingEvent Cause=CAUSE_NORMAL CiscoCause=CAUSE_NOERROR Cid=67113956 MetaCode(false)=META_CALL_PROGRESS Addr=299109 Term=SEP001F6C7F5233'
@16:52:31.5540 [((1] 1 169 S 9 'CallEv(5)=> Type=TermConnRingingEvent Cause=CAUSE_NORMAL CiscoCause=CAUSE_NOERROR Cid=67113956 MetaCode(false)=META_CALL_PROGRESS Addr=299109 Term=SEP001F6C7F5233'
@16:52:31.5540 [((1] 1 169 S 9 'CallEv(6)=> Type=TermConnRingingEvent Cause=CAUSE_NORMAL CiscoCause=CAUSE_NOERROR Cid=67113956 MetaCode(false)=META_CALL_PROGRESS Addr=299109 Term=SEP001F6C7F5233'
@16:52:31.5540 [((1] 1 173 S 9 'CallEv(0)=> Type=CallCtlTermConnRingingEv Cause=CAUSE_NORMAL CiscoCause=CAUSE_NOERROR Cid=67113956 MetaCode(false)=META_CALL_PROGRESS Addr=299109 Term=SEP001F6C7F5233'
@16:52:31.5540 [((1] 1 173 S 9 'CallEv(5)=> Type=CallCtlTermConnRingingEv Cause=CAUSE_NORMAL CiscoCause=CAUSE_NOERROR Cid=67113956 MetaCode(false)=META_CALL_PROGRESS Addr=299109 Term=SEP001F6C7F5233'
@16:52:31.5540 [((1] 1 81 ISISIS 3 67113956 '299109@SEP001F6C7F5233' 1 '299107@SEP001DA2F3E526' 0 '299109'
@16:52:31.5540 [tout] Collected jtapi[1] tevent(3:RINGING)(299109@SEP001F6C7F5233:299107@SEP001DA2F3E526) (40013e4:1) (299109:0).
@16:52:31.5540 [tout] CcmSharedAddressResolver: Resolved 299109@SEP001F6C7F5233 -> 299109 [Single in CME]
@16:52:31.5540 [tout] CcmSharedAddressResolver: Resolved 299107@SEP001DA2F3E526 -> 299107 [Single in CME]
@16:52:31.5540 [gctmi] TMsg [EventRinging(299109)] distributing to model
@16:52:31.5540 [gctmi] Call [019901b45634d009/40013e4,sOG,tOG,l2] distributing EventRinging
@16:52:31.5540 [gctmi] Call [019901b45634d009/40013e4,sOG,tOG,l2] processRinging
@16:52:31.5540 [tout] Call [019901b45634d009/40013e4,sOG,tOG,l2] (createParty) 299109
@16:52:31.5540 [gctm] Party [019901b45634d009:299109,s0,tDN,rDST,lINT] created.
@16:52:31.5540 [tout] Party [019901b45634d009:299109,s0,tDN,rDST,lINT] (CcmIntParty)
@16:52:31.5540 [tout] Party [019901b45634d009:299109,s0,tDN,rDST,lINT] (CcmAgentParty)
@16:52:31.5540 [gctmi] Party [019901b45634d009:299107,s1000c,tDN,rORG,lINT] processDialing
@16:52:31.5540 [gctmi] Address [299107,tDN,sOFFH] processOffHook
@16:52:31.5540 [gctmi] Party [019901b45634d009:299107,s1000c,tDN,rORG,lINT] EvDialing ignored, in Dialing state
@16:52:31.5540 [gctm] Party [019901b45634d009:299748,s800,tRP,rDST,lINT] rls-party best match, weight 48% to EventRinging
@16:52:31.5540 [gctmi] Party [019901b45634d009:299109,s0,tDN,rDST,lINT] distribute
@16:52:31.5540 [gctmi] Party [019901b45634d009:299109,s0,tDN,rDST,lINT] processRinging
@16:52:31.5540 [gctm] Party [019901b45634d009:299109,s0,tDN,rDST,lINT] Changing state to a
@16:52:31.5540 [ISCC] Party added [ssp view]:
@ c:019901b45634d009,013f52b0 @ m:0000000000000000,00000000,0000000000000000 p:3 i:040013e4 nw:00000000:0000000000000000 t:1
p:011e3bf0 @ c:019901b45634d009,013f52b0 r:1 t:0 s:1000c n:299107
p:013eb598 @ c:019901b45634d009,013f52b0 r:2 t:0 s:800 n:299748
+ p:011e32b0 @ c:019901b45634d009,013f52b0 r:2 t:0 s:a n:299109
@16:52:31.5540 [ISCC] Party added:
@ c:019901b45634d009,013f52b0 @ m:0000000000000000,00000000 p:3 i:040013e4 nw:0000000000000000 t:1
p:0000000000000000,011e3bf0 @ c:019901b45634d009,013f52b0 r:1 ------ n:299107:
p:0000000000000000,013eb598 @ c:019901b45634d009,013f52b0 r:2 ------ n:299748:
+ p:0000000000000000,011e32b0 @ c:019901b45634d009,013f52b0 r:2 ------ n:299109:
@16:52:31.5540 [0] 7.6.007.01 distribute_event: message EventRinging
AttributeEventSequenceNumber 00000000000001ca
AttributeTimeinuSecs 554000
AttributeTimeinSecs 1246546351 (16:52:31)
AttributeOtherDNRole 1
AttributeOtherDN '299107'
AttributeThisDNRole 2
AttributeThisDN '299109'
AttributeDNIS '299109'
AttributeUserData [593] 00 17 00 00..
'Site' 'S99'
'AGENT_ID' '299109'
'RVQID' 'R1SQ18ECTT6TD6RL4KMCR738MG000060'
'RTargetTypeSelected' '0'
'RTargetRuleSelected' ''
'RTargetObjectSelected' '299109'
'RTargetObjSelDBID' '842'
'RTargetAgentSelected' '299109'
'RTargetPlaceSelected' 'S99_Place_299109'
'RTenant' 'Resources'
'RStrategyName' 'CCM6_DD_Strategie_Appels_SDA v5'
'RStrategyDBID' '1048'
'CBR-actual_volume' ''
'CBR-Interaction_cost' ''
'CBR-contract_DBIDs' ''
'CBR-IT-path_DBIDs' ''
'RRequestedSkillCombination' ''
'RRequestedSkills'(list)
'CustomerSegment' 'default'
'ServiceType' 'default'
'ServiceObjective' ''
'PegTD' 1
'PegDOY' 2
AttributeCallUUID 'IU3KTO3V8T4A10MBBESV0JC5HK00001G'
AttributeConnID 019901b45634d009
AttributeCallID 67113956
AttributeCallType 1
AttributeCallState 0
AttributeAgentID '299109'
@16:52:31.5540 [ISCC] Translate: '' -> ''; result 1 ()
16:52:31.554 Int 04544 Interaction message "EventRinging" generated
16:52:31.554 Trc 04542 EventRinging sent to [368] (0000000b StatServer_CCP 10.110.130.201:3167)
16:52:31.554 Trc 04542 EventRinging sent to [508] (0000000a - SPv7203ST 10.110.153.82:2367)
16:52:31.554 Trc 04542 EventRinging sent to [520] (00000008 StatServer_CCA 10.110.130.203:4224)
16:52:31.554 Trc 04542 EventRinging sent to [392] (00000002 StatServer_GIS 10.110.130.203:4223)
16:52:31.554 Trc 04542 EventRinging sent to [472] (00000004 StatServer_URS 10.110.130.202:4253)
@16:52:31.5540 [((1] 1 173 S 9 'CallEv(6)=> Type=CallCtlTermConnRingingEv Cause=CAUSE_NORMAL CiscoCause=CAUSE_NOERROR Cid=67113956 MetaCode(false)=META_CALL_PROGRESS Addr=299109 Term=SEP001F6C7F5233'
@16:52:31.5700 [((1] 1 145 S 9 'CallEv(0)=> Type=ConnConnectedEvent Cause=CAUSE_NORMAL CiscoCause=CAUSE_NOERROR Cid=67113956 MetaCode(true)=META_CALL_PROGRESS Addr=299109'
@16:52:31.5700 [((1] 1 145 S 9 'CallEv(5)=> Type=ConnConnectedEvent Cause=CAUSE_NORMAL CiscoCause=CAUSE_NOERROR Cid=67113956 MetaCode(true)=META_CALL_PROGRESS Addr=299109'
@16:52:31.5700 [((1] 1 145 S 9 'CallEv(6)=> Type=ConnConnectedEvent Cause=CAUSE_NORMAL CiscoCause=CAUSE_NOERROR Cid=67113956 MetaCode(true)=META_CALL_PROGRESS Addr=299109'
@16:52:31.5700 [((1] 1 152 S 9 'CallEv(0)=> Type=CallCtlConnEstablishedEv Cause=CAUSE_NORMAL CiscoCause=CAUSE_NOERROR Cid=67113956 MetaCode(false)=META_CALL_PROGRESS Addr=299109'
@16:52:31.5700 [((1] 1 59 ISISIS 4 67113956 '299109' 2 '299107@SEP001DA2F3E526' 1 ''
@16:52:31.5700 [tout] Collected jtapi[1] tevent(4:ESTABLISHED)(299109:299107@SEP001DA2F3E526) (40013e4:2) (:1).
@16:52:31.5700 [tout] CcmSharedAddressResolver: Resolved 299107@SEP001DA2F3E526 -> 299107 [Single in CME]
@16:52:31.5700 [gctmi] TMsg [EventEstablished(299109)] distributing to model
@16:52:31.5700 [gctmi] Call [019901b45634d009/40013e4,sOG,tOG,l3] distributing EventEstablished
@16:52:31.5700 [tout] CcmCall(019901b45634d009): processEstablished
@16:52:31.5700 [gctmi] Call [019901b45634d009/40013e4,sOG,tOG,l3] processEstablished
@16:52:31.5700 [gctm] Call [019901b45634d009/40013e4,sOG,tOG,l3] Changing state to 5
@16:52:31.5700 [gctm] Call [019901b45634d009/40013e4,sSE,tOG,l3] Setting timer to SE:500mS
@16:52:31.5700 [gctmi] TMsg [EventEstablished(299109)] (re)distributing to model in 501mS
@16:52:31.5700 [((1] 1 152 S 9 'CallEv(5)=> Type=CallCtlConnEstablishedEv Cause=CAUSE_NORMAL CiscoCause=CAUSE_NOERROR Cid=67113956 MetaCode(false)=META_CALL_PROGRESS Addr=299109'
@16:52:31.5700 [((1] 1 59 ISISIS 4 67113956 '299109' 2 '299107@SEP001DA2F3E526' 1 ''
@16:52:31.5700 [tout] Collected jtapi[1] tevent(4:ESTABLISHED)(299109:299107@SEP001DA2F3E526) (40013e4:2) (:1).
@16:52:31.5700 [tout] CcmSharedAddressResolver: Resolved 299107@SEP001DA2F3E526 -> 299107 [Single in CME]
@16:52:31.5700 [gctmi] TMsg [EventEstablished(299109)] distributing to model
@16:52:31.5700 [gctmi] Call [019901b45634d009/40013e4,sSE,tSE,l3] distributing EventEstablished
@16:52:31.5700 [tout] CcmCall(019901b45634d009): processEstablished
@16:52:31.5700 [gctmi] Call [019901b45634d009/40013e4,sSE,tSE,l3] processEstablished
@16:52:31.5700 [gctmi] TMsg [EventEstablished(299109)] (re)distributing to model in 501mS
@16:52:31.5700 [((1] 1 152 S 9 'CallEv(6)=> Type=CallCtlConnEstablishedEv Cause=CAUSE_NORMAL CiscoCause=CAUSE_NOERROR Cid=67113956 MetaCode(false)=META_CALL_PROGRESS Addr=299109'
@16:52:31.5700 [((1] 1 59 ISISIS 4 67113956 '299109' 2 '299107@SEP001DA2F3E526' 1 ''
@16:52:31.5700 [tout] Collected jtapi[1] tevent(4:ESTABLISHED)(299109:299107@SEP001DA2F3E526) (40013e4:2) (:1).
@16:52:31.5700 [tout] CcmSharedAddressResolver: Resolved 299107@SEP001DA2F3E526 -> 299107 [Single in CME]
@16:52:31.5700 [gctmi] TMsg [EventEstablished(299109)] distributing to model
@16:52:31.5700 [gctmi] Call [019901b45634d009/40013e4,sSE,tSE,l3] distributing EventEstablished
@16:52:31.5700 [tout] CcmCall(019901b45634d009): processEstablished
@16:52:31.5700 [gctmi] Call [019901b45634d009/40013e4,sSE,tSE,l3] processEstablished
@16:52:31.5700 [gctmi] TMsg [EventEstablished(299109)] (re)distributing to model in 501mS
@16:52:31.5700 [((1] 1 154 S 9 'CallEv(0)=> Type=ConnDisconnectedEvent Cause=CAUSE_NORMAL CiscoCause=CAUSE_NOERROR Cid=67113956 MetaCode(true)=META_CALL_REMOVING_PARTY Addr=299748'
@16:52:31.5700 [((1] 1 154 S 9 'CallEv(5)=> Type=ConnDisconnectedEvent Cause=CAUSE_NORMAL CiscoCause=CAUSE_NOERROR Cid=67113956 MetaCode(true)=META_CALL_REMOVING_PARTY Addr=299748'
@16:52:31.5700 [((1] 1 154 S 9 'CallEv(6)=> Type=ConnDisconnectedEvent Cause=CAUSE_NORMAL CiscoCause=CAUSE_NOERROR Cid=67113956 MetaCode(true)=META_CALL_REMOVING_PARTY Addr=299748'
@16:52:31.5700 [((1] 1 163 S 9 'CallEv(0)=> Type=CallCtlConnDisconnectedEv Cause=CAUSE_REDIRECTED CiscoCause=CAUSE_NOERROR Cid=67113956 MetaCode(false)=META_CALL_REMOVING_PARTY Addr=299748'
@16:52:31.5700 [((1] 1 35 ISISI 5 67113956 '299748' 210 '' 0
@16:52:31.5700 [tout] Collected jtapi[1] tevent(5:RELEASED)(299748:) (40013e4:d2) (:0).
@16:52:31.5700 [tout] CcmRouteParty::CcmEventReleased with cause d2 OtherAddress: . State: REDIRECTING
@16:52:31.5700 [gctmi] TMsg [EventRouteUsed(299748)] distributing to model
@16:52:31.5700 [gctmi] Call [019901b45634d009/40013e4,sSE,tSE,l3] distributing EventRouteUsed
@16:52:31.5700 [gctmi] Call [019901b45634d009/40013e4,sSE,tSE,l3] processRouteUsed
@16:52:31.5700 [gctmi] Party [019901b45634d009:299748,s800,tRP,rDST,lINT] processRouteUsed
@16:52:31.5700 [gctm] Party [019901b45634d009:299748,s800,tRP,rDST,lINT] Changing state to 0
@16:52:31.5700 [gctmi] request RequestRouteCall removed from reqMgr
@16:52:31.5700 [0] 7.6.007.01 distribute_response: message EventRouteUsed
AttributeEventSequenceNumber 00000000000001cb
AttributeTimeinuSecs 570000
AttributeTimeinSecs 1246546351 (16:52:31)
AttributeThirdPartyDNRole 2
AttributeThirdPartyDN '299109'
AttributeOtherDNRole 1
AttributeOtherDN '299107'
AttributeThisDNRole 2
AttributeThisDN '299748'
AttributeDNIS '299109'
AttributeUserData [593] 00 17 00 00..
'Site' 'S99'
'AGENT_ID' '299109'
'RVQID' 'R1SQ18ECTT6TD6RL4KMCR738MG000060'
'RTargetTypeSelected' '0'
'RTargetRuleSelected' ''
'RTargetObjectSelected' '299109'
'RTargetObjSelDBID' '842'
'RTargetAgentSelected' '299109'
'RTargetPlaceSelected' 'S99_Place_299109'
'RTenant' 'Resources'
'RStrategyName' 'CCM6_DD_Strategie_Appels_SDA v5'
'RStrategyDBID' '1048'
'CBR-actual_volume' ''
'CBR-Interaction_cost' ''
'CBR-contract_DBIDs' ''
'CBR-IT-path_DBIDs' ''
'RRequestedSkillCombination' ''
'RRequestedSkills'(list)
'CustomerSegment' 'default'
'ServiceType' 'default'
'ServiceObjective' ''
'PegTD' 1
'PegDOY' 2
AttributeCallUUID 'IU3KTO3V8T4A10MBBESV0JC5HK00001G'
AttributeConnID 019901b45634d009
AttributeCallID 67113956
AttributeCallType 1
AttributeThisQueue '299748'
AttributeCallState 0
AttributeReason [14] 00 01 01 00..
'RTR' 110
AttributeReferenceID 2018
@16:52:31.5700 [ISCC] Translate: '' -> ''; result 1 ()
16:52:31.570 Int 04544 Interaction message "EventRouteUsed" generated
16:52:31.570 Trc 04542 EventRouteUsed sent to [484] (00000005 UniversalRoutingServer 10.110.130.202:4255)
16:52:31.570 Trc 04542 EventRouteUsed sent to [368] (0000000b StatServer_CCP 10.110.130.201:3167)
16:52:31.570 Trc 04542 EventRouteUsed sent to [520] (00000008 StatServer_CCA 10.110.130.203:4224)
16:52:31.570 Trc 04542 EventRouteUsed sent to [392] (00000002 StatServer_GIS 10.110.130.203:4223)
16:52:31.570 Trc 04542 EventRouteUsed sent to [472] (00000004 StatServer_URS 10.110.130.202:4253)
@16:52:31.5700 [gctm] Party [019901b45634d009:299748,s0,tRP,rDST,lINT] deleting.
@16:52:31.5700 [ISCC] Party removed [ssp view]:
@ c:019901b45634d009,013f52b0 @ m:0000000000000000,00000000,0000000000000000 p:3 i:040013e4 nw:00000000:0000000000000000 t:1
p:011e3bf0 @ c:019901b45634d009,013f52b0 r:1 t:0 s:1000c n:299107
- p:013eb598 @ c:019901b45634d009,013f52b0 r:2 t:0 s:0 n:299748
p:011e32b0 @ c:019901b45634d009,013f52b0 r:2 t:0 s:a n:299109
@16:52:31.5700 [ISCC] Party removed:
@ c:019901b45634d009,013f52b0 @ m:0000000000000000,00000000 p:3 i:040013e4 nw:0000000000000000 t:1
p:0000000000000000,011e3bf0 @ c:019901b45634d009,013f52b0 r:1 ------ n:299107:
- p:0000000000000000,013eb598 @ c:019901b45634d009,013f52b0 r:2 ------ n:299748:
p:0000000000000000,011e32b0 @ c:019901b45634d009,013f52b0 r:2 ------ n:299109:
@16:52:31.5700 [ISCC] Party object is removed: p:0000000000000000,00000000 n:299748:
@16:52:31.5700 [sm] SmLegOwner destructor entered.
@16:52:31.5700 [sm] free_dcr_queue...
@16:52:31.5700 [sm] dmx_stop_media_cmd, leg 90
@16:52:31.5700 [sm] gw_stop_media_cmd: l:90, MediaCmdActiveType 0, MediaStopActive 0, MediaCmdSent 0, MediaCmdIssuedType 0
@16:52:31.5700 [sm] SmLeg::Destroy for leg 90, status 2
@16:52:31.5700 [tout] Total 1 legs on SM 1.
@16:52:31.5700 [tout] <<<<<Sending SMEvent, s:412, n:'1 VoIP_SM_760', e: DESTROY_LEG(leg=90) ref=23
@16:52:31.5700 [tout] (CcmIntParty deleted)
16:52:31.570 Trc 04541 RequestDistributeEvent received from [484] (00000005 UniversalRoutingServer 10.110.130.202:4255)
message RequestDistributeEvent
AttributeUserEvent EventDiverted
AttributeReferenceID 4294967295
AttributeCustomerID 'Resources'
AttributeConnID 019901b45634d009
AttributeCallID 67113956
AttributeCallType 1
AttributeThisDN 'Appels_SDA_S99_Switch'
AttributeThisQueue 'Appels_SDA_S99_Switch'
AttributeThisDNRole 2
AttributeOtherDN '299107'
AttributeOtherDNRole 1
AttributeThirdPartyDN '299109'
AttributeThirdPartyDNRole 2
AttributeDNIS '299109'
AttributeUserData [593] 00 17 00 00..
'Site' 'S99'
'AGENT_ID' '299109'
'RVQID' 'R1SQ18ECTT6TD6RL4KMCR738MG000060'
'RTargetTypeSelected' '0'
'RTargetRuleSelected' ''
'RTargetObjectSelected' '299109'
'RTargetObjSelDBID' '842'
'RTargetAgentSelected' '299109'
'RTargetPlaceSelected' 'S99_Place_299109'
'RTenant' 'Resources'
'RStrategyName' 'CCM6_DD_Strategie_Appels_SDA v5'
'RStrategyDBID' '1048'
'CBR-actual_volume' ''
'CBR-Interaction_cost' ''
'CBR-contract_DBIDs' ''
'CBR-IT-path_DBIDs' ''
'RRequestedSkillCombination' ''
'RRequestedSkills'(list)
'CustomerSegment' 'default'
'ServiceType' 'default'
'ServiceObjective' ''
'PegTD' 1
'PegDOY' 2
AttributeReason [14] 00 01 01 00..
'RTR' 110
AttributeExtensions [222] 00 07 00 00..
'SIGNATURE' 'router'
'NAME' 'UniversalRoutingServer'
'VERSION' 'Version: 7.6.001.06'
'CLUSTER' 'UniversalRoutingServer'
'VQID' 'R1SQ18ECTT6TD6RL4KMCR738MG000060'
'Location' 'Cisco'
'CallUUID' 'IU3KTO3V8T4A10MBBESV0JC5HK00001G'
AttributeTimeout 60
AttributeCallUUID 'IU3KTO3V8T4A10MBBESV0JC5HK00001G'
16:52:31.570 Int 04543 Interaction message "RequestDistributeEvent" received from 484 ("UniversalRoutingServer")
@16:52:31.5700 [0] 7.6.007.01 send_to_client: message EventACK
AttributeEventSequenceNumber 00000000000001cc
AttributeTimeinuSecs 570000
AttributeTimeinSecs 1246546351 (16:52:31)
AttributeReferenceID 4294967295
AttributeThisDN 'Appels_SDA_S99_Switch'
AttributeUserEvent RequestDistributeEvent
16:52:31.570 Trc 04542 EventACK sent to [484] (00000005 UniversalRoutingServer 10.110.130.202:4255)
@16:52:31.5700 [0] 7.6.007.01 distribute_user_event: message EventDiverted
AttributeEventSequenceNumber 00000000000001cd
AttributeTimeinuSecs 570000
AttributeTimeinSecs 1246546351 (16:52:31)
AttributeCallUUID 'IU3KTO3V8T4A10MBBESV0JC5HK00001G'
AttributeTimeout 60
AttributeExtensions [222] 00 07 00 00..
'SIGNATURE' 'router'
'NAME' 'UniversalRoutingServer'
'VERSION' 'Version: 7.6.001.06'
'CLUSTER' 'UniversalRoutingServer'
'VQID' 'R1SQ18ECTT6TD6RL4KMCR738MG000060'
'Location' 'Cisco'
'CallUUID' 'IU3KTO3V8T4A10MBBESV0JC5HK00001G'
AttributeReason [14] 00 01 01 00..
'RTR' 110
AttributeUserData [593] 00 17 00 00..
'Site' 'S99'
'AGENT_ID' '299109'
'RVQID' 'R1SQ18ECTT6TD6RL4KMCR738MG000060'
'RTargetTypeSelected' '0'
'RTargetRuleSelected' ''
'RTargetObjectSelected' '299109'
'RTargetObjSelDBID' '842'
'RTargetAgentSelected' '299109'
'RTargetPlaceSelected' 'S99_Place_299109'
'RTenant' 'Resources'
'RStrategyName' 'CCM6_DD_Strategie_Appels_SDA v5'
'RStrategyDBID' '1048'
'CBR-actual_volume' ''
'CBR-Interaction_cost' ''
'CBR-contract_DBIDs' ''
'CBR-IT-path_DBIDs' ''
'RRequestedSkillCombination' ''
'RRequestedSkills'(list)
'CustomerSegment' 'default'
'ServiceType' 'default'
'ServiceObjective' ''
'PegTD' 1
'PegDOY' 2
AttributeDNIS '299109'
AttributeThirdPartyDNRole 2
AttributeThirdPartyDN '299109'
AttributeOtherDNRole 1
AttributeOtherDN '299107'
AttributeThisDNRole 2
AttributeThisQueue 'Appels_SDA_S99_Switch'
AttributeThisDN 'Appels_SDA_S99_Switch'
AttributeCallType 1
AttributeCallID 67113956
AttributeConnID 019901b45634d009
AttributeCustomerID 'Resources'
AttributeReferenceID 4294967295
AttributeUserEvent EventDiverted
16:52:31.570 Trc 04542 EventDiverted sent to [368] (0000000b StatServer_CCP 10.110.130.201:3167)
16:52:31.570 Trc 04542 EventDiverted sent to [520] (00000008 StatServer_CCA 10.110.130.203:4224)
16:52:31.570 Trc 04542 EventDiverted sent to [392] (00000002 StatServer_GIS 10.110.130.203:4223)
16:52:31.570 Trc 04542 EventDiverted sent to [472] (00000004 StatServer_URS 10.110.130.202:4253)
@16:52:31.5700 [((1] 1 163 S 9 'CallEv(5)=> Type=CallCtlConnDisconnectedEv Cause=CAUSE_REDIRECTED CiscoCause=CAUSE_NOERROR Cid=67113956 MetaCode(false)=META_CALL_REMOVING_PARTY Addr=299748'
@16:52:31.5700 [((1] 1 35 ISISI 5 67113956 '299748' 210 '' 0
@16:52:31.5700 [tout] Collected jtapi[1] tevent(5:RELEASED)(299748:) (40013e4:d2) (:0).
@16:52:31.5700 [gctmi] TMsg [EventReleased(299748)] distributing to model
@16:52:31.5700 [gctmi] Call [019901b45634d009/40013e4,sSE,tSE,l2] distributing EventReleased
@16:52:31.5700 [gctmi] Call [019901b45634d009/40013e4,sSE,tSE,l2] processReleased
@16:52:31.5700 [gctmi] Call [019901b45634d009/40013e4,sSE,tSE,l2] EvMigrated ignored for non-exist party.
@16:52:31.5700 [((1] 1 163 S 9 'CallEv(6)=> Type=CallCtlConnDisconnectedEv Cause=CAUSE_REDIRECTED CiscoCause=CAUSE_NOERROR Cid=67113956 MetaCode(false)=META_CALL_REMOVING_PARTY Addr=299748'
@16:52:31.5700 [((1] 1 35 ISISI 5 67113956 '299748' 210 '' 0
@16:52:31.5700 [tout] Collected jtapi[1] tevent(5:RELEASED)(299748:) (40013e4:d2) (:0).
@16:52:31.5700 [gctmi] TMsg [EventReleased(299748)] distributing to model
@16:52:31.5700 [gctmi] Call [019901b45634d009/40013e4,sSE,tSE,l2] distributing EventReleased
@16:52:31.5700 [gctmi] Call [019901b45634d009/40013e4,sSE,tSE,l2] processReleased
@16:52:31.5700 [gctmi] Call [019901b45634d009/40013e4,sSE,tSE,l2] EvMigrated ignored for non-exist party.
@16:52:31.5700 [((1] 1 131 S 9 'CallEv(6)=> Type=CallObservationEndedEv Cause=CAUSE_NORMAL CiscoCause=CAUSE_NOERROR Cid=67113956 MetaCode(true)=META_UNKNOWN'
@16:52:31.5700 [tout] >>>Incoming SMEvent, s:412, l:90, n:'1 VoIP_SM_760', e: DESTROY_LEG_ACK(id=1,err=0) ref=23
@16:52:32.0860 [gctm] Call [019901b45634d009/40013e4,sSE,tSE,l2] Single-Est timer expired, transition to Est.
@16:52:32.0860 [gctm] Call [019901b45634d009/40013e4,sSE,tSE,l2] Transition to ESTABLISHED state.
@16:52:32.0860 [gctmi] Party [019901b45634d009:299109,sa,tDN,rDST,lINT] processEstablished
@16:52:32.0860 [gctmi] Address [299109,tDN,sIDLE] processOffHook
@16:52:32.0860 [gctm] Address [299109,tDN,sIDLE] Changing state to 1
@16:52:32.0860 [0] 7.6.007.01 distribute_event: message EventOffHook
AttributeEventSequenceNumber 00000000000001ce
AttributeTimeinuSecs 86000
AttributeTimeinSecs 1246546352 (16:52:32)
AttributeThisDN '299109'
@16:52:32.0860 [ISCC] Translate: '' -> ''; result 1 ()
16:52:32.086 Int 04544 Interaction message "EventOffHook" generated
16:52:32.086 Trc 04542 EventOffHook sent to [368] (0000000b StatServer_CCP 10.110.130.201:3167)
16:52:32.086 Trc 04542 EventOffHook sent to [508] (0000000a - SPv7203ST 10.110.153.82:2367)
16:52:32.086 Trc 04542 EventOffHook sent to [520] (00000008 StatServer_CCA 10.110.130.203:4224)
16:52:32.086 Trc 04542 EventOffHook sent to [392] (00000002 StatServer_GIS 10.110.130.203:4223)
16:52:32.086 Trc 04542 EventOffHook sent to [472] (00000004 StatServer_URS 10.110.130.202:4253)
@16:52:32.0860 [gctm] Party [019901b45634d009:299109,sa,tDN,rDST,lINT] Changing state to c
@16:52:32.0860 [0] 7.6.007.01 distribute_event: message EventEstablished
AttributeEventSequenceNumber 00000000000001cf
AttributeTimeinuSecs 86000
AttributeTimeinSecs 1246546352 (16:52:32)
AttributeOtherDNRole 1
AttributeOtherDN '299107'
AttributeThisDNRole 2
AttributeThisDN '299109'
AttributeDNIS '299109'
AttributeUserData [593] 00 17 00 00..
'Site' 'S99'
'AGENT_ID' '299109'
'RVQID' 'R1SQ18ECTT6TD6RL4KMCR738MG000060'
'RTargetTypeSelected' '0'
'RTargetRuleSelected' ''
'RTargetObjectSelected' '299109'
'RTargetObjSelDBID' '842'
'RTargetAgentSelected' '299109'
'RTargetPlaceSelected' 'S99_Place_299109'
'RTenant' 'Resources'
'RStrategyName' 'CCM6_DD_Strategie_Appels_SDA v5'
'RStrategyDBID' '1048'
'CBR-actual_volume' ''
'CBR-Interaction_cost' ''
'CBR-contract_DBIDs' ''
'CBR-IT-path_DBIDs' ''
'RRequestedSkillCombination' ''
'RRequestedSkills'(list)
'CustomerSegment' 'default'
'ServiceType' 'default'
'ServiceObjective' ''
'PegTD' 1
'PegDOY' 2
AttributeCallUUID 'IU3KTO3V8T4A10MBBESV0JC5HK00001G'
AttributeConnID 019901b45634d009
AttributeCallID 67113956
AttributeCallType 1
AttributeCallState 0
AttributeAgentID '299109'
@16:52:32.0860 [ISCC] Translate: '' -> ''; result 1 ()
16:52:32.086 Int 04544 Interaction message "EventEstablished" generated
16:52:32.086 Trc 04542 EventEstablished sent to [368] (0000000b StatServer_CCP 10.110.130.201:3167)
16:52:32.086 Trc 04542 EventEstablished sent to [508] (0000000a - SPv7203ST 10.110.153.82:2367)
16:52:32.086 Trc 04542 EventEstablished sent to [520] (00000008 StatServer_CCA 10.110.130.203:4224)
16:52:32.086 Trc 04542 EventEstablished sent to [392] (00000002 StatServer_GIS 10.110.130.203:4223)
16:52:32.086 Trc 04542 EventEstablished sent to [472] (00000004 StatServer_URS 10.110.130.202:4253)
@16:52:32.0860 [gctmi] Party [019901b45634d009:299107,s1000c,tDN,rORG,lINT] processEstablished
@16:52:32.0860 [gctmi] Address [299107,tDN,sOFFH] processOffHook
@16:52:32.0860 [gctm] Party [019901b45634d009:299107,s1000c,tDN,rORG,lINT] Changing state to c
@16:52:32.0860 [0] 7.6.007.01 distribute_event: message EventEstablished
AttributeEventSequenceNumber 00000000000001d0
AttributeTimeinuSecs 86000
AttributeTimeinSecs 1246546352 (16:52:32)
AttributeOtherDNRole 2
AttributeOtherDN '299109'
AttributeThisDNRole 1
AttributeThisDN '299107'
AttributeDNIS '299109'
AttributeUserData [593] 00 17 00 00..
'Site' 'S99'
'AGENT_ID' '299109'
'RVQID' 'R1SQ18ECTT6TD6RL4KMCR738MG000060'
'RTargetTypeSelected' '0'
'RTargetRuleSelected' ''
'RTargetObjectSelected' '299109'
'RTargetObjSelDBID' '842'
'RTargetAgentSelected' '299109'
'RTargetPlaceSelected' 'S99_Place_299109'
'RTenant' 'Resources'
'RStrategyName' 'CCM6_DD_Strategie_Appels_SDA v5'
'RStrategyDBID' '1048'
'CBR-actual_volume' ''
'CBR-Interaction_cost' ''
'CBR-contract_DBIDs' ''
'CBR-IT-path_DBIDs' ''
'RRequestedSkillCombination' ''
'RRequestedSkills'(list)
'CustomerSegment' 'default'
'ServiceType' 'default'
'ServiceObjective' ''
'PegTD' 1
'PegDOY' 2
AttributeCallUUID 'IU3KTO3V8T4A10MBBESV0JC5HK00001G'
AttributeConnID 019901b45634d009
AttributeCallID 67113956
AttributeCallType 1
AttributeCallState 0
AttributeAgentID '299107'
@16:52:32.0860 [ISCC] Translate: '' -> ''; result 1 ()
16:52:32.086 Int 04544 Interaction message "EventEstablished" generated
16:52:32.086 Trc 04542 EventEstablished sent to [368] (0000000b StatServer_CCP 10.110.130.201:3167)
16:52:32.086 Trc 04542 EventEstablished sent to [532] (00000009 - SPv7203ST 10.110.153.82:2366)
16:52:32.086 Trc 04542 EventEstablished sent to [520] (00000008 StatServer_CCA 10.110.130.203:4224)
16:52:32.086 Trc 04542 EventEstablished sent to [392] (00000002 StatServer_GIS 10.110.130.203:4223)
16:52:32.086 Trc 04542 EventEstablished sent to [472] (00000004 StatServer_URS 10.110.130.202:4253)
@16:52:32.0860 [gctm] Call [019901b45634d009/40013e4,sSE,tSE,l2] Changing state to 6
@16:52:32.0860 [gctm] Call [019901b45634d009/40013e4,sES,tSE,l2] Setting timer to ES:100800000mS
@16:52:32.0860 [gctmi] TMsg [EventEstablished(299109)] re-distributing to model
@16:52:32.0860 [gctmi] Call [019901b45634d009/40013e4,sES,tES,l2] distributing EventEstablished
@16:52:32.0860 [tout] CcmCall(019901b45634d009): processEstablished
@16:52:32.0860 [gctmi] Call [019901b45634d009/40013e4,sES,tES,l2] processEstablished
@16:52:32.0860 [gctmi] Party [019901b45634d009:299109,sc,tDN,rDST,lINT] processEstablished