DSM6: madsonic is contantly stopping music after some minute

Need help? Post your questions here.
User avatar
Matt Zornig
Contributor
Contributor
Posts: 242
Joined: 14 Feb 2017, 12:03
Has thanked: 38 times
Been thanked: 28 times

DSM6: madsonic is contantly stopping music after some minute

Unread post by Matt Zornig »

Hi,
because this is not happening all the time, I ask here, not in the bug forum.

Code: Select all

logged in as admin
Madsonic via package on a Synology  NAS, DSM6.x
Java: 1.8.0.102

    Version   MADSONIC 6.2.9080.619dd31.20161222.0327
    REST   MADSONIC REST API v2.5.0, SUBSONIC REST API v1.14.0
    Server   jetty/8.y.z-SNAPSHOT, java 1.8.0_102, Linux 3.10.77 (amd64) (196.4 MB / 476.5 MB)
       Size: Database: 915MB, Thumbs-Cache: 11MB, LastFM-Cache: 86MB, Lucene-Cache: 69MB
       Spring.Framework v3.2.17, Spring.Security v3.2.9, HyperSQL DataBase v2.3.4
madsonic is contantly stopping music after a few songs.
It "seems" mostly not to stop, when I'm working/clicking/doing things in the webinterface. It seems only to stop (within a song) playing when the browser (firefox, mac) is idle.

I also recognized, that the log was not written for more than 20 minutes. The Synology-Box CPU is normal, nothing special happening.
the log stopped at 2017-02-19 14:25
now the time is 2017-02-19 14:50

here is the log, where it happens at least 5 times and I had to manually start the next song from the queue.

Code: Select all

[2017-02-19 13:43:40,242] ERROR SearchService - Failed to execute Lucene search.
java.lang.NullPointerException
at org.madsonic.service.SearchService.search(SearchService.java:227)
at org.madsonic.controller.SearchController.onSubmit(SearchController.java:94)
at org.springframework.web.servlet.mvc.SimpleFormController.processFormSubmission(SimpleFormController.java:272)
at org.springframework.web.servlet.mvc.AbstractFormController.handleRequestInternal(AbstractFormController.java:268)
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:933)
at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:867)
at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:951)
at org.springframework.web.servlet.FrameworkServlet.doPost(FrameworkServlet.java:853)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:755)
at org.springframework.web.servlet.FrameworkServlet.service(FrameworkServlet.java:827)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:848)
at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:684)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1507)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.invoke(FilterSecurityInterceptor.java:118)
at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.doFilter(FilterSecurityInterceptor.java:84)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.access.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:113)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.session.SessionManagementFilter.doFilter(SessionManagementFilter.java:103)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.authentication.AnonymousAuthenticationFilter.doFilter(AnonymousAuthenticationFilter.java:113)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.authentication.rememberme.RememberMeAuthenticationFilter.doFilter(RememberMeAuthenticationFilter.java:146)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter.doFilter(SecurityContextHolderAwareRequestFilter.java:154)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.savedrequest.RequestCacheAwareFilter.doFilter(RequestCacheAwareFilter.java:45)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.authentication.AbstractAuthenticationProcessingFilter.doFilter(AbstractAuthenticationProcessingFilter.java:199)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.authentication.logout.LogoutFilter.doFilter(LogoutFilter.java:110)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.context.request.async.WebAsyncManagerIntegrationFilter.doFilterInternal(WebAsyncManagerIntegrationFilter.java:50)
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:106)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.context.SecurityContextPersistenceFilter.doFilter(SecurityContextPersistenceFilter.java:87)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.FilterChainProxy.doFilterInternal(FilterChainProxy.java:192)
at org.springframework.security.web.FilterChainProxy.doFilter(FilterChainProxy.java:160)
at org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:343)
at org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:260)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1495)
at org.madsonic.filter.RequestEncodingFilter.doFilter(RequestEncodingFilter.java:43)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1495)
at org.madsonic.filter.ParameterDecodingFilter.doFilter(ParameterDecodingFilter.java:54)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1495)
at org.madsonic.filter.BootstrapVerificationFilter.doFilter(BootstrapVerificationFilter.java:58)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1487)
at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:499)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:137)
at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:557)
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:231)
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1086)
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:427)
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:193)
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1020)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:135)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:116)
at org.eclipse.jetty.server.Server.handle(Server.java:370)
at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:494)
at org.eclipse.jetty.server.AbstractHttpConnection.content(AbstractHttpConnection.java:984)
at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.content(AbstractHttpConnection.java:1045)
at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:861)
at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:236)
at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:82)
at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:696)
at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:53)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
at java.lang.Thread.run(Thread.java:745)

[2017-02-19 13:44:21,663] INFO StreamController - admin is streaming CON "1983 - Havana Moon [LPA]/01. Carlos Santana - Watch Your Step.mp3"
[2017-02-19 13:45:00,835] ERROR SearchService - Failed to execute Lucene search.
java.lang.NullPointerException
at org.madsonic.service.SearchService.search(SearchService.java:227)
at org.madsonic.controller.SearchController.onSubmit(SearchController.java:94)
at org.springframework.web.servlet.mvc.SimpleFormController.processFormSubmission(SimpleFormController.java:272)
at org.springframework.web.servlet.mvc.AbstractFormController.handleRequestInternal(AbstractFormController.java:268)
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:933)
at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:867)
at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:951)
at org.springframework.web.servlet.FrameworkServlet.doPost(FrameworkServlet.java:853)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:755)
at org.springframework.web.servlet.FrameworkServlet.service(FrameworkServlet.java:827)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:848)
at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:684)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1507)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.invoke(FilterSecurityInterceptor.java:118)
at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.doFilter(FilterSecurityInterceptor.java:84)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.access.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:113)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.session.SessionManagementFilter.doFilter(SessionManagementFilter.java:103)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.authentication.AnonymousAuthenticationFilter.doFilter(AnonymousAuthenticationFilter.java:113)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.authentication.rememberme.RememberMeAuthenticationFilter.doFilter(RememberMeAuthenticationFilter.java:146)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter.doFilter(SecurityContextHolderAwareRequestFilter.java:154)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.savedrequest.RequestCacheAwareFilter.doFilter(RequestCacheAwareFilter.java:45)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.authentication.AbstractAuthenticationProcessingFilter.doFilter(AbstractAuthenticationProcessingFilter.java:199)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.authentication.logout.LogoutFilter.doFilter(LogoutFilter.java:110)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.context.request.async.WebAsyncManagerIntegrationFilter.doFilterInternal(WebAsyncManagerIntegrationFilter.java:50)
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:106)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.context.SecurityContextPersistenceFilter.doFilter(SecurityContextPersistenceFilter.java:87)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.FilterChainProxy.doFilterInternal(FilterChainProxy.java:192)
at org.springframework.security.web.FilterChainProxy.doFilter(FilterChainProxy.java:160)
at org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:343)
at org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:260)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1495)
at org.madsonic.filter.RequestEncodingFilter.doFilter(RequestEncodingFilter.java:43)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1495)
at org.madsonic.filter.ParameterDecodingFilter.doFilter(ParameterDecodingFilter.java:54)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1495)
at org.madsonic.filter.BootstrapVerificationFilter.doFilter(BootstrapVerificationFilter.java:58)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1487)
at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:499)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:137)
at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:557)
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:231)
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1086)
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:427)
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:193)
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1020)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:135)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:116)
at org.eclipse.jetty.server.Server.handle(Server.java:370)
at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:494)
at org.eclipse.jetty.server.AbstractHttpConnection.content(AbstractHttpConnection.java:984)
at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.content(AbstractHttpConnection.java:1045)
at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:861)
at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:236)
at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:82)
at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:696)
at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:53)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
at java.lang.Thread.run(Thread.java:745)

[2017-02-19 13:47:28,201] INFO MediaScannerService - Automatic media scanning disabled.
[2017-02-19 13:48:33,490] INFO StreamController - admin is streaming CON "1983 - Havana Moon [LPA]/02. Carlos Santana - Lightnin'.mp3"
[2017-02-19 13:49:07,690] ERROR SearchService - Failed to execute Lucene search.
java.lang.NullPointerException
at org.madsonic.service.SearchService.search(SearchService.java:227)
at org.madsonic.controller.SearchController.onSubmit(SearchController.java:94)
at org.springframework.web.servlet.mvc.SimpleFormController.processFormSubmission(SimpleFormController.java:272)
at org.springframework.web.servlet.mvc.AbstractFormController.handleRequestInternal(AbstractFormController.java:268)
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:933)
at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:867)
at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:951)
at org.springframework.web.servlet.FrameworkServlet.doPost(FrameworkServlet.java:853)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:755)
at org.springframework.web.servlet.FrameworkServlet.service(FrameworkServlet.java:827)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:848)
at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:684)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1507)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.invoke(FilterSecurityInterceptor.java:118)
at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.doFilter(FilterSecurityInterceptor.java:84)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.access.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:113)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.session.SessionManagementFilter.doFilter(SessionManagementFilter.java:103)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.authentication.AnonymousAuthenticationFilter.doFilter(AnonymousAuthenticationFilter.java:113)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.authentication.rememberme.RememberMeAuthenticationFilter.doFilter(RememberMeAuthenticationFilter.java:146)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter.doFilter(SecurityContextHolderAwareRequestFilter.java:154)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.savedrequest.RequestCacheAwareFilter.doFilter(RequestCacheAwareFilter.java:45)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.authentication.AbstractAuthenticationProcessingFilter.doFilter(AbstractAuthenticationProcessingFilter.java:199)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.authentication.logout.LogoutFilter.doFilter(LogoutFilter.java:110)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.context.request.async.WebAsyncManagerIntegrationFilter.doFilterInternal(WebAsyncManagerIntegrationFilter.java:50)
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:106)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.context.SecurityContextPersistenceFilter.doFilter(SecurityContextPersistenceFilter.java:87)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.FilterChainProxy.doFilterInternal(FilterChainProxy.java:192)
at org.springframework.security.web.FilterChainProxy.doFilter(FilterChainProxy.java:160)
at org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:343)
at org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:260)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1495)
at org.madsonic.filter.RequestEncodingFilter.doFilter(RequestEncodingFilter.java:43)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1495)
at org.madsonic.filter.ParameterDecodingFilter.doFilter(ParameterDecodingFilter.java:54)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1495)
at org.madsonic.filter.BootstrapVerificationFilter.doFilter(BootstrapVerificationFilter.java:58)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1487)
at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:499)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:137)
at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:557)
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:231)
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1086)
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:427)
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:193)
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1020)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:135)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:116)
at org.eclipse.jetty.server.Server.handle(Server.java:370)
at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:494)
at org.eclipse.jetty.server.AbstractHttpConnection.content(AbstractHttpConnection.java:984)
at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.content(AbstractHttpConnection.java:1045)
at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:861)
at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:236)
at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:82)
at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:696)
at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:53)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
at java.lang.Thread.run(Thread.java:745)

[2017-02-19 13:51:13,647] INFO MediaScannerService - Automatic media scanning disabled.
[2017-02-19 13:51:54,588] INFO MediaScannerService - Automatic media scanning disabled.
[2017-02-19 13:52:35,260] INFO StreamController - admin is streaming CON "1983 - Havana Moon [LPA]/03. Carlos Santana - Who Do You Love.mp3"
[2017-02-19 13:54:27,939] INFO MediaScannerService - Automatic media scanning disabled.
[2017-02-19 13:55:40,364] INFO StreamController - admin is streaming CON "1983 - Havana Moon [LPA]/04. Carlos Santana - Mudbone.mp3"
[2017-02-19 13:57:54,552] INFO StreamController - admin is streaming CON "1983 - Havana Moon [LPA]/05. Carlos Santana - One With You.mp3"
[2017-02-19 13:59:46,754] ERROR SearchService - Failed to execute Lucene search.
java.lang.NullPointerException
at org.madsonic.service.SearchService.search(SearchService.java:227)
at org.madsonic.controller.SearchController.onSubmit(SearchController.java:94)
at org.springframework.web.servlet.mvc.SimpleFormController.processFormSubmission(SimpleFormController.java:272)
at org.springframework.web.servlet.mvc.AbstractFormController.handleRequestInternal(AbstractFormController.java:268)
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:933)
at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:867)
at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:951)
at org.springframework.web.servlet.FrameworkServlet.doPost(FrameworkServlet.java:853)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:755)
at org.springframework.web.servlet.FrameworkServlet.service(FrameworkServlet.java:827)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:848)
at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:684)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1507)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.invoke(FilterSecurityInterceptor.java:118)
at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.doFilter(FilterSecurityInterceptor.java:84)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.access.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:113)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.session.SessionManagementFilter.doFilter(SessionManagementFilter.java:103)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.authentication.AnonymousAuthenticationFilter.doFilter(AnonymousAuthenticationFilter.java:113)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.authentication.rememberme.RememberMeAuthenticationFilter.doFilter(RememberMeAuthenticationFilter.java:146)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter.doFilter(SecurityContextHolderAwareRequestFilter.java:154)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.savedrequest.RequestCacheAwareFilter.doFilter(RequestCacheAwareFilter.java:45)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.authentication.AbstractAuthenticationProcessingFilter.doFilter(AbstractAuthenticationProcessingFilter.java:199)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.authentication.logout.LogoutFilter.doFilter(LogoutFilter.java:110)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.context.request.async.WebAsyncManagerIntegrationFilter.doFilterInternal(WebAsyncManagerIntegrationFilter.java:50)
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:106)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.context.SecurityContextPersistenceFilter.doFilter(SecurityContextPersistenceFilter.java:87)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.FilterChainProxy.doFilterInternal(FilterChainProxy.java:192)
at org.springframework.security.web.FilterChainProxy.doFilter(FilterChainProxy.java:160)
at org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:343)
at org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:260)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1495)
at org.madsonic.filter.RequestEncodingFilter.doFilter(RequestEncodingFilter.java:43)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1495)
at org.madsonic.filter.ParameterDecodingFilter.doFilter(ParameterDecodingFilter.java:54)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1495)
at org.madsonic.filter.BootstrapVerificationFilter.doFilter(BootstrapVerificationFilter.java:58)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1487)
at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:499)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:137)
at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:557)
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:231)
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1086)
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:427)
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:193)
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1020)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:135)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:116)
at org.eclipse.jetty.server.Server.handle(Server.java:370)
at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:494)
at org.eclipse.jetty.server.AbstractHttpConnection.content(AbstractHttpConnection.java:984)
at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.content(AbstractHttpConnection.java:1045)
at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:861)
at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:236)
at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:82)
at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:696)
at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:53)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
at java.lang.Thread.run(Thread.java:745)

[2017-02-19 14:03:18,188] INFO StreamController - admin is streaming CON "1983 - Havana Moon [LPA]/06. Carlos Santana - Ecuador.mp3"
[2017-02-19 14:04:34,471] INFO StreamController - admin is streaming CON "1983 - Havana Moon [LPA]/07. Carlos Santana - Tales Of Kilimanjaro.mp3"
[2017-02-19 14:06:23,283] INFO MediaScannerService - Automatic media scanning disabled.
[2017-02-19 14:09:27,220] INFO StreamController - admin is streaming CON "1983 - Havana Moon [LPA]/08. Carlos Santana - Havana Moon.mp3"
[2017-02-19 14:10:00,468] INFO MediaScannerService - Automatic media scanning disabled.
[2017-02-19 14:11:34,112] ERROR SearchService - Failed to execute Lucene search.
java.lang.NullPointerException
at org.madsonic.service.SearchService.search(SearchService.java:227)
at org.madsonic.controller.SearchController.onSubmit(SearchController.java:94)
at org.springframework.web.servlet.mvc.SimpleFormController.processFormSubmission(SimpleFormController.java:272)
at org.springframework.web.servlet.mvc.AbstractFormController.handleRequestInternal(AbstractFormController.java:268)
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:933)
at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:867)
at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:951)
at org.springframework.web.servlet.FrameworkServlet.doPost(FrameworkServlet.java:853)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:755)
at org.springframework.web.servlet.FrameworkServlet.service(FrameworkServlet.java:827)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:848)
at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:684)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1507)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:330)
at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.invoke(FilterSecurityInterceptor.java:118)
at org.springframework.security.web.access.intercept.FilterSecurityInterceptor.doFilter(FilterSecurityInterceptor.java:84)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.access.ExceptionTranslationFilter.doFilter(ExceptionTranslationFilter.java:113)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.session.SessionManagementFilter.doFilter(SessionManagementFilter.java:103)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.authentication.AnonymousAuthenticationFilter.doFilter(AnonymousAuthenticationFilter.java:113)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.authentication.rememberme.RememberMeAuthenticationFilter.doFilter(RememberMeAuthenticationFilter.java:146)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter.doFilter(SecurityContextHolderAwareRequestFilter.java:154)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.savedrequest.RequestCacheAwareFilter.doFilter(RequestCacheAwareFilter.java:45)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.authentication.AbstractAuthenticationProcessingFilter.doFilter(AbstractAuthenticationProcessingFilter.java:199)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.authentication.logout.LogoutFilter.doFilter(LogoutFilter.java:110)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.context.request.async.WebAsyncManagerIntegrationFilter.doFilterInternal(WebAsyncManagerIntegrationFilter.java:50)
at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:106)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.context.SecurityContextPersistenceFilter.doFilter(SecurityContextPersistenceFilter.java:87)
at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
at org.springframework.security.web.FilterChainProxy.doFilterInternal(FilterChainProxy.java:192)
at org.springframework.security.web.FilterChainProxy.doFilter(FilterChainProxy.java:160)
at org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:343)
at org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:260)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1495)
at org.madsonic.filter.RequestEncodingFilter.doFilter(RequestEncodingFilter.java:43)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1495)
at org.madsonic.filter.ParameterDecodingFilter.doFilter(ParameterDecodingFilter.java:54)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1495)
at org.madsonic.filter.BootstrapVerificationFilter.doFilter(BootstrapVerificationFilter.java:58)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1487)
at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:499)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:137)
at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:557)
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:231)
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1086)
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:427)
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:193)
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1020)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:135)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:116)
at org.eclipse.jetty.server.Server.handle(Server.java:370)
at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:494)
at org.eclipse.jetty.server.AbstractHttpConnection.content(AbstractHttpConnection.java:984)
at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.content(AbstractHttpConnection.java:1045)
at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:861)
at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:236)
at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:82)
at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:696)
at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:53)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
at java.lang.Thread.run(Thread.java:745)

[2017-02-19 14:11:43,231] INFO StreamController - admin is streaming CON "1983 - Havana Moon [LPA]/09. Carlos Santana - Daughter Of The Night.mp3"
[2017-02-19 14:16:06,469] INFO StreamController - admin is streaming CON "1983 - Havana Moon [LPA]/10. Carlos Santana - They All Went To Mexico.mp3"
[2017-02-19 14:17:02,328] INFO StreamController - admin is streaming CON "1988 - Viva Santana! [CDA]/0101. Santana - Everybodys Everything.mp3"
[2017-02-19 14:20:34,796] INFO StreamController - admin is streaming CON "1988 - Viva Santana! [CDA]/0102. Santana - Black Magic Woman - Gypsy Queen.mp3"
[2017-02-19 14:25:56,167] INFO StreamController - admin is streaming CON "1988 - Viva Santana! [CDA]/0103. Santana - Guajira.mp3"

after loging out and in again (at 14:51), this was written to the log:
so it seems, the log does not cover the reasons of stopping the playing.
(here the songs all stopped and were manually started again)

Code: Select all

2017-02-19 14:35:13,641] INFO StreamController - admin is streaming CON "1988 - Viva Santana! [CDA]/0104. Santana - Jungle Strut (Live).mp3"
[2017-02-19 14:37:04,248] INFO StreamController - admin is streaming CON "1988 - Viva Santana! [CDA]/0105. Santana - Jingo.mp3"
[2017-02-19 14:37:11,867] INFO StreamController - admin is streaming CON "1988 - Viva Santana! [CDA]/0104. Santana - Jungle Strut (Live).mp3"
[2017-02-19 14:37:46,941] INFO StreamController - admin is streaming CON "1988 - Viva Santana! [CDA]/0104. Santana - Jungle Strut (Live).mp3"
[2017-02-19 14:38:15,518] INFO StreamController - admin is streaming CON "1988 - Viva Santana! [CDA]/0105. Santana - Jingo.mp3"
[2017-02-19 14:42:31,136] INFO StreamController - admin is streaming CON "1988 - Viva Santana! [CDA]/0106. Santana - Ballin (Unreleased).mp3"
[2017-02-19 14:43:30,563] INFO StreamController - admin is streaming CON "1988 - Viva Santana! [CDA]/0105. Santana - Jingo.mp3"
[2017-02-19 14:47:45,263] INFO StreamController - admin is streaming CON "1988 - Viva Santana! [CDA]/0106. Santana - Ballin (Unreleased).mp3"

after stoping and restarting the madsonic package via the packetmanager of my synology, this is the in the log:

(there are a lot of stranges chars in the log, which I stripped...)

Code: Select all

[2017-02-17 15:29:58,309] WARN HsqlDaoHelper - Checking database schema b.servletapi.SecurityContextHolderAwareRequestFilter.doFilter(SecurityContextHolderAwareRequestFilter.java:154)
	at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
	at org.springframework.security.web.savedrequest.RequestCacheAwareFilter.doFilter(RequestCacheAwareFilter.java:45)
	at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
	at org.springframework.security.web.authentication.AbstractAuthenticationProcessingFilter.doFilter(AbstractAuthenticationProcessingFilter.java:199)
	at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
	at org.springframework.security.web.authentication.logout.LogoutFilter.doFilter(LogoutFilter.java:110)
	at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
	at org.springframework.security.web.context.request.async.WebAsyncManagerIntegrationFilter.doFilterInternal(WebAsyncManagerIntegrationFilter.java:50)
	at org.springframework.web.filter.OncePerRequestFilter.doFilter(OncePerRequestFilter.java:106)
	at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
	at org.springframework.security.web.context.SecurityContextPersistenceFilter.doFilter(SecurityContextPersistenceFilter.java:87)
	at org.springframework.security.web.FilterChainProxy$VirtualFilterChain.doFilter(FilterChainProxy.java:342)
	at org.springframework.security.web.FilterChainProxy.doFilterInternal(FilterChainProxy.java:192)
	at org.springframework.security.web.FilterChainProxy.doFilter(FilterChainProxy.java:160)
	at org.springframework.web.filter.DelegatingFilterProxy.invokeDelegate(DelegatingFilterProxy.java:343)
	at org.springframework.web.filter.DelegatingFilterProxy.doFilter(DelegatingFilterProxy.java:260)
	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1495)
	at org.madsonic.filter.RequestEncodingFilter.doFilter(RequestEncodingFilter.java:43)
	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1495)
	at org.madsonic.filter.ParameterDecodingFilter.doFilter(ParameterDecodingFilter.java:54)
	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1495)
	at org.madsonic.filter.BootstrapVerificationFilter.doFilter(BootstrapVerificationFilter.java:58)
	at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1487)
	at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:499)
	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:137)
	at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:557)
	at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:231)
	at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1086)
	at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:427)
	at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:193)
	at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1020)
	at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:135)
	at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:116)
	at org.eclipse.jetty.server.Server.handle(Server.java:370)
	at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:494)
	at org.eclipse.jetty.server.AbstractHttpConnection.content(AbstractHttpConnection.java:984)
	at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.content(AbstractHttpConnection.java:1045)
	at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:861)
	at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:236)
	at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:82)
	at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:696)
	at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:53)
	at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
	at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
	at java.lang.Thread.run(Thread.java:745)

 

In case, its a Java thing...
here is my java packet on the synology:
java8 install path/version
java8 install path/version
java8 package
java8 package
User avatar
Madsonic
Administrator
Administrator
Posts: 984
Joined: 07 Dec 2012, 03:58
Answers: 7
Has thanked: 1201 times
Been thanked: 470 times

Re: DSM6: madsonic is contantly stopping music after some mi

Unread post by Madsonic »

Hi there,

can you report more of your used Synology model, architecture and firmware version.

Please upgrade your Java installation to latest build 1.8.121

http://www.oracle.com/technetwork/java/ ... 33151.html
dsm.png
Depending on your log, it seams your search index is corrupt.
Make a service restart and do a full mediascan and wait until it's finish.

best regards
User avatar
Matt Zornig
Contributor
Contributor
Posts: 242
Joined: 14 Feb 2017, 12:03
Has thanked: 38 times
Been thanked: 28 times

Re: DSM6: madsonic is contantly stopping music after some mi

Unread post by Matt Zornig »

Thanks,
Madevil wrote:can you report more of your used Synology model, architecture and firmware version.
I put that into my signature, but it seems its not displayed. So here it is:

Code: Select all

Madsonic 6.2.x
on a Synology NAS 1815+ (INTEL Atom C2538, 2.4 GHz, 6GB RAM), DSM 6.0.2-8451 Update 9
used on a MacBookPro w/ OSX Mavericks, and a Mac Pro Quad Core w/ OS Windows7 64Bit via FireFox Browser 51.x
Kodi 16.1 on RP2-ARM, 2GB RAM, OpenElec 7.0.1
More info here: https://www.synology.com//products/DS1815+
Madevil wrote:Please upgrade your Java installation to latest build 1.8.121
done.
Madevil wrote:Depending on your log, it seams your search index is corrupt.
Make a service restart and do a full mediascan and wait until it's finish.
I assume, you're talking about this option, and I clicked it:
fullrescan.png
fullrescan.png (3.65 KiB) Viewed 5530 times
Now I cannot listen to the music anymore, is this a desired behaviour?

The statistics says the music is still there
stats.png
stats.png (6.46 KiB) Viewed 5530 times
but search-function is not giving any results, nor does the "random"-function.

"The media folder is now being scanned. Some features are not available."
Does "some features" include playing music?

I guess, I need to wait 2-3 days. The initial scan took that long too.

EDIT:

Well,
according to the log, the scan has finished.
"[2017-02-20 15:35:31,669] INFO MediaScannerService - Completed media library scan."

Unfortunately no music was scanned, but deleted, and now I sit here with an empty Madsonic. :-)

The Log (after a service restart and clicking the above rescan-method):
Your message contains 69631 characters. The maximum number of allowed characters is 60000.

Maybe this post (lucene search? what is it good for?) is related?
User avatar
Madsonic
Administrator
Administrator
Posts: 984
Joined: 07 Dec 2012, 03:58
Answers: 7
Has thanked: 1201 times
Been thanked: 470 times

Re: DSM6: madsonic is contantly stopping music after some mi

Unread post by Madsonic »

We suggest to start from scratch and doing a step by step installation to identify other issues:

1. stop Madsonic service
2. connect via ssh to your Synology
3. cleanup existing data on your installed volume:
*) cd /volume1/@appstore/Madsonic
*) rm -R db/
*) rm -R jetty/
*) rm -R thumbs/
*) rm -R lucene30/
4. now you have a new starting base to configure
5. start Madsonic service
6. login as user admin
7. configure for testing only one mediafolder: Settings > Media Folder
*) /volume1/media/Artists/A
8. activate the "Fast scan" option to speedup access
9. click save to commit and a prescan starts immediately (with no index!)
10. on the Left Panel or in the Home Frame you can see if the system is still scanning
11. after the prescan you can start the normal scan with indexing: Settings > Admin Panel -> Scan all media folders now
12. after finishing indexing you should be able to scan through your new added mediafiles

TYI: The Lucene Search Index is used to build more complex search queries, without it Madsonic doesn't work as expected.

Best regards
User avatar
Matt Zornig
Contributor
Contributor
Posts: 242
Joined: 14 Feb 2017, 12:03
Has thanked: 38 times
Been thanked: 28 times

Re: DSM6: madsonic is contantly stopping music after some mi

Unread post by Matt Zornig »

Thank you for your detailled assistance!

Thats exactly the same way, I did after the initial install of madsonic. (just added one folder to take a look if madsonic is capable the amount of files....)

I now did as you suggested and it seems to work/scan as it did the first time before I added the rest of the media folders.
I'll take a look when its finished, test it and add the other folders then.

in the meantime, I recorded a video of the funny rotating circle, which makes me kinda nervous ;-)
dunny why, the rotating circle in the left frame looks not infected by a desease...
(Its a ZIP including two AVIs)
User avatar
Matt Zornig
Contributor
Contributor
Posts: 242
Joined: 14 Feb 2017, 12:03
Has thanked: 38 times
Been thanked: 28 times

Re: DSM6: madsonic is contantly stopping music after some mi

Unread post by Matt Zornig »

I still have the " Fast access mode " activated.

Everything went ok with one single mediafolder included.
Then I added 6 more and it was ok too.
Then I added the remaining 20 mediafolders and the scan was going on. (counting and updating the statistic in the webgui)

Then it suddenly stoped scanning at:

Statistic
4,920 all artists
601 album artists
929 albums
0 genres
13,441 songs
0 videos
0 podcasts
0 audiobooks
102.46 GB (~ 948 hours)

Here are the last lines of the log:

Code: Select all

[2017-02-21 04:27:29,905] INFO MediaScannerService - Scanned media library with 156500 entries.
[2017-02-21 04:28:21,956] INFO MediaScannerService - Scanned media library with 157000 entries.
[2017-02-21 04:29:24,806] INFO MediaScannerService - Scanned media library with 157500 entries.
[2017-02-21 04:30:30,215] INFO MediaScannerService - Scanned media library with 158000 entries.
[2017-02-21 04:31:24,741] INFO MediaScannerService - Scanned media library with 158500 entries.
[2017-02-21 04:32:09,334] INFO MusicFolderTasksDao - Created task for folder 5
[2017-02-21 04:35:06,413] WARN JaudiotaggerParser - Error when parsing tags in /volume1/Maya/Klangschale/E/Etienne Daho/1994 - Epaule Tattoo/02. Etienne Daho - Epaule Tattoo (William Orbit Instrumental).mpc No Reader associated with this extension:mpc
org.jaudiotagger.audio.exceptions.CannotReadException: No Reader associated with this extension:mpc
	at org.jaudiotagger.audio.AudioFileIO.readFile(AudioFileIO.java:285)
	at org.jaudiotagger.audio.AudioFileIO.read(AudioFileIO.java:151)
	at org.madsonic.service.metadata.JaudiotaggerParser.getRawMetaData(JaudiotaggerParser.java:110)
	at org.madsonic.service.metadata.MetaDataParser.getMetaData(MetaDataParser.java:48)
	at org.madsonic.service.MediaFileService.createMediaFile(MediaFileService.java:1149)
	at org.madsonic.service.MediaFileService.updateChildren(MediaFileService.java:729)
	at org.madsonic.service.MediaFileService.getChildrenOf(MediaFileService.java:330)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:418)
	at org.madsonic.service.MediaScannerService.doFolderScanLibrary(MediaScannerService.java:282)
	at org.madsonic.service.MediaScannerService.access$000(MediaScannerService.java:51)
	at org.madsonic.service.MediaScannerService$3.run(MediaScannerService.java:178)

[2017-02-21 04:37:10,965] INFO MediaScannerService - Scanned media library with 159000 entries.
[2017-02-21 04:37:55,128] INFO MediaScannerService - Scanned media library with 159500 entries.
[2017-02-21 04:38:48,199] INFO MediaScannerService - Scanned media library with 160000 entries.
[2017-02-21 04:39:51,122] INFO MediaScannerService - Scanned media library with 160500 entries.
[2017-02-21 04:40:49,486] INFO MediaScannerService - Scanned media library with 161000 entries.
[2017-02-21 04:41:51,149] INFO MediaScannerService - Scanned media library with 161500 entries.
[2017-02-21 04:43:21,694] INFO MediaScannerService - Scanned media library with 162000 entries.
[2017-02-21 04:44:14,611] INFO MediaScannerService - Scanned media library with 162500 entries.
[2017-02-21 04:45:07,144] INFO MediaScannerService - Scanned media library with 163000 entries.
[2017-02-21 04:46:03,913] INFO MediaScannerService - Scanned media library with 163500 entries.
[2017-02-21 04:47:17,274] INFO MediaScannerService - Scanned media library with 164000 entries.
[2017-02-21 04:48:08,854] INFO MediaScannerService - Scanned media library with 164500 entries.
[2017-02-21 04:48:40,519] INFO MediaScannerService - Scanned media library with 165000 entries.
[2017-02-21 04:49:32,953] INFO MediaScannerService - Scanned media library with 165500 entries.
[2017-02-21 04:50:17,555] INFO MediaScannerService - Scanned media library with 166000 entries.
[2017-02-21 04:51:20,026] INFO MediaScannerService - Scanned media library with 166500 entries.
[2017-02-21 04:52:11,068] INFO MediaScannerService - Scanned media library with 167000 entries.
[2017-02-21 04:53:55,694] INFO MediaScannerService - Scanned media library with 167500 entries.
[2017-02-21 04:54:28,218] INFO MediaScannerService - Scanned media library with 168000 entries.
[2017-02-21 04:55:11,610] INFO MediaScannerService - Scanned media library with 168500 entries.
[2017-02-21 04:56:01,973] INFO MediaScannerService - Scanned media library with 169000 entries.
[2017-02-21 04:56:08,841] WARN JaudiotaggerParser - Error when parsing tags in /volume1/Maya/Klangschale/E/Einstürzende Neubauten/1995 - Haus Der Lüge [CDA+RE]/101. Einstürzende Neubauten - Prolog.mpc No Reader associated with this extension:mpc
org.jaudiotagger.audio.exceptions.CannotReadException: No Reader associated with this extension:mpc
	at org.jaudiotagger.audio.AudioFileIO.readFile(AudioFileIO.java:285)
	at org.jaudiotagger.audio.AudioFileIO.read(AudioFileIO.java:151)
	at org.madsonic.service.metadata.JaudiotaggerParser.getRawMetaData(JaudiotaggerParser.java:110)
	at org.madsonic.service.metadata.MetaDataParser.getMetaData(MetaDataParser.java:48)
	at org.madsonic.service.MediaFileService.createMediaFile(MediaFileService.java:1046)
	at org.madsonic.service.MediaFileService.updateChildren(MediaFileService.java:729)
	at org.madsonic.service.MediaFileService.getChildrenOf(MediaFileService.java:330)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:418)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:422)
	at org.madsonic.service.MediaScannerService.doFolderScanLibrary(MediaScannerService.java:282)
	at org.madsonic.service.MediaScannerService.access$000(MediaScannerService.java:51)
	at org.madsonic.service.MediaScannerService$3.run(MediaScannerService.java:178)

[2017-02-21 04:56:08,850] WARN JaudiotaggerParser - Error when parsing tags in /volume1/Maya/Klangschale/E/Einstürzende Neubauten/1995 - Haus Der Lüge [CDA+RE]/101. Einstürzende Neubauten - Prolog.mpc No Reader associated with this extension:mpc
org.jaudiotagger.audio.exceptions.CannotReadException: No Reader associated with this extension:mpc
	at org.jaudiotagger.audio.AudioFileIO.readFile(AudioFileIO.java:285)
	at org.jaudiotagger.audio.AudioFileIO.read(AudioFileIO.java:151)
	at org.madsonic.service.metadata.JaudiotaggerParser.getRawMetaData(JaudiotaggerParser.java:110)
	at org.madsonic.service.metadata.MetaDataParser.getMetaData(MetaDataParser.java:48)
	at org.madsonic.service.MediaFileService.createMediaFile(MediaFileService.java:911)
	at org.madsonic.service.MediaFileService.getMediaFile(MediaFileService.java:144)
	at org.madsonic.service.MediaFileService.getMediaFile(MediaFileService.java:110)
	at org.madsonic.service.MediaFileService.findCoverArt(MediaFileService.java:1520)
	at org.madsonic.service.MediaFileService.createMediaFile(MediaFileService.java:1117)
	at org.madsonic.service.MediaFileService.updateChildren(MediaFileService.java:729)
	at org.madsonic.service.MediaFileService.getChildrenOf(MediaFileService.java:330)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:418)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:422)
	at org.madsonic.service.MediaScannerService.doFolderScanLibrary(MediaScannerService.java:282)
	at org.madsonic.service.MediaScannerService.access$000(MediaScannerService.java:51)
	at org.madsonic.service.MediaScannerService$3.run(MediaScannerService.java:178)

[2017-02-21 04:56:08,894] WARN JaudiotaggerParser - Failed to find cover art tag in 101. Einstürzende Neubauten - Prolog
org.jaudiotagger.audio.exceptions.CannotReadException: No Reader associated with this extension:mpc
	at org.jaudiotagger.audio.AudioFileIO.readFile(AudioFileIO.java:285)
	at org.jaudiotagger.audio.AudioFileIO.read(AudioFileIO.java:151)
	at org.madsonic.service.metadata.JaudiotaggerParser.getArtwork(JaudiotaggerParser.java:569)
	at org.madsonic.service.metadata.JaudiotaggerParser.isImageAvailable(JaudiotaggerParser.java:546)
	at org.madsonic.service.MediaFileService.findCoverArt(MediaFileService.java:1520)
	at org.madsonic.service.MediaFileService.createMediaFile(MediaFileService.java:1117)
	at org.madsonic.service.MediaFileService.updateChildren(MediaFileService.java:729)
	at org.madsonic.service.MediaFileService.getChildrenOf(MediaFileService.java:330)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:418)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:422)
	at org.madsonic.service.MediaScannerService.doFolderScanLibrary(MediaScannerService.java:282)
	at org.madsonic.service.MediaScannerService.access$000(MediaScannerService.java:51)
	at org.madsonic.service.MediaScannerService$3.run(MediaScannerService.java:178)

[2017-02-21 04:56:35,303] WARN JaudiotaggerParser - Error when parsing tags in /volume1/Maya/Klangschale/E/Einstürzende Neubauten/1995 - Haus Der Lüge [CDA+RE]/102. Einstürzende Neubauten - Feurio!.mpc No Reader associated with this extension:mpc
org.jaudiotagger.audio.exceptions.CannotReadException: No Reader associated with this extension:mpc
	at org.jaudiotagger.audio.AudioFileIO.readFile(AudioFileIO.java:285)
	at org.jaudiotagger.audio.AudioFileIO.read(AudioFileIO.java:151)
	at org.madsonic.service.metadata.JaudiotaggerParser.getRawMetaData(JaudiotaggerParser.java:110)
	at org.madsonic.service.metadata.MetaDataParser.getMetaData(MetaDataParser.java:48)
	at org.madsonic.service.MediaFileService.createMediaFile(MediaFileService.java:911)
	at org.madsonic.service.MediaFileService.updateChildren(MediaFileService.java:729)
	at org.madsonic.service.MediaFileService.getChildrenOf(MediaFileService.java:330)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:418)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:422)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:422)
	at org.madsonic.service.MediaScannerService.doFolderScanLibrary(MediaScannerService.java:282)
	at org.madsonic.service.MediaScannerService.access$000(MediaScannerService.java:51)
	at org.madsonic.service.MediaScannerService$3.run(MediaScannerService.java:178)

[2017-02-21 04:56:35,308] WARN JaudiotaggerParser - Error when parsing tags in /volume1/Maya/Klangschale/E/Einstürzende Neubauten/1995 - Haus Der Lüge [CDA+RE]/103. Einstürzende Neubauten - Ein Stuhl In Der Hölle.mpc No Reader associated with this extension:mpc
org.jaudiotagger.audio.exceptions.CannotReadException: No Reader associated with this extension:mpc
	at org.jaudiotagger.audio.AudioFileIO.readFile(AudioFileIO.java:285)
	at org.jaudiotagger.audio.AudioFileIO.read(AudioFileIO.java:151)
	at org.madsonic.service.metadata.JaudiotaggerParser.getRawMetaData(JaudiotaggerParser.java:110)
	at org.madsonic.service.metadata.MetaDataParser.getMetaData(MetaDataParser.java:48)
	at org.madsonic.service.MediaFileService.createMediaFile(MediaFileService.java:911)
	at org.madsonic.service.MediaFileService.updateChildren(MediaFileService.java:729)
	at org.madsonic.service.MediaFileService.getChildrenOf(MediaFileService.java:330)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:418)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:422)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:422)
	at org.madsonic.service.MediaScannerService.doFolderScanLibrary(MediaScannerService.java:282)
	at org.madsonic.service.MediaScannerService.access$000(MediaScannerService.java:51)
	at org.madsonic.service.MediaScannerService$3.run(MediaScannerService.java:178)

[2017-02-21 04:56:35,344] WARN JaudiotaggerParser - Error when parsing tags in /volume1/Maya/Klangschale/E/Einstürzende Neubauten/1995 - Haus Der Lüge [CDA+RE]/104. Einstürzende Neubauten - Haus Der Luege.mpc No Reader associated with this extension:mpc
org.jaudiotagger.audio.exceptions.CannotReadException: No Reader associated with this extension:mpc
	at org.jaudiotagger.audio.AudioFileIO.readFile(AudioFileIO.java:285)
	at org.jaudiotagger.audio.AudioFileIO.read(AudioFileIO.java:151)
	at org.madsonic.service.metadata.JaudiotaggerParser.getRawMetaData(JaudiotaggerParser.java:110)
	at org.madsonic.service.metadata.MetaDataParser.getMetaData(MetaDataParser.java:48)
	at org.madsonic.service.MediaFileService.createMediaFile(MediaFileService.java:911)
	at org.madsonic.service.MediaFileService.updateChildren(MediaFileService.java:729)
	at org.madsonic.service.MediaFileService.getChildrenOf(MediaFileService.java:330)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:418)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:422)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:422)
	at org.madsonic.service.MediaScannerService.doFolderScanLibrary(MediaScannerService.java:282)
	at org.madsonic.service.MediaScannerService.access$000(MediaScannerService.java:51)
	at org.madsonic.service.MediaScannerService$3.run(MediaScannerService.java:178)

[2017-02-21 04:56:35,349] WARN JaudiotaggerParser - Error when parsing tags in /volume1/Maya/Klangschale/E/Einstürzende Neubauten/1995 - Haus Der Lüge [CDA+RE]/105. Einstürzende Neubauten - Fiat Lux- A) Fiat Lux B) Maifestspiele C) Hirnlego.mpc No Reader associated with this extension:mpc
org.jaudiotagger.audio.exceptions.CannotReadException: No Reader associated with this extension:mpc
	at org.jaudiotagger.audio.AudioFileIO.readFile(AudioFileIO.java:285)
	at org.jaudiotagger.audio.AudioFileIO.read(AudioFileIO.java:151)
	at org.madsonic.service.metadata.JaudiotaggerParser.getRawMetaData(JaudiotaggerParser.java:110)
	at org.madsonic.service.metadata.MetaDataParser.getMetaData(MetaDataParser.java:48)
	at org.madsonic.service.MediaFileService.createMediaFile(MediaFileService.java:911)
	at org.madsonic.service.MediaFileService.updateChildren(MediaFileService.java:729)
	at org.madsonic.service.MediaFileService.getChildrenOf(MediaFileService.java:330)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:418)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:422)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:422)
	at org.madsonic.service.MediaScannerService.doFolderScanLibrary(MediaScannerService.java:282)
	at org.madsonic.service.MediaScannerService.access$000(MediaScannerService.java:51)
	at org.madsonic.service.MediaScannerService$3.run(MediaScannerService.java:178)

[2017-02-21 04:56:35,354] WARN JaudiotaggerParser - Error when parsing tags in /volume1/Maya/Klangschale/E/Einstürzende Neubauten/1995 - Haus Der Lüge [CDA+RE]/106. Einstürzende Neubauten - Schwindel.mpc No Reader associated with this extension:mpc
org.jaudiotagger.audio.exceptions.CannotReadException: No Reader associated with this extension:mpc
	at org.jaudiotagger.audio.AudioFileIO.readFile(AudioFileIO.java:285)
	at org.jaudiotagger.audio.AudioFileIO.read(AudioFileIO.java:151)
	at org.madsonic.service.metadata.JaudiotaggerParser.getRawMetaData(JaudiotaggerParser.java:110)
	at org.madsonic.service.metadata.MetaDataParser.getMetaData(MetaDataParser.java:48)
	at org.madsonic.service.MediaFileService.createMediaFile(MediaFileService.java:911)
	at org.madsonic.service.MediaFileService.updateChildren(MediaFileService.java:729)
	at org.madsonic.service.MediaFileService.getChildrenOf(MediaFileService.java:330)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:418)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:422)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:422)
	at org.madsonic.service.MediaScannerService.doFolderScanLibrary(MediaScannerService.java:282)
	at org.madsonic.service.MediaScannerService.access$000(MediaScannerService.java:51)
	at org.madsonic.service.MediaScannerService$3.run(MediaScannerService.java:178)

[2017-02-21 04:56:35,359] WARN JaudiotaggerParser - Error when parsing tags in /volume1/Maya/Klangschale/E/Einstürzende Neubauten/1995 - Haus Der Lüge [CDA+RE]/107. Einstürzende Neubauten - Der Kuss.mpc No Reader associated with this extension:mpc
org.jaudiotagger.audio.exceptions.CannotReadException: No Reader associated with this extension:mpc
	at org.jaudiotagger.audio.AudioFileIO.readFile(AudioFileIO.java:285)
	at org.jaudiotagger.audio.AudioFileIO.read(AudioFileIO.java:151)
	at org.madsonic.service.metadata.JaudiotaggerParser.getRawMetaData(JaudiotaggerParser.java:110)
	at org.madsonic.service.metadata.MetaDataParser.getMetaData(MetaDataParser.java:48)
	at org.madsonic.service.MediaFileService.createMediaFile(MediaFileService.java:911)
	at org.madsonic.service.MediaFileService.updateChildren(MediaFileService.java:729)
	at org.madsonic.service.MediaFileService.getChildrenOf(MediaFileService.java:330)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:418)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:422)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:422)
	at org.madsonic.service.MediaScannerService.doFolderScanLibrary(MediaScannerService.java:282)
	at org.madsonic.service.MediaScannerService.access$000(MediaScannerService.java:51)
	at org.madsonic.service.MediaScannerService$3.run(MediaScannerService.java:178)

[2017-02-21 04:56:35,364] WARN JaudiotaggerParser - Error when parsing tags in /volume1/Maya/Klangschale/E/Einstürzende Neubauten/1995 - Haus Der Lüge [CDA+RE]/108. Einstürzende Neubauten - Feurio! (Caffery-Einheit Remix).mpc No Reader associated with this extension:mpc
org.jaudiotagger.audio.exceptions.CannotReadException: No Reader associated with this extension:mpc
	at org.jaudiotagger.audio.AudioFileIO.readFile(AudioFileIO.java:285)
	at org.jaudiotagger.audio.AudioFileIO.read(AudioFileIO.java:151)
	at org.madsonic.service.metadata.JaudiotaggerParser.getRawMetaData(JaudiotaggerParser.java:110)
	at org.madsonic.service.metadata.MetaDataParser.getMetaData(MetaDataParser.java:48)
	at org.madsonic.service.MediaFileService.createMediaFile(MediaFileService.java:911)
	at org.madsonic.service.MediaFileService.updateChildren(MediaFileService.java:729)
	at org.madsonic.service.MediaFileService.getChildrenOf(MediaFileService.java:330)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:418)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:422)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:422)
	at org.madsonic.service.MediaScannerService.doFolderScanLibrary(MediaScannerService.java:282)
	at org.madsonic.service.MediaScannerService.access$000(MediaScannerService.java:51)
	at org.madsonic.service.MediaScannerService$3.run(MediaScannerService.java:178)

[2017-02-21 04:56:35,369] WARN JaudiotaggerParser - Error when parsing tags in /volume1/Maya/Klangschale/E/Einstürzende Neubauten/1995 - Haus Der Lüge [CDA+RE]/109. Einstürzende Neubauten - Partymucke.mpc No Reader associated with this extension:mpc
org.jaudiotagger.audio.exceptions.CannotReadException: No Reader associated with this extension:mpc
	at org.jaudiotagger.audio.AudioFileIO.readFile(AudioFileIO.java:285)
	at org.jaudiotagger.audio.AudioFileIO.read(AudioFileIO.java:151)
	at org.madsonic.service.metadata.JaudiotaggerParser.getRawMetaData(JaudiotaggerParser.java:110)
	at org.madsonic.service.metadata.MetaDataParser.getMetaData(MetaDataParser.java:48)
	at org.madsonic.service.MediaFileService.createMediaFile(MediaFileService.java:911)
	at org.madsonic.service.MediaFileService.updateChildren(MediaFileService.java:729)
	at org.madsonic.service.MediaFileService.getChildrenOf(MediaFileService.java:330)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:418)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:422)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:422)
	at org.madsonic.service.MediaScannerService.doFolderScanLibrary(MediaScannerService.java:282)
	at org.madsonic.service.MediaScannerService.access$000(MediaScannerService.java:51)
	at org.madsonic.service.MediaScannerService$3.run(MediaScannerService.java:178)

[2017-02-21 04:56:35,375] WARN JaudiotaggerParser - Error when parsing tags in /volume1/Maya/Klangschale/E/Einstürzende Neubauten/1995 - Haus Der Lüge [CDA+RE]/110. Einstürzende Neubauten - Feurio (Turen Offen).mpc No Reader associated with this extension:mpc
org.jaudiotagger.audio.exceptions.CannotReadException: No Reader associated with this extension:mpc
	at org.jaudiotagger.audio.AudioFileIO.readFile(AudioFileIO.java:285)
	at org.jaudiotagger.audio.AudioFileIO.read(AudioFileIO.java:151)
	at org.madsonic.service.metadata.JaudiotaggerParser.getRawMetaData(JaudiotaggerParser.java:110)
	at org.madsonic.service.metadata.MetaDataParser.getMetaData(MetaDataParser.java:48)
	at org.madsonic.service.MediaFileService.createMediaFile(MediaFileService.java:911)
	at org.madsonic.service.MediaFileService.updateChildren(MediaFileService.java:729)
	at org.madsonic.service.MediaFileService.getChildrenOf(MediaFileService.java:330)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:418)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:422)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:422)
	at org.madsonic.service.MediaScannerService.doFolderScanLibrary(MediaScannerService.java:282)
	at org.madsonic.service.MediaScannerService.access$000(MediaScannerService.java:51)
	at org.madsonic.service.MediaScannerService$3.run(MediaScannerService.java:178)

[2017-02-21 04:57:14,354] INFO MediaScannerService - Scanned media library with 169500 entries.
[2017-02-21 04:58:08,974] INFO MediaScannerService - Scanned media library with 170000 entries.
[2017-02-21 04:58:41,017] INFO MediaScannerService - Scanned media library with 170500 entries.
[2017-02-21 04:59:14,130] INFO MediaScannerService - Scanned media library with 171000 entries.
[2017-02-21 04:59:50,564] INFO MediaScannerService - Scanned media library with 171500 entries.
[2017-02-21 04:59:58,829] WARN JaudiotaggerParser - Error when parsing tags in /volume1/Maya/Klangschale/E/Etienne Daho/1994 - Epaule Tattoo/02. Etienne Daho - Epaule Tattoo (William Orbit Instrumental).mpc No Reader associated with this extension:mpc
org.jaudiotagger.audio.exceptions.CannotReadException: No Reader associated with this extension:mpc
	at org.jaudiotagger.audio.AudioFileIO.readFile(AudioFileIO.java:285)
	at org.jaudiotagger.audio.AudioFileIO.read(AudioFileIO.java:151)
	at org.madsonic.service.metadata.JaudiotaggerParser.getRawMetaData(JaudiotaggerParser.java:110)
	at org.madsonic.service.metadata.MetaDataParser.getMetaData(MetaDataParser.java:48)
	at org.madsonic.service.MediaFileService.createMediaFile(MediaFileService.java:1046)
	at org.madsonic.service.MediaFileService.updateChildren(MediaFileService.java:729)
	at org.madsonic.service.MediaFileService.getChildrenOf(MediaFileService.java:330)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:418)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:422)
	at org.madsonic.service.MediaScannerService.doFolderScanLibrary(MediaScannerService.java:282)
	at org.madsonic.service.MediaScannerService.access$000(MediaScannerService.java:51)
	at org.madsonic.service.MediaScannerService$3.run(MediaScannerService.java:178)

[2017-02-21 04:59:58,834] WARN JaudiotaggerParser - Error when parsing tags in /volume1/Maya/Klangschale/E/Etienne Daho/1994 - Epaule Tattoo/02. Etienne Daho - Epaule Tattoo (William Orbit Instrumental).mpc No Reader associated with this extension:mpc
org.jaudiotagger.audio.exceptions.CannotReadException: No Reader associated with this extension:mpc
	at org.jaudiotagger.audio.AudioFileIO.readFile(AudioFileIO.java:285)
	at org.jaudiotagger.audio.AudioFileIO.read(AudioFileIO.java:151)
	at org.madsonic.service.metadata.JaudiotaggerParser.getRawMetaData(JaudiotaggerParser.java:110)
	at org.madsonic.service.metadata.MetaDataParser.getMetaData(MetaDataParser.java:48)
	at org.madsonic.service.MediaFileService.createMediaFile(MediaFileService.java:911)
	at org.madsonic.service.MediaFileService.getMediaFile(MediaFileService.java:144)
	at org.madsonic.service.MediaFileService.getMediaFile(MediaFileService.java:110)
	at org.madsonic.service.MediaFileService.findCoverArt(MediaFileService.java:1520)
	at org.madsonic.service.MediaFileService.createMediaFile(MediaFileService.java:1117)
	at org.madsonic.service.MediaFileService.updateChildren(MediaFileService.java:729)
	at org.madsonic.service.MediaFileService.getChildrenOf(MediaFileService.java:330)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:418)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:422)
	at org.madsonic.service.MediaScannerService.doFolderScanLibrary(MediaScannerService.java:282)
	at org.madsonic.service.MediaScannerService.access$000(MediaScannerService.java:51)
	at org.madsonic.service.MediaScannerService$3.run(MediaScannerService.java:178)

[2017-02-21 04:59:58,838] WARN JaudiotaggerParser - Failed to find cover art tag in 02. Etienne Daho - Epaule Tattoo (William Orbit Instrumental)
org.jaudiotagger.audio.exceptions.CannotReadException: No Reader associated with this extension:mpc
	at org.jaudiotagger.audio.AudioFileIO.readFile(AudioFileIO.java:285)
	at org.jaudiotagger.audio.AudioFileIO.read(AudioFileIO.java:151)
	at org.madsonic.service.metadata.JaudiotaggerParser.getArtwork(JaudiotaggerParser.java:569)
	at org.madsonic.service.metadata.JaudiotaggerParser.isImageAvailable(JaudiotaggerParser.java:546)
	at org.madsonic.service.MediaFileService.findCoverArt(MediaFileService.java:1520)
	at org.madsonic.service.MediaFileService.createMediaFile(MediaFileService.java:1117)
	at org.madsonic.service.MediaFileService.updateChildren(MediaFileService.java:729)
	at org.madsonic.service.MediaFileService.getChildrenOf(MediaFileService.java:330)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:418)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:422)
	at org.madsonic.service.MediaScannerService.doFolderScanLibrary(MediaScannerService.java:282)
	at org.madsonic.service.MediaScannerService.access$000(MediaScannerService.java:51)
	at org.madsonic.service.MediaScannerService$3.run(MediaScannerService.java:178)

[2017-02-21 04:59:58,845] WARN JaudiotaggerParser - Error when parsing tags in /volume1/Maya/Klangschale/E/Etienne Daho/1994 - Epaule Tattoo/01. Etienne Daho - Epaule Tattoo (William Orbit Remix).mpc No Reader associated with this extension:mpc
org.jaudiotagger.audio.exceptions.CannotReadException: No Reader associated with this extension:mpc
	at org.jaudiotagger.audio.AudioFileIO.readFile(AudioFileIO.java:285)
	at org.jaudiotagger.audio.AudioFileIO.read(AudioFileIO.java:151)
	at org.madsonic.service.metadata.JaudiotaggerParser.getRawMetaData(JaudiotaggerParser.java:110)
	at org.madsonic.service.metadata.MetaDataParser.getMetaData(MetaDataParser.java:48)
	at org.madsonic.service.MediaFileService.createMediaFile(MediaFileService.java:911)
	at org.madsonic.service.MediaFileService.updateChildren(MediaFileService.java:729)
	at org.madsonic.service.MediaFileService.getChildrenOf(MediaFileService.java:330)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:418)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:422)
	at org.madsonic.service.MediaScannerService.scanFile(MediaScannerService.java:422)
	at org.madsonic.service.MediaScannerService.doFolderScanLibrary(MediaScannerService.java:282)
	at org.madsonic.service.MediaScannerService.access$000(MediaScannerService.java:51)
	at org.madsonic.service.MediaScannerService$3.run(MediaScannerService.java:178)

[2017-02-21 05:00:32,363] INFO MediaScannerService - Scanned media library with 172000 entries.
[2017-02-21 05:01:13,873] INFO MediaScannerService - Scanned media library with 172500 entries.
[2017-02-21 05:02:14,229] DEBUG StreamController - GET /stream?player=1&id=18267&auth=874092004, Range: bytes=0-
[2017-02-21 05:02:14,458] INFO StreamController - admin is streaming RAW "A Tribute to the Poetry of Nazim Hikmet/01. Abidin Ensemble - Abidin.mp3"
[2017-02-21 05:02:15,120] DEBUG StreamController - Wrote 7620173 bytes of 7620173 requested
[2017-02-21 05:02:17,393] DEBUG MultiService - Starting getTopTrackArtists() id:18267 artist:Abidin Ensemble limit:10
[2017-02-21 05:02:25,250] DEBUG AbstractDao - fn::getTrackByName::namedQueryOne:  3102 ms:  select id, path, folder, type, override, format, data, title, album, album_name, artist, album_artist, disc_number, track_number, year, genre, mood, bpm, composer, bit_rate, variable_bit_rate, duration_seconds, file_size, width, height, cover_art_path, parent_path, play_count, last_played, comment, created, changed, last_scanned, first_scanned, children_last_updated, present, version, rank from media_file where title = :title and type = :type and present
[2017-02-21 05:02:29,874] DEBUG AbstractDao - fn::getTrackByName::namedQueryOne:  4623 ms:  select id, path, folder, type, override, format, data, title, album, album_name, artist, album_artist, disc_number, track_number, year, genre, mood, bpm, composer, bit_rate, variable_bit_rate, duration_seconds, file_size, width, height, cover_art_path, parent_path, play_count, last_played, comment, created, changed, last_scanned, first_scanned, children_last_updated, present, version, rank from media_file where title = :title and type = :type and present
[2017-02-21 05:02:34,241] DEBUG AbstractDao - fn::getTrackByName::namedQueryOne:  4365 ms:  select id, path, folder, type, override, format, data, title, album, album_name, artist, album_artist, disc_number, track_number, year, genre, mood, bpm, composer, bit_rate, variable_bit_rate, duration_seconds, file_size, width, height, cover_art_path, parent_path, play_count, last_played, comment, created, changed, last_scanned, first_scanned, children_last_updated, present, version, rank from media_file where title = :title and type = :type and present
[2017-02-21 05:02:38,912] DEBUG AbstractDao - fn::updateChildren::createOrUpdateMediaFile:  16764 ms:  insert into media_file (id, path, folder, type, override, format, data, title, album, album_name, artist, album_artist, disc_number, track_number, year, genre, mood, bpm, composer, bit_rate, variable_bit_rate, duration_seconds, file_size, width, height, cover_art_path, parent_path, play_count, last_played, comment, created, changed, last_scanned, first_scanned, children_last_updated, present, version, rank) values (?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?)
[2017-02-21 05:02:38,912] DEBUG AbstractDao - fn::getTrackByName::namedQueryOne:  4670 ms:  select id, path, folder, type, override, format, data, title, album, album_name, artist, album_artist, disc_number, track_number, year, genre, mood, bpm, composer, bit_rate, variable_bit_rate, duration_seconds, file_size, width, height, cover_art_path, parent_path, play_count, last_played, comment, created, changed, last_scanned, first_scanned, children_last_updated, present, version, rank from media_file where title = :title and type = :type and present
[2017-02-21 05:02:43,447] DEBUG AbstractDao - fn::updateChildren::createOrUpdateMediaFile:  4325 ms:  update media_file set folder=?,type=?,override=?,format=?,data=?,title=?,album=?,album_name=?,artist=?,album_artist=?,disc_number=?,track_number=?,year=?,genre=?,mood=?,bpm=?,composer=?,bit_rate=?,variable_bit_rate=?,duration_seconds=?,file_size=?,width=?,height=?,cover_art_path=?,parent_path=?,play_count=?,last_played=?,comment=?,changed=?,last_scanned=?,children_last_updated=?,present=?, version=?, rank=? where path=?
[2017-02-21 05:02:43,448] DEBUG AbstractDao - fn::getTrackByName::namedQueryOne:  4534 ms:  select id, path, folder, type, override, format, data, title, album, album_name, artist, album_artist, disc_number, track_number, year, genre, mood, bpm, composer, bit_rate, variable_bit_rate, duration_seconds, file_size, width, height, cover_art_path, parent_path, play_count, last_played, comment, created, changed, last_scanned, first_scanned, children_last_updated, present, version, rank from media_file where title = :title and type = :type and present
[2017-02-21 05:02:48,728] DEBUG AbstractDao - fn::updateChildren::createOrUpdateMediaFile:  5279 ms:  insert into media_file (id, path, folder, type, override, format, data, title, album, album_name, artist, album_artist, disc_number, track_number, year, genre, mood, bpm, composer, bit_rate, variable_bit_rate, duration_seconds, file_size, width, height, cover_art_path, parent_path, play_count, last_played, comment, created, changed, last_scanned, first_scanned, children_last_updated, present, version, rank) values (?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?, ?)
[2017-02-21 05:02:48,732] DEBUG AbstractDao - fn::getTrackByName::namedQueryOne:  5280 ms:  select id, path, folder, type, override, format, data, title, album, album_name, artist, album_artist, disc_number, track_number, year, genre, mood, bpm, composer, bit_rate, variable_bit_rate, duration_seconds, file_size, width, height, cover_art_path, parent_path, play_count, last_played, comment, created, changed, last_scanned, first_scanned, children_last_updated, present, version, rank from media_file where title = :title and type = :type and present
[2017-02-21 05:02:53,163] DEBUG AbstractDao - fn::getTrackByName::namedQueryOne:  4429 ms:  select id, path, folder, type, override, format, data, title, album, album_name, artist, album_artist, disc_number, track_number, year, genre, mood, bpm, composer, bit_rate, variable_bit_rate, duration_seconds, file_size, width, height, cover_art_path, parent_path, play_count, last_played, comment, created, changed, last_scanned, first_scanned, children_last_updated, present, version, rank from media_file where title = :title and type = :type and present
[2017-02-21 05:02:57,261] DEBUG MultiService - Starting getTopTrackArtists() id:18267 artist:Abidin Ensemble limit:10
[2017-02-21 05:02:58,991] DEBUG AbstractDao - fn::getTrackByName::namedQueryOne:  5827 ms:  select id, path, folder, type, override, format, data, title, album, album_name, artist, album_artist, disc_number, track_number, year, genre, mood, bpm, composer, bit_rate, variable_bit_rate, duration_seconds, file_size, width, height, cover_art_path, parent_path, play_count, last_played, comment, created, changed, last_scanned, first_scanned, children_last_updated, present, version, rank from media_file where title = :title and type = :type and present
[2017-02-21 05:02:59,001] DEBUG MultiService - fn::getFullArtistInfo took: 46375 ms 
[2017-02-21 05:03:00,735] DEBUG AbstractDao - fn::updateChildren::createOrUpdateMediaFile:  11551 ms:  update media_file set folder=?,type=?,override=?,format=?,data=?,title=?,album=?,album_name=?,artist=?,album_artist=?,disc_number=?,track_number=?,year=?,genre=?,mood=?,bpm=?,composer=?,bit_rate=?,variable_bit_rate=?,duration_seconds=?,file_size=?,width=?,height=?,cover_art_path=?,parent_path=?,play_count=?,last_played=?,comment=?,changed=?,last_scanned=?,children_last_updated=?,present=?, version=?, rank=? where path=?
[2017-02-21 05:03:00,735] DEBUG AbstractDao - fn::getTrackByName::namedQueryOne:  3470 ms:  select id, path, folder, type, override, format, data, title, album, album_name, artist, album_artist, disc_number, track_number, year, genre, mood, bpm, composer, bit_rate, variable_bit_rate, duration_seconds, file_size, width, height, cover_art_path, parent_path, play_count, last_played, comment, created, changed, last_scanned, first_scanned, children_last_updated, present, version, rank from media_file where title = :title and type = :type and present
[2017-02-21 05:03:20,598] DEBUG MultiService - fn::getFullArtistInfo took: 57199 ms 
[2017-02-21 05:03:33,628] INFO MediaScannerService - Scanned media library with 173000 entries.
[2017-02-21 05:04:16,520] INFO MediaScannerService - Scanned media library with 173500 entries.
[2017-02-21 05:05:05,763] INFO MediaScannerService - Scanned media library with 174000 entries.
[2017-02-21 05:06:08,655] INFO MediaScannerService - Scanned media library with 174500 entries.
[2017-02-21 05:07:05,929] INFO MediaScannerService - Scanned media library with 175000 entries.
[2017-02-21 05:07:55,126] INFO MediaScannerService - Scanned media library with 175500 entries.
[2017-02-21 05:07:58,694] DEBUG AbstractDao - fn::run::getVideoConversionsByStatus:  3060 ms:  select id, media_file_id, audio_track_id, username, status, target_file, log_file, bit_rate, progress_seconds, created, changed, started from video_conversion where status=? order by created
[2017-02-21 05:07:58,694] DEBUG AbstractDao - fn::getMediaFile::queryOne:  3152 ms:  select id, path, folder, type, override, format, data, title, album, album_name, artist, album_artist, disc_number, track_number, year, genre, mood, bpm, composer, bit_rate, variable_bit_rate, duration_seconds, file_size, width, height, cover_art_path, parent_path, play_count, last_played, comment, created, changed, last_scanned, first_scanned, children_last_updated, present, version, rank from media_file where path=?
[2017-02-21 05:08:39,447] INFO MediaScannerService - Scanned media library with 176000 entries.
[2017-02-21 05:09:28,419] INFO MediaScannerService - Scanned media library with 176500 entries.
[2017-02-21 05:10:13,524] INFO MediaScannerService - Scanned media library with 177000 entries.
[2017-02-21 05:11:00,469] INFO MediaScannerService - Scanned media library with 177500 entries.
[2017-02-21 05:11:48,288] INFO MediaScannerService - Scanned media library with 178000 entries.
[2017-02-21 05:12:11,320] DEBUG MediaScannerService - WATCHDOG:RUN: doUpdateTasks()
[2017-02-21 05:12:11,321] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [Klangschale0]
[2017-02-21 05:12:11,321] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleA]
[2017-02-21 05:12:11,321] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleB]
[2017-02-21 05:12:11,321] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleC]
[2017-02-21 05:12:11,321] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleD]
[2017-02-21 05:12:11,322] DEBUG MediaScannerService - WATCHDOG:TIMER: UPDATED [KlangschaleE]
[2017-02-21 05:12:11,322] DEBUG MediaScannerService - WATCHDOG:TIMER: UPDATED [KlangschaleF]
[2017-02-21 05:12:11,323] DEBUG MediaScannerService - WATCHDOG:TIMER: UPDATED [KlangschaleG]
[2017-02-21 05:12:11,324] DEBUG MediaScannerService - WATCHDOG:TIMER: UPDATED [KlangschaleH]
[2017-02-21 05:12:11,324] DEBUG MediaScannerService - WATCHDOG:TIMER: UPDATED [KlangschaleI]
[2017-02-21 05:12:11,325] DEBUG MediaScannerService - WATCHDOG:TIMER: UPDATED [KlangschaleJ]
[2017-02-21 05:12:11,325] DEBUG MediaScannerService - WATCHDOG:TIMER: UPDATED [KlangschaleK]
[2017-02-21 05:12:11,326] DEBUG MediaScannerService - WATCHDOG:TIMER: UPDATED [KlangschaleL]
[2017-02-21 05:12:11,326] DEBUG MediaScannerService - WATCHDOG:TIMER: UPDATED [KlangschaleM]
[2017-02-21 05:12:11,327] DEBUG MediaScannerService - WATCHDOG:TIMER: UPDATED [KlangschaleN]
[2017-02-21 05:12:11,327] DEBUG MediaScannerService - WATCHDOG:TIMER: UPDATED [KlangschaleO]
[2017-02-21 05:12:11,328] DEBUG MediaScannerService - WATCHDOG:TIMER: UPDATED [KlangschaleP]
[2017-02-21 05:12:11,329] DEBUG MediaScannerService - WATCHDOG:TIMER: UPDATED [KlangschaleQ]
[2017-02-21 05:12:11,329] DEBUG MediaScannerService - WATCHDOG:TIMER: UPDATED [KlangschaleR]
[2017-02-21 05:12:11,330] DEBUG MediaScannerService - WATCHDOG:TIMER: UPDATED [KlangschaleS]
[2017-02-21 05:12:11,330] DEBUG MediaScannerService - WATCHDOG:TIMER: UPDATED [KlangschaleT]
[2017-02-21 05:12:11,331] DEBUG MediaScannerService - WATCHDOG:TIMER: UPDATED [KlangschaleU]
[2017-02-21 05:12:11,332] DEBUG MediaScannerService - WATCHDOG:TIMER: UPDATED [KlangschaleV]
[2017-02-21 05:12:11,332] DEBUG MediaScannerService - WATCHDOG:TIMER: UPDATED [KlangschaleW]
[2017-02-21 05:12:11,333] DEBUG MediaScannerService - WATCHDOG:TIMER: UPDATED [KlangschaleX]
[2017-02-21 05:12:11,333] DEBUG MediaScannerService - WATCHDOG:TIMER: UPDATED [KlangschaleY]
[2017-02-21 05:12:11,334] DEBUG MediaScannerService - WATCHDOG:TIMER: UPDATED [KlangschaleZ]
here it stopped. Webgui wasnt updating and just showed the rotating circles, but not increasing the numbers anymore.

Here I couldnt wait any longer for something to happen and logged out from the webgui and in again:

Code: Select all

[2017-02-21 05:56:21,824] DEBUG AbstractDao - fn::getArtistGenresforFolder::getArtistGenresforFolder:  3149 ms:  select distinct lower(genre) from media_file where lower(genre) is not null and present and type='ARTIST' and folder in (select path from music_folder where id in (select music_folder_id from user_group_access where music_folder_id=? and user_group_id=? and enabled))
[2017-02-21 05:56:22,972] DEBUG AbstractDao - fn::getNewestAlbums::getNewestAlbums:  4269 ms:  select id, path, folder, type, override, format, data, title, album, album_name, artist, album_artist, disc_number, track_number, year, genre, mood, bpm, composer, bit_rate, variable_bit_rate, duration_seconds, file_size, width, height, cover_art_path, parent_path, play_count, last_played, comment, created, changed, last_scanned, first_scanned, children_last_updated, present, version, rank from media_file where type in (:type) and folder in (:folders) and present order by created desc limit :count offset :offset
[2017-02-21 05:56:29,880] DEBUG MultiService - Starting getTopTrackArtists() id:18267 artist:Abidin Ensemble limit:10
[2017-02-21 05:56:52,857] DEBUG MultiService - fn::getFullArtistInfo took: 28300 ms 
I stopped and started the service via the package manager of my DSM.
stopping was good.
logfile
logfile
stopping db.png (4.14 KiB) Viewed 5513 times
starting seems ok to me as well.

Code: Select all

[2017-02-21 06:18:57,190] WARN HsqlDaoHelper - Checking database schema ...
[2017-02-21 06:19:00,510] INFO HsqlDaoHelper - Done checking database schema.
[2017-02-21 06:19:00,512] INFO HsqlDaoHelper - Checking HSQLDB version: 2.3.4
[2017-02-21 06:19:01,710] INFO SettingsService - Java: 1.8.0_121, OS: Linux
[2017-02-21 06:19:01,721] INFO SettingsService - write transcode path to property file: /bin
[2017-02-21 06:19:01,779] INFO SettingsService - ffmpeg: ffmpeg version 2.7.1 (17.08.2016) Copyright (c) 2000-2015 the FFmpeg developers
[2017-02-21 06:19:01,779] INFO SettingsService - Madsonic scanMode: NATIVE
[2017-02-21 06:19:01,784] DEBUG VersionService - Resolved local Madsonic version to: 6.2.9080.619dd31
[2017-02-21 06:19:01,853] DEBUG UserService - Checking User accounts ...
[2017-02-21 06:19:02,036] DEBUG SecurityService - Updated user default
[2017-02-21 06:19:02,036] DEBUG UserService - Checking Default User. Done
[2017-02-21 06:19:02,078] DEBUG SecurityService - Updated user guest
[2017-02-21 06:19:02,078] DEBUG UserService - Checking Guest User. Done
[2017-02-21 06:19:02,099] DEBUG SecurityService - Updated user node
[2017-02-21 06:19:02,099] DEBUG UserService - Checking Node User. Done
[2017-02-21 06:19:02,306] DEBUG MediaScannerService - WATCHDOG:RUN: doUpdateTasks()
[2017-02-21 06:19:02,318] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [Klangschale0]
[2017-02-21 06:19:02,318] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleA]
[2017-02-21 06:19:02,318] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleB]
[2017-02-21 06:19:02,318] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleC]
[2017-02-21 06:19:02,318] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleD]
[2017-02-21 06:19:02,318] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleE]
[2017-02-21 06:19:02,319] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleF]
[2017-02-21 06:19:02,319] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleG]
[2017-02-21 06:19:02,319] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleH]
[2017-02-21 06:19:02,319] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleI]
[2017-02-21 06:19:02,319] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleJ]
[2017-02-21 06:19:02,319] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleK]
[2017-02-21 06:19:02,319] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleL]
[2017-02-21 06:19:02,319] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleM]
[2017-02-21 06:19:02,319] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleN]
[2017-02-21 06:19:02,320] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleO]
[2017-02-21 06:19:02,320] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleP]
[2017-02-21 06:19:02,320] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleQ]
[2017-02-21 06:19:02,320] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleR]
[2017-02-21 06:19:02,320] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleS]
[2017-02-21 06:19:02,320] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleT]
[2017-02-21 06:19:02,320] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleU]
[2017-02-21 06:19:02,320] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleV]
[2017-02-21 06:19:02,320] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleW]
[2017-02-21 06:19:02,321] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleX]
[2017-02-21 06:19:02,321] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleY]
[2017-02-21 06:19:02,321] DEBUG MediaScannerService - WATCHDOG:TIMER: PLANNED [KlangschaleZ]
[2017-02-21 06:19:02,327] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-02-21 18:09:00.0 [Klangschale0]
[2017-02-21 06:19:02,327] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-02-24 01:00:00.0 [KlangschaleA]
[2017-02-21 06:19:02,327] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-02-24 01:00:00.0 [KlangschaleB]
[2017-02-21 06:19:02,328] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-02-24 01:00:00.0 [KlangschaleC]
[2017-02-21 06:19:02,328] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-02-24 01:00:00.0 [KlangschaleD]
[2017-02-21 06:19:02,328] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-02-24 01:00:00.0 [KlangschaleE]
[2017-02-21 06:19:02,328] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-02-24 01:00:00.0 [KlangschaleF]
[2017-02-21 06:19:02,328] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-02-24 01:00:00.0 [KlangschaleG]
[2017-02-21 06:19:02,329] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-02-24 01:00:00.0 [KlangschaleH]
[2017-02-21 06:19:02,329] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-02-24 01:00:00.0 [KlangschaleI]
[2017-02-21 06:19:02,329] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-02-24 01:00:00.0 [KlangschaleJ]
[2017-02-21 06:19:02,329] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-02-24 01:00:00.0 [KlangschaleK]
[2017-02-21 06:19:02,330] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-02-24 01:00:00.0 [KlangschaleL]
[2017-02-21 06:19:02,330] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-02-24 01:00:00.0 [KlangschaleM]
[2017-02-21 06:19:02,330] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-02-24 01:00:00.0 [KlangschaleN]
[2017-02-21 06:19:02,330] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-02-24 01:00:00.0 [KlangschaleO]
[2017-02-21 06:19:02,330] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-02-24 01:00:00.0 [KlangschaleP]
[2017-02-21 06:19:02,331] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-02-24 01:00:00.0 [KlangschaleQ]
[2017-02-21 06:19:02,331] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-02-24 01:00:00.0 [KlangschaleR]
[2017-02-21 06:19:02,331] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-02-24 01:00:00.0 [KlangschaleS]
[2017-02-21 06:19:02,331] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-02-24 01:00:00.0 [KlangschaleT]
[2017-02-21 06:19:02,331] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-02-24 01:00:00.0 [KlangschaleU]
[2017-02-21 06:19:02,331] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-02-24 01:00:00.0 [KlangschaleV]
[2017-02-21 06:19:02,332] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-02-24 01:00:00.0 [KlangschaleW]
[2017-02-21 06:19:02,332] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-02-24 01:00:00.0 [KlangschaleX]
[2017-02-21 06:19:02,332] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-02-24 01:00:00.0 [KlangschaleY]
[2017-02-21 06:19:02,332] DEBUG MediaScannerService - WATCHDOG:SCHEDULE: 2017-02-24 01:00:00.0 [KlangschaleZ]
[2017-02-21 06:19:02,333] INFO MediaScannerService - Automatic media scanning disabled.
[2017-02-21 06:19:02,521] INFO UPnPService - Checking UPnP service...
[2017-02-21 06:19:02,546] DEBUG NetworkService - Check backend interface ...
[2017-02-21 06:19:02,547] DEBUG NetworkService - Madsonic Node Discovery is disabled.
[2017-02-21 06:19:03,036] INFO PodcastService - Automatic Podcast update disabled.
[2017-02-21 06:19:03,842] INFO UPnPService - Enabling UPnP/DLNA media server
[2017-02-21 06:19:03,842] INFO UPnPService - Checking UPnP service - Done!
[2017-02-21 06:19:03,956] DEBUG JaudiotaggerParser - GenreMap turned: off
[2017-02-21 06:19:13,185] INFO NetworkService - Deleted port mapping for port 4040
[2017-02-21 06:19:18,752] DEBUG RESTController - supported MADSONIC REST version: 2.5.0
[2017-02-21 06:19:19,433] DEBUG RESTController - supported SUBSONIC REST version: 1.14.0
[2017-02-21 06:19:25,866] INFO BootstrapVerificationFilter - Servlet container: jetty/8.y.z-SNAPSHOT
[2017-02-21 06:20:59,156] DEBUG VersionService - Latest Version Info is outdated.
[2017-02-21 06:20:59,157] DEBUG VersionService - Check for Updates ...
[2017-02-21 06:20:59,180] DEBUG VersionService - http://madsonic.org/version.html
[2017-02-21 06:20:59,768] DEBUG VersionService - Resolved latest Madsonic final version to: 5.1.5260
[2017-02-21 06:20:59,768] DEBUG VersionService - Resolved latest Madsonic beta version to: 6.1.8740
[2017-02-21 06:20:59,769] DEBUG VersionService - Resolved latest Madsonic alpha version to: 6.2.9260
[2017-02-21 06:28:44,107] DEBUG StreamController - GET /stream?player=1&id=125278&auth=1931238465, Range: bytes=0-
[2017-02-21 06:28:44,195] INFO StreamController - admin is streaming CON "Disney Film-Hits (The Magic Of Disney) (2009)/106. Aristocats - Katzen Brauchen Furchtbar Viel Musik.mp3"
[2017-02-21 06:28:44,343] DEBUG TranscodeInputStream - Starting transcoder: /bin/ffmpeg -i /volume1/Maya/Klangschale/D/Disney Film-Hits (The Magic Of Disney) (2009)/106. Aristocats - Katzen Brauchen Furchtbar Viel Musik.mp3 -map 0:a:0 -b:a 128k -ar 44100 -v 0 -f mp3 - 
[2017-02-21 06:28:46,952] DEBUG MultiService - Starting getTopTrackArtists() id:125278 artist:Aristocats limit:10
[2017-02-21 06:29:10,714] DEBUG MultiService - fn::getFullArtistInfo took: 25768 ms  
madsonic is not continuing to scan. Playing music is possible.

Should I now deactivate the " Fast access mode " and do a full rescan again?
User avatar
Madsonic
Administrator
Administrator
Posts: 984
Joined: 07 Dec 2012, 03:58
Answers: 7
Has thanked: 1201 times
Been thanked: 470 times

Re: DSM6: madsonic is contantly stopping music after some mi

Unread post by Madsonic »

all looks great as expected. :thumbsup:

try to init a normal scan, this should scan your library much faster now.

you can leave your "Fast access" settings on, it would take the metadata from the database instead of reading it from the corresponding mediafile.

best regards
User avatar
Matt Zornig
Contributor
Contributor
Posts: 242
Joined: 14 Feb 2017, 12:03
Has thanked: 38 times
Been thanked: 28 times

Re: DSM6: madsonic is contantly stopping music after some mi

Unread post by Matt Zornig »

Madevil wrote:all looks great as expected.
I'm glad, but confused :-)

Question:
When everything seems ok, *why* are about 2TB musicfiles missing in the library? ("only" 13.000 songs, against 460.000 songs that were in the library before the "renewing" of the database)
User avatar
Matt Zornig
Contributor
Contributor
Posts: 242
Joined: 14 Feb 2017, 12:03
Has thanked: 38 times
Been thanked: 28 times

Re: DSM6: madsonic is contantly stopping music after some mi

Unread post by Matt Zornig »

Same problem has arrived again.

I need to restart the madsonic server to listen to music constantly for a few hours.

If it runs, say 1 day or more, problems occur with playing music.
Post Reply