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 603 forks source link

avs-device-sdk on Rapsberry Pi authorization issues #748

Closed ukdesignservices closed 6 years ago

ukdesignservices commented 6 years ago

Briefly summarize your issue:

when running sudo bash startsample.sh the authorisation message is displayed:

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

> > > > > NOT YET AUTHORIZED < < < < <

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

############################################################################### To authorize, browse to: 'https://amazon.com/us/code' and enter the code: {XXXX} # ##############################################################################

However before the code can be entered the application exits with the following message:

"Failed to create to SampleApplication"

I've tried authorising the code anyway and running startsample.sh again, but it repeatedly just says 'not yet authorized'

What is the expected behavior?

Application should authorise, expecting to see message:

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

Alexa is currently idle!

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

What behavior are you observing?

Application exits immediately after prompting auth code. Here's the output of the startsample.sh auth request.

pi@raspberrypi:~ $ sudo bash startsample.sh 2018-05-30 15:02:38.015 [ 1] I sdkVersion: 1.7.1 configFile /home/pi/build/Integration/AlexaClientSDKConfig.json Running app with log level: DEBUG9 2018-05-30 15:02:38.100 [ 1] 0 ConfigurationNode:initializeSuccess 2018-05-30 15:02:38.203 [ 1] 9 MediaPlayer:createCalled 2018-05-30 15:02:38.743 [ 1] 9 MediaPlayer:noOutputConversion 2018-05-30 15:02:38.764 [ 1] 9 MediaPlayer:createCalled 2018-05-30 15:02:38.767 [ 1] 9 MediaPlayer:noOutputConversion 2018-05-30 15:02:38.798 [ 1] 9 MediaPlayer:createCalled 2018-05-30 15:02:38.804 [ 1] 9 MediaPlayer:noOutputConversion 2018-05-30 15:02:38.833 [ 1] 9 MediaPlayer:createCalled 2018-05-30 15:02:38.838 [ 1] 9 MediaPlayer:noOutputConversion 2018-05-30 15:02:38.869 [ 1] 9 MediaPlayer:createCalled 2018-05-30 15:02:38.872 [ 1] 9 MediaPlayer:noOutputConversion 2018-05-30 15:02:38.878 [ 1] 9 MediaPlayer:createCalled 2018-05-30 15:02:38.891 [ 1] 9 MediaPlayer:noOutputConversion 2018-05-30 15:02:38.934 [ 1] 5 SQLiteBluetoothStorage:create 2018-05-30 15:02:38.947 [ 1] 5 CBLAuthDelegate:create 2018-05-30 15:02:38.974 [ 1] 5 CBLAuthDelegate:CBLAuthDelegate 2018-05-30 15:02:38.975 [ 1] 5 CBLAuthDelegate:init 2018-05-30 15:02:38.976 [ 1] 5 CBLAuthDelegateConfiguration:create 2018-05-30 15:02:38.977 [ 1] 5 CBLAuthDelegateConfiguration:init 2018-05-30 15:02:38.977 [ 1] 5 CBLAuthDelegateConfiguration:initScopeData 2018-05-30 15:02:38.979 [ 1] 9 CBLAuthDelegateConfiguration:initScopeDataSucceeded 2018-05-30 15:02:38.980 [ 1] 5 SQLiteCBLAuthDelegateStorage:open 2018-05-30 15:02:39.020 [ 2] 5 CBLAuthDelegate:handleAuthorizationFlow 2018-05-30 15:02:39.026 [ 2] 5 CBLAuthDelegate:handleStarting 2018-05-30 15:02:39.027 [ 2] 5 SQLiteCBLAuthDelegateStorage:getRefreshToken 2018-05-30 15:02:39.029 [ 2] 0 SQLiteCBLAuthDelegateStorage:getRefreshTokenFailed:reason=stepResultWasNotRow 2018-05-30 15:02:39.038 [ 2] 0 CBLAuthDelegate:getRefreshTokenFailed 2018-05-30 15:02:39.039 [ 2] 5 CBLAuthDelegate:handleRequestingCodePair 2018-05-30 15:02:39.040 [ 2] 5 CBLAuthDelegate:requestCodePair 2018-05-30 15:02:39.033 [ 1] 5 CBLAuthDelegate:addAuthObserver:observer=0x154e54c 2018-05-30 15:02:39.056 [ 1] 5 CBLAuthDelegate:addAuthObserver:observer=0x15396a8 2018-05-30 15:02:39.070 [ 1] 5 CapabilitiesDelegate:addCapabilitiesObserver:observer=0x15396ac 2018-05-30 15:02:39.117 [ 1] 5 InternetConnectionMonitor:startMonitoring 2018-05-30 15:02:39.171 [ 3] 5 InternetConnectionMonitor:testConnection 2018-05-30 15:02:39.327 [ 1] 9 MediaPlayer:setObserverCalled 2018-05-30 15:02:39.328 [ 4] 0 MediaPlayer:handleSetObserverCalled 2018-05-30 15:02:39.369 [ 1] 9 SpeechSynthesizer:addObserver:observer=0x15527e4 2018-05-30 15:02:39.376 [ 1] 9 PlaybackRouter:create::called 2018-05-30 15:02:39.413 [ 1] 9 MediaPlayer:setObserverCalled 2018-05-30 15:02:39.420 [ 4] 0 MediaPlayer:handleSetObserverCalled 2018-05-30 15:02:39.422 [ 1] 9 MediaPlayer:setObserverCalled 2018-05-30 15:02:39.422 [ 4] 0 MediaPlayer:handleSetObserverCalled 2018-05-30 15:02:39.474 [ 1] 9 AlertScheduler:setTimerForNextAlertLocked 2018-05-30 15:02:39.520 [ 1] 9 AlertScheduler:executeScheduleNextAlertForRendering::no work to do. 2018-05-30 15:02:39.527 [ 5] 1 AlertsCapabilityAgent:executeOnConnectionStatusChanged:status=DISCONNECTED,reason=ACL_CLIENT_REQUEST 2018-05-30 15:02:39.528 [ 1] 5 NotificationsRenderer:create 2018-05-30 15:02:39.531 [ 1] 9 MediaPlayer:setObserverCalled 2018-05-30 15:02:39.540 [ 4] 0 MediaPlayer:handleSetObserverCalled 2018-05-30 15:02:39.544 [ 1] 5 NotificationsCapabilityAgent:init 2018-05-30 15:02:39.550 [ 1] 5 NotificationsRenderer:addObserver 2018-05-30 15:02:39.590 [ 6] 5 NotificationsCapabilityAgent:executeInit 2018-05-30 15:02:39.591 [ 6] 5 NotificationsCapabilityAgent:notifyObservers:indicatorState=0 2018-05-30 15:02:39.593 [ 6] 5 NotificationsCapabilityAgent:executeProvideState:sendToken=false,stateRequestToken=0 2018-05-30 15:02:39.611 [ 6] 9 ContextManager:updateStateLocked:action=updatedState,namespace=Notifications,name=IndicatorState 2018-05-30 15:02:39.687 [ 1] 9 MediaPlayer:getSpeakerTypeCalled 2018-05-30 15:02:39.710 [ 1] 9 MediaPlayer:getSpeakerTypeCalled 2018-05-30 15:02:39.750 [ 1] 9 MediaPlayer:getSpeakerTypeCalled 2018-05-30 15:02:39.760 [ 1] 9 MediaPlayer:getSpeakerTypeCalled 2018-05-30 15:02:39.760 [ 1] 9 MediaPlayer:getSpeakerTypeCalled 2018-05-30 15:02:39.760 [ 1] 9 MediaPlayer:getSpeakerTypeCalled 2018-05-30 15:02:39.761 [ 1] 0 SpeakerManager:mapCreated:numAvsSynced=5,numLocal=1 2018-05-30 15:02:39.762 [ 1] 9 MediaPlayer:getSpeakerSettingsCalled 2018-05-30 15:02:39.763 [ 4] 9 MediaPlayer:handleGetSpeakerSettingsCalled 2018-05-30 15:02:39.771 [ 1] 9 MediaPlayer:getSpeakerSettingsCalled 2018-05-30 15:02:39.771 [ 4] 9 MediaPlayer:handleGetSpeakerSettingsCalled 2018-05-30 15:02:39.772 [ 1] 9 MediaPlayer:getSpeakerSettingsCalled 2018-05-30 15:02:39.772 [ 4] 9 MediaPlayer:handleGetSpeakerSettingsCalled 2018-05-30 15:02:39.773 [ 1] 9 MediaPlayer:getSpeakerSettingsCalled 2018-05-30 15:02:39.773 [ 4] 9 MediaPlayer:handleGetSpeakerSettingsCalled 2018-05-30 15:02:39.774 [ 1] 9 MediaPlayer:getSpeakerSettingsCalled 2018-05-30 15:02:39.774 [ 4] 9 MediaPlayer:handleGetSpeakerSettingsCalled 2018-05-30 15:02:39.775 [ 1] 9 SpeakerManager:validateSpeakerSettingsConsistencyResult:consistent=true 2018-05-30 15:02:39.775 [ 1] 9 SpeakerManager:validateSpeakerSettings:volume=100,mute=false 2018-05-30 15:02:39.776 [ 1] 9 SpeakerManager:updateContextManagerCalled:speakerType=AVS_SYNCED 2018-05-30 15:02:39.793 [ 1] 0 ExternalMediaPlayer:createAdapters 2018-05-30 15:02:39.888 [ 1] 1 AudioPlayer:addObserver 2018-05-30 15:02:39.904 [ 3] 0 InProcessAttachmentReader:readFailed:reason=SDS is closed 2018-05-30 15:02:39.921 [ 3] 5 InternetConnectionMonitor:updateConnectionStatus:connected=true 2018-05-30 15:02:39.921 [ 3] 5 InternetConnectionMonitor:notifyObserversLocked 2018-05-30 15:02:39.953 [ 7] 5 TemplateRuntime:onDialogUXStateChanged:state=IDLE 2018-05-30 15:02:39.984 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=SpeechSynthesizer,name=Speak,handler=0x155a580,policy=BLOCKING 2018-05-30 15:02:40.028 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=AudioPlayer,name=ClearQueue,handler=0x1564238,policy=NON_BLOCKING 2018-05-30 15:02:40.047 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=AudioPlayer,name=Stop,handler=0x1564238,policy=NON_BLOCKING 2018-05-30 15:02:40.048 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=AudioPlayer,name=Play,handler=0x1564238,policy=NON_BLOCKING 2018-05-30 15:02:40.061 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=ExternalMediaPlayer,name=Play,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.062 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=ExternalMediaPlayer,name=Logout,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.063 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=ExternalMediaPlayer,name=Login,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.063 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.SeekController,name=SetSeekPosition,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.064 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=Play,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.064 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.FavoritesController,name=Unfavorite,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.065 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaylistController,name=EnableShuffle,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.065 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=Pause,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.080 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=Next,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.080 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=Rewind,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.081 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaylistController,name=EnableRepeat,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.090 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=Previous,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.090 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=StartOver,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.091 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=FastForward,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.091 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.FavoritesController,name=Favorite,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.092 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaylistController,name=DisableShuffle,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.092 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaylistController,name=EnableRepeatOne,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.099 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaylistController,name=DisableRepeat,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.100 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.SeekController,name=AdjustSeekPosition,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.101 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=SpeechRecognizer,name=ExpectSpeech,handler=0x1559c90,policy=NON_BLOCKING 2018-05-30 15:02:40.113 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=SpeechRecognizer,name=StopCapture,handler=0x1559c90,policy=NON_BLOCKING 2018-05-30 15:02:40.115 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alerts,name=DeleteAlert,handler=0x1565108,policy=NON_BLOCKING 2018-05-30 15:02:40.125 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alerts,name=SetAlert,handler=0x1565108,policy=NON_BLOCKING 2018-05-30 15:02:40.126 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=System,name=SetEndpoint,handler=0x1554cf8,policy=NON_BLOCKING 2018-05-30 15:02:40.127 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=System,name=ResetUserInactivity,handler=0x15599f4,policy=NON_BLOCKING 2018-05-30 15:02:40.129 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Speaker,name=AdjustVolume,handler=0x1571528,policy=NON_BLOCKING 2018-05-30 15:02:40.177 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Speaker,name=SetMute,handler=0x1571528,policy=NON_BLOCKING 2018-05-30 15:02:40.177 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Speaker,name=SetVolume,handler=0x1571528,policy=NON_BLOCKING 2018-05-30 15:02:40.178 [ 1] 5 TemplateRuntime:getConfiguration 2018-05-30 15:02:40.178 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=TemplateRuntime,name=RenderPlayerInfo,handler=0x1573a90,policy=HANDLE_IMMEDIATELY 2018-05-30 15:02:40.179 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=TemplateRuntime,name=RenderTemplate,handler=0x1573a90,policy=HANDLE_IMMEDIATELY 2018-05-30 15:02:40.180 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Notifications,name=ClearIndicator,handler=0x1569e1c,policy=HANDLE_IMMEDIATELY 2018-05-30 15:02:40.180 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Notifications,name=SetIndicator,handler=0x1569e1c,policy=HANDLE_IMMEDIATELY 2018-05-30 15:02:40.232 [ 1] 9 SpeakerManager:addSpeakerManagerObserverCalled 2018-05-30 15:02:40.240 [ 1] 9 SpeakerManager:addSpeakerManagerObserver:observer=0x15396b8 2018-05-30 15:02:40.250 [ 1] 5 NotificationsCapabilityAgent:addObserver #################################################

NOTIFICATION INDICATOR STATE: OFF

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

2018-05-30 15:02:40.253 [ 1] 5 TemplateRuntime:addObserver 2018-05-30 15:02:40.254 [ 8] 5 TemplateRuntime:addObserverInExecutor 2018-05-30 15:02:40.715 [ 1] C PortAudioMicrophoneWrapper:Failed to open PortAudio default stream 2018-05-30 15:02:40.720 [ 1] C PortAudioMicrophoneWrapper:Failed to initialize PortAudioMicrophoneWrapper 2018-05-30 15:02:40.730 [ 1] C SampleApplication:Failed to create PortAudioMicrophoneWrapper! 2018-05-30 15:02:40.743 [ 1] 5 DefaultClient:DirectiveSequencerShutdown 2018-05-30 15:02:40.744 [ 1] 9 DirectiveSequencer:doShutdown 2018-05-30 15:02:40.748 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Notifications,name=ClearIndicator,handler=0x1569e1c,policy=HANDLE_IMMEDIATELY 2018-05-30 15:02:40.810 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Notifications,name=SetIndicator,handler=0x1569e1c,policy=HANDLE_IMMEDIATELY 2018-05-30 15:02:40.812 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Speaker,name=AdjustVolume,handler=0x1571528,policy=NON_BLOCKING 2018-05-30 15:02:40.826 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Speaker,name=SetMute,handler=0x1571528,policy=NON_BLOCKING 2018-05-30 15:02:40.828 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Speaker,name=SetVolume,handler=0x1571528,policy=NON_BLOCKING 2018-05-30 15:02:40.830 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=System,name=SetEndpoint,handler=0x1554cf8,policy=NON_BLOCKING 2018-05-30 15:02:40.840 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alerts,name=DeleteAlert,handler=0x1565108,policy=NON_BLOCKING 2018-05-30 15:02:40.840 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alerts,name=SetAlert,handler=0x1565108,policy=NON_BLOCKING 2018-05-30 15:02:40.841 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=SpeechRecognizer,name=ExpectSpeech,handler=0x1559c90,policy=NON_BLOCKING 2018-05-30 15:02:40.842 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=SpeechRecognizer,name=StopCapture,handler=0x1559c90,policy=NON_BLOCKING 2018-05-30 15:02:40.843 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=ExternalMediaPlayer,name=Play,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.890 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=ExternalMediaPlayer,name=Logout,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.900 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=ExternalMediaPlayer,name=Login,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.900 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.SeekController,name=SetSeekPosition,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.901 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaybackController,name=Play,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.901 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.FavoritesController,name=Unfavorite,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.902 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaylistController,name=EnableShuffle,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.902 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaybackController,name=Pause,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.903 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaybackController,name=Next,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.903 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaybackController,name=Rewind,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.904 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaylistController,name=EnableRepeat,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.904 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaybackController,name=Previous,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.904 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaybackController,name=StartOver,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.920 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaybackController,name=FastForward,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.920 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.FavoritesController,name=Favorite,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.921 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaylistController,name=DisableShuffle,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.921 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaylistController,name=EnableRepeatOne,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.922 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaylistController,name=DisableRepeat,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.922 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.SeekController,name=AdjustSeekPosition,handler=0x1571968,policy=NON_BLOCKING 2018-05-30 15:02:40.923 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=SpeechSynthesizer,name=Speak,handler=0x155a580,policy=BLOCKING 2018-05-30 15:02:40.924 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=AudioPlayer,name=ClearQueue,handler=0x1564238,policy=NON_BLOCKING 2018-05-30 15:02:40.924 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=AudioPlayer,name=Stop,handler=0x1564238,policy=NON_BLOCKING 2018-05-30 15:02:40.926 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=AudioPlayer,name=Play,handler=0x1564238,policy=NON_BLOCKING 2018-05-30 15:02:40.970 [ 1] 5 TemplateRuntime:getConfiguration 2018-05-30 15:02:40.970 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=TemplateRuntime,name=RenderPlayerInfo,handler=0x1573a90,policy=HANDLE_IMMEDIATELY 2018-05-30 15:02:40.980 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=TemplateRuntime,name=RenderTemplate,handler=0x1573a90,policy=HANDLE_IMMEDIATELY 2018-05-30 15:02:40.990 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=System,name=ResetUserInactivity,handler=0x15599f4,policy=NON_BLOCKING 2018-05-30 15:02:40.991 [ 1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x1569e1c 2018-05-30 15:02:40.991 [ 1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x1571528 2018-05-30 15:02:40.991 [ 1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x1554cf8 2018-05-30 15:02:40.992 [ 1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x1565108 2018-05-30 15:02:40.992 [ 1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x1559c90 2018-05-30 15:02:40.994 [ 1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x1571968 2018-05-30 15:02:41.000 [ 1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x155a580 2018-05-30 15:02:41.000 [ 1] 9 SpeechSynthesizer:onDeregistered 2018-05-30 15:02:41.000 [ 1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x1564238 2018-05-30 15:02:41.000 [ 1] 0 AudioPlayer:onDeregistered 2018-05-30 15:02:41.001 [ 9] 1 AudioPlayer:executeStop:playNextItem=false,m_currentActivity=IDLE 2018-05-30 15:02:41.002 [ 1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x1573a90 2018-05-30 15:02:41.002 [ 1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x15599f4 2018-05-30 15:02:41.003 [ 1] 5 DefaultClient:SpeakerManagerShutdown 2018-05-30 15:02:41.020 [ 1] 5 DefaultClient:TemplateRuntimeShutdown 2018-05-30 15:02:41.026 [ 1] 1 AudioPlayer:removeObserver 2018-05-30 15:02:41.034 [ 1] 5 DefaultClient:AIPShutdown 2018-05-30 15:02:41.041 [ 1] 5 DefaultClient:AudioPlayerShutdown 2018-05-30 15:02:41.042 [ 1] 1 AudioPlayer:executeStop:playNextItem=false,m_currentActivity=IDLE 2018-05-30 15:02:41.079 [ 1] 9 MediaPlayer:setObserverCalled 2018-05-30 15:02:41.080 [ 4] 0 MediaPlayer:handleSetObserverCalled 2018-05-30 15:02:41.081 [ 1] 5 ContextManager:setStateProvider:action=removedStateProvider,namespace=AudioPlayer,name=PlaybackState 2018-05-30 15:02:41.090 [ 1] 5 DefaultClient:ExternalMediaPlayerShutdown 2018-05-30 15:02:41.091 [ 1] 5 ContextManager:setStateProvider:action=removedStateProvider,namespace=ExternalMediaPlayer,name=ExternalMediaPlayerState 2018-05-30 15:02:41.091 [ 1] 5 ContextManager:setStateProvider:action=removedStateProvider,namespace=Alexa.PlaybackStateReporter,name=playbackState 2018-05-30 15:02:41.092 [ 1] 5 DefaultClient:SpeechSynthesizerShutdown 2018-05-30 15:02:41.092 [ 1] 9 SpeechSynthesizer:doShutdown 2018-05-30 15:02:41.093 [ 1] 9 MediaPlayer:setObserverCalled 2018-05-30 15:02:41.093 [ 4] 0 MediaPlayer:handleSetObserverCalled 2018-05-30 15:02:41.095 [ 1] 5 DefaultClient:AlertsShutdown 2018-05-30 15:02:41.100 [ 1] 9 AlertsCapabilityAgent:releaseChannel 2018-05-30 15:02:41.102 [ 1] 5 DefaultClient:PlaybackControllerShutdown 2018-05-30 15:02:41.110 [ 1] 5 DefaultClient:MessageRouterShutdown. 2018-05-30 15:02:41.127 [ 1] 5 DefaultClient:ConnectionManagerShutdown. 2018-05-30 15:02:41.128 [ 1] 5 DefaultClient:CertifiedSenderShutdown. 2018-05-30 15:02:41.128 [ 1] 5 DefaultClient:AudioActivityTrackerShutdown. 2018-05-30 15:02:41.150 [ 1] 5 DefaultClient:VisualActivityTrackerShutdown. 2018-05-30 15:02:41.151 [ 1] 5 DefaultClient:PlaybackRouterShutdown. 2018-05-30 15:02:41.151 [ 1] 5 DefaultClient:NotificationsShutdown. 2018-05-30 15:02:41.152 [ 1] 5 NotificationsCapabilityAgent:doShutdown 2018-05-30 15:02:41.152 [ 6] 5 NotificationsCapabilityAgent:executeShutdown:currentState=IDLE 2018-05-30 15:02:41.159 [ 6] 5 NotificationsCapabilityAgent:executeSetState:previousState=IDLE,newState=SHUTDOWN 2018-05-30 15:02:41.161 [ 1] 5 ContextManager:setStateProvider:action=removedStateProvider,namespace=Notifications,name=IndicatorState 2018-05-30 15:02:41.162 [ 1] 5 DefaultClient:UserInactivityMonitorShutdown. 2018-05-30 15:02:41.195 [ a] 9 CertifiedSender:CertifiedSender worker thread done. exiting mainloop. 2018-05-30 15:02:41.198 [ 1] 5 InternetConnectionMonitor:stopMonitoring 2018-05-30 15:02:41.233 [ 1] C SampleApplication:Failed to initialize SampleApplication 2018-05-30 15:02:41.261 [ 1] 5 CBLAuthDelegate:removeAuthObserver:observer=0x154e54c 2018-05-30 15:02:41.310 [ 1] 9 MediaPlayer:~MediaPlayerCalled 2018-05-30 15:02:41.312 [ 1] 9 MediaPlayer:resetPipeline 2018-05-30 15:02:41.314 [ 1] 5 CBLAuthDelegate:stop 2018-05-30 15:02:41.437 [ 2] 5 HttpPost:doPostSucceeded:code=200 2018-05-30 15:02:41.438 [ 2] 5 CBLAuthDelegate:receiveCodePairResponse:code=200 2018-05-30 15:02:41.438 [ 2] 5 CBLAuthDelegate:mapHTTPStatusToError:code=200,error=SUCCESS 2018-05-30 15:02:41.439 [ 2] 5 CBLAuthDelegate:setAuthError:authError=SUCCESS ##################################

NOT YET AUTHORIZED

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

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

To authorize, browse to: 'https://amazon.com/us/code' and enter the code: {XXXXX}

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

2018-05-30 15:02:41.531 [ 1] 5 SQLiteCBLAuthDelegateStorage:~SQLiteCBLAuthDelegateStorage 2018-05-30 15:02:41.543 [ 1] 5 SQLiteCBLAuthDelegateStorage:close 2018-05-30 15:02:41.544 [ 1] 9 MediaPlayer:~MediaPlayerCalled 2018-05-30 15:02:41.551 [ 1] 9 MediaPlayer:resetPipeline 2018-05-30 15:02:41.560 [ 1] 9 MediaPlayer:~MediaPlayerCalled 2018-05-30 15:02:41.561 [ 1] 9 MediaPlayer:resetPipeline 2018-05-30 15:02:41.562 [ 1] 9 MediaPlayer:~MediaPlayerCalled 2018-05-30 15:02:41.569 [ 1] 9 MediaPlayer:resetPipeline 2018-05-30 15:02:41.574 [ 1] 9 MediaPlayer:~MediaPlayerCalled 2018-05-30 15:02:41.576 [ 1] 9 MediaPlayer:resetPipeline 2018-05-30 15:02:41.580 [ 1] 9 MediaPlayer:~MediaPlayerCalled 2018-05-30 15:02:41.591 [ 1] 9 MediaPlayer:resetPipeline Failed to create to SampleApplication! pi@raspberrypi:~ $

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.7.1>

Tell us what hardware you're using:

Tell us about your OS (Type & version):

visayamv commented 6 years ago

@ukdesignservices, it seems that the portaudio library was not properly installed:

2018-05-30 15:02:40.715 [ 1] C PortAudioMicrophoneWrapper:Failed to open PortAudio default stream 2018-05-30 15:02:40.720 [ 1] C PortAudioMicrophoneWrapper:Failed to initialize PortAudioMicrophoneWrapper 2018-05-30 15:02:40.730 [ 1] C SampleApplication:Failed to create PortAudioMicrophoneWrapper!

Please reference the guide to check your microphone setting https://github.com/alexa/avs-device-sdk/wiki/Raspberry-Pi-Quick-Start-Guide

ukdesignservices commented 6 years ago

Thanks for the quick reply. Just to confirm, I was following this guide:

https://github.com/alexa/avs-device-sdk/wiki/Raspberry-Pi-Quick-Start-Guide-with-Script

Should I re-flash and follow this instead? :

https://github.com/alexa/avs-device-sdk/wiki/Raspberry-Pi-Quick-Start-Guide

As it looks like the install directories are different (~/home/pi/ vs ~/home/pi/sdk-folder/).

Thanks in advance.

visayamv commented 6 years ago

@ukdesignservices , can you please try the one without the script? https://github.com/alexa/avs-device-sdk/wiki/Raspberry-Pi-Quick-Start-Guide

please do a clean reflash before doing it again. thanks!

ukdesignservices commented 6 years ago

Hi again. I've run through the install using the guide you suggested. Everything fine up to the 'Run and Authorize' step, at which point the start command:

./SampleApp/src/SampleApp ./Integration/AlexaClientSDKConfig.json

fails with the following:

USAGE: ./SampleApp/src/SampleApp [log_level]

I've also tried running it with the inputs folder parameter:

./SampleApp/src/SampleApp ./Integration/AlexaClientSDKConfig.json /home/pi/sdk-folder/third-party/alexa-rpi/models

This fails with the following:

2018-06-04 11:33:19.699 [ 1] I sdkVersion: 1.7.1 configFile ./Integration/AlexaClientSDKConfig.json #################################################

NOTIFICATION INDICATOR STATE: OFF

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

ALSA lib confmisc.c:1281:(snd_func_refer) Unable to find definition 'cards.bcm2835_alsa.pcm.front.0:CARD=0' ALSA lib conf.c:4528:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory ALSA lib conf.c:5007:(snd_config_expand) Evaluate error: No such file or directory ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM front ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.rear ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.center_lfe ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.side ALSA lib confmisc.c:1281:(snd_func_refer) Unable to find definition 'cards.bcm2835_alsa.pcm.surround51.0:CARD=0' ALSA lib conf.c:4528:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory ALSA lib conf.c:5007:(snd_config_expand) Evaluate error: No such file or directory ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM surround21 ALSA lib confmisc.c:1281:(snd_func_refer) Unable to find definition 'cards.bcm2835_alsa.pcm.surround51.0:CARD=0' ALSA lib conf.c:4528:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory ALSA lib conf.c:5007:(snd_config_expand) Evaluate error: No such file or directory ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM surround21 ALSA lib confmisc.c:1281:(snd_func_refer) Unable to find definition 'cards.bcm2835_alsa.pcm.surround40.0:CARD=0' ALSA lib conf.c:4528:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory ALSA lib conf.c:5007:(snd_config_expand) Evaluate error: No such file or directory ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM surround40 ALSA lib confmisc.c:1281:(snd_func_refer) Unable to find definition 'cards.bcm2835_alsa.pcm.surround51.0:CARD=0' ALSA lib conf.c:4528:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory ALSA lib conf.c:5007:(snd_config_expand) Evaluate error: No such file or directory ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM surround41 ALSA lib confmisc.c:1281:(snd_func_refer) Unable to find definition 'cards.bcm2835_alsa.pcm.surround51.0:CARD=0' ALSA lib conf.c:4528:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory ALSA lib conf.c:5007:(snd_config_expand) Evaluate error: No such file or directory ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM surround50 ALSA lib confmisc.c:1281:(snd_func_refer) Unable to find definition 'cards.bcm2835_alsa.pcm.surround51.0:CARD=0' ALSA lib conf.c:4528:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory ALSA lib conf.c:5007:(snd_config_expand) Evaluate error: No such file or directory ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM surround51 ALSA lib confmisc.c:1281:(snd_func_refer) Unable to find definition 'cards.bcm2835_alsa.pcm.surround71.0:CARD=0' ALSA lib conf.c:4528:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory ALSA lib conf.c:5007:(snd_config_expand) Evaluate error: No such file or directory ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM surround71 ALSA lib confmisc.c:1281:(snd_func_refer) Unable to find definition 'cards.bcm2835_alsa.pcm.iec958.0:CARD=0,AES0=4,AES1=130,AES2=0,AES3=2' ALSA lib conf.c:4528:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory ALSA lib conf.c:5007:(snd_config_expand) Evaluate error: No such file or directory ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM iec958 ALSA lib confmisc.c:1281:(snd_func_refer) Unable to find definition 'cards.bcm2835_alsa.pcm.iec958.0:CARD=0,AES0=4,AES1=130,AES2=0,AES3=2' ALSA lib conf.c:4528:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory ALSA lib conf.c:5007:(snd_config_expand) Evaluate error: No such file or directory ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM spdif ALSA lib confmisc.c:1281:(snd_func_refer) Unable to find definition 'cards.bcm2835_alsa.pcm.iec958.0:CARD=0,AES0=4,AES1=130,AES2=0,AES3=2' ALSA lib conf.c:4528:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory ALSA lib conf.c:5007:(snd_config_expand) Evaluate error: No such file or directory ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM spdif ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.hdmi ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.hdmi ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.modem ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.modem ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.phoneline ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM cards.pcm.phoneline ALSA lib confmisc.c:1281:(snd_func_refer) Unable to find definition 'defaults.bluealsa.device' ALSA lib conf.c:4528:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory ALSA lib conf.c:4996:(snd_config_expand) Args evaluate error: No such file or directory ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM bluealsa ALSA lib confmisc.c:1281:(snd_func_refer) Unable to find definition 'defaults.bluealsa.device' ALSA lib conf.c:4528:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory ALSA lib conf.c:4996:(snd_config_expand) Args evaluate error: No such file or directory ALSA lib pcm.c:2495:(snd_pcm_open_noupdate) Unknown PCM bluealsa Illegal instruction pi@raspberrypi:~/sdk-folder/sdk-build $

Any ideas how to fix this? I followed the guide to the letter.

Thanks in advance.

kencecka commented 6 years ago

Hi @ukdesignservices,

I was reviewing the history on this issue and I'd like to verify what hardware revision you are trying to install on. Is this a Pi Zero? Per https://github.com/alexa/avs-device-sdk/wiki/Raspberry-Pi-Quick-Start-Guide-with-Script, a Pi 2 or Pi 3 are required. That "illegal instruction" error you see at the end of the last post is likely related to instructions which do not work on a Pi Zero.

Ken

ukdesignservices commented 6 years ago

Hi, thanks for getting back to me. Yes, this is on a Pi Zero. Is there any version that is compatible with the Zero? I believe this version did: https://github.com/alexa/alexa-avs-sample-app/wiki/Raspberry-Pi but has now been discontinued.

Many thanks

kencecka commented 6 years ago

Hi @ukdesignservices,

Unfortunately, we do not have any SDK releases which support the Pi Zero. The Java sample app you reference above may have in older releases, but is also currently only supporting Pi 2 and Pi 3. Your best bet at this point would be to upgrade to supported hardware.

Ken

ukdesignservices commented 6 years ago

Okay. Thank you for your help.

Amal-AG commented 5 years ago

THIS IS WHAT HAPPENS WITH ME PLEASE HELP ,Thanks in advance.

pi@raspberrypi:~ $ cd /home/pi/ pi@raspberrypi:~ $ sudo bash startsample.sh 2018-12-14 22:42:47.035 [ 1] I sdkVersion: 1.10.0 configFile /home/pi/build/Integration/AlexaClientSDKConfig.json Running app with log level: DEBUG9 2018-12-14 22:42:47.069 [ 1] 0 ConfigurationNode:initializeSuccess 2018-12-14 22:42:47.095 [ 1] 1 InMemoryEqualizerConfiguration:validateConfiguration::Validating Equalizer configuration 2018-12-14 22:42:47.095 [ 1] 1 InMemoryEqualizerConfiguration:validateConfiguration::Validating default Equalizer state 2018-12-14 22:42:47.097 [ 1] 1 InMemoryEqualizerConfiguration:validateConfiguration::Validating Equalizer configuration 2018-12-14 22:42:47.097 [ 1] 1 InMemoryEqualizerConfiguration:validateConfiguration::Validating default Equalizer state 2018-12-14 22:42:47.102 [ 1] 9 MediaPlayer:createCalled 2018-12-14 22:42:47.294 [ 1] 9 MediaPlayer:noOutputConversion 2018-12-14 22:42:47.299 [ 1] 9 MediaPlayer:createCalled 2018-12-14 22:42:47.305 [ 1] 9 MediaPlayer:noOutputConversion 2018-12-14 22:42:47.310 [ 1] 9 MediaPlayer:createCalled 2018-12-14 22:42:47.311 [ 1] 9 MediaPlayer:noOutputConversion 2018-12-14 22:42:47.316 [ 1] 9 MediaPlayer:createCalled 2018-12-14 22:42:47.317 [ 1] 9 MediaPlayer:noOutputConversion 2018-12-14 22:42:47.321 [ 1] 9 MediaPlayer:createCalled 2018-12-14 22:42:47.323 [ 1] 9 MediaPlayer:noOutputConversion 2018-12-14 22:42:47.327 [ 1] 9 MediaPlayer:createCalled 2018-12-14 22:42:47.328 [ 1] 9 MediaPlayer:noOutputConversion 2018-12-14 22:42:47.335 [ 1] 5 SQLiteBluetoothStorage:create 2018-12-14 22:42:47.338 [ 1] 5 CBLAuthDelegate:create 2018-12-14 22:42:47.340 [ 1] 5 CBLAuthDelegate:CBLAuthDelegate 2018-12-14 22:42:47.340 [ 1] 5 CBLAuthDelegate:init 2018-12-14 22:42:47.340 [ 1] 5 CBLAuthDelegateConfiguration:create 2018-12-14 22:42:47.341 [ 1] 5 CBLAuthDelegateConfiguration:init 2018-12-14 22:42:47.341 [ 1] 5 CBLAuthDelegateConfiguration:initScopeData 2018-12-14 22:42:47.341 [ 1] 9 CBLAuthDelegateConfiguration:initScopeDataSucceeded 2018-12-14 22:42:47.341 [ 1] 5 SQLiteCBLAuthDelegateStorage:open 2018-12-14 22:42:47.344 [ 2] 5 CBLAuthDelegate:handleAuthorizationFlow 2018-12-14 22:42:47.345 [ 2] 5 CBLAuthDelegate:handleStarting 2018-12-14 22:42:47.345 [ 2] 5 SQLiteCBLAuthDelegateStorage:getRefreshToken 2018-12-14 22:42:47.346 [ 2] 0 SQLiteCBLAuthDelegateStorage:getRefreshTokenFailed:reason=stepResultWasNotRow 2018-12-14 22:42:47.346 [ 2] 0 CBLAuthDelegate:getRefreshTokenFailed 2018-12-14 22:42:47.346 [ 2] 5 CBLAuthDelegate:handleRequestingCodePair 2018-12-14 22:42:47.346 [ 2] 5 CBLAuthDelegate:requestCodePair 2018-12-14 22:42:47.346 [ 1] 5 CBLAuthDelegate:addAuthObserver:observer=0x2269dec 2018-12-14 22:42:47.347 [ 1] 5 CBLAuthDelegate:addAuthObserver:observer=0x2254c00 2018-12-14 22:42:47.348 [ 1] 5 CapabilitiesDelegate:addCapabilitiesObserver:observer=0x2254c04 2018-12-14 22:42:47.353 [ 1] 5 InternetConnectionMonitor:startMonitoring 2018-12-14 22:42:47.357 [ 3] 5 InternetConnectionMonitor:testConnection 2018-12-14 22:42:47.392 [ 1] 9 MediaPlayer:setObserverCalled 2018-12-14 22:42:47.393 [ 4] 0 MediaPlayer:handleSetObserverCalled 2018-12-14 22:42:47.395 [ 1] 9 SpeechSynthesizer:addObserver:observer=0x226c594 2018-12-14 22:42:47.397 [ 1] 9 PlaybackRouter:create::called 2018-12-14 22:42:47.400 [ 1] 9 MediaPlayer:setObserverCalled 2018-12-14 22:42:47.406 [ 5] 0 MediaPlayer:handleSetObserverCalled 2018-12-14 22:42:47.408 [ 1] 9 MediaPlayer:getSpeakerTypeCalled 2018-12-14 22:42:47.409 [ 1] 9 MediaPlayer:getSpeakerTypeCalled 2018-12-14 22:42:47.409 [ 1] 9 MediaPlayer:getSpeakerTypeCalled 2018-12-14 22:42:47.409 [ 1] 9 MediaPlayer:getSpeakerTypeCalled 2018-12-14 22:42:47.409 [ 1] 9 MediaPlayer:getSpeakerTypeCalled 2018-12-14 22:42:47.409 [ 1] 9 MediaPlayer:getSpeakerTypeCalled 2018-12-14 22:42:47.410 [ 1] 0 SpeakerManager:mapCreated:numSpeakerVolume=5,numAlertsVolume=1 2018-12-14 22:42:47.410 [ 1] 9 MediaPlayer:getSpeakerSettingsCalled 2018-12-14 22:42:47.410 [ 4] 9 MediaPlayer:handleGetSpeakerSettingsCalled 2018-12-14 22:42:47.411 [ 1] 9 MediaPlayer:getSpeakerSettingsCalled 2018-12-14 22:42:47.411 [ 5] 9 MediaPlayer:handleGetSpeakerSettingsCalled 2018-12-14 22:42:47.412 [ 1] 9 MediaPlayer:getSpeakerSettingsCalled 2018-12-14 22:42:47.412 [ 6] 9 MediaPlayer:handleGetSpeakerSettingsCalled 2018-12-14 22:42:47.412 [ 1] 9 MediaPlayer:getSpeakerSettingsCalled 2018-12-14 22:42:47.412 [ 7] 9 MediaPlayer:handleGetSpeakerSettingsCalled 2018-12-14 22:42:47.412 [ 1] 9 MediaPlayer:getSpeakerSettingsCalled 2018-12-14 22:42:47.412 [ 8] 9 MediaPlayer:handleGetSpeakerSettingsCalled 2018-12-14 22:42:47.413 [ 1] 9 SpeakerManager:validateSpeakerSettingsConsistencyResult:consistent=true 2018-12-14 22:42:47.413 [ 1] 9 SpeakerManager:validateSpeakerSettings:volume=100,mute=false 2018-12-14 22:42:47.413 [ 1] 9 SpeakerManager:updateContextManagerCalled:speakerType=AVS_SPEAKER_VOLUME 2018-12-14 22:42:47.415 [ 1] 9 MediaPlayer:setObserverCalled 2018-12-14 22:42:47.415 [ 9] 0 MediaPlayer:handleSetObserverCalled 2018-12-14 22:42:47.422 [ 1] 9 AlertScheduler:setTimerForNextAlertLocked 2018-12-14 22:42:47.422 [ 1] 9 AlertScheduler:executeScheduleNextAlertForRendering::no work to do. 2018-12-14 22:42:47.422 [ 1] 9 SpeakerManager:getSpeakerSettingsCalled 2018-12-14 22:42:47.424 [ a] 9 SpeakerManager:executeGetSpeakerSettingsCalled 2018-12-14 22:42:47.424 [ a] 9 MediaPlayer:getSpeakerSettingsCalled 2018-12-14 22:42:47.425 [ 9] 9 MediaPlayer:handleGetSpeakerSettingsCalled 2018-12-14 22:42:47.425 [ a] 9 SpeakerManager:validateSpeakerSettingsConsistencyResult:consistent=true 2018-12-14 22:42:47.425 [ a] 9 SpeakerManager:validateSpeakerSettings:volume=100,mute=false 2018-12-14 22:42:47.429 [ 1] 9 SpeakerManager:addSpeakerManagerObserverCalled 2018-12-14 22:42:47.429 [ 1] 9 SpeakerManager:addSpeakerManagerObserver:observer=0x2275c54 2018-12-14 22:42:47.430 [ 1] 5 NotificationsRenderer:create 2018-12-14 22:42:47.431 [ b] 1 AlertsCapabilityAgent:executeOnConnectionStatusChanged:status=DISCONNECTED,reason=ACL_CLIENT_REQUEST 2018-12-14 22:42:47.432 [ 1] 9 MediaPlayer:setObserverCalled 2018-12-14 22:42:47.432 [ 6] 0 MediaPlayer:handleSetObserverCalled 2018-12-14 22:42:47.435 [ 1] 5 NotificationsCapabilityAgent:init 2018-12-14 22:42:47.435 [ 1] 5 NotificationsRenderer:addObserver 2018-12-14 22:42:47.441 [ c] 5 NotificationsCapabilityAgent:executeInit 2018-12-14 22:42:47.441 [ 1] 5 InteractionModel:InteractionModelCapabilityAgent 2018-12-14 22:42:47.442 [ c] 5 NotificationsCapabilityAgent:notifyObservers:indicatorState=0 2018-12-14 22:42:47.442 [ c] 5 NotificationsCapabilityAgent:executeProvideState:sendToken=false,stateRequestToken=0 2018-12-14 22:42:47.444 [ c] 9 ContextManager:updateStateLocked:action=updatedState,namespace=Notifications,name=IndicatorState 2018-12-14 22:42:47.455 [ 1] 0 ExternalMediaPlayer:createAdapters 2018-12-14 22:42:47.461 [ 1] 1 AudioPlayer:addObserver 2018-12-14 22:42:47.462 [ d] 5 TemplateRuntime:onDialogUXStateChanged:state=IDLE 2018-12-14 22:42:47.473 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=SpeechSynthesizer,name=Speak,handler=0x22736a0,policy=BLOCKING 2018-12-14 22:42:47.474 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=AudioPlayer,name=ClearQueue,handler=0x22746b8,policy=NON_BLOCKING 2018-12-14 22:42:47.474 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=AudioPlayer,name=Stop,handler=0x22746b8,policy=NON_BLOCKING 2018-12-14 22:42:47.474 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=AudioPlayer,name=Play,handler=0x22746b8,policy=NON_BLOCKING 2018-12-14 22:42:47.475 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=ExternalMediaPlayer,name=Play,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.475 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=ExternalMediaPlayer,name=Logout,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.475 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=ExternalMediaPlayer,name=Login,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.476 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.SeekController,name=SetSeekPosition,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.476 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=Play,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.476 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.FavoritesController,name=Unfavorite,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.476 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaylistController,name=EnableShuffle,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.476 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=Pause,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.476 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=Next,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.476 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=Rewind,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.476 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaylistController,name=EnableRepeat,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.477 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=Previous,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.477 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=StartOver,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.477 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=FastForward,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.477 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.FavoritesController,name=Favorite,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.477 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaylistController,name=DisableShuffle,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.477 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaylistController,name=EnableRepeatOne,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.477 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaylistController,name=DisableRepeat,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.477 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.SeekController,name=AdjustSeekPosition,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.478 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=SpeechRecognizer,name=SetEndOfSpeechOffset,handler=0x2272978,policy=NON_BLOCKING 2018-12-14 22:42:47.478 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=SpeechRecognizer,name=ExpectSpeech,handler=0x2272978,policy=NON_BLOCKING 2018-12-14 22:42:47.478 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=SpeechRecognizer,name=StopCapture,handler=0x2272978,policy=NON_BLOCKING 2018-12-14 22:42:47.478 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alerts,name=AdjustVolume,handler=0x2275be8,policy=NON_BLOCKING 2018-12-14 22:42:47.479 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alerts,name=SetAlert,handler=0x2275be8,policy=NON_BLOCKING 2018-12-14 22:42:47.479 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alerts,name=DeleteAlerts,handler=0x2275be8,policy=NON_BLOCKING 2018-12-14 22:42:47.479 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alerts,name=DeleteAlert,handler=0x2275be8,policy=NON_BLOCKING 2018-12-14 22:42:47.479 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alerts,name=SetVolume,handler=0x2275be8,policy=NON_BLOCKING 2018-12-14 22:42:47.479 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=System,name=SetEndpoint,handler=0x2286d58,policy=NON_BLOCKING 2018-12-14 22:42:47.479 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=System,name=ResetUserInactivity,handler=0x22726d4,policy=NON_BLOCKING 2018-12-14 22:42:47.480 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Speaker,name=AdjustVolume,handler=0x2275088,policy=NON_BLOCKING 2018-12-14 22:42:47.480 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Speaker,name=SetMute,handler=0x2275088,policy=NON_BLOCKING 2018-12-14 22:42:47.480 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Speaker,name=SetVolume,handler=0x2275088,policy=NON_BLOCKING 2018-12-14 22:42:47.480 [ 1] 5 TemplateRuntime:getConfiguration 2018-12-14 22:42:47.480 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=TemplateRuntime,name=RenderPlayerInfo,handler=0x2285e08,policy=HANDLE_IMMEDIATELY 2018-12-14 22:42:47.480 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=TemplateRuntime,name=RenderTemplate,handler=0x2285e08,policy=HANDLE_IMMEDIATELY 2018-12-14 22:42:47.481 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Notifications,name=ClearIndicator,handler=0x227ba04,policy=HANDLE_IMMEDIATELY 2018-12-14 22:42:47.481 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Notifications,name=SetIndicator,handler=0x227ba04,policy=HANDLE_IMMEDIATELY 2018-12-14 22:42:47.481 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=InteractionModel,name=NewDialogRequest,handler=0x22808e0,policy=HANDLE_IMMEDIATELY 2018-12-14 22:42:47.481 [ 1] 5 EqualizerController:getConfiguration 2018-12-14 22:42:47.481 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=EqualizerController,name=AdjustBands,handler=0x22877ec,policy=NON_BLOCKING 2018-12-14 22:42:47.482 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=EqualizerController,name=SetMode,handler=0x22877ec,policy=NON_BLOCKING 2018-12-14 22:42:47.482 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=EqualizerController,name=ResetBands,handler=0x22877ec,policy=NON_BLOCKING 2018-12-14 22:42:47.482 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=EqualizerController,name=SetBands,handler=0x22877ec,policy=NON_BLOCKING 2018-12-14 22:42:47.489 [ 1] 9 SpeakerManager:addSpeakerManagerObserverCalled 2018-12-14 22:42:47.489 [ 1] 9 SpeakerManager:addSpeakerManagerObserver:observer=0x2254c10 2018-12-14 22:42:47.490 [ 1] 5 NotificationsCapabilityAgent:addObserver #################################################

NOTIFICATION INDICATOR STATE: OFF

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

2018-12-14 22:42:47.493 [ 1] 5 TemplateRuntime:addObserver 2018-12-14 22:42:47.494 [ e] 5 TemplateRuntime:addObserverInExecutor 2018-12-14 22:42:47.562 [ 1] C PortAudioMicrophoneWrapper:Failed to open PortAudio default stream:errorCode=-9985 2018-12-14 22:42:47.562 [ 1] C PortAudioMicrophoneWrapper:Failed to initialize PortAudioMicrophoneWrapper 2018-12-14 22:42:47.563 [ 1] C SampleApplication:Failed to create PortAudioMicrophoneWrapper! 2018-12-14 22:42:47.564 [ 1] 5 DefaultClient:DirectiveSequencerShutdown 2018-12-14 22:42:47.564 [ 1] 9 DirectiveSequencer:doShutdown 2018-12-14 22:42:47.565 [ 1] 5 EqualizerController:getConfiguration 2018-12-14 22:42:47.566 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=EqualizerController,name=AdjustBands,handler=0x22877ec,policy=NON_BLOCKING 2018-12-14 22:42:47.566 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=EqualizerController,name=SetMode,handler=0x22877ec,policy=NON_BLOCKING 2018-12-14 22:42:47.566 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=EqualizerController,name=ResetBands,handler=0x22877ec,policy=NON_BLOCKING 2018-12-14 22:42:47.566 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=EqualizerController,name=SetBands,handler=0x22877ec,policy=NON_BLOCKING 2018-12-14 22:42:47.567 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=InteractionModel,name=NewDialogRequest,handler=0x22808e0,policy=HANDLE_IMMEDIATELY 2018-12-14 22:42:47.567 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Notifications,name=ClearIndicator,handler=0x227ba04,policy=HANDLE_IMMEDIATELY 2018-12-14 22:42:47.567 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Notifications,name=SetIndicator,handler=0x227ba04,policy=HANDLE_IMMEDIATELY 2018-12-14 22:42:47.568 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Speaker,name=AdjustVolume,handler=0x2275088,policy=NON_BLOCKING 2018-12-14 22:42:47.568 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Speaker,name=SetMute,handler=0x2275088,policy=NON_BLOCKING 2018-12-14 22:42:47.568 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Speaker,name=SetVolume,handler=0x2275088,policy=NON_BLOCKING 2018-12-14 22:42:47.568 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=System,name=SetEndpoint,handler=0x2286d58,policy=NON_BLOCKING 2018-12-14 22:42:47.568 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alerts,name=AdjustVolume,handler=0x2275be8,policy=NON_BLOCKING 2018-12-14 22:42:47.568 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alerts,name=SetAlert,handler=0x2275be8,policy=NON_BLOCKING 2018-12-14 22:42:47.569 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alerts,name=DeleteAlerts,handler=0x2275be8,policy=NON_BLOCKING 2018-12-14 22:42:47.569 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alerts,name=DeleteAlert,handler=0x2275be8,policy=NON_BLOCKING 2018-12-14 22:42:47.569 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alerts,name=SetVolume,handler=0x2275be8,policy=NON_BLOCKING 2018-12-14 22:42:47.569 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=SpeechRecognizer,name=SetEndOfSpeechOffset,handler=0x2272978,policy=NON_BLOCKING 2018-12-14 22:42:47.569 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=SpeechRecognizer,name=ExpectSpeech,handler=0x2272978,policy=NON_BLOCKING 2018-12-14 22:42:47.569 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=SpeechRecognizer,name=StopCapture,handler=0x2272978,policy=NON_BLOCKING 2018-12-14 22:42:47.570 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=ExternalMediaPlayer,name=Play,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.570 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=ExternalMediaPlayer,name=Logout,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.570 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=ExternalMediaPlayer,name=Login,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.570 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.SeekController,name=SetSeekPosition,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.570 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaybackController,name=Play,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.570 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.FavoritesController,name=Unfavorite,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.570 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaylistController,name=EnableShuffle,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.571 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaybackController,name=Pause,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.571 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaybackController,name=Next,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.571 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaybackController,name=Rewind,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.571 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaylistController,name=EnableRepeat,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.571 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaybackController,name=Previous,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.571 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaybackController,name=StartOver,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.571 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaybackController,name=FastForward,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.571 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.FavoritesController,name=Favorite,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.572 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaylistController,name=DisableShuffle,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.572 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaylistController,name=EnableRepeatOne,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.572 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.PlaylistController,name=DisableRepeat,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.572 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alexa.SeekController,name=AdjustSeekPosition,handler=0x2283db8,policy=NON_BLOCKING 2018-12-14 22:42:47.572 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=SpeechSynthesizer,name=Speak,handler=0x22736a0,policy=BLOCKING 2018-12-14 22:42:47.572 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=AudioPlayer,name=ClearQueue,handler=0x22746b8,policy=NON_BLOCKING 2018-12-14 22:42:47.573 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=AudioPlayer,name=Stop,handler=0x22746b8,policy=NON_BLOCKING 2018-12-14 22:42:47.573 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=AudioPlayer,name=Play,handler=0x22746b8,policy=NON_BLOCKING 2018-12-14 22:42:47.573 [ 1] 5 TemplateRuntime:getConfiguration 2018-12-14 22:42:47.573 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=TemplateRuntime,name=RenderPlayerInfo,handler=0x2285e08,policy=HANDLE_IMMEDIATELY 2018-12-14 22:42:47.573 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=TemplateRuntime,name=RenderTemplate,handler=0x2285e08,policy=HANDLE_IMMEDIATELY 2018-12-14 22:42:47.573 [ 1] 9 DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=System,name=ResetUserInactivity,handler=0x22726d4,policy=NON_BLOCKING 2018-12-14 22:42:47.573 [ 1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x22877ec 2018-12-14 22:42:47.574 [ 1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x22808e0 2018-12-14 22:42:47.574 [ 1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x227ba04 2018-12-14 22:42:47.574 [ 1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x2275088 2018-12-14 22:42:47.574 [ 1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x2286d58 2018-12-14 22:42:47.574 [ 1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x2275be8 2018-12-14 22:42:47.574 [ 1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x2272978 2018-12-14 22:42:47.574 [ 1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x2283db8 2018-12-14 22:42:47.574 [ 1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x22736a0 2018-12-14 22:42:47.574 [ 1] 9 SpeechSynthesizer:onDeregistered 2018-12-14 22:42:47.574 [ 1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x22746b8 2018-12-14 22:42:47.574 [ 1] 0 AudioPlayer:onDeregistered 2018-12-14 22:42:47.575 [ 1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x2285e08 2018-12-14 22:42:47.575 [ 1] 9 DirectiveRouter:onDeregisteredCalled:handler=0x22726d4 2018-12-14 22:42:47.575 [ 1] 5 DefaultClient:SpeakerManagerShutdown 2018-12-14 22:42:47.575 [ f] 1 AudioPlayer:executeStop:playNextItem=false,m_currentActivity=IDLE 2018-12-14 22:42:47.576 [ 1] 5 DefaultClient:TemplateRuntimeShutdown 2018-12-14 22:42:47.577 [ 1] 1 AudioPlayer:removeObserver 2018-12-14 22:42:47.577 [ 1] 5 DefaultClient:AIPShutdown 2018-12-14 22:42:47.579 [ 1] 5 DefaultClient:AudioPlayerShutdown 2018-12-14 22:42:47.579 [ 1] 5 ProgressTimer:stop 2018-12-14 22:42:47.579 [ 1] 1 AudioPlayer:executeStop:playNextItem=false,m_currentActivity=IDLE 2018-12-14 22:42:47.579 [ 1] 9 MediaPlayer:setObserverCalled 2018-12-14 22:42:47.581 [ 5] 0 MediaPlayer:handleSetObserverCalled 2018-12-14 22:42:47.581 [ 1] 5 ContextManager:setStateProvider:action=removedStateProvider,namespace=AudioPlayer,name=PlaybackState 2018-12-14 22:42:47.581 [ 1] 5 DefaultClient:ExternalMediaPlayerShutdown 2018-12-14 22:42:47.582 [ 1] 5 ContextManager:setStateProvider:action=removedStateProvider,namespace=ExternalMediaPlayer,name=ExternalMediaPlayerState 2018-12-14 22:42:47.582 [ 1] 5 ContextManager:setStateProvider:action=removedStateProvider,namespace=Alexa.PlaybackStateReporter,name=playbackState 2018-12-14 22:42:47.582 [ 1] 5 DefaultClient:SpeechSynthesizerShutdown 2018-12-14 22:42:47.582 [ 1] 9 SpeechSynthesizer:doShutdown 2018-12-14 22:42:47.582 [ 1] 9 MediaPlayer:setObserverCalled 2018-12-14 22:42:47.583 [ 4] 0 MediaPlayer:handleSetObserverCalled 2018-12-14 22:42:47.583 [ 1] 5 DefaultClient:AlertsShutdown 2018-12-14 22:42:47.584 [ 1] 9 AlertsCapabilityAgent:releaseChannel 2018-12-14 22:42:47.585 [ 1] 5 DefaultClient:PlaybackControllerShutdown 2018-12-14 22:42:47.587 [ 1] 5 DefaultClient:MessageRouterShutdown. 2018-12-14 22:42:47.588 [ 1] 5 DefaultClient:ConnectionManagerShutdown. 2018-12-14 22:42:47.589 [ 1] 5 DefaultClient:CertifiedSenderShutdown. 2018-12-14 22:42:47.589 [ 1] 5 DefaultClient:AudioActivityTrackerShutdown. 2018-12-14 22:42:47.590 [ 1] 5 DefaultClient:VisualActivityTrackerShutdown. 2018-12-14 22:42:47.590 [ 1] 5 DefaultClient:PlaybackRouterShutdown. 2018-12-14 22:42:47.590 [ 1] 5 DefaultClient:NotificationsShutdown. 2018-12-14 22:42:47.590 [ 1] 5 NotificationsCapabilityAgent:doShutdown 2018-12-14 22:42:47.590 [ c] 5 NotificationsCapabilityAgent:executeShutdown:currentState=IDLE 2018-12-14 22:42:47.591 [ c] 5 NotificationsCapabilityAgent:executeSetState:previousState=IDLE,newState=SHUTDOWN 2018-12-14 22:42:47.591 [ 1] 5 ContextManager:setStateProvider:action=removedStateProvider,namespace=Notifications,name=IndicatorState 2018-12-14 22:42:47.592 [ 1] 5 DefaultClient:UserInactivityMonitorShutdown. 2018-12-14 22:42:47.592 [ 1] 5 DefaultClient:EqualizerCapabilityAgentShutdown 2018-12-14 22:42:47.598 [ 1] 5 InteractionModel:~InteractionModelCapabilityAgent 2018-12-14 22:42:47.599 [ 1] 5 ProgressTimer:stop 2018-12-14 22:42:47.600 [ 10] 9 CertifiedSender:CertifiedSender worker thread done. exiting mainloop. 2018-12-14 22:42:47.602 [ 1] 5 InternetConnectionMonitor:stopMonitoring 2018-12-14 22:42:48.097 [ 3] 0 InProcessAttachmentReader:readFailed:reason=SDS is closed 2018-12-14 22:42:48.097 [ 3] 5 InternetConnectionMonitor:updateConnectionStatus:connected=true 2018-12-14 22:42:48.097 [ 3] 5 InternetConnectionMonitor:notifyObserversLocked 2018-12-14 22:42:48.099 [ 3] 9 LibCurlHttpContentFetcher:~LibCurlHttpContentFetcher 2018-12-14 22:42:48.106 [ 1] C SampleApplication:Failed to initialize SampleApplication 2018-12-14 22:42:48.107 [ 1] 5 CBLAuthDelegate:removeAuthObserver:observer=0x2269dec 2018-12-14 22:42:48.111 [ 1] 9 MediaPlayer:~MediaPlayerCalled 2018-12-14 22:42:48.114 [ 1] 9 MediaPlayer:resetPipeline 2018-12-14 22:42:48.116 [ 1] 5 CBLAuthDelegate:stop 2018-12-14 22:42:48.141 [ 2] E HttpPost:doPostFailed:reason=curl_easy_performFailed,result=27,error=Out of memory 2018-12-14 22:42:48.141 [ 2] 5 CBLAuthDelegate:receiveCodePairResponse:code=0 2018-12-14 22:42:48.141 [ 2] 5 CBLAuthDelegate:mapHTTPStatusToError:code=0,error=UNKNOWN_ERROR 2018-12-14 22:42:48.142 [ 2] E CBLAuthDelegate:parseLWAResponseFailed:reason=parseJsonFailed,position=0,error=The document is empty. 2018-12-14 22:42:48.142 [ 2] 5 CBLAuthDelegate:setAuthError:authError=UNKNOWN_ERROR 2018-12-14 22:42:48.142 [ 2] 0 CBLAuthDelegate:receiveCodePairResponseFailed:result=UNKNOWN_ERROR 2018-12-14 22:42:48.144 [ 1] 5 SQLiteCBLAuthDelegateStorage:~SQLiteCBLAuthDelegateStorage 2018-12-14 22:42:48.145 [ 1] 5 SQLiteCBLAuthDelegateStorage:close 2018-12-14 22:42:48.146 [ 1] 9 MediaPlayer:~MediaPlayerCalled 2018-12-14 22:42:48.147 [ 1] 9 MediaPlayer:resetPipeline 2018-12-14 22:42:48.147 [ 1] 9 MediaPlayer:~MediaPlayerCalled 2018-12-14 22:42:48.148 [ 1] 9 MediaPlayer:resetPipeline 2018-12-14 22:42:48.149 [ 1] 9 MediaPlayer:~MediaPlayerCalled 2018-12-14 22:42:48.150 [ 1] 9 MediaPlayer:resetPipeline 2018-12-14 22:42:48.150 [ 1] 9 MediaPlayer:~MediaPlayerCalled 2018-12-14 22:42:48.151 [ 1] 9 MediaPlayer:resetPipeline 2018-12-14 22:42:48.151 [ 1] 9 MediaPlayer:~MediaPlayerCalled 2018-12-14 22:42:48.153 [ 1] 9 MediaPlayer:resetPipeline Failed to create to SampleApplication! pi@raspberrypi:~ $

elnaz-t commented 5 years ago

Hi every body! I have this problem with my AVS , can enyone help me ???

sudo bash startsample.sh 2018-12-15 17:09:52.392 [ 1] I sdkVersion: 1.10.0 configFile /home/pi/build/Integration/AlexaClientSDKConfig.json Running app with log level: DEBUG9 2018-12-15 17:09:52.690 [ 1] 0 ConfigurationNode:initializeSuccess 2018-12-15 17:09:52.795 [ 1] 1 InMemoryEqualizerConfiguration:validateConfiguration::Validating Equalizer configuration 2018-12-15 17:09:52.795 [ 1] 1 InMemoryEqualizerConfiguration:validateConfiguration::Validating default Equalizer state 2018-12-15 17:09:52.796 [ 1] 1 InMemoryEqualizerConfiguration:validateConfiguration::Validating Equalizer configuration 2018-12-15 17:09:52.797 [ 1] 1 InMemoryEqualizerConfiguration:validateConfiguration::Validating default Equalizer state 2018-12-15 17:09:52.804 [ 1] 9 MediaPlayer:createCalled 2018-12-15 17:09:53.140 [ 1] 9 MediaPlayer:noOutputConversion 2018-12-15 17:09:53.145 [ 1] 9 MediaPlayer:createCalled 2018-12-15 17:09:53.154 [ 1] 9 MediaPlayer:noOutputConversion 2018-12-15 17:09:53.160 [ 1] 9 MediaPlayer:createCalled 2018-12-15 17:09:53.161 [ 1] 9 MediaPlayer:noOutputConversion 2018-12-15 17:09:53.165 [ 1] 9 MediaPlayer:createCalled 2018-12-15 17:09:53.166 [ 1] 9 MediaPlayer:noOutputConversion 2018-12-15 17:09:53.171 [ 1] 9 MediaPlayer:createCalled 2018-12-15 17:09:53.172 [ 1] 9 MediaPlayer:noOutputConversion 2018-12-15 17:09:53.178 [ 1] 9 MediaPlayer:createCalled 2018-12-15 17:09:53.179 [ 1] 9 MediaPlayer:noOutputConversion 2018-12-15 17:09:53.187 [ 1] 5 SQLiteBluetoothStorage:create 2018-12-15 17:09:53.190 [ 1] 5 CBLAuthDelegate:create 2018-12-15 17:09:53.192 [ 1] 5 CBLAuthDelegate:CBLAuthDelegate 2018-12-15 17:09:53.192 [ 1] 5 CBLAuthDelegate:init 2018-12-15 17:09:53.193 [ 1] 5 CBLAuthDelegateConfiguration:create 2018-12-15 17:09:53.193 [ 1] 5 CBLAuthDelegateConfiguration:init 2018-12-15 17:09:53.193 [ 1] 5 CBLAuthDelegateConfiguration:initScopeData 2018-12-15 17:09:53.193 [ 1] 9 CBLAuthDelegateConfiguration:initScopeDataSucceeded 2018-12-15 17:09:53.194 [ 1] 5 SQLiteCBLAuthDelegateStorage:open 2018-12-15 17:09:53.568 [ 2] 5 CBLAuthDelegate:handleAuthorizationFlow 2018-12-15 17:09:53.568 [ 2] 5 CBLAuthDelegate:handleStarting 2018-12-15 17:09:53.568 [ 2] 5 SQLiteCBLAuthDelegateStorage:getRefreshToken 2018-12-15 17:09:53.569 [ 2] 5 CBLAuthDelegate:handleRefreshingToken 2018-12-15 17:09:53.570 [ 2] 5 CBLAuthDelegate:requestRefresh 2018-12-15 17:09:53.570 [ 1] 5 CBLAuthDelegate:addAuthObserver:observer=0x12e9254 2018-12-15 17:09:53.571 [ 1] 5 CBLAuthDelegate:addAuthObserver:observer=0x12d4088 2018-12-15 17:09:54.170 [ 1] 5 CapabilitiesDelegate:addCapabilitiesObserver:observer=0x12d408c 2018-12-15 17:09:54.175 [ 1] 5 InternetConnectionMonitor:startMonitoring 2018-12-15 17:09:54.179 [ 3] 5 InternetConnectionMonitor:testConnection 2018-12-15 17:09:54.731 [ 1] 9 MediaPlayer:setObserverCalled 2018-12-15 17:09:54.737 [ 4] 0 MediaPlayer:handleSetObserverCalled 2018-12-15 17:09:54.739 [ 1] 9 SpeechSynthesizer:addObserver:observer=0x12ebdf4 2018-12-15 17:09:54.741 [ 1] 9 PlaybackRouter:create::called 2018-12-15 17:09:54.749 [ 1] 9 MediaPlayer:setObserverCalled 2018-12-15 17:09:54.750 [ 5] 0 MediaPlayer:handleSetObserverCalled 2018-12-15 17:09:54.755 [ 1] 9 MediaPlayer:getSpeakerTypeCalled 2018-12-15 17:09:54.756 [ 1] 9 MediaPlayer:getSpeakerTypeCalled 2018-12-15 17:09:54.756 [ 1] 9 MediaPlayer:getSpeakerTypeCalled 2018-12-15 17:09:54.756 [ 1] 9 MediaPlayer:getSpeakerTypeCalled 2018-12-15 17:09:54.756 [ 1] 9 MediaPlayer:getSpeakerTypeCalled 2018-12-15 17:09:54.757 [ 1] 9 MediaPlayer:getSpeakerTypeCalled 2018-12-15 17:09:54.757 [ 1] 0 SpeakerManager:mapCreated:numSpeakerVolume=5,numAlertsVolume=1 2018-12-15 17:09:54.758 [ 1] 9 MediaPlayer:getSpeakerSettingsCalled 2018-12-15 17:09:54.758 [ 3] 0 InProcessAttachmentReader:readFailed:reason=SDS is closed 2018-12-15 17:09:54.758 [ 4] 9 MediaPlayer:handleGetSpeakerSettingsCalled 2018-12-15 17:09:54.758 [ 3] 5 InternetConnectionMonitor:updateConnectionStatus:connected=true 2018-12-15 17:09:54.759 [ 3] 5 InternetConnectionMonitor:notifyObserversLocked 2018-12-15 17:09:54.760 [ 1] 9 MediaPlayer:getSpeakerSettingsCalled 2018-12-15 17:09:54.760 [ 5] 9 MediaPlayer:handleGetSpeakerSettingsCalled 2018-12-15 17:09:54.760 [ 1] 9 MediaPlayer:getSpeakerSettingsCalled 2018-12-15 17:09:54.760 [ 3] 9 LibCurlHttpContentFetcher:~LibCurlHttpContentFetcher 2018-12-15 17:09:54.761 [ 6] 9 MediaPlayer:handleGetSpeakerSettingsCalled 2018-12-15 17:09:54.761 [ 1] 9 MediaPlayer:getSpeakerSettingsCalled 2018-12-15 17:09:54.761 [ 7] 9 MediaPlayer:handleGetSpeakerSettingsCalled 2018-12-15 17:09:54.763 [ 1] 9 MediaPlayer:getSpeakerSettingsCalled 2018-12-15 17:09:54.763 [ 8] 9 MediaPlayer:handleGetSpeakerSettingsCalled 2018-12-15 17:09:54.763 [ 1] 9 SpeakerManager:validateSpeakerSettingsConsistencyResult:consistent=true 2018-12-15 17:09:54.764 [ 1] 9 SpeakerManager:validateSpeakerSettings:volume=100,mute=false 2018-12-15 17:09:54.764 [ 1] 9 SpeakerManager:updateContextManagerCalled:speakerType=AVS_SPEAKER_VOLUME 2018-12-15 17:09:54.766 [ 1] 9 MediaPlayer:setObserverCalled 2018-12-15 17:09:54.766 [ 9] 0 MediaPlayer:handleSetObserverCalled 2018-12-15 17:09:54.779 [ 1] 9 AlertScheduler:setTimerForNextAlertLocked 2018-12-15 17:09:54.780 [ 1] 9 AlertScheduler:executeScheduleNextAlertForRendering::no work to do. 2018-12-15 17:09:54.783 [ 1] 9 SpeakerManager:getSpeakerSettingsCalled 2018-12-15 17:09:54.784 [ a] 9 SpeakerManager:executeGetSpeakerSettingsCalled 2018-12-15 17:09:54.784 [ a] 9 MediaPlayer:getSpeakerSettingsCalled 2018-12-15 17:09:54.785 [ 9] 9 MediaPlayer:handleGetSpeakerSettingsCalled 2018-12-15 17:09:54.785 [ a] 9 SpeakerManager:validateSpeakerSettingsConsistencyResult:consistent=true 2018-12-15 17:09:54.785 [ a] 9 SpeakerManager:validateSpeakerSettings:volume=100,mute=false 2018-12-15 17:09:54.787 [ 1] 9 SpeakerManager:addSpeakerManagerObserverCalled 2018-12-15 17:09:54.787 [ b] 1 AlertsCapabilityAgent:executeOnConnectionStatusChanged:status=DISCONNECTED,reason=ACL_CLIENT_REQUEST 2018-12-15 17:09:54.788 [ 1] 9 SpeakerManager:addSpeakerManagerObserver:observer=0x12f4ee4 2018-12-15 17:09:54.789 [ 1] 5 NotificationsRenderer:create 2018-12-15 17:09:54.789 [ 1] 9 MediaPlayer:setObserverCalled 2018-12-15 17:09:54.790 [ 6] 0 MediaPlayer:handleSetObserverCalled 2018-12-15 17:09:54.794 [ 1] 5 NotificationsCapabilityAgent:init 2018-12-15 17:09:54.794 [ 1] 5 NotificationsRenderer:addObserver 2018-12-15 17:09:54.802 [ 1] 5 InteractionModel:InteractionModelCapabilityAgent 2018-12-15 17:09:54.803 [ c] 5 NotificationsCapabilityAgent:executeInit 2018-12-15 17:09:54.804 [ c] 5 NotificationsCapabilityAgent:notifyObservers:indicatorState=0 2018-12-15 17:09:54.805 [ c] 5 NotificationsCapabilityAgent:executeProvideState:sendToken=false,stateRequestToken=0 2018-12-15 17:09:54.807 [ c] 9 ContextManager:updateStateLocked:action=updatedState,namespace=Notifications,name=IndicatorState 2018-12-15 17:09:54.818 [ 1] 0 ExternalMediaPlayer:createAdapters 2018-12-15 17:09:54.832 [ 1] 1 AudioPlayer:addObserver 2018-12-15 17:09:54.834 [ d] 5 TemplateRuntime:onDialogUXStateChanged:state=IDLE 2018-12-15 17:09:54.845 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=SpeechSynthesizer,name=Speak,handler=0x12f26f8,policy=BLOCKING 2018-12-15 17:09:54.846 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=AudioPlayer,name=ClearQueue,handler=0x12f3868,policy=NON_BLOCKING 2018-12-15 17:09:54.846 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=AudioPlayer,name=Stop,handler=0x12f3868,policy=NON_BLOCKING 2018-12-15 17:09:54.846 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=AudioPlayer,name=Play,handler=0x12f3868,policy=NON_BLOCKING 2018-12-15 17:09:54.847 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=ExternalMediaPlayer,name=Play,handler=0x13030f8,policy=NON_BLOCKING 2018-12-15 17:09:54.847 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=ExternalMediaPlayer,name=Logout,handler=0x13030f8,policy=NON_BLOCKING 2018-12-15 17:09:54.848 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=ExternalMediaPlayer,name=Login,handler=0x13030f8,policy=NON_BLOCKING 2018-12-15 17:09:54.848 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.SeekController,name=SetSeekPosition,handler=0x13030f8,policy=NON_BLOCKING 2018-12-15 17:09:54.848 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=Play,handler=0x13030f8,policy=NON_BLOCKING 2018-12-15 17:09:54.848 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.FavoritesController,name=Unfavorite,handler=0x13030f8,policy=NON_BLOCKING 2018-12-15 17:09:54.848 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaylistController,name=EnableShuffle,handler=0x13030f8,policy=NON_BLOCKING 2018-12-15 17:09:54.848 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=Pause,handler=0x13030f8,policy=NON_BLOCKING 2018-12-15 17:09:54.848 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=Next,handler=0x13030f8,policy=NON_BLOCKING 2018-12-15 17:09:54.849 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=Rewind,handler=0x13030f8,policy=NON_BLOCKING 2018-12-15 17:09:54.849 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaylistController,name=EnableRepeat,handler=0x13030f8,policy=NON_BLOCKING 2018-12-15 17:09:54.849 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=Previous,handler=0x13030f8,policy=NON_BLOCKING 2018-12-15 17:09:54.849 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=StartOver,handler=0x13030f8,policy=NON_BLOCKING 2018-12-15 17:09:54.849 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=FastForward,handler=0x13030f8,policy=NON_BLOCKING 2018-12-15 17:09:54.849 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.FavoritesController,name=Favorite,handler=0x13030f8,policy=NON_BLOCKING 2018-12-15 17:09:54.849 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaylistController,name=DisableShuffle,handler=0x13030f8,policy=NON_BLOCKING 2018-12-15 17:09:54.849 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaylistController,name=EnableRepeatOne,handler=0x13030f8,policy=NON_BLOCKING 2018-12-15 17:09:54.850 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaylistController,name=DisableRepeat,handler=0x13030f8,policy=NON_BLOCKING 2018-12-15 17:09:54.850 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.SeekController,name=AdjustSeekPosition,handler=0x13030f8,policy=NON_BLOCKING 2018-12-15 17:09:54.850 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=SpeechRecognizer,name=SetEndOfSpeechOffset,handler=0x12f1df8,policy=NON_BLOCKING 2018-12-15 17:09:54.850 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=SpeechRecognizer,name=ExpectSpeech,handler=0x12f1df8,policy=NON_BLOCKING 2018-12-15 17:09:54.850 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=SpeechRecognizer,name=StopCapture,handler=0x12f1df8,policy=NON_BLOCKING 2018-12-15 17:09:54.851 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alerts,name=AdjustVolume,handler=0x12f4e78,policy=NON_BLOCKING 2018-12-15 17:09:54.851 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alerts,name=SetAlert,handler=0x12f4e78,policy=NON_BLOCKING 2018-12-15 17:09:54.851 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alerts,name=DeleteAlerts,handler=0x12f4e78,policy=NON_BLOCKING 2018-12-15 17:09:54.851 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alerts,name=DeleteAlert,handler=0x12f4e78,policy=NON_BLOCKING 2018-12-15 17:09:54.851 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alerts,name=SetVolume,handler=0x12f4e78,policy=NON_BLOCKING 2018-12-15 17:09:54.851 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=System,name=SetEndpoint,handler=0x1306098,policy=NON_BLOCKING 2018-12-15 17:09:54.851 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=System,name=ResetUserInactivity,handler=0x12f1b54,policy=NON_BLOCKING 2018-12-15 17:09:54.852 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Speaker,name=AdjustVolume,handler=0x12f4298,policy=NON_BLOCKING 2018-12-15 17:09:54.852 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Speaker,name=SetMute,handler=0x12f4298,policy=NON_BLOCKING 2018-12-15 17:09:54.852 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Speaker,name=SetVolume,handler=0x12f4298,policy=NON_BLOCKING 2018-12-15 17:09:54.852 [ 1] 5 TemplateRuntime:getConfiguration 2018-12-15 17:09:54.852 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=TemplateRuntime,name=RenderPlayerInfo,handler=0x1305148,policy=HANDLE_IMMEDIATELY 2018-12-15 17:09:54.852 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=TemplateRuntime,name=RenderTemplate,handler=0x1305148,policy=HANDLE_IMMEDIATELY 2018-12-15 17:09:54.853 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Notifications,name=ClearIndicator,handler=0x12fae04,policy=HANDLE_IMMEDIATELY 2018-12-15 17:09:54.853 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=Notifications,name=SetIndicator,handler=0x12fae04,policy=HANDLE_IMMEDIATELY 2018-12-15 17:09:54.853 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=InteractionModel,name=NewDialogRequest,handler=0x12ffe30,policy=HANDLE_IMMEDIATELY 2018-12-15 17:09:54.853 [ 1] 5 EqualizerController:getConfiguration 2018-12-15 17:09:54.853 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=EqualizerController,name=AdjustBands,handler=0x1306b2c,policy=NON_BLOCKING 2018-12-15 17:09:54.854 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=EqualizerController,name=SetMode,handler=0x1306b2c,policy=NON_BLOCKING 2018-12-15 17:09:54.854 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=EqualizerController,name=ResetBands,handler=0x1306b2c,policy=NON_BLOCKING 2018-12-15 17:09:54.854 [ 1] 9 DirectiveRouter:addDirectiveHandlers:action=added,namespace=EqualizerController,name=SetBands,handler=0x1306b2c,policy=NON_BLOCKING 2018-12-15 17:09:54.860 [ 1] 9 SpeakerManager:addSpeakerManagerObserverCalled 2018-12-15 17:09:54.860 [ 1] 9 SpeakerManager:addSpeakerManagerObserver:observer=0x12d4098 2018-12-15 17:09:54.861 [ 1] 5 NotificationsCapabilityAgent:addObserver 2018-12-15 17:09:54.861 [ 1] 5 TemplateRuntime:addObserver #################################################

NOTIFICATION INDICATOR STATE: OFF

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

2018-12-15 17:09:54.863 [ e] 5 TemplateRuntime:addObserverInExecutor 2018-12-15 17:09:55.252 [ 1] I SensoryKeywordDetector:License expires on 28 Feb 2019 00:00:00 GMT 2018-12-15 17:09:55.252 [ 1] I SensoryKeywordDetector:Sensory library license does not expire for at least 60 more days. 2018-12-15 17:09:55.338 [ 1] 5 CBLAuthDelegate:addAuthObserver:observer=0x1329f18 2018-12-15 17:09:55.339 [ 1] 5 CapabilitiesDelegate:addCapabilitiesObserver:observer=0x1329f1c 2018-12-15 17:09:55.339 [ 1] 5 CapabilitiesDelegate:addCapabilitiesObserver:observer=0x12eb900

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

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

   SDK Version 1.10.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 | | re-register your device. | | This option will also exit the application. | | Reauthorize device: | | Press 'z' followed by Enter at any time to re-authorize your device. | | This will erase any data stored in the device and initiate | | re-authorization. | | Quit: | | Press 'q' followed by Enter at any time to quit the application. | +----------------------------------------------------------------------------+

2018-12-15 17:09:56.388 [ 2] 5 HttpPost:doPostSucceeded:code=200 2018-12-15 17:09:56.388 [ 2] 5 CBLAuthDelegate:receiveTokenResponse:code=200 2018-12-15 17:09:56.389 [ 2] 5 CBLAuthDelegate:mapHTTPStatusToError:code=200,error=SUCCESS 2018-12-15 17:09:56.390 [ 2] 5 CBLAuthDelegate:setAuthError:authError=SUCCESS 2018-12-15 17:09:56.390 [ 2] 5 CBLAuthDelegate:setRefreshToken 2018-12-15 17:09:56.390 [ 2] 5 SQLiteCBLAuthDelegateStorage:setRefreshToken 2018-12-15 17:09:58.897 [ 2] 5 CBLAuthDelegate:setAuthState:newAuthState=REFRESHED 2018-12-15 17:09:58.898 [ 2] 9 CBLAuthDelegate:callingOnAuthStateChange:state=REFRESHED,error=SUCCESS ###########################

Authorized!

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

2018-12-15 17:09:59.795 [ f] E CapabilitiesDelegate:publishCapabilitiesFailed:responseCode=503,reason=httpRequestFailed Code\: 503\, Body\: <!DOCTYPE html PUBLIC "-//W3C//DTD XHTML 1.0 Transitional//EN" "http\://www.w3.org/TR/xhtml1/DTD/xhtml1-transitional.dtd"> <html xmlns\="http\://www.w3.org/1999/xhtml">

Website Temporarily Unavailable

 

2018-12-15 17:09:59.795 [ f] 5 CapabilitiesDelegate:setCapabilitiesState:newCapabilitiesState=RETRIABLE_ERROR 2018-12-15 17:09:59.795 [ f] 9 CapabilitiesDelegate:callingOnCapabilitiesStateChange:state=RETRIABLE_ERROR,error=UNKNOWN_ERROR 2018-12-15 17:09:59.796 [ f] E CapabilitiesDelegate:capabilitiesPublishFailed:reason=serverError,retryCount=1 2018-12-15 17:10:00.353 [ f] E CapabilitiesDelegate:publishCapabilitiesFailed:responseCode=503,reason=httpRequestFailed Code\: 503\, Body\: <!DOCTYPE html PUBLIC "-//W3C//DTD XHTML 1.0 Transitional//EN" "http\://www.w3.org/TR/xhtml1/DTD/xhtml1-transitional.dtd"> <html xmlns\="http\://www.w3.org/1999/xhtml">

Website Temporarily Unavailable

 

2018-12-15 17:10:00.354 [ f] 5 CapabilitiesDelegate:setCapabilitiesState:newCapabilitiesState=RETRIABLE_ERROR 2018-12-15 17:10:00.354 [ f] E CapabilitiesDelegate:capabilitiesPublishFailed:reason=serverError,retryCount=2 2018-12-15 17:10:02.066 [ f] E CapabilitiesDelegate:publishCapabilitiesFailed:responseCode=503,reason=httpRequestFailed Code\: 503\, Body\: <!DOCTYPE html PUBLIC "-//W3C//DTD XHTML 1.0 Transitional//EN" "http\://www.w3.org/TR/xhtml1/DTD/xhtml1-transitional.dtd"> <html xmlns\="http\://www.w3.org/1999/xhtml">

Website Temporarily Unavailable

 

2018-12-15 17:10:02.066 [ f] 5 CapabilitiesDelegate:setCapabilitiesState:newCapabilitiesState=RETRIABLE_ERROR 2018-12-15 17:10:02.067 [ f] E CapabilitiesDelegate:capabilitiesPublishFailed:reason=serverError,retryCount=3 2018-12-15 17:10:04.961 [ f] E CapabilitiesDelegate:publishCapabilitiesFailed:responseCode=503,reason=httpRequestFailed Code\: 503\, Body\: <!DOCTYPE html PUBLIC "-//W3C//DTD XHTML 1.0 Transitional//EN" "http\://www.w3.org/TR/xhtml1/DTD/xhtml1-transitional.dtd"> <html xmlns\="http\://www.w3.org/1999/xhtml">

Website Temporarily Unavailable

 

2018-12-15 17:10:04.961 [ f] 5 CapabilitiesDelegate:setCapabilitiesState:newCapabilitiesState=RETRIABLE_ERROR 2018-12-15 17:10:04.961 [ f] E CapabilitiesDelegate:capabilitiesPublishFailed:reason=serverError,retryCount=4 2018-12-15 17:10:11.532 [ f] E CapabilitiesDelegate:publishCapabilitiesFailed:responseCode=503,reason=httpRequestFailed Code\: 503\, Body\: <!DOCTYPE html PUBLIC "-//W3C//DTD XHTML 1.0 Transitional//EN" "http\://www.w3.org/TR/xhtml1/DTD/xhtml1-transitional.dtd"> <html xmlns\="http\://www.w3.org/1999/xhtml">

Website Temporarily Unavailable

 

2018-12-15 17:10:11.533 [ f] 5 CapabilitiesDelegate:setCapabilitiesState:newCapabilitiesState=RETRIABLE_ERROR 2018-12-15 17:10:11.533 [ f] E CapabilitiesDelegate:capabilitiesPublishFailed:reason=serverError,retryCount=5 2018-12-15 17:10:26.595 [ f] E CapabilitiesDelegate:publishCapabilitiesFailed:responseCode=503,reason=httpRequestFailed Code\: 503\, Body\: <!DOCTYPE html PUBLIC "-//W3C//DTD XHTML 1.0 Transitional//EN" "http\://www.w3.org/TR/xhtml1/DTD/xhtml1-transitional.dtd"> <html xmlns\="http\://www.w3.org/1999/xhtml">

Website Temporarily Unavailable

 

2018-12-15 17:10:26.595 [ f] 5 CapabilitiesDelegate:setCapabilitiesState:newCapabilitiesState=RETRIABLE_ERROR 2018-12-15 17:10:26.596 [ f] E CapabilitiesDelegate:capabilitiesPublishFailed:reason=serverError,retryCount=6 2018-12-15 17:10:40.866 [ f] E CapabilitiesDelegate:publishCapabilitiesFailed:responseCode=503,reason=httpRequestFailed Code\: 503\, Body\: <!DOCTYPE html PUBLIC "-//W3C//DTD XHTML 1.0 Transitional//EN" "http\://www.w3.org/TR/xhtml1/DTD/xhtml1-transitional.dtd"> <html xmlns\="http\://www.w3.org/1999/xhtml">

Website Temporarily Unavailable

 

2018-12-15 17:10:40.866 [ f] 5 CapabilitiesDelegate:setCapabilitiesState:newCapabilitiesState=RETRIABLE_ERROR 2018-12-15 17:10:40.866 [ f] E CapabilitiesDelegate:capabilitiesPublishFailed:reason=serverError,retryCount=7 2018-12-15 17:11:03.011 [ f] E CapabilitiesDelegate:publishCapabilitiesFailed:responseCode=503,reason=httpRequestFailed Code\: 503\, Body\: <!DOCTYPE html PUBLIC "-//W3C//DTD XHTML 1.0 Transitional//EN" "http\://www.w3.org/TR/xhtml1/DTD/xhtml1-transitional.dtd"> <html xmlns\="http\://www.w3.org/1999/xhtml">

Website Temporarily Unavailable

 

2018-12-15 17:11:03.011 [ f] 5 CapabilitiesDelegate:setCapabilitiesState:newCapabilitiesState=RETRIABLE_ERROR 2018-12-15 17:11:03.011 [ f] E CapabilitiesDelegate:capabilitiesPublishFailed:reason=serverError,retryCount=8 2018-12-15 17:11:26.243 [ f] E CapabilitiesDelegate:publishCapabilitiesFailed:responseCode=503,reason=httpRequestFailed Code\: 503\, Body\: <!DOCTYPE html PUBLIC "-//W3C//DTD XHTML 1.0 Transitional//EN" "http\://www.w3.org/TR/xhtml1/DTD/xhtml1-transitional.dtd"> <html xmlns\="http\://www.w3.org/1999/xhtml">

Website Temporarily Unavailable

 

2018-12-15 17:11:26.244 [ f] 5 CapabilitiesDelegate:setCapabilitiesState:newCapabilitiesState=RETRIABLE_ERROR 2018-12-15 17:11:26.244 [ f] E CapabilitiesDelegate:capabilitiesPublishFailed:reason=serverError,retryCount=9