I have been using SS for a couple years, but this is the first time I have had a problem. In a nutshell, I am getting very slow response times from the server, when logging into the actual server that is running subsonic. This is happening when I am listening to music on my wireless in the home, using the same connection that the server is using. I have the computer attached to a gig port of my router, the port 4040 is open, etc. I have noticed that when listening to the music, The music skips due to slow speeds. This happens from my android phone and my wifi enabled android tablet. Hoping someone can see something that sticks out.
Problem Description: Very Slow response from web or android app
Troubleshooting Steps: removed transcoding, tried from computer vs android app
Playback Application and version: Android app version 12-6-11
Subsonic Version: 4.6 (build 2585) – December 6, 2011
Server Version: jetty-6.1.x, java 1.6.0_23, Linux (71.6 MB / 96.7 MB)
Hardware Platform: Ubuntu 11.10
Problem Filename: example file but not limited to 02 - Amy Winehouse - Between the Cheats.mp3
- Code: Select all
Output from ffmpeg -i: mychal@mychal-desktop:~$ ffmpeg -i /home/mychal/Music/Amy\ Winehouse/Amy\ Winehouse\ -\ Lioness\ Hidden\ Treasures\ \(2011\)\ /02\ -\ Amy\ Winehouse\ -\ Between\ the\ Cheats.mp3
ffmpeg version 0.7.2-4:0.7.2-1ubuntu1, Copyright (c) 2000-2011 the Libav developers
built on Oct 2 2011 15:12:32 with gcc 4.6.1
configuration: --extra-version='4:0.7.2-1ubuntu1' --arch=i386 --prefix=/usr --enable-vdpau --enable-bzlib --enable-libgsm --enable-libschroedinger --enable-libspeex --enable-libtheora --enable-libvorbis --enable-pthreads --enable-zlib --enable-libvpx --enable-runtime-cpudetect --enable-vaapi --enable-gpl --enable-postproc --enable-swscale --enable-x11grab --enable-libdc1394 --enable-shared --disable-static
WARNING: library configuration mismatch
avutil configuration: --extra-version='4:0.7.2-1ubuntu1' --arch=i386 --prefix=/usr --enable-vdpau --enable-bzlib --enable-libgsm --enable-libschroedinger --enable-libspeex --enable-libtheora --enable-libvorbis --enable-pthreads --enable-zlib --enable-libvpx --enable-runtime-cpudetect --enable-vaapi --enable-gpl --enable-postproc --enable-swscale --enable-x11grab --enable-libdc1394 --shlibdir=/usr/lib/i686/cmov --cpu=i686 --enable-shared --disable-static --disable-ffmpeg --disable-ffplay
avcodec configuration: --extra-version='4:0.7.2-1ubuntu1' --arch=i386 --prefix=/usr --enable-vdpau --enable-bzlib --enable-libgsm --enable-libschroedinger --enable-libspeex --enable-libtheora --enable-libvorbis --enable-pthreads --enable-zlib --enable-libvpx --enable-runtime-cpudetect --enable-vaapi --enable-gpl --enable-postproc --enable-swscale --enable-x11grab --enable-libdc1394 --shlibdir=/usr/lib/i686/cmov --cpu=i686 --enable-shared --disable-static --disable-ffmpeg --disable-ffplay
avformat configuration: --extra-version='4:0.7.2-1ubuntu1' --arch=i386 --prefix=/usr --enable-vdpau --enable-bzlib --enable-libgsm --enable-libschroedinger --enable-libspeex --enable-libtheora --enable-libvorbis --enable-pthreads --enable-zlib --enable-libvpx --enable-runtime-cpudetect --enable-vaapi --enable-gpl --enable-postproc --enable-swscale --enable-x11grab --enable-libdc1394 --shlibdir=/usr/lib/i686/cmov --cpu=i686 --enable-shared --disable-static --disable-ffmpeg --disable-ffplay
avdevice configuration: --extra-version='4:0.7.2-1ubuntu1' --arch=i386 --prefix=/usr --enable-vdpau --enable-bzlib --enable-libgsm --enable-libschroedinger --enable-libspeex --enable-libtheora --enable-libvorbis --enable-pthreads --enable-zlib --enable-libvpx --enable-runtime-cpudetect --enable-vaapi --enable-gpl --enable-postproc --enable-swscale --enable-x11grab --enable-libdc1394 --shlibdir=/usr/lib/i686/cmov --cpu=i686 --enable-shared --disable-static --disable-ffmpeg --disable-ffplay
avfilter configuration: --extra-version='4:0.7.2-1ubuntu1' --arch=i386 --prefix=/usr --enable-vdpau --enable-bzlib --enable-libgsm --enable-libschroedinger --enable-libspeex --enable-libtheora --enable-libvorbis --enable-pthreads --enable-zlib --enable-libvpx --enable-runtime-cpudetect --enable-vaapi --enable-gpl --enable-postproc --enable-swscale --enable-x11grab --enable-libdc1394 --shlibdir=/usr/lib/i686/cmov --cpu=i686 --enable-shared --disable-static --disable-ffmpeg --disable-ffplay
swscale configuration: --extra-version='4:0.7.2-1ubuntu1' --arch=i386 --prefix=/usr --enable-vdpau --enable-bzlib --enable-libgsm --enable-libschroedinger --enable-libspeex --enable-libtheora --enable-libvorbis --enable-pthreads --enable-zlib --enable-libvpx --enable-runtime-cpudetect --enable-vaapi --enable-gpl --enable-postproc --enable-swscale --enable-x11grab --enable-libdc1394 --shlibdir=/usr/lib/i686/cmov --cpu=i686 --enable-shared --disable-static --disable-ffmpeg --disable-ffplay
postproc configuration: --extra-version='4:0.7.2-1ubuntu1' --arch=i386 --prefix=/usr --enable-vdpau --enable-bzlib --enable-libgsm --enable-libschroedinger --enable-libspeex --enable-libtheora --enable-libvorbis --enable-pthreads --enable-zlib --enable-libvpx --enable-runtime-cpudetect --enable-vaapi --enable-gpl --enable-postproc --enable-swscale --enable-x11grab --enable-libdc1394 --shlibdir=/usr/lib/i686/cmov --cpu=i686 --enable-shared --disable-static --disable-ffmpeg --disable-ffplay
libavutil 51. 7. 0 / 51. 7. 0
libavcodec 53. 5. 0 / 53. 5. 0
libavformat 53. 2. 0 / 53. 2. 0
libavdevice 53. 0. 0 / 53. 0. 0
libavfilter 2. 4. 0 / 2. 4. 0
libswscale 2. 0. 0 / 2. 0. 0
libpostproc 52. 0. 0 / 52. 0. 0
[mp3 @ 0x872a2a0] Invalid size in frame , skipping the rest of tag.
[mp3 @ 0x872a2a0] max_analyze_duration reached
Input #0, mp3, from '/home/mychal/Music/Amy Winehouse/Amy Winehouse - Lioness Hidden Treasures (2011) /02 - Amy Winehouse - Between the Cheats.mp3':
Metadata:
album : Lioness Hidden Treasures
artist : Amy Winehouse
genre : Pop
publisher : Island (Universal)
title : Between The Cheats
track : 2/12
date : 2011
Duration: 00:03:33.62, start: 0.000000, bitrate: 343 kb/s
Stream #0.0: Audio: mp3, 44100 Hz, stereo, s16, 320 kb/s
At least one output file must be specified
- Code: Select all
Last ten log file lines: mychal@mychal-desktop:~$ sudo more /var/subsonic/subsonic_sh.log
27 [main] INFO org.springframework.context.support.ClassPathXmlApplicationContext - Refreshing org.springframework.context.support.ClassPathXmlApplicationContext@174cc1f: displa
y name [org.springframework.context.support.ClassPathXmlApplicationContext@174cc1f]; startup date [Thu Dec 08 14:27:02 MST 2011]; root of context hierarchy
119 [main] INFO org.springframework.beans.factory.xml.XmlBeanDefinitionReader - Loading XML bean definitions from class path resource [applicationContext-deployer.xml]
[GC 4416K->242K(15872K), 0.0060140 secs]
[GC 4658K->522K(15872K), 0.0071850 secs]
727 [main] INFO org.springframework.context.support.ClassPathXmlApplicationContext - Bean factory for application context [org.springframework.context.support.ClassPathXmlApplic
ationContext@174cc1f]: org.springframework.beans.factory.support.DefaultListableBeanFactory@17a29a1
748 [main] INFO org.springframework.beans.factory.support.DefaultListableBeanFactory - Pre-instantiating singletons in org.springframework.beans.factory.support.DefaultListableB
eanFactory@17a29a1: defining beans [service,org.springframework.remoting.rmi.RmiServiceExporter#0]; root of factory hierarchy
786 [main] INFO org.mortbay.log - Logging to org.slf4j.impl.SimpleLogger(org.mortbay.log) via org.mortbay.log.Slf4jLog
Using WAR file: /usr/share/subsonic/subsonic.war
Extracting webapp to /var/subsonic/jetty/2585
Using WAR file: /usr/share/subsonic/subsonic.war
844 [main] INFO org.mortbay.log - jetty-6.1.x
[GC 4938K->451K(15872K), 0.0081090 secs]
[GC 4863K->812K(15872K), 0.0054540 secs]
[GC 5228K->821K(15872K), 0.0027470 secs]
[GC 5237K->884K(15872K), 0.0020900 secs]
1425 [main] INFO / - Initializing Spring root WebApplicationContext
1425 [main] INFO org.springframework.web.context.ContextLoader - Root WebApplicationContext: initialization started
1461 [main] INFO org.springframework.web.context.support.XmlWebApplicationContext - Refreshing org.springframework.web.context.support.XmlWebApplicationContext@1b15692: display
name [Root WebApplicationContext]; startup date [Thu Dec 08 14:27:03 MST 2011]; root of context hierarchy
[GC 5288K->1201K(15872K), 0.0033380 secs]
1534 [main] INFO org.springframework.beans.factory.xml.XmlBeanDefinitionReader - Loading XML bean definitions from ServletContext resource [/WEB-INF/applicationContext-service.x
ml]
1669 [main] INFO org.springframework.beans.factory.xml.XmlBeanDefinitionReader - Loading XML bean definitions from ServletContext resource [/WEB-INF/applicationContext-security.
xml]
1754 [main] INFO org.springframework.beans.factory.xml.XmlBeanDefinitionReader - Loading XML bean definitions from ServletContext resource [/WEB-INF/applicationContext-cache.xml
]
[GC 5615K->1110K(15872K), 0.0045160 secs]
1814 [main] INFO org.springframework.web.context.support.XmlWebApplicationContext - Bean factory for application context [org.springframework.web.context.support.XmlWebApplicati
onContext@1b15692]: org.springframework.beans.factory.support.DefaultListableBeanFactory@11a75a2
1934 [main] INFO org.springframework.beans.factory.support.DefaultListableBeanFactory - Pre-instantiating singletons in org.springframework.beans.factory.support.DefaultListable
BeanFactory@11a75a2: defining beans [playerDao,internetRadioDao,musicFileInfoDao,musicFolderDao,userDao,transcodingDao,podcastDao,avatarDao,shareDao,daoHelper,musicFileService,s
ecurityService,settingsService,searchService,luceneSearchService,networkService,playerService,playlistService,versionService,statusService,musicInfoService,musicIndexService,aud
ioScrobblerService,transcodingService,shareService,podcastService,adService,jukeboxService,metaDataParserFactory,ajaxMultiService,ajaxNowPlayingService,ajaxPlaylistService,ajaxL
yricsService,ajaxCoverArtService,ajaxTagService,ajaxTransferService,ajaxChatService,filterChainProxy,httpSessionContextIntegrationFilter,logoutFilter,authenticationProcessingFil
ter,basicProcessingFilter,restRequestParameterProcessingFilter,basicProcessingFilterEntryPoint,securityContextHolderAwareRequestFilter,rememberMeProcessingFilter,anonymousProces
singFilter,exceptionTranslationFilter,basicExceptionTranslationFilter,filterInvocationInterceptor,accessDecisionManager,rememberMeServices,authenticationManager,daoAuthenticatio
nProvider,userCacheWrapper,ldapAuthenticationProvider,bindAuthenticator,userDetailsServiceBasedAuthoritiesPopulator,ajaxServiceInterceptor,ajaxTagServiceSecure,ajaxTransferServi
ceSecure,cacheManager,userCache,musicFileCache,childDirCache,coverArtCache,musicFolderCache,chatCache]; root of factory hierarchy
[GC 5526K->1108K(15872K), 0.0040780 secs]
2006 [main] INFO org.springframework.jdbc.datasource.DriverManagerDataSource - Loaded JDBC driver: org.hsqldb.jdbcDriver
[GC 5514K->2217K(15872K), 0.0078340 secs]
[GC 6629K->3762K(15872K), 0.0081120 secs]
[GC 8178K->3856K(15872K), 0.0046770 secs]
2875 [main] INFO org.springframework.cache.ehcache.EhCacheManagerFactoryBean - Initializing EHCache CacheManager
[GC 8272K->4226K(15872K), 0.0071190 secs]
Dec 8, 2011 2:27:05 PM net.sf.ehcache.CacheManager addShutdownHookIfRequired
INFO: The CacheManager shutdown hook is enabled because net.sf.ehcache.enableShutdownHook is set to true.
Dec 8, 2011 2:27:05 PM net.sf.ehcache.Cache initialise
WARNING: Cache: chatCache has a maxElementsInMemory of 0. It is strongly recommended to have a maximumSize of at least 1. Performance is halved by not using a MemoryStore.
Dec 8, 2011 2:27:05 PM net.sf.ehcache.Cache initialise
WARNING: Cache: musicFolderCache has a maxElementsInMemory of 0. It is strongly recommended to have a maximumSize of at least 1. Performance is halved by not using a MemoryStore
.
[GC 8642K->4889K(15872K), 0.0129350 secs]
[GC 9299K->5698K(15872K), 0.0098580 secs]
[GC 10114K->6018K(15872K), 0.0133180 secs]
3908 [main] INFO org.acegisecurity.intercept.AbstractSecurityInterceptor - Validated configuration attributes
[GC 10434K->6368K(15872K), 0.0111210 secs]
3946 [main] INFO org.acegisecurity.intercept.method.MethodDefinitionMap - Adding secure method [public net.sourceforge.subsonic.ajax.UploadInfo net.sourceforge.subsonic.ajax.Tra
nsferService.getUploadInfo()] with attributes [[ROLE_UPLOAD]]
3946 [main] INFO org.acegisecurity.intercept.method.MethodDefinitionMap - Adding secure method [public java.lang.String net.sourceforge.subsonic.ajax.TagService.setTags(java.lan
g.String,java.lang.String,java.lang.String,java.lang.String,java.lang.String,java.lang.String,java.lang.String)] with attributes [[ROLE_COVERART]]
3947 [main] INFO org.acegisecurity.intercept.AbstractSecurityInterceptor - Validated configuration attributes
3983 [main] INFO org.springframework.web.context.ContextLoader - Root WebApplicationContext: initialization completed in 2558 ms
4052 [main] INFO / - Initializing Spring FrameworkServlet 'subsonic'
4052 [main] INFO org.springframework.web.servlet.DispatcherServlet - FrameworkServlet 'subsonic': initialization started
4053 [main] INFO org.springframework.web.context.support.XmlWebApplicationContext - Refreshing org.springframework.web.context.support.XmlWebApplicationContext@19a0feb: display
name [WebApplicationContext for namespace 'subsonic-servlet']; startup date [Thu Dec 08 14:27:06 MST 2011]; parent: org.springframework.web.context.support.XmlWebApplicationCont
ext@1b15692
4054 [main] INFO org.springframework.beans.factory.xml.XmlBeanDefinitionReader - Loading XML bean definitions from ServletContext resource [/WEB-INF/subsonic-servlet.xml]
[GC 10784K->7041K(15872K), 0.0081190 secs]
4208 [main] INFO org.springframework.web.context.support.XmlWebApplicationContext - Bean factory for application context [org.springframework.web.context.support.XmlWebApplicati
onContext@19a0feb]: org.springframework.beans.factory.support.DefaultListableBeanFactory@9be2b5
4290 [main] INFO org.springframework.beans.factory.support.DefaultListableBeanFactory - Pre-instantiating singletons in org.springframework.beans.factory.support.DefaultListable
BeanFactory@9be2b5: defining beans [leftController,rightController,statusController,mainController,topController,helpController,moreController,uploadController,lyricsController,
allmusicController,podcastController,podcastReceiverController,podcastReceiverAdminController,setMusicFileInfoController,shareManagementController,setRatingController,randomPlay
listController,loadPlaylistController,savePlaylistController,changeCoverArtController,nowPlayingController,searchController,settingsController,playerSettingsController,shareSett
ingsController,musicFolderSettingsController,networkSettingsController,transcodingSettingsController,internetRadioSettingsController,podcastSettingsController,searchSettingsCont
roller,generalSettingsController,advancedSettingsController,personalSettingsController,avatarUploadController,userSettingsController,passwordSettingsController,homeController,ed
itTagsController,playlistController,xspfPlaylistController,coverArtController,avatarController,proxyController,statusChartController,userChartController,m3uController,streamCont
roller,videoPlayerController,externalPlayerController,downloadController,donateController,multiController,wapController,restController,dbController,savePlaylistValidator,donateV
alidator,userSettingsValidator,passwordSettingsValidator,urlMapping,messageSource,themeSource,localeResolver,themeResolver,viewResolver]; parent: org.springframework.beans.facto
ry.support.DefaultListableBeanFactory@11a75a2
[GC 11457K->7224K(15872K), 0.0057850 secs]
[GC 11640K->7537K(15872K), 0.0070430 secs]
[GC 11953K->7845K(15872K), 0.0063070 secs]
[GC 12261K->8146K(15872K), 0.0052510 secs]
5053 [main] INFO org.springframework.web.servlet.DispatcherServlet - FrameworkServlet 'subsonic': initialization completed in 1001 ms
5081 [main] INFO org.mortbay.log - Started SelectChannelConnector@0.0.0.0:4040
Subsonic running on: http://localhost:4040/
[GC 12562K->8510K(15872K), 0.0092310 secs]
5155 [main] INFO org.springframework.remoting.rmi.RmiServiceExporter - Looking for RMI registry at port '9412'
5171 [main] INFO org.springframework.remoting.rmi.RmiServiceExporter - Could not detect RMI registry - creating new one
5221 [main] INFO org.springframework.remoting.rmi.RmiServiceExporter - Binding service 'SubsonicDeployerService' to RMI registry: RegistryImpl[UnicastServerRef [liveRef: [endpoi
nt:[127.0.1.1:9412](local),objID:[0:0:0, 0]]]]
[Full GC 10001K->8422K(15872K), 0.1539190 secs]
[GC 14118K->9225K(20440K), 0.0125010 secs]
- Code: Select all
12/8/11 2:51:41 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 762kB time=00:01:13.84 bitrate= 84.5kbits/s
[12/8/11 2:51:41 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 1178kB time=00:01:50.38 bitrate= 87.5kbits/s
[12/8/11 2:51:41 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 1436kB time=00:02:14.81 bitrate= 87.2kbits/s
[12/8/11 2:51:42 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 1784kB time=00:02:45.22 bitrate= 88.5kbits/s
[12/8/11 2:51:42 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 1208kB time=00:01:55.41 bitrate= 85.7kbits/s
[12/8/11 2:51:42 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 2436kB time=00:03:53.28 bitrate= 85.6kbits/s
[12/8/11 2:51:42 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 403kB time=00:00:36.37 bitrate= 90.7kbits/s
[12/8/11 2:51:42 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 2473kB time=00:03:56.08 bitrate= 85.8kbits/s
[12/8/11 2:51:42 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 250kB time=00:00:24.71 bitrate= 83.0kbits/s
[12/8/11 2:51:42 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 32kB time=00:00:05.67 bitrate= 46.6kbits/s
[12/8/11 2:51:42 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 1587kB time=00:02:27.54 bitrate= 88.1kbits/s
[12/8/11 2:51:42 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 122kB time=00:00:14.59 bitrate= 68.7kbits/s
[12/8/11 2:51:42 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 762kB time=00:01:14.18 bitrate= 84.1kbits/s
[12/8/11 2:51:42 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 1178kB time=00:01:50.61 bitrate= 87.3kbits/s
[12/8/11 2:51:42 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 1208kB time=00:01:55.73 bitrate= 85.5kbits/s
[12/8/11 2:51:42 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 1784kB time=00:02:45.50 bitrate= 88.3kbits/s
[12/8/11 2:51:42 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 1436kB time=00:02:15.10 bitrate= 87.1kbits/s
[12/8/11 2:51:42 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 2436kB time=00:03:53.58 bitrate= 85.4kbits/s
[12/8/11 2:51:42 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 250kB time=00:00:24.95 bitrate= 82.2kbits/s
[12/8/11 2:51:42 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 2473kB time=00:03:56.44 bitrate= 85.7kbits/s
[12/8/11 2:51:42 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 403kB time=00:00:36.62 bitrate= 90.1kbits/s
[12/8/11 2:51:42 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 32kB time=00:00:06.01 bitrate= 44.0kbits/s
[12/8/11 2:51:42 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 1587kB time=00:02:27.77 bitrate= 88.0kbits/s
[12/8/11 2:51:42 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 122kB time=00:00:14.91 bitrate= 67.2kbits/s
[12/8/11 2:51:43 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 762kB time=00:01:14.52 bitrate= 83.8kbits/s
[12/8/11 2:51:43 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 1436kB time=00:02:15.26 bitrate= 87.0kbits/s
[12/8/11 2:51:43 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 1784kB time=00:02:45.70 bitrate= 88.2kbits/s
[12/8/11 2:51:43 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 1178kB time=00:01:50.86 bitrate= 87.1kbits/s
[12/8/11 2:51:43 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 1243kB time=00:01:55.98 bitrate= 87.8kbits/s
[12/8/11 2:51:43 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 2473kB time=00:03:53.96 bitrate= 86.6kbits/s
[12/8/11 2:51:43 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 2473kB time=00:03:56.75 bitrate= 85.6kbits/s
[12/8/11 2:51:43 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 250kB time=00:00:25.34 bitrate= 81.0kbits/s
[12/8/11 2:51:43 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 32kB time=00:00:06.34 bitrate= 41.7kbits/s
[12/8/11 2:51:43 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 403kB time=00:00:36.86 bitrate= 89.5kbits/s
[12/8/11 2:51:43 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 1587kB time=00:02:27.98 bitrate= 87.8kbits/s
[12/8/11 2:51:43 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 153kB time=00:00:15.27 bitrate= 82.2kbits/s
[12/8/11 2:51:43 PM MST] DEBUG InputStreamReaderThread (/var/subsonic/transcode/ffmpeg) size= 762kB time=00:01:14.89 bitrate= 83.4kbits/s