Page 1 of 1

Subsonic will not start.

PostPosted: Tue Mar 24, 2009 12:58 pm
by HiSpeed
I have upgraded from 3.5 to 3.6 on my Vista PC and now Subsonic will not start (http://localhost:9000/). I have opened for port 9000 (tcp) and Subsonic-service.exe in Windows Firewall. The Service is running.

Some suggestions for solution?

PostPosted: Wed Mar 25, 2009 1:38 pm
by HiSpeed
Have tried to turn off the firewall but it did not help.

PostPosted: Wed Mar 25, 2009 3:01 pm
by agroni1888
try another port, maybe the port is used by another program - if this works

go : start --> run --> type cmd press enter and type netstat and see if port 9000 is already in use.

PostPosted: Wed Mar 25, 2009 3:28 pm
by HiSpeed
Port 9000 is not i use. I have also tried other ports.

PostPosted: Fri Mar 27, 2009 8:28 am
by HiSpeed
Not much help to get here but thx to agroni1888 for trying.

PostPosted: Sun Mar 29, 2009 8:28 pm
by jigsaw
You should check the logs to see if Subsonic post any error messages when starting. If you have any other security apps installed you should try stopping all of them to eliminate them as possible causes as well.
Also verify that subsonic is actually listening to 9000 after the service has started.

subsonic-service.log

PostPosted: Mon Mar 30, 2009 4:06 pm
by HiSpeed
132 [main] INFO org.springframework.context.support.ClassPathXmlApplicationContext - Refreshing org.springframework.context.support.ClassPathXmlApplicationContext@e24e2a: display name [org.springframework.context.support.ClassPathXmlApplicationContext@e24e2a]; startup date [Mon Mar 30 18:02:58 CEST 2009]; root of context hierarchy
418 [main] INFO org.springframework.beans.factory.xml.XmlBeanDefinitionReader - Loading XML bean definitions from class path resource [applicationContext-deployer.xml]
1081 [main] INFO org.springframework.context.support.ClassPathXmlApplicationContext - Bean factory for application context [org.springframework.context.support.ClassPathXmlApplicationContext@e24e2a]: org.springframework.beans.factory.support.DefaultListableBeanFactory@1b1aa65
1115 [main] INFO org.springframework.beans.factory.support.DefaultListableBeanFactory - Pre-instantiating singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@1b1aa65: defining beans [service,org.springframework.remoting.rmi.RmiServiceExporter#0]; root of factory hierarchy
1234 [main] INFO org.mortbay.log - Logging to org.slf4j.impl.SimpleLogger(org.mortbay.log) via org.mortbay.log.Slf4jLog
Using WAR file: C:\Program Files\Subsonic\subsonic.war
1440 [main] INFO org.mortbay.log - jetty-6.1.x
4189 [main] INFO / - Initializing Spring root WebApplicationContext
4189 [main] INFO org.springframework.web.context.ContextLoader - Root WebApplicationContext: initialization started
4240 [main] INFO org.springframework.web.context.support.XmlWebApplicationContext - Refreshing org.springframework.web.context.support.XmlWebApplicationContext@1db05b2: display name [Root WebApplicationContext]; startup date [Mon Mar 30 18:03:02 CEST 2009]; root of context hierarchy
4378 [main] INFO org.springframework.beans.factory.xml.XmlBeanDefinitionReader - Loading XML bean definitions from ServletContext resource [/WEB-INF/applicationContext-service.xml]
4500 [main] INFO org.springframework.beans.factory.xml.XmlBeanDefinitionReader - Loading XML bean definitions from ServletContext resource [/WEB-INF/applicationContext-security.xml]
4593 [main] INFO org.springframework.beans.factory.xml.XmlBeanDefinitionReader - Loading XML bean definitions from ServletContext resource [/WEB-INF/applicationContext-cache.xml]
4663 [main] INFO org.springframework.web.context.support.XmlWebApplicationContext - Bean factory for application context [org.springframework.web.context.support.XmlWebApplicationContext@1db05b2]: org.springframework.beans.factory.support.DefaultListableBeanFactory@1a7508a
7809 [main] INFO org.springframework.beans.factory.support.DefaultListableBeanFactory - Pre-instantiating singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@1a7508a: defining beans [playerDao,internetRadioDao,musicFileInfoDao,musicFolderDao,userDao,transcodingDao,podcastDao,avatarDao,daoHelper,musicFileService,securityService,settingsService,searchService,playerService,playlistService,versionService,statusService,musicInfoService,musicIndexService,amazonSearchService,discogsSearchService,audioScrobblerService,transcodingService,podcastService,adService,jukeboxService,ajaxNowPlayingService,ajaxPlaylistService,ajaxLyricsService,ajaxCoverArtService,ajaxTagService,ajaxTransferService,filterChainProxy,httpSessionContextIntegrationFilter,logoutFilter,authenticationProcessingFilter,basicProcessingFilter,requestParameterProcessingFilter,basicProcessingFilterEntryPoint,securityContextHolderAwareRequestFilter,rememberMeProcessingFilter,anonymousProcessingFilter,exceptionTranslationFilter,basicExceptionTranslationFilter,filterInvocationInterceptor,accessDecisionManager,rememberMeServices,authenticationManager,daoAuthenticationProvider,userCacheWrapper,ldapAuthenticationProvider,bindAuthenticator,userDetailsServiceBasedAuthoritiesPopulator,ajaxServiceInterceptor,ajaxTagServiceSecure,ajaxTransferServiceSecure,cacheManager,userCache,musicFileCache,childDirCache,coverArtCache]; root of factory hierarchy
8346 [main] INFO org.springframework.jdbc.datasource.DriverManagerDataSource - Loaded JDBC driver: org.hsqldb.jdbcDriver
10269 [main] INFO org.springframework.cache.ehcache.EhCacheManagerFactoryBean - Initializing EHCache CacheManager
12248 [main] INFO org.acegisecurity.intercept.AbstractSecurityInterceptor - Validated configuration attributes
12274 [main] INFO org.acegisecurity.intercept.method.MethodDefinitionMap - Adding secure method [public net.sourceforge.subsonic.ajax.UploadInfo net.sourceforge.subsonic.ajax.TransferService.getUploadInfo()] with attributes [[ROLE_UPLOAD]]
12274 [main] INFO org.acegisecurity.intercept.method.MethodDefinitionMap - Adding secure method [public java.lang.String net.sourceforge.subsonic.ajax.TagService.setTags(java.lang.String,java.lang.String,java.lang.String,java.lang.String,java.lang.String,java.lang.String,java.lang.String)] with attributes [[ROLE_COVERART]]
12275 [main] INFO org.acegisecurity.intercept.AbstractSecurityInterceptor - Validated configuration attributes
12343 [main] INFO org.springframework.web.context.ContextLoader - Root WebApplicationContext: initialization completed in 8154 ms
12569 [main] INFO / - Initializing Spring FrameworkServlet 'subsonic'
12569 [main] INFO org.springframework.web.servlet.DispatcherServlet - FrameworkServlet 'subsonic': initialization started
12570 [main] INFO org.springframework.web.context.support.XmlWebApplicationContext - Refreshing org.springframework.web.context.support.XmlWebApplicationContext@1dcc2a3: display name [WebApplicationContext for namespace 'subsonic-servlet']; startup date [Mon Mar 30 18:03:10 CEST 2009]; parent: org.springframework.web.context.support.XmlWebApplicationContext@1db05b2
12571 [main] INFO org.springframework.beans.factory.xml.XmlBeanDefinitionReader - Loading XML bean definitions from ServletContext resource [/WEB-INF/subsonic-servlet.xml]
12730 [main] INFO org.springframework.web.context.support.XmlWebApplicationContext - Bean factory for application context [org.springframework.web.context.support.XmlWebApplicationContext@1dcc2a3]: org.springframework.beans.factory.support.DefaultListableBeanFactory@7244ca
14016 [main] INFO org.springframework.beans.factory.support.DefaultListableBeanFactory - Pre-instantiating singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@7244ca: defining beans [leftController,statusController,mainController,topController,helpController,moreController,uploadController,helpPopupController,lyricsController,allmusicController,podcastController,podcastReceiverController,podcastReceiverAdminController,setMusicFileInfoController,setRatingController,albumInfoController,randomPlaylistController,loadPlaylistController,savePlaylistController,changeCoverArtController,nowPlayingController,searchController,settingsController,playerSettingsController,musicFolderSettingsController,transcodingSettingsController,internetRadioSettingsController,podcastSettingsController,searchSettingsController,generalSettingsController,advancedSettingsController,personalSettingsController,avatarUploadController,userSettingsController,passwordSettingsController,homeController,editTagsController,playlistController,xspfPlaylistController,coverArtController,avatarController,proxyController,statusChartController,userChartController,m3uController,streamController,downloadController,donateController,multiController,wapController,mobileController,dbController,savePlaylistValidator,donateValidator,userSettingsValidator,passwordSettingsValidator,urlMapping,messageSource,themeSource,localeResolver,themeResolver,viewResolver]; parent: org.springframework.beans.factory.support.DefaultListableBeanFactory@1a7508a
15232 [main] INFO org.springframework.web.servlet.DispatcherServlet - FrameworkServlet 'subsonic': initialization completed in 2663 ms
15354 [main] INFO org.mortbay.log - Started SelectChannelConnector@0.0.0.0:9000
Subsonic running on http://localhost:9000/
15431 [main] INFO org.springframework.remoting.rmi.RmiServiceExporter - Looking for RMI registry at port '9412'
16509 [main] INFO org.springframework.remoting.rmi.RmiServiceExporter - Could not detect RMI registry - creating new one
16668 [main] INFO org.springframework.remoting.rmi.RmiServiceExporter - Binding service 'SubsonicDeployerService' to RMI registry: RegistryImpl[UnicastServerRef [liveRef: [endpoint:[192.168.0.105:9412](local),objID:[0:0:0, 0]]]]

subsonic.log

PostPosted: Mon Mar 30, 2009 4:07 pm
by HiSpeed
[2009-03-30 18:03:06,655] INFO DaoHelper - Checking database schema.
[2009-03-30 18:03:07,882] INFO DaoHelper - Done checking database schema.
[2009-03-30 18:03:08,940] INFO SearchService - Automatic index creation scheduled to run every 1 day(s), starting at Tue Mar 31 03:00:00 CEST 2009
[2009-03-30 18:03:09,455] INFO PodcastService - Automatic Podcast update scheduled to run every 24 hour(s), starting at Mon Mar 30 18:08:09 CEST 2009

subsonic-agent.log

PostPosted: Mon Mar 30, 2009 4:22 pm
by HiSpeed
387 [main] INFO org.springframework.context.support.ClassPathXmlApplicationContext - Refreshing org.springframework.context.support.ClassPathXmlApplicationContext@1050e1f: display name [org.springframework.context.support.ClassPathXmlApplicationContext@1050e1f]; startup date [Mon Mar 30 16:12:53 CEST 2009]; root of context hierarchy
809 [main] INFO org.springframework.beans.factory.xml.XmlBeanDefinitionReader - Loading XML bean definitions from class path resource [applicationContext-agent.xml]
3561 [main] INFO org.springframework.context.support.ClassPathXmlApplicationContext - Bean factory for application context [org.springframework.context.support.ClassPathXmlApplicationContext@1050e1f]: org.springframework.beans.factory.support.DefaultListableBeanFactory@d80be3
3995 [main] INFO org.springframework.beans.factory.support.DefaultListableBeanFactory - Pre-instantiating singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@d80be3: defining beans [service,agent]; root of factory hierarchy
7027513 [pool-1-thread-2] WARN org.springframework.remoting.rmi.RmiProxyFactoryBean - Could not connect to RMI service [rmi://localhost:9412/SubsonicDeployerService] - retrying
7055686 [pool-1-thread-2] WARN org.springframework.remoting.rmi.RmiProxyFactoryBean - Could not connect to RMI service [rmi://localhost:9412/SubsonicDeployerService] - retrying
7256012 [pool-1-thread-2] WARN org.springframework.remoting.rmi.RmiProxyFactoryBean - Could not connect to RMI service [rmi://localhost:9412/SubsonicDeployerService] - retrying
7379367 [pool-1-thread-1] WARN org.springframework.remoting.rmi.RmiProxyFactoryBean - Could not connect to RMI service [rmi://localhost:9412/SubsonicDeployerService] - retrying
7707894 [pool-1-thread-1] WARN org.springframework.remoting.rmi.RmiProxyFactoryBean - Could not connect to RMI service [rmi://localhost:9412/SubsonicDeployerService] - retrying