Hi cavagnaro thank you for your answer and happy new year everyone. Here is SIP Server logs after removing prefix option :
12:02:24.945: Unable to resolve number for DN:anonymous
12:02:24.945: Unable to resolve number for DN:Anonymous
12:02:24.945: trunk ip addr 10.0.100.19
12:02:24.945: gateway 'Trunk_SIP_Avaya1' associated with address '10.0.100.19'
12:02:24.945: Assocaited transport for the device [15934] changed from [:0:0] to [10.0.100.19:5060:2]
12:02:24.945: CallMatcher: no call match attributes found
12:02:24.945: Unable to resolve number for DN:anonymous
12:02:24.945: Unable to resolve number for DN:Anonymous
12:02:24.945: trunk ip addr 10.0.100.19
12:02:24.945: gateway 'Trunk_SIP_Avaya1' associated with address '10.0.100.19'
12:02:24.945: Assocaited transport for the device [15935] changed from [:0:0] to [10.0.100.19:5060:2]
12:02:24.945: MarkAsLastUsed: Node not found for serviceDN 'dummy'
12:02:24.945: ResolveCallInfo: set flag DIAL_PLAN_PROCESSING
12:02:24.945: Sc(349):step 0, Tr(350,SipTransactionCreateCall) - begin
12:02:24.945 SIPCONN(anonymous): SIPCONN(0000000023d590f0,BD928RELK16D705QTHFAT93GAS00001M) +Tr(350,SipTransactionCreateCall)
12:02:24.945 SIPCONN(anonymous): Create dialog
12:02:24.945: SipDialog: set monitor 0000000023d591a8
12:02:24.945 SIPCONN(anonymous): refer dialog 0000000024a2c200 initiated
12:02:24.945 SIPCONN(anonymous): change transaction 0 -> 0
12:02:24.945: SipDialog: set monitor 0000000023d591a8
12:02:24.945 SIPCONN(anonymous): ClrMediaPeer
12:02:24.945: SIPDLG[71]: register TRN[102404]
12:02:24.945: SIPDLG[71]: TRN[102404] flags set to 0x1
12:02:24.945: SipDialog: event INVITE, t=102404, s=1, r=5, m=0000000023d591a8 port=5060
12:02:24.945: CID:CUUID>f043511a8a8c41edbf9f05056a1f079:EAD6TQ8MCT5F91D1U5NQDO9QIC00000T:
12:02:24.945 SIPCONN(anonymous): HandleSipDialogEvent(INVITE)
12:02:24.945 SIPCONN(anonymous): Capabilities 2301ef
12:02:24.945 SIPCONN(anonymous): new transaction
12:02:24.945 SIPCONN(anonymous): store remote content, canBeOffer 1
12:02:24.945 SIPCONN(anonymous): verify sdp
12:02:24.945 SIPCONN(anonymous): sdp state SDP_STATE_NULL, event SDP_EVENT_SDP
12:02:24.945 SIPCONN(anonymous): new sdp state SDP_STATE_OFFER_RECEIVED, event SDP_EVENT_SDP
12:02:24.945 SIPCONN(anonymous): state e:10,p:0,s:1,c:9,rc:0,m:0
12:02:24.945 SIPCONN(anonymous): SIPCONN(0000000023d590f0,BD928RELK16D705QTHFAT93GAS00001M) -Tr(350,SipTransactionCreateCall)
12:02:24.945: Tr(350,SipTransactionCreateCall):completed
12:02:24.945: Sc(349):step 0, Tr(350,SipTransactionCreateCall) - completed
12:02:24.945: Sc(349):step 1, Tr(351,SipTransactionResolveCallInfoByDialPlan) - begin
12:02:24.945: DialPlan:Not Found for dest 3199999
12:02:24.945: DialPlan: DialPlan found, but no rule defined for destination 3199999.
12:02:24.945: DialPlan: No rule applied, using original destination '3199999'.
12:02:24.945: DialPlan: clear flag 0x100, callId 16777245
12:02:24.945: ConnectToDevice: Connecting to DEVICE(15936,3199999).
@12:02:24.9450 {tscp.call {constructed} {uuid HSSNFC8II57HVBTAD3FCUJ7HE8000087} {connection-id 00970349dedfa01d} {call-id 16777245}}
12:02:24.945 -- created call_info_tspp 00970349dedfa01d@243633c0
@12:02:24.9450 Call [00970349dedfa01d]: urid 00010097
12:02:24.945 -- created aTmCall 23eb8510/243633c0
12:02:24.945 -- TmCallThread created: 22791270
12:02:24.945 SetANI for 23eb8510:1: anonymous
12:02:24.945 SetDNIS for 23eb8510:1: 3199999
12:02:24.945: SIPCALL(16777245): add party 'anonymous'
12:02:24.945 SIPPARTY(anonymous): Set Origination Info DN - anonymous ; Location - SIP_prod for party anonymous
12:02:24.945: SIPTS: OnPartyCreated
12:02:24.945 -- created party_info_tspp 25392510
12:02:24.945 -- created aTmParty 2428f5d0
12:02:24.945 SetRole: Origination for anonymous.2428f5d0-23eb8510:1
12:02:24.945 -- AddParty to 23eb8510: anonymous.2428f5d0-23eb8510:1
12:02:24.945 -- new TSCP call leg 1
12:02:24.945 -- call leg created leg_id=1
12:02:24.945 CreateParty new external: anonymous.2428f5d0-23eb8510:1
12:02:24.945: Call 16777245 dn anonymous SetPartyId 16777408
12:02:24.945: XS info is stored to TServer party anonymous: loginSessionId: , loginLocation: ; employeeId
12:02:24.945 SIPCONN(anonymous): set monitor 0000000023d590f0, 0000000023fab9a8
12:02:24.945: SIPCALL(16777245): add party '3199999'
12:02:24.945 SIPPARTY(3199999): Set Origination Info DN - anonymous ; Location - SIP_prod for party 3199999
12:02:24.945: SIPTS: OnPartyCreated
12:02:24.945 -- created party_info_tspp 25391c10
12:02:24.945 -- created aTmParty 2428fd80
12:02:24.945 SetRole: Destination for 3199999.2428fd80-23eb8510:1
12:02:24.945 -- AddParty to 23eb8510: 3199999.2428fd80-23eb8510:1
12:02:24.945 -- new TSCP call leg 2
12:02:24.945 -- call leg created leg_id=2
12:02:24.945 CreateParty new internal: 3199999.2428fd80-23eb8510:1
12:02:24.945: Call 16777245 dn 3199999 SetPartyId 16777409
12:02:24.945: XS info is stored to TServer party 3199999: loginSessionId: , loginLocation: ; employeeId
12:02:24.945: Tr(351,SipTransactionResolveCallInfoByDialPlan):completed
12:02:24.945: Sc(349):step 1, Tr(351,SipTransactionResolveCallInfoByDialPlan) - completed
12:02:24.945: Sc(349):step 2, Tr(352,SipTransactionChangePartyState) - begin
12:02:24.945 SIPPARTY(anonymous): ChangePartyState: new=1
12:02:24.945: SIPTS: 'anonymous' state changed null->initiated, cause 0
12:02:24.945: XS info is stored to TServer party anonymous: loginSessionId: , loginLocation: ; employeeId
12:02:24.945: Tr(352,SipTransactionChangePartyState):completed
12:02:24.945: Sc(349):step 2, Tr(352,SipTransactionChangePartyState) - completed
12:02:24.945: Sc(349):step 3, Tr(353,SipTransactionGetOffer) - begin
12:02:24.945: Tr(353,SipTransactionGetOffer):completed
12:02:24.945: Sc(349):step 3, Tr(353,SipTransactionGetOffer) - completed
12:02:24.945: Sc(349):step 4, Tr(354,SipTransactionConnectNewParty) - begin
12:02:24.945 SIPPARTY(3199999): ChangePartyState: new=5
12:02:24.945: SIPTS: '3199999' state changed null->queued, cause 9
12:02:24.945: IsCDN = true
12:02:24.945: Adding OtherTrunkName(Trunk_SIP_Avaya1): done
12:02:24.945 ClearContext: party 3199999.2428fd80-23eb8510:1
12:02:24.945 +++ CIFace::Event +++
+++ Pre-event +++
Type EventRouteRequest
Devices: <3199999/3199999> <-/anonymous> <-/->
Calls: 16777245/00970349dedfa01d/16777245.23eb8510/c:0/r:0 0/none
Parties: D3199999/3199999.2428fd80-23eb8510:1/l:2/r:0/Null,Destination
Xanonymous/anonymous.2428f5d0-23eb8510:1/l:1/r:0/Null,Origination
none
Flags: divert=0 hook=0 postCall=0 active=1 moveAll=1 callType=1 hideOtherPi=0 InternalOther=0
--- Pre-event ---
+++ Ringing +++
SetDialling: party anonymous.2428f5d0-23eb8510:1, cause Null
-- party_info anonymous.25392510 state change: from <Null> to <Connected,Dialing>
-- AgnEmu: business type taken from distribution device 3199999
-- AgnEmu: business call BusinessType[2/4:0]
-- aTmCall::SetBusinessType():00970349dedfa01d set to BusinessType[2/4:1]
-- aTmParty::SetBusinessType():3199999 set to BusinessType[2/4:1]
-- G7 dialing
-- call_info::committed created
@12:02:24.9450 [ISCC] Call object is created: c:00970349dedfa01d,00000000243633c0
@12:02:24.9450 [ISCC] Call created:
+ c:00970349dedfa01d,00000000243633c0 @ m:0000000000000000,0000000000000000 p:0 i:0100001d nw:0000000000000000 t:2
@12:02:24.9450 [0] 8.1.104.58 distribute call/party event: message EventCallCreated
AttributeEventSequenceNumber 00000000000004de
AttributeTimeStamp 63b2b9c0000e6b68
AttributeANI 'anonymous'
AttributeMediaType 0
AttributeCallType 2
AttributeCallID 16777245
AttributeConnID 00970349dedfa01d
AttributeCallUUID 'EAD6TQ8MCT5F91D1U5NQDO9QIC00000T'
AttributeDNIS '3199999'
12:02:24.945 Int 04544 Interaction message "EventCallCreated" generated
12:02:24.945 Trc 04542 EventCallCreated sent to [1152] (00000004 ors 10.0.241.5:65303)
@12:02:24.9450 [ISCC] Party added [ddp view]:
@ c:00970349dedfa01d,00000000243633c0 @ m:0000000000000000,0000000000000000,0000000000000000 p:2 i:0100001d nw:00000000:0000000000000000 t:2
+ p:0000000025392510 @ c:00970349dedfa01d,00000000243633c0 r:1 t:1 s:1000c n:anonymous
p:0000000025391c10 @ c:00970349dedfa01d,00000000243633c0 r:2 t:0 s:0 n:3199999
@12:02:24.9450 [ISCC] Party object is created: p:0000000000000000,0000000025392510 n:anonymous:
@12:02:24.9450 [ISCC] Party added:
@ c:00970349dedfa01d,00000000243633c0 @ m:0000000000000000,0000000000000000 p:1 i:0100001d nw:0000000000000000 t:2
+ p:0000000000000000,0000000025392510 @ c:00970349dedfa01d,00000000243633c0 r:1 ----- n:anonymous:
@12:02:24.9450 [0] 8.1.104.58 distribute call/party event: message EventCallPartyAdded
AttributeEventSequenceNumber 00000000000004df
AttributeTimeStamp 63b2b9c0000e6b68
AttributeDN 'anonymous'
AttributeMediaType 0
AttributePartyState 0x1000c
AttributePartyType 1
AttributeConnID 00970349dedfa01d
AttributeCallUUID 'EAD6TQ8MCT5F91D1U5NQDO9QIC00000T'
AttributePartyUUID 'HSSNFC8II57HVBTAD3FCUJ7HE8000088'
12:02:24.945 Int 04544 Interaction message "EventCallPartyAdded" generated
12:02:24.945 Trc 04542 EventCallPartyAdded sent to [1152] (00000004 ors 10.0.241.5:65303)
SetDelivered: party 3199999.2428fd80-23eb8510:1, cause Null
-- TellQueued
-- party_info 3199999.25391c10 state change: from <Null> to <Queued>
-- aTmParty::SetBusinessType():3199999 unchanged
@12:02:24.9450 [ISCC] Party added [ddp view]:
@ c:00970349dedfa01d,00000000243633c0 @ m:0000000000000000,0000000000000000,0000000000000000 p:2 i:0100001d nw:00000000:0000000000000000 t:2
p:0000000025392510 @ c:00970349dedfa01d,00000000243633c0 r:1 t:1 s:1000c n:anonymous
+ p:0000000025391c10 @ c:00970349dedfa01d,00000000243633c0 r:2 t:0 s:9 n:3199999
@12:02:24.9450 [ISCC] Party object is created: p:0000000000000000,0000000025391c10 n:3199999:
@12:02:24.9450 [ISCC] Party added:
@ c:00970349dedfa01d,00000000243633c0 @ m:0000000000000000,0000000000000000 p:2 i:0100001d nw:0000000000000000 t:2
p:0000000000000000,0000000025392510 @ c:00970349dedfa01d,00000000243633c0 r:1 ----- n:anonymous:
+ p:0000000000000000,0000000025391c10 @ c:00970349dedfa01d,00000000243633c0 r:2 ----- n:3199999:
@12:02:24.9450 [0] 8.1.104.58 distribute call/party event: message EventCallPartyAdded
AttributeEventSequenceNumber 00000000000004e0
AttributeTimeStamp 63b2b9c0000e6b68
AttributeDBID 123
AttributeDN '3199999'
AttributeMediaType 0
AttributePartyState 0x9
AttributePartyType 0
AttributeConnID 00970349dedfa01d
AttributeCallUUID 'EAD6TQ8MCT5F91D1U5NQDO9QIC00000T'
AttributePartyUUID 'HSSNFC8II57HVBTAD3FCUJ7HE8000089'
12:02:24.945 Int 04544 Interaction message "EventCallPartyAdded" generated
12:02:24.945 Trc 04542 EventCallPartyAdded sent to [1152] (00000004 ors 10.0.241.5:65303)
push_queue: 3199999 for 3199999
@12:02:24.9450 [0] 8.1.104.58 distribute_event: message EventQueued
AttributeEventSequenceNumber 00000000000004e1
AttributeTimeinuSecs 945000
AttributeTimeinSecs 1672657344 (12:02:24)
AttributeExtensions [58] 00 02 00 00..
'OtherTrunkName' 'Trunk_SIP_Avaya1'
'BusinessCall' 1
AttributePartyUUID 'HSSNFC8II57HVBTAD3FCUJ7HE8000089'
AttributeThisQueue '3199999'
AttributeThisDNRole 2
AttributeThisDN '3199999'
AttributeANI 'anonymous'
AttributeDNIS '3199999'
AttributeCallUUID 'EAD6TQ8MCT5F91D1U5NQDO9QIC00000T'
AttributeConnID 00970349dedfa01d
AttributeCallID 16777245
AttributePropagatedCallType 2
AttributeCallType 2
AttributeCallState 0
AttributeOtherDNRole 1
AttributeOtherDN 'anonymous'
-- AgnEmu: Previous CallType is used when BusinessCall type changes
12:02:24.945 Int 04544 Interaction message "EventQueued" generated
12:02:24.945 Trc 04542 EventQueued sent to [1156] (00000005 urs 10.0.241.8:61546)
12:02:24.945 Trc 04542 EventQueued sent to [1152] (00000004 ors 10.0.241.5:65303)
12:02:24.945 Trc 04542 EventQueued sent to [848] (00000003 stat_server_routage 10.0.241.8:61545)
@12:02:24.9450 [0] 8.1.104.58 distribute_event: message EventRouteRequest
AttributeEventSequenceNumber 00000000000004e2
AttributeTimeinuSecs 945000
AttributeTimeinSecs 1672657344 (12:02:24)
AttributeExtensions [58] 00 02 00 00..
'OtherTrunkName' 'Trunk_SIP_Avaya1'
'BusinessCall' 1
AttributeOtherDNRole 1
AttributeOtherDN 'anonymous'
AttributePartyUUID 'HSSNFC8II57HVBTAD3FCUJ7HE8000089'
AttributeThisQueue '3199999'
AttributeThisDNRole 2
AttributeThisDN '3199999'
AttributeANI 'anonymous'
AttributeDNIS '3199999'
AttributeCallUUID 'EAD6TQ8MCT5F91D1U5NQDO9QIC00000T'
AttributeConnID 00970349dedfa01d
AttributeCallID 16777245
AttributePropagatedCallType 2
AttributeCallType 2
AttributeCallState 0
12:02:24.945 Int 04544 Interaction message "EventRouteRequest" generated
12:02:24.945 Trc 04542 EventRouteRequest sent to [1156] (00000005 urs 10.0.241.8:61546)
12:02:24.945 Trc 04542 EventRouteRequest sent to [1152] (00000004 ors 10.0.241.5:65303)
12:02:24.945 Trc 04542 EventRouteRequest sent to [848] (00000003 stat_server_routage 10.0.241.8:61545)
@12:02:24.9450 [0] 8.1.104.58 distribute call/party event: message EventCallPartyState
AttributeEventSequenceNumber 00000000000004e3
AttributeTimeStamp 63b2b9c0000e6b68
AttributePartyState 0x809
AttributeConnID 00970349dedfa01d
AttributeCallUUID 'EAD6TQ8MCT5F91D1U5NQDO9QIC00000T'
AttributePartyUUID 'HSSNFC8II57HVBTAD3FCUJ7HE8000089'
12:02:25.023 Trc 04541 RequestUpdateUserData received from [1156] (00000005 urs 10.0.241.8:61546)
message RequestUpdateUserData
AttributeThisDN '3199999'
AttributeConnID 00970349dedfa01d
AttributeUserData [520] 00 17 00 00..
'RVQID' ''
'RVQDBID' ''
'RTargetTypeSelected' '100'
'RTargetRuleSelected' ''
'RTargetObjectSelected' ''
'RTargetObjSelDBID' ''
'RTargetAgentSelected' ''
'RTargetAgSelDBID' ''
'RTargetPlaceSelected' ''
'RTargetPlSelDBID' ''
'RTenant' 'Environment'
'RTenantDBID' '1'
'RStrategyName' 'TestIRD'
'RStrategyDBID' '399'
'CBR-actual_volume' ''
'CBR-Interaction_cost' ''
'CBR-contract_DBIDs' ''
'CBR-IT-path_DBIDs' ''
'RRequestedSkillCombination' ''
'RRequestedSkills'(list)
'CustomerSegment' 'default'
'ServiceType' 'default'
'ServiceObjective' ''
AttributeReferenceID 494
12:02:25.023 Int 04543 Interaction message "RequestUpdateUserData" received from 1156 ("urs")
@12:02:25.0230 Call [00970349dedfa01d]: urid 00020097
@12:02:25.0230 [0] 8.1.104.58 distribute_response: message EventAttachedDataChanged
AttributeEventSequenceNumber 00000000000004e4
AttributeTimeinuSecs 23000
AttributeTimeinSecs 1672657345 (12:02:25)
AttributeReferenceID 494
AttributeThirdPartyDN '3199999'
AttributeThisDNRole 2
AttributeThisDN '3199999'
AttributeANI 'anonymous'
AttributeDNIS '3199999'
AttributeUserData [520] 00 17 00 00..
'RVQID' ''
'RVQDBID' ''
'RTargetTypeSelected' '100'
'RTargetRuleSelected' ''
'RTargetObjectSelected' ''
'RTargetObjSelDBID' ''
'RTargetAgentSelected' ''
'RTargetAgSelDBID' ''
'RTargetPlaceSelected' ''
'RTargetPlSelDBID' ''
'RTenant' 'Environment'
'RTenantDBID' '1'
'RStrategyName' 'TestIRD'
'RStrategyDBID' '399'
'CBR-actual_volume' ''
'CBR-Interaction_cost' ''
'CBR-contract_DBIDs' ''
'CBR-IT-path_DBIDs' ''
'RRequestedSkillCombination' ''
'RRequestedSkills'(list)
'CustomerSegment' 'default'
'ServiceType' 'default'
'ServiceObjective' ''
AttributeCallUUID 'EAD6TQ8MCT5F91D1U5NQDO9QIC00000T'
AttributeConnID 00970349dedfa01d
AttributeCallID 16777245
AttributePropagatedCallType 2
AttributeCallType 2
12:02:25.023 Int 04544 Interaction message "EventAttachedDataChanged" generated
12:02:25.023 Trc 04542 EventAttachedDataChanged sent to [1156] (00000005 urs 10.0.241.8:61546)
12:02:25.023 Trc 04542 EventAttachedDataChanged sent to [848] (00000003 stat_server_routage 10.0.241.8:61545)
@12:02:25.0230 [ISCC] Updated call:
i c:00970349dedfa01d,00000000243633c0 @ m:0000000000000000,0000000000000000 p:2 i:0100001d nw:0000000000000000 t:2
p:0000000000000000,0000000025392510 @ c:00970349dedfa01d,00000000243633c0 r:1 ----- n:anonymous:
p:0000000000000000,0000000025391c10 @ c:00970349dedfa01d,00000000243633c0 r:2 ----- n:3199999:
@12:02:25.0230 [ISCC] UserData propagation has been started
@12:02:25.0230 [ISCC] UserData propagation has been finished
12:02:25.023 -- call_info::committed changed
@12:02:25.0230 [0] 8.1.104.58 distribute call/party event: message EventCallDataChanged
AttributeEventSequenceNumber 00000000000004e5
AttributeTimeStamp 63b2b9c1000059d8
AttributeConnID 00970349dedfa01d
AttributeCallUUID 'EAD6TQ8MCT5F91D1U5NQDO9QIC00000T'
AttributeCtrlParty '3199999'
AttributeUserData [520] 00 17 00 00..
'RVQID' ''
'RVQDBID' ''
'RTargetTypeSelected' '100'
'RTargetRuleSelected' ''
'RTargetObjectSelected' ''
'RTargetObjSelDBID' ''
'RTargetAgentSelected' ''
'RTargetAgSelDBID' ''
'RTargetPlaceSelected' ''
'RTargetPlSelDBID' ''
'RTenant' 'Environment'
'RTenantDBID' '1'
'RStrategyName' 'TestIRD'
'RStrategyDBID' '399'
'CBR-actual_volume' ''
'CBR-Interaction_cost' ''
'CBR-contract_DBIDs' ''
'CBR-IT-path_DBIDs' ''
'RRequestedSkillCombination' ''
'RRequestedSkills'(list)
'CustomerSegment' 'default'
'ServiceType' 'default'
'ServiceObjective' ''
12:02:25.023 Int 04544 Interaction message "EventCallDataChanged" generated
12:02:25.023 Trc 04542 EventCallDataChanged sent to [1152] (00000004 ors 10.0.241.5:65303)
12:02:25.023 -- created: CRequest@2273e410 RequestUpdateUserData-urs[1156]/494
12:02:25.023: $+TLIB:CTI:Unknown:0:139489259
12:02:25.023 -- deleted: CRequest@2273e410 RequestUpdateUserData-urs[1156]/494
12:02:25.023: $-TLIB:CTI:Unknown:0:7
12:02:25.023 Trc 04541 RequestRouteCall received from [1156] (00000005 urs 10.0.241.8:61546)
message RequestRouteCall
AttributeThisDN '3199999'
AttributeConnID 00970349dedfa01d
AttributeOtherDN '1234567'
AttributeExtensions [48] 00 02 00 00..
'CUSTOMER_ID' 'Environment'
'SWITCH' 'SIP_prod'
AttributeRouteType 6 (RouteTypeDirect)
AttributeReason [14] 00 01 01 00..
'RTR' 109
AttributeReferenceID 495
12:02:25.023 Int 04543 Interaction message "RequestRouteCall" received from 1156 ("urs")
@12:02:25.0230 [ISCC] destination_location substituted by local
@12:02:25.0230 [ISCC] destination_location substituted by local
12:02:25.023 -- created: CRequest@2273e670 RequestRouteCall-urs[1156]/495
12:02:25.023: $+TLIB:CTI:Unknown:0:32
12:02:25.023 +++ CIFace::Request +++
-- new invoke
-- thisCall by party
Parsed: RequestRouteCall
From: urs[1156]/495
Numbers: +<3199999> +<1234567>
Calls: 23eb8510:1 none
Parties: 3199999.2428fd80-23eb8510:1
none
Status: parsed:1 queued:0 sent:0 acked:0 preevent:0 event:0 context:0 transferred:0
-----
-- validate
-- state check: ok
CIFace: Sent CRequest@2273e670 RequestRouteCall-urs[1156]/495
-- aTmCall 00970349dedfa01d SetCause: Distributed to 1234567
-- created NAData 23fa1030
FinishRequest CRequest@2273e670 RequestRouteCall-urs[1156]/495
IFace stats: q=0 s=0
-- complete
-- NAData ClRq removed
TNAEmulator::NotifyBackup()
12:02:25.023: RID:CUUID>495:EAD6TQ8MCT5F91D1U5NQDO9QIC00000T:
12:02:25.023: IncrementRouteRequestCounter, option 100
12:02:25.023: GetRtPartyId: call 16777245, party 16777409
12:02:25.023: GetRtPartyId: routingLinkId not set
12:02:25.023: GetRtPartyId: call 16777245, party 16777409
12:02:25.023: GetRtPartyId: routingLinkId not set
12:02:25.023 SIPCONN(anonymous): re-invite-called-initiated
12:02:25.023: transfer re-INVITE
12:02:25.023 SIPCONN(1234567): set monitor 0000000024d5f030, 0000000023fabd68
12:02:25.023: SIPCALL(16777245): add party '1234567'
12:02:25.023 SIPPARTY(1234567): Set Origination Info DN - anonymous ; Location - SIP_prod for party 1234567
12:02:25.023: SIPTS: OnPartyCreated
-- created party_info_tspp 25392e10
-- created aTmParty 2428faf0
SetRole: Destination for 1234567.2428faf0-23eb8510:1
-- AddParty to 23eb8510: 1234567.2428faf0-23eb8510:1 after 3199999.2428fd80-23eb8510:1
CreateParty new internal: 1234567.2428faf0-23eb8510:1
12:02:25.023: Call 16777245 dn 1234567 SetPartyId 16777410
12:02:25.023: XS info is stored to TServer party 1234567: loginSessionId: , loginLocation: ; employeeId
12:02:25.023: Sc(355):step 0, Tr(356,SipTransactionTransferCall) - begin
Session value of the SDP is [1672657344]
Version values of the SDP is [1]
12:02:25.023 SIPCONN(1234567): SIPCONN(0000000024d5f030,BD928RELK16D705QTHFAT93GAS00001N) +Tr(356,SipTransactionTransferCall)
12:02:25.023 SIPCONN(1234567): re-invite-null
12:02:25.023: SipDialog: set monitor 0000000024d5f0e8
12:02:25.023 SIPCONN(1234567): main dialog 0 created, flags 0x21f
12:02:25.023 SIPCONN(1234567): Local contact: '<sip:anonymous@10.0.243.198:5060>'
12:02:25.023: add party info '1234567' state 0.
12:02:25.023: SIPDLG[72]: register TRN[102405]
12:02:25.023: SIPDLG[72]: TRN[102405] flags set to 0x6
12:02:25.023: GSProxyRegistar: Round robin slot selected for [1234567]
12:02:25.023: SipDialog::PrepareAliasedConnectionInfo: SelectActiveTransport dlg 72 10.0.100.19:5060
12:02:25.023: DIALOG_TRANSPORT_ASSOCIATION [72->1234567@10.0.100.19:5060:1] SET
12:02:25.023: Sending [0,UDP] 1191 bytes to 10.0.100.19:5060 >>>>>
INVITE sip:1234567@10.0.100.19:5060 SIP/2.0
From: "Anonymous" <sip:anonymous@anonymous.invalid>;tag=DC0096FE-ED23-4512-A58E-C23DBBEEC541-86575
To: <sip:3199999@10.0.243.198:5060>
Call-ID: 355466C1-3270-4CAD-8F28-2B7E02174511-86534@10.0.243.198
CSeq: 1 INVITE
Content-Length: 199
Content-Type: application/sdp
Via: SIP/2.0/UDP 10.0.243.198:5060;branch=z9hG4bKA2A93EAE-1DBD-4D31-A0B6-45D2D5CA1A98-86
Contact: <sip:anonymous@10.0.243.198:5060>
X-Genesys-CallInfo: routed
Allow: ACK, BYE, CANCEL, INFO, INVITE, MESSAGE, NOTIFY, OPTIONS, PRACK, REFER, UPDATE
Max-Breadth: 60
P-Asserted-Identity: "Laurent CEA" <sip:sip.propro>
History-Info: <sip:3199999@sip.propro>;index=1
History-Info: "3199999" <sip:3199999@sip.propro>;index=1.1
Accept-Language: en
User-Agent: Avaya CM/R018x.01.0.890.0 AVAYA-SM-8.1.3.4.813401
Max-Forwards: 65
X-Genesys-CallUUID: EAD6TQ8MCT5F91D1U5NQDO9QIC00000T
Privacy: id
Session-Expires: 1800;refresher=uac
Min-SE: 90
Supported: uui,100rel,timer
v=0
o=- 1671713018 1 IN IP4 172.20.80.56
s=-
c=IN IP4 172.20.80.56
b=AS:64
t=0 0
a=avf:avc=n prio=n
a=csup:avf-v0
m=audio 2136 RTP/AVP 8 0 127
a=sendrecv
a=rtpmap:127 telephone-event/8000
12:02:25.023: SipDialog: event SEND_INVITE, t=102405, s=2, r=7, m=0000000024d5f0e8 port=5060
12:02:25.023: CID:CUUID>355466C1-3270-4CAD-8F28-2B7E02174511-86534@10.0.243.198:EAD6TQ8MCT5F91D1U5NQDO9QIC00000T:
12:02:25.023 SIPCONN(1234567): HandleSipDialogEvent(SEND_INVITE) - filtered
12:02:25.023 SIPCONN(1234567): sdp state SDP_STATE_NULL, event SDP_EVENT_OFFER_SENT
12:02:25.023 SIPCONN(1234567): new sdp state SDP_STATE_OFFER_SENT, event SDP_EVENT_OFFER_SENT
12:02:25.023 --- CIFace::Request ---
12:02:25.023: $-TLIB:CTI:Unknown:0:819
12:02:25.023: SipDialog: event CALLING_RESPROV, t=102405, s=2, r=5, m=0000000024d5f0e8 port=5060
12:02:25.023: CID:CUUID>355466C1-3270-4CAD-8F28-2B7E02174511-86534@10.0.243.198:EAD6TQ8MCT5F91D1U5NQDO9QIC00000T:
12:02:25.023 SIPCONN(1234567): HandleSipDialogEvent(CALLING_RESPROV)
12:02:25.023 SIPCONN(1234567): Capabilities 61013f
12:02:25.023 SIPCONN(1234567): reliable=0
12:02:25.023 SIPCONN(1234567): store remote content, canBeOffer 1
12:02:25.023 SIPCONN(1234567): store remote content - trying ignored
12:02:25.023 SIPCONN(1234567): Trying Timer for 32000 mlsec started...
12:02:25.023: $-NET:SIP::0:38
12:02:25.023: $+NET:SIP::0:0
12:02:25.023: SIPTR: Received [0,UDP] 542 bytes from 10.0.100.19:5060 <<<<<
SIP/2.0 500 Server Internal Error (Cannot determine realm)
Call-ID: 355466C1-3270-4CAD-8F28-2B7E02174511-86534@10.0.243.198
CSeq: 1 INVITE
From: "Anonymous" <sip:anonymous@anonymous.invalid>;tag=DC0096FE-ED23-4512-A58E-C23DBBEEC541-86575
To: <sip:3199999@10.0.243.198:5060>;tag=2761704973578306_local.1650475683567_27343495_27391302
Via: SIP/2.0/UDP 10.0.243.198:5060;branch=z9hG4bKA2A93EAE-1DBD-4D31-A0B6-45D2D5CA1A98-86
Av-Global-Session-ID: f050e000-8a8c-11ed-8247-005056a1af0c
Server: AVAYA-SM-8.1.3.4.813401
Content-Length: 0
12:02:25.023: Sending [0,UDP] 509 bytes to 10.0.100.19:5060 >>>>>
ACK sip:1234567@10.0.100.19:5060 SIP/2.0
Via: SIP/2.0/UDP 10.0.243.198:5060;branch=z9hG4bKA2A93EAE-1DBD-4D31-A0B6-45D2D5CA1A98-86
From: "Anonymous" <sip:anonymous@anonymous.invalid>;tag=DC0096FE-ED23-4512-A58E-C23DBBEEC541-86575
To: <sip:3199999@10.0.243.198:5060>;tag=2761704973578306_local.1650475683567_27343495_27391302
Call-ID: 355466C1-3270-4CAD-8F28-2B7E02174511-86534@10.0.243.198
CSeq: 1 ACK
Max-Forwards: 65
User-Agent: Avaya CM/R018x.01.0.890.0 AVAYA-SM-8.1.3.4.813401
Content-Length: 0
12:02:25.023: SipDialog: event CALLING_RESREJECT, t=102405, s=9, r=5, m=0000000024d5f0e8 port=5060
12:02:25.023: CID:CUUID>355466C1-3270-4CAD-8F28-2B7E02174511-86534@10.0.243.198:EAD6TQ8MCT5F91D1U5NQDO9QIC00000T:
12:02:25.023 SIPCONN(1234567): HandleSipDialogEvent(CALLING_RESREJECT)
12:02:25.023 SIPCONN(1234567): Trying Timer deleted...
12:02:25.023 SIPCONN(1234567): ConvertResponse: 500
12:02:25.023 SIPCONN(1234567): ConvertResponse: no conversion configured for 500
12:02:25.023 SIPCONN(1234567): Failed to obtain Media Server ID
12:02:25.023 SIPCONN(1234567): Failed to obtain Media Server ID
12:02:25.023: GetRtPartyId: call 16777245, party 16777410
12:02:25.023: GetRtPartyId: looking up party 16777409
12:02:25.023 SIPCONN(1234567): state e:4,p:0,s:6,c:8,rc:500,m:1
12:02:25.023 SIPPARTY(1234567): 16777410 verify update of party-connection state N-F
12:02:25.023 SIPPARTY(1234567): 16777410 update party-connection state N-F
12:02:25.023 SIPPARTY(1234567): ChangePartyState: new=6
12:02:25.023: SIPTS: '1234567' state changed null->fail, cause 8
12:02:25.023 -- thisCall by party
12:02:25.023 SetContext: for party 3199999.2428fd80-23eb8510:1
12:02:25.023 +++ CIFace::Event +++
+++ Pre-event +++
Type EventError
Devices: <3199999/3199999> <-/-> <-/->
Calls: 16777245/00970349dedfa01d/16777245.23eb8510/c:2/r:1 0/none
Parties: D3199999/3199999.2428fd80-23eb8510:1/l:2/r:1/Queued,RtRequest,Destination
none
none
Cause: Busy/3, Info: 231
Flags: divert=0 hook=0 postCall=0 active=1 moveAll=1 callType=1 hideOtherPi=0 InternalOther=0
--- Pre-event ---
+++ Error +++
-- thisCall by party
12:02:25.023 Trc 36002 Request rejected: error code 231(DN is busy)
@12:02:25.0230 [0] 8.1.104.58 send_to_client: message EventError
(DN is busy)
AttributeEventSequenceNumber 00000000000004e6
AttributeTimeinuSecs 23000
AttributeTimeinSecs 1672657345 (12:02:25)
AttributeExtensions [48] 00 02 00 00..
'CUSTOMER_ID' 'Environment'
'SWITCH' 'SIP_prod'
AttributeErrorCode 231
AttributeErrorMessage 'DN is busy'
AttributeReferenceID 495
AttributeReason [14] 00 01 01 00..
'RTR' 109
AttributeRouteType 6 (RouteTypeDirect)
AttributeOtherDN '1234567'
AttributeConnID 00970349dedfa01d
AttributeThisDN '3199999'
AttributeClientID 5
12:02:25.023 Int 04545 Interaction message "EventError" sent to 1156 ("urs")
12:02:25.023 Trc 04542 EventError sent to [1156] (00000005 urs 10.0.241.8:61546)
--- Error ---
+++ Post-event +++
Type EventError
Devices: <3199999/3199999> <-/-> <-/->
Calls: 16777245/00970349dedfa01d/16777245.23eb8510/c:2/r:1 0/none
Parties: D3199999/3199999.2428fd80-23eb8510:1/l:2/r:1/Queued,RtRequest,Destination
none
none
Cause: Busy/3, Info: 231
Flags: divert=0 hook=0 postCall=0 active=1 moveAll=1 callType=1 hideOtherPi=0 InternalOther=0
--- Post-event ---
12:02:25.023 --- CIFace::Event ---
12:02:25.023 -- thisCall by party
12:02:25.023: check call postponed until end of operation
12:02:25.023 SIPCONN(1234567): terminate dialog
12:02:25.023: SipDialog: set monitor 0000000000000000
12:02:25.023: SipDialog::Terminate(state=9,reason=0)
12:02:25.023 SIPCONN(1234567): state e:4,p:6,s:6,c:8,rc:500,m:1
12:02:25.023 SIPPARTY(1234567): 16777410 verify update of party-connection state F-F
12:02:25.023 SIPCONN(anonymous): CheckUpdateTransferStatus: no original dialog
12:02:25.023 SIPCONN(1234567): SIPCONN(0000000024d5f030,BD928RELK16D705QTHFAT93GAS00001N) -Tr(356,SipTransactionTransferCall)
12:02:25.023: Tr(356,SipTransactionTransferCall):failed
12:02:25.023: Sc(355):step 0, Tr(356,SipTransactionTransferCall) - failed
12:02:25.023: Tr(355,SipScenario):failed
12:02:25.023: SIPCM: transaction Tr(355,SipScenario) failed
12:02:25.023: GetOtherParty: not two way call - 3
12:02:25.023: PI-1: 00 S[IN]D[anonymous]C[*D[anonymous]]P[-]
12:02:25.023: PI-1: 00 S[QN]D[3199999]E[-]
12:02:25.023: GetOtherParty: not two way call - 3
12:02:25.023: PI: 01 S[FN]D[1234567]P[-] - can't recover
12:02:25.023: SD: none
12:02:25.023 SIPCONN(1234567): CONNCHECK: dialog=0
12:02:25.023 SIPCONN(1234567): CONNCHECK: dialog=0
12:02:25.023 SIPCONN(1234567): set monitor 0000000024d5f030, 0000000000000000
12:02:25.023 SIPCONN(1234567): state e:1,p:6,s:0,c:0,rc:0,m:0
12:02:25.023 SIPCONN(1234567): DetachMediaPeer
12:02:25.023 SIPPARTY(1234567): ChangePartyState: new=0
12:02:25.023: SIPTS: '1234567' state changed fail->null, cause 0
12:02:25.023 -- setting cntrlDN=1234567 (for 2 parties)
12:02:25.023 -- setting cntrlDN=1234567 (for 2 parties)
12:02:25.023 -- setting cntrlDN=1234567 (for 2 parties)
12:02:25.023: duplicate check for routing failure
12:02:25.023: Adding OtherTrunkName(Trunk_SIP_Avaya1): done
12:02:25.023 ClearContext: party 1234567.2428faf0-23eb8510:1
12:02:25.023 +++ CIFace::Event +++
+++ Pre-event +++
Type EventReleased
Devices: <1234567/1234567> <-/anonymous> <-/->
Calls: 16777245/00970349dedfa01d/16777245.23eb8510/c:2/r:1 0/none
Parties: D1234567/1234567.2428faf0-23eb8510:1/l:2/r:0/Null,Destination
Xanonymous/anonymous.2428f5d0-23eb8510:1/l:1/r:0/Dialing,Origination
none
Cause: CallForwardBusy/7, Info: 0
Flags: divert=0 hook=1 postCall=0 active=1 moveAll=1 callType=1 hideOtherPi=0 InternalOther=0
--- Pre-event ---
+++ Released +++
-- XAction: start 1234567.2428faf0-23eb8510:1
SetReleased: party 1234567.2428faf0-23eb8510:1, cause CallForwardBusy
-- not connected
-- XAction: commit 1234567.2428faf0-23eb8510:1
12:02:25.023: device on hook
--- Released ---
+++ Post-event +++
Type EventReleased
Devices: <1234567/1234567> <-/anonymous> <-/->
Calls: 16777245/00970349dedfa01d/16777245.23eb8510/c:2/r:1 0/none
Parties: D1234567/1234567.2428faf0-23eb8510:1/l:2/r:0/Released,Destination
Xanonymous/anonymous.2428f5d0-23eb8510:1/l:1/r:0/Dialing,Origination
none
Cause: CallForwardBusy/7, Info: 0
Flags: divert=0 hook=1 postCall=0 active=1 moveAll=1 callType=1 hideOtherPi=0 InternalOther=0
--- Post-event ---
12:02:25.023 --- CIFace::Event ---
12:02:25.023 -- deleted aTmParty 2428faf0
12:02:25.023 -- RemoveParty 1234567.2428faf0-23eb8510:1
12:02:25.023 -- deleted party_info_tspp 25392e10
12:02:25.023: check call postponed until end of operation
12:02:25.023: Sc(355):step 0, No active transactions to verify for greeting
12:02:25.023: call will not be released alive: 2, null: 1, forkAlive: 0
12:02:25.023: 3pcc release, check call postponed until complete of current operation
12:02:25.023: SIPCM: delete party 1234567:16777410
12:02:25.023: SIPCALL(16777245): delete party '1234567'
12:02:25.023: GetPartyInfo party with partyId 16777410 not found
12:02:25.023: SipCallManager::OnTransactionFailure: Internal context, doesn't notify
12:02:25.023: OnRequestFailed
12:02:25.023 -- thisCall by party
12:02:25.023: call1 16777245 idle
12:02:25.023: SipDialog: event DESTROY, t=0, s=10, r=4, m=0000000000000000 port=5060
12:02:25.023: CID:CUUID>355466C1-3270-4CAD-8F28-2B7E02174511-86534@10.0.243.198:EAD6TQ8MCT5F91D1U5NQDO9QIC00000T:
12:02:25.023: DIALOG_TRANSPORT_ASSOCIATION[72] DELETED. TOTAL[0]
12:02:25.023: SipDialog[72]:<< Abort ALL <<
12:02:25.023: $-NET:SIP::0:664
12:02:25.132 Trc 04541 RequestUpdateUserData received from [1156] (00000005 urs 10.0.241.8:61546)
message RequestUpdateUserData
AttributeThisDN '3199999'
AttributeConnID 00970349dedfa01d
AttributeUserData [424] 00 13 00 00..
'RVQID' ''
'RVQDBID' ''
'RTargetTypeSelected' '100'
'RTargetRuleSelected' ''
'RTargetObjectSelected' ''
'RTargetObjSelDBID' ''
'RTargetAgentSelected' ''
'RTargetAgSelDBID' ''
'RTargetPlaceSelected' ''
'RTargetPlSelDBID' ''
'RTenant' 'Environment'
'RTenantDBID' '1'
'RStrategyName' 'TestIRD'
'RStrategyDBID' '399'
'CBR-actual_volume' ''
'CBR-Interaction_cost' ''
'CBR-contract_DBIDs' ''
'CBR-IT-path_DBIDs' ''
'RRequestedSkillCombination' ''
AttributeReferenceID 496
12:02:25.132 Int 04543 Interaction message "RequestUpdateUserData" received from 1156 ("urs")
@12:02:25.1320 Call [00970349dedfa01d]: urid 00030097
@12:02:25.1320 [0] 8.1.104.58 distribute_response: message EventAttachedDataChanged
AttributeEventSequenceNumber 00000000000004e7
AttributeTimeinuSecs 132000
AttributeTimeinSecs 1672657345 (12:02:25)
AttributeReferenceID 496
AttributeThirdPartyDN '3199999'
AttributeThisDNRole 2
AttributeThisDN '3199999'
AttributeANI 'anonymous'
AttributeDNIS '3199999'
AttributeUserData [520] 00 17 03 00..
'RRequestedSkills'(list)
'CustomerSegment' 'default'
'ServiceType' 'default'
'ServiceObjective' ''
'RVQID' ''
'RVQDBID' ''
'RTargetTypeSelected' '100'
'RTargetRuleSelected' ''
'RTargetObjectSelected' ''
'RTargetObjSelDBID' ''
'RTargetAgentSelected' ''
'RTargetAgSelDBID' ''
'RTargetPlaceSelected' ''
'RTargetPlSelDBID' ''
'RTenant' 'Environment'
'RTenantDBID' '1'
'RStrategyName' 'TestIRD'
'RStrategyDBID' '399'
'CBR-actual_volume' ''
'CBR-Interaction_cost' ''
'CBR-contract_DBIDs' ''
'CBR-IT-path_DBIDs' ''
'RRequestedSkillCombination' ''
AttributeCallUUID 'EAD6TQ8MCT5F91D1U5NQDO9QIC00000T'
AttributeConnID 00970349dedfa01d
AttributeCallID 16777245
AttributePropagatedCallType 2
AttributeCallType 2
12:02:25.132 Int 04544 Interaction message "EventAttachedDataChanged" generated
12:02:25.132 Trc 04542 EventAttachedDataChanged sent to [1156] (00000005 urs 10.0.241.8:61546)
12:02:25.132 Trc 04542 EventAttachedDataChanged sent to [848] (00000003 stat_server_routage 10.0.241.8:61545)
@12:02:25.1320 [ISCC] Updated call:
i c:00970349dedfa01d,00000000243633c0 @ m:0000000000000000,0000000000000000 p:2 i:0100001d nw:0000000000000000 t:2
p:0000000000000000,0000000025392510 @ c:00970349dedfa01d,00000000243633c0 r:1 ----- n:anonymous:
p:0000000000000000,0000000025391c10 @ c:00970349dedfa01d,00000000243633c0 r:2 ----- n:3199999:
@12:02:25.1320 [ISCC] UserData propagation has been started
@12:02:25.1320 [ISCC] UserData propagation has been finished
12:02:25.132 -- call_info::committed changed
@12:02:25.1320 [0] 8.1.104.58 distribute call/party event: message EventCallDataChanged
AttributeEventSequenceNumber 00000000000004e8
AttributeTimeStamp 63b2b9c1000203a0
AttributeConnID 00970349dedfa01d
AttributeCallUUID 'EAD6TQ8MCT5F91D1U5NQDO9QIC00000T'
AttributeCtrlParty '3199999'
AttributeUserData [520] 00 17 03 00..
'RRequestedSkills'(list)
'CustomerSegment' 'default'
'ServiceType' 'default'
'ServiceObjective' ''
'RVQID' ''
'RVQDBID' ''
'RTargetTypeSelected' '100'
'RTargetRuleSelected' ''
'RTargetObjectSelected' ''
'RTargetObjSelDBID' ''
'RTargetAgentSelected' ''
'RTargetAgSelDBID' ''
'RTargetPlaceSelected' ''
'RTargetPlSelDBID' ''
'RTenant' 'Environment'
'RTenantDBID' '1'
'RStrategyName' 'TestIRD'
'RStrategyDBID' '399'
'CBR-actual_volume' ''
'CBR-Interaction_cost' ''
'CBR-contract_DBIDs' ''
'CBR-IT-path_DBIDs' ''
'RRequestedSkillCombination' ''
AttributeDialedNumber ''
12:02:25.132 Int 04544 Interaction message "EventCallDataChanged" generated
12:02:25.132 Trc 04542 EventCallDataChanged sent to [1152] (00000004 ors 10.0.241.5:65303)
12:02:25.132 -- created: CRequest@2273ea00 RequestUpdateUserData-urs[1156]/496
12:02:25.132: $+TLIB:CTI:Unknown:0:108533
12:02:25.132 -- deleted: CRequest@2273ea00 RequestUpdateUserData-urs[1156]/496
12:02:25.132: $-TLIB:CTI:Unknown:0:8
12:02:25.132 Trc 04541 RequestUpdateUserData received from [1156] (00000005 urs 10.0.241.8:61546)
message RequestUpdateUserData
AttributeThisDN '3199999'
AttributeConnID 00970349dedfa01d
AttributeUserData [17] 00 01 01 00..
'PegDEF' 1
AttributeReferenceID 497
12:02:25.132 Int 04543 Interaction message "RequestUpdateUserData" received from 1156 ("urs")
@12:02:25.1320 Call [00970349dedfa01d]: urid 00040097
@12:02:25.1320 [0] 8.1.104.58 distribute_response: message EventAttachedDataChanged
AttributeEventSequenceNumber 00000000000004e9
AttributeTimeinuSecs 132000
AttributeTimeinSecs 1672657345 (12:02:25)
AttributeReferenceID 497
AttributeThirdPartyDN '3199999'
AttributeThisDNRole 2
AttributeThisDN '3199999'
AttributeANI 'anonymous'
AttributeDNIS '3199999'
AttributeUserData [535] 00 18 03 00..
'RRequestedSkills'(list)
'CustomerSegment' 'default'
'ServiceType' 'default'
'ServiceObjective' ''
'RVQID' ''
'RVQDBID' ''
'RTargetTypeSelected' '100'
'RTargetRuleSelected' ''
'RTargetObjectSelected' ''
'RTargetObjSelDBID' ''
'RTargetAgentSelected' ''
'RTargetAgSelDBID' ''
'RTargetPlaceSelected' ''
'RTargetPlSelDBID' ''
'RTenant' 'Environment'
'RTenantDBID' '1'
'RStrategyName' 'TestIRD'
'RStrategyDBID' '399'
'CBR-actual_volume' ''
'CBR-Interaction_cost' ''
'CBR-contract_DBIDs' ''
'CBR-IT-path_DBIDs' ''
'RRequestedSkillCombination' ''
'PegDEF' 1
AttributeCallUUID 'EAD6TQ8MCT5F91D1U5NQDO9QIC00000T'
AttributeConnID 00970349dedfa01d
AttributeCallID 16777245
AttributePropagatedCallType 2
AttributeCallType 2
12:02:25.132 Int 04544 Interaction message "EventAttachedDataChanged" generated
12:02:25.132 Trc 04542 EventAttachedDataChanged sent to [1156] (00000005 urs 10.0.241.8:61546)
12:02:25.132 Trc 04542 EventAttachedDataChanged sent to [848] (00000003 stat_server_routage 10.0.241.8:61545)
@12:02:25.1320 [ISCC] Updated call:
i c:00970349dedfa01d,00000000243633c0 @ m:0000000000000000,0000000000000000 p:2 i:0100001d nw:0000000000000000 t:2
p:0000000000000000,0000000025392510 @ c:00970349dedfa01d,00000000243633c0 r:1 ----- n:anonymous:
p:0000000000000000,0000000025391c10 @ c:00970349dedfa01d,00000000243633c0 r:2 ----- n:3199999:
@12:02:25.1320 [ISCC] UserData propagation has been started
@12:02:25.1320 [ISCC] UserData propagation has been finished
12:02:25.132 -- call_info::committed changed
@12:02:25.1320 [0] 8.1.104.58 distribute call/party event: message EventCallDataChanged
AttributeEventSequenceNumber 00000000000004ea
AttributeTimeStamp 63b2b9c1000203a0
AttributeConnID 00970349dedfa01d
AttributeCallUUID 'EAD6TQ8MCT5F91D1U5NQDO9QIC00000T'
AttributeCtrlParty '3199999'
AttributeUserData [535] 00 18 03 00..
'RRequestedSkills'(list)
'CustomerSegment' 'default'
'ServiceType' 'default'
'ServiceObjective' ''
'RVQID' ''
'RVQDBID' ''
'RTargetTypeSelected' '100'
'RTargetRuleSelected' ''
'RTargetObjectSelected' ''
'RTargetObjSelDBID' ''
'RTargetAgentSelected' ''
'RTargetAgSelDBID' ''
'RTargetPlaceSelected' ''
'RTargetPlSelDBID' ''
'RTenant' 'Environment'
'RTenantDBID' '1'
'RStrategyName' 'TestIRD'
'RStrategyDBID' '399'
'CBR-actual_volume' ''
'CBR-Interaction_cost' ''
'CBR-contract_DBIDs' ''
'CBR-IT-path_DBIDs' ''
'RRequestedSkillCombination' ''
'PegDEF' 1
12:02:25.132 Int 04544 Interaction message "EventCallDataChanged" generated
12:02:25.132 Trc 04542 EventCallDataChanged sent to [1152] (00000004 ors 10.0.241.5:65303)
12:02:25.132 -- created: CRequest@2273d110 RequestUpdateUserData-urs[1156]/497
12:02:25.132: $+TLIB:CTI:Unknown:0:144
12:02:25.132 -- deleted: CRequest@2273d110 RequestUpdateUserData-urs[1156]/497
12:02:25.132: $-TLIB:CTI:Unknown:0:3
12:02:25.132 Trc 04541 RequestRouteCall received from [1156] (00000005 urs 10.0.241.8:61546)
message RequestRouteCall
AttributeThisDN '3199999'
AttributeConnID 00970349dedfa01d
AttributeOtherDN ''
AttributeExtensions [48] 00 02 00 00..
'CUSTOMER_ID' 'Environment'
'SWITCH' 'SIP_prod'
AttributeRouteType 1 (RouteTypeDefault)
AttributeReason [14] 00 01 01 00..
'RTR' 109
AttributeReferenceID 498
12:02:25.132 Int 04543 Interaction message "RequestRouteCall" received from 1156 ("urs")
@12:02:25.1320 [ISCC] destination_location substituted by local
@12:02:25.1320 [ISCC] destination_location substituted by local
12:02:25.132 -- created: CRequest@2273e8d0 RequestRouteCall-urs[1156]/498
12:02:25.132: $+TLIB:CTI:Unknown:0:49
12:02:25.132 +++ CIFace::Request +++
-- new invoke
12:02:25.132 Trc 36210 Client 5(urs): no destination DN in request
-- thisCall by party
Parsed: RequestRouteCall
From: urs[1156]/498
Numbers: +<3199999> -<none>
Calls: 23eb8510:1 none
Parties: 3199999.2428fd80-23eb8510:1
none
Status: parsed:1 queued:0 sent:0 acked:0 preevent:0 event:0 context:0 transferred:0
-----
-- validate
-- state check: ok
CIFace: Sent CRequest@2273e8d0 RequestRouteCall-urs[1156]/498
-- aTmCall 00970349dedfa01d SetCause: Distributed
FinishRequest CRequest@2273e8d0 RequestRouteCall-urs[1156]/498
IFace stats: q=0 s=0
-- complete
-- NAData ClRq removed
TNAEmulator::NotifyBackup()
12:02:25.132: RID:CUUID>498:EAD6TQ8MCT5F91D1U5NQDO9QIC00000T:
12:02:25.132: routing destination missing, no default-dn is specified
Response (415): for CRequest@2273e8d0 RequestRouteCall-urs[1156]/498
12:02:25.132 Trc 36210 Client 5(urs): no destination DN in request
-- thisCall by party
12:02:25.132 Trc 36002 Request rejected: error code 415(Invalid Destination DN)
@12:02:25.1320 [0] 8.1.104.58 send_to_client: message EventError
(Invalid Destination DN)
AttributeEventSequenceNumber 00000000000004eb
AttributeTimeinuSecs 132000
AttributeTimeinSecs 1672657345 (12:02:25)
AttributeErrorCode 415
AttributeErrorMessage 'Invalid Destination DN'
AttributeReferenceID 498
AttributeReason [14] 00 01 01 00..
'RTR' 109
AttributeRouteType 1 (RouteTypeDefault)
AttributeExtensions [48] 00 02 00 00..
'CUSTOMER_ID' 'Environment'
'SWITCH' 'SIP_prod'
AttributeOtherDN ''
AttributeConnID 00970349dedfa01d
AttributeThisDN '3199999'
AttributeClientID 5
12:02:25.132 Int 04545 Interaction message "EventError" sent to 1156 ("urs")
12:02:25.132 Trc 04542 EventError sent to [1156] (00000005 urs 10.0.241.8:61546)
FinishRequest: second time for CRequest@2273e8d0 RequestRouteCall-urs[1156]/498
12:02:25.132 --- CIFace::Request ---
12:02:25.132 -- deleted: CRequest@2273e8d0 RequestRouteCall-urs[1156]/498
12:02:25.132: $-TLIB:CTI:Unknown:0:110
12:02:35.015: ROUTE(3199999,partyId:16777409): timeout
12:02:35.015: ROUTE(3199999,00970349dedfa01d): default routing
12:02:35.858: $+NET:SIP::0:0
12:02:35.858: SIPS:LOGBLOCK:BEGIN:SIPMSG:[
12:02:35.858: SIPTR: Received [18916,TCP] 998 bytes from 10.0.100.19:19682 <<<<<
CANCEL sip:3199999@sip.propro SIP/2.0
Record-Route: <sip:CASMSR1@10.0.100.19;transport=tcp;lr;av-asset-uid=7a08dc0e>
Route: <sip:10.0.243.198;transport=tcp;lr;phase=terminating;m-type=audio>
CSeq: 1 CANCEL
Call-ID: f043511a8a8c41edbf9f05056a1f079
From: "Laurent CEA" <sip:anonymous@sip.propro>;tag=f04350e88a8c41edbf9e05056a1f079
To: <sip:3199999@sip.propro>
Via: SIP/2.0/TCP 10.0.100.19;branch=z9hG4bK447796361848712-AP;ft=12
Via: SIP/2.0/TCP 127.0.0.2:15060;rport=35383;ibmsid=local.1650475683567_27343494_27391301;branch=z9hG4bK447796361848712
Via: SIP/2.0/TCP 127.0.0.2:15060;rport;ibmsid=local.1650475683567_27343493_27391300;branch=z9hG4bK316832230478823
Via: SIP/2.0/TCP 10.0.100.19:5067;branch=z9hG4bKf0435ae88a8c41edbfa005056a1f079-AP;ft=1677811;received=10.0.100.19;rport=25081
Via: SIP/2.0/TCP 10.0.100.40:5067;branch=z9hG4bKf0435ae88a8c41edbfa005056a1f079
Via: SIP/2.0/TCP 172.20.169.171;branch=z9hG4bKf0435ae88a8c41edbfa005056a1f079
Max-Forwards: 69
Content-Length: 0
12:02:35.858: SIPDLG[71]: register TRN[102407]
12:02:35.858: SipDialog: event CALLED_CANCELED, t=102407, s=3, r=5, m=0000000023d591a8 port=5060
12:02:35.858: CID:CUUID>f043511a8a8c41edbf9f05056a1f079:EAD6TQ8MCT5F91D1U5NQDO9QIC00000T:
12:02:35.858 SIPCONN(anonymous): HandleSipDialogEvent(CALLED_CANCELED)
12:02:35.858 SIPCONN(anonymous): concurrent transaction: c:102404, n:102407
12:02:35.858 SIPCONN(anonymous): 1pcc event CALLED_CANCELED
12:02:35.858 SIPCONN(anonymous): SendResponse(487,102404)
12:02:35.858: add party info 'anonymous' state 1.
12:02:35.858: Sending [18916,TCP] 1027 bytes to 10.0.100.19:19682 >>>>>
SIP/2.0 487 Request Terminated
Via: SIP/2.0/TCP 10.0.100.19;branch=z9hG4bK447796361848712-AP;ft=12;received=10.0.100.19
Via: SIP/2.0/TCP 127.0.0.2:15060;rport=35383;ibmsid=local.1650475683567_27343494_27391301;branch=z9hG4bK447796361848712
Via: SIP/2.0/TCP 127.0.0.2:15060;rport;ibmsid=local.1650475683567_27343493_27391300;branch=z9hG4bK316832230478823
Via: SIP/2.0/TCP 10.0.100.19:5067;branch=z9hG4bKf0435ae88a8c41edbfa005056a1f079-AP;ft=1677811;received=10.0.100.19;rport=25081
Via: SIP/2.0/TCP 10.0.100.40:5067;branch=z9hG4bKf0435ae88a8c41edbfa005056a1f079
Via: SIP/2.0/TCP 172.20.169.171;branch=z9hG4bKf0435ae88a8c41edbfa005056a1f079
From: "Laurent CEA" <sip:anonymous@sip.propro>;tag=f04350e88a8c41edbf9e05056a1f079
To: <sip:3199999@sip.propro>;tag=DC0096FE-ED23-4512-A58E-C23DBBEEC541-86574
Call-ID: f043511a8a8c41edbf9f05056a1f079
CSeq: 1 INVITE
X-Genesys-CallUUID: EAD6TQ8MCT5F91D1U5NQDO9QIC00000T
Allow: INVITE, ACK, PRACK, CANCEL, BYE, REFER, INFO, UPDATE, MESSAGE, NOTIFY, OPTIONS
Content-Length: 0
12:02:35.858: SipDialog: event CANCELED_SEND_RESREJECT, t=102404, s=4, r=8, m=0000000023d591a8 port=5060
12:02:35.858: CID:CUUID>f043511a8a8c41edbf9f05056a1f079:EAD6TQ8MCT5F91D1U5NQDO9QIC00000T:
12:02:35.858 SIPCONN(anonymous): HandleSipDialogEvent(CANCELED_SEND_RESREJECT) - filtered
12:02:35.858 SIPCONN(anonymous): SendResponse(200,102407)
12:02:35.858: add party info 'anonymous' state 1.
12:02:35.858: Sending [18916,TCP] 1116 bytes to 10.0.100.19:19682 >>>>>
SIP/2.0 200 OK
Record-Route: <sip:CASMSR1@10.0.100.19;transport=tcp;lr;av-asset-uid=7a08dc0e>
CSeq: 1 CANCEL
Call-ID: f043511a8a8c41edbf9f05056a1f079
From: "Laurent CEA" <sip:anonymous@sip.propro>;tag=f04350e88a8c41edbf9e05056a1f079
To: <sip:3199999@sip.propro>;tag=DC0096FE-ED23-4512-A58E-C23DBBEEC541-86574
Via: SIP/2.0/TCP 10.0.100.19;branch=z9hG4bK447796361848712-AP;ft=12;received=10.0.100.19
Via: SIP/2.0/TCP 127.0.0.2:15060;rport=35383;ibmsid=local.1650475683567_27343494_27391301;branch=z9hG4bK447796361848712
Via: SIP/2.0/TCP 127.0.0.2:15060;rport;ibmsid=local.1650475683567_27343493_27391300;branch=z9hG4bK316832230478823
Via: SIP/2.0/TCP 10.0.100.19:5067;branch=z9hG4bKf0435ae88a8c41edbfa005056a1f079-AP;ft=1677811;received=10.0.100.19;rport=25081
Via: SIP/2.0/TCP 10.0.100.40:5067;branch=z9hG4bKf0435ae88a8c41edbfa005056a1f079
Via: SIP/2.0/TCP 172.20.169.171;branch=z9hG4bKf0435ae88a8c41edbfa005056a1f079
X-Genesys-CallUUID: EAD6TQ8MCT5F91D1U5NQDO9QIC00000T
Allow: INVITE, ACK, PRACK, CANCEL, BYE, REFER, INFO, UPDATE, MESSAGE, NOTIFY, OPTIONS
Supported: uui,replaces
Content-Length: 0
12:02:35.858: SipDialog: event CANCELED_SEND_CANCEL_RES, t=102407, s=9, r=8, m=0000000023d591a8 port=5060
12:02:35.858: CID:CUUID>f043511a8a8c41edbf9f05056a1f079:EAD6TQ8MCT5F91D1U5NQDO9QIC00000T:
12:02:35.858 SIPCONN(anonymous): HandleSipDialogEvent(CANCELED_SEND_CANCEL_RES) - filtered
12:02:35.858 SIPCONN(anonymous): CONNCHECK: dialog=9
12:02:35.858 SIPCONN(anonymous): set monitor 0000000023d590f0, 0000000000000000
12:02:35.858 SIPCONN(anonymous): state e:1,p:1,s:0,c:8,rc:0,m:0
12:02:35.858: SipDialog: ClearCall(phone=0,state=9, reject[set:0;conf:603])
12:02:35.858: SipDialog::Terminate(state=9,reason=0)
12:02:35.858: SipDialog: set monitor 0000000000000000
12:02:35.858 SIPCONN(anonymous): DetachMediaPeer
12:02:35.858 SIPPARTY(anonymous): ChangePartyState: new=0
12:02:35.858: SIPTS: 'anonymous' state changed initiated->null, cause 8
12:02:35.858 -- setting cntrlDN=anonymous (for 1 parties)
12:02:35.858 -- setting cntrlDN=anonymous (for 1 parties)
12:02:35.858: SIPTS: external party released
12:02:35.858 ClearContext: party anonymous.2428f5d0-23eb8510:1
12:02:35.858 +++ CIFace::Event +++
+++ Pre-event +++
Type EventReleased
Devices: <-/anonymous> <3199999/3199999> <-/->
Calls: 16777245/00970349dedfa01d/16777245.23eb8510/c:2/r:1 0/none
Parties: Xanonymous/anonymous.2428f5d0-23eb8510:1/l:1/r:0/Dialing,Origination
D3199999/3199999.2428fd80-23eb8510:1/l:2/r:1/Queued,RtRequest,Destination
none
Flags: divert=0 hook=0 postCall=0 active=1 moveAll=1 callType=1 hideOtherPi=0 InternalOther=1
--- Pre-event ---
+++ Released +++
-- XAction: start anonymous.2428f5d0-23eb8510:1
SetReleased: party anonymous.2428f5d0-23eb8510:1, cause Null
-- party_info anonymous.25392510 state change: from <Connected,Dialing> to <Null>
-- G7 release
-- TellReleased
-- XAction: commit anonymous.2428f5d0-23eb8510:1
@12:02:35.8580 [ISCC] Party removed [ddp view]:
@ c:00970349dedfa01d,00000000243633c0 @ m:0000000000000000,0000000000000000,0000000000000000 p:2 i:0100001d nw:00000000:0000000000000000 t:2
- p:0000000025392510 @ c:00970349dedfa01d,00000000243633c0 r:1 t:1 s:0 n:anonymous
p:0000000025391c10 @ c:00970349dedfa01d,00000000243633c0 r:2 t:0 s:809 n:3199999
@12:02:35.8580 [ISCC] Party removed:
@ c:00970349dedfa01d,00000000243633c0 @ m:0000000000000000,0000000000000000 p:2 i:0100001d nw:0000000000000000 t:2
- p:0000000000000000,0000000025392510 @ c:00970349dedfa01d,00000000243633c0 r:1 ----- n:anonymous:
p:0000000000000000,0000000025391c10 @ c:00970349dedfa01d,00000000243633c0 r:2 ----- n:3199999:
@12:02:35.8580 [ISCC] Party object is removed: p:0000000000000000,0000000000000000 n:anonymous:
@12:02:35.8580 [0] 8.1.104.58 distribute call/party event: message EventCallPartyDeleted
AttributeEventSequenceNumber 00000000000004ec
AttributeTimeStamp 63b2b9cb000d1790
AttributeConnID 00970349dedfa01d
AttributeCallUUID 'EAD6TQ8MCT5F91D1U5NQDO9QIC00000T'
AttributePartyUUID 'HSSNFC8II57HVBTAD3FCUJ7HE8000088'
AttributeCtrlParty 'anonymous'
12:02:35.858 Int 04544 Interaction message "EventCallPartyDeleted" generated
12:02:35.858 Trc 04542 EventCallPartyDeleted sent to [1152] (00000004 ors 10.0.241.5:65303)
--- Released ---
+++ Post-event +++
Type EventReleased
Devices: <-/anonymous> <3199999/3199999> <-/->
Calls: 16777245/00970349dedfa01d/16777245.23eb8510/c:1/r:1 0/none
Parties: Xanonymous/anonymous.2428f5d0-23eb8510:1/l:1/r:0/Released,Origination
D3199999/3199999.2428fd80-23eb8510:1/l:2/r:1/Queued,RtRequest,Destination
none
Flags: divert=0 hook=0 postCall=0 active=1 moveAll=1 callType=1 hideOtherPi=0 InternalOther=1
--- Post-event ---
12:02:35.858 --- CIFace::Event ---
12:02:35.858: PI: 01 S[NI]D[anonymous]E[L-]MO[!] - should be deleted
12:02:35.858: check linked party
12:02:35.858: SIPCM: delete party anonymous:16777408
12:02:35.858: SIPCALL(16777245): delete party 'anonymous'
12:02:35.858: PI-1: 00 S[QN]D[3199999]E[-]
12:02:35.858: Check call state: no active[0] out of 1
12:02:35.858: ERROR: 10000002, party.GetEndPoint(endPoint), SipCallManagerScenarios.cpp,1752
12:02:35.858 SIPPARTY(3199999): ChangePartyState: new=0
12:02:35.858: SIPTS: '3199999' state changed queued->null, cause 0
12:02:35.858: routing dialog '16777409' terminated
12:02:35.858: Adding OtherTrunkName(Trunk_SIP_Avaya1): done
12:02:35.858 ClearContext: party 3199999.2428fd80-23eb8510:1
12:02:35.858 +++ CIFace::Event +++
+++ Pre-event +++
Type EventReleased
Devices: <3199999/3199999> <-/anonymous> <-/->
Calls: 16777245/00970349dedfa01d/16777245.23eb8510/c:1/r:1 0/none
Parties: D3199999/3199999.2428fd80-23eb8510:1/l:2/r:1/Queued,RtRequest,Destination
Xanonymous/anonymous.2428f5d0-23eb8510:1/l:1/r:0/Released,Origination
none
Flags: divert=0 hook=1 postCall=0 active=1 moveAll=1 callType=1 hideOtherPi=0 InternalOther=0
--- Pre-event ---
+++ Released +++
-- XAction: start 3199999.2428fd80-23eb8510:1
SetReleased: party 3199999.2428fd80-23eb8510:1, cause Null
-- party_info 3199999.25391c10 state change: from <Queued,Routing> to <Null,Routing>
@12:02:35.8580 [0] 8.1.104.58 distribute_event: message EventAbandoned
AttributeEventSequenceNumber 00000000000004ed
AttributeTimeinuSecs 858000
AttributeTimeinSecs 1672657355 (12:02:35)
AttributeExtensions [58] 00 02 00 00..
'OtherTrunkName' 'Trunk_SIP_Avaya1'
'BusinessCall' 1
AttributeOtherDNRole 1
AttributeOtherDN 'anonymous'
AttributePartyUUID 'HSSNFC8II57HVBTAD3FCUJ7HE8000089'
AttributeThisQueue '3199999'
AttributeThisDNRole 2
AttributeThisDN '3199999'
AttributeANI 'anonymous'
AttributeDNIS '3199999'
AttributeUserData [535] 00 18 03 00..
'RRequestedSkills'(list)
'CustomerSegment' 'default'
'ServiceType