Closed zeusshuang closed 6 years ago
ryan-esty
commented
6 years ago @zeusshuang,
There's a MEDIA_ERROR_INTERNAL_DEVICE_ERROR in your log. Another issue #242 suggests a way to enable more debug for this particular type of failure. If possible more logging might help debug the issue further.
Ryan
frozenberg
commented
6 years ago @zeusshuang, just like @ryan-esty it will be useful to print out gst debug logs. Run export GST_DEBUG=3 and then attempt to reproduce the issue.
Thanks
zeusshuang
commented
6 years ago Thanks for the information, I will try it.
zeusshuang
commented
6 years ago After I export GST_DEBUG=3 and reproduce this case, it said : No URI specified to play from. It's because I do not have any working model message to comparison with, any suggestion for the next step ? Is it related to playlist parser ? Before the "MEDIA_ERROR_INTERNAL_DEVICE_ERROR" message, I saw the "enableLibCurlCookieEngineFailed", is it a must item ?
zeusshuang
commented
6 years ago after I modified the curl, it seems it's more clear about the fail reason , it said no x-hls supported. However, it's actually built in gst-bad-plugins , is there anything I can check with ?
[ b] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 0ae1aafffe42e722-000069b0-0000a47d-e325d8aae491a346-7e20d014-13 878 [ b] 0 HTTP2Transport:cleanupFinishedStream:streamId=13,result=204 879 [ b] 0 HTTP2StreamPool:releaseStream:streamId=13,numAcquiredStreams=1 879 [ b] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT 420 [ 2] 9 MediaPlayer:messageReceived:messageType=duration-changed 429 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 429 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 429 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 433 [ 2] 9 MediaPlayer:messageReceived:messageType=element 434 [ 2] 9 MediaPlayer:messageReceived:messageType=warning 436 [ 2] 9 MediaPlayer:messageReceived:messageType=error 436 [ 2] E MediaPlayer:handleBusMessageError:source=decoder,error=Your GStreamer installation is missing a plug-in.,debug=gsturidecodebin.c(1005)\: no_more_pads_full ()\: /GstPipeline\:audio-pipeline/GstURIDecodeBin\:decoder\: no suitable plugins found\: gstdecodebin2.c(4592)\: gst_decode_bin_expose ()\: /GstPipeline\:audio-pipeline/GstURIDecodeBin\:decoder/GstDecodeBin\:decodebin0\: no suitable plugins found\: Missing decoder\: application/x-hls (application/x-hls)
436 [ 2] 0 MediaPlayer:callingOnPlaybackError:type=MEDIA_ERROR_INTERNAL_DEVICE_ERROR,error=Your GStreamer installation is missing a plug-in.,currentId=2
zeusshuang
commented
6 years ago Hi AVS team,
It's another failed log from Respberry Pi , seems the same fail as my previous log (my previous log is from our own platform). Is it possible that I am not in the States ?
2017-11-07 06:13:12.178 [ 8] 0 AudioInputProcessor:setState:from=IDLE,to=RECOGNIZING 2017-11-07 06:13:12.179 [ b] 0 DialogUXStateAggregator:setState:from=IDLE,to=LISTENING 2017-11-07 06:13:12.180 [ 6] 0 ContextManager:buildContextSuccessful:context={"context"\:[{"header"\:{"namespace"\:"AudioPlayer"\,"name"\:"PlaybackState"}\,"payload"\:{"token"\:""\,"offsetInMilliseconds"\:0\,"playerActivity"\:"IDLE"}}\,{"header"\:{"namespace"\:"SpeechSynthesizer"\,"name"\:"SpeechState"}\,"payload"\:{"token"\:"amzn1.as-ct.v1.#ACRI#ErrorNotifier_732a811c-fce8-47cb-8d7f-a962168fe8fb"\,"offsetInMilliseconds"\:0\,"playerActivity"\:"FINISHED"}}\,{"header"\:{"namespace"\:"Alerts"\,"name"\:"AlertsState"}\,"payload"\:{"allAlerts"\:[]\,"activeAlerts"\:[]}}\,{"header"\:{"namespace"\:"SpeechRecognizer"\,"name"\:"RecognizerState"}\,"payload"\:{"wakeword"\:""}}]} ############################
############################ 2017-11-07 06:13:12.181 [ 8] 0 AudioInputProcessor:executeOnContextAvailable:jsonContext={"context"\:[{"header"\:{"namespace"\:"AudioPlayer"\,"name"\:"PlaybackState"}\,"payload"\:{"token"\:""\,"offsetInMilliseconds"\:0\,"playerActivity"\:"IDLE"}}\,{"header"\:{"namespace"\:"SpeechSynthesizer"\,"name"\:"SpeechState"}\,"payload"\:{"token"\:"amzn1.as-ct.v1.#ACRI#ErrorNotifier_732a811c-fce8-47cb-8d7f-a962168fe8fb"\,"offsetInMilliseconds"\:0\,"playerActivity"\:"FINISHED"}}\,{"header"\:{"namespace"\:"Alerts"\,"name"\:"AlertsState"}\,"payload"\:{"allAlerts"\:[]\,"activeAlerts"\:[]}}\,{"header"\:{"namespace"\:"SpeechRecognizer"\,"name"\:"RecognizerState"}\,"payload"\:{"wakeword"\:""}}]} 2017-11-07 06:13:12.181 [ 8] 1 FocusManager:acquireChannel:channelName=Dialog,activityId=SpeechRecognizer.Recognize 2017-11-07 06:13:12.182 [ 8] I DirectiveProcessor:setDialogRequestIdLocked:oldValue=32389c4a-3c1f-4f72-8be0-a53b0ebf505e,newValue=9bd5d083-68fe-44a2-88ef-1b44ed9ffe20 2017-11-07 06:13:12.182 [ 8] 0 DirectiveProcessor:scrubDialogRequestIdLocked:dialogRequestId=32389c4a-3c1f-4f72-8be0-a53b0ebf505e 2017-11-07 06:13:12.183 [ 8] 0 EventBuilder:buildJsonEventString:messageId=548aa279-f1be-4965-848b-04354f40a0e2,namespace=SpeechRecognizer,name=Recognize 2017-11-07 06:13:12.184 [ 8] 0 AudioInputProcessor:executeOnFocusChanged:newFocus=FOREGROUND 2017-11-07 06:13:12.277 [ a] 0 HTTP2StreamPool:getStream:streamId=21,numAcquiredStreams=2 2017-11-07 06:13:12.277 [ a] 9 HTTP2Transport:insertActiveStream:handle=0x74bec2e8 2017-11-07 06:13:15.205 [ c] 0 MessageInterpreter:receive:messageId=5b915de5-f3ff-4754-9047-6d70bf0d6f44:No dialogRequestId attached to message. 2017-11-07 06:13:15.205 [ c] I DirectiveSequencer:onDirective:directive={"namespace\:"SpeechRecognizer"\,name\:"StopCapture"\,messageId\:"5b915de5-f3ff-4754-9047-6d70bf0d6f44"\,dialogRequestId\:""} 2017-11-07 06:13:15.205 [ d] I DirectiveRouter:preHandleDirective:messageId=5b915de5-f3ff-4754-9047-6d70bf0d6f44,action=calling 2017-11-07 06:13:15.205 [ d] 0 CapabilityAgent:addingMessageIdToMap:messageId=5b915de5-f3ff-4754-9047-6d70bf0d6f44 2017-11-07 06:13:15.206 [ e] I DirectiveRouter:handleDirective:messageId=5b915de5-f3ff-4754-9047-6d70bf0d6f44,action=calling 2017-11-07 06:13:15.206 [ 8] 0 AudioInputProcessor:stopCapture:stopImmediately=true 2017-11-07 06:13:15.207 [ 8] 0 AudioInputProcessor:setState:from=RECOGNIZING,to=BUSY 2017-11-07 06:13:15.207 [ 8] 0 DirectiveProcessor:onHandlingCompeted:messageId=5b915de5-f3ff-4754-9047-6d70bf0d6f44,directiveBeingPreHandled=(nullptr) 2017-11-07 06:13:15.207 [ b] 0 DialogUXStateAggregator:setState:from=LISTENING,to=THINKING 2017-11-07 06:13:15.207 [ 8] 0 CapabilityAgent:removingMessageIdFromMap:messageId=5b915de5-f3ff-4754-9047-6d70bf0d6f44 ###########################
###########################
2017-11-07 06:13:15.208 [ a] I InProcessAttachmentReader:readFailed:reason=SDS is closed
2017-11-07 06:13:16.563 [ a] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 124c16fffeeb83ce-00001c28-0000a91a-abe68b3214efa36a-97c9515a-21
2017-11-07 06:13:16.825 [ c] I DirectiveSequencer:onDirective:directive={"namespace\:"Speaker"\,name\:"SetMute"\,messageId\:"e55dee21-a306-49f5-bf17-80a8bfcefa88"\,dialogRequestId\:"9bd5d083-68fe-44a2-88ef-1b44ed9ffe20"}
2017-11-07 06:13:16.825 [ d] W DirectiveRouter:preHandleDirectiveFailed:messageId=e55dee21-a306-49f5-bf17-80a8bfcefa88,reason=noHandlerRegistered
2017-11-07 06:13:16.825 [ d] I DirectiveSequencer:sendingExceptionEncountered:messageId=e55dee21-a306-49f5-bf17-80a8bfcefa88
2017-11-07 06:13:16.826 [ d] 0 EventBuilder:buildJsonEventString:messageId=9fa4075e-fe23-44f4-93af-41a2673973b3,namespace=System,name=ExceptionEncountered
2017-11-07 06:13:16.826 [ c] I DirectiveSequencer:onDirective:directive={"namespace\:"SpeechSynthesizer"\,name\:"Speak"\,messageId\:"25f45385-d610-4fdf-84ea-49927ea37892"\,dialogRequestId\:"9bd5d083-68fe-44a2-88ef-1b44ed9ffe20"}
2017-11-07 06:13:16.827 [ d] I DirectiveRouter:preHandleDirective:messageId=25f45385-d610-4fdf-84ea-49927ea37892,action=calling
2017-11-07 06:13:16.827 [ c] I DirectiveSequencer:onDirective:directive={"namespace\:"Speaker"\,name\:"SetMute"\,messageId\:"0703f469-803f-470e-9789-1b593c9b6308"\,dialogRequestId\:"9bd5d083-68fe-44a2-88ef-1b44ed9ffe20"}
2017-11-07 06:13:16.827 [ d] 0 CapabilityAgent:addingMessageIdToMap:messageId=25f45385-d610-4fdf-84ea-49927ea37892
2017-11-07 06:13:16.828 [ d] 9 SpeechSynthesizer:preHandleDirective:messageId=25f45385-d610-4fdf-84ea-49927ea37892
2017-11-07 06:13:16.828 [ 7] 0 SpeechSynthesizer:executePreHandle:messageId=25f45385-d610-4fdf-84ea-49927ea37892
2017-11-07 06:13:16.828 [ d] W DirectiveRouter:preHandleDirectiveFailed:messageId=0703f469-803f-470e-9789-1b593c9b6308,reason=noHandlerRegistered
2017-11-07 06:13:16.828 [ d] I DirectiveSequencer:sendingExceptionEncountered:messageId=0703f469-803f-470e-9789-1b593c9b6308
2017-11-07 06:13:16.829 [ d] 0 EventBuilder:buildJsonEventString:messageId=4cdd8f52-2455-48d9-9e98-12da6b3a3542,namespace=System,name=ExceptionEncountered
2017-11-07 06:13:16.832 [ e] I DirectiveRouter:handleDirective:messageId=25f45385-d610-4fdf-84ea-49927ea37892,action=calling
2017-11-07 06:13:16.832 [ e] 9 SpeechSynthesizer:handleDirective:messageId=25f45385-d610-4fdf-84ea-49927ea37892
2017-11-07 06:13:16.833 [ a] 0 HTTP2Transport:cleanupFinishedStream:streamId=21,result=200
2017-11-07 06:13:16.833 [ a] 0 HTTP2StreamPool:releaseStream:streamId=21,numAcquiredStreams=1
2017-11-07 06:13:16.833 [ c] I DirectiveSequencer:onDirective:directive={"namespace\:"AudioPlayer"\,name\:"Play"\,messageId\:"f8c3038b-aa34-4bb8-9faa-68033222d17e"\,dialogRequestId\:"9bd5d083-68fe-44a2-88ef-1b44ed9ffe20"}
2017-11-07 06:13:16.834 [ a] 0 HTTP2StreamPool:getStream:streamId=23,numAcquiredStreams=2
2017-11-07 06:13:16.834 [ d] I DirectiveRouter:preHandleDirective:messageId=f8c3038b-aa34-4bb8-9faa-68033222d17e,action=calling
2017-11-07 06:13:16.834 [ d] 0 CapabilityAgent:addingMessageIdToMap:messageId=f8c3038b-aa34-4bb8-9faa-68033222d17e
2017-11-07 06:13:16.834 [ a] 9 HTTP2Transport:insertActiveStream:handle=0x74bec2e8
2017-11-07 06:13:16.834 [ 7] 0 SpeechSynthesizer:executeHandle:messageId=25f45385-d610-4fdf-84ea-49927ea37892
2017-11-07 06:13:16.835 [ 7] 1 FocusManager:acquireChannel:channelName=Dialog,activityId=SpeechSynthesizer.Speak
2017-11-07 06:13:16.847 [ f] 0 SpeechSynthesizer:onFocusChanged:newFocus=FOREGROUND
2017-11-07 06:13:16.847 [ 8] 0 AudioInputProcessor:executeOnFocusChanged:newFocus=NONE
2017-11-07 06:13:16.847 [ 8] 0 AudioInputProcessor:executeOnFocusChanged:reason=Lost focus
2017-11-07 06:13:16.847 [ 8] 0 AudioInputProcessor:setState:from=BUSY,to=IDLE
2017-11-07 06:13:16.848 [ 7] 0 SpeechSynthesizer:executeStateChange:newState=PLAYING
2017-11-07 06:13:16.848 [ 7] 9 SpeechSynthesizer:startPlaying
2017-11-07 06:13:16.848 [ 7] 9 MediaPlayer:setSourceCalled:sourceType=AttachmentReader
2017-11-07 06:13:16.852 [ 2] 0 MediaPlayer:handleSetSourceCalled
2017-11-07 06:13:16.852 [ 2] 9 MediaPlayer:tearDownTransientPipelineElements
2017-11-07 06:13:16.852 [ 2] 0 MediaPlayer:doStopSuccess:reason=alreadyStopped
2017-11-07 06:13:16.852 [ 2] 9 MediaPlayer:doStopSuccess
2017-11-07 06:13:16.854 [ 7] 9 MediaPlayer:playCalled
2017-11-07 06:13:16.854 [ 2] 0 MediaPlayer:handlePlayCalled
2017-11-07 06:13:16.854 [ 2] 0 MediaPlayer:doStopSuccess:reason=alreadyStopped
2017-11-07 06:13:16.854 [ 2] 9 MediaPlayer:doStopSuccess
2017-11-07 06:13:16.854 [ 2] 0 MediaPlayer:handlePlay:attemptBuffering=0
0:00:49.146086698 23562 0x10b8980 WARN pulse pulsesink.c:615:gst_pulseringbuffer_open_device:
(SampleApp:23562): CRITICAL : file gstaudioringbuffer.c: line 1993 (gst_audio_ring_buffer_set_channel_positions): should not be reached 2017-11-07 06:13:16.978 [ 2] 9 MediaPlayer:messageReceived:messageType=latency 2017-11-07 06:13:16.978 [ 2] 9 MediaPlayer:messageReceived:messageType=stream-status 2017-11-07 06:13:16.979 [ 2] 9 MediaPlayer:messageReceived:messageType=tag 2017-11-07 06:13:16.979 [ 2] 9 MediaPlayer:messageReceived:messageType=tag 2017-11-07 06:13:16.979 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-07 06:13:16.979 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-07 06:13:16.980 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-07 06:13:16.980 [ 2] 9 MediaPlayer:State Change:oldState=READY,newState=PAUSED,pendingState=PLAYING 2017-11-07 06:13:16.980 [ 2] 9 MediaPlayer:messageReceived:messageType=async-done 2017-11-07 06:13:16.980 [ 2] 9 MediaPlayer:messageReceived:messageType=new-clock 2017-11-07 06:13:16.982 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-07 06:13:16.982 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-07 06:13:16.982 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-07 06:13:16.983 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-07 06:13:16.983 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-07 06:13:16.984 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-07 06:13:16.984 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-07 06:13:16.984 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-07 06:13:16.985 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-07 06:13:16.985 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-07 06:13:16.985 [ 2] 9 MediaPlayer:State Change:oldState=PAUSED,newState=PLAYING,pendingState=VOID_PENDING 2017-11-07 06:13:16.985 [ 2] 0 MediaPlayer:callingOnPlaybackStarted 2017-11-07 06:13:16.985 [ 2] 9 SpeechSynthesizer:onPlaybackStarted 2017-11-07 06:13:16.985 [ 7] 0 SpeechSynthesizer:executePlaybackStarted 2017-11-07 06:13:16.986 [ 7] 0 SpeechSynthesizer:executeProvideState:stateRequestToken=0 2017-11-07 06:13:16.986 [ 7] 9 MediaPlayer:getOffsetCalled 2017-11-07 06:13:16.986 [ 2] 0 MediaPlayer:handleGetOffsetCalled 2017-11-07 06:13:16.987 [ 7] 0 ContextManager:updateStateLocked:action=updatedState,state={"token"\:"amzn1.as-ct.v1.Domain\:Application\:Music#ACRI#DeviceTTSRendererV4_784d11dd-e5b6-4219-8487-275846591a93"\,"offsetInMilliseconds"\:0\,"playerActivity"\:"PLAYING"},namespace=SpeechSynthesizer,name=SpeechState 2017-11-07 06:13:16.987 [ f] 9 SpeechSynthesizer:onFocusChangedSuccess 2017-11-07 06:13:16.988 [ 7] 0 EventBuilder:buildJsonEventString:messageId=399a8b98-7dc8-4891-8a1d-27ab02a92a5c,namespace=SpeechSynthesizer,name=SpeechStarted 2017-11-07 06:13:16.990 [ b] 0 DialogUXStateAggregator:setState:from=THINKING,to=SPEAKING ###########################
########################### 2017-11-07 06:13:16.998 [ 2] 9 MediaPlayer:messageReceived:messageType=tag 2017-11-07 06:13:17.100 [ a] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 124c16fffeeb83ce-00001c28-0000a91a-abe68b3214efa36a-97c9515a-23 2017-11-07 06:13:17.101 [ a] 0 HTTP2Transport:cleanupFinishedStream:streamId=23,result=204 2017-11-07 06:13:17.101 [ a] 0 HTTP2StreamPool:releaseStream:streamId=23,numAcquiredStreams=1 2017-11-07 06:13:17.101 [ a] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT 2017-11-07 06:13:17.102 [ a] 0 HTTP2StreamPool:getStream:streamId=25,numAcquiredStreams=2 2017-11-07 06:13:17.102 [ a] 9 HTTP2Transport:insertActiveStream:handle=0x74bec2e8 2017-11-07 06:13:17.377 [ a] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 124c16fffeeb83ce-00001c28-0000a91a-abe68b3214efa36a-97c9515a-25 2017-11-07 06:13:17.377 [ a] 0 HTTP2Transport:cleanupFinishedStream:streamId=25,result=204 2017-11-07 06:13:17.377 [ a] 0 HTTP2StreamPool:releaseStream:streamId=25,numAcquiredStreams=1 2017-11-07 06:13:17.378 [ a] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT 2017-11-07 06:13:17.378 [ a] 0 HTTP2StreamPool:getStream:streamId=27,numAcquiredStreams=2 2017-11-07 06:13:17.378 [ a] 9 HTTP2Transport:insertActiveStream:handle=0x74bec2e8 2017-11-07 06:13:17.824 [ a] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 124c16fffeeb83ce-00001c28-0000a91a-abe68b3214efa36a-97c9515a-27 2017-11-07 06:13:17.825 [ a] 0 HTTP2Transport:cleanupFinishedStream:streamId=27,result=204 2017-11-07 06:13:17.825 [ a] 0 HTTP2StreamPool:releaseStream:streamId=27,numAcquiredStreams=1 2017-11-07 06:13:17.825 [ a] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT 2017-11-07 06:13:18.442 [ 12] 9 BaseStreamSource:onNeedDataCalled:size=4096 2017-11-07 06:13:18.443 [ 2] 9 BaseStreamSource:handleNeedDataCalled 2017-11-07 06:13:18.811 [ 2] 9 MediaPlayer:messageReceived:messageType=eos 2017-11-07 06:13:18.811 [ 2] 9 MediaPlayer:tearDownTransientPipelineElements 2017-11-07 06:13:18.838 [ 2] 9 BaseStreamSource:~BaseStreamSource 2017-11-07 06:13:18.838 [ 2] 0 MediaPlayer:callingOnPlaybackFinished 2017-11-07 06:13:18.838 [ 2] 9 SpeechSynthesizer:onPlaybackFinished 2017-11-07 06:13:18.839 [ 2] 9 MediaPlayer:doStopSuccess 2017-11-07 06:13:18.839 [ 7] 0 SpeechSynthesizer:executePlaybackFinished 2017-11-07 06:13:18.839 [ 7] 0 SpeechSynthesizer:executeProvideState:stateRequestToken=0 2017-11-07 06:13:18.839 [ 7] 0 ContextManager:updateStateLocked:action=updatedState,state={"token"\:"amzn1.as-ct.v1.Domain\:Application\:Music#ACRI#DeviceTTSRendererV4_784d11dd-e5b6-4219-8487-275846591a93"\,"offsetInMilliseconds"\:0\,"playerActivity"\:"FINISHED"},namespace=SpeechSynthesizer,name=SpeechState 2017-11-07 06:13:18.840 [ 7] 9 SpeechSynthesizer:releaseForegroundFocus 2017-11-07 06:13:18.840 [ 7] 1 FocusManager:releaseChannel:channelName=Dialog 2017-11-07 06:13:18.840 [ f] 0 SpeechSynthesizer:onFocusChanged:newFocus=NONE 2017-11-07 06:13:18.840 [ 7] 0 EventBuilder:buildJsonEventString:messageId=1251b2b2-2343-478c-a396-b9d5c6cae7a7,namespace=SpeechSynthesizer,name=SpeechFinished 2017-11-07 06:13:18.841 [ 7] 9 SpeechSynthesizer:setHandlingCompleted 2017-11-07 06:13:18.841 [ 7] 0 DirectiveProcessor:onHandlingCompeted:messageId=25f45385-d610-4fdf-84ea-49927ea37892,directiveBeingPreHandled=(nullptr) 2017-11-07 06:13:18.841 [ 7] 0 CapabilityAgent:removingMessageIdFromMap:messageId=25f45385-d610-4fdf-84ea-49927ea37892 2017-11-07 06:13:18.842 [ e] I DirectiveRouter:handleDirective:messageId=f8c3038b-aa34-4bb8-9faa-68033222d17e,action=calling 2017-11-07 06:13:18.842 [ e] 9 AudioPlayer:handlePlayDirective 2017-11-07 06:13:18.843 [ e] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=streamFormat 2017-11-07 06:13:18.844 [ e] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=progressReportIntervalInMilliseconds 2017-11-07 06:13:18.844 [ e] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=expectedPreviousToken 2017-11-07 06:13:18.845 [ 9] 9 AudioPlayer:executePlay:playBehavior=REPLACE_ALL 2017-11-07 06:13:18.845 [ 9] 9 AudioPlayer:executeStop:m_currentActivity=IDLE 2017-11-07 06:13:18.845 [ 9] 1 FocusManager:acquireChannel:channelName=Content,activityId=AudioPlayer.Play 2017-11-07 06:13:18.846 [ 9] 0 DirectiveProcessor:onHandlingCompeted:messageId=f8c3038b-aa34-4bb8-9faa-68033222d17e,directiveBeingPreHandled=(nullptr) 2017-11-07 06:13:18.846 [ 9] 0 CapabilityAgent:removingMessageIdFromMap:messageId=f8c3038b-aa34-4bb8-9faa-68033222d17e 2017-11-07 06:13:18.847 [ f] 9 AudioPlayer:onFocusChanged:newFocus=FOREGROUND 2017-11-07 06:13:18.847 [ 9] 9 AudioPlayer:executeOnFocusChanged:from=NONE,to=FOREGROUND,m_starting=true,m_currentActivity=IDLE 2017-11-07 06:13:18.848 [ 9] 9 AudioPlayer:executeOnFocusChanged:action=playNextItem 2017-11-07 06:13:18.848 [ 9] 9 AudioPlayer:playNextItem:m_audioItems.size=1 2017-11-07 06:13:18.848 [ 9] 9 MediaPlayer:setSourceForUrlCalled 2017-11-07 06:13:18.849 [ 2] 9 MediaPlayer:tearDownTransientPipelineElements 2017-11-07 06:13:18.849 [ 2] 0 MediaPlayer:doStopSuccess:reason=alreadyStopped 2017-11-07 06:13:18.849 [ 2] 9 MediaPlayer:doStopSuccess 2017-11-07 06:13:18.850 [ 13] 0 MediaPlayer:handleSetSourceForUrlCalled 2017-11-07 06:13:18.852 [ 13] 9 UrlSource:UrlSourceCreate 2017-11-07 06:13:18.852 [ 13] 0 UrlSource:initCalledForUrlSource 2017-11-07 06:13:18.856 [ 9] 9 AudioPlayer:playNextItem:item.stream.offset=0 2017-11-07 06:13:18.856 [ 9] 9 MediaPlayer:playCalled 2017-11-07 06:13:18.932 [ a] 0 HTTP2StreamPool:getStream:streamId=29,numAcquiredStreams=2 2017-11-07 06:13:18.932 [ a] 9 HTTP2Transport:insertActiveStream:handle=0x74bec2e8 2017-11-07 06:13:19.043 [ b] 0 DialogUXStateAggregator:setState:from=FINISHED,to=IDLE ########################################
########################################
2017-11-07 06:13:19.420 [ a] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 124c16fffeeb83ce-00001c28-0000a91a-abe68b3214efa36a-97c9515a-29
2017-11-07 06:13:19.421 [ a] 0 HTTP2Transport:cleanupFinishedStream:streamId=29,result=204
2017-11-07 06:13:19.421 [ a] 0 HTTP2StreamPool:releaseStream:streamId=29,numAcquiredStreams=1
2017-11-07 06:13:19.421 [ a] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT
2017-11-07 06:13:20.110 [ 14] 9 LibCurlHttpContentFetcher:getContent:responseCode=200
2017-11-07 06:13:20.111 [ 14] 9 LibCurlHttpContentFetcher:getContent:contentType=application/vnd.apple.mpegurl
2017-11-07 06:13:20.112 [ 15] 9 PlaylistParser:PlaylistParser:contentType=application/vnd.apple.mpegurl
2017-11-07 06:13:20.847 [ f] E AudioPlayer:onFocusChangedFailed:reason=timedout,cause=executorTimeout
2017-11-07 06:13:21.068 [ 15] I InProcessAttachmentReader:readFailed:reason=SDS is closed
2017-11-07 06:13:21.081 [ 15] 9 PlaylistParser:isM3U8Playlist
2017-11-07 06:13:21.081 [ 15] 9 UrlSource:urlParsedSuccessfully
2017-11-07 06:13:21.082 [ 2] 0 MediaPlayer:handlePlayCalled
2017-11-07 06:13:21.082 [ 2] 0 MediaPlayer:doStopSuccess:reason=alreadyStopped
2017-11-07 06:13:21.082 [ 2] 9 MediaPlayer:doStopSuccess
2017-11-07 06:13:21.082 [ 2] 0 MediaPlayer:handlePlay:attemptBuffering=1
0:00:53.375933184 23562 0x10b8980 WARN pulse pulsesink.c:615:gst_pulseringbuffer_open_device:
2017-11-07 06:13:22.656 [ 2] 9 MediaPlayer:messageReceived:messageType=warning
0:00:54.939449142 23562 0x74103520 WARN uridecodebin gsturidecodebin.c:1005:no_more_pads_full:
2017-11-07 06:13:22.657 [ 2] 9 MediaPlayer:messageReceived:messageType=error 2017-11-07 06:13:22.657 [ 2] E MediaPlayer:handleBusMessageError:source=decoder,error=Your GStreamer installation is missing a plug-in.,debug=gsturidecodebin.c(1005)\: no_more_pads_full ()\: /GstPipeline\:audio-pipeline/GstURIDecodeBin\:decoder\: no suitable plugins found\: gstdecodebin2.c(4592)\: gst_decode_bin_expose ()\: /GstPipeline\:audio-pipeline/GstURIDecodeBin\:decoder/GstDecodeBin\:decodebin0\: no suitable plugins found\: Missing decoder\: application/x-hls (application/x-hls)
2017-11-07 06:13:22.658 [ 2] 0 MediaPlayer:callingOnPlaybackError:type=MEDIA_ERROR_INTERNAL_DEVICE_ERROR,error=Your GStreamer installation is missing a plug-in. 2017-11-07 06:13:22.658 [ 2] 9 AudioPlayer:onPlaybackError:type=MEDIA_ERROR_INTERNAL_DEVICE_ERROR,error=Your GStreamer installation is missing a plug-in. 2017-11-07 06:13:22.658 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-07 06:13:22.659 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-07 06:13:23.637 [ 9] E AudioPlayer:onFocusChangedFailed:reason=timedout,cause=notStarted 2017-11-07 06:13:23.638 [ 9] 0 EventBuilder:buildJsonEventString:messageId=e8f0a47b-e202-46cd-bbc7-7fd9df2f000b,namespace=AudioPlayer,name=ProgressReportDelayElapsed 2017-11-07 06:13:23.639 [ 9] E AudioPlayer:executeOnPlaybackError:type=MEDIA_ERROR_INTERNAL_DEVICE_ERROR,error=Your GStreamer installation is missing a plug-in. 2017-11-07 06:13:23.639 [ 9] 0 EventBuilder:buildJsonEventString:messageId=0af0775b-f2e5-4c03-973c-4e0376201704,namespace=AudioPlayer,name=PlaybackFailed 2017-11-07 06:13:23.640 [ 9] 9 AudioPlayer:executeStop:m_currentActivity=IDLE 2017-11-07 06:13:23.640 [ 9] 1 FocusManager:releaseChannel:channelName=Content 2017-11-07 06:13:23.641 [ f] 9 AudioPlayer:onFocusChanged:newFocus=NONE 2017-11-07 06:13:23.641 [ 9] 0 AudioPlayer:changeActivity:from=IDLE,to=STOPPED 2017-11-07 06:13:23.641 [ 9] 0 AudioPlayer:executeProvideState:sendToken=false,stateRequestToken=0 2017-11-07 06:13:23.641 [ 9] 0 ContextManager:updateStateLocked:action=updatedState,state={"token"\:"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#1d42c020-0c38-40f2-b273-815061aab4da\:1"\,"offsetInMilliseconds"\:0\,"playerActivity"\:"STOPPED"},namespace=AudioPlayer,name=PlaybackState 2017-11-07 06:13:23.642 [ 9] 0 EventBuilder:buildJsonEventString:messageId=32de21ae-bd5a-473b-ad25-c8e18267eb03,namespace=AudioPlayer,name=PlaybackStopped 2017-11-07 06:13:23.643 [ 9] 9 AudioPlayer:executeOnFocusChanged:from=FOREGROUND,to=NONE,m_starting=false,m_currentActivity=STOPPED 2017-11-07 06:13:23.735 [ a] 0 HTTP2StreamPool:getStream:streamId=31,numAcquiredStreams=2 2017-11-07 06:13:23.735 [ a] 9 HTTP2Transport:insertActiveStream:handle=0x74bec2e8 2017-11-07 06:13:24.509 [ a] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 124c16fffeeb83ce-00001c28-0000a91a-abe68b3214efa36a-97c9515a-31 2017-11-07 06:13:24.510 [ a] 0 HTTP2Transport:cleanupFinishedStream:streamId=31,result=204 2017-11-07 06:13:24.510 [ a] 0 HTTP2StreamPool:releaseStream:streamId=31,numAcquiredStreams=1 2017-11-07 06:13:24.510 [ a] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT 2017-11-07 06:13:24.510 [ a] 0 HTTP2StreamPool:getStream:streamId=33,numAcquiredStreams=2 2017-11-07 06:13:24.510 [ a] 9 HTTP2Transport:insertActiveStream:handle=0x611cc800 2017-11-07 06:13:25.640 [ a] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 124c16fffeeb83ce-00001c28-0000a91a-abe68b3214efa36a-97c9515a-33 2017-11-07 06:13:25.641 [ a] 0 HTTP2StreamPool:getStream:streamId=35,numAcquiredStreams=3 2017-11-07 06:13:25.641 [ a] 9 HTTP2Transport:insertActiveStream:handle=0x612c0d98 2017-11-07 06:13:25.642 [ c] 0 MessageInterpreter:receive:messageId=336e8ff6-3dfd-4d2f-8783-fe88bd22770a:No dialogRequestId attached to message. 2017-11-07 06:13:25.643 [ c] I DirectiveSequencer:onDirective:directive={"namespace\:"Speaker"\,name\:"SetMute"\,messageId\:"336e8ff6-3dfd-4d2f-8783-fe88bd22770a"\,dialogRequestId\:""} 2017-11-07 06:13:25.643 [ a] 0 HTTP2Transport:cleanupFinishedStream:streamId=33,result=200 2017-11-07 06:13:25.643 [ d] W DirectiveRouter:preHandleDirectiveFailed:messageId=336e8ff6-3dfd-4d2f-8783-fe88bd22770a,reason=noHandlerRegistered 2017-11-07 06:13:25.643 [ a] 0 HTTP2StreamPool:releaseStream:streamId=33,numAcquiredStreams=2 2017-11-07 06:13:25.644 [ d] I DirectiveSequencer:sendingExceptionEncountered:messageId=336e8ff6-3dfd-4d2f-8783-fe88bd22770a 2017-11-07 06:13:25.644 [ c] 0 MessageInterpreter:receive:messageId=eb23d51f-abe0-4b9c-ad60-53fbf13d9a2f:No dialogRequestId attached to message. 2017-11-07 06:13:25.645 [ d] 0 EventBuilder:buildJsonEventString:messageId=7a952931-d715-45ef-9f93-2a89928c5a38,namespace=System,name=ExceptionEncountered 2017-11-07 06:13:25.647 [ c] I DirectiveSequencer:onDirective:directive={"namespace\:"AudioPlayer"\,name\:"Play"\,messageId\:"eb23d51f-abe0-4b9c-ad60-53fbf13d9a2f"\,dialogRequestId\:""} 2017-11-07 06:13:25.648 [ d] I DirectiveRouter:preHandleDirective:messageId=eb23d51f-abe0-4b9c-ad60-53fbf13d9a2f,action=calling 2017-11-07 06:13:25.649 [ d] 0 CapabilityAgent:addingMessageIdToMap:messageId=eb23d51f-abe0-4b9c-ad60-53fbf13d9a2f 2017-11-07 06:13:25.649 [ e] I DirectiveRouter:handleDirective:messageId=eb23d51f-abe0-4b9c-ad60-53fbf13d9a2f,action=calling 2017-11-07 06:13:25.650 [ e] 9 AudioPlayer:handlePlayDirective 2017-11-07 06:13:25.650 [ e] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=streamFormat 2017-11-07 06:13:25.651 [ e] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=progressReportIntervalInMilliseconds 2017-11-07 06:13:25.651 [ e] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=expectedPreviousToken 2017-11-07 06:13:25.651 [ 9] 9 AudioPlayer:executePlay:playBehavior=REPLACE_ALL 2017-11-07 06:13:25.651 [ 9] 9 AudioPlayer:executeStop:m_currentActivity=STOPPED 2017-11-07 06:13:25.652 [ 9] 1 FocusManager:acquireChannel:channelName=Content,activityId=AudioPlayer.Play 2017-11-07 06:13:25.652 [ f] 9 AudioPlayer:onFocusChanged:newFocus=FOREGROUND 2017-11-07 06:13:25.652 [ 9] 0 DirectiveProcessor:onHandlingCompeted:messageId=eb23d51f-abe0-4b9c-ad60-53fbf13d9a2f,directiveBeingPreHandled=(nullptr) 2017-11-07 06:13:25.652 [ 9] 0 CapabilityAgent:removingMessageIdFromMap:messageId=eb23d51f-abe0-4b9c-ad60-53fbf13d9a2f 2017-11-07 06:13:25.653 [ 9] 9 AudioPlayer:executeOnFocusChanged:from=NONE,to=FOREGROUND,m_starting=true,m_currentActivity=STOPPED 2017-11-07 06:13:25.653 [ 9] 9 AudioPlayer:executeOnFocusChanged:action=playNextItem 2017-11-07 06:13:25.653 [ 9] 9 AudioPlayer:playNextItem:m_audioItems.size=1 2017-11-07 06:13:25.653 [ 9] 9 MediaPlayer:setSourceForUrlCalled 2017-11-07 06:13:25.654 [ 2] 9 MediaPlayer:tearDownTransientPipelineElements 2017-11-07 06:13:25.654 [ 2] E MediaPlayer:doStopFailed:reason=gstElementGetStateFailed
(SampleApp:23562): GStreamer-CRITICAL **: Trying to dispose element typefind, but it is in PAUSED instead of the NULL state. You need to explicitly set elements to the NULL state before dropping the final reference, to allow them to clean up. This problem may also be caused by a refcounting bug in the application or some element.
(SampleApp:23562): GStreamer-CRITICAL **: Trying to dispose element decodebin0, but it is in PAUSED instead of the NULL state. You need to explicitly set elements to the NULL state before dropping the final reference, to allow them to clean up. This problem may also be caused by a refcounting bug in the application or some element.
(SampleApp:23562): GStreamer-CRITICAL **: Trying to dispose element typefindelement0, but it is in PAUSED instead of the NULL state. You need to explicitly set elements to the NULL state before dropping the final reference, to allow them to clean up. This problem may also be caused by a refcounting bug in the application or some element.
(SampleApp:23562): GStreamer-CRITICAL **: Trying to dispose element source, but it is in PAUSED instead of the NULL state. You need to explicitly set elements to the NULL state before dropping the final reference, to allow them to clean up. This problem may also be caused by a refcounting bug in the application or some element.
(SampleApp:23562): GStreamer-CRITICAL **: Trying to dispose element decoder, but it is in PAUSED instead of the NULL state. You need to explicitly set elements to the NULL state before dropping the final reference, to allow them to clean up. This problem may also be caused by a refcounting bug in the application or some element.
(SampleApp:23562): GStreamer-CRITICAL **: gst_element_set_state: assertion 'GST_IS_ELEMENT (element)' failed
(SampleApp:23562): GStreamer-CRITICAL **: gst_bin_remove: assertion 'GST_IS_ELEMENT (element)' failed 2017-11-07 06:13:25.658 [ 16] 0 MediaPlayer:handleSetSourceForUrlCalled 2017-11-07 06:13:25.658 [ 16] 9 UrlSource:UrlSourceCreate 2017-11-07 06:13:25.658 [ 16] 0 UrlSource:initCalledForUrlSource 2017-11-07 06:13:25.662 [ 9] 9 AudioPlayer:playNextItem:item.stream.offset=0 2017-11-07 06:13:25.662 [ 9] 9 MediaPlayer:playCalled 2017-11-07 06:13:26.441 [ a] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 124c16fffeeb83ce-00001c28-0000a91a-abe68b3214efa36a-97c9515a-35 2017-11-07 06:13:26.441 [ a] 0 HTTP2Transport:cleanupFinishedStream:streamId=35,result=204 2017-11-07 06:13:26.442 [ a] 0 HTTP2StreamPool:releaseStream:streamId=35,numAcquiredStreams=1 2017-11-07 06:13:26.442 [ a] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT 2017-11-07 06:13:26.442 [ a] 0 HTTP2StreamPool:getStream:streamId=37,numAcquiredStreams=2 2017-11-07 06:13:26.442 [ a] 9 HTTP2Transport:insertActiveStream:handle=0x612c0d98 2017-11-07 06:13:26.636 [ 17] 9 LibCurlHttpContentFetcher:getContent:responseCode=200 2017-11-07 06:13:26.637 [ 17] 9 LibCurlHttpContentFetcher:getContent:contentType=application/vnd.apple.mpegurl 2017-11-07 06:13:26.637 [ 18] 9 PlaylistParser:PlaylistParser:contentType=application/vnd.apple.mpegurl 2017-11-07 06:13:26.711 [ a] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 124c16fffeeb83ce-00001c28-0000a91a-abe68b3214efa36a-97c9515a-37 2017-11-07 06:13:26.711 [ a] 0 HTTP2Transport:cleanupFinishedStream:streamId=37,result=204 2017-11-07 06:13:26.711 [ a] 0 HTTP2StreamPool:releaseStream:streamId=37,numAcquiredStreams=1 2017-11-07 06:13:26.711 [ a] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT 2017-11-07 06:13:27.652 [ f] E AudioPlayer:onFocusChangedFailed:reason=timedout,cause=executorTimeout 2017-11-07 06:13:27.716 [ 18] I InProcessAttachmentReader:readFailed:reason=SDS is closed 2017-11-07 06:13:27.733 [ 18] 9 PlaylistParser:isM3U8Playlist 2017-11-07 06:13:27.734 [ 18] 9 UrlSource:urlParsedSuccessfully 2017-11-07 06:13:27.734 [ 2] 0 MediaPlayer:handlePlayCalled 2017-11-07 06:13:27.734 [ 2] E MediaPlayer:doStopFailed:reason=gstElementGetStateFailed 2017-11-07 06:13:27.734 [ 2] E MediaPlayer:handlePlayFailed:reason=doStopFailed 2017-11-07 06:13:27.735 [ 9] E AudioPlayer:executeOnPlaybackError:type=MEDIA_ERROR_INTERNAL_DEVICE_ERROR,error=playFailed 2017-11-07 06:13:27.735 [ 9] 0 EventBuilder:buildJsonEventString:messageId=5dc45dc5-fb8f-4693-94e9-dd79eaef13ae,namespace=AudioPlayer,name=PlaybackFailed 2017-11-07 06:13:27.736 [ 9] 9 AudioPlayer:executeStop:m_currentActivity=STOPPED 2017-11-07 06:13:27.737 [ 9] 1 FocusManager:releaseChannel:channelName=Content 2017-11-07 06:13:27.737 [ 9] 0 AudioPlayer:changeActivity:from=STOPPED,to=STOPPED 2017-11-07 06:13:27.737 [ 9] 0 AudioPlayer:executeProvideState:sendToken=false,stateRequestToken=0 2017-11-07 06:13:27.738 [ 9] 0 ContextManager:updateStateLocked:action=updatedState,state={"token"\:"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#1d42c020-0c38-40f2-b273-815061aab4da\:2"\,"offsetInMilliseconds"\:0\,"playerActivity"\:"STOPPED"},namespace=AudioPlayer,name=PlaybackState 2017-11-07 06:13:27.738 [ 9] 0 EventBuilder:buildJsonEventString:messageId=cb46244c-05c7-44cf-9b6b-3b8f99691629,namespace=AudioPlayer,name=PlaybackStopped 2017-11-07 06:13:27.739 [ f] 9 AudioPlayer:onFocusChanged:newFocus=NONE 2017-11-07 06:13:27.816 [ a] 0 HTTP2StreamPool:getStream:streamId=39,numAcquiredStreams=2 2017-11-07 06:13:27.816 [ a] 9 HTTP2Transport:insertActiveStream:handle=0x612c0d98 2017-11-07 06:13:28.741 [ a] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 124c16fffeeb83ce-00001c28-0000a91a-abe68b3214efa36a-97c9515a-39 2017-11-07 06:13:28.741 [ a] 0 HTTP2StreamPool:getStream:streamId=41,numAcquiredStreams=3 2017-11-07 06:13:28.742 [ a] 9 HTTP2Transport:insertActiveStream:handle=0x611cc800 2017-11-07 06:13:28.745 [ a] 0 HTTP2Transport:cleanupFinishedStream:streamId=39,result=200 2017-11-07 06:13:28.746 [ c] 0 MessageInterpreter:receive:messageId=11d5d30f-b837-414a-8a34-4609c6fac23e:No dialogRequestId attached to message. 2017-11-07 06:13:28.746 [ a] 0 HTTP2StreamPool:releaseStream:streamId=39,numAcquiredStreams=2 2017-11-07 06:13:28.746 [ c] I DirectiveSequencer:onDirective:directive={"namespace\:"Speaker"\,name\:"SetMute"\,messageId\:"11d5d30f-b837-414a-8a34-4609c6fac23e"\,dialogRequestId\:""} 2017-11-07 06:13:28.748 [ d] W DirectiveRouter:preHandleDirectiveFailed:messageId=11d5d30f-b837-414a-8a34-4609c6fac23e,reason=noHandlerRegistered 2017-11-07 06:13:28.748 [ d] I DirectiveSequencer:sendingExceptionEncountered:messageId=11d5d30f-b837-414a-8a34-4609c6fac23e 2017-11-07 06:13:28.749 [ d] 0 EventBuilder:buildJsonEventString:messageId=15045edb-bc42-4df3-a92f-05c85a523350,namespace=System,name=ExceptionEncountered 2017-11-07 06:13:28.752 [ c] 0 MessageInterpreter:receive:messageId=f2d05940-456b-4b38-8e10-04fa4bfc01db:No dialogRequestId attached to message. 2017-11-07 06:13:28.752 [ c] I DirectiveSequencer:onDirective:directive={"namespace\:"AudioPlayer"\,name\:"Play"\,messageId\:"f2d05940-456b-4b38-8e10-04fa4bfc01db"\,dialogRequestId\:""} 2017-11-07 06:13:28.753 [ d] I DirectiveRouter:preHandleDirective:messageId=f2d05940-456b-4b38-8e10-04fa4bfc01db,action=calling 2017-11-07 06:13:28.753 [ d] 0 CapabilityAgent:addingMessageIdToMap:messageId=f2d05940-456b-4b38-8e10-04fa4bfc01db 2017-11-07 06:13:28.753 [ e] I DirectiveRouter:handleDirective:messageId=f2d05940-456b-4b38-8e10-04fa4bfc01db,action=calling 2017-11-07 06:13:28.753 [ e] 9 AudioPlayer:handlePlayDirective 2017-11-07 06:13:28.754 [ e] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=streamFormat 2017-11-07 06:13:28.754 [ e] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=progressReportIntervalInMilliseconds 2017-11-07 06:13:28.755 [ e] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=expectedPreviousToken 2017-11-07 06:13:29.531 [ a] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 124c16fffeeb83ce-00001c28-0000a91a-abe68b3214efa36a-97c9515a-41 2017-11-07 06:13:29.531 [ a] 0 HTTP2Transport:cleanupFinishedStream:streamId=41,result=204 2017-11-07 06:13:29.532 [ a] 0 HTTP2StreamPool:releaseStream:streamId=41,numAcquiredStreams=1 2017-11-07 06:13:29.532 [ a] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT 2017-11-07 06:13:29.532 [ a] 0 HTTP2StreamPool:getStream:streamId=43,numAcquiredStreams=2 2017-11-07 06:13:29.533 [ a] 9 HTTP2Transport:insertActiveStream:handle=0x611cc800 2017-11-07 06:13:29.739 [ 9] E AudioPlayer:onFocusChangedFailed:reason=timedout,cause=notStarted 2017-11-07 06:13:29.739 [ f] E AudioPlayer:onFocusChangedFailed:reason=timedout,cause=executorTimeout 2017-11-07 06:13:29.740 [ 9] 9 AudioPlayer:executeOnFocusChanged:from=FOREGROUND,to=NONE,m_starting=false,m_currentActivity=STOPPED 2017-11-07 06:13:29.740 [ 9] 9 AudioPlayer:executePlay:playBehavior=REPLACE_ALL 2017-11-07 06:13:29.740 [ 9] 9 AudioPlayer:executeStop:m_currentActivity=STOPPED 2017-11-07 06:13:29.740 [ 9] 1 FocusManager:acquireChannel:channelName=Content,activityId=AudioPlayer.Play 2017-11-07 06:13:29.740 [ f] 9 AudioPlayer:onFocusChanged:newFocus=FOREGROUND 2017-11-07 06:13:29.741 [ 9] 0 DirectiveProcessor:onHandlingCompeted:messageId=f2d05940-456b-4b38-8e10-04fa4bfc01db,directiveBeingPreHandled=(nullptr) 2017-11-07 06:13:29.741 [ 9] 0 CapabilityAgent:removingMessageIdFromMap:messageId=f2d05940-456b-4b38-8e10-04fa4bfc01db 2017-11-07 06:13:29.741 [ 9] 9 AudioPlayer:executeOnFocusChanged:from=NONE,to=FOREGROUND,m_starting=true,m_currentActivity=STOPPED 2017-11-07 06:13:29.741 [ 9] 9 AudioPlayer:executeOnFocusChanged:action=playNextItem 2017-11-07 06:13:29.741 [ 9] 9 AudioPlayer:playNextItem:m_audioItems.size=1 2017-11-07 06:13:29.741 [ 9] 9 MediaPlayer:setSourceForUrlCalled 2017-11-07 06:13:29.742 [ 2] 9 MediaPlayer:tearDownTransientPipelineElements 2017-11-07 06:13:29.742 [ 2] E MediaPlayer:doStopFailed:reason=gstElementGetStateFailed 2017-11-07 06:13:29.742 [ 19] 0 MediaPlayer:handleSetSourceForUrlCalled 2017-11-07 06:13:29.743 [ 19] 9 UrlSource:UrlSourceCreate 2017-11-07 06:13:29.743 [ 19] 0 UrlSource:initCalledForUrlSource 2017-11-07 06:13:29.744 [ 9] 9 AudioPlayer:playNextItem:item.stream.offset=0 2017-11-07 06:13:29.744 [ 9] 9 MediaPlayer:playCalled 2017-11-07 06:13:29.811 [ a] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 124c16fffeeb83ce-00001c28-0000a91a-abe68b3214efa36a-97c9515a-43 2017-11-07 06:13:29.812 [ a] 0 HTTP2Transport:cleanupFinishedStream:streamId=43,result=204 2017-11-07 06:13:29.812 [ a] 0 HTTP2StreamPool:releaseStream:streamId=43,numAcquiredStreams=1 2017-11-07 06:13:29.812 [ a] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT 2017-11-07 06:13:30.740 [ 1a] 9 LibCurlHttpContentFetcher:getContent:responseCode=200 2017-11-07 06:13:30.745 [ 1a] 9 LibCurlHttpContentFetcher:getContent:contentType=application/vnd.apple.mpegurl 2017-11-07 06:13:30.745 [ 1b] 9 PlaylistParser:PlaylistParser:contentType=application/vnd.apple.mpegurl 2017-11-07 06:13:31.678 [ 1b] I InProcessAttachmentReader:readFailed:reason=SDS is closed 2017-11-07 06:13:31.706 [ 1b] 9 PlaylistParser:isM3U8Playlist 2017-11-07 06:13:31.706 [ 1b] 9 UrlSource:urlParsedSuccessfully 2017-11-07 06:13:31.707 [ 2] 0 MediaPlayer:handlePlayCalled 2017-11-07 06:13:31.707 [ 2] E MediaPlayer:doStopFailed:reason=gstElementGetStateFailed 2017-11-07 06:13:31.707 [ 2] E MediaPlayer:handlePlayFailed:reason=doStopFailed 2017-11-07 06:13:31.707 [ 9] E AudioPlayer:executeOnPlaybackError:type=MEDIA_ERROR_INTERNAL_DEVICE_ERROR,error=playFailed 2017-11-07 06:13:31.708 [ 9] 0 EventBuilder:buildJsonEventString:messageId=66bd5f9a-214a-4c04-b1e7-d11dfb702829,namespace=AudioPlayer,name=PlaybackFailed 2017-11-07 06:13:31.709 [ 9] 9 AudioPlayer:executeStop:m_currentActivity=STOPPED 2017-11-07 06:13:31.709 [ 9] 1 FocusManager:releaseChannel:channelName=Content 2017-11-07 06:13:31.709 [ 9] 0 AudioPlayer:changeActivity:from=STOPPED,to=STOPPED 2017-11-07 06:13:31.709 [ 9] 0 AudioPlayer:executeProvideState:sendToken=false,stateRequestToken=0 2017-11-07 06:13:31.710 [ 9] 0 ContextManager:updateStateLocked:action=updatedState,state={"token"\:"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#1d42c020-0c38-40f2-b273-815061aab4da\:3"\,"offsetInMilliseconds"\:0\,"playerActivity"\:"STOPPED"},namespace=AudioPlayer,name=PlaybackState 2017-11-07 06:13:31.710 [ 9] 0 EventBuilder:buildJsonEventString:messageId=72447c33-6e9f-42bb-bc19-e33bfb8ef1f8,namespace=AudioPlayer,name=PlaybackStopped 2017-11-07 06:13:31.741 [ f] E AudioPlayer:onFocusChangedFailed:reason=timedout,cause=executorTimeout 2017-11-07 06:13:31.741 [ f] 9 AudioPlayer:onFocusChanged:newFocus=NONE 2017-11-07 06:13:31.769 [ a] 0 HTTP2StreamPool:getStream:streamId=45,numAcquiredStreams=2 2017-11-07 06:13:31.769 [ a] 9 HTTP2Transport:insertActiveStream:handle=0x611cc800 2017-11-07 06:13:32.687 [ a] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 124c16fffeeb83ce-00001c28-0000a91a-abe68b3214efa36a-97c9515a-45 2017-11-07 06:13:32.688 [ a] 0 HTTP2StreamPool:getStream:streamId=47,numAcquiredStreams=3 2017-11-07 06:13:32.688 [ a] 9 HTTP2Transport:insertActiveStream:handle=0x612c0d98 2017-11-07 06:13:32.690 [ c] 0 MessageInterpreter:receive:messageId=feee502b-275e-472a-993b-7df0bf0a207e:No dialogRequestId attached to message. 2017-11-07 06:13:32.690 [ c] I DirectiveSequencer:onDirective:directive={"namespace\:"Speaker"\,name\:"SetMute"\,messageId\:"feee502b-275e-472a-993b-7df0bf0a207e"\,dialogRequestId\:""} 2017-11-07 06:13:32.691 [ a] 0 HTTP2Transport:cleanupFinishedStream:streamId=45,result=200 2017-11-07 06:13:32.692 [ a] 0 HTTP2StreamPool:releaseStream:streamId=45,numAcquiredStreams=2 2017-11-07 06:13:32.692 [ c] 0 MessageInterpreter:receive:messageId=54da5a7e-fceb-49a6-85c2-6b99b9f18541:No dialogRequestId attached to message. 2017-11-07 06:13:32.693 [ c] I DirectiveSequencer:onDirective:directive={"namespace\:"AudioPlayer"\,name\:"Play"\,messageId\:"54da5a7e-fceb-49a6-85c2-6b99b9f18541"\,dialogRequestId\:""} 2017-11-07 06:13:32.693 [ d] W DirectiveRouter:preHandleDirectiveFailed:messageId=feee502b-275e-472a-993b-7df0bf0a207e,reason=noHandlerRegistered 2017-11-07 06:13:32.693 [ d] I DirectiveSequencer:sendingExceptionEncountered:messageId=feee502b-275e-472a-993b-7df0bf0a207e 2017-11-07 06:13:32.694 [ d] 0 EventBuilder:buildJsonEventString:messageId=ff739e2a-aada-4d07-ac18-bd3414934916,namespace=System,name=ExceptionEncountered 2017-11-07 06:13:32.695 [ d] I DirectiveRouter:preHandleDirective:messageId=54da5a7e-fceb-49a6-85c2-6b99b9f18541,action=calling 2017-11-07 06:13:32.695 [ d] 0 CapabilityAgent:addingMessageIdToMap:messageId=54da5a7e-fceb-49a6-85c2-6b99b9f18541 2017-11-07 06:13:32.696 [ e] I DirectiveRouter:handleDirective:messageId=54da5a7e-fceb-49a6-85c2-6b99b9f18541,action=calling 2017-11-07 06:13:32.696 [ e] 9 AudioPlayer:handlePlayDirective 2017-11-07 06:13:32.697 [ e] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=streamFormat 2017-11-07 06:13:32.697 [ e] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=progressReportIntervalInMilliseconds 2017-11-07 06:13:32.713 [ e] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=expectedPreviousToken 2017-11-07 06:13:33.502 [ a] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 124c16fffeeb83ce-00001c28-0000a91a-abe68b3214efa36a-97c9515a-47 2017-11-07 06:13:33.503 [ a] 0 HTTP2Transport:cleanupFinishedStream:streamId=47,result=204 2017-11-07 06:13:33.503 [ a] 0 HTTP2StreamPool:releaseStream:streamId=47,numAcquiredStreams=1 2017-11-07 06:13:33.503 [ a] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT 2017-11-07 06:13:33.504 [ a] 0 HTTP2StreamPool:getStream:streamId=49,numAcquiredStreams=2 2017-11-07 06:13:33.504 [ a] 9 HTTP2Transport:insertActiveStream:handle=0x612c0d98 2017-11-07 06:13:33.711 [ 9] E AudioPlayer:onFocusChangedFailed:reason=timedout,cause=notStarted 2017-11-07 06:13:33.711 [ 9] 9 AudioPlayer:executeOnFocusChanged:from=FOREGROUND,to=NONE,m_starting=false,m_currentActivity=STOPPED 2017-11-07 06:13:33.711 [ 9] 9 AudioPlayer:executePlay:playBehavior=REPLACE_ALL 2017-11-07 06:13:33.711 [ 9] 9 AudioPlayer:executeStop:m_currentActivity=STOPPED 2017-11-07 06:13:33.712 [ 9] 1 FocusManager:acquireChannel:channelName=Content,activityId=AudioPlayer.Play 2017-11-07 06:13:33.712 [ 9] 0 DirectiveProcessor:onHandlingCompeted:messageId=54da5a7e-fceb-49a6-85c2-6b99b9f18541,directiveBeingPreHandled=(nullptr) 2017-11-07 06:13:33.712 [ 9] 0 CapabilityAgent:removingMessageIdFromMap:messageId=54da5a7e-fceb-49a6-85c2-6b99b9f18541 2017-11-07 06:13:33.713 [ f] 9 AudioPlayer:onFocusChanged:newFocus=FOREGROUND 2017-11-07 06:13:33.713 [ 9] 9 AudioPlayer:executeOnFocusChanged:from=NONE,to=FOREGROUND,m_starting=true,m_currentActivity=STOPPED 2017-11-07 06:13:33.713 [ 9] 9 AudioPlayer:executeOnFocusChanged:action=playNextItem 2017-11-07 06:13:33.713 [ 9] 9 AudioPlayer:playNextItem:m_audioItems.size=1 2017-11-07 06:13:33.713 [ 9] 9 MediaPlayer:setSourceForUrlCalled 2017-11-07 06:13:33.714 [ 2] 9 MediaPlayer:tearDownTransientPipelineElements 2017-11-07 06:13:33.714 [ 2] E MediaPlayer:doStopFailed:reason=gstElementGetStateFailed 2017-11-07 06:13:33.714 [ 1c] 0 MediaPlayer:handleSetSourceForUrlCalled 2017-11-07 06:13:33.715 [ 1c] 9 UrlSource:UrlSourceCreate 2017-11-07 06:13:33.715 [ 1c] 0 UrlSource:initCalledForUrlSource 2017-11-07 06:13:33.716 [ 9] 9 AudioPlayer:playNextItem:item.stream.offset=0 2017-11-07 06:13:33.716 [ 9] 9 MediaPlayer:playCalled 2017-11-07 06:13:33.785 [ a] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 124c16fffeeb83ce-00001c28-0000a91a-abe68b3214efa36a-97c9515a-49 2017-11-07 06:13:33.786 [ a] 0 HTTP2Transport:cleanupFinishedStream:streamId=49,result=204 2017-11-07 06:13:33.786 [ a] 0 HTTP2StreamPool:releaseStream:streamId=49,numAcquiredStreams=1 2017-11-07 06:13:33.786 [ a] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT 2017-11-07 06:13:34.709 [ 1d] 9 LibCurlHttpContentFetcher:getContent:responseCode=200 2017-11-07 06:13:34.710 [ 1d] 9 LibCurlHttpContentFetcher:getContent:contentType=application/vnd.apple.mpegurl 2017-11-07 06:13:34.710 [ 1e] 9 PlaylistParser:PlaylistParser:contentType=application/vnd.apple.mpegurl 2017-11-07 06:13:35.713 [ f] E AudioPlayer:onFocusChangedFailed:reason=timedout,cause=executorTimeout
ryan-esty
commented
6 years ago @zeusshuang in your last log it said "error: Failed to connect: Connection refused" when trying to setup the pipeline with pulse. I've seen errors like this before specifically when root was trying to play sounds. Can the user running the sample app play sounds?
Ryan
erikly01
commented
6 years ago I'm having issues playing Amazon music as well. Is there documentation that explains the steps to get Amazon music supported?
2017-11-07 16:30:08.735 [ d] 0 AudioPlayer:onFocusChanged:newFocus=FOREGROUND 2017-11-07 16:30:08.736 [ e] 0 MediaPlayer:handleSetSourceForUrlCalled 2017-11-07 16:30:08.738 [ e] 0 UrlSource:initCalledForUrlSource 2017-11-07 16:30:08.923 [ 2] 0 MediaPlayer:handlePlayCalled:idPassed=1,currentId=1 2017-11-07 16:30:08.924 [ 2] 0 MediaPlayer:handlePlay:attemptBuffering=1 2017-11-07 16:30:08.945 [ 2] 0 MediaPlayer:handlePlay:startingState=PAUSED,stateReturn=FAILURE 2017-11-07 16:30:08.945 [ 2] E MediaPlayer:handlePlayFailed:reason=gstElementSetStateFailure 2017-11-07 16:30:08.945 [ 2] 0 MediaPlayer:callingOnPlaybackError:type=MEDIA_ERROR_INTERNAL_DEVICE_ERROR,error=MediaPlayer\:handlePlayFailed\:reason\=gstElementSetStateFailure,currentId=1 2017-11-07 16:30:08.945 [ 2] 0 AudioPlayer:onPlaybackError:type=MEDIA_ERROR_INTERNAL_DEVICE_ERROR,error=MediaPlayer\:handlePlayFailed\:reason\=gstElementSetStateFailure,id=1 2017-11-07 16:30:08.946 [ 6] E AudioPlayer:executeOnPlaybackError:id=1,type=MEDIA_ERROR_INTERNAL_DEVICE_ERROR,error=MediaPlayer\:handlePlayFailed\:reason\=gstElementSetStateFailure 2017-11-07 16:30:08.947 [ 6] 0 EventBuilder:buildJsonEventString:messageId=03697201-076f-4743-b768-b4cd5494ca8f,namespace=AudioPlayer,name=PlaybackFailed 2017-11-07 16:30:08.952 [ 8] 0 HTTP2Transport:processNextOutgoingMessage 2017-11-07 16:30:08.952 [ 8] 0 HTTP2StreamPool:getStream:streamId=7,numAcquiredStreams=2 2017-11-07 16:30:09.241 [ 8] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 0e079dfffe13f06c-000047fe-000185e7-0960d8de9912ead1-af221a98-7 2017-11-07 16:30:09.242 [ 8] 0 HTTP2Transport:cleanupFinishedStream:streamId=7,result=204 2017-11-07 16:30:09.242 [ 8] 0 HTTP2StreamPool:releaseStream:streamId=7,numAcquiredStreams=1 2017-11-07 16:30:09.243 [ 8] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT /home/pi/alexa/avs-device-sdk/Integration/test/AudioPlayerIntegrationTest.cpp:575: Failure Value of: playbackStartedFound Actual: false Expected: true
ryan-esty
commented
6 years ago erikly01,
From my experience I can only get streaming to work on 1.04 or 1.2 and only with pulse. I haven't tried alsa again on 1.2 but I couldn't be wrong about streaming not working with alsa. I haven't tried prime but I can do the news flash and iheartradio. Can you get the news flash to work with your setup?
Ryan
erikly01
commented
6 years ago flash works and Amazon music works if I play music via alexa.amazon.com. However if I enter a voice command it will say "Amazon not supported on this device"
Am I missing something with my compilation? Or is there some configuration change needed?
zeusshuang
commented
6 years ago @ryan-esty it can play news correctly and basic Q&A. I found it failed both Amazon Music and iHeartRadio, the error message (missing plugins ...) are the same. We tried it with three different platform, one is Respberry Pi which we use to run as a baseline comparison, all failed.
jjamazon
commented
6 years ago Hi zeusshuang,
you mentioned that you have built it with the bad plugins, what about get-plugins-base ? Can you attach the output of gst-inspect-1.0.
erikly01
commented
6 years ago libsoup is apart of the good plugins. You'll need to rebuild those too.
For some reason the instructions doesn't mention that.
On Nov 7, 2017 17:47, "jjamazon" notifications@github.com wrote:
Hi zeusshuang,
you mentioned that you have built it with the bad plugins, what about get-plugins-base ? Can you attach the output of gst-inspect-1.0.
— You are receiving this because you commented. Reply to this email directly, view it on GitHub https://github.com/alexa/avs-device-sdk/issues/293#issuecomment-342683289, or mute the thread https://github.com/notifications/unsubscribe-auth/AXl-voN4qqFnbU88oDvqigRruAL86AAMks5s0QgjgaJpZM4QPWny .
zeusshuang
commented
6 years ago @erikly01 , I will check it. Previously, I ever got libsoup with glib-networking issue while running news. @jjamazon it's my gst-inspect-1.0 output
/usr/lib/gstreamer-1.0# gst-inspect-1.0 wavparse: wavparse: WAV audio demuxer wavenc: wavenc: WAV audio muxer vpx: vp8dec: On2 VP8 Decoder vpx: vp8enc: On2 VP8 Encoder vpx: vp9dec: On2 VP9 Decoder vpx: vp9enc: On2 VP9 Encoder vorbis: vorbisenc: Vorbis audio encoder vorbis: vorbisdec: Vorbis audio decoder vorbis: vorbisparse: VorbisParse vorbis: vorbistag: VorbisTag volume: volume: Volume videotestsrc: videotestsrc: Video test source videoscale: videoscale: Video scaler videorate: videorate: Video rate adjuster videomixer: videomixer: Video mixer 2 videofilter: gamma: Video gamma correction videofilter: videobalance: Video balance videofilter: videoflip: Video flipper videofilter: videomedian: Median effect videoconvert: videoconvert: Colorspace converter video4linux2: v4l2src: Video (video4linux2) Source video4linux2: v4l2sink: Video (video4linux2) Sink video4linux2: v4l2radio: Radio (video4linux2) Tuner video4linux2: v4l2deviceprovider (GstDeviceProviderFactory) udp: udpsink: UDP packet sender udp: multiudpsink: UDP packet sender udp: dynudpsink: UDP packet sender udp: udpsrc: UDP packet receiver typefindfunctions: video/x-ms-asf: asf, wm, wma, wmv typefindfunctions: audio/x-musepack: mpc, mpp, mp+ typefindfunctions: audio/x-au: au, snd typefindfunctions: video/x-msvideo: avi typefindfunctions: audio/qcelp: qcp typefindfunctions: video/x-cdxa: dat typefindfunctions: video/x-vcd: dat typefindfunctions: audio/x-imelody: imy, ime, imelody typefindfunctions: audio/midi: mid, midi typefindfunctions: audio/riff-midi: mid, midi typefindfunctions: audio/mobile-xmf: mxmf typefindfunctions: video/x-fli: flc, fli typefindfunctions: application/x-id3v2: mp3, mp2, mp1, mpga, ogg, flac, tta typefindfunctions: application/x-id3v1: mp3, mp2, mp1, mpga, ogg, flac, tta typefindfunctions: application/x-apetag: mp3, ape, mpc, wv typefindfunctions: audio/x-ttafile: tta typefindfunctions: audio/x-mod: 669, amf, ams, dbm, digi, dmf, dsm, gdm, far, imf, it, j2b, mdl, med, mod, mt2, mtm, okt, psm, ptm, sam, s3m, stm, stx, ult, umx, xm typefindfunctions: audio/mpeg: mp3, mp2, mp1, mpga typefindfunctions: audio/x-ac3: ac3, eac3 typefindfunctions: audio/x-dts: dts typefindfunctions: audio/x-gsm: gsm typefindfunctions: video/mpeg-sys: mpe, mpeg, mpg typefindfunctions: video/mpegts: ts, mts typefindfunctions: application/ogg: ogg, oga, ogv, ogm, ogx, spx, anx, axa, axv typefindfunctions: video/mpeg-elementary: mpv, mpeg, mpg typefindfunctions: video/mpeg4: m4v typefindfunctions: video/x-h263: h263, 263 typefindfunctions: video/x-h264: h264, x264, 264 typefindfunctions: video/x-h265: h265, x265, 265 typefindfunctions: video/x-nuv: nuv typefindfunctions: audio/x-m4a: m4a typefindfunctions: application/x-3gp: 3gp typefindfunctions: video/quicktime: mov, mp4 typefindfunctions: image/x-quicktime: qif, qtif, qti typefindfunctions: image/jp2: jp2 typefindfunctions: video/mj2: mj2 typefindfunctions: text/html: htm, html typefindfunctions: application/vnd.rn-realmedia: ra, ram, rm, rmvb typefindfunctions: application/x-pn-realaudio: ra, ram, rm, rmvb typefindfunctions: application/x-shockwave-flash: swf, swfl typefindfunctions: application/dash+xml: mpd, MPD typefindfunctions: application/vnd.ms-sstr+xml: no extensions typefindfunctions: video/x-flv: flv typefindfunctions: text/plain: txt typefindfunctions: text/utf-16: txt typefindfunctions: text/utf-32: txt typefindfunctions: text/uri-list: ram typefindfunctions: application/x-hls: m3u8 typefindfunctions: application/sdp: sdp typefindfunctions: application/smil: smil typefindfunctions: application/ttml+xml: ttml+xml typefindfunctions: application/xml: xml typefindfunctions: audio/x-wav: wav typefindfunctions: audio/x-aiff: aiff, aif, aifc typefindfunctions: audio/x-svx: iff, svx typefindfunctions: audio/x-paris: paf typefindfunctions: audio/x-nist: nist typefindfunctions: audio/x-voc: voc typefindfunctions: audio/x-sds: sds typefindfunctions: audio/x-ircam: sf typefindfunctions: audio/x-w64: w64 typefindfunctions: audio/x-rf64: rf64 typefindfunctions: audio/x-shorten: shn typefindfunctions: application/x-ape: ape typefindfunctions: image/jpeg: jpg, jpe, jpeg typefindfunctions: image/gif: gif typefindfunctions: image/png: png typefindfunctions: image/bmp: bmp typefindfunctions: image/tiff: tif, tiff typefindfunctions: image/webp: webp typefindfunctions: image/x-exr: exr typefindfunctions: image/x-portable-pixmap: pnm, ppm, pgm, pbm typefindfunctions: video/x-matroska: mkv, mka, mk3d, webm typefindfunctions: application/mxf: mxf typefindfunctions: video/x-mve: mve typefindfunctions: video/x-dv: dv, dif typefindfunctions: audio/x-amr-nb-sh: amr typefindfunctions: audio/x-amr-wb-sh: amr typefindfunctions: audio/iLBC-sh: ilbc typefindfunctions: audio/x-sbc: sbc typefindfunctions: audio/x-sid: sid typefindfunctions: image/x-xcf: xcf typefindfunctions: video/x-mng: mng typefindfunctions: image/x-jng: jng typefindfunctions: image/x-xpixmap: xpm typefindfunctions: image/x-sun-raster: ras typefindfunctions: application/x-bzip: bz2 typefindfunctions: application/x-gzip: gz typefindfunctions: application/zip: zip typefindfunctions: application/x-compress: Z typefindfunctions: subtitle/x-kate: no extensions typefindfunctions: application/x-subtitle-vtt: vtt typefindfunctions: audio/x-flac: flac typefindfunctions: audio/x-vorbis: no extensions typefindfunctions: video/x-theora: no extensions typefindfunctions: application/x-ogm-video: no extensions typefindfunctions: application/x-ogm-audio: no extensions typefindfunctions: application/x-ogm-text: no extensions typefindfunctions: audio/x-speex: no extensions typefindfunctions: audio/x-celt: no extensions typefindfunctions: application/x-ogg-skeleton: no extensions typefindfunctions: text/x-cmml: no extensions typefindfunctions: application/x-executable: no extensions typefindfunctions: audio/aac: aac, adts, adif, loas typefindfunctions: audio/x-spc: spc typefindfunctions: audio/x-wavpack: wv, wvp typefindfunctions: audio/x-wavpack-correction: wvc typefindfunctions: audio/x-caf: caf typefindfunctions: application/postscript: ps typefindfunctions: image/svg+xml: svg typefindfunctions: application/x-rar: rar typefindfunctions: application/x-tar: tar typefindfunctions: application/x-ar: a typefindfunctions: application/x-ms-dos-executable: dll, exe, ocx, sys, scr, msstyles, cpl typefindfunctions: video/x-dirac: no extensions typefindfunctions: multipart/x-mixed-replace: no extensions typefindfunctions: application/x-mmsh: no extensions typefindfunctions: video/vivo: viv typefindfunctions: audio/x-nsf: nsf typefindfunctions: audio/x-gym: gym typefindfunctions: audio/x-ay: ay typefindfunctions: audio/x-gbs: gbs typefindfunctions: audio/x-vgm: vgm typefindfunctions: audio/x-sap: sap typefindfunctions: video/x-ivf: ivf typefindfunctions: audio/x-kss: kss typefindfunctions: application/pdf: pdf typefindfunctions: application/msword: doc typefindfunctions: image/vnd.adobe.photoshop: psd typefindfunctions: image/vnd.wap.wbmp: no extensions typefindfunctions: application/x-yuv4mpeg: no extensions typefindfunctions: image/x-icon: no extensions typefindfunctions: image/x-degas: no extensions typefindfunctions: application/octet-stream: no extensions typefindfunctions: application/x-ssa: ssa, ass typefindfunctions: video/x-pva: pva typefindfunctions: audio/x-xi: xi typefindfunctions: audio/audible: aa, aax tcp: socketsrc: socket source tcp: tcpclientsink: TCP client sink tcp: tcpclientsrc: TCP client source tcp: tcpserversink: TCP server sink tcp: tcpserversrc: TCP server source tcp: multifdsink: Multi filedescriptor sink tcp: multisocketsink: Multi socket sink soup: souphttpsrc: HTTP client source soup: souphttpclientsink: HTTP client sink shm: shmsrc: Shared Memory Source shm: shmsink: Shared Memory Sink rtsp: rtspsrc: RTSP packet receiver rtsp: rtpdec: RTP Decoder rtpmanager: rtpbin: RTP Bin rtpmanager: rtpjitterbuffer: RTP packet jitter-buffer rtpmanager: rtpptdemux: RTP Demux rtpmanager: rtpsession: RTP Session rtpmanager: rtprtxqueue: RTP Retransmission Queue rtpmanager: rtprtxreceive: RTP Retransmission receiver rtpmanager: rtprtxsend: RTP Retransmission Sender rtpmanager: rtpssrcdemux: RTP SSRC Demux rtpmanager: rtpmux: RTP muxer rtpmanager: rtpdtmfmux: RTP muxer rtp: rtpac3depay: RTP AC3 depayloader rtp: rtpac3pay: RTP AC3 audio payloader rtp: rtpbvdepay: RTP BroadcomVoice depayloader rtp: rtpbvpay: RTP BV Payloader rtp: rtpceltdepay: RTP CELT depayloader rtp: rtpceltpay: RTP CELT payloader rtp: rtpdvdepay: RTP DV Depayloader rtp: rtpdvpay: RTP DV Payloader rtp: rtpgstdepay: GStreamer depayloader rtp: rtpgstpay: RTP GStreamer payloader rtp: rtpilbcpay: RTP iLBC Payloader rtp: rtpilbcdepay: RTP iLBC depayloader rtp: rtpg722depay: RTP audio depayloader rtp: rtpg722pay: RTP audio payloader rtp: rtpg723depay: RTP G.723 depayloader rtp: rtpg723pay: RTP G.723 payloader rtp: rtpg726depay: RTP G.726 depayloader rtp: rtpg726pay: RTP G.726 payloader rtp: rtpg729depay: RTP G.729 depayloader rtp: rtpg729pay: RTP G.729 payloader rtp: rtpgsmdepay: RTP GSM depayloader rtp: rtpgsmpay: RTP GSM payloader rtp: rtpamrdepay: RTP AMR depayloader rtp: rtpamrpay: RTP AMR payloader rtp: rtppcmadepay: RTP PCMA depayloader rtp: rtppcmudepay: RTP PCMU depayloader rtp: rtppcmupay: RTP PCMU payloader rtp: rtppcmapay: RTP PCMA payloader rtp: rtpmpadepay: RTP MPEG audio depayloader rtp: rtpmpapay: RTP MPEG audio payloader rtp: rtpmparobustdepay: RTP MPEG audio depayloader rtp: rtpmpvdepay: RTP MPEG video depayloader rtp: rtpmpvpay: RTP MPEG2 ES video payloader rtp: rtpopusdepay: RTP Opus packet depayloader rtp: rtpopuspay: RTP Opus payloader rtp: rtph261pay: RTP H261 packet payloader rtp: rtph261depay: RTP H261 depayloader rtp: rtph263ppay: RTP H263 payloader rtp: rtph263pdepay: RTP H263 depayloader rtp: rtph263depay: RTP H263 depayloader rtp: rtph263pay: RTP H263 packet payloader rtp: rtph264depay: RTP H264 depayloader rtp: rtph264pay: RTP H264 payloader rtp: rtph265depay: RTP H265 depayloader rtp: rtph265pay: RTP H265 payloader rtp: rtpj2kdepay: RTP JPEG 2000 depayloader rtp: rtpj2kpay: RTP JPEG 2000 payloader rtp: rtpjpegdepay: RTP JPEG depayloader rtp: rtpjpegpay: RTP JPEG payloader rtp: rtpklvdepay: RTP KLV Depayloader rtp: rtpklvpay: RTP KLV Payloader rtp: rtpL16pay: RTP audio payloader rtp: rtpL16depay: RTP audio depayloader rtp: rtpL24pay: RTP audio payloader rtp: rtpL24depay: RTP audio depayloader rtp: asteriskh263: RTP Asterisk H263 depayloader rtp: rtpmp1sdepay: RTP MPEG1 System Stream depayloader rtp: rtpmp2tdepay: RTP MPEG Transport Stream depayloader rtp: rtpmp2tpay: RTP MPEG2 Transport Stream payloader rtp: rtpmp4vpay: RTP MPEG4 Video payloader rtp: rtpmp4vdepay: RTP MPEG4 video depayloader rtp: rtpmp4apay: RTP MPEG4 audio payloader rtp: rtpmp4adepay: RTP MPEG4 audio depayloader rtp: rtpmp4gdepay: RTP MPEG4 ES depayloader rtp: rtpmp4gpay: RTP MPEG4 ES payloader rtp: rtpqcelpdepay: RTP QCELP depayloader rtp: rtpqdm2depay: RTP QDM2 depayloader rtp: rtpsbcdepay: RTP SBC audio depayloader rtp: rtpsbcpay: RTP packet payloader rtp: rtpsirenpay: RTP Payloader for Siren Audio rtp: rtpsirendepay: RTP Siren packet depayloader rtp: rtpspeexpay: RTP Speex payloader rtp: rtpspeexdepay: RTP Speex depayloader rtp: rtpsv3vdepay: RTP SVQ3 depayloader rtp: rtptheoradepay: RTP Theora depayloader rtp: rtptheorapay: RTP Theora payloader rtp: rtpvorbisdepay: RTP Vorbis depayloader rtp: rtpvorbispay: RTP Vorbis payloader rtp: rtpvp8depay: RTP VP8 depayloader rtp: rtpvp8pay: RTP VP8 payloader rtp: rtpvp9depay: RTP VP9 depayloader rtp: rtpvp9pay: RTP VP9 payloader rtp: rtpvrawdepay: RTP Raw Video depayloader rtp: rtpvrawpay: RTP Raw Video payloader rtp: rtpstreampay: RTP Stream Payloading rtp: rtpstreamdepay: RTP Stream Depayloading rawparse: videoparse: Video Parse rawparse: audioparse: Audio Parse rawparse: unalignedaudioparse: unalignedaudioparse rawparse: unalignedvideoparse: unalignedvideoparse rawparse: rawaudioparse: rawaudioparse rawparse: rawvideoparse: rawvideoparse png: pngdec: PNG image decoder png: pngenc: PNG image encoder playback: playbin: Player Bin 2 playback: playbin3: Player Bin 3 playback: playsink: Player Sink playback: subtitleoverlay: Subtitle Overlay playback: streamsynchronizer: Stream Synchronizer playback: decodebin: Decoder Bin playback: decodebin3: Decoder Bin 3 playback: uridecodebin: URI Decoder playback: urisourcebin: URI reader playback: parsebin: Parse Bin ossaudio: osssrc: Audio Source (OSS) ossaudio: osssink: Audio Sink (OSS) oss4: oss4sink: OSS v4 Audio Sink oss4: oss4src: OSS v4 Audio Source opus: opusenc: Opus audio encoder opus: opusdec: Opus audio decoder ogg: oggdemux: Ogg demuxer ogg: oggmux: Ogg muxer ogg: ogmaudioparse: OGM audio stream parser ogg: ogmvideoparse: OGM video stream parser ogg: ogmtextparse: OGM text stream parser ogg: oggparse: Ogg parser ogg: oggaviparse: Ogg AVI parser navigationtest: navigationtest: Video navigation test mpegpsdemux: mpegpsdemux: MPEG Program Stream Demuxer mpeg2dec: mpeg2dec: mpeg1 and mpeg2 video decoder matroska: matroskademux: Matroska demuxer matroska: matroskaparse: Matroska parser matroska: matroskamux: Matroska muxer matroska: webmmux: WebM muxer mad: mad: mad mp3 decoder libav: avdec_aac: libav AAC (Advanced Audio Coding) decoder libav: avdec_ac3: libav ATSC A/52A (AC-3) decoder libav: avdec_atrac3: libav ATRAC3 (Adaptive TRansform Acoustic Coding 3) decoder libav: avdec_mp3: libav MP3 (MPEG audio layer 3) decoder libav: avdec_wmav1: libav Windows Media Audio 1 decoder libav: avdec_wmav2: libav Windows Media Audio 2 decoder libav: avdec_h263: libav H.263 / H.263-1996, H.263+ / H.263-1998 / H.263 version 2 decoder libav: avdec_h264: libav H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 decoder libav: avdec_jpegls: libav JPEG-LS decoder libav: avdec_mjpeg: libav MJPEG (Motion JPEG) decoder libav: avdec_mpeg2video: libav MPEG-2 video decoder libav: avdec_mpeg4: libav MPEG-4 part 2 decoder libav: avdec_mpegvideo: libav MPEG-1 video decoder libav: avdec_png: libav PNG (Portable Network Graphics) image decoder libav: avmux_mp3: libav MP3 (MPEG audio layer 3) formatter (not recommended, use id3v2mux instead) libav: avdeinterlace: libav Deinterlace element lame: lamemp3enc: L.A.M.E. mp3 encoder jpeg: jpegenc: JPEG image encoder jpeg: jpegdec: JPEG image decoder isomp4: qtdemux: QuickTime demuxer isomp4: rtpxqtdepay: RTP packet depayloader isomp4: qtmux: QuickTime Muxer isomp4: mp4mux: MP4 Muxer isomp4: ismlmux: ISML Muxer isomp4: 3gppmux: 3GPP Muxer isomp4: mj2mux: MJ2 Muxer isomp4: qtmoovrecover: QT Moov Recover id3tag: id3mux: ID3 v1 and v2 Muxer id3demux: id3demux: ID3 tag demuxer icydemux: icydemux: ICY tag demuxer gio: giosink: GIO sink gio: giosrc: GIO source gio: giostreamsink: GIO stream sink gio: giostreamsrc: GIO stream source flv: flvdemux: FLV Demuxer flv: flvmux: FLV muxer flac: flacenc: FLAC audio encoder flac: flacdec: FLAC audio decoder flac: flactag: FLAC tagger deinterlace: deinterlace: Deinterlacer coretracers: latency (GstTracerFactory) coretracers: log (GstTracerFactory) coretracers: rusage (GstTracerFactory) coretracers: stats (GstTracerFactory) coretracers: leaks (GstTracerFactory) coreelements: capsfilter: CapsFilter coreelements: concat: Concat coreelements: downloadbuffer: DownloadBuffer coreelements: fakesrc: Fake Source coreelements: fakesink: Fake Sink coreelements: fdsrc: Filedescriptor Source coreelements: fdsink: Filedescriptor Sink coreelements: filesrc: File Source coreelements: funnel: Funnel pipe fitting coreelements: identity: Identity coreelements: input-selector: Input selector coreelements: output-selector: Output selector coreelements: queue: Queue coreelements: queue2: Queue 2 coreelements: filesink: File Sink coreelements: tee: Tee pipe fitting coreelements: typefind: TypeFind coreelements: multiqueue: MultiQueue coreelements: valve: Valve element coreelements: streamiddemux: Streamid Demux avi: avidemux: Avi demuxer avi: avimux: Avi muxer avi: avisubtitle: Avi subtitle parser autodetect: autovideosink: Auto video sink autodetect: autovideosrc: Auto video source autodetect: autoaudiosink: Auto audio sink autodetect: autoaudiosrc: Auto audio source autoconvert: autoconvert: Select convertor based on caps autoconvert: autovideoconvert: Select color space convertor based on caps auparse: auparse: AU audio demuxer audiotestsrc: audiotestsrc: Audio test source audioresample: audioresample: Audio resampler audiorate: audiorate: Audio rate adjuster audioparsers: aacparse: AAC audio stream parser audioparsers: amrparse: AMR audio stream parser audioparsers: ac3parse: AC3 audio stream parser audioparsers: dcaparse: DTS Coherent Acoustics audio stream parser audioparsers: flacparse: FLAC audio parser audioparsers: mpegaudioparse: MPEG1 Audio Parser audioparsers: sbcparse: SBC audio parser audioparsers: wavpackparse: Wavpack audio stream parser audioconvert: audioconvert: Audio converter asf: asfdemux: ASF Demuxer asf: rtspwms: WMS RTSP Extension asf: rtpasfdepay: RTP ASF packet depayloader app: appsrc: AppSrc app: appsink: AppSink apetag: apedemux: APE tag demuxer alsa: alsasrc: Audio source (ALSA) alsa: alsasink: Audio sink (ALSA) alsa: alsamidisrc: AlsaMidi Source alphacolor: alphacolor: Alpha color filter alpha: alpha: Alpha filter staticelements: bin: Generic bin staticelements: pipeline: Pipeline object
Total count: 62 plugins (1 blacklist entry not shown), 414 features
jjamazon
commented
6 years ago Can you rebuild your Gstreamer with base, good and bad plugins and try again.
zeusshuang
commented
6 years ago @jjamazon
I re-built it but the issue is consistent. Do you see anything missing in my plugins list ?
So I may need to clarify it first. Amazon Music is must to be in white list device, I have done it.
How about iHeartRadio ?
And will only work in the States for Amazon Music and iHeartRadio, or it can be tested oversea ?
erikly01
commented
6 years ago How do you whitest Amazon music?
I can help you with the compilation
On Nov 9, 2017 17:29, "zeusshuang" notifications@github.com wrote:
@jjamazon https://github.com/jjamazon I re-built it but the issue is consistent. Do you see anything missing in my plugins list ? So I may need to clarify it first. Amazon Music is must to be in white list device, I have done it. How about iHeartRadio ? And will only work in the States for Amazon Music and iHeartRadio, or it can be tested oversea ?
— You are receiving this because you were mentioned. Reply to this email directly, view it on GitHub https://github.com/alexa/avs-device-sdk/issues/293#issuecomment-343326008, or mute the thread https://github.com/notifications/unsubscribe-auth/AXl-vj1fxuifCNeQxkYgkCsvaTz_ofGbks5s04ragaJpZM4QPWny .
zeusshuang
commented
6 years ago @erikly01 we have NDA signed with Amazon team and add our Amazon ID to whitelist. If it's not in whitelist, it will say : not support on this device ... After added to white list, it will reply to play XXX songs from Prime ... but got error ..
jjamazon
commented
6 years ago Hi zeusshuang,
When we grep for hls on our setup we see
$ gst-inspect-1.0 | grep hls typefindfunctions: application/x-hls: m3u8 libav: avmux_hls: libav Apple HTTP Live Streaming muxer
On different setup:
$ gst-inspect-1.0 | grep hls hls: hlsdemux: HLS Demuxer hls: hlssink: HTTP Live Streaming sink typefindfunctions: application/x-hls: m3u8 libav: avmux_hls: libav Apple HTTP Live Streaming muxer
hls support and libav is missing from your plugin list
What version of Gstreamer are you using ? $gst-inspect-1.0 --version
We require 1.10.4 or later. https://github.com/alexa/avs-device-sdk/wiki/Linux-Quick-Start-Guide#minimum-requirements-and-dependencies
You will have to build Gstreamer with hls support.
zeusshuang
commented
6 years ago @jjamazon thanks for the information! I have actually built 1.10.4 for Gstreamer, I will investigate why it's not built in the correct plug-ins.
zeusshuang
commented
6 years ago @jjamazon
thanks, this direction is correct and we solved hls issue and raise another codec missing.
We will solve it. and we can close this ticket now.
scotthea-amazon
commented
6 years ago zeusshuang,
Closing this ticket as you indicated above. Please re-open if I have closed it in error.
Regards, -SWH
Hi AVS team,
To try with SDK 1.2 on our platform, and try to test Q&A and list news, it's working, however, to try play Amazon Prime music, Alexa responded okay but no music is playing. I say : play the Beatles from Prime. Alexa will respond but no sound, could you have suggestion and I can look into this case ?
t 2017-11-02 08:53:36.451 [ a] 0 AudioInputProcessor:setState:from=IDLE,to=RECOGNIZING 2017-11-02 08:53:36.452 [ d] 0 DialogUXStateAggregator:setState:from=IDLE,to=LISTENING ############################
Listening...
############################
2017-11-02 08:53:36.453 [ 6] 9 SpeakerManager:provideStateCalled 2017-11-02 08:53:36.453 [ 7] 9 SpeakerManager:executeProvideStateCalled 2017-11-02 08:53:36.453 [ 7] 9 MediaPlayer:getSpeakerSettingsCalled 2017-11-02 08:53:36.454 [ 2] 9 MediaPlayer:handleGetSpeakerSettingsCalled 2017-11-02 08:53:36.454 [ 7] 9 MediaPlayer:getSpeakerSettingsCalled 2017-11-02 08:53:36.454 [ 2] 9 MediaPlayer:handleGetSpeakerSettingsCalled 2017-11-02 08:53:36.455 [ 7] 9 SpeakerManager:validateSpeakerSettingsConsistencyResult:consistent=true 2017-11-02 08:53:36.455 [ 7] 9 SpeakerManager:validateSpeakerSettings:volume=100,mute=false 2017-11-02 08:53:36.455 [ 7] 0 ContextManager:updateStateLocked:action=updatedState,state={"volume"\:100\,"muted"\:false},namespace=Speaker,name=VolumeState 2017-11-02 08:53:36.458 [ 6] 0 ContextManager:buildContextSuccessful:context={"context"\:[{"header"\:{"namespace"\:"Speaker"\,"name"\:"VolumeState"}\,"payload"\:{"volume"\:100\,"muted"\:false}}\,{"header"\:{"namespace"\:"SpeechSynthesizer"\,"name"\:"SpeechState"}\,"payload"\:{"token"\:"amzn1.as-ct.v1.Domain\:Application\:Knowledge#ACRI#dd30a595-a083-4d77-ad40-36b3574ec7a5#Alexa3P\:1.0/2017/11/02/08/031ce94656824a3bb035025ba4702532/52\:25\:\:TNIH_2V.0cd7db1a-2c0f-472b-853f-6e9cef0e98d7ZXV/1"\,"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"\:[]}}]} 2017-11-02 08:53:36.458 [ a] 0 AudioInputProcessor:executeOnContextAvailable:jsonContext={"context"\:[{"header"\:{"namespace"\:"Speaker"\,"name"\:"VolumeState"}\,"payload"\:{"volume"\:100\,"muted"\:false}}\,{"header"\:{"namespace"\:"SpeechSynthesizer"\,"name"\:"SpeechState"}\,"payload"\:{"token"\:"amzn1.as-ct.v1.Domain\:Application\:Knowledge#ACRI#dd30a595-a083-4d77-ad40-36b3574ec7a5#Alexa3P\:1.0/2017/11/02/08/031ce94656824a3bb035025ba4702532/52\:25\:\:TNIH_2V.0cd7db1a-2c0f-472b-853f-6e9cef0e98d7ZXV/1"\,"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"\:[]}}]} 2017-11-02 08:53:36.458 [ a] 1 FocusManager:acquireChannel:channelName=Dialog,activityId=SpeechRecognizer.Recognize 2017-11-02 08:53:36.459 [ 11] 0 AudioPlayer:onFocusChanged:newFocus=BACKGROUND 2017-11-02 08:53:36.459 [ a] I DirectiveProcessor:setDialogRequestIdLocked:oldValue=d0481bbc-6739-40ba-ace4-88cd97127867,newValue=795bca12-8f05-42d4-b2e5-164b9369c861 2017-11-02 08:53:36.459 [ a] 0 DirectiveProcessor:scrubDialogRequestIdLocked:dialogRequestId=d0481bbc-6739-40ba-ace4-88cd97127867 2017-11-02 08:53:36.459 [ 9] 1 AudioPlayer:executeOnFocusChanged:from=FOREGROUND,to=BACKGROUND,m_currentActivity=IDLE 2017-11-02 08:53:36.460 [ 9] 1 AudioPlayer:executeOnFocusChanged:action=pauseMediaPlayer 2017-11-02 08:53:36.460 [ 9] 9 MediaPlayer:pausedCalled 2017-11-02 08:53:36.461 [ a] 0 EventBuilder:buildJsonEventString:messageId=d58f1104-09ca-4f44-bf87-e31f630a5faf,namespace=SpeechRecognizer,name=Recognize 2017-11-02 08:53:36.462 [ a] 0 AudioInputProcessor:executeOnFocusChanged:newFocus=FOREGROUND 2017-11-02 08:53:36.462 [ a] 9 HTTP2Transport:enqueueRequest 2017-11-02 08:53:36.462 [ 2] 0 MediaPlayer:handlePauseCalled:idPassed=17,currentId=0 2017-11-02 08:53:36.463 [ 2] E MediaPlayer:validateSourceAndIdFailed:reason=sourceNotSet 2017-11-02 08:53:36.463 [ 2] E MediaPlayer:handlePauseFailed 2017-11-02 08:53:36.546 [ b] 0 HTTP2Transport:processNextOutgoingMessage 2017-11-02 08:53:36.546 [ b] 0 HTTP2StreamPool:getStream:streamId=111,numAcquiredStreams=2 2017-11-02 08:53:36.547 [ b] 9 HTTP2Transport:insertActiveStream:handle=0x10760c0 2017-11-02 08:53:39.926 [ e] 0 MessageInterpreter:receive:messageId=1e0ea7b3-e862-46a4-8ae2-328b841e1ee5:No dialogRequestId attached to message. 2017-11-02 08:53:39.926 [ e] I DirectiveSequencer:onDirective:directive={"namespace\:"SpeechRecognizer"\,name\:"StopCapture"\,messageId\:"1e0ea7b3-e862-46a4-8ae2-328b841e1ee5"\,dialogRequestId\:""} 2017-11-02 08:53:39.926 [ f] I DirectiveRouter:preHandleDirective:messageId=1e0ea7b3-e862-46a4-8ae2-328b841e1ee5,action=calling 2017-11-02 08:53:39.927 [ f] 0 CapabilityAgent:addingMessageIdToMap:messageId=1e0ea7b3-e862-46a4-8ae2-328b841e1ee5 2017-11-02 08:53:39.927 [ 10] I DirectiveRouter:handleDirective:messageId=1e0ea7b3-e862-46a4-8ae2-328b841e1ee5,action=calling 2017-11-02 08:53:39.928 [ a] 0 AudioInputProcessor:stopCapture:stopImmediately=true 2017-11-02 08:53:39.928 [ a] 0 AudioInputProcessor:setState:from=RECOGNIZING,to=BUSY 2017-11-02 08:53:39.929 [ a] 0 DirectiveProcessor:onHandlingCompeted:messageId=1e0ea7b3-e862-46a4-8ae2-328b841e1ee5,directiveBeingPreHandled=(nullptr) 2017-11-02 08:53:39.929 [ a] 0 CapabilityAgent:removingMessageIdFromMap:messageId=1e0ea7b3-e862-46a4-8ae2-328b841e1ee5 2017-11-02 08:53:39.929 [ d] 0 DialogUXStateAggregator:setState:from=LISTENING,to=THINKING ###########################
Thinking...
###########################
2017-11-02 08:53:39.936 [ b] I InProcessAttachmentReader:readFailed:reason=SDS is closed 2017-11-02 08:53:40.468 [ b] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 0e15c6fffedfef9a-000049b3-000d4a21-882d0fc6e169753c-52e2f26e-111 2017-11-02 08:53:40.477 [ e] I DirectiveSequencer:onDirective:directive={"namespace\:"AudioPlayer"\,name\:"Stop"\,messageId\:"01926e30-3214-474f-a4fb-007592b246af"\,dialogRequestId\:"795bca12-8f05-42d4-b2e5-164b9369c861"} 2017-11-02 08:53:40.478 [ f] I DirectiveRouter:preHandleDirective:messageId=01926e30-3214-474f-a4fb-007592b246af,action=calling 2017-11-02 08:53:40.478 [ f] 0 CapabilityAgent:addingMessageIdToMap:messageId=01926e30-3214-474f-a4fb-007592b246af 2017-11-02 08:53:40.479 [ 10] I DirectiveRouter:handleDirective:messageId=01926e30-3214-474f-a4fb-007592b246af,action=calling 2017-11-02 08:53:40.479 [ 10] 0 AudioPlayer:handleDirective:name=Stop,messageId=01926e30-3214-474f-a4fb-007592b246af 2017-11-02 08:53:40.479 [ e] I DirectiveSequencer:onDirective:directive={"namespace\:"SpeechSynthesizer"\,name\:"Speak"\,messageId\:"9c035fd6-cfbc-43c6-a950-d79dc50e87a4"\,dialogRequestId\:"795bca12-8f05-42d4-b2e5-164b9369c861"} 2017-11-02 08:53:40.479 [ 10] 1 AudioPlayer:handleStopDirective 2017-11-02 08:53:40.480 [ 10] 0 DirectiveProcessor:onHandlingCompeted:messageId=01926e30-3214-474f-a4fb-007592b246af,directiveBeingPreHandled=(nullptr) 2017-11-02 08:53:40.480 [ 10] 0 CapabilityAgent:removingMessageIdFromMap:messageId=01926e30-3214-474f-a4fb-007592b246af 2017-11-02 08:53:40.481 [ 9] 1 AudioPlayer:executeStop:playNextItem=false,m_currentActivity=IDLE 2017-11-02 08:53:40.481 [ f] I DirectiveRouter:preHandleDirective:messageId=9c035fd6-cfbc-43c6-a950-d79dc50e87a4,action=calling 2017-11-02 08:53:40.481 [ f] 0 CapabilityAgent:addingMessageIdToMap:messageId=9c035fd6-cfbc-43c6-a950-d79dc50e87a4 2017-11-02 08:53:40.482 [ f] 9 SpeechSynthesizer:preHandleDirective:messageId=9c035fd6-cfbc-43c6-a950-d79dc50e87a4 2017-11-02 08:53:40.482 [ 8] 0 SpeechSynthesizer:executePreHandle:messageId=9c035fd6-cfbc-43c6-a950-d79dc50e87a4 2017-11-02 08:53:40.483 [ 10] I DirectiveRouter:handleDirective:messageId=9c035fd6-cfbc-43c6-a950-d79dc50e87a4,action=calling 2017-11-02 08:53:40.483 [ 10] 9 SpeechSynthesizer:handleDirective:messageId=9c035fd6-cfbc-43c6-a950-d79dc50e87a4 2017-11-02 08:53:40.484 [ 8] 0 SpeechSynthesizer:executeHandle:messageId=9c035fd6-cfbc-43c6-a950-d79dc50e87a4 2017-11-02 08:53:40.485 [ 8] 1 FocusManager:acquireChannel:channelName=Dialog,activityId=SpeechSynthesizer.Speak 2017-11-02 08:53:40.485 [ 11] 0 SpeechSynthesizer:onFocusChanged:newFocus=FOREGROUND 2017-11-02 08:53:40.486 [ a] 0 AudioInputProcessor:executeOnFocusChanged:newFocus=NONE 2017-11-02 08:53:40.486 [ a] 0 AudioInputProcessor:executeOnFocusChanged:reason=Lost focus 2017-11-02 08:53:40.486 [ a] 0 AudioInputProcessor:setState:from=BUSY,to=IDLE 2017-11-02 08:53:40.487 [ 8] 0 SpeechSynthesizer:executeStateChange:newState=PLAYING 2017-11-02 08:53:40.487 [ 8] 9 SpeechSynthesizer:startPlaying 2017-11-02 08:53:40.488 [ 8] 9 MediaPlayer:setSourceCalled:sourceType=AttachmentReader 2017-11-02 08:53:40.488 [ 2] 0 MediaPlayer:handleSetSourceCalled 2017-11-02 08:53:40.488 [ 2] 9 MediaPlayer:tearDownTransientPipelineElements 2017-11-02 08:53:40.490 [ 8] 9 MediaPlayer:playCalled 2017-11-02 08:53:40.491 [ 2] 0 MediaPlayer:handlePlayCalled:idPassed=18,currentId=18 2017-11-02 08:53:40.491 [ 2] 0 MediaPlayer:handlePlay:attemptBuffering=0 2017-11-02 08:53:40.491 [ d] 0 DialogUXStateAggregator:setState:from=THINKING,to=IDLE ########################################
Alexa is currently idle!
########################################
2017-11-02 08:53:40.499 [ 2] 0 MediaPlayer:handlePlay:startingState=PLAYING,stateReturn=ASYNC 2017-11-02 08:53:40.499 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:40.499 [ 2b] 9 BaseStreamSource:onNeedDataCalled:size=4096 2017-11-02 08:53:40.500 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:40.500 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:40.500 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:40.500 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:40.500 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:40.500 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:40.501 [ 2] 9 MediaPlayer:State Change:oldState=NULL,newState=READY,pendingState=PLAYING 2017-11-02 08:53:40.710 [ b] 0 AudioInputProcessor:onSendCompleted:status=SUCCESS 2017-11-02 08:53:40.832 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:40.832 [ b] 0 HTTP2Transport:cleanupFinishedStream:streamId=111,result=200 2017-11-02 08:53:40.832 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:40.833 [ b] 0 HTTP2StreamPool:releaseStream:streamId=111,numAcquiredStreams=1 2017-11-02 08:53:40.833 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:40.833 [ 2] 9 MediaPlayer:messageReceived:messageType=stream-status 2017-11-02 08:53:40.833 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:40.834 [ 2] 9 MediaPlayer:messageReceived:messageType=stream-status 2017-11-02 08:53:40.834 [ 2] 9 BaseStreamSource:handleNeedDataCalled 2017-11-02 08:53:40.834 [ 2] 9 BaseStreamSource:installOnReadDataHandler:action=newSourceId,sourceId=154 2017-11-02 08:53:40.834 [ 2] 9 AttachmentReaderSource:read:size=4096,status=0 2017-11-02 08:53:40.835 [ 2] 9 AttachmentReaderSource:read:size=4096,status=0 2017-11-02 08:53:40.835 [ 2] 9 AttachmentReaderSource:read:size=2221,status=0 2017-11-02 08:53:40.835 [ 2] I InProcessAttachmentReader:readFailed:reason=SDS is closed 2017-11-02 08:53:40.835 [ 2] 9 AttachmentReaderSource:read:size=0,status=3 2017-11-02 08:53:40.836 [ 2] 9 BaseStreamSource:signalEndOfDataCalled 2017-11-02 08:53:40.837 [ 2] 9 BaseStreamSource:clearOnReadDataHandlerCalled:sourceId=154 2017-11-02 08:53:40.840 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:40.841 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:40.843 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:40.844 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:40.848 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:40.848 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:40.851 [ 2b] 9 MediaPlayer:onPadAddedCalled 2017-11-02 08:53:40.851 [ 2] 9 MediaPlayer:handlePadAddedSignalCalled 2017-11-02 08:53:40.875 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:40.875 [ 2] 9 MediaPlayer:messageReceived:messageType=stream-start 2017-11-02 08:53:41.100 [ 2] 9 MediaPlayer:messageReceived:messageType=latency 2017-11-02 08:53:41.100 [ 2] 9 MediaPlayer:messageReceived:messageType=stream-status 2017-11-02 08:53:41.100 [ 2] 9 MediaPlayer:messageReceived:messageType=tag 2017-11-02 08:53:41.101 [ 2] 0 MediaPlayer:callingOnTags 2017-11-02 08:53:41.101 [ 2] 9 MediaPlayer:messageReceived:messageType=tag 2017-11-02 08:53:41.102 [ 2] 0 MediaPlayer:callingOnTags 2017-11-02 08:53:41.102 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:41.102 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:41.102 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:41.102 [ 2] 9 MediaPlayer:State Change:oldState=READY,newState=PAUSED,pendingState=PLAYING 2017-11-02 08:53:41.103 [ 2] 9 MediaPlayer:messageReceived:messageType=async-done 2017-11-02 08:53:41.103 [ 2] 9 MediaPlayer:messageReceived:messageType=new-clock 2017-11-02 08:53:41.103 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:41.103 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:41.104 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:41.104 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:41.104 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:41.104 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:41.104 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:41.105 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:41.105 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:41.105 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:41.105 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:53:41.105 [ 2] 9 MediaPlayer:State Change:oldState=PAUSED,newState=PLAYING,pendingState=VOID_PENDING 2017-11-02 08:53:41.106 [ 2] 0 MediaPlayer:callingOnPlaybackStarted:currentId=18 2017-11-02 08:53:41.106 [ 2] 9 SpeechSynthesizer:onPlaybackStarted:callbackSourceId=18 2017-11-02 08:53:41.106 [ 8] 0 SpeechSynthesizer:executePlaybackStarted 2017-11-02 08:53:41.106 [ 8] 0 SpeechSynthesizer:executeProvideState:stateRequestToken=0 2017-11-02 08:53:41.107 [ 8] 9 MediaPlayer:getOffsetCalled 2017-11-02 08:53:41.108 [ 2] 0 MediaPlayer:handleGetOffsetCalled:idPassed=18,currentId=18 2017-11-02 08:53:41.109 [ 8] 0 ContextManager:updateStateLocked:action=updatedState,state={"token"\:"amzn1.as-ct.v1.Domain\:Alexa\:Notification#ACRI#NoNotifications0a7199b2-2fe8-40de-9484-a0d9f60a2256"\,"offsetInMilliseconds"\:0\,"playerActivity"\:"PLAYING"},namespace=SpeechSynthesizer,name=SpeechState 2017-11-02 08:53:41.109 [ 8] 0 EventBuilder:buildJsonEventString:messageId=cc95d5b9-80f5-429b-8334-a8b550822ee4,namespace=SpeechSynthesizer,name=SpeechStarted 2017-11-02 08:53:41.110 [ 8] 9 HTTP2Transport:enqueueRequest 2017-11-02 08:53:41.111 [ d] 0 DialogUXStateAggregator:setState:from=IDLE,to=SPEAKING ###########################
Speaking...
###########################
2017-11-02 08:53:41.111 [ 11] 9 SpeechSynthesizer:onFocusChangedSuccess 2017-11-02 08:53:41.112 [ 2] 9 MediaPlayer:messageReceived:messageType=tag 2017-11-02 08:53:41.113 [ 2] 0 MediaPlayer:callingOnTags 2017-11-02 08:53:41.134 [ b] 0 HTTP2Transport:processNextOutgoingMessage 2017-11-02 08:53:41.135 [ b] 0 HTTP2StreamPool:getStream:streamId=113,numAcquiredStreams=2 2017-11-02 08:53:41.135 [ b] 9 HTTP2Transport:insertActiveStream:handle=0x10760c0 2017-11-02 08:53:41.146 [ 2b] 9 BaseStreamSource:onNeedDataCalled:size=4096 2017-11-02 08:53:41.146 [ 2] 9 BaseStreamSource:handleNeedDataCalled 2017-11-02 08:53:41.475 [ b] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 0e15c6fffedfef9a-000049b3-000d4a21-882d0fc6e169753c-52e2f26e-113 2017-11-02 08:53:41.475 [ b] 0 HTTP2Transport:cleanupFinishedStream:streamId=113,result=204 2017-11-02 08:53:41.476 [ b] 0 HTTP2StreamPool:releaseStream:streamId=113,numAcquiredStreams=1 2017-11-02 08:53:41.476 [ b] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT 2017-11-02 08:53:42.925 [ 2] 9 MediaPlayer:messageReceived:messageType=eos 2017-11-02 08:53:42.925 [ 2] 9 BaseStreamSource:~BaseStreamSource 2017-11-02 08:53:42.926 [ 2] 0 MediaPlayer:callingOnPlaybackFinished:currentId=18 2017-11-02 08:53:42.926 [ 2] 9 SpeechSynthesizer:onPlaybackFinished:callbackSourceId=18 2017-11-02 08:53:42.926 [ 2] 9 MediaPlayer:tearDownTransientPipelineElements 2017-11-02 08:53:42.927 [ 8] 0 SpeechSynthesizer:executePlaybackFinished 2017-11-02 08:53:42.927 [ 8] 0 SpeechSynthesizer:executeProvideState:stateRequestToken=0 2017-11-02 08:53:42.927 [ 8] 0 ContextManager:updateStateLocked:action=updatedState,state={"token"\:"amzn1.as-ct.v1.Domain\:Alexa\:Notification#ACRI#NoNotifications0a7199b2-2fe8-40de-9484-a0d9f60a2256"\,"offsetInMilliseconds"\:0\,"playerActivity"\:"FINISHED"},namespace=SpeechSynthesizer,name=SpeechState 2017-11-02 08:53:42.928 [ 8] 9 SpeechSynthesizer:releaseForegroundFocus 2017-11-02 08:53:42.928 [ 8] 1 FocusManager:releaseChannel:channelName=Dialog 2017-11-02 08:53:42.929 [ 8] 0 EventBuilder:buildJsonEventString:messageId=0f47b710-e3be-4fef-a329-3c6ea74c7044,namespace=SpeechSynthesizer,name=SpeechFinished 2017-11-02 08:53:42.929 [ 8] 9 HTTP2Transport:enqueueRequest 2017-11-02 08:53:42.929 [ 8] 9 SpeechSynthesizer:setHandlingCompleted 2017-11-02 08:53:42.930 [ 8] 0 DirectiveProcessor:onHandlingCompeted:messageId=9c035fd6-cfbc-43c6-a950-d79dc50e87a4,directiveBeingPreHandled=(nullptr) 2017-11-02 08:53:42.930 [ 8] 0 CapabilityAgent:removingMessageIdFromMap:messageId=9c035fd6-cfbc-43c6-a950-d79dc50e87a4 2017-11-02 08:53:42.931 [ 11] 0 SpeechSynthesizer:onFocusChanged:newFocus=NONE 2017-11-02 08:53:42.932 [ 11] 0 AudioPlayer:onFocusChanged:newFocus=FOREGROUND 2017-11-02 08:53:42.932 [ 9] 1 AudioPlayer:executeOnFocusChanged:from=BACKGROUND,to=FOREGROUND,m_currentActivity=IDLE 2017-11-02 08:53:42.932 [ 9] 1 AudioPlayer:executeOnFocusChanged:action=playNextItem 2017-11-02 08:53:42.932 [ 9] 1 AudioPlayer:playNextItem:m_audioItems.size=1 2017-11-02 08:53:42.932 [ 9] 9 MediaPlayer:setSourceForUrlCalled 2017-11-02 08:53:42.982 [ b] 0 HTTP2Transport:processNextOutgoingMessage 2017-11-02 08:53:42.982 [ b] 0 HTTP2StreamPool:getStream:streamId=115,numAcquiredStreams=2 2017-11-02 08:53:42.983 [ b] 9 HTTP2Transport:insertActiveStream:handle=0x10760c0 2017-11-02 08:53:42.985 [ 2] 9 MediaPlayer:tearDownTransientPipelineElements 2017-11-02 08:53:42.986 [ 2c] 0 MediaPlayer:handleSetSourceForUrlCalled 2017-11-02 08:53:42.986 [ 2c] 9 UrlSource:UrlSourceCreate 2017-11-02 08:53:42.987 [ 2c] 0 UrlSource:initCalledForUrlSource 2017-11-02 08:53:42.988 [ 2d] E LibCurlHttpContentFetcher:getContentFailed:reason=enableLibCurlCookieEngineFailed 2017-11-02 08:53:42.988 [ 9] 1 AudioPlayer:playNextItem:item.stream.offset=0 2017-11-02 08:53:42.988 [ 2d] E PlaylistParser:getHTTPContent:reason=badHTTPContentReceived 2017-11-02 08:53:42.988 [ 9] 9 MediaPlayer:playCalled 2017-11-02 08:53:42.988 [ 2d] E UrlSource:parseError 2017-11-02 08:53:42.989 [ 9] E UrlSource:preprocess:reason=noValidUrls 2017-11-02 08:53:42.989 [ 2] 0 MediaPlayer:handlePlayCalled:idPassed=19,currentId=19 2017-11-02 08:53:42.989 [ 2] 0 MediaPlayer:handlePlay:attemptBuffering=0 2017-11-02 08:53:42.999 [ 2] 0 MediaPlayer:handlePlay:startingState=PLAYING,stateReturn=FAILURE 2017-11-02 08:53:42.999 [ 2] E MediaPlayer:handlePlayFailed:reason=gstElementSetStateFailure 2017-11-02 08:53:43.000 [ 2] 0 MediaPlayer:callingOnPlaybackError:type=MEDIA_ERROR_INTERNAL_DEVICE_ERROR,error=MediaPlayer\:handlePlayFailed\:reason\=gstElementSetStateFailure,currentId=19 2017-11-02 08:53:43.000 [ 2] 0 AudioPlayer:onPlaybackError:type=MEDIA_ERROR_INTERNAL_DEVICE_ERROR,error=MediaPlayer\:handlePlayFailed\:reason\=gstElementSetStateFailure,id=19 2017-11-02 08:53:43.000 [ 2] 9 MediaPlayer:tearDownTransientPipelineElements 2017-11-02 08:53:43.000 [ 9] E AudioPlayer:executeOnPlaybackError:id=19,type=MEDIA_ERROR_INTERNAL_DEVICE_ERROR,error=MediaPlayer\:handlePlayFailed\:reason\=gstElementSetStateFailure 2017-11-02 08:53:43.000 [ 2] 9 UrlSource:shutdownCalled 2017-11-02 08:53:43.001 [ 9] 0 EventBuilder:buildJsonEventString:messageId=d6ec19a1-6690-4de9-b51d-8c12e6335484,namespace=AudioPlayer,name=PlaybackFailed 2017-11-02 08:53:43.002 [ 9] 9 HTTP2Transport:enqueueRequest 2017-11-02 08:53:43.002 [ 9] 1 AudioPlayer:executeStop:playNextItem=false,m_currentActivity=IDLE 2017-11-02 08:53:43.131 [ d] 0 DialogUXStateAggregator:setState:from=FINISHED,to=IDLE ########################################
Alexa is currently idle!
########################################
2017-11-02 08:53:43.378 [ b] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 0e15c6fffedfef9a-000049b3-000d4a21-882d0fc6e169753c-52e2f26e-115 2017-11-02 08:53:43.378 [ b] 0 HTTP2Transport:cleanupFinishedStream:streamId=115,result=204 2017-11-02 08:53:43.379 [ b] 0 HTTP2StreamPool:releaseStream:streamId=115,numAcquiredStreams=1 2017-11-02 08:53:43.379 [ b] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT 2017-11-02 08:53:43.379 [ b] 0 HTTP2Transport:processNextOutgoingMessage 2017-11-02 08:53:43.379 [ b] 0 HTTP2StreamPool:getStream:streamId=117,numAcquiredStreams=2 2017-11-02 08:53:43.380 [ b] 9 HTTP2Transport:insertActiveStream:handle=0x10760c0 2017-11-02 08:53:43.990 [ 9] 1 AudioPlayer:sendEventWithTokenAndOffset:eventName=ProgressReportDelayElapsed 2017-11-02 08:53:43.991 [ 9] 0 EventBuilder:buildJsonEventString:messageId=e62a2e77-c07c-4687-a06e-432b8887ec5e,namespace=AudioPlayer,name=ProgressReportDelayElapsed 2017-11-02 08:53:43.991 [ 9] 9 HTTP2Transport:enqueueRequest 2017-11-02 08:53:44.159 [ b] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 0e15c6fffedfef9a-000049b3-000d4a21-882d0fc6e169753c-52e2f26e-117 2017-11-02 08:53:44.159 [ b] 0 HTTP2Transport:processNextOutgoingMessage 2017-11-02 08:53:44.159 [ b] 0 HTTP2StreamPool:getStream:streamId=119,numAcquiredStreams=3 2017-11-02 08:53:44.160 [ b] 9 HTTP2Transport:insertActiveStream:handle=0xffa068 2017-11-02 08:53:44.161 [ e] 0 MessageInterpreter:receive:messageId=805b2c7f-0541-45f5-aea9-084c4f5337e5:No dialogRequestId attached to message. 2017-11-02 08:53:44.162 [ e] I DirectiveSequencer:onDirective:directive={"namespace\:"Speaker"\,name\:"SetMute"\,messageId\:"805b2c7f-0541-45f5-aea9-084c4f5337e5"\,dialogRequestId\:""} 2017-11-02 08:53:44.162 [ f] I DirectiveRouter:preHandleDirective:messageId=805b2c7f-0541-45f5-aea9-084c4f5337e5,action=calling 2017-11-02 08:53:44.163 [ f] 0 CapabilityAgent:addingMessageIdToMap:messageId=805b2c7f-0541-45f5-aea9-084c4f5337e5 2017-11-02 08:53:44.163 [ e] 0 MessageInterpreter:receive:messageId=4a5187f7-23ea-4c96-bc10-9e9ebec3c856:No dialogRequestId attached to message. 2017-11-02 08:53:44.163 [ 10] I DirectiveRouter:handleDirective:messageId=805b2c7f-0541-45f5-aea9-084c4f5337e5,action=calling 2017-11-02 08:53:44.164 [ e] I DirectiveSequencer:onDirective:directive={"namespace\:"AudioPlayer"\,name\:"Play"\,messageId\:"4a5187f7-23ea-4c96-bc10-9e9ebec3c856"\,dialogRequestId\:""} 2017-11-02 08:53:44.164 [ 7] 9 SpeakerManager:executeSetMuteCalled:mute=false 2017-11-02 08:53:44.164 [ 7] 9 MediaPlayer:setMuteCalled 2017-11-02 08:53:44.165 [ 2] 9 MediaPlayer:handleSetMuteCalled 2017-11-02 08:53:44.165 [ 7] 9 MediaPlayer:setMuteCalled 2017-11-02 08:53:44.165 [ f] I DirectiveRouter:preHandleDirective:messageId=4a5187f7-23ea-4c96-bc10-9e9ebec3c856,action=calling 2017-11-02 08:53:44.165 [ f] 0 CapabilityAgent:addingMessageIdToMap:messageId=4a5187f7-23ea-4c96-bc10-9e9ebec3c856 2017-11-02 08:53:44.166 [ 2] 9 MediaPlayer:handleSetMuteCalled 2017-11-02 08:53:44.166 [ b] 0 HTTP2Transport:cleanupFinishedStream:streamId=117,result=200 2017-11-02 08:53:44.166 [ 7] 9 MediaPlayer:getSpeakerSettingsCalled 2017-11-02 08:53:44.167 [ 10] I DirectiveRouter:handleDirective:messageId=4a5187f7-23ea-4c96-bc10-9e9ebec3c856,action=calling 2017-11-02 08:53:44.167 [ 10] 0 AudioPlayer:handleDirective:name=Play,messageId=4a5187f7-23ea-4c96-bc10-9e9ebec3c856 2017-11-02 08:53:44.167 [ 10] 1 AudioPlayer:handlePlayDirective 2017-11-02 08:53:44.168 [ 10] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=streamFormat 2017-11-02 08:53:44.168 [ 10] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=progressReportIntervalInMilliseconds 2017-11-02 08:53:44.169 [ 10] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=expectedPreviousToken 2017-11-02 08:53:44.169 [ 10] 0 DirectiveProcessor:onHandlingCompeted:messageId=4a5187f7-23ea-4c96-bc10-9e9ebec3c856,directiveBeingPreHandled=(nullptr) 2017-11-02 08:53:44.169 [ 10] 0 CapabilityAgent:removingMessageIdFromMap:messageId=4a5187f7-23ea-4c96-bc10-9e9ebec3c856 2017-11-02 08:53:44.170 [ 9] 1 AudioPlayer:executePlay:playBehavior=REPLACE_ALL 2017-11-02 08:53:44.170 [ 9] 1 AudioPlayer:executeStop:playNextItem=true,m_currentActivity=IDLE 2017-11-02 08:53:44.170 [ 2] 9 MediaPlayer:handleGetSpeakerSettingsCalled 2017-11-02 08:53:44.170 [ 7] 9 MediaPlayer:getSpeakerSettingsCalled 2017-11-02 08:53:44.171 [ 2] 9 MediaPlayer:handleGetSpeakerSettingsCalled 2017-11-02 08:53:44.171 [ 7] 9 SpeakerManager:validateSpeakerSettingsConsistencyResult:consistent=true 2017-11-02 08:53:44.171 [ 7] 9 SpeakerManager:validateSpeakerSettings:volume=100,mute=false 2017-11-02 08:53:44.171 [ 7] 9 SpeakerManager:executeNotifyObserverCalled 2017-11-02 08:53:44.171 [ 7] 9 SpeakerManager:executeSendSpeakerSettingsChangedEvent ##################################################################
SOURCE:DIRECTIVE TYPE:AVS_SYNCED VOLUME:100 MUTE:0
##################################################################
2017-11-02 08:53:44.172 [ 7] 0 EventBuilder:buildJsonEventString:messageId=f4681981-0213-4f48-a531-af25210ae471,namespace=Speaker,name=MuteChanged 2017-11-02 08:53:44.172 [ 7] 9 HTTP2Transport:enqueueRequest 2017-11-02 08:53:44.507 [ 7] 0 DirectiveProcessor:onHandlingCompeted:messageId=805b2c7f-0541-45f5-aea9-084c4f5337e5,directiveBeingPreHandled=(nullptr) 2017-11-02 08:53:44.507 [ 7] 0 CapabilityAgent:removingMessageIdFromMap:messageId=805b2c7f-0541-45f5-aea9-084c4f5337e5 2017-11-02 08:53:44.167 [ b] 0 HTTP2StreamPool:releaseStream:streamId=117,numAcquiredStreams=2 2017-11-02 08:53:45.058 [ b] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 0e15c6fffedfef9a-000049b3-000d4a21-882d0fc6e169753c-52e2f26e-119 2017-11-02 08:53:45.059 [ b] 0 HTTP2Transport:cleanupFinishedStream:streamId=119,result=204 2017-11-02 08:53:45.059 [ b] 0 HTTP2StreamPool:releaseStream:streamId=119,numAcquiredStreams=1 2017-11-02 08:53:45.059 [ b] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT 2017-11-02 08:53:45.059 [ b] 0 HTTP2Transport:processNextOutgoingMessage 2017-11-02 08:53:45.060 [ b] 0 HTTP2StreamPool:getStream:streamId=121,numAcquiredStreams=2 2017-11-02 08:53:45.060 [ b] 9 HTTP2Transport:insertActiveStream:handle=0xffa068 2017-11-02 08:53:45.450 [ b] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 0e15c6fffedfef9a-000049b3-000d4a21-882d0fc6e169753c-52e2f26e-121 2017-11-02 08:53:45.450 [ b] 0 HTTP2Transport:cleanupFinishedStream:streamId=121,result=204 2017-11-02 08:53:45.450 [ b] 0 HTTP2StreamPool:releaseStream:streamId=121,numAcquiredStreams=1 2017-11-02 08:53:45.450 [ b] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT
t 2017-11-02 08:53:53.033 [ a] 0 AudioInputProcessor:setState:from=IDLE,to=RECOGNIZING 2017-11-02 08:53:53.033 [ 6] 9 SpeakerManager:provideStateCalled 2017-11-02 08:53:53.034 [ d] 0 DialogUXStateAggregator:setState:from=IDLE,to=LISTENING 2017-11-02 08:53:53.034 [ 7] 9 SpeakerManager:executeProvideStateCalled 2017-11-02 08:53:53.034 [ 7] 9 MediaPlayer:getSpeakerSettingsCalled ############################
Listening...
############################
2017-11-02 08:53:53.047 [ 2] 9 MediaPlayer:handleGetSpeakerSettingsCalled 2017-11-02 08:53:53.057 [ 7] 9 MediaPlayer:getSpeakerSettingsCalled 2017-11-02 08:53:53.057 [ 2] 9 MediaPlayer:handleGetSpeakerSettingsCalled 2017-11-02 08:53:53.057 [ 7] 9 SpeakerManager:validateSpeakerSettingsConsistencyResult:consistent=true 2017-11-02 08:53:53.058 [ 7] 9 SpeakerManager:validateSpeakerSettings:volume=100,mute=false 2017-11-02 08:53:53.058 [ 7] 0 ContextManager:updateStateLocked:action=updatedState,state={"volume"\:100\,"muted"\:false},namespace=Speaker,name=VolumeState 2017-11-02 08:53:53.060 [ 6] 0 ContextManager:buildContextSuccessful:context={"context"\:[{"header"\:{"namespace"\:"Speaker"\,"name"\:"VolumeState"}\,"payload"\:{"volume"\:100\,"muted"\:false}}\,{"header"\:{"namespace"\:"SpeechSynthesizer"\,"name"\:"SpeechState"}\,"payload"\:{"token"\:"amzn1.as-ct.v1.Domain\:Alexa\:Notification#ACRI#NoNotifications0a7199b2-2fe8-40de-9484-a0d9f60a2256"\,"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"\:[]}}]} 2017-11-02 08:53:53.060 [ a] 0 AudioInputProcessor:executeOnContextAvailable:jsonContext={"context"\:[{"header"\:{"namespace"\:"Speaker"\,"name"\:"VolumeState"}\,"payload"\:{"volume"\:100\,"muted"\:false}}\,{"header"\:{"namespace"\:"SpeechSynthesizer"\,"name"\:"SpeechState"}\,"payload"\:{"token"\:"amzn1.as-ct.v1.Domain\:Alexa\:Notification#ACRI#NoNotifications0a7199b2-2fe8-40de-9484-a0d9f60a2256"\,"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"\:[]}}]} 2017-11-02 08:53:53.060 [ a] 1 FocusManager:acquireChannel:channelName=Dialog,activityId=SpeechRecognizer.Recognize 2017-11-02 08:53:53.061 [ a] I DirectiveProcessor:setDialogRequestIdLocked:oldValue=795bca12-8f05-42d4-b2e5-164b9369c861,newValue=6770268a-6c04-4873-a62f-04d4ebef97e1 2017-11-02 08:53:53.061 [ a] 0 DirectiveProcessor:scrubDialogRequestIdLocked:dialogRequestId=795bca12-8f05-42d4-b2e5-164b9369c861 2017-11-02 08:53:53.062 [ a] 0 EventBuilder:buildJsonEventString:messageId=ffd0d397-c301-471c-8ace-9d0a647599b4,namespace=SpeechRecognizer,name=Recognize 2017-11-02 08:53:53.063 [ 11] 0 AudioPlayer:onFocusChanged:newFocus=BACKGROUND 2017-11-02 08:53:53.063 [ 9] 1 AudioPlayer:executeOnFocusChanged:from=FOREGROUND,to=BACKGROUND,m_currentActivity=IDLE 2017-11-02 08:53:53.063 [ 9] 1 AudioPlayer:executeOnFocusChanged:action=pauseMediaPlayer 2017-11-02 08:53:53.063 [ 9] 9 MediaPlayer:pausedCalled 2017-11-02 08:53:53.064 [ 2] 0 MediaPlayer:handlePauseCalled:idPassed=19,currentId=0 2017-11-02 08:53:53.064 [ 2] E MediaPlayer:validateSourceAndIdFailed:reason=sourceNotSet 2017-11-02 08:53:53.064 [ 2] E MediaPlayer:handlePauseFailed 2017-11-02 08:53:53.064 [ a] 0 AudioInputProcessor:executeOnFocusChanged:newFocus=FOREGROUND 2017-11-02 08:53:53.065 [ a] 9 HTTP2Transport:enqueueRequest 2017-11-02 08:53:53.081 [ b] 0 HTTP2Transport:processNextOutgoingMessage 2017-11-02 08:53:53.082 [ b] 0 HTTP2StreamPool:getStream:streamId=123,numAcquiredStreams=2 2017-11-02 08:53:53.082 [ b] 9 HTTP2Transport:insertActiveStream:handle=0xffa068 2017-11-02 08:53:57.003 [ e] 0 MessageInterpreter:receive:messageId=57d60c31-0273-40aa-95eb-0741aeabee4f:No dialogRequestId attached to message. 2017-11-02 08:53:57.004 [ e] I DirectiveSequencer:onDirective:directive={"namespace\:"SpeechRecognizer"\,name\:"StopCapture"\,messageId\:"57d60c31-0273-40aa-95eb-0741aeabee4f"\,dialogRequestId\:""} 2017-11-02 08:53:57.004 [ f] I DirectiveRouter:preHandleDirective:messageId=57d60c31-0273-40aa-95eb-0741aeabee4f,action=calling 2017-11-02 08:53:57.004 [ f] 0 CapabilityAgent:addingMessageIdToMap:messageId=57d60c31-0273-40aa-95eb-0741aeabee4f 2017-11-02 08:53:57.005 [ 10] I DirectiveRouter:handleDirective:messageId=57d60c31-0273-40aa-95eb-0741aeabee4f,action=calling 2017-11-02 08:53:57.005 [ a] 0 AudioInputProcessor:stopCapture:stopImmediately=true 2017-11-02 08:53:57.005 [ a] 0 AudioInputProcessor:setState:from=RECOGNIZING,to=BUSY 2017-11-02 08:53:57.006 [ a] 0 DirectiveProcessor:onHandlingCompeted:messageId=57d60c31-0273-40aa-95eb-0741aeabee4f,directiveBeingPreHandled=(nullptr) 2017-11-02 08:53:57.006 [ a] 0 CapabilityAgent:removingMessageIdFromMap:messageId=57d60c31-0273-40aa-95eb-0741aeabee4f 2017-11-02 08:53:57.007 [ d] 0 DialogUXStateAggregator:setState:from=LISTENING,to=THINKING ###########################
Thinking...
###########################
2017-11-02 08:53:57.013 [ b] I InProcessAttachmentReader:readFailed:reason=SDS is closed 2017-11-02 08:54:00.173 [ b] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 0e15c6fffedfef9a-000049b3-000d4a21-882d0fc6e169753c-52e2f26e-123 2017-11-02 08:54:00.408 [ e] I DirectiveSequencer:onDirective:directive={"namespace\:"SpeechSynthesizer"\,name\:"Speak"\,messageId\:"e9ab3861-d0dd-4218-80b4-914302f67b49"\,dialogRequestId\:"6770268a-6c04-4873-a62f-04d4ebef97e1"} 2017-11-02 08:54:00.408 [ f] I DirectiveRouter:preHandleDirective:messageId=e9ab3861-d0dd-4218-80b4-914302f67b49,action=calling 2017-11-02 08:54:00.409 [ f] 0 CapabilityAgent:addingMessageIdToMap:messageId=e9ab3861-d0dd-4218-80b4-914302f67b49 2017-11-02 08:54:00.409 [ f] 9 SpeechSynthesizer:preHandleDirective:messageId=e9ab3861-d0dd-4218-80b4-914302f67b49 2017-11-02 08:54:00.410 [ 8] 0 SpeechSynthesizer:executePreHandle:messageId=e9ab3861-d0dd-4218-80b4-914302f67b49 2017-11-02 08:54:00.410 [ 10] I DirectiveRouter:handleDirective:messageId=e9ab3861-d0dd-4218-80b4-914302f67b49,action=calling 2017-11-02 08:54:00.410 [ b] 0 AudioInputProcessor:onSendCompleted:status=SUCCESS 2017-11-02 08:54:00.410 [ e] I DirectiveSequencer:onDirective:directive={"namespace\:"AudioPlayer"\,name\:"Play"\,messageId\:"1efcf6c8-fcb1-4811-aa24-e03442b03c51"\,dialogRequestId\:"6770268a-6c04-4873-a62f-04d4ebef97e1"} 2017-11-02 08:54:00.411 [ b] 0 HTTP2Transport:cleanupFinishedStream:streamId=123,result=200 2017-11-02 08:54:00.411 [ b] 0 HTTP2StreamPool:releaseStream:streamId=123,numAcquiredStreams=1 2017-11-02 08:54:00.410 [ 10] 9 SpeechSynthesizer:handleDirective:messageId=e9ab3861-d0dd-4218-80b4-914302f67b49 2017-11-02 08:54:00.411 [ f] I DirectiveRouter:preHandleDirective:messageId=1efcf6c8-fcb1-4811-aa24-e03442b03c51,action=calling 2017-11-02 08:54:00.412 [ 8] 0 SpeechSynthesizer:executeHandle:messageId=e9ab3861-d0dd-4218-80b4-914302f67b49 2017-11-02 08:54:00.412 [ f] 0 CapabilityAgent:addingMessageIdToMap:messageId=1efcf6c8-fcb1-4811-aa24-e03442b03c51 2017-11-02 08:54:00.412 [ 8] 1 FocusManager:acquireChannel:channelName=Dialog,activityId=SpeechSynthesizer.Speak 2017-11-02 08:54:00.413 [ a] 0 AudioInputProcessor:executeOnFocusChanged:newFocus=NONE 2017-11-02 08:54:00.413 [ 11] 0 SpeechSynthesizer:onFocusChanged:newFocus=FOREGROUND 2017-11-02 08:54:00.413 [ a] 0 AudioInputProcessor:executeOnFocusChanged:reason=Lost focus 2017-11-02 08:54:00.413 [ a] 0 AudioInputProcessor:setState:from=BUSY,to=IDLE 2017-11-02 08:54:00.413 [ 8] 0 SpeechSynthesizer:executeStateChange:newState=PLAYING 2017-11-02 08:54:00.414 [ 8] 9 SpeechSynthesizer:startPlaying 2017-11-02 08:54:00.414 [ 8] 9 MediaPlayer:setSourceCalled:sourceType=AttachmentReader 2017-11-02 08:54:00.414 [ d] 0 DialogUXStateAggregator:setState:from=THINKING,to=IDLE 2017-11-02 08:54:00.414 [ 2] 0 MediaPlayer:handleSetSourceCalled 2017-11-02 08:54:00.414 [ 2] 9 MediaPlayer:tearDownTransientPipelineElements ########################################
Alexa is currently idle!
########################################
2017-11-02 08:54:00.417 [ 8] 9 MediaPlayer:playCalled 2017-11-02 08:54:00.417 [ 2] 0 MediaPlayer:handlePlayCalled:idPassed=20,currentId=20 2017-11-02 08:54:00.417 [ 2] 0 MediaPlayer:handlePlay:attemptBuffering=0 2017-11-02 08:54:00.425 [ 2] 0 MediaPlayer:handlePlay:startingState=PLAYING,stateReturn=ASYNC 2017-11-02 08:54:00.425 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:00.425 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:00.425 [ 2e] 9 BaseStreamSource:onNeedDataCalled:size=4096 2017-11-02 08:54:00.426 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:00.426 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:00.426 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:00.426 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:00.427 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:00.427 [ 2] 9 MediaPlayer:State Change:oldState=NULL,newState=READY,pendingState=PLAYING 2017-11-02 08:54:00.427 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:00.427 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:00.427 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:00.427 [ 2] 9 MediaPlayer:messageReceived:messageType=stream-status 2017-11-02 08:54:00.428 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:00.757 [ 2] 9 MediaPlayer:messageReceived:messageType=stream-status 2017-11-02 08:54:00.758 [ 2] 9 BaseStreamSource:handleNeedDataCalled 2017-11-02 08:54:00.758 [ 2] 9 BaseStreamSource:installOnReadDataHandler:action=newSourceId,sourceId=170 2017-11-02 08:54:00.758 [ 2] 9 AttachmentReaderSource:read:size=4096,status=0 2017-11-02 08:54:00.764 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:00.764 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:00.764 [ 2] 9 AttachmentReaderSource:read:size=4096,status=0 2017-11-02 08:54:00.764 [ 2e] 9 BaseStreamSource:onNeedDataCalled:size=4096 2017-11-02 08:54:00.765 [ 2] 9 AttachmentReaderSource:read:size=2653,status=0 2017-11-02 08:54:00.765 [ 2e] 9 BaseStreamSource:onNeedDataCalled:size=4096 2017-11-02 08:54:00.765 [ 2] I InProcessAttachmentReader:readFailed:reason=SDS is closed 2017-11-02 08:54:00.765 [ 2e] 9 BaseStreamSource:m_needDataCallbackId already set 2017-11-02 08:54:00.765 [ 2] 9 AttachmentReaderSource:read:size=0,status=3 2017-11-02 08:54:00.765 [ 2] 9 BaseStreamSource:signalEndOfDataCalled 2017-11-02 08:54:00.766 [ 2] 9 BaseStreamSource:clearOnReadDataHandlerCalled:sourceId=170 2017-11-02 08:54:00.766 [ 2] 9 BaseStreamSource:handleNeedDataCalled 2017-11-02 08:54:00.768 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:00.774 [ 2e] 9 MediaPlayer:onPadAddedCalled 2017-11-02 08:54:00.777 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:00.777 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:00.777 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:00.777 [ 2] 9 MediaPlayer:handlePadAddedSignalCalled 2017-11-02 08:54:00.794 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:00.795 [ 2] 9 MediaPlayer:messageReceived:messageType=stream-start 2017-11-02 08:54:01.017 [ 2] 9 MediaPlayer:messageReceived:messageType=latency 2017-11-02 08:54:01.018 [ 2] 9 MediaPlayer:messageReceived:messageType=stream-status 2017-11-02 08:54:01.018 [ 2] 9 MediaPlayer:messageReceived:messageType=tag 2017-11-02 08:54:01.018 [ 2] 0 MediaPlayer:callingOnTags 2017-11-02 08:54:01.019 [ 2] 9 MediaPlayer:messageReceived:messageType=tag 2017-11-02 08:54:01.019 [ 2] 0 MediaPlayer:callingOnTags 2017-11-02 08:54:01.019 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:01.019 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:01.020 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:01.020 [ 2] 9 MediaPlayer:State Change:oldState=READY,newState=PAUSED,pendingState=PLAYING 2017-11-02 08:54:01.020 [ 2] 9 MediaPlayer:messageReceived:messageType=async-done 2017-11-02 08:54:01.021 [ 2] 9 MediaPlayer:messageReceived:messageType=new-clock 2017-11-02 08:54:01.021 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:01.021 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:01.021 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:01.022 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:01.022 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:01.022 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:01.022 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:01.023 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:01.023 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:01.023 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:01.023 [ 2] 9 MediaPlayer:messageReceived:messageType=state-changed 2017-11-02 08:54:01.023 [ 2] 9 MediaPlayer:State Change:oldState=PAUSED,newState=PLAYING,pendingState=VOID_PENDING 2017-11-02 08:54:01.024 [ 2] 0 MediaPlayer:callingOnPlaybackStarted:currentId=20 2017-11-02 08:54:01.024 [ 2] 9 SpeechSynthesizer:onPlaybackStarted:callbackSourceId=20 2017-11-02 08:54:01.024 [ 8] 0 SpeechSynthesizer:executePlaybackStarted 2017-11-02 08:54:01.024 [ 8] 0 SpeechSynthesizer:executeProvideState:stateRequestToken=0 2017-11-02 08:54:01.024 [ 8] 9 MediaPlayer:getOffsetCalled 2017-11-02 08:54:01.025 [ 2] 0 MediaPlayer:handleGetOffsetCalled:idPassed=20,currentId=20 2017-11-02 08:54:01.026 [ 8] 0 ContextManager:updateStateLocked:action=updatedState,state={"token"\:"amzn1.as-ct.v1.Domain\:Application\:Music#ACRI#DeviceTTSRendererV4_33171e10-aa56-412f-a41e-9bab85d0038e"\,"offsetInMilliseconds"\:0\,"playerActivity"\:"PLAYING"},namespace=SpeechSynthesizer,name=SpeechState 2017-11-02 08:54:01.027 [ 8] 0 EventBuilder:buildJsonEventString:messageId=ac4a457b-6b7e-43c9-8c50-617b9c80bddc,namespace=SpeechSynthesizer,name=SpeechStarted 2017-11-02 08:54:01.028 [ 8] 9 HTTP2Transport:enqueueRequest 2017-11-02 08:54:01.028 [ d] 0 DialogUXStateAggregator:setState:from=IDLE,to=SPEAKING 2017-11-02 08:54:01.028 [ 11] 9 SpeechSynthesizer:onFocusChangedSuccess ###########################
Speaking...
###########################
2017-11-02 08:54:01.029 [ 2] 9 MediaPlayer:messageReceived:messageType=tag 2017-11-02 08:54:01.030 [ 2] 0 MediaPlayer:callingOnTags 2017-11-02 08:54:01.062 [ 2e] 9 BaseStreamSource:onNeedDataCalled:size=4096 2017-11-02 08:54:01.062 [ 2] 9 BaseStreamSource:handleNeedDataCalled 2017-11-02 08:54:01.115 [ b] 0 HTTP2Transport:processNextOutgoingMessage 2017-11-02 08:54:01.115 [ b] 0 HTTP2StreamPool:getStream:streamId=125,numAcquiredStreams=2 2017-11-02 08:54:01.115 [ b] 9 HTTP2Transport:insertActiveStream:handle=0xffa068 2017-11-02 08:54:01.462 [ b] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 0e15c6fffedfef9a-000049b3-000d4a21-882d0fc6e169753c-52e2f26e-125 2017-11-02 08:54:01.463 [ b] 0 HTTP2Transport:cleanupFinishedStream:streamId=125,result=204 2017-11-02 08:54:01.463 [ b] 0 HTTP2StreamPool:releaseStream:streamId=125,numAcquiredStreams=1 2017-11-02 08:54:01.463 [ b] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT 2017-11-02 08:54:02.916 [ 2] 9 MediaPlayer:messageReceived:messageType=eos 2017-11-02 08:54:02.916 [ 2] 9 BaseStreamSource:~BaseStreamSource 2017-11-02 08:54:02.916 [ 2] 0 MediaPlayer:callingOnPlaybackFinished:currentId=20 2017-11-02 08:54:02.917 [ 2] 9 SpeechSynthesizer:onPlaybackFinished:callbackSourceId=20 2017-11-02 08:54:02.917 [ 2] 9 MediaPlayer:tearDownTransientPipelineElements 2017-11-02 08:54:02.917 [ 8] 0 SpeechSynthesizer:executePlaybackFinished 2017-11-02 08:54:02.918 [ 8] 0 SpeechSynthesizer:executeProvideState:stateRequestToken=0 2017-11-02 08:54:02.918 [ 8] 0 ContextManager:updateStateLocked:action=updatedState,state={"token"\:"amzn1.as-ct.v1.Domain\:Application\:Music#ACRI#DeviceTTSRendererV4_33171e10-aa56-412f-a41e-9bab85d0038e"\,"offsetInMilliseconds"\:0\,"playerActivity"\:"FINISHED"},namespace=SpeechSynthesizer,name=SpeechState 2017-11-02 08:54:02.918 [ 8] 9 SpeechSynthesizer:releaseForegroundFocus 2017-11-02 08:54:02.919 [ 8] 1 FocusManager:releaseChannel:channelName=Dialog 2017-11-02 08:54:02.920 [ 8] 0 EventBuilder:buildJsonEventString:messageId=5334e92c-97e8-40a6-807c-a85a1373c775,namespace=SpeechSynthesizer,name=SpeechFinished 2017-11-02 08:54:02.920 [ 8] 9 HTTP2Transport:enqueueRequest 2017-11-02 08:54:02.920 [ 8] 9 SpeechSynthesizer:setHandlingCompleted 2017-11-02 08:54:02.921 [ 8] 0 DirectiveProcessor:onHandlingCompeted:messageId=e9ab3861-d0dd-4218-80b4-914302f67b49,directiveBeingPreHandled=(nullptr) 2017-11-02 08:54:02.921 [ 8] 0 CapabilityAgent:removingMessageIdFromMap:messageId=e9ab3861-d0dd-4218-80b4-914302f67b49 2017-11-02 08:54:02.921 [ 10] I DirectiveRouter:handleDirective:messageId=1efcf6c8-fcb1-4811-aa24-e03442b03c51,action=calling 2017-11-02 08:54:02.921 [ 10] 0 AudioPlayer:handleDirective:name=Play,messageId=1efcf6c8-fcb1-4811-aa24-e03442b03c51 2017-11-02 08:54:02.921 [ 10] 1 AudioPlayer:handlePlayDirective 2017-11-02 08:54:02.922 [ 10] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=streamFormat 2017-11-02 08:54:02.922 [ 11] 0 SpeechSynthesizer:onFocusChanged:newFocus=NONE 2017-11-02 08:54:02.922 [ 10] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=progressReportIntervalInMilliseconds 2017-11-02 08:54:02.923 [ 11] 0 AudioPlayer:onFocusChanged:newFocus=FOREGROUND 2017-11-02 08:54:02.923 [ 10] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=expectedPreviousToken 2017-11-02 08:54:02.923 [ 10] 0 DirectiveProcessor:onHandlingCompeted:messageId=1efcf6c8-fcb1-4811-aa24-e03442b03c51,directiveBeingPreHandled=(nullptr) 2017-11-02 08:54:02.923 [ 9] 1 AudioPlayer:executeOnFocusChanged:from=BACKGROUND,to=FOREGROUND,m_currentActivity=IDLE 2017-11-02 08:54:02.923 [ 10] 0 CapabilityAgent:removingMessageIdFromMap:messageId=1efcf6c8-fcb1-4811-aa24-e03442b03c51 2017-11-02 08:54:02.923 [ 9] 1 AudioPlayer:executeOnFocusChanged:action=playNextItem 2017-11-02 08:54:02.924 [ 9] 1 AudioPlayer:playNextItem:m_audioItems.size=1 2017-11-02 08:54:02.924 [ 9] 9 MediaPlayer:setSourceForUrlCalled 2017-11-02 08:54:02.966 [ 2] 9 MediaPlayer:tearDownTransientPipelineElements 2017-11-02 08:54:02.967 [ 2f] 0 MediaPlayer:handleSetSourceForUrlCalled 2017-11-02 08:54:02.968 [ 2f] 9 UrlSource:UrlSourceCreate 2017-11-02 08:54:02.968 [ 2f] 0 UrlSource:initCalledForUrlSource 2017-11-02 08:54:02.969 [ 30] E LibCurlHttpContentFetcher:getContentFailed:reason=enableLibCurlCookieEngineFailed 2017-11-02 08:54:02.969 [ 30] E PlaylistParser:getHTTPContent:reason=badHTTPContentReceived 2017-11-02 08:54:02.969 [ b] 0 HTTP2Transport:processNextOutgoingMessage 2017-11-02 08:54:02.969 [ 30] E UrlSource:parseError 2017-11-02 08:54:02.969 [ b] 0 HTTP2StreamPool:getStream:streamId=127,numAcquiredStreams=2 2017-11-02 08:54:02.970 [ b] 9 HTTP2Transport:insertActiveStream:handle=0xffa068 2017-11-02 08:54:02.972 [ 9] 1 AudioPlayer:playNextItem:item.stream.offset=0 2017-11-02 08:54:02.972 [ 9] 9 MediaPlayer:playCalled 2017-11-02 08:54:02.973 [ 9] E UrlSource:preprocess:reason=noValidUrls 2017-11-02 08:54:02.973 [ 2] 0 MediaPlayer:handlePlayCalled:idPassed=21,currentId=21 2017-11-02 08:54:02.973 [ 2] 0 MediaPlayer:handlePlay:attemptBuffering=0 2017-11-02 08:54:02.974 [ 9] 1 AudioPlayer:executePlay:playBehavior=REPLACE_ALL 2017-11-02 08:54:02.974 [ 9] 1 AudioPlayer:executeStop:playNextItem=true,m_currentActivity=IDLE 2017-11-02 08:54:02.982 [ 2] 0 MediaPlayer:handlePlay:startingState=PLAYING,stateReturn=FAILURE 2017-11-02 08:54:02.982 [ 2] E MediaPlayer:handlePlayFailed:reason=gstElementSetStateFailure 2017-11-02 08:54:02.982 [ 2] 0 MediaPlayer:callingOnPlaybackError:type=MEDIA_ERROR_INTERNAL_DEVICE_ERROR,error=MediaPlayer\:handlePlayFailed\:reason\=gstElementSetStateFailure,currentId=21 2017-11-02 08:54:02.983 [ 2] 0 AudioPlayer:onPlaybackError:type=MEDIA_ERROR_INTERNAL_DEVICE_ERROR,error=MediaPlayer\:handlePlayFailed\:reason\=gstElementSetStateFailure,id=21 2017-11-02 08:54:03.123 [ d] 0 DialogUXStateAggregator:setState:from=FINISHED,to=IDLE ########################################
Alexa is currently idle!
########################################
2017-11-02 08:54:03.319 [ 2] 9 MediaPlayer:tearDownTransientPipelineElements 2017-11-02 08:54:03.319 [ 9] E AudioPlayer:executeOnPlaybackError:id=21,type=MEDIA_ERROR_INTERNAL_DEVICE_ERROR,error=MediaPlayer\:handlePlayFailed\:reason\=gstElementSetStateFailure 2017-11-02 08:54:03.320 [ 9] 0 EventBuilder:buildJsonEventString:messageId=5a9befc1-1dae-4103-9060-6c1781998182,namespace=AudioPlayer,name=PlaybackFailed 2017-11-02 08:54:03.320 [ 9] 9 HTTP2Transport:enqueueRequest 2017-11-02 08:54:03.321 [ 9] 1 AudioPlayer:executeStop:playNextItem=false,m_currentActivity=IDLE 2017-11-02 08:54:03.319 [ 2] 9 UrlSource:shutdownCalled 2017-11-02 08:54:03.388 [ b] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 0e15c6fffedfef9a-000049b3-000d4a21-882d0fc6e169753c-52e2f26e-127 2017-11-02 08:54:03.388 [ b] 0 HTTP2Transport:cleanupFinishedStream:streamId=127,result=204 2017-11-02 08:54:03.389 [ b] 0 HTTP2StreamPool:releaseStream:streamId=127,numAcquiredStreams=1 2017-11-02 08:54:03.389 [ b] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT 2017-11-02 08:54:03.389 [ b] 0 HTTP2Transport:processNextOutgoingMessage 2017-11-02 08:54:03.390 [ b] 0 HTTP2StreamPool:getStream:streamId=129,numAcquiredStreams=2 2017-11-02 08:54:03.390 [ b] 9 HTTP2Transport:insertActiveStream:handle=0xffa068 2017-11-02 08:54:03.974 [ 9] 1 AudioPlayer:sendEventWithTokenAndOffset:eventName=ProgressReportDelayElapsed 2017-11-02 08:54:03.975 [ 9] 0 EventBuilder:buildJsonEventString:messageId=e43d51a0-d9f3-443f-88bc-40b3a665c6cb,namespace=AudioPlayer,name=ProgressReportDelayElapsed 2017-11-02 08:54:03.975 [ 9] 9 HTTP2Transport:enqueueRequest 2017-11-02 08:54:04.228 [ b] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 0e15c6fffedfef9a-000049b3-000d4a21-882d0fc6e169753c-52e2f26e-129 2017-11-02 08:54:04.229 [ b] 0 HTTP2Transport:processNextOutgoingMessage 2017-11-02 08:54:04.230 [ b] 0 HTTP2StreamPool:getStream:streamId=131,numAcquiredStreams=3 2017-11-02 08:54:04.230 [ b] 9 HTTP2Transport:insertActiveStream:handle=0x10760c0 2017-11-02 08:54:04.232 [ e] 0 MessageInterpreter:receive:messageId=3146a463-3bcc-4303-bf8a-05a56494964b:No dialogRequestId attached to message. 2017-11-02 08:54:04.232 [ e] I DirectiveSequencer:onDirective:directive={"namespace\:"Speaker"\,name\:"SetMute"\,messageId\:"3146a463-3bcc-4303-bf8a-05a56494964b"\,dialogRequestId\:""} 2017-11-02 08:54:04.232 [ f] I DirectiveRouter:preHandleDirective:messageId=3146a463-3bcc-4303-bf8a-05a56494964b,action=calling 2017-11-02 08:54:04.233 [ f] 0 CapabilityAgent:addingMessageIdToMap:messageId=3146a463-3bcc-4303-bf8a-05a56494964b 2017-11-02 08:54:04.233 [ e] 0 MessageInterpreter:receive:messageId=17e89258-ec7b-4628-89d9-5f1f1cdd64a9:No dialogRequestId attached to message. 2017-11-02 08:54:04.234 [ e] I DirectiveSequencer:onDirective:directive={"namespace\:"AudioPlayer"\,name\:"Play"\,messageId\:"17e89258-ec7b-4628-89d9-5f1f1cdd64a9"\,dialogRequestId\:""} 2017-11-02 08:54:04.234 [ f] I DirectiveRouter:preHandleDirective:messageId=17e89258-ec7b-4628-89d9-5f1f1cdd64a9,action=calling 2017-11-02 08:54:04.235 [ f] 0 CapabilityAgent:addingMessageIdToMap:messageId=17e89258-ec7b-4628-89d9-5f1f1cdd64a9 2017-11-02 08:54:04.235 [ 10] I DirectiveRouter:handleDirective:messageId=3146a463-3bcc-4303-bf8a-05a56494964b,action=calling 2017-11-02 08:54:04.235 [ 7] 9 SpeakerManager:executeSetMuteCalled:mute=false 2017-11-02 08:54:04.235 [ 10] I DirectiveRouter:handleDirective:messageId=17e89258-ec7b-4628-89d9-5f1f1cdd64a9,action=calling 2017-11-02 08:54:04.236 [ 7] 9 MediaPlayer:setMuteCalled 2017-11-02 08:54:04.236 [ 10] 0 AudioPlayer:handleDirective:name=Play,messageId=17e89258-ec7b-4628-89d9-5f1f1cdd64a9 2017-11-02 08:54:04.236 [ 2] 9 MediaPlayer:handleSetMuteCalled 2017-11-02 08:54:04.236 [ 10] 1 AudioPlayer:handlePlayDirective 2017-11-02 08:54:04.237 [ 7] 9 MediaPlayer:setMuteCalled 2017-11-02 08:54:04.237 [ 2] 9 MediaPlayer:handleSetMuteCalled 2017-11-02 08:54:04.238 [ 10] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=streamFormat 2017-11-02 08:54:04.238 [ 7] 9 MediaPlayer:getSpeakerSettingsCalled 2017-11-02 08:54:04.238 [ 10] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=progressReportIntervalInMilliseconds 2017-11-02 08:54:04.238 [ 10] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=expectedPreviousToken 2017-11-02 08:54:04.238 [ 2] 9 MediaPlayer:handleGetSpeakerSettingsCalled 2017-11-02 08:54:04.239 [ 7] 9 MediaPlayer:getSpeakerSettingsCalled 2017-11-02 08:54:04.239 [ 10] 0 DirectiveProcessor:onHandlingCompeted:messageId=17e89258-ec7b-4628-89d9-5f1f1cdd64a9,directiveBeingPreHandled=(nullptr) 2017-11-02 08:54:04.238 [ b] 0 HTTP2Transport:cleanupFinishedStream:streamId=129,result=200 2017-11-02 08:54:04.239 [ 2] 9 MediaPlayer:handleGetSpeakerSettingsCalled 2017-11-02 08:54:04.239 [ 10] 0 CapabilityAgent:removingMessageIdFromMap:messageId=17e89258-ec7b-4628-89d9-5f1f1cdd64a9 2017-11-02 08:54:04.240 [ 7] 9 SpeakerManager:validateSpeakerSettingsConsistencyResult:consistent=true 2017-11-02 08:54:04.240 [ b] 0 HTTP2StreamPool:releaseStream:streamId=129,numAcquiredStreams=2 2017-11-02 08:54:04.240 [ 9] 1 AudioPlayer:executePlay:playBehavior=REPLACE_ALL 2017-11-02 08:54:04.240 [ 9] 1 AudioPlayer:executeStop:playNextItem=true,m_currentActivity=IDLE 2017-11-02 08:54:04.240 [ 7] 9 SpeakerManager:validateSpeakerSettings:volume=100,mute=false 2017-11-02 08:54:04.241 [ 7] 9 SpeakerManager:executeNotifyObserverCalled 2017-11-02 08:54:04.241 [ 7] 9 SpeakerManager:executeSendSpeakerSettingsChangedEvent ##################################################################
SOURCE:DIRECTIVE TYPE:AVS_SYNCED VOLUME:100 MUTE:0
##################################################################
2017-11-02 08:54:04.242 [ 7] 0 EventBuilder:buildJsonEventString:messageId=bb65c1bc-7ec7-40f7-b1cd-2ed854697231,namespace=Speaker,name=MuteChanged 2017-11-02 08:54:04.572 [ 7] 9 HTTP2Transport:enqueueRequest 2017-11-02 08:54:04.573 [ 7] 0 DirectiveProcessor:onHandlingCompeted:messageId=3146a463-3bcc-4303-bf8a-05a56494964b,directiveBeingPreHandled=(nullptr) 2017-11-02 08:54:04.573 [ 7] 0 CapabilityAgent:removingMessageIdFromMap:messageId=3146a463-3bcc-4303-bf8a-05a56494964b 2017-11-02 08:54:04.769 [ b] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 0e15c6fffedfef9a-000049b3-000d4a21-882d0fc6e169753c-52e2f26e-131 2017-11-02 08:54:04.770 [ b] 0 HTTP2Transport:cleanupFinishedStream:streamId=131,result=204 2017-11-02 08:54:04.770 [ b] 0 HTTP2StreamPool:releaseStream:streamId=131,numAcquiredStreams=1 2017-11-02 08:54:04.770 [ b] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT 2017-11-02 08:54:04.771 [ b] 0 HTTP2Transport:processNextOutgoingMessage 2017-11-02 08:54:04.771 [ b] 0 HTTP2StreamPool:getStream:streamId=133,numAcquiredStreams=2 2017-11-02 08:54:04.771 [ b] 9 HTTP2Transport:insertActiveStream:handle=0x10760c0 2017-11-02 08:54:05.298 [ b] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 0e15c6fffedfef9a-000049b3-000d4a21-882d0fc6e169753c-52e2f26e-133 2017-11-02 08:54:05.299 [ b] 0 HTTP2Transport:cleanupFinishedStream:streamId=133,result=204 2017-11-02 08:54:05.299 [ b] 0 HTTP2StreamPool:releaseStream:streamId=133,numAcquiredStreams=1 2017-11-02 08:54:05.299 [ b] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT