===== Tuesday, April 21, 2009 8:48:14 AM US/Pacific ===== [09-04-21 08:58:51.6108] Slim::Utils::Strings::string (376) Error: missing string PLUGIN_WEATHERTIME_WIND_SOUTH [09-04-21 08:58:51.6245] Slim::Utils::Strings::string (376) Backtrace: frame 0: Slim::Utils::Log::logBacktrace (/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Slim/Utils/Strings.pm line 376) frame 1: Slim::Utils::Strings::string (Plugins/WeatherTime/Plugin.pm line 2473) frame 2: Plugins::WeatherTime::Plugin::retrieveWeather (Plugins/WeatherTime/Plugin.pm line 2024) frame 3: Plugins::WeatherTime::Plugin::tictac (/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Slim/Utils/Timers.pm line 211) frame 4: (eval) (/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Slim/Utils/Timers.pm line 211) frame 5: Slim::Utils::Timers::checkTimers (./slimserver.pl line 538) frame 6: main::idle (./slimserver.pl line 478) frame 7: main::main (./slimserver.pl line 1001) [09-04-21 08:58:51.6649] Slim::Utils::Strings::string (376) Error: missing string PLUGIN_WEATHERTIME_WIND_SOUTH [09-04-21 08:58:51.6653] Slim::Utils::Strings::string (376) Backtrace: frame 0: Slim::Utils::Log::logBacktrace (/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Slim/Utils/Strings.pm line 376) frame 1: Slim::Utils::Strings::string (Plugins/WeatherTime/Plugin.pm line 2520) frame 2: Plugins::WeatherTime::Plugin::getDayInfos (Plugins/WeatherTime/Plugin.pm line 2492) frame 3: Plugins::WeatherTime::Plugin::retrieveWeather (Plugins/WeatherTime/Plugin.pm line 2024) frame 4: Plugins::WeatherTime::Plugin::tictac (/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Slim/Utils/Timers.pm line 211) frame 5: (eval) (/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Slim/Utils/Timers.pm line 211) frame 6: Slim::Utils::Timers::checkTimers (./slimserver.pl line 538) frame 7: main::idle (./slimserver.pl line 478) frame 8: main::main (./slimserver.pl line 1001) [09-04-21 08:59:42.0570] Slim::Plugin::CLI::Plugin::cli_process (603) Error: Connections require authentication, check login command. [09-04-21 08:59:42.0574] Slim::Plugin::CLI::Plugin::cli_process (604) Error: Disconnecting: 216.245.212.18:1970 [09-04-21 08:59:42.1907] Slim::Plugin::CLI::Plugin::cli_process (603) Error: Connections require authentication, check login command. [09-04-21 08:59:42.1910] Slim::Plugin::CLI::Plugin::cli_process (604) Error: Disconnecting: 216.245.212.18:2129 [09-04-21 08:59:42.3566] Slim::Plugin::CLI::Plugin::cli_process (603) Error: Connections require authentication, check login command. [09-04-21 08:59:42.3569] Slim::Plugin::CLI::Plugin::cli_process (604) Error: Disconnecting: 216.245.212.18:2269 [09-04-21 08:59:42.5053] Slim::Plugin::CLI::Plugin::cli_process (603) Error: Connections require authentication, check login command. [09-04-21 08:59:42.5056] Slim::Plugin::CLI::Plugin::cli_process (604) Error: Disconnecting: 216.245.212.18:2569 [09-04-21 09:01:09.3053] Slim::Utils::Strings::string (376) Error: missing string PLUGIN_WEATHERTIME_WIND_SOUTH [09-04-21 09:01:09.3058] Slim::Utils::Strings::string (376) Backtrace: frame 0: Slim::Utils::Log::logBacktrace (/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Slim/Utils/Strings.pm line 376) frame 1: Slim::Utils::Strings::string (Plugins/WeatherTime/Plugin.pm line 2473) frame 2: Plugins::WeatherTime::Plugin::retrieveWeather (Plugins/WeatherTime/Plugin.pm line 2024) frame 3: Plugins::WeatherTime::Plugin::tictac (/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Slim/Utils/Timers.pm line 211) frame 4: (eval) (/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Slim/Utils/Timers.pm line 211) frame 5: Slim::Utils::Timers::checkTimers (./slimserver.pl line 538) frame 6: main::idle (./slimserver.pl line 478) frame 7: main::main (./slimserver.pl line 1001) [09-04-21 09:01:09.3267] Slim::Utils::Strings::string (376) Error: missing string PLUGIN_WEATHERTIME_WIND_SOUTH [09-04-21 09:01:09.3271] Slim::Utils::Strings::string (376) Backtrace: frame 0: Slim::Utils::Log::logBacktrace (/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Slim/Utils/Strings.pm line 376) frame 1: Slim::Utils::Strings::string (Plugins/WeatherTime/Plugin.pm line 2520) frame 2: Plugins::WeatherTime::Plugin::getDayInfos (Plugins/WeatherTime/Plugin.pm line 2492) frame 3: Plugins::WeatherTime::Plugin::retrieveWeather (Plugins/WeatherTime/Plugin.pm line 2024) frame 4: Plugins::WeatherTime::Plugin::tictac (/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Slim/Utils/Timers.pm line 211) frame 5: (eval) (/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Slim/Utils/Timers.pm line 211) frame 6: Slim::Utils::Timers::checkTimers (./slimserver.pl line 538) frame 7: main::idle (./slimserver.pl line 478) frame 8: main::main (./slimserver.pl line 1001) [09-04-21 09:02:26.4515] Slim::Player::TranscodingHelper::getConvertCommand2 (455) Error: Didn't find any command matches for type: mp4 [09-04-21 09:02:29.3930] Slim::Player::StreamingController::playerActive (1551) 00:04:20:10:02:d7 sync group now has: 00:04:20:10:02:d7 [09-04-21 09:02:29.3933] Slim::Player::StreamingController::playerActive (1552) 00:04:20:10:02:d7 active players are: 00:04:20:10:02:d7 [09-04-21 09:02:46.5337] Slim::Player::StreamingController::stop (1625) 00:04:20:10:02:d7 [09-04-21 09:02:46.5344] Slim::Player::Source::playmode (172) 00:04:20:10:02:d7: Current playmode: stop [09-04-21 09:02:46.5511] Slim::Player::StreamingController::play (1628) 00:04:20:10:02:d7 [09-04-21 09:02:46.5541] Slim::Player::StreamingController::_Stop (548) Song queue is now 0 [09-04-21 09:02:46.5545] Slim::Player::StreamingController::_setPlayingState (1882) new playing state STOPPED [09-04-21 09:02:46.5549] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state IDLE [09-04-21 09:02:46.5617] Slim::Player::Song::new (64) index 0 -> file:///Volumes/Music/Richard%20Marx/Richard%20Marx/01%20Should%27ve%20Known%20Better.m4a [09-04-21 09:02:46.5624] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state TRACKWAIT [09-04-21 09:02:46.5646] Slim::Player::Song::getNextSong (178) file:///Volumes/Music/Richard%20Marx/Richard%20Marx/01%20Should%27ve%20Known%20Better.m4a [09-04-21 09:02:46.5652] Slim::Player::StreamingController::_nextTrackReady (668) 00:04:20:10:02:d7: nextTrack will be index 0 [09-04-21 09:02:46.5656] Slim::Player::StreamingController::_Stream (942) 00:04:20:10:02:d7: preparing to stream song index 0 [09-04-21 09:02:46.5659] Slim::Player::StreamingController::_Stream (958) Song queue is now 0 [09-04-21 09:02:46.5663] Slim::Player::Song::open (302) file:///Volumes/Music/Richard%20Marx/Richard%20Marx/01%20Should%27ve%20Known%20Better.m4a [09-04-21 09:02:46.5694] Slim::Player::TranscodingHelper::getConvertCommand2 (455) Error: Didn't find any command matches for type: mp4 [09-04-21 09:02:46.5697] Slim::Player::Song::open (323) seek=false time=0 canSeek=0SEEK_ERROR_TYPE_NOT_SUPPORTEDmp4 [09-04-21 09:02:46.5707] Slim::Player::TranscodingHelper::getConvertCommand2 (458) Matched: mp4->flc via: [faad] -q -w -f 1 $FILE$ | [flac] -cs --totally-silent --compression-level-0 --ignore-chunk-sizes - [09-04-21 09:02:46.5711] Slim::Player::Song::open (340) Transcoder: streamMode=F, streamformat=flc [09-04-21 09:02:46.5721] Slim::Player::Song::open (460) Tokenized command "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/faad" -q -w -f 1 "/Volumes/Music/Richard Marx/Richard Marx/01 Should've Known Better.m4a" | "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/flac" -cs --totally-silent --compression-level-0 --ignore-chunk-sizes - & | [09-04-21 09:02:46.7930] Slim::Player::StreamingController::_Stream (1011) 00:04:20:10:02:d7: stream [09-04-21 09:02:46.7954] Slim::Player::Transporter::play (124) Setting DigitalInput to 0 for [file:///Volumes/Music/Richard%20Marx/Richard%20Marx/01%20Should%27ve%20Known%20Better.m4a] [09-04-21 09:02:46.7958] Slim::Player::Transporter::setDigitalInput (204) Switching to digital input 0 [09-04-21 09:02:46.8458] Slim::Player::StreamingController::_Stream (1041) Song queue is now 0 [09-04-21 09:02:46.8469] Slim::Player::StreamingController::_setPlayingState (1882) new playing state BUFFERING [09-04-21 09:02:46.8473] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state STREAMING [09-04-21 09:02:47.0890] Slim::Player::Source::_readNextChunk (499) end of file or error on socket, song pos: 0 [09-04-21 09:02:47.0895] Slim::Player::Source::_readNextChunk (506) Didn't stream any bytes for this song; mark it as failed [09-04-21 09:02:47.0900] Slim::Player::StreamingController::playerStreamingFailed (1759) 00:04:20:10:02:d7 [09-04-21 09:02:47.0907] Slim::Player::StreamingController::_playersMessage (711) Problem: Can't open file for:: file:///Volumes/Music/Richard%20Marx/Richard%20Marx/01%20Should%27ve%20Known%20Better.m4a [09-04-21 09:02:47.0944] Slim::Player::StreamingController::_Stop (548) Song queue is now 0 [09-04-21 09:02:47.0949] Slim::Player::StreamingController::_setPlayingState (1882) new playing state STOPPED [09-04-21 09:02:47.0952] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state IDLE [09-04-21 09:02:47.0957] Slim::Player::StreamingController::nextsong (776) The next song is number 1, was 0 [09-04-21 09:02:47.1003] Slim::Player::Song::new (64) index 1 -> file:///Volumes/Music/Richard%20Marx/Richard%20Marx/02%20Don%27t%20Mean%20Nothing.m4a [09-04-21 09:02:47.1008] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state TRACKWAIT [09-04-21 09:02:47.1013] Slim::Player::Song::getNextSong (178) file:///Volumes/Music/Richard%20Marx/Richard%20Marx/02%20Don%27t%20Mean%20Nothing.m4a [09-04-21 09:02:47.1016] Slim::Player::StreamingController::_nextTrackReady (668) 00:04:20:10:02:d7: nextTrack will be index 1 [09-04-21 09:02:47.1019] Slim::Player::StreamingController::_Stream (942) 00:04:20:10:02:d7: preparing to stream song index 1 [09-04-21 09:02:47.1022] Slim::Player::StreamingController::_Stream (958) Song queue is now 1 [09-04-21 09:02:47.1026] Slim::Player::Song::open (302) file:///Volumes/Music/Richard%20Marx/Richard%20Marx/02%20Don%27t%20Mean%20Nothing.m4a [09-04-21 09:02:47.1084] Slim::Player::TranscodingHelper::getConvertCommand2 (455) Error: Didn't find any command matches for type: alc [09-04-21 09:02:47.1088] Slim::Player::Song::open (323) seek=false time=0 canSeek=0SEEK_ERROR_TYPE_NOT_SUPPORTEDalc [09-04-21 09:02:47.1097] Slim::Player::TranscodingHelper::getConvertCommand2 (458) Matched: alc->pcm via: [alac] -r $FILE$ [09-04-21 09:02:47.1100] Slim::Player::Song::open (340) Transcoder: streamMode=F, streamformat=pcm [09-04-21 09:02:47.1109] Slim::Player::Song::open (460) Tokenized command "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/alac" -r "/Volumes/Music/Richard Marx/Richard Marx/02 Don't Mean Nothing.m4a" & | [09-04-21 09:02:47.1444] Slim::Player::StreamingController::_Stream (1011) 00:04:20:10:02:d7: stream [09-04-21 09:02:47.1470] Slim::Player::Transporter::play (124) Setting DigitalInput to 0 for [file:///Volumes/Music/Richard%20Marx/Richard%20Marx/02%20Don%27t%20Mean%20Nothing.m4a] [09-04-21 09:02:47.1475] Slim::Player::Transporter::setDigitalInput (204) Switching to digital input 0 [09-04-21 09:02:47.1529] Slim::Player::StreamingController::_Stream (1041) Song queue is now 1 [09-04-21 09:02:47.1541] Slim::Player::StreamingController::_setPlayingState (1882) new playing state BUFFERING [09-04-21 09:02:47.1544] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state STREAMING [09-04-21 09:02:47.2474] Slim::Player::StreamingController::playerTrackStarted (1701) 00:04:20:10:02:d7 [09-04-21 09:02:47.2478] Slim::Player::StreamingController::_setPlayingState (1882) new playing state PLAYING [09-04-21 09:02:47.2481] Slim::Player::StreamingController::_Playing (359) Song 1 has now started playing [09-04-21 09:02:47.2496] Slim::Player::StreamingController::_Playing (388) Song queue is now 1 [09-04-21 09:02:47.4046] Slim::Player::TranscodingHelper::getConvertCommand2 (455) Error: Didn't find any command matches for type: alc [09-04-21 09:02:56.1640] Slim::Player::StreamingController::stop (1625) 00:04:20:10:02:d7 [09-04-21 09:02:56.1657] Slim::Player::StreamingController::_Stop (548) Song queue is now 1 [09-04-21 09:02:56.1663] Slim::Player::StreamingController::_setPlayingState (1882) new playing state STOPPED [09-04-21 09:02:56.1666] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state IDLE [09-04-21 09:02:56.1675] Slim::Player::Source::playmode (172) 00:04:20:10:02:d7: Current playmode: stop [09-04-21 09:02:56.1814] Slim::Player::StreamingController::play (1628) 00:04:20:10:02:d7 [09-04-21 09:02:56.1843] Slim::Player::StreamingController::_Stop (548) Song queue is now 1 [09-04-21 09:02:56.1846] Slim::Player::StreamingController::_setPlayingState (1882) new playing state STOPPED [09-04-21 09:02:56.1849] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state IDLE [09-04-21 09:02:56.1900] Slim::Player::Song::new (64) index 0 -> file:///Volumes/Music/Rhonda%20Smith/Intellipop/01%20ITP.m4a [09-04-21 09:02:56.1906] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state TRACKWAIT [09-04-21 09:02:56.1913] Slim::Player::Song::getNextSong (178) file:///Volumes/Music/Rhonda%20Smith/Intellipop/01%20ITP.m4a [09-04-21 09:02:56.1917] Slim::Player::StreamingController::_nextTrackReady (668) 00:04:20:10:02:d7: nextTrack will be index 0 [09-04-21 09:02:56.1920] Slim::Player::StreamingController::_Stream (942) 00:04:20:10:02:d7: preparing to stream song index 0 [09-04-21 09:02:56.1923] Slim::Player::StreamingController::_Stream (958) Song queue is now 0 [09-04-21 09:02:56.1927] Slim::Player::Song::open (302) file:///Volumes/Music/Rhonda%20Smith/Intellipop/01%20ITP.m4a [09-04-21 09:02:56.1946] Slim::Player::TranscodingHelper::getConvertCommand2 (455) Error: Didn't find any command matches for type: alc [09-04-21 09:02:56.1950] Slim::Player::Song::open (323) seek=false time=0 canSeek=0SEEK_ERROR_TYPE_NOT_SUPPORTEDalc [09-04-21 09:02:56.1958] Slim::Player::TranscodingHelper::getConvertCommand2 (458) Matched: alc->pcm via: [alac] -r $FILE$ [09-04-21 09:02:56.1961] Slim::Player::Song::open (340) Transcoder: streamMode=F, streamformat=pcm [09-04-21 09:02:56.1972] Slim::Player::Song::open (460) Tokenized command "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/alac" -r "/Volumes/Music/Rhonda Smith/Intellipop/01 ITP.m4a" & | [09-04-21 09:02:56.2405] Slim::Player::StreamingController::_Stream (1011) 00:04:20:10:02:d7: stream [09-04-21 09:02:56.2431] Slim::Player::Transporter::play (124) Setting DigitalInput to 0 for [file:///Volumes/Music/Rhonda%20Smith/Intellipop/01%20ITP.m4a] [09-04-21 09:02:56.2436] Slim::Player::Transporter::setDigitalInput (204) Switching to digital input 0 [09-04-21 09:02:56.2538] Slim::Player::StreamingController::_Stream (1041) Song queue is now 0 [09-04-21 09:02:56.2550] Slim::Player::StreamingController::_setPlayingState (1882) new playing state BUFFERING [09-04-21 09:02:56.2555] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state STREAMING [09-04-21 09:02:56.9141] Slim::Player::StreamingController::playerTrackStarted (1701) 00:04:20:10:02:d7 [09-04-21 09:02:56.9145] Slim::Player::StreamingController::_setPlayingState (1882) new playing state PLAYING [09-04-21 09:02:56.9148] Slim::Player::StreamingController::_Playing (359) Song 0 has now started playing [09-04-21 09:02:56.9156] Slim::Player::StreamingController::_Playing (388) Song queue is now 0 [09-04-21 09:02:57.4474] Slim::Player::TranscodingHelper::getConvertCommand2 (455) Error: Didn't find any command matches for type: alc [09-04-21 09:03:02.9489] Slim::Player::StreamingController::stop (1625) 00:04:20:10:02:d7 [09-04-21 09:03:02.9506] Slim::Player::StreamingController::_Stop (548) Song queue is now 0 [09-04-21 09:03:02.9512] Slim::Player::StreamingController::_setPlayingState (1882) new playing state STOPPED [09-04-21 09:03:02.9515] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state IDLE [09-04-21 09:03:02.9524] Slim::Player::Source::playmode (172) 00:04:20:10:02:d7: Current playmode: stop [09-04-21 09:03:02.9956] Slim::Player::StreamingController::play (1628) 00:04:20:10:02:d7 [09-04-21 09:03:02.9987] Slim::Player::StreamingController::_Stop (548) Song queue is now 0 [09-04-21 09:03:02.9990] Slim::Player::StreamingController::_setPlayingState (1882) new playing state STOPPED [09-04-21 09:03:02.9994] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state IDLE [09-04-21 09:03:03.0142] Slim::Player::Song::new (64) index 0 -> file:///Volumes/Music/Rhonda%20Smith/RS2/01%20What%20Do%20They%20Think%20Music%20Is_.m4a [09-04-21 09:03:03.0148] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state TRACKWAIT [09-04-21 09:03:03.0153] Slim::Player::Song::getNextSong (178) file:///Volumes/Music/Rhonda%20Smith/RS2/01%20What%20Do%20They%20Think%20Music%20Is_.m4a [09-04-21 09:03:03.0158] Slim::Player::StreamingController::_nextTrackReady (668) 00:04:20:10:02:d7: nextTrack will be index 0 [09-04-21 09:03:03.0161] Slim::Player::StreamingController::_Stream (942) 00:04:20:10:02:d7: preparing to stream song index 0 [09-04-21 09:03:03.0164] Slim::Player::StreamingController::_Stream (958) Song queue is now 0 [09-04-21 09:03:03.0168] Slim::Player::Song::open (302) file:///Volumes/Music/Rhonda%20Smith/RS2/01%20What%20Do%20They%20Think%20Music%20Is_.m4a [09-04-21 09:03:03.0188] Slim::Player::TranscodingHelper::getConvertCommand2 (455) Error: Didn't find any command matches for type: mp4 [09-04-21 09:03:03.0191] Slim::Player::Song::open (323) seek=false time=0 canSeek=0SEEK_ERROR_TYPE_NOT_SUPPORTEDmp4 [09-04-21 09:03:03.0199] Slim::Player::TranscodingHelper::getConvertCommand2 (458) Matched: mp4->flc via: [faad] -q -w -f 1 $FILE$ | [flac] -cs --totally-silent --compression-level-0 --ignore-chunk-sizes - [09-04-21 09:03:03.0203] Slim::Player::Song::open (340) Transcoder: streamMode=F, streamformat=flc [09-04-21 09:03:03.0216] Slim::Player::Song::open (460) Tokenized command "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/faad" -q -w -f 1 "/Volumes/Music/Rhonda Smith/RS2/01 What Do They Think Music Is_.m4a" | "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/flac" -cs --totally-silent --compression-level-0 --ignore-chunk-sizes - & | [09-04-21 09:03:03.0677] Slim::Player::StreamingController::_Stream (1011) 00:04:20:10:02:d7: stream [09-04-21 09:03:03.0702] Slim::Player::Transporter::play (124) Setting DigitalInput to 0 for [file:///Volumes/Music/Rhonda%20Smith/RS2/01%20What%20Do%20They%20Think%20Music%20Is_.m4a] [09-04-21 09:03:03.0706] Slim::Player::Transporter::setDigitalInput (204) Switching to digital input 0 [09-04-21 09:03:03.0802] Slim::Player::StreamingController::_Stream (1041) Song queue is now 0 [09-04-21 09:03:03.0813] Slim::Player::StreamingController::_setPlayingState (1882) new playing state BUFFERING [09-04-21 09:03:03.0817] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state STREAMING [09-04-21 09:03:03.2592] Slim::Player::Source::_readNextChunk (499) end of file or error on socket, song pos: 12599296 [09-04-21 09:03:03.2595] Slim::Player::Source::_readNextChunk (506) Didn't stream any bytes for this song; mark it as failed [09-04-21 09:03:03.2599] Slim::Player::StreamingController::playerStreamingFailed (1759) 00:04:20:10:02:d7 [09-04-21 09:03:03.2603] Slim::Player::StreamingController::_playersMessage (711) Problem: Can't open file for:: file:///Volumes/Music/Rhonda%20Smith/RS2/01%20What%20Do%20They%20Think%20Music%20Is_.m4a [09-04-21 09:03:03.2622] Slim::Player::StreamingController::_Stop (548) Song queue is now 0 [09-04-21 09:03:03.2627] Slim::Player::StreamingController::_setPlayingState (1882) new playing state STOPPED [09-04-21 09:03:03.2630] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state IDLE [09-04-21 09:03:03.2636] Slim::Player::StreamingController::nextsong (776) The next song is number 1, was 0 [09-04-21 09:03:03.2686] Slim::Player::Song::new (64) index 1 -> file:///Volumes/Music/Rhonda%20Smith/RS2/02%20To%20Get%20With%20You.m4a [09-04-21 09:03:03.2690] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state TRACKWAIT [09-04-21 09:03:03.2695] Slim::Player::Song::getNextSong (178) file:///Volumes/Music/Rhonda%20Smith/RS2/02%20To%20Get%20With%20You.m4a [09-04-21 09:03:03.2699] Slim::Player::StreamingController::_nextTrackReady (668) 00:04:20:10:02:d7: nextTrack will be index 1 [09-04-21 09:03:03.2702] Slim::Player::StreamingController::_Stream (942) 00:04:20:10:02:d7: preparing to stream song index 1 [09-04-21 09:03:03.2705] Slim::Player::StreamingController::_Stream (958) Song queue is now 1 [09-04-21 09:03:03.2709] Slim::Player::Song::open (302) file:///Volumes/Music/Rhonda%20Smith/RS2/02%20To%20Get%20With%20You.m4a [09-04-21 09:03:03.2731] Slim::Player::TranscodingHelper::getConvertCommand2 (455) Error: Didn't find any command matches for type: alc [09-04-21 09:03:03.2734] Slim::Player::Song::open (323) seek=false time=0 canSeek=0SEEK_ERROR_TYPE_NOT_SUPPORTEDalc [09-04-21 09:03:03.2744] Slim::Player::TranscodingHelper::getConvertCommand2 (458) Matched: alc->pcm via: [alac] -r $FILE$ [09-04-21 09:03:03.2747] Slim::Player::Song::open (340) Transcoder: streamMode=F, streamformat=pcm [09-04-21 09:03:03.2758] Slim::Player::Song::open (460) Tokenized command "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/alac" -r "/Volumes/Music/Rhonda Smith/RS2/02 To Get With You.m4a" & | [09-04-21 09:03:03.3174] Slim::Player::StreamingController::_Stream (1011) 00:04:20:10:02:d7: stream [09-04-21 09:03:03.3199] Slim::Player::Transporter::play (124) Setting DigitalInput to 0 for [file:///Volumes/Music/Rhonda%20Smith/RS2/02%20To%20Get%20With%20You.m4a] [09-04-21 09:03:03.3203] Slim::Player::Transporter::setDigitalInput (204) Switching to digital input 0 [09-04-21 09:03:03.3246] Slim::Player::StreamingController::_Stream (1041) Song queue is now 1 [09-04-21 09:03:03.3257] Slim::Player::StreamingController::_setPlayingState (1882) new playing state BUFFERING [09-04-21 09:03:03.3261] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state STREAMING [09-04-21 09:03:04.1293] Slim::Player::StreamingController::playerTrackStarted (1701) 00:04:20:10:02:d7 [09-04-21 09:03:04.1297] Slim::Player::StreamingController::_setPlayingState (1882) new playing state PLAYING [09-04-21 09:03:04.1300] Slim::Player::StreamingController::_Playing (359) Song 1 has now started playing [09-04-21 09:03:04.1310] Slim::Player::StreamingController::_Playing (388) Song queue is now 1 [09-04-21 09:03:09.7567] Slim::Player::StreamingController::stop (1625) 00:04:20:10:02:d7 [09-04-21 09:03:09.7584] Slim::Player::StreamingController::_Stop (548) Song queue is now 1 [09-04-21 09:03:09.7590] Slim::Player::StreamingController::_setPlayingState (1882) new playing state STOPPED [09-04-21 09:03:09.7593] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state IDLE [09-04-21 09:03:09.7601] Slim::Player::Source::playmode (172) 00:04:20:10:02:d7: Current playmode: stop [09-04-21 09:03:09.7877] Slim::Player::StreamingController::play (1628) 00:04:20:10:02:d7 [09-04-21 09:03:09.7904] Slim::Player::StreamingController::_Stop (548) Song queue is now 1 [09-04-21 09:03:09.7907] Slim::Player::StreamingController::_setPlayingState (1882) new playing state STOPPED [09-04-21 09:03:09.7910] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state IDLE [09-04-21 09:03:09.7969] Slim::Player::Song::new (64) index 0 -> file:///Volumes/Music/Return%20To%20Forever/The%20Anthology/1-01%20Hymn%20Of%20The%20Seventh%20Galaxy.m4a [09-04-21 09:03:09.7974] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state TRACKWAIT [09-04-21 09:03:09.7980] Slim::Player::Song::getNextSong (178) file:///Volumes/Music/Return%20To%20Forever/The%20Anthology/1-01%20Hymn%20Of%20The%20Seventh%20Galaxy.m4a [09-04-21 09:03:09.7984] Slim::Player::StreamingController::_nextTrackReady (668) 00:04:20:10:02:d7: nextTrack will be index 0 [09-04-21 09:03:09.7987] Slim::Player::StreamingController::_Stream (942) 00:04:20:10:02:d7: preparing to stream song index 0 [09-04-21 09:03:09.7990] Slim::Player::StreamingController::_Stream (958) Song queue is now 0 [09-04-21 09:03:09.7994] Slim::Player::Song::open (302) file:///Volumes/Music/Return%20To%20Forever/The%20Anthology/1-01%20Hymn%20Of%20The%20Seventh%20Galaxy.m4a [09-04-21 09:03:09.8019] Slim::Player::TranscodingHelper::getConvertCommand2 (455) Error: Didn't find any command matches for type: alc [09-04-21 09:03:09.8023] Slim::Player::Song::open (323) seek=false time=0 canSeek=0SEEK_ERROR_TYPE_NOT_SUPPORTEDalc [09-04-21 09:03:09.8032] Slim::Player::TranscodingHelper::getConvertCommand2 (458) Matched: alc->pcm via: [alac] -r $FILE$ [09-04-21 09:03:09.8035] Slim::Player::Song::open (340) Transcoder: streamMode=F, streamformat=pcm [09-04-21 09:03:09.8046] Slim::Player::Song::open (460) Tokenized command "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/alac" -r "/Volumes/Music/Return To Forever/The Anthology/1-01 Hymn Of The Seventh Galaxy.m4a" & | [09-04-21 09:03:09.8458] Slim::Player::StreamingController::_Stream (1011) 00:04:20:10:02:d7: stream [09-04-21 09:03:09.8486] Slim::Player::Transporter::play (124) Setting DigitalInput to 0 for [file:///Volumes/Music/Return%20To%20Forever/The%20Anthology/1-01%20Hymn%20Of%20The%20Seventh%20Galaxy.m4a] [09-04-21 09:03:09.8490] Slim::Player::Transporter::setDigitalInput (204) Switching to digital input 0 [09-04-21 09:03:09.8598] Slim::Player::StreamingController::_Stream (1041) Song queue is now 0 [09-04-21 09:03:09.8610] Slim::Player::StreamingController::_setPlayingState (1882) new playing state BUFFERING [09-04-21 09:03:09.8615] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state STREAMING [09-04-21 09:03:10.2111] Slim::Player::StreamingController::playerTrackStarted (1701) 00:04:20:10:02:d7 [09-04-21 09:03:10.2115] Slim::Player::StreamingController::_setPlayingState (1882) new playing state PLAYING [09-04-21 09:03:10.2118] Slim::Player::StreamingController::_Playing (359) Song 0 has now started playing [09-04-21 09:03:10.2127] Slim::Player::StreamingController::_Playing (388) Song queue is now 0 [09-04-21 09:03:12.6297] Slim::Player::TranscodingHelper::getConvertCommand2 (455) Error: Didn't find any command matches for type: alc [09-04-21 09:03:14.7413] Slim::Player::StreamingController::stop (1625) 00:04:20:10:02:d7 [09-04-21 09:03:14.7430] Slim::Player::StreamingController::_Stop (548) Song queue is now 0 [09-04-21 09:03:14.7436] Slim::Player::StreamingController::_setPlayingState (1882) new playing state STOPPED [09-04-21 09:03:14.7439] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state IDLE [09-04-21 09:03:14.7448] Slim::Player::Source::playmode (172) 00:04:20:10:02:d7: Current playmode: stop [09-04-21 09:03:14.7586] Slim::Player::StreamingController::play (1628) 00:04:20:10:02:d7 [09-04-21 09:03:14.7602] Slim::Player::StreamingController::_Stop (548) Song queue is now 0 [09-04-21 09:03:14.7606] Slim::Player::StreamingController::_setPlayingState (1882) new playing state STOPPED [09-04-21 09:03:14.7609] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state IDLE [09-04-21 09:03:14.7656] Slim::Player::Song::new (64) index 0 -> file:///Volumes/Music/Rhonda%20Smith/Intellipop/01%20ITP.m4a [09-04-21 09:03:14.7662] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state TRACKWAIT [09-04-21 09:03:14.7667] Slim::Player::Song::getNextSong (178) file:///Volumes/Music/Rhonda%20Smith/Intellipop/01%20ITP.m4a [09-04-21 09:03:14.7671] Slim::Player::StreamingController::_nextTrackReady (668) 00:04:20:10:02:d7: nextTrack will be index 0 [09-04-21 09:03:14.7674] Slim::Player::StreamingController::_Stream (942) 00:04:20:10:02:d7: preparing to stream song index 0 [09-04-21 09:03:14.7677] Slim::Player::StreamingController::_Stream (958) Song queue is now 0 [09-04-21 09:03:14.7681] Slim::Player::Song::open (302) file:///Volumes/Music/Rhonda%20Smith/Intellipop/01%20ITP.m4a [09-04-21 09:03:14.7700] Slim::Player::TranscodingHelper::getConvertCommand2 (455) Error: Didn't find any command matches for type: alc [09-04-21 09:03:14.7703] Slim::Player::Song::open (323) seek=false time=0 canSeek=0SEEK_ERROR_TYPE_NOT_SUPPORTEDalc [09-04-21 09:03:14.7711] Slim::Player::TranscodingHelper::getConvertCommand2 (458) Matched: alc->pcm via: [alac] -r $FILE$ [09-04-21 09:03:14.7714] Slim::Player::Song::open (340) Transcoder: streamMode=F, streamformat=pcm [09-04-21 09:03:14.7725] Slim::Player::Song::open (460) Tokenized command "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/alac" -r "/Volumes/Music/Rhonda Smith/Intellipop/01 ITP.m4a" & | [09-04-21 09:03:14.8115] Slim::Player::StreamingController::_Stream (1011) 00:04:20:10:02:d7: stream [09-04-21 09:03:14.8140] Slim::Player::Transporter::play (124) Setting DigitalInput to 0 for [file:///Volumes/Music/Rhonda%20Smith/Intellipop/01%20ITP.m4a] [09-04-21 09:03:14.8144] Slim::Player::Transporter::setDigitalInput (204) Switching to digital input 0 [09-04-21 09:03:14.8241] Slim::Player::StreamingController::_Stream (1041) Song queue is now 0 [09-04-21 09:03:14.8253] Slim::Player::StreamingController::_setPlayingState (1882) new playing state BUFFERING [09-04-21 09:03:14.8256] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state STREAMING [09-04-21 09:03:15.1532] Slim::Player::StreamingController::playerTrackStarted (1701) 00:04:20:10:02:d7 [09-04-21 09:03:15.1536] Slim::Player::StreamingController::_setPlayingState (1882) new playing state PLAYING [09-04-21 09:03:15.1539] Slim::Player::StreamingController::_Playing (359) Song 0 has now started playing [09-04-21 09:03:15.1547] Slim::Player::StreamingController::_Playing (388) Song queue is now 0 [09-04-21 09:03:21.2695] Slim::Player::StreamingController::stop (1625) 00:04:20:10:02:d7 [09-04-21 09:03:21.2713] Slim::Player::StreamingController::_Stop (548) Song queue is now 0 [09-04-21 09:03:21.2719] Slim::Player::StreamingController::_setPlayingState (1882) new playing state STOPPED [09-04-21 09:03:21.2722] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state IDLE [09-04-21 09:03:21.2730] Slim::Player::Source::playmode (172) 00:04:20:10:02:d7: Current playmode: stop [09-04-21 09:03:21.2981] Slim::Player::StreamingController::play (1628) 00:04:20:10:02:d7 [09-04-21 09:03:21.2996] Slim::Player::StreamingController::_Stop (548) Song queue is now 0 [09-04-21 09:03:21.2999] Slim::Player::StreamingController::_setPlayingState (1882) new playing state STOPPED [09-04-21 09:03:21.3002] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state IDLE [09-04-21 09:03:21.3051] Slim::Player::Song::new (64) index 0 -> file:///Volumes/Music/Rhonda%20Smith/RS2/01%20What%20Do%20They%20Think%20Music%20Is_.m4a [09-04-21 09:03:21.3059] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state TRACKWAIT [09-04-21 09:03:21.3065] Slim::Player::Song::getNextSong (178) file:///Volumes/Music/Rhonda%20Smith/RS2/01%20What%20Do%20They%20Think%20Music%20Is_.m4a [09-04-21 09:03:21.3069] Slim::Player::StreamingController::_nextTrackReady (668) 00:04:20:10:02:d7: nextTrack will be index 0 [09-04-21 09:03:21.3072] Slim::Player::StreamingController::_Stream (942) 00:04:20:10:02:d7: preparing to stream song index 0 [09-04-21 09:03:21.3075] Slim::Player::StreamingController::_Stream (958) Song queue is now 0 [09-04-21 09:03:21.3079] Slim::Player::Song::open (302) file:///Volumes/Music/Rhonda%20Smith/RS2/01%20What%20Do%20They%20Think%20Music%20Is_.m4a [09-04-21 09:03:21.3102] Slim::Player::TranscodingHelper::getConvertCommand2 (455) Error: Didn't find any command matches for type: mp4 [09-04-21 09:03:21.3106] Slim::Player::Song::open (323) seek=false time=0 canSeek=0SEEK_ERROR_TYPE_NOT_SUPPORTEDmp4 [09-04-21 09:03:21.3114] Slim::Player::TranscodingHelper::getConvertCommand2 (458) Matched: mp4->flc via: [faad] -q -w -f 1 $FILE$ | [flac] -cs --totally-silent --compression-level-0 --ignore-chunk-sizes - [09-04-21 09:03:21.3118] Slim::Player::Song::open (340) Transcoder: streamMode=F, streamformat=flc [09-04-21 09:03:21.3128] Slim::Player::Song::open (460) Tokenized command "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/faad" -q -w -f 1 "/Volumes/Music/Rhonda Smith/RS2/01 What Do They Think Music Is_.m4a" | "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/flac" -cs --totally-silent --compression-level-0 --ignore-chunk-sizes - & | [09-04-21 09:03:21.3613] Slim::Player::StreamingController::_Stream (1011) 00:04:20:10:02:d7: stream [09-04-21 09:03:21.3640] Slim::Player::Transporter::play (124) Setting DigitalInput to 0 for [file:///Volumes/Music/Rhonda%20Smith/RS2/01%20What%20Do%20They%20Think%20Music%20Is_.m4a] [09-04-21 09:03:21.3644] Slim::Player::Transporter::setDigitalInput (204) Switching to digital input 0 [09-04-21 09:03:21.3738] Slim::Player::StreamingController::_Stream (1041) Song queue is now 0 [09-04-21 09:03:21.3748] Slim::Player::StreamingController::_setPlayingState (1882) new playing state BUFFERING [09-04-21 09:03:21.3751] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state STREAMING [09-04-21 09:03:21.6470] Slim::Player::Source::_readNextChunk (499) end of file or error on socket, song pos: 30425088 [09-04-21 09:03:21.6474] Slim::Player::Source::_readNextChunk (506) Didn't stream any bytes for this song; mark it as failed [09-04-21 09:03:21.6477] Slim::Player::StreamingController::playerStreamingFailed (1759) 00:04:20:10:02:d7 [09-04-21 09:03:21.6482] Slim::Player::StreamingController::_playersMessage (711) Problem: Can't open file for:: file:///Volumes/Music/Rhonda%20Smith/RS2/01%20What%20Do%20They%20Think%20Music%20Is_.m4a [09-04-21 09:03:21.6521] Slim::Player::StreamingController::_Stop (548) Song queue is now 0 [09-04-21 09:03:21.6528] Slim::Player::StreamingController::_setPlayingState (1882) new playing state STOPPED [09-04-21 09:03:21.6531] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state IDLE [09-04-21 09:03:21.6540] Slim::Player::StreamingController::nextsong (776) The next song is number 1, was 0 [09-04-21 09:03:21.6582] Slim::Player::Song::new (64) index 1 -> file:///Volumes/Music/Rhonda%20Smith/RS2/02%20To%20Get%20With%20You.m4a [09-04-21 09:03:21.6588] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state TRACKWAIT [09-04-21 09:03:21.6592] Slim::Player::Song::getNextSong (178) file:///Volumes/Music/Rhonda%20Smith/RS2/02%20To%20Get%20With%20You.m4a [09-04-21 09:03:21.6596] Slim::Player::StreamingController::_nextTrackReady (668) 00:04:20:10:02:d7: nextTrack will be index 1 [09-04-21 09:03:21.6599] Slim::Player::StreamingController::_Stream (942) 00:04:20:10:02:d7: preparing to stream song index 1 [09-04-21 09:03:21.6602] Slim::Player::StreamingController::_Stream (958) Song queue is now 1 [09-04-21 09:03:21.6606] Slim::Player::Song::open (302) file:///Volumes/Music/Rhonda%20Smith/RS2/02%20To%20Get%20With%20You.m4a [09-04-21 09:03:21.6629] Slim::Player::TranscodingHelper::getConvertCommand2 (455) Error: Didn't find any command matches for type: alc [09-04-21 09:03:21.6632] Slim::Player::Song::open (323) seek=false time=0 canSeek=0SEEK_ERROR_TYPE_NOT_SUPPORTEDalc [09-04-21 09:03:21.6641] Slim::Player::TranscodingHelper::getConvertCommand2 (458) Matched: alc->pcm via: [alac] -r $FILE$ [09-04-21 09:03:21.6644] Slim::Player::Song::open (340) Transcoder: streamMode=F, streamformat=pcm [09-04-21 09:03:21.6655] Slim::Player::Song::open (460) Tokenized command "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/alac" -r "/Volumes/Music/Rhonda Smith/RS2/02 To Get With You.m4a" & | [09-04-21 09:03:21.7091] Slim::Player::StreamingController::_Stream (1011) 00:04:20:10:02:d7: stream [09-04-21 09:03:21.7116] Slim::Player::Transporter::play (124) Setting DigitalInput to 0 for [file:///Volumes/Music/Rhonda%20Smith/RS2/02%20To%20Get%20With%20You.m4a] [09-04-21 09:03:21.7120] Slim::Player::Transporter::setDigitalInput (204) Switching to digital input 0 [09-04-21 09:03:21.7164] Slim::Player::StreamingController::_Stream (1041) Song queue is now 1 [09-04-21 09:03:21.7176] Slim::Player::StreamingController::_setPlayingState (1882) new playing state BUFFERING [09-04-21 09:03:21.7180] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state STREAMING [09-04-21 09:03:22.2178] Slim::Player::StreamingController::playerTrackStarted (1701) 00:04:20:10:02:d7 [09-04-21 09:03:22.2182] Slim::Player::StreamingController::_setPlayingState (1882) new playing state PLAYING [09-04-21 09:03:22.2185] Slim::Player::StreamingController::_Playing (359) Song 1 has now started playing [09-04-21 09:03:22.2195] Slim::Player::StreamingController::_Playing (388) Song queue is now 1 [09-04-21 09:03:22.7008] Slim::Player::TranscodingHelper::getConvertCommand2 (455) Error: Didn't find any command matches for type: alc [09-04-21 09:03:25.4172] Slim::Player::StreamingController::play (1628) 00:04:20:10:02:d7 [09-04-21 09:03:25.4190] Slim::Player::StreamingController::_Stop (548) Song queue is now 1 [09-04-21 09:03:25.4196] Slim::Player::StreamingController::_setPlayingState (1882) new playing state STOPPED [09-04-21 09:03:25.4199] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state IDLE [09-04-21 09:03:25.4239] Slim::Player::Song::new (64) index 0 -> file:///Volumes/Music/Rhonda%20Smith/RS2/01%20What%20Do%20They%20Think%20Music%20Is_.m4a [09-04-21 09:03:25.4244] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state TRACKWAIT [09-04-21 09:03:25.4250] Slim::Player::Song::getNextSong (178) file:///Volumes/Music/Rhonda%20Smith/RS2/01%20What%20Do%20They%20Think%20Music%20Is_.m4a [09-04-21 09:03:25.4253] Slim::Player::StreamingController::_nextTrackReady (668) 00:04:20:10:02:d7: nextTrack will be index 0 [09-04-21 09:03:25.4257] Slim::Player::StreamingController::_Stream (942) 00:04:20:10:02:d7: preparing to stream song index 0 [09-04-21 09:03:25.4260] Slim::Player::StreamingController::_Stream (958) Song queue is now 0 [09-04-21 09:03:25.4264] Slim::Player::Song::open (302) file:///Volumes/Music/Rhonda%20Smith/RS2/01%20What%20Do%20They%20Think%20Music%20Is_.m4a [09-04-21 09:03:25.4286] Slim::Player::TranscodingHelper::getConvertCommand2 (455) Error: Didn't find any command matches for type: mp4 [09-04-21 09:03:25.4289] Slim::Player::Song::open (323) seek=false time=0 canSeek=0SEEK_ERROR_TYPE_NOT_SUPPORTEDmp4 [09-04-21 09:03:25.4298] Slim::Player::TranscodingHelper::getConvertCommand2 (458) Matched: mp4->flc via: [faad] -q -w -f 1 $FILE$ | [flac] -cs --totally-silent --compression-level-0 --ignore-chunk-sizes - [09-04-21 09:03:25.4301] Slim::Player::Song::open (340) Transcoder: streamMode=F, streamformat=flc [09-04-21 09:03:25.4313] Slim::Player::Song::open (460) Tokenized command "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/faad" -q -w -f 1 "/Volumes/Music/Rhonda Smith/RS2/01 What Do They Think Music Is_.m4a" | "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/flac" -cs --totally-silent --compression-level-0 --ignore-chunk-sizes - & | [09-04-21 09:03:25.4798] Slim::Player::StreamingController::_Stream (1011) 00:04:20:10:02:d7: stream [09-04-21 09:03:25.4825] Slim::Player::Transporter::play (124) Setting DigitalInput to 0 for [file:///Volumes/Music/Rhonda%20Smith/RS2/01%20What%20Do%20They%20Think%20Music%20Is_.m4a] [09-04-21 09:03:25.4829] Slim::Player::Transporter::setDigitalInput (204) Switching to digital input 0 [09-04-21 09:03:25.4871] Slim::Player::StreamingController::_Stream (1041) Song queue is now 0 [09-04-21 09:03:25.4882] Slim::Player::StreamingController::_setPlayingState (1882) new playing state BUFFERING [09-04-21 09:03:25.4886] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state STREAMING [09-04-21 09:03:25.5303] Slim::Player::Source::_readNextChunk (499) end of file or error on socket, song pos: 35962880 [09-04-21 09:03:25.5306] Slim::Player::Source::_readNextChunk (506) Didn't stream any bytes for this song; mark it as failed [09-04-21 09:03:25.5310] Slim::Player::StreamingController::playerStreamingFailed (1759) 00:04:20:10:02:d7 [09-04-21 09:03:25.5316] Slim::Player::StreamingController::_playersMessage (711) Problem: Can't open file for:: file:///Volumes/Music/Rhonda%20Smith/RS2/01%20What%20Do%20They%20Think%20Music%20Is_.m4a [09-04-21 09:03:25.5340] Slim::Player::StreamingController::_Stop (548) Song queue is now 0 [09-04-21 09:03:25.5346] Slim::Player::StreamingController::_setPlayingState (1882) new playing state STOPPED [09-04-21 09:03:25.5349] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state IDLE [09-04-21 09:03:25.5355] Slim::Player::StreamingController::nextsong (776) The next song is number 1, was 0 [09-04-21 09:03:25.6162] Slim::Player::Song::new (64) index 1 -> file:///Volumes/Music/Rhonda%20Smith/RS2/02%20To%20Get%20With%20You.m4a [09-04-21 09:03:25.6169] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state TRACKWAIT [09-04-21 09:03:25.6174] Slim::Player::Song::getNextSong (178) file:///Volumes/Music/Rhonda%20Smith/RS2/02%20To%20Get%20With%20You.m4a [09-04-21 09:03:25.6178] Slim::Player::StreamingController::_nextTrackReady (668) 00:04:20:10:02:d7: nextTrack will be index 1 [09-04-21 09:03:25.6183] Slim::Player::StreamingController::_Stream (942) 00:04:20:10:02:d7: preparing to stream song index 1 [09-04-21 09:03:25.6186] Slim::Player::StreamingController::_Stream (958) Song queue is now 1 [09-04-21 09:03:25.6191] Slim::Player::Song::open (302) file:///Volumes/Music/Rhonda%20Smith/RS2/02%20To%20Get%20With%20You.m4a [09-04-21 09:03:25.6220] Slim::Player::TranscodingHelper::getConvertCommand2 (455) Error: Didn't find any command matches for type: alc [09-04-21 09:03:25.6224] Slim::Player::Song::open (323) seek=false time=0 canSeek=0SEEK_ERROR_TYPE_NOT_SUPPORTEDalc [09-04-21 09:03:25.6237] Slim::Player::TranscodingHelper::getConvertCommand2 (458) Matched: alc->pcm via: [alac] -r $FILE$ [09-04-21 09:03:25.6241] Slim::Player::Song::open (340) Transcoder: streamMode=F, streamformat=pcm [09-04-21 09:03:25.6254] Slim::Player::Song::open (460) Tokenized command "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/alac" -r "/Volumes/Music/Rhonda Smith/RS2/02 To Get With You.m4a" & | [09-04-21 09:03:25.6721] Slim::Player::StreamingController::_Stream (1011) 00:04:20:10:02:d7: stream [09-04-21 09:03:25.6748] Slim::Player::Transporter::play (124) Setting DigitalInput to 0 for [file:///Volumes/Music/Rhonda%20Smith/RS2/02%20To%20Get%20With%20You.m4a] [09-04-21 09:03:25.6752] Slim::Player::Transporter::setDigitalInput (204) Switching to digital input 0 [09-04-21 09:03:25.6795] Slim::Player::StreamingController::_Stream (1041) Song queue is now 1 [09-04-21 09:03:25.6806] Slim::Player::StreamingController::_setPlayingState (1882) new playing state BUFFERING [09-04-21 09:03:25.6809] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state STREAMING [09-04-21 09:03:25.8161] Slim::Player::StreamingController::playerTrackStarted (1701) 00:04:20:10:02:d7 [09-04-21 09:03:25.8166] Slim::Player::StreamingController::_setPlayingState (1882) new playing state PLAYING [09-04-21 09:03:25.8169] Slim::Player::StreamingController::_Playing (359) Song 1 has now started playing [09-04-21 09:03:25.8186] Slim::Player::StreamingController::_Playing (388) Song queue is now 1 [09-04-21 09:03:27.7564] Slim::Player::TranscodingHelper::getConvertCommand2 (455) Error: Didn't find any command matches for type: alc [09-04-21 09:03:31.3306] Slim::Player::StreamingController::play (1628) 00:04:20:10:02:d7 [09-04-21 09:03:31.3324] Slim::Player::StreamingController::_Stop (548) Song queue is now 1 [09-04-21 09:03:31.3330] Slim::Player::StreamingController::_setPlayingState (1882) new playing state STOPPED [09-04-21 09:03:31.3333] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state IDLE [09-04-21 09:03:31.3372] Slim::Player::Song::new (64) index 0 -> file:///Volumes/Music/Rhonda%20Smith/RS2/01%20What%20Do%20They%20Think%20Music%20Is_.m4a [09-04-21 09:03:31.3377] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state TRACKWAIT [09-04-21 09:03:31.3383] Slim::Player::Song::getNextSong (178) file:///Volumes/Music/Rhonda%20Smith/RS2/01%20What%20Do%20They%20Think%20Music%20Is_.m4a [09-04-21 09:03:31.3387] Slim::Player::StreamingController::_nextTrackReady (668) 00:04:20:10:02:d7: nextTrack will be index 0 [09-04-21 09:03:31.3391] Slim::Player::StreamingController::_Stream (942) 00:04:20:10:02:d7: preparing to stream song index 0 [09-04-21 09:03:31.3394] Slim::Player::StreamingController::_Stream (958) Song queue is now 0 [09-04-21 09:03:31.3400] Slim::Player::Song::open (302) file:///Volumes/Music/Rhonda%20Smith/RS2/01%20What%20Do%20They%20Think%20Music%20Is_.m4a [09-04-21 09:03:31.3420] Slim::Player::TranscodingHelper::getConvertCommand2 (455) Error: Didn't find any command matches for type: mp4 [09-04-21 09:03:31.3424] Slim::Player::Song::open (323) seek=false time=0 canSeek=0SEEK_ERROR_TYPE_NOT_SUPPORTEDmp4 [09-04-21 09:03:31.3432] Slim::Player::TranscodingHelper::getConvertCommand2 (458) Matched: mp4->flc via: [faad] -q -w -f 1 $FILE$ | [flac] -cs --totally-silent --compression-level-0 --ignore-chunk-sizes - [09-04-21 09:03:31.3436] Slim::Player::Song::open (340) Transcoder: streamMode=F, streamformat=flc [09-04-21 09:03:31.3449] Slim::Player::Song::open (460) Tokenized command "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/faad" -q -w -f 1 "/Volumes/Music/Rhonda Smith/RS2/01 What Do They Think Music Is_.m4a" | "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/flac" -cs --totally-silent --compression-level-0 --ignore-chunk-sizes - & | [09-04-21 09:03:31.3951] Slim::Player::StreamingController::_Stream (1011) 00:04:20:10:02:d7: stream [09-04-21 09:03:31.3979] Slim::Player::Transporter::play (124) Setting DigitalInput to 0 for [file:///Volumes/Music/Rhonda%20Smith/RS2/01%20What%20Do%20They%20Think%20Music%20Is_.m4a] [09-04-21 09:03:31.3983] Slim::Player::Transporter::setDigitalInput (204) Switching to digital input 0 [09-04-21 09:03:31.4027] Slim::Player::StreamingController::_Stream (1041) Song queue is now 0 [09-04-21 09:03:31.4039] Slim::Player::StreamingController::_setPlayingState (1882) new playing state BUFFERING [09-04-21 09:03:31.4043] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state STREAMING [09-04-21 09:03:31.4386] Slim::Player::Source::_readNextChunk (499) end of file or error on socket, song pos: 41910272 [09-04-21 09:03:31.4389] Slim::Player::Source::_readNextChunk (506) Didn't stream any bytes for this song; mark it as failed [09-04-21 09:03:31.4392] Slim::Player::StreamingController::playerStreamingFailed (1759) 00:04:20:10:02:d7 [09-04-21 09:03:31.4397] Slim::Player::StreamingController::_playersMessage (711) Problem: Can't open file for:: file:///Volumes/Music/Rhonda%20Smith/RS2/01%20What%20Do%20They%20Think%20Music%20Is_.m4a [09-04-21 09:03:31.4418] Slim::Player::StreamingController::_Stop (548) Song queue is now 0 [09-04-21 09:03:31.4423] Slim::Player::StreamingController::_setPlayingState (1882) new playing state STOPPED [09-04-21 09:03:31.4426] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state IDLE [09-04-21 09:03:31.4432] Slim::Player::StreamingController::nextsong (776) The next song is number 1, was 0 [09-04-21 09:03:31.4479] Slim::Player::Song::new (64) index 1 -> file:///Volumes/Music/Rhonda%20Smith/RS2/02%20To%20Get%20With%20You.m4a [09-04-21 09:03:31.4485] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state TRACKWAIT [09-04-21 09:03:31.4489] Slim::Player::Song::getNextSong (178) file:///Volumes/Music/Rhonda%20Smith/RS2/02%20To%20Get%20With%20You.m4a [09-04-21 09:03:31.4493] Slim::Player::StreamingController::_nextTrackReady (668) 00:04:20:10:02:d7: nextTrack will be index 1 [09-04-21 09:03:31.4496] Slim::Player::StreamingController::_Stream (942) 00:04:20:10:02:d7: preparing to stream song index 1 [09-04-21 09:03:31.4500] Slim::Player::StreamingController::_Stream (958) Song queue is now 1 [09-04-21 09:03:31.4503] Slim::Player::Song::open (302) file:///Volumes/Music/Rhonda%20Smith/RS2/02%20To%20Get%20With%20You.m4a [09-04-21 09:03:31.4528] Slim::Player::TranscodingHelper::getConvertCommand2 (455) Error: Didn't find any command matches for type: alc [09-04-21 09:03:31.4531] Slim::Player::Song::open (323) seek=false time=0 canSeek=0SEEK_ERROR_TYPE_NOT_SUPPORTEDalc [09-04-21 09:03:31.4540] Slim::Player::TranscodingHelper::getConvertCommand2 (458) Matched: alc->pcm via: [alac] -r $FILE$ [09-04-21 09:03:31.4543] Slim::Player::Song::open (340) Transcoder: streamMode=F, streamformat=pcm [09-04-21 09:03:31.4556] Slim::Player::Song::open (460) Tokenized command "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/alac" -r "/Volumes/Music/Rhonda Smith/RS2/02 To Get With You.m4a" & | [09-04-21 09:03:31.4985] Slim::Player::StreamingController::_Stream (1011) 00:04:20:10:02:d7: stream [09-04-21 09:03:31.5014] Slim::Player::Transporter::play (124) Setting DigitalInput to 0 for [file:///Volumes/Music/Rhonda%20Smith/RS2/02%20To%20Get%20With%20You.m4a] [09-04-21 09:03:31.5018] Slim::Player::Transporter::setDigitalInput (204) Switching to digital input 0 [09-04-21 09:03:31.5063] Slim::Player::StreamingController::_Stream (1041) Song queue is now 1 [09-04-21 09:03:31.5074] Slim::Player::StreamingController::_setPlayingState (1882) new playing state BUFFERING [09-04-21 09:03:31.5078] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state STREAMING [09-04-21 09:03:31.7199] Slim::Player::StreamingController::playerTrackStarted (1701) 00:04:20:10:02:d7 [09-04-21 09:03:31.7203] Slim::Player::StreamingController::_setPlayingState (1882) new playing state PLAYING [09-04-21 09:03:31.7206] Slim::Player::StreamingController::_Playing (359) Song 1 has now started playing [09-04-21 09:03:31.7221] Slim::Player::StreamingController::_Playing (388) Song queue is now 1 [09-04-21 09:03:37.8056] Slim::Player::TranscodingHelper::getConvertCommand2 (455) Error: Didn't find any command matches for type: alc [09-04-21 09:03:41.5830] Slim::Player::StreamingController::stop (1625) 00:04:20:10:02:d7 [09-04-21 09:03:41.5850] Slim::Player::StreamingController::_Stop (548) Song queue is now 1 [09-04-21 09:03:41.6041] Slim::Player::StreamingController::_setPlayingState (1882) new playing state STOPPED [09-04-21 09:03:41.6045] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state IDLE [09-04-21 09:03:41.6055] Slim::Player::Source::playmode (172) 00:04:20:10:02:d7: Current playmode: stop [09-04-21 09:03:41.6319] Slim::Player::StreamingController::play (1628) 00:04:20:10:02:d7 [09-04-21 09:03:41.6334] Slim::Player::StreamingController::_Stop (548) Song queue is now 1 [09-04-21 09:03:41.6337] Slim::Player::StreamingController::_setPlayingState (1882) new playing state STOPPED [09-04-21 09:03:41.6340] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state IDLE [09-04-21 09:03:41.6396] Slim::Player::Song::new (64) index 0 -> file:///Volumes/Music/Richard%20Marx/Richard%20Marx/01%20Should%27ve%20Known%20Better.m4a [09-04-21 09:03:41.6401] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state TRACKWAIT [09-04-21 09:03:41.6407] Slim::Player::Song::getNextSong (178) file:///Volumes/Music/Richard%20Marx/Richard%20Marx/01%20Should%27ve%20Known%20Better.m4a [09-04-21 09:03:41.6411] Slim::Player::StreamingController::_nextTrackReady (668) 00:04:20:10:02:d7: nextTrack will be index 0 [09-04-21 09:03:41.6415] Slim::Player::StreamingController::_Stream (942) 00:04:20:10:02:d7: preparing to stream song index 0 [09-04-21 09:03:41.6418] Slim::Player::StreamingController::_Stream (958) Song queue is now 0 [09-04-21 09:03:41.6422] Slim::Player::Song::open (302) file:///Volumes/Music/Richard%20Marx/Richard%20Marx/01%20Should%27ve%20Known%20Better.m4a [09-04-21 09:03:41.6444] Slim::Player::TranscodingHelper::getConvertCommand2 (455) Error: Didn't find any command matches for type: mp4 [09-04-21 09:03:41.6447] Slim::Player::Song::open (323) seek=false time=0 canSeek=0SEEK_ERROR_TYPE_NOT_SUPPORTEDmp4 [09-04-21 09:03:41.6458] Slim::Player::TranscodingHelper::getConvertCommand2 (458) Matched: mp4->flc via: [faad] -q -w -f 1 $FILE$ | [flac] -cs --totally-silent --compression-level-0 --ignore-chunk-sizes - [09-04-21 09:03:41.6461] Slim::Player::Song::open (340) Transcoder: streamMode=F, streamformat=flc [09-04-21 09:03:41.6477] Slim::Player::Song::open (460) Tokenized command "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/faad" -q -w -f 1 "/Volumes/Music/Richard Marx/Richard Marx/01 Should've Known Better.m4a" | "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/flac" -cs --totally-silent --compression-level-0 --ignore-chunk-sizes - & | [09-04-21 09:03:41.7067] Slim::Player::StreamingController::_Stream (1011) 00:04:20:10:02:d7: stream [09-04-21 09:03:41.7093] Slim::Player::Transporter::play (124) Setting DigitalInput to 0 for [file:///Volumes/Music/Richard%20Marx/Richard%20Marx/01%20Should%27ve%20Known%20Better.m4a] [09-04-21 09:03:41.7097] Slim::Player::Transporter::setDigitalInput (204) Switching to digital input 0 [09-04-21 09:03:41.7193] Slim::Player::StreamingController::_Stream (1041) Song queue is now 0 [09-04-21 09:03:41.7205] Slim::Player::StreamingController::_setPlayingState (1882) new playing state BUFFERING [09-04-21 09:03:41.7211] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state STREAMING [09-04-21 09:03:41.9108] Slim::Player::Source::_readNextChunk (499) end of file or error on socket, song pos: 48627712 [09-04-21 09:03:41.9111] Slim::Player::Source::_readNextChunk (506) Didn't stream any bytes for this song; mark it as failed [09-04-21 09:03:41.9114] Slim::Player::StreamingController::playerStreamingFailed (1759) 00:04:20:10:02:d7 [09-04-21 09:03:41.9119] Slim::Player::StreamingController::_playersMessage (711) Problem: Can't open file for:: file:///Volumes/Music/Richard%20Marx/Richard%20Marx/01%20Should%27ve%20Known%20Better.m4a [09-04-21 09:03:41.9138] Slim::Player::StreamingController::_Stop (548) Song queue is now 0 [09-04-21 09:03:41.9144] Slim::Player::StreamingController::_setPlayingState (1882) new playing state STOPPED [09-04-21 09:03:41.9147] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state IDLE [09-04-21 09:03:41.9152] Slim::Player::StreamingController::nextsong (776) The next song is number 1, was 0 [09-04-21 09:03:41.9188] Slim::Player::Song::new (64) index 1 -> file:///Volumes/Music/Richard%20Marx/Richard%20Marx/02%20Don%27t%20Mean%20Nothing.m4a [09-04-21 09:03:41.9194] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state TRACKWAIT [09-04-21 09:03:41.9199] Slim::Player::Song::getNextSong (178) file:///Volumes/Music/Richard%20Marx/Richard%20Marx/02%20Don%27t%20Mean%20Nothing.m4a [09-04-21 09:03:41.9203] Slim::Player::StreamingController::_nextTrackReady (668) 00:04:20:10:02:d7: nextTrack will be index 1 [09-04-21 09:03:41.9206] Slim::Player::StreamingController::_Stream (942) 00:04:20:10:02:d7: preparing to stream song index 1 [09-04-21 09:03:41.9209] Slim::Player::StreamingController::_Stream (958) Song queue is now 1 [09-04-21 09:03:41.9213] Slim::Player::Song::open (302) file:///Volumes/Music/Richard%20Marx/Richard%20Marx/02%20Don%27t%20Mean%20Nothing.m4a [09-04-21 09:03:41.9239] Slim::Player::TranscodingHelper::getConvertCommand2 (455) Error: Didn't find any command matches for type: alc [09-04-21 09:03:41.9242] Slim::Player::Song::open (323) seek=false time=0 canSeek=0SEEK_ERROR_TYPE_NOT_SUPPORTEDalc [09-04-21 09:03:41.9251] Slim::Player::TranscodingHelper::getConvertCommand2 (458) Matched: alc->pcm via: [alac] -r $FILE$ [09-04-21 09:03:41.9254] Slim::Player::Song::open (340) Transcoder: streamMode=F, streamformat=pcm [09-04-21 09:03:41.9265] Slim::Player::Song::open (460) Tokenized command "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/alac" -r "/Volumes/Music/Richard Marx/Richard Marx/02 Don't Mean Nothing.m4a" & | [09-04-21 09:03:41.9760] Slim::Player::StreamingController::_Stream (1011) 00:04:20:10:02:d7: stream [09-04-21 09:03:41.9788] Slim::Player::Transporter::play (124) Setting DigitalInput to 0 for [file:///Volumes/Music/Richard%20Marx/Richard%20Marx/02%20Don%27t%20Mean%20Nothing.m4a] [09-04-21 09:03:41.9792] Slim::Player::Transporter::setDigitalInput (204) Switching to digital input 0 [09-04-21 09:03:41.9894] Slim::Player::StreamingController::_Stream (1041) Song queue is now 1 [09-04-21 09:03:41.9907] Slim::Player::StreamingController::_setPlayingState (1882) new playing state BUFFERING [09-04-21 09:03:41.9910] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state STREAMING [09-04-21 09:03:42.3259] Slim::Player::StreamingController::playerTrackStarted (1701) 00:04:20:10:02:d7 [09-04-21 09:03:42.3263] Slim::Player::StreamingController::_setPlayingState (1882) new playing state PLAYING [09-04-21 09:03:42.3266] Slim::Player::StreamingController::_Playing (359) Song 1 has now started playing [09-04-21 09:03:42.3277] Slim::Player::StreamingController::_Playing (388) Song queue is now 1 [09-04-21 09:03:46.5664] Slim::Player::StreamingController::stop (1625) 00:04:20:10:02:d7 [09-04-21 09:03:46.5683] Slim::Player::StreamingController::_Stop (548) Song queue is now 1 [09-04-21 09:03:46.5790] Slim::Player::StreamingController::_setPlayingState (1882) new playing state STOPPED [09-04-21 09:03:46.5793] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state IDLE [09-04-21 09:03:46.5803] Slim::Player::Source::playmode (172) 00:04:20:10:02:d7: Current playmode: stop [09-04-21 09:03:46.6330] Slim::Player::StreamingController::play (1628) 00:04:20:10:02:d7 [09-04-21 09:03:46.6374] Slim::Player::StreamingController::_Stop (548) Song queue is now 1 [09-04-21 09:03:46.6377] Slim::Player::StreamingController::_setPlayingState (1882) new playing state STOPPED [09-04-21 09:03:46.6380] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state IDLE [09-04-21 09:03:46.6428] Slim::Player::Song::new (64) index 0 -> file:///Volumes/Music/Richard%20Marx/Repeat%20Offender/01%20Nothin%27%20You%20Can%20Do%20About%20It.m4a [09-04-21 09:03:46.6434] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state TRACKWAIT [09-04-21 09:03:46.6442] Slim::Player::Song::getNextSong (178) file:///Volumes/Music/Richard%20Marx/Repeat%20Offender/01%20Nothin%27%20You%20Can%20Do%20About%20It.m4a [09-04-21 09:03:46.6446] Slim::Player::StreamingController::_nextTrackReady (668) 00:04:20:10:02:d7: nextTrack will be index 0 [09-04-21 09:03:46.6450] Slim::Player::StreamingController::_Stream (942) 00:04:20:10:02:d7: preparing to stream song index 0 [09-04-21 09:03:46.6453] Slim::Player::StreamingController::_Stream (958) Song queue is now 0 [09-04-21 09:03:46.6458] Slim::Player::Song::open (302) file:///Volumes/Music/Richard%20Marx/Repeat%20Offender/01%20Nothin%27%20You%20Can%20Do%20About%20It.m4a [09-04-21 09:03:46.6486] Slim::Player::TranscodingHelper::getConvertCommand2 (455) Error: Didn't find any command matches for type: mp4 [09-04-21 09:03:46.6515] Slim::Player::Song::open (323) seek=false time=0 canSeek=0SEEK_ERROR_TYPE_NOT_SUPPORTEDmp4 [09-04-21 09:03:46.6526] Slim::Player::TranscodingHelper::getConvertCommand2 (458) Matched: mp4->flc via: [faad] -q -w -f 1 $FILE$ | [flac] -cs --totally-silent --compression-level-0 --ignore-chunk-sizes - [09-04-21 09:03:46.6529] Slim::Player::Song::open (340) Transcoder: streamMode=F, streamformat=flc [09-04-21 09:03:46.6599] Slim::Player::Song::open (460) Tokenized command "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/faad" -q -w -f 1 "/Volumes/Music/Richard Marx/Repeat Offender/01 Nothin' You Can Do About It.m4a" | "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/flac" -cs --totally-silent --compression-level-0 --ignore-chunk-sizes - & | [09-04-21 09:03:46.7089] Slim::Player::StreamingController::_Stream (1011) 00:04:20:10:02:d7: stream [09-04-21 09:03:46.7118] Slim::Player::Transporter::play (124) Setting DigitalInput to 0 for [file:///Volumes/Music/Richard%20Marx/Repeat%20Offender/01%20Nothin%27%20You%20Can%20Do%20About%20It.m4a] [09-04-21 09:03:46.7122] Slim::Player::Transporter::setDigitalInput (204) Switching to digital input 0 [09-04-21 09:03:46.7216] Slim::Player::StreamingController::_Stream (1041) Song queue is now 0 [09-04-21 09:03:46.7228] Slim::Player::StreamingController::_setPlayingState (1882) new playing state BUFFERING [09-04-21 09:03:46.7233] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state STREAMING [09-04-21 09:03:46.9143] Slim::Player::Source::_readNextChunk (499) end of file or error on socket, song pos: 54362112 [09-04-21 09:03:46.9146] Slim::Player::Source::_readNextChunk (506) Didn't stream any bytes for this song; mark it as failed [09-04-21 09:03:46.9149] Slim::Player::StreamingController::playerStreamingFailed (1759) 00:04:20:10:02:d7 [09-04-21 09:03:46.9155] Slim::Player::StreamingController::_playersMessage (711) Problem: Can't open file for:: file:///Volumes/Music/Richard%20Marx/Repeat%20Offender/01%20Nothin%27%20You%20Can%20Do%20About%20It.m4a [09-04-21 09:03:46.9189] Slim::Player::StreamingController::_Stop (548) Song queue is now 0 [09-04-21 09:03:46.9194] Slim::Player::StreamingController::_setPlayingState (1882) new playing state STOPPED [09-04-21 09:03:46.9197] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state IDLE [09-04-21 09:03:46.9203] Slim::Player::StreamingController::nextsong (776) The next song is number 1, was 0 [09-04-21 09:03:46.9245] Slim::Player::Song::new (64) index 1 -> file:///Volumes/Music/Richard%20Marx/Repeat%20Offender/02%20Satisfied.m4a [09-04-21 09:03:46.9251] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state TRACKWAIT [09-04-21 09:03:46.9255] Slim::Player::Song::getNextSong (178) file:///Volumes/Music/Richard%20Marx/Repeat%20Offender/02%20Satisfied.m4a [09-04-21 09:03:46.9259] Slim::Player::StreamingController::_nextTrackReady (668) 00:04:20:10:02:d7: nextTrack will be index 1 [09-04-21 09:03:46.9262] Slim::Player::StreamingController::_Stream (942) 00:04:20:10:02:d7: preparing to stream song index 1 [09-04-21 09:03:46.9265] Slim::Player::StreamingController::_Stream (958) Song queue is now 1 [09-04-21 09:03:46.9269] Slim::Player::Song::open (302) file:///Volumes/Music/Richard%20Marx/Repeat%20Offender/02%20Satisfied.m4a [09-04-21 09:03:46.9292] Slim::Player::TranscodingHelper::getConvertCommand2 (455) Error: Didn't find any command matches for type: mp4 [09-04-21 09:03:46.9298] Slim::Player::Song::open (323) seek=false time=0 canSeek=0SEEK_ERROR_TYPE_NOT_SUPPORTEDmp4 [09-04-21 09:03:46.9307] Slim::Player::TranscodingHelper::getConvertCommand2 (458) Matched: mp4->flc via: [faad] -q -w -f 1 $FILE$ | [flac] -cs --totally-silent --compression-level-0 --ignore-chunk-sizes - [09-04-21 09:03:46.9310] Slim::Player::Song::open (340) Transcoder: streamMode=F, streamformat=flc [09-04-21 09:03:46.9322] Slim::Player::Song::open (460) Tokenized command "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/faad" -q -w -f 1 "/Volumes/Music/Richard Marx/Repeat Offender/02 Satisfied.m4a" | "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/flac" -cs --totally-silent --compression-level-0 --ignore-chunk-sizes - & | [09-04-21 09:03:46.9778] Slim::Player::StreamingController::_Stream (1011) 00:04:20:10:02:d7: stream [09-04-21 09:03:46.9810] Slim::Player::Transporter::play (124) Setting DigitalInput to 0 for [file:///Volumes/Music/Richard%20Marx/Repeat%20Offender/02%20Satisfied.m4a] [09-04-21 09:03:46.9817] Slim::Player::Transporter::setDigitalInput (204) Switching to digital input 0 [09-04-21 09:03:46.9867] Slim::Player::StreamingController::_Stream (1041) Song queue is now 1 [09-04-21 09:03:46.9905] Slim::Player::StreamingController::_setPlayingState (1882) new playing state BUFFERING [09-04-21 09:03:46.9909] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state STREAMING [09-04-21 09:03:47.4865] Slim::Player::Source::_readNextChunk (499) end of file or error on socket, song pos: 54362112 [09-04-21 09:03:47.4868] Slim::Player::Source::_readNextChunk (506) Didn't stream any bytes for this song; mark it as failed [09-04-21 09:03:47.4871] Slim::Player::StreamingController::playerStreamingFailed (1759) 00:04:20:10:02:d7 [09-04-21 09:03:47.4878] Slim::Player::StreamingController::_playersMessage (711) Problem: Can't open file for:: file:///Volumes/Music/Richard%20Marx/Repeat%20Offender/02%20Satisfied.m4a [09-04-21 09:03:47.4898] Slim::Player::StreamingController::_Stop (548) Song queue is now 1 [09-04-21 09:03:47.4904] Slim::Player::StreamingController::_setPlayingState (1882) new playing state STOPPED [09-04-21 09:03:47.4907] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state IDLE [09-04-21 09:03:47.4912] Slim::Player::StreamingController::nextsong (747) Giving up because of too many consecutive errors: 2 [09-04-21 09:03:47.8905] Slim::Player::TranscodingHelper::getConvertCommand2 (455) Error: Didn't find any command matches for type: mp4 [09-04-21 09:03:53.0851] Slim::Player::StreamingController::stop (1625) 00:04:20:10:02:d7 [09-04-21 09:03:53.0860] Slim::Player::Source::playmode (172) 00:04:20:10:02:d7: Current playmode: stop [09-04-21 09:03:53.1004] Slim::Player::StreamingController::play (1628) 00:04:20:10:02:d7 [09-04-21 09:03:53.1032] Slim::Player::StreamingController::_Stop (548) Song queue is now 1 [09-04-21 09:03:53.1035] Slim::Player::StreamingController::_setPlayingState (1882) new playing state STOPPED [09-04-21 09:03:53.1038] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state IDLE [09-04-21 09:03:53.1080] Slim::Player::Song::new (64) index 0 -> file:///Volumes/Music/Richard%20Elliot/Take%20To%20The%20Skies/01%20I%27m%20Loving%20You.m4a [09-04-21 09:03:53.1085] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state TRACKWAIT [09-04-21 09:03:53.1091] Slim::Player::Song::getNextSong (178) file:///Volumes/Music/Richard%20Elliot/Take%20To%20The%20Skies/01%20I%27m%20Loving%20You.m4a [09-04-21 09:03:53.1095] Slim::Player::StreamingController::_nextTrackReady (668) 00:04:20:10:02:d7: nextTrack will be index 0 [09-04-21 09:03:53.1098] Slim::Player::StreamingController::_Stream (942) 00:04:20:10:02:d7: preparing to stream song index 0 [09-04-21 09:03:53.1101] Slim::Player::StreamingController::_Stream (958) Song queue is now 0 [09-04-21 09:03:53.1105] Slim::Player::Song::open (302) file:///Volumes/Music/Richard%20Elliot/Take%20To%20The%20Skies/01%20I%27m%20Loving%20You.m4a [09-04-21 09:03:53.1124] Slim::Player::TranscodingHelper::getConvertCommand2 (455) Error: Didn't find any command matches for type: alc [09-04-21 09:03:53.1128] Slim::Player::Song::open (323) seek=false time=0 canSeek=0SEEK_ERROR_TYPE_NOT_SUPPORTEDalc [09-04-21 09:03:53.1136] Slim::Player::TranscodingHelper::getConvertCommand2 (458) Matched: alc->pcm via: [alac] -r $FILE$ [09-04-21 09:03:53.1140] Slim::Player::Song::open (340) Transcoder: streamMode=F, streamformat=pcm [09-04-21 09:03:53.1150] Slim::Player::Song::open (460) Tokenized command "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/alac" -r "/Volumes/Music/Richard Elliot/Take To The Skies/01 I'm Loving You.m4a" & | [09-04-21 09:03:53.1648] Slim::Player::StreamingController::_Stream (1011) 00:04:20:10:02:d7: stream [09-04-21 09:03:53.1674] Slim::Player::Transporter::play (124) Setting DigitalInput to 0 for [file:///Volumes/Music/Richard%20Elliot/Take%20To%20The%20Skies/01%20I%27m%20Loving%20You.m4a] [09-04-21 09:03:53.1678] Slim::Player::Transporter::setDigitalInput (204) Switching to digital input 0 [09-04-21 09:03:53.1773] Slim::Player::StreamingController::_Stream (1041) Song queue is now 0 [09-04-21 09:03:53.1785] Slim::Player::StreamingController::_setPlayingState (1882) new playing state BUFFERING [09-04-21 09:03:53.1790] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state STREAMING [09-04-21 09:03:53.6357] Slim::Player::StreamingController::playerTrackStarted (1701) 00:04:20:10:02:d7 [09-04-21 09:03:53.6362] Slim::Player::StreamingController::_setPlayingState (1882) new playing state PLAYING [09-04-21 09:03:53.6366] Slim::Player::StreamingController::_Playing (359) Song 0 has now started playing [09-04-21 09:03:53.6375] Slim::Player::StreamingController::_Playing (388) Song queue is now 0 [09-04-21 09:03:58.0040] Slim::Player::TranscodingHelper::getConvertCommand2 (455) Error: Didn't find any command matches for type: alc [09-04-21 09:03:58.0197] Slim::Player::StreamingController::stop (1625) 00:04:20:10:02:d7 [09-04-21 09:03:58.0215] Slim::Player::StreamingController::_Stop (548) Song queue is now 0 [09-04-21 09:03:58.0221] Slim::Player::StreamingController::_setPlayingState (1882) new playing state STOPPED [09-04-21 09:03:58.0224] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state IDLE [09-04-21 09:03:58.0232] Slim::Player::Source::playmode (172) 00:04:20:10:02:d7: Current playmode: stop [09-04-21 09:03:58.0388] Slim::Player::StreamingController::play (1628) 00:04:20:10:02:d7 [09-04-21 09:03:58.0403] Slim::Player::StreamingController::_Stop (548) Song queue is now 0 [09-04-21 09:03:58.0408] Slim::Player::StreamingController::_setPlayingState (1882) new playing state STOPPED [09-04-21 09:03:58.0411] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state IDLE [09-04-21 09:03:58.0458] Slim::Player::Song::new (64) index 0 -> file:///Volumes/Music/Richard%20Marx/Richard%20Marx/01%20Should%27ve%20Known%20Better.m4a [09-04-21 09:03:58.0463] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state TRACKWAIT [09-04-21 09:03:58.0469] Slim::Player::Song::getNextSong (178) file:///Volumes/Music/Richard%20Marx/Richard%20Marx/01%20Should%27ve%20Known%20Better.m4a [09-04-21 09:03:58.0473] Slim::Player::StreamingController::_nextTrackReady (668) 00:04:20:10:02:d7: nextTrack will be index 0 [09-04-21 09:03:58.0476] Slim::Player::StreamingController::_Stream (942) 00:04:20:10:02:d7: preparing to stream song index 0 [09-04-21 09:03:58.0479] Slim::Player::StreamingController::_Stream (958) Song queue is now 0 [09-04-21 09:03:58.0483] Slim::Player::Song::open (302) file:///Volumes/Music/Richard%20Marx/Richard%20Marx/01%20Should%27ve%20Known%20Better.m4a [09-04-21 09:03:58.0503] Slim::Player::TranscodingHelper::getConvertCommand2 (455) Error: Didn't find any command matches for type: mp4 [09-04-21 09:03:58.0506] Slim::Player::Song::open (323) seek=false time=0 canSeek=0SEEK_ERROR_TYPE_NOT_SUPPORTEDmp4 [09-04-21 09:03:58.0515] Slim::Player::TranscodingHelper::getConvertCommand2 (458) Matched: mp4->flc via: [faad] -q -w -f 1 $FILE$ | [flac] -cs --totally-silent --compression-level-0 --ignore-chunk-sizes - [09-04-21 09:03:58.0518] Slim::Player::Song::open (340) Transcoder: streamMode=F, streamformat=flc [09-04-21 09:03:58.0529] Slim::Player::Song::open (460) Tokenized command "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/faad" -q -w -f 1 "/Volumes/Music/Richard Marx/Richard Marx/01 Should've Known Better.m4a" | "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/flac" -cs --totally-silent --compression-level-0 --ignore-chunk-sizes - & | [09-04-21 09:03:58.1064] Slim::Player::StreamingController::_Stream (1011) 00:04:20:10:02:d7: stream [09-04-21 09:03:58.1091] Slim::Player::Transporter::play (124) Setting DigitalInput to 0 for [file:///Volumes/Music/Richard%20Marx/Richard%20Marx/01%20Should%27ve%20Known%20Better.m4a] [09-04-21 09:03:58.1095] Slim::Player::Transporter::setDigitalInput (204) Switching to digital input 0 [09-04-21 09:03:58.1189] Slim::Player::StreamingController::_Stream (1041) Song queue is now 0 [09-04-21 09:03:58.1200] Slim::Player::StreamingController::_setPlayingState (1882) new playing state BUFFERING [09-04-21 09:03:58.1203] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state STREAMING [09-04-21 09:03:58.3006] Slim::Player::Source::_readNextChunk (499) end of file or error on socket, song pos: 60112896 [09-04-21 09:03:58.3009] Slim::Player::Source::_readNextChunk (506) Didn't stream any bytes for this song; mark it as failed [09-04-21 09:03:58.3012] Slim::Player::StreamingController::playerStreamingFailed (1759) 00:04:20:10:02:d7 [09-04-21 09:03:58.3017] Slim::Player::StreamingController::_playersMessage (711) Problem: Can't open file for:: file:///Volumes/Music/Richard%20Marx/Richard%20Marx/01%20Should%27ve%20Known%20Better.m4a [09-04-21 09:03:58.3037] Slim::Player::StreamingController::_Stop (548) Song queue is now 0 [09-04-21 09:03:58.3042] Slim::Player::StreamingController::_setPlayingState (1882) new playing state STOPPED [09-04-21 09:03:58.3045] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state IDLE [09-04-21 09:03:58.3050] Slim::Player::StreamingController::nextsong (776) The next song is number 1, was 0 [09-04-21 09:03:58.3093] Slim::Player::Song::new (64) index 1 -> file:///Volumes/Music/Richard%20Marx/Richard%20Marx/02%20Don%27t%20Mean%20Nothing.m4a [09-04-21 09:03:58.3099] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state TRACKWAIT [09-04-21 09:03:58.3103] Slim::Player::Song::getNextSong (178) file:///Volumes/Music/Richard%20Marx/Richard%20Marx/02%20Don%27t%20Mean%20Nothing.m4a [09-04-21 09:03:58.3108] Slim::Player::StreamingController::_nextTrackReady (668) 00:04:20:10:02:d7: nextTrack will be index 1 [09-04-21 09:03:58.3111] Slim::Player::StreamingController::_Stream (942) 00:04:20:10:02:d7: preparing to stream song index 1 [09-04-21 09:03:58.3114] Slim::Player::StreamingController::_Stream (958) Song queue is now 1 [09-04-21 09:03:58.3118] Slim::Player::Song::open (302) file:///Volumes/Music/Richard%20Marx/Richard%20Marx/02%20Don%27t%20Mean%20Nothing.m4a [09-04-21 09:03:58.3142] Slim::Player::TranscodingHelper::getConvertCommand2 (455) Error: Didn't find any command matches for type: alc [09-04-21 09:03:58.3145] Slim::Player::Song::open (323) seek=false time=0 canSeek=0SEEK_ERROR_TYPE_NOT_SUPPORTEDalc [09-04-21 09:03:58.3154] Slim::Player::TranscodingHelper::getConvertCommand2 (458) Matched: alc->pcm via: [alac] -r $FILE$ [09-04-21 09:03:58.3157] Slim::Player::Song::open (340) Transcoder: streamMode=F, streamformat=pcm [09-04-21 09:03:58.3168] Slim::Player::Song::open (460) Tokenized command "/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Bin/darwin/alac" -r "/Volumes/Music/Richard Marx/Richard Marx/02 Don't Mean Nothing.m4a" & | [09-04-21 09:03:58.3584] Slim::Player::StreamingController::_Stream (1011) 00:04:20:10:02:d7: stream [09-04-21 09:03:58.3613] Slim::Player::Transporter::play (124) Setting DigitalInput to 0 for [file:///Volumes/Music/Richard%20Marx/Richard%20Marx/02%20Don%27t%20Mean%20Nothing.m4a] [09-04-21 09:03:58.3617] Slim::Player::Transporter::setDigitalInput (204) Switching to digital input 0 [09-04-21 09:03:58.3665] Slim::Player::StreamingController::_Stream (1041) Song queue is now 1 [09-04-21 09:03:58.3676] Slim::Player::StreamingController::_setPlayingState (1882) new playing state BUFFERING [09-04-21 09:03:58.3679] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state STREAMING [09-04-21 09:03:58.7838] Slim::Player::StreamingController::playerTrackStarted (1701) 00:04:20:10:02:d7 [09-04-21 09:03:58.7842] Slim::Player::StreamingController::_setPlayingState (1882) new playing state PLAYING [09-04-21 09:03:58.7845] Slim::Player::StreamingController::_Playing (359) Song 1 has now started playing [09-04-21 09:03:58.7856] Slim::Player::StreamingController::_Playing (388) Song queue is now 1 [09-04-21 09:04:03.1220] Slim::Player::TranscodingHelper::getConvertCommand2 (455) Error: Didn't find any command matches for type: alc [09-04-21 09:04:03.3234] Slim::Player::StreamingController::stop (1625) 00:04:20:10:02:d7 [09-04-21 09:04:03.3252] Slim::Player::StreamingController::_Stop (548) Song queue is now 1 [09-04-21 09:04:03.3258] Slim::Player::StreamingController::_setPlayingState (1882) new playing state STOPPED [09-04-21 09:04:03.3261] Slim::Player::StreamingController::_setStreamingState (1895) new streaming state IDLE [09-04-21 09:04:03.3270] Slim::Player::Source::playmode (172) 00:04:20:10:02:d7: Current playmode: stop [09-04-21 09:04:03.4938] Slim::Player::TranscodingHelper::getConvertCommand2 (455) Error: Didn't find any command matches for type: alc [09-04-21 09:04:11.3269] Slim::Utils::Strings::string (376) Error: missing string PLUGIN_WEATHERTIME_WIND_SOUTH [09-04-21 09:04:11.3274] Slim::Utils::Strings::string (376) Backtrace: frame 0: Slim::Utils::Log::logBacktrace (/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Slim/Utils/Strings.pm line 376) frame 1: Slim::Utils::Strings::string (Plugins/WeatherTime/Plugin.pm line 2473) frame 2: Plugins::WeatherTime::Plugin::retrieveWeather (Plugins/WeatherTime/Plugin.pm line 2024) frame 3: Plugins::WeatherTime::Plugin::tictac (/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Slim/Utils/Timers.pm line 211) frame 4: (eval) (/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Slim/Utils/Timers.pm line 211) frame 5: Slim::Utils::Timers::checkTimers (./slimserver.pl line 538) frame 6: main::idle (./slimserver.pl line 478) frame 7: main::main (./slimserver.pl line 1001) [09-04-21 09:04:11.3488] Slim::Utils::Strings::string (376) Error: missing string PLUGIN_WEATHERTIME_WIND_SOUTH [09-04-21 09:04:11.3492] Slim::Utils::Strings::string (376) Backtrace: frame 0: Slim::Utils::Log::logBacktrace (/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Slim/Utils/Strings.pm line 376) frame 1: Slim::Utils::Strings::string (Plugins/WeatherTime/Plugin.pm line 2520) frame 2: Plugins::WeatherTime::Plugin::getDayInfos (Plugins/WeatherTime/Plugin.pm line 2492) frame 3: Plugins::WeatherTime::Plugin::retrieveWeather (Plugins/WeatherTime/Plugin.pm line 2024) frame 4: Plugins::WeatherTime::Plugin::tictac (/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Slim/Utils/Timers.pm line 211) frame 5: (eval) (/Library/PreferencePanes/SqueezeCenter.prefPane/Contents/server/Slim/Utils/Timers.pm line 211) frame 6: Slim::Utils::Timers::checkTimers (./slimserver.pl line 538) frame 7: main::idle (./slimserver.pl line 478) frame 8: main::main (./slimserver.pl line 1001)