I can't hear anything from alexa

Hi, Everyone :slight_smile:

link that is 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,

but alexa seems to be responding because I can see message(?) like thinking, speaking at console

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!

Can you here anything when you play a wav file using :

Downlad sample:
wget http://www.music.helsinki.fi/tmt/opetus/uusmedia/esim/a2002011001-e02.wav

Play it:
aplay ./a2002011001-e02.wav

You can use any wav audio file for testing

Hi @yoelrc88 :smile:

Thank you for your reply every time.

I already tested the following way


cd ~/matrixio-kernel-modules

cp misc/asound.conf ~/.asoundrc

arecord --duration 5 --rate 16000 --format S16_LE test.wav &&
aplay ./test.wav


I could hear in this test.

@Jang,

That’s really weird. I have tested that guide many times before. Maybe something changed. I do know that guide is still using Amazon AVS SDk version 1.5 (latest is 1.7) so I will suggest you to give a try to the newer version. We are updating the Hackster guide but in the meantime you can use this guide here.

Please, try this guide starting from scratch, flashing the latest Rapsbian again.
Let us know how it goes/

-Yoel

@yoelrc88

I tried new guide you attached but when I executed the following command

bash ./setup.sh ./config.txt

I got a error

E: Package ‘libcur14-openssl-dev’ has no installation candidate

What Raspbian version are you using ?

I tried NOOBS_v2.7.0 and I also tried ‘2018-04-18-raspbian-stretch’

Can you share the whole output ?
bash ./setup.sh ./config.txt

@yoelrc88 Thank you for your continued interest :slight_smile:

I can’t upload log so that size of log is so big, therefore I upload file through wetransfer
the output file you requested is here
but I missed front part of whole log and the shape of output can be inconvenient
because I’m not familiar with linux
if you require the part I missed or know how to view more comfortable, let me know
then I’ll try again

For your reference, I succeeded in operating the google assistant at site below
https://www.hackster.io/matrix-labs/matrix-voice-and-matrix-creator-running-google-assistant

From what i saw in the log it looks like you didn’t get any errors when building the Alexa project:

...
[ 95%] Building CXX object SampleApp/src/CMakeFiles/SampleApp.dir/InteractionManager.cpp.o
[ 96%] Building CXX object SampleApp/src/CMakeFiles/SampleApp.dir/KeywordObserver.cpp.o
[ 96%] Building CXX object SampleApp/src/CMakeFiles/SampleApp.dir/PortAudioMicrophoneWrapper.cpp.o
[ 97%] Building CXX object SampleApp/src/CMakeFiles/SampleApp.dir/UIManager.cpp.o
[ 97%] Building CXX object SampleApp/src/CMakeFiles/SampleApp.dir/UserInputManager.cpp.o
[ 98%] Building CXX object SampleApp/src/CMakeFiles/SampleApp.dir/SampleApplication.cpp.o
[ 98%] Building CXX object SampleApp/src/CMakeFiles/SampleApp.dir/main.cpp.o
[100%] Linking CXX executable SampleApp
[100%] Built target SampleApp

And also it looks like the setup.sh finished with any error. I didn’t see any error related to libcur14-openssl-dev mentioned before.

Is there something I am missing?

Regarding

This is great!

-Yoel

Thank you for reply @yoelrc88 :smile:

I didn’t see any error either, So it’s weird…

looking at console , Alexa seems to work well on the console

Google assistant works well, but not alexa…

is the speaker ouput setting wrong?

I tried all of the audio ouput setting in alexa app but alexa not working : :joy:

Can you share the output of the SampleApp running?

I reinstalled alexa app and got a full log about setup, startsample

you can download the log file at here

I attached both pdf and odt file formats to make it easier for you to view

thank you for your interest @yoelrc88 :smile:

Your output files look good, I dont see any errors or problems there.

Just to confirm, are you connecting a speaker/headphone to the 3.5mm audio jack in the Raspberry Pi.

Are you using an HDMI monitor ?

-Yoel

Sorry @yoelrc88 I’m late : :sweat:

I am connecting a speaker to the 3.5mm audio jack in the Raspberry Pi

I am using an DVI monitor through HDIM to DVI Converter

Thank you have a good day! :smile:

I’m also experiencing the same issue Jang. Here’s what happens when I use t for test or just regularly saying Alexa.

t
2018-05-28 15:51:54.209 [  b] 0 AudioInputProcessor:setState:from=IDLE,to=RECOGNIZING
2018-05-28 15:51:54.209 [  e] 0 DialogUXStateAggregator:setState:from=IDLE,to=LISTENING
2018-05-28 15:51:54.210 [  a] 0 ExternalMediaPlayer:executeProvideState:sendToken=true,stateRequestToken=2
############################
#       Listening...       #
############################

2018-05-28 15:51:54.210 [  a] 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-05-28 15:51:54.209 [  7] 0 NotificationsCapabilityAgent:provideState:stateRequestToken=2
2018-05-28 15:51:54.210 [  a] 0 ExternalMediaPlayer:executeProvideState:sendToken=true,stateRequestToken=2
2018-05-28 15:51:54.210 [  4] 5 NotificationsCapabilityAgent:executeProvideState:sendToken=true,stateRequestToken=2
2018-05-28 15:51:54.211 [  a] 0 ContextManager:updateStateLocked:action=updatedState,state={"playerInFocus"\:""\,"players"\:[]},namespace=ExternalMediaPlayer,name=ExternalMediaPlayerState
2018-05-28 15:51:54.211 [  4] 0 ContextManager:updateStateLocked:action=updatedState,state={"isEnabled"\:false\,"isVisualIndicatorPersisted"\:false},namespace=Notifications,name=IndicatorState
2018-05-28 15:51:54.213 [  7] 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"\:""\,"offsetInMilliseconds"\:0\,"playerActivity"\:"FINISHED"}}\,{"header"\:{"namespace"\:"AudioPlayer"\,"name"\:"PlaybackState"}\,"payload"\:{"token"\:""\,"offsetInMilliseconds"\:0\,"playerActivity"\:"IDLE"}}\,{"header"\:{"namespace"\:"SpeechRecognizer"\,"name"\:"RecognizerState"}\,"payload"\:{"wakeword"\:""}}\,{"header"\:{"namespace"\:"Alerts"\,"name"\:"AlertsState"}\,"payload"\:{"allAlerts"\:[]\,"activeAlerts"\:[]}}]}
2018-05-28 15:51:54.214 [  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"\:""\,"offsetInMilliseconds"\:0\,"playerActivity"\:"FINISHED"}}\,{"header"\:{"namespace"\:"AudioPlayer"\,"name"\:"PlaybackState"}\,"payload"\:{"token"\:""\,"offsetInMilliseconds"\:0\,"playerActivity"\:"IDLE"}}\,{"header"\:{"namespace"\:"SpeechRecognizer"\,"name"\:"RecognizerState"}\,"payload"\:{"wakeword"\:""}}\,{"header"\:{"namespace"\:"Alerts"\,"name"\:"AlertsState"}\,"payload"\:{"allAlerts"\:[]\,"activeAlerts"\:[]}}]}
2018-05-28 15:51:54.214 [  b] 1 FocusManager:acquireChannel:channelName=Dialog,activityId=SpeechRecognizer.Recognize
2018-05-28 15:51:54.215 [  b] I DirectiveProcessor:setDialogRequestIdLocked:oldValue=,newValue=4bd529ab-a12f-4e13-a78e-a283defff53e
2018-05-28 15:51:54.215 [  b] 0 DirectiveProcessor:scrubDialogRequestIdLocked:reason=emptyDialogRequestId
2018-05-28 15:51:54.216 [  f] 9 AudioInputProcessor:onFocusChanged:newFocus=FOREGROUND
2018-05-28 15:51:54.217 [  b] 0 EventBuilder:buildJsonEventString:messageId=89844aef-9224-4128-ba71-f44b766d8f6b,namespace=SpeechRecognizer,name=Recognize
2018-05-28 15:51:54.218 [  b] 0 AudioInputProcessor:executeOnFocusChanged:newFocus=FOREGROUND
2018-05-28 15:51:54.218 [  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"\:""\,"offsetInMilliseconds"\:0\,"playerActivity"\:"FINISHED"}}\,{"header"\:{"namespace"\:"AudioPlayer"\,"name"\:"PlaybackState"}\,"payload"\:{"token"\:""\,"offsetInMilliseconds"\:0\,"playerActivity"\:"IDLE"}}\,{"header"\:{"namespace"\:"SpeechRecognizer"\,"name"\:"RecognizerState"}\,"payload"\:{"wakeword"\:""}}\,{"header"\:{"namespace"\:"Alerts"\,"name"\:"AlertsState"}\,"payload"\:{"allAlerts"\:[]\,"activeAlerts"\:[]}}]\,"event"\:{"header"\:{"namespace"\:"SpeechRecognizer"\,"name"\:"Recognize"\,"messageId"\:"89844aef-9224-4128-ba71-f44b766d8f6b"\,"dialogRequestId"\:"4bd529ab-a12f-4e13-a78e-a283defff53e"}\,"payload"\:{"profile"\:"NEAR_FIELD"\,"format"\:"AUDIO_L16_RATE_16000_CHANNELS_1"\,"initiator"\:{"type"\:"TAP"\,"payload"\:{}}}}}
2018-05-28 15:51:54.252 [  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"\:""\,"offsetInMilliseconds"\:0\,"playerActivity"\:"FINISHED"}}\,{"header"\:{"namespace"\:"AudioPlayer"\,"name"\:"PlaybackState"}\,"payload"\:{"token"\:""\,"offsetInMilliseconds"\:0\,"playerActivity"\:"IDLE"}}\,{"header"\:{"namespace"\:"SpeechRecognizer"\,"name"\:"RecognizerState"}\,"payload"\:{"wakeword"\:""}}\,{"header"\:{"namespace"\:"Alerts"\,"name"\:"AlertsState"}\,"payload"\:{"allAlerts"\:[]\,"activeAlerts"\:[]}}]\,"event"\:{"header"\:{"namespace"\:"SpeechRecognizer"\,"name"\:"Recognize"\,"messageId"\:"89844aef-9224-4128-ba71-f44b766d8f6b"\,"dialogRequestId"\:"4bd529ab-a12f-4e13-a78e-a283defff53e"}\,"payload"\:{"profile"\:"NEAR_FIELD"\,"format"\:"AUDIO_L16_RATE_16000_CHANNELS_1"\,"initiator"\:{"type"\:"TAP"\,"payload"\:{}}}}}
2018-05-28 15:51:54.252 [  c] 0 HTTP2StreamPool:getStream:streamId=5,numAcquiredStreams=2
2018-05-28 15:51:54.253 [  c] 9 HTTP2Transport:insertActiveStream:handle=0x73fde150
2018-05-28 15:51:54.254 [  c] 0 HTTP2Stream:libcurl:streamId=5,text=Found bundle for host avs-alexa-na.amazon.com\: 0x73f02268 [can multiplex]
2018-05-28 15:51:54.254 [  c] 0 HTTP2Stream:libcurl:streamId=5,text=Conn\: 0 (0x73f01958) Receive pipe weight\: (-1/0)\, penalized\: (nil)
2018-05-28 15:51:54.254 [  c] 0 HTTP2Stream:libcurl:streamId=5,text=Multiplexed connection found!
2018-05-28 15:51:54.254 [  c] 0 HTTP2Stream:libcurl:streamId=5,text=Found connection 0\, with requests in the pipe (1)
2018-05-28 15:51:54.254 [  c] 0 HTTP2Stream:libcurl:streamId=5,text=Re-using existing connection! (#0) with host avs-alexa-na.amazon.com
2018-05-28 15:51:54.255 [  c] 0 HTTP2Stream:libcurl:streamId=5,text=Using Stream ID\: 5 (easy handle 0x73fde150)
2018-05-28 15:51:57.426 [ 10] 0 MessageInterpreter:receive:messageId=020da065-5c21-4824-ad66-bff8effca5b1:No dialogRequestId attached to message.
2018-05-28 15:51:57.428 [ 10] I DirectiveSequencer:onDirective:directive={"namespace\:"SpeechRecognizer"\,name\:"StopCapture"\,messageId\:"020da065-5c21-4824-ad66-bff8effca5b1"\,dialogRequestId\:""}
2018-05-28 15:51:57.430 [ 11] I DirectiveRouter:preHandleDirective:messageId=020da065-5c21-4824-ad66-bff8effca5b1,action=calling
2018-05-28 15:51:57.431 [ 11] 0 CapabilityAgent:addingMessageIdToMap:messageId=020da065-5c21-4824-ad66-bff8effca5b1
2018-05-28 15:51:57.433 [ 12] I DirectiveRouter:handleDirective:messageId=020da065-5c21-4824-ad66-bff8effca5b1,action=calling
2018-05-28 15:51:57.434 [  b] 0 AudioInputProcessor:stopCapture:stopImmediately=true
2018-05-28 15:51:57.434 [  b] 0 AudioInputProcessor:setState:from=RECOGNIZING,to=BUSY
2018-05-28 15:51:57.434 [  e] 0 DialogUXStateAggregator:setState:from=LISTENING,to=THINKING
2018-05-28 15:51:57.434 [  b] 0 DirectiveProcessor:onHandlingCompeted:messageId=020da065-5c21-4824-ad66-bff8effca5b1,directiveBeingPreHandled=(nullptr)
###########################
#       Thinking...       #
###########################

2018-05-28 15:51:57.435 [  b] 0 CapabilityAgent:removingMessageIdFromMap:messageId=020da065-5c21-4824-ad66-bff8effca5b1
2018-05-28 15:51:57.437 [  c] I InProcessAttachmentReader:readFailed:reason=SDS is closed
2018-05-28 15:51:57.903 [  c] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 02036cfffef4aee6-000048c9-00179351-4add814456370ab6-cb2d953e-49
2018-05-28 15:51:57.905 [ 10] I DirectiveSequencer:onDirective:directive={"namespace\:"SpeechSynthesizer"\,name\:"Speak"\,messageId\:"ebe67a9e-a0ef-41b5-bf98-5a4b408fb462"\,dialogRequestId\:"4bd529ab-a12f-4e13-a78e-a283defff53e"}
2018-05-28 15:51:57.906 [ 11] I DirectiveRouter:preHandleDirective:messageId=ebe67a9e-a0ef-41b5-bf98-5a4b408fb462,action=calling
2018-05-28 15:51:57.906 [ 11] 0 CapabilityAgent:addingMessageIdToMap:messageId=ebe67a9e-a0ef-41b5-bf98-5a4b408fb462
2018-05-28 15:51:57.906 [ 11] 9 SpeechSynthesizer:preHandleDirective:messageId=ebe67a9e-a0ef-41b5-bf98-5a4b408fb462
2018-05-28 15:51:57.907 [  8] 0 SpeechSynthesizer:executePreHandle:messageId=ebe67a9e-a0ef-41b5-bf98-5a4b408fb462
2018-05-28 15:51:57.907 [ 12] I DirectiveRouter:handleDirective:messageId=ebe67a9e-a0ef-41b5-bf98-5a4b408fb462,action=calling
2018-05-28 15:51:57.907 [ 12] 9 SpeechSynthesizer:handleDirective:messageId=ebe67a9e-a0ef-41b5-bf98-5a4b408fb462
2018-05-28 15:51:57.912 [  c] 0 HTTP2Stream:libcurl:streamId=5,text=Curl_http_done\: called premature \=\= 0
2018-05-28 15:51:57.913 [  c] 0 AudioInputProcessor:onSendCompleted:status=SUCCESS
2018-05-28 15:51:57.913 [  c] 0 HTTP2Transport:cleanupFinishedStream:streamId=5,result=200
2018-05-28 15:51:57.913 [  c] 0 HTTP2StreamPool:releaseStream:streamId=5,numAcquiredStreams=1
2018-05-28 15:51:57.914 [  8] 0 SpeechSynthesizer:executeHandle:messageId=ebe67a9e-a0ef-41b5-bf98-5a4b408fb462
2018-05-28 15:51:57.914 [  8] 1 FocusManager:acquireChannel:channelName=Dialog,activityId=SpeechSynthesizer.Speak
2018-05-28 15:51:57.914 [  f] 9 AudioInputProcessor:onFocusChanged:newFocus=NONE
2018-05-28 15:51:57.915 [  b] 0 AudioInputProcessor:executeOnFocusChanged:newFocus=NONE
2018-05-28 15:51:57.915 [  f] 0 SpeechSynthesizer:onFocusChanged:newFocus=FOREGROUND
2018-05-28 15:51:57.915 [  b] 0 AudioInputProcessor:executeOnFocusChanged:reason=Lost focus
2018-05-28 15:51:57.915 [  f] 9 SpeechSynthesizer:setCurrentStateLocked:state=GAINING_FOCUS
2018-05-28 15:51:57.915 [  b] 0 AudioInputProcessor:setState:from=BUSY,to=IDLE
2018-05-28 15:51:57.916 [  8] 0 SpeechSynthesizer:executeStateChange:newState=PLAYING
2018-05-28 15:51:57.916 [  8] 9 SpeechSynthesizer:startPlaying
2018-05-28 15:51:57.917 [  8] 9 MediaPlayer:setSourceCalled:sourceType=AttachmentReader
2018-05-28 15:51:57.917 [  2] 0 MediaPlayer:handleSetSourceCalled
2018-05-28 15:51:57.917 [  2] 9 MediaPlayer:tearDownTransientPipelineElements
2018-05-28 15:51:57.922 [  2] E MediaPlayer:saveOffsetBeforeTeardown - gst_element_query_position failed
2018-05-28 15:51:57.926 [  2] 9 BaseStreamSource:initNoAudioFormat
2018-05-28 15:51:57.966 [  8] 9 MediaPlayer:playCalled
2018-05-28 15:51:57.967 [  2] 0 MediaPlayer:handlePlayCalled:idPassed=1,currentId=1
2018-05-28 15:51:58.105 [  2] 9 AttachmentReaderSource:handleSeekData:offset=0
2018-05-28 15:51:58.105 [  2] 0 MediaPlayer:handlePlay:startingState=PLAYING,stateReturn=ASYNC
2018-05-28 15:51:58.106 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=audio_sink
2018-05-28 15:51:58.106 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=volume
2018-05-28 15:51:58.106 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=converter
2018-05-28 15:51:58.106 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=decodedQueue
2018-05-28 15:51:58.106 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=typefind
2018-05-28 15:51:58.106 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=decoder
2018-05-28 15:51:58.106 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=src
2018-05-28 15:51:58.106 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=audio-pipeline
2018-05-28 15:51:58.106 [  2] 9 MediaPlayer:State Change:oldState=NULL,newState=READY,pendingState=PLAYING
2018-05-28 15:51:58.106 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=volume
2018-05-28 15:51:58.106 [ 13] 9 BaseStreamSource:onNeedDataCalled:size=4096
2018-05-28 15:51:58.106 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=converter
2018-05-28 15:51:58.106 [  2] 9 MediaPlayer:messageReceived:type=stream-status,source=src
2018-05-28 15:51:58.106 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=decodedQueue
2018-05-28 15:51:58.106 [  2] 9 MediaPlayer:messageReceived:type=stream-status,source=src
2018-05-28 15:51:58.106 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=typefind
2018-05-28 15:51:58.106 [  2] 9 MediaPlayer:messageReceived:type=stream-status,source=src
2018-05-28 15:51:58.107 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=src
2018-05-28 15:51:58.107 [  2] 9 MediaPlayer:messageReceived:type=stream-status,source=src
2018-05-28 15:51:58.107 [  2] 9 BaseStreamSource:handleNeedDataCalled
2018-05-28 15:51:58.107 [  2] 9 BaseStreamSource:installOnReadDataHandler:action=newSourceId,sourceId=15
2018-05-28 15:51:58.107 [  2] 9 AttachmentReaderSource:read:size=4096,status=0
2018-05-28 15:51:58.107 [  2] 9 AttachmentReaderSource:read:size=4096,status=0
2018-05-28 15:51:58.107 [  2] 9 AttachmentReaderSource:read:size=61,status=0
2018-05-28 15:51:58.107 [  2] I InProcessAttachmentReader:readFailed:reason=SDS is closed
2018-05-28 15:51:58.107 [  2] 9 AttachmentReaderSource:read:size=0,status=3
2018-05-28 15:51:58.108 [  2] 9 AttachmentReaderSource:handleReadData:info=signalingEndOfData
2018-05-28 15:51:58.108 [  2] 9 BaseStreamSource:signalEndOfDataCalled
2018-05-28 15:51:58.108 [  2] 9 BaseStreamSource:gstAppSrcEndOfStreamSuccess
2018-05-28 15:51:58.108 [  2] 9 BaseStreamSource:clearOnReadDataHandlerCalled:sourceId=15
2018-05-28 15:51:58.159 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=id3demux0
2018-05-28 15:51:58.159 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=id3demux0
2018-05-28 15:51:58.170 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=mpegaudioparse0
2018-05-28 15:51:58.171 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=mpegaudioparse0
2018-05-28 15:51:58.193 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=mad0
2018-05-28 15:51:58.193 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=mad0
2018-05-28 15:51:58.196 [ 13] 9 MediaPlayer:onPadAddedCalled
2018-05-28 15:51:58.197 [  2] 9 MediaPlayer:handlePadAddedSignalCalled
2018-05-28 15:51:58.200 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=decoder
2018-05-28 15:51:58.201 [  2] 9 MediaPlayer:messageReceived:type=stream-start,source=audio-pipeline
2018-05-28 15:51:58.226 [  2] 9 MediaPlayer:messageReceived:type=latency,source=audio_sink-actual-sink-omxhdmiaudio
2018-05-28 15:51:58.226 [  2] 9 MediaPlayer:messageReceived:type=stream-status,source=audiosinkringbuffer0
2018-05-28 15:51:58.227 [  2] 9 MediaPlayer:messageReceived:type=tag,source=audio_sink-actual-sink-omxhdmiaudio
2018-05-28 15:51:58.228 [  2] 0 MediaPlayer:callingOnTags
2018-05-28 15:51:58.229 [  2] 9 MediaPlayer:messageReceived:type=tag,source=audio_sink-actual-sink-omxhdmiaudio
2018-05-28 15:51:58.229 [  2] 0 MediaPlayer:callingOnTags
2018-05-28 15:51:58.229 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=audio_sink-actual-sink-omxhdmiaudio
2018-05-28 15:51:58.229 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=audio_sink
2018-05-28 15:51:58.229 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=audio-pipeline
2018-05-28 15:51:58.229 [  2] 9 MediaPlayer:State Change:oldState=READY,newState=PAUSED,pendingState=PLAYING
2018-05-28 15:51:58.230 [  2] 9 MediaPlayer:messageReceived:type=async-done,source=audio-pipeline
2018-05-28 15:51:58.231 [  2] 9 MediaPlayer:messageReceived:type=new-clock,source=audio-pipeline
2018-05-28 15:51:58.234 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=audio_sink-actual-sink-omxhdmiaudio
2018-05-28 15:51:58.234 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=audio_sink
2018-05-28 15:51:58.235 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=volume
2018-05-28 15:51:58.235 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=converter
2018-05-28 15:51:58.237 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=decodedQueue
2018-05-28 15:51:58.238 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=mad0
2018-05-28 15:51:58.239 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=mpegaudioparse0
2018-05-28 15:51:58.240 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=id3demux0
2018-05-28 15:51:58.240 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=typefind
2018-05-28 15:51:58.240 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=decoder
2018-05-28 15:51:58.240 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=src
2018-05-28 15:51:58.240 [  2] 9 MediaPlayer:messageReceived:type=state-changed,source=audio-pipeline
2018-05-28 15:51:58.241 [  2] 9 MediaPlayer:State Change:oldState=PAUSED,newState=PLAYING,pendingState=VOID_PENDING
2018-05-28 15:51:58.241 [  2] 0 MediaPlayer:callingOnPlaybackStarted:currentId=1
2018-05-28 15:51:58.241 [  2] 9 SpeechSynthesizer:onPlaybackStarted:callbackSourceId=1
2018-05-28 15:51:58.241 [  8] 0 SpeechSynthesizer:executePlaybackStarted
2018-05-28 15:51:58.242 [  8] 9 SpeechSynthesizer:setCurrentStateLocked:state=PLAYING
2018-05-28 15:51:58.242 [  8] 0 SpeechSynthesizer:executeProvideState:stateRequestToken=0
2018-05-28 15:51:58.242 [  8] 9 MediaPlayer:getOffsetCalled
2018-05-28 15:51:58.242 [  2] 0 MediaPlayer:handleGetOffsetCalled:idPassed=1,currentId=1
2018-05-28 15:51:58.244 [  8] 0 ContextManager:updateStateLocked:action=updatedState,state={"token"\:"amzn1.as-ct.v1.Domain\:Application\:Knowledge#ACRI#72e3fb54-cfce-4183-b250-6f3e0e59cadd"\,"offsetInMilliseconds"\:48\,"playerActivity"\:"PLAYING"},namespace=SpeechSynthesizer,name=SpeechState
2018-05-28 15:51:58.245 [  8] 0 EventBuilder:buildJsonEventString:messageId=2dc20143-b2bb-423f-8bfa-398a49343c91,namespace=SpeechSynthesizer,name=SpeechStarted
2018-05-28 15:51:58.246 [  8] 9 HTTP2Transport:enqueueRequest:jsonContent={"event"\:{"header"\:{"namespace"\:"SpeechSynthesizer"\,"name"\:"SpeechStarted"\,"messageId"\:"2dc20143-b2bb-423f-8bfa-398a49343c91"}\,"payload"\:{"token"\:"amzn1.as-ct.v1.Domain\:Application\:Knowledge#ACRI#72e3fb54-cfce-4183-b250-6f3e0e59cadd"}}}
2018-05-28 15:51:58.246 [  e] 0 DialogUXStateAggregator:setState:from=THINKING,to=SPEAKING
###########################
#       Speaking...       #
###########################

2018-05-28 15:51:58.248 [  f] 9 SpeechSynthesizer:onFocusChangedSuccess
2018-05-28 15:51:58.249 [  2] 9 MediaPlayer:messageReceived:type=tag,source=audio_sink-actual-sink-omxhdmiaudio
2018-05-28 15:51:58.250 [  2] 0 MediaPlayer:callingOnTags
2018-05-28 15:51:58.271 [ 13] 9 BaseStreamSource:onNeedDataCalled:size=4096
2018-05-28 15:51:58.272 [  2] 9 BaseStreamSource:handleNeedDataCalled
2018-05-28 15:51:58.315 [  c] 0 HTTP2Transport:processNextOutgoingMessage:jsonContent={"event"\:{"header"\:{"namespace"\:"SpeechSynthesizer"\,"name"\:"SpeechStarted"\,"messageId"\:"2dc20143-b2bb-423f-8bfa-398a49343c91"}\,"payload"\:{"token"\:"amzn1.as-ct.v1.Domain\:Application\:Knowledge#ACRI#72e3fb54-cfce-4183-b250-6f3e0e59cadd"}}}
2018-05-28 15:51:58.315 [  c] 0 HTTP2StreamPool:getStream:streamId=7,numAcquiredStreams=2
2018-05-28 15:51:58.316 [  c] 9 HTTP2Transport:insertActiveStream:handle=0x73fde150
2018-05-28 15:51:58.316 [  c] 0 HTTP2Stream:libcurl:streamId=7,text=Found bundle for host avs-alexa-na.amazon.com\: 0x73f02268 [can multiplex]
2018-05-28 15:51:58.316 [  c] 0 HTTP2Stream:libcurl:streamId=7,text=Conn\: 0 (0x73f01958) Receive pipe weight\: (-1/0)\, penalized\: (nil)
2018-05-28 15:51:58.316 [  c] 0 HTTP2Stream:libcurl:streamId=7,text=Multiplexed connection found!
2018-05-28 15:51:58.316 [  c] 0 HTTP2Stream:libcurl:streamId=7,text=Found connection 0\, with requests in the pipe (1)
2018-05-28 15:51:58.316 [  c] 0 HTTP2Stream:libcurl:streamId=7,text=Re-using existing connection! (#0) with host avs-alexa-na.amazon.com
2018-05-28 15:51:58.317 [  c] 0 HTTP2Stream:libcurl:streamId=7,text=Using Stream ID\: 7 (easy handle 0x73fde150)
2018-05-28 15:51:58.506 [  c] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 02036cfffef4aee6-000048c9-0017b528-3ff232a4636df4b1-b0db7f49-7
2018-05-28 15:51:58.506 [  c] 0 HTTP2Stream:libcurl:streamId=7,text=Curl_http_done\: called premature \=\= 0
2018-05-28 15:51:58.506 [  c] 0 HTTP2Transport:cleanupFinishedStream:streamId=7,result=204
2018-05-28 15:51:58.506 [  c] 0 HTTP2StreamPool:releaseStream:streamId=7,numAcquiredStreams=1
2018-05-28 15:51:58.506 [  c] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT
2018-05-28 15:51:58.708 [  2] 9 MediaPlayer:messageReceived:type=eos,source=audio-pipeline
2018-05-28 15:51:59.009 [  2] 9 BaseStreamSource:~BaseStreamSource
2018-05-28 15:51:59.009 [  2] 0 MediaPlayer:callingOnPlaybackFinished:currentId=1
2018-05-28 15:51:59.009 [  2] 9 SpeechSynthesizer:onPlaybackFinished:callbackSourceId=1
2018-05-28 15:51:59.010 [  2] 9 MediaPlayer:tearDownTransientPipelineElements
2018-05-28 15:51:59.010 [  8] 0 SpeechSynthesizer:executePlaybackFinished
2018-05-28 15:51:59.010 [  8] 9 SpeechSynthesizer:setCurrentStateLocked:state=FINISHED
2018-05-28 15:51:59.010 [  8] 0 SpeechSynthesizer:executeProvideState:stateRequestToken=0
2018-05-28 15:51:59.010 [  2] 0 MediaPlayer:saveOffsetBeforeTeardown:offset=1368
2018-05-28 15:51:59.010 [  8] 0 ContextManager:updateStateLocked:action=updatedState,state={"token"\:"amzn1.as-ct.v1.Domain\:Application\:Knowledge#ACRI#72e3fb54-cfce-4183-b250-6f3e0e59cadd"\,"offsetInMilliseconds"\:0\,"playerActivity"\:"FINISHED"},namespace=SpeechSynthesizer,name=SpeechState
2018-05-28 15:51:59.011 [  8] 0 EventBuilder:buildJsonEventString:messageId=8f99577b-51f1-432b-aa79-e20acf8d09fe,namespace=SpeechSynthesizer,name=SpeechFinished
2018-05-28 15:51:59.012 [  8] 9 HTTP2Transport:enqueueRequest:jsonContent={"event"\:{"header"\:{"namespace"\:"SpeechSynthesizer"\,"name"\:"SpeechFinished"\,"messageId"\:"8f99577b-51f1-432b-aa79-e20acf8d09fe"}\,"payload"\:{"token"\:"amzn1.as-ct.v1.Domain\:Application\:Knowledge#ACRI#72e3fb54-cfce-4183-b250-6f3e0e59cadd"}}}
2018-05-28 15:51:59.012 [  8] 9 SpeechSynthesizer:setHandlingCompleted
2018-05-28 15:51:59.012 [  8] 0 DirectiveProcessor:onHandlingCompeted:messageId=ebe67a9e-a0ef-41b5-bf98-5a4b408fb462,directiveBeingPreHandled=(nullptr)
2018-05-28 15:51:59.012 [  8] 0 CapabilityAgent:removingMessageIdFromMap:messageId=ebe67a9e-a0ef-41b5-bf98-5a4b408fb462
2018-05-28 15:51:59.109 [  c] 0 HTTP2Transport:processNextOutgoingMessage:jsonContent={"event"\:{"header"\:{"namespace"\:"SpeechSynthesizer"\,"name"\:"SpeechFinished"\,"messageId"\:"8f99577b-51f1-432b-aa79-e20acf8d09fe"}\,"payload"\:{"token"\:"amzn1.as-ct.v1.Domain\:Application\:Knowledge#ACRI#72e3fb54-cfce-4183-b250-6f3e0e59cadd"}}}
2018-05-28 15:51:59.109 [  c] 0 HTTP2StreamPool:getStream:streamId=9,numAcquiredStreams=2
2018-05-28 15:51:59.109 [  c] 9 HTTP2Transport:insertActiveStream:handle=0x73fde150
2018-05-28 15:51:59.110 [  c] 0 HTTP2Stream:libcurl:streamId=9,text=Found bundle for host avs-alexa-na.amazon.com\: 0x73f02268 [can multiplex]
2018-05-28 15:51:59.110 [  c] 0 HTTP2Stream:libcurl:streamId=9,text=Conn\: 0 (0x73f01958) Receive pipe weight\: (-1/0)\, penalized\: (nil)
2018-05-28 15:51:59.110 [  c] 0 HTTP2Stream:libcurl:streamId=9,text=Multiplexed connection found!
2018-05-28 15:51:59.110 [  c] 0 HTTP2Stream:libcurl:streamId=9,text=Found connection 0\, with requests in the pipe (1)
2018-05-28 15:51:59.110 [  c] 0 HTTP2Stream:libcurl:streamId=9,text=Re-using existing connection! (#0) with host avs-alexa-na.amazon.com
2018-05-28 15:51:59.110 [  c] 0 HTTP2Stream:libcurl:streamId=9,text=Using Stream ID\: 9 (easy handle 0x73fde150)
2018-05-28 15:51:59.212 [  e] 0 DialogUXStateAggregator:setState:from=SPEAKING,to=IDLE
2018-05-28 15:51:59.213 [  8] 1 FocusManager:releaseChannel:channelName=Dialog
########################################
#       Alexa is currently idle!       #
########################################

2018-05-28 15:51:59.213 [  f] 0 SpeechSynthesizer:onFocusChanged:newFocus=NONE
2018-05-28 15:51:59.275 [  c] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 02036cfffef4aee6-000048c9-0017794f-7d2285284dec870c-8daa8515-27
2018-05-28 15:51:59.275 [  c] 0 HTTP2Stream:libcurl:streamId=9,text=Curl_http_done\: called premature \=\= 0
2018-05-28 15:51:59.276 [  c] 0 HTTP2Transport:cleanupFinishedStream:streamId=9,result=204
2018-05-28 15:51:59.276 [  c] 0 HTTP2StreamPool:releaseStream:streamId=9,numAcquiredStreams=1
2018-05-28 15:51:59.276 [  c] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT

I’m grad you had symptoms like me :slight_smile:

I still have problems… :joy:

Let me know if you solved problem~

if i solve problem first, I’ll tell you the solution :smile:

@Jang I did a little more digging and someone else here was having the same issue on another thread and they fixed it with this! It also fixed the issue I was having!
Here’s a link to the thread: [Solved] Matrix Voice and Alexa SDK no audio output issue