[09-01-09 08:53:37.2884] Slim::Player::TranscodingHelper::loadConversionTables (46) Loading conversion config files... [09-01-09 08:53:37.2904] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'mov' output: 'mp3' clienttype: '*': clientid: '*': '[mov123] $FILE$ | [lame] -s 44100 --silent -q $QUALITY$ $RESAMPLE$ -v $BITRATE$ -r --big-endian - -' [09-01-09 08:53:37.2908] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'alc' output: 'mp3' clienttype: '*': clientid: '*': '[alac] $FILE$ | [lame] --silent -q $QUALITY$ $RESAMPLE$ -v $BITRATE$ - -' [09-01-09 08:53:37.2912] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'ogg' output: 'mp3' clienttype: '*': clientid: '*': '[sox] -q -t ogg $FILE$ -t wav - | [lame] --silent -q $QUALITY$ $RESAMPLE$ -v $BITRATE$ - -' [09-01-09 08:53:37.2916] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'wav' output: 'mp3' clienttype: '*': clientid: '*': '[lame] --silent -q $QUALITY$ $RESAMPLE$ -v $BITRATE$ $FILE$ -' [09-01-09 08:53:37.2920] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'aif' output: 'mp3' clienttype: '*': clientid: '*': '[lame] --silent -q $QUALITY$ $RESAMPLE$ -v $BITRATE$ $FILE$ -' [09-01-09 08:53:37.2924] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'flc' output: 'mp3' clienttype: '*': clientid: '*': '[flac] -dcs $START$ $END$ -- $FILE$ | [lame] --silent -q $QUALITY$ $RESAMPLE$ -v $BITRATE$ - -' [09-01-09 08:53:37.2929] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'wma' output: 'mp3' clienttype: '*': clientid: '*': '[wmadec] -w $PATH$ | [lame] --silent -q $QUALITY$ $RESAMPLE$ -v $BITRATE$ - -' [09-01-09 08:53:37.2933] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'mpc' output: 'mp3' clienttype: '*': clientid: '*': '[mppdec] --silent --prev --gain 3 - - | [lame] --silent -q $QUALITY$ $RESAMPLE$ -v $BITRATE$ - -' [09-01-09 08:53:37.2937] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'ape' output: 'mp3' clienttype: '*': clientid: '*': '[mac] $FILE$ - -d | [lame] --silent -q $QUALITY$ $RESAMPLE$ -v $BITRATE$ - -' [09-01-09 08:53:37.2941] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'wvp' output: 'mp3' clienttype: '*': clientid: '*': '[wvunpack] $FILE$ -wq $START$ $END$ -o - | [lame] --silent -q $QUALITY$ $RESAMPLE$ -v $BITRATE$ - -' [09-01-09 08:53:37.2944] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'mp3' output: 'mp3' clienttype: '*': clientid: '*': '-' [09-01-09 08:53:37.2948] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'aif' output: 'aif' clienttype: '*': clientid: '*': '-' [09-01-09 08:53:37.2951] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'wav' output: 'wav' clienttype: '*': clientid: '*': '-' [09-01-09 08:53:37.2955] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'flc' output: 'wav' clienttype: '*': clientid: '*': '[flac] -dcs --force-raw-format --endian=little --sign=signed $START$ $END$ -- $FILE$' [09-01-09 08:53:37.2959] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'ogg' output: 'ogg' clienttype: '*': clientid: '*': '-' [09-01-09 08:53:37.2963] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'ogg' output: 'aif' clienttype: '*': clientid: '*': '[sox] -q -t ogg $FILE$ -t raw -r 44100 -c 2 -w -s $-x$ -' [09-01-09 08:53:37.2967] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'wma' output: 'wav' clienttype: '*': clientid: '*': '[wmadec] -r 44100 -b 16 -n 2 $PATH$' [09-01-09 08:53:37.2970] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'mpc' output: 'wav' clienttype: '*': clientid: '*': '[mppdec] --raw-le --silent --prev --gain 2 - -' [09-01-09 08:53:37.2973] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'ape' output: 'wav' clienttype: '*': clientid: '*': '[mac] $FILE$ - -d' [09-01-09 08:53:37.2976] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'mpc' output: 'aif' clienttype: '*': clientid: '*': '[mppdec] --raw-be --silent --prev --gain 2 - -' [09-01-09 08:53:37.2980] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'alc' output: 'wav' clienttype: '*': clientid: '*': '[alac] -r $FILE$' [09-01-09 08:53:37.2983] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'wvp' output: 'wav' clienttype: '*': clientid: '*': '[wvunpack] $FILE$ -rq $START$ $END$ -o -' [09-01-09 08:53:37.2987] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'mov' output: 'aif' clienttype: '*': clientid: '*': '[mov123] $FILE$' [09-01-09 08:53:37.2989] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'wma' output: 'wma' clienttype: '*': clientid: '*': '-' [09-01-09 08:53:37.2992] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'flc' output: 'flc' clienttype: '*': clientid: '*': '-' [09-01-09 08:53:37.2995] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'aif' output: 'flc' clienttype: '*': clientid: '*': '[flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$' [09-01-09 08:53:37.2998] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'wav' output: 'flc' clienttype: '*': clientid: '*': '[flac] -cs --totally-silent --compression-level-0 $START$ $END$ -- $FILE$' [09-01-09 08:53:37.3001] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'ogg' output: 'flc' clienttype: '*': clientid: '*': '[sox] -t ogg $FILE$ -t wav $RESAMPLE$ - | [flac] -cs --compression-level-0 --totally-silent -' [09-01-09 08:53:37.3004] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'wma' output: 'flc' clienttype: '*': clientid: '*': '[wmadec] -w $PATH$ | [flac] -cs --totally-silent --compression-level-0 -' [09-01-09 08:53:37.3007] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'mpc' output: 'flc' clienttype: '*': clientid: '*': '[mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 -' [09-01-09 08:53:37.3010] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'ape' output: 'flc' clienttype: '*': clientid: '*': '[mac] $FILE$ - -d | [flac] -cs --totally-silent --compression-level-0 -' [09-01-09 08:53:37.3013] Slim::Player::TranscodingHelper::loadConversionTables (109) 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-01-09 08:53:37.3016] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'alc' output: 'flc' clienttype: '*': clientid: '*': '[alac] $FILE$ | [flac] -cs --totally-silent --compression-level-0 -' [09-01-09 08:53:37.3019] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'wvp' output: 'flc' clienttype: '*': clientid: '*': '[wvunpack] $FILE$ -wq $START$ $END$ -o - | [flac] -cs --totally-silent --compression-level-0 -' [09-01-09 08:53:37.3022] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'mp3' output: 'mp3' clienttype: 'transcode': clientid: '*': '[lame] --silent -q $QUALITY$ -v $BITRATE$ $RESAMPLE$ --mp3input $FILE$ -' [09-01-09 08:53:37.3025] Slim::Player::TranscodingHelper::loadConversionTables (109) input: 'flc' output: 'flc' clienttype: 'transcode': clientid: '*': '[flac] -dcs $START$ $END$ -- $FILE$ | [sox] -q -t wav - -t flac $RESAMPLE$ -' [09-01-09 08:53:42.9286] Slim::Player::Squeezebox::reconnect (118) 00:04:20:07:e3:81 forcing stop on pseudo-reconnect [09-01-09 08:53:42.9425] Slim::Player::StreamingController::playerActive (1461) 00:04:20:16:01:ea player already active: 00:04:20:16:01:ea [09-01-09 08:53:42.9725] Slim::Player::StreamingController::playerActive (1461) 00:04:20:16:01:ea player already active: 00:04:20:16:01:ea [09-01-09 08:53:42.9730] Slim::Player::Squeezebox::reconnect (110) 00:04:20:16:01:ea restaring play on pseudo-reconnect at 0 [09-01-09 08:53:42.9733] Slim::Player::StreamingController::playerReconnect (1532) 00:04:20:16:01:ea [09-01-09 08:53:42.9736] Slim::Player::Squeezebox::reconnect (118) 00:04:20:16:01:ea forcing stop on pseudo-reconnect [09-01-09 08:53:42.9762] Slim::Player::StreamingController::_eventAction (269) 00:04:20:16:01:ea: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:43.0006] Slim::Player::Squeezebox::reconnect (118) 00:04:20:10:01:1b forcing stop on pseudo-reconnect [09-01-09 08:53:43.0031] Slim::Player::Transporter::setDigitalInput (204) Switching to digital input 0 [09-01-09 08:53:43.0038] Slim::Player::StreamingController::_eventAction (269) 00:04:20:10:01:1b: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:43.0043] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:e3:81: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:43.0047] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:e3:81: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:43.0051] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:e3:81: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:43.0057] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:e3:81: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:43.0060] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:e3:81: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:43.0101] Slim::Player::StreamingController::_eventAction (269) 00:04:20:16:01:ea: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:43.0106] Slim::Player::StreamingController::_eventAction (269) 00:04:20:16:01:ea: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:43.0112] Slim::Player::StreamingController::_eventAction (269) 00:04:20:16:01:ea: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:43.0115] Slim::Player::StreamingController::_eventAction (269) 00:04:20:16:01:ea: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:43.0120] Slim::Player::StreamingController::_eventAction (269) 00:04:20:10:01:1b: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:43.0123] Slim::Player::StreamingController::_eventAction (269) 00:04:20:10:01:1b: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:43.0197] Slim::Player::StreamingController::_eventAction (269) 00:04:20:10:01:1b: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:43.0202] Slim::Player::StreamingController::_eventAction (269) 00:04:20:10:01:1b: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:43.0211] Slim::Player::StreamingController::_eventAction (269) 00:04:20:10:01:1b: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:44.0060] Slim::Player::StreamingController::_eventAction (269) 00:04:20:10:01:1b: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:47.0168] Slim::Player::StreamingController::_eventAction (269) 00:04:20:10:01:1b: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:47.0175] Slim::Player::StreamingController::_eventAction (269) 00:04:20:10:01:1b: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:47.0239] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:e3:81: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:47.0244] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:e3:81: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:47.0252] Slim::Player::StreamingController::_eventAction (269) 00:04:20:16:01:ea: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:47.0256] Slim::Player::StreamingController::_eventAction (269) 00:04:20:16:01:ea: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:47.3345] Slim::Player::StreamingController::playerActive (1461) 00:1b:63:b4:7a:23 player already active: 00:1b:63:b4:7a:23 [09-01-09 08:53:47.3454] Slim::Player::Source::streamingSongIndex (310) Adding song index 0 to song queue [09-01-09 08:53:47.3456] Slim::Player::Source::streamingSongIndex (314) Clearing out song queue first [09-01-09 08:53:47.3479] Slim::Player::Song::new (64) index 0 -> slacker://stations/4595820/1212442209.mp3 [09-01-09 08:53:47.3495] Slim::Player::Song::new (101) live=1 [09-01-09 08:53:47.3497] Slim::Player::Source::streamingSongIndex (330) Song queue is now 0 [09-01-09 08:53:47.3507] Slim::Player::StreamingController::playerActive (1461) 00:1b:63:b4:7a:23 player already active: 00:1b:63:b4:7a:23 [09-01-09 08:53:47.3510] Slim::Player::Squeezebox::reconnect (110) 00:1b:63:b4:7a:23 restaring play on pseudo-reconnect at 0 [09-01-09 08:53:47.3511] Slim::Player::StreamingController::playerReconnect (1532) 00:1b:63:b4:7a:23 [09-01-09 08:53:47.3514] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: ContinuePlay in STOPPED-IDLE -> Slim::Player::StreamingController::_Stop [09-01-09 08:53:47.3516] Slim::Player::StreamingController::_eventAction (282) params: song => Slim::Player::Song=HASH(0x343b2b8) bytesReceived => undef [09-01-09 08:53:47.3524] Slim::Player::StreamingController::_Stop (532) Song queue is now 0 [09-01-09 08:53:47.3526] Slim::Player::StreamingController::_setPlayingState (1802) new playing state STOPPED [09-01-09 08:53:47.3529] Slim::Player::StreamingController::_setStreamingState (1815) new streaming state IDLE [09-01-09 08:53:47.3531] Slim::Player::Squeezebox::reconnect (118) 00:1b:63:b4:7a:23 forcing stop on pseudo-reconnect [09-01-09 08:53:47.6082] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:47.6098] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:47.6105] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:47.6183] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:47.7233] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = mp3, squeezeplay = 00:1b:63:b4:7a:23 [09-01-09 08:53:47.7237] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mp3-mp3-*-* is enabled [09-01-09 08:53:47.7239] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-ogg-squeezeplay-00:1b:63:b4:7a:23 [09-01-09 08:53:47.7241] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-ogg-*-00:1b:63:b4:7a:23 [09-01-09 08:53:47.7243] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-ogg-squeezeplay-* [09-01-09 08:53:47.7245] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-ogg-*-* [09-01-09 08:53:47.7247] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-flc-squeezeplay-00:1b:63:b4:7a:23 [09-01-09 08:53:47.7249] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-flc-*-00:1b:63:b4:7a:23 [09-01-09 08:53:47.7251] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-flc-squeezeplay-* [09-01-09 08:53:47.7253] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-flc-*-* [09-01-09 08:53:47.7256] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-aif-squeezeplay-00:1b:63:b4:7a:23 [09-01-09 08:53:47.7258] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-aif-*-00:1b:63:b4:7a:23 [09-01-09 08:53:47.7260] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-aif-squeezeplay-* [09-01-09 08:53:47.7262] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-aif-*-* [09-01-09 08:53:47.7264] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-wav-squeezeplay-00:1b:63:b4:7a:23 [09-01-09 08:53:47.7267] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-wav-*-00:1b:63:b4:7a:23 [09-01-09 08:53:47.7269] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-wav-squeezeplay-* [09-01-09 08:53:47.7271] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-wav-*-* [09-01-09 08:53:47.7273] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-mp3-squeezeplay-00:1b:63:b4:7a:23 [09-01-09 08:53:47.7275] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-mp3-*-00:1b:63:b4:7a:23 [09-01-09 08:53:47.7277] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-mp3-squeezeplay-* [09-01-09 08:53:47.7279] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-mp3-*-* [09-01-09 08:53:47.7281] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mp3-mp3-*-* is enabled [09-01-09 08:53:47.7283] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-09 08:53:47.7285] Slim::Player::TranscodingHelper::checkBin (237) Found command: - [09-01-09 08:53:47.7288] Slim::Player::TranscodingHelper::getConvertCommand2 (390) Rejecting - because no available stream mode supported: R [09-01-09 08:53:47.7290] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-mp3-transcode-* [09-01-09 08:53:47.7291] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mp3-mp3-transcode-* is enabled [09-01-09 08:53:47.7293] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-09 08:53:47.7296] Slim::Player::TranscodingHelper::checkBin (237) Found command: [lame] --silent -q $QUALITY$ -v $BITRATE$ $RESAMPLE$ --mp3input $FILE$ - [09-01-09 08:53:47.7301] Slim::Player::TranscodingHelper::checkBin (260) couldn't find binary for: lame [09-01-09 08:53:47.7303] Slim::Player::TranscodingHelper::getConvertCommand2 (451) Error: Didn't find any command matches for type: mp3 [09-01-09 08:53:47.8406] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:48.9763] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:50.0719] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:51.1365] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:52.0034] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:52.0041] Slim::Player::StreamingController::_eventAction (269) 00:04:20:16:01:ea: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:52.0047] Slim::Player::StreamingController::_eventAction (269) 00:04:20:10:01:1b: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:52.0051] Slim::Player::StreamingController::_eventAction (269) 00:04:20:10:01:1b: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:52.0055] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:e3:81: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:52.0059] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:e3:81: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:52.0066] Slim::Player::StreamingController::_eventAction (269) 00:04:20:16:01:ea: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:52.2754] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:53.3359] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:54.4779] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:55.4837] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:56.5321] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:57.0043] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:57.0054] Slim::Player::StreamingController::_eventAction (269) 00:04:20:16:01:ea: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:57.0061] Slim::Player::StreamingController::_eventAction (269) 00:04:20:10:01:1b: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:57.0066] Slim::Player::StreamingController::_eventAction (269) 00:04:20:10:01:1b: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:57.0072] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:e3:81: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:57.0077] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:e3:81: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:57.0086] Slim::Player::StreamingController::_eventAction (269) 00:04:20:16:01:ea: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:57.6762] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:58.7392] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:53:59.8130] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:00.8686] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:01.7547] Slim::Player::StreamingController::stop (1557) 00:1b:63:b4:7a:23 [09-01-09 08:54:01.7552] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: Stop in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:01.7561] Slim::Player::Source::playmode (172) 00:1b:63:b4:7a:23: Current playmode: stop [09-01-09 08:54:01.7600] Slim::Player::StreamingController::play (1560) 00:1b:63:b4:7a:23 [09-01-09 08:54:01.7604] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: Play in STOPPED-IDLE -> Slim::Player::StreamingController::_StopGetNext [09-01-09 08:54:01.7607] Slim::Player::StreamingController::_eventAction (282) params: index => 0 seekdata => undef [09-01-09 08:54:01.7620] Slim::Player::StreamingController::_Stop (532) Song queue is now 0 [09-01-09 08:54:01.7623] Slim::Player::StreamingController::_setPlayingState (1802) new playing state STOPPED [09-01-09 08:54:01.7631] Slim::Player::StreamingController::_setStreamingState (1815) new streaming state IDLE [09-01-09 08:54:01.7672] Slim::Player::Song::new (64) index 0 -> slacker://stations/4595820/1217364463.mp3 [09-01-09 08:54:01.7679] Slim::Player::Song::new (101) live=2 [09-01-09 08:54:01.7682] Slim::Player::StreamingController::_setStreamingState (1815) new streaming state TRACKWAIT [09-01-09 08:54:01.7686] Slim::Player::Song::getNextSong (178) slacker://stations/4595820/1217364463.mp3 [09-01-09 08:54:01.7690] Slim::Player::Song::getNextSong (200) scanning URL slacker://stations/4595820/1217364463.mp3 [09-01-09 08:54:01.7696] Slim::Player::Song::getNextSong (178) slacker://stations/4595820/1217364463.mp3 [09-01-09 08:54:01.7709] Slim::Plugin::Slacker::ProtocolHandler::_getNextTrack (146) 00:1b:63:b4:7a:23 Getting next track from SqueezeNetwork [09-01-09 08:54:01.7749] Slim::Player::StreamingController::_playersMessage (684) Getting stream info...: Play Station [09-01-09 08:54:01.7759] Slim::Player::StreamingController::_eventAction (301) 00:1b:63:b4:7a:23: Play - new state STOPPED-TRACKWAIT [09-01-09 08:54:01.8907] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in STOPPED-TRACKWAIT -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:02.0037] Slim::Player::StreamingController::_eventAction (269) 00:04:20:10:01:1b: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:02.0049] Slim::Player::StreamingController::_eventAction (269) 00:04:20:16:01:ea: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:02.0057] Slim::Player::StreamingController::_eventAction (269) 00:04:20:10:01:1b: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:02.0064] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:e3:81: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:02.0082] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:e3:81: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:02.0092] Slim::Player::StreamingController::_eventAction (269) 00:04:20:16:01:ea: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:02.0099] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in STOPPED-TRACKWAIT -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:02.1501] Slim::Plugin::Slacker::ProtocolHandler::gotNextTrack (169) Got Slacker track: { URL => "http://signal-6.slacker.com/c2/transcodings/wmg/adriveB/20070814_0731/093624729822/mp3_128/093624729860_00010_128.mp3?e=1231520062&h=9c2ff43893a39d5ec53e3422af09b30e", album => "The Singles 81>85", albumid => 29_782, arate => 0, artist => "Depeche Mode", artistid => 3470, audiogain => -4, copyright => "1999 Reprise Records", fid => 3_643_206, licensed => 1, pid => 6_508_491, portablelicensed => 1, saved => 0, sid => "stations/4595820/1217364463", skip => "yes", skips => 6, tid => 6_131_649, title => "People Are People", tlen => 226, trate => 0, type => "radio", upnext => "U2", year => 1998, } [09-01-09 08:54:02.1511] Slim::Player::StreamingController::_nextTrackReady (639) 00:1b:63:b4:7a:23: nextTrack will be index 0 [09-01-09 08:54:02.1514] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: NextTrackReady in STOPPED-TRACKWAIT -> Slim::Player::StreamingController::_Stream [09-01-09 08:54:02.1517] Slim::Player::StreamingController::_Stream (913) 00:1b:63:b4:7a:23: preparing to stream song index 0 [09-01-09 08:54:02.1519] Slim::Player::Song::DESTROY (111) DESTROY(Slim::Player::Song=HASH(0x343b2b8)) live=1: index=0, url=slacker://stations/4595820/1212442209.mp3 [09-01-09 08:54:02.1524] Slim::Player::StreamingController::_Stream (928) Song queue is now 0 [09-01-09 08:54:02.1527] Slim::Player::Song::open (302) slacker://stations/4595820/1217364463.mp3 [09-01-09 08:54:02.1537] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = mp3, squeezeplay = 00:1b:63:b4:7a:23 [09-01-09 08:54:02.1540] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mp3-mp3-*-* is enabled [09-01-09 08:54:02.1542] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-ogg-squeezeplay-00:1b:63:b4:7a:23 [09-01-09 08:54:02.1544] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-ogg-*-00:1b:63:b4:7a:23 [09-01-09 08:54:02.1546] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-ogg-squeezeplay-* [09-01-09 08:54:02.1548] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-ogg-*-* [09-01-09 08:54:02.1550] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-flc-squeezeplay-00:1b:63:b4:7a:23 [09-01-09 08:54:02.1553] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-flc-*-00:1b:63:b4:7a:23 [09-01-09 08:54:02.1555] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-flc-squeezeplay-* [09-01-09 08:54:02.1557] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-flc-*-* [09-01-09 08:54:02.1559] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-aif-squeezeplay-00:1b:63:b4:7a:23 [09-01-09 08:54:02.1561] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-aif-*-00:1b:63:b4:7a:23 [09-01-09 08:54:02.1564] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-aif-squeezeplay-* [09-01-09 08:54:02.1566] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-aif-*-* [09-01-09 08:54:02.1567] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-wav-squeezeplay-00:1b:63:b4:7a:23 [09-01-09 08:54:02.1569] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-wav-*-00:1b:63:b4:7a:23 [09-01-09 08:54:02.1571] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-wav-squeezeplay-* [09-01-09 08:54:02.1574] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-wav-*-* [09-01-09 08:54:02.1576] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-mp3-squeezeplay-00:1b:63:b4:7a:23 [09-01-09 08:54:02.1578] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-mp3-*-00:1b:63:b4:7a:23 [09-01-09 08:54:02.1580] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-mp3-squeezeplay-* [09-01-09 08:54:02.1582] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-mp3-*-* [09-01-09 08:54:02.1584] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mp3-mp3-*-* is enabled [09-01-09 08:54:02.1586] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-09 08:54:02.1588] Slim::Player::TranscodingHelper::checkBin (237) Found command: - [09-01-09 08:54:02.1590] Slim::Player::TranscodingHelper::getConvertCommand2 (390) Rejecting - because no available stream mode supported: R [09-01-09 08:54:02.1593] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-mp3-transcode-* [09-01-09 08:54:02.1595] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mp3-mp3-transcode-* is enabled [09-01-09 08:54:02.1597] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-09 08:54:02.1599] Slim::Player::TranscodingHelper::checkBin (237) Found command: [lame] --silent -q $QUALITY$ -v $BITRATE$ $RESAMPLE$ --mp3input $FILE$ - [09-01-09 08:54:02.1605] Slim::Player::TranscodingHelper::checkBin (260) couldn't find binary for: lame [09-01-09 08:54:02.1607] Slim::Player::TranscodingHelper::getConvertCommand2 (451) Error: Didn't find any command matches for type: mp3 [09-01-09 08:54:02.1610] Slim::Player::Song::open (323) seek=false time=0 canSeek=0SEEK_ERROR_TYPE_NOT_SUPPORTEDSlacker [09-01-09 08:54:02.1615] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = mp3, squeezeplay = 00:1b:63:b4:7a:23 [09-01-09 08:54:02.1618] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mp3-mp3-*-* is enabled [09-01-09 08:54:02.1620] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-ogg-squeezeplay-00:1b:63:b4:7a:23 [09-01-09 08:54:02.1622] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-ogg-*-00:1b:63:b4:7a:23 [09-01-09 08:54:02.1624] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-ogg-squeezeplay-* [09-01-09 08:54:02.1627] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-ogg-*-* [09-01-09 08:54:02.1629] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-flc-squeezeplay-00:1b:63:b4:7a:23 [09-01-09 08:54:02.1631] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-flc-*-00:1b:63:b4:7a:23 [09-01-09 08:54:02.1633] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-flc-squeezeplay-* [09-01-09 08:54:02.1635] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-flc-*-* [09-01-09 08:54:02.1637] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-aif-squeezeplay-00:1b:63:b4:7a:23 [09-01-09 08:54:02.1639] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-aif-*-00:1b:63:b4:7a:23 [09-01-09 08:54:02.1641] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-aif-squeezeplay-* [09-01-09 08:54:02.1643] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-aif-*-* [09-01-09 08:54:02.1645] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-wav-squeezeplay-00:1b:63:b4:7a:23 [09-01-09 08:54:02.1647] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-wav-*-00:1b:63:b4:7a:23 [09-01-09 08:54:02.1649] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-wav-squeezeplay-* [09-01-09 08:54:02.1651] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-wav-*-* [09-01-09 08:54:02.1653] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-mp3-squeezeplay-00:1b:63:b4:7a:23 [09-01-09 08:54:02.1655] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-mp3-*-00:1b:63:b4:7a:23 [09-01-09 08:54:02.1658] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-mp3-squeezeplay-* [09-01-09 08:54:02.1659] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mp3-mp3-*-* [09-01-09 08:54:02.1661] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mp3-mp3-*-* is enabled [09-01-09 08:54:02.1663] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-09 08:54:02.1665] Slim::Player::TranscodingHelper::checkBin (237) Found command: - [09-01-09 08:54:02.1668] Slim::Player::TranscodingHelper::getConvertCommand2 (454) Matched: mp3->mp3 via: - [09-01-09 08:54:02.1670] Slim::Player::Song::open (340) Transcoder: streamMode=I, streamformat=mp3 [09-01-09 08:54:02.1674] Slim::Player::Song::open (354) URL supports direct streaming [slacker://stations/4595820/1217364463.mp3->http://signal-6.slacker.com/c2/transcodings/wmg/adriveB/20070814_0731/093624729822/mp3_128/093624729860_00010_128.mp3?e=1231520062&h=9c2ff43893a39d5ec53e3422af09b30e] [09-01-09 08:54:02.1709] Slim::Player::SongStreamController::new (32) live=1 [09-01-09 08:54:02.1716] Slim::Player::StreamingController::_Stream (969) 00:1b:63:b4:7a:23: stream [09-01-09 08:54:02.1721] Slim::Plugin::Slacker::ProtocolHandler::trackGain (554) Using replaygain value of -4 for Slacker track [09-01-09 08:54:02.1736] Slim::Player::Squeezebox::stream_s (735) This player supports direct streaming for http://signal-6.slacker.com/c2/transcodings/wmg/adriveB/20070814_0731/093624729822/mp3_128/093624729860_00010_128.mp3?e=1231520062&h=9c2ff43893a39d5ec53e3422af09b30e as http://signal-6.slacker.com/c2/transcodings/wmg/adriveB/20070814_0731/093624729822/mp3_128/093624729860_00010_128.mp3?e=1231520062&h=9c2ff43893a39d5ec53e3422af09b30e, let's do it. [09-01-09 08:54:02.1865] Slim::Player::Squeezebox::stream_s (773) setting up direct stream (3496973318:80) autostart: 3. [09-01-09 08:54:02.1869] Slim::Player::Squeezebox::stream_s (774) request string: GET /c2/transcodings/wmg/adriveB/20070814_0731/093624729822/mp3_128/093624729860_00010_128.mp3?e=1231520062&h=9c2ff43893a39d5ec53e3422af09b30e HTTP/1.0 Cache-Control: no-cache Connection: close Accept: */* Host: signal-6.slacker.com User-Agent: iTunes/4.7.1 (Darwin; N; Mac OS X 10.5.5 (9F33); x86; EN; utf8) SqueezeCenter/7.3.2/24591 Icy-Metadata: 1 [09-01-09 08:54:02.1884] Slim::Player::StreamingController::_Stream (998) Song queue is now 0 [09-01-09 08:54:02.1888] Slim::Player::StreamingController::_setPlayingState (1802) new playing state BUFFERING [09-01-09 08:54:02.1891] Slim::Player::StreamingController::_setStreamingState (1815) new streaming state STREAMING [09-01-09 08:54:02.1893] Slim::Player::StreamingController::_eventAction (301) 00:1b:63:b4:7a:23: NextTrackReady - new state BUFFERING-STREAMING [09-01-09 08:54:02.1901] Slim::Plugin::Slacker::ProtocolHandler::playlistCallback (455) Got playlist event: repeat [09-01-09 08:54:02.1926] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:02.2994] Slim::Player::Player::_buffering (1172) Buffering... 0 / 20480 [09-01-09 08:54:02.3173] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:02.3184] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:02.3264] Slim::Player::StreamingController::playerEndOfStream (1711) 00:1b:63:b4:7a:23 [09-01-09 08:54:02.3266] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: EndOfStream in BUFFERING-STREAMING -> Slim::Player::StreamingController::_StartStreamout [09-01-09 08:54:02.3268] Slim::Player::StreamingController::_setStreamingState (1815) new streaming state STREAMOUT [09-01-09 08:54:02.3275] Slim::Player::StreamingController::_setPlayingState (1802) new playing state PLAYING [09-01-09 08:54:02.3277] Slim::Player::StreamingController::_Playing (352) Song 0 has now started playing [09-01-09 08:54:02.3284] Slim::Player::StreamingController::_Playing (381) Song queue is now 0 [09-01-09 08:54:02.3286] Slim::Player::StreamingController::_eventAction (301) 00:1b:63:b4:7a:23: EndOfStream - new state PLAYING-STREAMOUT [09-01-09 08:54:02.3293] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:02.4759] Slim::Plugin::Slacker::ProtocolHandler::playlistCallback (455) Got playlist event: newsong [09-01-09 08:54:02.9813] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:04.0409] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:05.1759] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:06.2402] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:07.0039] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:07.0052] Slim::Player::StreamingController::_eventAction (269) 00:04:20:10:01:1b: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:07.0059] Slim::Player::StreamingController::_eventAction (269) 00:04:20:10:01:1b: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:07.0075] Slim::Player::StreamingController::_eventAction (269) 00:04:20:16:01:ea: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:07.0082] Slim::Player::StreamingController::_eventAction (269) 00:04:20:16:01:ea: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:07.0089] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:e3:81: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:07.0095] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:e3:81: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:07.3767] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:07.5992] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:07.8892] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:08.1632] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:08.4425] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:09.5123] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:10.5717] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:11.6399] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:12.0045] Slim::Player::StreamingController::_eventAction (269) 00:04:20:10:01:1b: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:12.0055] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:12.0066] Slim::Player::StreamingController::_eventAction (269) 00:04:20:16:01:ea: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:12.0074] Slim::Player::StreamingController::_eventAction (269) 00:04:20:16:01:ea: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:12.0081] Slim::Player::StreamingController::_eventAction (269) 00:04:20:10:01:1b: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:12.0088] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:e3:81: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:12.0094] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:e3:81: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:12.7726] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:13.8481] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:14.9753] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:16.0402] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:17.0035] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:17.0045] Slim::Player::StreamingController::_eventAction (269) 00:04:20:10:01:1b: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:17.0050] Slim::Player::StreamingController::_eventAction (269) 00:04:20:10:01:1b: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:17.0056] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:e3:81: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:17.0061] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:e3:81: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:17.0069] Slim::Player::StreamingController::_eventAction (269) 00:04:20:16:01:ea: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:17.0075] Slim::Player::StreamingController::_eventAction (269) 00:04:20:16:01:ea: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:17.1749] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:18.2401] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:19.3753] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:20.4412] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:21.4596] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:22.0021] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:22.0029] Slim::Player::StreamingController::_eventAction (269) 00:04:20:10:01:1b: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:22.0036] Slim::Player::StreamingController::_eventAction (269) 00:04:20:16:01:ea: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:22.0041] Slim::Player::StreamingController::_eventAction (269) 00:04:20:10:01:1b: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:22.0045] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:e3:81: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:22.0049] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:e3:81: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:22.0056] Slim::Player::StreamingController::_eventAction (269) 00:04:20:16:01:ea: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:22.5710] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:23.6356] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:24.7707] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:25.8465] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:26.9741] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:27.0033] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:27.0045] Slim::Player::StreamingController::_eventAction (269) 00:04:20:10:01:1b: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:27.0050] Slim::Player::StreamingController::_eventAction (269) 00:04:20:10:01:1b: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:27.0056] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:e3:81: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:27.0059] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:e3:81: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:27.0065] Slim::Player::StreamingController::_eventAction (269) 00:04:20:16:01:ea: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:27.0071] Slim::Player::StreamingController::_eventAction (269) 00:04:20:16:01:ea: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:28.0383] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:29.1741] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:30.2390] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:31.3754] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:32.0040] Slim::Player::StreamingController::_eventAction (269) 00:04:20:10:01:1b: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:32.0048] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-09 08:54:32.0055] Slim::Player::StreamingController::_eventAction (269) 00:04:20:16:01:ea: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:32.0059] Slim::Player::StreamingController::_eventAction (269) 00:04:20:10:01:1b: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:32.0064] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:e3:81: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:32.0068] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:e3:81: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:32.0074] Slim::Player::StreamingController::_eventAction (269) 00:04:20:16:01:ea: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp [09-01-09 08:54:32.4397] Slim::Player::StreamingController::_eventAction (269) 00:1b:63:b4:7a:23: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync