cant start traccar 3.15 anymore

gabrielcz7 years ago

Hi,
I make a fresh install of traccar, set mysql server and works perfect.
After a reboot, I can not access anymore to traccar server...
On wrapper log i found this when I start it. (BOTTON OF THIS MESSAGE)
On starting traccar from /opt/traccar/bin start script I get...

root@GEgps:/home/gabrielcz# sh /opt/traccar/bin/startDaemon.sh
/opt/traccar/bin/startDaemon.sh: 23: /opt/traccar/bin/startDaemon.sh: source: not found
++++++++++ YAJSW SET ENV ++++++++++
openjdk version "1.8.0_151"
OpenJDK Runtime Environment (build 1.8.0_151-8u151-b12-0ubuntu0.16.04.2-b12)
OpenJDK 64-Bit Server VM (build 25.151-b12, mixed mode)
wrapper home : /opt/traccar
configuration: /opt/traccar/conf/wrapper.conf
openjdk version "1.8.0_151"
OpenJDK Runtime Environment (build 1.8.0_151-8u151-b12-0ubuntu0.16.04.2-b12)
OpenJDK 64-Bit Server VM (build 25.151-b12, mixed mode)
---------- YAJSW SET ENV ----------
YAJSW: yajsw-stable-12.11
OS   : Linux/4.4.0-87-generic/amd64
JVM  : Oracle Corporation/1.8.0_151//usr/lib/jvm/java-8-openjdk-amd64/jre/64
mar 01, 2018 5:17:50 PM org.apache.commons.vfs2.VfsLog info
INFORMACIÓN: Using "/tmp/vfs_cache" as temporary files store.
mar 01, 2018 5:17:51 PM org.rzo.yajsw.os.posix.PosixService init
INFORMACIÓN: /etc/init.d/traccar already exists
************* STARTING traccar ***********************

mar 01, 2018 5:17:51 PM org.rzo.yajsw.os.posix.PosixService getPid
INFORMACIÓN: wrapper pid file: /run/wrapper.traccar.pid
mar 01, 2018 5:17:55 PM org.rzo.yajsw.os.posix.PosixService start
INFORMACIÓN: Starting traccar ...
YAJSW: yajsw-stable-12.11
OS   : Linux/4.4.0-87-generic/amd64
JVM  : Oracle Corporation/1.8.0_151//usr/lib/jvm/java-8-openjdk-amd64/jre/64
************* STARTING traccar ***********************

Service traccar started

mar 01, 2018 5:17:55 PM org.rzo.yajsw.os.posix.PosixService getPid
INFORMACIÓN: wrapper pid file: /run/wrapper.traccar.pid
mar 01, 2018 5:17:56 PM org.rzo.yajsw.os.posix.PosixService getPid
INFORMACIÓN: wrapper pid file: /run/wrapper.traccar.pid
mar 01, 2018 5:17:56 PM org.rzo.yajsw.os.posix.PosixService getPid
INFORMACIÓN: wrapper pid file: /run/wrapper.traccar.pid
Service traccar started
WARNING|wrapper|Service traccar|18-03-01 17:12:55|YAJSW: yajsw-stable-12.11
WARNING|wrapper|Service traccar|18-03-01 17:12:55|OS   : Linux/4.4.0-87-generic/amd64
WARNING|wrapper|Service traccar|18-03-01 17:12:55|JVM  : Oracle Corporation/1.8.0_151//usr/lib/jvm/java-8-openjdk-amd64/jre/64
INFO|wrapper|Service traccar|18-03-01 17:12:55|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.9.jar:/opt/traccar/lib/h2-1.4.196.jar:/opt/traccar/lib/mysql-connector-java-5.1.45.jar:/opt/traccar/lib/postgresql-42.1.4.jre7.jar:/opt/traccar/lib/mssql-jdbc-6.2.2.jre7.jar:/opt/traccar/lib/HikariCP-java7-2.4.13.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.25.jar:/opt/traccar/lib/javax.json-1.0.4.jar:/opt/traccar/lib/jetty-server-9.2.22.v20170606.jar:/opt/traccar/lib/javax.servlet-api-3.1.0.jar:/opt/traccar/lib/jetty-http-9.2.22.v20170606.jar:/opt/traccar/lib/jetty-io-9.2.22.v20170606.jar:/opt/traccar/lib/jetty-servlet-9.2.22.v20170606.jar:/opt/traccar/lib/jetty-security-9.2.22.v20170606.jar:/opt/traccar/lib/jetty-webapp-9.2.22.v20170606.jar:/opt/traccar/lib/jetty-xml-9.2.22.v20170606.jar:/opt/traccar/lib/jetty-jndi-9.2.22.v20170606.jar:/opt/traccar/lib/jetty-util-9.2.22.v20170606.jar:/opt/traccar/lib/jetty-proxy-9.2.22.v20170606.jar:/opt/traccar/lib/jetty-client-9.2.22.v20170606.jar:/opt/traccar/lib/websocket-server-9.2.22.v20170606.jar:/opt/traccar/lib/websocket-common-9.2.22.v20170606.jar:/opt/traccar/lib/websocket-api-9.2.22.v20170606.jar:/opt/traccar/lib/websocket-client-9.2.22.v20170606.jar:/opt/traccar/lib/websocket-servlet-9.2.22.v20170606.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.4.2.jar:/opt/traccar/lib/commons-jexl-2.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.13.jar:/opt/traccar/lib/poi-3.16.jar:/opt/traccar/lib/poi-ooxml-3.16.jar:/opt/traccar/lib/poi-ooxml-schemas-3.16.jar:/opt/traccar/lib/xmlbeans-2.6.0.jar:/opt/traccar/lib/stax-api-1.0.1.jar:/opt/traccar/lib/curvesapi-1.04.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/velocity-tools-2.0.jar:/opt/traccar/lib/commons-digester-1.8.jar:/opt/traccar/lib/commons-chain-1.1.jar:/opt/traccar/lib/commons-logging-1.1.jar:/opt/traccar/lib/servlet-api-2.3.jar:/opt/traccar/lib/commons-validator-1.3.1.jar:/opt/traccar/lib/dom4j-1.1.jar:/opt/traccar/lib/oro-2.0.8.jar:/opt/traccar/lib/sslext-1.2-0.jar:/opt/traccar/lib/struts-core-1.3.8.jar:/opt/traccar/lib/antlr-2.7.2.jar:/opt/traccar/lib/struts-taglib-1.3.8.jar:/opt/traccar/lib/struts-tiles-1.3.8.jar:/opt/traccar/lib/commons-collections4-4.1.jar:/opt/traccar/lib/ical4j-2.0.4.jar:/opt/traccar/lib/commons-codec-1.9.jar:/opt/traccar/lib/commons-lang3-3.3.2.jar:/opt/traccar/lib/threetenbp-1.3.3.jar:/opt/traccar/lib/ch-smpp-5.0.9.jar:/opt/traccar/lib/ch-commons-util-6.0.2.jar:/opt/traccar/lib/ch-commons-charset-3.0.2.jar -Dfile.encoding=UTF-8 -Xrs -Dwrapper.service=true -Dwrapper.console.visible=false -Dwrapper.port=15003 -Dwrapper.key=6761529650473749005 -Dwrapper.teeName=6761529650473749005$1519935175390 -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|18-03-01 17:12:55|posix_spawn pid 1688
INFO|wrapper|Service traccar|18-03-01 17:12:55|started process 1688
INFO|wrapper|Service traccar|18-03-01 17:12:55|started process with pid 1688
INFO|1688/0|Service traccar|18-03-01 17:12:57|[INFO] StandardFileSystemManager - Using "/tmp/vfs_cache" as temporary files store.
INFO|1688/0|Service traccar|18-03-01 17:12:57|java.lang.reflect.InvocationTargetException
INFO|1688/0|Service traccar|18-03-01 17:12:57|  at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
INFO|1688/0|Service traccar|18-03-01 17:12:57|  at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
INFO|1688/0|Service traccar|18-03-01 17:12:57|  at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
INFO|1688/0|Service traccar|18-03-01 17:12:57|  at java.lang.reflect.Method.invoke(Method.java:498)
INFO|1688/0|Service traccar|18-03-01 17:12:57|  at org.rzo.yajsw.app.WrapperJVMMain.executeMain(WrapperJVMMain.java:60)
INFO|1688/0|Service traccar|18-03-01 17:12:57|  at org.rzo.yajsw.app.WrapperJVMMain.main(WrapperJVMMain.java:43)
INFO|1688/0|Service traccar|18-03-01 17:12:57|Caused by: java.util.InvalidPropertiesFormatException: org.xml.sax.SAXParseException; lineNumber: 231; columnNumber: 14; The content of element type "properties" must match "(comment?,entry*)".
INFO|1688/0|Service traccar|18-03-01 17:12:57|  at sun.util.xml.PlatformXmlPropertiesProvider.load(PlatformXmlPropertiesProvider.java:80)
INFO|1688/0|Service traccar|18-03-01 17:12:57|  at java.util.Properties$XmlSupport.load(Properties.java:1201)
INFO|1688/0|Service traccar|18-03-01 17:12:57|  at java.util.Properties.loadFromXML(Properties.java:881)
INFO|1688/0|Service traccar|18-03-01 17:12:57|  at org.traccar.Config.load(Config.java:38)
INFO|1688/0|Service traccar|18-03-01 17:12:57|  at org.traccar.Context.init(Context.java:318)
INFO|1688/0|Service traccar|18-03-01 17:12:57|  at org.traccar.Main.main(Main.java:35)
INFO|1688/0|Service traccar|18-03-01 17:12:57|  ... 6 more
INFO|1688/0|Service traccar|18-03-01 17:12:57|Caused by: org.xml.sax.SAXParseException; lineNumber: 231; columnNumber: 14; The content of element type "properties" must match "(comment?,entry*)".
INFO|1688/0|Service traccar|18-03-01 17:12:57|  at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.createSAXParseException(ErrorHandlerWrapper.java:203)
INFO|1688/0|Service traccar|18-03-01 17:12:57|  at com.sun.org.apache.xerces.internal.util.ErrorHandlerWrapper.error(ErrorHandlerWrapper.java:134)
INFO|1688/0|Service traccar|18-03-01 17:12:57|  at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:396)
INFO|1688/0|Service traccar|18-03-01 17:12:57|  at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:327)
INFO|1688/0|Service traccar|18-03-01 17:12:57|  at com.sun.org.apache.xerces.internal.impl.XMLErrorReporter.reportError(XMLErrorReporter.java:284)
INFO|1688/0|Service traccar|18-03-01 17:12:57|  at com.sun.org.apache.xerces.internal.impl.dtd.XMLDTDValidator.handleEndElement(XMLDTDValidator.java:1994)
INFO|1688/0|Service traccar|18-03-01 17:12:57|  at com.sun.org.apache.xerces.internal.impl.dtd.XMLDTDValidator.endElement(XMLDTDValidator.java:879)
INFO|1688/0|Service traccar|18-03-01 17:12:57|  at com.sun.org.apache.xerces.internal.impl.XMLDocumentFragmentScannerImpl.scanEndElement(XMLDocumentFragmentScannerImpl.java:1782)
INFO|1688/0|Service traccar|18-03-01 17:12:57|  at com.sun.org.apache.xerces.internal.impl.XMLDocumentFragmentScannerImpl$FragmentContentDriver.next(XMLDocumentFragmentScannerImpl.java:2967)
INFO|1688/0|Service traccar|18-03-01 17:12:57|  at com.sun.org.apache.xerces.internal.impl.XMLDocumentScannerImpl.next(XMLDocumentScannerImpl.java:602)
INFO|1688/0|Service traccar|18-03-01 17:12:57|  at com.sun.org.apache.xerces.internal.impl.XMLDocumentFragmentScannerImpl.scanDocument(XMLDocumentFragmentScannerImpl.java:505)
INFO|1688/0|Service traccar|18-03-01 17:12:57|  at com.sun.org.apache.xerces.internal.parsers.XML11Configuration.parse(XML11Configuration.java:841)
INFO|1688/0|Service traccar|18-03-01 17:12:57|  at com.sun.org.apache.xerces.internal.parsers.XML11Configuration.parse(XML11Configuration.java:770)
INFO|1688/0|Service traccar|18-03-01 17:12:57|  at com.sun.org.apache.xerces.internal.parsers.XMLParser.parse(XMLParser.java:141)
INFO|1688/0|Service traccar|18-03-01 17:12:57|  at com.sun.org.apache.xerces.internal.parsers.DOMParser.parse(DOMParser.java:243)
INFO|1688/0|Service traccar|18-03-01 17:12:57|  at com.sun.org.apache.xerces.internal.jaxp.DocumentBuilderImpl.parse(DocumentBuilderImpl.java:339)
INFO|1688/0|Service traccar|18-03-01 17:12:57|  at sun.util.xml.PlatformXmlPropertiesProvider.getLoadingDoc(PlatformXmlPropertiesProvider.java:106)
INFO|1688/0|Service traccar|18-03-01 17:12:57|  at sun.util.xml.PlatformXmlPropertiesProvider.load(PlatformXmlPropertiesProvider.java:78)
INFO|1688/0|Service traccar|18-03-01 17:12:57|  ... 11 more
INFO|wrapper|Service traccar|18-03-01 17:12:58|waitpid 1688 59136
INFO|wrapper|Service traccar|18-03-01 17:12:58|exit code posix process: 59136 application: 231
Anton Tananaev7 years ago

Your config file is an invalid XML. Wrapper log error message even tells you exactly where the problem is.

gabrielcz7 years ago

Wooowwwww I feel like ......
Im so sorry for take your time for this stupid mistake, I forgot a "w" in line 231 without sense, and feel more stupid for not read careful log file.

viacom12347 years ago

Mine also stopped working today randomly. Reinstalled to default config files and still doesnt work. Log:

WARNING|wrapper|Service traccar|18-03-01 18:40:23|YAJSW: yajsw-stable-12.11
WARNING|wrapper|Service traccar|18-03-01 18:40:23|OS   : Windows 8.1/6.3/amd64
WARNING|wrapper|Service traccar|18-03-01 18:40:23|JVM  : Oracle Corporation/1.7.0_80/C:\Program Files\Java\jre7/64
WARNING|wrapper|Service traccar|18-03-01 18:40:23|!! WARNING !! Windows JDK7 should set -Djava.net.preferIPv4Stack=true (see java bug 7179799 )
INFO|wrapper|Service traccar|18-03-01 18:40:23|start delay: 0
INFO|wrapper|Service traccar|18-03-01 18:40:23|started process with pid 1852
INFO|1852/0|Service traccar|18-03-01 18:40:24|[INFO] StandardFileSystemManager - Using "C:\WINDOWS\TEMP\vfs_cache" as temporary files store.
INFO|1852/0|Service traccar|18-03-01 18:40:24|!! WARNING !! Windows JDK7 should set -Djava.net.preferIPv4Stack=true (see java bug 7179799 )
INFO|1852/0|Service traccar|18-03-01 18:40:24|[main] INFO com.zaxxer.hikari.HikariDataSource - HikariPool-1 - Starting...
INFO|1852/0|Service traccar|18-03-01 18:40:25|[main] ERROR com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Exception during pool initialization.
INFO|1852/0|Service traccar|18-03-01 18:40:25|org.h2.jdbc.JdbcSQLException: IO Exception: null [90028-196]
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.message.DbException.getJdbcSQLException(DbException.java:345)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.message.DbException.get(DbException.java:168)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.db.MVTableEngine$Store.convertIllegalStateException(MVTableEngine.java:192)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.db.MVTableEngine$Store.open(MVTableEngine.java:168)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.db.MVTableEngine.init(MVTableEngine.java:100)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.engine.Database.getPageStore(Database.java:2476)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.engine.Database.open(Database.java:697)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.engine.Database.openDatabase(Database.java:276)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.engine.Database.<init>(Database.java:270)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.engine.Engine.openSession(Engine.java:64)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.engine.Engine.openSession(Engine.java:176)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.engine.Engine.createSessionAndValidate(Engine.java:154)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.engine.Engine.createSession(Engine.java:137)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.engine.Engine.createSession(Engine.java:27)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.engine.SessionRemote.connectEmbeddedOrServer(SessionRemote.java:354)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.jdbc.JdbcConnection.<init>(JdbcConnection.java:116)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.jdbc.JdbcConnection.<init>(JdbcConnection.java:100)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.Driver.connect(Driver.java:69)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at com.zaxxer.hikari.util.DriverDataSource.getConnection(DriverDataSource.java:112)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at com.zaxxer.hikari.util.DriverDataSource.getConnection(DriverDataSource.java:118)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at com.zaxxer.hikari.pool.PoolBase.newConnection(PoolBase.java:341)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at com.zaxxer.hikari.pool.PoolBase.newPoolEntry(PoolBase.java:193)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at com.zaxxer.hikari.pool.HikariPool.createPoolEntry(HikariPool.java:428)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at com.zaxxer.hikari.pool.HikariPool.checkFailFast(HikariPool.java:499)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at com.zaxxer.hikari.pool.HikariPool.<init>(HikariPool.java:112)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at com.zaxxer.hikari.HikariDataSource.<init>(HikariDataSource.java:72)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.traccar.database.DataManager.initDatabase(DataManager.java:133)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.traccar.database.DataManager.<init>(DataManager.java:86)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.traccar.Context.init(Context.java:333)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.traccar.Main.main(Main.java:35)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at java.lang.reflect.Method.invoke(Unknown Source)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.rzo.yajsw.app.WrapperJVMMain.executeMain(WrapperJVMMain.java:60)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.rzo.yajsw.app.WrapperJVMMain.main(WrapperJVMMain.java:43)
INFO|1852/0|Service traccar|18-03-01 18:40:25|Caused by: java.lang.IllegalStateException: Reading from nio:C:/Program Files/Traccar/data/database.mv.db failed; file length 336527360 read length 768 at 341528522 [1.4.196/1]
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.DataUtils.newIllegalStateException(DataUtils.java:765)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.DataUtils.readFully(DataUtils.java:435)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.FileStore.readFully(FileStore.java:98)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.Page.read(Page.java:190)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.MVStore.readPage(MVStore.java:1952)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.MVMap.readPage(MVMap.java:741)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.Page.getChildPage(Page.java:217)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.Cursor.fetchNext(Cursor.java:150)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.Cursor.next(Cursor.java:50)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.MVStore.loadChunkMeta(MVStore.java:695)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.MVStore.readStoreHeader(MVStore.java:675)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.MVStore.<init>(MVStore.java:358)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.MVStore$Builder.open(MVStore.java:2930)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.db.MVTableEngine$Store.open(MVTableEngine.java:155)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	... 32 more
INFO|1852/0|Service traccar|18-03-01 18:40:25|Caused by: java.io.EOFException
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.DataUtils.readFully(DataUtils.java:423)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	... 44 more
INFO|1852/0|Service traccar|18-03-01 18:40:25|java.lang.reflect.InvocationTargetException
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at java.lang.reflect.Method.invoke(Unknown Source)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.rzo.yajsw.app.WrapperJVMMain.executeMain(WrapperJVMMain.java:60)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.rzo.yajsw.app.WrapperJVMMain.main(WrapperJVMMain.java:43)
INFO|1852/0|Service traccar|18-03-01 18:40:25|Caused by: com.zaxxer.hikari.pool.HikariPool$PoolInitializationException: Failed to initialize pool: IO Exception: null [90028-196]
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at com.zaxxer.hikari.pool.HikariPool.throwPoolInitializationException(HikariPool.java:528)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at com.zaxxer.hikari.pool.HikariPool.checkFailFast(HikariPool.java:520)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at com.zaxxer.hikari.pool.HikariPool.<init>(HikariPool.java:112)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at com.zaxxer.hikari.HikariDataSource.<init>(HikariDataSource.java:72)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.traccar.database.DataManager.initDatabase(DataManager.java:133)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.traccar.database.DataManager.<init>(DataManager.java:86)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.traccar.Context.init(Context.java:333)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.traccar.Main.main(Main.java:35)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	... 6 more
INFO|1852/0|Service traccar|18-03-01 18:40:25|Caused by: org.h2.jdbc.JdbcSQLException: IO Exception: null [90028-196]
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.message.DbException.getJdbcSQLException(DbException.java:345)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.message.DbException.get(DbException.java:168)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.db.MVTableEngine$Store.convertIllegalStateException(MVTableEngine.java:192)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.db.MVTableEngine$Store.open(MVTableEngine.java:168)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.db.MVTableEngine.init(MVTableEngine.java:100)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.engine.Database.getPageStore(Database.java:2476)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.engine.Database.open(Database.java:697)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.engine.Database.openDatabase(Database.java:276)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.engine.Database.<init>(Database.java:270)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.engine.Engine.openSession(Engine.java:64)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.engine.Engine.openSession(Engine.java:176)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.engine.Engine.createSessionAndValidate(Engine.java:154)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.engine.Engine.createSession(Engine.java:137)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.engine.Engine.createSession(Engine.java:27)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.engine.SessionRemote.connectEmbeddedOrServer(SessionRemote.java:354)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.jdbc.JdbcConnection.<init>(JdbcConnection.java:116)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.jdbc.JdbcConnection.<init>(JdbcConnection.java:100)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.Driver.connect(Driver.java:69)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at com.zaxxer.hikari.util.DriverDataSource.getConnection(DriverDataSource.java:112)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at com.zaxxer.hikari.util.DriverDataSource.getConnection(DriverDataSource.java:118)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at com.zaxxer.hikari.pool.PoolBase.newConnection(PoolBase.java:341)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at com.zaxxer.hikari.pool.PoolBase.newPoolEntry(PoolBase.java:193)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at com.zaxxer.hikari.pool.HikariPool.createPoolEntry(HikariPool.java:428)
INFO|1852/0|Service traccar|18-03-01 18:40:25|	at com.zaxxer.hikari.pool.HikariPool.checkFailFast(HikariPool.java:499)
FINEST|1852/0|Service traccar|18-03-01 18:40:25|	... 12 more
FINEST|1852/0|Service traccar|18-03-01 18:40:25|Caused by: java.lang.IllegalStateException: Reading from nio:C:/Program Files/Traccar/data/database.mv.db failed; file length 336527360 read length 768 at 341528522 [1.4.196/1]
FINEST|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.DataUtils.newIllegalStateException(DataUtils.java:765)
FINEST|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.DataUtils.readFully(DataUtils.java:435)
FINEST|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.FileStore.readFully(FileStore.java:98)
FINEST|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.Page.read(Page.java:190)
FINEST|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.MVStore.readPage(MVStore.java:1952)
FINEST|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.MVMap.readPage(MVMap.java:741)
FINEST|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.Page.getChildPage(Page.java:217)
FINEST|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.Cursor.fetchNext(Cursor.java:150)
FINEST|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.Cursor.next(Cursor.java:50)
FINEST|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.MVStore.loadChunkMeta(MVStore.java:695)
FINEST|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.MVStore.readStoreHeader(MVStore.java:675)
FINEST|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.MVStore.<init>(MVStore.java:358)
FINEST|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.MVStore$Builder.open(MVStore.java:2930)
FINEST|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.db.MVTableEngine$Store.open(MVTableEngine.java:155)
FINEST|1852/0|Service traccar|18-03-01 18:40:25|	... 32 more
FINEST|1852/0|Service traccar|18-03-01 18:40:25|Caused by: java.io.EOFException
FINEST|1852/0|Service traccar|18-03-01 18:40:25|	at org.h2.mvstore.DataUtils.readFully(DataUtils.java:423)
FINEST|1852/0|Service traccar|18-03-01 18:40:25|	... 44 more
INFO|wrapper|Service traccar|18-03-01 18:40:26|calling onStop
INFO|wrapper|Service traccar|18-03-01 18:40:26|Win service stop - timeout: 30000
INFO|wrapper|Service traccar|18-03-01 18:40:26|Win service wrapper.control -> stopping application
INFO|wrapper|Service traccar|18-03-01 18:40:26|Win service stop - after shutdown
INFO|wrapper|Service traccar|18-03-01 18:40:26|Win service stop - before notify
INFO|wrapper|Service traccar|18-03-01 18:40:26|Win service terminated
Anton Tananaev7 years ago

Looks like your database is corrupted, so you need to restore it from backup or start from scratch. Also, I would not recommend using H2 database in production.

viacom12347 years ago

I removed old database and then program folder and it still doesnt start.

Anton Tananaev7 years ago

What's the error after you removed it?

viacom12347 years ago
...
INFO|wrapper|Service traccar|18-03-01 19:24:27|Win service terminated
WARNING|wrapper|Service traccar|18-03-01 19:25:20|YAJSW: yajsw-stable-12.11
WARNING|wrapper|Service traccar|18-03-01 19:25:20|OS   : Windows 8.1/6.3/amd64
WARNING|wrapper|Service traccar|18-03-01 19:25:20|JVM  : Oracle Corporation/1.7.0_80/C:\Program Files\Java\jre7/64
WARNING|wrapper|Service traccar|18-03-01 19:25:20|!! WARNING !! Windows JDK7 should set -Djava.net.preferIPv4Stack=true (see java bug 7179799 )
INFO|wrapper|Service traccar|18-03-01 19:25:20|start delay: 0
INFO|wrapper|Service traccar|18-03-01 19:25:20|started process with pid 18156
INFO|18156/0|Service traccar|18-03-01 19:25:20|[INFO] StandardFileSystemManager - Using "C:\WINDOWS\TEMP\vfs_cache" as temporary files store.
INFO|18156/0|Service traccar|18-03-01 19:25:20|!! WARNING !! Windows JDK7 should set -Djava.net.preferIPv4Stack=true (see java bug 7179799 )
INFO|18156/0|Service traccar|18-03-01 19:25:21|[main] INFO com.zaxxer.hikari.HikariDataSource - HikariPool-1 - Starting...
INFO|18156/0|Service traccar|18-03-01 19:25:21|[main] INFO com.zaxxer.hikari.HikariDataSource - HikariPool-1 - Start completed.
INFO|18156/0|Service traccar|18-03-01 19:25:21|INFO 3/1/18 7:25 PM: liquibase: Clearing database change log checksums
INFO|18156/0|Service traccar|18-03-01 19:25:21|INFO 3/1/18 7:25 PM: liquibase: Successfully acquired change log lock
INFO|18156/0|Service traccar|18-03-01 19:25:21|INFO 3/1/18 7:25 PM: liquibase: Successfully released change log lock
INFO|18156/0|Service traccar|18-03-01 19:25:21|INFO 3/1/18 7:25 PM: liquibase: Successfully acquired change log lock
INFO|18156/0|Service traccar|18-03-01 19:25:22|INFO 3/1/18 7:25 PM: liquibase: Reading from PUBLIC.DATABASECHANGELOG
INFO|18156/0|Service traccar|18-03-01 19:25:22|INFO 3/1/18 7:25 PM: liquibase: Reading from PUBLIC.DATABASECHANGELOG
INFO|18156/0|Service traccar|18-03-01 19:25:22|INFO 3/1/18 7:25 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: Constraint "UK_USER_TOKEN" not found; SQL statement:
INFO|18156/0|Service traccar|18-03-01 19:25:22|ALTER TABLE PUBLIC.users DROP CONSTRAINT uk_user_token [90057-196] [Failed SQL: ALTER TABLE PUBLIC.users DROP CONSTRAINT uk_user_token]
INFO|18156/0|Service traccar|18-03-01 19:25:22|INFO 3/1/18 7:25 PM: liquibase: Successfully released change log lock
INFO|18156/0|Service traccar|18-03-01 19:25:22|[main] INFO org.eclipse.jetty.util.log - Logging initialized @2569ms
INFO|18156/0|Service traccar|18-03-01 19:25:23|java.lang.reflect.InvocationTargetException
INFO|18156/0|Service traccar|18-03-01 19:25:23|	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
INFO|18156/0|Service traccar|18-03-01 19:25:23|	at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
INFO|18156/0|Service traccar|18-03-01 19:25:23|	at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
INFO|18156/0|Service traccar|18-03-01 19:25:23|	at java.lang.reflect.Method.invoke(Unknown Source)
INFO|18156/0|Service traccar|18-03-01 19:25:23|	at org.rzo.yajsw.app.WrapperJVMMain.executeMain(WrapperJVMMain.java:60)
INFO|18156/0|Service traccar|18-03-01 19:25:23|	at org.rzo.yajsw.app.WrapperJVMMain.main(WrapperJVMMain.java:43)
INFO|18156/0|Service traccar|18-03-01 19:25:23|Caused by: org.jboss.netty.channel.ChannelException: Failed to bind to: 0.0.0.0/0.0.0.0:5040
INFO|18156/0|Service traccar|18-03-01 19:25:23|	at org.jboss.netty.bootstrap.ServerBootstrap.bind(ServerBootstrap.java:272)
INFO|18156/0|Service traccar|18-03-01 19:25:23|	at org.traccar.TrackerServer.start(TrackerServer.java:117)
INFO|18156/0|Service traccar|18-03-01 19:25:23|	at org.traccar.ServerManager.start(ServerManager.java:81)
INFO|18156/0|Service traccar|18-03-01 19:25:23|	at org.traccar.Main.main(Main.java:38)
INFO|18156/0|Service traccar|18-03-01 19:25:23|	... 6 more
INFO|18156/0|Service traccar|18-03-01 19:25:23|Caused by: java.net.BindException: Address already in use: bind
INFO|18156/0|Service traccar|18-03-01 19:25:23|	at sun.nio.ch.Net.bind0(Native Method)
INFO|18156/0|Service traccar|18-03-01 19:25:23|	at sun.nio.ch.Net.bind(Unknown Source)
INFO|18156/0|Service traccar|18-03-01 19:25:23|	at sun.nio.ch.Net.bind(Unknown Source)
INFO|18156/0|Service traccar|18-03-01 19:25:23|	at sun.nio.ch.ServerSocketChannelImpl.bind(Unknown Source)
INFO|18156/0|Service traccar|18-03-01 19:25:23|	at sun.nio.ch.ServerSocketAdaptor.bind(Unknown Source)
INFO|18156/0|Service traccar|18-03-01 19:25:23|	at org.jboss.netty.channel.socket.nio.NioServerBoss$RegisterTask.run(NioServerBoss.java:193)
INFO|18156/0|Service traccar|18-03-01 19:25:23|	at org.jboss.netty.channel.socket.nio.AbstractNioSelector.processTaskQueue(AbstractNioSelector.java:391)
INFO|18156/0|Service traccar|18-03-01 19:25:23|	at org.jboss.netty.channel.socket.nio.AbstractNioSelector.run(AbstractNioSelector.java:315)
INFO|18156/0|Service traccar|18-03-01 19:25:23|	at org.jboss.netty.channel.socket.nio.NioServerBoss.run(NioServerBoss.java:42)
INFO|18156/0|Service traccar|18-03-01 19:25:23|	at org.jboss.netty.util.ThreadRenamingRunnable.run(ThreadRenamingRunnable.java:108)
INFO|18156/0|Service traccar|18-03-01 19:25:23|	at org.jboss.netty.util.internal.DeadLockProofWorker$1.run(DeadLockProofWorker.java:42)
INFO|18156/0|Service traccar|18-03-01 19:25:23|	at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
INFO|18156/0|Service traccar|18-03-01 19:25:23|	at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
INFO|18156/0|Service traccar|18-03-01 19:25:23|	at java.lang.Thread.run(Unknown Source)
INFO|wrapper|Service traccar|18-03-01 19:25:23|calling onStop
INFO|wrapper|Service traccar|18-03-01 19:25:23|Win service stop - timeout: 30000
INFO|wrapper|Service traccar|18-03-01 19:25:23|Win service wrapper.control -> stopping application
INFO|wrapper|Service traccar|18-03-01 19:25:23|Win service stop - after shutdown
INFO|wrapper|Service traccar|18-03-01 19:25:23|Win service stop - before notify
INFO|wrapper|Service traccar|18-03-01 19:25:23|Win service terminated
Anton Tananaev7 years ago

Now you have a port conflict with some other process. It has been discussed on the forum countless number of times. I would recommend in future using search first before asking for help.

viacom12347 years ago

You are correct. I had to edit the default.xml in the past to remove one of the ports.