AVSSDK: not able to connect to amazon server #403
Comments
|
@dhananjayj29 it looks like a certificate error. Take a look at these lines in your log: Did you make that amazon.crt yourself? Ryan |
|
Yes. I just renamed it. |
|
@dhananjayj29 glad to help the community when I can. Do you mind closing the issue if you are all set. |
|
It appears the problem has been resolved. If this is not the case, please re-open the ticket. |
Hi
While initialising the avs sdk , getting the below errors and not able to connect:
Delegate:onAuthStateChangeCalled:state=1,error=0
2017-12-19 12:04:03.311 [ 1] 0 MessageRouter:connectionStatusChanged:reason=ACL_CLIENT_REQUEST,newStatus=PENDING
2017-12-19 12:04:03.311 [ 1] W HTTP2Transport:Unable to parse OpenSSL version!:version=GnuTLS/2.12.23,required=1.0.2
2017-12-19 12:04:03.312 [ 1] 0 HTTP2StreamPool:getStream:streamId=1,numAcquiredStreams=1
2017-12-19 12:04:03.313 [ 5] 9 PostConnectSynchronize:Entering postConnectLoop thread
2017-12-19 12:04:03.314 [ 3] 1 AlertsCapabilityAgent:executeOnConnectionStatusChanged:status=PENDING,reason=ACL_CLIENT_REQUEST
#############################
Connecting...
#############################
2017-12-19 12:04:03.315 [ 6] 9 SpeakerManager:provideStateCalled
2017-12-19 12:04:03.315 [ 6] 0 AudioPlayer:provideState:stateRequestToken=1
2017-12-19 12:04:03.315 [ 6] 9 SpeechSynthesizer:provideState:token=1
2017-12-19 12:04:03.316 [ 7] 0 AudioPlayer:executeProvideState:sendToken=true,stateRequestToken=1
2017-12-19 12:04:03.316 [ 8] 9 SpeakerManager:executeProvideStateCalled
2017-12-19 12:04:03.316 [ 8] 9 MediaPlayer:getSpeakerSettingsCalled
2017-12-19 12:04:03.316 [ 2] 9 MediaPlayer:handleGetSpeakerSettingsCalled
2017-12-19 12:04:03.316 [ 9] 0 SpeechSynthesizer:executeProvideState:stateRequestToken=1
2017-12-19 12:04:03.317 [ 8] 9 MediaPlayer:getSpeakerSettingsCalled
2017-12-19 12:04:03.317 [ 2] 9 MediaPlayer:handleGetSpeakerSettingsCalled
2017-12-19 12:04:03.317 [ 8] 9 SpeakerManager:validateSpeakerSettingsConsistencyResult:consistent=true
2017-12-19 12:04:03.317 [ 8] 9 SpeakerManager:validateSpeakerSettings:volume=100,mute=false
2017-12-19 12:04:03.317 [ a] 0 ContextManager:updateStateLocked:action=updatedState,state={"wakeword" : ""},namespace=SpeechRecognizer,name=R
ecognizerState
2017-12-19 12:04:03.318 [ 7] 0 ContextManager:updateStateLocked:action=updatedState,state={"token":"","offsetInMilliseconds":0,"playerActi
vity":"IDLE"},namespace=AudioPlayer,name=PlaybackState
2017-12-19 12:04:03.318 [ 8] 0 ContextManager:updateStateLocked:action=updatedState,state={"volume":100,"muted":false},namespace=Speaker,na
me=VolumeState
2017-12-19 12:04:03.319 [ 9] 0 ContextManager:updateStateLocked:action=updatedState,state={"token":"","offsetInMilliseconds":0,"playerActi
vity":"FINISHED"},namespace=SpeechSynthesizer,name=SpeechState
2017-12-19 12:04:03.319 [ 6] 0 ContextManager:buildContextSuccessful:context={"context":[{"header":{"namespace":"Speaker","name":"VolumeS
tate"},"payload":{"volume":100,"muted":false}},{"header":{"namespace":"AudioPlayer","name":"PlaybackState"},"payload":{"token":""
,"offsetInMilliseconds":0,"playerActivity":"IDLE"}},{"header":{"namespace":"SpeechSynthesizer","name":"SpeechState"},"payload":{"toke
n":"","offsetInMilliseconds":0,"playerActivity":"FINISHED"}},{"header":{"namespace":"Alerts","name":"AlertsState"},"payload":{"allA
lerts":[],"activeAlerts":[]}},{"header":{"namespace":"SpeechRecognizer","name":"RecognizerState"},"payload":{"wakeword":""}}]}
2017-12-19 12:04:03.664 [ 6] 0 EventBuilder:buildJsonEventString:messageId=943f346a-796c-4b7c-ab22-ec1175683da8,namespace=System,name=Synchron
izeState
2017-12-19 12:04:03.664 [ 6] 0 PostConnectSynchronize:onContextAvailable : Send PostConnectMessage to transport
2017-12-19 12:04:03.664 [ 6] 9 HTTP2Transport:enqueueRequest:jsonContent={"context":[{"header":{"namespace":"Speaker","name":"VolumeState
"},"payload":{"volume":100,"muted":false}},{"header":{"namespace":"AudioPlayer","name":"PlaybackState"},"payload":{"token":"","of
fsetInMilliseconds":0,"playerActivity":"IDLE"}},{"header":{"namespace":"SpeechSynthesizer","name":"SpeechState"},"payload":{"token":
"","offsetInMilliseconds":0,"playerActivity":"FINISHED"}},{"header":{"namespace":"Alerts","name":"AlertsState"},"payload":{"allAlert
s":[],"activeAlerts":[]}},{"header":{"namespace":"SpeechRecognizer","name":"RecognizerState"},"payload":{"wakeword":""}}],"event":
{"header":{"namespace":"System","name":"SynchronizeState","messageId":"943f346a-796c-4b7c-ab22-ec1175683da8"},"payload":{}}}
2017-12-19 12:04:04.567 [ b] I HTTP2Stream:libcurl:streamId=1,text= Trying 54.239.26.171...
2017-12-19 12:04:04.568 [ b] I HTTP2Stream:libcurl:streamId=1,text=TCP_NODELAY set
2017-12-19 12:04:05.074 [ b] I HTTP2Stream:libcurl:streamId=1,text=Connected to avs-alexa-na.amazon.com (54.239.26.171) port 443 (#0)
2017-12-19 12:04:05.578 [ b] I HTTP2Stream:libcurl:streamId=1,text=found 143 certificates in /etc/ssl/certs/amazon.crt
2017-12-19 12:04:06.062 [ b] I HTTP2Stream:libcurl:streamId=1,text=gnutls_handshake() failed: Handshake failed
2017-12-19 12:04:06.063 [ b] I HTTP2Stream:libcurl:streamId=1,text=stopped the pause stream!
2017-12-19 12:04:06.063 [ b] I HTTP2Stream:libcurl:streamId=1,text=Closing connection 0
2017-12-19 12:04:06.094 [ b] 0 HTTP2StreamPool:releaseStream:streamId=1,numAcquiredStreams=0
2017-12-19 12:04:06.095 [ b] 0 HTTP2StreamPool:getStream:streamId=3,numAcquiredStreams=1
2017-12-19 12:04:06.095 [ b] E HTTP2Transport:networkLoopRetryingToConnect:reason=establishConnectionFailed,retryCount=0,retryBackoff=185
2017-12-19 12:04:06.296 [ b] I HTTP2Stream:libcurl:streamId=3,text=Hostname avs-alexa-na.amazon.com was found in DNS cache
2017-12-19 12:04:06.297 [ b] I HTTP2Stream:libcurl:streamId=3,text= Trying 54.239.26.171...
2017-12-19 12:04:06.297 [ b] I HTTP2Stream:libcurl:streamId=3,text=TCP_NODELAY set
2017-12-19 12:04:07.004 [ b] I HTTP2Stream:libcurl:streamId=3,text=Connected to avs-alexa-na.amazon.com (54.239.26.171) port 443 (#1)
2017-12-19 12:04:07.512 [ b] I HTTP2Stream:libcurl:streamId=3,text=found 143 certificates in /etc/ssl/certs/amazon.crt
2017-12-19 12:04:08.355 [ b] I HTTP2Stream:libcurl:streamId=3,text=gnutls_handshake() failed: Handshake failed
2017-12-19 12:04:08.355 [ b] I HTTP2Stream:libcurl:streamId=3,text=stopped the pause stream!
2017-12-19 12:04:08.355 [ b] I HTTP2Stream:libcurl:streamId=3,text=Closing connection 1
2017-12-19 12:04:08.379 [ b] 0 HTTP2StreamPool:releaseStream:streamId=3,numAcquiredStreams=0
2017-12-19 12:04:08.381 [ b] 0 HTTP2StreamPool:getStream:streamId=5,numAcquiredStreams=1
2017-12-19 12:04:08.381 [ b] E HTTP2Transport:networkLoopRetryingToConnect:reason=establishConnectionFailed,retryCount=1,retryBackoff=1114
2017-12-19 12:04:09.506 [ b] I HTTP2Stream:libcurl:streamId=5,text=Hostname avs-alexa-na.amazon.com was found in DNS cache
2017-12-19 12:04:09.507 [ b] I HTTP2Stream:libcurl:streamId=5,text= Trying 54.239.26.171...
2017-12-19 12:04:09.507 [ b] I HTTP2Stream:libcurl:streamId=5,text=TCP_NODELAY set
2017-12-19 12:04:10.300 [ b] I HTTP2Stream:libcurl:streamId=5,text=Connected to avs-alexa-na.amazon.com (54.239.26.171) port 443 (#2)
2017-12-19 12:04:10.740 [ b] I HTTP2Stream:libcurl:streamId=5,text=found 143 certificates in /etc/ssl/certs/amazon.crt
2017-12-19 12:04:11.529 [ b] I HTTP2Stream:libcurl:streamId=5,text=gnutls_handshake() failed: Handshake failed
2017-12-19 12:04:11.530 [ b] I HTTP2Stream:libcurl:streamId=5,text=stopped the pause stream!
2017-12-19 12:04:11.530 [ b] I HTTP2Stream:libcurl:streamId=5,text=Closing connection 2
2017-12-19 12:04:11.548 [ b] 0 HTTP2StreamPool:releaseStream:streamId=5,numAcquiredStreams=0
2017-12-19 12:04:11.550 [ b] 0 HTTP2StreamPool:getStream:streamId=7,numAcquiredStreams=1
2017-12-19 12:04:11.550 [ b] E HTTP2Transport:networkLoopRetryingToConnect:reason=establishConnectionFailed,retryCount=2,retryBackoff=3446
2017-12-19 12:04:15.016 [ b] I HTTP2Stream:libcurl:streamId=7,text=Hostname avs-alexa-na.amazon.com was found in DNS cache
2017-12-19 12:04:15.017 [ b] I HTTP2Stream:libcurl:streamId=7,text= Trying 54.239.26.171...
2017-12-19 12:04:15.017 [ b] I HTTP2Stream:libcurl:streamId=7,text=TCP_NODELAY set
2017-12-19 12:04:15.646 [ b] I HTTP2Stream:libcurl:streamId=7,text=Connected to avs-alexa-na.amazon.com (54.239.26.171) port 443 (#3)
2017-12-19 12:04:16.075 [ b] I HTTP2Stream:libcurl:streamId=7,text=found 143 certificates in /etc/ssl/certs/amazon.crt
2017-12-19 12:04:16.752 [ b] I HTTP2Stream:libcurl:streamId=7,text=gnutls_handshake() failed: Handshake failed
2017-12-19 12:04:16.752 [ b] I HTTP2Stream:libcurl:streamId=7,text=stopped the pause stream!
2017-12-19 12:04:16.752 [ b] I HTTP2Stream:libcurl:streamId=7,text=Closing connection 3
2017-12-19 12:04:16.778 [ b] 0 HTTP2StreamPool:releaseStream:streamId=7,numAcquiredStreams=0
2017-12-19 12:04:16.779 [ b] 0 HTTP2StreamPool:getStream:streamId=9,numAcquiredStreams=1
2017-12-19 12:04:16.779 [ b] E HTTP2Transport:networkLoopRetryingToConnect:reason=establishConnectionFailed,retryCount=3,retryBackoff=4747
2017-12-19 12:04:21.536 [ b] I HTTP2Stream:libcurl:streamId=9,text=Hostname avs-alexa-na.amazon.com was found in DNS cache
2017-12-19 12:04:21.537 [ b] I HTTP2Stream:libcurl:streamId=9,text= Trying 54.239.26.171...
2017-12-19 12:04:21.537 [ b] I HTTP2Stream:libcurl:streamId=9,text=TCP_NODELAY set
2017-12-19 12:04:22.485 [ b] I HTTP2Stream:libcurl:streamId=9,text=Connected to avs-alexa-na.amazon.com (54.239.26.171) port 443 (#4)
2017-12-19 12:04:22.935 [ b] I HTTP2Stream:libcurl:streamId=9,text=found 143 certificates in /etc/ssl/certs/amazon.crt
Failed to connect to AVS!
2017-12-19 12:04:23.326 [ 1] I DirectiveSequencer:doShutdown
2017-12-19 12:04:23.328 [ 1] 9 TemplateRuntime:getConfiguration
2017-12-19 12:04:23.328 [ 1] I DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=TemplateRuntime,name=RenderPlayerInfo,handler=
0x1c3fe8,policy=NON_BLOCKING
2017-12-19 12:04:23.328 [ 1] I DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=TemplateRuntime,name=RenderTemplate,handler=0x
1c3fe8,policy=NON_BLOCKING
2017-12-19 12:04:23.328 [ 1] I DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Speaker,name=SetMute,handler=0x1c4820,policy=N
ON_BLOCKING
2017-12-19 12:04:23.328 [ 1] I DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Speaker,name=AdjustVolume,handler=0x1c4820,pol
icy=NON_BLOCKING
2017-12-19 12:04:23.328 [ 1] I DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Speaker,name=SetVolume,handler=0x1c4820,policy
=NON_BLOCKING
2017-12-19 12:04:23.328 [ 1] I DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=SpeechSynthesizer,name=Speak,handler=0x19c938,
policy=BLOCKING
2017-12-19 12:04:23.328 [ 1] I DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=AudioPlayer,name=ClearQueue,handler=0x19d428,p
olicy=NON_BLOCKING
2017-12-19 12:04:23.329 [ 1] I DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=AudioPlayer,name=Stop,handler=0x19d428,policy=
NON_BLOCKING
2017-12-19 12:04:23.329 [ 1] I DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=AudioPlayer,name=Play,handler=0x19d428,policy=
NON_BLOCKING
2017-12-19 12:04:23.329 [ 1] I DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=SpeechRecognizer,name=ExpectSpeech,handler=0x1
9c158,policy=NON_BLOCKING
2017-12-19 12:04:23.329 [ 1] I DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=SpeechRecognizer,name=StopCapture,handler=0x19
c158,policy=NON_BLOCKING
2017-12-19 12:04:23.329 [ 1] I DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alerts,name=DeleteAlert,handler=0x19e008,polic
y=NON_BLOCKING
2017-12-19 12:04:23.329 [ 1] I DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=Alerts,name=SetAlert,handler=0x19e008,policy=N
ON_BLOCKING
2017-12-19 12:04:23.329 [ 1] I DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=System,name=ResetUserInactivity,handler=0x19bf
34,policy=NON_BLOCKING
2017-12-19 12:04:23.329 [ 1] I DirectiveRouter:removeDirectiveHandlers:action=removed,namespace=System,name=SetEndpoint,handler=0x1c5280,polic
y=NON_BLOCKING
2017-12-19 12:04:23.329 [ 1] I DirectiveRouter:onDeregisteredCalled:handler=0x1c3fe8
2017-12-19 12:04:23.329 [ 1] I DirectiveRouter:onDeregisteredCalled:handler=0x1c4820
2017-12-19 12:04:23.329 [ 1] I DirectiveRouter:onDeregisteredCalled:handler=0x19c938
2017-12-19 12:04:23.329 [ 1] 9 SpeechSynthesizer:onDeregistered
2017-12-19 12:04:23.329 [ 1] I DirectiveRouter:onDeregisteredCalled:handler=0x19d428
2017-12-19 12:04:23.330 [ 1] 0 AudioPlayer:onDeregistered
2017-12-19 12:04:23.330 [ 7] 1 AudioPlayer:executeStop:playNextItem=false,m_currentActivity=IDLE
2017-12-19 12:04:23.330 [ 1] I DirectiveRouter:onDeregisteredCalled:handler=0x19c158
2017-12-19 12:04:23.330 [ 1] I DirectiveRouter:onDeregisteredCalled:handler=0x19e008
2017-12-19 12:04:23.330 [ 1] I DirectiveRouter:onDeregisteredCalled:handler=0x19bf34
2017-12-19 12:04:23.330 [ 1] I DirectiveRouter:onDeregisteredCalled:handler=0x1c5280
2017-12-19 12:04:23.331 [ 1] 0 ContextManager:setStateProvider:action=removedStateProvider,namespace=Speaker,name=VolumeState
2017-12-19 12:04:23.331 [ 1] 1 AudioPlayer:removeObserver
2017-12-19 12:04:23.332 [ 1] 1 AudioPlayer:executeStop:playNextItem=false,m_currentActivity=IDLE
2017-12-19 12:04:23.332 [ 1] 9 MediaPlayer:setObserverCalled
2017-12-19 12:04:23.332 [ 2] 0 MediaPlayer:handleSetObserverCalled
2017-12-19 12:04:23.332 [ 1] 0 ContextManager:setStateProvider:action=removedStateProvider,namespace=AudioPlayer,name=PlaybackState
2017-12-19 12:04:23.332 [ 1] 9 SpeechSynthesizer:doShutdown
2017-12-19 12:04:23.332 [ 1] 9 MediaPlayer:setObserverCalled
2017-12-19 12:04:23.673 [ 2] 0 MediaPlayer:handleSetObserverCalled
2017-12-19 12:04:23.674 [ 1] 9 AlertsCapabilityAgent:releaseChannel
2017-12-19 12:04:23.675 [ 1] 0 MessageRouter:connectionStatusChanged:reason=ACL_CLIENT_REQUEST,newStatus=DISCONNECTED
2017-12-19 12:04:23.675 [ 1] 0 PostConnectSynchronize:PostConnectSynchronizer::doShutdown().
2017-12-19 12:04:23.675 [ 5] 9 PostConnectSynchronize:Exiting postConnectLoop thread
#####################################
Client not connected!
#####################################
2017-12-19 12:04:23.706 [ b] I HTTP2Stream:libcurl:streamId=9,text=stopped the pause stream!
2017-12-19 12:04:23.707 [ b] I HTTP2Stream:libcurl:streamId=9,text=Closing connection 4
2017-12-19 12:04:23.749 [ b] 0 HTTP2StreamPool:releaseStream:streamId=9,numAcquiredStreams=0
2017-12-19 12:04:23.751 [ b] 0 HTTP2StreamPool:getStream:streamId=11,numAcquiredStreams=1
2017-12-19 12:04:23.751 [ b] 0 HTTP2StreamPool:releaseStream:streamId=11,numAcquiredStreams=0
2017-12-19 12:04:23.752 [ b] 0 PostConnectSynchronize:onSendCompleted:status=NOT_CONNECTED
2017-12-19 12:04:23.752 [ b] 0 PostConnectSynchronize:onDisconnected()
2017-12-19 12:04:23.752 [ b] 0 PostConnectSynchronize:PostConnectSynchronizer::doShutdown().
2017-12-19 12:04:23.754 [ c] I CertifiedSender:CertifiedSender worker thread done. exiting mainloop.
2017-12-19 12:04:23.822 [ 1] 9 MediaPlayer:~MediaPlayerCalled
2017-12-19 12:04:23.829 [ 1] 9 MediaPlayer:resetPipeline
2017-12-19 12:04:23.829 [ 1] 9 MediaPlayer:~MediaPlayerCalled
2017-12-19 12:04:23.832 [ 1] 9 MediaPlayer:resetPipeline
Failed to initialize SampleApplication
Failed to create to SampleApplication!
Please suggest the problem area.
The text was updated successfully, but these errors were encountered: