[quote author=cavagnaro link=topic=11452.msg52173#msg52173 date=1570162841]
Can you share the URS log that routes the call to the agent?
[/quote]
Hi cavagnaro,
These are the logs taken from the URS:
[b]Agent_With_Toaster_OK[/b]
10:11:33.446 Int 22000 @@@STARTSTRATEGYCHAT
_I_I_007302e8668311f6 [09:04] ASSIGN: _GMS_CONTACT(LOCAL) <- STRING[1,10]: "3472719757"
_I_I_007302e8668311f6 [09:04] ASSIGN: new_cli(LOCAL) <- STRING[1,14]: "+39 3472719757"
_I_I_007302e8668311f6 [09:04] ASSIGN: url_anag(LOCAL) <- STRING[2,100]: "LINKOFTHEWS"
_I_I_007302e8668311f6 [09:04] ASSIGN: Scenario(LOCAL) <- STRING[2,3]: "PDW"
_I_I_007302e8668311f6 [09:04] ASSIGN: ContactKey(LOCAL) <- STRING[2,15]: "SAP_TELCONTATTO"
_I_I_007302e8668311f6 [09:04] ASSIGN: v_chat_app_name(LOCAL) <- STRING[2,26]: "GMS_ChatServer_PRI_TO_TEST"
_I_I_007302e8668311f6 [09:04] ASSIGN: __IntVar(LOCAL) <- INTEGER: 5
10:11:33.446_I_I_007302e8668311f6 [07:39] HERE IS XDATA
10:11:33.446_H_I_ [08:0c] SOAP request 205 sent to HTTP Bridge:
URL: LINKOFTHEWS
Method: urn:ZfmwsGetCustomer
NameSpace: urn=urn:sap-com:document:sap:soap:functions:mc-style
SOAPaction: ZfmwsGetCustomer
Input: ItSearchCriteria.item.AttrName:SAP_TELCONTATTO|ItSearchCriteria.item.AttrValue:+39 3472719757|IvScenario:PDW
Output: ZfmwsGetCustomerResponse.Esito,ZfmwsGetCustomerResponse.EtResults.item.UsernameCons
HTTPAuthent:2 user and password (1 )
SOAPSecrty:
Cookie:
10:11:33.446_I_I_007302e8668311f6 [09:04] <<<<<<<<<<<<suspend interp(WAIT_WEBSERVICE), func:GetWebServiceInfoTLS timers:00000
10:11:33.446_R_I_ [19:10] routing interface request received: urs/call/007302e8668311f6/func?name=Timeout¶ms=%5B120%5D&sync=1, client=740(ORS_PRI_TEST), ref=3295175
_I_I_007302e8668311f6 [09:0e] script 9c31c25680 DS 9c34b1f610 [37] +r (24 5) (9 0)
_I_I_ [25:01] script **InvokeFunction usage +1=1
10:11:33.446_I_I_007302e8668311f6 [09:06] >>>>>>>>>>>>start interp()
_I_I_007302e8668311f6 [07:46] no error mode for this call
_I_I_007302e8668311f6 [09:04] ASSIGN: v:0:this(LOCAL) <- OBJECT:0000009C31C0DC78[Global]={"Class":"Global"}
_I_I_007302e8668311f6 [09:04] ASSIGN: v:0:_urs(LOCAL) <- OBJECT:0000009C337757F0[FM]={}
_I_I_007302e8668311f6 [09:04] ASSIGN: v:0:_parms(LOCAL) <- OBJECT:0000009C33774DD0[Array]=[120]
_I_I_007302e8668311f6 [09:04] ASSIGN: v:0:_pbl_func(LOCAL) <- STRING[1,7]: "Timeout"
_I_I_007302e8668311f6 [09:04] ASSIGN: v:0:_r(LOCAL) <- UNKNOWN: NULL-STRING
_I_I_007302e8668311f6 [01:1f] <<<<<<<<<<<<stop interp
_I_I_007302e8668311f6 [09:0f] script 9c31c25680 DS 9c34b1f610 [37] -s (24 5) (10 9c34b1f610)
_I_I_ [25:01] script **InvokeFunction usage -1=0
10:11:33.446_R_I_ [19:11] routing interface response 'Info' sent to client 740(ORS_PRI_TEST), ref=3295175
Message: undefined
10:11:33.493_R_I_ [19:10] routing interface request received: urs/call/007302e8668311f6/lvq?name=VQ_CHAT_POSTEDW_TO&aqt=urs2&filter=ewt%2Ctime%2Cwt%2Ccalls%2Cpos%2Cwpos%2Chit%2Cpriority, client=740(ORS_PRI_TEST), ref=3295176
10:11:33.493_R_I_ [19:11] routing interface response 'Info' sent to client 740(ORS_PRI_TEST), ref=3295176
Message: {}
10:11:33.493_R_I_ [19:10] routing interface request received: urs/call/007302e8668311f6/func?name=FindConfigObject¶ms=%5B1%2C+%22name%3A%22%5D&sync=1, client=740(ORS_PRI_TEST), ref=3295177
_I_I_007302e8668311f6 [09:0e] script 9c31c25680 DS 9c34b1f610 [37] +r (24 5) (10 0)
_I_I_ [25:01] script **InvokeFunction usage +1=1
10:11:33.493_I_I_007302e8668311f6 [09:06] >>>>>>>>>>>>start interp()
_I_I_007302e8668311f6 [07:46] no error mode for this call
_I_I_007302e8668311f6 [09:04] ASSIGN: v:0:this(LOCAL) <- OBJECT:0000009C31C0DC78[Global]={"Class":"Global"}
_I_I_007302e8668311f6 [09:04] ASSIGN: v:0:_urs(LOCAL) <- OBJECT:0000009C33774DD0[FM]={}
_I_I_007302e8668311f6 [09:04] ASSIGN: v:0:_parms(LOCAL) <- OBJECT:0000009C337757F0[Array]=[1,"name:"]
_I_I_007302e8668311f6 [09:04] ASSIGN: v:0:_pbl_func(LOCAL) <- STRING[1,16]: "FindConfigObject"
_I_I_007302e8668311f6 [09:04] ASSIGN: v:0:_r(LOCAL) <- LIST[1]: :
_I_I_007302e8668311f6 [01:1f] <<<<<<<<<<<<stop interp
_I_I_007302e8668311f6 [09:0f] script 9c31c25680 DS 9c34b1f610 [37] -s (24 5) (11 9c34b1f610)
_I_I_ [25:01] script **InvokeFunction usage -1=0
10:11:33.493_R_I_ [19:11] routing interface response 'Info' sent to client 740(ORS_PRI_TEST), ref=3295177
Message: {}
10:11:33.493 RLIB: received from 740(ORS_PRI_TEST) message RequestInvoke(1000000100)
refid(1) 3295178
callid(1000000000) '*CPRRGNCUM52SNDD4R3TUGJD8KG00EDCD'
sessionid(1000000010) 'CPRRGNCUM52SNDD4R3TUGJD8KG00EDCD'
fm(1000000001) 'queue'
function(1000000002) 'countSkillInGroup'
args(1000000003) '["","VAG_PDW_CHAT@SS_ROU_PRI_TO.GA","login(voice)"]'
10:11:33.493_I_I_007302e8668311f5 [09:0a] SCXML: session SID=PSJEJVCR8H5M7A7KJFEHAOKGCC00ECQ2 external queue: event "function" added
10:11:33.493_I_I_007302e8668311f5 [1c:06] SCXML: {{{{{resume session SID=PSJEJVCR8H5M7A7KJFEHAOKGCC00ECQ2
_I_I_007302e8668311f5 [1c:06] 1. SCXML: look for transitions (1)
_I_I_007302e8668311f5 [1c:04] 1.x SCXML: state <initial>: check transitions, event "function"
10:11:33.493_I_I_007302e8668311f5 [09:05] >>>>>>>>>>>>resume interp(0), func:SCXMLGetEvent
_I_I_007302e8668311f5 [09:04] ASSIGN: v:0:_event(LOCAL) <- OBJECT:0000009C337757F0[undefined]={"name":"function","data":{"module":"queue","func":"countSkillInGroup","params":"[\"\",\"VAG_PDW_CHAT@SS_ROU_PRI_TO.GA\",\"login(voice)\"]"}}
_I_I_007302e8668311f5 [09:04] ASSIGN: v:0:_eventdata(LOCAL) <- LIST[3]: module:queue|func:countSkillInGroup|params:["","VAG_PDW_CHAT@SS_ROU_PRI_TO.GA","login(voice)"]
10:11:33.493_I_I_007302e8668311f5 [09:04] <<<<<<<<<<<<suspend interp(NONE), func:SCXMLChangeState timers:00000
_I_I_007302e8668311f5 [1c:05] 2. SCXML: microstep
_I_I_007302e8668311f5 [1c:05] 2.1 SCXML: microstep exitting phase
_I_I_007302e8668311f5 [1c:05] 2.2 SCXML: microstep transiting phase
10:11:33.493_I_I_007302e8668311f5 [09:05] >>>>>>>>>>>>resume interp(0), func:SCXMLChangeState
_I_I_007302e8668311f5 [09:04] ASSIGN: v:25:_pbl_m(LOCAL) <- STRING[1,5]: "queue"
_I_I_007302e8668311f5 [09:04] ASSIGN: v:25:_pbl_f(LOCAL) <- STRING[1,17]: "countSkillInGroup"
_I_I_007302e8668311f5 [09:04] ASSIGN: v:25:_pbl_parms(LOCAL) <- OBJECT:0000009C337A0360[Array]=["","VAG_PDW_CHAT@SS_ROU_PRI_TO.GA","login(voice)"]
10:11:33.493_I_I_007302e8668311f5 [07:15] skill login(voice) for group VAG_PDW_CHAT@SS_ROU_PRI_TO.GA
10:11:33.493_M_I_ [10:06] SO(9c34b24388 -1 2) ten=Environment name=?VAG_PDW_CHAT:login(voice)@SS_ROU_PRI_TO.GA: stat <##content> asked (0,0,3)
_I_I_007302e8668311f5 [09:04] ASSIGN: v:25:_pbl_r(LOCAL) <- FLOAT: 0
10:11:33.493_I_I_007302e8668311f5 [09:04] <<<<<<<<<<<<suspend interp(NONE), func:SCXMLGetEvent timers:00000
_I_I_007302e8668311f5 [1c:05] 2.3 SCXML: microstep entering phase
_I_I_007302e8668311f5 [1c:06] 1. SCXML: look for transitions (2)
10:11:33.493_I_I_007302e8668311f5 [1c:06] SCXML: }}}}}suspend session SID=PSJEJVCR8H5M7A7KJFEHAOKGCC00ECQ2
10:11:33.493 RLIB: request to 740(ORS_PRI_TEST) message ResultOfInvoke(1000000101)
refid(1) 3295178
result(1000000004) '0'
10:11:33.493_R_I_ [19:10] routing interface request received: urs/call/007302e8668311f6/func?name=FindConfigObject¶ms=%5B2%2C+%22name%3AVQ_CHAT_POSTEDW_TO%22%5D&sync=1, client=740(ORS_PRI_TEST), ref=3295179
_I_I_007302e8668311f6 [09:0e] script 9c31c25680 DS 9c34b1f610 [37] +r (24 5) (11 0)
_I_I_ [25:01] script **InvokeFunction usage +1=1
10:11:33.493_I_I_007302e8668311f6 [09:06] >>>>>>>>>>>>start interp()
_I_I_007302e8668311f6 [07:46] no error mode for this call
_I_I_007302e8668311f6 [09:04] ASSIGN: v:0:this(LOCAL) <- OBJECT:0000009C31C0DC78[Global]={"Class":"Global"}
_I_I_007302e8668311f6 [09:04] ASSIGN: v:0:_urs(LOCAL) <- OBJECT:0000009C34AF6E40[FM]={}
_I_I_007302e8668311f6 [09:04] ASSIGN: v:0:_parms(LOCAL) <- OBJECT:0000009C33774DD0[Array]=[2,"name:VQ_CHAT_POSTEDW_TO"]
_I_I_007302e8668311f6 [09:04] ASSIGN: v:0:_pbl_func(LOCAL) <- STRING[1,16]: "FindConfigObject"
_I_I_007302e8668311f6 [09:04] ASSIGN: v:0:_r(LOCAL) <- LIST[2]: dbid:1123|type:5|number:VQ_CHAT_POSTEDW_TO|name:VQ_CHAT_POSTEDW_TO|switchdbid:102|switch:IXNSwitch|tenantdbid:1|tenant:Environment
_I_I_007302e8668311f6 [01:1f] <<<<<<<<<<<<stop interp
_I_I_007302e8668311f6 [09:0f] script 9c31c25680 DS 9c34b1f610 [37] -s (24 5) (12 9c34b1f610)
_I_I_ [25:01] script **InvokeFunction usage -1=0
10:11:33.493_R_I_ [19:11] routing interface response 'Info' sent to client 740(ORS_PRI_TEST), ref=3295179
Message: {"dbid":1123,"type":5,"number":"VQ_CHAT_POSTEDW_TO","name":"VQ_CHAT_POSTEDW_TO","switchdbid":102,"switch":"IXNSwitch","tenantdbid":1,"tenant":"Environment"}
10:11:33.493_R_I_ [19:10] routing interface request received: urs/call/007302e8668311f6/udata?RouterData70, client=740(ORS_PRI_TEST), ref=3295180
10:11:33.493_R_I_ [19:11] routing interface response 'Info' sent to client 740(ORS_PRI_TEST), ref=3295180
Message: {}
10:11:33.508_R_I_ [19:10] routing interface request received: urs/call/007302e8668311f6/lvq?name=VQ_CHAT_POSTEDW_TO&aqt=urs2&filter=ewt%2Ctime%2Cwt%2Ccalls%2Cpos%2Cwpos%2Chit, client=740(ORS_PRI_TEST), ref=3295181
10:11:33.508_R_I_ [19:11] routing interface response 'Info' sent to client 740(ORS_PRI_TEST), ref=3295181
Message: {}
10:11:33.508 RLIB: received from 740(ORS_PRI_TEST) message RequestInvoke(1000000100)
refid(1) 3295182
callid(1000000000) '*CPRRGNCUM52SNDD4R3TUGJD8KG00EDCD'
sessionid(1000000010) 'CPRRGNCUM52SNDD4R3TUGJD8KG00EDCD'
fm(1000000001) 'session'
function(1000000002) 'getListItemValue'
args(1000000003) '["GMS_Paused_Services","services","*"]'
10:11:33.508_I_I_007302e8668311f5 [09:0a] SCXML: session SID=PSJEJVCR8H5M7A7KJFEHAOKGCC00ECQ2 external queue: event "function" added
10:11:33.508_I_I_007302e8668311f5 [1c:06] SCXML: {{{{{resume session SID=PSJEJVCR8H5M7A7KJFEHAOKGCC00ECQ2
_I_I_007302e8668311f5 [1c:06] 1. SCXML: look for transitions (1)
_I_I_007302e8668311f5 [1c:04] 1.x SCXML: state <initial>: check transitions, event "function"
10:11:33.508_I_I_007302e8668311f5 [09:05] >>>>>>>>>>>>resume interp(0), func:SCXMLGetEvent
_I_I_007302e8668311f5 [09:04] ASSIGN: v:0:_event(LOCAL) <- OBJECT:0000009C33774DD0[undefined]={"name":"function","data":{"module":"session","func":"getListItemValue","params":"[\"GMS_Paused_Services\",\"services\",\"*\"]"}}
_I_I_007302e8668311f5 [09:04] ASSIGN: v:0:_eventdata(LOCAL) <- LIST[3]: module:session|func:getListItemValue|params:["GMS_Paused_Services","services","*"]
10:11:33.508_I_I_007302e8668311f5 [09:04] <<<<<<<<<<<<suspend interp(NONE), func:SCXMLChangeState timers:00000
_I_I_007302e8668311f5 [1c:05] 2. SCXML: microstep
_I_I_007302e8668311f5 [1c:05] 2.1 SCXML: microstep exitting phase
_I_I_007302e8668311f5 [1c:05] 2.2 SCXML: microstep transiting phase
10:11:33.508_I_I_007302e8668311f5 [09:05] >>>>>>>>>>>>resume interp(0), func:SCXMLChangeState
_I_I_007302e8668311f5 [09:04] ASSIGN: v:25:_pbl_m(LOCAL) <- STRING[1,7]: "session"
_I_I_007302e8668311f5 [09:04] ASSIGN: v:25:_pbl_f(LOCAL) <- STRING[1,16]: "getListItemValue"
_I_I_007302e8668311f5 [09:04] ASSIGN: v:25:_pbl_parms(LOCAL) <- OBJECT:0000009C337757F0[Array]=["GMS_Paused_Services","services","*"]
_I_I_007302e8668311f5 [07:3f] get data from cfglist GMS_Paused_Services(0 0) item services, key * result: 'no list'
_I_I_007302e8668311f5 [09:04] ASSIGN: v:25:_pbl_r(LOCAL) <- STRING[2,0]: ""
10:11:33.508_I_I_007302e8668311f5 [09:04] <<<<<<<<<<<<suspend interp(NONE), func:SCXMLGetEvent timers:00000
_I_I_007302e8668311f5 [1c:05] 2.3 SCXML: microstep entering phase
_I_I_007302e8668311f5 [1c:06] 1. SCXML: look for transitions (2)
10:11:33.508_I_I_007302e8668311f5 [1c:06] SCXML: }}}}}suspend session SID=PSJEJVCR8H5M7A7KJFEHAOKGCC00ECQ2
10:11:33.508 RLIB: request to 740(ORS_PRI_TEST) message (1)
errmsg(10) '0018 Unknown object'
error(9) 10
refid(1) 3295182
10:11:33.587_H_I_007302e8668311f6 [08:08] OK InfoMessage (-1) is received from server ##HTTPSERVER, refid=205, hint=soap
HTTPHeaders set-cookie:sap-usercontext=sap-client=100; path=/|content-type:text/xml; charset=utf-8|content-length:1054|accept:text/xml|sap-srt_id:20191004/101139/v1.00_final_6.40/005056AE19FE1ED9B9CFD2EEF168D588|sap-srt_server_info:GBQ_100,56 ,urn:sap-com:document:sap:soap:functions:mc-style,ZWS_GET_CUSTOMER,ZfmwsGetCustomer,6 |sap-srt_server_info_ext:0
key V1 [list] value: (size=0)
key STRN [String] value: "OK"
key V2 [list] value: (size=0)
key STRN [String] value: "FEDERICO.RIDARELLA"
10:11:33.587_I_I_007302e8668311f6 [09:05] >>>>>>>>>>>>resume interp(0), func:GetWebServiceInfoTLS
_I_I_007302e8668311f6 [09:04] ASSIGN: __WEBReturn(SCRIPT) <- LIST[1]: V1.STRN:OK|V2.STRN:FEDERICO.RIDARELLA
_I_I_007302e8668311f6 [09:04] ASSIGN: EsitoNfea(LOCAL) <- STRING[1,4]: "1:OK"
_I_I_007302e8668311f6 [09:04] ASSIGN: consulente_user(LOCAL) <- STRING[1,20]: "1:FEDERICO.RIDARELLA"
_I_I_007302e8668311f6 [09:04] ASSIGN: consulente_new(LOCAL) <- STRING[1,18]: "FEDERICO.RIDARELLA"
_I_I_007302e8668311f6 [09:04] ASSIGN: EsitoNfea(LOCAL) <- STRING[1,2]: "OK"
_I_I_007302e8668311f6 [09:04] ASSIGN: A_Target(LOCAL) <- STRING[1,34]: "FEDERICO.RIDARELLA@SS_ROU_PRI_TO.A"
10:11:33.587 Int 22000 @@@ESITOWSCHATFEDERICO.RIDARELLA @@@@target=FEDERICO.RIDARELLA@SS_ROU_PRI_TO.A
10:11:33.587_I_I_007302e8668311f6 [07:07] HERE IS TARGETS
TARGETS: FEDERICO.RIDARELLA@SS_ROU_PRI_TO.A
10:11:33.587_M_I_ [17:0c] VQ 9c34b6d210 created: type=0, ten=Environment
===============================
_M_I_ [17:06] VQ 9c34b6d210 TRG 9c34b6d378 added: name=FEDERICO.RIDARELLA, location=SS_ROU_PRI_TO, type=A, state=##state, activity=unknown
_C_W_ [10:05] SO(0 0 0) ten=Environment name=FEDERICO.RIDARELLA@SS_ROU_PRI_TO.A: there is no config object
_M_E_ [10:06] SO(0 0 0) ten=Environment name=FEDERICO.RIDARELLA@SS_ROU_PRI_TO.A: stat <##state> failed
_M_E_ [17:02] can not find SO FEDERICO.RIDARELLA[##state] for stat server SS_ROU_PRI_TO
_M_I_007302e8668311f6 [17:0f] VQ 9c34b6d210 [at all 6 0/0 0] 1 Target(s), flag=c08a, guid: 0Environment|||1|md38|1|00|0|0|---|||||||00|00{}{}{}[]FEDERICO.RIDARELLA@SS_ROU_PRI_TO.A
10:11:33.587_M_I_007302e8668311f6 [13:01] current vq: 9c337a0360 id=472234(), nVQ=D-AJGHFHDD, priority=0, time=1570176693.587
10:11:33.587_M_I_007302e8668311f6 [17:11] VQ 9c34b6d210 first available call: 007302e8668311f6, reason=(1)binding
10:11:33.587_M_I_007302e8668311f6 [13:03] call (vq 9c337a0360, id=472234, priority 0, time 1570176693.587) waits for VQ 9c34b6d210 (name="") now (0 1570176693.587)
10:11:33.587_M_I_007302e8668311f6 [17:0e] VQ 9c34b6d210 (LVQ "", id=472234), (1 Targets): SELECT ANY by stat <NONE>(random 0)
_M_I_007302e8668311f6 [17:0e] VQ 9c34b6d210 TRG "FEDERICO.RIDARELLA"(9c34b6d378): empty(0-0 components) passed
_M_I_007302e8668311f6 [17:0e] VQ 9c34b6d210 (LVQ "" id=472234): TRG NOT SELECTED (1 0 0 0 0)
_I_I_007302e8668311f6 [07:0a] HERE IS WAIT (-1 sec)
_I_I_007302e8668311f6 [07:0a] HERE IS WAIT (10 sec)
10:11:33.587_B_I_007302e8668311f6 [07:0a] delay treatments for 0 msec
10:11:33.587_I_I_007302e8668311f6 [09:04] <<<<<<<<<<<<suspend interp(WAIT), func:Wait timers:11000
________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________________
10:12:00.836_B_I_007302e866831203 [07:64] start chain of treatments
10:12:00.836 RLIB: received from 740(ORS_PRI_TEST) message RequestUpdateVCall(1000000006)
refid(1) 3295278
callid(1000000000) '00011aECP47T0BHG'
args(1000000003) '{"MediaType":"chat","UserData":{"ReceivedAt":"2019-07-26T16:13:52Z","InteractionId":"00011aECP47T0BHG","MediaType":"chat","PlacedInQueueAt":"2019-10-04T08:11:59Z","InteractionType":"Inbound","InteractionSubType":"InboundNew","Queue":"GMSInbound.Chat.QueueORSWebPostemobile","SubmittedBy":"GMS_ChatServer_PRI_TO_TEST","SubmittedAt":"2019-07-26T16:13:52Z","MovedToQueueAt":"2019-07-26T16:13:52Z","TenantId":1,"InteractionState":1,"IsOnline":0,"IsLocked":0,"ChatServerAppName":"GMS_ChatServer_PRI_TO_TEST","ChatServerDBID":"198","ChatServerHost":"T-CTI-POM-WSV06","ChatServerModeHA":"true","ChatServerPort":"7201","ChatServerSessionClientLeftAt":"2019-07-26T16:16:13Z","ChatServerSessionClosedAt":"2019-07-26T16:16:13Z","ChatServerSessionStartedAt":"2019-07-26T16:13:52Z","ChatServerVersion":"8.5.304.04","ChatServerWebapiPort":"7200","ContactCreated":"false","IdentifyCreateContact":"3","RStrategyDBID":"977","RStrategyName":"GMSInbound.Chat.QueueORSWebPostemobile.Routing","Subject":"supporto","TimeZone":"120","_data_id":"219-343eede9-8c58-40fb-a6ef-1f6be79d4dd4","csg_MediaType":"chat","csg_SessionEndedAgent":"ABSENT","csg_SessionEndedBy":"CLIENT","csg_SessionEndedReason":"QUIT","userDisplayName":"Gianni","csg_TenantId":1}}'
10:12:00.836 RLIB: request to 740(ORS_PRI_TEST) message ResultOfUpdateVCall(1000000007)
callid(1000000000) '00011aECP47T0BHG'
refid(1) 3295278
10:12:00.836 RLIB: received from 740(ORS_PRI_TEST) message RequestUpdateVCall(1000000006)
refid(1) 3295279
callid(1000000000) '00011aECP47T0BHG'
args(1000000003) '{"MediaType":"chat","UserData":{"ReceivedAt":"2019-07-26T16:13:52Z","InteractionId":"00011aECP47T0BHG","MediaType":"chat","PlacedInQueueAt":"2019-10-04T08:11:59Z","InteractionType":"Inbound","InteractionSubType":"InboundNew","Queue":"GMSInbound.Chat.QueueORSWebPostemobile","SubmittedBy":"GMS_ChatServer_PRI_TO_TEST","SubmittedAt":"2019-07-26T16:13:52Z","MovedToQueueAt":"2019-07-26T16:13:52Z","TenantId":1,"InteractionState":1,"IsOnline":0,"IsLocked":0,"ChatServerAppName":"GMS_ChatServer_PRI_TO_TEST","ChatServerDBID":"198","ChatServerHost":"T-CTI-POM-WSV06","ChatServerModeHA":"true","ChatServerPort":"7201","ChatServerSessionClientLeftAt":"2019-07-26T16:16:13Z","ChatServerSessionClosedAt":"2019-07-26T16:16:13Z","ChatServerSessionStartedAt":"2019-07-26T16:13:52Z","ChatServerVersion":"8.5.304.04","ChatServerWebapiPort":"7200","ContactCreated":"false","IdentifyCreateContact":"3","RStrategyDBID":"977","RStrategyName":"GMSInbound.Chat.QueueORSWebPostemobile.Routing","RTargetAgentGroup":"VAG_POSTEMOBILEWEB_CHAT","Subject":"supporto","TimeZone":"120","_data_id":"219-343eede9-8c58-40fb-a6ef-1f6be79d4dd4","csg_MediaType":"chat","csg_SessionEndedAgent":"ABSENT","csg_SessionEndedBy":"CLIENT","csg_SessionEndedReason":"QUIT","userDisplayName":"Gianni","csg_TenantId":1}}'
10:12:00.836 RLIB: request to 740(ORS_PRI_TEST) message ResultOfUpdateVCall(1000000007)
callid(1000000000) '00011aECP47T0BHG'
refid(1) 3295279
10:12:00.867_R_I_ [19:10] routing interface request received: urs/call/007302e8668311f6/update?_CB_N_AGENT_ADDED_TO_IXN=1&sync=1, client=740(ORS_PRI_TEST), ref=3295280
10:12:00.867_T_I_007302e8668311f6 [14:02] sending event 85 for vq VQ_CHAT_POSTEDW_TO (0 0-0 (0, i=121 o=120) 1570098958 787/32)
request to 65201(--) message RequestDistributeEvent
AttributeMediaType 5
AttributeTimeout 60
AttributeTimeinuSecs 867651
AttributeTimeinSecs 1570176720 (10:12:00)
AttributeExtensions [172] 00 06 00 00..
'SIGNATURE' 'router'
'NAME' 'URS_PRI_TO_TEST'
'VERSION' 'Version: 8.1.400.55'
'CLUSTER' 'URS_PRI_TO_TEST'
'VQID' 'PSJEJVCR8H5M7A7KJFEHAOKGCC00ECQ7'
'CUSTOMER_ID' 'Environment'
AttributeUserData [1623] 00 33 00 00..
'_CB_SERVICE_ID' '219-532fb697-ad9f-4d7e-9f34-981ebc9544d5'
'_CB_T_SERVICE_START' '1570176693'
'_CB_T_CALLBACK_ACCEPTED' '1570176580'
'_CB_T_NEXT_REDIAL_ATTEMPT' 'undefined'
'_CB_N_IS_SNOOZED' 'false'
'_CB_N_CALLBACK_MEDIA_ATTEMPTS' '0'
'_CB_T_LAST_DIAL_ATTEMPT' 'undefined'
'_CB_N_CALLBACK_ACCEPTED' '1'
'_CB_DIM_CHANNEL' 'WEB'
'_CB_DIM_TYPE' 'IMMEDIATE'
'SAP_USERCONS' 'FEDERICO.RIDARELLA'
'SAP_SOLUTION' 'GMS'
'SERVIZIO' 'chat'
'SAP_CANALE' '007'
'EmailAddress' '3472719757'
'SAP_EMAIL' '3472719757'
'SAP_SERVIZIO' ''
'GMS_ROUTABLE' '0'
'RouterData70' '("t"="1570176693 446")'
'GMS_Target_Requested' '[{"target":"VAG_PDW_CHAT@SS_ROU_PRI_TO.GA","timeout":"10","clear":false,"stat_to_check":"StatAgentsAvailable","stat_operator":"<","stat_value":"1"}]'
'GMS_Target_Used' 'VAG_PDW_CHAT@SS_ROU_PRI_TO.GA'
'RTargetAgentGroup' 'VAG_PDW_CHAT'
'RPVQID' 'PSJEJVCR8H5M7A7KJFEHAOKGCC00ECQ7'
'_CB_T_CUSTOMER_CONNECTED' '1570176710'
'GMS_ROUTABLE' '1'
'RVQID' 'PSJEJVCR8H5M7A7KJFEHAOKGCC00ECQ7'
'RVQDBID' '1123'
'RTargetTypeSelected' '2'
'RTargetRuleSelected' ''
'RTargetObjectSelected' 'VAG_PDW_CHAT'
'RTargetObjSelDBID' '989'
'RTargetAgentSelected' '1692'
'RTargetAgSelDBID' '815'
'RTargetPlaceSelected' 'PlaceDigital3'
'RTargetPlSelDBID' '116'
'RTenant' 'Environment'
'RTenantDBID' '1'
'RStrategyName' 'GMS_WaitForTarget_TO_8520705_v4'
'RStrategyDBID' '1348'
'CBR-actual_volume' ''
'CBR-Interaction_cost' ''
'CBR-contract_DBIDs' ''
'CBR-IT-path_DBIDs' ''
'RRequestedSkillCombination' ''
'RRequestedSkills'(list)
'RTargetRequested' 'VAG_PDW_CHAT'
'CustomerSegment' 'default'
'ServiceType' 'default'
'ServiceObjective' ''
'PegAGVAG_PDW_CHAT' 1
'_CB_N_AGENT_ADDED_TO_IXN' '1'
AttributeOtherDNRole 1
AttributeThisDNRole 2
AttributeThisQueue 'VQ_CHAT_POSTEDW_TO'
AttributeThisDN 'VQ_CHAT_POSTEDW_TO'
AttributeConnID 007302e8668311f6
AttributeCustomerID 'Environment'
AttributeReferenceID 4294967295
AttributeUserEvent EventAttachedDataChanged
..sent to T-CTI-POM-WSV06:7500(fd=696)
10:12:00.867_R_I_ [19:11] routing interface response 'Info' sent to client 740(ORS_PRI_TEST), ref=3295280
Message: OK
received from 65201(INX_PRI_TO_TEST)T-CTI-POM-WSV06:7500(fd=) message EventACK(refid=-1)
10:12:00.883_H_I_007302e8668311f6 [08:08] OK InfoMessage (200) is received from server ##HTTPSERVER, refid=206, hint=http
HTTPHeaders Set-Cookie:XSRF-TOKEN=192f6fae-6231-46a5-b11d-9d0eaa96ac79;Path=/genesys,JSESSIONID=node0oi2g2k7c00wzh69x4upcoxep91674.node0;Path=/genesys;HttpOnly|Expires:Thu, 01 Jan 1970 00:00:00 GMT|Content-Type:text/html|X-Content-Type-Options:nosniff,nosniff|X-XSS-Protection:1; mode=block|X-Frame-Options:SAMEORIGIN|Content-Length:16
HTTPBody {"message":"OK"}
10:12:00.883_A_I_007302e8668311f6 [0E:1c] DEPARTURE/ARRIVAL+TIMER(0) delivery
10:12:00.883_A_I_007302e8668311f6 [0E:09] <-----------TIMER
10:12:00.883_T_I_007302e8668311f6 [14:02] sending event 58 for vq VQ_CHAT_POSTEDW_TO (1 17-17 (0, i=121 o=121) 1570176720 794/32)
request to 65201(--) message RequestDistributeEvent
AttributeMediaType 5
AttributeTimeout 60
AttributeTimeinuSecs 883271
AttributeTimeinSecs 1570176720 (10:12:00)
AttributeExtensions [172] 00 06 00 00..
'SIGNATURE' 'router'
'NAME' 'URS_PRI_TO_TEST'
'VERSION' 'Version: 8.1.400.55'
'CLUSTER' 'URS_PRI_TO_TEST'
'VQID' 'PSJEJVCR8H5M7A7KJFEHAOKGCC00ECQ7'
'CUSTOMER_ID' 'Environment'
AttributeUserData [1623] 00 33 00 00..
'_CB_SERVICE_ID' '219-532fb697-ad9f-4d7e-9f34-981ebc9544d5'
'_CB_T_SERVICE_START' '1570176693'
'_CB_T_CALLBACK_ACCEPTED' '1570176580'
'_CB_T_NEXT_REDIAL_ATTEMPT' 'undefined'
'_CB_N_IS_SNOOZED' 'false'
'_CB_N_CALLBACK_MEDIA_ATTEMPTS' '0'
'_CB_T_LAST_DIAL_ATTEMPT' 'undefined'
'_CB_N_CALLBACK_ACCEPTED' '1'
'_CB_DIM_CHANNEL' 'WEB'
'_CB_DIM_TYPE' 'IMMEDIATE'
'SAP_USERCONS' 'FEDERICO.RIDARELLA'
'SAP_SOLUTION' 'GMS'
'SERVIZIO' 'chat'
'SAP_CANALE' '007'
'EmailAddress' '3472719757'
'SAP_EMAIL' '3472719757'
'SAP_SERVIZIO' ''
'GMS_ROUTABLE' '0'
'RouterData70' '("t"="1570176693 446")'
'GMS_Target_Requested' '[{"target":"VAG_PDW_CHAT@SS_ROU_PRI_TO.GA","timeout":"10","clear":false,"stat_to_check":"StatAgentsAvailable","stat_operator":"<","stat_value":"1"}]'
'GMS_Target_Used' 'VAG_PDW_CHAT@SS_ROU_PRI_TO.GA'
'RTargetAgentGroup' 'VAG_PDW_CHAT'
'RPVQID' 'PSJEJVCR8H5M7A7KJFEHAOKGCC00ECQ7'
'_CB_T_CUSTOMER_CONNECTED' '1570176710'
'GMS_ROUTABLE' '1'
'RVQID' 'PSJEJVCR8H5M7A7KJFEHAOKGCC00ECQ7'
'RVQDBID' '1123'
'RTargetTypeSelected' '2'
'RTargetRuleSelected' ''
'RTargetObjectSelected' 'VAG_PDW_CHAT'
'RTargetObjSelDBID' '989'
'RTargetAgentSelected' '1692'
'RTargetAgSelDBID' '815'
'RTargetPlaceSelected' 'PlaceDigital3'
'RTargetPlSelDBID' '116'
'RTenant' 'Environment'
'RTenantDBID' '1'
'RStrategyName' 'GMS_WaitForTarget_TO_8520705_v4'
'RStrategyDBID' '1348'
'CBR-actual_volume' ''
'CBR-Interaction_cost' ''
'CBR-contract_DBIDs' ''
'CBR-IT-path_DBIDs' ''
'RRequestedSkillCombination' ''
'RRequestedSkills'(list)
'RTargetRequested' 'VAG_PDW_CHAT'
'CustomerSegment' 'default'
'ServiceType' 'default'
'ServiceObjective' ''
'PegAGVAG_PDW_CHAT' 1
'_CB_N_AGENT_ADDED_TO_IXN' '1'
AttributeThirdPartyDNRole 2
AttributeThirdPartyDN '1692'
AttributeOtherDNRole 1
AttributeThisDNRole 2
AttributeThisQueue 'VQ_CHAT_POSTEDW_TO'
AttributeThisDN 'VQ_CHAT_POSTEDW_TO'
AttributeConnID 007302e8668311f6
AttributeCustomerID 'Environment'
AttributeReferenceID 4294967295
AttributeUserEvent EventDiverted
..sent to T-CTI-POM-WSV06:7500(fd=696)
_I_I_007302e8668311f6 [01:0f] binding with TRG 0 (VQ 0), vq=9c337a0360
_I_I_007302e8668311f6 [01:10] binding with TRG 0 (VQ 0), vq=9c337a0360
10:12:00.883_M_I_007302e8668311f6 [13:03] call (vq 9c337a0360, id=472240, priority 500) doesn't wait for VQ 9c34b3b280 (name="VQ_CHAT_POSTEDW_TO" stats=17281 17281 1 1570176720.883) now (0)
10:12:00.883 Int 20002 interaction 007302e8668311f6 is routed to VAG_PDW_CHAT@SS_ROU_PRI_TO.GA
_T_I_007302e8668311f6 [0E:0d] routing done
Time to receive acknowledgement of call sending(msec) < 27437 >
10:12:00.883_I_I_007302e8668311f6 [09:05] >>>>>>>>>>>>resume interp(0), func:Wait
10:12:00.883 Int 22000 GMSCB: Target selected on index: 0
10:12:00.883 Int 22000 @@@ENDSTRATEGYCHATOP
[b]Agent_With_Toaster_KO[/b]
10:38:33.142 Int 22000 @@@STARTSTRATEGYCHAT
_I_I_007302e8668314a7 [09:04] ASSIGN: _GMS_CONTACT(LOCAL) <- STRING[1,10]: "3450828769"
_I_I_007302e8668314a7 [09:04] ASSIGN: new_cli(LOCAL) <- STRING[1,14]: "+39 3450828769"
_I_I_007302e8668314a7 [09:04] ASSIGN: url_anag(LOCAL) <- STRING[2,100]: "LINKOFTHEWS"
_I_I_007302e8668314a7 [09:04] ASSIGN: Scenario(LOCAL) <- STRING[2,3]: "PDW"
_I_I_007302e8668314a7 [09:04] ASSIGN: ContactKey(LOCAL) <- STRING[2,15]: "SAP_TELCONTATTO"
_I_I_007302e8668314a7 [09:04] ASSIGN: v_chat_app_name(LOCAL) <- STRING[2,26]: "GMS_ChatServer_PRI_TO_TEST"
_I_I_007302e8668314a7 [09:04] ASSIGN: __IntVar(LOCAL) <- INTEGER: 5
10:38:33.142_I_I_007302e8668314a7 [07:39] HERE IS XDATA
10:38:33.142_H_I_ [08:0c] SOAP request 207 sent to HTTP Bridge:
URL: LINKOFTHEWS
Method: urn:ZfmwsGetCustomer
NameSpace: urn=urn:sap-com:document:sap:soap:functions:mc-style
SOAPaction: ZfmwsGetCustomer
Input: ItSearchCriteria.item.AttrName:SAP_TELCONTATTO|ItSearchCriteria.item.AttrValue:+39 3450828769|IvScenario:PDW
Output: ZfmwsGetCustomerResponse.Esito,ZfmwsGetCustomerResponse.EtResults.item.UsernameCons
HTTPAuthent:2 user and password (1 )
SOAPSecrty:
Cookie:
10:38:33.142_I_I_007302e8668314a7 [09:04] <<<<<<<<<<<<suspend interp(WAIT_WEBSERVICE), func:GetWebServiceInfoTLS timers:00000
10:38:33.142_R_I_ [19:10] routing interface request received: urs/call/007302e8668314a7/func?name=Timeout¶ms=%5B120%5D&sync=1, client=740(ORS_PRI_TEST), ref=3300002
_I_I_007302e8668314a7 [09:0e] script 9c31c25680 DS 9c34b1f610 [37] +r (24 5) (13 0)
_I_I_ [25:01] script **InvokeFunction usage +1=1
10:38:33.142_I_I_007302e8668314a7 [09:06] >>>>>>>>>>>>start interp()
_I_I_007302e8668314a7 [07:46] no error mode for this call
_I_I_007302e8668314a7 [09:04] ASSIGN: v:0:this(LOCAL) <- OBJECT:0000009C31C0DC78[Global]={"Class":"Global"}
_I_I_007302e8668314a7 [09:04] ASSIGN: v:0:_urs(LOCAL) <- OBJECT:0000009C34AE2ED0[FM]={}
_I_I_007302e8668314a7 [09:04] ASSIGN: v:0:_parms(LOCAL) <- OBJECT:0000009C33A1FE10[Array]=[120]
_I_I_007302e8668314a7 [09:04] ASSIGN: v:0:_pbl_func(LOCAL) <- STRING[1,7]: "Timeout"
_I_I_007302e8668314a7 [09:04] ASSIGN: v:0:_r(LOCAL) <- UNKNOWN: NULL-STRING
_I_I_007302e8668314a7 [01:1f] <<<<<<<<<<<<stop interp
_I_I_007302e8668314a7 [09:0f] script 9c31c25680 DS 9c34b1f610 [37] -s (24 5) (14 9c34b1f610)
_I_I_ [25:01] script **InvokeFunction usage -1=0
10:38:33.142_R_I_ [19:11] routing interface response 'Info' sent to client 740(ORS_PRI_TEST), ref=3300002
Message: undefined
10:38:33.142_R_I_ [19:10] routing interface request received: urs/call/007302e8668314a7/lvq?name=VQ_CHAT_POSTEDW_TO&aqt=urs2&filter=ewt%2Ctime%2Cwt%2Ccalls%2Cpos%2Cwpos%2Chit%2Cpriority, client=740(ORS_PRI_TEST), ref=3300003
10:38:33.142_R_I_ [19:11] routing interface response 'Info' sent to client 740(ORS_PRI_TEST), ref=3300003
Message: {}
10:38:33.142_R_I_ [19:10] routing interface request received: urs/call/007302e8668314a7/func?name=FindConfigObject¶ms=%5B1%2C+%22name%3A%22%5D&sync=1, client=740(ORS_PRI_TEST), ref=3300004
_I_I_007302e8668314a7 [09:0e] script 9c31c25680 DS 9c34b1f610 [37] +r (24 5) (14 0)
_I_I_ [25:01] script **InvokeFunction usage +1=1
10:38:33.142_I_I_007302e8668314a7 [09:06] >>>>>>>>>>>>start interp()
_I_I_007302e8668314a7 [07:46] no error mode for this call
_I_I_007302e8668314a7 [09:04] ASSIGN: v:0:this(LOCAL) <- OBJECT:0000009C31C0DC78[Global]={"Class":"Global"}
_I_I_007302e8668314a7 [09:04] ASSIGN: v:0:_urs(LOCAL) <- OBJECT:0000009C33A1FE10[FM]={}
_I_I_007302e8668314a7 [09:04] ASSIGN: v:0:_parms(LOCAL) <- OBJECT:0000009C34AE2ED0[Array]=[1,"name:"]
_I_I_007302e8668314a7 [09:04] ASSIGN: v:0:_pbl_func(LOCAL) <- STRING[1,16]: "FindConfigObject"
_I_I_007302e8668314a7 [09:04] ASSIGN: v:0:_r(LOCAL) <- LIST[1]: :
_I_I_007302e8668314a7 [01:1f] <<<<<<<<<<<<stop interp
_I_I_007302e8668314a7 [09:0f] script 9c31c25680 DS 9c34b1f610 [37] -s (24 5) (15 9c34b1f610)
_I_I_ [25:01] script **InvokeFunction usage -1=0
10:38:33.142_R_I_ [19:11] routing interface response 'Info' sent to client 740(ORS_PRI_TEST), ref=3300004
Message: {}
10:38:33.142 RLIB: received from 740(ORS_PRI_TEST) message RequestInvoke(1000000100)
refid(1) 3300005
callid(1000000000) '*CPRRGNCUM52SNDD4R3TUGJD8KG00EE21'
sessionid(1000000010) 'CPRRGNCUM52SNDD4R3TUGJD8KG00EE21'
fm(1000000001) 'queue'
function(1000000002) 'countSkillInGroup'
args(1000000003) '["","VAG_PDW_CHAT@SS_ROU_PRI_TO.GA","login(voice)"]'
10:38:33.142_I_I_007302e8668314a6 [09:0a] SCXML: session SID=PSJEJVCR8H5M7A7KJFEHAOKGCC00EDFJ external queue: event "function" added
10:38:33.142_I_I_007302e8668314a6 [1c:06] SCXML: {{{{{resume session SID=PSJEJVCR8H5M7A7KJFEHAOKGCC00EDFJ
_I_I_007302e8668314a6 [1c:06] 1. SCXML: look for transitions (1)
_I_I_007302e8668314a6 [1c:04] 1.x SCXML: state <initial>: check transitions, event "function"
10:38:33.142_I_I_007302e8668314a6 [09:05] >>>>>>>>>>>>resume interp(0), func:SCXMLGetEvent
_I_I_007302e8668314a6 [09:04] ASSIGN: v:0:_event(LOCAL) <- OBJECT:0000009C34AE2ED0[undefined]={"name":"function","data":{"module":"queue","func":"countSkillInGroup","params":"[\"\",\"VAG_PDW_CHAT@SS_ROU_PRI_TO.GA\",\"login(voice)\"]"}}
_I_I_007302e8668314a6 [09:04] ASSIGN: v:0:_eventdata(LOCAL) <- LIST[3]: module:queue|func:countSkillInGroup|params:["","VAG_PDW_CHAT@SS_ROU_PRI_TO.GA","login(voice)"]
10:38:33.142_I_I_007302e8668314a6 [09:04] <<<<<<<<<<<<suspend interp(NONE), func:SCXMLChangeState timers:00000
_I_I_007302e8668314a6 [1c:05] 2. SCXML: microstep
_I_I_007302e8668314a6 [1c:05] 2.1 SCXML: microstep exitting phase
_I_I_007302e8668314a6 [1c:05] 2.2 SCXML: microstep transiting phase
10:38:33.142_I_I_007302e8668314a6 [09:05] >>>>>>>>>>>>resume interp(0), func:SCXMLChangeState
_I_I_007302e8668314a6 [09:04] ASSIGN: v:25:_pbl_m(LOCAL) <- STRING[1,5]: "queue"
_I_I_007302e8668314a6 [09:04] ASSIGN: v:25:_pbl_f(LOCAL) <- STRING[1,17]: "countSkillInGroup"
_I_I_007302e8668314a6 [09:04] ASSIGN: v:25:_pbl_parms(LOCAL) <- OBJECT:0000009C33A342D0[Array]=["","VAG_PDW_CHAT@SS_ROU_PRI_TO.GA","login(voice)"]
10:38:33.142_I_I_007302e8668314a6 [07:15] skill login(voice) for group VAG_PDW_CHAT@SS_ROU_PRI_TO.GA
10:38:33.142_M_I_ [10:06] SO(9c34b24388 -1 2) ten=Environment name=?VAG_PDW_CHAT:login(voice)@SS_ROU_PRI_TO.GA: stat <##content> asked (0,0,3)
_I_I_007302e8668314a6 [09:04] ASSIGN: v:25:_pbl_r(LOCAL) <- FLOAT: 0
10:38:33.142_I_I_007302e8668314a6 [09:04] <<<<<<<<<<<<suspend interp(NONE), func:SCXMLGetEvent timers:00000
_I_I_007302e8668314a6 [1c:05] 2.3 SCXML: microstep entering phase
_I_I_007302e8668314a6 [1c:06] 1. SCXML: look for transitions (2)
10:38:33.142_I_I_007302e8668314a6 [1c:06] SCXML: }}}}}suspend session SID=PSJEJVCR8H5M7A7KJFEHAOKGCC00EDFJ
10:38:33.142 RLIB: request to 740(ORS_PRI_TEST) message ResultOfInvoke(1000000101)
refid(1) 3300005
result(1000000004) '0'
10:38:33.158_R_I_ [19:10] routing interface request received: urs/call/007302e8668314a7/func?name=FindConfigObject¶ms=%5B2%2C+%22name%3AVQ_CHAT_POSTEDW_TO%22%5D&sync=1, client=740(ORS_PRI_TEST), ref=3300006
_I_I_007302e8668314a7 [09:0e] script 9c31c25680 DS 9c34b1f610 [37] +r (24 5) (15 0)
_I_I_ [25:01] script **InvokeFunction usage +1=1
10:38:33.158_I_I_007302e8668314a7 [09:06] >>>>>>>>>>>>start interp()
_I_I_007302e8668314a7 [07:46] no error mode for this call
_I_I_007302e8668314a7 [09:04] ASSIGN: v:0:this(LOCAL) <- OBJECT:0000009C31C0DC78[Global]={"Class":"Global"}
_I_I_007302e8668314a7 [09:04] ASSIGN: v:0:_urs(LOCAL) <- OBJECT:0000009C336E7BA8[FM]={}
_I_I_007302e8668314a7 [09:04] ASSIGN: v:0:_parms(LOCAL) <- OBJECT:0000009C33A1FE10[Array]=[2,"name:VQ_CHAT_POSTEDW_TO"]
_I_I_007302e8668314a7 [09:04] ASSIGN: v:0:_pbl_func(LOCAL) <- STRING[1,16]: "FindConfigObject"
_I_I_007302e8668314a7 [09:04] ASSIGN: v:0:_r(LOCAL) <- LIST[2]: dbid:1123|type:5|number:VQ_CHAT_POSTEDW_TO|name:VQ_CHAT_POSTEDW_TO|switchdbid:102|switch:IXNSwitch|tenantdbid:1|tenant:Environment
_I_I_007302e8668314a7 [01:1f] <<<<<<<<<<<<stop interp
_I_I_007302e8668314a7 [09:0f] script 9c31c25680 DS 9c34b1f610 [37] -d (24 5) (0 0)
_I_I_ [25:01] script **InvokeFunction usage -1=0
10:38:33.158_R_I_ [19:11] routing interface response 'Info' sent to client 740(ORS_PRI_TEST), ref=3300006
Message: {"dbid":1123,"type":5,"number":"VQ_CHAT_POSTEDW_TO","name":"VQ_CHAT_POSTEDW_TO","switchdbid":102,"switch":"IXNSwitch","tenantdbid":1,"tenant":"Environment"}
10:38:33.158_R_I_ [19:10] routing interface request received: urs/call/007302e8668314a7/udata?RouterData70, client=740(ORS_PRI_TEST), ref=3300007
10:38:33.158_R_I_ [19:11] routing interface response 'Info' sent to client 740(ORS_PRI_TEST), ref=3300007
Message: {}
10:38:33.158_R_I_ [19:10] routing interface request received: urs/call/007302e8668314a7/lvq?name=VQ_CHAT_POSTEDW_TO&aqt=urs2&filter=ewt%2Ctime%2Cwt%2Ccalls%2Cpos%2Cwpos%2Chit, client=740(ORS_PRI_TEST), ref=3300008
10:38:33.158_R_I_ [19:11] routing interface response 'Info' sent to client 740(ORS_PRI_TEST), ref=3300008
Message: {}
10:38:33.158 RLIB: received from 740(ORS_PRI_TEST) message RequestInvoke(1000000100)
refid(1) 3300009
callid(1000000000) '*CPRRGNCUM52SNDD4R3TUGJD8KG00EE21'
sessionid(1000000010) 'CPRRGNCUM52SNDD4R3TUGJD8KG00EE21'
fm(1000000001) 'session'
function(1000000002) 'getListItemValue'
args(1000000003) '["GMS_Paused_Services","services","*"]'
10:38:33.158_I_I_007302e8668314a6 [09:0a] SCXML: session SID=PSJEJVCR8H5M7A7KJFEHAOKGCC00EDFJ external queue: event "function" added
10:38:33.158_I_I_007302e8668314a6 [1c:06] SCXML: {{{{{resume session SID=PSJEJVCR8H5M7A7KJFEHAOKGCC00EDFJ
_I_I_007302e8668314a6 [1c:06] 1. SCXML: look for transitions (1)
_I_I_007302e8668314a6 [1c:04] 1.x SCXML: state <initial>: check transitions, event "function"
10:38:33.158_I_I_007302e8668314a6 [09:05] >>>>>>>>>>>>resume interp(0), func:SCXMLGetEvent
_I_I_007302e8668314a6 [09:04] ASSIGN: v:0:_event(LOCAL) <- OBJECT:0000009C33A1FE10[undefined]={"name":"function","data":{"module":"session","func":"getListItemValue","params":"[\"GMS_Paused_Services\",\"services\",\"*\"]"}}
_I_I_007302e8668314a6 [09:04] ASSIGN: v:0:_eventdata(LOCAL) <- LIST[3]: module:session|func:getListItemValue|params:["GMS_Paused_Services","services","*"]
10:38:33.158_I_I_007302e8668314a6 [09:04] <<<<<<<<<<<<suspend interp(NONE), func:SCXMLChangeState timers:00000
_I_I_007302e8668314a6 [1c:05] 2. SCXML: microstep
_I_I_007302e8668314a6 [1c:05] 2.1 SCXML: microstep exitting phase
_I_I_007302e8668314a6 [1c:05] 2.2 SCXML: microstep transiting phase
10:38:33.158_I_I_007302e8668314a6 [09:05] >>>>>>>>>>>>resume interp(0), func:SCXMLChangeState
_I_I_007302e8668314a6 [09:04] ASSIGN: v:25:_pbl_m(LOCAL) <- STRING[1,7]: "session"
_I_I_007302e8668314a6 [09:04] ASSIGN: v:25:_pbl_f(LOCAL) <- STRING[1,16]: "getListItemValue"
_I_I_007302e8668314a6 [09:04] ASSIGN: v:25:_pbl_parms(LOCAL) <- OBJECT:0000009C34AE2ED0[Array]=["GMS_Paused_Services","services","*"]
_I_I_007302e8668314a6 [07:3f] get data from cfglist GMS_Paused_Services(0 0) item services, key * result: 'no list'
_I_I_007302e8668314a6 [09:04] ASSIGN: v:25:_pbl_r(LOCAL) <- STRING[3,0]: ""
10:38:33.158_I_I_007302e8668314a6 [09:04] <<<<<<<<<<<<suspend interp(NONE), func:SCXMLGetEvent timers:00000
_I_I_007302e8668314a6 [1c:05] 2.3 SCXML: microstep entering phase
_I_I_007302e8668314a6 [1c:06] 1. SCXML: look for transitions (2)
10:38:33.158_I_I_007302e8668314a6 [1c:06] SCXML: }}}}}suspend session SID=PSJEJVCR8H5M7A7KJFEHAOKGCC00EDFJ
10:38:33.158 RLIB: request to 740(ORS_PRI_TEST) message (1)
errmsg(10) '0018 Unknown object'
error(9) 10
refid(1) 3300009
10:38:33.267_H_I_007302e8668314a7 [08:08] OK InfoMessage (-1) is received from server ##HTTPSERVER, refid=207, hint=soap
HTTPHeaders set-cookie:sap-usercontext=sap-client=100; path=/|content-type:text/xml; charset=utf-8|content-length:1021|accept:text/xml|sap-srt_id:20191004/103839/v1.00_final_6.40/005056AE19FE1ED9B9D04B8A01B0966A|sap-srt_server_info:GBQ_100,62 ,urn:sap-com:document:sap:soap:functions:mc-style,ZWS_GET_CUSTOMER,ZfmwsGetCustomer,6 |sap-srt_server_info_ext:0
key V1 [list] value: (size=0)
key STRN [String] value: "OK"
key V2 [list] value: (size=0)
key STRN [String] value: "test1"
10:38:33.267_I_I_007302e8668314a7 [09:05] >>>>>>>>>>>>resume interp(0), func:GetWebServiceInfoTLS
_I_I_007302e8668314a7 [09:04] ASSIGN: __WEBReturn(SCRIPT) <- LIST[1]: V1.STRN:OK|V2.STRN:test1
_I_I_007302e8668314a7 [09:04] ASSIGN: EsitoNfea(LOCAL) <- STRING[1,4]: "1:OK"
_I_I_007302e8668314a7 [09:04] ASSIGN: consulente_user(LOCAL) <- STRING[1,7]: "1:test1"
_I_I_007302e8668314a7 [09:04] ASSIGN: consulente_new(LOCAL) <- STRING[1,5]: "test1"
_I_I_007302e8668314a7 [09:04] ASSIGN: EsitoNfea(LOCAL) <- STRING[1,2]: "OK"
_I_I_007302e8668314a7 [09:04] ASSIGN: A_Target(LOCAL) <- STRING[1,21]: "test1@SS_ROU_PRI_TO.A"
10:38:33.267 Int 22000 @@@ESITOWSCHATtest1 @@@@target=test1@SS_ROU_PRI_TO.A
10:38:33.267_I_I_007302e8668314a7 [07:07] HERE IS TARGETS
TARGETS: test1@SS_ROU_PRI_TO.A
10:38:33.267_M_I_ [17:0c] VQ 9c34b3b280 created: type=0, ten=Environment
===============================
_M_I_ [17:06] VQ 9c34b3b280 TRG 9c34b6d178 added: name=test1, location=SS_ROU_PRI_TO, type=A, state=##state, activity=unknown
10:38:33.267_M_I_ [10:06] SO(9c337b6d58 17 2) ten=Environment name=test1@SS_ROU_PRI_TO.A: stat <##state> asked (0,0,1b)
_M_I_ [17:09] VQ 9c34b3b280 TRG "test1"(9c34b6d178): connected to state Agent test1 ##state(9c337b6d58), bf=0
_M_I_007302e8668314a7 [17:0f] VQ 9c34b3b280 [at all 6 0/0 0] 1 Target(s), flag=c08a, guid: 0Environment|||1|md38|1|00|0|0|---|||||||00|00{}{}{}[]test1@SS_ROU_PRI_TO.A
10:38:33.267_M_I_007302e8668314a7 [13:01] current vq: 9c33a342d0 id=472934(), nVQ=D-AJGHFHDD, priority=0, time=1570178313.267
10:38:33.267_M_I_007302e8668314a7 [17:11] VQ 9c34b3b280 first available call: 007302e8668314a7, reason=(1)binding
10:38:33.267_M_I_007302e8668314a7 [13:03] call (vq 9c33a342d0, id=472934, priority 0, time 1570178313.267) waits for VQ 9c34b3b280 (name="") now (0 1570178313.267)
10:38:33.267_M_I_007302e8668314a7 [17:0e] VQ 9c34b3b280 (LVQ "", id=472934), (1 Targets): SELECT ANY by stat <NONE>(random 0)
_M_I_007302e8668314a7 [17:0b] VQ 9c34b3b280 TRG "test1"(9c34b6d178) #1, (1-0 Components): SELECT ANY by stat <NONE>(random 0)
10:38:33.267_M_I_ [10:0a] object 1:PlaceDigital3|Environment| is not blocked
10:38:33.267_M_I_ [10:0a] object 0:test1|Environment| is not blocked
10:38:33.267_M_I_ [10:0a] object 2:test1|| is not blocked
_M_I_007302e8668314a7 [10:0c] tenant Environment Agent test1: dn test1 (m 35) is ignored: other dn type(cfg)
_M_I_007302e8668314a7 [10:0c] tenant Environment Agent test1: dn test1(m 38, ready since 1570178278) is OK
_M_I_007302e8668314a7 [17:0b] VQ 9c34b3b280 TRG "test1"(9c34b6d178) Cmp #1 test1: stat: (0)0, 0(N) the best
_M_I_007302e8668314a7 [17:0b] VQ 9c34b3b280 TRG "test1"(9c34b6d178): Cmp test1 SELECTED (0 0)
_M_I_007302e8668314a7 [17:0e] VQ 9c34b3b280 TRG "test1"(9c34b6d178): stat: (0)0, 6.66402172918e-007(N) the best
_M_I_007302e8668314a7 [17:0e] VQ 9c34b3b280 (LVQ "" id=472934): TRG "test1"(9c34b6d178) SELECTED
_M_I_007302e8668314a7 [01:0d] attempt to route (1 0) to test1(9c337b6d58)
_J_I_007302e8668314a7 [0E:19] check call routing states (vq 9c33a342d0): s=0 d=0 t=0 h=(0 0 0) r=0 i=0 x=0 b=0 - true
======== DN Information =======
Number test1
Access test1
Agent test1
Place PlaceDigital3
Login
Switch {m}131
Type 38
===============================
============== Target Information =================
Name < test1 >
Location < SS_ROU_PRI_TO >
Type < A >
STATE MAPPING - < ##state >:
Stat Value: DN info OK
Modelling : NA
===================================================
_I_I_007302e8668314a7 [01:0f] binding with TRG 9c34b6d178 (VQ 9c34b3b280), vq=9c33a342d0
10:38:33.267_M_I_007302e8668314a7 [10:2f] RStatCallsInQueue update: object <test1>(103), type CfgPerson value 1+0+0, reason <target selection>
10:38:33.267_M_I_007302e8668314a7 [10:2f] RStatCallsInQueue update: object <PlaceDigital3>(116), type CfgPlace value 1+0+0, reason <target selection>
_I_I_007302e8668314a7 [07:0a] HERE IS WAIT (-1 sec)
_I_I_007302e8668314a7 [07:0a] HERE IS WAIT (10 sec)
_I_I_007302e8668314a7 [0E:10] HERE IS ROUTE_CALL: LVQ=, target=test1
_I_I_007302e8668314a7 [01:10] binding with TRG 9c34b6d178 (VQ 9c34b3b280), vq=9c33a342d0
_M_I_007302e8668314a7 [10:3c] COST for test1@SS_ROU_PRI_TO.A (pO=9c337b6d58, TRG ""(0)) asked: from to , contract
_M_I_007302e8668314a7 [10:3c] cost from to , contract [table (,:0)] returns 0+0
10:38:33.267_M_I_007302e8668314a7 [17:11] VQ 9c34b3b280 first available call: none, reason=(0)strategy
10:38:33.267_H_I_ [08:11] POST request 208 sent to HTTP Bridge:
URL: http://10.12.255.67:8080/genesys/1/ors/scxml/session/CPRRGNCUM52SNDD4R3TUGJD8KG00EE21/request/method_urs_request_route_done
Headers: Content-Type:application/json
Content: {"return":"target","type":"A","id":"test1","agent":"test1","place":"PlaceDigital3","dn":"test1","switch":"{m}131","resource":"test1","stat_value":"0"}
Authent: 1 (0 )
_A_I_007302e8668314a7 [0E:1a] ----------->DEPARTURE(processing time 125)
10:38:33.267_M_I_0000000000000000 [10:1b] blocking: ag test1, pl PlaceDigital3, sw {m}131 dn test1 for 15 sec by 1000000001, expire 1570178328
10:38:33.267_M_I_007302e8668314a7 [10:3a] update volume contracts tables: target test1, group , tenant Environment
10:38:33.267_I_I_007302e8668314a7 [09:04] <<<<<<<<<<<<suspend interp(ROUTING), func:Wait timers:00000
10:38:33.298_R_I_ [19:10] routing interface request received: urs/call/007302e8668314a7/udata?RTargetAgentGroup&RPVQID&RVQID&RVQDBID&RTargetTypeSelected&RTargetRuleSelected&RTargetObjectSelected&RTargetObjSelDBID&RTargetAgentSelected&RTargetAgSelDBID&RTargetPlaceSelected&RTargetPlSelDBID&RTenant&RTenantDBID&RRequestedSkillCombination&RRequestedSkills&RTargetRequested&RStrategyName&RStrategyDBID&GMS_Target_Used&GMS_Target_Requested&SAP_EMAIL&SAP_SOLUTION&SAP_SERVIZIO&SAP_CANALE&EmailAddress, client=740(ORS_PRI_TEST), ref=3300010
10:38:33.298_R_I_ [19:11] routing interface response 'Info' sent to client 740(ORS_PRI_TEST), ref=3300010
Message: {"RVQID":"","RVQDBID":"","RTargetTypeSelected":"0","RTargetRuleSelected":"","RTargetObjectSelected":"test1","RTargetObjSelDBID":"103","RTargetAgentSelected":"test1","RTargetAgSelDBID":"103","RTargetPlaceSelected":"PlaceDigital3","RTargetPlSelDBID":"116","RTenant":"Environment","RTenantDBID":"1","RRequestedSkillCombination":"","RRequestedSkills":{},"RStrategyName":"GMS_WaitForTarget_TO_8520705_v4","RStrategyDBID":"1348"}
10:38:33.298_R_I_ [19:1b] routing interface request received: urs/entity/tag?tenant=Environment&tag=rdnd&expire=30&target=test1.A&sync=1, client=740(ORS_PRI_TEST), ref=3300011
10:38:33.298_I_I_ [0E:20] tag rdnd for test1.A (ten Environment) set (30, 1570178343)
10:38:33.298_R_I_ [19:11] routing interface response 'Info' sent to client 740(ORS_PRI_TEST), ref=3300011
Message: ["rdnd"]
10:38:34.002_M_I_ [10:1d] PULSE (calls: 33(33)=31+3-1, trgts=1, first=5,0, time=1570178314, mem=176831,1961[10380],109,443[20641],4294967022,0 - 2,1,0)
10:38:34.002_M_I_ [10:1d] vqs allocation pattern: static=(13-3600 256 256) dynamic=(472934 6/1024)
10:38:34.002_M_I_ [10:1d] PULSE over: 0 cpu 0 objects 0 trgs
10:38:36.001_M_I_ [10:1d] PULSE (calls: 33(33)=33+0-0, trgts=1, first=5,0, time=1570178316, mem=176831,1961[10380],109,443[20641],4294967022,0 - 2,1,0)
10:38:36.001_M_I_ [10:1d] vqs allocation pattern: static=(13-3600 256 256) dynamic=(472934 6/1024)
10:38:36.001_M_I_ [10:1d] PULSE over: 0 cpu 0 objects 0 trgs
10:38:36.908 Trc 04500 Connecting to DBServer 'DAP_UCS_PRI_TEST' at host 't-contactcenter-scan.rete.testposte', port 1555
10:38:36.908_G_I_ [05:05] try X-connecting: ("name"="DAP_UCS_PRI_TEST","host"="t-contactcenter-scan.rete.testposte","is-server"="1","client-type"="15","server-type"="8","server_dbid"="137","port"="1555","protocol"="addp","addp-timeout"="0","addp-remote-timeout"="0","addp-trace"="off","port_as_string"="1555")
addp-trace off
(addp_xconfig) local OFF, remote OFF, trace off
10:38:36.908 Trc 04501 Server DAP_UCS_PRI_TEST contacted, socket 936
DEvent: nMsgID=MSG_REGISTERED; nServer=5; nStatus=0; nRequestID=-1; nProfileTime 0 szSQLCmd=''; pRecord=0x0; pRecord2=0x0
DEvent: nMsgID=MSG_DISCONNECTED; nServer=5; nStatus=0; nRequestID=-1; nProfileTime 0 szSQLCmd=''; pRecord=0x0; pRecord2=0x0
10:38:36.908 Std 04502 Cannot connect to DBServer 'DAP_UCS_PRI_TEST' at host 't-contactcenter-scan.rete.testposte', port 1555, reason 'cancel'
10:38:36.908_G_I_ [05:06] server DAP_UCS_PRI_TEST is being closed, socket 936
10:38:36.908_G_I_ [0F:08] SERVER DAP_UCS_PRI_TEST(9c33ae2f48 0 1 1) tried: 0 9c33ae2f48 9c33ae2f48
10:38:38.001_M_I_ [10:1d] PULSE (calls: 33(33)=33+0-0, trgts=1, first=5,0, time=1570178318, mem=176831,1961[10380],109,443[20641],4294967022,0 - 2,1,0)
10:38:38.001_M_I_ [10:1d] vqs allocation pattern: static=(13-3600 256 256) dynamic=(472934 6/1024)
10:38:38.001_M_I_ [10:1d] PULSE over: 0 cpu 0 objects 0 trgs
10:38:40.001_M_I_ [10:1d] PULSE (calls: 33(33)=33+0-0, trgts=1, first=5,0, time=1570178320, mem=176831,1961[10380],109,443[20641],4294967022,0 - 2,1,0)
10:38:40.001_M_I_ [10:1d] vqs allocation pattern: static=(13-3600 256 256) dynamic=(472934 6/1024)
10:38:40.001_M_I_ [10:1d] PULSE over: 0 cpu 0 objects 0 trgs
10:38:41.111_I_I_007302e866831499 [09:0a] SCXML: session SID=PSJEJVCR8H5M7A7KJFEHAOKGCC00EDF6 external queue: event "error.queue.submit" added
10:38:41.111_I_I_007302e866831499 [1c:06] SCXML: {{{{{resume session SID=PSJEJVCR8H5M7A7KJFEHAOKGCC00EDF6
_I_I_007302e866831499 [1c:06] 1. SCXML: look for transitions (1)
_I_I_007302e866831499 [1c:04] 1.x SCXML: state <initial>: check transitions, event "error.queue.submit"
10:38:41.111_I_I_007302e866831499 [09:05] >>>>>>>>>>>>resume interp(0), func:SCXMLGetEvent
_I_I_007302e866831499 [09:04] ASSIGN: v:0:_event(LOCAL) <- OBJECT:0000009C336E7BA8[undefined]={"name":"error.queue.submit","data":{"requestid":472921,"error":"-001 Timeout"}}
_I_I_007302e866831499 [09:04] ASSIGN: v:0:_eventdata(LOCAL) <- OBJECT:0000009C33738B10[undefined]={"requestid":472921,"error":"-001 Timeout"}
10:38:41.111_I_I_007302e866831499 [09:04] <<<<<<<<<<<<suspend interp(NONE), func:SCXMLChangeState timers:00000
_I_I_007302e866831499 [1c:05] 2. SCXML: microstep
_I_I_007302e866831499 [1c:05] 2.1 SCXML: microstep exitting phase
_I_I_007302e866831499 [1c:05] 2.2 SCXML: microstep transiting phase
10:38:41.111_I_I_007302e866831499 [09:05] >>>>>>>>>>>>resume interp(0), func:SCXMLChangeState
10:38:41.111 RLIB: request to 740(ORS_PRI_TEST) message EventOnInvoke(1000000102)
result(1000000004) '{"name":"error.queue.submit","data":{"requestid":472921,"error":"-001 Timeout"}}'
sessionid(1000000010) 'CPRRGNCUM52SNDD4R3TUGJD8KG00EE1J'
10:38:41.111_I_I_007302e866831499 [09:04] <<<<<<<<<<<<suspend interp(NONE), func:SCXMLGetEvent timers:00000
_I_I_007302e866831499 [1c:05] 2.3 SCXML: microstep entering phase
_I_I_007302e866831499 [1c:06] 1. SCXML: look for transitions (2)
10:38:41.111_I_I_007302e866831499 [1c:06] SCXML: }}}}}suspend session SID=PSJEJVCR8H5M7A7KJFEHAOKGCC00EDF6
10:38:41.111 RLIB: received from 740(ORS_PRI_TEST) message RequestDeleteVCall(1000000004)
refid(1) 3300012
callid(1000000000) '00011aECP47T00EM'
10:38:41.111_M_I_007302e86683[/list][/list][/list][/list]