Skip to content

Instantly share code, notes, and snippets.

@boyce-xx
Created November 14, 2017 11:24
Show Gist options
  • Save boyce-xx/91d7f91ecb7045d0dd13b29d447848f3 to your computer and use it in GitHub Desktop.
Save boyce-xx/91d7f91ecb7045d0dd13b29d447848f3 to your computer and use it in GitHub Desktop.
"Segmentation fault" error when playing Amazon music
2017-11-14 11:19:10.119 [ 2] E MediaPlayer:messageReceived:messageType=buffering
2017-11-14 11:19:10.427 [ 9] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 06da90fffe2ee54a-00005193-0000e184-cb22ac9d458cc8d2-7e6425cc-539
2017-11-14 11:19:10.430 [ 9] 0 HTTP2Transport:cleanupFinishedStream:streamId=539,result=200
2017-11-14 11:19:10.430 [ 9] 0 HTTP2StreamPool:releaseStream:streamId=539,numAcquiredStreams=1
2017-11-14 11:19:10.430 [ e] 0 MessageInterpreter:receive:messageId=730fa074-4af3-423a-b68b-ef4e82aac36b:No dialogRequestId attached to message.
2017-11-14 11:19:10.431 [ e] I DirectiveSequencer:onDirective:UnparsedDirective={"directive"\:{"header"\:{"namespace"\:"AudioPlayer"\,"name"\:"Play"\,"messageId"\:"730fa074-4af3-423a-b68b-ef4e82aac36b"}\,"payload"\:{"audioItem"\:{"audioItemId"\:"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb\:8"\,"stream"\:{"offsetInMilliseconds"\:0\,"expiryTime"\:"2017-11-14T11\:20\:10+0000"\,"progressReport"\:{"progressReportDelayInMilliseconds"\:1000}\,"url"\:"https\://d29r7idq0wxsiz.cloudfront.net/DigitalMusicDeliveryService/HPS.m3u8?m\=m&dmid\=219189193&c\=cf&f\=ts&t\=10&bl\=256k&s\=true&e1\=1510661700000&e2\=1510662600000&v\=V2&h\=4129436f9cd51afaeeed457b785cc483482a28ab0cc5305d0e7c883b32966fef"\,"token"\:"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb\:8"}}\,"playBehavior"\:"ENQUEUE"}}}
...onDirectiveArrived...
----------------- default directive
2017-11-14 11:19:10.431 [ f] I DirectiveRouter:preHandleDirective:UnparsedDirective={"directive"\:{"header"\:{"namespace"\:"AudioPlayer"\,"name"\:"Play"\,"messageId"\:"730fa074-4af3-423a-b68b-ef4e82aac36b"}\,"payload"\:{"audioItem"\:{"audioItemId"\:"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb\:8"\,"stream"\:{"offsetInMilliseconds"\:0\,"expiryTime"\:"2017-11-14T11\:20\:10+0000"\,"progressReport"\:{"progressReportDelayInMilliseconds"\:1000}\,"url"\:"https\://d29r7idq0wxsiz.cloudfront.net/DigitalMusicDeliveryService/HPS.m3u8?m\=m&dmid\=219189193&c\=cf&f\=ts&t\=10&bl\=256k&s\=true&e1\=1510661700000&e2\=1510662600000&v\=V2&h\=4129436f9cd51afaeeed457b785cc483482a28ab0cc5305d0e7c883b32966fef"\,"token"\:"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb\:8"}}\,"playBehavior"\:"ENQUEUE"}}}
2017-11-14 11:19:10.431 [ f] I DirectiveRouter:preHandleDirective:messageId=730fa074-4af3-423a-b68b-ef4e82aac36b,action=calling
2017-11-14 11:19:10.431 [ f] 0 CapabilityAgent:addingMessageIdToMap:messageId=730fa074-4af3-423a-b68b-ef4e82aac36b
2017-11-14 11:19:10.432 [ 10] I DirectiveRouter:handleDirective:messageId=730fa074-4af3-423a-b68b-ef4e82aac36b,action=calling
AudioPlayer::handleDirective getName = Play
2017-11-14 11:19:10.432 [ 10] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=streamFormat
2017-11-14 11:19:10.432 [ 10] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=progressReportIntervalInMilliseconds
2017-11-14 11:19:10.432 [ 10] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=expectedPreviousToken
2017-11-14 11:19:10.433 [ 5] 0 DirectiveProcessor:onHandlingCompeted:messageId=730fa074-4af3-423a-b68b-ef4e82aac36b,directiveBeingPreHandled=(nullptr)
2017-11-14 11:19:10.433 [ 5] 0 CapabilityAgent:removingMessageIdFromMap:messageId=730fa074-4af3-423a-b68b-ef4e82aac36b
2017-11-14 11:19:12.039 [ 2] E MediaPlayer:messageReceived:messageType=element
2017-11-14 11:19:12.039 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:12.040 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:12.040 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:12.040 [ 2] E MediaPlayer:messageReceived:messageType=stream-status
2017-11-14 11:19:12.040 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:12.040 [ 2] E MediaPlayer:messageReceived:messageType=stream-status
2017-11-14 11:19:12.040 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:12.041 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:12.041 [ 2] E MediaPlayer:messageReceived:messageType=stream-status
2017-11-14 11:19:12.041 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:12.042 [ 2] E MediaPlayer:messageReceived:messageType=stream-status
2017-11-14 11:19:12.042 [ 2] E MediaPlayer:messageReceived:messageType=stream-status
2017-11-14 11:19:12.042 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:12.042 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:12.043 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:12.044 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:12.044 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:12.044 [ 2] E MediaPlayer:messageReceived:messageType=stream-status
2017-11-14 11:19:12.045 [ 2] E MediaPlayer:messageReceived:messageType=tag
2017-11-14 11:19:12.233 [ 2] E MediaPlayer:messageReceived:messageType=duration-changed
2017-11-14 11:19:14.373 [ e] 0 MessageInterpreter:receive:messageId=3187f72e-b843-4a7a-bd46-d99a76e512de:No dialogRequestId attached to message.
2017-11-14 11:19:14.373 [ e] I DirectiveSequencer:onDirective:UnparsedDirective={"directive"\:{"header"\:{"namespace"\:"System"\,"name"\:"ResetUserInactivity"\,"messageId"\:"3187f72e-b843-4a7a-bd46-d99a76e512de"}\,"payload"\:{"cause"\:"GUI_ACTION"}}}
...onDirectiveArrived...
----------------- default directive
2017-11-14 11:19:14.373 [ f] I DirectiveRouter:preHandleDirective:UnparsedDirective={"directive"\:{"header"\:{"namespace"\:"System"\,"name"\:"ResetUserInactivity"\,"messageId"\:"3187f72e-b843-4a7a-bd46-d99a76e512de"}\,"payload"\:{"cause"\:"GUI_ACTION"}}}
2017-11-14 11:19:14.374 [ f] I DirectiveRouter:preHandleDirective:messageId=3187f72e-b843-4a7a-bd46-d99a76e512de,action=calling
2017-11-14 11:19:14.374 [ f] 0 CapabilityAgent:addingMessageIdToMap:messageId=3187f72e-b843-4a7a-bd46-d99a76e512de
2017-11-14 11:19:14.374 [ 10] I DirectiveRouter:handleDirective:messageId=3187f72e-b843-4a7a-bd46-d99a76e512de,action=calling
2017-11-14 11:19:14.374 [ 10] 0 DirectiveProcessor:onHandlingCompeted:messageId=3187f72e-b843-4a7a-bd46-d99a76e512de,directiveBeingPreHandled=(nullptr)
2017-11-14 11:19:14.375 [ 10] 0 CapabilityAgent:removingMessageIdFromMap:messageId=3187f72e-b843-4a7a-bd46-d99a76e512de
2017-11-14 11:19:14.439 [ e] 0 MessageInterpreter:receive:messageId=7846e12f-0016-47c5-8d57-5d7bb800dd34:No dialogRequestId attached to message.
2017-11-14 11:19:14.439 [ e] I DirectiveSequencer:onDirective:UnparsedDirective={"directive"\:{"header"\:{"namespace"\:"System"\,"name"\:"ResetUserInactivity"\,"messageId"\:"7846e12f-0016-47c5-8d57-5d7bb800dd34"}\,"payload"\:{"cause"\:"GUI_ACTION"}}}
...onDirectiveArrived...
----------------- default directive
2017-11-14 11:19:14.440 [ f] I DirectiveRouter:preHandleDirective:UnparsedDirective={"directive"\:{"header"\:{"namespace"\:"System"\,"name"\:"ResetUserInactivity"\,"messageId"\:"7846e12f-0016-47c5-8d57-5d7bb800dd34"}\,"payload"\:{"cause"\:"GUI_ACTION"}}}
2017-11-14 11:19:14.440 [ f] I DirectiveRouter:preHandleDirective:messageId=7846e12f-0016-47c5-8d57-5d7bb800dd34,action=calling
2017-11-14 11:19:14.440 [ f] 0 CapabilityAgent:addingMessageIdToMap:messageId=7846e12f-0016-47c5-8d57-5d7bb800dd34
2017-11-14 11:19:14.440 [ 10] I DirectiveRouter:handleDirective:messageId=7846e12f-0016-47c5-8d57-5d7bb800dd34,action=calling
2017-11-14 11:19:14.440 [ 10] 0 DirectiveProcessor:onHandlingCompeted:messageId=7846e12f-0016-47c5-8d57-5d7bb800dd34,directiveBeingPreHandled=(nullptr)
2017-11-14 11:19:14.440 [ 10] 0 CapabilityAgent:removingMessageIdFromMap:messageId=7846e12f-0016-47c5-8d57-5d7bb800dd34
2017-11-14 11:19:14.697 [ e] 0 MessageInterpreter:receive:messageId=c14daa78-ae43-4a3e-8440-2869859e9e14:No dialogRequestId attached to message.
2017-11-14 11:19:14.697 [ e] I DirectiveSequencer:onDirective:UnparsedDirective={"directive"\:{"header"\:{"namespace"\:"AudioPlayer"\,"name"\:"Play"\,"messageId"\:"c14daa78-ae43-4a3e-8440-2869859e9e14"}\,"payload"\:{"audioItem"\:{"audioItemId"\:"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb\:11"\,"stream"\:{"offsetInMilliseconds"\:0\,"expiryTime"\:"292278993-08-17T07\:12\:55+0000"\,"progressReport"\:{"progressReportDelayInMilliseconds"\:1000}\,"url"\:"https\://d29r7idq0wxsiz.cloudfront.net/DigitalMusicDeliveryService/HPS.m3u8?m\=m&dmid\=283964561&c\=cf&f\=ts&t\=10&bl\=256k&s\=true&e1\=1510661700000&e2\=1510662600000&v\=V2&h\=095052887860b45ac67f8aca1a4f4b25b8a4386a9dca13a732f37efaf12978de"\,"token"\:"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb\:11"}}\,"playBehavior"\:"REPLACE_ALL"}}}
...onDirectiveArrived...
----------------- default directive
2017-11-14 11:19:14.698 [ f] I DirectiveRouter:preHandleDirective:UnparsedDirective={"directive"\:{"header"\:{"namespace"\:"AudioPlayer"\,"name"\:"Play"\,"messageId"\:"c14daa78-ae43-4a3e-8440-2869859e9e14"}\,"payload"\:{"audioItem"\:{"audioItemId"\:"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb\:11"\,"stream"\:{"offsetInMilliseconds"\:0\,"expiryTime"\:"292278993-08-17T07\:12\:55+0000"\,"progressReport"\:{"progressReportDelayInMilliseconds"\:1000}\,"url"\:"https\://d29r7idq0wxsiz.cloudfront.net/DigitalMusicDeliveryService/HPS.m3u8?m\=m&dmid\=283964561&c\=cf&f\=ts&t\=10&bl\=256k&s\=true&e1\=1510661700000&e2\=1510662600000&v\=V2&h\=095052887860b45ac67f8aca1a4f4b25b8a4386a9dca13a732f37efaf12978de"\,"token"\:"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb\:11"}}\,"playBehavior"\:"REPLACE_ALL"}}}
2017-11-14 11:19:14.698 [ f] I DirectiveRouter:preHandleDirective:messageId=c14daa78-ae43-4a3e-8440-2869859e9e14,action=calling
2017-11-14 11:19:14.698 [ f] 0 CapabilityAgent:addingMessageIdToMap:messageId=c14daa78-ae43-4a3e-8440-2869859e9e14
2017-11-14 11:19:14.699 [ 10] I DirectiveRouter:handleDirective:messageId=c14daa78-ae43-4a3e-8440-2869859e9e14,action=calling
AudioPlayer::handleDirective getName = Play
2017-11-14 11:19:14.699 [ 10] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=streamFormat
2017-11-14 11:19:14.699 [ 10] E TimeUtils:convert8601TimeStringToUnixFailed:unexpected time string length:=29
2017-11-14 11:19:14.699 [ 10] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=progressReportIntervalInMilliseconds
2017-11-14 11:19:14.700 [ 10] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=expectedPreviousToken
2017-11-14 11:19:14.700 [ 5] E MediaPlayer:getOffsetCalled
2017-11-14 11:19:14.700 [ 2] E MediaPlayer:handleGetOffsetCalled
2017-11-14 11:19:14.701 [ 5] E MediaPlayer:stopCalled
2017-11-14 11:19:14.701 [ 2] E MediaPlayer:handleStopCalled
2017-11-14 11:19:14.943 [ 2] E MediaPlayer:callingOnPlaybackFinished
2017-11-14 11:19:14.944 [ 2] E MediaPlayer:doStopSuccess
--> King:: AudioPlayer changeActivity from PLAYING to STOPPED...
2017-11-14 11:19:14.944 [ 5] 0 AudioPlayer:changeActivity:from=PLAYING,to=STOPPED
King:: onAudioPlayerPlayStatusChanged to 2
openFMDuringTest : isFMOpened = 0 , mLastFMOpened = 0
start:: turn on LED
Start to open < DEFAULT > LED --> 2017-11-14 19:19:14:945
end:: turn on LED
socketfd = 95
send content is: play_music:status=0
send avs data ok
--> King:: AudioPlayer executeProvideState start ...
2017-11-14 11:19:15.025 [ 5] 0 AudioPlayer:executeProvideState:sendToken=false,stateRequestToken=0
--> King:: AudioPlayer executeProvideState update payload to: {"token":"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb:7","offsetInMilliseconds":5722,"playerActivity":"STOPPED"}
2017-11-14 11:19:15.026 [ 5] 0 ContextManager:updateStateLocked:action=updatedState,state={"token"\:"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb\:7"\,"offsetInMilliseconds"\:5722\,"playerActivity"\:"STOPPED"},namespace=AudioPlayer,name=PlaybackState
--> King:: AudioPlayer executeProvideState update Success!!!
2017-11-14 11:19:15.026 [ 5] 0 EventBuilder:buildJsonEventString:messageId=24835ec6-4ec1-48cb-a8a0-fd71101b49fe,namespace=AudioPlayer,name=PlaybackStopped
AVSConnectionManager::sendMessage {"event":{"header":{"namespace":"AudioPlayer","name":"PlaybackStopped","messageId":"24835ec6-4ec1-48cb-a8a0-fd71101b49fe"},"payload":{"token":"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb:7","offsetInMilliseconds":5722}}}
2017-11-14 11:19:15.027 [ 5] E MediaPlayer:setSourceForUrlCalled
setSourceForUrlCalledhttps://d29r7idq0wxsiz.cloudfront.net/DigitalMusicDeliveryService/HPS.m3u8?m=m&dmid=283964561&c=cf&f=ts&t=10&bl=256k&s=true&e1=1510661700000&e2=1510662600000&v=V2&h=095052887860b45ac67f8aca1a4f4b25b8a4386a9dca13a732f37efaf12978de
2017-11-14 11:19:15.027 [ 5] E MediaPlayer:doStopSuccess:reason=alreadyStopped
2017-11-14 11:19:15.027 [ 5] E MediaPlayer:doStopSuccess
2017-11-14 11:19:15.031 [ 2] E MediaPlayer:resetPipeline
2017-11-14 11:19:15.032 [ a9] E MediaPlayer:handleSetSourceForUrlCalled
2017-11-14 11:19:15.033 [ a9] 0 UrlSource:initCalledForUrlSource
2017-11-14 11:19:15.034 [ a9] E UrlSource:Creating Decoder
2017-11-14 11:19:15.034 [ aa] E PlaylistParser:doDepthFirstSearch
2017-11-14 11:19:15.035 [ a9] E UrlSource:Decoder Created
2017-11-14 11:19:15.036 [ aa] E PlaylistParser:doDepthFirstSearch 1
2017-11-14 11:19:15.037 [ a9] E MediaPlayer:handleSetSourceForUrl exit
>>>>>>>>>>>MediaPlayer::play 1
>>>>>>>>>>>MediaPlayer::play 2
2017-11-14 11:19:15.037 [ 5] E MediaPlayer:playCalled
2017-11-14 11:19:15.038 [ 5] E UrlSource:UrlSource::preprocess 1
2017-11-14 11:19:15.097 [ 9] 0 HTTP2StreamPool:getStream:streamId=541,numAcquiredStreams=2
2017-11-14 11:19:15.670 [ 9] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 06da90fffe2ee54a-00005193-0000e184-cb22ac9d458cc8d2-7e6425cc-541
2017-11-14 11:19:15.670 [ 9] 0 HTTP2Transport:cleanupFinishedStream:streamId=541,result=204
2017-11-14 11:19:15.671 [ 9] 0 HTTP2StreamPool:releaseStream:streamId=541,numAcquiredStreams=1
2017-11-14 11:19:15.671 [ 9] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT
Urlhttps://d29r7idq0wxsiz.cloudfront.net/DigitalMusicDeliveryService/HPS.m3u8?m=m&dmid=283964561&c=cf&f=ts&t=10&bl=256k&s=true&e1=1510661700000&e2=1510662600000&v=V2&h=095052887860b45ac67f8aca1a4f4b25b8a4386a9dca13a732f37efaf12978de
contentTypeapplication/vnd.apple.mpegurl
2017-11-14 11:19:15.993 [ aa] E PlaylistParser:doDepthFirstSearch 2
2017-11-14 11:19:15.996 [ aa] E PlaylistParser:PlaylistParser::getContentFromPlaylistUrlIntoString 1
2017-11-14 11:19:15.996 [ aa] E PlaylistParser:PlaylistParser::getContentFromPlaylistUrlIntoString 2
2017-11-14 11:19:16.842 [ aa] E PlaylistParser:PlaylistParser::getContentFromPlaylistUrlIntoString 3
2017-11-14 11:19:16.842 [ aa] E PlaylistParser:PlaylistParser::getContentFromPlaylistUrlIntoString 4
2017-11-14 11:19:16.843 [ aa] E PlaylistParser:PlaylistParser::getContentFromPlaylistUrlIntoString 5
2017-11-14 11:19:16.843 [ aa] E PlaylistParser:PlaylistParser::getContentFromPlaylistUrlIntoString 7
2017-11-14 11:19:16.843 [ aa] E PlaylistParser:PlaylistParser::getContentFromPlaylistUrlIntoString 5
2017-11-14 11:19:16.843 [ aa] I InProcessAttachmentReader:readFailed:reason=SDS is closed
2017-11-14 11:19:16.843 [ aa] E PlaylistParser:PlaylistParser::getContentFromPlaylistUrlIntoString 6
2017-11-14 11:19:16.843 [ aa] E PlaylistParser:PlaylistParser::getContentFromPlaylistUrlIntoString 10
2017-11-14 11:19:16.859 [ aa] E PlaylistParser:doDepthFirstSearch 3
Urlhttps://d29r7idq0wxsiz.cloudfront.net/DigitalMusicDeliveryService/HPS.m3u8?m=m&dmid=283964561&c=cf&f=ts&t=10&bl=256k&s=true&e1=1510661700000&e2=1510662600000&v=V2&h=095052887860b45ac67f8aca1a4f4b25b8a4386a9dca13a732f37efaf12978de
2017-11-14 11:19:16.861 [ aa] E PlaylistParser:isM3U8Playlist
2017-11-14 11:19:16.862 [ aa] E PlaylistParser:doDepthFirstSearch 4
2017-11-14 11:19:16.862 [ aa] E PlaylistParser:doDepthFirstSearch 5
2017-11-14 11:19:16.862 [ aa] E UrlSource:onPlaylistEntryParsed 1
2017-11-14 11:19:16.862 [ aa] E UrlSource:onPlaylistEntryParsed 2
2017-11-14 11:19:16.862 [ aa] E UrlSource:onPlaylistEntryParsed 3
2017-11-14 11:19:16.862 [ 5] E UrlSource:UrlSource::preprocess 2
2017-11-14 11:19:16.863 [ 5] E UrlSource:UrlSource::preprocess 3
UrlSource::preprocesshttps://d29r7idq0wxsiz.cloudfront.net/DigitalMusicDeliveryService/HPS.m3u8?m=m&dmid=283964561&c=cf&f=ts&t=10&bl=256k&s=true&e1=1510661700000&e2=1510662600000&v=V2&h=095052887860b45ac67f8aca1a4f4b25b8a4386a9dca13a732f37efaf12978de
2017-11-14 11:19:16.863 [ 5] E UrlSource:UrlSource::preprocess 4
(Nut2AVS:14091): GLib-GObject-WARNING **: g_object_set_valist: object class 'GstPlayBin' has no property named 'use-buffering'
2017-11-14 11:19:16.863 [ 5] E UrlSource:UrlSource::preprocess 5
2017-11-14 11:19:16.863 [ 5] E MediaPlayer:playCalled 2
2017-11-14 11:19:16.863 [ 5] E MediaPlayer:playCalled 3
2017-11-14 11:19:16.863 [ 2] E MediaPlayer:handlePlayCalled
2017-11-14 11:19:16.864 [ 2] E MediaPlayer:doStopSuccess:reason=alreadyStopped
2017-11-14 11:19:16.864 [ 2] E MediaPlayer:doStopSuccess
(Nut2AVS:14091): GLib-GObject-WARNING **: g_object_get_valist: object class 'GstPlayBin' has no property named 'use-buffering'
2017-11-14 11:19:16.864 [ 2] E MediaPlayer:handlePlay:attemptBuffering=-1849375488
2017-11-14 11:19:16.867 [ 2] E MediaPlayer:handlePlay:startingState=PLAYING,stateReturn=ASYNC
2017-11-14 11:19:16.868 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:16.868 [ 5] 0 DirectiveProcessor:onHandlingCompeted:messageId=c14daa78-ae43-4a3e-8440-2869859e9e14,directiveBeingPreHandled=(nullptr)
2017-11-14 11:19:16.868 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:16.868 [ 5] 0 CapabilityAgent:removingMessageIdFromMap:messageId=c14daa78-ae43-4a3e-8440-2869859e9e14
2017-11-14 11:19:16.868 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:16.868 [ 2] E MediaPlayer:State Change:oldState=NULL,newState=READY,pendingState=PLAYING
2017-11-14 11:19:16.868 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:16.868 [ 5] E AudioPlayer:executeOnPlaybackFinishedError:reason=notPlaying,m_currentActivity=STOPPED
2017-11-14 11:19:16.869 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:16.869 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:16.869 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:16.869 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:16.869 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:16.869 [ 2] E MediaPlayer:messageReceived:messageType=stream-status
2017-11-14 11:19:16.869 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:16.870 [ 2] E MediaPlayer:messageReceived:messageType=stream-status
handleOneSpeechBySensory::waitForWakeword------
2017-11-14 11:19:17.869 [ 5] 0 EventBuilder:buildJsonEventString:messageId=fe8b5002-14d3-4b52-aef5-a727ad2586d2,namespace=AudioPlayer,name=ProgressReportDelayElapsed
AVSConnectionManager::sendMessage {"event":{"header":{"namespace":"AudioPlayer","name":"ProgressReportDelayElapsed","messageId":"fe8b5002-14d3-4b52-aef5-a727ad2586d2"},"payload":{"token":"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb:11","offsetInMilliseconds":5722}}}
2017-11-14 11:19:17.880 [ 9] 0 HTTP2StreamPool:getStream:streamId=543,numAcquiredStreams=2
2017-11-14 11:19:18.359 [ 9] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 06da90fffe2ee54a-00005193-0000e184-cb22ac9d458cc8d2-7e6425cc-543
2017-11-14 11:19:18.360 [ 9] 0 HTTP2Transport:cleanupFinishedStream:streamId=543,result=204
2017-11-14 11:19:18.360 [ 9] 0 HTTP2StreamPool:releaseStream:streamId=543,numAcquiredStreams=1
2017-11-14 11:19:18.360 [ 9] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT
2017-11-14 11:19:22.428 [ 2] E MediaPlayer:messageReceived:messageType=duration-changed
2017-11-14 11:19:22.432 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:22.432 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:22.432 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:22.460 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:22.460 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:22.722 [ e] 0 MessageInterpreter:receive:messageId=012051f0-0dea-45d4-b61f-eef4a997a4bb:No dialogRequestId attached to message.
2017-11-14 11:19:22.722 [ e] I DirectiveSequencer:onDirective:UnparsedDirective={"directive"\:{"header"\:{"namespace"\:"System"\,"name"\:"ResetUserInactivity"\,"messageId"\:"012051f0-0dea-45d4-b61f-eef4a997a4bb"}\,"payload"\:{"cause"\:"GUI_ACTION"}}}
...onDirectiveArrived...
----------------- default directive
2017-11-14 11:19:22.722 [ f] I DirectiveRouter:preHandleDirective:UnparsedDirective={"directive"\:{"header"\:{"namespace"\:"System"\,"name"\:"ResetUserInactivity"\,"messageId"\:"012051f0-0dea-45d4-b61f-eef4a997a4bb"}\,"payload"\:{"cause"\:"GUI_ACTION"}}}
2017-11-14 11:19:22.722 [ f] I DirectiveRouter:preHandleDirective:messageId=012051f0-0dea-45d4-b61f-eef4a997a4bb,action=calling
2017-11-14 11:19:22.723 [ f] 0 CapabilityAgent:addingMessageIdToMap:messageId=012051f0-0dea-45d4-b61f-eef4a997a4bb
2017-11-14 11:19:22.723 [ 10] I DirectiveRouter:handleDirective:messageId=012051f0-0dea-45d4-b61f-eef4a997a4bb,action=calling
2017-11-14 11:19:22.723 [ 10] 0 DirectiveProcessor:onHandlingCompeted:messageId=012051f0-0dea-45d4-b61f-eef4a997a4bb,directiveBeingPreHandled=(nullptr)
2017-11-14 11:19:22.723 [ 10] 0 CapabilityAgent:removingMessageIdFromMap:messageId=012051f0-0dea-45d4-b61f-eef4a997a4bb
2017-11-14 11:19:22.978 [ e] 0 MessageInterpreter:receive:messageId=e8bbdaad-c8fa-41fd-ac59-7f964c9f892f:No dialogRequestId attached to message.
2017-11-14 11:19:22.978 [ e] I DirectiveSequencer:onDirective:UnparsedDirective={"directive"\:{"header"\:{"namespace"\:"System"\,"name"\:"ResetUserInactivity"\,"messageId"\:"e8bbdaad-c8fa-41fd-ac59-7f964c9f892f"}\,"payload"\:{"cause"\:"GUI_ACTION"}}}
...onDirectiveArrived...
----------------- default directive
2017-11-14 11:19:22.978 [ f] I DirectiveRouter:preHandleDirective:UnparsedDirective={"directive"\:{"header"\:{"namespace"\:"System"\,"name"\:"ResetUserInactivity"\,"messageId"\:"e8bbdaad-c8fa-41fd-ac59-7f964c9f892f"}\,"payload"\:{"cause"\:"GUI_ACTION"}}}
2017-11-14 11:19:22.979 [ f] I DirectiveRouter:preHandleDirective:messageId=e8bbdaad-c8fa-41fd-ac59-7f964c9f892f,action=calling
2017-11-14 11:19:22.979 [ f] 0 CapabilityAgent:addingMessageIdToMap:messageId=e8bbdaad-c8fa-41fd-ac59-7f964c9f892f
2017-11-14 11:19:22.979 [ 10] I DirectiveRouter:handleDirective:messageId=e8bbdaad-c8fa-41fd-ac59-7f964c9f892f,action=calling
2017-11-14 11:19:22.979 [ 10] 0 DirectiveProcessor:onHandlingCompeted:messageId=e8bbdaad-c8fa-41fd-ac59-7f964c9f892f,directiveBeingPreHandled=(nullptr)
2017-11-14 11:19:22.979 [ 10] 0 CapabilityAgent:removingMessageIdFromMap:messageId=e8bbdaad-c8fa-41fd-ac59-7f964c9f892f
2017-11-14 11:19:23.256 [ e] 0 MessageInterpreter:receive:messageId=613d7787-49ab-47f6-9619-1dd744119039:No dialogRequestId attached to message.
2017-11-14 11:19:23.257 [ e] I DirectiveSequencer:onDirective:UnparsedDirective={"directive"\:{"header"\:{"namespace"\:"AudioPlayer"\,"name"\:"Play"\,"messageId"\:"613d7787-49ab-47f6-9619-1dd744119039"}\,"payload"\:{"audioItem"\:{"audioItemId"\:"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb\:9"\,"stream"\:{"offsetInMilliseconds"\:0\,"expiryTime"\:"292278993-08-17T07\:12\:55+0000"\,"progressReport"\:{"progressReportDelayInMilliseconds"\:1000}\,"url"\:"https\://d29r7idq0wxsiz.cloudfront.net/DigitalMusicDeliveryService/HPS.m3u8?m\=m&dmid\=233011647&c\=cf&f\=ts&t\=10&bl\=256k&s\=true&e1\=1510661700000&e2\=1510662600000&v\=V2&h\=45eba57bf4d0c78770c3bc988a82617a34750488c6c5d45ca6ddd5eb808b256e"\,"token"\:"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb\:9"}}\,"playBehavior"\:"REPLACE_ALL"}}}
...onDirectiveArrived...
----------------- default directive
2017-11-14 11:19:23.257 [ f] I DirectiveRouter:preHandleDirective:UnparsedDirective={"directive"\:{"header"\:{"namespace"\:"AudioPlayer"\,"name"\:"Play"\,"messageId"\:"613d7787-49ab-47f6-9619-1dd744119039"}\,"payload"\:{"audioItem"\:{"audioItemId"\:"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb\:9"\,"stream"\:{"offsetInMilliseconds"\:0\,"expiryTime"\:"292278993-08-17T07\:12\:55+0000"\,"progressReport"\:{"progressReportDelayInMilliseconds"\:1000}\,"url"\:"https\://d29r7idq0wxsiz.cloudfront.net/DigitalMusicDeliveryService/HPS.m3u8?m\=m&dmid\=233011647&c\=cf&f\=ts&t\=10&bl\=256k&s\=true&e1\=1510661700000&e2\=1510662600000&v\=V2&h\=45eba57bf4d0c78770c3bc988a82617a34750488c6c5d45ca6ddd5eb808b256e"\,"token"\:"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb\:9"}}\,"playBehavior"\:"REPLACE_ALL"}}}
2017-11-14 11:19:23.257 [ f] I DirectiveRouter:preHandleDirective:messageId=613d7787-49ab-47f6-9619-1dd744119039,action=calling
2017-11-14 11:19:23.257 [ f] 0 CapabilityAgent:addingMessageIdToMap:messageId=613d7787-49ab-47f6-9619-1dd744119039
2017-11-14 11:19:23.258 [ 10] I DirectiveRouter:handleDirective:messageId=613d7787-49ab-47f6-9619-1dd744119039,action=calling
AudioPlayer::handleDirective getName = Play
2017-11-14 11:19:23.258 [ 10] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=streamFormat
2017-11-14 11:19:23.258 [ 10] E TimeUtils:convert8601TimeStringToUnixFailed:unexpected time string length:=29
2017-11-14 11:19:23.258 [ 10] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=progressReportIntervalInMilliseconds
2017-11-14 11:19:23.259 [ 10] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=expectedPreviousToken
--> King:: AudioPlayer changeActivity from STOPPED to STOPPED...
2017-11-14 11:19:23.259 [ 5] 0 AudioPlayer:changeActivity:from=STOPPED,to=STOPPED
King:: onAudioPlayerPlayStatusChanged to 2
openFMDuringTest : isFMOpened = 0 , mLastFMOpened = 0
start:: turn on LED
Start to open < DEFAULT > LED --> 2017-11-14 19:19:23:259
end:: turn on LED
socketfd = 102
send content is: play_music:status=0
send avs data ok
--> King:: AudioPlayer executeProvideState start ...
2017-11-14 11:19:23.332 [ 5] 0 AudioPlayer:executeProvideState:sendToken=false,stateRequestToken=0
--> King:: AudioPlayer executeProvideState update payload to: {"token":"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb:11","offsetInMilliseconds":5722,"playerActivity":"STOPPED"}
2017-11-14 11:19:23.333 [ 5] 0 ContextManager:updateStateLocked:action=updatedState,state={"token"\:"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb\:11"\,"offsetInMilliseconds"\:5722\,"playerActivity"\:"STOPPED"},namespace=AudioPlayer,name=PlaybackState
--> King:: AudioPlayer executeProvideState update Success!!!
2017-11-14 11:19:23.333 [ 5] 0 EventBuilder:buildJsonEventString:messageId=9b652e75-7865-41dc-8f6c-6a38124c25b4,namespace=AudioPlayer,name=PlaybackStopped
AVSConnectionManager::sendMessage {"event":{"header":{"namespace":"AudioPlayer","name":"PlaybackStopped","messageId":"9b652e75-7865-41dc-8f6c-6a38124c25b4"},"payload":{"token":"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb:11","offsetInMilliseconds":5722}}}
2017-11-14 11:19:23.333 [ 5] E MediaPlayer:setSourceForUrlCalled
setSourceForUrlCalledhttps://d29r7idq0wxsiz.cloudfront.net/DigitalMusicDeliveryService/HPS.m3u8?m=m&dmid=233011647&c=cf&f=ts&t=10&bl=256k&s=true&e1=1510661700000&e2=1510662600000&v=V2&h=45eba57bf4d0c78770c3bc988a82617a34750488c6c5d45ca6ddd5eb808b256e
2017-11-14 11:19:23.334 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:23.334 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:23.357 [ 9] 0 HTTP2StreamPool:getStream:streamId=545,numAcquiredStreams=2
2017-11-14 11:19:23.492 [ 2] E MediaPlayer:messageReceived:messageType=element
2017-11-14 11:19:23.492 [ 2] E MediaPlayer:messageReceived:messageType=duration-changed
2017-11-14 11:19:23.495 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:23.495 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:23.495 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:23.495 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:23.495 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:23.496 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:23.496 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:23.496 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:23.496 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:23.496 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:23.496 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:23.499 [ 5] E MediaPlayer:callingOnPlaybackFinished
2017-11-14 11:19:23.500 [ 5] E MediaPlayer:doStopSuccess
2017-11-14 11:19:23.501 [ 2] E MediaPlayer:resetPipeline
2017-11-14 11:19:23.502 [ ab] E MediaPlayer:handleSetSourceForUrlCalled
2017-11-14 11:19:23.502 [ ab] 0 UrlSource:initCalledForUrlSource
2017-11-14 11:19:23.503 [ ab] E UrlSource:Creating Decoder
2017-11-14 11:19:23.503 [ ac] E PlaylistParser:doDepthFirstSearch
2017-11-14 11:19:23.503 [ ac] E PlaylistParser:doDepthFirstSearch 1
2017-11-14 11:19:23.504 [ ab] E UrlSource:Decoder Created
2017-11-14 11:19:23.504 [ ab] E MediaPlayer:handleSetSourceForUrl exit
>>>>>>>>>>>MediaPlayer::play 1
>>>>>>>>>>>MediaPlayer::play 2
2017-11-14 11:19:23.505 [ 5] E MediaPlayer:playCalled
2017-11-14 11:19:23.505 [ 5] E UrlSource:UrlSource::preprocess 1
2017-11-14 11:19:23.998 [ 9] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 06da90fffe2ee54a-00005193-0000e184-cb22ac9d458cc8d2-7e6425cc-545
2017-11-14 11:19:23.998 [ 9] 0 HTTP2Transport:cleanupFinishedStream:streamId=545,result=204
2017-11-14 11:19:23.998 [ 9] 0 HTTP2StreamPool:releaseStream:streamId=545,numAcquiredStreams=1
2017-11-14 11:19:23.998 [ 9] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT
Urlhttps://d29r7idq0wxsiz.cloudfront.net/DigitalMusicDeliveryService/HPS.m3u8?m=m&dmid=233011647&c=cf&f=ts&t=10&bl=256k&s=true&e1=1510661700000&e2=1510662600000&v=V2&h=45eba57bf4d0c78770c3bc988a82617a34750488c6c5d45ca6ddd5eb808b256e
contentTypeapplication/vnd.apple.mpegurl
2017-11-14 11:19:24.418 [ ac] E PlaylistParser:doDepthFirstSearch 2
2017-11-14 11:19:24.423 [ ac] E PlaylistParser:PlaylistParser::getContentFromPlaylistUrlIntoString 1
2017-11-14 11:19:24.423 [ ac] E PlaylistParser:PlaylistParser::getContentFromPlaylistUrlIntoString 2
2017-11-14 11:19:24.891 [ e] 0 MessageInterpreter:receive:messageId=d9a88ca1-e472-496d-9357-cfaa6289ffcd:No dialogRequestId attached to message.
2017-11-14 11:19:24.892 [ e] I DirectiveSequencer:onDirective:UnparsedDirective={"directive"\:{"header"\:{"namespace"\:"System"\,"name"\:"ResetUserInactivity"\,"messageId"\:"d9a88ca1-e472-496d-9357-cfaa6289ffcd"}\,"payload"\:{"cause"\:"GUI_ACTION"}}}
...onDirectiveArrived...
----------------- default directive
2017-11-14 11:19:24.892 [ f] I DirectiveRouter:preHandleDirective:UnparsedDirective={"directive"\:{"header"\:{"namespace"\:"System"\,"name"\:"ResetUserInactivity"\,"messageId"\:"d9a88ca1-e472-496d-9357-cfaa6289ffcd"}\,"payload"\:{"cause"\:"GUI_ACTION"}}}
2017-11-14 11:19:24.892 [ f] I DirectiveRouter:preHandleDirective:messageId=d9a88ca1-e472-496d-9357-cfaa6289ffcd,action=calling
2017-11-14 11:19:24.892 [ f] 0 CapabilityAgent:addingMessageIdToMap:messageId=d9a88ca1-e472-496d-9357-cfaa6289ffcd
2017-11-14 11:19:24.893 [ 10] I DirectiveRouter:handleDirective:messageId=d9a88ca1-e472-496d-9357-cfaa6289ffcd,action=calling
2017-11-14 11:19:24.893 [ 10] 0 DirectiveProcessor:onHandlingCompeted:messageId=d9a88ca1-e472-496d-9357-cfaa6289ffcd,directiveBeingPreHandled=(nullptr)
2017-11-14 11:19:24.893 [ 10] 0 CapabilityAgent:removingMessageIdFromMap:messageId=d9a88ca1-e472-496d-9357-cfaa6289ffcd
2017-11-14 11:19:25.057 [ e] 0 MessageInterpreter:receive:messageId=aa0926de-82e3-403a-b2f1-f0ea430e860a:No dialogRequestId attached to message.
2017-11-14 11:19:25.058 [ e] I DirectiveSequencer:onDirective:UnparsedDirective={"directive"\:{"header"\:{"namespace"\:"System"\,"name"\:"ResetUserInactivity"\,"messageId"\:"aa0926de-82e3-403a-b2f1-f0ea430e860a"}\,"payload"\:{"cause"\:"GUI_ACTION"}}}
...onDirectiveArrived...
----------------- default directive
2017-11-14 11:19:25.059 [ f] I DirectiveRouter:preHandleDirective:UnparsedDirective={"directive"\:{"header"\:{"namespace"\:"System"\,"name"\:"ResetUserInactivity"\,"messageId"\:"aa0926de-82e3-403a-b2f1-f0ea430e860a"}\,"payload"\:{"cause"\:"GUI_ACTION"}}}
2017-11-14 11:19:25.059 [ f] I DirectiveRouter:preHandleDirective:messageId=aa0926de-82e3-403a-b2f1-f0ea430e860a,action=calling
2017-11-14 11:19:25.060 [ f] 0 CapabilityAgent:addingMessageIdToMap:messageId=aa0926de-82e3-403a-b2f1-f0ea430e860a
2017-11-14 11:19:25.060 [ 10] I DirectiveRouter:handleDirective:messageId=aa0926de-82e3-403a-b2f1-f0ea430e860a,action=calling
2017-11-14 11:19:25.061 [ 10] 0 DirectiveProcessor:onHandlingCompeted:messageId=aa0926de-82e3-403a-b2f1-f0ea430e860a,directiveBeingPreHandled=(nullptr)
2017-11-14 11:19:25.061 [ 10] 0 CapabilityAgent:removingMessageIdFromMap:messageId=aa0926de-82e3-403a-b2f1-f0ea430e860a
2017-11-14 11:19:25.245 [ ac] E PlaylistParser:PlaylistParser::getContentFromPlaylistUrlIntoString 3
2017-11-14 11:19:25.245 [ ac] E PlaylistParser:PlaylistParser::getContentFromPlaylistUrlIntoString 4
2017-11-14 11:19:25.246 [ ac] E PlaylistParser:PlaylistParser::getContentFromPlaylistUrlIntoString 5
2017-11-14 11:19:25.246 [ ac] E PlaylistParser:PlaylistParser::getContentFromPlaylistUrlIntoString 7
2017-11-14 11:19:25.246 [ ac] E PlaylistParser:PlaylistParser::getContentFromPlaylistUrlIntoString 5
2017-11-14 11:19:25.246 [ ac] I InProcessAttachmentReader:readFailed:reason=SDS is closed
2017-11-14 11:19:25.246 [ ac] E PlaylistParser:PlaylistParser::getContentFromPlaylistUrlIntoString 6
2017-11-14 11:19:25.246 [ ac] E PlaylistParser:PlaylistParser::getContentFromPlaylistUrlIntoString 10
2017-11-14 11:19:25.261 [ ac] E PlaylistParser:doDepthFirstSearch 3
Urlhttps://d29r7idq0wxsiz.cloudfront.net/DigitalMusicDeliveryService/HPS.m3u8?m=m&dmid=233011647&c=cf&f=ts&t=10&bl=256k&s=true&e1=1510661700000&e2=1510662600000&v=V2&h=45eba57bf4d0c78770c3bc988a82617a34750488c6c5d45ca6ddd5eb808b256e
2017-11-14 11:19:25.265 [ ac] E PlaylistParser:isM3U8Playlist
2017-11-14 11:19:25.265 [ ac] E PlaylistParser:doDepthFirstSearch 4
2017-11-14 11:19:25.265 [ ac] E PlaylistParser:doDepthFirstSearch 5
2017-11-14 11:19:25.265 [ ac] E UrlSource:onPlaylistEntryParsed 1
2017-11-14 11:19:25.266 [ ac] E UrlSource:onPlaylistEntryParsed 2
2017-11-14 11:19:25.266 [ ac] E UrlSource:onPlaylistEntryParsed 3
2017-11-14 11:19:25.266 [ 5] E UrlSource:UrlSource::preprocess 2
2017-11-14 11:19:25.267 [ 5] E UrlSource:UrlSource::preprocess 3
UrlSource::preprocesshttps://d29r7idq0wxsiz.cloudfront.net/DigitalMusicDeliveryService/HPS.m3u8?m=m&dmid=233011647&c=cf&f=ts&t=10&bl=256k&s=true&e1=1510661700000&e2=1510662600000&v=V2&h=45eba57bf4d0c78770c3bc988a82617a34750488c6c5d45ca6ddd5eb808b256e
2017-11-14 11:19:25.267 [ 5] E UrlSource:UrlSource::preprocess 4
(Nut2AVS:14091): GLib-GObject-WARNING **: g_object_set_valist: object class 'GstPlayBin' has no property named 'use-buffering'
2017-11-14 11:19:25.267 [ 5] E UrlSource:UrlSource::preprocess 5
2017-11-14 11:19:25.267 [ 5] E MediaPlayer:playCalled 2
2017-11-14 11:19:25.268 [ 5] E MediaPlayer:playCalled 3
2017-11-14 11:19:25.268 [ 2] E MediaPlayer:handlePlayCalled
2017-11-14 11:19:25.268 [ 2] E MediaPlayer:doStopSuccess:reason=alreadyStopped
2017-11-14 11:19:25.268 [ 2] E MediaPlayer:doStopSuccess
(Nut2AVS:14091): GLib-GObject-WARNING **: g_object_get_valist: object class 'GstPlayBin' has no property named 'use-buffering'
2017-11-14 11:19:25.268 [ 2] E MediaPlayer:handlePlay:attemptBuffering=-1849375488
2017-11-14 11:19:25.272 [ 2] E MediaPlayer:handlePlay:startingState=PLAYING,stateReturn=ASYNC
2017-11-14 11:19:25.273 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:25.273 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:25.273 [ 5] 0 DirectiveProcessor:onHandlingCompeted:messageId=613d7787-49ab-47f6-9619-1dd744119039,directiveBeingPreHandled=(nullptr)
2017-11-14 11:19:25.273 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:25.273 [ 5] 0 CapabilityAgent:removingMessageIdFromMap:messageId=613d7787-49ab-47f6-9619-1dd744119039
2017-11-14 11:19:25.273 [ 2] E MediaPlayer:State Change:oldState=NULL,newState=READY,pendingState=PLAYING
2017-11-14 11:19:25.274 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:25.274 [ 5] E AudioPlayer:executeOnPlaybackFinishedError:reason=notPlaying,m_currentActivity=STOPPED
2017-11-14 11:19:25.274 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:25.275 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:25.275 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:25.275 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:25.275 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:25.275 [ 2] E MediaPlayer:messageReceived:messageType=stream-status
2017-11-14 11:19:25.276 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:25.276 [ 2] E MediaPlayer:messageReceived:messageType=stream-status
2017-11-14 11:19:25.326 [ e] 0 MessageInterpreter:receive:messageId=7d2adcbd-948f-4806-9b89-1404c4948299:No dialogRequestId attached to message.
2017-11-14 11:19:25.327 [ e] I DirectiveSequencer:onDirective:UnparsedDirective={"directive"\:{"header"\:{"namespace"\:"AudioPlayer"\,"name"\:"Play"\,"messageId"\:"7d2adcbd-948f-4806-9b89-1404c4948299"}\,"payload"\:{"audioItem"\:{"audioItemId"\:"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb\:14"\,"stream"\:{"offsetInMilliseconds"\:0\,"expiryTime"\:"292278993-08-17T07\:12\:55+0000"\,"progressReport"\:{"progressReportDelayInMilliseconds"\:1000}\,"url"\:"https\://d29r7idq0wxsiz.cloudfront.net/DigitalMusicDeliveryService/HPS.m3u8?m\=m&dmid\=227176497&c\=cf&f\=ts&t\=10&bl\=256k&s\=true&e1\=1510661700000&e2\=1510662600000&v\=V2&h\=fa1c30398c927c158d0e1747d124e459837cb6aa8d2b19098f884376de10ac32"\,"token"\:"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb\:14"}}\,"playBehavior"\:"REPLACE_ALL"}}}
...onDirectiveArrived...
----------------- default directive
2017-11-14 11:19:25.327 [ f] I DirectiveRouter:preHandleDirective:UnparsedDirective={"directive"\:{"header"\:{"namespace"\:"AudioPlayer"\,"name"\:"Play"\,"messageId"\:"7d2adcbd-948f-4806-9b89-1404c4948299"}\,"payload"\:{"audioItem"\:{"audioItemId"\:"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb\:14"\,"stream"\:{"offsetInMilliseconds"\:0\,"expiryTime"\:"292278993-08-17T07\:12\:55+0000"\,"progressReport"\:{"progressReportDelayInMilliseconds"\:1000}\,"url"\:"https\://d29r7idq0wxsiz.cloudfront.net/DigitalMusicDeliveryService/HPS.m3u8?m\=m&dmid\=227176497&c\=cf&f\=ts&t\=10&bl\=256k&s\=true&e1\=1510661700000&e2\=1510662600000&v\=V2&h\=fa1c30398c927c158d0e1747d124e459837cb6aa8d2b19098f884376de10ac32"\,"token"\:"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb\:14"}}\,"playBehavior"\:"REPLACE_ALL"}}}
2017-11-14 11:19:25.327 [ f] I DirectiveRouter:preHandleDirective:messageId=7d2adcbd-948f-4806-9b89-1404c4948299,action=calling
2017-11-14 11:19:25.327 [ f] 0 CapabilityAgent:addingMessageIdToMap:messageId=7d2adcbd-948f-4806-9b89-1404c4948299
2017-11-14 11:19:25.328 [ 10] I DirectiveRouter:handleDirective:messageId=7d2adcbd-948f-4806-9b89-1404c4948299,action=calling
AudioPlayer::handleDirective getName = Play
2017-11-14 11:19:25.328 [ 10] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=streamFormat
2017-11-14 11:19:25.329 [ 10] E TimeUtils:convert8601TimeStringToUnixFailed:unexpected time string length:=29
2017-11-14 11:19:25.329 [ 10] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=progressReportIntervalInMilliseconds
2017-11-14 11:19:25.329 [ 10] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=expectedPreviousToken
--> King:: AudioPlayer changeActivity from STOPPED to STOPPED...
2017-11-14 11:19:25.330 [ 5] 0 AudioPlayer:changeActivity:from=STOPPED,to=STOPPED
King:: onAudioPlayerPlayStatusChanged to 2
openFMDuringTest : isFMOpened = 0 , mLastFMOpened = 0
start:: turn on LED
Start to open < DEFAULT > LED --> 2017-11-14 19:19:25:330
end:: turn on LED
socketfd = 102
send content is: play_music:status=0
send avs data ok
--> King:: AudioPlayer executeProvideState start ...
2017-11-14 11:19:25.408 [ 5] 0 AudioPlayer:executeProvideState:sendToken=false,stateRequestToken=0
--> King:: AudioPlayer executeProvideState update payload to: {"token":"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb:9","offsetInMilliseconds":5722,"playerActivity":"STOPPED"}
2017-11-14 11:19:25.409 [ 5] 0 ContextManager:updateStateLocked:action=updatedState,state={"token"\:"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb\:9"\,"offsetInMilliseconds"\:5722\,"playerActivity"\:"STOPPED"},namespace=AudioPlayer,name=PlaybackState
--> King:: AudioPlayer executeProvideState update Success!!!
2017-11-14 11:19:25.409 [ 5] 0 EventBuilder:buildJsonEventString:messageId=7873fb11-8761-4fdb-bc59-e2b179eb0b4e,namespace=AudioPlayer,name=PlaybackStopped
AVSConnectionManager::sendMessage {"event":{"header":{"namespace":"AudioPlayer","name":"PlaybackStopped","messageId":"7873fb11-8761-4fdb-bc59-e2b179eb0b4e"},"payload":{"token":"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb:9","offsetInMilliseconds":5722}}}
2017-11-14 11:19:25.409 [ 5] E MediaPlayer:setSourceForUrlCalled
setSourceForUrlCalledhttps://d29r7idq0wxsiz.cloudfront.net/DigitalMusicDeliveryService/HPS.m3u8?m=m&dmid=227176497&c=cf&f=ts&t=10&bl=256k&s=true&e1=1510661700000&e2=1510662600000&v=V2&h=fa1c30398c927c158d0e1747d124e459837cb6aa8d2b19098f884376de10ac32
2017-11-14 11:19:25.410 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:25.410 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:25.411 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:25.412 [ 2] E MediaPlayer:messageReceived:messageType=stream-status
2017-11-14 11:19:25.412 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:25.412 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:25.413 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:25.413 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:25.414 [ 5] E MediaPlayer:callingOnPlaybackFinished
2017-11-14 11:19:25.414 [ 5] E MediaPlayer:doStopSuccess
2017-11-14 11:19:25.415 [ 2] E MediaPlayer:resetPipeline
2017-11-14 11:19:25.416 [ ad] E MediaPlayer:handleSetSourceForUrlCalled
2017-11-14 11:19:25.416 [ ad] 0 UrlSource:initCalledForUrlSource
2017-11-14 11:19:25.417 [ ad] E UrlSource:Creating Decoder
2017-11-14 11:19:25.417 [ ae] E PlaylistParser:doDepthFirstSearch
2017-11-14 11:19:25.418 [ ad] E UrlSource:Decoder Created
2017-11-14 11:19:25.418 [ ae] E PlaylistParser:doDepthFirstSearch 1
2017-11-14 11:19:25.419 [ ad] E MediaPlayer:handleSetSourceForUrl exit
>>>>>>>>>>>MediaPlayer::play 1
>>>>>>>>>>>MediaPlayer::play 2
2017-11-14 11:19:25.420 [ 5] E MediaPlayer:playCalled
2017-11-14 11:19:25.420 [ 5] E UrlSource:UrlSource::preprocess 1
2017-11-14 11:19:25.426 [ 9] 0 HTTP2StreamPool:getStream:streamId=547,numAcquiredStreams=2
2017-11-14 11:19:26.090 [ 9] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 06da90fffe2ee54a-00005193-0000e184-cb22ac9d458cc8d2-7e6425cc-547
2017-11-14 11:19:26.090 [ 9] 0 HTTP2Transport:cleanupFinishedStream:streamId=547,result=204
2017-11-14 11:19:26.090 [ 9] 0 HTTP2StreamPool:releaseStream:streamId=547,numAcquiredStreams=1
2017-11-14 11:19:26.091 [ 9] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT
Urlhttps://d29r7idq0wxsiz.cloudfront.net/DigitalMusicDeliveryService/HPS.m3u8?m=m&dmid=227176497&c=cf&f=ts&t=10&bl=256k&s=true&e1=1510661700000&e2=1510662600000&v=V2&h=fa1c30398c927c158d0e1747d124e459837cb6aa8d2b19098f884376de10ac32
contentTypeapplication/vnd.apple.mpegurl
2017-11-14 11:19:26.401 [ ae] E PlaylistParser:doDepthFirstSearch 2
2017-11-14 11:19:26.404 [ ae] E PlaylistParser:PlaylistParser::getContentFromPlaylistUrlIntoString 1
2017-11-14 11:19:26.405 [ ae] E PlaylistParser:PlaylistParser::getContentFromPlaylistUrlIntoString 2
2017-11-14 11:19:27.473 [ ae] E PlaylistParser:PlaylistParser::getContentFromPlaylistUrlIntoString 3
2017-11-14 11:19:27.473 [ ae] E PlaylistParser:PlaylistParser::getContentFromPlaylistUrlIntoString 4
2017-11-14 11:19:27.473 [ ae] E PlaylistParser:PlaylistParser::getContentFromPlaylistUrlIntoString 5
2017-11-14 11:19:27.473 [ ae] E PlaylistParser:PlaylistParser::getContentFromPlaylistUrlIntoString 7
2017-11-14 11:19:27.473 [ ae] E PlaylistParser:PlaylistParser::getContentFromPlaylistUrlIntoString 5
2017-11-14 11:19:27.473 [ ae] I InProcessAttachmentReader:readFailed:reason=SDS is closed
2017-11-14 11:19:27.473 [ ae] E PlaylistParser:PlaylistParser::getContentFromPlaylistUrlIntoString 6
2017-11-14 11:19:27.473 [ ae] E PlaylistParser:PlaylistParser::getContentFromPlaylistUrlIntoString 10
2017-11-14 11:19:27.487 [ ae] E PlaylistParser:doDepthFirstSearch 3
Urlhttps://d29r7idq0wxsiz.cloudfront.net/DigitalMusicDeliveryService/HPS.m3u8?m=m&dmid=227176497&c=cf&f=ts&t=10&bl=256k&s=true&e1=1510661700000&e2=1510662600000&v=V2&h=fa1c30398c927c158d0e1747d124e459837cb6aa8d2b19098f884376de10ac32
2017-11-14 11:19:27.491 [ ae] E PlaylistParser:isM3U8Playlist
2017-11-14 11:19:27.491 [ ae] E PlaylistParser:doDepthFirstSearch 4
2017-11-14 11:19:27.491 [ ae] E PlaylistParser:doDepthFirstSearch 5
2017-11-14 11:19:27.491 [ ae] E UrlSource:onPlaylistEntryParsed 1
2017-11-14 11:19:27.491 [ ae] E UrlSource:onPlaylistEntryParsed 2
2017-11-14 11:19:27.491 [ ae] E UrlSource:onPlaylistEntryParsed 3
2017-11-14 11:19:27.491 [ 5] E UrlSource:UrlSource::preprocess 2
2017-11-14 11:19:27.492 [ 5] E UrlSource:UrlSource::preprocess 3
UrlSource::preprocesshttps://d29r7idq0wxsiz.cloudfront.net/DigitalMusicDeliveryService/HPS.m3u8?m=m&dmid=227176497&c=cf&f=ts&t=10&bl=256k&s=true&e1=1510661700000&e2=1510662600000&v=V2&h=fa1c30398c927c158d0e1747d124e459837cb6aa8d2b19098f884376de10ac32
2017-11-14 11:19:27.492 [ 5] E UrlSource:UrlSource::preprocess 4
(Nut2AVS:14091): GLib-GObject-WARNING **: g_object_set_valist: object class 'GstPlayBin' has no property named 'use-buffering'
2017-11-14 11:19:27.492 [ 5] E UrlSource:UrlSource::preprocess 5
2017-11-14 11:19:27.492 [ 5] E MediaPlayer:playCalled 2
2017-11-14 11:19:27.493 [ 5] E MediaPlayer:playCalled 3
2017-11-14 11:19:27.493 [ 2] E MediaPlayer:handlePlayCalled
2017-11-14 11:19:27.493 [ 2] E MediaPlayer:doStopSuccess:reason=alreadyStopped
2017-11-14 11:19:27.493 [ 2] E MediaPlayer:doStopSuccess
(Nut2AVS:14091): GLib-GObject-WARNING **: g_object_get_valist: object class 'GstPlayBin' has no property named 'use-buffering'
2017-11-14 11:19:27.493 [ 2] E MediaPlayer:handlePlay:attemptBuffering=-1849375488
2017-11-14 11:19:27.497 [ 2] E MediaPlayer:handlePlay:startingState=PLAYING,stateReturn=ASYNC
2017-11-14 11:19:27.498 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:27.498 [ 5] 0 DirectiveProcessor:onHandlingCompeted:messageId=7d2adcbd-948f-4806-9b89-1404c4948299,directiveBeingPreHandled=(nullptr)
2017-11-14 11:19:27.498 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:27.498 [ 5] 0 CapabilityAgent:removingMessageIdFromMap:messageId=7d2adcbd-948f-4806-9b89-1404c4948299
2017-11-14 11:19:27.499 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:27.499 [ 2] E MediaPlayer:State Change:oldState=NULL,newState=READY,pendingState=PLAYING
2017-11-14 11:19:27.499 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:27.499 [ 5] E AudioPlayer:executeOnPlaybackFinishedError:reason=notPlaying,m_currentActivity=STOPPED
2017-11-14 11:19:27.499 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:27.499 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:27.499 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:27.500 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:27.500 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:27.500 [ 2] E MediaPlayer:messageReceived:messageType=stream-status
2017-11-14 11:19:27.500 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:27.500 [ 2] E MediaPlayer:messageReceived:messageType=stream-status
2017-11-14 11:19:28.264 [ 2] E MediaPlayer:messageReceived:messageType=duration-changed
2017-11-14 11:19:28.272 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:28.273 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:28.273 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:28.301 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:28.301 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:28.499 [ 5] 0 EventBuilder:buildJsonEventString:messageId=36446639-6522-4ad7-8dc9-9a27f84172f9,namespace=AudioPlayer,name=ProgressReportDelayElapsed
AVSConnectionManager::sendMessage {"event":{"header":{"namespace":"AudioPlayer","name":"ProgressReportDelayElapsed","messageId":"36446639-6522-4ad7-8dc9-9a27f84172f9"},"payload":{"token":"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb:14","offsetInMilliseconds":5722}}}
2017-11-14 11:19:28.598 [ 9] 0 HTTP2StreamPool:getStream:streamId=549,numAcquiredStreams=2
2017-11-14 11:19:28.809 [ e] 0 MessageInterpreter:receive:messageId=f52c99bf-62ae-40a8-824e-b93c03dad95e:No dialogRequestId attached to message.
2017-11-14 11:19:28.810 [ e] I DirectiveSequencer:onDirective:UnparsedDirective={"directive"\:{"header"\:{"namespace"\:"System"\,"name"\:"ResetUserInactivity"\,"messageId"\:"f52c99bf-62ae-40a8-824e-b93c03dad95e"}\,"payload"\:{"cause"\:"GUI_ACTION"}}}
...onDirectiveArrived...
----------------- default directive
2017-11-14 11:19:28.812 [ f] I DirectiveRouter:preHandleDirective:UnparsedDirective={"directive"\:{"header"\:{"namespace"\:"System"\,"name"\:"ResetUserInactivity"\,"messageId"\:"f52c99bf-62ae-40a8-824e-b93c03dad95e"}\,"payload"\:{"cause"\:"GUI_ACTION"}}}
2017-11-14 11:19:28.813 [ f] I DirectiveRouter:preHandleDirective:messageId=f52c99bf-62ae-40a8-824e-b93c03dad95e,action=calling
2017-11-14 11:19:28.814 [ f] 0 CapabilityAgent:addingMessageIdToMap:messageId=f52c99bf-62ae-40a8-824e-b93c03dad95e
2017-11-14 11:19:28.815 [ 10] I DirectiveRouter:handleDirective:messageId=f52c99bf-62ae-40a8-824e-b93c03dad95e,action=calling
2017-11-14 11:19:28.816 [ 10] 0 DirectiveProcessor:onHandlingCompeted:messageId=f52c99bf-62ae-40a8-824e-b93c03dad95e,directiveBeingPreHandled=(nullptr)
2017-11-14 11:19:28.816 [ 10] 0 CapabilityAgent:removingMessageIdFromMap:messageId=f52c99bf-62ae-40a8-824e-b93c03dad95e
2017-11-14 11:19:28.959 [ e] 0 MessageInterpreter:receive:messageId=949f11c0-79b8-40de-aa0d-513924a94dfb:No dialogRequestId attached to message.
2017-11-14 11:19:28.959 [ e] I DirectiveSequencer:onDirective:UnparsedDirective={"directive"\:{"header"\:{"namespace"\:"System"\,"name"\:"ResetUserInactivity"\,"messageId"\:"949f11c0-79b8-40de-aa0d-513924a94dfb"}\,"payload"\:{"cause"\:"GUI_ACTION"}}}
...onDirectiveArrived...
----------------- default directive
2017-11-14 11:19:28.962 [ f] I DirectiveRouter:preHandleDirective:UnparsedDirective={"directive"\:{"header"\:{"namespace"\:"System"\,"name"\:"ResetUserInactivity"\,"messageId"\:"949f11c0-79b8-40de-aa0d-513924a94dfb"}\,"payload"\:{"cause"\:"GUI_ACTION"}}}
2017-11-14 11:19:28.962 [ f] I DirectiveRouter:preHandleDirective:messageId=949f11c0-79b8-40de-aa0d-513924a94dfb,action=calling
2017-11-14 11:19:28.962 [ f] 0 CapabilityAgent:addingMessageIdToMap:messageId=949f11c0-79b8-40de-aa0d-513924a94dfb
2017-11-14 11:19:28.962 [ 10] I DirectiveRouter:handleDirective:messageId=949f11c0-79b8-40de-aa0d-513924a94dfb,action=calling
2017-11-14 11:19:28.962 [ 10] 0 DirectiveProcessor:onHandlingCompeted:messageId=949f11c0-79b8-40de-aa0d-513924a94dfb,directiveBeingPreHandled=(nullptr)
2017-11-14 11:19:28.962 [ 10] 0 CapabilityAgent:removingMessageIdFromMap:messageId=949f11c0-79b8-40de-aa0d-513924a94dfb
2017-11-14 11:19:29.078 [ 2] E MediaPlayer:messageReceived:messageType=element
2017-11-14 11:19:29.079 [ 2] E MediaPlayer:messageReceived:messageType=duration-changed
2017-11-14 11:19:29.085 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:29.086 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:29.087 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:29.087 [ 2] E MediaPlayer:messageReceived:messageType=stream-status
2017-11-14 11:19:29.087 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:29.088 [ 2] E MediaPlayer:messageReceived:messageType=stream-status
2017-11-14 11:19:29.089 [ 2] E MediaPlayer:messageReceived:messageType=stream-status
2017-11-14 11:19:29.089 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:29.090 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:29.090 [ 2] E MediaPlayer:messageReceived:messageType=stream-status
2017-11-14 11:19:29.114 [ 9] 0 HTTP2Stream:receivedRequestId:value=x-amzn-requestid\: 06da90fffe2ee54a-00005193-0000e184-cb22ac9d458cc8d2-7e6425cc-549
2017-11-14 11:19:29.114 [ 9] 0 HTTP2Transport:cleanupFinishedStream:streamId=549,result=204
2017-11-14 11:19:29.114 [ 9] 0 HTTP2StreamPool:releaseStream:streamId=549,numAcquiredStreams=1
2017-11-14 11:19:29.114 [ 9] 0 CurlEasyHandleWrapper:reset:responseCode=HTTP_RESPONSE_SUCCESS_NO_CONTENT
2017-11-14 11:19:29.221 [ e] 0 MessageInterpreter:receive:messageId=6942596e-de5b-4870-a70d-c7cbab3fecd7:No dialogRequestId attached to message.
2017-11-14 11:19:29.222 [ e] I DirectiveSequencer:onDirective:UnparsedDirective={"directive"\:{"header"\:{"namespace"\:"AudioPlayer"\,"name"\:"Play"\,"messageId"\:"6942596e-de5b-4870-a70d-c7cbab3fecd7"}\,"payload"\:{"audioItem"\:{"audioItemId"\:"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb\:20"\,"stream"\:{"offsetInMilliseconds"\:0\,"expiryTime"\:"292278993-08-17T07\:12\:55+0000"\,"progressReport"\:{"progressReportDelayInMilliseconds"\:1000}\,"url"\:"https\://d29r7idq0wxsiz.cloudfront.net/DigitalMusicDeliveryService/HPS.m3u8?m\=m&dmid\=227176501&c\=cf&f\=ts&t\=10&bl\=256k&s\=true&e1\=1510661700000&e2\=1510662600000&v\=V2&h\=3a1813cb0eeb08b675d655f3566a265b8dabf137903b66a6d9dbde084540ad3c"\,"token"\:"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb\:20"}}\,"playBehavior"\:"REPLACE_ALL"}}}
...onDirectiveArrived...
----------------- default directive
2017-11-14 11:19:29.224 [ f] I DirectiveRouter:preHandleDirective:UnparsedDirective={"directive"\:{"header"\:{"namespace"\:"AudioPlayer"\,"name"\:"Play"\,"messageId"\:"6942596e-de5b-4870-a70d-c7cbab3fecd7"}\,"payload"\:{"audioItem"\:{"audioItemId"\:"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb\:20"\,"stream"\:{"offsetInMilliseconds"\:0\,"expiryTime"\:"292278993-08-17T07\:12\:55+0000"\,"progressReport"\:{"progressReportDelayInMilliseconds"\:1000}\,"url"\:"https\://d29r7idq0wxsiz.cloudfront.net/DigitalMusicDeliveryService/HPS.m3u8?m\=m&dmid\=227176501&c\=cf&f\=ts&t\=10&bl\=256k&s\=true&e1\=1510661700000&e2\=1510662600000&v\=V2&h\=3a1813cb0eeb08b675d655f3566a265b8dabf137903b66a6d9dbde084540ad3c"\,"token"\:"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb\:20"}}\,"playBehavior"\:"REPLACE_ALL"}}}
2017-11-14 11:19:29.224 [ f] I DirectiveRouter:preHandleDirective:messageId=6942596e-de5b-4870-a70d-c7cbab3fecd7,action=calling
2017-11-14 11:19:29.225 [ f] 0 CapabilityAgent:addingMessageIdToMap:messageId=6942596e-de5b-4870-a70d-c7cbab3fecd7
2017-11-14 11:19:29.225 [ 10] I DirectiveRouter:handleDirective:messageId=6942596e-de5b-4870-a70d-c7cbab3fecd7,action=calling
AudioPlayer::handleDirective getName = Play
2017-11-14 11:19:29.226 [ 10] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=streamFormat
2017-11-14 11:19:29.226 [ 10] E TimeUtils:convert8601TimeStringToUnixFailed:unexpected time string length:=29
2017-11-14 11:19:29.227 [ 10] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=progressReportIntervalInMilliseconds
2017-11-14 11:19:29.227 [ 10] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=expectedPreviousToken
--> King:: AudioPlayer changeActivity from STOPPED to STOPPED...
2017-11-14 11:19:29.228 [ 5] 0 AudioPlayer:changeActivity:from=STOPPED,to=STOPPED
King:: onAudioPlayerPlayStatusChanged to 2
openFMDuringTest : isFMOpened = 0 , mLastFMOpened = 0
start:: turn on LED
Start to open < DEFAULT > LED --> 2017-11-14 19:19:29:228
end:: turn on LED
socketfd = 107
send content is: play_music:status=0
send avs data ok
--> King:: AudioPlayer executeProvideState start ...
2017-11-14 11:19:29.334 [ 5] 0 AudioPlayer:executeProvideState:sendToken=false,stateRequestToken=0
--> King:: AudioPlayer executeProvideState update payload to: {"token":"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb:14","offsetInMilliseconds":5722,"playerActivity":"STOPPED"}
2017-11-14 11:19:29.334 [ 5] 0 ContextManager:updateStateLocked:action=updatedState,state={"token"\:"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb\:14"\,"offsetInMilliseconds"\:5722\,"playerActivity"\:"STOPPED"},namespace=AudioPlayer,name=PlaybackState
--> King:: AudioPlayer executeProvideState update Success!!!
2017-11-14 11:19:29.334 [ 5] 0 EventBuilder:buildJsonEventString:messageId=7a11ea45-f001-4711-8f40-baee5965c233,namespace=AudioPlayer,name=PlaybackStopped
AVSConnectionManager::sendMessage {"event":{"header":{"namespace":"AudioPlayer","name":"PlaybackStopped","messageId":"7a11ea45-f001-4711-8f40-baee5965c233"},"payload":{"token":"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#28c0096e-9acd-4e19-9482-b5074a103fbb:14","offsetInMilliseconds":5722}}}
2017-11-14 11:19:29.335 [ 5] E MediaPlayer:setSourceForUrlCalled
setSourceForUrlCalledhttps://d29r7idq0wxsiz.cloudfront.net/DigitalMusicDeliveryService/HPS.m3u8?m=m&dmid=227176501&c=cf&f=ts&t=10&bl=256k&s=true&e1=1510661700000&e2=1510662600000&v=V2&h=3a1813cb0eeb08b675d655f3566a265b8dabf137903b66a6d9dbde084540ad3c
2017-11-14 11:19:29.335 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:29.336 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:29.336 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:29.336 [ 2] E MediaPlayer:messageReceived:messageType=stream-status
2017-11-14 11:19:29.336 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:29.338 [ 2] E MediaPlayer:messageReceived:messageType=stream-status
2017-11-14 11:19:29.338 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:29.338 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:29.339 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:29.339 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
2017-11-14 11:19:29.339 [ 2] E MediaPlayer:messageReceived:messageType=state-changed
Segmentation fault
/usr/nut2_avs #
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment