search

alexa / avs-device-sdk

An SDK for commercial device makers to integrate Alexa directly into connected products.
https://developer.amazon.com/alexa/alexa-voice-service
Apache License 2.0
1.26k stars 604 forks source link

AVS client crash when playing iheartradio #645

Closed subjectxbj closed 6 years ago

subjectxbj commented 6 years ago

IMPORTANT: Before you create an issue, please take a look at our Issue Reporting Guide.

Briefly summarize your issue:

I'm testing iheartradio on AVS SDK 1.6. No matter how I start iheartradio, it always crash. I have tried using voice to request iHeartRadio, also I have tried click the item on "alexa.amazon.com". Both will cause AVS client to crash.

Following is the log that I click "NASH FM 102.7", which cause the crash:

             # #   #     # #     #    #     # #     # #   #
            #   #  #     # #          #       #     # #  #
           #     # #     #  #####      #####  #     # ###
           #######  #   #        #          # #     # #  #
           #     #   # #   #     #    #     # #     # #   #
           #     #    #     #####      #####  ######  #    #

   #####                                           #
  #     #   ##   #    # #####  #      ######      # #   #####  #####
  #        #  #  ##  ## #    # #      #          #   #  #    # #    #
   #####  #    # # ## # #    # #      #####     #     # #    # #    #
        # ###### #    # #####  #      #         ####### #####  #####
  #     # #    # #    # #      #      #         #     # #      #
   #####  #    # #    # #      ###### ######    #     # #      #

   SDK Version 1.6.0

+----------------------------------------------------------------------------+ | Options: | | Wake word: | | Simply say Alexa and begin your query. | | Tap to talk: | | Press 't' and Enter followed by your query (no need for the 'Alexa').| | Hold to talk: | | Press 'h' followed by Enter to simulate holding a button. | | Then say your query (no need for the 'Alexa'). | | Press 'h' followed by Enter to simulate releasing a button. | | Stop an interaction: | | Press 's' and Enter to stop an ongoing interaction. | | Privacy mode (microphone off): | | Press 'm' and Enter to turn on and off the microphone. | | Echo Spatial Perception (ESP): This is for testing purpose only! | | Press 'e' followed by Enter at any time to adjust ESP settings. | | Playback Controls: | | Press '1' for a 'PLAY' button press. | | Press '2' for a 'PAUSE' button press. | | Press '3' for a 'NEXT' button press. | | Press '4' for a 'PREVIOUS' button press. | | Settings: | | Press 'c' followed by Enter at any time to see the settings screen. | | Speaker Control: | | Press 'p' followed by Enter at any time to adjust speaker settings. | | Firmware Version: | | Press 'f' followed by Enter at any time to report a different | | firmware version. | | Info: | | Press 'i' followed by Enter at any time to see the help screen. | | Reset device: | | Press 'k' followed by Enter at any time to reset your device. This | | will erase any data stored in the device and you will have to | | register your device with another account. | | This will kill the application since we don't support login yet. | | Quit: | | Press 'q' followed by Enter at any time to quit the application. | +----------------------------------------------------------------------------+

2018-04-23 05:41:42.979 [ e] 0 MessageInterpreter:receive:messageId=89b129ff-eb41-4c65-822f-efab4bfb3bb7:No dialogRequestId attached to message. 2018-04-23 05:41:42.980 [ e] I DirectiveSequencer:onDirective:directive={"namespace\:"System"\,name\:"ResetUserInactivity"\,messageId\:"89b129ff-eb41-4c65-822f-efab4bfb3bb7"\,dialogRequestId\:""} 2018-04-23 05:41:42.980 [ f] I DirectiveRouter:preHandleDirective:messageId=89b129ff-eb41-4c65-822f-efab4bfb3bb7,action=calling 2018-04-23 05:41:42.980 [ f] 0 CapabilityAgent:addingMessageIdToMap:messageId=89b129ff-eb41-4c65-822f-efab4bfb3bb7 2018-04-23 05:41:42.980 [ 10] I DirectiveRouter:handleDirective:messageId=89b129ff-eb41-4c65-822f-efab4bfb3bb7,action=calling 2018-04-23 05:41:42.980 [ 10] 0 DirectiveProcessor:onHandlingCompeted:messageId=89b129ff-eb41-4c65-822f-efab4bfb3bb7,directiveBeingPreHandled=(nullptr) 2018-04-23 05:41:42.980 [ 10] 0 CapabilityAgent:removingMessageIdFromMap:messageId=89b129ff-eb41-4c65-822f-efab4bfb3bb7 2018-04-23 05:41:43.157 [ e] 0 MessageInterpreter:receive:messageId=d52a464a-d8ee-4077-ab48-cf0b6704d8a9:No dialogRequestId attached to message. 2018-04-23 05:41:43.157 [ e] I DirectiveSequencer:onDirective:directive={"namespace\:"AudioPlayer"\,name\:"Play"\,messageId\:"d52a464a-d8ee-4077-ab48-cf0b6704d8a9"\,dialogRequestId\:""} 2018-04-23 05:41:43.158 [ f] I DirectiveRouter:preHandleDirective:messageId=d52a464a-d8ee-4077-ab48-cf0b6704d8a9,action=calling 2018-04-23 05:41:43.158 [ f] 0 CapabilityAgent:addingMessageIdToMap:messageId=d52a464a-d8ee-4077-ab48-cf0b6704d8a9 2018-04-23 05:41:43.158 [ 10] I DirectiveRouter:handleDirective:messageId=d52a464a-d8ee-4077-ab48-cf0b6704d8a9,action=calling 2018-04-23 05:41:43.158 [ 10] 0 AudioPlayer:handleDirective:name=Play,messageId=d52a464a-d8ee-4077-ab48-cf0b6704d8a9 2018-04-23 05:41:43.158 [ 10] 1 AudioPlayer:handlePlayDirective 2018-04-23 05:41:43.158 [ 10] 9 AudioPlayer:PLAY:payload={"audioItem"\:{"audioItemId"\:"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#89d2c68a-de21-4157-8aeb-dec3292edbb7\:1"\,"stream"\:{"offsetInMilliseconds"\:0\,"expiryTime"\:"292278993-08-17T07\:12\:55+0000"\,"progressReport"\:{"progressReportIntervalInMilliseconds"\:60000}\,"url"\:"http\://playerservices.streamtheworld.com/pls/WHKRFMAAC.pls?at\=1&fb_broadcast\=false&deviceid\=amzn1.account.AHTV34OXL3TWQ3MTXLGDYWCEUBOQ&callLetters\=WHKR-FM&streamid\=5748&clienttype\=amazon&iheartradioversion\=1.0&osversion\=1.0&devicename\=Indigo&terminalid\=304&init_id\=8169&profileid\=531864039"\,"token"\:"amzn1.as-ct.v1.Dee-Domain-Music#ACRI#url#ACRI#89d2c68a-de21-4157-8aeb-dec3292edbb7\:1"}}\,"playBehavior"\:"REPLACE_ALL"} 2018-04-23 05:41:43.159 [ 10] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=streamFormat 2018-04-23 05:41:43.159 [ 10] E TimeUtils:convert8601TimeStringToUnixFailed:unexpected time string length:=29 2018-04-23 05:41:43.159 [ 10] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=progressReportDelayInMilliseconds 2018-04-23 05:41:43.159 [ 10] E JsonUtils:findNodeFailed:reason=missingDirectChild,child=expectedPreviousToken 2018-04-23 05:41:43.159 [ 10] 0 DirectiveProcessor:onHandlingCompeted:messageId=d52a464a-d8ee-4077-ab48-cf0b6704d8a9,directiveBeingPreHandled=(nullptr) 2018-04-23 05:41:43.159 [ 10] 0 CapabilityAgent:removingMessageIdFromMap:messageId=d52a464a-d8ee-4077-ab48-cf0b6704d8a9 2018-04-23 05:41:43.162 [ c] 1 AudioPlayer:executePlay:playBehavior=REPLACE_ALL 2018-04-23 05:41:43.162 [ c] 1 AudioPlayer:executeStop:playNextItem=true,m_currentActivity=IDLE 2018-04-23 05:41:43.162 [ c] 1 FocusManager:acquireChannel:channelName=Content,interface=AudioPlayer 2018-04-23 05:41:43.162 [ 11] 0 AudioPlayer:onFocusChanged:newFocus=FOREGROUND 2018-04-23 05:41:43.163 [ c] 1 AudioPlayer:executeOnFocusChanged:from=NONE,to=FOREGROUND,m_currentActivity=IDLE 2018-04-23 05:41:43.163 [ 11] 5 AudioActivityTracker:notifyOfActivityUpdates 2018-04-23 05:41:43.163 [ c] 1 AudioPlayer:executeOnFocusChanged:action=playNextItem 2018-04-23 05:41:43.163 [ 9] 5 AudioActivityTracker:executeNotifyOfActivityUpdates 2018-04-23 05:41:43.163 [ c] 1 AudioPlayer:playNextItem:m_audioItems.size=1 2018-04-23 05:41:43.163 [ c] 0 AudioPlayer:cancelTimers 2018-04-23 05:41:43.167 [ c] 9 AudioPlayer:settingUrlSource:offset=0 2018-04-23 05:41:43.167 [ c] 9 MediaPlayer:setSourceForUrlCalled 2018-04-23 05:41:43.168 [ 2] 0 MediaPlayer:handleSetSourceForUrlCalled 2018-04-23 05:41:43.168 [ 2] 9 MediaPlayer:tearDownTransientPipelineElements 2018-04-23 05:41:43.168 [ 2] E MediaPlayer:saveOffsetBeforeTeardown - gst_element_query_position failed 2018-04-23 05:41:43.170 [ 2] 0 MediaPlayer:handleSetSourceCalled 2018-04-23 05:41:43.170 [ 2] 9 MediaPlayer:tearDownTransientPipelineElements 2018-04-23 05:41:43.170 [ 2] E MediaPlayer:saveOffsetBeforeTeardown - gst_element_query_position failed 2018-04-23 05:41:43.172 [ 2] 9 BaseStreamSource:initNoAudioFormat 2018-04-23 05:41:43.184 [ c] 9 MediaPlayer:playCalled 2018-04-23 05:41:43.184 [ 2] 0 MediaPlayer:handlePlayCalled:idPassed=1,currentId=1 2018-04-23 05:41:43.185 [ c] 5 IntervalCalculator:getIntervalStart:interval=60000,offset=0,*intervalStart=0x74cd3238 2018-04-23 05:41:43.227 [ 2] 9 AttachmentReaderSource:handleSeekData:offset=0 2018-04-23 05:41:43.227 [ 2] 0 MediaPlayer:handlePlay:startingState=PLAYING,stateReturn=ASYNC 2018-04-23 05:41:43.227 [ 2] 9 MediaPlayer:messageReceived:type=state-changed,source=audio_sink 2018-04-23 05:41:43.227 [ 2] 9 MediaPlayer:messageReceived:type=state-changed,source=capsfilter1 2018-04-23 05:41:43.227 [ 2] 9 MediaPlayer:messageReceived:type=state-changed,source=caps 2018-04-23 05:41:43.227 [ 2] 9 MediaPlayer:messageReceived:type=state-changed,source=resample 2018-04-23 05:41:43.227 [ 2] 9 MediaPlayer:messageReceived:type=state-changed,source=volume 2018-04-23 05:41:43.227 [ 12] 9 BaseStreamSource:onNeedDataCalled:size=4096 2018-04-23 05:41:43.228 [ 2] 9 MediaPlayer:messageReceived:type=state-changed,source=converter 2018-04-23 05:41:43.228 [ 2] 9 MediaPlayer:messageReceived:type=state-changed,source=decodedQueue 2018-04-23 05:41:43.228 [ 2] 9 MediaPlayer:messageReceived:type=state-changed,source=typefind 2018-04-23 05:41:43.228 [ 2] 9 MediaPlayer:messageReceived:type=state-changed,source=decoder 2018-04-23 05:41:43.228 [ 2] 9 MediaPlayer:messageReceived:type=state-changed,source=src 2018-04-23 05:41:43.228 [ 2] 9 MediaPlayer:messageReceived:type=state-changed,source=audio-pipeline 2018-04-23 05:41:43.228 [ 2] 9 MediaPlayer:State Change:oldState=NULL,newState=READY,pendingState=PLAYING 2018-04-23 05:41:43.228 [ 2] 9 MediaPlayer:messageReceived:type=state-changed,source=capsfilter1 2018-04-23 05:41:43.228 [ 2] 9 MediaPlayer:messageReceived:type=state-changed,source=caps 2018-04-23 05:41:43.228 [ 2] 9 MediaPlayer:messageReceived:type=state-changed,source=resample 2018-04-23 05:41:43.228 [ 2] 9 MediaPlayer:messageReceived:type=state-changed,source=volume 2018-04-23 05:41:43.228 [ 2] 9 MediaPlayer:messageReceived:type=state-changed,source=converter 2018-04-23 05:41:43.228 [ 2] 9 MediaPlayer:messageReceived:type=stream-status,source=src 2018-04-23 05:41:43.229 [ 2] 9 MediaPlayer:messageReceived:type=state-changed,source=decodedQueue 2018-04-23 05:41:43.229 [ 2] 9 MediaPlayer:messageReceived:type=stream-status,source=src 2018-04-23 05:41:43.229 [ 2] 9 MediaPlayer:messageReceived:type=state-changed,source=typefind 2018-04-23 05:41:43.229 [ 2] 9 MediaPlayer:messageReceived:type=stream-status,source=src 2018-04-23 05:41:43.229 [ 2] 9 MediaPlayer:messageReceived:type=state-changed,source=src 2018-04-23 05:41:43.229 [ 2] 9 MediaPlayer:messageReceived:type=stream-status,source=src 2018-04-23 05:41:43.229 [ 2] 9 BaseStreamSource:handleNeedDataCalled 2018-04-23 05:41:43.229 [ 2] 9 BaseStreamSource:installOnReadDataHandler:action=newSourceId,sourceId=15 2018-04-23 05:41:47.194 [ 13] 9 LibCurlHttpContentFetcher:getContent:responseCode=200 2018-04-23 05:41:47.194 [ 13] 9 LibCurlHttpContentFetcher:getContent:contentType=audio/x-scpls; charset=UTF-8 2018-04-23 05:41:47.194 [ 14] 9 PlaylistParser:PlaylistParser:contentType=audio/x-scpls; charset\=UTF-8,length=-1 2018-04-23 05:41:47.194 [ 14] 9 PlaylistParser:isPLSPlaylist 2018-04-23 05:41:49.187 [ 14] I InProcessAttachmentReader:readFailed:reason=SDS is closed 2018-04-23 05:41:50.055 [ 15] 9 LibCurlHttpContentFetcher:getContent:responseCode=200 2018-04-23 05:41:50.055 [ 15] 9 LibCurlHttpContentFetcher:getContent:contentType=audio/aacp 2018-04-23 05:41:50.055 [ 14] 9 PlaylistParser:PlaylistParser:contentType=audio/aacp,length=-1 2018-04-23 05:41:50.055 [ 14] 9 PlaylistParser:foundNonPlaylistURL 2018-04-23 05:41:50.055 [ 14] 3 UrlContentToAttachmentConverter:onPlaylistEntryParsed:status=STILL_ONGOING 2018-04-23 05:41:50.056 [ 16] 9 UrlContentToAttachmentConverter:writeUrlContentIntoStream:info=beginning 2018-04-23 05:41:53.051 [ 16] 9 UrlContentToAttachmentConverter:writeUrlContentIntoStreamSuccess 2018-04-23 05:41:53.051 [ 2] 9 AttachmentReaderSource:read:size=787,status=0 2018-04-23 05:41:53.051 [ 2] 9 AttachmentReaderSource:read:size=4096,status=0 2018-04-23 05:41:53.051 [ 2] 9 AttachmentReaderSource:read:size=4096,status=0 2018-04-23 05:41:53.052 [ 2] 9 AttachmentReaderSource:read:size=740,status=0 2018-04-23 05:41:53.068 [ 2] 9 AttachmentReaderSource:read:size=2736,status=0 2018-04-23 05:41:53.085 [ 12] 9 MediaPlayer:onPadAddedCalled 2018-04-23 05:41:53.139 [ 17] 9 LibCurlHttpContentFetcher:getContent:responseCode=200 2018-04-23 05:41:53.140 [ 17] 9 LibCurlHttpContentFetcher:getContent:contentType=audio/aacp 2018-04-23 05:41:53.140 [ 14] 9 PlaylistParser:PlaylistParser:contentType=audio/aacp,length=-1 2018-04-23 05:41:53.140 [ 14] 9 PlaylistParser:foundNonPlaylistURL 2018-04-23 05:41:53.140 [ 14] 3 UrlContentToAttachmentConverter:onPlaylistEntryParsed:status=STILL_ONGOING 2018-04-23 05:41:53.276 [ 2] 9 AttachmentReaderSource:read:size=4096,status=0 2018-04-23 05:41:53.276 [ 2] 9 MediaPlayer:messageReceived:type=state-changed,source=aacparse0 2018-04-23 05:41:53.277 [ 2] 9 MediaPlayer:messageReceived:type=state-changed,source=aacparse0 2018-04-23 05:41:53.277 [ 2] 9 MediaPlayer:messageReceived:type=state-changed,source=faad0 2018-04-23 05:41:53.277 [ 2] 9 MediaPlayer:messageReceived:type=state-changed,source=faad0 2018-04-23 05:41:53.277 [ 2] 9 AttachmentReaderSource:read:size=4096,status=0 2018-04-23 05:41:53.277 [ 2] 9 MediaPlayer:handlePadAddedSignalCalled 2018-04-23 05:41:53.281 [ 2] 9 AttachmentReaderSource:read:size=4096,status=0 2018-04-23 05:41:53.281 [ 2] 9 MediaPlayer:messageReceived:type=state-changed,source=decoder 2018-04-23 05:41:53.282 [ 2] 9 MediaPlayer:messageReceived:type=stream-start,source=audio-pipeline 2018-04-23 05:41:53.282 [ 2] 9 AttachmentReaderSource:read:size=4096,status=0 2018-04-23 05:41:53.282 [ 2] 9 AttachmentReaderSource:read:size=4096,status=0 2018-04-23 05:41:53.282 [ 2] 9 AttachmentReaderSource:read:size=4096,status=0 2018-04-23 05:41:53.282 [ 2] 9 AttachmentReaderSource:read:size=48,status=0 Segmentation fault [avs_new] / #

What is the expected behavior?

What behavior are you observing?

Provide the steps to reproduce the issue, if applicable:

Tell us about your environment:

What version of the AVS Device SDK are you using?

  1.6.0

Tell us what hardware you're using:

Tell us about your OS (Type & version):

bandkenamazoncom commented 6 years ago

Is iheartradio able to output anything (does it run for a bit and then stop; or does it crash immediately)?

Is it possible to capture a stack trace or core dump of the Segmentation Fault?

subjectxbj commented 6 years ago

It run for a bit and then stop.

kclchan commented 6 years ago

Hi @subjectxbj, I see that you have the issue resolved in #831, I am closing this issue now. Please re-open it if you still have further questions. Thanks!