Error Login

smsoousa5 years ago

Hello Anton and everyone.
I'm having the following problem when signing in, as attached image.

Description text

Can you tell me how to solve it?
View my logs:

FINEST|22031/0|Service traccar|19-04-11 17:45:34|Caused by: java.util.concurrent.TimeoutException: Idle timeout expired: 30001/30000 ms
...
FINEST|22031/0|Service traccar|19-04-11 18:01:16|Apr 11, 2019 6:01:16 PM org.glassfish.jersey.server.ServerRuntime$Responder writeResponse
FINEST|22031/0|Service traccar|19-04-11 18:01:16|SEVERE: Error while closing the output stream in order to commit response.
FINEST|22031/0|Service traccar|19-04-11 18:01:16|java.nio.channels.WritePendingException
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.server.HttpConnection$SendCallback.reset(HttpConnection.java:669)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.server.HttpConnection$SendCallback.access$100(HttpConnection.java:639)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.server.HttpConnection.send(HttpConnection.java:480)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.server.HttpChannel.sendResponse(HttpChannel.java:765)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.server.HttpChannel.write(HttpChannel.java:798)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.server.HttpOutput.write(HttpOutput.java:155)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.server.HttpOutput.write(HttpOutput.java:148)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.server.HttpOutput.flush(HttpOutput.java:250)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.glassfish.jersey.servlet.internal.ResponseWriter$NonCloseableOutputStreamWrapper.flush(ResponseWriter.java:330)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.glassfish.jersey.message.internal.CommittingOutputStream.flush(CommittingOutputStream.java:292)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.glassfish.jersey.message.internal.OutboundMessageContext.close(OutboundMessageContext.java:876)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.glassfish.jersey.server.ContainerResponse.close(ContainerResponse.java:412)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.glassfish.jersey.server.ServerRuntime$Responder.writeResponse(ServerRuntime.java:784)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.glassfish.jersey.server.ServerRuntime$Responder.processResponse(ServerRuntime.java:444)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.glassfish.jersey.server.ServerRuntime$Responder.process(ServerRuntime.java:434)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.glassfish.jersey.server.ServerRuntime$2.run(ServerRuntime.java:329)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.glassfish.jersey.internal.Errors$1.call(Errors.java:271)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.glassfish.jersey.internal.Errors$1.call(Errors.java:267)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.glassfish.jersey.internal.Errors.process(Errors.java:315)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.glassfish.jersey.internal.Errors.process(Errors.java:297)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.glassfish.jersey.internal.Errors.process(Errors.java:267)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.glassfish.jersey.process.internal.RequestScope.runInScope(RequestScope.java:317)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.glassfish.jersey.server.ServerRuntime.process(ServerRuntime.java:305)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.glassfish.jersey.server.ApplicationHandler.handle(ApplicationHandler.java:1154)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.glassfish.jersey.servlet.WebComponent.serviceImpl(WebComponent.java:473)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.glassfish.jersey.servlet.WebComponent.service(WebComponent.java:427)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:388)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:341)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:228)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:812)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:587)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:221)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1127)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:515)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1061)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.server.handler.HandlerList.handle(HandlerList.java:52)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:97)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.server.Server.handle(Server.java:499)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:311)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:258)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.io.AbstractConnection$2.run(AbstractConnection.java:544)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at java.lang.Thread.run(Thread.java:748)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|
FINEST|22031/0|Service traccar|19-04-11 18:01:16|[qtp654416693-884] WARN org.eclipse.jetty.server.HttpChannel - complete failed
FINEST|22031/0|Service traccar|19-04-11 18:01:16|java.nio.channels.WritePendingException
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.server.HttpConnection$SendCallback.reset(HttpConnection.java:669)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.server.HttpConnection$SendCallback.access$100(HttpConnection.java:639)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.server.HttpConnection.send(HttpConnection.java:480)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.server.HttpChannel.sendResponse(HttpChannel.java:765)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.server.HttpChannel.write(HttpChannel.java:798)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.server.HttpOutput.write(HttpOutput.java:155)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.server.HttpOutput.write(HttpOutput.java:148)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.server.HttpOutput.close(HttpOutput.java:179)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.server.Response.closeOutput(Response.java:1007)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:422)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:258)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.io.AbstractConnection$2.run(AbstractConnection.java:544)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555)
FINEST|22031/0|Service traccar|19-04-11 18:01:16|	at java.lang.Thread.run(Thread.java:748)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|[qtp654416693-50-selector-ServerConnectorManager@6afe181b/0] WARN org.eclipse.jetty.io.SelectorManager - Could not process key for channel java.nio.channels.SocketChannel[connected local=/63.142.251.174:8082 remote=/177.99.66.177:1913]
FINEST|22031/0|Service traccar|19-04-11 18:01:26|java.lang.IllegalStateException: org.eclipse.jetty.util.SharedBlockingCallback$BlockerTimeoutException
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.eclipse.jetty.util.SharedBlockingCallback$Blocker.succeeded(SharedBlockingCallback.java:137)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.eclipse.jetty.server.HttpChannel$CommitCallback.succeeded(HttpChannel.java:841)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.eclipse.jetty.server.HttpConnection$SendCallback.onCompleteSuccess(HttpConnection.java:776)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.eclipse.jetty.util.IteratingCallback.processing(IteratingCallback.java:300)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.eclipse.jetty.util.IteratingCallback.succeeded(IteratingCallback.java:367)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.eclipse.jetty.io.WriteFlusher$PendingState.complete(WriteFlusher.java:270)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.eclipse.jetty.io.WriteFlusher.completeWrite(WriteFlusher.java:383)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.eclipse.jetty.io.SelectChannelEndPoint.onSelected(SelectChannelEndPoint.java:111)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.eclipse.jetty.io.SelectorManager$ManagedSelector.processKey(SelectorManager.java:641)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.eclipse.jetty.io.SelectorManager$ManagedSelector.select(SelectorManager.java:612)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.eclipse.jetty.io.SelectorManager$ManagedSelector.run(SelectorManager.java:550)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.eclipse.jetty.util.thread.NonBlockingThread.run(NonBlockingThread.java:52)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at java.lang.Thread.run(Thread.java:748)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|Caused by: org.eclipse.jetty.util.SharedBlockingCallback$BlockerTimeoutException
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.eclipse.jetty.util.SharedBlockingCallback$Blocker.block(SharedBlockingCallback.java:195)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.eclipse.jetty.server.HttpOutput.write(HttpOutput.java:149)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.eclipse.jetty.server.HttpOutput.flush(HttpOutput.java:250)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.glassfish.jersey.servlet.internal.ResponseWriter$NonCloseableOutputStreamWrapper.flush(ResponseWriter.java:330)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.glassfish.jersey.message.internal.CommittingOutputStream.flush(CommittingOutputStream.java:292)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.glassfish.jersey.message.internal.WriterInterceptorExecutor$UnCloseableOutputStream.flush(WriterInterceptorExecutor.java:304)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at com.fasterxml.jackson.core.json.UTF8JsonGenerator.flush(UTF8JsonGenerator.java:1048)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at com.fasterxml.jackson.databind.ObjectWriter.writeValue(ObjectWriter.java:942)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at com.fasterxml.jackson.jaxrs.base.ProviderBase.writeTo(ProviderBase.java:618)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.glassfish.jersey.message.internal.WriterInterceptorExecutor$TerminalWriterInterceptor.invokeWriteTo(WriterInterceptorExecutor.java:265)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.glassfish.jersey.message.internal.WriterInterceptorExecutor$TerminalWriterInterceptor.aroundWriteTo(WriterInterceptorExecutor.java:250)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.glassfish.jersey.message.internal.WriterInterceptorExecutor.proceed(WriterInterceptorExecutor.java:162)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.glassfish.jersey.server.internal.JsonWithPaddingInterceptor.aroundWriteTo(JsonWithPaddingInterceptor.java:106)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.glassfish.jersey.message.internal.WriterInterceptorExecutor.proceed(WriterInterceptorExecutor.java:162)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.glassfish.jersey.server.internal.MappableExceptionWrapperInterceptor.aroundWriteTo(MappableExceptionWrapperInterceptor.java:86)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.glassfish.jersey.message.internal.WriterInterceptorExecutor.proceed(WriterInterceptorExecutor.java:162)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.glassfish.jersey.message.internal.MessageBodyFactory.writeTo(MessageBodyFactory.java:1130)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.glassfish.jersey.server.ServerRuntime$Responder.writeResponse(ServerRuntime.java:711)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.glassfish.jersey.server.ServerRuntime$Responder.processResponse(ServerRuntime.java:444)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.glassfish.jersey.server.ServerRuntime$Responder.process(ServerRuntime.java:434)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.glassfish.jersey.server.ServerRuntime$2.run(ServerRuntime.java:329)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.glassfish.jersey.internal.Errors$1.call(Errors.java:271)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.glassfish.jersey.internal.Errors$1.call(Errors.java:267)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.glassfish.jersey.internal.Errors.process(Errors.java:315)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.glassfish.jersey.internal.Errors.process(Errors.java:297)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.glassfish.jersey.internal.Errors.process(Errors.java:267)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.glassfish.jersey.process.internal.RequestScope.runInScope(RequestScope.java:317)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.glassfish.jersey.server.ServerRuntime.process(ServerRuntime.java:305)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.glassfish.jersey.server.ApplicationHandler.handle(ApplicationHandler.java:1154)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.glassfish.jersey.servlet.WebComponent.serviceImpl(WebComponent.java:473)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.glassfish.jersey.servlet.WebComponent.service(WebComponent.java:427)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:388)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:341)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:228)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:812)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:587)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:221)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1127)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:515)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1061)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.eclipse.jetty.server.handler.HandlerList.handle(HandlerList.java:52)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:97)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.eclipse.jetty.server.Server.handle(Server.java:499)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:311)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:258)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	at org.eclipse.jetty.io.AbstractConnection$2.run(AbstractConnection.java:544)
FINEST|22031/0|Service traccar|19-04-11 18:01:26|	... 3 more
FINEST|22031/0|Service traccar|19-04-11 18:17:01|[qtp654416693-965] WARN org.eclipse.jetty.server.handler.ResourceHandler - org.eclipse.jetty.io.EofException
FINEST|22031/0|Service traccar|19-04-11 18:50:23|[qtp654416693-1060] WARN org.eclipse.jetty.server.handler.ResourceHandler - org.eclipse.jetty.io.EofException
Track-trace5 years ago

Hi, Im not an expert. But seems you have no msql connection. Make sure mysql server is up.

P.s.
Im interested to discuss your progress with traccar. can you send me an email message to bernhardruimschoot@gmail.com

Anton Tananaev5 years ago

Increase MySQL connection timeouts.

smsoousa5 years ago

Sorry for my ignorance and for getting away from it, but you could tell me what the file would be to edit this configuration on Linux server Ubuntu 16.04

smsoousa5 years ago

Hi Anton, I did these procedures to try to fix the problem, but today it happened again, see the logs...

1 - Enter SFTP via root
2 - Open the file /etc/my.cnf
3 - Enter the following line: open_files_limit = 100000
4 - Save the changes
5 - Restarting MySQL

FINEST|1462/0|Service traccar|19-04-12 17:34:01|	at org.glassfish.jersey.server.internal.MappableExceptionWrapperInterceptor.aroundWriteTo(MappableExceptionWrapperInterceptor.java:86)
FINEST|1462/0|Service traccar|19-04-12 17:34:01|	... 36 more
FINEST|1462/0|Service traccar|19-04-12 17:34:01|Caused by: org.eclipse.jetty.util.SharedBlockingCallback$BlockerTimeoutException
FINEST|1462/0|Service traccar|19-04-12 17:34:01|	at org.eclipse.jetty.util.SharedBlockingCallback$Blocker.block(SharedBlockingCallback.java:195)
FINEST|1462/0|Service traccar|19-04-12 17:34:01|	... 61 more
FINEST|1462/0|Service traccar|19-04-12 17:34:01|
FINEST|1462/0|Service traccar|19-04-12 17:34:01|Apr 12, 2019 5:34:01 PM org.glassfish.jersey.server.ServerRuntime$Responder writeResponse
FINEST|1462/0|Service traccar|19-04-12 17:34:01|SEVERE: Error while closing the output stream in order to commit response.
FINEST|1462/0|Service traccar|19-04-12 17:34:01|java.nio.channels.WritePendingException
---
FINEST|1462/0|Service traccar|19-04-12 17:34:01|	at java.lang.Thread.run(Thread.java:748)
FINEST|1462/0|Service traccar|19-04-12 17:34:09|[Scheduler-829409053] WARN org.eclipse.jetty.server.HttpChannel - Commit failed
FINEST|1462/0|Service traccar|19-04-12 17:34:09|java.util.concurrent.TimeoutException: Idle timeout expired: 30001/30000 ms
FINEST|1462/0|Service traccar|19-04-12 17:34:09|	at org.eclipse.jetty.io.IdleTimeout.checkIdleTimeout(IdleTimeout.java:161)
FINEST|1462/0|Service traccar|19-04-12 17:34:09|	at org.eclipse.jetty.io.IdleTimeout$1.run(IdleTimeout.java:50)
FINEST|1462/0|Service traccar|19-04-12 17:34:09|	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:473)
FINEST|1462/0|Service traccar|19-04-12 17:34:09|	at java.util.concurrent.FutureTask.run(FutureTask.java:262)
FINEST|1462/0|Service traccar|19-04-12 17:34:09|	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:178)
FINEST|1462/0|Service traccar|19-04-12 17:34:09|	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:292)
FINEST|1462/0|Service traccar|19-04-12 17:34:09|	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1152)
FINEST|1462/0|Service traccar|19-04-12 17:34:09|	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:622)
FINEST|1462/0|Service traccar|19-04-12 17:34:09|	at java.lang.Thread.run(Thread.java:748)
FINEST|1462/0|Service traccar|19-04-12 17:34:22|[qtp986137999-50-selector-ServerConnectorManager@19f14230/0] WARN org.eclipse.jetty.io.SelectorManager - Could not process key for channel java.nio.channels.SocketChannel[connected local=/63.142.251.174:8082 remote=/189.71.103.196:58433]
FINEST|1462/0|Service traccar|19-04-12 17:34:22|java.lang.IllegalStateException: org.eclipse.jetty.util.SharedBlockingCallback$BlockerTimeoutException
FINEST|1462/0|Service traccar|19-04-12 17:34:22|	at org.eclipse.jetty.util.SharedBlockingCallback$Blocker.failed(SharedBlockingCallback.java:163)
FINEST|1462/0|Service traccar|19-04-12 17:34:22|	at org.eclipse.jetty.server.HttpChannel$CommitCallback$1.succeeded(HttpChannel.java:861)
FINEST|1462/0|Service traccar|19-04-12 17:34:22|	at org.eclipse.jetty.server.HttpConnection$SendCallback.onCompleteSuccess(HttpConnection.java:776)
FINEST|1462/0|Service traccar|19-04-12 17:34:22|	at org.eclipse.jetty.util.IteratingCallback.processing(IteratingCallback.java:300)
FINEST|1462/0|Service traccar|19-04-12 17:34:22|	at org.eclipse.jetty.util.IteratingCallback.succeeded(IteratingCallback.java:367)
FINEST|1462/0|Service traccar|19-04-12 17:34:22|	at org.eclipse.jetty.io.WriteFlusher$PendingState.complete(WriteFlusher.java:270)
FINEST|1462/0|Service traccar|19-04-12 17:34:22|	at org.eclipse.jetty.io.WriteFlusher.completeWrite(WriteFlusher.java:383)
FINEST|1462/0|Service traccar|19-04-12 17:34:22|	at org.eclipse.jetty.io.SelectChannelEndPoint.onSelected(SelectChannelEndPoint.java:111)
FINEST|1462/0|Service traccar|19-04-12 17:34:22|	at org.eclipse.jetty.io.SelectorManager$ManagedSelector.processKey(SelectorManager.java:641)
FINEST|1462/0|Service traccar|19-04-12 17:34:22|	at org.eclipse.jetty.io.SelectorManager$ManagedSelector.select(SelectorManager.java:612)
FINEST|1462/0|Service traccar|19-04-12 17:34:22|	at org.eclipse.jetty.io.SelectorManager$ManagedSelector.run(SelectorManager.java:550)
FINEST|1462/0|Service traccar|19-04-12 17:34:22|	at org.eclipse.jetty.util.thread.NonBlockingThread.run(NonBlockingThread.java:52)
FINEST|1462/0|Service traccar|19-04-12 17:34:22|	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635)
FINEST|1462/0|Service traccar|19-04-12 17:34:22|	at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555)
FINEST|1462/0|Service traccar|19-04-12 17:34:22|	at java.lang.Thread.run(Thread.java:748)
FINEST|1462/0|Service traccar|19-04-12 17:34:22|Caused by: org.eclipse.jetty.util.SharedBlockingCallback$BlockerTimeoutException
---
FINEST|1462/0|Service traccar|19-04-12 17:34:24|[qtp986137999-50-selector-ServerConnectorManager@19f14230/0] WARN org.eclipse.jetty.io.SelectorManager - Could not process key for channel java.nio.channels.SocketChannel[connected local=/63.142.251.174:8082 remote=/189.71.103.196:55408]
FINEST|1462/0|Service traccar|19-04-12 17:34:24|java.lang.IllegalStateException: org.eclipse.jetty.util.SharedBlockingCallback$BlockerTimeoutException
FINEST|1462/0|Service traccar|19-04-12 17:34:24|	at org.eclipse.jetty.util.SharedBlockingCallback$Blocker.failed(SharedBlockingCallback.java:163)
FINEST|1462/0|Service traccar|19-04-12 17:34:24|	at org.eclipse.jetty.server.HttpChannel$CommitCallback$1.succeeded(HttpChannel.java:861)
FINEST|1462/0|Service traccar|19-04-12 17:34:24|	at org.eclipse.jetty.server.HttpConnection$SendCallback.onCompleteSuccess(HttpConnection.java:776)
---
FINEST|1462/0|Service traccar|19-04-12 17:34:24|	at java.lang.Thread.run(Thread.java:748)
FINEST|1462/0|Service traccar|19-04-12 17:34:24|Caused by: org.eclipse.jetty.util.SharedBlockingCallback$BlockerTimeoutException
FINEST|1462/0|Service traccar|19-04-12 17:34:24|	at org.eclipse.jetty.util.SharedBlockingCallback$Blocker.block(SharedBlockingCallback.java:195)
FINEST|1462/0|Service traccar|19-04-12 17:34:24|	at org.eclipse.jetty.server.HttpOutput.write(HttpOutput.java:149)
FINEST|1462/0|Service traccar|19-04-12 17:34:24|	at org.eclipse.jetty.server.HttpOutput.write(HttpOutput.java:363)
FINEST|1462/0|Service traccar|19-04-12 17:34:24|	at org.glassfish.jersey.servlet.internal.ResponseWriter$NonCloseableOutputStreamWrapper.write(ResponseWriter.java:325)
---
Anton Tananaev5 years ago

How is open_files_limit related to timeout?

smsoousa5 years ago

The default is 30000, so I went to 100000. However, in the logs, the default value of 30000

FINEST|11661/0|Service traccar|19-04-13 00:33:21|[Scheduler-1553795451] WARN org.eclipse.jetty.server.HttpChannel - Commit failed
FINEST|11661/0|Service traccar|19-04-13 00:33:21|java.util.concurrent.TimeoutException: Idle timeout expired: 30000/30000 ms
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.eclipse.jetty.io.IdleTimeout.checkIdleTimeout(IdleTimeout.java:161)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.eclipse.jetty.io.IdleTimeout$1.run(IdleTimeout.java:50)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:473)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at java.util.concurrent.FutureTask.run(FutureTask.java:262)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:178)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:292)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1152)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:622)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at java.lang.Thread.run(Thread.java:748)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|Apr 13, 2019 12:33:21 AM org.glassfish.jersey.server.ServerRuntime$Responder writeResponse
FINEST|11661/0|Service traccar|19-04-13 00:33:21|SEVERE: An I/O error has occurred while writing a response message entity to the container output stream.
FINEST|11661/0|Service traccar|19-04-13 00:33:21|org.glassfish.jersey.server.internal.process.MappableException: java.io.IOException: java.util.concurrent.TimeoutException: Idle timeout expired: 30000/30000 ms
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.glassfish.jersey.server.internal.MappableExceptionWrapperInterceptor.aroundWriteTo(MappableExceptionWrapperInterceptor.java:92)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.glassfish.jersey.message.internal.WriterInterceptorExecutor.proceed(WriterInterceptorExecutor.java:162)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.glassfish.jersey.message.internal.MessageBodyFactory.writeTo(MessageBodyFactory.java:1130)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.glassfish.jersey.server.ServerRuntime$Responder.writeResponse(ServerRuntime.java:711)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.glassfish.jersey.server.ServerRuntime$Responder.processResponse(ServerRuntime.java:444)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.glassfish.jersey.server.ServerRuntime$Responder.process(ServerRuntime.java:434)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.glassfish.jersey.server.ServerRuntime$2.run(ServerRuntime.java:329)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.glassfish.jersey.internal.Errors$1.call(Errors.java:271)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.glassfish.jersey.internal.Errors$1.call(Errors.java:267)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.glassfish.jersey.internal.Errors.process(Errors.java:315)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.glassfish.jersey.internal.Errors.process(Errors.java:297)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.glassfish.jersey.internal.Errors.process(Errors.java:267)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.glassfish.jersey.process.internal.RequestScope.runInScope(RequestScope.java:317)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.glassfish.jersey.server.ServerRuntime.process(ServerRuntime.java:305)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.glassfish.jersey.server.ApplicationHandler.handle(ApplicationHandler.java:1154)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.glassfish.jersey.servlet.WebComponent.serviceImpl(WebComponent.java:473)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.glassfish.jersey.servlet.WebComponent.service(WebComponent.java:427)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:388)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:341)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:228)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:812)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:587)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:221)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1127)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:515)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1061)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.eclipse.jetty.server.handler.HandlerList.handle(HandlerList.java:52)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:97)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.eclipse.jetty.server.Server.handle(Server.java:499)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:311)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:258)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.eclipse.jetty.io.AbstractConnection$2.run(AbstractConnection.java:544)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at java.lang.Thread.run(Thread.java:748)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|Caused by: java.io.IOException: java.util.concurrent.TimeoutException: Idle timeout expired: 30000/30000 ms
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.eclipse.jetty.util.SharedBlockingCallback$Blocker.block(SharedBlockingCallback.java:213)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.eclipse.jetty.server.HttpOutput.write(HttpOutput.java:149)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.eclipse.jetty.server.HttpOutput.flush(HttpOutput.java:250)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.glassfish.jersey.servlet.internal.ResponseWriter$NonCloseableOutputStreamWrapper.flush(ResponseWriter.java:330)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.glassfish.jersey.message.internal.CommittingOutputStream.flush(CommittingOutputStream.java:292)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.glassfish.jersey.message.internal.WriterInterceptorExecutor$UnCloseableOutputStream.flush(WriterInterceptorExecutor.java:304)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at com.fasterxml.jackson.core.json.UTF8JsonGenerator.flush(UTF8JsonGenerator.java:1048)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at com.fasterxml.jackson.databind.ObjectWriter.writeValue(ObjectWriter.java:942)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at com.fasterxml.jackson.jaxrs.base.ProviderBase.writeTo(ProviderBase.java:618)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.glassfish.jersey.message.internal.WriterInterceptorExecutor$TerminalWriterInterceptor.invokeWriteTo(WriterInterceptorExecutor.java:265)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.glassfish.jersey.message.internal.WriterInterceptorExecutor$TerminalWriterInterceptor.aroundWriteTo(WriterInterceptorExecutor.java:250)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.glassfish.jersey.message.internal.WriterInterceptorExecutor.proceed(WriterInterceptorExecutor.java:162)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.glassfish.jersey.server.internal.JsonWithPaddingInterceptor.aroundWriteTo(JsonWithPaddingInterceptor.java:106)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.glassfish.jersey.message.internal.WriterInterceptorExecutor.proceed(WriterInterceptorExecutor.java:162)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.glassfish.jersey.server.internal.MappableExceptionWrapperInterceptor.aroundWriteTo(MappableExceptionWrapperInterceptor.java:86)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	... 36 more
FINEST|11661/0|Service traccar|19-04-13 00:33:21|Caused by: java.util.concurrent.TimeoutException: Idle timeout expired: 30000/30000 ms
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.eclipse.jetty.io.IdleTimeout.checkIdleTimeout(IdleTimeout.java:161)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at org.eclipse.jetty.io.IdleTimeout$1.run(IdleTimeout.java:50)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:473)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at java.util.concurrent.FutureTask.run(FutureTask.java:262)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:178)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:292)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1152)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:622)
FINEST|11661/0|Service traccar|19-04-13 00:33:21|	... 1 more
FINEST|11661/0|Service traccar|19-04-13 00:33:21|
FINEST|11661/0|Service traccar|19-04-13 05:34:12|[qtp994629287-607] WARN org.eclipse.jetty.server.handler.ResourceHandler - org.eclipse.jetty.io.EofException
FINEST|11661/0|Service traccar|19-04-13 06:59:40|[qtp994629287-650] WARN org.eclipse.jetty.http.HttpParser - Illegal character 0x16 in state=START for buffer HeapByteBuffer@43437a99[p=1,l=227,c=16384,r=226]={\x16<<<\x03\x01\x00\xDe\x01\x00\x00\xDa\x03\x03E\x00\x14tK\xB4...\x03\x02\x03\x03\x02\x01\x02\x02\x02\x03\x00\x0f\x00\x01\x01>>>caabzci5x4\r\nUser-...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00}
FINEST|11661/0|Service traccar|19-04-13 06:59:40|[qtp994629287-650] WARN org.eclipse.jetty.http.HttpParser - badMessage: 400 Illegal character 0x16 for HttpChannelOverHttp@325f54f{r=0,c=false,a=IDLE,uri=}
FINEST|11661/0|Service traccar|19-04-13 07:42:00|[qtp994629287-650] WARN org.eclipse.jetty.server.handler.ResourceHandler - org.eclipse.jetty.io.EofException
FINEST|11661/0|Service traccar|19-04-13 08:18:20|[qtp994629287-1530] WARN org.eclipse.jetty.http.HttpParser - Illegal character 0x16 in state=START for buffer HeapByteBuffer@43437a99[p=1,l=257,c=16384,r=256]={\x16<<<\x03\x01\x00\xFc\x01\x00\x00\xF8\x03\x03\xF8\xA9\xFe<x\x94=...\x03\x02\x03\x03\x02\x01\x02\x02\x02\x03\x00\x0f\x00\x01\x01>>>p/3.4.2\r\n\r\nncodin...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00}
FINEST|11661/0|Service traccar|19-04-13 08:18:20|[qtp994629287-1530] WARN org.eclipse.jetty.http.HttpParser - badMessage: 400 Illegal character 0x16 for HttpChannelOverHttp@415952a9{r=0,c=false,a=IDLE,uri=}
FINEST|11661/0|Service traccar|19-04-13 08:37:49|[qtp994629287-1613] WARN org.eclipse.jetty.server.handler.ResourceHandler - org.eclipse.jetty.io.EofException
FINEST|11661/0|Service traccar|19-04-13 08:42:00|[qtp994629287-1665] WARN org.eclipse.jetty.server.handler.ResourceHandler - org.eclipse.jetty.io.EofException
Ernesto Vallejo5 years ago

Check this link.

Abner Velasco5 years ago

you do not have access to the database server, you must verify the connection or in the best case, your username and password do not have permissions to access the traccar database.

Verify the connection with the MySQL Server
Verify if you have the correct username and password
Verify if the user has sufficient permissions

smsoousa5 years ago

Hello friends and Anton.
I have still not been able to resolve the problem, even by increasing Mysql connection timeout.

INFO|18909/0|Service traccar|19-04-17 03:17:48|[qtp177388537-55] WARN org.eclipse.jetty.http.HttpParser - Illegal character 0x3 in state=START for buffer HeapByteBuffer@7ee2df1c[p=1,l=47,c=16384,r=46]={\x03<<<\x00\x00/*\xE0\x00\x00\x00\x00\x00Cookie:...nistr\r\n\x01\x00\x08\x00\x03\x00\x00\x00>>>.com:8082\r\nConnec...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00}
INFO|18909/0|Service traccar|19-04-17 03:17:48|[qtp177388537-55] WARN org.eclipse.jetty.http.HttpParser - badMessage: 400 Illegal character 0x3 for HttpChannelOverHttp@4a4c216f{r=0,c=false,a=IDLE,uri=}
INFO|18909/0|Service traccar|19-04-17 04:38:08|[Scheduler-2003313507] WARN org.eclipse.jetty.server.HttpChannel - Commit failed
INFO|18909/0|Service traccar|19-04-17 04:38:08|java.util.concurrent.TimeoutException: Idle timeout expired: 30002/30000 ms
INFO|18909/0|Service traccar|19-04-17 04:38:08|	at org.eclipse.jetty.io.IdleTimeout.checkIdleTimeout(IdleTimeout.java:161)
INFO|18909/0|Service traccar|19-04-17 04:38:08|	at org.eclipse.jetty.io.IdleTimeout$1.run(IdleTimeout.java:50)
INFO|18909/0|Service traccar|19-04-17 04:38:08|	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:473)
INFO|18909/0|Service traccar|19-04-17 04:38:08|	at java.util.concurrent.FutureTask.run(FutureTask.java:262)
INFO|18909/0|Service traccar|19-04-17 04:38:08|	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:178)
INFO|18909/0|Service traccar|19-04-17 04:38:08|	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:292)
INFO|18909/0|Service traccar|19-04-17 04:38:08|	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1152)
INFO|18909/0|Service traccar|19-04-17 04:38:08|	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:622)
INFO|18909/0|Service traccar|19-04-17 04:38:08|	at java.lang.Thread.run(Thread.java:748)
INFO|18909/0|Service traccar|19-04-17 04:38:08|[Scheduler-2003313507] WARN org.eclipse.jetty.server.handler.ResourceHandler - java.util.concurrent.TimeoutException: Idle timeout expired: 30002/30000 ms
INFO|18909/0|Service traccar|19-04-17 05:35:18|[qtp177388537-190] WARN org.eclipse.jetty.server.handler.ResourceHandler - org.eclipse.jetty.io.EofException
INFO|18909/0|Service traccar|19-04-17 05:35:18|[qtp177388537-204] WARN org.eclipse.jetty.server.handler.ResourceHandler - org.eclipse.jetty.io.EofException
INFO|18909/0|Service traccar|19-04-17 06:10:28|[qtp177388537-216] WARN org.eclipse.jetty.server.handler.ResourceHandler - org.eclipse.jetty.io.EofException
INFO|18909/0|Service traccar|19-04-17 08:09:10|[qtp177388537-270] WARN org.eclipse.jetty.server.handler.ResourceHandler - org.eclipse.jetty.io.EofException
INFO|18909/0|Service traccar|19-04-17 08:27:36|[qtp177388537-286] WARN org.eclipse.jetty.server.handler.ResourceHandler - org.eclipse.jetty.io.EofException
INFO|18909/0|Service traccar|19-04-17 08:27:37|[qtp177388537-270] WARN org.eclipse.jetty.server.handler.ResourceHandler - org.eclipse.jetty.io.EofException
INFO|18909/0|Service traccar|19-04-17 09:22:11|[qtp177388537-270] WARN org.eclipse.jetty.server.handler.ResourceHandler - org.eclipse.jetty.io.EofException
INFO|18909/0|Service traccar|19-04-17 09:51:07|[qtp177388537-322] WARN org.eclipse.jetty.server.handler.ResourceHandler - org.eclipse.jetty.io.EofException
INFO|18909/0|Service traccar|19-04-17 09:51:08|[qtp177388537-321] WARN org.eclipse.jetty.server.handler.ResourceHandler - org.eclipse.jetty.io.EofException
INFO|18909/0|Service traccar|19-04-17 12:05:57|[qtp177388537-396] WARN org.eclipse.jetty.server.handler.ResourceHandler - org.eclipse.jetty.io.EofException
INFO|18909/0|Service traccar|19-04-17 12:06:06|[Scheduler-2003313507] WARN org.eclipse.jetty.server.HttpChannel - Commit failed
INFO|18909/0|Service traccar|19-04-17 12:06:06|java.util.concurrent.TimeoutException: Idle timeout expired: 30001/30000 ms
INFO|18909/0|Service traccar|19-04-17 12:06:06|	at org.eclipse.jetty.io.IdleTimeout.checkIdleTimeout(IdleTimeout.java:161)
INFO|18909/0|Service traccar|19-04-17 12:06:06|	at org.eclipse.jetty.io.IdleTimeout$1.run(IdleTimeout.java:50)
INFO|18909/0|Service traccar|19-04-17 12:06:06|	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:473)
INFO|18909/0|Service traccar|19-04-17 12:06:06|	at java.util.concurrent.FutureTask.run(FutureTask.java:262)
INFO|18909/0|Service traccar|19-04-17 12:06:06|	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:178)
INFO|18909/0|Service traccar|19-04-17 12:06:06|	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:292)
INFO|18909/0|Service traccar|19-04-17 12:06:06|	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1152)
INFO|18909/0|Service traccar|19-04-17 12:06:06|	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:622)
INFO|18909/0|Service traccar|19-04-17 12:06:06|	at java.lang.Thread.run(Thread.java:748)
INFO|18909/0|Service traccar|19-04-17 12:06:06|[Scheduler-2003313507] WARN org.eclipse.jetty.server.handler.ResourceHandler - java.util.concurrent.TimeoutException: Idle timeout expired: 30001/30000 ms
INFO|18909/0|Service traccar|19-04-17 13:18:15|[Scheduler-2003313507] WARN org.eclipse.jetty.server.HttpChannel - Commit failed
INFO|18909/0|Service traccar|19-04-17 13:18:15|java.util.concurrent.TimeoutException: Idle timeout expired: 30000/30000 ms
INFO|18909/0|Service traccar|19-04-17 13:18:15|	at org.eclipse.jetty.io.IdleTimeout.checkIdleTimeout(IdleTimeout.java:161)
INFO|18909/0|Service traccar|19-04-17 13:18:15|	at org.eclipse.jetty.io.IdleTimeout$1.run(IdleTimeout.java:50)
INFO|18909/0|Service traccar|19-04-17 13:18:15|	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:473)
INFO|18909/0|Service traccar|19-04-17 13:18:15|	at java.util.concurrent.FutureTask.run(FutureTask.java:262)
INFO|18909/0|Service traccar|19-04-17 13:18:15|	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:178)
INFO|18909/0|Service traccar|19-04-17 13:18:15|	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:292)
INFO|18909/0|Service traccar|19-04-17 13:18:15|	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1152)
INFO|18909/0|Service traccar|19-04-17 13:18:15|	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:622)
INFO|18909/0|Service traccar|19-04-17 13:18:15|	at java.lang.Thread.run(Thread.java:748)
INFO|18909/0|Service traccar|19-04-17 13:18:15|[Scheduler-2003313507] WARN org.eclipse.jetty.server.handler.ResourceHandler - java.util.concurrent.TimeoutException: Idle timeout expired: 30000/30000 ms
INFO|wrapper|Service traccar|19-04-17 15:05:36|Shutting down Wrapper
INFO|wrapper|Service traccar|19-04-17 15:05:36|stopping process with pid/timeout 18909 45000
INFO|18909/0|Service traccar|19-04-17 15:05:37|wrapper manager received stop command
INFO|18909/0|Service traccar|19-04-17 15:05:37|[Thread-12] INFO org.eclipse.jetty.server.ServerConnector - Stopped ServerConnector@13755d15{HTTP/1.1}{0.0.0.0:8082}
INFO|18909/0|Service traccar|19-04-17 15:05:37|[Thread-12] INFO org.eclipse.jetty.server.handler.ContextHandler - Stopped o.t.w.@37819e72{/,null,UNAVAILABLE}
INFO|18909/0|Service traccar|19-04-17 15:05:37|[Thread-12] INFO org.eclipse.jetty.server.handler.ContextHandler - Stopped o.e.j.s.ServletContextHandler@3688d12f{/api,null,UNAVAILABLE}
...
INFO|27055/0|Service traccar|19-04-17 15:06:18|INFO 4/17/19 3:06 PM: liquibase: Successfully acquired change log lock
INFO|27055/0|Service traccar|19-04-17 15:06:21|INFO 4/17/19 3:06 PM: liquibase: Reading from tecsat.DATABASECHANGELOG
INFO|27055/0|Service traccar|19-04-17 15:06:21|INFO 4/17/19 3:06 PM: liquibase: Reading from tecsat.DATABASECHANGELOG
INFO|27055/0|Service traccar|19-04-17 15:06:21|INFO 4/17/19 3:06 PM: liquibase: ./schema/changelog-master.xml: changelog-3.8::changelog-3.8-dropuniquetoken::author: Change set changelog-3.8::changelog-3.8-dropuniquetoken::author failed, but failOnError was false.  Error: Can't DROP 'uk_user_token'; check that column/key exists [Failed SQL: ALTER TABLE tecsat.users DROP KEY uk_user_token]
INFO|27055/0|Service traccar|19-04-17 15:06:21|INFO 4/17/19 3:06 PM: liquibase: Successfully released change log lock
INFO|27055/0|Service traccar|19-04-17 15:06:22|[main] INFO org.eclipse.jetty.util.log - Logging initialized @9274ms
INFO|27055/0|Service traccar|19-04-17 15:06:23|[main] INFO org.eclipse.jetty.server.Server - jetty-9.2.24.v20180105
INFO|27055/0|Service traccar|19-04-17 15:06:26|[main] INFO org.eclipse.jetty.server.handler.ContextHandler - Started o.e.j.s.ServletContextHandler@2b641c83{/api,null,AVAILABLE}
INFO|27055/0|Service traccar|19-04-17 15:06:26|[main] INFO org.eclipse.jetty.server.handler.ContextHandler - Started o.t.w.@f390948{/,null,AVAILABLE}
INFO|27055/0|Service traccar|19-04-17 15:06:26|[main] INFO org.eclipse.jetty.server.ServerConnector - Started ServerConnector@2103ad6{HTTP/1.1}{0.0.0.0:8082}
INFO|27055/0|Service traccar|19-04-17 15:06:26|[main] INFO org.eclipse.jetty.server.Server - Started @13698ms
INFO|27055/0|Service traccar|19-04-17 15:06:54|[qtp1332975086-63] WARN org.eclipse.jetty.server.handler.ResourceHandler - org.eclipse.jetty.io.EofException
INFO|27055/0|Service traccar|19-04-17 15:06:54|[qtp1332975086-55] WARN org.eclipse.jetty.server.handler.ResourceHandler - org.eclipse.jetty.io.EofException
Anton Tananaev5 years ago

As you can clearly see from logs, your MySQL timeout hasn't changed and is still 30 seconds:

Idle timeout expired: 30000/30000 ms
Track-trace5 years ago

Isnt 3 seconds already a very long time ?

I also wonder why this setting would be needed to change. Sins it already was running for a long time without these constant timeouts.

smsoousa5 years ago

I configured my my.cnf, see if it is correct:

#
# The MySQL database server configuration file.
#
# You can copy this to one of:
# - "/etc/mysql/my.cnf" to set global options,
# - "~/.my.cnf" to set user-specific options.
# 
# One can use all long options that the program supports.
# Run program with --help to get a list of available options and with
# --print-defaults to see which it would actually understand and use.
#
# For explanations see
# http://dev.mysql.com/doc/mysql/en/server-system-variables.html

# This will be passed to all mysql clients
# It has been reported that passwords should be enclosed with ticks/quotes
# escpecially if they contain "#" chars...
# Remember to edit /etc/mysql/debian.cnf when changing the socket location.
[client]
port		= 3306
socket		= /var/run/mysqld/mysqld.sock

# Here is entries for some specific programs
# The following values assume you have at least 32M ram

# This was formally known as [safe_mysqld]. Both versions are currently parsed.
[mysqld_safe]
socket		= /var/run/mysqld/mysqld.sock
nice		= 0

[mysqld]
#
# * Basic Settings
#
user		= mysql
pid-file	= /var/run/mysqld/mysqld.pid
socket		= /var/run/mysqld/mysqld.sock
port		= 3306
basedir		= /usr
datadir		= /var/lib/mysql
tmpdir		= /tmp
lc-messages-dir	= /usr/share/mysql
skip-external-locking
#
# Instead of skip-networking the default is now to listen only on
# localhost which is more compatible and is not less secure.
bind-address		= 127.0.0.1
#
# * Fine Tuning
#
key_buffer		= 64M
max_allowed_packet	= 64M
thread_stack		= 192K
thread_cache_size       = 8
# This replaces the startup script and checks MyISAM tables if needed
# the first time they are touched
myisam-recover         = BACKUP
max_connections        = 10000
table_cache            = 20000
thread_concurrency     = 10
#
# * Query Cache Configuration
#
query_cache_limit	= 5M
query_cache_size        = 128M
#
# * Logging and Replication
#
# Both location gets rotated by the cronjob.
# Be aware that this log type is a performance killer.
# As of 5.1 you can enable the log at runtime!
#general_log_file        = /var/log/mysql/mysql.log
#general_log             = 1
#
# Error log - should be very few entries.
#
log_error = /var/log/mysql/error.log
#
# Here you can see queries with especially long duration
#log_slow_queries	= /var/log/mysql/mysql-slow.log
#long_query_time = 2
#log-queries-not-using-indexes
#
# The following can be used as easy to replay backup logs or for replication.
# note: if you are setting up a replication slave, see README.Debian about
#       other settings you may need to change.
#server-id		= 1
#log_bin			= /var/log/mysql/mysql-bin.log
expire_logs_days	= 10
max_binlog_size         = 100M
#binlog_do_db		= include_database_name
#binlog_ignore_db	= include_database_name
#
# * InnoDB
#
# InnoDB is enabled by default with a 10MB datafile in /var/lib/mysql/.
# Read the manual for more InnoDB related options. There are many!
#
# * Security Features
#
# Read the manual, too, if you want chroot!
# chroot = /var/lib/mysql/
#
# For generating SSL certificates I recommend the OpenSSL GUI "tinyca".
#
# ssl-ca=/etc/mysql/cacert.pem
# ssl-cert=/etc/mysql/server-cert.pem
# ssl-key=/etc/mysql/server-key.pem



[mysqldump]
quick
quote-names
max_allowed_packet	= 64M

[mysql]
#no-auto-rehash	# faster start of mysql but no tab completition

[isamchk]
key_buffer		= 64M

#
# * IMPORTANT: Additional settings that can override those from this file!
#   The files must end with '.cnf', otherwise they'll be ignored.
#
!includedir /etc/mysql/conf.d/

open_files_limit = 7000000000
wait_timeout = 28800
interactive_timeout = 28800
smsoousa5 years ago

Hello everyone, now when accessing the system I got the "500 - Server Error". I checked, and the system generated a log file of almost 4GB, and CPU usage went to 100%, knocking down the server even with the logs turned off.

smsoousa5 years ago

This is the system-generated log size "5.673.886.903" even though it is disabled in the settings. Now I'm getting the error:

FINEST|4274/0|Service traccar|19-04-18 10:48:10|java.io.IOException: Too many open files
FINEST|4274/0|Service traccar|19-04-18 10:48:10|	at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
FINEST|4274/0|Service traccar|19-04-18 10:48:10|	at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:250)
FINEST|4274/0|Service traccar|19-04-18 10:48:10|	at org.eclipse.jetty.server.ServerConnector.accept(ServerConnector.java:377)
FINEST|4274/0|Service traccar|19-04-18 10:48:10|	at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:500)
FINEST|4274/0|Service traccar|19-04-18 10:48:10|	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635)
FINEST|4274/0|Service traccar|19-04-18 10:48:10|	at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555)
FINEST|4274/0|Service traccar|19-04-18 10:48:10|	at java.lang.Thread.run(Thread.java:748)
FINEST|4274/0|Service traccar|19-04-18 10:48:10|[qtp1752523585-52-acceptor-0@4cd60dde-ServerConnector@485c7356{HTTP/1.1}{0.0.0.0:8082}] WARN org.eclipse.jetty.server.ServerConnector - 
FINEST|4274/0|Service traccar|19-04-18 10:48:10|java.io.IOException: Too many open files
FINEST|4274/0|Service traccar|19-04-18 10:48:10|	at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
FINEST|4274/0|Service traccar|19-04-18 10:48:10|	at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:250)
FINEST|4274/0|Service traccar|19-04-18 10:48:10|	at org.eclipse.jetty.server.ServerConnector.accept(ServerConnector.java:377)
FINEST|4274/0|Service traccar|19-04-18 10:48:10|	at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:500)
FINEST|4274/0|Service traccar|19-04-18 10:48:10|	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635)
FINEST|4274/0|Service traccar|19-04-18 10:48:10|	at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555)
FINEST|4274/0|Service traccar|19-04-18 10:48:10|	at java.lang.Thread.run(Thread.java:748)
FINEST|4274/0|Service traccar|19-04-18 10:48:10|[qtp1752523585-52-acceptor-0@4cd60dde-ServerConnector@485c7356{HTTP/1.1}{0.0.0.0:8082}] WARN org.eclipse.jetty.server.ServerConnector - 
FINEST|4274/0|Service traccar|19-04-18 10:48:10|java.io.IOException: Too many open files
FINEST|4274/0|Service traccar|19-04-18 10:48:10|	at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
FINEST|4274/0|Service traccar|19-04-18 10:48:10|	at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:250)
FINEST|4274/0|Service traccar|19-04-18 10:48:10|	at org.eclipse.jetty.server.ServerConnector.accept(ServerConnector.java:377)
FINEST|4274/0|Service traccar|19-04-18 10:48:10|	at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:500)
FINEST|4274/0|Service traccar|19-04-18 10:48:10|	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635)
FINEST|4274/0|Service traccar|19-04-18 10:48:10|	at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555)
FINEST|4274/0|Service traccar|19-04-18 10:48:10|	at java.lang.Thread.run(Thread.java:748)
FINEST|4274/0|Service traccar|19-04-18 10:48:10|[qtp1752523585-52-acceptor-0@4cd60dde-ServerConnector@485c7356{HTTP/1.1}{0.0.0.0:8082}] WARN org.eclipse.jetty.server.ServerConnector - 
FINEST|4274/0|Service traccar|19-04-18 10:48:10|java.io.IOException: Too many open files
FINEST|4274/0|Service traccar|19-04-18 10:48:10|	at sun.nio.ch.ServerSocketChannelImpl.accept0(Native Method)
FINEST|4274/0|Service traccar|19-04-18 10:48:10|	at sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:250)
FINEST|4274/0|Service traccar|19-04-18 10:48:10|	at org.eclipse.jetty.server.ServerConnector.accept(ServerConnector.java:377)
FINEST|4274/0|Service traccar|19-04-18 10:48:10|	at org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:500)
FINEST|4274/0|Service traccar|19-04-18 10:48:10|	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635)
FINEST|4274/0|Service traccar|19-04-18 10:48:10|	at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555)
FINEST|4274/0|Service traccar|19-04-18 10:48:10|	at java.lang.Thread.run(Thread.java:748)

I'm getting this error multiple times per second
My setting in default.xml:



<entry key='logger.level'>off</entry>