[08-12-20 14:19:09.6418] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:xx:xx: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[08-12-20 14:19:10.6466] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:xx:xx: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[08-12-20 14:19:11.6475] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:xx:xx: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[08-12-20 14:19:12.6416] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:xx:xx: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[08-12-20 14:19:12.6861] Slim::Player::StreamingController::playerReadyToStream (1628) 00:04:20:07:xx:xx
[08-12-20 14:19:12.6869] Slim::Plugin::RhapsodyDirect::ProtocolHandler::onPlayout (749) onPlayout, logging playback
[08-12-20 14:19:12.6881] Slim::Plugin::RhapsodyDirect::ProtocolHandler::_doLog (799) Logging track playback: 289 seconds, trackId: Tra.7454268, stationId: 
[08-12-20 14:19:12.7490] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:xx:xx: ReadyToStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_NextIfMore
[08-12-20 14:19:12.7520] Slim::Player::StreamingController::_setStreamingState (1792) new streaming state IDLE
[08-12-20 14:19:12.7533] Slim::Player::StreamingController::nextsong (747) The next song is number 57, was 56
[08-12-20 14:19:12.7697] Slim::Player::Song::new (64) index 57 -> rhapd://Tra.7454262.mp3
[08-12-20 14:19:12.7709] Slim::Player::Song::new (101) live=2
[08-12-20 14:19:12.7717] Slim::Player::StreamingController::_setStreamingState (1792) new streaming state TRACKWAIT
[08-12-20 14:19:12.7725] Slim::Player::Song::getNextSong (178) rhapd://Tra.7454262.mp3
[08-12-20 14:19:12.7733] Slim::Player::Song::getNextSong (200) scanning URL rhapd://Tra.7454262.mp3
[08-12-20 14:19:12.7744] Slim::Player::Song::getNextSong (178) rhapd://Tra.7454262.mp3
[08-12-20 14:19:12.7757] Slim::Plugin::RhapsodyDirect::ProtocolHandler::_getTrackInfo (413) Getting next track playback info from SN
[08-12-20 14:19:12.8012] Slim::Player::StreamingController::_eventAction (301) 00:04:20:07:xx:xx: ReadyToStream - new state PLAYING-TRACKWAIT
[08-12-20 14:19:13.0479] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:xx:xx: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync
[08-12-20 14:19:13.0493] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:xx:xx: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync
[08-12-20 14:19:13.6439] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:xx:xx: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync
[08-12-20 14:19:14.6514] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:xx:xx: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync
[08-12-20 14:19:15.6410] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:xx:xx: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync
[08-12-20 14:19:16.7219] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:xx:xx: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync
[08-12-20 14:19:17.6517] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:xx:xx: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync
[08-12-20 14:19:17.9457] Slim::Plugin::RhapsodyDirect::ProtocolHandler::__ANON__ (791) Logging returned error: Timed out waiting for data
[08-12-20 14:19:18.0133] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:xx:xx: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync
[08-12-20 14:19:18.0140] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:xx:xx: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync
[08-12-20 14:19:18.0474] Slim::Plugin::RhapsodyDirect::ProtocolHandler::__ANON__ (402) getTrackInfo failed: Timed out waiting for data
[08-12-20 14:19:18.0477] Slim::Plugin::RhapsodyDirect::ProtocolHandler::_gotTrackError (460) Error during getTrackInfo: Timed out waiting for data
[08-12-20 14:19:18.0498] Slim::Player::StreamingController::_playersMessage (684) Timed out waiting for data: If I Could Only Fly by Blaze Foley from Live at the Austin Outhouse
[08-12-20 14:19:18.0569] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:xx:xx: NextTrackError in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_NextIfMore
[08-12-20 14:19:18.0573] Slim::Player::StreamingController::_eventAction (282) params: errorIndex => undef error => ARRAY(0x76b7dec) errorSong => Slim::Player::Song=HASH(0x7628d8c)
[08-12-20 14:19:18.0576] Slim::Player::StreamingController::_setStreamingState (1792) new streaming state IDLE
[08-12-20 14:19:18.0595] Slim::Player::StreamingController::nextsong (747) The next song is number 58, was 57
[08-12-20 14:19:18.0670] Slim::Player::Song::new (64) index 58 -> rhapd://Tra.9030964.mp3
[08-12-20 14:19:18.0677] Slim::Player::Song::new (101) live=3
[08-12-20 14:19:18.0680] Slim::Player::StreamingController::_setStreamingState (1792) new streaming state TRACKWAIT
[08-12-20 14:19:18.0684] Slim::Player::Song::getNextSong (178) rhapd://Tra.9030964.mp3
[08-12-20 14:19:18.0688] Slim::Player::Song::getNextSong (200) scanning URL rhapd://Tra.9030964.mp3
[08-12-20 14:19:18.0695] Slim::Player::Song::getNextSong (178) rhapd://Tra.9030964.mp3
[08-12-20 14:19:18.0701] Slim::Plugin::RhapsodyDirect::ProtocolHandler::_getTrackInfo (413) Getting next track playback info from SN
[08-12-20 14:19:18.0828] Slim::Player::Song::DESTROY (111) DESTROY(Slim::Player::Song=HASH(0x7628d8c)) live=2: index=57, url=rhapd://Tra.7454262.mp3
[08-12-20 14:19:18.6456] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:xx:xx: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync
[08-12-20 14:19:19.6466] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:xx:xx: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync
[08-12-20 14:19:20.6498] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:xx:xx: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync
[08-12-20 14:19:21.6385] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:xx:xx: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync
[08-12-20 14:19:22.6418] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:xx:xx: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync
[08-12-20 14:19:22.6480] Slim::Player::StreamingController::playerStopped (1590) 00:04:20:07:xx:xx
[08-12-20 14:19:22.6533] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:xx:xx: Stopped in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_PlayIfReady
[08-12-20 14:19:22.6544] Slim::Player::StreamingController::_setPlayingState (1779) new playing state STOPPED
[08-12-20 14:19:22.6553] Slim::Player::StreamingController::_eventAction (301) 00:04:20:07:xx:xx: Stopped - new state STOPPED-TRACKWAIT
[08-12-20 14:19:23.0078] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:xx:xx: StatusHeartbeat in STOPPED-TRACKWAIT -> Slim::Player::StreamingController::_NoOp
[08-12-20 14:19:23.0138] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:xx:xx: StatusHeartbeat in STOPPED-TRACKWAIT -> Slim::Player::StreamingController::_NoOp
[08-12-20 14:19:23.1754] Slim::Plugin::RhapsodyDirect::ProtocolHandler::__ANON__ (402) getTrackInfo failed: Timed out waiting for data
[08-12-20 14:19:23.1764] Slim::Plugin::RhapsodyDirect::ProtocolHandler::_gotTrackError (460) Error during getTrackInfo: Timed out waiting for data
[08-12-20 14:19:23.1809] Slim::Player::StreamingController::_playersMessage (684) Timed out waiting for data: Lived in Bars by Cat Power from The Greatest
[08-12-20 14:19:23.1823] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:xx:xx: NextTrackError in STOPPED-TRACKWAIT -> Slim::Player::StreamingController::_NextIfMore
[08-12-20 14:19:23.1833] Slim::Player::StreamingController::_eventAction (282) params: errorIndex => undef error => ARRAY(0x76284d4) errorSong => Slim::Player::Song=HASH(0x7466560)
[08-12-20 14:19:23.1841] Slim::Player::StreamingController::_setStreamingState (1792) new streaming state IDLE
[08-12-20 14:19:23.1852] Slim::Player::StreamingController::nextsong (718) Giving up because of too many consecutive errors: 2
[08-12-20 14:19:23.1860] Slim::Player::StreamingController::_eventAction (301) 00:04:20:07:xx:xx: NextTrackError - new state STOPPED-IDLE
[08-12-20 14:19:23.1874] Slim::Player::Song::DESTROY (111) DESTROY(Slim::Player::Song=HASH(0x7466560)) live=1: index=58, url=rhapd://Tra.9030964.mp3
[08-12-20 14:19:23.6448] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:xx:xx: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp
[08-12-20 14:19:24.6472] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:xx:xx: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp
[08-12-20 14:19:25.6447] Slim::Player::StreamingController::_eventAction (269) 00:04:20:07:xx:xx: StatusHeartbeat in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp