Slow transcoding

[BillG]

I recently updated from version 4.0, to the latest, 4.6, and everything still works fine except transcoding seems very slow now compared to the version I previously was using. Most of my library is flac. It used to start playing nearly instantly. Now I have a 30-45 second gap in between each song. Any ideas on what changed that would cause it to be so slow?

[BKKKPewsey]

I would suggest a read of http://forum.subsonic.org/forum/viewtopic.php?f=2&t=5506

Apart from that you are running SS 4.6 on something
and transcoding flac to something
you haven't given too many clues

[BillG]

Oye. Sorry. I completely missed the instructions. Also, a little more tinkering revealed that it's a problem with the external player (with playlist) functionality. I switched it to the built in player, and it works fine. Works fine with regular (without playlist) external player setting too.

Problem Description: Transcoding flac in the latest version (4.6) seems slow compared to previous installed verion (4.0) when using the External Player with playlist
Troubleshooting Steps: Play a flac file
Playback Application and version: foobar2000/1.0.3
Subsonic Version: 4.6 (build 2583) – December 6, 2011
Server Version: jetty-6.1.x, java 1.6.0_30, Windows 7 (34.9 MB / 77.1 MB)
Hardware Platform: Windows 7 Ultimate
Java Memory Limit: 100mb

ffmpeg -i output:

Code: Select all

C:\subsonic\transcode>ffmpeg -i "G:\Music\Alternative\Coheed and Cambria\Good Ap
ollo I'm Burning Star IV, Vol. 2 No World for Tomorrow\10 - II - Radio Bye Bye.f
lac"
ffmpeg version N-31653-gfaa3381, Copyright (c) 2000-2011 the FFmpeg developers
  built on Jul 28 2011 01:57:12 with gcc 4.6.1
  configuration: --enable-gpl --enable-version3 --enable-memalign-hack --enable-
runtime-cpudetect --enable-avisynth --enable-bzlib --enable-frei0r --enable-libo
pencore-amrnb --enable-libopencore-amrwb --enable-libfreetype --enable-libgsm --
enable-libmp3lame --enable-libopenjpeg --enable-librtmp --enable-libschroedinger
--enable-libspeex --enable-libtheora --enable-libvorbis --enable-libvpx --enabl
e-libx264 --enable-libxavs --enable-libxvid --enable-zlib
  libavutil    51. 11. 0 / 51. 11. 0
  libavcodec   53.  9. 0 / 53.  9. 0
  libavformat  53.  6. 0 / 53.  6. 0
  libavdevice  53.  2. 0 / 53.  2. 0
  libavfilter   2. 27. 3 /  2. 27. 3
  libswscale    2.  0. 0 /  2.  0. 0
  libpostproc  51.  2. 0 / 51.  2. 0
[flac @ 019E9E60] max_analyze_duration 5000000 reached at 5015510
Input #0, flac, from 'G:\Music\Alternative\Coheed and Cambria\Good Apollo I'm Bu
rning Star IV, Vol. 2 No World for Tomorrow\10 - II - Radio Bye Bye.flac':
  Metadata:
    TITLE           : II - Radio Bye Bye
    ALBUM           : Good Apollo, I'm Burning Star IV. Volume Two: No World for
Tomorrow
    ARTIST          : Coheed and Cambria
    GENRE           : Alternative
    DATE            : 2007
    track           : 10
  Duration: 00:04:54.37, bitrate: 1048 kb/s
    Stream #0.0: Audio: flac, 44100 Hz, stereo, s16
At least one output file must be specified

C:\subsonic\transcode>

Log:

Code: Select all

[12/21/11 11:46:12 AM CST]   INFO   PlaylistInputStream   admin listening to "Good Apollo I'm Burning Star IV, Vol. 2 No World for Tomorrow\10 - II - Radio Bye Bye.flac"
[12/21/11 11:46:12 AM CST]   DEBUG   TranscodeInputStream   Starting transcoder: [c:\subsonic\transcode\ffmpeg] [-i] [G:\Music\Alternative\Coheed and Cambria\Good Apollo I'm Burning Star IV, Vol. 2 No World for Tomorrow\10 - II - Radio Bye Bye.flac] [-ab] [160k] [-v] [0] [-f] [mp3] [-]
[12/21/11 11:46:12 AM CST]   DEBUG   AudioScrobblerService   Successfully registered now playing for song 'II - Radio Bye Bye' for user d-lexington at Last.fm.
[12/21/11 11:46:13 AM CST]   INFO   StreamController   Got range: Range[5862592,9223372036854775807]
[12/21/11 11:46:13 AM CST]   INFO   PlaylistInputStream   admin listening to "Good Apollo I'm Burning Star IV, Vol. 2 No World for Tomorrow\10 - II - Radio Bye Bye.flac"
[12/21/11 11:46:13 AM CST]   DEBUG   TranscodeInputStream   Starting transcoder: [c:\subsonic\transcode\ffmpeg] [-i] [G:\Music\Alternative\Coheed and Cambria\Good Apollo I'm Burning Star IV, Vol. 2 No World for Tomorrow\10 - II - Radio Bye Bye.flac] [-ab] [160k] [-v] [0] [-f] [mp3] [-]
[12/21/11 11:46:13 AM CST]   DEBUG   AudioScrobblerService   Successfully registered now playing for song 'II - Radio Bye Bye' for user d-lexington at Last.fm.
[12/21/11 11:46:27 AM CST]   DEBUG   AudioScrobblerService   Successfully registered submission for song 'II - Radio Bye Bye' for user d-lexington at Last.fm.
[12/21/11 11:46:27 AM CST]   INFO   PlaylistInputStream   admin listening to "Good Apollo I'm Burning Star IV, Vol. 2 No World for Tomorrow\10 - II - Radio Bye Bye.flac"
[12/21/11 11:46:27 AM CST]   DEBUG   TranscodeInputStream   Starting transcoder: [c:\subsonic\transcode\ffmpeg] [-i] [G:\Music\Alternative\Coheed and Cambria\Good Apollo I'm Burning Star IV, Vol. 2 No World for Tomorrow\10 - II - Radio Bye Bye.flac] [-ab] [160k] [-v] [0] [-f] [mp3] [-]
[12/21/11 11:46:28 AM CST]   DEBUG   AudioScrobblerService   Successfully registered now playing for song 'II - Radio Bye Bye' for user d-lexington at Last.fm.
[12/21/11 11:46:28 AM CST]   INFO   StreamController   Got range: Range[5878944,9223372036854775807]
[12/21/11 11:46:28 AM CST]   INFO   PlaylistInputStream   admin listening to "Good Apollo I'm Burning Star IV, Vol. 2 No World for Tomorrow\10 - II - Radio Bye Bye.flac"
[12/21/11 11:46:28 AM CST]   DEBUG   TranscodeInputStream   Starting transcoder: [c:\subsonic\transcode\ffmpeg] [-i] [G:\Music\Alternative\Coheed and Cambria\Good Apollo I'm Burning Star IV, Vol. 2 No World for Tomorrow\10 - II - Radio Bye Bye.flac] [-ab] [160k] [-v] [0] [-f] [mp3] [-]
[12/21/11 11:46:29 AM CST]   DEBUG   AudioScrobblerService   Successfully registered now playing for song 'II - Radio Bye Bye' for user d-lexington at Last.fm.
[12/21/11 11:46:43 AM CST]   INFO   PlaylistInputStream   admin listening to "Good Apollo I'm Burning Star IV, Vol. 2 No World for Tomorrow\10 - II - Radio Bye Bye.flac"
[12/21/11 11:46:43 AM CST]   DEBUG   TranscodeInputStream   Starting transcoder: [c:\subsonic\transcode\ffmpeg] [-i] [G:\Music\Alternative\Coheed and Cambria\Good Apollo I'm Burning Star IV, Vol. 2 No World for Tomorrow\10 - II - Radio Bye Bye.flac] [-ab] [160k] [-v] [0] [-f] [mp3] [-]
[12/21/11 11:46:43 AM CST]   DEBUG   AudioScrobblerService   Successfully registered now playing for song 'II - Radio Bye Bye' for user d-lexington at Last.fm.
[12/21/11 11:46:43 AM CST]   INFO   StreamController   Got range: Range[5878944,9223372036854775807]
[12/21/11 11:46:43 AM CST]   INFO   PlaylistInputStream   admin listening to "Good Apollo I'm Burning Star IV, Vol. 2 No World for Tomorrow\10 - II - Radio Bye Bye.flac"
[12/21/11 11:46:43 AM CST]   DEBUG   TranscodeInputStream   Starting transcoder: [c:\subsonic\transcode\ffmpeg] [-i] [G:\Music\Alternative\Coheed and Cambria\Good Apollo I'm Burning Star IV, Vol. 2 No World for Tomorrow\10 - II - Radio Bye Bye.flac] [-ab] [160k] [-v] [0] [-f] [mp3] [-]
[12/21/11 11:46:44 AM CST]   DEBUG   AudioScrobblerService   Successfully registered now playing for song 'II - Radio Bye Bye' for user d-lexington at Last.fm.
[12/21/11 11:46:58 AM CST]   INFO   PlaylistInputStream   admin listening to "Good Apollo I'm Burning Star IV, Vol. 2 No World for Tomorrow\10 - II - Radio Bye Bye.flac"
[12/21/11 11:46:58 AM CST]   DEBUG   TranscodeInputStream   Starting transcoder: [c:\subsonic\transcode\ffmpeg] [-i] [G:\Music\Alternative\Coheed and Cambria\Good Apollo I'm Burning Star IV, Vol. 2 No World for Tomorrow\10 - II - Radio Bye Bye.flac] [-ab] [160k] [-v] [0] [-f] [mp3] [-]
[12/21/11 11:46:58 AM CST]   DEBUG   AudioScrobblerService   Successfully registered submission for song 'II - Radio Bye Bye' for user d-lexington at Last.fm.
[12/21/11 11:46:58 AM CST]   DEBUG   AudioScrobblerService   Successfully registered now playing for song 'II - Radio Bye Bye' for user d-lexington at Last.fm.

Edit: Further investigation revealed it to just be a problem with External Player with playlist. Regular External Player setting works fine.

[BKKKPewsey]

Just did a test playing flac files using an external player with playlist using foobar2000 (v1.1.7)
Everything worked fine
SS 4.6 on windows server 2003

Try increasing your java memory limit to 250MB

[BillG]

I tried increasing my java memory limit to 250 and I updated foobar to the latest stable version (1.1.10). No dice. Still very slow on external player with playlist.

[djandrius]

Same here. Slow transcoding when using external player with playlist. However, what's weird appears only Subsonic android app and iSub for iPhone are impacted.

Version 4.6 (build 2583) – December 6, 2011
Server jetty-6.1.x, java 1.6.0_30, Windows 7 (80.7 MB / 144.5 MB)
Allocated 700Meg for JAVA, never used that much anyway.

Most of my library is in FLAC. Any player in browser Webplayer, ExternalWithTranscodingOn, ExternalWithTranscodingOff are almost instant.

Caching on iPhone iSub app takes about 3 minutes before song starts downloading. Used to be instant.
Caching/preloading on Android Subsonic app takes 3 minutes before any song will start playing. Used to be instant.

Both apps used to get 1Mb/s speeds while caching, now I barely get 200Kb/s. When use PC browser, downloading/caching is not a problem. Speeds are great, no performance issues.

I'm using NAS. Will try to copy some songs to local install to see if that has any impact on transcoding speeds over NAS.

UPDATE: Copied a folder to local location from NAS, transcoding/downloading is almost instant. Not sure what would be an issue, however. NAS is on a Gig switch, multiple other apps are being used within network and there are no performance problems with any of them. Transcoding/caching with Subsonic and NAS?

[buttpirate]

Any update on this?
I've got the same problem with foobar, Windows Media Player and Winamp play without any problems. This only happens with foobar...

EDIT: Disabling "Allow seeking over HTTP" fixes the problem for me. But now foobar doesn't read the metadata at all. I don't get the Artist / Track title anymore.