Non-required form slot is not filled from entity when the form is active in Rasa 3.0

IuliaCotaga · December 10, 2021, 12:52pm

Hello,

With the recent migration of my model to Rasa Open Source 3.0, I noticed that slot filling within a form did work similarly to Rasa 2.8.

If a slot was defined in domain, but it was not a required slot in a form, then the slot did not get set through entity extraction when the form was active.

Below is the model I used:

version: '3.0'

recipe: default.v1

config:
  store_entities_as_slots: true
session_config:
  session_expiration_time: 60
  carry_over_slots_to_new_session: true

intents:
- form_start
- intent1
- intent2

entities:
- form1_info1
- form1_slot1
- form1_slot2

slots:
  form1_info1:
    type: text
    mappings:
    - type: from_entity
      entity: form1_info1
  
  form1_slot1:
    type: text
    influence_conversation: false
    mappings:
    - type: from_intent
      value: Filled
      intent: intent1
      conditions:
      - active_loop: form1
        requested_slot: form1_slot1

  form1_slot2:
    type: text
    influence_conversation: false
    mappings:
    - type: from_intent
      value: Filled
      intent: intent2
      conditions:
      - active_loop: form1
        requested_slot: form1_slot2
  
forms:
  form1:
    ignored_intents: []
    required_slots:
    - form1_slot1
    - form1_slot2

responses:
  utter_ask_form1_slot1:
    - text: "intent1 will fill slot1 and info1 slots"
  utter_ask_form1_slot2:
    - text: "intent2 will fill slot2 slot"
  utter_slots_values:
    - text: "form1_slot1 is {form1_slot1}, form1_slot2 is {form1_slot2}, form1_info1 is {form1_info1}"   

nlu:

language: en

pipeline:
- name: WhitespaceTokenizer
- name: RegexFeaturizer
- name: RegexInterpreter
- name: LexicalSyntacticFeaturizer
- name: CountVectorsFeaturizer
- name: DIETClassifier
  epochs: 100
  constrain_similarities: true
- name: EntitySynonymMapper
- name: ResponseSelector
  epochs: 100
  constrain_similarities: true
- name: FallbackClassifier
  threshold: 0.3
  ambiguity_threshold: 0.1
  
policies:
- name: MemoizationPolicy
- name: RulePolicy

rules:
- rule: Activate form
  steps:
  - intent: form_start
  - action: form1
  - active_loop: form1
  
- rule: Submit form
  condition:
  - active_loop: form1
  steps:
  - action: form1
  - active_loop: null
  - slot_was_set:
    - requested_slot: null
  - action: utter_slots_values

Rasa conversation (sent intents and Rasa responses):

Your input ->  /form_start
intent1 will fill slot1 and info1 slots
Your input ->  /intent1{"form1_info1":"info1"}
intent2 will fill slot2 slot
Your input ->  /intent2
form1_slot1 is Filled, form1_slot2 is Filled, form1_info1 is None

In a similar scenario, in Rasa 2.8, ‘form1_info1’ slot was correctly set to the extracted value, although it was not specified as form required slot.

In Rasa 3.0, once ‘form1_info1’ slot was added to the form, it was correctly set with ‘/intent1{“form1_info1”:“info1”}’ user message.

Could you, please, clarify whether the slot filling behavior in this context has changed in Rasa 3.0 or this is a bug?

Thanks, Iulia

anca · December 10, 2021, 3:57pm

@IuliaCotaga Happy to help! Could you please share the debug log after the 2nd user input (/intent1{"form1_info1: "info1"}) by running rasa shell --debug? I would be particularly interested if the entity is correctly extracted from the user message.

The slot filling behaviour in 3.0 is now executed by the default action action_extract_slots and it should fill in the slot form1_info1 regardless of whether a form is active or not, since you haven’t specified mapping conditions for this slot.

IuliaCotaga · December 10, 2021, 5:07pm

Hi Anca,

It looks like the entity was correctly identified and extracted, but the mapped slot was not filled in.

2021-12-10 16:58:06 DEBUG    rasa.core.processor  - Received user message '/intent1{"form1_info1":"info1"}' with intent '{'name': 'intent1', 'confidence': 1.0}' and entities '[{'entity': 'form1_info1', 'value': 'info1', 'start': 8, 'end': 31, 'extractor': 'RegexMessageHandler'}]'

Please find below the entire dialog output:

Your input ->  /form_start
2021-12-10 16:58:01 DEBUG    rasa.core.lock_store  - Issuing ticket for conversation '760dff531743417d993523a150fe2f53'.
2021-12-10 16:58:01 DEBUG    rasa.core.lock_store  - Acquiring lock for conversation '760dff531743417d993523a150fe2f53'.
2021-12-10 16:58:01 DEBUG    rasa.core.lock_store  - Acquired lock for conversation '760dff531743417d993523a150fe2f53'.
2021-12-10 16:58:01 DEBUG    rasa.core.tracker_store  - Could not find tracker for conversation ID '760dff531743417d993523a150fe2f53'.
2021-12-10 16:58:01 DEBUG    rasa.core.processor  - Starting a new session for conversation ID '760dff531743417d993523a150fe2f53'.
2021-12-10 16:58:01 DEBUG    rasa.core.processor  - Policy prediction ended with events '[]'.
2021-12-10 16:58:01 DEBUG    rasa.core.processor  - Action 'action_session_start' ended with events '[<rasa.shared.core.events.SessionStarted object at 0x7fdf465152e0>, ActionExecuted(action: action_listen, policy: None, confidence: None)]'.
2021-12-10 16:58:01 DEBUG    rasa.core.processor  - Current slot values:
        form1_info1: None
        form1_slot1: None
        form1_slot2: None
        requested_slot: None
        session_started_metadata: None
2021-12-10 16:58:01 DEBUG    rasa.engine.runner.dask  - Running graph with inputs: {'__message__': [<rasa.core.channels.channel.UserMessage object at 0x7fdf46517790>]}, targets: ['run_RegexMessageHandler'] and ExecutionContext(model_id='a135329785a9449b91605fc10c21ffa5', should_add_diagnostic_data=False, is_finetuning=False, 
node_name=None).
2021-12-10 16:58:01 DEBUG    rasa.engine.graph  - Node 'nlu_message_converter' running 'NLUMessageConverter.convert_user_message'.
2021-12-10 16:58:01 DEBUG    rasa.engine.graph  - Node 'domain_provider' running 'DomainProvider.provide_inference'.
2021-12-10 16:58:01 DEBUG    rasa.engine.graph  - Node 'run_RegexMessageHandler' running 'RegexMessageHandler.process'.
2021-12-10 16:58:01 DEBUG    rasa.core.processor  - Received user message '/form_start' with intent '{'name': 'form_start', 'confidence': 1.0}' and entities '[]'
2021-12-10 16:58:01 DEBUG    rasa.core.processor  - Logged UserUtterance - tracker now has 4 events.
2021-12-10 16:58:01 DEBUG    rasa.core.actions.action  - Validating extracted slots:
2021-12-10 16:58:01 DEBUG    rasa.core.processor  - Default action 'action_extract_slots' was executed, resulting in 0 events:
2021-12-10 16:58:01 DEBUG    rasa.engine.runner.dask  - Running graph with inputs: {'__tracker__': <rasa.shared.core.trackers.DialogueStateTracker object at 0x7fdf46517820>}, targets: ['select_prediction'] and ExecutionContext(model_id='a135329785a9449b91605fc10c21ffa5', should_add_diagnostic_data=False, is_finetuning=False, 
node_name=None).
2021-12-10 16:58:01 DEBUG    rasa.engine.graph  - Node 'rule_only_data_provider' running 'RuleOnlyDataProvider.provide'.
2021-12-10 16:58:01 DEBUG    rasa.engine.graph  - Node 'domain_provider' running 'DomainProvider.provide_inference'.
2021-12-10 16:58:01 DEBUG    rasa.engine.graph  - Node 'run_MemoizationPolicy0' running 'MemoizationPolicy.predict_action_probabilities'.
2021-12-10 16:58:01 DEBUG    rasa.core.policies.memoization  - Current tracker state:
[state 1] user intent: form_start | previous action name: action_listen
2021-12-10 16:58:01 DEBUG    rasa.core.policies.memoization  - There is no memorised next action
2021-12-10 16:58:01 DEBUG    rasa.engine.graph  - Node 'run_RulePolicy1' running 'RulePolicy.predict_action_probabilities'.
2021-12-10 16:58:01 DEBUG    rasa.core.policies.rule_policy  - Current tracker state:
[state 1] user text: /form_start | previous action name: action_listen
2021-12-10 16:58:01 DEBUG    rasa.core.policies.rule_policy  - There is no applicable rule.
2021-12-10 16:58:01 DEBUG    rasa.core.policies.rule_policy  - Current tracker state:
[state 1] user intent: form_start | previous action name: action_listen
2021-12-10 16:58:01 DEBUG    rasa.core.policies.rule_policy  - There is a rule for the next action 'form1'.  
2021-12-10 16:58:01 DEBUG    rasa.engine.graph  - Node 'select_prediction' running 'DefaultPolicyPredictionEnsemble.combine_predictions_from_kwargs'.
2021-12-10 16:58:01 DEBUG    rasa.core.policies.ensemble  - Made prediction using user intent.
2021-12-10 16:58:01 DEBUG    rasa.core.policies.ensemble  - Added `DefinePrevUserUtteredFeaturization(False)` event.
2021-12-10 16:58:01 DEBUG    rasa.core.policies.ensemble  - Predicted next action using RulePolicy.
2021-12-10 16:58:01 DEBUG    rasa.core.processor  - Predicted next action 'form1' with confidence 1.00.      
2021-12-10 16:58:01 DEBUG    rasa.core.actions.forms  - Activated the form 'form1'.
2021-12-10 16:58:01 DEBUG    rasa.core.actions.forms  - No pre-filled required slots to validate.
2021-12-10 16:58:01 DEBUG    rasa.core.actions.forms  - Request next slot 'form1_slot1'
2021-12-10 16:58:01 DEBUG    rasa.core.processor  - Policy prediction ended with events '[<rasa.shared.core.events.DefinePrevUserUtteredFeaturization object at 0x7fdf464484f0>]'.
2021-12-10 16:58:01 DEBUG    rasa.core.processor  - Action 'form1' ended with events '[<rasa.shared.core.events.ActiveLoop object at 0x7fdf46527640>, <rasa.shared.core.events.SlotSet object at 0x7fdf464482e0>, BotUttered('intent1 will fill slot1 and info1 slots', {"elements": null, "quick_replies": null, "buttons": null, "attachment": null, "image": null, "custom": null}, {"utter_action": "utter_ask_form1_slot1"}, 1639155481.1879516)]'.
2021-12-10 16:58:01 DEBUG    rasa.core.processor  - Current slot values:
        form1_info1: None
        form1_slot1: None
        form1_slot2: None
        requested_slot: form1_slot1
        session_started_metadata: None
2021-12-10 16:58:01 DEBUG    rasa.engine.runner.dask  - Running graph with inputs: {'__tracker__': <rasa.shared.core.trackers.DialogueStateTracker object at 0x7fdf46517820>}, targets: ['select_prediction'] and ExecutionContext(model_id='a135329785a9449b91605fc10c21ffa5', should_add_diagnostic_data=False, is_finetuning=False, 
node_name=None).
2021-12-10 16:58:01 DEBUG    rasa.engine.graph  - Node 'rule_only_data_provider' running 'RuleOnlyDataProvider.provide'.
2021-12-10 16:58:01 DEBUG    rasa.engine.graph  - Node 'domain_provider' running 'DomainProvider.provide_inference'.
2021-12-10 16:58:01 DEBUG    rasa.engine.graph  - Node 'run_MemoizationPolicy0' running 'MemoizationPolicy.predict_action_probabilities'.
2021-12-10 16:58:01 DEBUG    rasa.core.policies.memoization  - Current tracker state:
2021-12-10 16:58:01 DEBUG    rasa.core.policies.memoization  - There is no memorised next action
2021-12-10 16:58:01 DEBUG    rasa.engine.graph  - Node 'run_RulePolicy1' running 'RulePolicy.predict_action_probabilities'.
2021-12-10 16:58:01 DEBUG    rasa.core.policies.rule_policy  - Predicted 'action_listen' after loop 'form1'. 
2021-12-10 16:58:01 DEBUG    rasa.engine.graph  - Node 'select_prediction' running 'DefaultPolicyPredictionEnsemble.combine_predictions_from_kwargs'.
2021-12-10 16:58:01 DEBUG    rasa.core.policies.ensemble  - Predicted next action using RulePolicy.
2021-12-10 16:58:01 DEBUG    rasa.core.processor  - Predicted next action 'action_listen' with confidence 1.00.
2021-12-10 16:58:01 DEBUG    rasa.core.processor  - Policy prediction ended with events '[]'.
2021-12-10 16:58:01 DEBUG    rasa.core.processor  - Action 'action_listen' ended with events '[]'.
2021-12-10 16:58:01 DEBUG    rasa.core.lock_store  - Deleted lock for conversation '760dff531743417d993523a150fe2f53'.
intent1 will fill slot1 and info1 slots
Your input ->  /intent1{"form1_info1":"info1"}
2021-12-10 16:58:06 DEBUG    rasa.core.lock_store  - Issuing ticket for conversation '760dff531743417d993523a150fe2f53'.
2021-12-10 16:58:06 DEBUG    rasa.core.lock_store  - Acquiring lock for conversation '760dff531743417d993523a150fe2f53'.
2021-12-10 16:58:06 DEBUG    rasa.core.lock_store  - Acquired lock for conversation '760dff531743417d993523a150fe2f53'.
2021-12-10 16:58:06 DEBUG    rasa.core.tracker_store  - Recreating tracker for id '760dff531743417d993523a150fe2f53'
2021-12-10 16:58:06 DEBUG    rasa.engine.runner.dask  - Running graph with inputs: {'__message__': [<rasa.core.channels.channel.UserMessage object at 0x7fdf46da2bb0>]}, targets: ['run_RegexMessageHandler'] and ExecutionContext(model_id='a135329785a9449b91605fc10c21ffa5', should_add_diagnostic_data=False, is_finetuning=False, 
node_name=None).
2021-12-10 16:58:06 DEBUG    rasa.engine.graph  - Node 'nlu_message_converter' running 'NLUMessageConverter.convert_user_message'.
2021-12-10 16:58:06 DEBUG    rasa.engine.graph  - Node 'domain_provider' running 'DomainProvider.provide_inference'.
2021-12-10 16:58:06 DEBUG    rasa.engine.graph  - Node 'run_RegexMessageHandler' running 'RegexMessageHandler.process'.
2021-12-10 16:58:06 DEBUG    rasa.core.processor  - Received user message '/intent1{"form1_info1":"info1"}' with intent '{'name': 'intent1', 'confidence': 1.0}' and entities '[{'entity': 'form1_info1', 'value': 'info1', 'start': 8, 'end': 31, 'extractor': 'RegexMessageHandler'}]'
2021-12-10 16:58:06 DEBUG    rasa.core.processor  - Current slot values:
        form1_info1: None
        form1_slot1: None
        form1_slot2: None
        requested_slot: form1_slot1
        session_started_metadata: None
2021-12-10 16:58:06 DEBUG    rasa.core.processor  - Logged UserUtterance - tracker now has 11 events.        
2021-12-10 16:58:06 DEBUG    rasa.core.actions.action  - Validating extracted slots: form1_slot1
2021-12-10 16:58:06 DEBUG    rasa.core.processor  - Default action 'action_extract_slots' was executed, resulting in 1 events: SlotSet(key: form1_slot1, value: Filled)
2021-12-10 16:58:06 DEBUG    rasa.engine.runner.dask  - Running graph with inputs: {'__tracker__': <rasa.shared.core.trackers.DialogueStateTracker object at 0x7fdf46da2dc0>}, targets: ['select_prediction'] and ExecutionContext(model_id='a135329785a9449b91605fc10c21ffa5', should_add_diagnostic_data=False, is_finetuning=False, 
node_name=None).
2021-12-10 16:58:06 DEBUG    rasa.engine.graph  - Node 'rule_only_data_provider' running 'RuleOnlyDataProvider.provide'.
2021-12-10 16:58:06 DEBUG    rasa.engine.graph  - Node 'domain_provider' running 'DomainProvider.provide_inference'.
2021-12-10 16:58:06 DEBUG    rasa.engine.graph  - Node 'run_MemoizationPolicy0' running 'MemoizationPolicy.predict_action_probabilities'.
2021-12-10 16:58:06 DEBUG    rasa.core.policies.memoization  - Current tracker state:
[state 1] user intent: intent1 | user entities: ('form1_info1',) | previous action name: action_listen       
2021-12-10 16:58:06 DEBUG    rasa.core.policies.memoization  - There is no memorised next action
2021-12-10 16:58:06 DEBUG    rasa.engine.graph  - Node 'run_RulePolicy1' running 'RulePolicy.predict_action_probabilities'.
2021-12-10 16:58:06 DEBUG    rasa.core.policies.rule_policy  - Current tracker state:
[state 1] user intent: form_start | previous action name: action_listen
[state 2] user intent: form_start | previous action name: form1 | active loop: {'name': 'form1'}
[state 3] user text: /intent1{"form1_info1":"info1"} | previous action name: action_listen | active loop: {'name': 'form1'}
2021-12-10 16:58:06 DEBUG    rasa.core.policies.rule_policy  - There is no applicable rule.
2021-12-10 16:58:06 DEBUG    rasa.core.policies.rule_policy  - Predicted loop 'form1'.
2021-12-10 16:58:06 DEBUG    rasa.engine.graph  - Node 'select_prediction' running 'DefaultPolicyPredictionEnsemble.combine_predictions_from_kwargs'.
2021-12-10 16:58:06 DEBUG    rasa.core.policies.ensemble  - Made prediction using user intent.
2021-12-10 16:58:06 DEBUG    rasa.core.policies.ensemble  - Added `DefinePrevUserUtteredFeaturization(False)` event.
2021-12-10 16:58:06 DEBUG    rasa.core.policies.ensemble  - Predicted next action using RulePolicy.
2021-12-10 16:58:06 DEBUG    rasa.core.processor  - Predicted next action 'form1' with confidence 1.00.      
2021-12-10 16:58:06 DEBUG    rasa.core.actions.forms  - Validating user input 'UserUttered(text: /intent1{"form1_info1":"info1"}, intent: intent1, entities: info1 (Type: form1_info1, Role: None, Group: None), use_text_for_featurization: False)'.
2021-12-10 16:58:06 DEBUG    rasa.core.actions.forms  - Validating extracted slots: {'form1_slot1': 'Filled'}2021-12-10 16:58:06 DEBUG    rasa.core.actions.forms  - Request next slot 'form1_slot2'
2021-12-10 16:58:06 DEBUG    rasa.core.processor  - Policy prediction ended with events '[<rasa.shared.core.events.DefinePrevUserUtteredFeaturization object at 0x7fdf46d9b400>]'.
2021-12-10 16:58:06 DEBUG    rasa.core.processor  - Action 'form1' ended with events '[<rasa.shared.core.events.SlotSet object at 0x7fdf40b34160>, <rasa.shared.core.events.SlotSet object at 0x7fdf40be1790>, BotUttered('intent2 will fill slot2 slot', {"elements": null, "quick_replies": null, "buttons": null, "attachment": null, "image": null, "custom": null}, {"utter_action": "utter_ask_form1_slot2"}, 1639155486.7616467)]'.
2021-12-10 16:58:06 DEBUG    rasa.core.processor  - Current slot values:
        form1_info1: None
        form1_slot1: Filled
        form1_slot2: None
        requested_slot: form1_slot2
        session_started_metadata: None
2021-12-10 16:58:06 DEBUG    rasa.engine.runner.dask  - Running graph with inputs: {'__tracker__': <rasa.shared.core.trackers.DialogueStateTracker object at 0x7fdf46da2dc0>}, targets: ['select_prediction'] and ExecutionContext(model_id='a135329785a9449b91605fc10c21ffa5', should_add_diagnostic_data=False, is_finetuning=False, 
node_name=None).
2021-12-10 16:58:06 DEBUG    rasa.engine.graph  - Node 'rule_only_data_provider' running 'RuleOnlyDataProvider.provide'.
2021-12-10 16:58:06 DEBUG    rasa.engine.graph  - Node 'domain_provider' running 'DomainProvider.provide_inference'.
2021-12-10 16:58:06 DEBUG    rasa.engine.graph  - Node 'run_MemoizationPolicy0' running 'MemoizationPolicy.predict_action_probabilities'.
2021-12-10 16:58:06 DEBUG    rasa.core.policies.memoization  - Current tracker state:
2021-12-10 16:58:06 DEBUG    rasa.core.policies.memoization  - There is no memorised next action
2021-12-10 16:58:06 DEBUG    rasa.engine.graph  - Node 'run_RulePolicy1' running 'RulePolicy.predict_action_probabilities'.
2021-12-10 16:58:06 DEBUG    rasa.core.policies.rule_policy  - Predicted 'action_listen' after loop 'form1'. 
2021-12-10 16:58:06 DEBUG    rasa.engine.graph  - Node 'select_prediction' running 'DefaultPolicyPredictionEnsemble.combine_predictions_from_kwargs'.
2021-12-10 16:58:06 DEBUG    rasa.core.policies.ensemble  - Predicted next action using RulePolicy.
2021-12-10 16:58:06 DEBUG    rasa.core.processor  - Predicted next action 'action_listen' with confidence 1.00.
2021-12-10 16:58:06 DEBUG    rasa.core.processor  - Policy prediction ended with events '[]'.
2021-12-10 16:58:06 DEBUG    rasa.core.processor  - Action 'action_listen' ended with events '[]'.
2021-12-10 16:58:06 DEBUG    rasa.core.lock_store  - Deleted lock for conversation '760dff531743417d993523a150fe2f53'.
intent2 will fill slot2 slot
Your input ->  /intent2
2021-12-10 16:59:37 DEBUG    rasa.core.lock_store  - Issuing ticket for conversation '760dff531743417d993523a150fe2f53'.
2021-12-10 16:59:37 DEBUG    rasa.core.lock_store  - Acquiring lock for conversation '760dff531743417d993523a150fe2f53'.
2021-12-10 16:59:37 DEBUG    rasa.core.lock_store  - Acquired lock for conversation '760dff531743417d993523a150fe2f53'.
2021-12-10 16:59:37 DEBUG    rasa.core.tracker_store  - Recreating tracker for id '760dff531743417d993523a150fe2f53'
2021-12-10 16:59:37 DEBUG    rasa.engine.runner.dask  - Running graph with inputs: {'__message__': [<rasa.core.channels.channel.UserMessage object at 0x7fdf46cf6a30>]}, targets: ['run_RegexMessageHandler'] and ExecutionContext(model_id='a135329785a9449b91605fc10c21ffa5', should_add_diagnostic_data=False, is_finetuning=False, 
node_name=None).
2021-12-10 16:59:37 DEBUG    rasa.engine.graph  - Node 'nlu_message_converter' running 'NLUMessageConverter.convert_user_message'.
2021-12-10 16:59:37 DEBUG    rasa.engine.graph  - Node 'domain_provider' running 'DomainProvider.provide_inference'.
2021-12-10 16:59:37 DEBUG    rasa.engine.graph  - Node 'run_RegexMessageHandler' running 'RegexMessageHandler.process'.
2021-12-10 16:59:37 DEBUG    rasa.core.processor  - Received user message '/intent2' with intent '{'name': 'intent2', 'confidence': 1.0}' and entities '[]'
2021-12-10 16:59:37 DEBUG    rasa.core.processor  - Logged UserUtterance - tracker now has 19 events.        
2021-12-10 16:59:37 DEBUG    rasa.core.actions.action  - Validating extracted slots: form1_slot2
2021-12-10 16:59:37 DEBUG    rasa.core.processor  - Default action 'action_extract_slots' was executed, resulting in 1 events: SlotSet(key: form1_slot2, value: Filled)
2021-12-10 16:59:37 DEBUG    rasa.engine.runner.dask  - Running graph with inputs: {'__tracker__': <rasa.shared.core.trackers.DialogueStateTracker object at 0x7fdf465830d0>}, targets: ['select_prediction'] and ExecutionContext(model_id='a135329785a9449b91605fc10c21ffa5', should_add_diagnostic_data=False, is_finetuning=False, 
node_name=None).
2021-12-10 16:59:37 DEBUG    rasa.engine.graph  - Node 'rule_only_data_provider' running 'RuleOnlyDataProvider.provide'.
2021-12-10 16:59:37 DEBUG    rasa.engine.graph  - Node 'domain_provider' running 'DomainProvider.provide_inference'.
2021-12-10 16:59:37 DEBUG    rasa.engine.graph  - Node 'run_MemoizationPolicy0' running 'MemoizationPolicy.predict_action_probabilities'.
2021-12-10 16:59:37 DEBUG    rasa.core.policies.memoization  - Current tracker state:
[state 1] user intent: intent2 | previous action name: action_listen
2021-12-10 16:59:37 DEBUG    rasa.core.policies.memoization  - There is no memorised next action
2021-12-10 16:59:37 DEBUG    rasa.engine.graph  - Node 'run_RulePolicy1' running 'RulePolicy.predict_action_probabilities'.
2021-12-10 16:59:37 DEBUG    rasa.core.policies.rule_policy  - Current tracker state:
[state 1] user intent: form_start | previous action name: action_listen
[state 2] user intent: form_start | previous action name: form1 | active loop: {'name': 'form1'}
[state 3] user text: /intent2 | previous action name: action_listen | active loop: {'name': 'form1'}
2021-12-10 16:59:37 DEBUG    rasa.core.policies.rule_policy  - There is no applicable rule.
2021-12-10 16:59:37 DEBUG    rasa.core.policies.rule_policy  - Predicted loop 'form1'.
2021-12-10 16:59:37 DEBUG    rasa.engine.graph  - Node 'select_prediction' running 'DefaultPolicyPredictionEnsemble.combine_predictions_from_kwargs'.
2021-12-10 16:59:37 DEBUG    rasa.core.policies.ensemble  - Made prediction using user intent.
2021-12-10 16:59:37 DEBUG    rasa.core.policies.ensemble  - Added `DefinePrevUserUtteredFeaturization(False)` event.
2021-12-10 16:59:37 DEBUG    rasa.core.policies.ensemble  - Predicted next action using RulePolicy.
2021-12-10 16:59:37 DEBUG    rasa.core.processor  - Predicted next action 'form1' with confidence 1.00.      
2021-12-10 16:59:37 DEBUG    rasa.core.actions.forms  - Validating user input 'UserUttered(text: /intent2, intent: intent2, use_text_for_featurization: False)'.
2021-12-10 16:59:37 DEBUG    rasa.core.actions.forms  - Validating extracted slots: {'form1_slot2': 'Filled'}2021-12-10 16:59:37 DEBUG    rasa.core.actions.forms  - Deactivating the form 'form1'
2021-12-10 16:59:37 DEBUG    rasa.core.processor  - Policy prediction ended with events '[<rasa.shared.core.events.DefinePrevUserUtteredFeaturization object at 0x7fdf40b27850>]'.
2021-12-10 16:59:37 DEBUG    rasa.core.processor  - Action 'form1' ended with events '[<rasa.shared.core.events.SlotSet object at 0x7fdf40bb6040>, <rasa.shared.core.events.SlotSet object at 0x7fdf4657bdc0>, <rasa.shared.core.events.ActiveLoop object at 0x7fdf40b348e0>]'.
2021-12-10 16:59:37 DEBUG    rasa.core.processor  - Current slot values:
        form1_info1: None
        form1_slot1: Filled
        form1_slot2: Filled
        requested_slot: None
        session_started_metadata: None
2021-12-10 16:59:37 DEBUG    rasa.engine.runner.dask  - Running graph with inputs: {'__tracker__': <rasa.shared.core.trackers.DialogueStateTracker object at 0x7fdf465830d0>}, targets: ['select_prediction'] and ExecutionContext(model_id='a135329785a9449b91605fc10c21ffa5', should_add_diagnostic_data=False, is_finetuning=False, 
node_name=None).
2021-12-10 16:59:37 DEBUG    rasa.engine.graph  - Node 'rule_only_data_provider' running 'RuleOnlyDataProvider.provide'.
2021-12-10 16:59:37 DEBUG    rasa.engine.graph  - Node 'domain_provider' running 'DomainProvider.provide_inference'.
2021-12-10 16:59:37 DEBUG    rasa.engine.graph  - Node 'run_MemoizationPolicy0' running 'MemoizationPolicy.predict_action_probabilities'.
2021-12-10 16:59:37 DEBUG    rasa.core.policies.memoization  - Current tracker state:
[state 1] previous action name: action_listen
2021-12-10 16:59:37 DEBUG    rasa.core.policies.memoization  - There is no memorised next action
2021-12-10 16:59:37 DEBUG    rasa.engine.graph  - Node 'run_RulePolicy1' running 'RulePolicy.predict_action_probabilities'.
2021-12-10 16:59:37 DEBUG    rasa.core.policies.rule_policy  - Current tracker state:
[state 1] user intent: form_start | previous action name: action_listen
[state 2] user intent: form_start | previous action name: form1
2021-12-10 16:59:37 DEBUG    rasa.core.policies.rule_policy  - There is a rule for the next action 'utter_slots_values'.
2021-12-10 16:59:37 DEBUG    rasa.engine.graph  - Node 'select_prediction' running 'DefaultPolicyPredictionEnsemble.combine_predictions_from_kwargs'.
2021-12-10 16:59:37 DEBUG    rasa.core.policies.ensemble  - Predicted next action using RulePolicy.
2021-12-10 16:59:37 DEBUG    rasa.core.processor  - Predicted next action 'utter_slots_values' with confidence 1.00.
2021-12-10 16:59:37 DEBUG    rasa.core.processor  - Policy prediction ended with events '[]'.
2021-12-10 16:59:37 DEBUG    rasa.core.processor  - Action 'utter_slots_values' ended with events '[BotUttered('form1_slot1 is Filled, form1_slot2 is Filled, form1_info1 is None', {"elements": null, "quick_replies": null, "buttons": null, "attachment": null, "image": null, "custom": null}, {"utter_action": "utter_slots_values"}, 1639155577.4213212)]'.
2021-12-10 16:59:37 DEBUG    rasa.engine.runner.dask  - Running graph with inputs: {'__tracker__': <rasa.shared.core.trackers.DialogueStateTracker object at 0x7fdf465830d0>}, targets: ['select_prediction'] and ExecutionContext(model_id='a135329785a9449b91605fc10c21ffa5', should_add_diagnostic_data=False, is_finetuning=False, 
node_name=None).
2021-12-10 16:59:37 DEBUG    rasa.engine.graph  - Node 'rule_only_data_provider' running 'RuleOnlyDataProvider.provide'.
2021-12-10 16:59:37 DEBUG    rasa.engine.graph  - Node 'domain_provider' running 'DomainProvider.provide_inference'.
2021-12-10 16:59:37 DEBUG    rasa.engine.graph  - Node 'run_MemoizationPolicy0' running 'MemoizationPolicy.predict_action_probabilities'.
2021-12-10 16:59:37 DEBUG    rasa.core.policies.memoization  - Current tracker state:
[state 1] previous action name: action_listen
2021-12-10 16:59:37 DEBUG    rasa.core.policies.memoization  - There is no memorised next action
2021-12-10 16:59:37 DEBUG    rasa.engine.graph  - Node 'run_RulePolicy1' running 'RulePolicy.predict_action_probabilities'.
2021-12-10 16:59:37 DEBUG    rasa.core.policies.rule_policy  - Current tracker state:
[state 1] user intent: form_start | previous action name: action_listen
[state 2] user intent: form_start | previous action name: form1
[state 3] user intent: form_start | previous action name: utter_slots_values
2021-12-10 16:59:37 DEBUG    rasa.core.policies.rule_policy  - There is a rule for the next action 'action_listen'.
2021-12-10 16:59:37 DEBUG    rasa.engine.graph  - Node 'select_prediction' running 'DefaultPolicyPredictionEnsemble.combine_predictions_from_kwargs'.
2021-12-10 16:59:37 DEBUG    rasa.core.policies.ensemble  - Predicted next action using RulePolicy.
2021-12-10 16:59:37 DEBUG    rasa.core.processor  - Predicted next action 'action_listen' with confidence 1.00.
2021-12-10 16:59:37 DEBUG    rasa.core.processor  - Policy prediction ended with events '[]'.
2021-12-10 16:59:37 DEBUG    rasa.core.processor  - Action 'action_listen' ended with events '[]'.
2021-12-10 16:59:37 DEBUG    rasa.core.lock_store  - Deleted lock for conversation '760dff531743417d993523a150fe2f53'.
form1_slot1 is Filled, form1_slot2 is Filled, form1_info1 is None

Thanks.

IuliaCotaga · December 15, 2021, 8:08pm

Hello,

Any updates on this case? Is this a bug?

Thanks!

anca · December 16, 2021, 10:03am

@IuliaCotaga Apologies for the delay, I’ve been on holiday for the last week. Yes, seems quite strange that the slot doesn’t get set and could be a bug. Could you please submit a Github issue filling in this template with the issue as you described in the forum (domain file, debug log etc) ? In Projects, please select Enable Inbox, and this issue will land into my team’s inbox for prioritisation.

IuliaCotaga · December 16, 2021, 11:00am

@anca Opened Issue #10540. I did not see where to set Projects option from.

Topic		Replies	Views
Slots gets filled even if form is not active Rasa Open Source	4	471	January 25, 2022
Problem using forms Rasa Open Source	2	782	October 16, 2019
Form next requested slot incorrectly asked in Rasa 3.0, although it was removed from required slots Rasa Open Source	5	865	December 16, 2021
Forms does not fill list slot Rasa Open Source	46	2674	April 21, 2022
Don't fill "foreign" slots during form Rasa Open Source	1	243	April 26, 2021

Non-required form slot is not filled from entity when the form is active in Rasa 3.0

Related Topics