MP3 fails to play

[hegleran]

I have an album where a couple of MP3s fail to play in Subsonic. They do play successfully in Rhythmbox on my local computer. When I press play, the song timer does not increment by one second, and then the player stops. Other songs in the same album play just fine.
My Android Subsonic app streams and plays the song successfully.
Both my subsonic android app and the webplayer have the same active transcoders.
Version 4.7 build 3105
Server jetty-6.1x java 1.7.0_11, Linux 76.3MB / 109.8MB
ffmeg -i output of the file that fails to play followed by the output of a song that does play:
:/var/subsonic/transcode$ ./ffmpeg -i ~/Music/Primus\ and\ Claypool\ Discography/Primus\ Discography/Primus\ -\ 1991\ -\ Sailing\ The\ Seas\ Of\ Cheese/Primus\ -\ Sailing\ The\ Seas\ Of\ Cheese\ -\ 03\ -\ Sgt.\ Baker.mp3
ffmpeg version N-31780-gd5d74cf, Copyright (c) 2000-2011 the FFmpeg developers
built on Aug 9 2011 14:18:27 with gcc 4.5.2
configuration: --disable-ffplay --disable-ffprobe --disable-ffserver --enable-gpl --enable-nonfree --enable-postproc --enable-pthreads --enable-libfaac --enable-libmp3lame --enable-libvpx --enable-libtheora --enable-libvorbis --enable-libx264 --enable-libxvid --enable-zlib --enable-libopencore-amrnb --enable-libopencore-amrwb --enable-libvpx --enable-version3 --enable-bzlib --enable-static --disable-shared --extra-libs=-static --extra-cflags=--static
libavutil 51. 11. 1 / 51. 11. 1
libavcodec 53. 9. 1 / 53. 9. 1
libavformat 53. 6. 0 / 53. 6. 0
libavdevice 53. 2. 0 / 53. 2. 0
libavfilter 2. 28. 1 / 2. 28. 1
libswscale 2. 0. 0 / 2. 0. 0
libpostproc 51. 2. 0 / 51. 2. 0
[mp3 @ 0xa6f0a20] max_analyze_duration 5000000 reached at 5015510
[mp3 @ 0xa6f0a20] Estimating duration from bitrate, this may be inaccurate
Input #0, mp3, from '/home/hegleran/Music/Primus and Claypool Discography/Primus Discography/Primus - 1991 - Sailing The Seas Of Cheese/Primus - Sailing The Seas Of Cheese - 03 - Sgt. Baker.mp3':
Metadata:
title : Sgt. Baker
artist : Primus
TIT1 : Primus
publisher : Interscope
genre : Primus
album : Sailing the Seas of Cheese
album_artist : Primus
track : 3
composer : Les Claypool/Primus/Todd Hath
date : 1991
Duration: 00:04:17.70, start: 0.000000, bitrate: 191 kb/s
Stream #0.0: Audio: mp3, 44100 Hz, stereo, s16, 192 kb/s
At least one output file must be specified
:/var/subsonic/transcode$ ./ffmpeg -i ~/Music/Primus\ and\ Claypool\ Discography/Primus\ Discography/Primus\ -\ 1991\ -\ Sailing\ The\ Seas\ Of\ Cheese/Primus\ -\ Sailing\ The\ Seas\ Of\ Cheese\ -\ 05\ -\ Jerry\ Was\ A\ Race\ Car\ Driver.mp3
ffmpeg version N-31780-gd5d74cf, Copyright (c) 2000-2011 the FFmpeg developers
built on Aug 9 2011 14:18:27 with gcc 4.5.2
configuration: --disable-ffplay --disable-ffprobe --disable-ffserver --enable-gpl --enable-nonfree --enable-postproc --enable-pthreads --enable-libfaac --enable-libmp3lame --enable-libvpx --enable-libtheora --enable-libvorbis --enable-libx264 --enable-libxvid --enable-zlib --enable-libopencore-amrnb --enable-libopencore-amrwb --enable-libvpx --enable-version3 --enable-bzlib --enable-static --disable-shared --extra-libs=-static --extra-cflags=--static
libavutil 51. 11. 1 / 51. 11. 1
libavcodec 53. 9. 1 / 53. 9. 1
libavformat 53. 6. 0 / 53. 6. 0
libavdevice 53. 2. 0 / 53. 2. 0
libavfilter 2. 28. 1 / 2. 28. 1
libswscale 2. 0. 0 / 2. 0. 0
libpostproc 51. 2. 0 / 51. 2. 0
[mp3 @ 0xa45ea20] max_analyze_duration 5000000 reached at 5015510
[mp3 @ 0xa45ea20] Estimating duration from bitrate, this may be inaccurate
Input #0, mp3, from '/home/hegleran/Music/Primus and Claypool Discography/Primus Discography/Primus - 1991 - Sailing The Seas Of Cheese/Primus - Sailing The Seas Of Cheese - 05 - Jerry Was A Race Car Driver.mp3':
Metadata:
title : Jerry Was a Race Car Driver
artist : Primus
TIT1 : Primus
publisher : Interscope
genre : Primus
album : Sailing the Seas of Cheese
album_artist : Primus
track : 5
composer : Les Claypool/Primus
date : 1991
Duration: 00:03:12.00, start: 0.000000, bitrate: 192 kb/s
Stream #0.0: Audio: mp3, 44100 Hz, stereo, s16, 192 kb/s
At least one output file must be specified


Tail of subsonic.log
:/var/subsonic/transcode$ ./ffmpeg -i ~/Music/Primus\ and\ Claypool\ Discography/Primus\ Discography/Primus\ -\ 1991\ -\ Sailing\ The\ Seas\ Of\ Cheese/Primus\ -\ Sailing\ The\ Seas\ Of\ Cheese\ -\ 03\ -\ Sgt.\ Baker.mp3
ffmpeg version N-31780-gd5d74cf, Copyright (c) 2000-2011 the FFmpeg developers
built on Aug 9 2011 14:18:27 with gcc 4.5.2
configuration: --disable-ffplay --disable-ffprobe --disable-ffserver --enable-gpl --enable-nonfree --enable-postproc --enable-pthreads --enable-libfaac --enable-libmp3lame --enable-libvpx --enable-libtheora --enable-libvorbis --enable-libx264 --enable-libxvid --enable-zlib --enable-libopencore-amrnb --enable-libopencore-amrwb --enable-libvpx --enable-version3 --enable-bzlib --enable-static --disable-shared --extra-libs=-static --extra-cflags=--static
libavutil 51. 11. 1 / 51. 11. 1
libavcodec 53. 9. 1 / 53. 9. 1
libavformat 53. 6. 0 / 53. 6. 0
libavdevice 53. 2. 0 / 53. 2. 0
libavfilter 2. 28. 1 / 2. 28. 1
libswscale 2. 0. 0 / 2. 0. 0
libpostproc 51. 2. 0 / 51. 2. 0
[mp3 @ 0xa6f0a20] max_analyze_duration 5000000 reached at 5015510
[mp3 @ 0xa6f0a20] Estimating duration from bitrate, this may be inaccurate
Input #0, mp3, from '/home/hegleran/Music/Primus and Claypool Discography/Primus Discography/Primus - 1991 - Sailing The Seas Of Cheese/Primus - Sailing The Seas Of Cheese - 03 - Sgt. Baker.mp3':
Metadata:
title : Sgt. Baker
artist : Primus
TIT1 : Primus
publisher : Interscope
genre : Primus
album : Sailing the Seas of Cheese
album_artist : Primus
track : 3
composer : Les Claypool/Primus/Todd Hath
date : 1991
Duration: 00:04:17.70, start: 0.000000, bitrate: 191 kb/s
Stream #0.0: Audio: mp3, 44100 Hz, stereo, s16, 192 kb/s
At least one output file must be specified
hegleran@Media-Server:/var/subsonic/transcode$ ./ffmpeg -i ~/Music/Primus\ and\ Claypool\ Discography/Primus\ Discography/Primus\ -\ 1991\ -\ Sailing\ The\ Seas\ Of\ Cheese/Primus\ -\ Sailing\ The\ Seas\ Of\ Cheese\ -\ 05\ -\ Jerry\ Was\ A\ Race\ Car\ Driver.mp3
ffmpeg version N-31780-gd5d74cf, Copyright (c) 2000-2011 the FFmpeg developers
built on Aug 9 2011 14:18:27 with gcc 4.5.2
configuration: --disable-ffplay --disable-ffprobe --disable-ffserver --enable-gpl --enable-nonfree --enable-postproc --enable-pthreads --enable-libfaac --enable-libmp3lame --enable-libvpx --enable-libtheora --enable-libvorbis --enable-libx264 --enable-libxvid --enable-zlib --enable-libopencore-amrnb --enable-libopencore-amrwb --enable-libvpx --enable-version3 --enable-bzlib --enable-static --disable-shared --extra-libs=-static --extra-cflags=--static
libavutil 51. 11. 1 / 51. 11. 1
libavcodec 53. 9. 1 / 53. 9. 1
libavformat 53. 6. 0 / 53. 6. 0
libavdevice 53. 2. 0 / 53. 2. 0
libavfilter 2. 28. 1 / 2. 28. 1
libswscale 2. 0. 0 / 2. 0. 0
libpostproc 51. 2. 0 / 51. 2. 0
[mp3 @ 0xa45ea20] max_analyze_duration 5000000 reached at 5015510
[mp3 @ 0xa45ea20] Estimating duration from bitrate, this may be inaccurate
Input #0, mp3, from '/home/hegleran/Music/Primus and Claypool Discography/Primus Discography/Primus - 1991 - Sailing The Seas Of Cheese/Primus - Sailing The Seas Of Cheese - 05 - Jerry Was A Race Car Driver.mp3':
Metadata:
title : Jerry Was a Race Car Driver
artist : Primus
TIT1 : Primus
publisher : Interscope
genre : Primus
album : Sailing the Seas of Cheese
album_artist : Primus
track : 5
composer : Les Claypool/Primus
date : 1991
Duration: 00:03:12.00, start: 0.000000, bitrate: 192 kb/s
Stream #0.0: Audio: mp3, 44100 Hz, stereo, s16, 192 kb/s
At least one output file must be specified


Thanks in advance for any assistance!

[gurutech]

I have the exact same problem, I thought it was the MP3's so I re-ripped a few of the songs that were doing this to me, but still having the problem, even after ripping to different bitrates.

I'm running Madsonic 4.8 beta 3, but had the problem on previous versions also. Running on Centos 6.3.

I'm thinking it's an issue with ffmpeg itself, since I can play the files on any other media player with no problems.

Trying to locate a different transcoder that's compatible with Linux to see if that works.

Edit: Found some debugging info that may be useful to MadEvil and/or Sindre:

Code: Select all

==1702== Memcheck, a memory error detector
==1702== Copyright (C) 2002-2010, and GNU GPL'd, by Julian Seward et al.
==1702== Using Valgrind-3.6.0 and LibVEX; rerun with -h for copyright info
==1702== Command: /usr/bin/subsonic
==1702==
--1702-- Valgrind options:
--1702--    -v
--1702--    --leak-check=full
--1702-- Contents of /proc/version:
--1702--   Linux version 2.6.32-279.19.1.el6.x86_64 (mockbuild@c6b8.bsys.dev.centos.org) (gcc version 4.4.6
20120305 (Red Hat 4.4.6-4) (GCC) ) #1 SMP Wed Dec 19 07:05:20 UTC 2012
--1702-- Arch and hwcaps: AMD64, amd64-sse3-cx16-lzcnt
--1702-- Page sizes: currently 4096, max supported 4096
--1702-- Valgrind library directory: /usr/lib64/valgrind
--1702-- Reading syms from /bin/bash (0x400000)
--1702--    object doesn't have a symbol table
--1702-- Reading syms from /usr/lib64/valgrind/memcheck-amd64-linux (0x38000000)
--1702--    object doesn't have a dynamic symbol table
--1702-- Reading syms from /lib64/ld-2.12.so (0x3c5f600000)
--1702-- Reading suppressions file: /usr/lib64/valgrind/default.supp
--1702-- REDIR: 0x3c5f6174a0 (strlen) redirected to 0x38042ae7 (vgPlain_amd64_linux_REDIR_FOR_strlen)
--1702-- Reading syms from /usr/lib64/valgrind/vgpreload_core-amd64-linux.so (0x4801000)
--1702-- Reading syms from /usr/lib64/valgrind/vgpreload_memcheck-amd64-linux.so (0x4a02000)
==1702== WARNING: new redirection conflicts with existing -- ignoring it
--1702--     new: 0x3c5f6174a0 (strlen              ) R-> 0x04a07830 strlen
--1702-- REDIR: 0x3c5f617310 (index) redirected to 0x4a07470 (index)
--1702-- REDIR: 0x3c5f617390 (strcmp) redirected to 0x4a07df0 (strcmp)
--1702-- Reading syms from /lib64/libtinfo.so.5.7 (0x3c70200000)
--1702--    object doesn't have a symbol table
--1702-- Reading syms from /lib64/libdl-2.12.so (0x3c5fa00000)
--1702-- Reading syms from /lib64/libc-2.12.so (0x3c5fe00000)
--1702-- REDIR: 0x3c5fe846b0 (strcasecmp) redirected to 0x4801560 (_vgnU_ifunc_wrapper)
--1702-- REDIR: 0x3c5fe86970 (strncasecmp) redirected to 0x4801560 (_vgnU_ifunc_wrapper)
--1702-- REDIR: 0x3c5fe82620 (__GI_strrchr) redirected to 0x4a072f0 (__GI_strrchr)
--1702-- REDIR: 0x3c5fe7f100 (__GI_strcmp) redirected to 0x4a07da0 (__GI_strcmp)
--1702-- REDIR: 0x3c5fe80b40 (__GI_strlen) redirected to 0x4a077f0 (__GI_strlen)
--1702-- REDIR: 0x3c5fe80d70 (__GI_strncmp) redirected to 0x4a07cf0 (__GI_strncmp)
--1702-- REDIR: 0x3c5fe7f040 (__GI_strchr) redirected to 0x4a073b0 (__GI_strchr)
--1702-- REDIR: 0x3c5fe8a4d0 (strchrnul) redirected to 0x4a08f40 (strchrnul)
--1702-- REDIR: 0x3c5fe7a0d0 (malloc) redirected to 0x4a05f10 (malloc)
--1702-- REDIR: 0x3c5fe7af00 (free) redirected to 0x4a05890 (free)
--1702-- REDIR: 0x3c5fe89050 (memcpy) redirected to 0x4a07ec0 (memcpy)
--1702-- REDIR: 0x3c5fe80b00 (strlen) redirected to 0x4801560 (_vgnU_ifunc_wrapper)
==1702== WARNING: new redirection conflicts with existing -- ignoring it
--1702--     new: 0x3c5fe80b40 (__GI_strlen         ) R-> 0x04a077d0 strlen
--1702-- REDIR: 0x3c5fe80550 (strcpy) redirected to 0x4801560 (_vgnU_ifunc_wrapper)
==1702== WARNING: new redirection conflicts with existing -- ignoring it
--1702--     new: 0x3c5fe80580 (__GI_strcpy         ) R-> 0x04a07850 strcpy
--1702-- REDIR: 0x3c5fe80580 (__GI_strcpy) redirected to 0x4a07920 (__GI_strcpy)
--1702-- REDIR: 0x3c5fe80d30 (strncmp) redirected to 0x4801560 (_vgnU_ifunc_wrapper)
==1702== WARNING: new redirection conflicts with existing -- ignoring it
--1702--     new: 0x3c5fe80d70 (__GI_strncmp        ) R-> 0x04a07c90 strncmp
--1702-- REDIR: 0x3c5fe825f0 (rindex) redirected to 0x4801560 (_vgnU_ifunc_wrapper)
==1702== WARNING: new redirection conflicts with existing -- ignoring it
--1702--     new: 0x3c5fe82620 (__GI_strrchr        ) R-> 0x04a072c0 rindex
--1702-- REDIR: 0xffffffffff600400 (???) redirected to 0x38042add (vgPlain_amd64_linux_REDIR_FOR_vtime)
--1702-- REDIR: 0x3c5fe82d30 (memchr) redirected to 0x4a07e90 (memchr)
--1702-- REDIR: 0x3c5fe8a480 (__GI___rawmemchr) redirected to 0x4a08f90 (__GI___rawmemchr)
--1702-- REDIR: 0x3c5fe7f0c0 (strcmp) redirected to 0x4801560 (_vgnU_ifunc_wrapper)
==1702== WARNING: new redirection conflicts with existing -- ignoring it
--1702--     new: 0x3c5fe7f100 (__GI_strcmp         ) R-> 0x04a07d50 strcmp
--1702-- REDIR: 0x3c5fe80c20 (strnlen) redirected to 0x4a07770 (strnlen)
--1702-- REDIR: 0x3c5fefeaf0 (__strcpy_chk) redirected to 0x4a097c0 (__strcpy_chk)
--1702-- REDIR: 0x3c5fe7f010 (index) redirected to 0x4801560 (_vgnU_ifunc_wrapper)
==1702== WARNING: new redirection conflicts with existing -- ignoring it
--1702--     new: 0x3c5fe7f040 (__GI_strchr         ) R-> 0x04a07380 index
--1702-- REDIR: 0xffffffffff600000 (???) redirected to 0x38042ad3 (vgPlain_amd64_linux_REDIR_FOR_vgettimeofday)
--1702-- REDIR: 0x3c5fe83380 (memset) redirected to 0x4801560 (_vgnU_ifunc_wrapper)
--1702-- REDIR: 0x3c5fe8d950 (__memset_x86_64) redirected to 0x4a08e30 (memset)
--1702-- REDIR: 0x3c5fe7b3f0 (realloc) redirected to 0x4a06030 (realloc)
--1702-- REDIR: 0x3c5fe825c0 (strncpy) redirected to 0x4801560 (_vgnU_ifunc_wrapper)
==1702== WARNING: new redirection conflicts with existing -- ignoring it
--1702--     new: 0x3c5fe8d7c0 (__GI_strncpy        ) R-> 0x04a079f0 strncpy
--1702-- REDIR: 0x3c5fe8d7c0 (__GI_strncpy) redirected to 0x4a07b40 (__GI_strncpy)
==1706==
==1706== HEAP SUMMARY:
==1706==     in use at exit: 35,860 bytes in 1,023 blocks
==1706==   total heap usage: 2,236 allocs, 1,213 frees, 86,907 bytes allocated
==1706==
==1706== Searching for pointers to 1,023 not-freed blocks
==1706== Checked 216,096 bytes
==1706==
==1706== 53 bytes in 1 blocks are definitely lost in loss record 306 of 350
==1706==    at 0x4A05FDE: malloc (vg_replace_malloc.c:236)
==1706==    by 0x465E32: xmalloc (in /bin/bash)
==1706==    by 0x42F7ED: execute_command_internal (in /bin/bash)
==1706==    by 0x430BED: execute_command (in /bin/bash)
==1706==    by 0x432FFA: ??? (in /bin/bash)
==1706==    by 0x42FE9C: execute_command_internal (in /bin/bash)
==1706==    by 0x430BED: execute_command (in /bin/bash)
==1706==    by 0x4315FB: ??? (in /bin/bash)
==1706==    by 0x430024: execute_command_internal (in /bin/bash)
==1706==    by 0x430BED: execute_command (in /bin/bash)
==1706==    by 0x41D535: reader_loop (in /bin/bash)
==1706==    by 0x41CCF8: main (in /bin/bash)
==1706==
==1706== LEAK SUMMARY:
==1706==    definitely lost: 53 bytes in 1 blocks
==1706==    indirectly lost: 0 bytes in 0 blocks
==1706==      possibly lost: 0 bytes in 0 blocks
==1706==    still reachable: 35,807 bytes in 1,022 blocks
==1706==         suppressed: 0 bytes in 0 blocks
==1706== Reachable blocks (those to which a pointer was found) are not shown.
==1706== To see them, rerun with: --leak-check=full --show-reachable=yes
==1706==
==1706== ERROR SUMMARY: 1 errors from 1 contexts (suppressed: 6 from 6)
--1706--
--1706-- used_suppression:      6 dl-hack3-cond-1
==1706==
==1706== ERROR SUMMARY: 1 errors from 1 contexts (suppressed: 6 from 6)
==1708==
==1708== HEAP SUMMARY:
==1708==     in use at exit: 37,218 bytes in 1,066 blocks
==1708==   total heap usage: 2,378 allocs, 1,312 frees, 92,109 bytes allocated
==1708==
==1708== Searching for pointers to 1,066 not-freed blocks
==1708== Checked 217,952 bytes
==1708==
==1708== LEAK SUMMARY:
==1708==    definitely lost: 0 bytes in 0 blocks
==1708==    indirectly lost: 0 bytes in 0 blocks
==1708==      possibly lost: 0 bytes in 0 blocks
==1708==    still reachable: 37,218 bytes in 1,066 blocks
==1708==         suppressed: 0 bytes in 0 blocks
==1708== Reachable blocks (those to which a pointer was found) are not shown.
==1708== To see them, rerun with: --leak-check=full --show-reachable=yes
==1708==
==1708== ERROR SUMMARY: 0 errors from 0 contexts (suppressed: 6 from 6)
--1708--
--1708-- used_suppression:      6 dl-hack3-cond-1
==1708==
==1708== ERROR SUMMARY: 0 errors from 0 contexts (suppressed: 6 from 6)
--1702-- REDIR: 0x3c5fe83ee0 (mempcpy) redirected to 0x4a08fb0 (mempcpy) Started Subsonic [PID 1710, /var/subsonic/subsonic_sh.log]
==1702==
==1702== HEAP SUMMARY:
==1702==     in use at exit: 41,181 bytes in 976 blocks
==1702==   total heap usage: 2,560 allocs, 1,584 frees, 98,877 bytes allocated
==1702==
==1702== Searching for pointers to 976 not-freed blocks
==1702== Checked 221,272 bytes
==1702==
==1702== LEAK SUMMARY:
==1702==    definitely lost: 0 bytes in 0 blocks
==1702==    indirectly lost: 0 bytes in 0 blocks
==1702==      possibly lost: 0 bytes in 0 blocks
==1702==    still reachable: 41,181 bytes in 976 blocks
==1702==         suppressed: 0 bytes in 0 blocks
==1702== Reachable blocks (those to which a pointer was found) are not shown.
==1702== To see them, rerun with: --leak-check=full --show-reachable=yes
==1702==
==1702== ERROR SUMMARY: 0 errors from 0 contexts (suppressed: 6 from 6)
--1702--
--1702-- used_suppression:      6 dl-hack3-cond-1
==1702==
==1702== ERROR SUMMARY: 0 errors from 0 contexts (suppressed: 6 from 6)



[GJ51]

Unless your downsampling an mp3 ffmpeg shouldn't be involved. An mp3 should get passed directly to JW Player on the desktop.

You could also try the latest ffmpeg builds http://ffmpeg.org/download.html but that should only affect transcoded and downsampled media.

[gurutech]

Hmmm.... let me create a user with no "max" on the bitrate and see if the songs that previously wouldn't play will play now... If that's the case, then it's definitely with the downsampling, and ffmpeg is the issue....

Edit: OK, definitely the downsampling... I can play all songs without downsampling, but as soon as I login with my regular account (limited to 128kbps, as are everyone else's accounts), certain songs don't play any more.

On a side note, I set my own account to "No Max", and some songs won't play. (The same ones that don't play normally on my account.) So I'm stuck again...

[gurutech]

Now really confused, but I think I pinpointed the issue...

In the attached file, I added "mp3" to the first transcoding line (see highlight). It still resides in its default location next to "SubWiji", but it appears to hit the first line first and ignore the SubWiji line.

Now I can play the songs I couldn't play previously, even with a "max" bitrate of 128kbps for my user account.

Try this solution and we'll see if it works.

[GJ51]

Check your player that is active. By default the Subwiji transcoding should NOT be checked for a player you're using on the desktop. From what you've done it suggests that your mp3's were trying to use the Subwijitranscoding on the desktop? By placing mp3 in the mp3 audio string you just put that string ahead in the list as SS will use the first available string if more than one transcoding is selected for a given player. Just a hunch...