System disconnecting repeatedly

Hello Anton and everyone.
I have an endless problem in the system, it is disconnected suddenly, having to restart the service to return to normal operation.

Previously I used a server with only 512mb of memory, I informed you about the connection error, and you told me that it could be the server with low memory and that it would ideally be one of at least 1gb for the system to work fine, so I changed Server and hired a 2GB memory plan, but the error persists.

Here are some facts:

Using Ubuntu 14.04 64-bit
2GB of memory
Java package installed: default-jre
28 active devices in the system

My traccar.xml setting:

<entry key="config.default">./conf/default.xml</entry>
    
<entry key='geocoder.enable'>true</entry>
<entry key='geocoder.type'>nominatim</entry>
<entry key='geocoder.url'>http://locationiq.org/v1/reverse.php</entry>
<entry key='geocoder.key'>my key</entry>
<entry key='database.driver'>com.mysql.jdbc.Driver</entry> 
<entry key='database.url'>jdbc:mysql://localhost:3306/mydatabase?allowMultiQueries=true&autoReconnect=true&useUnicode=yes&characterEncoding=UTF-8&sessionVariables=sql_mode=''</entry>
<entry key='database.user'>usuario_cli</entry> 
<entry key='database.password'>senha_cli</entry>
<entry key='logger.enable'>true</entry>
<entry key='logger.level'>all</entry>
<entry key='logger.file'>./logs/tracker-server.log</entry>
<entry key='event.enable'>true</entry>
<entry key='event.overspeedHandler'>true</entry>
<entry key='event.overspeed.notRepeat'>true</entry>
<entry key='event.motionHandler'>true</entry>
<entry key='event.geofenceHandler'>true</entry>
<entry key='event.alertHandler'>true</entry>
<entry key='event.ignitionHandler'>true</entry>
<entry key='event.statusHandler'>true</entry>
<entry key='event.maintenanceHandler'>true</entry>	
<entry key='processing.copyAttributes'>power,ignition,battery</entry>
<entry key='processing.copyAttributes.enable'>true</entry>	
<entry key='report.trip.minimalTripDistance'>1</entry>
<entry key='report.trip.minimalTripDuration'>30</entry>	
<entry key='database.positionsHistoryDays'>120</entry>

Follows log data:
- tracker-server.log


2017-04-19 18:51:41  INFO: [3CF8376A] connected
2017-04-19 18:51:41 DEBUG: [A92E93A1: 5001 < 187.60.56.100] HEX: 3836383638333032323830303537313b696d65693a3836383638333032323830303537312c747261636b65722c3137303431393135353133322c2c462c3138353132382e3030302c412c303534372e353630332c532c30333531322e353832362c572c2c3b
2017-04-19 18:51:41 DEBUG: [A92E93A1: 5001 > 187.60.56.100] HEX: 4f4e
2017-04-19 18:51:41  INFO: Shutting down server...
2017-04-19 18:51:41 DEBUG: [DA3C2F90: 5001 < 187.60.56.100] HEX: 3836383638333032373239393633393b696d65693a3836383638333032373239393633392c616363206f66662c3137303432303032353034362c2c462c3138353034312e3030302c412c303535322e393737382c532c30333531322e323136332c572c302e30302c303b696d65693a3836383638333032373239393633392c747261636b65722c3137303432303032353035372c2c462c3138353035322e3030302c412c303535322e393737382c532c30333531322e323136332c572c302e30302c303b
2017-04-19 18:51:41 DEBUG: [DA3C2F90: 5001 > 187.60.56.100] HEX: 4f4e
2017-04-19 18:51:41 DEBUG: [F7A752D0: 5001 < 187.60.56.100] HEX: 696d65693a3836383638333032353136393033322c747261636b65722c3137303431393135353033342c2c462c3138353033302e3030302c412c303534382e343632342c532c30333531322e363434302c572c372e31382c3334392e35393b3836383638333032353136393033323b696d65693a3836383638333032353136393033322c747261636b65722c3137303431393135353131392c2c462c3138353131352e3030302c412c303534382e343330322c532c30333531322e363233392c572c302e30302c303b696d65693a3836383638333032353136393033322c616363206f66662c3137303431393135353133332c2c462c3138353132372e3030302c412c303534382e343330322c532c30333531322e363233392c572c302e30302c303b696d65693a3836383638333032353136393033322c616363206f6e2c3137303431393135353133352c2c462c3138353133302e3030302c412c303534382e343330322c532c30333531322e363233392c572c302e30302c303b
2017-04-19 18:51:41 DEBUG: [F7A752D0: 5001 > 187.60.56.100] HEX: 4f4e
2017-04-19 18:51:41 DEBUG: [3CF8376A: 5001 < 187.60.56.100] HEX: 23232c696d65693a3836383638333032353334323737392c413b
2017-04-19 18:51:41 DEBUG: [3CF8376A: 5001 > 187.60.56.100] HEX: 4c4f4144
2017-04-19 18:51:41  INFO: [CDD17616] connected
2017-04-19 18:51:41  INFO: [41D7DD70] connected
2017-04-19 18:51:41 DEBUG: [ECA0E4C8: 5001 < 187.60.56.100] HEX: 3836383638333032323831303539363b696d65693a3836383638333032323831303539362c747261636b65722c3137303431393135353130302c2c462c3138353035352e3030302c412c303534342e313832392c532c30333531342e333334382c572c302e30302c303b696d65693a3836383638333032323831303539362c747261636b65722c3137303431393135353132302c2c462c3138353131362e3030302c412c303534342e313832392c532c30333531342e333334382c572c302e30302c303b
2017-04-19 18:51:41 DEBUG: [ECA0E4C8: 5001 > 187.60.56.100] HEX: 4f4e
2017-04-19 18:51:41 DEBUG: [C5712487: 5001 < 187.60.56.100] HEX: 3836383638333032373432363031383b696d65693a3836383638333032373432363031382c616363206f6e2c3137303432303032353132372c2c462c3138353132312e3030302c412c303534382e323837372c532c30333531332e363632332c572c302e30302c303b696d65693a3836383638333032373432363031382c616363206f66662c3137303432303032353133312c2c462c3138353132362e3030302c412c303534382e323837372c532c30333531332e363632332c572c302e30302c303b696d65693a3836383638333032373432363031382c616363206f6e2c3137303432303032353133352c2c462c3138353133302e3030302c412c303534382e323739302c532c30333531332e363539382c572c392e37392c32312e34333b
2017-04-19 18:51:41 DEBUG: [C5712487: 5001 > 187.60.56.100] HEX: 4f4e
2017-04-19 18:51:41 DEBUG: [CDD17616: 5001 < 187.60.56.100] HEX: 23232c696d65693a3836383638333032353139363539372c413b
2017-04-19 18:51:41 DEBUG: [CDD17616: 5001 > 187.60.56.100] HEX: 4c4f4144
2017-04-19 18:51:41  INFO: [CDD17616] disconnected
2017-04-19 18:51:41 DEBUG: [41D7DD70: 5001 < 187.60.56.100] HEX: 23232c696d65693a3836383638333032353139363539372c413b
2017-04-19 18:51:41 DEBUG: [41D7DD70: 5001 > 187.60.56.100] HEX: 4c4f4144
2017-04-19 18:51:41  INFO: [61A6272E] disconnected

2017-04-19 18:51:42 INFO: [DA3C2F90] id: 868683027299639, time: 2017-04-19 18:50:52, lat: -5.88296, lon: -35.20361, speed: 0.0, course: 0.0
2017-04-19 18:51:42 WARN: Geocoding failed - Empty address - GeocoderException (JsonGeocoder:74 < ...)
2017-04-19 22:58:46 INFO: Operating system name: Linux version: 3.13.0-100-generic architecture: amd64
2017-04-19 22:58:46 INFO: Java runtime name: OpenJDK 64-Bit Server VM vendor: Oracle Corporation version: 24.121-b00
2017-04-19 22:58:46 INFO: Memory limit heap: 643mb non-heap: 214mb
2017-04-19 22:58:46 INFO: Character encoding: UTF-8 charset: UTF-8
2017-04-19 22:58:46 INFO: Version: 3.10-SNAPSHOT
2017-04-19 22:58:54 INFO: Starting server...
2017-04-19 22:59:00 INFO: [0DA6BA8E] connected
2017-04-19 22:59:00 DEBUG: [0DA6BA8E: 5001 < 187.60.56.100] HEX: 23232c696d65693a3836383638333032373432363031382c413b
2017-04-19 22:59:00 DEBUG: [0DA6BA8E: 5001 > 187.60.56.100] HEX: 4c4f4144
2017-04-19 22:59:01 DEBUG: [0DA6BA8E: 5001 < 187.60.56.100] HEX: 696d65693a3836383638333032373432363031382c616363206f6e2c3137303432303036353835392c2c462c3232353835352e3030302c412c303534382e383432372c532c30333531322e353730392c572c31392e35322c3130382e35373b
2017-04-19 22:59:01 INFO: [0DA6BA8E] id: 868683027426018, time: 2017-04-19 22:58:55, lat: -5.81405, lon: -35.20952, speed: 19.5, course: 108.6
2017-04-19 22:59:02 INFO: [78389C5A] connected
2017-04-19 22:59:02 DEBUG: [78389C5A: 5001 < 187.60.56.100] HEX: 23232c696d65693a3836383638333032353136393033322c413b
2017-04-19 22:59:02 DEBUG: [78389C5A: 5001 > 187.60.56.100] HEX: 4c4f4144
2017-04-19 22:59:03 INFO: [E9B77915] connected

wrapper.log:

FINEST|31433/0|Service traccar|17-04-19 04:17:47|[HikariPool-1 housekeeper] WARN com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Thread starvation or clock leap detected (housekeeper delta=47s109ms647µs717ns).
FINEST|31433/0|Service traccar|17-04-19 12:13:21|[HikariPool-1 housekeeper] WARN com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Thread starvation or clock leap detected (housekeeper delta=46s770ms677µs475ns).
FINEST|31433/0|Service traccar|17-04-19 17:26:49|[HikariPool-1 housekeeper] WARN com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Thread starvation or clock leap detected (housekeeper delta=58s950ms79µs994ns).
FINEST|31433/0|Service traccar|17-04-19 17:59:36|[HikariPool-1 housekeeper] WARN com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Thread starvation or clock leap detected (housekeeper delta=45s289ms283µs551ns).
FINEST|31433/0|Service traccar|17-04-19 18:20:48|[HikariPool-1 housekeeper] WARN com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Thread starvation or clock leap detected (housekeeper delta=48s960ms410µs62ns).
FINEST|31433/0|Service traccar|17-04-19 18:42:04|[HikariPool-1 housekeeper] WARN com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Thread starvation or clock leap detected (housekeeper delta=1m2s797ms997µs349ns).
INFO|31433/0|Service traccar|17-04-19 18:51:39|Missing wrapper ping within timeout of 30000
WARNING|31433/0|Service traccar|17-04-19 18:51:39|ping between java application and wrapper timed out. if this this is due to server overload consider increasing wrapper.ping.timeout
INFO|31433/0|Service traccar|17-04-19 18:51:41|wrapper manager received stop command
FINEST|31433/0|Service traccar|17-04-19 18:51:41|[HikariPool-1 housekeeper] WARN com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Thread starvation or clock leap detected (housekeeper delta=1m28s307ms228µs398ns).
FINEST|31433/0|Service traccar|17-04-19 18:51:41|[Thread-12] INFO org.eclipse.jetty.server.ServerConnector - Stopped ServerConnector@23f79429{HTTP/1.1}{0.0.0.0:8082}
FINEST|31433/0|Service traccar|17-04-19 18:51:41|[Thread-12] INFO org.eclipse.jetty.server.handler.ContextHandler - Stopped o.e.j.s.ServletContextHandler@63d82a54{/api,null,UNAVAILABLE}
INFO|wrapper|Service traccar|17-04-19 18:51:42|waitpid 31433 0
INFO|wrapper|Service traccar|17-04-19 18:51:42|exit code posix process: 0 application: 0
WARNING|wrapper|Service traccar|17-04-19 22:58:44|YAJSW: yajsw-stable-12.08
WARNING|wrapper|Service traccar|17-04-19 22:58:44|OS   : Linux/3.13.0-100-generic/amd64
WARNING|wrapper|Service traccar|17-04-19 22:58:44|JVM  : Oracle Corporation/1.7.0_121//usr/lib/jvm/java-7-openjdk-amd64/jre/64
INFO|wrapper|Service traccar|17-04-19 22:58:44|exec:"java" "-classpath" "/opt/traccar/wrapperApp.jar:/opt/traccar/tracker-server.jar:/opt/traccar/lib/log4j-1.2.17.jar:/opt/traccar/lib/joda-time-2.9.7.jar:/opt/traccar/lib/h2-1.4.193.jar:/opt/traccar/lib/mysql-connector-java-5.1.40.jar:/opt/traccar/lib/postgresql-9.4.1212.jre7.jar:/opt/traccar/lib/mssql-jdbc-6.1.0.jre7.jar:/opt/traccar/lib/HikariCP-java7-2.4.11.jar:/opt/traccar/lib/slf4j-api-1.7.21.jar:/opt/traccar/lib/netty-3.10.6.Final.jar:/opt/traccar/lib/async-http-client-1.9.40.jar:/opt/traccar/lib/slf4j-simple-1.7.22.jar:/opt/traccar/lib/javax.json-1.0.4.jar:/opt/traccar/lib/jetty-server-9.2.21.v20170120.jar:/opt/traccar/lib/javax.servlet-api-3.1.0.jar:/opt/traccar/lib/jetty-http-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-io-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-servlet-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-security-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-webapp-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-xml-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-jndi-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-util-9.2.21.v20170120.jar:/opt/traccar/lib/websocket-server-9.2.21.v20170120.jar:/opt/traccar/lib/websocket-common-9.2.21.v20170120.jar:/opt/traccar/lib/websocket-api-9.2.21.v20170120.jar:/opt/traccar/lib/websocket-client-9.2.21.v20170120.jar:/opt/traccar/lib/websocket-servlet-9.2.21.v20170120.jar:/opt/traccar/lib/jersey-container-servlet-2.25.1.jar:/opt/traccar/lib/jersey-container-servlet-core-2.25.1.jar:/opt/traccar/lib/javax.inject-2.5.0-b32.jar:/opt/traccar/lib/jersey-common-2.25.1.jar:/opt/traccar/lib/javax.annotation-api-1.2.jar:/opt/traccar/lib/jersey-guava-2.25.1.jar:/opt/traccar/lib/hk2-api-2.5.0-b32.jar:/opt/traccar/lib/hk2-utils-2.5.0-b32.jar:/opt/traccar/lib/aopalliance-repackaged-2.5.0-b32.jar:/opt/traccar/lib/hk2-locator-2.5.0-b32.jar:/opt/traccar/lib/javassist-3.20.0-GA.jar:/opt/traccar/lib/osgi-resource-locator-1.0.1.jar:/opt/traccar/lib/jersey-server-2.25.1.jar:/opt/traccar/lib/jersey-client-2.25.1.jar:/opt/traccar/lib/jersey-media-jaxb-2.25.1.jar:/opt/traccar/lib/validation-api-1.1.0.Final.jar:/opt/traccar/lib/javax.ws.rs-api-2.0.1.jar:/opt/traccar/lib/jersey-media-json-jackson-2.25.1.jar:/opt/traccar/lib/jersey-entity-filtering-2.25.1.jar:/opt/traccar/lib/jackson-jaxrs-base-2.8.4.jar:/opt/traccar/lib/jackson-core-2.8.4.jar:/opt/traccar/lib/jackson-databind-2.8.4.jar:/opt/traccar/lib/jackson-jaxrs-json-provider-2.8.4.jar:/opt/traccar/lib/jackson-module-jaxb-annotations-2.8.4.jar:/opt/traccar/lib/jackson-annotations-2.8.4.jar:/opt/traccar/lib/liquibase-core-3.5.3.jar:/opt/traccar/lib/snakeyaml-1.17.jar:/opt/traccar/lib/mail-1.4.7.jar:/opt/traccar/lib/activation-1.1.jar:/opt/traccar/lib/jxls-2.3.0.jar:/opt/traccar/lib/commons-jexl-2.1.1.jar:/opt/traccar/lib/commons-logging-1.1.1.jar:/opt/traccar/lib/commons-beanutils-1.9.2.jar:/opt/traccar/lib/jcl-over-slf4j-1.7.12.jar:/opt/traccar/lib/logback-core-1.1.3.jar:/opt/traccar/lib/jxls-poi-1.0.11.jar:/opt/traccar/lib/poi-3.14.jar:/opt/traccar/lib/poi-ooxml-3.14.jar:/opt/traccar/lib/poi-ooxml-schemas-3.14.jar:/opt/traccar/lib/xmlbeans-2.6.0.jar:/opt/traccar/lib/stax-api-1.0.1.jar:/opt/traccar/lib/curvesapi-1.03.jar:/opt/traccar/lib/velocity-1.7.jar:/opt/traccar/lib/commons-collections-3.2.1.jar:/opt/traccar/lib/commons-lang-2.4.jar:/opt/traccar/lib/ical4j-2.0.0.jar:/opt/traccar/lib/commons-collections4-4.0.jar:/opt/traccar/lib/groovy-all-2.3.2.jar:/opt/traccar/lib/bndlib-2.3.0.jar:/opt/traccar/lib/org.osgi.core-4.3.1.jar:/opt/traccar/lib/commons-lang3-3.3.2.jar:/opt/traccar/lib/commons-codec-1.9.jar" "-Dfile.encoding=UTF-8" "-Xrs" "-Dwrapper.service=true" "-Dwrapper.console.visible=false" "-Dwrapper.port=15003" "-Dwrapper.key=4822902580851400911" "-Dwrapper.teeName=4822902580851400911$1492642724135" "-Dwrapper.tmp.path=/opt/traccar/tmp" "-Djna_tmpdir=/opt/traccar/tmp" "-Dwrapper.config=/opt/traccar/conf/wrapper.conf" "-Dwrapper.visible=false" "-Dwrapper.pidfile=/run/wrapper.traccar.pid" "org.rzo.yajsw.app.WrapperJVMMain" 
INFO|wrapper|Service traccar|17-04-19 22:58:44|posix_spawn pid 4401
INFO|wrapper|Service traccar|17-04-19 22:58:44|started process 4401
INFO|wrapper|Service traccar|17-04-19 22:58:44|started process with pid 4401
INFO|4401/0|Service traccar|17-04-19 22:58:46|[INFO] StandardFileSystemManager - Using "/tmp/vfs_cache" as temporary files store.
INFO|4401/0|Service traccar|17-04-19 22:58:47|[main] INFO com.zaxxer.hikari.HikariDataSource - HikariPool-1 - Starting...
INFO|4401/0|Service traccar|17-04-19 22:58:47|[main] INFO com.zaxxer.hikari.HikariDataSource - HikariPool-1 - Start completed.
INFO|4401/0|Service traccar|17-04-19 22:58:48|INFO 4/19/17 10:58 PM: liquibase: Clearing database change log checksums
INFO|4401/0|Service traccar|17-04-19 22:58:49|INFO 4/19/17 10:58 PM: liquibase: Successfully acquired change log lock
INFO|4401/0|Service traccar|17-04-19 22:58:49|INFO 4/19/17 10:58 PM: liquibase: Successfully released change log lock
INFO|4401/0|Service traccar|17-04-19 22:58:49|INFO 4/19/17 10:58 PM: liquibase: Successfully acquired change log lock
INFO|4401/0|Service traccar|17-04-19 22:58:52|INFO 4/19/17 10:58 PM: liquibase: Reading from tecsat.DATABASECHANGELOG
INFO|4401/0|Service traccar|17-04-19 22:58:52|INFO 4/19/17 10:58 PM: liquibase: Reading from tecsat.DATABASECHANGELOG
INFO|4401/0|Service traccar|17-04-19 22:58:52|INFO 4/19/17 10:58 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|4401/0|Service traccar|17-04-19 22:58:52|INFO 4/19/17 10:58 PM: liquibase: Successfully released change log lock
INFO|4401/0|Service traccar|17-04-19 22:58:53|[main] INFO org.eclipse.jetty.util.log - Logging initialized @8382ms
INFO|4401/0|Service traccar|17-04-19 22:58:54|[main] INFO org.eclipse.jetty.server.Server - jetty-9.2.21.v20170120
INFO|4401/0|Service traccar|17-04-19 22:58:56|[main] INFO org.eclipse.jetty.server.handler.ContextHandler - Started o.e.j.s.ServletContextHandler@7a17959a{/api,null,AVAILABLE}
INFO|4401/0|Service traccar|17-04-19 22:58:56|[main] INFO org.eclipse.jetty.server.ServerConnector - Started ServerConnector@2ae6d0e2{HTTP/1.1}{0.0.0.0:8082}
INFO|4401/0|Service traccar|17-04-19 22:58:56|[main] INFO org.eclipse.jetty.server.Server - Started @11832ms

Anton Tananaev8 years ago

It seems like you ran out of resources. How many users and devices do you have?

smsoousa8 years ago

Hello Anton.

30 devices
22 users

Anton Tananaev8 years ago

That doesn't sound like a lot. You might want to check this page:

https://www.traccar.org/optimization/

smsoousa8 years ago

Anton, this sentence from the configuration file, refers to the sending time of the device? In my case I configured the devices to send data every 5 minutes, the configuration in seconds would have to be more than 5 minutes in the web.timeout, but how much longer? The double?

"It’s configured per protocol, and it’s recommended to set the value (in seconds) to slightly higher than your device reporting interval."

I will try the optimization setup as you have quoted, and I will test, we will see the result, any anomaly or fall back from the server I inform you.

smsoousa8 years ago

Would it be possible to create a cron on the server, so when the system disconnects for any reason, it automatically runs it?

Anton Tananaev8 years ago

Optimization page refers to protocol timeout, not web timeout. You should should pick value slightly higher than reporting interval.

As for cron, I don't see why not.

smsoousa8 years ago

Hello Anton.
I did the procedures as directed, but the result remains the same. The system has stopped again since yesterday at around 8:00 p.m.

tracker-server.log

2017-04-23 23:07:44 DEBUG: [41BFBFEB: 5001 < 187.60.56.100] HEX: 696d65693a3836383638333032323830313732382c747261636b65722c3137303432333230303734312c2c462c3233303733372e3030302c412c303334352e303632392c532c30333833302e323132362c572c2c3b
2017-04-23 23:07:45  INFO: [41BFBFEB] id: 868683022801728, time: 2017-04-23 23:07:37, lat: -3.75105, lon: -38.50354, speed: 0.0, course: 0.0
2017-04-23 23:07:46 DEBUG: [41BFBFEB: 5001 < 187.60.56.100] HEX: 3836383638333032323830313732383b
2017-04-23 23:07:46 DEBUG: [41BFBFEB: 5001 > 187.60.56.100] HEX: 4f4e
2017-04-23 23:07:57 DEBUG: [9702A6E2: 5001 < 187.60.56.100] HEX: 696d65693a3836383638333032373432363031382c616363206f66662c3137303432343037303735362c2c462c3233303735312e3030302c412c303534342e373336372c532c30333531342e353935322c572c31362e39372c3134332e32303b
...
2017-04-23 23:09:02  INFO: [8EE20634] disconnected
2017-04-23 23:09:02  INFO: [C8D8DEC3] disconnected
2017-04-23 23:09:02  INFO: [CF6BD752] disconnected
2017-04-23 23:09:02  INFO: [702F5C97] disconnected
2017-04-23 23:09:02  INFO: [25994516] disconnected
2017-04-23 23:09:02  INFO: [A6D49B54] disconnected

wrapper.log

INFO|1394/0|Service traccar|17-04-23 15:44:15|[HikariPool-1 housekeeper] WARN com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Thread starvation or clock leap detected (housekeeper delta=45s326ms615??s619ns).
INFO|1394/0|Service traccar|17-04-23 15:51:43|[HikariPool-1 housekeeper] WARN com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Thread starvation or clock leap detected (housekeeper delta=45s928ms815??s190ns).
INFO|1394/0|Service traccar|17-04-23 16:10:04|[HikariPool-1 housekeeper] WARN com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Thread starvation or clock leap detected (housekeeper delta=50s440ms837??s169ns).
INFO|1394/0|Service traccar|17-04-23 17:51:16|[HikariPool-1 housekeeper] WARN com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Thread starvation or clock leap detected (housekeeper delta=58s379ms65??s254ns).
INFO|1394/0|Service traccar|17-04-23 18:48:57|[HikariPool-1 housekeeper] WARN com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Thread starvation or clock leap detected (housekeeper delta=56s162ms330??s549ns).
INFO|1394/0|Service traccar|17-04-23 22:24:51|[HikariPool-1 housekeeper] WARN com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Thread starvation or clock leap detected (housekeeper delta=47s231ms805??s904ns).
INFO|1394/0|Service traccar|17-04-23 22:25:47|[HikariPool-1 housekeeper] WARN com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Thread starvation or clock leap detected (housekeeper delta=55s670ms963??s458ns).
INFO|1394/0|Service traccar|17-04-23 22:54:07|[HikariPool-1 housekeeper] WARN com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Thread starvation or clock leap detected (housekeeper delta=46s307ms36??s837ns).
INFO|1394/0|Service traccar|17-04-23 23:05:49|[HikariPool-1 housekeeper] WARN com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Thread starvation or clock leap detected (housekeeper delta=55s286ms921??s578ns).
INFO|1394/0|Service traccar|17-04-23 23:07:05|[HikariPool-1 housekeeper] WARN com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Thread starvation or clock leap detected (housekeeper delta=46s881ms529??s50ns).
INFO|1394/0|Service traccar|17-04-23 23:08:29|[HikariPool-1 housekeeper] WARN com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Thread starvation or clock leap detected (housekeeper delta=53s90ms23??s478ns).
INFO|1394/0|Service traccar|17-04-23 23:08:59|Missing wrapper ping within timeout of 30000
WARNING|1394/0|Service traccar|17-04-23 23:08:59|ping between java application and wrapper timed out. if this this is due to server overload consider increasing wrapper.ping.timeout
INFO|1394/0|Service traccar|17-04-23 23:09:01|wrapper manager received stop command
INFO|1394/0|Service traccar|17-04-23 23:09:01|[Thread-12] INFO org.eclipse.jetty.server.ServerConnector - Stopped ServerConnector@6ba2fbc7{HTTP/1.1}{0.0.0.0:8082}
INFO|1394/0|Service traccar|17-04-23 23:09:01|[Thread-12] INFO org.eclipse.jetty.server.handler.ContextHandler - Stopped o.e.j.s.ServletContextHandler@40e2e453{/api,null,UNAVAILABLE}
INFO|wrapper|Service traccar|17-04-23 23:09:02|waitpid 1394 0
INFO|wrapper|Service traccar|17-04-23 23:09:02|exit code posix process: 0 application: 0

smsoousa8 years ago

This log is today, when I started the system

2017-04-24 09:44:42  INFO: Operating system name: Linux version: 3.13.0-100-generic architecture: amd64
2017-04-24 09:44:42  INFO: Java runtime name: OpenJDK 64-Bit Server VM vendor: Oracle Corporation version: 24.121-b00
2017-04-24 09:44:42  INFO: Memory limit heap: 643mb non-heap: 214mb
2017-04-24 09:44:42  INFO: Character encoding: UTF-8 charset: UTF-8
2017-04-24 09:44:42  INFO: Version: 3.10-SNAPSHOT
2017-04-24 09:44:50  INFO: Starting server...
2017-04-24 09:44:59  INFO: [6EA2D62D] connected
2017-04-24 09:45:00 DEBUG: [6EA2D62D: 5001 < 187.60.56.100] HEX: 23232c696d65693a3836383638333032353136383333312c413b
2017-04-24 09:45:00 DEBUG: [6EA2D62D: 5001 > 187.60.56.100] HEX: 4c4f4144

Anton Tananaev8 years ago

Looks like you are running out of database connections. Usually it happens when there are many long running queries. Try to set "database.maxPoolSize" parameter in the config to a high number (e.g. 100 or more).

smsoousa8 years ago

Hi, Anton.
I did the procedure as you directed me, but the same problem continues.

2017-04-24 15:59:02 DEBUG: [BD989D22: 5001 < 187.60.56.100] HEX: 3836383638333032373432363031383b
2017-04-24 15:59:02 DEBUG: [BD989D22: 5001 > 187.60.56.100] HEX: 4f4e
2017-04-24 15:59:02  INFO: [9CC4B23C] id: 868683022810596, time: 2017-04-24 15:58:25, lat: -5.70588, lon: -35.26613, speed: 0.0, course: 0.0
2017-04-24 15:59:02  INFO: Shutting down server...
2017-04-24 15:59:03  INFO: [06ACF0CA] disconnected
...
2017-04-25 09:30:03  INFO: [3A09096F] disconnected
2017-04-25 09:30:14  INFO: Operating system name: Linux version: 3.13.0-100-generic architecture: amd64
2017-04-25 09:30:14  INFO: Java runtime name: OpenJDK 64-Bit Server VM vendor: Oracle Corporation version: 24.121-b00
2017-04-25 09:30:14  INFO: Memory limit heap: 643mb non-heap: 214mb
2017-04-25 09:30:14  INFO: Character encoding: UTF-8 charset: UTF-8
2017-04-25 09:30:14  INFO: Version: 3.10-SNAPSHOT
2017-04-25 09:30:22  INFO: Starting server...
2017-04-25 09:30:36  INFO: [ECE0F2C1] connected
2017-04-25 09:30:36 DEBUG: [ECE0F2C1: 5001 < 187.60.56.100] HEX: 23232c696d65693a3836383638333032323831303539362c413b
2017-04-25 09:30:36 DEBUG: [ECE0F2C1: 5001 > 187.60.56.100] HEX: 4c4f4144
2017-04-25 09:30:37  INFO: [BC54721A] connected

WARNING|wrapper|Service traccar|17-04-24 09:44:36|YAJSW: yajsw-stable-12.08
WARNING|wrapper|Service traccar|17-04-24 09:44:36|OS   : Linux/3.13.0-100-generic/amd64
WARNING|wrapper|Service traccar|17-04-24 09:44:36|JVM  : Oracle Corporation/1.7.0_121//usr/lib/jvm/java-7-openjdk-amd64/jre/64
INFO|wrapper|Service traccar|17-04-24 09:44:40|exec:"java" "-classpath" "/opt/traccar/wrapperApp.jar:/opt/traccar/tracker-server.jar:/opt/traccar/lib/log4j-1.2.17.jar:/opt/traccar/lib/joda-time-2.9.7.jar:/opt/traccar/lib/h2-1.4.193.jar:/opt/traccar/lib/mysql-connector-java-5.1.40.jar:/opt/traccar/lib/postgresql-9.4.1212.jre7.jar:/opt/traccar/lib/mssql-jdbc-6.1.0.jre7.jar:/opt/traccar/lib/HikariCP-java7-2.4.11.jar:/opt/traccar/lib/slf4j-api-1.7.21.jar:/opt/traccar/lib/netty-3.10.6.Final.jar:/opt/traccar/lib/async-http-client-1.9.40.jar:/opt/traccar/lib/slf4j-simple-1.7.22.jar:/opt/traccar/lib/javax.json-1.0.4.jar:/opt/traccar/lib/jetty-server-9.2.21.v20170120.jar:/opt/traccar/lib/javax.servlet-api-3.1.0.jar:/opt/traccar/lib/jetty-http-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-io-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-servlet-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-security-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-webapp-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-xml-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-jndi-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-util-9.2.21.v20170120.jar:/opt/traccar/lib/websocket-server-9.2.21.v20170120.jar:/opt/traccar/lib/websocket-common-9.2.21.v20170120.jar:/opt/traccar/lib/websocket-api-9.2.21.v20170120.jar:/opt/traccar/lib/websocket-client-9.2.21.v20170120.jar:/opt/traccar/lib/websocket-servlet-9.2.21.v20170120.jar:/opt/traccar/lib/jersey-container-servlet-2.25.1.jar:/opt/traccar/lib/jersey-container-servlet-core-2.25.1.jar:/opt/traccar/lib/javax.inject-2.5.0-b32.jar:/opt/traccar/lib/jersey-common-2.25.1.jar:/opt/traccar/lib/javax.annotation-api-1.2.jar:/opt/traccar/lib/jersey-guava-2.25.1.jar:/opt/traccar/lib/hk2-api-2.5.0-b32.jar:/opt/traccar/lib/hk2-utils-2.5.0-b32.jar:/opt/traccar/lib/aopalliance-repackaged-2.5.0-b32.jar:/opt/traccar/lib/hk2-locator-2.5.0-b32.jar:/opt/traccar/lib/javassist-3.20.0-GA.jar:/opt/traccar/lib/osgi-resource-locator-1.0.1.jar:/opt/traccar/lib/jersey-server-2.25.1.jar:/opt/traccar/lib/jersey-client-2.25.1.jar:/opt/traccar/lib/jersey-media-jaxb-2.25.1.jar:/opt/traccar/lib/validation-api-1.1.0.Final.jar:/opt/traccar/lib/javax.ws.rs-api-2.0.1.jar:/opt/traccar/lib/jersey-media-json-jackson-2.25.1.jar:/opt/traccar/lib/jersey-entity-filtering-2.25.1.jar:/opt/traccar/lib/jackson-jaxrs-base-2.8.4.jar:/opt/traccar/lib/jackson-core-2.8.4.jar:/opt/traccar/lib/jackson-databind-2.8.4.jar:/opt/traccar/lib/jackson-jaxrs-json-provider-2.8.4.jar:/opt/traccar/lib/jackson-module-jaxb-annotations-2.8.4.jar:/opt/traccar/lib/jackson-annotations-2.8.4.jar:/opt/traccar/lib/liquibase-core-3.5.3.jar:/opt/traccar/lib/snakeyaml-1.17.jar:/opt/traccar/lib/mail-1.4.7.jar:/opt/traccar/lib/activation-1.1.jar:/opt/traccar/lib/jxls-2.3.0.jar:/opt/traccar/lib/commons-jexl-2.1.1.jar:/opt/traccar/lib/commons-logging-1.1.1.jar:/opt/traccar/lib/commons-beanutils-1.9.2.jar:/opt/traccar/lib/jcl-over-slf4j-1.7.12.jar:/opt/traccar/lib/logback-core-1.1.3.jar:/opt/traccar/lib/jxls-poi-1.0.11.jar:/opt/traccar/lib/poi-3.14.jar:/opt/traccar/lib/poi-ooxml-3.14.jar:/opt/traccar/lib/poi-ooxml-schemas-3.14.jar:/opt/traccar/lib/xmlbeans-2.6.0.jar:/opt/traccar/lib/stax-api-1.0.1.jar:/opt/traccar/lib/curvesapi-1.03.jar:/opt/traccar/lib/velocity-1.7.jar:/opt/traccar/lib/commons-collections-3.2.1.jar:/opt/traccar/lib/commons-lang-2.4.jar:/opt/traccar/lib/ical4j-2.0.0.jar:/opt/traccar/lib/commons-collections4-4.0.jar:/opt/traccar/lib/groovy-all-2.3.2.jar:/opt/traccar/lib/bndlib-2.3.0.jar:/opt/traccar/lib/org.osgi.core-4.3.1.jar:/opt/traccar/lib/commons-lang3-3.3.2.jar:/opt/traccar/lib/commons-codec-1.9.jar" "-Dfile.encoding=UTF-8" "-Xrs" "-Dwrapper.service=true" "-Dwrapper.console.visible=false" "-Dwrapper.port=15003" "-Dwrapper.key=3683222495523613892" "-Dwrapper.teeName=3683222495523613892$1493027076915" "-Dwrapper.tmp.path=/opt/traccar/tmp" "-Djna_tmpdir=/opt/traccar/tmp" "-Dwrapper.config=/opt/traccar/conf/wrapper.conf" "-Dwrapper.visible=false" "-Dwrapper.pidfile=/run/wrapper.traccar.pid" "org.rzo.yajsw.app.WrapperJVMMain" 
INFO|wrapper|Service traccar|17-04-24 09:44:40|posix_spawn pid 1414
INFO|wrapper|Service traccar|17-04-24 09:44:40|started process 1414
INFO|wrapper|Service traccar|17-04-24 09:44:40|started process with pid 1414
INFO|1414/0|Service traccar|17-04-24 09:44:41|[INFO] StandardFileSystemManager - Using "/tmp/vfs_cache" as temporary files store.
INFO|1414/0|Service traccar|17-04-24 09:44:43|[main] INFO com.zaxxer.hikari.HikariDataSource - HikariPool-1 - Starting...
INFO|1414/0|Service traccar|17-04-24 09:44:43|[main] INFO com.zaxxer.hikari.HikariDataSource - HikariPool-1 - Start completed.
INFO|1414/0|Service traccar|17-04-24 09:44:44|INFO 4/24/17 9:44 AM: liquibase: Clearing database change log checksums
INFO|1414/0|Service traccar|17-04-24 09:44:44|INFO 4/24/17 9:44 AM: liquibase: Successfully acquired change log lock
INFO|1414/0|Service traccar|17-04-24 09:44:44|INFO 4/24/17 9:44 AM: liquibase: Successfully released change log lock
INFO|1414/0|Service traccar|17-04-24 09:44:44|INFO 4/24/17 9:44 AM: liquibase: Successfully acquired change log lock
INFO|1414/0|Service traccar|17-04-24 09:44:45|Failed to generate a seed from SecureRandom within {} seconds. Not enough entrophy?
INFO|1414/0|Service traccar|17-04-24 09:44:45|3
INFO|1414/0|Service traccar|17-04-24 09:44:47|INFO 4/24/17 9:44 AM: liquibase: Reading from tecsat.DATABASECHANGELOG
INFO|1414/0|Service traccar|17-04-24 09:44:48|INFO 4/24/17 9:44 AM: liquibase: Reading from tecsat.DATABASECHANGELOG
INFO|1414/0|Service traccar|17-04-24 09:44:48|INFO 4/24/17 9:44 AM: 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|1414/0|Service traccar|17-04-24 09:44:48|INFO 4/24/17 9:44 AM: liquibase: Successfully released change log lock
INFO|1414/0|Service traccar|17-04-24 09:44:49|[main] INFO org.eclipse.jetty.util.log - Logging initialized @9203ms
INFO|1414/0|Service traccar|17-04-24 09:44:51|[main] INFO org.eclipse.jetty.server.Server - jetty-9.2.21.v20170120
INFO|1414/0|Service traccar|17-04-24 09:44:52|[main] INFO org.eclipse.jetty.server.handler.ContextHandler - Started o.e.j.s.ServletContextHandler@41779a2c{/api,null,AVAILABLE}
INFO|1414/0|Service traccar|17-04-24 09:44:53|[main] INFO org.eclipse.jetty.server.ServerConnector - Started ServerConnector@23dbd708{HTTP/1.1}{0.0.0.0:8082}
INFO|1414/0|Service traccar|17-04-24 09:44:53|[main] INFO org.eclipse.jetty.server.Server - Started @12267ms
INFO|1414/0|Service traccar|17-04-24 15:59:01|Missing wrapper ping within timeout of 30000
WARNING|1414/0|Service traccar|17-04-24 15:59:01|ping between java application and wrapper timed out. if this this is due to server overload consider increasing wrapper.ping.timeout
INFO|1414/0|Service traccar|17-04-24 15:59:02|wrapper manager received stop command
INFO|1414/0|Service traccar|17-04-24 15:59:03|[Thread-12] INFO org.eclipse.jetty.server.ServerConnector - Stopped ServerConnector@23dbd708{HTTP/1.1}{0.0.0.0:8082}
INFO|1414/0|Service traccar|17-04-24 15:59:03|[Thread-12] INFO org.eclipse.jetty.server.handler.ContextHandler - Stopped o.e.j.s.ServletContextHandler@41779a2c{/api,null,UNAVAILABLE}
INFO|wrapper|Service traccar|17-04-24 15:59:03|waitpid 1414 0
INFO|wrapper|Service traccar|17-04-24 15:59:03|exit code posix process: 0 application: 0
WARNING|wrapper|Service traccar|17-04-24 16:20:05|YAJSW: yajsw-stable-12.08
WARNING|wrapper|Service traccar|17-04-24 16:20:05|OS   : Linux/3.13.0-100-generic/amd64
WARNING|wrapper|Service traccar|17-04-24 16:20:05|JVM  : Oracle Corporation/1.7.0_121//usr/lib/jvm/java-7-openjdk-amd64/jre/64
INFO|wrapper|Service traccar|17-04-24 16:20:09|exec:"java" "-classpath" "/opt/traccar/wrapperApp.jar:/opt/traccar/tracker-server.jar:/opt/traccar/lib/log4j-1.2.17.jar:/opt/traccar/lib/joda-time-2.9.7.jar:/opt/traccar/lib/h2-1.4.193.jar:/opt/traccar/lib/mysql-connector-java-5.1.40.jar:/opt/traccar/lib/postgresql-9.4.1212.jre7.jar:/opt/traccar/lib/mssql-jdbc-6.1.0.jre7.jar:/opt/traccar/lib/HikariCP-java7-2.4.11.jar:/opt/traccar/lib/slf4j-api-1.7.21.jar:/opt/traccar/lib/netty-3.10.6.Final.jar:/opt/traccar/lib/async-http-client-1.9.40.jar:/opt/traccar/lib/slf4j-simple-1.7.22.jar:/opt/traccar/lib/javax.json-1.0.4.jar:/opt/traccar/lib/jetty-server-9.2.21.v20170120.jar:/opt/traccar/lib/javax.servlet-api-3.1.0.jar:/opt/traccar/lib/jetty-http-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-io-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-servlet-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-security-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-webapp-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-xml-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-jndi-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-util-9.2.21.v20170120.jar:/opt/traccar/lib/websocket-server-9.2.21.v20170120.jar:/opt/traccar/lib/websocket-common-9.2.21.v20170120.jar:/opt/traccar/lib/websocket-api-9.2.21.v20170120.jar:/opt/traccar/lib/websocket-client-9.2.21.v20170120.jar:/opt/traccar/lib/websocket-servlet-9.2.21.v20170120.jar:/opt/traccar/lib/jersey-container-servlet-2.25.1.jar:/opt/traccar/lib/jersey-container-servlet-core-2.25.1.jar:/opt/traccar/lib/javax.inject-2.5.0-b32.jar:/opt/traccar/lib/jersey-common-2.25.1.jar:/opt/traccar/lib/javax.annotation-api-1.2.jar:/opt/traccar/lib/jersey-guava-2.25.1.jar:/opt/traccar/lib/hk2-api-2.5.0-b32.jar:/opt/traccar/lib/hk2-utils-2.5.0-b32.jar:/opt/traccar/lib/aopalliance-repackaged-2.5.0-b32.jar:/opt/traccar/lib/hk2-locator-2.5.0-b32.jar:/opt/traccar/lib/javassist-3.20.0-GA.jar:/opt/traccar/lib/osgi-resource-locator-1.0.1.jar:/opt/traccar/lib/jersey-server-2.25.1.jar:/opt/traccar/lib/jersey-client-2.25.1.jar:/opt/traccar/lib/jersey-media-jaxb-2.25.1.jar:/opt/traccar/lib/validation-api-1.1.0.Final.jar:/opt/traccar/lib/javax.ws.rs-api-2.0.1.jar:/opt/traccar/lib/jersey-media-json-jackson-2.25.1.jar:/opt/traccar/lib/jersey-entity-filtering-2.25.1.jar:/opt/traccar/lib/jackson-jaxrs-base-2.8.4.jar:/opt/traccar/lib/jackson-core-2.8.4.jar:/opt/traccar/lib/jackson-databind-2.8.4.jar:/opt/traccar/lib/jackson-jaxrs-json-provider-2.8.4.jar:/opt/traccar/lib/jackson-module-jaxb-annotations-2.8.4.jar:/opt/traccar/lib/jackson-annotations-2.8.4.jar:/opt/traccar/lib/liquibase-core-3.5.3.jar:/opt/traccar/lib/snakeyaml-1.17.jar:/opt/traccar/lib/mail-1.4.7.jar:/opt/traccar/lib/activation-1.1.jar:/opt/traccar/lib/jxls-2.3.0.jar:/opt/traccar/lib/commons-jexl-2.1.1.jar:/opt/traccar/lib/commons-logging-1.1.1.jar:/opt/traccar/lib/commons-beanutils-1.9.2.jar:/opt/traccar/lib/jcl-over-slf4j-1.7.12.jar:/opt/traccar/lib/logback-core-1.1.3.jar:/opt/traccar/lib/jxls-poi-1.0.11.jar:/opt/traccar/lib/poi-3.14.jar:/opt/traccar/lib/poi-ooxml-3.14.jar:/opt/traccar/lib/poi-ooxml-schemas-3.14.jar:/opt/traccar/lib/xmlbeans-2.6.0.jar:/opt/traccar/lib/stax-api-1.0.1.jar:/opt/traccar/lib/curvesapi-1.03.jar:/opt/traccar/lib/velocity-1.7.jar:/opt/traccar/lib/commons-collections-3.2.1.jar:/opt/traccar/lib/commons-lang-2.4.jar:/opt/traccar/lib/ical4j-2.0.0.jar:/opt/traccar/lib/commons-collections4-4.0.jar:/opt/traccar/lib/groovy-all-2.3.2.jar:/opt/traccar/lib/bndlib-2.3.0.jar:/opt/traccar/lib/org.osgi.core-4.3.1.jar:/opt/traccar/lib/commons-lang3-3.3.2.jar:/opt/traccar/lib/commons-codec-1.9.jar" "-Dfile.encoding=UTF-8" "-Xrs" "-Dwrapper.service=true" "-Dwrapper.console.visible=false" "-Dwrapper.port=15003" "-Dwrapper.key=-6077200971481052806" "-Dwrapper.teeName=-6077200971481052806$1493050805902" "-Dwrapper.tmp.path=/opt/traccar/tmp" "-Djna_tmpdir=/opt/traccar/tmp" "-Dwrapper.config=/opt/traccar/conf/wrapper.conf" "-Dwrapper.visible=false" "-Dwrapper.pidfile=/run/wrapper.traccar.pid" "org.rzo.yajsw.app.WrapperJVMMain" 
INFO|wrapper|Service traccar|17-04-24 16:20:09|posix_spawn pid 1399
INFO|wrapper|Service traccar|17-04-24 16:20:09|started process 1399
INFO|wrapper|Service traccar|17-04-24 16:20:09|started process with pid 1399
INFO|1399/0|Service traccar|17-04-24 16:20:10|[INFO] StandardFileSystemManager - Using "/tmp/vfs_cache" as temporary files store.
INFO|1399/0|Service traccar|17-04-24 16:20:12|[main] INFO com.zaxxer.hikari.HikariDataSource - HikariPool-1 - Starting...
INFO|1399/0|Service traccar|17-04-24 16:20:12|[main] INFO com.zaxxer.hikari.HikariDataSource - HikariPool-1 - Start completed.
INFO|1399/0|Service traccar|17-04-24 16:20:13|INFO 4/24/17 4:20 PM: liquibase: Clearing database change log checksums
INFO|1399/0|Service traccar|17-04-24 16:20:14|INFO 4/24/17 4:20 PM: liquibase: Successfully acquired change log lock
INFO|1399/0|Service traccar|17-04-24 16:20:14|INFO 4/24/17 4:20 PM: liquibase: Successfully released change log lock
INFO|1399/0|Service traccar|17-04-24 16:20:14|INFO 4/24/17 4:20 PM: liquibase: Successfully acquired change log lock
INFO|1399/0|Service traccar|17-04-24 16:20:14|Failed to generate a seed from SecureRandom within {} seconds. Not enough entrophy?
INFO|1399/0|Service traccar|17-04-24 16:20:14|3
INFO|1399/0|Service traccar|17-04-24 16:20:17|INFO 4/24/17 4:20 PM: liquibase: Reading from tecsat.DATABASECHANGELOG
INFO|1399/0|Service traccar|17-04-24 16:20:18|INFO 4/24/17 4:20 PM: liquibase: Reading from tecsat.DATABASECHANGELOG
INFO|1399/0|Service traccar|17-04-24 16:20:18|INFO 4/24/17 4:20 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|1399/0|Service traccar|17-04-24 16:20:18|INFO 4/24/17 4:20 PM: liquibase: Successfully released change log lock
INFO|1399/0|Service traccar|17-04-24 16:20:19|[main] INFO org.eclipse.jetty.util.log - Logging initialized @10113ms
INFO|1399/0|Service traccar|17-04-24 16:20:21|[main] INFO org.eclipse.jetty.server.Server - jetty-9.2.21.v20170120
INFO|1399/0|Service traccar|17-04-24 16:20:23|[main] INFO org.eclipse.jetty.server.handler.ContextHandler - Started o.e.j.s.ServletContextHandler@32354b00{/api,null,AVAILABLE}
INFO|1399/0|Service traccar|17-04-24 16:20:23|[main] INFO org.eclipse.jetty.server.ServerConnector - Started ServerConnector@1f5362c4{HTTP/1.1}{0.0.0.0:8082}
INFO|1399/0|Service traccar|17-04-24 16:20:23|[main] INFO org.eclipse.jetty.server.Server - Started @13358ms
INFO|wrapper|Service traccar|17-04-24 17:30:48|Shutting down Wrapper
INFO|wrapper|Service traccar|17-04-24 17:30:48|stopping process with pid/timeout 1399 45000
INFO|1399/0|Service traccar|17-04-24 17:30:48|wrapper manager received stop command
INFO|1399/0|Service traccar|17-04-24 17:30:48|[Thread-12] INFO org.eclipse.jetty.server.ServerConnector - Stopped ServerConnector@1f5362c4{HTTP/1.1}{0.0.0.0:8082}
INFO|1399/0|Service traccar|17-04-24 17:30:48|[Thread-12] INFO org.eclipse.jetty.server.handler.ContextHandler - Stopped o.e.j.s.ServletContextHandler@32354b00{/api,null,UNAVAILABLE}
INFO|wrapper|Service traccar|17-04-24 17:30:49|waitpid 1399 0
INFO|wrapper|Service traccar|17-04-24 17:30:49|exit code posix process: 0 application: 0
INFO|wrapper|Service traccar|17-04-24 17:30:49|killing 1399
INFO|wrapper|Service traccar|17-04-24 17:30:49|process exit code: 0
WARNING|wrapper|Service traccar|17-04-24 17:30:57|YAJSW: yajsw-stable-12.08
WARNING|wrapper|Service traccar|17-04-24 17:30:57|OS   : Linux/3.13.0-100-generic/amd64
WARNING|wrapper|Service traccar|17-04-24 17:30:57|JVM  : Oracle Corporation/1.7.0_121//usr/lib/jvm/java-7-openjdk-amd64/jre/64
INFO|wrapper|Service traccar|17-04-24 17:30:58|exec:"java" "-classpath" "/opt/traccar/wrapperApp.jar:/opt/traccar/tracker-server.jar:/opt/traccar/lib/log4j-1.2.17.jar:/opt/traccar/lib/joda-time-2.9.7.jar:/opt/traccar/lib/h2-1.4.193.jar:/opt/traccar/lib/mysql-connector-java-5.1.40.jar:/opt/traccar/lib/postgresql-9.4.1212.jre7.jar:/opt/traccar/lib/mssql-jdbc-6.1.0.jre7.jar:/opt/traccar/lib/HikariCP-java7-2.4.11.jar:/opt/traccar/lib/slf4j-api-1.7.21.jar:/opt/traccar/lib/netty-3.10.6.Final.jar:/opt/traccar/lib/async-http-client-1.9.40.jar:/opt/traccar/lib/slf4j-simple-1.7.22.jar:/opt/traccar/lib/javax.json-1.0.4.jar:/opt/traccar/lib/jetty-server-9.2.21.v20170120.jar:/opt/traccar/lib/javax.servlet-api-3.1.0.jar:/opt/traccar/lib/jetty-http-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-io-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-servlet-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-security-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-webapp-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-xml-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-jndi-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-util-9.2.21.v20170120.jar:/opt/traccar/lib/websocket-server-9.2.21.v20170120.jar:/opt/traccar/lib/websocket-common-9.2.21.v20170120.jar:/opt/traccar/lib/websocket-api-9.2.21.v20170120.jar:/opt/traccar/lib/websocket-client-9.2.21.v20170120.jar:/opt/traccar/lib/websocket-servlet-9.2.21.v20170120.jar:/opt/traccar/lib/jersey-container-servlet-2.25.1.jar:/opt/traccar/lib/jersey-container-servlet-core-2.25.1.jar:/opt/traccar/lib/javax.inject-2.5.0-b32.jar:/opt/traccar/lib/jersey-common-2.25.1.jar:/opt/traccar/lib/javax.annotation-api-1.2.jar:/opt/traccar/lib/jersey-guava-2.25.1.jar:/opt/traccar/lib/hk2-api-2.5.0-b32.jar:/opt/traccar/lib/hk2-utils-2.5.0-b32.jar:/opt/traccar/lib/aopalliance-repackaged-2.5.0-b32.jar:/opt/traccar/lib/hk2-locator-2.5.0-b32.jar:/opt/traccar/lib/javassist-3.20.0-GA.jar:/opt/traccar/lib/osgi-resource-locator-1.0.1.jar:/opt/traccar/lib/jersey-server-2.25.1.jar:/opt/traccar/lib/jersey-client-2.25.1.jar:/opt/traccar/lib/jersey-media-jaxb-2.25.1.jar:/opt/traccar/lib/validation-api-1.1.0.Final.jar:/opt/traccar/lib/javax.ws.rs-api-2.0.1.jar:/opt/traccar/lib/jersey-media-json-jackson-2.25.1.jar:/opt/traccar/lib/jersey-entity-filtering-2.25.1.jar:/opt/traccar/lib/jackson-jaxrs-base-2.8.4.jar:/opt/traccar/lib/jackson-core-2.8.4.jar:/opt/traccar/lib/jackson-databind-2.8.4.jar:/opt/traccar/lib/jackson-jaxrs-json-provider-2.8.4.jar:/opt/traccar/lib/jackson-module-jaxb-annotations-2.8.4.jar:/opt/traccar/lib/jackson-annotations-2.8.4.jar:/opt/traccar/lib/liquibase-core-3.5.3.jar:/opt/traccar/lib/snakeyaml-1.17.jar:/opt/traccar/lib/mail-1.4.7.jar:/opt/traccar/lib/activation-1.1.jar:/opt/traccar/lib/jxls-2.3.0.jar:/opt/traccar/lib/commons-jexl-2.1.1.jar:/opt/traccar/lib/commons-logging-1.1.1.jar:/opt/traccar/lib/commons-beanutils-1.9.2.jar:/opt/traccar/lib/jcl-over-slf4j-1.7.12.jar:/opt/traccar/lib/logback-core-1.1.3.jar:/opt/traccar/lib/jxls-poi-1.0.11.jar:/opt/traccar/lib/poi-3.14.jar:/opt/traccar/lib/poi-ooxml-3.14.jar:/opt/traccar/lib/poi-ooxml-schemas-3.14.jar:/opt/traccar/lib/xmlbeans-2.6.0.jar:/opt/traccar/lib/stax-api-1.0.1.jar:/opt/traccar/lib/curvesapi-1.03.jar:/opt/traccar/lib/velocity-1.7.jar:/opt/traccar/lib/commons-collections-3.2.1.jar:/opt/traccar/lib/commons-lang-2.4.jar:/opt/traccar/lib/ical4j-2.0.0.jar:/opt/traccar/lib/commons-collections4-4.0.jar:/opt/traccar/lib/groovy-all-2.3.2.jar:/opt/traccar/lib/bndlib-2.3.0.jar:/opt/traccar/lib/org.osgi.core-4.3.1.jar:/opt/traccar/lib/commons-lang3-3.3.2.jar:/opt/traccar/lib/commons-codec-1.9.jar" "-Dfile.encoding=UTF-8" "-Xrs" "-Dwrapper.service=true" "-Dwrapper.console.visible=false" "-Dwrapper.port=15003" "-Dwrapper.key=-6582235694886658091" "-Dwrapper.teeName=-6582235694886658091$1493055057854" "-Dwrapper.tmp.path=/opt/traccar/tmp" "-Djna_tmpdir=/opt/traccar/tmp" "-Dwrapper.config=/opt/traccar/conf/wrapper.conf" "-Dwrapper.visible=false" "-Dwrapper.pidfile=/run/wrapper.traccar.pid" "org.rzo.yajsw.app.WrapperJVMMain" 
INFO|wrapper|Service traccar|17-04-24 17:30:58|posix_spawn pid 1989
INFO|wrapper|Service traccar|17-04-24 17:30:58|started process 1989
INFO|wrapper|Service traccar|17-04-24 17:30:58|started process with pid 1989
INFO|1989/0|Service traccar|17-04-24 17:30:59|[INFO] StandardFileSystemManager - Using "/tmp/vfs_cache" as temporary files store.
INFO|1989/0|Service traccar|17-04-24 17:31:00|[main] INFO com.zaxxer.hikari.HikariDataSource - HikariPool-1 - Starting...
INFO|1989/0|Service traccar|17-04-24 17:31:01|[main] INFO com.zaxxer.hikari.HikariDataSource - HikariPool-1 - Start completed.
INFO|1989/0|Service traccar|17-04-24 17:31:02|INFO 4/24/17 5:31 PM: liquibase: Clearing database change log checksums
INFO|1989/0|Service traccar|17-04-24 17:31:02|INFO 4/24/17 5:31 PM: liquibase: Successfully acquired change log lock
INFO|1989/0|Service traccar|17-04-24 17:31:03|INFO 4/24/17 5:31 PM: liquibase: Successfully released change log lock
INFO|1989/0|Service traccar|17-04-24 17:31:03|INFO 4/24/17 5:31 PM: liquibase: Successfully acquired change log lock
INFO|1989/0|Service traccar|17-04-24 17:31:03|Failed to generate a seed from SecureRandom within {} seconds. Not enough entrophy?
INFO|1989/0|Service traccar|17-04-24 17:31:03|3
INFO|1989/0|Service traccar|17-04-24 17:31:05|INFO 4/24/17 5:31 PM: liquibase: Reading from tecsat.DATABASECHANGELOG
INFO|1989/0|Service traccar|17-04-24 17:31:06|INFO 4/24/17 5:31 PM: liquibase: Reading from tecsat.DATABASECHANGELOG
INFO|1989/0|Service traccar|17-04-24 17:31:06|INFO 4/24/17 5:31 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|1989/0|Service traccar|17-04-24 17:31:06|INFO 4/24/17 5:31 PM: liquibase: Successfully released change log lock
INFO|1989/0|Service traccar|17-04-24 17:31:07|[main] INFO org.eclipse.jetty.util.log - Logging initialized @9068ms
INFO|1989/0|Service traccar|17-04-24 17:31:08|[main] INFO org.eclipse.jetty.server.Server - jetty-9.2.21.v20170120
INFO|1989/0|Service traccar|17-04-24 17:31:10|[main] INFO org.eclipse.jetty.server.handler.ContextHandler - Started o.e.j.s.ServletContextHandler@eefa46c{/api,null,AVAILABLE}
INFO|1989/0|Service traccar|17-04-24 17:31:10|[main] INFO org.eclipse.jetty.server.ServerConnector - Started ServerConnector@4845ddbf{HTTP/1.1}{0.0.0.0:8082}
INFO|1989/0|Service traccar|17-04-24 17:31:10|[main] INFO org.eclipse.jetty.server.Server - Started @11672ms
INFO|1989/0|Service traccar|17-04-24 17:44:50|[qtp1957635453-36] WARN org.eclipse.jetty.servlet.ServletHandler - /api/socket
INFO|1989/0|Service traccar|17-04-24 17:44:50|java.lang.NullPointerException
INFO|1989/0|Service traccar|17-04-24 17:44:50|	at org.traccar.api.AsyncSocketServlet$1.createWebSocket(AsyncSocketServlet.java:37)
INFO|1989/0|Service traccar|17-04-24 17:44:50|	at org.eclipse.jetty.websocket.server.WebSocketServerFactory.acceptWebSocket(WebSocketServerFactory.java:166)
INFO|1989/0|Service traccar|17-04-24 17:44:50|	at org.eclipse.jetty.websocket.server.WebSocketServerFactory.acceptWebSocket(WebSocketServerFactory.java:153)
INFO|1989/0|Service traccar|17-04-24 17:44:50|	at org.eclipse.jetty.websocket.servlet.WebSocketServlet.service(WebSocketServlet.java:151)
INFO|1989/0|Service traccar|17-04-24 17:44:50|	at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
INFO|1989/0|Service traccar|17-04-24 17:44:50|	at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:812)
INFO|1989/0|Service traccar|17-04-24 17:44:50|	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:587)
INFO|1989/0|Service traccar|17-04-24 17:44:50|	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:221)
INFO|1989/0|Service traccar|17-04-24 17:44:50|	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1127)
INFO|1989/0|Service traccar|17-04-24 17:44:50|	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:515)
INFO|1989/0|Service traccar|17-04-24 17:44:50|	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
INFO|1989/0|Service traccar|17-04-24 17:44:50|	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1061)
INFO|1989/0|Service traccar|17-04-24 17:44:50|	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
INFO|1989/0|Service traccar|17-04-24 17:44:50|	at org.eclipse.jetty.server.handler.HandlerList.handle(HandlerList.java:52)
INFO|1989/0|Service traccar|17-04-24 17:44:50|	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:97)
INFO|1989/0|Service traccar|17-04-24 17:44:50|	at org.eclipse.jetty.server.Server.handle(Server.java:499)
INFO|1989/0|Service traccar|17-04-24 17:44:50|	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:311)
INFO|1989/0|Service traccar|17-04-24 17:44:50|	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:258)
INFO|1989/0|Service traccar|17-04-24 17:44:50|	at org.eclipse.jetty.io.AbstractConnection$2.run(AbstractConnection.java:544)
INFO|1989/0|Service traccar|17-04-24 17:44:50|	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635)
INFO|1989/0|Service traccar|17-04-24 17:44:50|	at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555)
INFO|1989/0|Service traccar|17-04-24 17:44:50|	at java.lang.Thread.run(Thread.java:745)
INFO|1989/0|Service traccar|17-04-24 17:51:57|[HikariPool-1 housekeeper] WARN com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Thread starvation or clock leap detected (housekeeper delta=55s816ms425µs904ns).
INFO|1989/0|Service traccar|17-04-24 18:15:45|[qtp1957635453-35] WARN org.eclipse.jetty.servlet.ServletHandler - /api/socket
INFO|1989/0|Service traccar|17-04-24 18:15:45|java.lang.NullPointerException
INFO|1989/0|Service traccar|17-04-24 18:15:45|	at org.traccar.api.AsyncSocketServlet$1.createWebSocket(AsyncSocketServlet.java:37)
INFO|1989/0|Service traccar|17-04-24 18:15:45|	at org.eclipse.jetty.websocket.server.WebSocketServerFactory.acceptWebSocket(WebSocketServerFactory.java:166)
INFO|1989/0|Service traccar|17-04-24 18:15:45|	at org.eclipse.jetty.websocket.server.WebSocketServerFactory.acceptWebSocket(WebSocketServerFactory.java:153)
INFO|1989/0|Service traccar|17-04-24 18:15:45|	at org.eclipse.jetty.websocket.servlet.WebSocketServlet.service(WebSocketServlet.java:151)
INFO|1989/0|Service traccar|17-04-24 18:15:45|	at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
INFO|1989/0|Service traccar|17-04-24 18:15:45|	at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:812)
INFO|1989/0|Service traccar|17-04-24 18:15:45|	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:587)
INFO|1989/0|Service traccar|17-04-24 18:15:45|	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:221)
INFO|1989/0|Service traccar|17-04-24 18:15:45|	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1127)
INFO|1989/0|Service traccar|17-04-24 18:15:45|	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:515)
INFO|1989/0|Service traccar|17-04-24 18:15:45|	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
INFO|1989/0|Service traccar|17-04-24 18:15:45|	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1061)
INFO|1989/0|Service traccar|17-04-24 18:15:45|	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
INFO|1989/0|Service traccar|17-04-24 18:15:45|	at org.eclipse.jetty.server.handler.HandlerList.handle(HandlerList.java:52)
INFO|1989/0|Service traccar|17-04-24 18:15:45|	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:97)
INFO|1989/0|Service traccar|17-04-24 18:15:45|	at org.eclipse.jetty.server.Server.handle(Server.java:499)
INFO|1989/0|Service traccar|17-04-24 18:15:45|	at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:311)
INFO|1989/0|Service traccar|17-04-24 18:15:45|	at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:258)
INFO|1989/0|Service traccar|17-04-24 18:15:45|	at org.eclipse.jetty.io.AbstractConnection$2.run(AbstractConnection.java:544)
INFO|1989/0|Service traccar|17-04-24 18:15:45|	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635)
INFO|1989/0|Service traccar|17-04-24 18:15:45|	at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555)
INFO|1989/0|Service traccar|17-04-24 18:15:45|	at java.lang.Thread.run(Thread.java:745)
INFO|1989/0|Service traccar|17-04-24 22:23:22|[HikariPool-1 housekeeper] WARN com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Thread starvation or clock leap detected (housekeeper delta=58s511ms205µs169ns).
INFO|1989/0|Service traccar|17-04-24 23:16:53|[HikariPool-1 housekeeper] WARN com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Thread starvation or clock leap detected (housekeeper delta=46s210ms898µs363ns).
INFO|1989/0|Service traccar|17-04-24 23:34:55|Missing wrapper ping within timeout of 30000
WARNING|1989/0|Service traccar|17-04-24 23:34:55|ping between java application and wrapper timed out. if this this is due to server overload consider increasing wrapper.ping.timeout
INFO|1989/0|Service traccar|17-04-24 23:34:56|wrapper manager received stop command
INFO|1989/0|Service traccar|17-04-24 23:34:56|[Thread-12] INFO org.eclipse.jetty.server.ServerConnector - Stopped ServerConnector@4845ddbf{HTTP/1.1}{0.0.0.0:8082}
INFO|1989/0|Service traccar|17-04-24 23:34:56|[Thread-12] INFO org.eclipse.jetty.server.handler.ContextHandler - Stopped o.e.j.s.ServletContextHandler@eefa46c{/api,null,UNAVAILABLE}
INFO|wrapper|Service traccar|17-04-24 23:34:57|waitpid 1989 0
INFO|wrapper|Service traccar|17-04-24 23:34:57|exit code posix process: 0 application: 0
WARNING|wrapper|Service traccar|17-04-24 23:39:56|YAJSW: yajsw-stable-12.08
WARNING|wrapper|Service traccar|17-04-24 23:39:56|OS   : Linux/3.13.0-100-generic/amd64
WARNING|wrapper|Service traccar|17-04-24 23:39:56|JVM  : Oracle Corporation/1.7.0_121//usr/lib/jvm/java-7-openjdk-amd64/jre/64
INFO|wrapper|Service traccar|17-04-24 23:39:56|exec:"java" "-classpath" "/opt/traccar/wrapperApp.jar:/opt/traccar/tracker-server.jar:/opt/traccar/lib/log4j-1.2.17.jar:/opt/traccar/lib/joda-time-2.9.7.jar:/opt/traccar/lib/h2-1.4.193.jar:/opt/traccar/lib/mysql-connector-java-5.1.40.jar:/opt/traccar/lib/postgresql-9.4.1212.jre7.jar:/opt/traccar/lib/mssql-jdbc-6.1.0.jre7.jar:/opt/traccar/lib/HikariCP-java7-2.4.11.jar:/opt/traccar/lib/slf4j-api-1.7.21.jar:/opt/traccar/lib/netty-3.10.6.Final.jar:/opt/traccar/lib/async-http-client-1.9.40.jar:/opt/traccar/lib/slf4j-simple-1.7.22.jar:/opt/traccar/lib/javax.json-1.0.4.jar:/opt/traccar/lib/jetty-server-9.2.21.v20170120.jar:/opt/traccar/lib/javax.servlet-api-3.1.0.jar:/opt/traccar/lib/jetty-http-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-io-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-servlet-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-security-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-webapp-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-xml-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-jndi-9.2.21.v20170120.jar:/opt/traccar/lib/jetty-util-9.2.21.v20170120.jar:/opt/traccar/lib/websocket-server-9.2.21.v20170120.jar:/opt/traccar/lib/websocket-common-9.2.21.v20170120.jar:/opt/traccar/lib/websocket-api-9.2.21.v20170120.jar:/opt/traccar/lib/websocket-client-9.2.21.v20170120.jar:/opt/traccar/lib/websocket-servlet-9.2.21.v20170120.jar:/opt/traccar/lib/jersey-container-servlet-2.25.1.jar:/opt/traccar/lib/jersey-container-servlet-core-2.25.1.jar:/opt/traccar/lib/javax.inject-2.5.0-b32.jar:/opt/traccar/lib/jersey-common-2.25.1.jar:/opt/traccar/lib/javax.annotation-api-1.2.jar:/opt/traccar/lib/jersey-guava-2.25.1.jar:/opt/traccar/lib/hk2-api-2.5.0-b32.jar:/opt/traccar/lib/hk2-utils-2.5.0-b32.jar:/opt/traccar/lib/aopalliance-repackaged-2.5.0-b32.jar:/opt/traccar/lib/hk2-locator-2.5.0-b32.jar:/opt/traccar/lib/javassist-3.20.0-GA.jar:/opt/traccar/lib/osgi-resource-locator-1.0.1.jar:/opt/traccar/lib/jersey-server-2.25.1.jar:/opt/traccar/lib/jersey-client-2.25.1.jar:/opt/traccar/lib/jersey-media-jaxb-2.25.1.jar:/opt/traccar/lib/validation-api-1.1.0.Final.jar:/opt/traccar/lib/javax.ws.rs-api-2.0.1.jar:/opt/traccar/lib/jersey-media-json-jackson-2.25.1.jar:/opt/traccar/lib/jersey-entity-filtering-2.25.1.jar:/opt/traccar/lib/jackson-jaxrs-base-2.8.4.jar:/opt/traccar/lib/jackson-core-2.8.4.jar:/opt/traccar/lib/jackson-databind-2.8.4.jar:/opt/traccar/lib/jackson-jaxrs-json-provider-2.8.4.jar:/opt/traccar/lib/jackson-module-jaxb-annotations-2.8.4.jar:/opt/traccar/lib/jackson-annotations-2.8.4.jar:/opt/traccar/lib/liquibase-core-3.5.3.jar:/opt/traccar/lib/snakeyaml-1.17.jar:/opt/traccar/lib/mail-1.4.7.jar:/opt/traccar/lib/activation-1.1.jar:/opt/traccar/lib/jxls-2.3.0.jar:/opt/traccar/lib/commons-jexl-2.1.1.jar:/opt/traccar/lib/commons-logging-1.1.1.jar:/opt/traccar/lib/commons-beanutils-1.9.2.jar:/opt/traccar/lib/jcl-over-slf4j-1.7.12.jar:/opt/traccar/lib/logback-core-1.1.3.jar:/opt/traccar/lib/jxls-poi-1.0.11.jar:/opt/traccar/lib/poi-3.14.jar:/opt/traccar/lib/poi-ooxml-3.14.jar:/opt/traccar/lib/poi-ooxml-schemas-3.14.jar:/opt/traccar/lib/xmlbeans-2.6.0.jar:/opt/traccar/lib/stax-api-1.0.1.jar:/opt/traccar/lib/curvesapi-1.03.jar:/opt/traccar/lib/velocity-1.7.jar:/opt/traccar/lib/commons-collections-3.2.1.jar:/opt/traccar/lib/commons-lang-2.4.jar:/opt/traccar/lib/ical4j-2.0.0.jar:/opt/traccar/lib/commons-collections4-4.0.jar:/opt/traccar/lib/groovy-all-2.3.2.jar:/opt/traccar/lib/bndlib-2.3.0.jar:/opt/traccar/lib/org.osgi.core-4.3.1.jar:/opt/traccar/lib/commons-lang3-3.3.2.jar:/opt/traccar/lib/commons-codec-1.9.jar" "-Dfile.encoding=UTF-8" "-Xrs" "-Dwrapper.service=true" "-Dwrapper.console.visible=false" "-Dwrapper.port=15003" "-Dwrapper.key=9077798662837609125" "-Dwrapper.teeName=9077798662837609125$1493077196526" "-Dwrapper.tmp.path=/opt/traccar/tmp" "-Djna_tmpdir=/opt/traccar/tmp" "-Dwrapper.config=/opt/traccar/conf/wrapper.conf" "-Dwrapper.visible=false" "-Dwrapper.pidfile=/run/wrapper.traccar.pid" "org.rzo.yajsw.app.WrapperJVMMain" 
INFO|wrapper|Service traccar|17-04-24 23:39:56|posix_spawn pid 5149
INFO|wrapper|Service traccar|17-04-24 23:39:56|started process 5149
INFO|wrapper|Service traccar|17-04-24 23:39:56|started process with pid 5149
INFO|5149/0|Service traccar|17-04-24 23:39:58|[INFO] StandardFileSystemManager - Using "/tmp/vfs_cache" as temporary files store.
INFO|5149/0|Service traccar|17-04-24 23:39:59|[main] INFO com.zaxxer.hikari.HikariDataSource - HikariPool-1 - Starting...
INFO|5149/0|Service traccar|17-04-24 23:39:59|[main] INFO com.zaxxer.hikari.HikariDataSource - HikariPool-1 - Start completed.
INFO|5149/0|Service traccar|17-04-24 23:40:01|INFO 4/24/17 11:40 PM: liquibase: Clearing database change log checksums
INFO|5149/0|Service traccar|17-04-24 23:40:01|INFO 4/24/17 11:40 PM: liquibase: Successfully acquired change log lock
INFO|5149/0|Service traccar|17-04-24 23:40:01|INFO 4/24/17 11:40 PM: liquibase: Successfully released change log lock
INFO|5149/0|Service traccar|17-04-24 23:40:01|INFO 4/24/17 11:40 PM: liquibase: Successfully acquired change log lock
INFO|5149/0|Service traccar|17-04-24 23:40:04|INFO 4/24/17 11:40 PM: liquibase: Reading from tecsat.DATABASECHANGELOG
INFO|5149/0|Service traccar|17-04-24 23:40:04|INFO 4/24/17 11:40 PM: liquibase: Reading from tecsat.DATABASECHANGELOG
INFO|5149/0|Service traccar|17-04-24 23:40:05|INFO 4/24/17 11:40 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|5149/0|Service traccar|17-04-24 23:40:05|INFO 4/24/17 11:40 PM: liquibase: Successfully released change log lock
INFO|5149/0|Service traccar|17-04-24 23:40:06|[main] INFO org.eclipse.jetty.util.log - Logging initialized @9108ms
INFO|5149/0|Service traccar|17-04-24 23:40:07|[main] INFO org.eclipse.jetty.server.Server - jetty-9.2.21.v20170120
INFO|5149/0|Service traccar|17-04-24 23:40:09|[main] INFO org.eclipse.jetty.server.handler.ContextHandler - Started o.e.j.s.ServletContextHandler@762f6520{/api,null,AVAILABLE}
INFO|5149/0|Service traccar|17-04-24 23:40:09|[main] INFO org.eclipse.jetty.server.ServerConnector - Started ServerConnector@7e344a51{HTTP/1.1}{0.0.0.0:8082}
INFO|5149/0|Service traccar|17-04-24 23:40:09|[main] INFO org.eclipse.jetty.server.Server - Started @11828ms

smsoousa8 years ago

I also inform that from time to time the system emits a web socket error in the map area, is this normal?

Would you guide me to create a cron so that every time the service stops it runs the service again?

Anton Tananaev8 years ago

There is clearly some problem with resources on the server or JVM. There should be no websocket errors either. It likely means that you also have some network problem.

I'm not an expect in cron, but I'm sure there is plenty information on the internet that you can find on how to set it up.

smsoousa8 years ago

So you're telling me that a server with 2GB of RAM and a processing core is not good enough to allocate the system? Well, you yourself said that you have few devices for such a configuration, so how can resources be lacking? I am using the default-jre package, as you yourself indicate in some previous posts, if this is giving problem, which one do you indicate? As for the network problem, what would be causing the same? Would you like to access my server? Well, I've been through three different servers, two international and one national now, and the problem is always the same, I do not imagine the problem is on the server.

Anton Tananaev8 years ago

I don't know what resources are lacking or why it happens. I have multiple server with less memory and more devices and they run without any issues for many months.