java error in logs

[Aethies]

Everything has been working perfectly for a few months, then I started seeing my log files filling up with the following:

jsvc.exec[7788]: java.lang.ArrayIndexOutOfBoundsException: 3
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at entagged.audioformats.mp3.util.id3frames.Id3Frame.getString(Unknown Source)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at entagged.audioformats.mp3.util.id3frames.TextId3Frame.populate(Unknown Source)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at entagged.audioformats.mp3.util.id3frames.Id3Frame.<init>(Unknown Source)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at entagged.audioformats.mp3.util.id3frames.TextId3Frame.<init>(Unknown Source)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at entagged.audioformats.mp3.util.Id3v24TagReader.createId3Frame(Unknown Source)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at entagged.audioformats.mp3.util.Id3v24TagReader.read(Unknown Source)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at entagged.audioformats.mp3.util.Id3v2TagReader.read(Unknown Source)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at entagged.audioformats.mp3.Mp3FileReader.getTag(Unknown Source)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at entagged.audioformats.generic.AudioFileReader.read(Unknown Source)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at entagged.audioformats.AudioFileIO.readFile(Unknown Source)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at entagged.audioformats.AudioFileIO.read(Unknown Source)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at net.sourceforge.subsonic.domain.EntaggedParser.getAPICFrame(EntaggedParser.java:233)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at net.sourceforge.subsonic.domain.EntaggedParser.isImageAvailable(EntaggedParser.java:209)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at net.sourceforge.subsonic.service.MusicFileService.getBestCoverArt(MusicFileService.java:203)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at net.sourceforge.subsonic.service.MusicFileService.listCoverArtRecursively(MusicFileService.java:183)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at net.sourceforge.subsonic.service.MusicFileService.listCoverArtRecursively(MusicFileService.java:175)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at net.sourceforge.subsonic.service.MusicFileService.getCoverArt(MusicFileService.java:112)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at net.sourceforge.subsonic.controller.MainController.handleRequestInternal(MainController.java:134)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.springframework.web.servlet.mvc.AbstractController.handleRequest(AbstractController.java:153)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.springframework.web.servlet.mvc.SimpleControllerHandlerAdapter.handle(SimpleControllerHandlerAdapter.java:48)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:874)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:808)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:476)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.springframework.web.servlet.FrameworkServlet.doGet(FrameworkServlet.java:431)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at javax.servlet.http.HttpServlet.service(HttpServlet.java:689)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at javax.servlet.http.HttpServlet.service(HttpServlet.java:802)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:269)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.acegisecurity.util.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:265)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.acegisecurity.intercept.web.FilterSecurityInterceptor.invoke(FilterSecurityInterceptor.java:107)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.acegisecurity.intercept.web.FilterSecurityInterceptor.doFilter(FilterSecurityInterceptor.java:72)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.acegisecurity.util.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:275)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.acegisecurity.ui.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:166)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.acegisecurity.util.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:275)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.acegisecurity.providers.anonymous.AnonymousProcessingFilter.doFilter(AnonymousProcessingFilter.java:125)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.acegisecurity.util.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:275)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.acegisecurity.ui.rememberme.RememberMeProcessingFilter.doFilter(RememberMeProcessingFilter.java:142)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.acegisecurity.util.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:275)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.acegisecurity.wrapper.SecurityContextHolderAwareRequestFilter.doFilter(SecurityContextHolderAwareRequestFilter.java:81)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.acegisecurity.util.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:275)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.acegisecurity.ui.basicauth.BasicProcessingFilter.doFilter(BasicProcessingFilter.java:173)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.acegisecurity.util.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:275)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.acegisecurity.ui.AbstractProcessingFilter.doFilter(AbstractProcessingFilter.java:271)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.acegisecurity.util.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:275)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.acegisecurity.ui.logout.LogoutFilter.doFilter(LogoutFilter.java:110)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.acegisecurity.util.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:275)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.acegisecurity.context.HttpSessionContextIntegrationFilter.doFilter(HttpSessionContextIntegrationFilter.java:249)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.acegisecurity.util.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:275)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.acegisecurity.util.FilterChainProxy.doFilter(FilterChainProxy.java:149)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.acegisecurity.util.FilterToBeanProxy.doFilter(FilterToBeanProxy.java:98)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:215)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at net.sourceforge.subsonic.filter.RequestEncodingFilter.doFilter(RequestEncodingFilter.java:43)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:215)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at net.sourceforge.subsonic.filter.ParameterDecodingFilter.doFilter(ParameterDecodingFilter.java:54)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:215)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at net.sourceforge.subsonic.filter.BootstrapVerificationFilter.doFilter(BootstrapVerificationFilter.java:54)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:215)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:188)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:213)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:172)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:117)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:108)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:151)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.apache.coyote.http11.Http11Processor.process(Http11Processor.java:874)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.apache.coyote.http11.Http11BaseProtocol$Http11ConnectionHandler.processConnection(Http11BaseProtocol.java:665)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.apache.tomcat.util.net.PoolTcpEndpoint.processSocket(PoolTcpEndpoint.java:528)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.apache.tomcat.util.net.LeaderFollowerWorkerThread.runIt(LeaderFollowerWorkerThread.java:81)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at org.apache.tomcat.util.threads.ThreadPool$ControlRunnable.run(ThreadPool.java:689)
Apr 6 07:40:35 s_local@localhost jsvc.exec[7788]: at java.lang.Thread.run(Thread.java:619)



Any direction would be appreciated.
Server: Ubuntu 8.04 server
Tomcat 5.5
Subsonic: 3.6

[Aethies]

I am still rotating logs every 3 days or so as this is filling all my logfiles up. I have scoured the web and there is nothing about this error that I am smart enough to figure out. The only thing I have found that was right on was this:

Description: an attempt has been made to access a non-existent portion of the array; for example, if the array has only 3 elements, then the elements exist at indexes 0 to 2, there is nothing at index 3 or above, and there are never any negative indexes.

- use the illegal index given to you to work out where you have gone wrong
- common errors include starting a loop at index 1 (remember, Java starts counting at 0), and using '=' in the boolean expression of a loop (usually, you shouldn't)

[sindre_mehus]

I also see this from time to time. It's related to illegal ID3 tags in some of your files.