failed upgrade

Need help? Post your questions here.

Moderator: moderators

failed upgrade

Postby kerridge » Sun Sep 24, 2006 11:07 pm

Hi, I upgraded from (pretty sure) 2.7 to 2.8 by stopping tomcat on fc4 and then renaming subsonic.war to subsonic.old. I then renamed the subsonic folder to subsnicold. I put in the new subsonic.war and browsed to the web location that had previously worked.

The left and top panels come up with errors like :

Exception java.lang.NullPointerException
Message null
Java version Sun Microsystems Inc. 1.5.0_07
Operating system Linux 2.6.15-1.1833_FC4
Tomcat home /usr/local/apache-tomcat-5.5.17
Stack trace java.lang.NullPointerException at net.sourceforge.subsonic.domain.MusicFile$MusicFileSorter.compare(MusicFile.java:568) at net.sourceforge.subsonic.domain.MusicFile$MusicFileSorter.compare(MusicFile.java:553) at java.util.Arrays.mergeSort(Unknown Source) at java.util.Arrays.mergeSort(Unknown Source) at java.util.Arrays.mergeSort(Unknown Source) at java.util.Arrays.mergeSort(Unknown Source) at java.util.Arrays.mergeSort(Unknown Source) at java.util.Arrays.mergeSort(Unknown Source) at java.util.Arrays.mergeSort(Unknown Source) at java.util.Arrays.sort(Unknown Source) at net.sourceforge.subsonic.domain.MusicFile.getChildren(MusicFile.java:252) at net.sourceforge.subsonic.domain.MusicIndex.getIndexedChildren(MusicIndex.java:159) at net.sourceforge.subsonic.controller.LeftController.handleRequestInternal(LeftController.java:46) at org.springframework.web.servlet.mvc.AbstractController.handleRequest(AbstractController.java:153) at org.springframework.web.servlet.mvc.SimpleControllerHandlerAdapter.handle(SimpleControllerHandlerAdapter.java:45) at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:796) at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:727) at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:396) at org.springframework.web.servlet.FrameworkServlet.doGet(FrameworkServlet.java:350) at javax.servlet.http.HttpServlet.service(HttpServlet.java:689) at javax.servlet.http.HttpServlet.service(HttpServlet.java:802) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:252) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:173) at org.acegisecurity.util.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:264) at org.acegisecurity.intercept.web.FilterSecurityInterceptor.invoke(FilterSecurityInterceptor.java:107) at org.acegisecurity.intercept.web.FilterSecurityInterceptor.doFilter(FilterSecurityInterceptor.java:72) at org.acegisecurity.util.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:274) at org.acegisecurity.ui.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:110) at org.acegisecurity.util.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:274) at org.acegisecurity.providers.anonymous.AnonymousProcessingFilter.doFilter(AnonymousProcessingFilter.java:125) at org.acegisecurity.util.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:274) at org.acegisecurity.ui.rememberme.RememberMeProcessingFilter.doFilter(RememberMeProcessingFilter.java:142) at org.acegisecurity.util.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:274) at org.acegisecurity.wrapper.SecurityContextHolderAwareRequestFilter.doFilter(SecurityContextHolderAwareRequestFilter.java:81) at org.acegisecurity.util.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:274) at org.acegisecurity.ui.basicauth.BasicProcessingFilter.doFilter(BasicProcessingFilter.java:181) at org.acegisecurity.util.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:274) at org.acegisecurity.ui.AbstractProcessingFilter.doFilter(AbstractProcessingFilter.java:216) at org.acegisecurity.util.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:274) at org.acegisecurity.ui.logout.LogoutFilter.doFilter(LogoutFilter.java:108) at org.acegisecurity.util.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:274) at org.acegisecurity.context.HttpSessionContextIntegrationFilter.doFilter(HttpSessionContextIntegrationFilter.java:195) at org.acegisecurity.util.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:274) at org.acegisecurity.util.FilterChainProxy.doFilter(FilterChainProxy.java:148) at org.acegisecurity.util.FilterToBeanProxy.doFilter(FilterToBeanProxy.java:90) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:202) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:173) at net.sourceforge.subsonic.filter.RequestEncodingFilter.doFilter(RequestEncodingFilter.java:25) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:202) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:173) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:178) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:126) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:105) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:107) at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:148) at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:869) at org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:664) at org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:527) at org.apache.tomcat.util.net.LeaderFollowerWorkerThread.runIt(LeaderFollowerWorkerThread.java:80) at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:684) at java.lang.Thread.run(Unknown Source)

however the central window does still work, i am able to navigate e.g. new music and play by clicking on the album cover.

I had a look and the closest error i could find on this forum was a problem with non-standard characters in the music directories. I am not sure how that could come about from an upgrade, have not made any attempts to change folder locations because I am not sure how to without moving my music files out of the way.

Any ideas?

PS nice piece of software, by the way!
kerridge
 
Posts: 7
Joined: Sun Sep 24, 2006 10:12 pm

Postby sindre_mehus » Mon Sep 25, 2006 7:44 am

Hi,

It's indeed the problem with non-standard characters you are running into. This bug was not present in 2.7.

I haven't been able to reproduce this bug on Windows - it seems it only occurs on Linux. Maybe you can help me a little? When you get this error, can you please look for any warnings or errors in /var/subsonic/subsonic.log? Also, please look for anything "suspicious" in the log files in /usr/local/apache-tomcat-5.5.17/logs.

If you're not sure what to look for, you can mail me the entire log files.

Thanks in advance :D

Sindre
User avatar
sindre_mehus
 
Posts: 1955
Joined: Tue Nov 29, 2005 6:19 pm
Location: Oslo, Norway

indexing error

Postby kerridge » Mon Sep 25, 2006 8:12 am

Hi yes whe the indexing went ahead at 3am this morning i got this error in the logs:

Code: Select all
[2006-09-25 03:00:00,315] INFO SearchService - Starting to create search index.
[2006-09-25 03:00:15,173] ERROR SearchService - Failed to create search index.
java.lang.NullPointerException
        at net.sourceforge.subsonic.domain.MusicFile$MusicFileSorter.compare(MusicFile.java:568)
        at net.sourceforge.subsonic.domain.MusicFile$MusicFileSorter.compare(MusicFile.java:553)
        at java.util.Arrays.mergeSort(Unknown Source)
        at java.util.Arrays.mergeSort(Unknown Source)
        at java.util.Arrays.sort(Unknown Source)
        at net.sourceforge.subsonic.domain.MusicFile.getChildren(MusicFile.java:252)
        at net.sourceforge.subsonic.domain.MusicFile.listMusicRecursively(MusicFile.java:294)
        at net.sourceforge.subsonic.domain.MusicFile.listMusicRecursively(MusicFile.java:297)
        at net.sourceforge.subsonic.domain.MusicFile.listMusicRecursively(MusicFile.java:297)
        at net.sourceforge.subsonic.domain.MusicFile.getChildren(MusicFile.java:245)
        at net.sourceforge.subsonic.service.SearchService$1.run(SearchService.java:77)

and selectively from catalina.2006-09-24.log:

Code: Select all
INFO: The Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: /usr/ja
va/jre1.5.0_07/lib/i386/client:/usr/java/jre1.5.0_07/lib/i386:/usr/java/jre1.5.0_07/../lib/i386
Sep 24, 2006 10:56:32 PM org.apache.coyote.http11.Http11BaseProtocol init
INFO: Initializing Coyote HTTP/1.1 on http-8080
Sep 24, 2006 10:56:32 PM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 2045 ms
Sep 24, 2006 10:56:32 PM org.apache.catalina.core.StandardService start
INFO: Starting service Catalina
Sep 24, 2006 10:56:32 PM org.apache.catalina.core.StandardEngine start
INFO: Starting Servlet Engine: Apache Tomcat/5.5.17
Sep 24, 2006 10:56:32 PM org.apache.catalina.core.StandardHost start
INFO: XML validation disabled
Sep 24, 2006 10:56:34 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive subsonic.war
Sep 24, 2006 10:56:45 PM org.apache.coyote.http11.Http11BaseProtocol start
INFO: Starting Coyote HTTP/1.1 on http-8080
Sep 24, 2006 10:56:52 PM org.apache.jk.common.ChannelSocket init
INFO: JK: ajp13 listening on /0.0.0.0:8009
Sep 24, 2006 10:56:53 PM org.apache.jk.server.JkMain start
INFO: Jk running ID=0 time=0/1231  config=null
Sep 24, 2006 10:56:54 PM org.apache.catalina.storeconfig.StoreLoader load
INFO: Find registry server-registry.xml at classpath resource
Sep 24, 2006 10:56:54 PM org.apache.catalina.startup.Catalina start
INFO: Server startup in 21982 ms
Sep 24, 2006 11:00:38 PM org.apache.coyote.http11.Http11BaseProtocol pause
INFO: Pausing Coyote HTTP/1.1 on http-8080
Sep 24, 2006 11:00:39 PM org.apache.catalina.core.StandardService stop
INFO: Stopping service Catalina
Sep 24, 2006 11:00:40 PM org.apache.coyote.http11.Http11BaseProtocol destroy
INFO: Stopping Coyote HTTP/1.1 on http-8080
Sep 24, 2006 11:00:40 PM org.apache.catalina.core.AprLifecycleListener lifecycleEvent
INFO: Failed shutdown of Apache Portable Runtime
Sep 24, 2006 11:01:32 PM org.apache.catalina.core.AprLifecycleListener lifecycleEvent


the other logs looked pretty standard.

let me know if ther's anything else you need testing out.

Thanks!
kerridge
 
Posts: 7
Joined: Sun Sep 24, 2006 10:12 pm

Postby sindre_mehus » Mon Sep 25, 2006 6:19 pm

Hm, no more leads there, I'm afraid.

I'm having a hard time tracking down this bug since I don't have a Linux system myself, so I really appreciate you helping me out here.

I've prepared a war file which adds some debug logging when this error occurs. Could you be so kind to install it (normal upgrade procedure), and let me know what's written in subsonic.log when the error occurs?

http://www.activeobjects.no/subsonic/do ... -debug.zip

Thanks a bunch!
Sindre
User avatar
sindre_mehus
 
Posts: 1955
Joined: Tue Nov 29, 2005 6:19 pm
Location: Oslo, Norway

Postby kerridge » Mon Sep 25, 2006 6:38 pm

here you go:

Code: Select all
[2006-09-25 19:31:31,466] INFO DaoHelper - Checking database schema.
[2006-09-25 19:31:35,725] INFO DaoHelper - Done checking database schema.
[2006-09-25 19:31:35,910] INFO SearchService - Automatic index creation scheduled to run every 1 day(s), starting at Tue Sep 26 03:00:00 BST 2006
[2006-09-25 19:32:28,438] INFO PlayerDao - Created player 11.
[2006-09-25 19:32:33,298] ERROR MusicFile - Failed to parse ID3 tags for file '/home/data/media/ma/Mot�rHead'.
[2006-09-25 19:32:33,298] ERROR MusicFile - parser: null, isFile: false, isDirectory: false
[2006-09-25 19:32:33,483] ERROR MusicFile - Failed to parse ID3 tags for file '/home/data/media/ma/Mot�rHead'.
[2006-09-25 19:32:33,483] ERROR MusicFile - parser: null, isFile: false, isDirectory: false


output of ls (in putty) for problem folder:

/home/data/media/ma/Mot?rHead

I will rename said folder and see what happens
kerridge
 
Posts: 7
Joined: Sun Sep 24, 2006 10:12 pm

Postby sindre_mehus » Mon Sep 25, 2006 6:59 pm

Thanks.

Does the error occur when you click on the "ma" folder, or the "Motörhead" folder?
User avatar
sindre_mehus
 
Posts: 1955
Joined: Tue Nov 29, 2005 6:19 pm
Location: Oslo, Norway

Postby kerridge » Mon Sep 25, 2006 6:59 pm

sfter renaming the m?torhead folder i get a new error:

Code: Select all
[2006-09-25 19:50:20,583] WARN Mp3Parser - Failed to parse MP3 header for /home/data/media/ma/(02) Summertime In England - Van Morrison.mp3
java.lang.IllegalArgumentException
        at java.nio.Buffer.position(Unknown Source)
        at org.jaudiotagger.audio.mp3.MP3AudioHeader.isNextFrameValid(MP3AudioHeader.java:282)
        at org.jaudiotagger.audio.mp3.MP3AudioHeader.seek(MP3AudioHeader.java:169)
        at org.jaudiotagger.audio.mp3.MP3AudioHeader.<init>(MP3AudioHeader.java:82)
        at net.sourceforge.subsonic.domain.Mp3Parser.parseMp3Header(Mp3Parser.java:190)
        at net.sourceforge.subsonic.domain.Mp3Parser.getRawMetaData(Mp3Parser.java:126)
        at net.sourceforge.subsonic.domain.Mp3Parser.getMetaData(Mp3Parser.java:26)
        at net.sourceforge.subsonic.domain.MusicFile.getMetaData(MusicFile.java:198)
        at net.sourceforge.subsonic.domain.MusicFile$MusicFileSorter.compare(MusicFile.java:575)
        at net.sourceforge.subsonic.domain.MusicFile$MusicFileSorter.compare(MusicFile.java:559)
        at java.util.Arrays.mergeSort(Unknown Source)
        at java.util.Arrays.mergeSort(Unknown Source)
        at java.util.Arrays.mergeSort(Unknown Source)
        at java.util.Arrays.mergeSort(Unknown Source)
        at java.util.Arrays.mergeSort(Unknown Source)
        at java.util.Arrays.mergeSort(Unknown Source)
        at java.util.Arrays.mergeSort(Unknown Source)
        at java.util.Arrays.sort(Unknown Source)
        at net.sourceforge.subsonic.domain.MusicFile.getChildren(MusicFile.java:258)
        at net.sourceforge.subsonic.domain.MusicIndex.getIndexedChildren(MusicIndex.java:159)
        at net.sourceforge.subsonic.controller.LeftController.handleRequestInternal(LeftController.java:46)
        at org.springframework.web.servlet.mvc.AbstractController.handleRequest(AbstractController.java:153)
        at org.springframework.web.servlet.mvc.SimpleControllerHandlerAdapter.handle(SimpleControllerHandlerAdapter.java:45)
        at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:796)
        at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:727)
        at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:396)
        at org.springframework.web.servlet.FrameworkServlet.doGet(FrameworkServlet.java:350)
        at javax.servlet.http.HttpServlet.service(HttpServlet.java:689)
        at javax.servlet.http.HttpServlet.service(HttpServlet.java:802)
        at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:252)
        at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:173)
        at org.acegisecurity.util.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:264)
        at org.acegisecurity.intercept.web.FilterSecurityInterceptor.invoke(FilterSecurityInterceptor.java:107)
        at org.acegisecurity.intercept.web.FilterSecurityInterceptor.doFilter(FilterSecurityInterceptor.java:72)
        at org.acegisecurity.util.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:274)
        at org.acegisecurity.ui.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:110)
        at org.acegisecurity.util.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:274)
        at org.acegisecurity.providers.anonymous.AnonymousProcessingFilter.doFilter(AnonymousProcessingFilter.java:125)
        at org.acegisecurity.util.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:274)
kerridge
 
Posts: 7
Joined: Sun Sep 24, 2006 10:12 pm

Postby kerridge » Mon Sep 25, 2006 7:04 pm

error occurs when i try to load the subsonic homepage, i don't see the folder to click on, top & left bars have error, but central frame shows fine

can send a screenshot if you like
kerridge
 
Posts: 7
Joined: Sun Sep 24, 2006 10:12 pm

Postby sindre_mehus » Mon Sep 25, 2006 7:31 pm

I think I've found the explanation:
http://bugs.sun.com/bugdatabase/view_bu ... id=4866151

Do you know if the Mot?rhead folder originates from a Windows drive?
What happens if you rename the folder to "Motörhead" (the proper spelling)?

Also, can you please check what your LC_ALL environment variable is set to? Does it work if you set it to "en_US"?

Sindre
User avatar
sindre_mehus
 
Posts: 1955
Joined: Tue Nov 29, 2005 6:19 pm
Location: Oslo, Norway

Postby kerridge » Mon Sep 25, 2006 7:51 pm

that's done it!

so i entered:

Code: Select all
export LC_ALL=en_US


at the prompt yay. Now to just add that to /etc/profile and done!


nice work :P :P!!!
kerridge
 
Posts: 7
Joined: Sun Sep 24, 2006 10:12 pm

Postby sindre_mehus » Mon Sep 25, 2006 8:30 pm

Great! Did you notice what LC_ALL was set to before you changed it?

Thanks again for your help :-)
User avatar
sindre_mehus
 
Posts: 1955
Joined: Tue Nov 29, 2005 6:19 pm
Location: Oslo, Norway

Postby kerridge » Mon Sep 25, 2006 9:13 pm

from what I could gather, it was not set at all, although there was a us codepage set elsewhere. I am in the UK if that makes any difference.
kerridge
 
Posts: 7
Joined: Sun Sep 24, 2006 10:12 pm

Postby yozik » Wed Oct 04, 2006 5:10 am

I too am having this issue

my LC_ALL was set to ""

I have tried the following vars with no success

en_US.utf8
en_US
C


please let me know what other info you need to help t-shoot this
yozik
 
Posts: 3
Joined: Wed Oct 04, 2006 5:07 am

Postby yozik » Wed Oct 04, 2006 5:43 am

verified that I had the correct locales installed

once I did that and updated my locales install I tried with export LC_ALL=en_US


works for me now

I am seeing the following messages and would like to know if it is related

[2006-10-03 22:39:49,850] WARN Mp3Parser - Failed to parse MP3 header for /mnt/music/media/music/U/Unkown/Doc Vs JonC 020603.mp3
org.jaudiotagger.audio.InvalidAudioFrameException: No audio header found withinDoc Vs JonC 020603.mp3
at org.jaudiotagger.audio.mp3.MP3AudioHeader.<init>(MP3AudioHeader.java:84)
at net.sourceforge.subsonic.domain.Mp3Parser.parseMp3Header(Mp3Parser.java:190)
yozik
 
Posts: 3
Joined: Wed Oct 04, 2006 5:07 am

Postby sindre_mehus » Wed Oct 04, 2006 6:29 am

No, this warning is not at all related to the locale problem. It's just a warning that Subsonic wasn't able to find the MP3 header in the given file (either due to a corrupt file, or to a bug in the third-pary library Subsonic uses to parse MP3 headers).

The consequences of this warning is that Subsonic will not be able to display the bitrate and duration of this track.

Sindre
User avatar
sindre_mehus
 
Posts: 1955
Joined: Tue Nov 29, 2005 6:19 pm
Location: Oslo, Norway

Next

Return to Help

Who is online

Users browsing this forum: No registered users and 14 guests