Inconsistent answer in converse api

Hi,

I’m trying to implement a bot UI via the converse API, but I’m facing a strange issue.

Often (not always), when I request an answer from the API, I get a wrong (previous?) answer. When I enable the debugging options in the URL (in PostMan /converse/postman/secured?include=suggestions), I see what happens:

{
    "responses": [
        {
            "type": "text",
            "markdown": true,
            "text": "Hi there!"
        },
        {
            "type": "typing",
            "value": true
        }
    ],
    "suggestions": [
        {
            "confidence": 1,
            "payloads": [
                {
                    "type": "typing",
                    "value": true
                },
                {
                    "type": "text",
                    "markdown": true,
                    "text": "Contact the Helpdesk and ask for ....."
                }
            ],
            "source": "qna",
            "sourceDetails": "__qna__egazk4qf2i_i_contact_helpdesk",
            "decision": {
                "status": "elected",
                "reason": "best remaining suggestion available"
            }
        }
    ]
}

So the suggestion indicates that the confidence is 1, and the decision states that that suggestion is elected, but the returned text in the response is wrong.

When I look in the “History” tab in the console of my Botpress 12.1.0, I see that it states to have returned the correct answer…

Please help, this really blocks my development, as I don’t want to authenticate to see and manually use the suggestions…

Thanks in advance!
Sjoerd

How long does it take for the response to get back from the API? I think you might be right when you say “(previous?)”, I suspect that sometimes you are retrieving the previous answer because the API didn’t return within the allowed timeout window.

To see if that’s the issue, you can change the default timeout interval for converse in your global botpress config:

  "dialog": {
   // ....
  }, // --> add this below
  "converse": {
    "timeout": "20s"
  },

Source: https://github.com/botpress/botpress/blob/e919ea47162e81e4da5f9102c5a6ab68596de7cd/src/bp/core/config/botpress.config.ts#L41

Hi Sylvain,

I already put the below in the specific bot.config.json, but I will also try in the global config:

 "dialog": {
    "timeoutInterval": "5m"
  },
  "converse": {
    "timeout": "15s"
  },

I just tested in the global config.

It didn’t work, but the (wrong) response indeed comes usually after longer time, in the last tests a little more than 5 seconds (5,65) --> can I check whether the timeout was really active (is there some debugflag to show the used parameters)?

The wrong answers also occur after just 1,5 seconds, so it’s not a rule that it only happens after possible timeout.

@sylvain: do you see any options how I could proceed?

Can you enable the debug flags and copy/paste your logs here?

Please enable the following:

I don’t see the hook “before_session_timeout”, but will enable the other options:

At 13:39 I executed the following command in Postman:

{
	"type":"text",
	"text":"i lost my ipad"
}

and received the following (wrong) answer:

{
    "responses": [
        {
            "type": "text",
            "markdown": true,
            "text": "Hi there!"
        },
        {
            "type": "typing",
            "value": true
        }
    ]
}

The log around this time is below (actual answer should have been “Contact the helpdesk …”)

2019-08-27 13:36:08debug2019-08-27T11:36:08.158Z bp:janitor:dialog (my-bot) Found stale sessionsapi::270f78e1-9cdd-4016-8ef2-787b94d452ff, { botId: 'my-bot' }
2019-08-27 13:36:08debug2019-08-27T11:36:08.163Z bp:janitor:dialog (my-bot) Processing timeoutapi::270f78e1-9cdd-4016-8ef2-787b94d452ff, { botId: 'my-bot' }
2019-08-27 13:36:08debug2019-08-27T11:36:08.168Z bp:janitor:dialog (my-bot) Skipping. No changes in contextapi::270f78e1-9cdd-4016-8ef2-787b94d452ff, { botId: 'my-bot' }
2019-08-27 13:36:08debug2019-08-27T11:36:08.367Z bp:janitor:dialog (my-bot) New expiry set for Tue Aug 27 2019 11:41:08 GMT+0000 (Coordinated Universal Time)api::270f78e1-9cdd-4016-8ef2-787b94d452ff, { botId: 'my-bot' }
2019-08-27 13:36:18debug2019-08-27T11:36:18.155Z bp:janitor:dialog (my-bot) Found stale sessionsapi::ciso12, { botId: 'my-bot' }
2019-08-27 13:36:18debug2019-08-27T11:36:18.156Z bp:janitor:dialog (my-bot) Processing timeoutapi::ciso12, { botId: 'my-bot' }
2019-08-27 13:36:18debug2019-08-27T11:36:18.158Z bp:janitor:dialog (my-bot) Skipping. No changes in contextapi::ciso12, { botId: 'my-bot' }
2019-08-27 13:36:18debug2019-08-27T11:36:18.297Z bp:janitor:dialog (my-bot) New expiry set for Tue Aug 27 2019 11:41:18 GMT+0000 (Coordinated Universal Time)api::ciso12, { botId: 'my-bot' }
2019-08-27 13:36:38debug2019-08-27T11:36:38.158Z bp:janitor:dialog (my-bot) Found stale sessionsapi::f9092436-ca7f-54bc-94f2-998d68276b33, { botId: 'my-bot' }
2019-08-27 13:36:38debug2019-08-27T11:36:38.161Z bp:janitor:dialog (my-bot) Processing timeoutapi::f9092436-ca7f-54bc-94f2-998d68276b33, { botId: 'my-bot' }
2019-08-27 13:36:38debug2019-08-27T11:36:38.164Z bp:janitor:dialog (my-bot) Skipping. No changes in contextapi::f9092436-ca7f-54bc-94f2-998d68276b33, { botId: 'my-bot' }
2019-08-27 13:36:38debug2019-08-27T11:36:38.311Z bp:janitor:dialog (my-bot) New expiry set for Tue Aug 27 2019 11:41:38 GMT+0000 (Coordinated Universal Time)api::f9092436-ca7f-54bc-94f2-998d68276b33, { botId: 'my-bot' }
2019-08-27 13:37:08debug2019-08-27T11:37:08.158Z bp:janitor:dialog (my-bot) Found stale sessionsapi::96dca850-847a-5b39-aa9c-9f8d0e377a02, api::user123, { botId: 'my-bot' }
2019-08-27 13:37:08debug2019-08-27T11:37:08.160Z bp:janitor:dialog (my-bot) Processing timeoutapi::96dca850-847a-5b39-aa9c-9f8d0e377a02, { botId: 'my-bot' }
2019-08-27 13:37:08debug2019-08-27T11:37:08.164Z bp:janitor:dialog (my-bot) Skipping. No changes in contextapi::96dca850-847a-5b39-aa9c-9f8d0e377a02, { botId: 'my-bot' }
2019-08-27 13:37:08debug2019-08-27T11:37:08.314Z bp:janitor:dialog (my-bot) New expiry set for Tue Aug 27 2019 11:42:08 GMT+0000 (Coordinated Universal Time)api::96dca850-847a-5b39-aa9c-9f8d0e377a02, { botId: 'my-bot' }
2019-08-27 13:37:08debug2019-08-27T11:37:08.317Z bp:janitor:dialog (my-bot) Processing timeoutapi::user123, { botId: 'my-bot' }
2019-08-27 13:37:08debug2019-08-27T11:37:08.321Z bp:janitor:dialog (my-bot) Skipping. No changes in contextapi::user123, { botId: 'my-bot' }
2019-08-27 13:37:08debug2019-08-27T11:37:08.457Z bp:janitor:dialog (my-bot) New expiry set for Tue Aug 27 2019 11:42:08 GMT+0000 (Coordinated Universal Time)api::user123, { botId: 'my-bot' }
2019-08-27 13:37:28debug2019-08-27T11:37:28.160Z bp:janitor:dialog (my-bot) Found stale sessionsapi::a4fef475-1958-4d38-8f6d-c4ee0ae666fc, api::postman, { botId: 'my-bot' }
2019-08-27 13:37:28debug2019-08-27T11:37:28.163Z bp:janitor:dialog (my-bot) Processing timeoutapi::a4fef475-1958-4d38-8f6d-c4ee0ae666fc, { botId: 'my-bot' }
2019-08-27 13:37:28debug2019-08-27T11:37:28.167Z bp:janitor:dialog (my-bot) Skipping. No changes in contextapi::a4fef475-1958-4d38-8f6d-c4ee0ae666fc, { botId: 'my-bot' }
2019-08-27 13:37:28debug2019-08-27T11:37:28.366Z bp:janitor:dialog (my-bot) New expiry set for Tue Aug 27 2019 11:42:28 GMT+0000 (Coordinated Universal Time)api::a4fef475-1958-4d38-8f6d-c4ee0ae666fc, { botId: 'my-bot' }
2019-08-27 13:37:28debug2019-08-27T11:37:28.369Z bp:janitor:dialog (my-bot) Processing timeoutapi::postman, { botId: 'my-bot' }
2019-08-27 13:37:28debug2019-08-27T11:37:28.376Z bp:janitor:dialog (my-bot) Skipping. No changes in contextapi::postman, { botId: 'my-bot' }
2019-08-27 13:37:29debug2019-08-27T11:37:28.674Z bp:janitor:dialog (my-bot) New expiry set for Tue Aug 27 2019 11:42:28 GMT+0000 (Coordinated Universal Time)api::postman, { botId: 'my-bot' }
2019-08-27 13:37:48debug2019-08-27T11:37:48.161Z bp:janitor:dialog (my-bot) Found stale sessionsweb::2UYqvOuHTWMCM09oDF~v5::6, { botId: 'my-bot' }
2019-08-27 13:37:48debug2019-08-27T11:37:48.165Z bp:janitor:dialog (my-bot) Processing timeoutweb::2UYqvOuHTWMCM09oDF~v5::6, { botId: 'my-bot' }
2019-08-27 13:37:48debug2019-08-27T11:37:48.171Z bp:janitor:dialog (my-bot) Skipping. No changes in contextweb::2UYqvOuHTWMCM09oDF~v5::6, { botId: 'my-bot' }
2019-08-27 13:37:48debug2019-08-27T11:37:48.316Z bp:janitor:dialog (my-bot) New expiry set for Tue Aug 27 2019 11:42:48 GMT+0000 (Coordinated Universal Time)web::2UYqvOuHTWMCM09oDF~v5::6, { botId: 'my-bot' }
2019-08-27 13:37:58debug2019-08-27T11:37:58.161Z bp:janitor:dialog (my-bot) Found stale sessionsweb::2UYqvOuHTWMCM09oDF~v5::12, { botId: 'my-bot' }
2019-08-27 13:37:58debug2019-08-27T11:37:58.163Z bp:janitor:dialog (my-bot) Processing timeoutweb::2UYqvOuHTWMCM09oDF~v5::12, { botId: 'my-bot' }
2019-08-27 13:37:58debug2019-08-27T11:37:58.168Z bp:janitor:dialog (my-bot) Skipping. No changes in contextweb::2UYqvOuHTWMCM09oDF~v5::12, { botId: 'my-bot' }
2019-08-27 13:37:58debug2019-08-27T11:37:58.305Z bp:janitor:dialog (my-bot) New expiry set for Tue Aug 27 2019 11:42:58 GMT+0000 (Coordinated Universal Time)web::2UYqvOuHTWMCM09oDF~v5::12, { botId: 'my-bot' }
2019-08-27 13:38:18debug2019-08-27T11:38:18.161Z bp:janitor:dialog (my-bot) Found stale sessionsweb::test_E0_xz2aOdOo5hcJBpDF9o, web::test_DvAQDzgAmfnbs2t30lHCV, { botId: 'my-bot' }
2019-08-27 13:38:18debug2019-08-27T11:38:18.164Z bp:janitor:dialog (my-bot) Processing timeoutweb::test_E0_xz2aOdOo5hcJBpDF9o, { botId: 'my-bot' }
2019-08-27 13:38:18debug2019-08-27T11:38:18.168Z bp:janitor:dialog (my-bot) Skipping. No changes in contextweb::test_E0_xz2aOdOo5hcJBpDF9o, { botId: 'my-bot' }
2019-08-27 13:38:18debug2019-08-27T11:38:18.311Z bp:janitor:dialog (my-bot) New expiry set for Tue Aug 27 2019 11:43:18 GMT+0000 (Coordinated Universal Time)web::test_E0_xz2aOdOo5hcJBpDF9o, { botId: 'my-bot' }
2019-08-27 13:38:18debug2019-08-27T11:38:18.314Z bp:janitor:dialog (my-bot) Processing timeoutweb::test_DvAQDzgAmfnbs2t30lHCV, { botId: 'my-bot' }
2019-08-27 13:38:18debug2019-08-27T11:38:18.319Z bp:janitor:dialog (my-bot) Skipping. No changes in contextweb::test_DvAQDzgAmfnbs2t30lHCV, { botId: 'my-bot' }
2019-08-27 13:38:18debug2019-08-27T11:38:18.466Z bp:janitor:dialog (my-bot) New expiry set for Tue Aug 27 2019 11:43:18 GMT+0000 (Coordinated Universal Time)web::test_DvAQDzgAmfnbs2t30lHCV, { botId: 'my-bot' }
2019-08-27 13:38:48debug2019-08-27T11:38:48.195Z bp:janitor:dialog (my-bot) Found stale sessionsweb::test_MBVv-NOQmTsaIpOwLob_v, { botId: 'my-bot' }
2019-08-27 13:38:48debug2019-08-27T11:38:48.200Z bp:janitor:dialog (my-bot) Processing timeoutweb::test_MBVv-NOQmTsaIpOwLob_v, { botId: 'my-bot' }
2019-08-27 13:38:48debug2019-08-27T11:38:48.226Z bp:janitor:dialog (my-bot) Skipping. No changes in contextweb::test_MBVv-NOQmTsaIpOwLob_v, { botId: 'my-bot' }
2019-08-27 13:38:48debug2019-08-27T11:38:48.410Z bp:janitor:dialog (my-bot) New expiry set for Tue Aug 27 2019 11:43:48 GMT+0000 (Coordinated Universal Time)web::test_MBVv-NOQmTsaIpOwLob_v, { botId: 'my-bot' }
2019-08-27 13:39:38debug2019-08-27T11:39:38.163Z bp:janitor:dialog (my-bot) Found stale sessionsweb::TKv_X3p42L7SwoJf1sI_::8, api::user1234, { botId: 'my-bot' }
2019-08-27 13:39:38debug2019-08-27T11:39:38.166Z bp:janitor:dialog (my-bot) Processing timeoutweb::TKv_X3p42L7SwoJf1sI_::8, { botId: 'my-bot' }
2019-08-27 13:39:38debug2019-08-27T11:39:38.170Z bp:janitor:dialog (my-bot) Skipping. No changes in contextweb::TKv_X3p42L7SwoJf1sI_::8, { botId: 'my-bot' }
2019-08-27 13:39:38debug2019-08-27T11:39:38.320Z bp:janitor:dialog (my-bot) New expiry set for Tue Aug 27 2019 11:44:38 GMT+0000 (Coordinated Universal Time)web::TKv_X3p42L7SwoJf1sI_::8, { botId: 'my-bot' }
2019-08-27 13:39:38debug2019-08-27T11:39:38.326Z bp:janitor:dialog (my-bot) Processing timeoutapi::user1234, { botId: 'my-bot' }
2019-08-27 13:39:38debug2019-08-27T11:39:38.331Z bp:janitor:dialog (my-bot) Skipping. No changes in contextapi::user1234, { botId: 'my-bot' }
2019-08-27 13:39:38debug2019-08-27T11:39:38.485Z bp:janitor:dialog (my-bot) New expiry set for Tue Aug 27 2019 11:44:38 GMT+0000 (Coordinated Universal Time)api::user1234, { botId: 'my-bot' }
2019-08-27 13:39:41debug2019-08-27T11:39:41.943Z bp:hooks:before_incoming_middleware (my-bot) before execute { path: 'builtin/apply_nlu_contexts.js', botId: 'my-bot', args: { event: IOEvent { type: 'text', channel: 'api', direction: 'incoming', payload: [Object], target: 'postman', botId: 'my-bot', createdOn: 2019-08-27T11:39:41.923Z, threadId: undefined, id: '156690598192362530', preview: 'i lost my ipad', flags: {}, state: [Object], suggestions: [], credentials: undefined, nlu: [Object] } } }{ botId: 'my-bot' }
2019-08-27 13:39:41debug2019-08-27T11:39:41.947Z bp:hooks:before_incoming_middleware (my-bot) after execute{ botId: 'my-bot' }
2019-08-27 13:39:42debug2019-08-27T11:39:42.912Z bp:hooks:after_incoming_middleware (my-bot) before execute { path: 'builtin/00_dialog_engine.js', botId: 'my-bot', args: { event: IOEvent { type: 'text', channel: 'api', direction: 'incoming', payload: [Object], target: 'postman', botId: 'my-bot', createdOn: 2019-08-27T11:39:41.923Z, threadId: undefined, id: '156690598192362530', preview: 'i lost my ipad', flags: {}, state: [Object], suggestions: [Array], credentials: undefined, nlu: [Object] } } }{ botId: 'my-bot' }
2019-08-27 13:39:42debug2019-08-27T11:39:42.916Z bp:hooks:after_incoming_middleware (my-bot) after execute{ botId: 'my-bot' }
2019-08-27 13:39:42debug2019-08-27T11:39:42.927Z bp:hooks:after_incoming_middleware (my-bot) before execute { path: 'channel-web/00_dialog_engine.js', botId: 'my-bot', args: { event: IOEvent { type: 'text', channel: 'api', direction: 'incoming', payload: [Object], target: 'postman', botId: 'my-bot', createdOn: 2019-08-27T11:39:41.923Z, threadId: undefined, id: '156690598192362530', preview: 'i lost my ipad', flags: {}, state: [Object], suggestions: [Array], credentials: undefined, nlu: [Object] } } }{ botId: 'my-bot' }
2019-08-27 13:39:42debug2019-08-27T11:39:42.930Z bp:hooks:after_incoming_middleware (my-bot) after execute{ botId: 'my-bot' }
2019-08-27 13:39:42debug2019-08-27T11:39:42.933Z bp:hooks:after_incoming_middleware (my-bot) before execute { path: 'builtin/01_expire_nlu_contexts.js', botId: 'my-bot', args: { event: IOEvent { type: 'text', channel: 'api', direction: 'incoming', payload: [Object], target: 'postman', botId: 'my-bot', createdOn: 2019-08-27T11:39:41.923Z, threadId: undefined, id: '156690598192362530', preview: 'i lost my ipad', flags: {}, state: [Object], suggestions: [Array], credentials: undefined, nlu: [Object] } } }{ botId: 'my-bot' }
2019-08-27 13:39:42debug2019-08-27T11:39:42.934Z bp:hooks:after_incoming_middleware (my-bot) after execute{ botId: 'my-bot' }
2019-08-27 13:39:42debug2019-08-27T11:39:42.936Z bp:hooks:after_incoming_middleware (my-bot) before execute { path: 'basic-skills/05_extract_slots.js', botId: 'my-bot', args: { event: IOEvent { type: 'text', channel: 'api', direction: 'incoming', payload: [Object], target: 'postman', botId: 'my-bot', createdOn: 2019-08-27T11:39:41.923Z, threadId: undefined, id: '156690598192362530', preview: 'i lost my ipad', flags: {}, state: [Object], suggestions: [Array], credentials: undefined, nlu: [Object] } } }{ botId: 'my-bot' }
2019-08-27 13:39:42debug2019-08-27T11:39:42.941Z bp:hooks:after_incoming_middleware (my-bot) after execute{ botId: 'my-bot' }
2019-08-27 13:39:42debug2019-08-27T11:39:42.945Z bp:hooks:before_outgoing_middleware (my-bot) before execute { path: 'channel-web/quick_replies.js', botId: 'my-bot', args: { event: IOEvent { type: 'typing', channel: 'api', direction: 'outgoing', payload: [Object], target: 'postman', botId: 'my-bot', createdOn: 2019-08-27T11:39:42.941Z, threadId: undefined, id: '156690598294127040', preview: undefined, flags: {}, state: {}, incomingEventId: '156690598192362530', nlu: [Object] } } }{ botId: 'my-bot' }
2019-08-27 13:39:42debug2019-08-27T11:39:42.948Z bp:hooks:before_outgoing_middleware (my-bot) after execute{ botId: 'my-bot' }
2019-08-27 13:39:43debug2019-08-27T11:39:43.315Z bp:hooks:before_outgoing_middleware (my-bot) before execute { path: 'channel-web/quick_replies.js', botId: 'my-bot', args: { event: IOEvent { type: 'text', channel: 'api', direction: 'outgoing', payload: [Object], target: 'postman', botId: 'my-bot', createdOn: 2019-08-27T11:39:42.942Z, threadId: undefined, id: '156690598294258180', preview: 'Contact the Helpdesk ....\n', flags: {}, state: {}, incomingEventId: '156690598192362530', nlu: [Object] } } }{ botId: 'my-bot' }
2019-08-27 13:39:43debug2019-08-27T11:39:43.330Z bp:hooks:before_outgoing_middleware (my-bot) after execute{ botId: 'my-bot' }
2019-08-27 13:39:58debug2019-08-27T11:39:58.164Z bp:janitor:dialog (my-bot) Found stale sessionsapi::0d28a90b-1b9f-4d78-b42c-02cf4ad8740b, api::aeb517a1-9999-416d-9f5b-e1a9bb2a2f5c, { botId: 'my-bot' }
2019-08-27 13:39:58debug2019-08-27T11:39:58.167Z bp:janitor:dialog (my-bot) Processing timeoutapi::0d28a90b-1b9f-4d78-b42c-02cf4ad8740b, { botId: 'my-bot' }
2019-08-27 13:39:58debug2019-08-27T11:39:58.172Z bp:janitor:dialog (my-bot) Skipping. No changes in contextapi::0d28a90b-1b9f-4d78-b42c-02cf4ad8740b, { botId: 'my-bot' }
2019-08-27 13:39:58debug2019-08-27T11:39:58.315Z bp:janitor:dialog (my-bot) New expiry set for Tue Aug 27 2019 11:44:58 GMT+0000 (Coordinated Universal Time)api::0d28a90b-1b9f-4d78-b42c-02cf4ad8740b, { botId: 'my-bot' }
2019-08-27 13:39:58debug2019-08-27T11:39:58.321Z bp:janitor:dialog (my-bot) Processing timeoutapi::aeb517a1-9999-416d-9f5b-e1a9bb2a2f5c, { botId: 'my-bot' }
2019-08-27 13:39:58debug2019-08-27T11:39:58.326Z bp:janitor:dialog (my-bot) Skipping. No changes in contextapi::aeb517a1-9999-416d-9f5b-e1a9bb2a2f5c, { botId: 'my-bot' }
2019-08-27 13:39:58debug2019-08-27T11:39:58.491Z bp:janitor:dialog (my-bot) New expiry set for Tue Aug 27 2019 11:44:58 GMT+0000 (Coordinated Universal Time)api::aeb517a1-9999-416d-9f5b-e1a9bb2a2f5c, { botId: 'my-bot' }
2019-08-27 13:40:08debug2019-08-27T11:40:08.162Z bp:janitor:dialog (my-bot) Found stale sessionsapi::user12345, { botId: 'my-bot' }
2019-08-27 13:40:08debug2019-08-27T11:40:08.165Z bp:janitor:dialog (my-bot) Processing timeoutapi::user12345, { botId: 'my-bot' }
2019-08-27 13:40:08debug2019-08-27T11:40:08.169Z bp:janitor:dialog (my-bot) Skipping. No changes in contextapi::user12345, { botId: 'my-bot' }
2019-08-27 13:40:08debug2019-08-27T11:40:08.470Z bp:janitor:dialog (my-bot) New expiry set for Tue Aug 27 2019 11:45:08 GMT+0000 (Coordinated Universal Time)api::user12345, { botId: 'my-bot' }
2019-08-27 13:40:28debug2019-08-27T11:40:28.158Z bp:janitor:dialog (my-bot) Found stale sessionsapi::db6c38ea-262e-427f-ba16-339b98bbe8f0, { botId: 'my-bot' }
2019-08-27 13:40:28debug2019-08-27T11:40:28.160Z bp:janitor:dialog (my-bot) Processing timeoutapi::db6c38ea-262e-427f-ba16-339b98bbe8f0, { botId: 'my-bot' }
2019-08-27 13:40:28debug2019-08-27T11:40:28.161Z bp:janitor:dialog (my-bot) Skipping. No changes in contextapi::db6c38ea-262e-427f-ba16-339b98bbe8f0, { botId: 'my-bot' }
2019-08-27 13:40:28debug2019-08-27T11:40:28.471Z bp:janitor:dialog (my-bot) New expiry set for Tue Aug 27 2019 11:45:28 GMT+0000 (Coordinated Universal Time)api::db6c38ea-262e-427f-ba16-339b98bbe8f0, { botId: 'my-bot' }
2019-08-27 13:40:58debug2019-08-27T11:40:58.159Z bp:janitor:dialog (my-bot) Found stale sessionsapi::79649685-bc32-4741-a8f8-4eebda57f498, { botId: 'my-bot' }
2019-08-27 13:40:58debug2019-08-27T11:40:58.159Z bp:janitor:dialog (my-bot) Processing timeoutapi::79649685-bc32-4741-a8f8-4eebda57f498, { botId: 'my-bot' }
2019-08-27 13:40:58debug2019-08-27T11:40:58.160Z bp:janitor:dialog (my-bot) Skipping. No changes in contextapi::79649685-bc32-4741-a8f8-4eebda57f498, { botId: 'my-bot' }
2019-08-27 13:40:58debug2019-08-27T11:40:58.767Z bp:janitor:dialog (my-bot) New expiry set for Tue Aug 27 2019 11:45:58 GMT+0000 (Coordinated Universal Time)api::79649685-bc32-4741-a8f8-4eebda57f498, { botId: 'my-bot' }
2019-08-27 13:41:08debug2019-08-27T11:41:08.163Z bp:janitor:dialog (my-bot) Found stale sessionsapi::e1e4a752-439c-423f-95e0-4f3699598966, { botId: 'my-bot' }
2019-08-27 13:41:08debug2019-08-27T11:41:08.166Z bp:janitor:dialog (my-bot) Processing timeoutapi::e1e4a752-439c-423f-95e0-4f3699598966, { botId: 'my-bot' }

OK, I see the right response in there, so I think our hypothesis about replying with the an old message / converse timing out is correct.

Is the response generated programmatically by any chance? If yes, did you make sure to await sending the response in your action?

If no, would it be possible for you to send me an archive of your bot (admin -> export your bot from the list) in private message so that I can have a look. Else we can jump on a 1-on-1 call over Skype, please hit me up in private message.

Thanks!

Hi Sylvain,

The answer is coming from a Q&A entry.

How can I send something in a private message, I can’t seem to find a button to do so…

Cheers,
Sjoerd

@sylvain: can you please tell me how to send something as private message? I now updated to 12.1.2 and still have the same issue…

@sylvain : I have sent a message via e-mail; did that reach you in good order?

@sylvain: Are you on to my case, because I’m completely blocked… (sorry for putting pressure)?

Hi,

We upgraded to 12.1.4, and from that moment on we didn’t get any inconsistent answer back from the bot.

I propose to close this issue until we re-encounter the exact same problem…