New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Random Java error - Java.UTIL.Concurrent.TimeoutException #334

Closed
bill-orange opened this Issue Oct 18, 2016 · 16 comments

Comments

Projects
None yet
@bill-orange

bill-orange commented Oct 18, 2016

Randomly, often after several hours of running, Alex stops working with the error:

Java.Util.Concurrent.TimeoutException

It generally works again after clicking OK in the resulting dialog box.

Is Amazon's server getting overloaded perhaps? The WiFi connection to my network is pretty good.

@ghost73

This comment has been minimized.

ghost73 commented Oct 26, 2016

i am also get it

@bill-orange

This comment has been minimized.

bill-orange commented Nov 2, 2016

Still happening this morning.

@CainanW

This comment has been minimized.

CainanW commented Nov 6, 2016

This is what I get every time when I run it, have not been able to run is successfully yet. Error message does leave much room for debugging either :/. Relevant part of my application.log file:

21:48:48.804 [main] INFO com.amazon.alexa.avs.http.AVSClient - HttpClient starting
21:48:49.622 [main] INFO com.amazon.alexa.avs.http.AVSClient - HttpClient started
21:48:50.388 [pool-6-thread-1] INFO com.amazon.alexa.avs.http.AVSClient - Request metadata:
{
"event" : {
"header" : {
"namespace" : "System",
"name" : "SynchronizeState",
"messageId" : "839ce074-91c7-4481-ad97-b23d501145b2"
},
"payload" : { }
},
"context" : [ {
"header" : {
"namespace" : "AudioPlayer",
"name" : "PlaybackState"
},
"payload" : {
"token" : "",
"offsetInMilliseconds" : 0,
"playerActivity" : "IDLE"
}
}, {
"header" : {
"namespace" : "SpeechSynthesizer",
"name" : "SpeechState"
},
"payload" : {
"token" : "",
"offsetInMilliseconds" : 0,
"playerActivity" : "FINISHED"
}
}, {
"header" : {
"namespace" : "Alerts",
"name" : "AlertsState"
},
"payload" : {
"allAlerts" : [ ],
"activeAlerts" : [ ]
}
}, {
"header" : {
"namespace" : "Speaker",
"name" : "VolumeState"
},
"payload" : {
"volume" : 50,
"muted" : false
}
} ]
}
21:49:23.572 [DownchannelRequestThread] INFO com.amazon.alexa.avs.http.AVSClient - Establishing downchannel
21:49:55.089 [AWT-EventQueue-0] INFO com.amazon.alexa.avs.http.AVSClient - Request metadata:
{
"event" : {
"header" : {
"namespace" : "SpeechRecognizer",
"name" : "Recognize",
"messageId" : "8ad348e4-c9e9-401b-866d-1d7d5b38b4d6",
"dialogRequestId" : "35e1ad74-c4bf-43b9-90bf-1af5b1d20ed3"
},
"payload" : {
"profile" : "NEAR_FIELD",
"format" : "AUDIO_L16_RATE_16000_CHANNELS_1"
}
},
"context" : [ {
"header" : {
"namespace" : "AudioPlayer",
"name" : "PlaybackState"
},
"payload" : {
"token" : "",
"offsetInMilliseconds" : 0,
"playerActivity" : "IDLE"
}
}, {
"header" : {
"namespace" : "SpeechSynthesizer",
"name" : "SpeechState"
},
"payload" : {
"token" : "",
"offsetInMilliseconds" : 0,
"playerActivity" : "FINISHED"
}
}, {
"header" : {
"namespace" : "Alerts",
"name" : "AlertsState"
},
"payload" : {
"allAlerts" : [ ],
"activeAlerts" : [ ]
}
}, {
"header" : {
"namespace" : "Speaker",
"name" : "VolumeState"
},
"payload" : {
"volume" : 50,
"muted" : false
}
} ]
}
21:50:13.634 [DownchannelRequestThread] ERROR com.amazon.alexa.avs.http.AVSClient - There was a problem with the request.
com.amazon.alexa.avs.http.AVSClient$RequestException: java.util.concurrent.TimeoutException
at com.amazon.alexa.avs.http.AVSClient.doRequestActual(AVSClient.java:269) ~[classes/:?]
at com.amazon.alexa.avs.http.AVSClient.access$200(AVSClient.java:64) ~[classes/:?]
at com.amazon.alexa.avs.http.AVSClient$2.call(AVSClient.java:218) ~[classes/:?]
at com.amazon.alexa.avs.http.AVSClient$2.call(AVSClient.java:214) ~[classes/:?]
at com.amazon.alexa.avs.http.AbstractRetryPolicy.tryCall(AbstractRetryPolicy.java:33) ~[classes/:?]
at com.amazon.alexa.avs.http.AVSClient.doRequest(AVSClient.java:224) [classes/:?]
at com.amazon.alexa.avs.http.AVSClient.access$400(AVSClient.java:64) [classes/:?]
at com.amazon.alexa.avs.http.AVSClient$DownchannelRequestThread.openConnection(AVSClient.java:479) [classes/:?]
at com.amazon.alexa.avs.http.AVSClient$DownchannelRequestThread.run(AVSClient.java:471) [classes/:?]
Caused by: java.util.concurrent.TimeoutException
at com.amazon.alexa.avs.http.jetty.InputStreamResponseListener.get(InputStreamResponseListener.java:248) ~[classes/:?]
at com.amazon.alexa.avs.http.AVSClient.doRequestActual(AVSClient.java:264) ~[classes/:?]
... 8 more
21:50:13.647 [DownchannelRequestThread] INFO com.amazon.alexa.avs.http.AVSClient - Finishing downchannel
21:50:13.647 [DownchannelRequestThread] INFO com.amazon.alexa.avs.http.AVSClient - Establishing downchannel
21:50:23.635 [RequestThread] ERROR com.amazon.alexa.avs.http.AVSClient - There was a problem with the request.
com.amazon.alexa.avs.http.AVSClient$RequestException: java.util.concurrent.TimeoutException
at com.amazon.alexa.avs.http.AVSClient.doRequestActual(AVSClient.java:269) ~[classes/:?]
at com.amazon.alexa.avs.http.AVSClient.access$200(AVSClient.java:64) ~[classes/:?]
at com.amazon.alexa.avs.http.AVSClient$2.call(AVSClient.java:218) ~[classes/:?]
at com.amazon.alexa.avs.http.AVSClient$2.call(AVSClient.java:214) ~[classes/:?]
at com.amazon.alexa.avs.http.AbstractRetryPolicy.tryCall(AbstractRetryPolicy.java:33) ~[classes/:?]
at com.amazon.alexa.avs.http.AVSClient.doRequest(AVSClient.java:224) [classes/:?]
at com.amazon.alexa.avs.http.AVSClient.access$400(AVSClient.java:64) [classes/:?]
at com.amazon.alexa.avs.http.AVSClient$RequestThread.run(AVSClient.java:498) [classes/:?]
Caused by: java.util.concurrent.TimeoutException
at com.amazon.alexa.avs.http.jetty.InputStreamResponseListener.get(InputStreamResponseListener.java:248) ~[classes/:?]
at com.amazon.alexa.avs.http.AVSClient.doRequestActual(AVSClient.java:264) ~[classes/:?]
... 7 more
21:51:12.035 [Thread-12] INFO com.amazon.alexa.avs.http.AVSClient - HttpClient stopping
21:51:12.036 [Thread-12] INFO com.amazon.alexa.avs.http.AVSClient - [java.lang.Thread.getStackTrace(Thread.java:1556), com.amazon.alexa.avs.http.AVSClient$1.lifeCycleStopping(AVSClient.java:184), org.eclipse.jetty.util.component.AbstractLifeCycle.setStopping(AbstractLifeCycle.java:197), org.eclipse.jetty.util.component.AbstractLifeCycle.stop(AbstractLifeCycle.java:88), com.amazon.alexa.avs.http.AVSClient.shutdown(AVSClient.java:448), com.amazon.alexa.avs.AVSController$2.run(AVSController.java:168)]
21:51:25.756 [main] INFO com.amazon.alexa.avs.http.AVSClient - HttpClient starting
21:51:26.503 [main] INFO com.amazon.alexa.avs.http.AVSClient - HttpClient started

@bill-orange

This comment has been minimized.

bill-orange commented Nov 6, 2016

I strongly suspect this is on the Amazon server side. It happens to me randomly.

@GenericUK

This comment has been minimized.

GenericUK commented Dec 23, 2016

I am getting this and did suspect Amazon server delay. However the Java GUI alert needs user intervention to continue so this breaks the headless setup using VNC. We need to find a way to stop the GUI alert or increase the timeout.

@shishirranjan08

This comment has been minimized.

shishirranjan08 commented Jan 23, 2017

Hi,

I am getting the below error every time .

Below is the snippet of error stack:

10:59:44.074 [DownchannelRequestThread] ERROR com.amazon.alexa.avs.http.AVSClient - There was a problem with the request.
com.amazon.alexa.avs.http.AVSClient$RequestException: java.util.concurrent.TimeoutException
at com.amazon.alexa.avs.http.AVSClient.doRequestActual(AVSClient.java:271) ~[classes/:?]
at com.amazon.alexa.avs.http.AVSClient.access$200(AVSClient.java:65) ~[classes/:?]
at com.amazon.alexa.avs.http.AVSClient$2.call(AVSClient.java:220) ~[classes/:?]
at com.amazon.alexa.avs.http.AVSClient$2.call(AVSClient.java:215) ~[classes/:?]
at com.amazon.alexa.avs.http.AbstractRetryPolicy.tryCall(AbstractRetryPolicy.java:38) ~[classes/:?]
at com.amazon.alexa.avs.http.AVSClient.doRequest(AVSClient.java:226) [classes/:?]
at com.amazon.alexa.avs.http.AVSClient.access$400(AVSClient.java:65) [classes/:?]
at com.amazon.alexa.avs.http.AVSClient$DownchannelRequestThread.openConnection(AVSClient.java:520) [classes/:?]
at com.amazon.alexa.avs.http.AVSClient$DownchannelRequestThread.run(AVSClient.java:484) [classes/:?]
Caused by: java.util.concurrent.TimeoutException
at com.amazon.alexa.avs.http.jetty.InputStreamResponseListener.get(InputStreamResponseListener.java:248) ~[classes/:?]
at com.amazon.alexa.avs.http.AVSClient.doRequestActual(AVSClient.java:266) ~[classes/:?]
... 8 more
11:00:17.075 [DownchannelRequestThread] ERROR com.amazon.alexa.avs.http.AVSClient - There was a problem with the request.
com.amazon.alexa.avs.http.AVSClient$RequestException: java.util.concurrent.TimeoutException
at com.amazon.alexa.avs.http.AVSClient.doRequestActual(AVSClient.java:271) ~[classes/:?]
at com.amazon.alexa.avs.http.AVSClient.access$200(AVSClient.java:65) ~[classes/:?]
at com.amazon.alexa.avs.http.AVSClient$2.call(AVSClient.java:220) ~[classes/:?]
at com.amazon.alexa.avs.http.AVSClient$2.call(AVSClient.java:215) ~[classes/:?]
at com.amazon.alexa.avs.http.AbstractRetryPolicy.tryCall(AbstractRetryPolicy.java:38) ~[classes/:?]
at com.amazon.alexa.avs.http.AVSClient.doRequest(AVSClient.java:226) [classes/:?]
at com.amazon.alexa.avs.http.AVSClient.access$400(AVSClient.java:65) [classes/:?]
at com.amazon.alexa.avs.http.AVSClient$DownchannelRequestThread.openConnection(AVSClient.java:520) [classes/:?]
at com.amazon.alexa.avs.http.AVSClient$DownchannelRequestThread.run(AVSClient.java:484) [classes/:?]
Caused by: java.util.concurrent.TimeoutException
at com.amazon.alexa.avs.http.jetty.InputStreamResponseListener.get(InputStreamResponseListener.java:248) ~[classes/:?]
at com.amazon.alexa.avs.http.AVSClient.doRequestActual(AVSClient.java:266) ~[classes/:?]
... 8 more
11:00:50.094 [DownchannelRequestThread] ERROR com.amazon.alexa.avs.http.AVSClient - There was a problem with the request.
com.amazon.alexa.avs.http.AVSClient$RequestException: java.util.concurrent.TimeoutException
at com.amazon.alexa.avs.http.AVSClient.doRequestActual(AVSClient.java:271) ~[classes/:?]
at com.amazon.alexa.avs.http.AVSClient.access$200(AVSClient.java:65) ~[classes/:?]
at com.amazon.alexa.avs.http.AVSClient$2.call(AVSClient.java:220) ~[classes/:?]
at com.amazon.alexa.avs.http.AVSClient$2.call(AVSClient.java:215) ~[classes/:?]
at com.amazon.alexa.avs.http.AbstractRetryPolicy.tryCall(AbstractRetryPolicy.java:38) ~[classes/:?]
at com.amazon.alexa.avs.http.AVSClient.doRequest(AVSClient.java:226) [classes/:?]
at com.amazon.alexa.avs.http.AVSClient.access$400(AVSClient.java:65) [classes/:?]
at com.amazon.alexa.avs.http.AVSClient$DownchannelRequestThread.openConnection(AVSClient.java:520) [classes/:?]
at com.amazon.alexa.avs.http.AVSClient$DownchannelRequestThread.run(AVSClient.java:484) [classes/:?]
Caused by: java.util.concurrent.TimeoutException
at com.amazon.alexa.avs.http.jetty.InputStreamResponseListener.get(InputStreamResponseListener.java:248) ~[classes/:?]
at com.amazon.alexa.avs.http.AVSClient.doRequestActual(AVSClient.java:266) ~[classes/:?]
... 8 more

@nberserk

This comment has been minimized.

nberserk commented Mar 3, 2017

I'm also having this exception too. randomly

@miclass

This comment has been minimized.

miclass commented Mar 4, 2017

I am also having this exception, on random basis.
As already said, this exception triggers a popup error on java client that blocks the operation, needing manual intervention to unblock it...it's quite annoying.

@giterliu

This comment has been minimized.

giterliu commented Mar 8, 2017

I am also having this exception,too,every time.

@elstryan

This comment has been minimized.

Collaborator

elstryan commented Mar 15, 2017

Hi guys,
Are you still running into this issue?

@bill-orange

This comment has been minimized.

bill-orange commented Mar 15, 2017

I stoped running the software on the Pi. Gave up in frustration.

@elstryan

This comment has been minimized.

Collaborator

elstryan commented Mar 15, 2017

@bill-orange
Since you reported this issue the service has undergone some changes that might address this issue. Please give it another shot and let us know the outcome.

@bill-orange

This comment has been minimized.

bill-orange commented Mar 15, 2017

I still have a uSD with the Alexa code installed. I will retest its performance tomorrow or the next day and report back on this thread.

@bill-orange

This comment has been minimized.

bill-orange commented Mar 16, 2017

Looks like the changes you made did some good, I am not getting the timeouts now. It is an intermittent so I will watch it for a bit.

@elstryan

This comment has been minimized.

Collaborator

elstryan commented Mar 16, 2017

Glad to hear it! I'll mark this as closed for now and we'll keep our eye out for the issue.

@elstryan elstryan closed this Mar 16, 2017

@sangshengjie

This comment has been minimized.

sangshengjie commented Jul 22, 2017

@elstryan
I run the code on my pc, it worked well.
But when I run the code on my arm device which environment is "Linux buildroot 3.10.33 #1 SMP PREEMPT Fri Jul 21 11:18:13 CST 2017 armv7l GNU/Linux", the error came always.
Did the server request some specially environment? Or did the avs not support in my country(china)?

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment