MusicCabinet - artist radio, genre radio & related artists

[hakko]

Make sure there's no other Subsonic process running (look for java processes and kill them). The error says that another process is indeed running and has locked the Subsonic internal database file, so when you're starting a new process, it can't access the database and fails.

I don't know how your previous install is set up, but basically, you need to replace the two java archive files (subsonic.war and subsonic-booter-with-dependencies.jar) in your current installation with the ones from the zip file on the MusicCabinet installation page and then start the Subsonic process just as usual.

The settings from your 4.7 install will be read and transformed into MusicCabinet 0.7 format (for example, updating passwords to be stored as salted hash sums instead of clear text). That's why it tells you to make a backup of your current settings before installation, as you can't go back from MusicCabinet 0.7 to Subsonic 4.x unless you save your current settings somewhere.

[Pcace]

Hmm ok, that helped!
Its runing now. Thanks, but: when i click on "upgrade database" nothing happens.. ideas?

the log sais:

root@t64:/home/hannes# tail -f /var/subsonic/subsonic.log
[2012-09-05 22:07:58,352] DEBUG DaoHelper - DAO Helper constructor.
[2012-09-05 22:07:58,361] DEBUG DaoHelper - Data source URL: jdbc:hsqldb:file:/var/subsonic/db/subsonic
[2012-09-05 22:07:58,361] INFO DaoHelper - Checking database schema.
[2012-09-05 22:07:59,104] INFO DaoHelper - Done checking database schema.
[2012-09-05 22:07:59,314] INFO VersionService - Resolved local Subsonic version to: 0.7
[2012-09-05 22:08:00,780] INFO SearchService - Automatic index creation scheduled to run every 1 day(s), starting at Thu Sep 06 04:00:00 CEST 2012
[2012-09-05 22:08:00,929] INFO PodcastService - Automatic Podcast update scheduled to run every 1 hour(s), starting at Wed Sep 05 22:13:00 CEST 2012
[2012-09-05 22:08:04,189] INFO NetworkService - Deleted port mapping for port 4040
[2012-09-05 22:09:04,281] DEBUG SecurityService - Load user user
[2012-09-05 22:09:04,673] DEBUG LeftController - return last modified as Wed Sep 05 22:08:00 CEST 2012
[2012-09-05 22:09:05,720] DEBUG LeftController - hasArtists = false, method = null
[2012-09-05 22:10:03,925] DEBUG SecurityService - Load user munin
[2012-09-05 22:11:44,982] DEBUG LastFmSettingsController - lastFmUsername = null, sessionKey = null
[2012-09-05 22:11:44,982] DEBUG LastFmSettingsController - token = null
[2012-09-05 22:11:44,982] DEBUG LastFmSettingsController - Prepare data for last.fm auth.
[2012-09-05 22:11:44,982] DEBUG LastFmSettingsController - callback url = http://server.local:4040/lastFmSettings.view
[2012-09-05 22:11:52,410] DEBUG LastFmSettingsController - lastFmUsername = null, sessionKey = null
[2012-09-05 22:11:52,410] DEBUG LastFmSettingsController - token = 0dbb1a543fe62ea7b388c13
[2012-09-05 22:11:53,202] DEBUG LastFmSettingsController - user, ed61bb22f691e9339c0fc1ddb
[2012-09-05 22:11:58,044] DEBUG LastFmSettingsController - lastFmUsername = user, sessionKey = ed61bb22f690cc4cb11e9339c0fc1ddb
[2012-09-05 22:13:00,928] INFO PodcastService - Starting scheduled Podcast refresh.
[2012-09-05 22:13:00,933] INFO PodcastService - Completed scheduled Podcast refresh.
[2012-09-05 22:15:05,390] DEBUG SecurityService - Load user munin
[2012-09-05 22:16:17,719] DEBUG LeftController - return last modified as Wed Sep 05 22:11:58 CEST 2012
[2012-09-05 22:16:17,727] DEBUG LeftController - hasArtists = false, method = null

but there is a postgres process wich completely uses my cpu:

1826 postgres 20 0 57196 39556 29852 R 89.0 1.9 7:04.96 postgres: postgres musiccabinet 127.0.0.1(59170) SELECT

is everything right?

Thanks,

Pcace

[hakko]

It's hard to tell, if you come from an installation of MusicCabinet 0.5 and upgrade to 0.7, there has been quite a lot of work on the database engine. It'll definitely take a little while re-organizing the db to 0.7.

If you try upgrading the db and scanning your library at the same time it might get confused (I think the interface should stop you from doing that though).

[Pcace]

Thats right! when i click on search in the preferences it sais:

Search configuration

MusicCabinet configuration isn't completed. Please finish it here before updating search index.

and when i click "here" the i come to the musiccabinet preferences:

MusicCabinet configuration

It seems like you recently installed or upgraded MusicCabinet. Press 'Upgrade database' to load the latest version.

and now when i say "upgrade database" nothing happens! Is there a way to completely remove the postgres database and begin the game from the beginning?!

[hakko]

Could you restart your Subsonic service before nuking the db? When it starts up, it should say something like:

Load version number 1025
Version 1025 loaded, result code 0
Load version number 1026
Version 1026 loaded, result code 0

etc

Some of these updates might take a while (maybe even a couple of minutes), but I'd be interested to hear where it stops before you start from scratch.

[Pcace]

Hmm you ment the subsonic.log?

it consists of billions of lines like:

[2012-09-05 22:46:11,158] DEBUG MediaFileService - request for non indexed media file /media/medien/Musik/Bibliothek/Chopin - A.Rubinstein, cache as -14862765

Than:

[2012-09-05 22:46:19,451] DEBUG PlaylistService - starting play([-1533426171], P)
[2012-09-05 22:46:19,517] DEBUG StreamController - got mfId = -1533426171 from param -1533426171
[2012-09-05 22:46:19,538] INFO PlaylistInputStream - user listening to "...Bis Ihr Nicht....mp3"
[2012-09-05 22:46:19,553] DEBUG AudioScrobblerService - Scrobbling failed!
org.springframework.jdbc.BadSqlGrammarException: PreparedStatementCallback; bad SQL grammar [select id, lastfm_user_capitalization, session_key from library.lastfmuser where lastfm_user = upper(?)]; nested exception is org.postgresql.util.PSQLException: FEHLER: Spalte »session_key« existiert nicht
Position: 40
at org.springframework.jdbc.support.SQLStateSQLExceptionTranslator.doTranslate(SQLStateSQLExceptionTranslator.java:98)
at org.springframework.jdbc.support.AbstractFallbackSQLExceptionTranslator.translate(AbstractFallbackSQLExceptionTranslator.java:72)
at org.springframework.jdbc.support.AbstractFallbackSQLExceptionTranslator.translate(AbstractFallbackSQLExceptionTranslator.java:80)
at org.springframework.jdbc.support.AbstractFallbackSQLExceptionTranslator.translate(AbstractFallbackSQLExceptionTranslator.java:80)
at org.springframework.jdbc.core.JdbcTemplate.execute(JdbcTemplate.java:603)
at org.springframework.jdbc.core.JdbcTemplate.query(JdbcTemplate.java:637)
at org.springframework.jdbc.core.JdbcTemplate.query(JdbcTemplate.java:666)
at org.springframework.jdbc.core.JdbcTemplate.query(JdbcTemplate.java:674)
at org.springframework.jdbc.core.JdbcTemplate.queryForObject(JdbcTemplate.java:729)
at com.github.hakko.musiccabinet.dao.jdbc.JdbcLastFmUserDao.getLastFmUser(JdbcLastFmUserDao.java:28)
at com.github.hakko.musiccabinet.service.ScrobbleService.scrobble(ScrobbleService.java:59)
at net.sourceforge.subsonic.service.AudioScrobblerService.scrobble(AudioScrobblerService.java:34)
at net.sourceforge.subsonic.io.PlaylistInputStream.prepare(PlaylistInputStream.java:117)
at net.sourceforge.subsonic.io.PlaylistInputStream.read(PlaylistInputStream.java:89)
at net.sourceforge.subsonic.io.PlaylistInputStream.read(PlaylistInputStream.java:81)
at net.sourceforge.subsonic.controller.StreamController.handleRequest(StreamController.java:212)
at org.springframework.web.servlet.mvc.SimpleControllerHandlerAdapter.handle(SimpleControllerHandlerAdapter.java:48)
at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:900)
at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:827)
at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:882)
at org.springframework.web.servlet.FrameworkServlet.doGet(FrameworkServlet.java:778)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:820)
at org.mortbay.jetty.servlet.ServletHolder.handle(ServletHolder.java:487)
at org.mortbay.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1093)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:311)
at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.invoke(FilterSecurityInterceptor.java:116)
at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.doFilter(FilterSecurityInterceptor.java:83)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.access.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:113)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.session.SessionManagementFilter.doFilter(SessionManagementFilter.java:101)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.authentication.AnonymousAuthenticationFilter.doFilter(AnonymousAuthenticationFilter.java:113)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.authentication.rememberme.RememberMeAuthenticationFilter.doFilter(RememberMeAuthenticationFilter.java:146)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter.doFilter(SecurityContextHolderAwareRequestFilter.java:54)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.savedrequest.RequestCacheAwareFilter.doFilter(RequestCacheAwareFilter.java:45)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.authentication.www.BasicAuthenticationFilter.doFilter(BasicAuthenticationFilter.java:150)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.authentication.AbstractAuthenticationProcessingFilter.doFilter(AbstractAuthenticationProcessingFilter.java:182)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.authentication.logout.LogoutFilter.doFilter(LogoutFilter.java:105)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.context.SecurityContextPersistenceFilter.doFilter(SecurityContextPersistenceFilter.java:87)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.FilterChainProxy.doFilter(FilterChainProxy.java:173)
at org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:346)
at org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:259)
at org.mortbay.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1084)
at net.sourceforge.subsonic.filter.RequestEncodingFilter.doFilter(RequestEncodingFilter.java:43)
at org.mortbay.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1084)
at net.sourceforge.subsonic.filter.ParameterDecodingFilter.doFilter(ParameterDecodingFilter.java:54)
at org.mortbay.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1084)
at net.sourceforge.subsonic.filter.BootstrapVerificationFilter.doFilter(BootstrapVerificationFilter.java:54)
at org.mortbay.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1084)
at org.mortbay.jetty.servlet.ServletHandler.handle(ServletHandler.java:360)
at org.mortbay.jetty.security.SecurityHandler.handle(SecurityHandler.java:216)
at org.mortbay.jetty.servlet.SessionHandler.handle(SessionHandler.java:181)
at org.mortbay.jetty.handler.ContextHandler.handle(ContextHandler.java:712)
at org.mortbay.jetty.webapp.WebAppContext.handle(WebAppContext.java:405)
at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:139)
at org.mortbay.jetty.Server.handle(Server.java:313)
at org.mortbay.jetty.HttpConnection.handleRequest(HttpConnection.java:506)
at org.mortbay.jetty.HttpConnection$RequestHandler.headerComplete(HttpConnection.java:830)
at org.mortbay.jetty.HttpParser.parseNext(HttpParser.java:514)
at org.mortbay.jetty.HttpParser.parseAvailable(HttpParser.java:211)
at org.mortbay.jetty.HttpConnection.handle(HttpConnection.java:381)
at org.mortbay.io.nio.SelectChannelEndPoint.run(SelectChannelEndPoint.java:396)
at org.mortbay.thread.BoundedThreadPool$PoolThread.run(BoundedThreadPool.java:442)
Caused by: org.postgresql.util.PSQLException: FEHLER: Spalte »session_key« existiert nicht
Position: 40
at org.postgresql.core.v3.QueryExecutorImpl.receiveErrorResponse(QueryExecutorImpl.java:2102)
at org.postgresql.core.v3.QueryExecutorImpl.processResults(QueryExecutorImpl.java:1835)
at org.postgresql.core.v3.QueryExecutorImpl.execute(QueryExecutorImpl.java:257)
at org.postgresql.jdbc2.AbstractJdbc2Statement.execute(AbstractJdbc2Statement.java:500)
at org.postgresql.jdbc2.AbstractJdbc2Statement.executeWithFlags(AbstractJdbc2Statement.java:388)
at org.postgresql.jdbc2.AbstractJdbc2Statement.executeQuery(AbstractJdbc2Statement.java:273)
at com.mchange.v2.c3p0.impl.NewProxyPreparedStatement.executeQuery(NewProxyPreparedStatement.java:446)
at org.springframework.jdbc.core.JdbcTemplate$1.doInPreparedStatement(JdbcTemplate.java:644)
at org.springframework.jdbc.core.JdbcTemplate.execute(JdbcTemplate.java:587)
... 68 more

[2012-09-05 22:46:26,891] DEBUG AudioScrobblerService - Scrobbling failed!
org.springframework.jdbc.BadSqlGrammarException: PreparedStatementCallback; bad SQL grammar [select id, lastfm_user_capitalization, session_key from library.lastfmuser where lastfm_user = upper(?)]; nested exception is org.postgresql.util.PSQLException: FEHLER: Spalte »session_key« existiert nicht
Position: 40
at org.springframework.jdbc.support.SQLStateSQLExceptionTranslator.doTranslate(SQLStateSQLExceptionTranslator.java:98)
at org.springframework.jdbc.support.AbstractFallbackSQLExceptionTranslator.translate(AbstractFallbackSQLExceptionTranslator.java:72)
at org.springframework.jdbc.support.AbstractFallbackSQLExceptionTranslator.translate(AbstractFallbackSQLExceptionTranslator.java:80)
at org.springframework.jdbc.support.AbstractFallbackSQLExceptionTranslator.translate(AbstractFallbackSQLExceptionTranslator.java:80)
at org.springframework.jdbc.core.JdbcTemplate.execute(JdbcTemplate.java:603)
at org.springframework.jdbc.core.JdbcTemplate.query(JdbcTemplate.java:637)
at org.springframework.jdbc.core.JdbcTemplate.query(JdbcTemplate.java:666)
at org.springframework.jdbc.core.JdbcTemplate.query(JdbcTemplate.java:674)
at org.springframework.jdbc.core.JdbcTemplate.queryForObject(JdbcTemplate.java:729)
at com.github.hakko.musiccabinet.dao.jdbc.JdbcLastFmUserDao.getLastFmUser(JdbcLastFmUserDao.java:28)
at com.github.hakko.musiccabinet.service.ScrobbleService.scrobble(ScrobbleService.java:59)
at net.sourceforge.subsonic.service.AudioScrobblerService.scrobble(AudioScrobblerService.java:34)
at net.sourceforge.subsonic.io.PlaylistInputStream.close(PlaylistInputStream.java:139)
at net.sourceforge.subsonic.io.PlaylistInputStream.read(PlaylistInputStream.java:99)
at net.sourceforge.subsonic.io.PlaylistInputStream.read(PlaylistInputStream.java:81)
at net.sourceforge.subsonic.controller.StreamController.handleRequest(StreamController.java:212)
at org.springframework.web.servlet.mvc.SimpleControllerHandlerAdapter.handle(SimpleControllerHandlerAdapter.java:48)
at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:900)
at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:827)
at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:882)
at org.springframework.web.servlet.FrameworkServlet.doGet(FrameworkServlet.java:778)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:820)
at org.mortbay.jetty.servlet.ServletHolder.handle(ServletHolder.java:487)
at org.mortbay.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1093)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:311)
at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.invoke(FilterSecurityInterceptor.java:116)
at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.doFilter(FilterSecurityInterceptor.java:83)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.access.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:113)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.session.SessionManagementFilter.doFilter(SessionManagementFilter.java:101)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.authentication.AnonymousAuthenticationFilter.doFilter(AnonymousAuthenticationFilter.java:113)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.authentication.rememberme.RememberMeAuthenticationFilter.doFilter(RememberMeAuthenticationFilter.java:146)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter.doFilter(SecurityContextHolderAwareRequestFilter.java:54)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.savedrequest.RequestCacheAwareFilter.doFilter(RequestCacheAwareFilter.java:45)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.authentication.www.BasicAuthenticationFilter.doFilter(BasicAuthenticationFilter.java:150)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.authentication.AbstractAuthenticationProcessingFilter.doFilter(AbstractAuthenticationProcessingFilter.java:182)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.authentication.logout.LogoutFilter.doFilter(LogoutFilter.java:105)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.context.SecurityContextPersistenceFilter.doFilter(SecurityContextPersistenceFilter.java:87)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.FilterChainProxy.doFilter(FilterChainProxy.java:173)
at org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:346)
at org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:259)
at org.mortbay.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1084)
at net.sourceforge.subsonic.filter.RequestEncodingFilter.doFilter(RequestEncodingFilter.java:43)
at org.mortbay.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1084)
at net.sourceforge.subsonic.filter.ParameterDecodingFilter.doFilter(ParameterDecodingFilter.java:54)
at org.mortbay.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1084)
at net.sourceforge.subsonic.filter.BootstrapVerificationFilter.doFilter(BootstrapVerificationFilter.java:54)
at org.mortbay.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1084)
at org.mortbay.jetty.servlet.ServletHandler.handle(ServletHandler.java:360)
at org.mortbay.jetty.security.SecurityHandler.handle(SecurityHandler.java:216)
at org.mortbay.jetty.servlet.SessionHandler.handle(SessionHandler.java:181)
at org.mortbay.jetty.handler.ContextHandler.handle(ContextHandler.java:712)
at org.mortbay.jetty.webapp.WebAppContext.handle(WebAppContext.java:405)
at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:139)
at org.mortbay.jetty.Server.handle(Server.java:313)
at org.mortbay.jetty.HttpConnection.handleRequest(HttpConnection.java:506)
at org.mortbay.jetty.HttpConnection$RequestHandler.headerComplete(HttpConnection.java:830)
at org.mortbay.jetty.HttpParser.parseNext(HttpParser.java:514)
at org.mortbay.jetty.HttpParser.parseAvailable(HttpParser.java:211)
at org.mortbay.jetty.HttpConnection.handle(HttpConnection.java:381)
at org.mortbay.io.nio.SelectChannelEndPoint.run(SelectChannelEndPoint.java:396)
at org.mortbay.thread.BoundedThreadPool$PoolThread.run(BoundedThreadPool.java:442)
Caused by: org.postgresql.util.PSQLException: FEHLER: Spalte »session_key« existiert nicht
Position: 40
at org.postgresql.core.v3.QueryExecutorImpl.receiveErrorResponse(QueryExecutorImpl.java:2102)
at org.postgresql.core.v3.QueryExecutorImpl.processResults(QueryExecutorImpl.java:1835)
at org.postgresql.core.v3.QueryExecutorImpl.execute(QueryExecutorImpl.java:257)
at org.postgresql.jdbc2.AbstractJdbc2Statement.execute(AbstractJdbc2Statement.java:500)
at org.postgresql.jdbc2.AbstractJdbc2Statement.executeWithFlags(AbstractJdbc2Statement.java:388)
at org.postgresql.jdbc2.AbstractJdbc2Statement.executeQuery(AbstractJdbc2Statement.java:273)
at com.mchange.v2.c3p0.impl.NewProxyPreparedStatement.executeQuery(NewProxyPreparedStatement.java:446)
at org.springframework.jdbc.core.JdbcTemplate$1.doInPreparedStatement(JdbcTemplate.java:644)
at org.springframework.jdbc.core.JdbcTemplate.execute(JdbcTemplate.java:587)
... 68 more

[2012-09-05 22:50:05,862] DEBUG SecurityService - Load user munin

lines like you described i cannot find in the log... or is it the wrong log?

Tanks,

Pcace

EDIT: when i restart subsonic, the log looks like that:

ta

il: /var/subsonic/subsonic.log: Datei abgeschnitten
[2012-09-05 23:05:08,513] DEBUG DaoHelper - DAO Helper constructor.
[2012-09-05 23:05:08,537] DEBUG DaoHelper - Data source URL: jdbc:hsqldb:file:/var/subsonic/db/subsonic
[2012-09-05 23:05:08,537] INFO DaoHelper - Checking database schema.
[2012-09-05 23:05:09,958] INFO DaoHelper - Done checking database schema.
[2012-09-05 23:05:10,235] INFO VersionService - Resolved local Subsonic version to: 0.7
[2012-09-05 23:05:12,746] INFO SearchService - Automatic index creation scheduled to run every 1 day(s), starting at Thu Sep 06 04:00:00 CEST 2012
[2012-09-05 23:05:12,962] INFO PodcastService - Automatic Podcast update scheduled to run every 1 hour(s), starting at Wed Sep 05 23:10:12 CEST 2012
[2012-09-05 23:05:15,961] INFO NetworkService - Deleted port mapping for port 4040

[Pcace]

Sorry for all those long posts, but here is the log you are looking for (i think):

root@t64:/var/subsonic# cat subsonic_sh.log
58 [main] INFO org.springframework.context.support.ClassPathXmlApplicationContext - Refreshing org.springframework.context.support.ClassPathXmlApplicationContext@5e13ad: display name [org.springframework.context.support.ClassPathXmlApplicationContext@5e13ad]; startup date [Wed Sep 05 23:04:59 CEST 2012]; root of context hierarchy
211 [main] INFO org.springframework.beans.factory.xml.XmlBeanDefinitionReader - Loading XML bean definitions from class path resource [applicationContext-deployer.xml]
[GC 4416K->1112K(15872K), 0,0092750 secs]
[GC 5528K->1992K(15872K), 0,0055360 secs]
1134 [main] INFO org.springframework.context.support.ClassPathXmlApplicationContext - Bean factory for application context [org.springframework.context.support.ClassPathXmlApplicationContext@5e13ad]: org.springframework.beans.factory.support.DefaultListableBeanFactory@b172ef
1243 [main] INFO org.springframework.beans.factory.support.DefaultListableBeanFactory - Pre-instantiating singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@b172ef: defining beans [service,org.springframework.remoting.rmi.RmiServiceExporter#0]; root of factory hierarchy
[GC 6408K->2601K(15872K), 0,0058800 secs]
1367 [main] INFO org.mortbay.log - Logging to org.slf4j.impl.SimpleLogger(org.mortbay.log) via org.mortbay.log.Slf4jLog
Using WAR file: /usr/share/subsonic/subsonic.war
Extracting webapp to /var/subsonic/jetty/0.7.8
Using WAR file: /usr/share/subsonic/subsonic.war
1578 [main] INFO org.mortbay.log - jetty-6.1.x
[GC 7017K->3441K(15872K), 0,0093800 secs]
[GC 7857K->3683K(15872K), 0,0080560 secs]
[GC 8099K->3541K(15872K), 0,0018930 secs]
[GC 7957K->3547K(15872K), 0,0009780 secs]
6598 [main] INFO / - Initializing Spring root WebApplicationContext
6598 [main] INFO org.springframework.web.context.ContextLoader - Root WebApplicationContext: initialization started
[GC 7963K->4133K(15872K), 0,0030060 secs]
6902 [main] INFO org.springframework.web.context.support.XmlWebApplicationContext - Refreshing Root WebApplicationContext: startup date [Wed Sep 05 23:05:06 CEST 2012]; root of context hierarchy
[GC 8549K->4507K(15872K), 0,0035290 secs]
7101 [main] INFO org.springframework.beans.factory.xml.XmlBeanDefinitionReader - Loading XML bean definitions from ServletContext resource [/WEB-INF/applicationContext-service.xml]
[GC 8923K->5199K(15872K), 0,0070360 secs]
[GC 9615K->6083K(15872K), 0,0098160 secs]
7733 [main] INFO org.springframework.beans.factory.xml.XmlBeanDefinitionReader - Loading XML bean definitions from ServletContext resource [/WEB-INF/applicationContext-security.xml]
[GC 10499K->7153K(15872K), 0,0063910 secs]
7855 [main] INFO org.springframework.security.config.SecurityNamespaceHandler - Spring Security 'config' module version is 3.1.0.RELEASE
7928 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'permitAll' for /**
[GC 11569K->7613K(15872K), 0,0039670 secs]
7972 [main] INFO org.springframework.security.config.http.HttpSecurityBeanDefinitionParser - Checking sorted filter chain: [Root bean: class [org.springframework.security.web.context.SecurityContextPersistenceFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 300, <restRequestParameterProcessingFilter>, order = 601, Root bean: class [org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 1400, Root bean: class [org.springframework.security.web.authentication.AnonymousAuthenticationFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 1700, Root bean: class [org.springframework.security.web.access.ExceptionTranslationFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 1900, <org.springframework.security.web.access.intercept.FilterSecurityInterceptor#0>, order = 2000]
7990 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'permitAll' for /login.view
7990 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'permitAll' for /accessDenied.view
7990 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'permitAll' for /videoPlayer.view
7990 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'permitAll' for /coverArt.view
7990 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'permitAll' for /stream/**
7990 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'permitAll' for /share/**
7995 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'permitAll' for /style/**
7995 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'permitAll' for /icons/**
7995 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'permitAll' for /flash/**
7995 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'permitAll' for /script/**
7995 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'permitAll' for /crossdomain.xml
7995 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'hasRole('ROLE_SETTINGS')' for /personalSettings.view
7995 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'hasRole('ROLE_SETTINGS')' for /lastFmSettings.view
7996 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'hasRole('ROLE_SETTINGS')' for /passwordSettings.view
7996 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'hasRole('ROLE_SETTINGS')' for /playerSettings.view
7996 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'hasRole('ROLE_SETTINGS')' for /shareSettings.view
7996 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'hasRole('ROLE_ADMIN')' for /generalSettings.view
7996 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'hasRole('ROLE_ADMIN')' for /advancedSettings.view
7996 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'hasRole('ROLE_ADMIN')' for /userSettings.view
7999 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'hasRole('ROLE_ADMIN')' for /mediaFolderSettings.view
7999 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'hasRole('ROLE_ADMIN')' for /networkSettings.view
7999 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'hasRole('ROLE_ADMIN')' for /transcodingSettings.view
7999 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'hasRole('ROLE_ADMIN')' for /internetRadioSettings.view
7999 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'hasRole('ROLE_ADMIN')' for /searchSettings.view
7999 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'hasRole('ROLE_ADMIN')' for /musicCabinetSettings.view
7999 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'hasRole('ROLE_ADMIN')' for /podcastSettings.view
8002 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'hasRole('ROLE_ADMIN')' for /radioSettings.view
8002 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'hasRole('ROLE_ADMIN')' for /db.view
8002 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'hasRole('ROLE_PLAYLIST')' for /deletePlaylist.view
8002 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'hasRole('ROLE_PLAYLIST')' for /savePlaylist.view
8002 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'hasRole('ROLE_DOWNLOAD')' for /download.view
8002 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'hasRole('ROLE_UPLOAD')' for /upload.view
8002 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'hasRole('ROLE_SHARE')' for /createShare.view
8002 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'hasRole('ROLE_COVERART')' for /changeCoverArt.view
8003 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'hasRole('ROLE_COVERART')' for /editTags.view
8003 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'hasRole('ROLE_COVERART')' for /editArtist.view
8003 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'hasRole('ROLE_COMMENT')' for /setMusicFileInfo.view
8003 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'hasRole('ROLE_PODCAST')' for /podcastReceiverAdmin.view
8003 [main] INFO org.springframework.security.config.http.FilterInvocationSecurityMetadataSourceParser - Creating access control expression attribute 'hasRole('ROLE_STREAM')' for /*
8038 [main] INFO org.springframework.security.config.http.HttpSecurityBeanDefinitionParser - Checking sorted filter chain: [Root bean: class [org.springframework.security.web.context.SecurityContextPersistenceFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 300, Root bean: class [org.springframework.security.web.authentication.logout.LogoutFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 400, <org.springframework.security.web.authentication.UsernamePasswordAuthenticationFilter#0>, order = 800, Root bean: class [org.springframework.security.web.authentication.www.BasicAuthenticationFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 1200, Root bean: class [org.springframework.security.web.savedrequest.RequestCacheAwareFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 1300, Root bean: class [org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 1400, Root bean: class [org.springframework.security.web.authentication.rememberme.RememberMeAuthenticationFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 1600, Root bean: class [org.springframework.security.web.authentication.AnonymousAuthenticationFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 1700, Root bean: class [org.springframework.security.web.session.SessionManagementFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 1800, Root bean: class [org.springframework.security.web.access.ExceptionTranslationFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 1900, <org.springframework.security.web.access.intercept.FilterSecurityInterceptor#1>, order = 2000]
8055 [main] INFO org.springframework.beans.factory.xml.XmlBeanDefinitionReader - Loading XML bean definitions from ServletContext resource [/WEB-INF/applicationContext-cache.xml]
[GC 12029K->7859K(15872K), 0,0069840 secs]
[GC 12275K->8176K(15872K), 0,0079030 secs]
8617 [main] INFO org.springframework.jdbc.datasource.DriverManagerDataSource - Loaded JDBC driver: org.hsqldb.jdbcDriver
[GC 12592K->8376K(15872K), 0,0057330 secs]
[GC 12792K->9691K(15872K), 0,0111570 secs]
[GC 14091K->11636K(16128K), 0,0075260 secs]
[Full GC 11636K->6554K(16128K), 0,1349010 secs]
[GC 11034K->6844K(15936K), 0,0024540 secs]
9756 [main] INFO org.springframework.beans.factory.xml.XmlBeanDefinitionReader - Loading XML bean definitions from class path resource [org/springframework/jdbc/support/sql-error-codes.xml]
[GC 11324K->8070K(15936K), 0,0061380 secs]
10009 [main] INFO org.springframework.jdbc.support.SQLErrorCodesFactory - SQLErrorCodes loaded: [DB2, Derby, H2, HSQL, Informix, MS-SQL, MySQL, Oracle, PostgreSQL, Sybase]
[GC 12550K->8407K(15936K), 0,0048530 secs]
[GC 12887K->8546K(15936K), 0,0036770 secs]
10364 [main] INFO org.springframework.integration.config.xml.DefaultConfiguringBeanFactoryPostProcessor - No bean named 'errorChannel' has been explicitly defined. Therefore, a default PublishSubscribeChannel will be created.
10364 [main] INFO org.springframework.integration.config.xml.DefaultConfiguringBeanFactoryPostProcessor - No bean named 'taskScheduler' has been explicitly defined. Therefore, a default ThreadPoolTaskScheduler will be created.
10471 [main] INFO org.springframework.beans.factory.support.DefaultListableBeanFactory - Pre-instantiating singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@15735fd: defining beans [passwordEncoder,saltSource,playerDao,internetRadioDao,musicFileInfoDao,mediaFolderDao,userDao,transcodingDao,podcastDao,avatarDao,shareDao,daoHelper,audioScrobblerService,mediaFileService,securityService,settingsService,searchService,networkService,playerService,playlistService,versionService,statusService,musicInfoService,transcodingService,shareService,podcastService,jukeboxService,metaDataParserFactory,artistIndexService,ajaxMultiService,ajaxNowPlayingService,ajaxPlaylistService,ajaxLyricsService,ajaxCoverArtService,ajaxTagService,ajaxTransferService,ajaxChatService,ajaxLibraryStatusService,ajaxUIStarService,propertyConfigurer,taskExecutor,channelInitializer,$autoCreateChannelCandidates,org.springframework.integration.internalDefaultConfiguringBeanFactoryPostProcessor,libraryPresenceChannel,libraryMetadataChannel,libraryAdditionChannel,libraryDeletionChannel,scrobbleChannel,directoryBrowserService,starService,lastFmService,scrobbleService,databaseAdministrationService,libraryScannerService,libraryPresenceService,libraryMetadataService,libraryAdditionService,libraryBrowserService,audioTagService,libraryDeletionService,throttleService,artistInfoService,albumInfoService,artistRelationService,artistTopTracksService,artistTopTagsService,scrobbledTracksService,tagInfoService,userTopArtistsService,userRecommendedArtistsService,tagTopArtistsService,searchIndexUpdateSettingsService,webserviceHistoryService,tagService,nameSearchService,artistRecommendationService,searchIndexUpdateExecutorService,playlistGeneratorService,libraryUpdateService,updateNowPlayingClient,scrobbleClient,authSessionClient,radioPlaylistClient,artistInfoClient,albumInfoClient,artistSimilarityClient,artistTopTracksClient,artistTopTagsClient,trackSimilarityClient,scrobbledTracksClient,tagInfoClient,userTopArtistsClient,userRecommendedArtistsClient,tagTopArtistsClient,directoryBrowserDao,libraryPresenceDao,libraryAdditionDao,libraryDeletionDao,libraryBrowserDao,musicDao,starDao,playCountDao,trackPlayCountDao,webserviceHistoryDao,trackRelationDao,artistInfoDao,albumInfoDao,artistRelationDao,artistTopTracksDao,artistTopTagsDao,nameSearchDao,playlistGeneratorDao,artistRecommendationDao,tagDao,tagInfoDao,lastFmUserDao,userTopArtistsDao,userRecommendedArtistsDao,functionCountDao,databaseAdministrationDao,dataSource,initialDataSource,org.springframework.security.filterChains,org.springframework.security.filterChainProxy,org.springframework.security.web.PortMapperImpl#0,org.springframework.security.config.authentication.AuthenticationManagerFactoryBean#0,org.springframework.security.authentication.ProviderManager#0,org.springframework.security.web.context.NullSecurityContextRepository#0,org.springframework.security.web.savedrequest.NullRequestCache#0,org.springframework.security.web.access.expression.DefaultWebSecurityExpressionHandler#0,org.springframework.security.access.vote.AffirmativeBased#0,org.springframework.security.web.access.intercept.FilterSecurityInterceptor#0,org.springframework.security.web.access.DefaultWebInvocationPrivilegeEvaluator#0,org.springframework.security.authentication.AnonymousAuthenticationProvider#0,org.springframework.security.userDetailsServiceFactory,org.springframework.security.web.DefaultSecurityFilterChain#0,org.springframework.security.web.PortMapperImpl#1,org.springframework.security.config.authentication.AuthenticationManagerFactoryBean#1,org.springframework.security.authentication.ProviderManager#1,org.springframework.security.web.context.HttpSessionSecurityContextRepository#0,org.springframework.security.web.authentication.session.SessionFixationProtectionStrategy#0,org.springframework.security.web.savedrequest.HttpSessionRequestCache#0,org.springframework.security.web.access.expression.DefaultWebSecurityExpressionHandler#1,org.springframework.security.access.vote.AffirmativeBased#1,org.springframework.security.web.access.intercept.FilterSecurityInterceptor#1,org.springframework.security.web.access.DefaultWebInvocationPrivilegeEvaluator#1,org.springframework.security.authentication.AnonymousAuthenticationProvider#1,org.springframework.security.web.authentication.rememberme.TokenBasedRememberMeServices#0,org.springframework.security.authentication.RememberMeAuthenticationProvider#0,org.springframework.security.web.authentication.www.BasicAuthenticationEntryPoint#0,org.springframework.security.web.authentication.UsernamePasswordAuthenticationFilter#0,org.springframework.security.web.DefaultSecurityFilterChain#1,restRequestParameterProcessingFilter,restRequestEntryPoint,org.springframework.security.authentication.dao.DaoAuthenticationProvider#0,org.springframework.security.authentication.DefaultAuthenticationEventPublisher#0,org.springframework.security.authenticationManager,cacheManager,userCache,mediaFileCache,childDirCache,coverArtCache,musicFolderCache,chatCache,nullChannel,errorChannel,_org.springframework.integration.errorLogger,taskScheduler,org.springframework.integration.config.IdGeneratorConfigurer#0]; root of factory hierarchy
[GC 13026K->8843K(15936K), 0,0054530 secs]
[GC 13323K->9398K(15936K), 0,0124460 secs]
[GC 13878K->9873K(15936K), 0,0062090 secs]
[GC 14353K->10578K(15936K), 0,0057040 secs]
[GC 15058K->11053K(15936K), 0,0062860 secs]
[GC 15533K->11220K(15936K), 0,0067890 secs]
[GC 15700K->11357K(16064K), 0,0053010 secs]
[Full GC 11357K->9496K(16064K), 0,2015270 secs]
12011 [main] INFO org.springframework.cache.ehcache.EhCacheManagerFactoryBean - Initializing EHCache CacheManager
Sep 05, 2012 11:05:11 PM net.sf.ehcache.CacheManager addShutdownHookIfRequired
Information: The CacheManager shutdown hook is enabled because net.sf.ehcache.enableShutdownHook is set to true.
Sep 05, 2012 11:05:12 PM net.sf.ehcache.Cache initialise
Warnung: 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.
Sep 05, 2012 11:05:12 PM net.sf.ehcache.Cache initialise
Warnung: Cache: childDirCache 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.
[GC 15896K->10061K(22996K), 0,0041640 secs]
12279 [main] INFO org.springframework.scheduling.concurrent.ThreadPoolTaskExecutor - Initializing ExecutorService
[GC 16461K->10117K(22996K), 0,0110170 secs]
[GC 16517K->10299K(22996K), 0,0037920 secs]
[GC 16699K->10488K(22996K), 0,0046980 secs]
[GC 16888K->10629K(22996K), 0,0038460 secs]
[GC 17029K->11162K(22996K), 0,0061360 secs]
[GC 17562K->11528K(22996K), 0,0211730 secs]
[GC 17928K->11647K(22996K), 0,0052470 secs]
[GC 18047K->12964K(22996K), 0,0167970 secs]
Load version number 1012

[hakko]

Yes, that's it! 1012 was quite heavy, I wouldn't be surprised if that takes a couple of minutes to finish. Especially since you have a pretty big library. It's this one: https://github.com/hakko/musiccabinet/b ... p/1012.sql

I'd be surprised if it stops forever though. I think it would be worth waiting for, as it means you don't have to re-import a lot of artist data from last.fm. That's even slower for 120.000 songs.

[Pcace]

That means i simply have to wait? (sorry my english is not the best )


Thanks,

Pcace

[hakko]

Well give it fifteen minutes? I don't understand why it's so slow. If it stalls for longer than that, I guess you could just uninstall+install Postgresql and start from scratch and you shouldn't have these problems at all. Sorry for the inconvenience.

[Pcace]

hey, i just reinstalled postgres via: apt-get remove --purge postgresql && apt-get install postgresql. It seems nothing changed. the still happens nothing, and i still get the "Load version number 1012".

for me it looks like the database was never deleted. How can i do this?


Thanks,

Pcace

[hakko]

You could run the command psql -U postgres (psql is found in your postgres install dir/bin) and at the prompt that appears, type drop database musiccabinet; and press enter.

[Pcace]

Hey, thank you - that seems to work. But now i have an other Problem: there are houndreds of error messages in the subsonic_sh.log: http://pastebin.com/raw.php?i=in5BpNzT

When i open the site, i get a little popup with something like "error" (screenshot).

and i see the info page with the error:

Error
Subsonic encountered an internal error. You can report this error in the Subsonic Forum. Please include the information below.

Exception org.springframework.dao.EmptyResultDataAccessException
Message Incorrect result size: expected 1, actual 0
Java version Oracle Corporation 1.7.0_03
Operating system Linux 3.0.0-1-486
Server jetty-6.1.x
Memory Used 59 of 105 MB
Stack trace org.springframework.dao.EmptyResultDataAccessException: Incorrect result size: expected 1, actual 0
at org.springframework.dao.support.DataAccessUtils.requiredSingleResult(DataAccessUtils.java:71)
at org.springframework.jdbc.core.JdbcTemplate.queryForObject(JdbcTemplate.java:473)
at com.github.hakko.musiccabinet.dao.jdbc.JdbcArtistInfoDao.getArtistInfo(JdbcArtistInfoDao.java:73)
at com.github.hakko.musiccabinet.service.lastfm.ArtistInfoService.getArtistInfo(ArtistInfoService.java:35)
at net.sourceforge.subsonic.controller.ArtistController.setArtistInfo(ArtistController.java:132)
at net.sourceforge.subsonic.controller.ArtistController.handleRequestInternal(ArtistController.java:78)
at org.springframework.web.servlet.mvc.AbstractController.handleRequest(AbstractController.java:153)
at org.springframework.web.servlet.mvc.SimpleControllerHandlerAdapter.handle(SimpleControllerHandlerAdapter.java:48)
at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:900)
at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:827)
at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:882)
at org.springframework.web.servlet.FrameworkServlet.doGet(FrameworkServlet.java:778)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:820)
at org.mortbay.jetty.servlet.ServletHolder.handle(ServletHolder.java:487)
at org.mortbay.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1093)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:311)
at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.invoke(FilterSecurityInterceptor.java:116)
at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.doFilter(FilterSecurityInterceptor.java:83)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.access.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:113)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.session.SessionManagementFilter.doFilter(SessionManagementFilter.java:101)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.authentication.AnonymousAuthenticationFilter.doFilter(AnonymousAuthenticationFilter.java:113)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.authentication.rememberme.RememberMeAuthenticationFilter.doFilter(RememberMeAuthenticationFilter.java:146)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter.doFilter(SecurityContextHolderAwareRequestFilter.java:54)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.savedrequest.RequestCacheAwareFilter.doFilter(RequestCacheAwareFilter.java:45)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.authentication.www.BasicAuthenticationFilter.doFilter(BasicAuthenticationFilter.java:150)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.authentication.AbstractAuthenticationProcessingFilter.doFilter(AbstractAuthenticationProcessingFilter.java:182)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.authentication.logout.LogoutFilter.doFilter(LogoutFilter.java:105)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.context.SecurityContextPersistenceFilter.doFilter(SecurityContextPersistenceFilter.java:87)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:323)
at org.springframework.security.web.FilterChainProxy.doFilter(FilterChainProxy.java:173)
at org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:346)
at org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:259)
at org.mortbay.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1084)
at net.sourceforge.subsonic.filter.RequestEncodingFilter.doFilter(RequestEncodingFilter.java:43)
at org.mortbay.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1084)
at net.sourceforge.subsonic.filter.ParameterDecodingFilter.doFilter(ParameterDecodingFilter.java:54)
at org.mortbay.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1084)
at net.sourceforge.subsonic.filter.BootstrapVerificationFilter.doFilter(BootstrapVerificationFilter.java:54)
at org.mortbay.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1084)
at org.mortbay.jetty.servlet.ServletHandler.handle(ServletHandler.java:360)
at org.mortbay.jetty.security.SecurityHandler.handle(SecurityHandler.java:216)
at org.mortbay.jetty.servlet.SessionHandler.handle(SessionHandler.java:181)
at org.mortbay.jetty.handler.ContextHandler.handle(ContextHandler.java:712)
at org.mortbay.jetty.webapp.WebAppContext.handle(WebAppContext.java:405)
at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:139)
at org.mortbay.jetty.Server.handle(Server.java:313)
at org.mortbay.jetty.HttpConnection.handleRequest(HttpConnection.java:506)
at org.mortbay.jetty.HttpConnection$RequestHandler.headerComplete(HttpConnection.java:830)
at org.mortbay.jetty.HttpParser.parseNext(HttpParser.java:514)
at org.mortbay.jetty.HttpParser.parseAvailable(HttpParser.java:211)
at org.mortbay.jetty.HttpConnection.handle(HttpConnection.java:381)
at org.mortbay.io.nio.SelectChannelEndPoint.run(SelectChannelEndPoint.java:396)
at org.mortbay.thread.BoundedThreadPool$PoolThread.run(BoundedThreadPool.java:442)

[hakko]

Have you scanned your library? From Settings -> Media Folders -> Full scan

[Pcace]

Ah, does that have to be ready to get rid of the errors?


Pcace