Skipped songs

[funa]

I am using squeezecenter 7.3.3, SqueezeBox, Transporter and SoftSqueeze.

Since quite a long time I experience the following problem:
Some songs (usually the whole album) are not played - they are simply skipped.

Some time ago (I don't know exactly and with which version) everything worked fine. I have checked all the files and they play fine in WinAmp.

All my files are in FLAC format. Some albums have individual FLAC files, some one big FLAC + cue file. I use dBpoweramp for conversion of other lossless files to FLAC. Again, all files play normally in other players (e.g. WinAmp).

Any idea what could be wrong?

[funkstar]

Is there any pattern to the skipped files?

Is it the same ones all the time?

Try turning on some logging so you can see better what is going on (Set them to Debug)

Settings -> Advanced -> Logging -> player.source & player.streaming

[funa]

Yes, always the same songs get skipped. In this example the whole album gets skipped.

Attached is the log file (here just a few starting lines). I see some errors like "Rejecting - because required capability T not supported".
I don't know what this means.


[09-06-08 09:45:59.1898] Slim::Player::StreamingController::_eventAction (269) d8:45:51:0e:41:7e: EndOfStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_AutoStart
[09-06-08 09:45:59.1899] Slim::Player::StreamingController::_setStreamingSt ate (1872) new streaming state STREAMOUT
[09-06-08 09:45:59.2896] Slim::Player::StreamingController:layerReadyToStream (1695) d8:45:51:0e:41:7e
[09-06-08 09:45:59.2898] Slim::Player::StreamingController::_eventAction (269) d8:45:51:0e:41:7e: ReadyToStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_NextIfMore
[09-06-08 09:45:59.2900] Slim::Player::StreamingController::_setStreamingSt ate (1872) new streaming state IDLE
[09-06-08 09:45:59.2903] Slim::Player::StreamingController::nextsong (761) The next song is number 5, was 4
[09-06-08 09:45:59.2932] Slim::Player::Song::new (64) index 5 -> file:///mnt/md0/DATA/FLAC/GARY%20MOORE/Ballads%20&%20Blues%201982%20-%201994/Ballads%20&%20Blues%201982%20-%201994.flac#1388.10666666667-1682.26666666667
[09-06-08 09:45:59.2935] Slim::Player::Song::new (101) live=2
[09-06-08 09:45:59.2937] Slim::Player::StreamingController::_setStreamingSt ate (1872) new streaming state TRACKWAIT
[09-06-08 09:45:59.2940] Slim::Player::Song::getNextSong (178) file:///mnt/md0/DATA/FLAC/GARY%20MOORE/Ballads%20&%20Blues%201982%20-%201994/Ballads%20&%20Blues%201982%20-%201994.flac#1388.10666666667-1682.26666666667
[09-06-08 09:45:59.2942] Slim::Player::StreamingController::_nextTrackReady (653) d8:45:51:0e:41:7e: nextTrack will be index 5
[09-06-08 09:45:59.2945] Slim::Player::StreamingController::_eventAction (269) d8:45:51:0e:41:7e: NextTrackReady in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_StreamIfReady
[09-06-08 09:45:59.2947] Slim::Player::StreamingController::_Stream (927) d8:45:51:0e:41:7e: preparing to stream song index 5
[09-06-08 09:45:59.2949] Slim::Player::StreamingController::_Stream (942) Song queue is now 5,4
[09-06-08 09:45:59.2951] Slim::Player::Song:pen (302) file:///mnt/md0/DATA/FLAC/GARY%20MOORE/Ballads%20&%20Blues%201982%20-%201994/Ballads%20&%20Blues%201982%20-%201994.flac#1388.10666666667-1682.26666666667
[09-06-08 09:45:59.2960] Slim::Player::TranscodingHelper::getConvertCommand 2 (324) rateLimit = 0, type = flc, softsqueeze = d8:45:51:0e:41:7e
[09-06-08 09:45:59.2962] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if flc-flc-*-* is enabled
[09-06-08 09:45:59.2964] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: flc-ogg-softsqueeze-d8:45:51:0e:41:7e
[09-06-08 09:45:59.2966] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: flc-ogg-*-d8:45:51:0e:41:7e
[09-06-08 09:45:59.2968] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: flc-ogg-softsqueeze-*
[09-06-08 09:45:59.2970] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: flc-ogg-*-*
[09-06-08 09:45:59.2971] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: flc-flc-softsqueeze-d8:45:51:0e:41:7e
[09-06-08 09:45:59.2973] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: flc-flc-*-d8:45:51:0e:41:7e
[09-06-08 09:45:59.2975] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: flc-flc-softsqueeze-*
[09-06-08 09:45:59.2977] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: flc-flc-*-*
[09-06-08 09:45:59.2979] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if flc-flc-*-* is enabled
[09-06-08 09:45:59.2980] Slim::Player::TranscodingHelper::checkBin (235) enabled
[09-06-08 09:45:59.2982] Slim::Player::TranscodingHelper::checkBin (237) Found command: -
[09-06-08 09:45:59.2984] Slim::Player::TranscodingHelper::getConvertCommand 2 (400) Rejecting - because required capability T not supported:
[09-06-08 09:45:59.2986] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: flc-flc-transcode-*
[09-06-08 09:45:59.2988] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if flc-flc-transcode-* is enabled
[09-06-08 09:45:59.2990] Slim::Player::TranscodingHelper::checkBin (235) enabled
[09-06-08 09:45:59.2991] Slim::Player::TranscodingHelper::checkBin (237) Found command: [flac] -dcs $START$ $END$ -- $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -
[09-06-08 09:45:59.2994] Slim::Player::TranscodingHelper::getConvertCommand 2 (458) Matched: flc->flc via: [flac] -dcs $START$ $END$ -- $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -
[09-06-08 09:45:59.2996] Slim::Player::Song:pen (323) seek=false time=0 canSeek=2
[09-06-08 09:45:59.2999] Slim::Player::TranscodingHelper::getConvertCommand 2 (324) rateLimit = 0, type = flc, softsqueeze = d8:45:51:0e:41:7e
[09-06-08 09:45:59.3001] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if flc-flc-*-* is enabled
[09-06-08 09:45:59.3003] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: flc-ogg-softsqueeze-d8:45:51:0e:41:7e
[09-06-08 09:45:59.3005] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: flc-ogg-*-d8:45:51:0e:41:7e
[09-06-08 09:45:59.3007] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: flc-ogg-softsqueeze-*
[09-06-08 09:45:59.3009] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: flc-ogg-*-*
[09-06-08 09:45:59.3010] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: flc-flc-softsqueeze-d8:45:51:0e:41:7e
[09-06-08 09:45:59.3012] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: flc-flc-*-d8:45:51:0e:41:7e
[09-06-08 09:45:59.3014] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: flc-flc-softsqueeze-*
[09-06-08 09:45:59.3016] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: flc-flc-*-*
[09-06-08 09:45:59.3018] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if flc-flc-*-* is enabled
[09-06-08 09:45:59.3019] Slim::Player::TranscodingHelper::checkBin (235) enabled
[09-06-08 09:45:59.3021] Slim::Player::TranscodingHelper::checkBin (237) Found command: -
[09-06-08 09:45:59.3023] Slim::Player::TranscodingHelper::getConvertCommand 2 (400) Rejecting - because required capability T not supported:
[09-06-08 09:45:59.3025] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: flc-flc-transcode-*
[09-06-08 09:45:59.3026] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if flc-flc-transcode-* is enabled
[09-06-08 09:45:59.3028] Slim::Player::TranscodingHelper::checkBin (235) enabled
[09-06-08 09:45:59.3030] Slim::Player::TranscodingHelper::checkBin (237) Found command: [flac] -dcs $START$ $END$ -- $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -
[09-06-08 09:45:59.3032] Slim::Player::TranscodingHelper::getConvertCommand 2 (458) Matched: flc->flc via: [flac] -dcs $START$ $END$ -- $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -
[09-06-08 09:45:59.3034] Slim::Player::Song:pen (340) Transcoder: streamMode=F, streamformat=flc
[09-06-08 09:45:59.3045] Slim::Player::TranscodingHelper::tokenizeConvertCo mmand2 (561) Using command for conversion: "/usr/share/squeezecenter/Bin/i386-linux/flac" -dcs --skip=23:08.10 --until=28:02.26 -- "/mnt/md0/DATA/FLAC/GARY MOORE/Ballads & Blues 1982 - 1994/Ballads & Blues 1982 - 1994.flac" | "/usr/share/squeezecenter/Bin/i386-linux/sox" -q -t wav - -t flac -C 0 - & |
[09-06-08 09:45:59.3047] Slim::Player::Song:pen (460) Tokenized command "/usr/share/squeezecenter/Bin/i386-linux/flac" -dcs --skip=23:08.10 --until=28:02.26 -- "/mnt/md0/DATA/FLAC/GARY MOORE/Ballads & Blues 1982 - 1994/Ballads & Blues 1982 - 1994.flac" | "/usr/share/squeezecenter/Bin/i386-linux/sox" -q -t wav - -t flac -C 0 - & |
[09-06-08 09:45:59.3187] Slim::Player::SongStreamController::new (32) live=2
[09-06-08 09:45:59.3192] Slim::Player::SongStreamController:ESTROY (45) DESTROY(Slim::Player::SongStreamController=HASH(0x 6852d30)) live=1
[09-06-08 09:45:59.3195] Slim::Player::StreamingController::_Stream (995) d8:45:51:0e:41:7e: stream
[09-06-08 09:45:59.3203] Slim::Player::Transporter:lay (124) Setting DigitalInput to 0 for [file:///mnt/md0/DATA/FLAC/GARY%20MOORE/Ballads%20&%20Blues%201982%20-%201994/Ballads%20&%20Blues%201982%20-%201994.flac#1388.10666666667-1682.26666666667]
[09-06-08 09:45:59.3205] Slim::Player::Transporter::setDigitalInput (204) Switching to digital input 0
[09-06-08 09:45:59.3249] Slim::Player::StreamingController::_Stream (1025) Song queue is now 5,4
[09-06-08 09:45:59.3253] Slim::Player::StreamingController::_setStreamingSt ate (1872) new streaming state STREAMING
[09-06-08 09:45:59.3255] Slim::Player::StreamingController::_eventAction (301) d8:45:51:0e:41:7e: NextTrackReady - new state PLAYING-STREAMING
[09-06-08 09:45:59.3257] Slim::Player::StreamingController::_eventAction (301) d8:45:51:0e:41:7e: ReadyToStream - new state PLAYING-STREAMING
[09-06-08 09:45:59.3312] Slim::Player::Source::_readNextChunk (476) Read to end of file or pipe