[09-07-09 16:51:37.2070] main::init (319) Starting Squeezebox Server (v7.4, r27455, Thu Jul  9 04:01:29 PDT 2009) perl 5.008008
[09-07-09 16:51:39.3380] Slim::Player::TranscodingHelper::loadConversionTables (51) Loading conversion config files...
[09-07-09 16:51:39.3440] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'mp4' output: 'mp3' clienttype: '*': clientid: '*': '[faad] -q -w -f 1 $FILE$ | [lame] --silent -q $QUALITY$ $BITRATE - -'
[09-07-09 16:51:39.3453] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'aac' output: 'mp3' clienttype: '*': clientid: '*': '[faad] -q -w -f 1 $FILE$ | [lame] --silent -q $QUALITY$ $BITRATE - -'
[09-07-09 16:51:39.3465] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'mov' output: 'mp3' clienttype: '*': clientid: '*': '[mov123] $FILE$ | [lame] -s 44100 --silent -q $QUALITY$ $RESAMPLE$ -v $BITRATE$ -r --big-endian - -'
[09-07-09 16:51:39.3477] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'alc' output: 'mp3' clienttype: '*': clientid: '*': '[alac] $FILE$ | [lame] --silent -q $QUALITY$ $RESAMPLE$ -v $BITRATE$ - -'
[09-07-09 16:51:39.3489] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'ogg' output: 'mp3' clienttype: '*': clientid: '*': '[sox] -q -t ogg $FILE$ -t wav - | [lame] --silent -q $QUALITY$ $RESAMPLE$ -v $BITRATE$ - -'
[09-07-09 16:51:39.3503] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'wav' output: 'mp3' clienttype: '*': clientid: '*': '[lame] --silent -q $QUALITY$ $RESAMPLE$ -v $BITRATE$ $FILE$ -'
[09-07-09 16:51:39.3516] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'aif' output: 'mp3' clienttype: '*': clientid: '*': '[lame] --silent -q $QUALITY$ $RESAMPLE$ -v $BITRATE$ $FILE$ -'
[09-07-09 16:51:39.3529] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'flc' output: 'mp3' clienttype: '*': clientid: '*': '[flac] -dcs $START$ $END$ -- $FILE$ | [lame] --silent -q $QUALITY$ $RESAMPLE$ -v $BITRATE$ - -'
[09-07-09 16:51:39.3543] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'wma' output: 'mp3' clienttype: '*': clientid: '*': '[wmadec] -w $PATH$ | [lame] --silent -q $QUALITY$ $RESAMPLE$ -v $BITRATE$ - -'
[09-07-09 16:51:39.3556] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'wmal' output: 'mp3' clienttype: '*': clientid: '*': '[wmadec] -w $PATH$ | [lame] --silent -q $QUALITY$ $RESAMPLE$ -v $BITRATE$ - -'
[09-07-09 16:51:39.3568] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'wmap' output: 'mp3' clienttype: '*': clientid: '*': '[wmadec] -w $PATH$ | [lame] --silent -q $QUALITY$ $RESAMPLE$ -v $BITRATE$ - -'
[09-07-09 16:51:39.3581] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'mpc' output: 'mp3' clienttype: '*': clientid: '*': '[mppdec] --silent --prev --gain 3 - - | [lame] --silent -q $QUALITY$ $RESAMPLE$ -v $BITRATE$ - -'
[09-07-09 16:51:39.3593] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'ape' output: 'mp3' clienttype: '*': clientid: '*': '[mac] $FILE$ - -d | [lame] --silent -q $QUALITY$ $RESAMPLE$ -v $BITRATE$ - -'
[09-07-09 16:51:39.3606] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'wvp' output: 'mp3' clienttype: '*': clientid: '*': '[wvunpack] $FILE$ -wq $START$ $END$ -o - | [lame] --silent -q $QUALITY$ $RESAMPLE$ -v $BITRATE$ - -'
[09-07-09 16:51:39.3617] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'mp3' output: 'mp3' clienttype: '*': clientid: '*': '-'
[09-07-09 16:51:39.3627] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'aif' output: 'aif' clienttype: '*': clientid: '*': '-'
[09-07-09 16:51:39.3637] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'wav' output: 'pcm' clienttype: '*': clientid: '*': '-'
[09-07-09 16:51:39.3649] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'flc' output: 'pcm' clienttype: '*': clientid: '*': '[flac] -dcs --force-raw-format --endian=little --sign=signed $START$ $END$ -- $FILE$'
[09-07-09 16:51:39.3660] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'ogg' output: 'ogg' clienttype: '*': clientid: '*': '-'
[09-07-09 16:51:39.3670] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'ogg' output: 'aif' clienttype: '*': clientid: '*': '[sox] -q -t ogg $FILE$ -t raw -r 44100 -c 2 -2 -s $-x$ -'
[09-07-09 16:51:39.3682] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'wma' output: 'pcm' clienttype: '*': clientid: '*': '[wmadec] -r 44100 -b 16 -n 2 $PATH$'
[09-07-09 16:51:39.3694] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'wmal' output: 'pcm' clienttype: '*': clientid: '*': '[wmadec] -r 44100 -b 16 -n 2 $PATH$'
[09-07-09 16:51:39.3706] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'wmap' output: 'pcm' clienttype: '*': clientid: '*': '[wmadec] -r 44100 -b 16 -n 2 $PATH$'
[09-07-09 16:51:39.3718] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'mpc' output: 'pcm' clienttype: '*': clientid: '*': '[mppdec] --raw-le --silent --prev --gain 2 - -'
[09-07-09 16:51:39.3729] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'ape' output: 'pcm' clienttype: '*': clientid: '*': '[mac] $FILE$ - -d'
[09-07-09 16:51:39.3740] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'mpc' output: 'aif' clienttype: '*': clientid: '*': '[mppdec] --raw-be --silent --prev --gain 2 - -'
[09-07-09 16:51:39.3752] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'alc' output: 'pcm' clienttype: '*': clientid: '*': '[alac] -r $FILE$'
[09-07-09 16:51:39.3763] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'wvp' output: 'pcm' clienttype: '*': clientid: '*': '[wvunpack] $FILE$ -rq $START$ $END$ -o -'
[09-07-09 16:51:39.3775] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'mp4' output: 'pcm' clienttype: '*': clientid: '*': '[faad] -q -w -f 2 -b 1 -s 44100 $FILE$'
[09-07-09 16:51:39.3787] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'aac' output: 'pcm' clienttype: '*': clientid: '*': '[faad] -q -w -f 2 -b 1 -s 44100 $FILE$'
[09-07-09 16:51:39.3798] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'mov' output: 'aif' clienttype: '*': clientid: '*': '[mov123] $FILE$'
[09-07-09 16:51:39.3809] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'wma' output: 'wma' clienttype: '*': clientid: '*': '-'
[09-07-09 16:51:39.3820] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'wmal' output: 'wmal' clienttype: '*': clientid: '*': '-'
[09-07-09 16:51:39.3830] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'wmap' output: 'wmap' clienttype: '*': clientid: '*': '-'
[09-07-09 16:51:39.3840] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'flc' output: 'flc' clienttype: '*': clientid: '*': '-'
[09-07-09 16:51:39.3853] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'aif' output: 'flc' clienttype: '*': clientid: '*': '[flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$ | [sox] -q -t flac - -t flac -C 0 $RESAMPLE$ -'
[09-07-09 16:51:39.3866] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'wav' output: 'flc' clienttype: '*': clientid: '*': '[sox] -q -t wav $FILE$ -t flac -C 0 $RESAMPLE$ -'
[09-07-09 16:51:39.3878] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'ogg' output: 'flc' clienttype: '*': clientid: '*': '[sox] -t ogg $FILE$ -t flac -C 0 $RESAMPLE$ -'
[09-07-09 16:51:39.3890] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'wma' output: 'flc' clienttype: '*': clientid: '*': '[wmadec] -w $PATH$ | [flac] -cs --totally-silent --compression-level-0 -'
[09-07-09 16:51:39.3903] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'wmal' output: 'flc' clienttype: '*': clientid: '*': '[wmadec] -w $PATH$ | [flac] -cs --totally-silent --compression-level-0 -'
[09-07-09 16:51:39.3915] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'wmap' output: 'flc' clienttype: '*': clientid: '*': '[wmadec] -w $PATH$ | [flac] -cs --totally-silent --compression-level-0 -'
[09-07-09 16:51:39.3927] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'mpc' output: 'flc' clienttype: '*': clientid: '*': '[mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 -'
[09-07-09 16:51:39.3939] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'ape' output: 'flc' clienttype: '*': clientid: '*': '[mac] $FILE$ - -d | [flac] -cs --totally-silent --compression-level-0 -'
[09-07-09 16:51:39.3951] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'mp4' output: 'flc' clienttype: '*': clientid: '*': '[faad] -q -w -f 1 $FILE$ | [flac] -cs --totally-silent --compression-level-0 --ignore-chunk-sizes -'
[09-07-09 16:51:39.3963] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'aac' output: 'flc' clienttype: '*': clientid: '*': '[faad] -q -w -f 1 $FILE$ | [flac] -cs --totally-silent --compression-level-0 --ignore-chunk-sizes -'
[09-07-09 16:51:39.3975] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'mov' output: 'flc' clienttype: '*': clientid: '*': '[mov123] $FILE$ | [flac] -cs --totally-silent --compression-level-0 --endian big --sign signed --channels 2 --bps 16 --sample-rate 44100 -'
[09-07-09 16:51:39.3987] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'alc' output: 'flc' clienttype: '*': clientid: '*': '[alac] $FILE$ | [flac] -cs --totally-silent --compression-level-0 -'
[09-07-09 16:51:39.4000] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'wvp' output: 'flc' clienttype: '*': clientid: '*': '[wvunpack] $FILE$ -wq $START$ $END$ -o - | [flac] -cs --totally-silent --compression-level-0 -'
[09-07-09 16:51:39.4011] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'aac' output: 'aac' clienttype: '*': clientid: '*': '-'
[09-07-09 16:51:39.4022] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'mp4' output: 'aac' clienttype: '*': clientid: '*': '-'
[09-07-09 16:51:39.4032] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'alc' output: 'alc' clienttype: '*': clientid: '*': '-'
[09-07-09 16:51:39.4044] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'mp3' output: 'mp3' clienttype: 'transcode': clientid: '*': '[lame] --silent -q $QUALITY$ -v $BITRATE$ $RESAMPLE$ --mp3input $FILE$ -'
[09-07-09 16:51:39.4058] Slim::Player::TranscodingHelper::loadConversionTables (114) input: 'flc' output: 'flc' clienttype: 'transcode': clientid: '*': '[flac] -dcs $START$ $END$ -- $FILE$ | [sox] -q -t wav - -t flac -C 0 $RESAMPLE$ -'
[09-07-09 16:51:39.5320] Slim::Utils::Alarm::init (1164) Alarm initing...
[09-07-09 16:52:21.4183] Slim::Utils::Alarm::loadAlarms (1282) Loading saved alarms from prefs for Sovrum
[09-07-09 16:52:21.4203] Slim::Utils::Alarm::loadAlarms (1323) Alarms loaded.  Rescheduling...
[09-07-09 16:52:21.4224] Slim::Utils::Alarm::scheduleNext (1339) Asked to schedule next alarm for Sovrum
[09-07-09 16:52:21.4242] Slim::Utils::Alarm::findNextTime (456) Potential next time found: 8:0:0 11/7/2009
[09-07-09 16:52:21.4256] Slim::Utils::Alarm::findNextTime (456) Potential next time found: 17:0:0 9/7/2009
[09-07-09 16:52:21.4276] Slim::Utils::Alarm::findNextTime (456) Potential next time found: 9:0:0 12/7/2009
[09-07-09 16:52:21.4288] Slim::Utils::Alarm::scheduleNext (1372) Next alarm is at 17:0:0 9/7/2009
[09-07-09 16:52:21.4298] Slim::Utils::Alarm::scheduleNext (1384) Scheduling alarm
[09-07-09 16:52:21.4311] Slim::Utils::Alarm::_startStopTimeCheck (1808) 1 scheduled alarm(s)
[09-07-09 16:52:21.4320] Slim::Utils::Alarm::_startStopTimeCheck (1812) Starting time checker task
[09-07-09 16:52:21.4335] Slim::Utils::Alarm::setRTCAlarm (1418) Asked to set rtc alarm for Sovrum
[09-07-09 16:52:21.4351] Slim::Utils::Alarm::setRTCAlarm (1447) Setting RTC alarm to 61200, volume 48
[09-07-09 16:52:20.8621] Slim::Player::Source::streamingSongIndex (203) Adding song index 0 to song queue
[09-07-09 16:52:20.8631] Slim::Player::Source::streamingSongIndex (207) Clearing out song queue first
[09-07-09 16:52:20.8734] Slim::Player::Song::new (107) index 0 -> file:///mnt/music1/Lossles%20Music/Rush%20-%20R30%20(2005,%20FLAC)/R30%20Overture.flac
[09-07-09 16:52:20.8896] Slim::Player::Song::new (149) live=1
[09-07-09 16:52:20.8907] Slim::Player::Source::streamingSongIndex (224) Song queue is now 0
[09-07-09 16:52:21.0100] Slim::Player::Squeezebox::reconnect (113) 00:04:20:1e:e6:5d forcing stop on pseudo-reconnect
[09-07-09 16:52:21.0290] Slim::Player::Boom::setLineInLevel (437) Setting line in level to 50
[09-07-09 16:52:21.0626] Slim::Utils::Alarm::loadAlarms (1282) Loading saved alarms from prefs for vardagsrum
[09-07-09 16:52:21.0652] Slim::Utils::Alarm::loadAlarms (1323) Alarms loaded.  Rescheduling...
[09-07-09 16:52:21.1468] Slim::Utils::Alarm::scheduleNext (1339) Asked to schedule next alarm for vardagsrum
[09-07-09 16:52:21.1504] Slim::Utils::Alarm::scheduleNext (1392) No future alarms found
[09-07-09 16:52:21.1632] Slim::Player::StreamingController::playerActive (1734) 00:04:20:06:42:42 player already active: 00:04:20:06:42:42
[09-07-09 16:52:22.0194] Slim::Player::Source::streamingSongIndex (203) Adding song index 10 to song queue
[09-07-09 16:52:22.0205] Slim::Player::Source::streamingSongIndex (207) Clearing out song queue first
[09-07-09 16:52:22.0323] Slim::Player::Song::new (107) index 10 -> file:///mnt/music1/My%20CD/Beth%20Orton/Beth%20Orton%20-%20Central%20Reservation/Stolen%20Car.flac
[09-07-09 16:52:22.0341] Slim::Player::Song::new (149) live=2
[09-07-09 16:52:22.0352] Slim::Player::Source::streamingSongIndex (224) Song queue is now 10
[09-07-09 16:52:22.0384] Slim::Player::StreamingController::playerActive (1734) 00:04:20:06:42:42 player already active: 00:04:20:06:42:42
[09-07-09 16:52:22.0394] Slim::Player::Squeezebox::reconnect (105) 00:04:20:06:42:42 restaring play on pseudo-reconnect at 0
[09-07-09 16:52:22.0404] Slim::Player::StreamingController::playerReconnect (1812) 00:04:20:06:42:42
[09-07-09 16:52:22.0416] Slim::Player::StreamingController::_eventAction (271) 00:04:20:06:42:42: ContinuePlay in STOPPED-IDLE -> Slim::Player::StreamingController::_Stop
[09-07-09 16:52:22.0428] Slim::Player::StreamingController::_eventAction (284) params: song => Slim::Player::Song=ARRAY(0xc7c8bc0) bytesReceived => undef
[09-07-09 16:52:22.0463] Slim::Player::StreamingController::_Stop (600) Song queue is now 10
[09-07-09 16:52:22.0474] Slim::Player::StreamingController::_setPlayingState (2102) new playing state STOPPED
[09-07-09 16:52:22.0484] Slim::Player::StreamingController::_setStreamingState (2115) new streaming state IDLE
[09-07-09 16:52:22.0499] Slim::Player::Squeezebox::reconnect (113) 00:04:20:06:42:42 forcing stop on pseudo-reconnect
[09-07-09 16:52:22.1033] Slim::Utils::Alarm::loadAlarms (1282) Loading saved alarms from prefs for kök
[09-07-09 16:52:22.1049] Slim::Utils::Alarm::loadAlarms (1323) Alarms loaded.  Rescheduling...
[09-07-09 16:52:22.1062] Slim::Utils::Alarm::scheduleNext (1339) Asked to schedule next alarm for kök
[09-07-09 16:52:22.1073] Slim::Utils::Alarm::scheduleNext (1392) No future alarms found
[09-07-09 16:52:22.1114] Slim::Player::StreamingController::playerActive (1734) 00:04:20:16:3f:16 player already active: 00:04:20:16:3f:16
[09-07-09 16:52:22.1174] Slim::Player::StreamingController::playerActive (1734) 00:04:20:16:3f:16 player already active: 00:04:20:16:3f:16
[09-07-09 16:52:22.1185] Slim::Player::Squeezebox::reconnect (105) 00:04:20:16:3f:16 restaring play on pseudo-reconnect at 0
[09-07-09 16:52:22.1196] Slim::Player::StreamingController::playerReconnect (1812) 00:04:20:16:3f:16
[09-07-09 16:52:22.1208] Slim::Player::Squeezebox::reconnect (113) 00:04:20:16:3f:16 forcing stop on pseudo-reconnect
[09-07-09 16:52:48.8680] Slim::Utils::Update::getUpdateInstaller (263) Reading update installer path from /var/lib/squeezecenter/cache/updates/server.version
[09-07-09 16:52:48.8692] Slim::Utils::Update::getUpdateInstaller (266) Failure reading '/var/lib/squeezecenter/cache/updates/server.version'
[09-07-09 16:52:48.8706] Slim::Utils::Update::checkVersion (57) Checking version in 5609.14582896233 seconds
[09-07-09 16:53:20.3006] Slim::Utils::Alarm::_checkTime (1839) System time has changed (delta 59, lastDST 1, dst: 1) - rescheduling all alarms
[09-07-09 16:53:20.3018] Slim::Utils::Alarm::scheduleNext (1339) Asked to schedule next alarm for Sovrum
[09-07-09 16:53:20.3028] Slim::Utils::Alarm::scheduleNext (1345) Previous scheduled alarm wasn't triggered.  Clearing nextAlarm and killing timer
[09-07-09 16:53:20.3043] Slim::Utils::Alarm::_startStopTimeCheck (1808) 0 scheduled alarm(s)
[09-07-09 16:53:20.3052] Slim::Utils::Alarm::_startStopTimeCheck (1817) Stopping time checker task
[09-07-09 16:53:20.3067] Slim::Utils::Alarm::findNextTime (456) Potential next time found: 8:0:0 11/7/2009
[09-07-09 16:53:20.3080] Slim::Utils::Alarm::findNextTime (456) Potential next time found: 17:0:0 9/7/2009
[09-07-09 16:53:20.3093] Slim::Utils::Alarm::findNextTime (456) Potential next time found: 9:0:0 12/7/2009
[09-07-09 16:53:20.3105] Slim::Utils::Alarm::scheduleNext (1372) Next alarm is at 17:0:0 9/7/2009
[09-07-09 16:53:20.3114] Slim::Utils::Alarm::scheduleNext (1384) Scheduling alarm
[09-07-09 16:53:20.3125] Slim::Utils::Alarm::_startStopTimeCheck (1808) 1 scheduled alarm(s)
[09-07-09 16:53:20.3134] Slim::Utils::Alarm::_startStopTimeCheck (1812) Starting time checker task
[09-07-09 16:53:20.3147] Slim::Utils::Alarm::setRTCAlarm (1418) Asked to set rtc alarm for Sovrum
[09-07-09 16:53:20.3163] Slim::Utils::Alarm::setRTCAlarm (1447) Setting RTC alarm to 61200, volume 48
[09-07-09 16:53:20.3183] Slim::Utils::Alarm::scheduleNext (1339) Asked to schedule next alarm for kök
[09-07-09 16:53:20.3198] Slim::Utils::Alarm::scheduleNext (1392) No future alarms found
[09-07-09 16:53:20.3210] Slim::Utils::Alarm::scheduleNext (1339) Asked to schedule next alarm for vardagsrum
[09-07-09 16:53:20.3222] Slim::Utils::Alarm::scheduleNext (1392) No future alarms found
[09-07-09 16:58:37.3797] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if flc-flc-*-* is enabled
[09-07-09 16:58:37.3809] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: flc-wma-boom-00:04:20:1e:e6:5d
[09-07-09 16:58:37.3818] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: flc-wma-*-00:04:20:1e:e6:5d
[09-07-09 16:58:37.3828] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: flc-wma-boom-*
[09-07-09 16:58:37.3839] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: flc-wma-*-*
[09-07-09 16:58:37.3849] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: flc-ogg-boom-00:04:20:1e:e6:5d
[09-07-09 16:58:37.3858] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: flc-ogg-*-00:04:20:1e:e6:5d
[09-07-09 16:58:37.3867] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: flc-ogg-boom-*
[09-07-09 16:58:37.3876] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: flc-ogg-*-*
[09-07-09 16:58:37.3885] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: flc-flc-boom-00:04:20:1e:e6:5d
[09-07-09 16:58:37.3894] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: flc-flc-*-00:04:20:1e:e6:5d
[09-07-09 16:58:37.3903] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: flc-flc-boom-*
[09-07-09 16:58:37.3912] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: flc-flc-*-*
[09-07-09 16:58:37.3920] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if flc-flc-*-* is enabled
[09-07-09 16:58:37.3929] Slim::Player::TranscodingHelper::checkBin (240)    enabled
[09-07-09 16:58:37.3938] Slim::Player::TranscodingHelper::checkBin (242)   Found command: -
[09-07-09 16:58:37.3950] Slim::Player::TranscodingHelper::getConvertCommand2 (433) Matched: flc->flc via: -
[09-07-09 17:00:00.0016] Slim::Utils::Alarm::sound (509) Alarm triggered for Sovrum
[09-07-09 17:00:00.0030] Slim::Utils::Alarm::sound (575) Sounding alarm
[09-07-09 17:00:00.0165] Slim::Player::StreamingController::playerActive (1763) 00:04:20:1e:e6:5d sync group now has: 00:04:20:1e:e6:5d
[09-07-09 17:00:00.0174] Slim::Player::StreamingController::playerActive (1764) 00:04:20:1e:e6:5d active players are: 00:04:20:1e:e6:5d
[09-07-09 17:00:00.0214] Slim::Utils::Alarm::pushAlarmScreensaver (1769) Attempting to push into alarm screensaver: SCREENSAVER.datetime. Current mode: INPUT.List
[09-07-09 17:00:00.0223] Slim::Utils::Alarm::pushAlarmScreensaver (1775) Pushing alarm screensaver
[09-07-09 17:00:00.0251] Slim::Utils::Alarm::sound (614) Current vol: 23 Alarm vol: 48
[09-07-09 17:00:00.0263] Slim::Utils::Alarm::sound (617) Changing volume from 23 to 48
[09-07-09 17:00:00.0294] Slim::Utils::Alarm::sound (623) Alarm playlist url: randomplay://track
[09-07-09 17:00:00.0337] Slim::Player::StreamingController::stop (1837) 00:04:20:1e:e6:5d
[09-07-09 17:00:00.0348] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: Stop in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp
[09-07-09 17:00:00.0363] Slim::Player::Song::DESTROY (159) DESTROY(Slim::Player::Song=ARRAY(0xc87b3ac)) live=1: index=0, url=file:///mnt/music1/Lossles%20Music/Rush%20-%20R30%20(2005,%20FLAC)/R30%20Overture.flac
[09-07-09 17:00:00.0490] Slim::Player::StreamingController::play (1840) 00:04:20:1e:e6:5d
[09-07-09 17:00:00.0502] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: Play in STOPPED-IDLE -> Slim::Player::StreamingController::_StopGetNext
[09-07-09 17:00:00.0512] Slim::Player::StreamingController::_eventAction (284) params: index => 0 seekdata => undef
[09-07-09 17:00:00.0646] Slim::Player::StreamingController::_setPlayingState (2102) new playing state STOPPED
[09-07-09 17:00:00.0656] Slim::Player::StreamingController::_setStreamingState (2115) new streaming state IDLE
[09-07-09 17:00:00.0680] Slim::Player::Song::new (107) index 0 -> randomplay://track
[09-07-09 17:00:00.0703] Slim::Player::Song::new (149) live=2
[09-07-09 17:00:00.0713] Slim::Player::StreamingController::_setStreamingState (2115) new streaming state TRACKWAIT
[09-07-09 17:00:00.0726] Slim::Player::Song::getNextSong (228) randomplay://track
[09-07-09 17:00:00.0739] Slim::Player::StreamingController::_nextTrackReady (719) 00:04:20:1e:e6:5d: nextTrack will be index 0
[09-07-09 17:00:00.0751] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: NextTrackReady in STOPPED-TRACKWAIT -> Slim::Player::StreamingController::_Stream
[09-07-09 17:00:00.0762] Slim::Player::StreamingController::_Stream (1039) 00:04:20:1e:e6:5d: preparing to stream song index 0
[09-07-09 17:00:00.0775] Slim::Player::StreamingController::_Stream (1056) Song queue is now 0
[09-07-09 17:00:00.0787] Slim::Player::StreamingController::_Stream (1062) Protocol Handler for randomplay://track overriding playback
[09-07-09 17:00:01.4197] Slim::Player::StreamingController::stop (1837) 00:04:20:1e:e6:5d
[09-07-09 17:00:01.4210] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: Stop in STOPPED-TRACKWAIT -> Slim::Player::StreamingController::_Stop
[09-07-09 17:00:01.4261] Slim::Player::StreamingController::_Stop (600) Song queue is now 0
[09-07-09 17:00:01.4271] Slim::Player::StreamingController::_setPlayingState (2102) new playing state STOPPED
[09-07-09 17:00:01.4282] Slim::Player::StreamingController::_setStreamingState (2115) new streaming state IDLE
[09-07-09 17:00:01.4299] Slim::Player::StreamingController::_eventAction (303) 00:04:20:1e:e6:5d: Stop - new state STOPPED-IDLE
[09-07-09 17:00:01.4509] Slim::Player::StreamingController::play (1840) 00:04:20:1e:e6:5d
[09-07-09 17:00:01.4521] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: Play in STOPPED-IDLE -> Slim::Player::StreamingController::_StopGetNext
[09-07-09 17:00:01.4534] Slim::Player::StreamingController::_eventAction (284) params: index => 0 seekdata => undef
[09-07-09 17:00:01.4954] Slim::Player::StreamingController::_setPlayingState (2102) new playing state STOPPED
[09-07-09 17:00:01.4966] Slim::Player::StreamingController::_setStreamingState (2115) new streaming state IDLE
[09-07-09 17:00:01.5129] Slim::Player::Song::new (107) index 0 -> file:///mnt/music1/Lossy%20Music/Vulsor%20-%20The%20Project%20--%20Jamendo%20-%20MP3%20VBR%20192k%20-%202006.01.20%20[www.jamendo.com]/Youkou%20Yeah%20Yeah%20!.mp3
[09-07-09 17:00:01.5148] Slim::Player::Song::new (149) live=3
[09-07-09 17:00:01.5158] Slim::Player::StreamingController::_setStreamingState (2115) new streaming state TRACKWAIT
[09-07-09 17:00:01.5173] Slim::Player::Song::getNextSong (228) file:///mnt/music1/Lossy%20Music/Vulsor%20-%20The%20Project%20--%20Jamendo%20-%20MP3%20VBR%20192k%20-%202006.01.20%20[www.jamendo.com]/Youkou%20Yeah%20Yeah%20!.mp3
[09-07-09 17:00:01.5193] Slim::Player::StreamingController::_nextTrackReady (719) 00:04:20:1e:e6:5d: nextTrack will be index 0
[09-07-09 17:00:01.5206] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: NextTrackReady in STOPPED-TRACKWAIT -> Slim::Player::StreamingController::_Stream
[09-07-09 17:00:01.5219] Slim::Player::StreamingController::_Stream (1039) 00:04:20:1e:e6:5d: preparing to stream song index 0
[09-07-09 17:00:01.5230] Slim::Player::StreamingController::_Stream (1056) Song queue is now 0
[09-07-09 17:00:01.5246] Slim::Player::Song::open (357) file:///mnt/music1/Lossy%20Music/Vulsor%20-%20The%20Project%20--%20Jamendo%20-%20MP3%20VBR%20192k%20-%202006.01.20%20[www.jamendo.com]/Youkou%20Yeah%20Yeah%20!.mp3
[09-07-09 17:00:01.5432] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if mp3-mp3-*-* is enabled
[09-07-09 17:00:01.5443] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-wma-boom-00:04:20:1e:e6:5d
[09-07-09 17:00:01.5453] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-wma-*-00:04:20:1e:e6:5d
[09-07-09 17:00:01.5461] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-wma-boom-*
[09-07-09 17:00:01.5470] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-wma-*-*
[09-07-09 17:00:01.5480] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-ogg-boom-00:04:20:1e:e6:5d
[09-07-09 17:00:01.5489] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-ogg-*-00:04:20:1e:e6:5d
[09-07-09 17:00:01.5498] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-ogg-boom-*
[09-07-09 17:00:01.5508] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-ogg-*-*
[09-07-09 17:00:01.5518] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-flc-boom-00:04:20:1e:e6:5d
[09-07-09 17:00:01.5528] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-flc-*-00:04:20:1e:e6:5d
[09-07-09 17:00:01.5538] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-flc-boom-*
[09-07-09 17:00:01.5547] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-flc-*-*
[09-07-09 17:00:01.5556] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-aif-boom-00:04:20:1e:e6:5d
[09-07-09 17:00:01.5565] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-aif-*-00:04:20:1e:e6:5d
[09-07-09 17:00:01.5574] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-aif-boom-*
[09-07-09 17:00:01.5584] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-aif-*-*
[09-07-09 17:00:01.5593] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-pcm-boom-00:04:20:1e:e6:5d
[09-07-09 17:00:01.5602] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-pcm-*-00:04:20:1e:e6:5d
[09-07-09 17:00:01.5611] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-pcm-boom-*
[09-07-09 17:00:01.5620] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-pcm-*-*
[09-07-09 17:00:01.5631] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-mp3-boom-00:04:20:1e:e6:5d
[09-07-09 17:00:01.5641] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-mp3-*-00:04:20:1e:e6:5d
[09-07-09 17:00:01.5650] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-mp3-boom-*
[09-07-09 17:00:01.5659] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-mp3-*-*
[09-07-09 17:00:01.5669] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if mp3-mp3-*-* is enabled
[09-07-09 17:00:01.5679] Slim::Player::TranscodingHelper::checkBin (240)    enabled
[09-07-09 17:00:01.5688] Slim::Player::TranscodingHelper::checkBin (242)   Found command: -
[09-07-09 17:00:01.5699] Slim::Player::TranscodingHelper::getConvertCommand2 (433) Matched: mp3->mp3 via: -
[09-07-09 17:00:01.5710] Slim::Player::Song::open (377) seek=false time=0 canSeek=1
[09-07-09 17:00:01.5732] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if mp3-mp3-*-* is enabled
[09-07-09 17:00:01.5744] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-wma-boom-00:04:20:1e:e6:5d
[09-07-09 17:00:01.5754] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-wma-*-00:04:20:1e:e6:5d
[09-07-09 17:00:01.5763] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-wma-boom-*
[09-07-09 17:00:01.5771] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-wma-*-*
[09-07-09 17:00:01.5781] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-ogg-boom-00:04:20:1e:e6:5d
[09-07-09 17:00:01.5790] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-ogg-*-00:04:20:1e:e6:5d
[09-07-09 17:00:01.5799] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-ogg-boom-*
[09-07-09 17:00:01.5808] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-ogg-*-*
[09-07-09 17:00:01.5817] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-flc-boom-00:04:20:1e:e6:5d
[09-07-09 17:00:01.5826] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-flc-*-00:04:20:1e:e6:5d
[09-07-09 17:00:01.5835] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-flc-boom-*
[09-07-09 17:00:01.5845] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-flc-*-*
[09-07-09 17:00:01.5856] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-aif-boom-00:04:20:1e:e6:5d
[09-07-09 17:00:01.5865] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-aif-*-00:04:20:1e:e6:5d
[09-07-09 17:00:01.5874] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-aif-boom-*
[09-07-09 17:00:01.5883] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-aif-*-*
[09-07-09 17:00:01.5891] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-pcm-boom-00:04:20:1e:e6:5d
[09-07-09 17:00:01.5910] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-pcm-*-00:04:20:1e:e6:5d
[09-07-09 17:00:01.5919] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-pcm-boom-*
[09-07-09 17:00:01.5929] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-pcm-*-*
[09-07-09 17:00:01.5938] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-mp3-boom-00:04:20:1e:e6:5d
[09-07-09 17:00:01.5948] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-mp3-*-00:04:20:1e:e6:5d
[09-07-09 17:00:01.5959] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-mp3-boom-*
[09-07-09 17:00:01.5969] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-mp3-*-*
[09-07-09 17:00:01.5978] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if mp3-mp3-*-* is enabled
[09-07-09 17:00:01.5987] Slim::Player::TranscodingHelper::checkBin (240)    enabled
[09-07-09 17:00:01.5996] Slim::Player::TranscodingHelper::checkBin (242)   Found command: -
[09-07-09 17:00:01.6007] Slim::Player::TranscodingHelper::getConvertCommand2 (433) Matched: mp3->mp3 via: -
[09-07-09 17:00:01.6018] Slim::Player::Song::open (398) Transcoder: streamMode=I, streamformat=mp3
[09-07-09 17:00:01.6032] Slim::Player::Song::open (446) Opening stream (no direct streaming) using Slim::Player::Protocols::File [file:///mnt/music1/Lossy%20Music/Vulsor%20-%20The%20Project%20--%20Jamendo%20-%20MP3%20VBR%20192k%20-%202006.01.20%20[www.jamendo.com]/Youkou%20Yeah%20Yeah%20!.mp3]
[09-07-09 17:00:01.6056] Slim::Player::Protocols::File::open (78) duration: [80.457] size: [1286016] endian [] offset: [1865] for file:///mnt/music1/Lossy%20Music/Vulsor%20-%20The%20Project%20--%20Jamendo%20-%20MP3%20VBR%20192k%20-%202006.01.20%20[www.jamendo.com]/Youkou%20Yeah%20Yeah%20!.mp3
[09-07-09 17:00:01.6067] Slim::Player::Protocols::File::open (95) Opening file /mnt/music1/Lossy Music/Vulsor - The Project -- Jamendo - MP3 VBR 192k - 2006.01.20 [www.jamendo.com]/Youkou Yeah Yeah !.mp3
[09-07-09 17:00:01.6090] Slim::Player::Protocols::File::open (173) Seeking in 1865 into /mnt/music1/Lossy Music/Vulsor - The Project -- Jamendo - MP3 VBR 192k - 2006.01.20 [www.jamendo.com]/Youkou Yeah Yeah !.mp3
[09-07-09 17:00:01.6109] Slim::Player::Song::open (467) URL is a song (audio): file:///mnt/music1/Lossy%20Music/Vulsor%20-%20The%20Project%20--%20Jamendo%20-%20MP3%20VBR%20192k%20-%202006.01.20%20[www.jamendo.com]/Youkou%20Yeah%20Yeah%20!.mp3, type=mp3
[09-07-09 17:00:01.7233] Slim::Player::SongStreamController::new (32) live=1
[09-07-09 17:00:01.7271] Slim::Player::StreamingController::_Stream (1108) 00:04:20:1e:e6:5d: stream
[09-07-09 17:00:01.7307] Slim::Player::Boom::play (335) Setting LineIn to 0 for [file:///mnt/music1/Lossy%20Music/Vulsor%20-%20The%20Project%20--%20Jamendo%20-%20MP3%20VBR%20192k%20-%202006.01.20%20[www.jamendo.com]/Youkou%20Yeah%20Yeah%20!.mp3]
[09-07-09 17:00:01.7320] Slim::Player::Boom::setLineIn (427) Switching to line in 0
[09-07-09 17:00:01.7379] Slim::Player::StreamingController::_Stream (1139) Song queue is now 0
[09-07-09 17:00:01.7407] Slim::Player::StreamingController::_setPlayingState (2102) new playing state BUFFERING
[09-07-09 17:00:01.7418] Slim::Player::StreamingController::_setStreamingState (2115) new streaming state STREAMING
[09-07-09 17:00:01.7428] Slim::Player::StreamingController::_eventAction (303) 00:04:20:1e:e6:5d: NextTrackReady - new state BUFFERING-STREAMING
[09-07-09 17:00:01.7440] Slim::Player::StreamingController::_eventAction (303) 00:04:20:1e:e6:5d: Play - new state BUFFERING-STREAMING
[09-07-09 17:00:01.7676] Slim::Player::StreamingController::_eventAction (303) 00:04:20:1e:e6:5d: NextTrackReady - new state BUFFERING-STREAMING
[09-07-09 17:00:01.7688] Slim::Player::Song::DESTROY (159) DESTROY(Slim::Player::Song=ARRAY(0xca1efc4)) live=2: index=0, url=randomplay://track
[09-07-09 17:00:01.7699] Slim::Player::StreamingController::_eventAction (303) 00:04:20:1e:e6:5d: Play - new state BUFFERING-STREAMING
[09-07-09 17:00:01.7778] Slim::Utils::Alarm::_setAlarmSubscription (1180) Adding alarm subscription
[09-07-09 17:00:01.7797] Slim::Utils::Alarm::sound (686) Scheduling time out in 600 seconds
[09-07-09 17:00:01.7817] Slim::Utils::Alarm::_startStopTimeCheck (1808) 0 scheduled alarm(s)
[09-07-09 17:00:01.7828] Slim::Utils::Alarm::_startStopTimeCheck (1817) Stopping time checker task
[09-07-09 17:00:01.7845] Slim::Utils::Alarm::scheduleNext (1339) Asked to schedule next alarm for Sovrum
[09-07-09 17:00:01.7860] Slim::Utils::Alarm::findNextTime (456) Potential next time found: 8:0:0 11/7/2009
[09-07-09 17:00:01.7872] Slim::Utils::Alarm::findNextTime (461) Last alarm due: 17:0:0 9/7/2009
[09-07-09 17:00:01.7885] Slim::Utils::Alarm::findNextTime (456) Potential next time found: 17:0:0 9/7/2009
[09-07-09 17:00:01.7896] Slim::Utils::Alarm::findNextTime (461) Last alarm due: 17:0:0 9/7/2009
[09-07-09 17:00:01.7905] Slim::Utils::Alarm::findNextTime (466) Skipping..
[09-07-09 17:00:01.7916] Slim::Utils::Alarm::findNextTime (456) Potential next time found: 17:0:0 10/7/2009
[09-07-09 17:00:01.7927] Slim::Utils::Alarm::findNextTime (461) Last alarm due: 17:0:0 9/7/2009
[09-07-09 17:00:01.7941] Slim::Utils::Alarm::findNextTime (456) Potential next time found: 9:0:0 12/7/2009
[09-07-09 17:00:01.7953] Slim::Utils::Alarm::findNextTime (461) Last alarm due: 17:0:0 9/7/2009
[09-07-09 17:00:01.7968] Slim::Utils::Alarm::scheduleNext (1372) Next alarm is at 17:0:0 10/7/2009
[09-07-09 17:00:01.7980] Slim::Utils::Alarm::scheduleNext (1384) Scheduling alarm
[09-07-09 17:00:01.7993] Slim::Utils::Alarm::_startStopTimeCheck (1808) 1 scheduled alarm(s)
[09-07-09 17:00:01.8003] Slim::Utils::Alarm::_startStopTimeCheck (1812) Starting time checker task
[09-07-09 17:00:01.8017] Slim::Utils::Alarm::setRTCAlarm (1418) Asked to set rtc alarm for Sovrum
[09-07-09 17:00:01.8036] Slim::Utils::Alarm::setRTCAlarm (1447) Setting RTC alarm to 61200, volume 48
[09-07-09 17:00:01.8266] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[09-07-09 17:00:01.8291] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[09-07-09 17:00:01.8317] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[09-07-09 17:00:01.8836] Slim::Utils::Alarm::_alarmEnd (1896) _alarmEnd called with request: stop
[09-07-09 17:00:01.8848] Slim::Utils::Alarm::_alarmEnd (1907) Ignoring self-created request
[09-07-09 17:00:01.9915] Slim::Utils::Alarm::_alarmEnd (1896) _alarmEnd called with request: power
[09-07-09 17:00:01.9926] Slim::Utils::Alarm::_alarmEnd (1907) Ignoring self-created request
[09-07-09 17:00:02.0239] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[09-07-09 17:00:02.0321] Slim::Player::Source::_readNextChunk (334) Sending 0 bytes of silence.
[09-07-09 17:00:02.0895] Slim::Utils::Alarm::_alarmEnd (1892) Ignoring unwanted notification: playlist stop
[09-07-09 17:00:04.7016] Slim::Player::StreamingController::playerTrackStarted (1920) 00:04:20:1e:e6:5d
[09-07-09 17:00:04.7030] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: Started in BUFFERING-STREAMING -> Slim::Player::StreamingController::_Playing
[09-07-09 17:00:04.7041] Slim::Player::StreamingController::_setPlayingState (2102) new playing state PLAYING
[09-07-09 17:00:04.7052] Slim::Player::StreamingController::_Playing (361) Song 0 has now started playing
[09-07-09 17:00:04.7092] Slim::Player::StreamingController::_Playing (391) Song queue is now 0
[09-07-09 17:00:04.7105] Slim::Player::StreamingController::_eventAction (303) 00:04:20:1e:e6:5d: Started - new state PLAYING-STREAMING
[09-07-09 17:00:04.7133] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:04.7160] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:05.0441] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:05.0476] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:05.1176] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:05.4679] Slim::Player::Source::_readNextChunk (369) Read to end of file or pipe
[09-07-09 17:00:05.4720] Slim::Player::Source::_readNextChunk (392) end of file or error on socket, song pos: 1286144, tell says: 1286144, totalbytes: 1286016
[09-07-09 17:00:05.4740] Slim::Player::Source::_readNextChunk (406) 00:04:20:1e:e6:5d mark end of stream
[09-07-09 17:00:05.4755] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: LocalEndOfStream in PLAYING-STREAMING -> Slim::Player::StreamingController::_Streamout
[09-07-09 17:00:05.4771] Slim::Player::StreamingController::_setStreamingState (2115) new streaming state STREAMOUT
[09-07-09 17:00:05.4783] Slim::Player::StreamingController::_eventAction (303) 00:04:20:1e:e6:5d: LocalEndOfStream - new state PLAYING-STREAMOUT
[09-07-09 17:00:05.8833] Slim::Player::StreamingController::playerEndOfStream (2011) 00:04:20:1e:e6:5d
[09-07-09 17:00:05.8846] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: EndOfStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_AutoStart
[09-07-09 17:00:05.8857] Slim::Player::StreamingController::_setStreamingState (2115) new streaming state STREAMOUT
[09-07-09 17:00:06.1118] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:07.1120] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:08.1123] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:09.1122] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:09.2217] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if mp3-mp3-*-* is enabled
[09-07-09 17:00:09.2228] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-wma-boom-00:04:20:1e:e6:5d
[09-07-09 17:00:09.2237] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-wma-*-00:04:20:1e:e6:5d
[09-07-09 17:00:09.2245] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-wma-boom-*
[09-07-09 17:00:09.2254] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-wma-*-*
[09-07-09 17:00:09.2262] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-ogg-boom-00:04:20:1e:e6:5d
[09-07-09 17:00:09.2270] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-ogg-*-00:04:20:1e:e6:5d
[09-07-09 17:00:09.2279] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-ogg-boom-*
[09-07-09 17:00:09.2288] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-ogg-*-*
[09-07-09 17:00:09.2296] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-flc-boom-00:04:20:1e:e6:5d
[09-07-09 17:00:09.2304] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-flc-*-00:04:20:1e:e6:5d
[09-07-09 17:00:09.2312] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-flc-boom-*
[09-07-09 17:00:09.2324] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-flc-*-*
[09-07-09 17:00:09.2333] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-aif-boom-00:04:20:1e:e6:5d
[09-07-09 17:00:09.2341] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-aif-*-00:04:20:1e:e6:5d
[09-07-09 17:00:09.2351] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-aif-boom-*
[09-07-09 17:00:09.2360] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-aif-*-*
[09-07-09 17:00:09.2368] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-pcm-boom-00:04:20:1e:e6:5d
[09-07-09 17:00:09.2377] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-pcm-*-00:04:20:1e:e6:5d
[09-07-09 17:00:09.2385] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-pcm-boom-*
[09-07-09 17:00:09.2393] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-pcm-*-*
[09-07-09 17:00:09.2401] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-mp3-boom-00:04:20:1e:e6:5d
[09-07-09 17:00:09.2410] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-mp3-*-00:04:20:1e:e6:5d
[09-07-09 17:00:09.2419] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-mp3-boom-*
[09-07-09 17:00:09.2429] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: mp3-mp3-*-*
[09-07-09 17:00:09.2438] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if mp3-mp3-*-* is enabled
[09-07-09 17:00:09.2446] Slim::Player::TranscodingHelper::checkBin (240)    enabled
[09-07-09 17:00:09.2454] Slim::Player::TranscodingHelper::checkBin (242)   Found command: -
[09-07-09 17:00:09.2465] Slim::Player::TranscodingHelper::getConvertCommand2 (433) Matched: mp3->mp3 via: -
[09-07-09 17:00:10.0431] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:10.0478] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:10.1260] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:11.1794] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:12.7885] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:13.1323] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:14.1140] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:15.0048] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:15.0074] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:15.1139] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:16.1142] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:17.1143] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:18.1144] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:19.1146] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:20.0049] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:20.0074] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:20.1145] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:21.1148] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:21.7775] Slim::Utils::Alarm::_checkPlaying (1089) Checking whether client is playing for alarm b1e59ccc
[09-07-09 17:00:21.7790] Slim::Utils::Alarm::_checkPlaying (1096) Current playmode: play
[09-07-09 17:00:22.1153] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:23.1152] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:24.1154] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:25.0048] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:25.0082] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:25.1152] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:26.1157] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:27.1157] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:28.1157] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:29.1159] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:30.0053] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:30.0079] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:30.1159] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:31.1161] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:32.1162] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:33.1164] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:34.1166] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:35.0050] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:35.0081] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:35.1166] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:36.1168] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:37.1169] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:38.1170] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:39.1171] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:40.0049] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:40.0078] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:40.1172] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:41.1176] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:42.1176] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:44.5614] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:44.5641] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:45.0049] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:45.0077] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:45.1181] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:46.1184] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:47.1185] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:48.1187] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:49.1188] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:50.0051] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:50.0076] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:50.1188] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:51.1192] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:52.1192] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:53.1193] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[09-07-09 17:00:53.3956] Slim::Player::StreamingController::pause (1856) 00:04:20:1e:e6:5d
[09-07-09 17:00:53.3970] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: Pause in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_Pause
[09-07-09 17:00:53.3983] Slim::Player::StreamingController::_setPlayingState (2102) new playing state PAUSED
[09-07-09 17:00:53.4014] Slim::Player::StreamingController::_eventAction (303) 00:04:20:1e:e6:5d: Pause - new state PAUSED-STREAMOUT
[09-07-09 17:00:53.4037] Slim::Player::Source::playmode (93) 00:04:20:1e:e6:5d: Current playmode: pause
[09-07-09 17:00:53.4352] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PAUSED-STREAMOUT -> Slim::Player::StreamingController::_CheckPaused
[09-07-09 17:00:53.4379] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PAUSED-STREAMOUT -> Slim::Player::StreamingController::_CheckPaused
[09-07-09 17:00:53.4397] Slim::Utils::Alarm::_alarmEnd (1896) _alarmEnd called with request: power
[09-07-09 17:00:53.4409] Slim::Utils::Alarm::_alarmEnd (1918) Stopping alarm
[09-07-09 17:00:53.4437] Slim::Utils::Alarm::popAlarmScreensaver (1794) Attempting to pop alarm screensaver.  Current mode: OFF.datetime
[09-07-09 17:00:53.5216] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PAUSED-STREAMOUT -> Slim::Player::StreamingController::_CheckPaused
[09-07-09 17:00:53.5510] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PAUSED-STREAMOUT -> Slim::Player::StreamingController::_CheckPaused
[09-07-09 17:00:53.5608] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PAUSED-STREAMOUT -> Slim::Player::StreamingController::_CheckPaused
[09-07-09 17:00:53.5706] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PAUSED-STREAMOUT -> Slim::Player::StreamingController::_CheckPaused
[09-07-09 17:00:53.6173] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PAUSED-STREAMOUT -> Slim::Player::StreamingController::_CheckPaused
[09-07-09 17:00:53.6603] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PAUSED-STREAMOUT -> Slim::Player::StreamingController::_CheckPaused
[09-07-09 17:00:53.7113] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PAUSED-STREAMOUT -> Slim::Player::StreamingController::_CheckPaused
[09-07-09 17:00:55.3382] Slim::Utils::Alarm::__ANON__ (877) Restoring pre-alarm volume level: 23
[09-07-09 17:00:55.3472] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PAUSED-STREAMOUT -> Slim::Player::StreamingController::_CheckPaused
[09-07-09 17:00:55.3512] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PAUSED-STREAMOUT -> Slim::Player::StreamingController::_CheckPaused
[09-07-09 17:00:55.3539] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PAUSED-STREAMOUT -> Slim::Player::StreamingController::_CheckPaused
[09-07-09 17:00:55.3565] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PAUSED-STREAMOUT -> Slim::Player::StreamingController::_CheckPaused
[09-07-09 17:00:55.3591] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PAUSED-STREAMOUT -> Slim::Player::StreamingController::_CheckPaused
[09-07-09 17:00:55.3774] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PAUSED-STREAMOUT -> Slim::Player::StreamingController::_CheckPaused
[09-07-09 17:00:55.3801] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PAUSED-STREAMOUT -> Slim::Player::StreamingController::_CheckPaused
[09-07-09 17:00:55.3828] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PAUSED-STREAMOUT -> Slim::Player::StreamingController::_CheckPaused
[09-07-09 17:00:55.3855] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PAUSED-STREAMOUT -> Slim::Player::StreamingController::_CheckPaused
[09-07-09 17:01:00.0059] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PAUSED-STREAMOUT -> Slim::Player::StreamingController::_CheckPaused
[09-07-09 17:01:00.0088] Slim::Player::StreamingController::_eventAction (271) 00:04:20:1e:e6:5d: StatusHeartbeat in PAUSED-STREAMOUT -> Slim::Player::StreamingController::_CheckPaused