Skip to content

Instantly share code, notes, and snippets.

@floweisshardt
Created May 29, 2018 07:17
Show Gist options
  • Save floweisshardt/026ccdba0c339bdaa8cecb8703b5d9b1 to your computer and use it in GitHub Desktop.
Save floweisshardt/026ccdba0c339bdaa8cecb8703b5d9b1 to your computer and use it in GitHub Desktop.
[ INFO] [1527578145.188302091]: request_customer_intention: Accepted Goal, starting dialog to request customer intention with question Welches Produkt suchst du denn?
[ WARN] [1527578145.188517844]: MojinVoiceControlAdapterCallback_sendEventCustomerIntention: sending new event CustomerIntention to odp
[29/05/2018 09:15:45,188] INFO MojinVoiceControlAdapter - [#6600CC] Event CustomerIntention received from backend: Welches Produkt suchst du denn?
[29/05/2018 09:15:45,188] INFO IPC:Facade - Received event: CustomerIntentionEvent(747f41cf-8a3e-4c7f-aeeb-0821a9fefa6f) (from MojinVoiceControlAdapter)
[29/05/2018 09:15:45,188] INFO IPC:EventSystem - Receiver 'de.mojin.bundles.MojinVoiceControl.components.MojinVoiceControlDialogEventReceiver' handles event: CustomerIntentionEvent(747f41cf-8a3e-4c7f-aeeb-0821a9fefa6f)
[29/05/2018 09:15:45,189] INFO MojinVoiceControlEventReceiver - handleEvent: CustomerIntentionEvent
[29/05/2018 09:15:45,189] INFO IPC:Facade - Received service request: PresentEvent(a8fe284a-4a17-42c7-b04a-5892f60766cf) (from MojinVoiceControlEventReceiver)
[29/05/2018 09:15:45,189] INFO IPC:ServiceInvoker - Service 'de.semvox.SQUINT' handles request: PRESENT_EVENT=PresentEvent(a8fe284a-4a17-42c7-b04a-5892f60766cf)
[29/05/2018 09:15:45,189] INFO DM:Pipeline - [#66FF66]**** INPUT: PresentEvent(Interruptive, CustomerIntentionEvent)
[29/05/2018 09:15:45,189] INFO DM:InteractionManager - [#4DFFFF][on-interrupted] if available: reset action schedule & history turn cache
[29/05/2018 09:15:45,189] INFO DM:DialogState - [#E7D1A2]DialogIdle -> SystemTurnActive
[29/05/2018 09:15:45,189] INFO IPC:ServiceInvoker - Response from 'de.semvox.SQUINT': StatusAccepted, PresentEvent(a8fe284a-4a17-42c7-b04a-5892f60766cf)
[29/05/2018 09:15:45,189] INFO DM:DialogState - [#E7D1A2]>>>>> CALL: beforeDialogStarted(false)
[29/05/2018 09:15:45,189] INFO DM:DialogState - [#E7D1A2]>>>>> RESPONSE: beforeDialogStarted() = StatusSuccess
[29/05/2018 09:15:45,189] INFO DM:HistoryLimiter - [#99FF99]limiting history
[29/05/2018 09:15:45,189] INFO DM:HistoryLimiter - [#F1E5CA][history-limiter] removing 1 of 31 interactions (maxTurns: 30)
[29/05/2018 09:15:45,189] INFO DM:InteractionHistory - [#E7D1A2][on-dialog-state-changed] init new interaction object with id '6f73286c-6f85-4936-abf1-0354c0ee0cef' (based on dialog state: SystemTurnActive(6f73286c-6f85-4936-abf1-0354c0ee0cef))
[29/05/2018 09:15:45,189] INFO IPC:Facade - Received event: DialogStarted(428595f5-473e-4c35-8692-ca6a86f83cb2) (from de.semvox.SQUINT)
[29/05/2018 09:15:45,190] INFO IPC:EventSystem - Receiver 'de.mojin.bundles.MojinVoiceControl.components.MojinVoiceControlDialogEventReceiver' handles event: DialogStarted(428595f5-473e-4c35-8692-ca6a86f83cb2)
[29/05/2018 09:15:45,190] INFO IPC:Facade - Received event: SystemTurnStarted(d0820a7e-8d2a-4fb2-b03a-c30f215f7f53) (from de.semvox.SQUINT)
[29/05/2018 09:15:45,199] INFO MojinVoiceControlEventReceiver - handleEvent: DialogStarted
[29/05/2018 09:15:45,199] INFO IPC:EventSystem - Receiver 'de.mojin.bundles.MojinVoiceControl.components.MojinVoiceControlDialogEventReceiver' handles event: SystemTurnStarted(d0820a7e-8d2a-4fb2-b03a-c30f215f7f53)
[29/05/2018 09:15:45,199] INFO MojinVoiceControlEventReceiver - handleEvent: SystemTurnStarted
[29/05/2018 09:15:45,199] INFO DM:InteractionManager - [#4DFFFF]===== START: Process event 'CustomerIntentionEvent'
[29/05/2018 09:15:45,200] INFO DM:InteractionManager - [#B3FFFF][process-presentable-event] select event definition 'CUSTOMER_INTENTION_EVENT'
[29/05/2018 09:15:45,200] INFO IPC:Facade - Received event: ActivatedPresentableEvent(17449f39-0c47-4af4-a1b6-b7da57ef769f) (from de.semvox.SQUINT)
[29/05/2018 09:15:45,200] INFO DM:InteractionManager - [#B3FFFF][process-presentable-event] last speech output took place at '1527578144188' /current time is '1527578145200' / gap is '1012'
[29/05/2018 09:15:45,200] INFO DM:ScheduleExecutor - [#4DFFFF][execute] schedule size is: 1
[29/05/2018 09:15:45,200] INFO DM:ScheduleExecutor - [#4DFFFF][execute] TaskRequestAction(UnexpectedNewTaskMatch(RequestTask(CustomerIntentionRequest)))
[29/05/2018 09:15:45,200] INFO DM:TaskProcessor - [#4DFFFF]===== START: [build-action-schedule] input UnexpectedNewTaskMatch(RequestTask(CustomerIntentionRequest))
[29/05/2018 09:15:45,200] INFO DM:TaskModelHandler - [#B3FFFF][evaluate task] select task definition for task CustomerIntentionRequest
[29/05/2018 09:15:45,200] INFO DM:TaskModelHandler - [#B3FFFF][evaluate task] selected task definition with name 'CUSTOMER_INTENTION_TASK' (processing took 0 ms)
[29/05/2018 09:15:45,200] INFO IPC:Facade - Received event: TaskStarted(a65e6189-3d65-49fe-986e-2be7f048ee09) (from de.semvox.SQUINT)
[29/05/2018 09:15:45,201] INFO IPC:EventSystem - Receiver 'de.mojin.bundles.MojinVoiceControl.components.MojinVoiceControlDialogEventReceiver' handles event: TaskStarted(a65e6189-3d65-49fe-986e-2be7f048ee09)
[29/05/2018 09:15:45,201] INFO MojinVoiceControlEventReceiver - handleEvent: TaskStarted
[29/05/2018 09:15:45,201] INFO DM:TaskProcessor - [#4DFFFF][established-scheduling-advice]: ScheduleTaskStateBuilding(CUSTOMER_INTENTION_TASK)
[29/05/2018 09:15:45,201] INFO MojinVoiceControlEventReceiver - EVENT_INFO TaskStarted: CustomerIntentionRequest
[29/05/2018 09:15:45,201] INFO DM:TaskProcessor - [#4DFFFF][build-slot-state] (system|task) slot 'BOOLEAN_BINDING' is POSSIBLE
[29/05/2018 09:15:45,201] INFO DM:TaskProcessor - [#B3FFFF][build-task-state] number of new filled slots: 0
[29/05/2018 09:15:45,201] INFO DM:TaskProcessor - [#B3FFFF][build-task-state] number of groundable slots: 0
[29/05/2018 09:15:45,201] INFO DM:TaskProcessor - [#B3FFFF][build-task-state] number of invalid slots: 0
[29/05/2018 09:15:45,201] INFO DM:TaskProcessor - [#4DFFFF][build-task-state] number of preset-slots: 0
[29/05/2018 09:15:45,201] INFO DM:TaskProcessor - [#B3FFFF][build-task-state] task is completed: false
[29/05/2018 09:15:45,201] INFO DM:TaskProcessor - [#4DFFFF][selected-task-completion-strategy] ScheduleFocusedSlotHandling
[29/05/2018 09:15:45,201] INFO DM:TaskModelHandler - [#B3FFFF][evaluate task] select task definition for task OfferDecisionRequest
[29/05/2018 09:15:45,202] INFO DM:TaskModelHandler - [#B3FFFF][evaluate task] selected task definition with name 'OFFER_DECISION_TASK' (processing took 0 ms)
[29/05/2018 09:15:45,202] INFO DM:TaskModelHandler - [#B3FFFF][evaluate task] select task definition for task OfferProductSearchRequest
[29/05/2018 09:15:45,202] INFO DM:TaskModelHandler - [#B3FFFF][evaluate task] selected task definition with name 'OFFER_PRODUCT_SEARCH_TASK' (processing took 0 ms)
[29/05/2018 09:15:45,202] INFO DM:TaskModelHandler - [#B3FFFF][evaluate task] select task definition for task OfferFreetextRequest
[29/05/2018 09:15:45,202] INFO DM:TaskModelHandler - [#B3FFFF][evaluate task] selected task definition with name 'OFFER_FREETEXT_TASK' (processing took 0 ms)
[29/05/2018 09:15:45,202] INFO DM:TaskModelHandler - [#B3FFFF][evaluate task] select task definition for task OfferServiceLocationRequest
[29/05/2018 09:15:45,203] INFO DM:TaskModelHandler - [#B3FFFF][evaluate task] selected task definition with name 'OFFER_SERVICE_LOCATION_TASK' (processing took 0 ms)
[29/05/2018 09:15:45,203] INFO DM:TaskProcessor - [#B3FFFF][focused-slot-handling] schedule task slot filling (BOOLEAN_BINDING)
[29/05/2018 09:15:45,203] INFO DM:InteractionManager - [#4DFFFF]===== START: [create-expectation] start for act: OfferTask(OfferDecisionRequest OfferProductSearchRequest OfferFreetextRequest OfferServiceLocationRequest) (tcs-based)
[29/05/2018 09:15:45,203] INFO DM:InteractionManager - [#B3FFFF][new-expectation] use template activation (selector is '<null>') for act 'OfferTask(OfferDecisionRequest OfferProductSearchRequest OfferFreetextRequest OfferServiceLocationRequest)'
[29/05/2018 09:15:45,203] INFO DM:InteractionManager - [#B3FFFF][new-expectation] act OfferTask(OfferDecisionRequest OfferProductSearchRequest OfferFreetextRequest OfferServiceLocationRequest) is based on subsequent reaction: false
[29/05/2018 09:15:45,203] INFO DM:InteractionManager - [#4DFFFF][new-expectation] activate-tasks defined by executable-task definition CUSTOMER_INTENTION_TASK
[29/05/2018 09:15:45,203] INFO DM:InteractionManager - [#4DFFFF]===== END: [new-expectation] creation took 0 ms
[29/05/2018 09:15:45,204] INFO IPC:Facade - Received event: TaskSuspended(6b3c87f4-8933-439d-ae1e-7ae9c6c0b008) (from de.semvox.SQUINT)
[29/05/2018 09:15:45,204] INFO IPC:EventSystem - Receiver 'de.mojin.bundles.MojinVoiceControl.components.MojinVoiceControlDialogEventReceiver' handles event: TaskSuspended(6b3c87f4-8933-439d-ae1e-7ae9c6c0b008)
[29/05/2018 09:15:45,204] INFO MojinVoiceControlEventReceiver - handleEvent: TaskSuspended
[29/05/2018 09:15:45,204] INFO MojinVoiceControlEventReceiver - EVENT_INFO TaskSuspended: CustomerIntentionRequest
[29/05/2018 09:15:45,204] INFO DM:TaskProcessor - [#4DFFFF]===== END: [build-action-schedule] took 4 ms
[29/05/2018 09:15:45,204] INFO DM:InteractionManager - [#4DFFFF][on-result] schedule-execution-result is: UpdateSchedule
[29/05/2018 09:15:45,204] INFO DM:ScheduleExecutor - [#4DFFFF][execute] schedule size is: 1
[29/05/2018 09:15:45,204] INFO DM:ScheduleExecutor - [#4DFFFF][execute] OutputActions(OfferTask(OfferDecisionRequest OfferProductSearchRequest OfferFreetextRequest OfferServiceLocationRequest))
[29/05/2018 09:15:45,204] INFO DM:InteractionManager - [#4DFFFF][on-result] schedule-execution-result is: Wait
[29/05/2018 09:15:45,205] INFO DM:TaskModelHandler - [#B3FFFF][evaluate task] select task definition for task OfferDecisionRequest
[29/05/2018 09:15:45,205] INFO DM:TaskModelHandler - [#B3FFFF][evaluate task] selected task definition with name 'OFFER_DECISION_TASK' (processing took 0 ms)
[29/05/2018 09:15:45,205] INFO DM:TaskModelHandler - [#B3FFFF][evaluate task] select task definition for task OfferProductSearchRequest
[29/05/2018 09:15:45,205] INFO DM:TaskModelHandler - [#B3FFFF][evaluate task] selected task definition with name 'OFFER_PRODUCT_SEARCH_TASK' (processing took 0 ms)
[29/05/2018 09:15:45,205] INFO DM:TaskModelHandler - [#B3FFFF][evaluate task] select task definition for task OfferFreetextRequest
[29/05/2018 09:15:45,205] INFO DM:TaskModelHandler - [#B3FFFF][evaluate task] selected task definition with name 'OFFER_FREETEXT_TASK' (processing took 0 ms)
[29/05/2018 09:15:45,205] INFO DM:TaskModelHandler - [#B3FFFF][evaluate task] select task definition for task OfferServiceLocationRequest
[29/05/2018 09:15:45,206] INFO DM:TaskModelHandler - [#B3FFFF][evaluate task] selected task definition with name 'OFFER_SERVICE_LOCATION_TASK' (processing took 0 ms)
[29/05/2018 09:15:45,206] INFO DM:InteractionManager - [#4DFFFF]===== START: [create-expectation] start for act: OfferTask(OfferDecisionRequest OfferProductSearchRequest OfferFreetextRequest OfferServiceLocationRequest) (state-based)
[29/05/2018 09:15:45,206] INFO DM:InteractionManager - [#B3FFFF][new-expectation] use template activation (selector is '<null>') for act 'OfferTask(OfferDecisionRequest OfferProductSearchRequest OfferFreetextRequest OfferServiceLocationRequest)'
[29/05/2018 09:15:45,206] INFO DM:InteractionManager - [#B3FFFF][new-expectation] act OfferTask(OfferDecisionRequest OfferProductSearchRequest OfferFreetextRequest OfferServiceLocationRequest) is based on subsequent reaction: false
[29/05/2018 09:15:45,206] INFO DM:InteractionManager - [#4DFFFF][new-expectation] activate-tasks defined by executable-task definition CUSTOMER_INTENTION_TASK
[29/05/2018 09:15:45,206] INFO DM:InteractionManager - [#4DFFFF]===== END: [new-expectation] creation took 0 ms
[29/05/2018 09:15:45,206] INFO DM:InteractionHistory - [#E7D1A2][process-expectations] number of expectations: 1
[29/05/2018 09:15:45,206] INFO DM:InteractionHistory - [#E7D1A2][process-expectations] fragment 1: adding/replacing expected acts: 8
[29/05/2018 09:15:45,206] INFO DM:InteractionHistory - [#E7D1A2][process-expectations] fragment 1: --> expected acts: RequestTask(OfferDecisionRequest)
[29/05/2018 09:15:45,206] INFO DM:InteractionHistory - [#E7D1A2][process-expectations] fragment 1: --> expected acts: RequestTask(OfferProductSearchRequest)
[29/05/2018 09:15:45,206] INFO DM:InteractionHistory - [#E7D1A2][process-expectations] fragment 1: --> expected acts: RequestTask(OfferFreetextRequest)
[29/05/2018 09:15:45,207] INFO DM:InteractionHistory - [#E7D1A2][process-expectations] fragment 1: --> expected acts: RequestTask(OfferServiceLocationRequest)
[29/05/2018 09:15:45,207] INFO DM:InteractionHistory - [#E7D1A2][process-expectations] fragment 1: --> expected acts: RejectOffer(OfferDecisionRequest)
[29/05/2018 09:15:45,207] INFO DM:InteractionHistory - [#E7D1A2][process-expectations] fragment 1: --> expected acts: Cancel(CustomerIntentionRequest)
[29/05/2018 09:15:45,207] INFO DM:InteractionHistory - [#E7D1A2][process-expectations] fragment 1: --> expected acts: RequestTask(SmallTalkRequest)
[29/05/2018 09:15:45,207] INFO DM:InteractionHistory - [#E7D1A2][process-expectations] fragment 1: --> expected acts: RequestTask(SmallTalkRequest)
[29/05/2018 09:15:45,207] INFO DM:InteractionHistory - [#E7D1A2][process-expectations] fragment 1: defines task offering
[29/05/2018 09:15:45,207] INFO DM:PresentationManager - [#D47DD4][present-output] got 1 jobs to process
[29/05/2018 09:15:45,207] INFO IPC:Facade - Received service request: GenerateOutput(a8378959-8ed0-4aad-ae3f-56f812f10494) (from de.semvox.SQUINT)
[29/05/2018 09:15:45,207] INFO IPC:ServiceInvoker - Service 'de.semvox.SPIT' handles request: GENERATE=GenerateOutput(a8378959-8ed0-4aad-ae3f-56f812f10494)
[29/05/2018 09:15:45,207] INFO NLG:TemplateEngine - Applying template: Inform#OfferTask_CustomerIntention
[29/05/2018 09:15:45,207] INFO IPC:ServiceInvoker - Response from 'de.semvox.SPIT': StatusSuccess, GenerateOutput(a8378959-8ed0-4aad-ae3f-56f812f10494)
[29/05/2018 09:15:45,207] INFO DM:GrammarActivationHandler - [#4DFFFF][get-grammar-directive] incorporating default yes/no-grammar
[29/05/2018 09:15:45,208] INFO DM:PresentationManager - [#E0A3E0][on-output-generated] do non-speech-output step-by-step
[29/05/2018 09:15:45,208] INFO DM:PresentationManager - [#E0A3E0][on-output-generated] updated jobs after postprocessing: 1
[29/05/2018 09:15:45,208] INFO DM:PresentationManager - [#E0A3E0][on-output-generated] initiate rendering of 'non-speech' OutputAction(s)
[29/05/2018 09:15:45,208] INFO DM:PresentationManager - [#E0A3E0][on-output-generated] handling result of compound template. processing 2 rendering actions (speech and non-speech).
[29/05/2018 09:15:45,208] INFO DM:PresentationManager - [#E0A3E0][on-output-generated] first presentation action is DoOutput. Adding GrammarActivationAction afterwards
[29/05/2018 09:15:45,208] INFO DM:PresentationManager - [#E0A3E0][present-output] start processing jobs...
[29/05/2018 09:15:45,208] INFO DM:PresentationManager - [#D47DD4]***** OUTPUT: NonSpeech > de.mojin.bundles.MojinVoiceControl.components.MojinVoiceControlOutputHandler
[29/05/2018 09:15:45,208] INFO DM:TaskProcessor - [#B3FFFF]>>>> CALL: do-output (de.mojin.bundles.MojinVoiceControl.components.MojinVoiceControlOutputHandler)
[29/05/2018 09:15:45,208] INFO IPC:Facade - Received service request: DoOutput(97273236-c3ef-4563-9df4-ccff2aedb7e0) (from de.semvox.SQUINT)
[29/05/2018 09:15:45,208] INFO IPC:ServiceInvoker - Service 'de.semvox.OutputService' handles request: DO_OUTPUT=DoOutput(97273236-c3ef-4563-9df4-ccff2aedb7e0)
[29/05/2018 09:15:45,208] INFO MojinVoiceControlOutputHandler - [#0000FF] handleOutput: feedback - [OfferTask_CustomerIntention]
[29/05/2018 09:15:45,208] INFO MojinVoiceControlAdapter - [#0000FF] sendFeedbackIntentionRequest to backend: 0 | [OfferTask_CustomerIntention]
[ WARN] [1527578145.208765277]: MojinVoiceControlAdapter_nativeRosSendIntentionFeedback: Received IntentionFeedback from odp
[ INFO] [1527578145.208801940]: Intention Feedback Received: 0, [OfferTask_CustomerIntention].
[29/05/2018 09:15:45,208] INFO MojinVoiceControlAdapter - returned 1
[29/05/2018 09:15:45,208] INFO IPC:ServiceInvoker - Response from 'de.semvox.OutputService': StatusSuccess, DoOutput(97273236-c3ef-4563-9df4-ccff2aedb7e0)
[29/05/2018 09:15:45,208] INFO DM:TaskProcessor - [#B3FFFF]>>>> RESPONSE: do-output (de.mojin.bundles.MojinVoiceControl.components.MojinVoiceControlOutputHandler, StatusSuccess)
[29/05/2018 09:15:45,209] INFO IPC:Facade - Received service request: SelectGrammars(ca0a3fc8-70ce-4c09-993d-4c4ac2aac0c4) (from de.semvox.SQUINT)
[29/05/2018 09:15:45,209] INFO IPC:ServiceInvoker - Service 'de.semvox.SPIJK' handles request: SELECT_GRAMMARS=SelectGrammars(ca0a3fc8-70ce-4c09-993d-4c4ac2aac0c4)
[29/05/2018 09:15:45,209] INFO IPC:ServiceInvoker - Response from 'de.semvox.SPIJK': StatusSuccess, SelectGrammars(ca0a3fc8-70ce-4c09-993d-4c4ac2aac0c4)
[29/05/2018 09:15:45,209] INFO DM:GrammarManager - [#E7D1A2]Activating grammars: [SmallTalkGrammarCommon, OfferServiceLocationGrammar, YesNoGrammar, OfferDecisionGrammar, OfferProductSearchGrammar, SmallTalkGrammarMSH]
[29/05/2018 09:15:45,209] INFO IPC:Facade - Received service request: ActivateGrammars(85a288e5-fb73-4f0f-ab4b-4480ec2c20fe) (from de.semvox.SQUINT)
[29/05/2018 09:15:45,209] INFO IPC:ServiceInvoker - Service 'de.semvox.ASR' handles request: ACTIVATE_GRAMMARS=ActivateGrammars(85a288e5-fb73-4f0f-ab4b-4480ec2c20fe)
[29/05/2018 09:15:45,209] INFO IPC:ServiceInvoker - Response from 'de.semvox.ASR': StatusAccepted, ActivateGrammars(85a288e5-fb73-4f0f-ab4b-4480ec2c20fe)
[29/05/2018 09:15:45,209] INFO DM:PresentationManager - [#D47DD4]***** OUTPUT: Speech > SSML(de-DE, "Welches Produkt suchst du denn?") from (Inform#OfferTask_CustomerIntention, N/A)
[29/05/2018 09:15:45,209] INFO DM:PresentationManager - [#D47DD4]>>>>> CALL: TTS
[29/05/2018 09:15:45,209] INFO IPC:Facade - Received service request: StartSpeaking(b145e669-440b-4824-b635-3634b7348828) (from de.semvox.SQUINT)
[29/05/2018 09:15:45,210] INFO IPC:ServiceInvoker - Service 'de.semvox.TTS' handles request: START_SPEAKING=StartSpeaking(b145e669-440b-4824-b635-3634b7348828)
[29/05/2018 09:15:45,210] INFO IPC:ServiceInvoker - Response from 'de.semvox.TTS': StatusAccepted, StartSpeaking(b145e669-440b-4824-b635-3634b7348828)
[29/05/2018 09:15:45,217] INFO SAC:PA - Activate realtime scheduling
[29/05/2018 09:15:45,217] INFO SAC:PA - Output audio device opened
[29/05/2018 09:15:45,217] INFO TTS:Vocalizer - Audio device opened
[29/05/2018 09:15:45,221] INFO SAC:PA - Audio device started
[29/05/2018 09:15:45,221] INFO TTS:Vocalizer - Audio device started
[29/05/2018 09:15:45,221] INFO TTS:Vocalizer - Process START
[29/05/2018 09:15:45,221] INFO IPC:Facade - Received event: VoiceOutputStarted(c027fc58-f184-460e-be95-07fb7105990c) (from de.semvox.TTS)
[29/05/2018 09:15:45,221] INFO IPC:EventSystem - Receiver 'de.semvox.AudioReceiver' handles event: VoiceOutputStarted(c027fc58-f184-460e-be95-07fb7105990c)
[29/05/2018 09:15:45,221] INFO IPC:EventSystem - Receiver 'de.mojin.bundles.MojinVoiceControl.components.MojinVoiceControlDialogEventReceiver' handles event: VoiceOutputStarted(c027fc58-f184-460e-be95-07fb7105990c)
[29/05/2018 09:15:45,221] INFO MojinVoiceControlEventReceiver - handleEvent: VoiceOutputStarted
[29/05/2018 09:15:45,221] INFO IPC:EventSystem - Receiver 'de.semvox.SQUINT' handles event: VoiceOutputStarted(c027fc58-f184-460e-be95-07fb7105990c)
[29/05/2018 09:15:45,221] INFO DM:Pipeline - [#66FF66]**** INPUT: VoiceOutputStarted
[29/05/2018 09:15:45,221] INFO DM:InteractionHistory - [#E7D1A2][on-rendering-started] assumed as rendered: OfferTask(OfferDecisionRequest OfferProductSearchRequest OfferFreetextRequest OfferServiceLocationRequest)
[29/05/2018 09:15:45,712] INFO TTS:Vocalizer - Process DONE
[29/05/2018 09:15:47,073] INFO SAC:PA - Audio device stopped
[29/05/2018 09:15:47,073] INFO TTS:Vocalizer - Audio device stopped
[29/05/2018 09:15:47,074] INFO SAC:PA - Audio device closed
[29/05/2018 09:15:47,074] INFO TTS:Vocalizer - Audio device closed
[29/05/2018 09:15:47,074] INFO IPC:Facade - Received event: VoiceOutputFinished(56f5ca89-1b99-4fd7-9948-933f362f4ab2) (from de.semvox.TTS)
[29/05/2018 09:15:47,074] INFO IPC:EventSystem - Receiver 'de.mojin.bundles.MojinVoiceControl.components.MojinVoiceControlDialogEventReceiver' handles event: VoiceOutputFinished(56f5ca89-1b99-4fd7-9948-933f362f4ab2)
[29/05/2018 09:15:47,074] INFO MojinVoiceControlEventReceiver - handleEvent: VoiceOutputFinished
[29/05/2018 09:15:47,074] INFO IPC:EventSystem - Receiver 'de.semvox.AudioReceiver' handles event: VoiceOutputFinished(56f5ca89-1b99-4fd7-9948-933f362f4ab2)
[29/05/2018 09:15:47,074] INFO MojinVoiceControlBeepStrategy - [#0000FF] TIMING: onSpeakingStopped
[29/05/2018 09:15:47,074] INFO IPC:EventSystem - Receiver 'de.semvox.SQUINT' handles event: VoiceOutputFinished(56f5ca89-1b99-4fd7-9948-933f362f4ab2)
[29/05/2018 09:15:47,075] INFO DM:Pipeline - [#66FF66]**** INPUT: VoiceOutputFinished
[29/05/2018 09:15:47,075] INFO DM:PresentationManager - [#D47DD4]>>>>> RESPONSE: TTS = VoiceOutputFinished
[29/05/2018 09:15:47,075] INFO DM:ScheduleExecutor - [#B3FFFF][callback] on-output-processed (activate-asr:true, proposed-asr-activation:true)
[29/05/2018 09:15:47,075] INFO DM:ScheduleExecutor - [#B3FFFF][get-final-result] result: ActivateAsr)
[29/05/2018 09:15:47,075] INFO DM:InteractionManager - [#4DFFFF][on-result] schedule-execution-result is: ActivateAsr
[29/05/2018 09:15:47,075] INFO DM:DialogState - [#E7D1A2]SystemTurnActive -> UserTurnActive
[29/05/2018 09:15:47,075] INFO DM:InteractionHistory - [#ECDBB6][on-dialog-state-changed] current dialog costs for active dialog are 0 user turns
[29/05/2018 09:15:47,075] INFO IPC:Facade - Received event: SystemTurnFinished(65deca8b-06d3-4896-9870-c96e58ea54ff) (from de.semvox.SQUINT)
[29/05/2018 09:15:47,075] INFO IPC:EventSystem - Receiver 'de.mojin.bundles.MojinVoiceControl.components.MojinVoiceControlDialogEventReceiver' handles event: SystemTurnFinished(65deca8b-06d3-4896-9870-c96e58ea54ff)
[29/05/2018 09:15:47,075] INFO MojinVoiceControlEventReceiver - handleEvent: SystemTurnFinished
[29/05/2018 09:15:47,075] INFO IPC:Facade - Received event: UserTurnStarted(90d01288-16a5-49b8-bd32-122586efb5dd) (from de.semvox.SQUINT)
[29/05/2018 09:15:47,076] INFO IPC:EventSystem - Receiver 'de.mojin.bundles.MojinVoiceControl.components.MojinVoiceControlDialogEventReceiver' handles event: UserTurnStarted(90d01288-16a5-49b8-bd32-122586efb5dd)
[29/05/2018 09:15:47,076] INFO DM:RecognitionState - [#ECDBB6]Idle -> Started
[29/05/2018 09:15:47,076] INFO MojinVoiceControlEventReceiver - handleEvent: UserTurnStarted
[29/05/2018 09:15:47,076] INFO DM:Arbiter - [#33FF33][asr-arbiter] onInit: arbiter mode: NORMAL
[29/05/2018 09:15:47,076] INFO DM:Arbiter - [#99FF99][incremental-recognition] setting as 'Pending': OnboardRecognition
[29/05/2018 09:15:47,076] INFO DM:Arbiter - [#99FF99][incremental-recognition] setting OnboardRecognition to 'Pending'
[29/05/2018 09:15:47,076] INFO DM:Arbiter - [#99FF99][incremental-recognition] setting as 'Pending': OnlineRecognition
[29/05/2018 09:15:47,076] INFO DM:Arbiter - [#99FF99][incremental-recognition] setting OnlineRecognition to 'Pending'
[29/05/2018 09:15:47,076] INFO DM:DoIncrementalSpeechInput - [#33FF33]===== START: [incremental-recognition] incremental recognition...
[29/05/2018 09:15:47,076] INFO DM:DoIncrementalSpeechInput - [#D47DD4]>>>>> CALL: ASR
[29/05/2018 09:15:47,076] INFO IPC:Facade - Received service request: StartRecognition(a2d74775-5e3d-4604-9750-7fa0920e8345) (from de.semvox.SQUINT)
[29/05/2018 09:15:47,076] INFO IPC:ServiceInvoker - Service 'de.semvox.ASR' handles request: START_RECOGNITION=StartRecognition(a2d74775-5e3d-4604-9750-7fa0920e8345)
[29/05/2018 09:15:47,076] INFO IPC:ServiceInvoker - Response from 'de.semvox.ASR': StatusAccepted, StartRecognition(a2d74775-5e3d-4604-9750-7fa0920e8345)
[29/05/2018 09:15:47,076] INFO DM:DoIncrementalSpeechInput - [#99FF99][incremental-recognition] Waiting for incremental recognition results (count=0, id=824fa6ec-e2b6-442f-ab7c-565d4acd7f7b)...
[29/05/2018 09:15:47,276] INFO ASR:AsrBridge - onNmspConnected()
[29/05/2018 09:15:47,276] INFO MojinVoiceControlBeepStrategy - [#0000FF] TIMING: onPrepareRecognition - time since onSpeakingStopped: 202
[29/05/2018 09:15:47,277] INFO MojinVoiceControlBeepStrategy - [#0000FF] TIMING: onPrepareRecognition - beep duration: 1
[29/05/2018 09:15:47,293] INFO SAC:PA - Activate realtime scheduling
[29/05/2018 09:15:47,293] INFO SAC:PA - Input audio device opened
[29/05/2018 09:15:47,293] INFO ASR:VoCon - Audio device opened
[29/05/2018 09:15:47,298] INFO SAC:PA - Audio device started
[29/05/2018 09:15:47,299] INFO ASR:VoCon - Audio device started
[29/05/2018 09:15:47,299] INFO IPC:Facade - Received event: RecognitionStarted(223c9950-6c8c-447f-b9d3-fa1b61503789) (from de.semvox.ASR)
[29/05/2018 09:15:47,300] INFO IPC:EventSystem - Receiver 'de.semvox.SQUINT' handles event: RecognitionStarted(223c9950-6c8c-447f-b9d3-fa1b61503789)
[29/05/2018 09:15:47,300] INFO IPC:EventSystem - Receiver 'de.semvox.AudioReceiver' handles event: RecognitionStarted(223c9950-6c8c-447f-b9d3-fa1b61503789)
[29/05/2018 09:15:47,300] INFO MojinVoiceControlBeepStrategy - [#0000FF] TIMING: onListeningStarted: (Mic is open) - time since onPrepareRecognition: 24
[29/05/2018 09:15:47,300] INFO IPC:EventSystem - Receiver 'de.mojin.bundles.MojinVoiceControl.components.MojinVoiceControlDialogEventReceiver' handles event: RecognitionStarted(223c9950-6c8c-447f-b9d3-fa1b61503789)
[29/05/2018 09:15:47,301] INFO MojinVoiceControlEventReceiver - handleEvent: RecognitionStarted
[29/05/2018 09:15:48,412] INFO IPC:Facade - Received event: StartOfSpeech(81962e99-febb-4fd4-b068-5f234efe1620) (from de.semvox.ASR)
[29/05/2018 09:15:48,412] INFO IPC:EventSystem - Receiver 'de.mojin.bundles.MojinVoiceControl.components.MojinVoiceControlDialogEventReceiver' handles event: StartOfSpeech(81962e99-febb-4fd4-b068-5f234efe1620)
[29/05/2018 09:15:48,412] INFO MojinVoiceControlEventReceiver - handleEvent: StartOfSpeech
[29/05/2018 09:15:48,412] INFO IPC:EventSystem - Receiver 'de.semvox.AudioReceiver' handles event: StartOfSpeech(81962e99-febb-4fd4-b068-5f234efe1620)
[29/05/2018 09:15:48,412] INFO IPC:EventSystem - Receiver 'de.semvox.SQUINT' handles event: StartOfSpeech(81962e99-febb-4fd4-b068-5f234efe1620)
[29/05/2018 09:15:48,412] INFO DM:Pipeline - [#66FF66]**** INPUT: StartOfSpeech (824fa6ec-e2b6-442f-ab7c-565d4acd7f7b)
[29/05/2018 09:15:48,414] INFO DM:RecognitionState - [#ECDBB6]Started -> Recognizing
#
# A fatal error has been detected by the Java Runtime Environment:
#
# SIGSEGV (0xb) at pc=0x00007fa6c5343fe1, pid=13172, tid=0x00007fa6bd4a0700
#
# JRE version: OpenJDK Runtime Environment (8.0_171-b11) (build 1.8.0_171-8u171-b11-0ubuntu0.16.04.1-b11)
# Java VM: OpenJDK 64-Bit Server VM (25.171-b11 mixed mode linux-amd64 compressed oops)
# Problematic frame:
# C [libvocon_nmsp_core.so+0x3fe1] get_sequence_value+0x31
#
# Failed to write core dump. Core dumps have been disabled. To enable core dumping, try "ulimit -c unlimited" before starting Java again
#
# An error report file with more information is saved as:
# /home/fmw/git/mojin_ws/devel/share/mojin_voice_control_standalone/mojin_voice_control_standalone/target/runtime/hs_err_pid13172.log
#
# If you would like to submit a bug report, please visit:
# http://bugreport.java.com/bugreport/crash.jsp
#
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment