2020-02-10 22:20:16,445 [DEBUG] Starting a new session for conversation ID '0730e9c6df2844c0bb67102ddda3f90f'. 2020-02-10 22:20:16,447 [DEBUG] Action 'action_session_start' ended with events '[, ]'. 2020-02-10 22:20:16,449 [DEBUG] Current slot values: business_email: None mobile: None person_name: None requested_slot: None 2020-02-10 22:20:16,450 [DEBUG] Received user message '/greet' with intent '{'name': 'greet', 'confidence': 1.0}' and entities '[]' 2020-02-10 22:20:16,451 [DEBUG] Logged UserUtterance - tracker now has 4 events. 2020-02-10 22:20:16,457 [DEBUG] Current tracker state [None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, {}, {'prev_action_listen': 1.0, 'intent_greet': 1.0}] 2020-02-10 22:20:16,458 [DEBUG] There is a memorised next action '110' 2020-02-10 22:20:16,460 [DEBUG] There is no active form 2020-02-10 22:20:16,465 [DEBUG] NLU confidence threshold met, confidence of fallback action set to core threshold (0.3). 2020-02-10 22:20:16,466 [DEBUG] Predicted next action using policy_1_AugmentedMemoizationPolicy 2020-02-10 22:20:16,467 [DEBUG] Predicted next action 'utter_greet' with confidence 1.00. 2020-02-10 22:20:16,468 [DEBUG] Action 'utter_greet' ended with events '[BotUttered('Hi, I'm Alisa!', {"elements": null, "quick_replies": null, "buttons": null, "attachment": null, "image": null, "custom": null}, {}, 1581353416.4684246)]'. 2020-02-10 22:20:16,482 [DEBUG] Current tracker state [None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, {}, {'prev_action_listen': 1.0, 'intent_greet': 1.0}, {'prev_utter_greet': 1.0, 'intent_greet': 1.0}] 2020-02-10 22:20:16,483 [DEBUG] There is a memorised next action '143' 2020-02-10 22:20:16,485 [DEBUG] There is no mapped action for the predicted intent, 'greet'. 2020-02-10 22:20:16,486 [DEBUG] There is no active form 2020-02-10 22:20:16,487 [DEBUG] NLU confidence threshold met, confidence of fallback action set to core threshold (0.3). 2020-02-10 22:20:16,488 [DEBUG] Predicted next action using policy_1_AugmentedMemoizationPolicy 2020-02-10 22:20:16,489 [DEBUG] Predicted next action 'utter_welcome' with confidence 1.00. 2020-02-10 22:20:16,490 [DEBUG] Action 'utter_welcome' ended with events '[BotUttered('Welcome to the World of AI Cloud-based Workforce Capital Management Solutions.', {"elements": null, "quick_replies": null, "buttons": null, "attachment": null, "image": null, "custom": null}, {}, 1581353416.4904163)]'. 2020-02-10 22:20:16,504 [DEBUG] Current tracker state [None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, {}, {'prev_action_listen': 1.0, 'intent_greet': 1.0}, {'prev_utter_greet': 1.0, 'intent_greet': 1.0}, {'prev_utter_welcome': 1.0, 'intent_greet': 1.0}] 2020-02-10 22:20:16,506 [DEBUG] There is a memorised next action '107' 2020-02-10 22:20:16,507 [DEBUG] There is no mapped action for the predicted intent, 'greet'. 2020-02-10 22:20:16,508 [DEBUG] There is no active form 2020-02-10 22:20:16,509 [DEBUG] NLU confidence threshold met, confidence of fallback action set to core threshold (0.3). 2020-02-10 22:20:16,510 [DEBUG] Predicted next action using policy_1_AugmentedMemoizationPolicy 2020-02-10 22:20:16,512 [DEBUG] Predicted next action 'utter_getstarted' with confidence 1.00. 2020-02-10 22:20:16,514 [DEBUG] Action 'utter_getstarted' ended with events '[BotUttered('To determine how I can help you best, I'm going to ask you a few questions.', {"elements": null, "quick_replies": null, "buttons": null, "attachment": null, "image": null, "custom": null}, {}, 1581353416.514432)]'. 2020-02-10 22:20:16,527 [DEBUG] Current tracker state [None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, {}, {'prev_action_listen': 1.0, 'intent_greet': 1.0}, {'prev_utter_greet': 1.0, 'intent_greet': 1.0}, {'prev_utter_welcome': 1.0, 'intent_greet': 1.0}, {'prev_utter_getstarted': 1.0, 'intent_greet': 1.0}] 2020-02-10 22:20:16,528 [DEBUG] There is a memorised next action '0' 2020-02-10 22:20:16,530 [DEBUG] There is no mapped action for the predicted intent, 'greet'. 2020-02-10 22:20:16,531 [DEBUG] There is no active form 2020-02-10 22:20:16,534 [DEBUG] NLU confidence threshold met, confidence of fallback action set to core threshold (0.3). 2020-02-10 22:20:16,535 [DEBUG] Predicted next action using policy_1_AugmentedMemoizationPolicy 2020-02-10 22:20:16,537 [DEBUG] Predicted next action 'action_listen' with confidence 1.00. 2020-02-10 22:20:16,538 [DEBUG] Action 'action_listen' ended with events '[]'. 2020-02-10 22:20:16,539 [DEBUG] Deleted lock for conversation '0730e9c6df2844c0bb67102ddda3f90f'. 2020-02-10 22:20:20,852 [DEBUG] Recreating tracker for id '0730e9c6df2844c0bb67102ddda3f90f' 2020-02-10 22:20:20,863 [DEBUG] Received user message 'ok' with intent '{'name': 'product_accept', 'confidence': 0.9895835518836975}' and entities '[]' 2020-02-10 22:20:20,864 [DEBUG] Logged UserUtterance - tracker now has 12 events. 2020-02-10 22:20:20,870 [DEBUG] Current tracker state [None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, {}, {'prev_action_listen': 1.0, 'intent_greet': 1.0}, {'prev_utter_greet': 1.0, 'intent_greet': 1.0}, {'prev_utter_welcome': 1.0, 'intent_greet': 1.0}, {'prev_utter_getstarted': 1.0, 'intent_greet': 1.0}, {'prev_action_listen': 1.0, 'intent_product_accept': 1.0}] 2020-02-10 22:20:20,872 [DEBUG] There is a memorised next action '88' 2020-02-10 22:20:20,873 [DEBUG] There is no active form 2020-02-10 22:20:20,874 [DEBUG] NLU confidence threshold met, confidence of fallback action set to core threshold (0.3). 2020-02-10 22:20:20,875 [DEBUG] Predicted next action using policy_1_AugmentedMemoizationPolicy 2020-02-10 22:20:20,877 [DEBUG] Predicted next action 'utter_ask_person' with confidence 1.00. 2020-02-10 22:20:20,878 [DEBUG] Action 'utter_ask_person' ended with events '[BotUttered('What's your name?', {"elements": null, "quick_replies": null, "buttons": null, "attachment": null, "image": null, "custom": null}, {}, 1581353420.8788748)]'. 2020-02-10 22:20:20,891 [DEBUG] Current tracker state [None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, {}, {'prev_action_listen': 1.0, 'intent_greet': 1.0}, {'prev_utter_greet': 1.0, 'intent_greet': 1.0}, {'prev_utter_welcome': 1.0, 'intent_greet': 1.0}, {'prev_utter_getstarted': 1.0, 'intent_greet': 1.0}, {'prev_action_listen': 1.0, 'intent_product_accept': 1.0}, {'prev_utter_ask_person': 1.0, 'intent_product_accept': 1.0}] 2020-02-10 22:20:20,892 [DEBUG] There is a memorised next action '145' 2020-02-10 22:20:20,894 [DEBUG] There is no mapped action for the predicted intent, 'product_accept'. 2020-02-10 22:20:20,896 [DEBUG] There is no active form 2020-02-10 22:20:20,897 [DEBUG] NLU confidence threshold met, confidence of fallback action set to core threshold (0.3). 2020-02-10 22:20:20,899 [DEBUG] Predicted next action using policy_1_AugmentedMemoizationPolicy 2020-02-10 22:20:20,900 [DEBUG] Predicted next action 'store_form' with confidence 1.00. 2020-02-10 22:20:20,901 [DEBUG] Calling action endpoint to run action 'store_form'. 2020-02-10 22:20:22,950 [DEBUG] Action 'store_form' ended with events '[, ]'. 2020-02-10 22:20:22,951 [DEBUG] Current slot values: business_email: None mobile: None person_name: None requested_slot: person_name 2020-02-10 22:20:22,957 [DEBUG] Current tracker state [None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, {}, {'prev_action_listen': 1.0, 'intent_greet': 1.0}, {'prev_utter_greet': 1.0, 'intent_greet': 1.0}, {'prev_utter_welcome': 1.0, 'intent_greet': 1.0}, {'prev_utter_getstarted': 1.0, 'intent_greet': 1.0}, {'prev_action_listen': 1.0, 'intent_product_accept': 1.0}, {'prev_utter_ask_person': 1.0, 'intent_product_accept': 1.0}] 2020-02-10 22:20:22,959 [DEBUG] There is a memorised next action '145' 2020-02-10 22:20:22,961 [DEBUG] There is no mapped action for the predicted intent, 'product_accept'. 2020-02-10 22:20:22,962 [DEBUG] There is an active form 'store_form' 2020-02-10 22:20:22,963 [DEBUG] NLU confidence threshold met, confidence of fallback action set to core threshold (0.3). 2020-02-10 22:20:22,965 [DEBUG] Predicted next action using policy_3_FormPolicy 2020-02-10 22:20:22,966 [DEBUG] Predicted next action 'action_listen' with confidence 1.00. 2020-02-10 22:20:22,967 [DEBUG] Action 'action_listen' ended with events '[]'. 2020-02-10 22:20:22,968 [DEBUG] Deleted lock for conversation '0730e9c6df2844c0bb67102ddda3f90f'. 2020-02-10 22:20:24,636 [DEBUG] Recreating tracker for id '0730e9c6df2844c0bb67102ddda3f90f' 2020-02-10 22:20:24,646 [DEBUG] Received user message 'karthik' with intent '{'name': 'inform', 'confidence': 0.4930369555950165}' and entities '[{'start': 0, 'end': 7, 'value': 'karthik', 'entity': 'person_name', 'confidence': 0.8269398558264487, 'extractor': 'CRFEntityExtractor'}]' 2020-02-10 22:20:24,648 [DEBUG] Current slot values: business_email: None mobile: None person_name: karthik requested_slot: person_name 2020-02-10 22:20:24,649 [DEBUG] Logged UserUtterance - tracker now has 20 events. 2020-02-10 22:20:24,656 [DEBUG] Current tracker state [None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, {}, {'prev_action_listen': 1.0, 'intent_greet': 1.0}, {'prev_utter_greet': 1.0, 'intent_greet': 1.0}, {'prev_utter_welcome': 1.0, 'intent_greet': 1.0}, {'prev_utter_getstarted': 1.0, 'intent_greet': 1.0}, {'prev_action_listen': 1.0, 'intent_product_accept': 1.0}, {'prev_utter_ask_person': 1.0, 'intent_product_accept': 1.0}] 2020-02-10 22:20:24,658 [DEBUG] There is a memorised next action '145' 2020-02-10 22:20:24,659 [DEBUG] There is an active form 'store_form' 2020-02-10 22:20:24,661 [DEBUG] The difference in NLU confidences for the top two intents (0.019687622785568237) is lower than the ambiguity threshold 0.10. 2020-02-10 22:20:24,662 [DEBUG] Predicted next action using policy_3_FormPolicy 2020-02-10 22:20:24,663 [DEBUG] Predicted next action 'store_form' with confidence 1.00. 2020-02-10 22:20:24,665 [DEBUG] Calling action endpoint to run action 'store_form'. 2020-02-10 22:20:26,738 [DEBUG] Action 'store_form' ended with events '[BotUttered('Can i have your Mobile Number.', {"elements": null, "quick_replies": null, "buttons": null, "attachment": null, "image": null, "custom": null}, {"person_name": "karthik", "requested_slot": "person_name"}, 1581353426.738709), , ]'. 2020-02-10 22:20:26,740 [DEBUG] Current slot values: business_email: None mobile: None person_name: karthik requested_slot: mobile 2020-02-10 22:20:26,758 [DEBUG] Current tracker state [None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, {}, {'prev_action_listen': 1.0, 'intent_greet': 1.0}, {'prev_utter_greet': 1.0, 'intent_greet': 1.0}, {'prev_utter_welcome': 1.0, 'intent_greet': 1.0}, {'prev_utter_getstarted': 1.0, 'intent_greet': 1.0}, {'prev_action_listen': 1.0, 'intent_product_accept': 1.0}, {'prev_utter_ask_person': 1.0, 'intent_product_accept': 1.0}] 2020-02-10 22:20:26,760 [DEBUG] There is a memorised next action '145' 2020-02-10 22:20:26,762 [DEBUG] There is no mapped action for the predicted intent, 'inform'. 2020-02-10 22:20:26,764 [DEBUG] There is an active form 'store_form' 2020-02-10 22:20:26,766 [DEBUG] NLU confidence threshold met, confidence of fallback action set to core threshold (0.3). 2020-02-10 22:20:26,769 [DEBUG] Predicted next action using policy_3_FormPolicy 2020-02-10 22:20:26,771 [DEBUG] Predicted next action 'action_listen' with confidence 1.00. 2020-02-10 22:20:26,772 [DEBUG] Action 'action_listen' ended with events '[]'. 2020-02-10 22:20:26,774 [DEBUG] Deleted lock for conversation '0730e9c6df2844c0bb67102ddda3f90f'. 2020-02-10 22:20:31,171 [DEBUG] Recreating tracker for id '0730e9c6df2844c0bb67102ddda3f90f' 2020-02-10 22:20:31,182 [DEBUG] Received user message '9618223591' with intent '{'name': 'mobile', 'confidence': 0.6074466705322266}' and entities '[{'start': 0, 'end': 10, 'value': '9618223591', 'entity': 'mobile', 'confidence': 0.9731738554784689, 'extractor': 'CRFEntityExtractor'}]' 2020-02-10 22:20:31,183 [DEBUG] Current slot values: business_email: None mobile: 9618223591 person_name: karthik requested_slot: mobile 2020-02-10 22:20:31,186 [DEBUG] Logged UserUtterance - tracker now has 27 events. 2020-02-10 22:20:31,194 [DEBUG] Current tracker state [None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, {}, {'prev_action_listen': 1.0, 'intent_greet': 1.0}, {'prev_utter_greet': 1.0, 'intent_greet': 1.0}, {'prev_utter_welcome': 1.0, 'intent_greet': 1.0}, {'prev_utter_getstarted': 1.0, 'intent_greet': 1.0}, {'prev_action_listen': 1.0, 'intent_product_accept': 1.0}, {'prev_utter_ask_person': 1.0, 'intent_product_accept': 1.0}] 2020-02-10 22:20:31,196 [DEBUG] There is a memorised next action '145' 2020-02-10 22:20:31,199 [DEBUG] There is an active form 'store_form' 2020-02-10 22:20:31,202 [DEBUG] NLU confidence threshold met, confidence of fallback action set to core threshold (0.3). 2020-02-10 22:20:31,204 [DEBUG] Predicted next action using policy_3_FormPolicy 2020-02-10 22:20:31,207 [DEBUG] Predicted next action 'store_form' with confidence 1.00. 2020-02-10 22:20:31,210 [DEBUG] Calling action endpoint to run action 'store_form'. 2020-02-10 22:20:33,281 [DEBUG] Action 'store_form' ended with events '[, ]'. 2020-02-10 22:20:33,284 [DEBUG] Current slot values: business_email: None mobile: 9618223591 person_name: karthik requested_slot: business_email 2020-02-10 22:20:33,294 [DEBUG] Current tracker state [None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, {}, {'prev_action_listen': 1.0, 'intent_greet': 1.0}, {'prev_utter_greet': 1.0, 'intent_greet': 1.0}, {'prev_utter_welcome': 1.0, 'intent_greet': 1.0}, {'prev_utter_getstarted': 1.0, 'intent_greet': 1.0}, {'prev_action_listen': 1.0, 'intent_product_accept': 1.0}, {'prev_utter_ask_person': 1.0, 'intent_product_accept': 1.0}] 2020-02-10 22:20:33,296 [DEBUG] There is a memorised next action '145' 2020-02-10 22:20:33,297 [DEBUG] There is no mapped action for the predicted intent, 'mobile'. 2020-02-10 22:20:33,299 [DEBUG] There is an active form 'store_form' 2020-02-10 22:20:33,300 [DEBUG] NLU confidence threshold met, confidence of fallback action set to core threshold (0.3). 2020-02-10 22:20:33,301 [DEBUG] Predicted next action using policy_3_FormPolicy 2020-02-10 22:20:33,303 [DEBUG] Predicted next action 'action_listen' with confidence 1.00. 2020-02-10 22:20:33,304 [DEBUG] Action 'action_listen' ended with events '[]'. 2020-02-10 22:20:33,306 [DEBUG] Deleted lock for conversation '0730e9c6df2844c0bb67102ddda3f90f'. 2020-02-10 22:20:45,508 [DEBUG] Recreating tracker for id '0730e9c6df2844c0bb67102ddda3f90f' 2020-02-10 22:20:45,518 [DEBUG] Received user message 'karthik@gmail.com' with intent '{'name': 'inform', 'confidence': 0.517474353313446}' and entities '[{'start': 0, 'end': 17, 'value': 'karthik@gmail.com', 'entity': 'business_email', 'confidence': 0.9950419190328679, 'extractor': 'CRFEntityExtractor'}]' 2020-02-10 22:20:45,520 [DEBUG] Current slot values: business_email: karthik@gmail.com mobile: 9618223591 person_name: karthik requested_slot: business_email 2020-02-10 22:20:45,521 [DEBUG] Logged UserUtterance - tracker now has 33 events. 2020-02-10 22:20:45,527 [DEBUG] Current tracker state [None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, {}, {'prev_action_listen': 1.0, 'intent_greet': 1.0}, {'prev_utter_greet': 1.0, 'intent_greet': 1.0}, {'prev_utter_welcome': 1.0, 'intent_greet': 1.0}, {'prev_utter_getstarted': 1.0, 'intent_greet': 1.0}, {'prev_action_listen': 1.0, 'intent_product_accept': 1.0}, {'prev_utter_ask_person': 1.0, 'intent_product_accept': 1.0}] 2020-02-10 22:20:45,529 [DEBUG] There is a memorised next action '145' 2020-02-10 22:20:45,530 [DEBUG] There is an active form 'store_form' 2020-02-10 22:20:45,531 [DEBUG] The difference in NLU confidences for the top two intents (0.06498804688453674) is lower than the ambiguity threshold 0.10. 2020-02-10 22:20:45,532 [DEBUG] Predicted next action using policy_3_FormPolicy 2020-02-10 22:20:45,534 [DEBUG] Predicted next action 'store_form' with confidence 1.00. 2020-02-10 22:20:45,535 [DEBUG] Calling action endpoint to run action 'store_form'. 2020-02-10 22:21:05,421 [ERROR] Encountered an exception while running action 'store_form'. Bot will continue, but the actions events are lost. Please check the logs of your action server for more information. 2020-02-10 22:21:05,428 [DEBUG] Failed to execute custom action. Traceback (most recent call last): File "c:\users\karthik\appdata\local\continuum\anaconda3\envs\tensorflow\lib\site-packages\rasa\core\actions\action.py", line 549, in run json=json_body, method="post", timeout=DEFAULT_REQUEST_TIMEOUT File "c:\users\karthik\appdata\local\continuum\anaconda3\envs\tensorflow\lib\site-packages\rasa\utils\endpoints.py", line 150, in request resp.status, resp.reason, await resp.content.read() rasa.utils.endpoints.ClientResponseError: 500, Internal Server Error, body='b'\n

Internal Server Error

\n

\n The server encountered an internal error and cannot complete\n your request.\n

\n'' The above exception was the direct cause of the following exception: Traceback (most recent call last): File "c:\users\karthik\appdata\local\continuum\anaconda3\envs\tensorflow\lib\site-packages\rasa\core\processor.py", line 599, in _run_action events = await action.run(output_channel, nlg, tracker, self.domain) File "c:\users\karthik\appdata\local\continuum\anaconda3\envs\tensorflow\lib\site-packages\rasa\core\actions\action.py", line 572, in run raise Exception("Failed to execute custom action.") from e Exception: Failed to execute custom action. 2020-02-10 22:21:05,437 [DEBUG] Action 'store_form' ended with events '[]'. 2020-02-10 22:21:05,447 [DEBUG] Current slot values: business_email: karthik@gmail.com mobile: 9618223591 person_name: karthik requested_slot: business_email 2020-02-10 22:21:05,466 [DEBUG] Current tracker state [None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, None, {}, {'prev_action_listen': 1.0, 'intent_greet': 1.0}, {'prev_utter_greet': 1.0, 'intent_greet': 1.0}, {'prev_utter_welcome': 1.0, 'intent_greet': 1.0}, {'prev_utter_getstarted': 1.0, 'intent_greet': 1.0}, {'prev_action_listen': 1.0, 'intent_product_accept': 1.0}, {'prev_utter_ask_person': 1.0, 'intent_product_accept': 1.0}] 2020-02-10 22:21:05,469 [DEBUG] There is a memorised next action '145' 2020-02-10 22:21:05,472 [DEBUG] There is no mapped action for the predicted intent, 'inform'. 2020-02-10 22:21:05,477 [DEBUG] There is an active form 'store_form' 2020-02-10 22:21:05,480 [DEBUG] NLU confidence threshold met, confidence of fallback action set to core threshold (0.3). 2020-02-10 22:21:05,483 [DEBUG] Predicted next action using policy_3_FormPolicy 2020-02-10 22:21:05,487 [DEBUG] Predicted next action 'action_listen' with confidence 1.00. 2020-02-10 22:21:05,490 [DEBUG] Action 'action_listen' ended with events '[]'. 2020-02-10 22:21:05,493 [DEBUG] Deleted lock for conversation '0730e9c6df2844c0bb67102ddda3f90f'. 2020-02-10 22:21:15,186 [ERROR] Exception occurred while handling uri: unknown NoneType: None 2020-02-10 22:21:15,292 [ERROR] Exception occurred while handling uri: unknown NoneType: None