Problem with restart a service

Vladimir Dimitrow 7 years ago

Hello,

When I want to restart a traccar service (when changing something), the service fail to restart. This is my log file :

WARNING|wrapper|Service traccar|18-08-01 14:04:44|YAJSW: yajsw-stable-12.12
WARNING|wrapper|Service traccar|18-08-01 14:04:44|OS   : Windows 7/6.1/amd64
WARNING|wrapper|Service traccar|18-08-01 14:04:44|JVM  : Oracle Corporation/1.8.0_181/C:\Program Files\Java\jre1.8.0_181/64
INFO|wrapper|Service traccar|18-08-01 14:04:44|start delay: 0
INFO|wrapper|Service traccar|18-08-01 14:04:45|started process with pid 3912
INFO|3912/0|Service traccar|18-08-01 14:04:46|[INFO] StandardFileSystemManager - Using "C:\Windows\TEMP\vfs_cache" as temporary files store.
INFO|3912/0|Service traccar|18-08-01 14:04:46|SLF4J: Class path contains multiple SLF4J bindings.
INFO|3912/0|Service traccar|18-08-01 14:04:46|SLF4J: Found binding in [jar:file:/D:/Program%20Files/Traccar/lib/slf4j-simple-1.7.25.jar!/org/slf4j/impl/StaticLoggerBinder.class]
INFO|3912/0|Service traccar|18-08-01 14:04:46|SLF4J: Found binding in [jar:file:/D:/Program%20Files/Traccar/lib/logback-classic-1.2.3.jar!/org/slf4j/impl/StaticLoggerBinder.class]
INFO|3912/0|Service traccar|18-08-01 14:04:46|SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation.
INFO|3912/0|Service traccar|18-08-01 14:04:46|SLF4J: Actual binding is of type [org.slf4j.impl.SimpleLoggerFactory]
INFO|3912/0|Service traccar|18-08-01 14:04:47|[main] INFO com.zaxxer.hikari.HikariDataSource - HikariPool-1 - Starting...
INFO|3912/0|Service traccar|18-08-01 14:04:47|[main] INFO com.zaxxer.hikari.HikariDataSource - HikariPool-1 - Start completed.
INFO|3912/0|Service traccar|18-08-01 14:04:48|[main] INFO liquibase.Liquibase - Clearing database change log checksums
INFO|3912/0|Service traccar|18-08-01 14:04:48|[main] INFO liquibase.executor.jvm.JdbcExecutor - SELECT COUNT(*) FROM traccar.DATABASECHANGELOGLOCK
INFO|3912/0|Service traccar|18-08-01 14:04:48|[main] INFO liquibase.executor.jvm.JdbcExecutor - SELECT COUNT(*) FROM traccar.DATABASECHANGELOGLOCK
INFO|3912/0|Service traccar|18-08-01 14:04:48|[main] INFO liquibase.executor.jvm.JdbcExecutor - SELECT LOCKED FROM traccar.DATABASECHANGELOGLOCK WHERE ID=1
INFO|3912/0|Service traccar|18-08-01 14:04:48|[main] INFO liquibase.lockservice.StandardLockService - Successfully acquired change log lock
INFO|3912/0|Service traccar|18-08-01 14:04:48|[main] INFO liquibase.executor.jvm.JdbcExecutor - SELECT MD5SUM FROM traccar.DATABASECHANGELOG WHERE MD5SUM IS NOT NULL LIMIT 1
INFO|3912/0|Service traccar|18-08-01 14:04:48|[main] INFO liquibase.executor.jvm.JdbcExecutor - UPDATE traccar.DATABASECHANGELOG SET MD5SUM = NULL
INFO|3912/0|Service traccar|18-08-01 14:04:49|[main] INFO liquibase.lockservice.StandardLockService - Successfully released change log lock
INFO|3912/0|Service traccar|18-08-01 14:04:49|[main] INFO liquibase.executor.jvm.JdbcExecutor - SELECT COUNT(*) FROM traccar.DATABASECHANGELOGLOCK
INFO|3912/0|Service traccar|18-08-01 14:04:49|[main] INFO liquibase.executor.jvm.JdbcExecutor - SELECT COUNT(*) FROM traccar.DATABASECHANGELOGLOCK
INFO|3912/0|Service traccar|18-08-01 14:04:49|[main] INFO liquibase.executor.jvm.JdbcExecutor - SELECT LOCKED FROM traccar.DATABASECHANGELOGLOCK WHERE ID=1
INFO|3912/0|Service traccar|18-08-01 14:04:49|[main] INFO liquibase.lockservice.StandardLockService - Successfully acquired change log lock
INFO|3912/0|Service traccar|18-08-01 14:04:50|[main] INFO liquibase.executor.jvm.JdbcExecutor - SELECT MD5SUM FROM traccar.DATABASECHANGELOG WHERE MD5SUM IS NOT NULL LIMIT 1
INFO|3912/0|Service traccar|18-08-01 14:04:50|[main] INFO liquibase.executor.jvm.JdbcExecutor - SELECT COUNT(*) FROM traccar.DATABASECHANGELOG
INFO|3912/0|Service traccar|18-08-01 14:04:50|[main] INFO liquibase.changelog.StandardChangeLogHistoryService - Reading from traccar.DATABASECHANGELOG
INFO|3912/0|Service traccar|18-08-01 14:04:50|[main] INFO liquibase.executor.jvm.JdbcExecutor - SELECT * FROM traccar.DATABASECHANGELOG ORDER BY DATEEXECUTED ASC, ORDEREXECUTED ASC
INFO|3912/0|Service traccar|18-08-01 14:04:50|[main] INFO liquibase.executor.jvm.JdbcExecutor - UPDATE traccar.DATABASECHANGELOG SET MD5SUM = '8:ea6f202534dc7845fd1a49e1d8384d9c' WHERE ID = 'changelog-3.3' AND AUTHOR = 'author' AND FILENAME = 'changelog-3.3'
INFO|3912/0|Service traccar|18-08-01 14:04:51|[main] INFO liquibase.executor.jvm.JdbcExecutor - UPDATE traccar.DATABASECHANGELOG SET MD5SUM = '8:194e3ae7ec6d201917136e04a26e237b' WHERE ID = 'changelog-3.5' AND AUTHOR = 'author' AND FILENAME = 'changelog-3.5'
INFO|3912/0|Service traccar|18-08-01 14:04:51|[main] INFO liquibase.executor.jvm.JdbcExecutor - UPDATE traccar.DATABASECHANGELOG SET MD5SUM = '8:1ec7941b03749f24e365bc6126b07e1a' WHERE ID = 'changelog-3.6' AND AUTHOR = 'author' AND FILENAME = 'changelog-3.6'
INFO|3912/0|Service traccar|18-08-01 14:04:51|[main] INFO liquibase.executor.jvm.JdbcExecutor - UPDATE traccar.DATABASECHANGELOG SET MD5SUM = '8:2e444e379f31d0b8e09273ec7ffe87a0' WHERE ID = 'changelog-3.7' AND AUTHOR = 'author' AND FILENAME = 'changelog-3.7'
INFO|3912/0|Service traccar|18-08-01 14:04:51|[main] INFO liquibase.executor.jvm.JdbcExecutor - UPDATE traccar.DATABASECHANGELOG SET MD5SUM = '8:974c33d2fb399ef6477c3897450fb078' WHERE ID = 'changelog-3.7-notmssql' AND AUTHOR = 'author' AND FILENAME = 'changelog-3.7'
INFO|3912/0|Service traccar|18-08-01 14:04:51|[main] INFO liquibase.executor.jvm.JdbcExecutor - UPDATE traccar.DATABASECHANGELOG SET MD5SUM = '8:74d68027951f8d2ae6bb2e24df8365bc' WHERE ID = 'changelog-3.8' AND AUTHOR = 'author' AND FILENAME = 'changelog-3.8'
INFO|3912/0|Service traccar|18-08-01 14:04:51|[main] INFO liquibase.executor.jvm.JdbcExecutor - UPDATE traccar.DATABASECHANGELOG SET MD5SUM = '8:34822842d65deb843a7d16f857d52ecc' WHERE ID = 'changelog-3.9' AND AUTHOR = 'author' AND FILENAME = 'changelog-3.9'
INFO|3912/0|Service traccar|18-08-01 14:04:51|[main] INFO liquibase.executor.jvm.JdbcExecutor - UPDATE traccar.DATABASECHANGELOG SET MD5SUM = '8:e1ddbe83e1ecf856a912755fc118f82e' WHERE ID = 'changelog-3.10' AND AUTHOR = 'author' AND FILENAME = 'changelog-3.10'
INFO|3912/0|Service traccar|18-08-01 14:04:51|[main] INFO liquibase.executor.jvm.JdbcExecutor - UPDATE traccar.DATABASECHANGELOG SET MD5SUM = '8:191c21d8f0f921845cf93bbc9d0639b9' WHERE ID = 'changelog-3.10-notmssql' AND AUTHOR = 'author' AND FILENAME = 'changelog-3.10'
INFO|3912/0|Service traccar|18-08-01 14:04:51|[main] INFO liquibase.executor.jvm.JdbcExecutor - UPDATE traccar.DATABASECHANGELOG SET MD5SUM = '8:ad1f63566e8d08812fbf0b93a118ef6e' WHERE ID = 'changelog-3.10-mssql' AND AUTHOR = 'author' AND FILENAME = 'changelog-3.10'
INFO|3912/0|Service traccar|18-08-01 14:04:51|[main] INFO liquibase.executor.jvm.JdbcExecutor - UPDATE traccar.DATABASECHANGELOG SET MD5SUM = '8:127b36b9d32a9d236df51d19b18c3766' WHERE ID = 'changelog-3.7-mssql' AND AUTHOR = 'author' AND FILENAME = 'changelog-3.10'
INFO|3912/0|Service traccar|18-08-01 14:04:51|[main] INFO liquibase.executor.jvm.JdbcExecutor - UPDATE traccar.DATABASECHANGELOG SET MD5SUM = '8:7800f890b9706a480bd5a79b591b6ca7' WHERE ID = 'changelog-3.11' AND AUTHOR = 'author' AND FILENAME = 'changelog-3.11'
INFO|3912/0|Service traccar|18-08-01 14:04:51|[main] INFO liquibase.executor.jvm.JdbcExecutor - UPDATE traccar.DATABASECHANGELOG SET MD5SUM = '8:5ce520811d626ad325a014b9fcbb1a13' WHERE ID = 'changelog-3.12' AND AUTHOR = 'author' AND FILENAME = 'changelog-3.12'
INFO|3912/0|Service traccar|18-08-01 14:04:51|[main] INFO liquibase.executor.jvm.JdbcExecutor - UPDATE traccar.DATABASECHANGELOG SET MD5SUM = '8:a3bf7fabcde29e106fe2f89829a76a84' WHERE ID = 'changelog-3.12-notmssql' AND AUTHOR = 'author' AND FILENAME = 'changelog-3.12'
INFO|3912/0|Service traccar|18-08-01 14:04:51|[main] INFO liquibase.executor.jvm.JdbcExecutor - UPDATE traccar.DATABASECHANGELOG SET MD5SUM = '8:cfc881bd2dadb561aa9c1a467bc8cc1c' WHERE ID = 'changelog-3.12-pgsql' AND AUTHOR = 'author' AND FILENAME = 'changelog-3.12'
INFO|3912/0|Service traccar|18-08-01 14:04:51|[main] INFO liquibase.executor.jvm.JdbcExecutor - UPDATE traccar.DATABASECHANGELOG SET MD5SUM = '8:1be7e6c0520f8be53ef1b099d96afba5' WHERE ID = 'changelog-3.14' AND AUTHOR = 'author' AND FILENAME = 'changelog-3.14'
INFO|3912/0|Service traccar|18-08-01 14:04:52|[main] INFO liquibase.executor.jvm.JdbcExecutor - UPDATE traccar.DATABASECHANGELOG SET MD5SUM = '8:ac8ccec176027e98bbf45dc6c15d9b05' WHERE ID = 'changelog-3.15' AND AUTHOR = 'author' AND FILENAME = 'changelog-3.15'
INFO|3912/0|Service traccar|18-08-01 14:04:52|[main] INFO liquibase.executor.jvm.JdbcExecutor - UPDATE traccar.DATABASECHANGELOG SET MD5SUM = '8:b59407d70bfe9bf57bc9968adfbbdf1c' WHERE ID = 'changelog-3.16' AND AUTHOR = 'author' AND FILENAME = 'changelog-3.16'
INFO|3912/0|Service traccar|18-08-01 14:04:52|[main] INFO liquibase.executor.jvm.JdbcExecutor - UPDATE traccar.DATABASECHANGELOG SET MD5SUM = '8:3f14c3b08068eb7628d0d3e2941eb2d3' WHERE ID = 'changelog-3.3-admin' AND AUTHOR = 'author' AND FILENAME = 'changelog-3.17'
INFO|3912/0|Service traccar|18-08-01 14:04:52|[main] INFO liquibase.executor.jvm.JdbcExecutor - UPDATE traccar.DATABASECHANGELOG SET MD5SUM = '8:8aa3e56afe6ba86cd004fa801507bc28' WHERE ID = 'changelog-3.17' AND AUTHOR = 'author' AND FILENAME = 'changelog-3.17'
INFO|3912/0|Service traccar|18-08-01 14:04:52|[main] INFO liquibase.executor.jvm.JdbcExecutor - SELECT COUNT(*) FROM traccar.DATABASECHANGELOG
INFO|3912/0|Service traccar|18-08-01 14:04:52|[main] INFO liquibase.changelog.StandardChangeLogHistoryService - Reading from traccar.DATABASECHANGELOG
INFO|3912/0|Service traccar|18-08-01 14:04:52|[main] INFO liquibase.executor.jvm.JdbcExecutor - SELECT * FROM traccar.DATABASECHANGELOG ORDER BY DATEEXECUTED ASC, ORDEREXECUTED ASC
INFO|3912/0|Service traccar|18-08-01 14:04:52|[main] INFO liquibase.lockservice.StandardLockService - Successfully released change log lock
INFO|3912/0|Service traccar|18-08-01 14:04:52|[main] INFO org.eclipse.jetty.util.log - Logging initialized @6899ms
INFO|3912/0|Service traccar|18-08-01 14:04:53|[main] INFO org.eclipse.jetty.server.Server - jetty-9.2.24.v20180105
INFO|3912/0|Service traccar|18-08-01 14:04:54|[main] INFO org.eclipse.jetty.server.handler.ContextHandler - Started o.e.j.s.ServletContextHandler@2accaec2{/api,null,AVAILABLE}
INFO|3912/0|Service traccar|18-08-01 14:04:54|[main] INFO org.eclipse.jetty.server.handler.ContextHandler - Started o.t.w.@6a32191e{/,null,AVAILABLE}
INFO|3912/0|Service traccar|18-08-01 14:04:54|[main] WARN org.eclipse.jetty.util.component.AbstractLifeCycle - FAILED ServerConnector@66fbc5e7{HTTP/1.1}{0.0.0.0:80}: java.net.BindException: Address already in use: bind
INFO|3912/0|Service traccar|18-08-01 14:04:54|java.net.BindException: Address already in use: bind
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at sun.nio.ch.Net.bind0(Native Method)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at sun.nio.ch.Net.bind(Unknown Source)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at sun.nio.ch.Net.bind(Unknown Source)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at sun.nio.ch.ServerSocketChannelImpl.bind(Unknown Source)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at sun.nio.ch.ServerSocketAdaptor.bind(Unknown Source)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at org.eclipse.jetty.server.ServerConnector.open(ServerConnector.java:321)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at org.eclipse.jetty.server.AbstractNetworkConnector.doStart(AbstractNetworkConnector.java:80)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at org.eclipse.jetty.server.ServerConnector.doStart(ServerConnector.java:236)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:68)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at org.eclipse.jetty.server.Server.doStart(Server.java:366)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:68)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at org.traccar.web.WebServer.start(WebServer.java:197)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at org.traccar.Main.main(Main.java:40)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at java.lang.reflect.Method.invoke(Unknown Source)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at org.rzo.yajsw.app.WrapperJVMMain.executeMain(WrapperJVMMain.java:60)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at org.rzo.yajsw.app.WrapperJVMMain.main(WrapperJVMMain.java:43)
INFO|3912/0|Service traccar|18-08-01 14:04:54|[main] WARN org.eclipse.jetty.util.component.AbstractLifeCycle - FAILED org.eclipse.jetty.server.Server@52559a69: java.net.BindException: Address already in use: bind
INFO|3912/0|Service traccar|18-08-01 14:04:54|java.net.BindException: Address already in use: bind
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at sun.nio.ch.Net.bind0(Native Method)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at sun.nio.ch.Net.bind(Unknown Source)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at sun.nio.ch.Net.bind(Unknown Source)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at sun.nio.ch.ServerSocketChannelImpl.bind(Unknown Source)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at sun.nio.ch.ServerSocketAdaptor.bind(Unknown Source)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at org.eclipse.jetty.server.ServerConnector.open(ServerConnector.java:321)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at org.eclipse.jetty.server.AbstractNetworkConnector.doStart(AbstractNetworkConnector.java:80)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at org.eclipse.jetty.server.ServerConnector.doStart(ServerConnector.java:236)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:68)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at org.eclipse.jetty.server.Server.doStart(Server.java:366)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:68)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at org.traccar.web.WebServer.start(WebServer.java:197)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at org.traccar.Main.main(Main.java:40)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at java.lang.reflect.Method.invoke(Unknown Source)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at org.rzo.yajsw.app.WrapperJVMMain.executeMain(WrapperJVMMain.java:60)
INFO|3912/0|Service traccar|18-08-01 14:04:54|	at org.rzo.yajsw.app.WrapperJVMMain.main(WrapperJVMMain.java:43)
Anton Tananaev 7 years ago

Which process causes the conflict? If it's the old instance of Traccar, just kill it.

Vladimir Dimitrow 7 years ago

I dont have old instance of Traccar. I dont understand what the conflict is, can you tell me? Its port or ?

Anton Tananaev 7 years ago

Yes, port conflict.

Vladimir Dimitrow 7 years ago

Wich port? 80? The traccar work on port 80 and this happen when i restart the service. How is this posible?

Anton Tananaev 7 years ago

As I said, it can be an old instance of Traccar still running.

Vladimir Dimitrow 7 years ago

How to fimd out if there is an old instance? I have only one service with name traccar

Anton Tananaev 7 years ago

Stop the service and check if the old process is still running.

Vladimir Dimitrow 7 years ago

Although I have stopped the traccar service, I can see that the java is still working with a tracker. How can I resolve this?

proces_still_running
service_stopped

Anton Tananaev 7 years ago

Kill the process.

Vladimir Dimitrow 7 years ago

Verry strange. After killing java process and running traccar, the error in log with conflicting port is happen again

Vladimir Dimitrow 7 years ago

Can you tell me how to clear all traccar instance and use only one?

Anton Tananaev 7 years ago

Find the process that uses the port and kill it.

Vladimir Dimitrow 7 years ago

I found my problem. I access the pc remotely by software Ammyy Admin. Facing the problem when restart the application throw this remote connection. If i restart the application throw RDP, there is no problem.

Vladimir Dimitrow 7 years ago

In order not to open a new topic I will ask here. With a server installed on Windows 7, is there a limit to the devices that can be hooked at the same time?