question

newuser-d065cf2f-2739-49b9-a3ca-2cdf49a373c7 avatar image
newuser-d065cf2f-2739-49b9-a3ca-2cdf49a373c7 asked ·

error: curl code 60 Not able to verify peer certificate

hello team,

i cross compiled alexa auto sdk for pokyarm64 with sample app. compilation is done properly but while executing sample i selected A for authentication and verifying the code.

then iam getting error:

CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-7,text= CAfile\: none

CApath\: /etc/ssl/certs

and if i press T then its going instantly to idle state from listening state.

logs are as follows:

2019-05-30 10:17:20.025 [ 1] I sdkVersion: 1.11.0

2019-05-30 10:17:20.040 [AAC] I aace.core.EngineImpl:initialize:engineVersion=1.6.0

2019-05-30 10:17:20.040 [AAC] V aace.core.EngineImpl:initialize:signal=SIGPIPE,value=SIG_IGN

2019-05-30 10:17:20.042 [AAC] I aace.core.EngineImpl:checkServices::aace.logger:v=1.0.0

2019-05-30 10:17:20.042 [AAC] I aace.core.EngineImpl:checkServices::aace.network:v=1.0.0

2019-05-30 10:17:20.042 [AAC] I aace.core.EngineImpl:checkServices::aace.location:v=1.0.0

2019-05-30 10:17:20.042 [AAC] I aace.core.EngineImpl:checkServices::aace.vehicle:v=1.0.0

2019-05-30 10:17:20.042 [AAC] I aace.core.EngineImpl:checkServices::aace.storage:v=1.0.0

2019-05-30 10:17:20.042 [AAC] I aace.core.EngineImpl:checkServices::aace.metrics:v=1.0.0

2019-05-30 10:17:20.042 [AAC] I aace.core.EngineImpl:checkServices::aace.alexa:v=1.0.0

2019-05-30 10:17:20.042 [AAC] I aace.core.EngineImpl:checkServices::aace.cbl:v=1.0.0

2019-05-30 10:17:20.042 [AAC] I aace.core.EngineImpl:checkServices::aace.phoneCallController:v=1.0.0

2019-05-30 10:17:20.042 [AAC] I aace.core.EngineImpl:checkServices::aace.navigation:v=1.0.0

2019-05-30 10:17:20.042 [AAC] V aace.core.EngineImpl:configure::EngineConfigure

2019-05-30 10:17:20.043 [AAC] I aace.vehicle.VehicleEngineService:VehicleProperty:make=Amazon

2019-05-30 10:17:20.044 [AAC] I aace.vehicle.VehicleEngineService:VehicleProperty:model=AACE

2019-05-30 10:17:20.044 [AAC] I aace.vehicle.VehicleEngineService:VehicleProperty:year=2019

2019-05-30 10:17:20.044 [AAC] I aace.vehicle.VehicleEngineService:VehicleProperty:trim=aac

2019-05-30 10:17:20.044 [AAC] I aace.vehicle.VehicleEngineService:VehicleProperty:geography=US

2019-05-30 10:17:20.044 [AAC] I aace.vehicle.VehicleEngineService:VehicleProperty:version=1.2.3

2019-05-30 10:17:20.044 [AAC] I aace.vehicle.VehicleEngineService:VehicleProperty:os=Sample OS 1.0

2019-05-30 10:17:20.044 [AAC] I aace.vehicle.VehicleEngineService:VehicleProperty:arch=Sample Arch 1.0

2019-05-30 10:17:20.044 [AAC] I aace.vehicle.VehicleEngineService:VehicleProperty:language=en-US

2019-05-30 10:17:20.044 [AAC] I aace.vehicle.VehicleEngineService:VehicleProperty:microphone=SingleArray

2019-05-30 10:17:20.044 [AAC] I aace.vehicle.VehicleEngineService:VehicleProperty:countries=US\,GB\,IE\,CA\,DE\,AT\,IN\,JP\,AU\,NZ\,FR

2019-05-30 10:17:20.044 [AAC] I aace.vehicle.VehicleEngineService:VehicleProperty:vehicleIdentifier=Sample Identifier ABC

2019-05-30 10:17:20.048 [AVS] V ConfigurationNode:initializeSuccess:configuration={"deviceInfo"\:{"clientId"\:"amzn1.application-oa2-client.1d8d9a0e2ed84bf1abca8f9d3d311e31"\,"deviceSerialNumber"\:"78\:32\:1b\:73\:a2\:35"\,"productId"\:"AlexaPrototype"}\,"libcurlUtils"\:{"CURLOPT_CAPATH"\:"/etc/ssl/certs"}\,"miscDatabase"\:{"databaseFilePath"\:"./miscDatabase.db"}\,"certifiedSender"\:{"databaseFilePath"\:"./certifiedSender.db"}\,"alertsCapabilityAgent"\:{"databaseFilePath"\:"./alertsCapabilityAgent.db"}\,"notifications"\:{"databaseFilePath"\:"./notifications.db"}\,"settings"\:{"databaseFilePath"\:"./settings.db"\,"defaultAVSClientSettings"\:{"locale"\:"en-US"}}\,"aace.storage"\:{"localStoragePath"\:"./sample-aace.db"\,"storageType"\:"sqlite"}\,"aace.vehicle"\:{"info"\:{"make"\:"Amazon"\,"model"\:"AACE"\,"year"\:"2019"\,"trim"\:"aac"\,"geography"\:"US"\,"version"\:"1.2.3"\,"os"\:"Sample OS 1.0"\,"arch"\:"Sample Arch 1.0"\,"language"\:"en-US"\,"microphone"\:"SingleArray"\,"countries"\:"US\,GB\,IE\,CA\,DE\,AT\,IN\,JP\,AU\,NZ\,FR"\,"vehicleIdentifier"\:"Sample Identifier ABC"}\,"operatingCountry"\:"US"}}

2019-05-30 10:17:20.066 [AVS] V CapabilitiesDelegate:CapabilitiesDelegateInit:reason=missingCapabilitiesDelegateConfigurationValue,key=capabilitiesDelegate

2019-05-30 10:17:20.074 [AVS] V CapabilitiesDelegate:addCapabilitiesObserver:observer=0xaaaadccb5558

2019-05-30 10:17:20.075 [AAC] I aace.alexa.AlexaEngineService:onCapabilitiesStateChange:newState=UNINTIALIZED

2019-05-30 10:17:20.112 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=System,name=SetEndpoint,handler=0xaaaadcd678a0,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False

2019-05-30 10:17:20.112 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=System,name=ResetUserInactivity,handler=0xaaaadccb94b8,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False

2019-05-30 10:17:20.113 [AVS] V SoftwareInfoSender:create

2019-05-30 10:17:20.113 [AVS] V SoftwareInfoSender:SoftwareInfoSender

2019-05-30 10:17:20.113 [AVS] V SoftwareInfoSender:onConnectionStatusChanged:status=DISCONNECTED,reason=ACL_CLIENT_REQUEST

2019-05-30 10:17:20.115 [AVS] V SpeakerManager:mapCreated:numSpeakerVolume=0,numAlertsVolume=0

2019-05-30 10:17:20.115 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Speaker,name=SetVolume,handler=0xaaaadcd9f300,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False

2019-05-30 10:17:20.115 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Speaker,name=SetMute,handler=0xaaaadcd9f300,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False

2019-05-30 10:17:20.115 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Speaker,name=AdjustVolume,handler=0xaaaadcd9f300,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False

2019-05-30 10:17:20.119 [AVS] V DirectiveProcessor:processingLoop

2019-05-30 10:17:20.132 [AVS] V InteractionModel:InteractionModelCapabilityAgent

2019-05-30 10:17:20.135 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=InteractionModel,name=NewDialogRequest,handler=0xaaaadcd9fff0,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False

2019-05-30 10:17:20.535 [AVS] V AlertScheduler:setTimerForNextAlertLocked

2019-05-30 10:17:20.549 [AVS] V AlertScheduler:executeScheduleNextAlertForRendering::no work to do.

2019-05-30 10:17:20.549 [AVS] V SpeakerManager:getSpeakerSettingsCalled

2019-05-30 10:17:20.549 [AVS] V SpeakerManager:executeGetSpeakerSettingsCalled

2019-05-30 10:17:20.550 [AVS] V SpeakerManager:validateSpeakerSettingsConsistencyResult:consistent=true

2019-05-30 10:17:20.550 [AVS] V SpeakerManager:validateSpeakerSettings:volume=100,mute=false

2019-05-30 10:17:20.560 [AVS] V SpeakerManager:addSpeakerManagerObserverCalled

2019-05-30 10:17:20.560 [AVS] V SpeakerManager:addSpeakerManagerObserver:observer=0xaaaadce79508

2019-05-30 10:17:20.560 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alerts,name=AdjustVolume,handler=0xaaaadce79440,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False

2019-05-30 10:17:20.560 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alerts,name=SetVolume,handler=0xaaaadce79440,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False

2019-05-30 10:17:20.560 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alerts,name=DeleteAlerts,handler=0xaaaadce79440,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False

2019-05-30 10:17:20.560 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alerts,name=SetAlert,handler=0xaaaadce79440,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False

2019-05-30 10:17:20.560 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alerts,name=DeleteAlert,handler=0xaaaadce79440,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False

2019-05-30 10:17:20.560 [CLI] I AlexaClientHandler:DISCONNECTED/ACL_CLIENT_REQUEST

2019-05-30 10:17:20.561 [AVS] V AudioPlayer:addObserver

2019-05-30 10:17:20.561 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=AudioPlayer,name=ClearQueue,handler=0xaaaadd04bf00,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False

2019-05-30 10:17:20.561 [CLI] I AlexaClientHandler:IDLE

2019-05-30 10:17:20.561 [AVS] V AlertsCapabilityAgent:executeOnConnectionStatusChanged:status=DISCONNECTED,reason=ACL_CLIENT_REQUEST

2019-05-30 10:17:20.561 [AVS] V AlertsCapabilityAgent:executeAddObserver:observer=0xaaaadce01df0

2019-05-30 10:17:20.561 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=AudioPlayer,name=Play,handler=0xaaaadd04bf00,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False

2019-05-30 10:17:20.561 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=AudioPlayer,name=Stop,handler=0xaaaadd04bf00,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False

2019-05-30 10:17:20.561 [AAC] V CBLAuthDelegateConfiguration:create

2019-05-30 10:17:20.561 [AAC] V CBLAuthDelegateConfiguration:init

2019-05-30 10:17:20.561 [AAC] V CBLAuthDelegateConfiguration:initScopeData

2019-05-30 10:17:20.561 [AAC] V CBLAuthDelegateConfiguration:initScopeDataSucceeded

2019-05-30 10:17:20.561 [AAC] V CBLAuthDelegate:create

2019-05-30 10:17:20.561 [AAC] V CBLAuthDelegate:CBLAuthDelegate

2019-05-30 10:17:20.562 [AVS] V InMemoryEqualizerConfiguration:validateConfiguration::Validating Equalizer configuration

2019-05-30 10:17:20.562 [AVS] V InMemoryEqualizerConfiguration:validateConfiguration::Validating default Equalizer state

2019-05-30 10:17:20.562 [AVS] V InMemoryEqualizerConfiguration:validateConfiguration::Validating Equalizer configuration

2019-05-30 10:17:20.562 [AVS] V InMemoryEqualizerConfiguration:validateConfiguration::Validating default Equalizer state

2019-05-30 10:17:20.562 [CLI] I EqualizerControllerHandler:getBandLevels

2019-05-30 10:17:20.562 [AAC] V aace.alexa.EqualizerControllerEngineImpl:loadState:bandLevels=

2019-05-30 10:17:20.563 [AVS] V EqualizerController:getConfiguration

2019-05-30 10:17:20.563 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=EqualizerController,name=ResetBands,handler=0xaaaadce6fe18,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False

2019-05-30 10:17:20.563 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=EqualizerController,name=SetBands,handler=0xaaaadce6fe18,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False

2019-05-30 10:17:20.563 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=EqualizerController,name=SetMode,handler=0xaaaadce6fe18,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False

2019-05-30 10:17:20.563 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=EqualizerController,name=AdjustBands,handler=0xaaaadce6fe18,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False

2019-05-30 10:17:20.579 [AAC] V aace.alexa.EqualizerControllerEngineImpl:setEqualizerBandLevels:bandLevels=MIDRANGE\:0 TREBLE\:0 BASS\:0

2019-05-30 10:17:20.580 [CLI] I EqualizerControllerHandler:setBandLevels:bandLevels={MIDRANGE:0,TREBLE:0,BASS:0}

2019-05-30 10:17:20.580 [AVS] V ExternalMediaPlayer:createAdapters

2019-05-30 10:17:20.580 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.FavoritesController,name=Unfavorite,handler=0xaaaadcf564c0,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False

2019-05-30 10:17:20.580 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.FavoritesController,name=Favorite,handler=0xaaaadcf564c0,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False

2019-05-30 10:17:20.580 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.SeekController,name=SetSeekPosition,handler=0xaaaadcf564c0,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False

2019-05-30 10:17:20.580 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.SeekController,name=AdjustSeekPosition,handler=0xaaaadcf564c0,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False

2019-05-30 10:17:20.580 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaylistController,name=EnableShuffle,handler=0xaaaadcf564c0,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False

2019-05-30 10:17:20.580 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaylistController,name=DisableRepeat,handler=0xaaaadcf564c0,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False

2019-05-30 10:17:20.580 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaylistController,name=EnableRepeat,handler=0xaaaadcf564c0,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False

2019-05-30 10:17:20.580 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=Rewind,handler=0xaaaadcf564c0,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False

2019-05-30 10:17:20.580 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=Previous,handler=0xaaaadcf564c0,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False

2019-05-30 10:17:20.580 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaylistController,name=DisableShuffle,handler=0xaaaadcf564c0,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False

2019-05-30 10:17:20.580 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=Next,handler=0xaaaadcf564c0,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False

2019-05-30 10:17:20.580 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaylistController,name=EnableRepeatOne,handler=0xaaaadcf564c0,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False

2019-05-30 10:17:20.580 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=Pause,handler=0xaaaadcf564c0,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False

2019-05-30 10:17:20.581 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=FastForward,handler=0xaaaadcf564c0,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False

2019-05-30 10:17:20.581 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=Play,handler=0xaaaadcf564c0,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False

2019-05-30 10:17:20.581 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.PlaybackController,name=StartOver,handler=0xaaaadcf564c0,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False

2019-05-30 10:17:20.581 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=ExternalMediaPlayer,name=Logout,handler=0xaaaadcf564c0,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False

2019-05-30 10:17:20.581 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=ExternalMediaPlayer,name=Login,handler=0xaaaadcf564c0,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False

2019-05-30 10:17:20.581 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=ExternalMediaPlayer,name=Play,handler=0xaaaadcf564c0,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False

2019-05-30 10:17:20.581 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=ExternalMediaPlayer,name=AuthorizeDiscoveredPlayers,handler=0xaaaadcf564c0,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False

2019-05-30 10:17:20.581 [AVS] V ExternalMediaPlayer:addAdapterHandler

2019-05-30 10:17:20.581 [AAC] V aace.alexa.ExternalMediaPlayerEngineImpl:reportDiscoveredPlayers::addingDiscoveredPlayerToPendingMap:localPlayerId=com.amazon.alexa.auto.players.COMPACT_DISC

2019-05-30 10:17:20.583 [AVS] V ExternalMediaPlayer:addAdapterHandlerInExecutor

2019-05-30 10:17:20.597 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Navigation,name=CancelNavigation,handler=0xaaaadce50c40,policy= Mediums:MEDIUMS_AUDIO_AND_VISUAL11 .isBlocking:True

2019-05-30 10:17:20.597 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Navigation,name=SetDestination,handler=0xaaaadce50c40,policy= Mediums:MEDIUMS_AUDIO_AND_VISUAL11 .isBlocking:True

2019-05-30 10:17:20.598 [AAC] V aace.navigation.NavigationEngineImpl:RegisterCapability:Navigation=successful

2019-05-30 10:17:20.598 [AVS] V NotificationsRenderer:create

2019-05-30 10:17:20.598 [AVS] V NotificationsCapabilityAgent:init

2019-05-30 10:17:20.598 [AVS] V NotificationsRenderer:addObserver

2019-05-30 10:17:20.599 [AVS] V NotificationsCapabilityAgent:executeInit

2019-05-30 10:17:20.600 [AVS] V NotificationsCapabilityAgent:notifyObservers:indicatorState=0

2019-05-30 10:17:20.600 [AVS] V NotificationsCapabilityAgent:executeProvideState:sendToken=false,stateRequestToken=0

2019-05-30 10:17:20.600 [AVS] V ContextManager:updateStateLocked:action=updatedState,state={"isEnabled"\:false\,"isVisualIndicatorPersisted"\:false},namespace=Notifications,name=IndicatorState

2019-05-30 10:17:20.607 [AVS] V NotificationsCapabilityAgent:addObserver

2019-05-30 10:17:20.608 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Notifications,name=ClearIndicator,handler=0xaaaadce6a008,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False

2019-05-30 10:17:20.608 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Notifications,name=SetIndicator,handler=0xaaaadce6a008,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False

2019-05-30 10:17:20.608 [CLI] I NotificationsHandler:OFF

2019-05-30 10:17:20.608 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.Comms.PhoneCallController,name=PlayRingtone,handler=0xaaaadcf60560,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False

2019-05-30 10:17:20.608 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.Comms.PhoneCallController,name=Stop,handler=0xaaaadcf60560,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False

2019-05-30 10:17:20.608 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.Comms.PhoneCallController,name=Dial,handler=0xaaaadcf60560,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False

2019-05-30 10:17:20.608 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.Comms.PhoneCallController,name=SendDTMF,handler=0xaaaadcf60560,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False

2019-05-30 10:17:20.608 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.Comms.PhoneCallController,name=Answer,handler=0xaaaadcf60560,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False

2019-05-30 10:17:20.608 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=Alexa.Comms.PhoneCallController,name=Redial,handler=0xaaaadcf60560,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:False

2019-05-30 10:17:20.609 [AVS] V PlaybackRouter:create::called

2019-05-30 10:17:20.624 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=SpeechRecognizer,name=SetEndOfSpeechOffset,handler=0xaaaadce22e00,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False

2019-05-30 10:17:20.624 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=SpeechRecognizer,name=StopCapture,handler=0xaaaadce22e00,policy= Mediums:MEDIUMS_NONE00 .isBlocking:False

2019-05-30 10:17:20.624 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=SpeechRecognizer,name=ExpectSpeech,handler=0xaaaadce22e00,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:True

2019-05-30 10:17:20.625 [AVS] V SpeechSynthesizer:addObserver:observer=0xaaaadcd41ea8

2019-05-30 10:17:20.625 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=SpeechSynthesizer,name=Speak,handler=0xaaaadcf3fc70,policy= Mediums:MEDIUM_AUDIO01 .isBlocking:True

2019-05-30 10:17:20.625 [AVS] V AudioPlayer:addObserver

2019-05-30 10:17:20.625 [AVS] V TemplateRuntime:addObserver

2019-05-30 10:17:20.631 [AVS] V TemplateRuntime:addObserverInExecutor

2019-05-30 10:17:20.643 [AVS] V TemplateRuntime:onDialogUXStateChanged:state=IDLE

2019-05-30 10:17:20.643 [AVS] V TemplateRuntime:getConfiguration

2019-05-30 10:17:20.644 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=TemplateRuntime,name=RenderPlayerInfo,handler=0xaaaadceeac00,policy= Mediums:MEDIUM_VISUAL10 .isBlocking:False

2019-05-30 10:17:20.644 [AVS] V DirectiveRouter:addDirectiveHandlers:action=added,namespace=TemplateRuntime,name=RenderTemplate,handler=0xaaaadceeac00,policy= Mediums:MEDIUM_VISUAL10 .isBlocking:False

2019-05-30 10:17:20.644 [AAC] V aace.core.EngineImpl:start::EngineStart

2019-05-30 10:17:20.644 [AAC] M aace.core.EngineImpl:start:Location=ENGINE_START_BEGIN

2019-05-30 10:17:20.644 [AAC] M MetricEvent:AlexaAuto_Vehicle:VehicleConfiguration:VehicleIdentifier=Sample Identifier ABC;DV;1,:Countries=US-GB-IE-CA-DE-AT-IN-JP-AU-NZ-FR;DV;1,:Microphone=SingleArray;DV;1,:Language=en-US;DV;1,:HW=Sample Arch 1.0;DV;1,:OS=Sample OS 1.0;DV;1,:Model=AACE;DV;1,:Make=Amazon;DV;1,:Year=2019;DV;1,:Trim=aac;DV;1,:Geography=US;DV;1,:SWVersion=1.2.3;DV;1,:NR

2019-05-30 10:17:20.644 [AAC] V CBLAuthDelegate:addAuthObserver:observer=0xaaaadccc94e0

2019-05-30 10:17:20.644 [AAC] V CBLAuthDelegate:addAuthObserver:observer=0xaaaadd04b4a0

2019-05-30 10:17:20.644 [CLI] I AlexaClientHandler:UNINITIALIZED/NO_ERROR

2019-05-30 10:17:20.644 [AAC] V CBLAuthDelegate:addAuthObserver:observer=0xaaaadccb5550

2019-05-30 10:17:20.644 [AAC] I aace.alexa.AlexaEngineService:onAuthStateChange:state=UNINTIALIZED,error=SUCCESS

2019-05-30 10:17:20.644 [AAC] V CBLAuthDelegate:addAuthObserver:observer=0xaaaadcc69408

2019-05-30 10:17:20.644 [AAC] M aace.core.EngineImpl:start:Location=ENGINE_START_END

2019-05-30 10:17:20.644 [CLI] I Application:Engine:started successfully

2019-05-30 10:17:26.830 [CLI] V CBLHandler:onCBLStart

2019-05-30 10:17:26.830 [AAC] V CBLAuthDelegate:handleAuthorizationFlow

2019-05-30 10:17:26.830 [AAC] V CBLAuthDelegate:handleStarting

2019-05-30 10:17:26.830 [CLI] I CBLHandler:cblStateChanged:state=STARTING,reason=SUCCESS,url=,code=

2019-05-30 10:17:26.830 [AAC] V CBLAuthDelegate:getRefreshTokenFailed

2019-05-30 10:17:26.830 [AAC] V CBLAuthDelegate:handleRequestingCodePair

2019-05-30 10:17:26.830 [CLI] I CBLHandler:cblStateChanged:state=REQUESTING_CODE_PAIR,reason=SUCCESS,url=,code=

2019-05-30 10:17:26.830 [AAC] V CBLAuthDelegate:requestCodePair

2019-05-30 10:17:27.340 [AVS] V CurlEasyHandleWrapper:libcurl:id=3,text= Trying 54.239.26.114...

2019-05-30 10:17:27.340 [AVS] V CurlEasyHandleWrapper:libcurl:id=3,text=TCP_NODELAY set

2019-05-30 10:17:27.630 [AVS] V CurlEasyHandleWrapper:libcurl:id=3,text=Connected to api.amazon.com (54.239.26.114) port 443 (#0)

2019-05-30 10:17:27.632 [AVS] V CurlEasyHandleWrapper:libcurl:id=3,text=ALPN\, offering h2

2019-05-30 10:17:27.632 [AVS] V CurlEasyHandleWrapper:libcurl:id=3,text=ALPN\, offering http/1.1

2019-05-30 10:17:27.632 [AVS] V CurlEasyHandleWrapper:libcurl:id=3,text=successfully set certificate verify locations\:

2019-05-30 10:17:27.632 [AVS] V CurlEasyHandleWrapper:libcurl:id=3,text= CAfile\: none

CApath\: /etc/ssl/certs

2019-05-30 10:17:27.633 [AVS] V CurlEasyHandleWrapper:libcurl:id=3,text=TLSv1.2 (OUT)\, TLS handshake\, Client hello (1)\:

2019-05-30 10:17:27.937 [AVS] V CurlEasyHandleWrapper:libcurl:id=3,text=TLSv1.2 (IN)\, TLS handshake\, Server hello (2)\:

2019-05-30 10:17:27.938 [AVS] V CurlEasyHandleWrapper:libcurl:id=3,text=TLSv1.2 (IN)\, TLS handshake\, Certificate (11)\:

2019-05-30 10:17:27.939 [AVS] V CurlEasyHandleWrapper:libcurl:id=3,text=TLSv1.2 (IN)\, TLS handshake\, Server key exchange (12)\:

2019-05-30 10:17:27.939 [AVS] V CurlEasyHandleWrapper:libcurl:id=3,text=TLSv1.2 (IN)\, TLS handshake\, Server finished (14)\:

2019-05-30 10:17:27.940 [AVS] V CurlEasyHandleWrapper:libcurl:id=3,text=TLSv1.2 (OUT)\, TLS handshake\, Client key exchange (16)\:

2019-05-30 10:17:27.940 [AVS] V CurlEasyHandleWrapper:libcurl:id=3,text=TLSv1.2 (OUT)\, TLS change cipher\, Client hello (1)\:

2019-05-30 10:17:27.940 [AVS] V CurlEasyHandleWrapper:libcurl:id=3,text=TLSv1.2 (OUT)\, TLS handshake\, Finished (20)\:

2019-05-30 10:17:28.246 [AVS] V CurlEasyHandleWrapper:libcurl:id=3,text=TLSv1.2 (IN)\, TLS handshake\, Finished (20)\:

2019-05-30 10:17:28.246 [AVS] V CurlEasyHandleWrapper:libcurl:id=3,text=SSL connection using TLSv1.2 / ECDHE-RSA-AES128-GCM-SHA256

2019-05-30 10:17:28.246 [AVS] V CurlEasyHandleWrapper:libcurl:id=3,text=ALPN\, server accepted to use http/1.1

2019-05-30 10:17:28.247 [AVS] V CurlEasyHandleWrapper:libcurl:id=3,text=Server certificate\:

2019-05-30 10:17:28.247 [AVS] V CurlEasyHandleWrapper:libcurl:id=3,text= subject\: C\=US; ST\=Washington; L\=Seattle; O\=Amazon.com\, Inc.; CN\=api.amazon.com

2019-05-30 10:17:28.247 [AVS] V CurlEasyHandleWrapper:libcurl:id=3,text= start date\: Mar 18 00\:00\:00 2019 GMT

2019-05-30 10:17:28.247 [AVS] V CurlEasyHandleWrapper:libcurl:id=3,text= expire date\: Feb 21 12\:00\:00 2020 GMT

2019-05-30 10:17:28.247 [AVS] V CurlEasyHandleWrapper:libcurl:id=3,text= subjectAltName\: host "api.amazon.com" matched cert's "api.amazon.com"

2019-05-30 10:17:28.247 [AVS] V CurlEasyHandleWrapper:libcurl:id=3,text= issuer\: C\=US; O\=DigiCert Inc; CN\=DigiCert Global CA G2

2019-05-30 10:17:28.247 [AVS] V CurlEasyHandleWrapper:libcurl:id=3,text= SSL certificate verify ok.

2019-05-30 10:17:28.247 [AVS] V CurlEasyHandleWrapper:libcurl:id=3,text=upload completely sent off\: 300 out of 300 bytes

2019-05-30 10:17:28.654 [AVS] V CurlEasyHandleWrapper:libcurl:id=3,text=Connection #0 to host api.amazon.com left intact

2019-05-30 10:17:28.654 [AVS] V HttpPost:doPostSucceeded:code=200

2019-05-30 10:17:28.654 [AAC] V CBLAuthDelegate:receiveCodePairResponse:code=200

2019-05-30 10:17:28.654 [AAC] V CBLAuthDelegate:mapHTTPStatusToError:code=200,error=SUCCESS

2019-05-30 10:17:28.654 [AAC] V CBLAuthDelegate:setAuthError:authError=SUCCESS

2019-05-30 10:17:28.655 [CLI] I CBLHandler:cblStateChanged:state=CODE_PAIR_RECEIVED,reason=SUCCESS,url=https://amazon.com/us/code,code=AMM2VA

2019-05-30 10:17:28.655 [AAC] V CBLAuthDelegate:handleRequestingToken

2019-05-30 10:17:28.655 [CLI] I CBLHandler:cblStateChanged:state=REQUESTING_TOKEN,reason=SUCCESS,url=,code=

2019-05-30 10:17:28.655 [AAC] V CBLAuthDelegate:requestToken

2019-05-30 10:17:28.655 [AVS] V CurlEasyHandleWrapper:libcurl:id=4,text=Found bundle for host api.amazon.com\: 0xffff28001820 [can pipeline]

2019-05-30 10:17:28.655 [AVS] V CurlEasyHandleWrapper:libcurl:id=4,text=Re-using existing connection! (#0) with host api.amazon.com

2019-05-30 10:17:28.655 [AVS] V CurlEasyHandleWrapper:libcurl:id=4,text=Connected to api.amazon.com (54.239.26.114) port 443 (#0)

2019-05-30 10:17:28.655 [AVS] V CurlEasyHandleWrapper:libcurl:id=4,text=upload completely sent off\: 88 out of 88 bytes

2019-05-30 10:17:28.961 [AVS] V CurlEasyHandleWrapper:libcurl:id=4,text=Connection #0 to host api.amazon.com left intact

2019-05-30 10:17:28.961 [AVS] V HttpPost:doPostSucceeded:code=400

2019-05-30 10:17:28.961 [AAC] V CBLAuthDelegate:receiveTokenResponse:code=400

2019-05-30 10:17:28.961 [AAC] V CBLAuthDelegate:mapHTTPStatusToError:code=400,error=INVALID_REQUEST

2019-05-30 10:17:28.961 [AAC] V CBLAuthDelegate:errorInLwaResponseBody:error=authorization_pending,errorCode=AUTHORIZATION_PENDING

2019-05-30 10:17:28.961 [AAC] V CBLAuthDelegate:setAuthError:authError=AUTHORIZATION_PENDING

2019-05-30 10:17:28.961 [AAC] V CBLAuthDelegate:receiveTokenResponseFailed:result=AUTHORIZATION_PENDING

2019-05-30 10:17:33.962 [AAC] V CBLAuthDelegate:requestToken

2019-05-30 10:17:33.962 [AVS] V CurlEasyHandleWrapper:libcurl:id=5,text=Found bundle for host api.amazon.com\: 0xffff28001820 [can pipeline]

2019-05-30 10:17:33.962 [AVS] V CurlEasyHandleWrapper:libcurl:id=5,text=Re-using existing connection! (#0) with host api.amazon.com

2019-05-30 10:17:33.962 [AVS] V CurlEasyHandleWrapper:libcurl:id=5,text=Connected to api.amazon.com (54.239.26.114) port 443 (#0)

2019-05-30 10:17:33.962 [AVS] V CurlEasyHandleWrapper:libcurl:id=5,text=upload completely sent off\: 88 out of 88 bytes

2019-05-30 10:17:34.287 [AVS] V CurlEasyHandleWrapper:libcurl:id=5,text=Connection #0 to host api.amazon.com left intact

2019-05-30 10:17:34.287 [AVS] V HttpPost:doPostSucceeded:code=400

2019-05-30 10:17:34.287 [AAC] V CBLAuthDelegate:receiveTokenResponse:code=400

2019-05-30 10:17:34.287 [AAC] V CBLAuthDelegate:mapHTTPStatusToError:code=400,error=INVALID_REQUEST

2019-05-30 10:17:34.287 [AAC] V CBLAuthDelegate:errorInLwaResponseBody:error=authorization_pending,errorCode=AUTHORIZATION_PENDING

2019-05-30 10:17:34.287 [AAC] V CBLAuthDelegate:setAuthError:authError=AUTHORIZATION_PENDING

2019-05-30 10:17:34.287 [AAC] V CBLAuthDelegate:receiveTokenResponseFailed:result=AUTHORIZATION_PENDING

2019-05-30 10:17:39.287 [AAC] V CBLAuthDelegate:requestToken

2019-05-30 10:17:39.288 [AVS] V CurlEasyHandleWrapper:libcurl:id=6,text=Found bundle for host api.amazon.com\: 0xffff28001820 [can pipeline]

2019-05-30 10:17:39.288 [AVS] V CurlEasyHandleWrapper:libcurl:id=6,text=Re-using existing connection! (#0) with host api.amazon.com

2019-05-30 10:17:39.288 [AVS] V CurlEasyHandleWrapper:libcurl:id=6,text=Connected to api.amazon.com (54.239.26.114) port 443 (#0)

2019-05-30 10:17:39.288 [AVS] V CurlEasyHandleWrapper:libcurl:id=6,text=upload completely sent off\: 88 out of 88 bytes

2019-05-30 10:17:39.612 [AVS] V CurlEasyHandleWrapper:libcurl:id=6,text=Connection #0 to host api.amazon.com left intact

2019-05-30 10:17:39.612 [AVS] V HttpPost:doPostSucceeded:code=400

2019-05-30 10:17:39.612 [AAC] V CBLAuthDelegate:receiveTokenResponse:code=400

2019-05-30 10:17:39.612 [AAC] V CBLAuthDelegate:mapHTTPStatusToError:code=400,error=INVALID_REQUEST

2019-05-30 10:17:39.612 [AAC] V CBLAuthDelegate:errorInLwaResponseBody:error=authorization_pending,errorCode=AUTHORIZATION_PENDING

2019-05-30 10:17:39.612 [AAC] V CBLAuthDelegate:setAuthError:authError=AUTHORIZATION_PENDING

2019-05-30 10:17:39.612 [AAC] V CBLAuthDelegate:receiveTokenResponseFailed:result=AUTHORIZATION_PENDING

2019-05-30 10:17:44.612 [AAC] V CBLAuthDelegate:requestToken

2019-05-30 10:17:44.613 [AVS] V CurlEasyHandleWrapper:libcurl:id=7,text=Found bundle for host api.amazon.com\: 0xffff28001820 [can pipeline]

2019-05-30 10:17:44.613 [AVS] V CurlEasyHandleWrapper:libcurl:id=7,text=Re-using existing connection! (#0) with host api.amazon.com

2019-05-30 10:17:44.613 [AVS] V CurlEasyHandleWrapper:libcurl:id=7,text=Connected to api.amazon.com (54.239.26.114) port 443 (#0)

2019-05-30 10:17:44.613 [AVS] V CurlEasyHandleWrapper:libcurl:id=7,text=upload completely sent off\: 88 out of 88 bytes

2019-05-30 10:17:44.937 [AVS] V CurlEasyHandleWrapper:libcurl:id=7,text=Connection #0 to host api.amazon.com left intact

2019-05-30 10:17:44.937 [AVS] V HttpPost:doPostSucceeded:code=400

2019-05-30 10:17:44.937 [AAC] V CBLAuthDelegate:receiveTokenResponse:code=400

2019-05-30 10:17:44.937 [AAC] V CBLAuthDelegate:mapHTTPStatusToError:code=400,error=INVALID_REQUEST

2019-05-30 10:17:44.937 [AAC] V CBLAuthDelegate:errorInLwaResponseBody:error=authorization_pending,errorCode=AUTHORIZATION_PENDING

2019-05-30 10:17:44.937 [AAC] V CBLAuthDelegate:setAuthError:authError=AUTHORIZATION_PENDING

2019-05-30 10:17:44.937 [AAC] V CBLAuthDelegate:receiveTokenResponseFailed:result=AUTHORIZATION_PENDING

2019-05-30 10:17:49.937 [AAC] V CBLAuthDelegate:requestToken

2019-05-30 10:17:49.937 [AVS] V CurlEasyHandleWrapper:libcurl:id=8,text=Found bundle for host api.amazon.com\: 0xffff28001820 [can pipeline]

2019-05-30 10:17:49.937 [AVS] V CurlEasyHandleWrapper:libcurl:id=8,text=Re-using existing connection! (#0) with host api.amazon.com

2019-05-30 10:17:49.938 [AVS] V CurlEasyHandleWrapper:libcurl:id=8,text=Connected to api.amazon.com (54.239.26.114) port 443 (#0)

2019-05-30 10:17:49.938 [AVS] V CurlEasyHandleWrapper:libcurl:id=8,text=upload completely sent off\: 88 out of 88 bytes

2019-05-30 10:17:50.262 [AVS] V CurlEasyHandleWrapper:libcurl:id=8,text=Connection #0 to host api.amazon.com left intact

2019-05-30 10:17:50.262 [AVS] V HttpPost:doPostSucceeded:code=400

2019-05-30 10:17:50.262 [AAC] V CBLAuthDelegate:receiveTokenResponse:code=400

2019-05-30 10:17:50.262 [AAC] V CBLAuthDelegate:mapHTTPStatusToError:code=400,error=INVALID_REQUEST

2019-05-30 10:17:50.262 [AAC] V CBLAuthDelegate:errorInLwaResponseBody:error=authorization_pending,errorCode=AUTHORIZATION_PENDING

2019-05-30 10:17:50.262 [AAC] V CBLAuthDelegate:setAuthError:authError=AUTHORIZATION_PENDING

2019-05-30 10:17:50.262 [AAC] V CBLAuthDelegate:receiveTokenResponseFailed:result=AUTHORIZATION_PENDING

2019-05-30 10:17:55.262 [AAC] V CBLAuthDelegate:requestToken

2019-05-30 10:17:55.263 [AVS] V CurlEasyHandleWrapper:libcurl:id=9,text=Found bundle for host api.amazon.com\: 0xffff28001820 [can pipeline]

2019-05-30 10:17:55.263 [AVS] V CurlEasyHandleWrapper:libcurl:id=9,text=Re-using existing connection! (#0) with host api.amazon.com

2019-05-30 10:17:55.263 [AVS] V CurlEasyHandleWrapper:libcurl:id=9,text=Connected to api.amazon.com (54.239.26.114) port 443 (#0)

2019-05-30 10:17:55.263 [AVS] V CurlEasyHandleWrapper:libcurl:id=9,text=upload completely sent off\: 88 out of 88 bytes

2019-05-30 10:17:55.586 [AVS] V CurlEasyHandleWrapper:libcurl:id=9,text=Connection #0 to host api.amazon.com left intact

2019-05-30 10:17:55.586 [AVS] V HttpPost:doPostSucceeded:code=400

2019-05-30 10:17:55.586 [AAC] V CBLAuthDelegate:receiveTokenResponse:code=400

2019-05-30 10:17:55.586 [AAC] V CBLAuthDelegate:mapHTTPStatusToError:code=400,error=INVALID_REQUEST

2019-05-30 10:17:55.586 [AAC] V CBLAuthDelegate:errorInLwaResponseBody:error=authorization_pending,errorCode=AUTHORIZATION_PENDING

2019-05-30 10:17:55.587 [AAC] V CBLAuthDelegate:setAuthError:authError=AUTHORIZATION_PENDING

2019-05-30 10:17:55.587 [AAC] V CBLAuthDelegate:receiveTokenResponseFailed:result=AUTHORIZATION_PENDING

2019-05-30 10:18:00.587 [AAC] V CBLAuthDelegate:requestToken

2019-05-30 10:18:00.587 [AVS] V CurlEasyHandleWrapper:libcurl:id=10,text=Found bundle for host api.amazon.com\: 0xffff28001820 [can pipeline]

2019-05-30 10:18:00.587 [AVS] V CurlEasyHandleWrapper:libcurl:id=10,text=Re-using existing connection! (#0) with host api.amazon.com

2019-05-30 10:18:00.587 [AVS] V CurlEasyHandleWrapper:libcurl:id=10,text=Connected to api.amazon.com (54.239.26.114) port 443 (#0)

2019-05-30 10:18:00.587 [AVS] V CurlEasyHandleWrapper:libcurl:id=10,text=upload completely sent off\: 88 out of 88 bytes

2019-05-30 10:18:00.912 [AVS] V CurlEasyHandleWrapper:libcurl:id=10,text=Connection #0 to host api.amazon.com left intact

2019-05-30 10:18:00.912 [AVS] V HttpPost:doPostSucceeded:code=400

2019-05-30 10:18:00.912 [AAC] V CBLAuthDelegate:receiveTokenResponse:code=400

2019-05-30 10:18:00.912 [AAC] V CBLAuthDelegate:mapHTTPStatusToError:code=400,error=INVALID_REQUEST

2019-05-30 10:18:00.912 [AAC] V CBLAuthDelegate:errorInLwaResponseBody:error=authorization_pending,errorCode=AUTHORIZATION_PENDING

2019-05-30 10:18:00.912 [AAC] V CBLAuthDelegate:setAuthError:authError=AUTHORIZATION_PENDING

2019-05-30 10:18:00.912 [AAC] V CBLAuthDelegate:receiveTokenResponseFailed:result=AUTHORIZATION_PENDING

2019-05-30 10:18:05.912 [AAC] V CBLAuthDelegate:requestToken

2019-05-30 10:18:05.912 [AVS] V CurlEasyHandleWrapper:libcurl:id=11,text=Found bundle for host api.amazon.com\: 0xffff28001820 [can pipeline]

2019-05-30 10:18:05.912 [AVS] V CurlEasyHandleWrapper:libcurl:id=11,text=Re-using existing connection! (#0) with host api.amazon.com

2019-05-30 10:18:05.912 [AVS] V CurlEasyHandleWrapper:libcurl:id=11,text=Connected to api.amazon.com (54.239.26.114) port 443 (#0)

2019-05-30 10:18:05.913 [AVS] V CurlEasyHandleWrapper:libcurl:id=11,text=upload completely sent off\: 88 out of 88 bytes

2019-05-30 10:18:06.236 [AVS] V CurlEasyHandleWrapper:libcurl:id=11,text=Connection #0 to host api.amazon.com left intact

2019-05-30 10:18:06.236 [AVS] V HttpPost:doPostSucceeded:code=400

2019-05-30 10:18:06.236 [AAC] V CBLAuthDelegate:receiveTokenResponse:code=400

2019-05-30 10:18:06.236 [AAC] V CBLAuthDelegate:mapHTTPStatusToError:code=400,error=INVALID_REQUEST

2019-05-30 10:18:06.236 [AAC] V CBLAuthDelegate:errorInLwaResponseBody:error=authorization_pending,errorCode=AUTHORIZATION_PENDING

2019-05-30 10:18:06.236 [AAC] V CBLAuthDelegate:setAuthError:authError=AUTHORIZATION_PENDING

2019-05-30 10:18:06.236 [AAC] V CBLAuthDelegate:receiveTokenResponseFailed:result=AUTHORIZATION_PENDING

2019-05-30 10:18:11.236 [AAC] V CBLAuthDelegate:requestToken

2019-05-30 10:18:11.237 [AVS] V CurlEasyHandleWrapper:libcurl:id=12,text=Found bundle for host api.amazon.com\: 0xffff28001820 [can pipeline]

2019-05-30 10:18:11.237 [AVS] V CurlEasyHandleWrapper:libcurl:id=12,text=Re-using existing connection! (#0) with host api.amazon.com

2019-05-30 10:18:11.237 [AVS] V CurlEasyHandleWrapper:libcurl:id=12,text=Connected to api.amazon.com (54.239.26.114) port 443 (#0)

2019-05-30 10:18:11.237 [AVS] V CurlEasyHandleWrapper:libcurl:id=12,text=upload completely sent off\: 88 out of 88 bytes

2019-05-30 10:18:11.561 [AVS] V CurlEasyHandleWrapper:libcurl:id=12,text=Closing connection 0

2019-05-30 10:18:11.561 [AVS] V CurlEasyHandleWrapper:libcurl:id=12,text=TLSv1.2 (OUT)\, TLS alert\, Client hello (1)\:

2019-05-30 10:18:11.561 [AVS] V HttpPost:doPostSucceeded:code=400

2019-05-30 10:18:11.562 [AAC] V CBLAuthDelegate:receiveTokenResponse:code=400

2019-05-30 10:18:11.562 [AAC] V CBLAuthDelegate:mapHTTPStatusToError:code=400,error=INVALID_REQUEST

2019-05-30 10:18:11.562 [AAC] V CBLAuthDelegate:errorInLwaResponseBody:error=authorization_pending,errorCode=AUTHORIZATION_PENDING

2019-05-30 10:18:11.562 [AAC] V CBLAuthDelegate:setAuthError:authError=AUTHORIZATION_PENDING

2019-05-30 10:18:11.562 [AAC] V CBLAuthDelegate:receiveTokenResponseFailed:result=AUTHORIZATION_PENDING

2019-05-30 10:18:16.562 [AAC] V CBLAuthDelegate:requestToken

2019-05-30 10:18:16.562 [AVS] V CurlEasyHandleWrapper:libcurl:id=13,text=Hostname api.amazon.com was found in DNS cache

2019-05-30 10:18:16.562 [AVS] V CurlEasyHandleWrapper:libcurl:id=13,text= Trying 54.239.26.114...

2019-05-30 10:18:16.562 [AVS] V CurlEasyHandleWrapper:libcurl:id=13,text=TCP_NODELAY set

2019-05-30 10:18:18.273 [AVS] V CurlEasyHandleWrapper:libcurl:id=13,text=Connected to api.amazon.com (54.239.26.114) port 443 (#1)

2019-05-30 10:18:18.273 [AVS] V CurlEasyHandleWrapper:libcurl:id=13,text=ALPN\, offering h2

2019-05-30 10:18:18.274 [AVS] V CurlEasyHandleWrapper:libcurl:id=13,text=ALPN\, offering http/1.1

2019-05-30 10:18:18.274 [AVS] V CurlEasyHandleWrapper:libcurl:id=13,text=successfully set certificate verify locations\:

2019-05-30 10:18:18.274 [AVS] V CurlEasyHandleWrapper:libcurl:id=13,text= CAfile\: none

CApath\: /etc/ssl/certs

2019-05-30 10:18:18.274 [AVS] V CurlEasyHandleWrapper:libcurl:id=13,text=SSL re-using session ID

2019-05-30 10:18:18.274 [AVS] V CurlEasyHandleWrapper:libcurl:id=13,text=TLSv1.2 (OUT)\, TLS handshake\, Client hello (1)\:

2019-05-30 10:18:18.532 [AVS] V CurlEasyHandleWrapper:libcurl:id=13,text=TLSv1.2 (IN)\, TLS handshake\, Server hello (2)\:

2019-05-30 10:18:18.532 [AVS] V CurlEasyHandleWrapper:libcurl:id=13,text=TLSv1.2 (IN)\, TLS handshake\, Finished (20)\:

2019-05-30 10:18:18.532 [AVS] V CurlEasyHandleWrapper:libcurl:id=13,text=TLSv1.2 (OUT)\, TLS change cipher\, Client hello (1)\:

2019-05-30 10:18:18.532 [AVS] V CurlEasyHandleWrapper:libcurl:id=13,text=TLSv1.2 (OUT)\, TLS handshake\, Finished (20)\:

2019-05-30 10:18:18.532 [AVS] V CurlEasyHandleWrapper:libcurl:id=13,text=SSL connection using TLSv1.2 / ECDHE-RSA-AES128-GCM-SHA256

2019-05-30 10:18:18.532 [AVS] V CurlEasyHandleWrapper:libcurl:id=13,text=ALPN\, server accepted to use http/1.1

2019-05-30 10:18:18.532 [AVS] V CurlEasyHandleWrapper:libcurl:id=13,text=Server certificate\:

2019-05-30 10:18:18.532 [AVS] V CurlEasyHandleWrapper:libcurl:id=13,text= subject\: C\=US; ST\=Washington; L\=Seattle; O\=Amazon.com\, Inc.; CN\=api.amazon.com

2019-05-30 10:18:18.532 [AVS] V CurlEasyHandleWrapper:libcurl:id=13,text= start date\: Mar 18 00\:00\:00 2019 GMT

2019-05-30 10:18:18.532 [AVS] V CurlEasyHandleWrapper:libcurl:id=13,text= expire date\: Feb 21 12\:00\:00 2020 GMT

2019-05-30 10:18:18.532 [AVS] V CurlEasyHandleWrapper:libcurl:id=13,text= subjectAltName\: host "api.amazon.com" matched cert's "api.amazon.com"

2019-05-30 10:18:18.533 [AVS] V CurlEasyHandleWrapper:libcurl:id=13,text= issuer\: C\=US; O\=DigiCert Inc; CN\=DigiCert Global CA G2

2019-05-30 10:18:18.533 [AVS] V CurlEasyHandleWrapper:libcurl:id=13,text= SSL certificate verify ok.

2019-05-30 10:18:18.533 [AVS] V CurlEasyHandleWrapper:libcurl:id=13,text=upload completely sent off\: 88 out of 88 bytes

2019-05-30 10:18:18.803 [AVS] V CurlEasyHandleWrapper:libcurl:id=13,text=Connection #1 to host api.amazon.com left intact

2019-05-30 10:18:18.803 [AVS] V HttpPost:doPostSucceeded:code=400

2019-05-30 10:18:18.804 [AAC] V CBLAuthDelegate:receiveTokenResponse:code=400

2019-05-30 10:18:18.804 [AAC] V CBLAuthDelegate:mapHTTPStatusToError:code=400,error=INVALID_REQUEST

2019-05-30 10:18:18.804 [AAC] V CBLAuthDelegate:errorInLwaResponseBody:error=authorization_pending,errorCode=AUTHORIZATION_PENDING

2019-05-30 10:18:18.804 [AAC] V CBLAuthDelegate:setAuthError:authError=AUTHORIZATION_PENDING

2019-05-30 10:18:18.804 [AAC] V CBLAuthDelegate:receiveTokenResponseFailed:result=AUTHORIZATION_PENDING

2019-05-30 10:18:23.804 [AAC] V CBLAuthDelegate:requestToken

2019-05-30 10:18:23.804 [AVS] V CurlEasyHandleWrapper:libcurl:id=14,text=Found bundle for host api.amazon.com\: 0xffff28001860 [can pipeline]

2019-05-30 10:18:23.804 [AVS] V CurlEasyHandleWrapper:libcurl:id=14,text=Re-using existing connection! (#1) with host api.amazon.com

2019-05-30 10:18:23.804 [AVS] V CurlEasyHandleWrapper:libcurl:id=14,text=Connected to api.amazon.com (54.239.26.114) port 443 (#1)

2019-05-30 10:18:23.804 [AVS] V CurlEasyHandleWrapper:libcurl:id=14,text=upload completely sent off\: 88 out of 88 bytes

2019-05-30 10:18:24.156 [AVS] V CurlEasyHandleWrapper:libcurl:id=14,text=Connection #1 to host api.amazon.com left intact

2019-05-30 10:18:24.157 [AVS] V HttpPost:doPostSucceeded:code=400

2019-05-30 10:18:24.157 [AAC] V CBLAuthDelegate:receiveTokenResponse:code=400

2019-05-30 10:18:24.157 [AAC] V CBLAuthDelegate:mapHTTPStatusToError:code=400,error=INVALID_REQUEST

2019-05-30 10:18:24.157 [AAC] V CBLAuthDelegate:errorInLwaResponseBody:error=authorization_pending,errorCode=AUTHORIZATION_PENDING

2019-05-30 10:18:24.157 [AAC] V CBLAuthDelegate:setAuthError:authError=AUTHORIZATION_PENDING

2019-05-30 10:18:24.157 [AAC] V CBLAuthDelegate:receiveTokenResponseFailed:result=AUTHORIZATION_PENDING

2019-05-30 10:18:29.157 [AAC] V CBLAuthDelegate:requestToken

2019-05-30 10:18:29.157 [AVS] V CurlEasyHandleWrapper:libcurl:id=15,text=Found bundle for host api.amazon.com\: 0xffff28001860 [can pipeline]

2019-05-30 10:18:29.157 [AVS] V CurlEasyHandleWrapper:libcurl:id=15,text=Re-using existing connection! (#1) with host api.amazon.com

2019-05-30 10:18:29.157 [AVS] V CurlEasyHandleWrapper:libcurl:id=15,text=Connected to api.amazon.com (54.239.26.114) port 443 (#1)

2019-05-30 10:18:29.157 [AVS] V CurlEasyHandleWrapper:libcurl:id=15,text=upload completely sent off\: 88 out of 88 bytes

2019-05-30 10:18:29.482 [AVS] V CurlEasyHandleWrapper:libcurl:id=15,text=Connection #1 to host api.amazon.com left intact

2019-05-30 10:18:29.482 [AVS] V HttpPost:doPostSucceeded:code=200

2019-05-30 10:18:29.482 [AAC] V CBLAuthDelegate:receiveTokenResponse:code=200

2019-05-30 10:18:29.482 [AAC] V CBLAuthDelegate:mapHTTPStatusToError:code=200,error=SUCCESS

2019-05-30 10:18:29.482 [AAC] V CBLAuthDelegate:setAuthError:authError=SUCCESS

2019-05-30 10:18:29.482 [AAC] V CBLAuthDelegate:handleRefreshingToken

2019-05-30 10:18:29.482 [CLI] I CBLHandler:cblStateChanged:state=REFRESHING_TOKEN,reason=SUCCESS,url=,code=

2019-05-30 10:18:29.482 [AAC] V CBLAuthDelegate:requestRefresh

2019-05-30 10:18:29.482 [AVS] V CurlEasyHandleWrapper:libcurl:id=16,text=Found bundle for host api.amazon.com\: 0xffff28001860 [can pipeline]

2019-05-30 10:18:29.482 [AVS] V CurlEasyHandleWrapper:libcurl:id=16,text=Re-using existing connection! (#1) with host api.amazon.com

2019-05-30 10:18:29.482 [AVS] V CurlEasyHandleWrapper:libcurl:id=16,text=Connected to api.amazon.com (54.239.26.114) port 443 (#1)

2019-05-30 10:18:29.482 [AVS] V CurlEasyHandleWrapper:libcurl:id=16,text=upload completely sent off\: 658 out of 658 bytes

2019-05-30 10:18:29.891 [AVS] V CurlEasyHandleWrapper:libcurl:id=16,text=Connection #1 to host api.amazon.com left intact

2019-05-30 10:18:29.891 [AVS] V HttpPost:doPostSucceeded:code=200

2019-05-30 10:18:29.891 [AAC] V CBLAuthDelegate:receiveTokenResponse:code=200

2019-05-30 10:18:29.891 [AAC] V CBLAuthDelegate:mapHTTPStatusToError:code=200,error=SUCCESS

2019-05-30 10:18:29.891 [AAC] V CBLAuthDelegate:setAuthError:authError=SUCCESS

2019-05-30 10:18:29.891 [AAC] V CBLAuthDelegate:setAuthState:newAuthState=REFRESHED

2019-05-30 10:18:29.891 [AAC] V CBLAuthDelegate:callingOnAuthStateChange:state=REFRESHED,error=SUCCESS

2019-05-30 10:18:29.891 [AAC] I aace.alexa.AlexaEngineService:onAuthStateChange:state=REFRESHED,error=SUCCESS

2019-05-30 10:18:29.891 [AAC] V aace.alexa.AlexaEngineService:Publishing capabilities

2019-05-30 10:18:29.891 [AVS] V CapabilitiesDelegate:setCapabilitiesPublishOverride::overriding capabilities publish

2019-05-30 10:18:29.893 [AVS] V CapabilitiesDelegate:getCapabilityConfigsStringFromJsonFailed::Interface configurations not available

2019-05-30 10:18:29.893 [AVS] V CapabilitiesDelegate:getCapabilityConfigsStringFromJsonFailed::Interface configurations not available

2019-05-30 10:18:29.894 [AVS] V CapabilitiesDelegate:getCapabilityConfigsStringFromJsonFailed::Interface configurations not available

2019-05-30 10:18:29.894 [AVS] V CapabilitiesDelegate:getCapabilityConfigsStringFromJsonFailed::Interface configurations not available

2019-05-30 10:18:29.894 [AVS] V CapabilitiesDelegate:getCapabilityConfigsStringFromJsonFailed::Interface configurations not available

2019-05-30 10:18:29.894 [AVS] V CapabilitiesDelegate:getCapabilityConfigsStringFromJsonFailed::Interface configurations not available

2019-05-30 10:18:29.894 [AVS] V CapabilitiesDelegate:getCapabilityConfigsStringFromJsonFailed::Interface configurations not available

2019-05-30 10:18:29.894 [AVS] V CapabilitiesDelegate:getCapabilityConfigsStringFromJsonFailed::Interface configurations not available

2019-05-30 10:18:29.894 [AVS] V CapabilitiesDelegate:getCapabilityConfigsStringFromJsonFailed::Interface configurations not available

2019-05-30 10:18:29.894 [AVS] V CapabilitiesDelegate:getCapabilityConfigsStringFromJsonFailed::Interface configurations not available

2019-05-30 10:18:29.894 [AVS] V CapabilitiesDelegate:getCapabilityConfigsStringFromJsonFailed::Interface configurations not available

2019-05-30 10:18:29.894 [AVS] V CapabilitiesDelegate:getCapabilityConfigsStringFromJsonFailed::Interface configurations not available

2019-05-30 10:18:29.894 [AVS] V CapabilitiesDelegate:getCapabilityConfigsStringFromJsonFailed::Interface configurations not available

2019-05-30 10:18:29.894 [AVS] V CapabilitiesDelegate:getCapabilityConfigsStringFromJsonFailed::Interface configurations not available

2019-05-30 10:18:29.894 [AVS] V CapabilitiesDelegate:getCapabilityConfigsStringFromJsonFailed::Interface configurations not available

2019-05-30 10:18:29.894 [AVS] V CapabilitiesDelegate:getCapabilityConfigsStringFromJsonFailed::Interface configurations not available

2019-05-30 10:18:29.894 [AVS] V CapabilitiesDelegate:getCapabilityConfigsStringFromJsonFailed::Interface configurations not available

2019-05-30 10:18:29.894 [AVS] V CapabilitiesDelegate:getCapabilityConfigsStringFromJsonFailed::Interface configurations not available

2019-05-30 10:18:29.894 [AVS] V CapabilitiesDelegate:getCapabilityConfigsStringFromJsonFailed::Interface configurations not available

2019-05-30 10:18:29.894 [AVS] V CapabilitiesDelegate:getCapabilityConfigsStringFromJsonFailed::Interface configurations not available

2019-05-30 10:18:29.894 [CLI] I AlexaClientHandler:REFRESHED/NO_ERROR

2019-05-30 10:18:30.147 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text= Trying 13.35.214.92...

2019-05-30 10:18:30.147 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text=TCP_NODELAY set

2019-05-30 10:18:30.215 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text=Connected to api.amazonalexa.com (13.35.214.92) port 443 (#0)

2019-05-30 10:18:30.215 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text=ALPN\, offering h2

2019-05-30 10:18:30.215 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text=ALPN\, offering http/1.1

2019-05-30 10:18:30.215 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text=successfully set certificate verify locations\:

2019-05-30 10:18:30.215 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text= CAfile\: none

CApath\: /etc/ssl/certs

2019-05-30 10:18:30.215 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text=TLSv1.2 (OUT)\, TLS handshake\, Client hello (1)\:

2019-05-30 10:18:30.303 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text=TLSv1.2 (IN)\, TLS handshake\, Server hello (2)\:

2019-05-30 10:18:30.305 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text=TLSv1.2 (IN)\, TLS handshake\, Certificate (11)\:

2019-05-30 10:18:30.307 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text=TLSv1.2 (IN)\, TLS handshake\, Server key exchange (12)\:

2019-05-30 10:18:30.307 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text=TLSv1.2 (IN)\, TLS handshake\, Server finished (14)\:

2019-05-30 10:18:30.308 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text=TLSv1.2 (OUT)\, TLS handshake\, Client key exchange (16)\:

2019-05-30 10:18:30.308 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text=TLSv1.2 (OUT)\, TLS change cipher\, Client hello (1)\:

2019-05-30 10:18:30.308 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text=TLSv1.2 (OUT)\, TLS handshake\, Finished (20)\:

2019-05-30 10:18:30.388 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text=TLSv1.2 (IN)\, TLS handshake\, Finished (20)\:

2019-05-30 10:18:30.388 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text=SSL connection using TLSv1.2 / ECDHE-RSA-AES128-GCM-SHA256

2019-05-30 10:18:30.388 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text=ALPN\, server accepted to use h2

2019-05-30 10:18:30.389 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text=Server certificate\:

2019-05-30 10:18:30.389 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text= subject\: CN\=api.amazonalexa.com

2019-05-30 10:18:30.389 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text= start date\: May 3 00\:00\:00 2019 GMT

2019-05-30 10:18:30.389 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text= expire date\: Apr 26 12\:00\:00 2020 GMT

2019-05-30 10:18:30.389 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text= subjectAltName\: host "api.amazonalexa.com" matched cert's "api.amazonalexa.com"

2019-05-30 10:18:30.389 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text= issuer\: C\=US; O\=Amazon; OU\=Server CA 1B; CN\=Amazon

2019-05-30 10:18:30.389 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text= SSL certificate verify ok.

2019-05-30 10:18:30.389 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text=Using HTTP2\, server supports multi-use

2019-05-30 10:18:30.389 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text=Connection state changed (HTTP/2 confirmed)

2019-05-30 10:18:30.389 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text=Copying HTTP/2 data in stream buffer to connection buffer after upgrade\: len\=0

2019-05-30 10:18:30.389 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text=Using Stream ID\: 1 (easy handle 0xaaaadcd01de0)

2019-05-30 10:18:30.390 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text=We are completely uploaded and fine

2019-05-30 10:18:30.390 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text=Connection state changed (MAX_CONCURRENT_STREAMS updated)!

2019-05-30 10:18:30.928 [AVS] V CurlEasyHandleWrapper:libcurl:id=17,text=Connection #0 to host api.amazonalexa.com left intact

2019-05-30 10:18:30.928 [AVS] V CapabilitiesDelegate:setCapabilitiesState:newCapabilitiesState=SUCCESS

2019-05-30 10:18:30.928 [AVS] V CapabilitiesDelegate:callingOnCapabilitiesStateChange:state=SUCCESS,error=SUCCESS

2019-05-30 10:18:30.928 [AAC] I aace.alexa.AlexaEngineService:onCapabilitiesStateChange:newState=SUCCESS

2019-05-30 10:18:30.928 [AVS] V MessageRouter:connectionStatusChanged:reason=ACL_CLIENT_REQUEST,newStatus=PENDING

2019-05-30 10:18:30.928 [AVS] V LibcurlHTTP2ConnectionFactory:createHTTP2Connection

2019-05-30 10:18:30.928 [AVS] V HTTP2Transport:create:authDelegate=0xaaaadcc94010,avsEndpoint=https\://avs-alexa-na.amazon.com,http2Connection=0xffff2c02fc20,messageConsumer=0xaaaadcd44ea0,attachmentManager=0xaaaadcd440e0,transportObserver=0xaaaadcd44e98,postConnectFactory=0xaaaadcd44af0

2019-05-30 10:18:30.928 [AVS] V HTTP2Transport:HTTP2Transport:authDelegate=0xaaaadcc94010,avsEndpoint=https\://avs-alexa-na.amazon.com,http2Connection=0xffff2c02fc20,messageConsumer=0xaaaadcd44ea0,attachmentManager=0xaaaadcd440e0,transportObserver=0xaaaadcd44e98,postConnectFactory=0xaaaadcd44af0

2019-05-30 10:18:30.929 [AVS] V HTTP2Transport:connect

2019-05-30 10:18:30.929 [AVS] V HTTP2Transport:setStateLocked:newState=AUTHORIZING,changedReason=ACL_CLIENT_REQUEST

2019-05-30 10:18:30.929 [AVS] V HTTP2Transport:mainLoop

2019-05-30 10:18:30.930 [AVS] V SoftwareInfoSender:onConnectionStatusChanged:status=PENDING,reason=ACL_CLIENT_REQUEST

2019-05-30 10:18:30.930 [CLI] I AlexaClientHandler:PENDING/ACL_CLIENT_REQUEST

2019-05-30 10:18:30.930 [AVS] V LibcurlHTTP2Connection:networkLoop

2019-05-30 10:18:30.930 [AVS] V PostConnectSynchronizer:doPostConnect

2019-05-30 10:18:30.930 [AVS] V PostConnectSynchronizer:setState:from=IDLE,to=RUNNING

2019-05-30 10:18:30.930 [AVS] V AlertsCapabilityAgent:executeOnConnectionStatusChanged:status=PENDING,reason=ACL_CLIENT_REQUEST

2019-05-30 10:18:30.930 [AVS] V PostConnectSynchronizer:mainLoop

2019-05-30 10:18:30.930 [AVS] V PostConnectSynchronizer:setState:from=RUNNING,to=FETCHING

2019-05-30 10:18:30.931 [AVS] V NotificationsCapabilityAgent:provideState:stateRequestToken=1

2019-05-30 10:18:30.931 [AVS] V VisualActivityTracker:provideState

2019-05-30 10:18:30.931 [AVS] V NotificationsCapabilityAgent:executeProvideState:sendToken=true,stateRequestToken=1

2019-05-30 10:18:30.931 [AVS] V ContextManager:updateStateLocked:action=updatedState,state={"timestamp"\:"2019-05-30T10\:18\:30+00\:00"\,"coordinate"\:{"latitudeInDegrees"\:37.3790629\,"longitudeInDegrees"\:-122.116578\,"accuracyInMeters"\:0.0}},namespace=Geolocation,name=GeolocationState

2019-05-30 10:18:30.931 [AVS] V ContextManager:updateStateLocked:action=updatedState,state={"isEnabled"\:false\,"isVisualIndicatorPersisted"\:false},namespace=Notifications,name=IndicatorState

2019-05-30 10:18:30.931 [AVS] V ExternalMediaPlayer:executeProvideState:sendToken=true,stateRequestToken=1

2019-05-30 10:18:30.931 [AVS] V AudioActivityTracker:provideState

2019-05-30 10:18:30.931 [AVS] V AudioPlayer:provideState:stateRequestToken=1

2019-05-30 10:18:30.931 [AVS] V SpeechSynthesizer:provideState:token=1

2019-05-30 10:18:30.931 [AVS] V ContextManager:updateStateLocked:action=updatedState,state={"state"\:"IDLE"\,"supportedOperations"\:[]\,"shuffle"\:"NOT_SHUFFLED"\,"repeat"\:"NOT_REPEATED"\,"favorite"\:"NOT_RATED"\,"positionMilliseconds"\:0\,"uncertaintyInMilliseconds"\:0\,"players"\:[{"playerId"\:""\,"state"\:"IDLE"\,"supportedOperations"\:["Play"\,"Pause"\,"Stop"]\,"positionMilliseconds"\:0\,"shuffle"\:"NOT_SHUFFLED"\,"repeat"\:"NOT_REPEATED"\,"favorite"\:"NOT_RATED"\,"media"\:{"type"\:"ExternalMediaPlayerMusicItem"\,"value"\:{"playbackSource"\:"mock playbackSource"\,"playbackSourceId"\:"mock playbackSourceId"\,"trackName"\:"mock trackName"\,"trackId"\:""\,"trackNumber"\:"mock trackNumber"\,"artist"\:"mock artistName"\,"artistId"\:""\,"album"\:"mock albumName"\,"albumId"\:""\,"coverUrls"\:{"tiny"\:""\,"small"\:""\,"medium"\:""\,"large"\:""}\,"coverId"\:""\,"mediaProvider"\:"Local CD Player"\,"mediaType"\:"TRACK"\,"durationInMilliseconds"\:60000}}}]},namespace=Alexa.PlaybackStateReporter,name=playbackState

2019-05-30 10:18:30.931 [AVS] V AudioPlayer:executeProvideState:sendToken=true,stateRequestToken=1

2019-05-30 10:18:30.932 [AVS] V ExternalMediaPlayer:executeProvideState:sendToken=true,stateRequestToken=1

2019-05-30 10:18:30.932 [AVS] V VisualActivityTracker:executeProvideState

2019-05-30 10:18:30.932 [AVS] V ContextManager:updateStateLocked:action=updatedState,state=,namespace=VisualActivityTracker,name=ActivityState

2019-05-30 10:18:30.932 [AVS] V ContextManager:updateStateLocked:action=updatedState,state={"token"\:""\,"offsetInMilliseconds"\:0\,"playerActivity"\:"IDLE"},namespace=AudioPlayer,name=PlaybackState

2019-05-30 10:18:30.932 [AVS] V AudioActivityTracker:executeProvideState

2019-05-30 10:18:30.932 [AVS] V ContextManager:updateStateLocked:action=updatedState,state=,namespace=AudioActivityTracker,name=ActivityState

2019-05-30 10:18:30.932 [AVS] V ContextManager:updateStateLocked:action=updatedState,state={"playerInFocus"\:""\,"spiVersion"\:"1.0"\,"agent"\:"RUHAV8PRLD"\,"players"\:[]},namespace=ExternalMediaPlayer,name=ExternalMediaPlayerState

2019-05-30 10:18:30.932 [AVS] V SpeechSynthesizer:executeProvideState:stateRequestToken=1

2019-05-30 10:18:30.932 [AVS] V ContextManager:updateStateLocked:action=updatedState,state={"token"\:""\,"offsetInMilliseconds"\:0\,"playerActivity"\:"FINISHED"},namespace=SpeechSynthesizer,name=SpeechState

2019-05-30 10:18:30.932 [AVS] V ContextManager:buildContextIgnored:namespace=VisualActivityTracker,name=ActivityState

2019-05-30 10:18:30.933 [AVS] V ContextManager:buildContextIgnored:namespace=AudioActivityTracker,name=ActivityState

2019-05-30 10:18:30.933 [AVS] V ContextManager:buildContextSuccessful:context={"context"\:[{"header"\:{"namespace"\:"Geolocation"\,"name"\:"GeolocationState"}\,"payload"\:{"timestamp"\:"2019-05-30T10\:18\:30+00\:00"\,"coordinate"\:{"latitudeInDegrees"\:37.3790629\,"longitudeInDegrees"\:-122.116578\,"accuracyInMeters"\:0.0}}}\,{"header"\:{"namespace"\:"Notifications"\,"name"\:"IndicatorState"}\,"payload"\:{"isEnabled"\:false\,"isVisualIndicatorPersisted"\:false}}\,{"header"\:{"namespace"\:"Alexa.PlaybackStateReporter"\,"name"\:"playbackState"}\,"payload"\:{"state"\:"IDLE"\,"supportedOperations"\:[]\,"shuffle"\:"NOT_SHUFFLED"\,"repeat"\:"NOT_REPEATED"\,"favorite"\:"NOT_RATED"\,"positionMilliseconds"\:0\,"uncertaintyInMilliseconds"\:0\,"players"\:[{"playerId"\:""\,"state"\:"IDLE"\,"supportedOperations"\:["Play"\,"Pause"\,"Stop"]\,"positionMilliseconds"\:0\,"shuffle"\:"NOT_SHUFFLED"\,"repeat"\:"NOT_REPEATED"\,"favorite"\:"NOT_RATED"\,"media"\:{"type"\:"ExternalMediaPlayerMusicItem"\,"value"\:{"playbackSource"\:"mock playbackSource"\,"playbackSourceId"\:"mock playbackSourceId"\,"trackName"\:"mock trackName"\,"trackId"\:""\,"trackNumber"\:"mock trackNumber"\,"artist"\:"mock artistName"\,"artistId"\:""\,"album"\:"mock albumName"\,"albumId"\:""\,"coverUrls"\:{"tiny"\:""\,"small"\:""\,"medium"\:""\,"large"\:""}\,"coverId"\:""\,"mediaProvider"\:"Local CD Player"\,"mediaType"\:"TRACK"\,"durationInMilliseconds"\:60000}}}]}}\,{"header"\:{"namespace"\:"Alexa.Comms.PhoneCallController"\,"name"\:"PhoneCallControllerState"}\,"payload"\:{"device"\:{"connectionState"\:"DISCONNECTED"}\,"configuration"\:{"callingFeature"\:[{"OVERRIDE_RINGTONE_SUPPORTED"\:false}]}\,"allCalls"\:[]}}\,{"header"\:{"namespace"\:"Alerts"\,"name"\:"AlertsState"}\,"payload"\:{"allAlerts"\:[]\,"activeAlerts"\:[]}}\,{"header"\:{"namespace"\:"AudioPlayer"\,"name"\:"PlaybackState"}\,"payload"\:{"token"\:""\,"offsetInMilliseconds"\:0\,"playerActivity"\:"IDLE"}}\,{"header"\:{"namespace"\:"EqualizerController"\,"name"\:"EqualizerState"}\,"payload"\:{"bands"\:[{"name"\:"MIDRANGE"\,"level"\:0}\,{"name"\:"TREBLE"\,"level"\:0}\,{"name"\:"BASS"\,"level"\:0}]}}\,{"header"\:{"namespace"\:"SpeechSynthesizer"\,"name"\:"SpeechState"}\,"payload"\:{"token"\:""\,"offsetInMilliseconds"\:0\,"playerActivity"\:"FINISHED"}}\,{"header"\:{"namespace"\:"ExternalMediaPlayer"\,"name"\:"ExternalMediaPlayerState"}\,"payload"\:{"playerInFocus"\:""\,"spiVersion"\:"1.0"\,"agent"\:"RUHAV8PRLD"\,"players"\:[]}}]}

2019-05-30 10:18:30.933 [AVS] V PostConnectSynchronizer:onContextAvailable:context={"context"\:[{"header"\:{"namespace"\:"Geolocation"\,"name"\:"GeolocationState"}\,"payload"\:{"timestamp"\:"2019-05-30T10\:18\:30+00\:00"\,"coordinate"\:{"latitudeInDegrees"\:37.3790629\,"longitudeInDegrees"\:-122.116578\,"accuracyInMeters"\:0.0}}}\,{"header"\:{"namespace"\:"Notifications"\,"name"\:"IndicatorState"}\,"payload"\:{"isEnabled"\:false\,"isVisualIndicatorPersisted"\:false}}\,{"header"\:{"namespace"\:"Alexa.PlaybackStateReporter"\,"name"\:"playbackState"}\,"payload"\:{"state"\:"IDLE"\,"supportedOperations"\:[]\,"shuffle"\:"NOT_SHUFFLED"\,"repeat"\:"NOT_REPEATED"\,"favorite"\:"NOT_RATED"\,"positionMilliseconds"\:0\,"uncertaintyInMilliseconds"\:0\,"players"\:[{"playerId"\:""\,"state"\:"IDLE"\,"supportedOperations"\:["Play"\,"Pause"\,"Stop"]\,"positionMilliseconds"\:0\,"shuffle"\:"NOT_SHUFFLED"\,"repeat"\:"NOT_REPEATED"\,"favorite"\:"NOT_RATED"\,"media"\:{"type"\:"ExternalMediaPlayerMusicItem"\,"value"\:{"playbackSource"\:"mock playbackSource"\,"playbackSourceId"\:"mock playbackSourceId"\,"trackName"\:"mock trackName"\,"trackId"\:""\,"trackNumber"\:"mock trackNumber"\,"artist"\:"mock artistName"\,"artistId"\:""\,"album"\:"mock albumName"\,"albumId"\:""\,"coverUrls"\:{"tiny"\:""\,"small"\:""\,"medium"\:""\,"large"\:""}\,"coverId"\:""\,"mediaProvider"\:"Local CD Player"\,"mediaType"\:"TRACK"\,"durationInMilliseconds"\:60000}}}]}}\,{"header"\:{"namespace"\:"Alexa.Comms.PhoneCallController"\,"name"\:"PhoneCallControllerState"}\,"payload"\:{"device"\:{"connectionState"\:"DISCONNECTED"}\,"configuration"\:{"callingFeature"\:[{"OVERRIDE_RINGTONE_SUPPORTED"\:false}]}\,"allCalls"\:[]}}\,{"header"\:{"namespace"\:"Alerts"\,"name"\:"AlertsState"}\,"payload"\:{"allAlerts"\:[]\,"activeAlerts"\:[]}}\,{"header"\:{"namespace"\:"AudioPlayer"\,"name"\:"PlaybackState"}\,"payload"\:{"token"\:""\,"offsetInMilliseconds"\:0\,"playerActivity"\:"IDLE"}}\,{"header"\:{"namespace"\:"EqualizerController"\,"name"\:"EqualizerState"}\,"payload"\:{"bands"\:[{"name"\:"MIDRANGE"\,"level"\:0}\,{"name"\:"TREBLE"\,"level"\:0}\,{"name"\:"BASS"\,"level"\:0}]}}\,{"header"\:{"namespace"\:"SpeechSynthesizer"\,"name"\:"SpeechState"}\,"payload"\:{"token"\:""\,"offsetInMilliseconds"\:0\,"playerActivity"\:"FINISHED"}}\,{"header"\:{"namespace"\:"ExternalMediaPlayer"\,"name"\:"ExternalMediaPlayerState"}\,"payload"\:{"playerInFocus"\:""\,"spiVersion"\:"1.0"\,"agent"\:"RUHAV8PRLD"\,"players"\:[]}}]}

2019-05-30 10:18:30.933 [AVS] V PostConnectSynchronizer:setState:from=FETCHING,to=SENDING

2019-05-30 10:18:30.933 [AVS] V EventBuilder:buildJsonEventString:messageId=52338466-a780-4c64-ad9d-a3145c4dd4af,namespace=System,name=SynchronizeState

2019-05-30 10:18:30.934 [AVS] V HTTP2Transport:sendPostConnectMessage

2019-05-30 10:18:30.934 [AVS] V HTTP2Transport:enqueueRequest:beforeConnected=true

2019-05-30 10:18:30.930 [AVS] V HTTP2Transport:handleAuthorizing

2019-05-30 10:18:30.939 [AAC] V CBLAuthDelegate:addAuthObserver:observer=0xffff2c01c300

2019-05-30 10:18:30.939 [AVS] V HTTP2Transport:onAuthStateChange:newState=REFRESHED,error=SUCCESS

2019-05-30 10:18:30.939 [AVS] V HTTP2Transport:setStateLocked:newState=CONNECTING,changedReason=SUCCESS

2019-05-30 10:18:30.939 [AVS] V HTTP2Transport:handleConnecting

2019-05-30 10:18:30.940 [AVS] V DownchannelHandler:create:context=0xffff2c01c308

2019-05-30 10:18:30.940 [AVS] V ExchangeHandler:ExchangeHandler:context=0xffff2c01c308,authToken=Atza|IwEBIMdQVCOt-PolmyZvdY04mpLx4Ncbuw68v4OV6tohXwqf3xT-sSG1NeIa8isDds49rPnmnXULANdFwjQpdRL4asfDhlD6WCmtvl6x1OG94lpr3tD_DzLhdkn1_-I4mYv0L7BQo7_SnS-h6EQivKyfDKUaZIxAeX4lzyfLrfhJf4I-XMoMIBpaAMkD26UjyTOGiV5Ay_RhNSU8Idp131Rmzq9kGQkxwEERrIyiorjDej_NciFzQuWsmjQ7dD6FJ15RCidGaVPQ5vR7AlTsg62QsZPRUbNEIuT_LEos-bw5AfTiBQzUP-sFIXyBdvq1aYluAP0RJUASZIQvy_Cd9ceA5qhIP2vvKuIAFagEtzgG5LSjktwgxIL2b4PoEytwcFISOSiBLKvVnVwnAKW7tPhdeFyVjx0Wy1yRPMpBSFR5Gux2HOawZmNlmjyf2XeWbnTOAPfQPIy6-qaEHKiYZRhKtA0eCmU2CrO6H5BfBtB3GcL8D6CeaKt3Ib5o-CX2r_rP2GgpBDEYOKjsHDtFvwIgtPWuj8RgSd-F-WnwYEtz09QxQQ

2019-05-30 10:18:30.940 [AVS] V DownchannelHandler:DownchannelHandler:context=0xffff2c01c308

2019-05-30 10:18:30.940 [AVS] V MimeResponseSink:MimeResponseSink:handler=0xffff1c001610

2019-05-30 10:18:30.940 [AVS] V HTTP2MimeResponseDecoder:HTTP2MimeResponseDecoder

2019-05-30 10:18:30.940 [AVS] V HTTP2Transport:createAndSendRequest:type=GET,url=https\://avs-alexa-na.amazon.com/v20160207/directives

2019-05-30 10:18:30.940 [AVS] V DownchannelHandler:getRequestHeaderLines

2019-05-30 10:18:30.941 [AVS] V LibcurlHTTP2Connection:insertActiveStream:handle=0xffff1c002f30,streamId=AVSDownChannel-1

2019-05-30 10:18:31.007 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-1,text= Trying 54.239.26.171...

2019-05-30 10:18:31.008 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-1,text=TCP_NODELAY set

2019-05-30 10:18:31.313 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-1,text=Connected to avs-alexa-na.amazon.com (54.239.26.171) port 443 (#0)

2019-05-30 10:18:31.314 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-1,text=ALPN\, offering h2

2019-05-30 10:18:31.314 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-1,text=ALPN\, offering http/1.1

2019-05-30 10:18:31.314 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-1,text=successfully set certificate verify locations\:

2019-05-30 10:18:31.314 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-1,text= CAfile\: none

CApath\: /etc/ssl/certs

2019-05-30 10:18:31.314 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-1,text=TLSv1.2 (OUT)\, TLS handshake\, Client hello (1)\:

2019-05-30 10:18:31.628 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-1,text=TLSv1.2 (IN)\, TLS handshake\, Server hello (2)\:

2019-05-30 10:18:31.635 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-1,text=TLSv1.2 (IN)\, TLS handshake\, Certificate (11)\:

2019-05-30 10:18:31.637 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-1,text=TLSv1.2 (OUT)\, TLS alert\, Server hello (2)\:

2019-05-30 10:18:31.637 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-1,text=SSL certificate problem\: certificate is not yet valid

2019-05-30 10:18:31.637 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-1,text=stopped the pause stream!

2019-05-30 10:18:31.637 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-1,text=Closing connection 0

2019-05-30 10:18:31.638 [AVS] V HTTP2MimeResponseDecoder:onResponseFinished:status=COMPLETE

2019-05-30 10:18:31.638 [AVS] V MimeResponseSink:onResponseFinished:status=COMPLETE

2019-05-30 10:18:31.638 [AVS] V DownchannelHandler:onResponseFinished:status=COMPLETE,nonMimeBody=

2019-05-30 10:18:31.638 [AVS] V HTTP2Transport:onDownchannelFinished

2019-05-30 10:18:31.638 [AVS] V HTTP2Transport:setStateLocked:newState=WAITING_TO_RETRY_CONNECTING,changedReason=NONE

2019-05-30 10:18:31.638 [AVS] V LibcurlHTTP2Connection:streamFinished:streamId=AVSDownChannel-1,result=Peer certificate cannot be authenticated with given CA certificates,CURLcode=60

2019-05-30 10:18:31.638 [AVS] V LibcurlHTTP2Connection:releaseStream:streamId=AVSDownChannel-1

2019-05-30 10:18:31.638 [AVS] V HTTP2Transport:handleWaitingToRetryConnecting

2019-05-30 10:18:31.638 [AVS] V HTTP2Transport:handleConnectingWaitingToRetry:connectRetryCount=0,timeout=165

2019-05-30 10:18:31.803 [AVS] V HTTP2Transport:setStateLocked:newState=CONNECTING,changedReason=NONE

2019-05-30 10:18:31.803 [AVS] V HTTP2Transport:handleConnecting

2019-05-30 10:18:31.803 [AVS] V DownchannelHandler:create:context=0xffff2c01c308

2019-05-30 10:18:31.804 [AVS] V ExchangeHandler:ExchangeHandler:context=0xffff2c01c308,authToken=Atza|IwEBIMdQVCOt-PolmyZvdY04mpLx4Ncbuw68v4OV6tohXwqf3xT-sSG1NeIa8isDds49rPnmnXULANdFwjQpdRL4asfDhlD6WCmtvl6x1OG94lpr3tD_DzLhdkn1_-I4mYv0L7BQo7_SnS-h6EQivKyfDKUaZIxAeX4lzyfLrfhJf4I-XMoMIBpaAMkD26UjyTOGiV5Ay_RhNSU8Idp131Rmzq9kGQkxwEERrIyiorjDej_NciFzQuWsmjQ7dD6FJ15RCidGaVPQ5vR7AlTsg62QsZPRUbNEIuT_LEos-bw5AfTiBQzUP-sFIXyBdvq1aYluAP0RJUASZIQvy_Cd9ceA5qhIP2vvKuIAFagEtzgG5LSjktwgxIL2b4PoEytwcFISOSiBLKvVnVwnAKW7tPhdeFyVjx0Wy1yRPMpBSFR5Gux2HOawZmNlmjyf2XeWbnTOAPfQPIy6-qaEHKiYZRhKtA0eCmU2CrO6H5BfBtB3GcL8D6CeaKt3Ib5o-CX2r_rP2GgpBDEYOKjsHDtFvwIgtPWuj8RgSd-F-WnwYEtz09QxQQ

2019-05-30 10:18:31.804 [AVS] V DownchannelHandler:DownchannelHandler:context=0xffff2c01c308

2019-05-30 10:18:31.804 [AVS] V MimeResponseSink:MimeResponseSink:handler=0xffff1c001610

2019-05-30 10:18:31.804 [AVS] V HTTP2MimeResponseDecoder:HTTP2MimeResponseDecoder

2019-05-30 10:18:31.804 [AVS] V HTTP2Transport:createAndSendRequest:type=GET,url=https\://avs-alexa-na.amazon.com/v20160207/directives

2019-05-30 10:18:31.804 [AVS] V DownchannelHandler:getRequestHeaderLines

2019-05-30 10:18:31.804 [AVS] V LibcurlHTTP2Connection:insertActiveStream:handle=0xffff1c0033f0,streamId=AVSDownChannel-3

2019-05-30 10:18:31.812 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-3,text= Trying 54.239.26.171...

2019-05-30 10:18:31.812 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-3,text=TCP_NODELAY set

2019-05-30 10:18:32.103 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-3,text=Connected to avs-alexa-na.amazon.com (54.239.26.171) port 443 (#0)

2019-05-30 10:18:32.103 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-3,text=ALPN\, offering h2

2019-05-30 10:18:32.103 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-3,text=ALPN\, offering http/1.1

2019-05-30 10:18:32.103 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-3,text=successfully set certificate verify locations\:

2019-05-30 10:18:32.103 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-3,text= CAfile\: none

CApath\: /etc/ssl/certs

2019-05-30 10:18:32.104 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-3,text=TLSv1.2 (OUT)\, TLS handshake\, Client hello (1)\:

2019-05-30 10:18:32.400 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-3,text=TLSv1.2 (IN)\, TLS handshake\, Server hello (2)\:

2019-05-30 10:18:32.405 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-3,text=TLSv1.2 (IN)\, TLS handshake\, Certificate (11)\:

2019-05-30 10:18:32.407 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-3,text=TLSv1.2 (OUT)\, TLS alert\, Server hello (2)\:

2019-05-30 10:18:32.407 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-3,text=SSL certificate problem\: certificate is not yet valid

2019-05-30 10:18:32.407 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-3,text=stopped the pause stream!

2019-05-30 10:18:32.407 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-3,text=Closing connection 0

2019-05-30 10:18:32.407 [AVS] V HTTP2MimeResponseDecoder:onResponseFinished:status=COMPLETE

2019-05-30 10:18:32.407 [AVS] V MimeResponseSink:onResponseFinished:status=COMPLETE

2019-05-30 10:18:32.407 [AVS] V DownchannelHandler:onResponseFinished:status=COMPLETE,nonMimeBody=

2019-05-30 10:18:32.407 [AVS] V HTTP2Transport:onDownchannelFinished

2019-05-30 10:18:32.407 [AVS] V HTTP2Transport:setStateLocked:newState=WAITING_TO_RETRY_CONNECTING,changedReason=NONE

2019-05-30 10:18:32.407 [AVS] V HTTP2Transport:handleWaitingToRetryConnecting

2019-05-30 10:18:32.407 [AVS] V HTTP2Transport:handleConnectingWaitingToRetry:connectRetryCount=1,timeout=670

2019-05-30 10:18:32.408 [AVS] V LibcurlHTTP2Connection:streamFinished:streamId=AVSDownChannel-3,result=Peer certificate cannot be authenticated with given CA certificates,CURLcode=60

2019-05-30 10:18:32.408 [AVS] V LibcurlHTTP2Connection:releaseStream:streamId=AVSDownChannel-3

2019-05-30 10:18:33.078 [AVS] V HTTP2Transport:setStateLocked:newState=CONNECTING,changedReason=NONE

2019-05-30 10:18:33.078 [AVS] V HTTP2Transport:handleConnecting

2019-05-30 10:18:33.078 [AVS] V DownchannelHandler:create:context=0xffff2c01c308

2019-05-30 10:18:33.078 [AVS] V ExchangeHandler:ExchangeHandler:context=0xffff2c01c308,authToken=Atza|IwEBIMdQVCOt-PolmyZvdY04mpLx4Ncbuw68v4OV6tohXwqf3xT-sSG1NeIa8isDds49rPnmnXULANdFwjQpdRL4asfDhlD6WCmtvl6x1OG94lpr3tD_DzLhdkn1_-I4mYv0L7BQo7_SnS-h6EQivKyfDKUaZIxAeX4lzyfLrfhJf4I-XMoMIBpaAMkD26UjyTOGiV5Ay_RhNSU8Idp131Rmzq9kGQkxwEERrIyiorjDej_NciFzQuWsmjQ7dD6FJ15RCidGaVPQ5vR7AlTsg62QsZPRUbNEIuT_LEos-bw5AfTiBQzUP-sFIXyBdvq1aYluAP0RJUASZIQvy_Cd9ceA5qhIP2vvKuIAFagEtzgG5LSjktwgxIL2b4PoEytwcFISOSiBLKvVnVwnAKW7tPhdeFyVjx0Wy1yRPMpBSFR5Gux2HOawZmNlmjyf2XeWbnTOAPfQPIy6-qaEHKiYZRhKtA0eCmU2CrO6H5BfBtB3GcL8D6CeaKt3Ib5o-CX2r_rP2GgpBDEYOKjsHDtFvwIgtPWuj8RgSd-F-WnwYEtz09QxQQ

2019-05-30 10:18:33.078 [AVS] V DownchannelHandler:DownchannelHandler:context=0xffff2c01c308

2019-05-30 10:18:33.078 [AVS] V MimeResponseSink:MimeResponseSink:handler=0xffff1c008940

2019-05-30 10:18:33.078 [AVS] V HTTP2MimeResponseDecoder:HTTP2MimeResponseDecoder

2019-05-30 10:18:33.078 [AVS] V HTTP2Transport:createAndSendRequest:type=GET,url=https\://avs-alexa-na.amazon.com/v20160207/directives

2019-05-30 10:18:33.078 [AVS] V DownchannelHandler:getRequestHeaderLines

2019-05-30 10:18:33.078 [AVS] V LibcurlHTTP2Connection:insertActiveStream:handle=0xffff1c0033f0,streamId=AVSDownChannel-5

2019-05-30 10:18:33.084 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-5,text= Trying 54.239.26.171...

2019-05-30 10:18:33.084 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-5,text=TCP_NODELAY set

2019-05-30 10:18:33.394 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-5,text=Connected to avs-alexa-na.amazon.com (54.239.26.171) port 443 (#0)

2019-05-30 10:18:33.394 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-5,text=ALPN\, offering h2

2019-05-30 10:18:33.394 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-5,text=ALPN\, offering http/1.1

2019-05-30 10:18:33.394 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-5,text=successfully set certificate verify locations\:

2019-05-30 10:18:33.394 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-5,text= CAfile\: none

CApath\: /etc/ssl/certs

2019-05-30 10:18:33.395 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-5,text=TLSv1.2 (OUT)\, TLS handshake\, Client hello (1)\:

2019-05-30 10:18:33.703 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-5,text=TLSv1.2 (IN)\, TLS handshake\, Server hello (2)\:

2019-05-30 10:18:33.709 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-5,text=TLSv1.2 (IN)\, TLS handshake\, Certificate (11)\:

2019-05-30 10:18:33.711 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-5,text=TLSv1.2 (OUT)\, TLS alert\, Server hello (2)\:

2019-05-30 10:18:33.711 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-5,text=SSL certificate problem\: certificate is not yet valid

2019-05-30 10:18:33.711 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-5,text=stopped the pause stream!

2019-05-30 10:18:33.711 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-5,text=Closing connection 0

2019-05-30 10:18:33.711 [AVS] V HTTP2MimeResponseDecoder:onResponseFinished:status=COMPLETE

2019-05-30 10:18:33.711 [AVS] V MimeResponseSink:onResponseFinished:status=COMPLETE

2019-05-30 10:18:33.711 [AVS] V DownchannelHandler:onResponseFinished:status=COMPLETE,nonMimeBody=

2019-05-30 10:18:33.711 [AVS] V HTTP2Transport:onDownchannelFinished

2019-05-30 10:18:33.711 [AVS] V HTTP2Transport:setStateLocked:newState=WAITING_TO_RETRY_CONNECTING,changedReason=NONE

2019-05-30 10:18:33.711 [AVS] V HTTP2Transport:handleWaitingToRetryConnecting

2019-05-30 10:18:33.711 [AVS] V HTTP2Transport:handleConnectingWaitingToRetry:connectRetryCount=2,timeout=3564

2019-05-30 10:18:33.711 [AVS] V LibcurlHTTP2Connection:streamFinished:streamId=AVSDownChannel-5,result=Peer certificate cannot be authenticated with given CA certificates,CURLcode=60

2019-05-30 10:18:33.711 [AVS] V LibcurlHTTP2Connection:releaseStream:streamId=AVSDownChannel-5

2019-05-30 10:18:37.275 [AVS] V HTTP2Transport:setStateLocked:newState=CONNECTING,changedReason=NONE

2019-05-30 10:18:37.275 [AVS] V HTTP2Transport:handleConnecting

2019-05-30 10:18:37.275 [AVS] V DownchannelHandler:create:context=0xffff2c01c308

2019-05-30 10:18:37.275 [AVS] V ExchangeHandler:ExchangeHandler:context=0xffff2c01c308,authToken=Atza|IwEBIMdQVCOt-PolmyZvdY04mpLx4Ncbuw68v4OV6tohXwqf3xT-sSG1NeIa8isDds49rPnmnXULANdFwjQpdRL4asfDhlD6WCmtvl6x1OG94lpr3tD_DzLhdkn1_-I4mYv0L7BQo7_SnS-h6EQivKyfDKUaZIxAeX4lzyfLrfhJf4I-XMoMIBpaAMkD26UjyTOGiV5Ay_RhNSU8Idp131Rmzq9kGQkxwEERrIyiorjDej_NciFzQuWsmjQ7dD6FJ15RCidGaVPQ5vR7AlTsg62QsZPRUbNEIuT_LEos-bw5AfTiBQzUP-sFIXyBdvq1aYluAP0RJUASZIQvy_Cd9ceA5qhIP2vvKuIAFagEtzgG5LSjktwgxIL2b4PoEytwcFISOSiBLKvVnVwnAKW7tPhdeFyVjx0Wy1yRPMpBSFR5Gux2HOawZmNlmjyf2XeWbnTOAPfQPIy6-qaEHKiYZRhKtA0eCmU2CrO6H5BfBtB3GcL8D6CeaKt3Ib5o-CX2r_rP2GgpBDEYOKjsHDtFvwIgtPWuj8RgSd-F-WnwYEtz09QxQQ

2019-05-30 10:18:37.276 [AVS] V DownchannelHandler:DownchannelHandler:context=0xffff2c01c308

2019-05-30 10:18:37.276 [AVS] V MimeResponseSink:MimeResponseSink:handler=0xffff1c001610

2019-05-30 10:18:37.276 [AVS] V HTTP2MimeResponseDecoder:HTTP2MimeResponseDecoder

2019-05-30 10:18:37.276 [AVS] V HTTP2Transport:createAndSendRequest:type=GET,url=https\://avs-alexa-na.amazon.com/v20160207/directives

2019-05-30 10:18:37.276 [AVS] V DownchannelHandler:getRequestHeaderLines

2019-05-30 10:18:37.276 [AVS] V LibcurlHTTP2Connection:insertActiveStream:handle=0xffff1c0033f0,streamId=AVSDownChannel-7

2019-05-30 10:18:37.284 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-7,text= Trying 54.239.26.171...

2019-05-30 10:18:37.284 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-7,text=TCP_NODELAY set

2019-05-30 10:18:37.673 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-7,text=Connected to avs-alexa-na.amazon.com (54.239.26.171) port 443 (#0)

2019-05-30 10:18:37.674 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-7,text=ALPN\, offering h2

2019-05-30 10:18:37.674 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-7,text=ALPN\, offering http/1.1

2019-05-30 10:18:37.674 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-7,text=successfully set certificate verify locations\:

2019-05-30 10:18:37.674 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-7,text= CAfile\: none

CApath\: /etc/ssl/certs

2019-05-30 10:18:37.674 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-7,text=TLSv1.2 (OUT)\, TLS handshake\, Client hello (1)\:

2019-05-30 10:18:38.083 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-7,text=TLSv1.2 (IN)\, TLS handshake\, Server hello (2)\:

2019-05-30 10:18:38.083 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-7,text=TLSv1.2 (IN)\, TLS handshake\, Certificate (11)\:

2019-05-30 10:18:38.085 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-7,text=TLSv1.2 (OUT)\, TLS alert\, Server hello (2)\:

2019-05-30 10:18:38.085 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-7,text=SSL certificate problem\: certificate is not yet valid

2019-05-30 10:18:38.085 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-7,text=stopped the pause stream!

2019-05-30 10:18:38.085 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-7,text=Closing connection 0

2019-05-30 10:18:38.085 [AVS] V HTTP2MimeResponseDecoder:onResponseFinished:status=COMPLETE

2019-05-30 10:18:38.085 [AVS] V MimeResponseSink:onResponseFinished:status=COMPLETE

2019-05-30 10:18:38.085 [AVS] V DownchannelHandler:onResponseFinished:status=COMPLETE,nonMimeBody=

2019-05-30 10:18:38.085 [AVS] V HTTP2Transport:onDownchannelFinished

2019-05-30 10:18:38.085 [AVS] V HTTP2Transport:setStateLocked:newState=WAITING_TO_RETRY_CONNECTING,changedReason=NONE

2019-05-30 10:18:38.086 [AVS] V HTTP2Transport:handleWaitingToRetryConnecting

2019-05-30 10:18:38.086 [AVS] V HTTP2Transport:handleConnectingWaitingToRetry:connectRetryCount=3,timeout=4581

2019-05-30 10:18:38.086 [AVS] V LibcurlHTTP2Connection:streamFinished:streamId=AVSDownChannel-7,result=Peer certificate cannot be authenticated with given CA certificates,CURLcode=60

2019-05-30 10:18:38.086 [AVS] V LibcurlHTTP2Connection:releaseStream:streamId=AVSDownChannel-7

2019-05-30 10:18:42.667 [AVS] V HTTP2Transport:setStateLocked:newState=CONNECTING,changedReason=NONE

2019-05-30 10:18:42.667 [AVS] V HTTP2Transport:handleConnecting

2019-05-30 10:18:42.667 [AVS] V DownchannelHandler:create:context=0xffff2c01c308

2019-05-30 10:18:42.667 [AVS] V ExchangeHandler:ExchangeHandler:context=0xffff2c01c308,authToken=Atza|IwEBIMdQVCOt-PolmyZvdY04mpLx4Ncbuw68v4OV6tohXwqf3xT-sSG1NeIa8isDds49rPnmnXULANdFwjQpdRL4asfDhlD6WCmtvl6x1OG94lpr3tD_DzLhdkn1_-I4mYv0L7BQo7_SnS-h6EQivKyfDKUaZIxAeX4lzyfLrfhJf4I-XMoMIBpaAMkD26UjyTOGiV5Ay_RhNSU8Idp131Rmzq9kGQkxwEERrIyiorjDej_NciFzQuWsmjQ7dD6FJ15RCidGaVPQ5vR7AlTsg62QsZPRUbNEIuT_LEos-bw5AfTiBQzUP-sFIXyBdvq1aYluAP0RJUASZIQvy_Cd9ceA5qhIP2vvKuIAFagEtzgG5LSjktwgxIL2b4PoEytwcFISOSiBLKvVnVwnAKW7tPhdeFyVjx0Wy1yRPMpBSFR5Gux2HOawZmNlmjyf2XeWbnTOAPfQPIy6-qaEHKiYZRhKtA0eCmU2CrO6H5BfBtB3GcL8D6CeaKt3Ib5o-CX2r_rP2GgpBDEYOKjsHDtFvwIgtPWuj8RgSd-F-WnwYEtz09QxQQ

2019-05-30 10:18:42.667 [AVS] V DownchannelHandler:DownchannelHandler:context=0xffff2c01c308

2019-05-30 10:18:42.667 [AVS] V MimeResponseSink:MimeResponseSink:handler=0xffff1c008940

2019-05-30 10:18:42.667 [AVS] V HTTP2MimeResponseDecoder:HTTP2MimeResponseDecoder

2019-05-30 10:18:42.667 [AVS] V HTTP2Transport:createAndSendRequest:type=GET,url=https\://avs-alexa-na.amazon.com/v20160207/directives

2019-05-30 10:18:42.667 [AVS] V DownchannelHandler:getRequestHeaderLines

2019-05-30 10:18:42.667 [AVS] V LibcurlHTTP2Connection:insertActiveStream:handle=0xffff1c0033f0,streamId=AVSDownChannel-9

2019-05-30 10:18:42.676 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-9,text= Trying 54.239.26.171...

2019-05-30 10:18:42.676 [AVS] V CurlEasyHandleWrapper:libcurl:id=AVSDownChannel-9,text=TCP_NODELAY set



sdkdeveloper portal
10 |2000 characters needed characters left characters exceeded

Up to 2 attachments (including images) can be used with a maximum of 512.0 KiB each and 1.0 MiB total.

0 Answers