cant start traccar 3.15 anymore

gabrielcz 8 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 Tananaev 8 years ago

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

gabrielcz 8 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.

viacom1234 8 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 Tananaev 8 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.

viacom1234 8 years ago

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

Anton Tananaev 8 years ago

What's the error after you removed it?

viacom1234 8 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 Tananaev 8 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.

viacom1234 8 years ago

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