Serviio

DLNA media server
https://forum.serviio.org/

Windows 10 serviio 1.6.1 server will not stay started

https://forum.serviio.org/viewtopic.php?f=5&t=22249

Page 1 of 1

Windows 10 serviio 1.6.1 server will not stay started

PostPosted: Thu Jul 21, 2016 5:31 pm
by w1k3dsmart
I have recently had a issue with serviio and after looking into the issue further it looks as though the server will not stay started. i have checked the windows running services and it is not running or present. looking into the services.msc i can see the service is there after starting it there it go away and shows running but but its not it will not run for more than 1 second. I have also tried uninstalling serviio and reinstalling with no success.
here is the log file:
  Code:
2016-07-21 13:14:14,370 INFO  [MediaServer] ------------------------------------------------------------------------
2016-07-21 13:14:14,370 INFO  [MediaServer] Serviio DLNA media streaming server v 1.6.1 (rev. 34f326d2b259)
2016-07-21 13:14:14,370 INFO  [MediaServer] Petr Nejedly 2009-2015
2016-07-21 13:14:14,370 INFO  [MediaServer] http://www.serviio.org
2016-07-21 13:14:14,370 INFO  [MediaServer]
2016-07-21 13:14:14,371 INFO  [MediaServer] Java 1.8.0_40-Oracle Corporation x86
2016-07-21 13:14:14,371 INFO  [MediaServer] OS Windows 8 6.2
2016-07-21 13:14:14,371 INFO  [MediaServer] File encoding: windows-1252
2016-07-21 13:14:14,371 INFO  [MediaServer] Headless mode enabled: true
2016-07-21 13:14:14,371 INFO  [MediaServer] User: WIKED-PC$
2016-07-21 13:14:14,371 INFO  [MediaServer] User home dir: C:\WINDOWS\system32\config\systemprofile
2016-07-21 13:14:14,371 INFO  [MediaServer] Temp dir: C:\WINDOWS\TEMP\
2016-07-21 13:14:14,371 INFO  [MediaServer] ------------------------------------------------------------------------
2016-07-21 13:14:14,378 INFO  [DBSchemaUpdateExecutor] Checking if DB schema needs to be updated
2016-07-21 13:14:14,385 INFO  [DatabaseManager] Using DERBY database language
2016-07-21 13:14:15,164 INFO  [WebServer] Socket buffer set to 65535 bytes
2016-07-21 13:14:15,165 INFO  [RestletServer] Starting HTTP/1.1 Restlet server (/console) exposed on port 23423
2016-07-21 13:14:15,166 INFO  [RestletServer] Starting HTTP/1.1 Restlet server (/rest) exposed on port 23423
2016-07-21 13:14:15,167 INFO  [RestletServer] Starting HTTPS/1.1 Restlet server (/console) exposed on port 23523
2016-07-21 13:14:15,167 INFO  [RestletServer] Starting HTTPS/1.1 Restlet server (/rest) exposed on port 23523
2016-07-21 13:14:15,404 INFO  [RestletServer] Starting HTTP/1.1 Restlet server (/cds) exposed on port 23424
2016-07-21 13:14:15,405 INFO  [RestletServer] Starting HTTP/1.1 Restlet server (/mediabrowser) exposed on port 23424
2016-07-21 13:14:15,405 INFO  [RestletServer] Starting HTTPS/1.1 Restlet server (/cds) exposed on port 23524
2016-07-21 13:14:15,405 INFO  [RestletServer] Starting HTTPS/1.1 Restlet server (/mediabrowser) exposed on port 23524
2016-07-21 13:14:15,407 ERROR [MediaServer] An unexpected error occured. Ending the application. Message: java.net.BindException: Address already in use: bind
java.lang.RuntimeException: java.net.BindException: Address already in use: bind
   at org.serviio.restlet.RestletServer.runServer(RestletServer.java:93)
   at org.serviio.MediaServer.main(MediaServer.java:122)
   at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   at java.lang.reflect.Method.invoke(Method.java:497)
   at com.exe4j.runtime.LauncherEngine.launch(Unknown Source)
   at com.exe4j.runtime.WinLauncher$2.run(Unknown Source)
Caused by: java.net.BindException: Address already in use: bind
   at sun.nio.ch.Net.bind0(Native Method)
   at sun.nio.ch.Net.bind(Net.java:437)
   at sun.nio.ch.Net.bind(Net.java:429)
   at sun.nio.ch.ServerSocketChannelImpl.bind(ServerSocketChannelImpl.java:223)
   at sun.nio.ch.ServerSocketAdaptor.bind(ServerSocketAdaptor.java:74)
   at org.simpleframework.transport.connect.SocketAcceptor.bind(SocketAcceptor.java:183)
   at org.simpleframework.transport.connect.SocketAcceptor.<init>(SocketAcceptor.java:100)
   at org.simpleframework.transport.connect.SocketListener.<init>(SocketListener.java:81)
   at org.simpleframework.transport.connect.SocketListenerManager.listen(SocketListenerManager.java:98)
   at org.simpleframework.transport.connect.SocketListenerManager.listen(SocketListenerManager.java:81)
   at org.simpleframework.transport.connect.SocketConnection.connect(SocketConnection.java:106)
   at org.restlet.ext.simple.HttpServerHelper.start(HttpServerHelper.java:99)
   at org.restlet.Server.start(Server.java:588)
   at org.restlet.Component.startServers(Component.java:637)
   at org.restlet.Component.start(Component.java:562)
   at org.serviio.restlet.RestletServer.startComponent(RestletServer.java:172)
   at org.serviio.restlet.RestletServer.runServer(RestletServer.java:91)
   ... 7 more

Re: Windows 10 serviio 1.6.1 server will not stay started

PostPosted: Thu Jul 21, 2016 5:40 pm
by w1k3dsmart
I added DEBUG into the log4j file and here are the results:
  Code:
2016-07-21 13:37:31,227 DEBUG [ApplicationInstanceManager] Listening for application instances on socket 44331
2016-07-21 13:37:31,228 INFO  [MediaServer] ------------------------------------------------------------------------
2016-07-21 13:37:31,228 INFO  [MediaServer] Serviio DLNA media streaming server v 1.6.1 (rev. 34f326d2b259)
2016-07-21 13:37:31,228 INFO  [MediaServer] Petr Nejedly 2009-2015
2016-07-21 13:37:31,228 INFO  [MediaServer] http://www.serviio.org
2016-07-21 13:37:31,229 INFO  [MediaServer]
2016-07-21 13:37:31,229 INFO  [MediaServer] Java 1.8.0_40-Oracle Corporation x86
2016-07-21 13:37:31,229 INFO  [MediaServer] OS Windows 8 6.2
2016-07-21 13:37:31,229 INFO  [MediaServer] File encoding: windows-1252
2016-07-21 13:37:31,229 INFO  [MediaServer] Headless mode enabled: true
2016-07-21 13:37:31,229 INFO  [MediaServer] User: WIKED-PC$
2016-07-21 13:37:31,229 INFO  [MediaServer] User home dir: C:\WINDOWS\system32\config\systemprofile
2016-07-21 13:37:31,229 INFO  [MediaServer] Temp dir: C:\WINDOWS\TEMP\
2016-07-21 13:37:31,229 INFO  [MediaServer] ------------------------------------------------------------------------
2016-07-21 13:37:31,231 DEBUG [MediaServer] Runtime params: -Dexe4j.semaphoreName=Local\h:_pc5dczc_bin_serviioservice.exe0, -Dexe4j.isService=true, -Dexe4j.moduleName=H:\Serviio\bin\ServiioService.exe, -Dexe4j.tempDir=C:\WINDOWS\TEMP\e4j83B6.tmp_dir1469122651, -Dexe4j.unextractedPosition=327425, -Djava.library.path=C:\ProgramData\Oracle\Java\javapath;H:\Downloads\WinAVR\bin;H:\Downloads\WinAVR\utils\bin;H:\Downloads\bin;H:\Downloads\utils\bin;C:\Windows\system32;C:\Windows;C:\Windows\System32\Wbem;C:\Windows\System32\WindowsPowerShell\v1.0\;C:\Program Files (x86)\Microsoft SQL Server\100\Tools\Binn\;C:\Program Files\Microsoft SQL Server\100\Tools\Binn\;C:\Program Files\Microsoft SQL Server\100\DTS\Binn\;C:\Program Files (x86)\Google\Google Apps Sync\;C:\Program Files (x86)\Google\Google Apps Migration\;C:\Program Files (x86)\NVIDIA Corporation\PhysX\Common;H:\Program Files (x86)\QTSystem\;%SystemRoot%\system32;%SystemRoot%;%SystemRoot%\System32\Wbem;%SYSTEMROOT%\System32\WindowsPowerShell\v1.0\;;h:\serviio\jre\bin, -Dexe4j.consoleCodepage=cp0, -Xms20M, -XX:+UseG1GC, -XX:GCTimeRatio=1, -XX:MinHeapFreeRatio=10, -XX:MaxHeapFreeRatio=20, -Djava.net.preferIPv4Stack=true, -Djava.awt.headless=true, -Dorg.restlet.engine.loggerFacadeClass=org.restlet.ext.slf4j.Slf4jLoggerFacade, -Dserviio.home=H:\Serviio\bin\\.., -Dderby.system.home=H:\Serviio\bin\\..\library, -Xrs, -Xmx512m
2016-07-21 13:37:31,236 INFO  [DBSchemaUpdateExecutor] Checking if DB schema needs to be updated
2016-07-21 13:37:31,242 DEBUG [DBLogDAOImpl] Checking if script 'script-0.1.sql' has been run
2016-07-21 13:37:31,243 INFO  [DatabaseManager] Using DERBY database language
2016-07-21 13:37:32,086 DEBUG [DBLogDAOImpl] Checking if script 'script-0.1.1.sql' has been run
2016-07-21 13:37:32,087 DEBUG [DBLogDAOImpl] Checking if script 'script-0.2.sql' has been run
2016-07-21 13:37:32,087 DEBUG [DBLogDAOImpl] Checking if script 'script-0.3.1.sql' has been run
2016-07-21 13:37:32,087 DEBUG [DBLogDAOImpl] Checking if script 'script-0.4.sql' has been run
2016-07-21 13:37:32,088 DEBUG [DBLogDAOImpl] Checking if script 'script-0.4.1.sql' has been run
2016-07-21 13:37:32,088 DEBUG [DBLogDAOImpl] Checking if script 'script-0.4.2.sql' has been run
2016-07-21 13:37:32,088 DEBUG [DBLogDAOImpl] Checking if script 'script-0.5.sql' has been run
2016-07-21 13:37:32,089 DEBUG [DBLogDAOImpl] Checking if script 'script-0.5.1.sql' has been run
2016-07-21 13:37:32,089 DEBUG [DBLogDAOImpl] Checking if script 'script-0.6.sql' has been run
2016-07-21 13:37:32,090 DEBUG [DBLogDAOImpl] Checking if script 'script-0.6.1.sql' has been run
2016-07-21 13:37:32,090 DEBUG [DBLogDAOImpl] Checking if script 'script-0.6.2.sql' has been run
2016-07-21 13:37:32,090 DEBUG [DBLogDAOImpl] Checking if script 'script-1.0.sql' has been run
2016-07-21 13:37:32,091 DEBUG [DBLogDAOImpl] Checking if script 'script-1.1.sql' has been run
2016-07-21 13:37:32,091 DEBUG [DBLogDAOImpl] Checking if script 'script-1.2.sql' has been run
2016-07-21 13:37:32,091 DEBUG [DBLogDAOImpl] Checking if script 'script-1.2.1.sql' has been run
2016-07-21 13:37:32,092 DEBUG [DBLogDAOImpl] Checking if script 'script-1.3.sql' has been run
2016-07-21 13:37:32,093 DEBUG [DBLogDAOImpl] Checking if script 'script-1.4.sql' has been run
2016-07-21 13:37:32,093 DEBUG [DBLogDAOImpl] Checking if script 'script-1.5.sql' has been run
2016-07-21 13:37:32,093 DEBUG [DBLogDAOImpl] Checking if script 'script-1.6.sql' has been run
2016-07-21 13:37:32,145 INFO  [WebServer] Socket buffer set to 65535 bytes
2016-07-21 13:37:32,146 INFO  [RestletServer] Starting HTTP/1.1 Restlet server (/console) exposed on port 23423
2016-07-21 13:37:32,147 INFO  [RestletServer] Starting HTTP/1.1 Restlet server (/rest) exposed on port 23423
2016-07-21 13:37:32,148 INFO  [RestletServer] Starting HTTPS/1.1 Restlet server (/console) exposed on port 23523
2016-07-21 13:37:32,148 INFO  [RestletServer] Starting HTTPS/1.1 Restlet server (/rest) exposed on port 23523
2016-07-21 13:37:32,389 INFO  [RestletServer] Starting HTTP/1.1 Restlet server (/cds) exposed on port 23424
2016-07-21 13:37:32,389 INFO  [RestletServer] Starting HTTP/1.1 Restlet server (/mediabrowser) exposed on port 23424
2016-07-21 13:37:32,390 INFO  [RestletServer] Starting HTTPS/1.1 Restlet server (/cds) exposed on port 23524
2016-07-21 13:37:32,390 INFO  [RestletServer] Starting HTTPS/1.1 Restlet server (/mediabrowser) exposed on port 23524
2016-07-21 13:37:32,392 ERROR [MediaServer] An unexpected error occured. Ending the application. Message: java.net.BindException: Address already in use: bind
java.lang.RuntimeException: java.net.BindException: Address already in use: bind
   at org.serviio.restlet.RestletServer.runServer(RestletServer.java:93)
   at org.serviio.MediaServer.main(MediaServer.java:122)
   at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   at java.lang.reflect.Method.invoke(Method.java:497)
   at com.exe4j.runtime.LauncherEngine.launch(Unknown Source)
   at com.exe4j.runtime.WinLauncher$2.run(Unknown Source)
Caused by: java.net.BindException: Address already in use: bind
   at sun.nio.ch.Net.bind0(Native Method)
   at sun.nio.ch.Net.bind(Net.java:437)
   at sun.nio.ch.Net.bind(Net.java:429)
   at sun.nio.ch.ServerSocketChannelImpl.bind(ServerSocketChannelImpl.java:223)
   at sun.nio.ch.ServerSocketAdaptor.bind(ServerSocketAdaptor.java:74)
   at org.simpleframework.transport.connect.SocketAcceptor.bind(SocketAcceptor.java:183)
   at org.simpleframework.transport.connect.SocketAcceptor.<init>(SocketAcceptor.java:100)
   at org.simpleframework.transport.connect.SocketListener.<init>(SocketListener.java:81)
   at org.simpleframework.transport.connect.SocketListenerManager.listen(SocketListenerManager.java:98)
   at org.simpleframework.transport.connect.SocketListenerManager.listen(SocketListenerManager.java:81)
   at org.simpleframework.transport.connect.SocketConnection.connect(SocketConnection.java:106)
   at org.restlet.ext.simple.HttpServerHelper.start(HttpServerHelper.java:99)
   at org.restlet.Server.start(Server.java:588)
   at org.restlet.Component.startServers(Component.java:637)
   at org.restlet.Component.start(Component.java:562)
   at org.serviio.restlet.RestletServer.startComponent(RestletServer.java:172)
   at org.serviio.restlet.RestletServer.runServer(RestletServer.java:91)
   ... 7 more

Re: Windows 10 serviio 1.6.1 server will not stay started

PostPosted: Fri Jul 22, 2016 1:44 pm
by atc98092
If you either provide the log as an attachment, or embed it in the message using the CODE tags it will be a little easier to examine :D

The log shows the issue: the IP address on your computer appears to be in use by something else on your network, or something on your computer is already using the requested ports. I know Plex doesn't interfere with Serviio, but has you installed some other application that might be using the same ports?

Re: Windows 10 serviio 1.6.1 server will not stay started

PostPosted: Fri Jul 22, 2016 5:26 pm
by w1k3dsmart
UPDATE:
I checked out all ports and ip addresses that were being used by the computer by using this command line.
  Code:
netstat -a -n -p tcp -b
This command needs to be used while in admin mode in the command prompt.
I found that the Dyn DNS service was causing the hang up so i have stopped that service as well as a VNC service for now until i can figure out the issue.
I used the service for several days while serviio ran fine. it might be after a remote access session that the issue started to happen. Either way maybe this will help someone else in the future.
atc98092 thank you for your time a effort in this issue!!

Re: Windows 10 serviio 1.6.1 server will not stay started

PostPosted: Fri Jul 22, 2016 5:51 pm
by atc98092
Excellent troubleshoot. Good work, and glad it's resolved. I hadn't considered a DDNS service as a cause. I use DNSEXIT with no issues on my Serviio box, but different services could cause different results.

:D
All times are UTC
Page 1 of 1
Powered by phpBB © 2000, 2002, 2005, 2007 phpBB Group
http://www.phpbb.com/