Hi hsujdik,
I also more explain about this issue while I and NHANT test on my LAB
Example:
A call is queued in site A, and is targetting agents in sites A and B. An agent becomes available in site B, so the call is transferred to site B using an External Routing Point. Then the caller receives a busy signal, it take time from 1 – 2 minutes to agent at site B can see pop-up on IWS is ‘ Inbound Call and ringing’. So I don’t know why call transfer between 2 sites it takes too much time.
From in my opinion, I see that can this issue can be resolved by edit transition_time and verification_time settings for that URS as solution on Genesys Customercare.
https://genesyspartner.force.com/customercare/pkb_Home?id=kA4U00000008dCsKAI&l=en_US&fs=Search&pn=1
I tried to a few solutions on Customer Care, but this issue still not yet resolved until now. So can who anyone else can help me fix this issue.
[code] _I_I_008402a8728d6020 [01:0f] binding with TRG 00000000026b70b8 (VQ 00000000027031a8), vq=000000000270c948
_A_I_ [0D:12] number of calls from sw bdgswitch to sw hcmswitch (0+1): 1(1)
20:13:52.015_M_I_008402a8728d6020 [10:2f] RStatCallsInQueue update: object <2001>(407), type CfgDN value 1+0+0, reason <target selection>
20:13:52.015_M_I_008402a8728d6020 [10:2f] RStatCallsInQueue update: object <nhannt>(102), type CfgPerson value 1+0+0, reason <target selection>
20:13:52.015_M_I_008402a8728d6020 [10:2f] RStatCallsInQueue update: object <2001>(101), type CfgPlace value 1+0+0, reason <target selection>
_I_I_008402a8728d6020 [0E:10] HERE IS ROUTE_CALL: VQ=, target=nhannt
_I_I_008402a8728d6020 [01:10] binding with TRG 00000000026b70b8 (VQ 00000000027031a8), vq=000000000270c948
request to 65201(bdgsip01/bdgsip02) message RequestUpdateUserData
AttributeReferenceID 1347
AttributeUserData [497] 00 15 00 00..
'RVQID' ''
'RVQDBID' ''
'RTargetTypeSelected' '0'
'RTargetRuleSelected' ''
'RTargetObjectSelected' 'nhannt'
'RTargetObjSelDBID' '102'
'RTargetAgentSelected' 'nhannt'
'RTargetAgSelDBID' '102'
'RTargetPlaceSelected' '2001'
'RTargetPlSelDBID' '101'
'RTenant' 'Environment'
'RTenantDBID' '1'
'CBR-actual_volume' ''
'CBR-Interaction_cost' ''
'CBR-contract_DBIDs' ''
'CBR-IT-path_DBIDs' ''
'RRequestedSkillCombination' ''
'RRequestedSkills'(list)
'CustomerSegment' 'default'
'ServiceType' 'default'
'ServiceObjective' ''
AttributeConnID 008402a8728d6020
AttributeThisDN '7507'
..sent to bdgsip01:3000(fd=668)
20:13:52.015_M_I_008402a8728d6020 [17:11] VQ 00000000027031a8 first available call: none, reason=(0)strategy
_I_I_008402a8728d6020 [0E:03] NO TRANSLATION for this call
20:13:52.015_T_I_008402a8728d6020 [14:19] send to ts bdgsip01 RequestRouteCall to dn 2001 on hcmswitch (dnis= )
request to 65201(bdgsip01/bdgsip02) message RequestRouteCall
AttributeReferenceID 1348
AttributeReason [14] 00 01 01 00..
'RTR' 121
AttributeRouteType 0 (RouteTypeUnknown)
AttributeExtensions [146] 00 08 00 00..
'CUSTOMER_ID' 'Environment'
'AGENT' 'nhannt'
'PLACE' '2001'
'DN' '2001'
'ACCESS' '2001'
'SWITCH' 'hcmswitch'
'NVQ' 2
'TARGET' 'nhannt@start_srv.A'
AttributeLocation 'hcmswitch'
AttributeOtherDN '2001'
AttributeConnID 008402a8728d6020
AttributeThisDN '7507'
..sent to bdgsip01:3000(fd=668)
_A_I_008402a8728d6020 [0E:04] ----------->DEPARTURE(processing time 20405)
20:13:52.015_M_I_0000000000000000 [10:1b] blocking: ag nhannt, pl 2001, sw hcmswitch dn 2001 for 15 sec by 1000000001, expire 1502457247
20:13:52.015_M_I_008402a8728d6020 [10:3a] update volume contracts tables: target nhannt, group , tenant Environment
_M_I_008402a8728d6020 [10:21] LAUNCHED (dn=2001)
20:13:52.015_M_I_ [10:1d] PULSE over: 0 cpu 1 objects 1 trgs
received from 65201(bdgsip01)bdgsip01:3000(fd=) message EventAttachedDataChanged(refid=1347)
20:13:52.077_T_I_008402a8728d6020 [14:32] EventAttachedDataChanged is received for ts bdgsip01[bdgswitch] (this dn=7507, refid=1347)
received from 65201(bdgsip01)bdgsip01:3000(fd=) message EventError
(Invalid Called Dn)
AttributeExtensions [204] 00 0a 00 00..
'CUSTOMER_ID' 'Environment'
'AGENT' 'nhannt'
'PLACE' '2001'
'DN' '2001'
'ACCESS' '2001'
'SWITCH' 'hcmswitch'
'NVQ' 2
'TARGET' 'nhannt@start_srv.A'
'iscc-request-type' 'transfer'
'iscc-destination-dn' '2001'
AttributeErrorCode 71
AttributeErrorMessage 'Invalid Called Dn'
AttributeReason [14] 00 01 01 00..
'RTR' 121
AttributeRouteType 0 (RouteTypeUnknown)
AttributeLocation 'hcmswitch'
AttributeThisDN '7507'
AttributeOtherDN '19912'
AttributeConnID 008402a8728d6020
AttributeClientID 1
AttributeReferenceID 1348
AttributeTimeinSecs 1502457221 (20:13:41)
AttributeTimeinuSecs 152000
AttributeEventSequenceNumber 0000000000001544
20:13:52.140_T_E_ [14:0c] EventError is received for ts bdgsip01[bdgswitch] - Invalid Called Dn
20:13:52.140_A_E_008402a8728d6020 [14:32] <-----------ERROR
20:13:52.140 Std 21003 interaction 008402a8728d6020 routing error 0071 Invalid Called Dn
20:13:52.140_M_I_008402a8728d6020 [17:11] VQ 00000000027031a8 first available call: 008402a8728d6020, reason=(1)strategy
_T_W_008402a8728d6020 [0E:0f] emergency: continue strategy on this error
_I_I_008402a8728d6020 [01:0f] binding with TRG 0000000000000000 (VQ 0000000000000000), vq=000000000270c948
_A_I_ [0D:12] number of calls from sw bdgswitch to sw hcmswitch (0-1): 0(0)
20:13:52.140_M_I_008402a8728d6020 [10:2f] RStatCallsInQueue update: object <2001>(407), type CfgDN value 0+0+0, reason <not a target>
20:13:52.140_M_I_008402a8728d6020 [10:2f] RStatCallsInQueue update: object <nhannt>(102), type CfgPerson value 0+0+0, reason <not a target>
20:13:52.140_M_I_008402a8728d6020 [10:2f] RStatCallsInQueue update: object <2001>(101), type CfgPlace value 0+0+0, reason <not a target>
_I_I_008402a8728d6020 [01:10] binding with TRG 0000000000000000 (VQ 0000000000000000), vq=000000000270c948
20:13:52.140_I_I_008402a8728d6020 [09:0a] SCXML: session SID=BS06MLOJ4D7ETA1HBDVB3QEFLK00000H external queue: event "error.queue.submit" added
20:13:52.140_I_I_008402a8728d6020 [1c:06] SCXML: {{{{{resume session SID=BS06MLOJ4D7ETA1HBDVB3QEFLK00000H
_I_I_008402a8728d6020 [1c:06] 1. SCXML: look for transitions (1)
_I_I_008402a8728d6020 [1c:04] 1.x SCXML: state <initial>: check transitions, event "error.queue.submit"
20:13:52.140_I_I_008402a8728d6020 [09:05] >>>>>>>>>>>>resume interp(0), func:SCXMLGetEvent
_I_I_008402a8728d6020 [09:04] ASSIGN: v:0:_event(LOCAL) <- OBJECT:0000000002703150[undefined]={"name":"error.queue.submit","data":{"requestid":11,"error":"0013 Remote error","description":"0071 Invalid Called Dn"}}
_I_I_008402a8728d6020 [09:04] ASSIGN: v:0:_eventdata(LOCAL) <- OBJECT:0000000002705138[undefined]={"requestid":11,"error":"0013 Remote error","description":"0071 Invalid Called Dn"}
20:13:52.140_I_I_008402a8728d6020 [09:04] <<<<<<<<<<<<suspend interp(NONE), func:SCXMLChangeState timers:00000
_I_I_008402a8728d6020 [1c:05] 2. SCXML: microstep
_I_I_008402a8728d6020 [1c:05] 2.1 SCXML: microstep exitting phase
_I_I_008402a8728d6020 [1c:05] 2.2 SCXML: microstep transiting phase
20:13:52.140_I_I_008402a8728d6020 [09:05] >>>>>>>>>>>>resume interp(0), func:SCXMLChangeState
20:13:52.140 RLIB: request to 724(bdgors01) message EventOnInvoke(1000000102)
result(1000000004) '{"name":"error.queue.submit","data":{"requestid":11,"error":"0013 Remote error","description":"0071 Invalid Called Dn"}}'
sessionid(1000000010) 'FG5MK2KSC102F64DSD68C2IPK400008O'
20:13:52.140_I_I_008402a8728d6020 [09:04] <<<<<<<<<<<<suspend interp(NONE), func:SCXMLGetEvent timers:00000
_I_I_008402a8728d6020 [1c:05] 2.3 SCXML: microstep entering phase
_I_I_008402a8728d6020 [1c:06] 1. SCXML: look for transitions (2)
20:13:52.140_I_I_008402a8728d6020 [1c:06] SCXML: }}}}}suspend session SID=BS06MLOJ4D7ETA1HBDVB3QEFLK00000H
20:13:52.140 RLIB: received from 724(bdgors01) message RequestInvoke(1000000100)
refid(1) 11812
callid(1000000000) 'KFJM6LTU093SL9HRDEJO7KE7T000000S'
sessionid(1000000010) 'FG5MK2KSC102F64DSD68C2IPK400008O'
fm(1000000001) 'urs'
function(1000000002) 'SCXMLStartTreatment'
args(1000000003) '[7,"LANGUAGE","English (US)","PROMPT.1.INTERRUPTABLE",true,"PROMPT.1.ID",222]'
20:13:52.140_I_I_008402a8728d6020 [09:0a] SCXML: session SID=BS06MLOJ4D7ETA1HBDVB3QEFLK00000H external queue: event "function" added
20:13:52.140_I_I_008402a8728d6020 [1c:06] SCXML: {{{{{resume session SID=BS06MLOJ4D7ETA1HBDVB3QEFLK00000H
_I_I_008402a8728d6020 [1c:06] 1. SCXML: look for transitions (1)
_I_I_008402a8728d6020 [1c:04] 1.x SCXML: state <initial>: check transitions, event "function"
20:13:52.140_I_I_008402a8728d6020 [09:05] >>>>>>>>>>>>resume interp(0), func:SCXMLGetEvent
_I_I_008402a8728d6020 [09:04] ASSIGN: v:0:_event(LOCAL) <- OBJECT:00000000027056A8[undefined]={"name":"function","data":{"module":"urs","func":"SCXMLStartTreatment","params":"[7,\"LANGUAGE\",\"English (US)\",\"PROMPT.1.INTERRUPTABLE\",true,\"PROMPT.1.ID\",222]"}}
_I_I_008402a8728d6020 [09:04] ASSIGN: v:0:_eventdata(LOCAL) <- LIST: module:urs|func:SCXMLStartTreatment|params:[7,"LANGUAGE","English (US)","PROMPT.1.INTERRUPTABLE",true,"PROMPT.1.ID",222]
20:13:52.140_I_I_008402a8728d6020 [09:04] <<<<<<<<<<<<suspend interp(NONE), func:SCXMLChangeState timers:00000
_I_I_008402a8728d6020 [1c:05] 2. SCXML: microstep
_I_I_008402a8728d6020 [1c:05] 2.1 SCXML: microstep exitting phase
_I_I_008402a8728d6020 [1c:05] 2.2 SCXML: microstep transiting phase
20:13:52.140_I_I_008402a8728d6020 [09:05] >>>>>>>>>>>>resume interp(0), func:SCXMLChangeState
_I_I_008402a8728d6020 [09:04] ASSIGN: v:25:_m(LOCAL) <- STRING[1,3]: "urs"
_I_I_008402a8728d6020 [09:04] ASSIGN: v:25:_f(LOCAL) <- STRING[1,19]: "SCXMLStartTreatment"
_I_I_008402a8728d6020 [09:04] ASSIGN: v:25:_parms(LOCAL) <- OBJECT:0000000002705138[Array]=[7,"LANGUAGE","English (US)","PROMPT.1.INTERRUPTABLE",true,"PROMPT.1.ID",222]
20:13:52.140_B_I_008402a8728d6020 [14:22] request to abort treatment after treatment is applied===========>TREATMENT_NONE
_B_I_008402a8728d6020 [14:22] call states: s=0 d=0 t=0
_I_I_008402a8728d6020 [07:59] HERE IS START TREATMENT
20:13:52.140_T_I_008402a8728d6020 [14:28] TApplyTreatment (type PlayAnnouncement) is being called
request to 65201(bdgsip01/bdgsip02) message RequestApplyTreatment
AttributeReferenceID 1349
AttributeExtensions [146] 00 08 00 00..
'CUSTOMER_ID' 'Environment'
'AGENT' 'nhannt'
'PLACE' '2001'
'DN' '2001'
'ACCESS' '2001'
'SWITCH' 'hcmswitch'
'NVQ' 2
'TARGET' 'nhannt@start_srv.A'
AttributeTreatmentParms [85] 00 02 00 00..
'LANGUAGE' 'English (US)'
'PROMPT'(list) '1'(list) 'INTERRUPTABLE' 1
'ID' 222
AttributeTreatmentType 7 (TreatmentPlayAnnouncement)
AttributeConnID 008402a8728d6020
AttributeThisDN '7507'
..sent to bdgsip01:3000(fd=668)
_B_I_008402a8728d6020 [14:28] treatment===========>TREATMENT_REQUEST
_B_I_008402a8728d6020 [07:59] call states: s=0 d=0 t=2
20:13:52.140_M_I_008402a8728d6020 [17:11] VQ 00000000027031a8 first available call: none, reason=(0)treatment
_I_I_008402a8728d6020 [09:04] ASSIGN: v:25:_r(LOCAL) <- FLOAT: 1349
20:13:52.140_I_I_008402a8728d6020 [09:04] <<<<<<<<<<<<suspend interp(NONE), func:SCXMLGetEvent timers:00000
_I_I_008402a8728d6020 [1c:05] 2.3 SCXML: microstep entering phase
_I_I_008402a8728d6020 [1c:06] 1. SCXML: look for transitions (2)
20:13:52.140_I_I_008402a8728d6020 [1c:06] SCXML: }}}}}suspend session SID=BS06MLOJ4D7ETA1HBDVB3QEFLK00000H
20:13:52.140 RLIB: request to 724(bdgors01) message ResultOfInvoke(1000000101)
refid(1) 11812
result(1000000004) '1349'
received from 65201(bdgsip01)bdgsip01:3000(fd=) message EventTreatmentApplied
AttributeCallState 0
AttributeCallType 2
AttributePropagatedCallType 2
AttributeCallID 16778244
AttributeConnID 008402a8728d6020
AttributeCallUUID 'KFJM6LTU093SL9HRDEJO7KE7T000000S'
AttributeUserData [842] 00 1e 03 00..
'ORSI:iBDGCluster:KFJM6LTU093SL9HRDEJO7KE7T000000S'(list) 'Session' 'FG5MK2KSC102F64DSD68C2IPK400008O'
'Node' '138'
'Url' 'http://bdgsip01:7210/scxml'
'RStrategyName' '7507_msml_collectdtmf_data.default.defaultWorkflow'
'RStrategyDBID' '384'
'ADDRESS' 'Delhi '
'AGE' 'undefined'
'SALARY' '3500.00'
'SDT' '5115'
'TEN' 'TINNT'
'Nhanh' '3'
'RVQID' ''
'RVQDBID' ''
'RTargetTypeSelected' '0'
'RTargetRuleSelected' ''
'RTargetObjectSelected' 'nhannt'
'RTargetObjSelDBID' '102'
'RTargetAgentSelected' 'nhannt'
'RTargetAgSelDBID' '102'
'RTargetPlaceSelected' '2001'
'RTargetPlSelDBID' '101'
'RTenant' 'Environment'
'RTenantDBID' '1'
'CBR-actual_volume' ''
'CBR-Interaction_cost' ''
'CBR-contract_DBIDs' ''
'CBR-IT-path_DBIDs' ''
'RRequestedSkillCombination' ''
'RRequestedSkills'(list)
'CustomerSegment' 'default'
'ServiceType' 'default'
'ServiceObjective' ''
AttributeDNIS '7507'
AttributeANI '5115'
AttributeNetworkDestDN 'hcmswitch::2001'
AttributeThisDN '7507'
AttributeThisDNRole 2
AttributeCollectedDigits ''
AttributeThisQueue '7507'
AttributePartyUUID '651JAIK57T1AF9P6PKNDVF5RB80000AP'
AttributeTreatmentType 7 (TreatmentPlayAnnouncement)
AttributeReferenceID 1349
AttributeExtensions [54] 00 02 00 00..
'OtherTrunkName' 'Customer5115'
'BusinessCall' 1
AttributeTimeinSecs 1502457221 (20:13:41)
AttributeTimeinuSecs 292000
AttributeEventSequenceNumber 0000000000001548
20:13:52.280_T_I_008402a8728d6020 [14:0c] EventTreatmentApplied is received for ts bdgsip01[bdgswitch] (this dn=7507)
_B_I_008402a8728d6020 [14:21] treatment applied===========>TREATMENT_APPLIED
_B_I_008402a8728d6020 [14:21] call states: s=31 d=0 t=3
20:13:52.280_M_I_008402a8728d6020 [17:11] VQ 00000000027031a8 first available call: 008402a8728d6020, reason=(1)treatment
20:13:52.280_M_I_008402a8728d6020 [10:1f] pulse for one call
_T_I_008402a8728d6020 [0E:19] check call routing states: s=31 d=0 t=3 h=(0 0) r=0 i=0 x=0 b=0 - true
20:13:52.280_M_I_008402a8728d6020 [17:0e] VQ 00000000027031a8 (vq "", id=11), (1 Targets): SELECT ANY by stat <NONE>(random 0000000000000000)
_M_I_008402a8728d6020 [17:0b] VQ 00000000027031a8 TRG "nhannt"(00000000026b70b8) #1, (1-0 Components): SELECT ANY by stat <NONE>(random 0)
_M_I_008402a8728d6020 [10:0c] ag nhannt, pl 2001, sw dn is blocked with call 1000000001 (15 sec from 1502457232)
_M_I_008402a8728d6020 [17:0b] VQ 00000000027031a8 TRG "nhannt"(00000000026b70b8) Cmp #1 nhannt: not valid
_M_I_008402a8728d6020 [17:0b] VQ 00000000027031a8 TRG "nhannt"(00000000026b70b8): Cmp NOT SELECTED (0 0 1 0)
_M_I_008402a8728d6020 [17:0e] VQ 00000000027031a8 TRG "nhannt"(00000000026b70b8): not ready passed
_M_I_008402a8728d6020 [17:0e] VQ 00000000027031a8 (vq "" id=11): TRG NOT SELECTED (0 0 0 1 0)
20:13:54.012_M_I_ [10:1d] PULSE (calls: 1(1)=1+0-0, trgts=1, first=1,0, time=1502457234, mem=35111,498,15,224[5855],1,0 - 2,0)
20:13:54.012_M_I_ [10:1d] vqs allocation pattern: static=(13 256 256) dynamic=(11 7/1024)
20:13:54.012_M_I_ [10:1d] check queue for SO <nhannt> type <Agent> stat <##state> (1 trgs 0 cpu)
_M_I_0000000000000000 [10:20] try to route to ag "nhannt" (pl "2001", 3 ready DNs, 1 trgs): TRG 00000000026b70b8 VQ 00000000027031a8 "" (1 calls), 0, 0, 980aa
_M_I_ [10:0b] ag nhannt, pl 2001, sw dn nhannt isn't blocked absolutely(0)
_M_I_008402a8728d6020 [10:21] try to route to ag "nhannt" (pl "2001", 3 ready DNs, 1 trgs): TRG 00000000026b70b8 VQ 00000000027031a8 "" (1 calls), -1, 0, 180aa
_T_I_008402a8728d6020 [0E:19] check call routing states: s=31 d=0 t=3 h=(0 0) r=0 i=0 x=0 b=0 - true
_M_I_008402a8728d6020 [10:21] ag nhannt, pl 2001, sw dn is blocked with call 1000000001 (13 sec from 1502457234)
_M_I_008402a8728d6020 [10:21] stop trying route to ag "nhannt" (pl "2001"): agent blocker (00000000027031a8 0)
20:13:54.012_M_I_ [10:1d] PULSE over: 0 cpu 1 objects 1 trgs
20:13:55.057 Trc 20011 current number of targets for tenant Environment: Agents 1, Places 0, AgentGroups 0, PlaceGroups 0, ACDQueues 0, Routing Points 0
20:13:55.057 Trc 20012 current number of interactions per second - 0.40
20:13:55.057 Trc 20013 current number of entries: for longest queue 0, for all queues 0
20:13:56.009_M_I_ [10:1d] PULSE (calls: 1(1)=1+0-0, trgts=1, first=1,0, time=1502457236, mem=35111,498,15,224[5855],1,0 - 2,0)
20:13:56.009_M_I_ [10:1d] vqs allocation pattern: static=(13 256 256) dynamic=(11 7/1024)
20:13:56.009_M_I_ [10:1d] check queue for SO <nhannt> type <Agent> stat <##state> (1 trgs 0 cpu)
_M_I_0000000000000000 [10:20] try to route to ag "nhannt" (pl "2001", 3 ready DNs, 1 trgs): TRG 00000000026b70b8 VQ 00000000027031a8 "" (1 calls), 0, 0, 180aa
_M_I_ [10:0b] ag nhannt, pl 2001, sw dn nhannt isn't blocked absolutely(0)
_M_I_008402a8728d6020 [10:21] try to route to ag "nhannt" (pl "2001", 3 ready DNs, 1 trgs): TRG 00000000026b70b8 VQ 00000000027031a8 "" (1 calls), -1, 0, 180aa
_T_I_008402a8728d6020 [0E:19] check call routing states: s=31 d=0 t=3 h=(0 0) r=0 i=0 x=0 b=0 - true
_M_I_008402a8728d6020 [10:21] ag nhannt, pl 2001, sw dn is blocked with call 1000000001 (11 sec from 1502457236)
_M_I_008402a8728d6020 [10:21] stop trying route to ag "nhannt" (pl "2001"): agent blocker (00000000027031a8 0)
20:13:56.009_M_I_ [10:1d] PULSE over: 0 cpu 1 objects 1 trgs
20:13:56.383_I_I_008402a8728d6020 [09:0a] SCXML: session SID=BS06MLOJ4D7ETA1HBDVB3QEFLK00000H external queue: event "error.queue.submit" added
20:13:56.383_I_I_008402a8728d6020 [1c:06] SCXML: {{{{{resume session SID=BS06MLOJ4D7ETA1HBDVB3QEFLK00000H
_I_I_008402a8728d6020 [1c:06] 1. SCXML: look for transitions (1)
_I_I_008402a8728d6020 [1c:04] 1.x SCXML: state <initial>: check transitions, event "error.queue.submit"
20:13:56.383_I_I_008402a8728d6020 [09:05] >>>>>>>>>>>>resume interp(0), func:SCXMLGetEvent
_I_I_008402a8728d6020 [09:04] ASSIGN: v:0:_event(LOCAL) <- OBJECT:0000000002709290[undefined]={"name":"error.queue.submit","data":{"requestid":11,"error":"-001 Timeout"}}
_I_I_008402a8728d6020 [09:04] ASSIGN: v:0:_eventdata(LOCAL) <- OBJECT:0000000002703150[undefined]={"requestid":11,"error":"-001 Timeout"}
20:13:56.383_I_I_008402a8728d6020 [09:04] <<<<<<<<<<<<suspend interp(NONE), func:SCXMLChangeState timers:00000
_I_I_008402a8728d6020 [1c:05] 2. SCXML: microstep
_I_I_008402a8728d6020 [1c:05] 2.1 SCXML: microstep exitting phase
_I_I_008402a8728d6020 [1c:05] 2.2 SCXML: microstep transiting phase
20:13:56.383_I_I_008402a8728d6020 [09:05] >>>>>>>>>>>>resume interp(0), func:SCXMLChangeState
20:13:56.383 RLIB: request to 724(bdgors01) message EventOnInvoke(1000000102)
result(1000000004) '{"name":"error.queue.submit","data":{"requestid":11,"error":"-001 Timeout"}}'
sessionid(1000000010) 'FG5MK2KSC102F64DSD68C2IPK400008O'
20:13:56.383_I_I_008402a8728d6020 [09:04] <<<<<<<<<<<<suspend interp(NONE), func:SCXMLGetEvent timers:00000
_I_I_008402a8728d6020 [1c:05] 2.3 SCXML: microstep entering phase
_I_I_008402a8728d6020 [1c:06] 1. SCXML: look for transitions (2)
20:13:56.383_I_I_008402a8728d6020 [1c:06] SCXML: }}}}}suspend session SID=BS06MLOJ4D7ETA1HBDVB3QEFLK00000H
20:13:56.383 RLIB: received from 724(bdgors01) message RequestInvoke(1000000100)
refid(1) 11813
callid(1000000000) 'KFJM6LTU093SL9HRDEJO7KE7T000000S'
sessionid(1000000010) 'FG5MK2KSC102F64DSD68C2IPK400008O'
fm(1000000001) 'urs'
function(1000000002) 'SCXMLStartTreatment'
args(1000000003) '[7,"LANGUAGE","English (US)","PROMPT.1.INTERRUPTABLE",true,"PROMPT.1.ID",102]'
20:13:56.383_I_I_008402a8728d6020 [09:0a] SCXML: session SID=BS06MLOJ4D7ETA1HBDVB3QEFLK00000H external queue: event "function" added
20:13:56.383_I_I_008402a8728d6020 [1c:06] SCXML: {{{{{resume session SID=BS06MLOJ4D7ETA1HBDVB3QEFLK00000H
_I_I_008402a8728d6020 [1c:06] 1. SCXML: look for transitions (1)
_I_I_008402a8728d6020 [1c:04] 1.x SCXML: state <initial>: check transitions, event "function"
20:13:56.383_I_I_008402a8728d6020 [09:05] >>>>>>>>>>>>resume interp(0), func:SCXMLGetEvent
_I_I_008402a8728d6020 [09:04] ASSIGN: v:0:_event(LOCAL) <- OBJECT:0000000002705868[undefined]={"name":"function","data":{"module":"urs","func":"SCXMLStartTreatment","params":"[7,\"LANGUAGE\",\"English (US)\",\"PROMPT.1.INTERRUPTABLE\",true,\"PROMPT.1.ID\",102]"}}
_I_I_008402a8728d6020 [09:04] ASSIGN: v:0:_eventdata(LOCAL) <- LIST: module:urs|func:SCXMLStartTreatment|params:[7,"LANGUAGE","English (US)","PROMPT.1.INTERRUPTABLE",true,"PROMPT.1.ID",102]
20:13:56.383_I_I_008402a8728d6020 [09:04] <<<<<<<<<<<<suspend interp(NONE), func:SCXMLChangeState timers:00000
_I_I_008402a8728d6020 [1c:05] 2. SCXML: microstep
_I_I_008402a8728d6020 [1c:05] 2.1 SCXML: microstep exitting phase
_I_I_008402a8728d6020 [1c:05] 2.2 SCXML: microstep transiting phase
20:13:56.383_I_I_008402a8728d6020 [09:05] >>>>>>>>>>>>resume interp(0), func:SCXMLChangeState
_I_I_008402a8728d6020 [09:04] ASSIGN: v:25:_m(LOCAL) <- STRING[1,3]: "urs"
_I_I_008402a8728d6020 [09:04] ASSIGN: v:25:_f(LOCAL) <- STRING[1,19]: "SCXMLStartTreatment"
_I_I_008402a8728d6020 [09:04] ASSIGN: v:25:_parms(LOCAL) <- OBJECT:0000000002703150[Array]=[7,"LANGUAGE","English (US)","PROMPT.1.INTERRUPTABLE",true,"PROMPT.1.ID",102]
20:13:56.383_B_I_008402a8728d6020 [14:22] request to abort treatment after treatment is applied===========>TREATMENT_NONE
_B_I_008402a8728d6020 [14:22] call states: s=0 d=0 t=0
_I_I_008402a8728d6020 [07:59] HERE IS START TREATMENT[/code]
