Serviio server dies a few seconds after starting it

[Former user]

In a Mac OS X 10.8.2 system up to date, freshly booted and with Apple's Java 6 installed:

$ java -version
java version "1.6.0_37"
Java(TM) SE Runtime Environment (build 1.6.0_37-b06-434-11M3909)
Java HotSpot(TM) 64-Bit Server VM (build 20.12-b01-434, mixed mode)

I download serviio-1.1-osx.tar.gz, unpack it and move Serviio.app and Serviio-Console.app to /Applications

I then start Serviio.app, which starts bouncing in the Dock and dies mysteriously without opening any window, a few seconds after that. If I then start Serviio-Console.app, it opens a pop up saying "Cannot connect to Serviio server, it does not seem to be running. Exiting..."

I've tried to trace the process with the Process Monitor. The Serviio process is created when I start the app and then it just disappears a few seconds later.

There is no error logged in /var/log/system.log I've tried with the Console application in Mac OS X and I haven't found any error either.

If I start the Serviio.app from the console with:

$ open /Applications/Serviio.app/

I does the same and it doesn't output any error or warning.

GateKeeper is set to allow applications downloaded from anywhere.

I really don't know what's going on or if I'm doing something wrong.

I don't know how to extract more debug information. Is this a known issue? Can I help providing more information?

Thanks

Miguel

[Petr Nejedly]

This is more of a support issue. Post on the forum and provide detailed log (there are HOWTOs for that). Looks most likely as a java issue.

[Former user]

From the the log at DEBUG level, I see a No suitable driver found for jdbc:derby:db;create=true that's probably the cause for the following NullPointerException

Full log:

2013-01-20 22:25:05,450 DEBUG [ApplicationInstanceManager] Listening for application instances on socket 44331
2013-01-20 22:25:05,462 INFO  [MediaServer] ------------------------------------------------------------------------
2013-01-20 22:25:05,462 INFO  [MediaServer] Serviio DLNA media streaming server v 1.1 (rev. 6ba0dd933a8e+)
2013-01-20 22:25:05,462 INFO  [MediaServer] Petr Nejedly 2009-2012
2013-01-20 22:25:05,462 INFO  [MediaServer] http://www.serviio.org
2013-01-20 22:25:05,462 INFO  [MediaServer] 
2013-01-20 22:25:05,462 INFO  [MediaServer] Java 1.6.0_37-Apple Inc.
2013-01-20 22:25:05,463 INFO  [MediaServer] OS Mac OS X x86_64 10.8.2
2013-01-20 22:25:05,463 INFO  [MediaServer] File encoding: UTF-8
2013-01-20 22:25:05,463 INFO  [MediaServer] Headless mode enabled: true
2013-01-20 22:25:05,463 INFO  [MediaServer] User: myuser
2013-01-20 22:25:05,464 INFO  [MediaServer] User home dir: /Users/myuser
2013-01-20 22:25:05,464 INFO  [MediaServer] Temp dir: /var/folders/lr/rnv4gjw52dz73c37m079rdg00000gn/T/
2013-01-20 22:25:05,464 INFO  [MediaServer] ------------------------------------------------------------------------
2013-01-20 22:25:05,614 INFO  [WebServer] Socket buffer set to 65535 bytes
2013-01-20 22:25:05,616 INFO  [RestletServer] Starting Restlet server (/rest) exposed on port 23423
2013-01-20 22:25:05,651 INFO  [RestletServer] Starting Restlet server (/cds) exposed on port 23424
2013-01-20 22:25:05,652 INFO  [RestletServer] Starting Restlet server (/mediabrowser) exposed on port 23424
2013-01-20 22:25:05,666 INFO  [DBSchemaUpdateExecutor] Checking if DB schema needs to be updated
2013-01-20 22:25:05,679 DEBUG [DBLogDAOImpl] Checking if script 'script-0.1.sql' has been run
2013-01-20 22:25:05,684 WARN  [DBConnectionPool] Can't create a new connection for jdbc:derby:db;create=true
java.sql.SQLException: No suitable driver found for jdbc:derby:db;create=true
    at java.sql.DriverManager.getConnection(DriverManager.java:602)
    at java.sql.DriverManager.getConnection(DriverManager.java:207)
    at org.serviio.db.DBConnectionPool.newConnection(DBConnetionPool.java:186)
    at org.serviio.db.DBConnectionPool.getConnection(DBConnetionPool.java:123)
    at org.serviio.db.DBConnectionPool.getConnection(DBConnetionPool.java:149)
    at org.serviio.db.DatabaseManager.getConnection(DatabaseManager.java:66)
    at org.serviio.db.DatabaseManager.getConnection(DatabaseManager.java:59)
    at org.serviio.update.dao.DBLogDAOImpl.isScriptPresent(DBLogDAOImpl.java:49)
    at org.serviio.update.DBSchemaUpdateExecutor.updateDBSchema(DBSchemaUpdateExecutor.java:57)
    at org.serviio.MediaServer.main(MediaServer.java:110)
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
    at java.lang.reflect.Method.invoke(Method.java:597)
    at apple.launcher.LaunchRunner.run(LaunchRunner.java:116)
    at apple.launcher.LaunchRunner.callMain(LaunchRunner.java:51)
    at apple.launcher.JavaApplicationLauncher.launch(JavaApplicationLauncher.java:52)
2013-01-20 22:25:07,692 ERROR [MediaServer] An unexpected error occured. Ending the application. Message: null
java.lang.NullPointerException
    at org.serviio.update.dao.DBLogDAOImpl.isScriptPresent(DBLogDAOImpl.java:50)
    at org.serviio.update.DBSchemaUpdateExecutor.updateDBSchema(DBSchemaUpdateExecutor.java:57)
    at org.serviio.MediaServer.main(MediaServer.java:110)
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
    at java.lang.reflect.Method.invoke(Method.java:597)
    at apple.launcher.LaunchRunner.run(LaunchRunner.java:116)
    at apple.launcher.LaunchRunner.callMain(LaunchRunner.java:51)
    at apple.launcher.JavaApplicationLauncher.launch(JavaApplicationLauncher.java:52)

[Petr Nejedly]

is Derby.jar part of the Serviio.app package? It might be corrupted, not readable or the java you have cannot load it properly

[Former user]

It is part of Serviio.app at:

Serviio.app/Contents/Resources/Java/derby.jar 

The tarball from which I extracted Serviio.app has the correct md5 checksum as per Serviio's Download webpage (93051e796b6428c7ca87194fe53e92bb).

I have the Java 6 JDK that provides Apple (I reinstalled it just in case something was corrupted inside it) plus Oracle's Java 7 plugin for web browsers.

[Former user]

and the MD5 checksum of Serviio.app/Contents/Resources/Java/derby.jar is 000702c96fa81afad91ba1be32ff0a08

[Former user]

I've tried replacing derby.jar in Serviio.app/Contents/Resources/Java/derby.jar by another version I've found in /usr/share/java/derby-10.8.1.2/lib/derby.jar

I get exactly the same warning and error.

Regarding permissions, All directories and files inside Serviio.app are 755 and 644, respectively, with myuser:staff as owners. Being myuser the user I'm using to execute Serviio.app

I run the Repair Permissions procedure in the Disk Utility of Mac OS X just to be sure everything else is OK.

And I tried

$ sudo open /Applications/Serviio.app

which produced the same warning and error as always, so I'd really say it's not a permissions problem.

[Former user]

I've checked on another system with the same OS and Java versions and it works well.

What in Earth could be afffecting me??

Any way to get further debug info beyond what Serviio provides in the serviio.log with DEBUG set at log4j.xml ?

[Petr Nejedly]

Continue the forum thread. This ticket is closed.