QNAP TS-239 ProII v3.3.6 Build1110: Subsonic fails to start.

[zekebgaf@gmail.com]

<Moderators: please feel free to move to Help. It's late & I mis-posted.>

I've verified all symlinks for /var/subsonic are still in place. Tomcat is running: Apache Tomcat/6.0.20 JVM: 1.6.0_13-b03. Subsonic before firmware update was running nicely. Post firmware update - not so much.

Reviewing the tomcat logs, I see errors which may say why, but they're over my head. The error (received when I attempt to start subsonic from Tomcat Manager) in Catalina.log is:

Nov 26, 2010 11:59:10 PM org.apache.catalina.loader.WebappClassLoader loadClass
INFO: Illegal access: this web application instance has been stopped already. Could not load com.sun.org.apache.xerces.internal.impl.dv.dtd.DTDDVFactoryImpl. The eventual following stack trace is caused by an error thrown for debugging purposes as well as to attempt to terminate the thread which caused the illegal access, and has no functional impact.
java.lang.IllegalStateException
at org.apache.catalina.loader.WebappClassLoader.loadClass(WebappClassLoader.java:1273)
at org.apache.catalina.loader.WebappClassLoader.loadClass(WebappClassLoader.java:1233)
at com.sun.org.apache.xerces.internal.impl.dv.ObjectFactory.findProviderClass(ObjectFactory.java:395)
at com.sun.org.apache.xerces.internal.impl.dv.ObjectFactory.newInstance(ObjectFactory.java:350)
at com.sun.org.apache.xerces.internal.impl.dv.DTDDVFactory.getInstance(DTDDVFactory.java:59)
at com.sun.org.apache.xerces.internal.impl.dv.DTDDVFactory.getInstance(DTDDVFactory.java:44)
at com.sun.org.apache.xerces.internal.parsers.XML11Configuration.<init>(XML11Configuration.java:538)
at com.sun.org.apache.xerces.internal.parsers.XIncludeAwareParserConfiguration.<init>(XIncludeAwareParserConfiguration.java:125)
at com.sun.org.apache.xerces.internal.parsers.XIncludeAwareParserConfiguration.<init>(XIncludeAwareParserConfiguration.java:86)
at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:39)
at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:27)
at java.lang.reflect.Constructor.newInstance(Constructor.java:513)
at java.lang.Class.newInstance0(Class.java:355)
at java.lang.Class.newInstance(Class.java:308)
at com.sun.org.apache.xerces.internal.parsers.ObjectFactory.newInstance(ObjectFactory.java:349)
at com.sun.org.apache.xerces.internal.parsers.ObjectFactory.createObject(ObjectFactory.java:154)
at com.sun.org.apache.xerces.internal.parsers.ObjectFactory.createObject(ObjectFactory.java:97)
at com.sun.org.apache.xerces.internal.parsers.SAXParser.<init>(SAXParser.java:98)
at com.sun.org.apache.xerces.internal.parsers.SAXParser.<init>(SAXParser.java:83)
at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:39)
at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:27)
at java.lang.reflect.Constructor.newInstance(Constructor.java:513)
at java.lang.Class.newInstance0(Class.java:355)
at java.lang.Class.newInstance(Class.java:308)
at org.xml.sax.helpers.NewInstance.newInstance(NewInstance.java:51)
at org.xml.sax.helpers.XMLReaderFactory.loadClass(XMLReaderFactory.java:187)
at org.xml.sax.helpers.XMLReaderFactory.createXMLReader(XMLReaderFactory.java:150)
at org.wetorrent.upnp.GatewayDevice.loadDescription(GatewayDevice.java:120)
at org.wetorrent.upnp.GatewayDiscover.discover(GatewayDiscover.java:144)
at net.sourceforge.subsonic.domain.WeUPnPRouter.findRouter(WeUPnPRouter.java:39)
at net.sourceforge.subsonic.service.NetworkService$PortForwardingTask.findRouter(NetworkService.java:185)
at net.sourceforge.subsonic.service.NetworkService$PortForwardingTask.execute(NetworkService.java:132)
at net.sourceforge.subsonic.service.NetworkService$Task.run(NetworkService.java:299)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
at java.util.concurrent.FutureTask$Sync.innerRunAndReset(FutureTask.java:317)
at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:150)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$101(ScheduledThreadPoolExecutor.java:98)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.runPeriodic(ScheduledThreadPoolExecutor.java:181)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:205)
at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
at java.lang.Thread.run(Thread.java:619)

Thoughts?

-Zeke

[zekebgaf@gmail.com]

After updating / reinstalling Subsonic 4.2, same result - Subsonic won't start. The Catalina.log gives a slightly different error:

Nov 27, 2010 12:54:01 AM net.sf.ehcache.Cache initialise
WARNING: Cache: musicFolderCache has a maxElementsInMemory of 0. It is strongly recommended to have a maximumSize of at least 1. Performance is halved by not using a MemoryStore.
Nov 27, 2010 12:54:01 AM net.sf.ehcache.Cache initialise
WARNING: Cache: chatCache has a maxElementsInMemory of 0. It is strongly recommended to have a maximumSize of at least 1. Performance is halved by not using a MemoryStore.
Nov 27, 2010 12:54:03 AM org.apache.catalina.core.StandardContext start
SEVERE: Error listenerStart
Nov 27, 2010 12:54:03 AM org.apache.catalina.core.StandardContext start
SEVERE: Context [/subsonic] startup failed due to previous errors
Nov 27, 2010 12:54:05 AM org.apache.catalina.loader.WebappClassLoader loadClass
INFO: Illegal access: this web application instance has been stopped already. Could not load org.wetorrent.upnp.GatewayDiscover. The eventual following stack trace is caused by an error thrown for debugging purposes as well as to attempt to terminate the thread which caused the illegal access, and has no functional impact.
java.lang.IllegalStateException
at org.apache.catalina.loader.WebappClassLoader.loadClass(WebappClassLoader.java:1273)
at org.apache.catalina.loader.WebappClassLoader.loadClass(WebappClassLoader.java:1233)
at java.lang.ClassLoader.loadClassInternal(ClassLoader.java:320)
at net.sourceforge.subsonic.domain.WeUPnPRouter.findRouter(WeUPnPRouter.java:38)
at net.sourceforge.subsonic.service.NetworkService$PortForwardingTask.findRouter(NetworkService.java:185)
at net.sourceforge.subsonic.service.NetworkService$PortForwardingTask.execute(NetworkService.java:132)
at net.sourceforge.subsonic.service.NetworkService$Task.run(NetworkService.java:297)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
at java.util.concurrent.FutureTask$Sync.innerRunAndReset(FutureTask.java:317)
at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:150)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$101(ScheduledThreadPoolExecutor.java:98)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.runPeriodic(ScheduledThreadPoolExecutor.java:181)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:205)
at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
at java.lang.Thread.run(Thread.java:619)

[zekebgaf@gmail.com]

I've got things resolved and Subsonic running again.

Why these steps helped, I don't know. But here they are:

Undeployed Subsonic 4.1 using Tomcat Manager.
Shut down Tomcat

Deleted a file named subsonic in the /share/HDA_DATA/.qpkg/Tomcat/tomcat/work directory (in a sub directory, don't recall which one).

Re-started Tomcat.

Re-deployed 4.2 WAR and it started up no problem. All users, files, settings intact.