MATRIX VOICE / Failed to create SampleApplication

Jang · April 16, 2018, 1:51am

Hi EveryOne

I’m not good at english, Please Understand

I am following the instructions on the link below
https://github.com/alexa/avs-device-sdk/wiki/Raspberry-Pi-Quick-Start-Guide-with-Script

but I was in trouble at “sudo bash startsample.sh” command

please look at log below

--------------------------------------------------------------------------------------------
pi@raspberrypi:~ $ sudo bash startsample.sh
2018-04-16 01:27:45.852 [  1] I sdkVersion: 1.6.0
Running app with log level: DEBUG9
2018-04-16 01:27:46.049 [  1] 0 ConfigurationNode:initializeSuccess
2018-04-16 01:27:46.065 [  1] 9 MediaPlayer:createCalled
2018-04-16 01:27:46.270 [  1] 9 MediaPlayer:noOutputConversion
2018-04-16 01:27:46.273 [  1] 9 MediaPlayer:createCalled
2018-04-16 01:27:46.274 [  1] 9 MediaPlayer:noOutputConversion
2018-04-16 01:27:46.276 [  1] 9 MediaPlayer:createCalled
2018-04-16 01:27:46.277 [  1] 9 MediaPlayer:noOutputConversion
2018-04-16 01:27:46.279 [  1] 9 MediaPlayer:createCalled
2018-04-16 01:27:46.279 [  1] 9 MediaPlayer:noOutputConversion
2018-04-16 01:27:46.328 [  1] 9 MediaPlayer:setObserverCalled
2018-04-16 01:27:46.329 [  2] 0 MediaPlayer:handleSetObserverCalled
2018-04-16 01:27:46.329 [  1] 9 SpeechSynthesizer:addObserver:observer=0x19adfac
2018-04-16 01:27:46.330 [  1] 9 PlaybackRouter:create::called
2018-04-16 01:27:46.332 [  1] 9 MediaPlayer:setObserverCalled
2018-04-16 01:27:46.332 [  2] 0 MediaPlayer:handleSetObserverCalled
2018-04-16 01:27:46.332 [  1] 9 MediaPlayer:setObserverCalled
2018-04-16 01:27:46.333 [  2] 0 MediaPlayer:handleSetObserverCalled
2018-04-16 01:27:46.355 [  1] 9 AlertScheduler:setTimerForNextAlertLocked
2018-04-16 01:27:46.355 [  1] 9 AlertScheduler:executeScheduleNextAlertForRendering::no work to do.
2018-04-16 01:27:46.358 [  1] 5 NotificationsRenderer:create
2018-04-16 01:27:46.358 [  3] 1 AlertsCapabilityAgent:executeOnConnectionStatusChanged:status=DISCONNECTED,reason=ACL_CLIENT_REQUEST
2018-04-16 01:27:46.358 [  1] 9 MediaPlayer:setObserverCalled
2018-04-16 01:27:46.359 [  2] 0 MediaPlayer:handleSetObserverCalled
2018-04-16 01:27:46.362 [  1] 5 NotificationsCapabilityAgent:init
2018-04-16 01:27:46.362 [  1] 5 NotificationsRenderer:addObserver
2018-04-16 01:27:46.370 [  4] 5 NotificationsCapabilityAgent:executeInit
2018-04-16 01:27:46.371 [  4] 0 NotificationsCapabilityAgent:notifyObservers:indicatorState=0
2018-04-16 01:27:46.372 [  4] 5 NotificationsCapabilityAgent:executeProvideState:sendToken=false,stateRequestToken=0
2018-04-16 01:27:46.374 [  4] 0 ContextManager:updateStateLocked:action=updatedState,namespace=Notifications,name=IndicatorState
2018-04-16 01:27:46.381 [  1] 9 MediaPlayer:getSpeakerTypeCalled
2018-04-16 01:27:46.382 [  1] 9 MediaPlayer:getSpeakerTypeCalled
2018-04-16 01:27:46.382 [  1] 9 MediaPlayer:getSpeakerTypeCalled
2018-04-16 01:27:46.382 [  1] 9 MediaPlayer:getSpeakerTypeCalled
2018-04-16 01:27:46.383 [  1] 0 SpeakerManager:mapCreated:numAvsSynced=3,numLocal=1
2018-04-16 01:27:46.383 [  1] 9 MediaPlayer:getSpeakerSettingsCalled
2018-04-16 01:27:46.383 [  2] 9 MediaPlayer:handleGetSpeakerSettingsCalled
2018-04-16 01:27:46.384 [  1] 9 MediaPlayer:getSpeakerSettingsCalled
2018-04-16 01:27:46.384 [  2] 9 MediaPlayer:handleGetSpeakerSettingsCalled
2018-04-16 01:27:46.384 [  1] 9 MediaPlayer:getSpeakerSettingsCalled
2018-04-16 01:27:46.385 [  2] 9 MediaPlayer:handleGetSpeakerSettingsCalled
2018-04-16 01:27:46.385 [  1] 9 SpeakerManager:validateSpeakerSettingsConsistencyResult:consistent=true
2018-04-16 01:27:46.385 [  1] 9 SpeakerManager:validateSpeakerSettings:volume=100,mute=false
2018-04-16 01:27:46.385 [  1] 9 SpeakerManager:updateContextManagerCalled:speakerType=AVS_SYNCED
2018-04-16 01:27:46.387 [  1] 0 ExternalMediaPlayer:createAdapters
2018-04-16 01:27:46.394 [  1] 1 AudioPlayer:addObserver
2018-04-16 01:27:46.396 [  5] 5 TemplateRuntime:onDialogUXStateChanged:state=IDLE
2018-04-16 01:27:46.398 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=SpeechSynthesizer,name=Speak,handler=0x19b4df0,policy=BLOCKING
2018-04-16 01:27:46.399 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=AudioPlayer,name=ClearQueue,handler=0x19b5c28,policy=NON_BLOCKING
2018-04-16 01:27:46.399 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=AudioPlayer,name=Stop,handler=0x19b5c28,policy=NON_BLOCKING
2018-04-16 01:27:46.400 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=AudioPlayer,name=Play,handler=0x19b5c28,policy=NON_BLOCKING
2018-04-16 01:27:46.401 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.SeekController,name=AdjustSeekPosition,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:46.402 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaylistController,name=DisableRepeat,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:46.402 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaylistController,name=DisableShuffle,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:46.402 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=FastForward,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:46.402 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.FavoritesController,name=Unfavorite,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:46.402 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=StartOver,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:46.403 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=Previous,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:46.403 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaylistController,name=EnableRepeat,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:46.403 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=Rewind,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:46.403 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=Next,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:46.403 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=Pause,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:46.403 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaylistController,name=EnableShuffle,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:46.404 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=Play,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:46.404 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.FavoritesController,name=Favorite,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:46.404 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.SeekController,name=SetSeekPosition,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:46.404 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=ExternalMediaPlayer,name=Login,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:46.404 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=ExternalMediaPlayer,name=Logout,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:46.404 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=ExternalMediaPlayer,name=Play,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:46.405 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=SpeechRecognizer,name=ExpectSpeech,handler=0x19b4418,policy=NON_BLOCKING
2018-04-16 01:27:46.405 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=SpeechRecognizer,name=StopCapture,handler=0x19b4418,policy=NON_BLOCKING
2018-04-16 01:27:46.405 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alerts,name=DeleteAlert,handler=0x19b6a20,policy=NON_BLOCKING
2018-04-16 01:27:46.405 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alerts,name=SetAlert,handler=0x19b6a20,policy=NON_BLOCKING
2018-04-16 01:27:46.406 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=System,name=SetEndpoint,handler=0x19c5458,policy=NON_BLOCKING
2018-04-16 01:27:46.406 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=System,name=ResetUserInactivity,handler=0x19b41d4,policy=NON_BLOCKING
2018-04-16 01:27:46.406 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Speaker,name=AdjustVolume,handler=0x19c2ac8,policy=NON_BLOCKING
2018-04-16 01:27:46.406 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Speaker,name=SetMute,handler=0x19c2ac8,policy=NON_BLOCKING
2018-04-16 01:27:46.406 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Speaker,name=SetVolume,handler=0x19c2ac8,policy=NON_BLOCKING
2018-04-16 01:27:46.406 [  1] 5 TemplateRuntime:getConfiguration
2018-04-16 01:27:46.407 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=TemplateRuntime,name=RenderPlayerInfo,handler=0x19c4810,policy=HANDLE_IMMEDIATELY
2018-04-16 01:27:46.407 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=TemplateRuntime,name=RenderTemplate,handler=0x19c4810,policy=HANDLE_IMMEDIATELY
2018-04-16 01:27:46.407 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Notifications,name=ClearIndicator,handler=0x19bb6c4,policy=HANDLE_IMMEDIATELY
2018-04-16 01:27:46.407 [  1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Notifications,name=SetIndicator,handler=0x19bb6c4,policy=HANDLE_IMMEDIATELY
2018-04-16 01:27:47.559 [  6] 0 HttpPost:doPostSucceeded:code=200
2018-04-16 01:27:47.560 [  6] 0 AuthDelegate:handleLwaResponseSucceeded:expiresInSeconds=3600
2018-04-16 01:27:47.560 [  6] 0 AuthDelegate:onAuthStateChangeCalled:state=1,error=0
2018-04-16 01:27:47.561 [  1] 0 MessageRouter:connectionStatusChanged:reason=ACL_CLIENT_REQUEST,newStatus=PENDING
2018-04-16 01:27:47.565 [  1] 9 HTTP2Transport:setupDownchannelStream:url=https\://avs-alexa-na.amazon.com/v20160207/directives
2018-04-16 01:27:47.567 [  1] 0 HTTP2StreamPool:getStream:streamId=1,numAcquiredStreams=1
2018-04-16 01:27:47.569 [  7] 9 PostConnectSynchronize:Entering postConnectLoop thread
2018-04-16 01:27:47.571 [  8] 5 VisualActivityTracker:provideState
2018-04-16 01:27:47.571 [  3] 1 AlertsCapabilityAgent:executeOnConnectionStatusChanged:status=PENDING,reason=ACL_CLIENT_REQUEST
2018-04-16 01:27:47.572 [  9] 5 VisualActivityTracker:executeProvideState
2018-04-16 01:27:47.572 [  9] 0 ContextManager:updateStateLocked:action=updatedState,namespace=VisualActivityTracker,name=ActivityState
2018-04-16 01:27:47.572 [  a] 0 ExternalMediaPlayer:executeProvideState:sendToken=true,stateRequestToken=1
2018-04-16 01:27:47.573 [  8] 0 NotificationsCapabilityAgent:provideState:stateRequestToken=1
2018-04-16 01:27:47.573 [  8] 5 AudioActivityTracker:provideState
2018-04-16 01:27:47.574 [  8] 9 SpeechSynthesizer:provideState:token=1
2018-04-16 01:27:47.574 [  b] 5 AudioActivityTracker:executeProvideState
2018-04-16 01:27:47.574 [  a] 0 ContextManager:updateStateLocked:action=updatedState,namespace=Alexa.PlaybackStateReporter,name=playbackState
2018-04-16 01:27:47.574 [  4] 5 NotificationsCapabilityAgent:executeProvideState:sendToken=true,stateRequestToken=1
2018-04-16 01:27:47.575 [  b] 0 ContextManager:updateStateLocked:action=updatedState,namespace=AudioActivityTracker,name=ActivityState
2018-04-16 01:27:47.575 [  a] 0 ExternalMediaPlayer:executeProvideState:sendToken=true,stateRequestToken=1
#############################
#       Connecting...       #
#############################

2018-04-16 01:27:47.575 [  4] 0 ContextManager:updateStateLocked:action=updatedState,namespace=Notifications,name=IndicatorState
2018-04-16 01:27:47.574 [  c] 0 SpeechSynthesizer:executeProvideState:stateRequestToken=1
2018-04-16 01:27:47.576 [  d] 0 ContextManager:updateStateLocked:action=updatedState,namespace=SpeechRecognizer,name=RecognizerState
2018-04-16 01:27:47.576 [  a] 0 ContextManager:updateStateLocked:action=updatedState,namespace=ExternalMediaPlayer,name=ExternalMediaPlayerState
2018-04-16 01:27:47.576 [  8] 0 AudioPlayer:provideState:stateRequestToken=1
2018-04-16 01:27:47.576 [  c] 0 ContextManager:updateStateLocked:action=updatedState,namespace=SpeechSynthesizer,name=SpeechState
2018-04-16 01:27:47.577 [  e] 0 AudioPlayer:executeProvideState:sendToken=true,stateRequestToken=1
2018-04-16 01:27:47.577 [  e] 0 ContextManager:updateStateLocked:action=updatedState,namespace=AudioPlayer,name=PlaybackState
2018-04-16 01:27:47.578 [  8] 9 ContextManager:buildContextIgnored:namespace=VisualActivityTracker,name=ActivityState
2018-04-16 01:27:47.579 [  8] 9 ContextManager:buildContextIgnored:namespace=AudioActivityTracker,name=ActivityState
2018-04-16 01:27:47.580 [  8] 0 ContextManager:buildContextSuccessful
2018-04-16 01:27:47.582 [  8] 0 EventBuilder:buildJsonEventString:messageId=bf476f9c-a10d-42aa-aa7a-17603481c2e0,namespace=System,name=SynchronizeState
2018-04-16 01:27:47.585 [  8] 0 PostConnectSynchronize:onContextAvailable : Send PostConnectMessage to transport
2018-04-16 01:27:47.585 [  8] 9 HTTP2Transport:enqueueRequest
2018-04-16 01:27:48.599 [  f] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 120eedfffe065754-00002763-002309a5-2a4a6ca96fe70e1c-2e813426-1
2018-04-16 01:27:48.600 [  f] 0 HTTP2Transport:processNextOutgoingMessage
2018-04-16 01:27:48.601 [  f] 0 HTTP2StreamPool:getStream:streamId=3,numAcquiredStreams=2
2018-04-16 01:27:48.601 [  f] 9 HTTP2Transport:insertActiveStream:handle=0x73ed7bb0
2018-04-16 01:27:49.049 [  f] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 120eedfffe065754-00002763-002305f6-87f6304615fa41fd-3ae8d7bf-11
2018-04-16 01:27:49.050 [  f] 0 PostConnectSynchronize:onSendCompleted:status=SUCCESS_NO_CONTENT
2018-04-16 01:27:49.050 [  7] 9 PostConnectSynchronize:Exiting postConnectLoop thread
2018-04-16 01:27:49.051 [  f] 0 PostConnectSynchronize:onConnected()
2018-04-16 01:27:49.051 [  f] 0 MessageRouter:connectionStatusChanged:reason=ACL_CLIENT_REQUEST,newStatus=CONNECTED
2018-04-16 01:27:49.052 [  3] 1 AlertsCapabilityAgent:executeOnConnectionStatusChanged:status=CONNECTED,reason=ACL_CLIENT_REQUEST
########################################
#       Alexa is currently idle!       #
########################################

2018-04-16 01:27:49.052 [  f] 0 HTTP2Transport:cleanupFinishedStream:streamId=3,result=204
2018-04-16 01:27:49.052 [  1] 9 SpeakerManager:addSpeakerManagerObserverCalled
2018-04-16 01:27:49.053 [  1] 9 SpeakerManager:addSpeakerManagerObserver:observer=0x19a4c30
2018-04-16 01:27:49.053 [  f] 0 HTTP2StreamPool:releaseStream:streamId=3,numAcquiredStreams=1
2018-04-16 01:27:49.053 [  1] 5 NotificationsCapabilityAgent:addObserver
2018-04-16 01:27:49.053 [  f] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT
2018-04-16 01:27:49.054 [  1] 5 TemplateRuntime:addObserver
2018-04-16 01:27:49.054 [ 10] 5 TemplateRuntime:addObserverInExecutor
#################################################
#       NOTIFICATION INDICATOR STATE: OFF       #
#################################################

ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.front
ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.rear
ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.center_lfe
ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.side
ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.surround21
ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.surround21
ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.surround40
ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.surround41
ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.surround50
ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.surround51
ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.surround71
ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.iec958
ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.iec958
ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.iec958
ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.hdmi
ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.hdmi
ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.modem
ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.modem
ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.phoneline
ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.phoneline
ALSA lib confmisc.c:1281:(snd_func_refer) Unable to find definition 'defaults.bluealsa.device'
ALSA lib conf.c:4528:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory
ALSA lib conf.c:4996:(snd_config_expand) Args evaluate error: No such file or directory
ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM bluealsa
ALSA lib confmisc.c:1281:(snd_func_refer) Unable to find definition 'defaults.bluealsa.device'
ALSA lib conf.c:4528:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory
ALSA lib conf.c:4996:(snd_config_expand) Args evaluate error: No such file or directory
ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM bluealsa
ALSA lib pcm_hw.c:1713:(_snd_pcm_hw_open) Invalid value for card
Failed to open PortAudio default stream
Failed to initialize PortAudioMicrophoneWrapper
Failed to create PortAudioMicrophoneWrapper!
2018-04-16 01:27:49.131 [  1] 5 DefaultClient:DirectiveSequencerShutdown
2018-04-16 01:27:49.132 [  1] 9 DirectiveSequencer:doShutdown
2018-04-16 01:27:49.135 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Notifications,name=ClearIndicator,handler=0x19bb6c4,policy=HANDLE_IMMEDIATELY
2018-04-16 01:27:49.135 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Notifications,name=SetIndicator,handler=0x19bb6c4,policy=HANDLE_IMMEDIATELY
2018-04-16 01:27:49.136 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Speaker,name=AdjustVolume,handler=0x19c2ac8,policy=NON_BLOCKING
2018-04-16 01:27:49.136 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Speaker,name=SetMute,handler=0x19c2ac8,policy=NON_BLOCKING
2018-04-16 01:27:49.137 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Speaker,name=SetVolume,handler=0x19c2ac8,policy=NON_BLOCKING
2018-04-16 01:27:49.137 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=System,name=SetEndpoint,handler=0x19c5458,policy=NON_BLOCKING
2018-04-16 01:27:49.137 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alerts,name=DeleteAlert,handler=0x19b6a20,policy=NON_BLOCKING
2018-04-16 01:27:49.138 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alerts,name=SetAlert,handler=0x19b6a20,policy=NON_BLOCKING
2018-04-16 01:27:49.138 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=SpeechRecognizer,name=ExpectSpeech,handler=0x19b4418,policy=NON_BLOCKING
2018-04-16 01:27:49.138 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=SpeechRecognizer,name=StopCapture,handler=0x19b4418,policy=NON_BLOCKING
2018-04-16 01:27:49.139 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.SeekController,name=AdjustSeekPosition,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:49.139 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaylistController,name=DisableRepeat,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:49.139 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaylistController,name=DisableShuffle,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:49.139 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaybackController,name=FastForward,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:49.139 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.FavoritesController,name=Unfavorite,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:49.140 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaybackController,name=StartOver,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:49.140 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaybackController,name=Previous,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:49.140 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaylistController,name=EnableRepeat,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:49.140 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaybackController,name=Rewind,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:49.140 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaybackController,name=Next,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:49.140 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaybackController,name=Pause,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:49.141 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaylistController,name=EnableShuffle,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:49.141 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaybackController,name=Play,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:49.141 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.FavoritesController,name=Favorite,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:49.141 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.SeekController,name=SetSeekPosition,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:49.141 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=ExternalMediaPlayer,name=Login,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:49.141 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=ExternalMediaPlayer,name=Logout,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:49.142 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=ExternalMediaPlayer,name=Play,handler=0x19c2e58,policy=NON_BLOCKING
2018-04-16 01:27:49.142 [  1] 5 TemplateRuntime:getConfiguration
2018-04-16 01:27:49.142 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=TemplateRuntime,name=RenderPlayerInfo,handler=0x19c4810,policy=HANDLE_IMMEDIATELY
2018-04-16 01:27:49.142 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=TemplateRuntime,name=RenderTemplate,handler=0x19c4810,policy=HANDLE_IMMEDIATELY
2018-04-16 01:27:49.142 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=SpeechSynthesizer,name=Speak,handler=0x19b4df0,policy=BLOCKING
2018-04-16 01:27:49.143 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=AudioPlayer,name=ClearQueue,handler=0x19b5c28,policy=NON_BLOCKING
2018-04-16 01:27:49.143 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=AudioPlayer,name=Stop,handler=0x19b5c28,policy=NON_BLOCKING
2018-04-16 01:27:49.143 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=AudioPlayer,name=Play,handler=0x19b5c28,policy=NON_BLOCKING
2018-04-16 01:27:49.143 [  1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=System,name=ResetUserInactivity,handler=0x19b41d4,policy=NON_BLOCKING
2018-04-16 01:27:49.144 [  1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x19bb6c4
2018-04-16 01:27:49.144 [  1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x19c2ac8
2018-04-16 01:27:49.144 [  1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x19c5458
2018-04-16 01:27:49.144 [  1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x19b6a20
2018-04-16 01:27:49.144 [  1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x19b4418
2018-04-16 01:27:49.145 [  1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x19c2e58
2018-04-16 01:27:49.145 [  1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x19c4810
2018-04-16 01:27:49.145 [  1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x19b4df0
2018-04-16 01:27:49.146 [  1] 9 SpeechSynthesizer:onDeregistered
2018-04-16 01:27:49.146 [  1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x19b5c28
2018-04-16 01:27:49.146 [  1] 0 AudioPlayer:onDeregistered
2018-04-16 01:27:49.146 [  1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x19b41d4
2018-04-16 01:27:49.146 [  e] 1 AudioPlayer:executeStop:playNextItem=false,m_currentActivity=IDLE
2018-04-16 01:27:49.147 [  1] 5 DefaultClient:SpeakerManagerShutdown
2018-04-16 01:27:49.148 [  1] 5 DefaultClient:TemplateRuntimeShutdown
2018-04-16 01:27:49.148 [  1] 1 AudioPlayer:removeObserver
2018-04-16 01:27:49.149 [  1] 5 DefaultClient:AIPShutdown
2018-04-16 01:27:49.150 [  1] 5 DefaultClient:AudioPlayerShutdown
2018-04-16 01:27:49.150 [  1] 1 AudioPlayer:executeStop:playNextItem=false,m_currentActivity=IDLE
2018-04-16 01:27:49.150 [  1] 9 MediaPlayer:setObserverCalled
2018-04-16 01:27:49.151 [  2] 0 MediaPlayer:handleSetObserverCalled
2018-04-16 01:27:49.151 [  1] 0 ContextManager:setStateProvider:action=removedStateProvider,namespace=AudioPlayer,name=PlaybackState
2018-04-16 01:27:49.151 [  1] 5 DefaultClient:ExternalMediaPlayerShutdown
2018-04-16 01:27:49.152 [  1] 0 ContextManager:setStateProvider:action=removedStateProvider,namespace=ExternalMediaPlayer,name=ExternalMediaPlayerState
2018-04-16 01:27:49.152 [  1] 0 ContextManager:setStateProvider:action=removedStateProvider,namespace=Alexa.PlaybackStateReporter,name=playbackState
2018-04-16 01:27:49.152 [  1] 5 DefaultClient:SpeechSynthesizerShutdown
2018-04-16 01:27:49.152 [  1] 9 SpeechSynthesizer:doShutdown
2018-04-16 01:27:49.152 [  1] 9 MediaPlayer:setObserverCalled
2018-04-16 01:27:49.153 [  2] 0 MediaPlayer:handleSetObserverCalled
2018-04-16 01:27:49.153 [  1] 5 DefaultClient:AlertsShutdown
2018-04-16 01:27:49.154 [  1] 9 AlertsCapabilityAgent:releaseChannel
2018-04-16 01:27:49.155 [  1] 5 DefaultClient:PlaybackControllerShutdown
2018-04-16 01:27:49.155 [  1] 5 DefaultClient:MessageRouterShutdown.
2018-04-16 01:27:49.156 [  1] 0 MessageRouter:connectionStatusChanged:reason=ACL_CLIENT_REQUEST,newStatus=DISCONNECTED
2018-04-16 01:27:49.156 [  1] 0 PostConnectSynchronize:PostConnectSynchronizer::doShutdown().
#####################################
#       Client not connected!       #
#####################################

2018-04-16 01:27:49.267 [  f] 0 HTTP2StreamPool:releaseStream:streamId=1,numAcquiredStreams=0
2018-04-16 01:27:49.272 [  f] 0 PostConnectSynchronize:onDisconnected()
2018-04-16 01:27:49.272 [  f] 0 PostConnectSynchronize:PostConnectSynchronizer::doShutdown().
2018-04-16 01:27:49.274 [  1] 5 DefaultClient:ConnectionManagerShutdown.
2018-04-16 01:27:49.275 [  1] 5 DefaultClient:CertifiedSenderShutdown.
2018-04-16 01:27:49.275 [  1] 5 DefaultClient:AudioActivityTrackerShutdown.
2018-04-16 01:27:49.276 [  1] 5 DefaultClient:VisualActivityTrackerShutdown.
2018-04-16 01:27:49.276 [  1] 5 DefaultClient:PlaybackRouterShutdown.
2018-04-16 01:27:49.276 [  1] 5 DefaultClient:NotificationsShutdown.
2018-04-16 01:27:49.276 [  1] 5 NotificationsCapabilityAgent:doShutdown
2018-04-16 01:27:49.277 [  4] 5 NotificationsCapabilityAgent:executeShutdown:currentState=IDLE
2018-04-16 01:27:49.277 [  4] 5 NotificationsCapabilityAgent:executeSetState:previousState=IDLE,newState=SHUTDOWN
2018-04-16 01:27:49.277 [  1] 0 ContextManager:setStateProvider:action=removedStateProvider,namespace=Notifications,name=IndicatorState
2018-04-16 01:27:49.282 [ 11] 9 CertifiedSender:CertifiedSender worker thread done.  exiting mainloop.
Failed to initialize SampleApplication
2018-04-16 01:27:49.309 [  1] 9 MediaPlayer:~MediaPlayerCalled
2018-04-16 01:27:49.311 [  1] 9 MediaPlayer:resetPipeline
2018-04-16 01:27:49.311 [  1] 9 MediaPlayer:~MediaPlayerCalled
2018-04-16 01:27:49.313 [  1] 9 MediaPlayer:resetPipeline
2018-04-16 01:27:49.313 [  1] 9 MediaPlayer:~MediaPlayerCalled
2018-04-16 01:27:49.314 [  1] 9 MediaPlayer:resetPipeline
2018-04-16 01:27:49.315 [  1] 9 MediaPlayer:~MediaPlayerCalled
2018-04-16 01:27:49.316 [  1] 9 MediaPlayer:resetPipeline
Failed to create to SampleApplication!

----------------------------------------------------------------------------------------

Thank you for reading my long post!

have a good day!

yoelrc88 · April 16, 2018, 3:22pm

Hi that link is the official Alexa guide that is not customized for MATRIX Voice. We made a nice guide for this, please take a look here.

We recommend to start this guide form scratch.

Let me know how it goes

-Yoel

yoelrc88 · April 16, 2018, 8:38pm

We just published a nicer guide to run Alexa!. Check it out here on Hackster.

-Yoel

Jang · April 17, 2018, 2:56am

Thank you for your reply !!

I’ll try

have a good day @yoelrc88

Jang · April 17, 2018, 5:54am

link that you attached partially works!

If i call ‘alexa’, MATRIX VOICE LED’s color changed

Wait state : blue

Call ‘alexa’ : red -> green -> blue

but I can’t hear anything,

I checked on youtube, but the speakers are OK

I’ll attach log

--------------------------------------------------------------------------------------------

2018-04-17 05:50:24.613 [  c] 0 AudioInputProcessor:onSendCompleted:status=SUCCESS_NO_CONTENT
2018-04-17 05:50:24.613 [  c] 0 HTTP2Transport:cleanupFinishedStream:streamId=27,result=204
2018-04-17 05:50:24.613 [  c] 0 HTTP2StreamPool:releaseStream:streamId=27,numAcquiredStreams=1
2018-04-17 05:50:24.613 [  c] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT
2018-04-17 05:50:29.375 [ 10] 0 DialogUXStateAggregator:transitionFromThinkingTimedOut
2018-04-17 05:50:29.376 [ 10] 0 DialogUXStateAggregator:setState:from=THINKING,to=IDLE
2018-04-17 05:50:29.376 [  b] 1 FocusManager:releaseChannel:channelName=Dialog
########################################
#       Alexa is currently idle!       #
########################################

2018-04-17 05:50:29.376 [  b] 0 AudioInputProcessor:setState:from=BUSY,to=IDLE
2018-04-17 05:50:29.377 [ 11] 9 AudioInputProcessor:onFocusChanged:newFocus=NONE
2018-04-17 05:50:29.378 [  b] 0 AudioInputProcessor:executeOnFocusChanged:newFocus=NONE
2018-04-17 05:50:29.378 [  b] 0 AudioInputProcessor:executeOnFocusChanged:reason=Lost focus
2018-04-17 05:52:53.999 [  b] 0 AudioInputProcessor:setState:from=IDLE,to=RECOGNIZING
2018-04-17 05:52:54.000 [ 10] 0 DialogUXStateAggregator:setState:from=IDLE,to=LISTENING
2018-04-17 05:52:54.000 [  7] 0 ExternalMediaPlayer:executeProvideState:sendToken=true,stateRequestToken=9
2018-04-17 05:52:54.000 [  8] 0 NotificationsCapabilityAgent:provideState:stateRequestToken=9
############################
#       Listening...       #
############################

2018-04-17 05:52:54.001 [  4] 5 NotificationsCapabilityAgent:executeProvideState:sendToken=true,stateRequestToken=9
2018-04-17 05:52:54.001 [  7] 0 ContextManager:updateStateLocked:action=updatedState,state={"state"\:"IDLE"\,"supportedOperations"\:[]\,"shuffle"\:"NOT_SHUFFLED"\,"repeat"\:"NOT_REPEATED"\,"favorite"\:"NOT_RATED"\,"positionMilliseconds"\:0\,"uncertaintyInMilliseconds"\:0\,"players"\:[]},namespace=Alexa.PlaybackStateReporter,name=playbackState
2018-04-17 05:52:54.001 [  7] 0 ExternalMediaPlayer:executeProvideState:sendToken=true,stateRequestToken=9
2018-04-17 05:52:54.001 [  7] 0 ContextManager:updateStateLocked:action=updatedState,state={"playerInFocus"\:""\,"players"\:[]},namespace=ExternalMediaPlayer,name=ExternalMediaPlayerState
2018-04-17 05:52:54.002 [  4] 0 ContextManager:updateStateLocked:action=updatedState,state={"isEnabled"\:false\,"isVisualIndicatorPersisted"\:false},namespace=Notifications,name=IndicatorState
2018-04-17 05:52:54.004 [  8] 0 ContextManager:buildContextSuccessful:context={"context"\:[{"header"\:{"namespace"\:"Alexa.PlaybackStateReporter"\,"name"\:"playbackState"}\,"payload"\:{"state"\:"IDLE"\,"supportedOperations"\:[]\,"shuffle"\:"NOT_SHUFFLED"\,"repeat"\:"NOT_REPEATED"\,"favorite"\:"NOT_RATED"\,"positionMilliseconds"\:0\,"uncertaintyInMilliseconds"\:0\,"players"\:[]}}\,{"header"\:{"namespace"\:"Speaker"\,"name"\:"VolumeState"}\,"payload"\:{"volume"\:100\,"muted"\:false}}\,{"header"\:{"namespace"\:"ExternalMediaPlayer"\,"name"\:"ExternalMediaPlayerState"}\,"payload"\:{"playerInFocus"\:""\,"players"\:[]}}\,{"header"\:{"namespace"\:"Notifications"\,"name"\:"IndicatorState"}\,"payload"\:{"isEnabled"\:false\,"isVisualIndicatorPersisted"\:false}}\,{"header"\:{"namespace"\:"SpeechSynthesizer"\,"name"\:"SpeechState"}\,"payload"\:{"token"\:"amzn1.as-ct.v1.#ACRI#ErrorNotifier_6cfe4ba8-5a2f-42b6-ba28-de13752c6ce2"\,"offsetInMilliseconds"\:0\,"playerActivity"\:"FINISHED"}}\,{"header"\:{"namespace"\:"AudioPlayer"\,"name"\:"PlaybackState"}\,"payload"\:{"token"\:""\,"offsetInMilliseconds"\:0\,"playerActivity"\:"IDLE"}}\,{"header"\:{"namespace"\:"SpeechRecognizer"\,"name"\:"RecognizerState"}\,"payload"\:{"wakeword"\:"alexa"}}\,{"header"\:{"namespace"\:"Alerts"\,"name"\:"AlertsState"}\,"payload"\:{"allAlerts"\:[]\,"activeAlerts"\:[]}}]}
2018-04-17 05:52:54.005 [  b] 0 AudioInputProcessor:executeOnContextAvailable:jsonContext={"context"\:[{"header"\:{"namespace"\:"Alexa.PlaybackStateReporter"\,"name"\:"playbackState"}\,"payload"\:{"state"\:"IDLE"\,"supportedOperations"\:[]\,"shuffle"\:"NOT_SHUFFLED"\,"repeat"\:"NOT_REPEATED"\,"favorite"\:"NOT_RATED"\,"positionMilliseconds"\:0\,"uncertaintyInMilliseconds"\:0\,"players"\:[]}}\,{"header"\:{"namespace"\:"Speaker"\,"name"\:"VolumeState"}\,"payload"\:{"volume"\:100\,"muted"\:false}}\,{"header"\:{"namespace"\:"ExternalMediaPlayer"\,"name"\:"ExternalMediaPlayerState"}\,"payload"\:{"playerInFocus"\:""\,"players"\:[]}}\,{"header"\:{"namespace"\:"Notifications"\,"name"\:"IndicatorState"}\,"payload"\:{"isEnabled"\:false\,"isVisualIndicatorPersisted"\:false}}\,{"header"\:{"namespace"\:"SpeechSynthesizer"\,"name"\:"SpeechState"}\,"payload"\:{"token"\:"amzn1.as-ct.v1.#ACRI#ErrorNotifier_6cfe4ba8-5a2f-42b6-ba28-de13752c6ce2"\,"offsetInMilliseconds"\:0\,"playerActivity"\:"FINISHED"}}\,{"header"\:{"namespace"\:"AudioPlayer"\,"name"\:"PlaybackState"}\,"payload"\:{"token"\:""\,"offsetInMilliseconds"\:0\,"playerActivity"\:"IDLE"}}\,{"header"\:{"namespace"\:"SpeechRecognizer"\,"name"\:"RecognizerState"}\,"payload"\:{"wakeword"\:"alexa"}}\,{"header"\:{"namespace"\:"Alerts"\,"name"\:"AlertsState"}\,"payload"\:{"allAlerts"\:[]\,"activeAlerts"\:[]}}]}
2018-04-17 05:52:54.005 [  b] 1 FocusManager:acquireChannel:channelName=Dialog,activityId=SpeechRecognizer.Recognize
2018-04-17 05:52:54.006 [ 11] 9 AudioInputProcessor:onFocusChanged:newFocus=FOREGROUND
2018-04-17 05:52:54.006 [  b] I DirectiveProcessor:setDialogRequestIdLocked:oldValue=a1c15a3b-6cbd-4228-84f3-6ee317c8f417,newValue=fa7480b5-1799-4a04-9ea7-17b159d5de78
2018-04-17 05:52:54.006 [  b] 0 DirectiveProcessor:scrubDialogRequestIdLocked:dialogRequestId=a1c15a3b-6cbd-4228-84f3-6ee317c8f417
2018-04-17 05:52:54.007 [  b] 0 EventBuilder:buildJsonEventString:messageId=46e2c23f-90c5-4140-bd48-71d56b35f569,namespace=SpeechRecognizer,name=Recognize
2018-04-17 05:52:54.008 [  b] 0 AudioInputProcessor:executeOnFocusChanged:newFocus=FOREGROUND
2018-04-17 05:52:54.010 [  b] 9 HTTP2Transport:enqueueRequest:jsonContent={"context"\:[{"header"\:{"namespace"\:"Alexa.PlaybackStateReporter"\,"name"\:"playbackState"}\,"payload"\:{"state"\:"IDLE"\,"supportedOperations"\:[]\,"shuffle"\:"NOT_SHUFFLED"\,"repeat"\:"NOT_REPEATED"\,"favorite"\:"NOT_RATED"\,"positionMilliseconds"\:0\,"uncertaintyInMilliseconds"\:0\,"players"\:[]}}\,{"header"\:{"namespace"\:"Speaker"\,"name"\:"VolumeState"}\,"payload"\:{"volume"\:100\,"muted"\:false}}\,{"header"\:{"namespace"\:"ExternalMediaPlayer"\,"name"\:"ExternalMediaPlayerState"}\,"payload"\:{"playerInFocus"\:""\,"players"\:[]}}\,{"header"\:{"namespace"\:"Notifications"\,"name"\:"IndicatorState"}\,"payload"\:{"isEnabled"\:false\,"isVisualIndicatorPersisted"\:false}}\,{"header"\:{"namespace"\:"SpeechSynthesizer"\,"name"\:"SpeechState"}\,"payload"\:{"token"\:"amzn1.as-ct.v1.#ACRI#ErrorNotifier_6cfe4ba8-5a2f-42b6-ba28-de13752c6ce2"\,"offsetInMilliseconds"\:0\,"playerActivity"\:"FINISHED"}}\,{"header"\:{"namespace"\:"AudioPlayer"\,"name"\:"PlaybackState"}\,"payload"\:{"token"\:""\,"offsetInMilliseconds"\:0\,"playerActivity"\:"IDLE"}}\,{"header"\:{"namespace"\:"SpeechRecognizer"\,"name"\:"RecognizerState"}\,"payload"\:{"wakeword"\:"alexa"}}\,{"header"\:{"namespace"\:"Alerts"\,"name"\:"AlertsState"}\,"payload"\:{"allAlerts"\:[]\,"activeAlerts"\:[]}}]\,"event"\:{"header"\:{"namespace"\:"SpeechRecognizer"\,"name"\:"Recognize"\,"messageId"\:"46e2c23f-90c5-4140-bd48-71d56b35f569"\,"dialogRequestId"\:"fa7480b5-1799-4a04-9ea7-17b159d5de78"}\,"payload"\:{"profile"\:"NEAR_FIELD"\,"format"\:"AUDIO_L16_RATE_16000_CHANNELS_1"\,"initiator"\:{"type"\:"WAKEWORD"\,"payload"\:{"wakeWordIndices"\:{"startIndexInSamples"\:8000\,"endIndexInSamples"\:14960}}}}}}
2018-04-17 05:52:54.060 [  c] 0 HTTP2Transport:processNextOutgoingMessage:jsonContent={"context"\:[{"header"\:{"namespace"\:"Alexa.PlaybackStateReporter"\,"name"\:"playbackState"}\,"payload"\:{"state"\:"IDLE"\,"supportedOperations"\:[]\,"shuffle"\:"NOT_SHUFFLED"\,"repeat"\:"NOT_REPEATED"\,"favorite"\:"NOT_RATED"\,"positionMilliseconds"\:0\,"uncertaintyInMilliseconds"\:0\,"players"\:[]}}\,{"header"\:{"namespace"\:"Speaker"\,"name"\:"VolumeState"}\,"payload"\:{"volume"\:100\,"muted"\:false}}\,{"header"\:{"namespace"\:"ExternalMediaPlayer"\,"name"\:"ExternalMediaPlayerState"}\,"payload"\:{"playerInFocus"\:""\,"players"\:[]}}\,{"header"\:{"namespace"\:"Notifications"\,"name"\:"IndicatorState"}\,"payload"\:{"isEnabled"\:false\,"isVisualIndicatorPersisted"\:false}}\,{"header"\:{"namespace"\:"SpeechSynthesizer"\,"name"\:"SpeechState"}\,"payload"\:{"token"\:"amzn1.as-ct.v1.#ACRI#ErrorNotifier_6cfe4ba8-5a2f-42b6-ba28-de13752c6ce2"\,"offsetInMilliseconds"\:0\,"playerActivity"\:"FINISHED"}}\,{"header"\:{"namespace"\:"AudioPlayer"\,"name"\:"PlaybackState"}\,"payload"\:{"token"\:""\,"offsetInMilliseconds"\:0\,"playerActivity"\:"IDLE"}}\,{"header"\:{"namespace"\:"SpeechRecognizer"\,"name"\:"RecognizerState"}\,"payload"\:{"wakeword"\:"alexa"}}\,{"header"\:{"namespace"\:"Alerts"\,"name"\:"AlertsState"}\,"payload"\:{"allAlerts"\:[]\,"activeAlerts"\:[]}}]\,"event"\:{"header"\:{"namespace"\:"SpeechRecognizer"\,"name"\:"Recognize"\,"messageId"\:"46e2c23f-90c5-4140-bd48-71d56b35f569"\,"dialogRequestId"\:"fa7480b5-1799-4a04-9ea7-17b159d5de78"}\,"payload"\:{"profile"\:"NEAR_FIELD"\,"format"\:"AUDIO_L16_RATE_16000_CHANNELS_1"\,"initiator"\:{"type"\:"WAKEWORD"\,"payload"\:{"wakeWordIndices"\:{"startIndexInSamples"\:8000\,"endIndexInSamples"\:14960}}}}}}
2018-04-17 05:52:54.060 [  c] 0 HTTP2StreamPool:getStream:streamId=29,numAcquiredStreams=2
2018-04-17 05:52:54.061 [  c] 9 HTTP2Transport:insertActiveStream:handle=0x73fd7bc8
2018-04-17 05:52:54.061 [  c] 0 HTTP2Stream:libcurl:streamId=29,text=Found bundle for host avs-alexa-na.amazon.com\: 0x73f02268 [can multiplex]
2018-04-17 05:52:54.061 [  c] 0 HTTP2Stream:libcurl:streamId=29,text=Conn\: 0 (0x73f01958) Receive pipe weight\: (-1/0)\, penalized\: (nil)
2018-04-17 05:52:54.061 [  c] 0 HTTP2Stream:libcurl:streamId=29,text=Multiplexed connection found!
2018-04-17 05:52:54.061 [  c] 0 HTTP2Stream:libcurl:streamId=29,text=Found connection 0\, with requests in the pipe (1)
2018-04-17 05:52:54.062 [  c] 0 HTTP2Stream:libcurl:streamId=29,text=Re-using existing connection! (#0) with host avs-alexa-na.amazon.com
2018-04-17 05:52:54.062 [  c] 0 HTTP2Stream:libcurl:streamId=29,text=Using Stream ID\: 1d (easy handle 0x73fd7bc8)
2018-04-17 05:53:00.280 [ 12] 0 MessageInterpreter:receive:messageId=a8a3fb3b-cb1f-4530-a98f-a51e7d7c8fda:No dialogRequestId attached to message.
2018-04-17 05:53:00.280 [ 12] I DirectiveSequencer:onDirective:directive={"namespace\:"SpeechRecognizer"\,name\:"StopCapture"\,messageId\:"a8a3fb3b-cb1f-4530-a98f-a51e7d7c8fda"\,dialogRequestId\:""}
2018-04-17 05:53:00.281 [ 13] I DirectiveRouter:preHandleDirective:messageId=a8a3fb3b-cb1f-4530-a98f-a51e7d7c8fda,action=calling
2018-04-17 05:53:00.281 [ 13] 0 CapabilityAgent:addingMessageIdToMap:messageId=a8a3fb3b-cb1f-4530-a98f-a51e7d7c8fda
2018-04-17 05:53:00.282 [ 14] I DirectiveRouter:handleDirective:messageId=a8a3fb3b-cb1f-4530-a98f-a51e7d7c8fda,action=calling
2018-04-17 05:53:00.282 [  b] 0 AudioInputProcessor:stopCapture:stopImmediately=true
2018-04-17 05:53:00.282 [  b] 0 AudioInputProcessor:setState:from=RECOGNIZING,to=BUSY
2018-04-17 05:53:00.283 [  b] 0 DirectiveProcessor:onHandlingCompeted:messageId=a8a3fb3b-cb1f-4530-a98f-a51e7d7c8fda,directiveBeingPreHandled=(nullptr)
2018-04-17 05:53:00.283 [ 10] 0 DialogUXStateAggregator:setState:from=LISTENING,to=THINKING
2018-04-17 05:53:00.283 [  b] 0 CapabilityAgent:removingMessageIdFromMap:messageId=a8a3fb3b-cb1f-4530-a98f-a51e7d7c8fda
###########################
#       Thinking...       #
###########################

2018-04-17 05:53:00.290 [  c] I InProcessAttachmentReader:readFailed:reason=SDS is closed
2018-04-17 05:53:00.504 [  c] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 0228a5fffee2280a-000015a0-000278d5-31c93f9ceefc1a1c-d5d8142c-117
2018-04-17 05:53:00.504 [  c] 0 HTTP2Stream:libcurl:streamId=29,text=Curl_http_done\: called premature \=\= 0
2018-04-17 05:53:00.504 [  c] 0 AudioInputProcessor:onSendCompleted:status=SUCCESS_NO_CONTENT
2018-04-17 05:53:00.504 [  c] 0 HTTP2Transport:cleanupFinishedStream:streamId=29,result=204
2018-04-17 05:53:00.504 [  c] 0 HTTP2StreamPool:releaseStream:streamId=29,numAcquiredStreams=1
2018-04-17 05:53:00.505 [  c] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT
2018-04-17 05:53:05.284 [ 10] 0 DialogUXStateAggregator:transitionFromThinkingTimedOut
2018-04-17 05:53:05.284 [ 10] 0 DialogUXStateAggregator:setState:from=THINKING,to=IDLE

###########################
#       Speaking...       #
###########################

2018-04-17 06:27:56.000 [  9] 9 HTTP2Transport:enqueueRequest:jsonContent={"event"\:{"header"\:{"namespace"\:"SpeechSynthesizer"\,"name"\:"SpeechStarted"\,"messageId"\:"7b7a68d0-6896-4ed6-9ddc-872336804e88"}\,"payload"\:{"token"\:"amzn1.as-ct.v1.Domain\:Application\:Knowledge#ACRI#8c3b61c6-e004-4517-9e3e-d3c57f47dd7c"}}}
2018-04-17 06:27:56.020 [  2] 9 MediaPlayer:messageReceived:type=eos,source=audio-pipeline
2018-04-17 06:27:56.092 [  c] 0 HTTP2Transport:processNextOutgoingMessage:jsonContent={"event"\:{"header"\:{"namespace"\:"SpeechSynthesizer"\,"name"\:"SpeechStarted"\,"messageId"\:"7b7a68d0-6896-4ed6-9ddc-872336804e88"}\,"payload"\:{"token"\:"amzn1.as-ct.v1.Domain\:Application\:Knowledge#ACRI#8c3b61c6-e004-4517-9e3e-d3c57f47dd7c"}}}
2018-04-17 06:27:56.092 [  c] 0 HTTP2StreamPool:getStream:streamId=7,numAcquiredStreams=2
2018-04-17 06:27:56.092 [  c] 9 HTTP2Transport:insertActiveStream:handle=0x734d7b68
2018-04-17 06:27:56.093 [  c] 0 HTTP2Stream:libcurl:streamId=7,text=Found bundle for host avs-alexa-na.amazon.com\: 0x734021b0 [can multiplex]
2018-04-17 06:27:56.093 [  c] 0 HTTP2Stream:libcurl:streamId=7,text=Conn\: 0 (0x734018d8) Receive pipe weight\: (-1/0)\, penalized\: (nil)
2018-04-17 06:27:56.093 [  c] 0 HTTP2Stream:libcurl:streamId=7,text=Multiplexed connection found!
2018-04-17 06:27:56.093 [  c] 0 HTTP2Stream:libcurl:streamId=7,text=Found connection 0\, with requests in the pipe (1)
2018-04-17 06:27:56.093 [  c] 0 HTTP2Stream:libcurl:streamId=7,text=Re-using existing connection! (#0) with host avs-alexa-na.amazon.com
2018-04-17 06:27:56.093 [  c] 0 HTTP2Stream:libcurl:streamId=7,text=Using Stream ID\: 7 (easy handle 0x734d7b68)
2018-04-17 06:27:56.320 [  2] 9 BaseStreamSource:~BaseStreamSource
2018-04-17 06:27:56.321 [  2] 0 MediaPlayer:callingOnPlaybackFinished:currentId=1
2018-04-17 06:27:56.321 [  2] 9 SpeechSynthesizer:onPlaybackFinished:callbackSourceId=1
2018-04-17 06:27:56.321 [  9] 0 SpeechSynthesizer:executePlaybackFinished
2018-04-17 06:27:56.321 [  9] 9 SpeechSynthesizer:setCurrentStateLocked:state=FINISHED
2018-04-17 06:27:56.321 [  9] 0 SpeechSynthesizer:executeProvideState:stateRequestToken=0
2018-04-17 06:27:56.322 [  9] 0 ContextManager:updateStateLocked:action=updatedState,state={"token"\:"amzn1.as-ct.v1.Domain\:Application\:Knowledge#ACRI#8c3b61c6-e004-4517-9e3e-d3c57f47dd7c"\,"offsetInMilliseconds"\:0\,"playerActivity"\:"FINISHED"},namespace=SpeechSynthesizer,name=SpeechState
2018-04-17 06:27:56.322 [  2] 9 MediaPlayer:tearDownTransientPipelineElements
2018-04-17 06:27:56.322 [  9] 0 EventBuilder:buildJsonEventString:messageId=446dd4d3-4f86-4047-9bbc-5bf243d9bf3c,namespace=SpeechSynthesizer,name=SpeechFinished
2018-04-17 06:27:56.322 [  2] 0 MediaPlayer:saveOffsetBeforeTeardown:offset=744
2018-04-17 06:27:56.322 [  9] 9 HTTP2Transport:enqueueRequest:jsonContent={"event"\:{"header"\:{"namespace"\:"SpeechSynthesizer"\,"name"\:"SpeechFinished"\,"messageId"\:"446dd4d3-4f86-4047-9bbc-5bf243d9bf3c"}\,"payload"\:{"token"\:"amzn1.as-ct.v1.Domain\:Application\:Knowledge#ACRI#8c3b61c6-e004-4517-9e3e-d3c57f47dd7c"}}}
2018-04-17 06:27:56.323 [  9] 9 SpeechSynthesizer:setHandlingCompleted
2018-04-17 06:27:56.323 [  9] 0 DirectiveProcessor:onHandlingCompeted:messageId=5606d206-5d13-4b63-8713-d69e1c18df7e,directiveBeingPreHandled=(nullptr)
2018-04-17 06:27:56.323 [  9] 0 CapabilityAgent:removingMessageIdFromMap:messageId=5606d206-5d13-4b63-8713-d69e1c18df7e
2018-04-17 06:27:56.470 [  c] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 0e9702fffe511af6-0000040f-00022e87-f16dbf378e32388c-87decdf3-1183
2018-04-17 06:27:56.471 [  c] 0 HTTP2Stream:libcurl:streamId=7,text=Curl_http_done\: called premature \=\= 0
2018-04-17 06:27:56.471 [  c] 0 HTTP2Transport:cleanupFinishedStream:streamId=7,result=204
2018-04-17 06:27:56.471 [  c] 0 HTTP2StreamPool:releaseStream:streamId=7,numAcquiredStreams=1
2018-04-17 06:27:56.471 [  c] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT
2018-04-17 06:27:56.471 [  c] 0 HTTP2Transport:processNextOutgoingMessage:jsonContent={"event"\:{"header"\:{"namespace"\:"SpeechSynthesizer"\,"name"\:"SpeechFinished"\,"messageId"\:"446dd4d3-4f86-4047-9bbc-5bf243d9bf3c"}\,"payload"\:{"token"\:"amzn1.as-ct.v1.Domain\:Application\:Knowledge#ACRI#8c3b61c6-e004-4517-9e3e-d3c57f47dd7c"}}}
2018-04-17 06:27:56.472 [  c] 0 HTTP2StreamPool:getStream:streamId=9,numAcquiredStreams=2
2018-04-17 06:27:56.472 [  c] 9 HTTP2Transport:insertActiveStream:handle=0x734d7b68
2018-04-17 06:27:56.472 [  c] 0 HTTP2Stream:libcurl:streamId=9,text=Found bundle for host avs-alexa-na.amazon.com\: 0x734021b0 [can multiplex]
2018-04-17 06:27:56.472 [  c] 0 HTTP2Stream:libcurl:streamId=9,text=Conn\: 0 (0x734018d8) Receive pipe weight\: (-1/0)\, penalized\: (nil)
2018-04-17 06:27:56.472 [  c] 0 HTTP2Stream:libcurl:streamId=9,text=Multiplexed connection found!
2018-04-17 06:27:56.472 [  c] 0 HTTP2Stream:libcurl:streamId=9,text=Found connection 0\, with requests in the pipe (1)
2018-04-17 06:27:56.472 [  c] 0 HTTP2Stream:libcurl:streamId=9,text=Re-using existing connection! (#0) with host avs-alexa-na.amazon.com
2018-04-17 06:27:56.473 [  c] 0 HTTP2Stream:libcurl:streamId=9,text=Using Stream ID\: 9 (easy handle 0x734d7b68)
2018-04-17 06:27:56.523 [  e] 0 DialogUXStateAggregator:setState:from=SPEAKING,to=IDLE

########################################
#       Alexa is currently idle!       #
########################################

2018-04-17 05:53:05.285 [  b] 1 FocusManager:releaseChannel:channelName=Dialog
2018-04-17 05:53:05.285 [  b] 0 AudioInputProcessor:setState:from=BUSY,to=IDLE
2018-04-17 05:53:05.285 [ 11] 9 AudioInputProcessor:onFocusChanged:newFocus=NONE
2018-04-17 05:53:05.285 [  b] 0 AudioInputProcessor:executeOnFocusChanged:newFocus=NONE
2018-04-17 05:53:05.286 [  b] 0 AudioInputProcessor:executeOnFocusChanged:reason=Lost focus

---------------------------------------------------------------------------------------------

thank you for reading my long question!