Genesys CTI User Forum
Genesys CTI User Forum => Genesys CTI Technical Discussion => Topic started by: Maya on May 28, 2015, 12:13:32 AM
-
hello , we are facing strange issue , where we are able to setup a chat session using sample app and all works fine for approx. 5 mins . . After that customer is able to send text message to agent WDE but nothing from agent WDE goes back on client device,We are able to replicate this issue
Something is causing the request to cancel from sample application ...any idea what is sending this request to close the session
We are using GMS sample application - chat-now
+++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
:27:05.015 Dbg 09900 [GMSTaskExecutor-17] Job Engine Service: received an accept job message: tenant [1], queueName [chat_polling], jobId [332c4350-04c7-11e5-9b91-005056aa6b5c] and Job is Job {"jobId":"332c4350-04c7-11e5-9b91-005056aa6b5c","jobDetails":"136-14c3e25f-a480-47c4-9ae9-241fe8406271","jobType":"ONCE","jobTypeDetails":"","executionTimeMillis":1432768930821,"maxExecutionTimeMillis":330000,"endAt":9223372036854775807,"worker number":1,"worker":"2733d720-04c7-11e5-9b91-005056aa6b5c"}
19:27:05.018 Int 09900 [GMSTaskExecutor-17] Service with id 136-14c3e25f-a480-47c4-9ae9-241fe8406271 contains session to fetch : C9P3GB526H1GN41A2UTRHURNS0000080
19:27:05.024 Dbg 09900 [GMSTaskExecutor-17] getServiceInfo called with alias: 129
19:27:05.034 Trc 09900 [GMSTaskExecutor-17] ChatService: connecting to Chat Server conn-STC_GMS_GMS_SRV_51_PoC-STC_ESRV_CHT_SRV_51_PoC - tcp://stcdevxmevo51.x.dev.can:16182
19:27:05.047 Trc 09900 [GMSTaskExecutor-17] ChatService: disconnected from Chat Server conn-STC_GMS_GMS_SRV_51_PoC-STC_ESRV_CHT_SRV_51_PoC - tcp://stcdevxmevo51.x.dev.can:16182
19:27:05.049 Dbg 09900 [GMSTaskExecutor-17] ChatJobWorker: transcriptToShow: [["Notice.TypingStopped","Test002","stopped typing","294","AGENT"]]
19:27:05.051 Dbg 09900 Notification2ProviderDispatcher dispatching NotificationDTO [notification=NotificationEvent [tag=service.chat.refresh.136-14c3e25f-a480-47c4-9ae9-241fe8406271, language=N/A, mediaEntry=MapMediaEntry [map={chatSessionId=0001PaANY21Y0031, transcriptPosition=33, startedAt=2015-05-27T23:22:10Z, chatIxnState=TRANSCRIPT, transcriptToShow=[["Notice.TypingStopped","Test002","stopped typing","294","AGENT"]]}], providerName=null, notificationDetails=null, subscriptionId=null, essential=false, authorization=N], subscription=Subscription [id=136-9330c234-209c-40d7-b409-a04bfd0184de, subscriberId=136-14c3e25f-a480-47c4-9ae9-241fe8406271, expiration=0, filter=service.chat.refresh.136-14c3e25f-a480-47c4-9ae9-241fe8406271, notificationDetails=NotificationDetails [type=comet, deviceId=jdoe_desktop, properties=null], providerName=null, language=null, authorization=N]] to provider null
19:27:05.058 Dbg 09900 [GMSTaskExecutor-23] Counter Incremented (notification:__notification)
19:27:05.059 Dbg 09900 [GMSTaskExecutor-17] ChatJobWorker: Sent transcript notification
19:27:05.083 Dbg 09900 [qtp161113152-144] Setting comet client location: user jdoe_desktop, clientId 73sks2lp3l2f7ghrkod6xymuk, location 10.180.129.62:8080@1432767984213
19:27:05.834 Dbg 09900 [qtp161113152-155] Setting comet client location: user jdoe_desktop, clientId 31x8mpsgymhlxa1at5yqhikc2go, location 10.180.129.62:8080@1432767984213
19:27:06.025 Dbg 09900 [GMScheduler-19] Setting comet client location: user 10.180.129.62:8080@1432767984213, clientId 41oj97x9so6ujv10ysi4agnvgc8, location 10.180.129.62:8080@1432767984213
19:27:07.069 Int 09900 [GMSTaskExecutor-20] Service with id 136-14c3e25f-a480-47c4-9ae9-241fe8406271 contains session to fetch : C9P3GB526H1GN41A2UTRHURNS0000080
19:27:07.075 Dbg 09900 [GMSTaskExecutor-20] getServiceInfo called with alias: 129
19:27:07.085 Trc 09900 [GMSTaskExecutor-20] ChatService: connecting to Chat Server conn-STC_GMS_GMS_SRV_51_PoC-STC_ESRV_CHT_SRV_51_PoC - tcp://stcdevxmevo51.x.dev.can:16182
19:27:07.097 Trc 09900 [GMSTaskExecutor-20] ChatService: disconnected from Chat Server conn-STC_GMS_GMS_SRV_51_PoC-STC_ESRV_CHT_SRV_51_PoC - tcp://stcdevxmevo51.x.dev.can:16182
19:27:07.098 Dbg 09900 [GMSTaskExecutor-20] ChatJobWorker: transcriptToShow: [["Notice.TypingStarted","Test002","is typing","295","AGENT"],["Notice.TypingStarted","Test002","is typing","295","AGENT"]]
19:27:07.101 Dbg 09900 Notification2ProviderDispatcher dispatching NotificationDTO [notification=NotificationEvent [tag=service.chat.refresh.136-14c3e25f-a480-47c4-9ae9-241fe8406271, language=N/A, mediaEntry=MapMediaEntry [map={chatSessionId=0001PaANY21Y0031, transcriptPosition=35, startedAt=2015-05-27T23:22:10Z, chatIxnState=TRANSCRIPT, transcriptToShow=[["Notice.TypingStarted","Test002","is typing","295","AGENT"],["Notice.TypingStarted","Test002","is typing","295","AGENT"]]}], providerName=null, notificationDetails=null, subscriptionId=null, essential=false, authorization=N], subscription=Subscription [id=136-9330c234-209c-40d7-b409-a04bfd0184de, subscriberId=136-14c3e25f-a480-47c4-9ae9-241fe8406271, expiration=0, filter=service.chat.refresh.136-14c3e25f-a480-47c4-9ae9-241fe8406271, notificationDetails=NotificationDetails [type=comet, deviceId=jdoe_desktop, properties=null], providerName=null, language=null, authorization=N]] to provider null
19:27:07.108 Dbg 09900 [GMSTaskExecutor-25] Counter Incremented (notification:__notification)
19:27:07.109 Dbg 09900 [GMSTaskExecutor-20] ChatJobWorker: Sent transcript notification
19:27:07.133 Dbg 09900 [qtp161113152-160] Setting comet client location: user jdoe_desktop, clientId 73sks2lp3l2f7ghrkod6xymuk, location 10.180.129.62:8080@1432767984213
19:27:07.834 Dbg 09900 [qtp161113152-155] Setting comet client location: user jdoe_desktop, clientId 31x8mpsgymhlxa1at5yqhikc2go, location 10.180.129.62:8080@1432767984213
19:27:09.121 Int 09900 [GMSTaskExecutor-27] Service with id 136-14c3e25f-a480-47c4-9ae9-241fe8406271 contains session to fetch : C9P3GB526H1GN41A2UTRHURNS0000080
19:27:09.128 Dbg 09900 [GMSTaskExecutor-27] getServiceInfo called with alias: 129
19:27:09.139 Trc 09900 [GMSTaskExecutor-27] ChatService: connecting to Chat Server conn-STC_GMS_GMS_SRV_51_PoC-STC_ESRV_CHT_SRV_51_PoC - tcp://stcdevxmevo51.x.dev.can:16182
19:27:09.150 Trc 09900 [GMSTaskExecutor-27] ChatService: disconnected from Chat Server conn-STC_GMS_GMS_SRV_51_PoC-STC_ESRV_CHT_SRV_51_PoC - tcp://stcdevxmevo51.x.dev.can:16182
19:27:09.151 Dbg 09900 [GMSTaskExecutor-27] ChatJobWorker: transcriptToShow: [["Message.Text","Test002","fffffffffffffff","297","AGENT"]]
19:27:09.154 Dbg 09900 Notification2ProviderDispatcher dispatching NotificationDTO [notification=NotificationEvent [tag=service.chat.refresh.136-14c3e25f-a480-47c4-9ae9-241fe8406271, language=N/A, mediaEntry=MapMediaEntry [map={chatSessionId=0001PaANY21Y0031, transcriptPosition=36, startedAt=2015-05-27T23:22:10Z, chatIxnState=TRANSCRIPT, transcriptToShow=[["Message.Text","Test002","fffffffffffffff","297","AGENT"]]}], providerName=null, notificationDetails=null, subscriptionId=null, essential=false, authorization=N], subscription=Subscription [b][id=136-9330c234-209c-40d7-b409-a04bfd0184de, subscriberId=136-14c3e25f-a480-47c4-9ae9-241fe8406271, expiration=0, filter=service.chat.refresh.136-14c3e25f-a480-47c4-9ae9-241fe8406271, notificationDetails=NotificationDetails [type=comet, deviceId=jdoe_desktop, properties=null], providerName=null, language=null, authorization=N]] to provider null
19:27:09.160 Dbg 09900 [GMSTaskExecutor-29] Counter Incremented (notification:__notification)
19:27:09.162 Dbg 09900 [GMSTaskExecutor-27] ChatJobWorker: Sent transcript notification
19:27:09.187 Dbg 09900 [qtp161113152-160] Setting comet client location: user jdoe_desktop, clientId 73sks2lp3l2f7ghrkod6xymuk, location 10.180.129.62:8080@1432767984213
19:27:09.835 Dbg 09900 [qtp161113152-155] Setting comet client location: user jdoe_desktop, clientId 31x8mpsgymhlxa1at5yqhikc2go, location 10.180.129.62:8080@1432767984213
[b]19:27:10.609 Dbg 09900 [qtp161113152-153] (POST) Client IP Address: 10.180.129.62, URI:http://STCDEVMEVO52.DEV.CAN:8080/genesys/1/ors/scxml/session/C9P3GB526H1GN41A2UTRHURNS0000080/request/cancel
19:27:10.610 Dbg 09900 [qtp161113152-153] Params: KVList:
19:27:10.625 Trc 09900 [qtp161113152-153] >>>Forward request POST /scxml/session/C9P3GB526H1GN41A2UTRHURNS0000080/request/cancel to ORS
19:27:10.627 Dbg 09900 [qtp161113152-153] Attempting to forward request (POST /scxml/session/C9P3GB526H1GN41A2UTRHURNS0000080/request/cancel)
19:27:10.628 Trc 09900 [qtp161113152-153] OrsService: submit to ORS http://10.180.129.62:3801/scxml/session/C9P3GB526H1GN41A2UTRHURNS0000080/request/cancel?_gms_external_url=http%3A%2F%2FSTCDEVMEVO52.DEV.CAN%3A8080%2F
19:27:10.632 Trc 09900 [qtp161113152-153] OrsService: response from ORS KVList:
'_ok_title' [str] = "Ok"
'_action' [str] = "ConfirmationDialog"
'_text' [str] = "Your service request is now cancelled."
'_id' [str] = "136-14c3e25f-a480-47c4-9ae9-241fe8406271"
'_dialog_id' [str] = "0"[/b]19:27:10.633 Trc 09900 [qtp161113152-153] <<<Service specific request result: {"_dialog_id":"0","_action":"ConfirmationDialog","_text":"Your service request is now cancelled.","_ok_title":"Ok","_id":"136-14c3e25f-a480-47c4-9ae9-241fe8406271"}[/b]
19:27:10.638 Dbg 09900 [qtp161113152-161] (PUT) Client IP Address: 10.180.129.62, URI:http://STCDEVMEVO52.DEV.CAN:8080/genesys/1/service/callback/samples/136-14c3e25f-a480-47c4-9ae9-241fe8406271
19:27:10.639 Dbg 09900 [qtp161113152-161] Params: KVList:
'_callback_reason' [str] = "CANCELLED"
'_callback_state' [str] = "COMPLETED"
19:27:10.651 Trc 09900 [qtp161113152-161] >>>Callback-Reschedule request: [serviceId=136-14c3e25f-a480-47c4-9ae9-241fe8406271]
19:27:10.660 Dbg 09900 [qtp161113152-161] Updating callback in storage 136-14c3e25f-a480-47c4-9ae9-241fe8406271 - state=COMPLETED - time=2015-05-27T23:22:09.843Z
19:27:10.672 Dbg 09900 [qtp161113152-153] (DELETE) Client IP Address: 127.0.0.1, URI:http://127.0.0.1:8080/genesys/1/notification/subscription/subscriber/136-14c3e25f-a480-47c4-9ae9-241fe8406271
19:27:10.673 Dbg 09900 [qtp161113152-153] Params: KVList:
19:27:10.679 Dbg 09900 [qtp161113152-161] result=[MutationResult took (1104us) for query (n/a) on host: 10.180.129.59(10.180.129.59):9160]
19:27:10.679 Trc 09900 [qtp161113152-161] <<<Callback-Reschedule response
19:27:10.683 Trc 09900 SubscriptionController >>>Delete subscriptions for subscriber: [subscriberId=136-14c3e25f-a480-47c4-9ae9-241fe8406271]
19:27:10.701 Trc 09900 SubscriptionController <<<Delete subscription for subscriber done
19:27:11.029 Dbg 09900 [GMScheduler-5] Setting comet client location: user 10.180.129.62:8080@1432767984213, clientId 41oj97x9so6ujv10ysi4agnvgc8, location 10.180.129.62:8080@1432767984213
19:27:11.171 Int 09900 [GMSTaskExecutor-28] Service with id 136-14c3e25f-a480-47c4-9ae9-241fe8406271 contains session to fetch : C9P3GB526H1GN41A2UTRHURNS0000080
19:27:11.177 Dbg 09900 [GMSTaskExecutor-28] getServiceInfo called with alias: 129
19:27:11.186 Trc 09900 [GMSTaskExecutor-28] ChatService: connecting to Chat Server conn-STC_GMS_GMS_SRV_51_PoC-STC_ESRV_CHT_SRV_51_PoC - tcp://stcdevxmevo51.x.dev.can:16182
19:27:11.197 Trc 09900 [GMSTaskExecutor-28] ChatService: disconnected from Chat Server conn-STC_GMS_GMS_SRV_51_PoC-STC_ESRV_CHT_SRV_51_PoC - tcp://stcdevxmevo51.x.dev.can:16182
19:27:11.199 Dbg 09900 [GMSTaskExecutor-28] ChatJobWorker: transcriptToShow: [["Notice.TypingStarted","Test002","is typing","299","AGENT"]]
19:27:11.203 Dbg 09900 [GMSTaskExecutor-28] ChatJobWorker: Sent transcript notification
19:27:13.212 Int 09900 [GMSTaskExecutor-26] Service with id 136-14c3e25f-a480-47c4-9ae9-241fe8406271 contains session to fetch : C9P3GB526H1GN41A2UTRHURNS0000080
19:27:13.219 Dbg 09900 [GMSTaskExecutor-26] getServiceInfo called with alias: 129
-
Got the issue resolved, it was timer in Virtaul Q - wait for target sample which was causing this issue.
created own strategy and all working :)