-- Logs begin at Mon 2024-08-19 21:01:21 IST, end at Tue 2024-08-20 15:08:50 IST. -- Aug 20 15:08:32 ffdac volumio[878]: info: VolumeController::SetAlsaVolume47 Aug 20 15:08:32 ffdac volumio[878]: info: CoreCommandRouter::volumioGetState Aug 20 15:08:32 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:32 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 15:08:32 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:32 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:32 ffdac volumio[878]: SPOTIFY: SPOTIFY VOLUME 61 Aug 20 15:08:32 ffdac volumio[878]: SPOTIFY: VOLUMIO VOLUME 47 Aug 20 15:08:32 ffdac volumio[878]: SPOTIFY: DELTA VOLUME ENOUGH: true Aug 20 15:08:32 ffdac volumio[878]: info: Setting Spotify Volume from Volumio: 47 Aug 20 15:08:33 ffdac volumio[878]: SPOTIFY: SETTING SPOTIFY VOLUME 47 Aug 20 15:08:33 ffdac volumio[878]: info: Sending Spotify command with payload to local API: /player/volume Aug 20 15:08:36 ffdac volumio[878]: info: Preload queue cleared Aug 20 15:08:36 ffdac volumio[878]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 20 15:08:36 ffdac volumio[878]: info: CoreStateMachine::ClearQueue Aug 20 15:08:36 ffdac volumio[878]: info: CoreStateMachine::stop Aug 20 15:08:36 ffdac volumio[878]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 20 15:08:36 ffdac volumio[878]: info: CoreStateMachine::stPlaybackTimer Aug 20 15:08:36 ffdac volumio[878]: info: CoreStateMachine::updateTrackBlock Aug 20 15:08:36 ffdac volumio[878]: info: CorePlayQueue::getTrackBlock Aug 20 15:08:36 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:36 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:36 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 15:08:36 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:36 ffdac volumio[878]: info: CoreStateMachine::serviceStop Aug 20 15:08:36 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:36 ffdac volumio[878]: info: CoreCommandRouter::serviceStop Aug 20 15:08:36 ffdac volumio[878]: info: [1724146716726] ControllerWebradio::stop Aug 20 15:08:36 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand stop Aug 20 15:08:36 ffdac volumio[878]: info: CorePlayQueue::clearPlayQueue Aug 20 15:08:36 ffdac volumio[878]: info: CorePlayQueue::saveQueue Aug 20 15:08:36 ffdac volumio[878]: info: CoreCommandRouter::volumioPushQueue Aug 20 15:08:36 ffdac volumio[878]: info: CoreStateMachine::addQueueItems Aug 20 15:08:36 ffdac volumio[878]: info: CorePlayQueue::addQueueItems Aug 20 15:08:36 ffdac volumio[878]: info: Preload queue cleared Aug 20 15:08:36 ffdac volumio[878]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1635044 Aug 20 15:08:36 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 20 15:08:36 ffdac volumio[878]: info: CoreCommandRouter::volumioPushQueue Aug 20 15:08:36 ffdac volumio[878]: info: CorePlayQueue::saveQueue Aug 20 15:08:36 ffdac volumio[878]: info: CoreStateMachine::updateTrackBlock Aug 20 15:08:36 ffdac volumio[878]: info: CorePlayQueue::getTrackBlock Aug 20 15:08:36 ffdac volumio[878]: info: CoreCommandRouter::volumioPlay Aug 20 15:08:36 ffdac volumio[878]: info: CoreStateMachine::play index 0 Aug 20 15:08:36 ffdac volumio[878]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 20 15:08:36 ffdac volumio[878]: info: CoreStateMachine::stop Aug 20 15:08:36 ffdac volumio[878]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 20 15:08:36 ffdac volumio[878]: info: CoreStateMachine::play index undefined Aug 20 15:08:36 ffdac volumio[878]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 20 15:08:36 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:36 ffdac volumio[878]: info: CoreStateMachine::startPlaybackTimer Aug 20 15:08:36 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:36 ffdac volumio[878]: info: [1724146716739] ControllerWebradio::clearAddPlayTrack Aug 20 15:08:36 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand stop Aug 20 15:08:36 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:36 ffdac volumio[878]: info: Aug 20 15:08:36 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:36 ffdac volumio[878]: info: sendMpdCommand stop took 16 milliseconds Aug 20 15:08:36 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:36 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:36 ffdac volumio[878]: info: sendMpdCommand stop took 3 milliseconds Aug 20 15:08:36 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand clear Aug 20 15:08:36 ffdac volumio[878]: info: Aug 20 15:08:36 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:36 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:36 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:36 ffdac volumio[878]: info: Aug 20 15:08:36 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:36 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:36 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:36 ffdac volumio[878]: info: Aug 20 15:08:36 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:36 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:36 ffdac volumio[878]: info: sendMpdCommand status took 3 milliseconds Aug 20 15:08:36 ffdac volumio[878]: info: sendMpdCommand clear took 3 milliseconds Aug 20 15:08:36 ffdac volumio[878]: info: sendMpdCommand status took 1 milliseconds Aug 20 15:08:36 ffdac volumio[878]: info: sendMpdCommand status took 1 milliseconds Aug 20 15:08:36 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:36 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:36 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1635044" Aug 20 15:08:36 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:36 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:36 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:36 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:36 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:36 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:36 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 15:08:36 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:36 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:36 ffdac volumio[878]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Aug 20 15:08:36 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:36 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:36 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:36 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:36 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:36 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:36 ffdac volumio[878]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Aug 20 15:08:36 ffdac volumio[878]: info: ------------------------------ 9ms Aug 20 15:08:36 ffdac volumio[878]: info: ------------------------------ 9ms Aug 20 15:08:36 ffdac volumio[878]: info: Aug 20 15:08:36 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:36 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:36 ffdac volumio[878]: info: Aug 20 15:08:36 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:36 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:36 ffdac volumio[878]: error: updateQueue error: null Aug 20 15:08:36 ffdac volumio[878]: info: ------------------------------ 9ms Aug 20 15:08:36 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 9 milliseconds Aug 20 15:08:36 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:36 ffdac volumio[878]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 20 15:08:36 ffdac volumio[878]: info: ------------------------------ 14ms Aug 20 15:08:36 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:36 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:37 ffdac volumio[878]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1635044" took 987 milliseconds Aug 20 15:08:37 ffdac volumio[878]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 20 15:08:37 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand play Aug 20 15:08:37 ffdac volumio[878]: info: Aug 20 15:08:37 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:37 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:37 ffdac volumio[878]: info: ------------------------------ 982ms Aug 20 15:08:37 ffdac volumio[878]: info: ------------------------------ 981ms Aug 20 15:08:37 ffdac volumio[878]: info: sendMpdCommand play took 1 milliseconds Aug 20 15:08:37 ffdac volumio[878]: info: Aug 20 15:08:37 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:37 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:37 ffdac volumio[878]: info: Aug 20 15:08:37 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:37 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:37 ffdac volumio[878]: info: ------------------------------ 3ms Aug 20 15:08:37 ffdac volumio[878]: info: ------------------------------ 1ms Aug 20 15:08:38 ffdac volumio[878]: info: Aug 20 15:08:38 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:38 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:38 ffdac volumio[878]: info: Aug 20 15:08:38 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:38 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:38 ffdac volumio[878]: info: Aug 20 15:08:38 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:38 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:38 ffdac volumio[878]: info: Aug 20 15:08:38 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:38 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:38 ffdac volumio[878]: info: Aug 20 15:08:38 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:38 ffdac volumio[878]: info: sendMpdCommand status took 3 milliseconds Aug 20 15:08:38 ffdac volumio[878]: info: sendMpdCommand status took 2 milliseconds Aug 20 15:08:38 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:38 ffdac volumio[878]: info: sendMpdCommand status took 2 milliseconds Aug 20 15:08:38 ffdac volumio[878]: info: sendMpdCommand status took 2 milliseconds Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:38 ffdac volumio[878]: info: Aug 20 15:08:38 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:38 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:38 ffdac volumio[878]: info: Aug 20 15:08:38 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:38 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:38 ffdac volumio[878]: info: Aug 20 15:08:38 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:38 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:38 ffdac volumio[878]: info: Aug 20 15:08:38 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:38 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:38 ffdac volumio[878]: info: Aug 20 15:08:38 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:38 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:38 ffdac volumio[878]: info: sendMpdCommand status took 14 milliseconds Aug 20 15:08:38 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 13 milliseconds Aug 20 15:08:38 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 13 milliseconds Aug 20 15:08:38 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 13 milliseconds Aug 20 15:08:38 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 13 milliseconds Aug 20 15:08:38 ffdac volumio[878]: info: sendMpdCommand status took 12 milliseconds Aug 20 15:08:38 ffdac volumio[878]: info: ------------------------------ 3ms Aug 20 15:08:38 ffdac volumio[878]: info: sendMpdCommand status took 2 milliseconds Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:38 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:38 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:38 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"22.05 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"s2.voscast.com:12084","artist":"Tubetamilfm","album":null,"uri":"http://s2.voscast.com:12084","trackType":"com:12084"} Aug 20 15:08:38 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus stop Aug 20 15:08:38 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:38 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:38 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"22.05 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"s2.voscast.com:12084","artist":"Tubetamilfm","album":null,"uri":"http://s2.voscast.com:12084","trackType":"com:12084"} Aug 20 15:08:38 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus play Aug 20 15:08:38 ffdac volumio[878]: info: Received an update from plugin. extracting info from payload Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:38 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:38 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:38 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:38 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"22.05 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"s2.voscast.com:12084","artist":"Tubetamilfm","album":null,"uri":"http://s2.voscast.com:12084","trackType":"com:12084"} Aug 20 15:08:38 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus play Aug 20 15:08:38 ffdac volumio[878]: info: Received an update from plugin. extracting info from payload Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:38 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:38 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:38 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:38 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"22.05 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"s2.voscast.com:12084","artist":"Tubetamilfm","album":null,"uri":"http://s2.voscast.com:12084","trackType":"com:12084"} Aug 20 15:08:38 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus play Aug 20 15:08:38 ffdac volumio[878]: info: Received an update from plugin. extracting info from payload Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:38 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:38 ffdac volumio[878]: info: ------------------------------ 31ms Aug 20 15:08:38 ffdac volumio[878]: info: ------------------------------ 37ms Aug 20 15:08:38 ffdac volumio[878]: info: ------------------------------ 37ms Aug 20 15:08:38 ffdac volumio[878]: info: ------------------------------ 36ms Aug 20 15:08:38 ffdac volumio[878]: info: Aug 20 15:08:38 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:38 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:38 ffdac volumio[878]: info: Aug 20 15:08:38 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:38 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:38 ffdac volumio[878]: info: ------------------------------ 24ms Aug 20 15:08:38 ffdac volumio[878]: info: sendMpdCommand status took 23 milliseconds Aug 20 15:08:38 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 22 milliseconds Aug 20 15:08:38 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 21 milliseconds Aug 20 15:08:38 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 21 milliseconds Aug 20 15:08:38 ffdac volumio[878]: info: ------------------------------ 2ms Aug 20 15:08:38 ffdac volumio[878]: info: sendMpdCommand status took 2 milliseconds Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:38 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:38 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:38 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":342,"duration":0,"samplerate":"22.05 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"s2.voscast.com:12084","artist":"Tubetamilfm","album":null,"uri":"http://s2.voscast.com:12084","trackType":"com:12084"} Aug 20 15:08:38 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus play Aug 20 15:08:38 ffdac volumio[878]: info: Received an update from plugin. extracting info from payload Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:38 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:38 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:38 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:38 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":342,"duration":0,"samplerate":"22.05 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"s2.voscast.com:12084","artist":"Tubetamilfm","album":null,"uri":"http://s2.voscast.com:12084","trackType":"com:12084"} Aug 20 15:08:38 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus play Aug 20 15:08:38 ffdac volumio[878]: info: Received an update from plugin. extracting info from payload Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:38 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:38 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:38 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:38 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":342,"duration":0,"samplerate":"22.05 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"s2.voscast.com:12084","artist":"Tubetamilfm","album":null,"uri":"http://s2.voscast.com:12084","trackType":"com:12084"} Aug 20 15:08:38 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus play Aug 20 15:08:38 ffdac volumio[878]: info: Received an update from plugin. extracting info from payload Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:38 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:38 ffdac volumio[878]: info: ------------------------------ 55ms Aug 20 15:08:38 ffdac volumio[878]: info: ------------------------------ 53ms Aug 20 15:08:38 ffdac volumio[878]: info: ------------------------------ 44ms Aug 20 15:08:38 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:38 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:38 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:38 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:38 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:38 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:38 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:38 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:38 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:38 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:38 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:38 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:38 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 33 milliseconds Aug 20 15:08:38 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 33 milliseconds Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:38 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:38 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:38 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:38 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":342,"duration":0,"samplerate":"22.05 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"s2.voscast.com:12084","artist":"Tubetamilfm","album":null,"uri":"http://s2.voscast.com:12084","trackType":"com:12084"} Aug 20 15:08:38 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus play Aug 20 15:08:38 ffdac volumio[878]: info: Received an update from plugin. extracting info from payload Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:38 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:38 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:38 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:38 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":342,"duration":0,"samplerate":"22.05 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"s2.voscast.com:12084","artist":"Tubetamilfm","album":null,"uri":"http://s2.voscast.com:12084","trackType":"com:12084"} Aug 20 15:08:38 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus play Aug 20 15:08:38 ffdac volumio[878]: info: Received an update from plugin. extracting info from payload Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:38 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:38 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:38 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:38 ffdac volumio[878]: info: ------------------------------ 67ms Aug 20 15:08:38 ffdac volumio[878]: info: ------------------------------ 45ms Aug 20 15:08:38 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:38 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:38 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:38 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:39 ffdac volumio[878]: info: Aug 20 15:08:39 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:39 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:39 ffdac volumio[878]: info: Aug 20 15:08:39 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:39 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:39 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:39 ffdac volumio[878]: info: Aug 20 15:08:39 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:39 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:39 ffdac volumio[878]: info: Aug 20 15:08:39 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:39 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:39 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:39 ffdac volumio[878]: info: ------------------------------ 2ms Aug 20 15:08:39 ffdac volumio[878]: info: sendMpdCommand status took 1 milliseconds Aug 20 15:08:39 ffdac volumio[878]: info: ------------------------------ 1ms Aug 20 15:08:39 ffdac volumio[878]: info: sendMpdCommand status took 2 milliseconds Aug 20 15:08:39 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:39 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:39 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:39 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:39 ffdac volumio[878]: info: Aug 20 15:08:39 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:39 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:39 ffdac volumio[878]: info: Aug 20 15:08:39 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:39 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:39 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:39 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 20 15:08:39 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 20 15:08:39 ffdac volumio[878]: info: ------------------------------ 1ms Aug 20 15:08:39 ffdac volumio[878]: info: sendMpdCommand status took 1 milliseconds Aug 20 15:08:39 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:39 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:39 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:39 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:39 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:39 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:39 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:39 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":571,"duration":0,"samplerate":"22.05 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"SPB0111","artist":"Tubetamilfm","album":null,"uri":"http://s2.voscast.com:12084","trackType":"com:12084"} Aug 20 15:08:39 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:39 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:39 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus play Aug 20 15:08:39 ffdac volumio[878]: info: Received an update from plugin. extracting info from payload Aug 20 15:08:39 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 20 15:08:39 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:39 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 15:08:39 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:39 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:39 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:39 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:39 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:39 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:39 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":571,"duration":0,"samplerate":"22.05 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"SPB0111","artist":"Tubetamilfm","album":null,"uri":"http://s2.voscast.com:12084","trackType":"com:12084"} Aug 20 15:08:39 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:39 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:39 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus play Aug 20 15:08:39 ffdac volumio[878]: info: Received an update from plugin. extracting info from payload Aug 20 15:08:39 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 20 15:08:39 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:39 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:39 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:39 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:39 ffdac volumio[878]: info: ------------------------------ 16ms Aug 20 15:08:39 ffdac volumio[878]: info: ------------------------------ 15ms Aug 20 15:08:39 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 11 milliseconds Aug 20 15:08:39 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:39 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:39 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:39 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:39 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":571,"duration":0,"samplerate":"22.05 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"SPB0111","artist":"Tubetamilfm","album":null,"uri":"http://s2.voscast.com:12084","trackType":"com:12084"} Aug 20 15:08:39 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:39 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:39 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus play Aug 20 15:08:39 ffdac volumio[878]: info: Received an update from plugin. extracting info from payload Aug 20 15:08:39 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 20 15:08:39 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:39 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:39 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:39 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:39 ffdac volumio[878]: info: ------------------------------ 20ms Aug 20 15:08:39 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:39 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:39 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:39 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:39 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:39 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:42 ffdac volumio[878]: error: [yt-cast-receiver] RPC connection error: Aug 20 15:08:42 ffdac volumio[878]: (FetchError) request to https://www.youtube.com/api/lounge/bc/bind?AID=923&CI=0&RID=rpc&SID=6167F3EA69B70432&TYPE=xmlhttp&VER=8&app=ytcr&capabilities=dsp%2Cmic%2Cdpa%2Cntb&cst=m&device=LOUNGE_SCREEN&gsessionid=LAx63cwzOlM0vgB7VdyfCv5QPWNMhXH8Wyo7zoT2o4w&id=337d72bb-6725-4d68-839b-821662b2ec3d&loungeIdToken=AGdO5p-hDdtsp4TceeQjowibolrpSuA4dDK-SeoAotIR8svISNIwNdYJBBdvHxVAE7VwH2--VDyQNNfpGFXa7vVwyJ4oM0zdF6mpv67sbLHw0uGNXmz8tBk&mdxVersion=2&name=YouTube%20on%20FFDAC&obfuscatedGaiaId=&t=1&theme=cl&v=2&zx=89c62c96083f failed, reason: getaddrinfo ENOTFOUND www.youtube.com Aug 20 15:08:42 ffdac volumio[878]: FetchError: request to https://www.youtube.com/api/lounge/bc/bind?AID=923&CI=0&RID=rpc&SID=6167F3EA69B70432&TYPE=xmlhttp&VER=8&app=ytcr&capabilities=dsp%2Cmic%2Cdpa%2Cntb&cst=m&device=LOUNGE_SCREEN&gsessionid=LAx63cwzOlM0vgB7VdyfCv5QPWNMhXH8Wyo7zoT2o4w&id=337d72bb-6725-4d68-839b-821662b2ec3d&loungeIdToken=AGdO5p-hDdtsp4TceeQjowibolrpSuA4dDK-SeoAotIR8svISNIwNdYJBBdvHxVAE7VwH2--VDyQNNfpGFXa7vVwyJ4oM0zdF6mpv67sbLHw0uGNXmz8tBk&mdxVersion=2&name=YouTube%20on%20FFDAC&obfuscatedGaiaId=&t=1&theme=cl&v=2&zx=89c62c96083f failed, reason: getaddrinfo ENOTFOUND www.youtube.com Aug 20 15:08:42 ffdac volumio[878]: at ClientRequest. (/data/plugins/music_service/ytcr/node_modules/node-fetch/lib/index.js:1505:11) Aug 20 15:08:42 ffdac volumio[878]: at ClientRequest.emit (events.js:315:20) Aug 20 15:08:42 ffdac volumio[878]: at TLSSocket.socketErrorListener (_http_client.js:469:9) Aug 20 15:08:42 ffdac volumio[878]: at TLSSocket.emit (events.js:315:20) Aug 20 15:08:42 ffdac volumio[878]: at emitErrorNT (internal/streams/destroy.js:106:8) Aug 20 15:08:42 ffdac volumio[878]: at emitErrorCloseNT (internal/streams/destroy.js:74:3) Aug 20 15:08:42 ffdac volumio[878]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Aug 20 15:08:42 ffdac volumio[878]: error: [yt-cast-receiver] Retrying 1 / 3 Aug 20 15:08:42 ffdac volumio[878]: info: Preload queue cleared Aug 20 15:08:42 ffdac volumio[878]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 20 15:08:42 ffdac volumio[878]: info: CoreStateMachine::ClearQueue Aug 20 15:08:42 ffdac volumio[878]: info: CoreStateMachine::stop Aug 20 15:08:42 ffdac volumio[878]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 20 15:08:42 ffdac volumio[878]: info: CoreStateMachine::stPlaybackTimer Aug 20 15:08:42 ffdac volumio[878]: info: CoreStateMachine::updateTrackBlock Aug 20 15:08:42 ffdac volumio[878]: info: CorePlayQueue::getTrackBlock Aug 20 15:08:42 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:42 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:42 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 15:08:42 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:42 ffdac volumio[878]: info: CoreStateMachine::serviceStop Aug 20 15:08:42 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:42 ffdac volumio[878]: info: CoreCommandRouter::serviceStop Aug 20 15:08:42 ffdac volumio[878]: info: [1724146722941] ControllerWebradio::stop Aug 20 15:08:42 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand stop Aug 20 15:08:42 ffdac volumio[878]: info: CorePlayQueue::clearPlayQueue Aug 20 15:08:42 ffdac volumio[878]: info: CorePlayQueue::saveQueue Aug 20 15:08:42 ffdac volumio[878]: info: CoreCommandRouter::volumioPushQueue Aug 20 15:08:42 ffdac volumio[878]: info: CoreStateMachine::addQueueItems Aug 20 15:08:42 ffdac volumio[878]: info: CorePlayQueue::addQueueItems Aug 20 15:08:42 ffdac volumio[878]: info: Preload queue cleared Aug 20 15:08:42 ffdac volumio[878]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99540405 Aug 20 15:08:42 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 20 15:08:42 ffdac volumio[878]: info: CoreCommandRouter::volumioPushQueue Aug 20 15:08:42 ffdac volumio[878]: info: CorePlayQueue::saveQueue Aug 20 15:08:42 ffdac volumio[878]: info: CoreStateMachine::updateTrackBlock Aug 20 15:08:42 ffdac volumio[878]: info: CorePlayQueue::getTrackBlock Aug 20 15:08:42 ffdac volumio[878]: info: CoreCommandRouter::volumioPlay Aug 20 15:08:42 ffdac volumio[878]: info: CoreStateMachine::play index 0 Aug 20 15:08:42 ffdac volumio[878]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 20 15:08:42 ffdac volumio[878]: info: CoreStateMachine::stop Aug 20 15:08:42 ffdac volumio[878]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 20 15:08:42 ffdac volumio[878]: info: CoreStateMachine::play index undefined Aug 20 15:08:42 ffdac volumio[878]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 20 15:08:42 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:42 ffdac volumio[878]: info: CoreStateMachine::startPlaybackTimer Aug 20 15:08:42 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:42 ffdac volumio[878]: info: [1724146722950] ControllerWebradio::clearAddPlayTrack Aug 20 15:08:42 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand stop Aug 20 15:08:42 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:42 ffdac volumio[878]: info: Aug 20 15:08:42 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:42 ffdac volumio[878]: info: sendMpdCommand stop took 12 milliseconds Aug 20 15:08:42 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:42 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:42 ffdac volumio[878]: info: sendMpdCommand stop took 3 milliseconds Aug 20 15:08:42 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand clear Aug 20 15:08:42 ffdac volumio[878]: info: Aug 20 15:08:42 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:42 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:42 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:42 ffdac volumio[878]: info: Aug 20 15:08:42 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:42 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:42 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:42 ffdac volumio[878]: info: Aug 20 15:08:42 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:42 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:42 ffdac volumio[878]: info: sendMpdCommand status took 2 milliseconds Aug 20 15:08:42 ffdac volumio[878]: info: sendMpdCommand clear took 2 milliseconds Aug 20 15:08:42 ffdac volumio[878]: info: sendMpdCommand status took 2 milliseconds Aug 20 15:08:42 ffdac volumio[878]: info: sendMpdCommand status took 1 milliseconds Aug 20 15:08:42 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:42 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:42 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99540405" Aug 20 15:08:42 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:42 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:42 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:42 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:42 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:42 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:42 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 15:08:42 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:42 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:42 ffdac volumio[878]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Aug 20 15:08:42 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:42 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:42 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:42 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:42 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:42 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:42 ffdac volumio[878]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Aug 20 15:08:42 ffdac volumio[878]: info: ------------------------------ 8ms Aug 20 15:08:42 ffdac volumio[878]: info: ------------------------------ 9ms Aug 20 15:08:42 ffdac volumio[878]: info: Aug 20 15:08:42 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:42 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:42 ffdac volumio[878]: info: Aug 20 15:08:42 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:42 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:42 ffdac volumio[878]: error: updateQueue error: null Aug 20 15:08:42 ffdac volumio[878]: info: ------------------------------ 9ms Aug 20 15:08:42 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 8 milliseconds Aug 20 15:08:42 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:42 ffdac volumio[878]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 20 15:08:42 ffdac volumio[878]: info: ------------------------------ 13ms Aug 20 15:08:42 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:42 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:43 ffdac volumio[878]: info: Preload queue cleared Aug 20 15:08:43 ffdac volumio[878]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 20 15:08:43 ffdac volumio[878]: info: CoreStateMachine::ClearQueue Aug 20 15:08:43 ffdac volumio[878]: info: CoreStateMachine::stop Aug 20 15:08:43 ffdac volumio[878]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 20 15:08:43 ffdac volumio[878]: info: CorePlayQueue::clearPlayQueue Aug 20 15:08:43 ffdac volumio[878]: info: CorePlayQueue::saveQueue Aug 20 15:08:43 ffdac volumio[878]: info: CoreCommandRouter::volumioPushQueue Aug 20 15:08:43 ffdac volumio[878]: info: CoreStateMachine::addQueueItems Aug 20 15:08:43 ffdac volumio[878]: info: CorePlayQueue::addQueueItems Aug 20 15:08:43 ffdac volumio[878]: info: Preload queue cleared Aug 20 15:08:43 ffdac volumio[878]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99540405 Aug 20 15:08:43 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 20 15:08:43 ffdac volumio[878]: info: CoreCommandRouter::volumioPushQueue Aug 20 15:08:43 ffdac volumio[878]: info: CorePlayQueue::saveQueue Aug 20 15:08:43 ffdac volumio[878]: info: CoreStateMachine::updateTrackBlock Aug 20 15:08:43 ffdac volumio[878]: info: CorePlayQueue::getTrackBlock Aug 20 15:08:43 ffdac volumio[878]: info: CoreCommandRouter::volumioPlay Aug 20 15:08:43 ffdac volumio[878]: info: CoreStateMachine::play index 0 Aug 20 15:08:43 ffdac volumio[878]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 20 15:08:43 ffdac volumio[878]: info: CoreStateMachine::stop Aug 20 15:08:43 ffdac volumio[878]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 20 15:08:43 ffdac volumio[878]: info: CoreStateMachine::play index undefined Aug 20 15:08:43 ffdac volumio[878]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 20 15:08:43 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:43 ffdac volumio[878]: info: CoreStateMachine::startPlaybackTimer Aug 20 15:08:43 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:43 ffdac volumio[878]: info: [1724146723132] ControllerWebradio::clearAddPlayTrack Aug 20 15:08:43 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand stop Aug 20 15:08:43 ffdac volumio[878]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99540405" took 251 milliseconds Aug 20 15:08:43 ffdac volumio[878]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 20 15:08:43 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand play Aug 20 15:08:43 ffdac volumio[878]: info: Aug 20 15:08:43 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:43 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:43 ffdac volumio[878]: info: ------------------------------ 245ms Aug 20 15:08:43 ffdac volumio[878]: info: ------------------------------ 245ms Aug 20 15:08:43 ffdac volumio[878]: info: sendMpdCommand stop took 76 milliseconds Aug 20 15:08:43 ffdac volumio[878]: info: sendMpdCommand play took 1 milliseconds Aug 20 15:08:43 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand clear Aug 20 15:08:43 ffdac volumio[878]: info: Aug 20 15:08:43 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:43 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:43 ffdac volumio[878]: info: Aug 20 15:08:43 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:43 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:43 ffdac volumio[878]: info: Aug 20 15:08:43 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:43 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:43 ffdac volumio[878]: info: Aug 20 15:08:43 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:43 ffdac volumio[878]: error: updateQueue error: null Aug 20 15:08:43 ffdac volumio[878]: error: updateQueue error: null Aug 20 15:08:43 ffdac volumio[878]: info: ------------------------------ 3ms Aug 20 15:08:43 ffdac volumio[878]: info: sendMpdCommand clear took 2 milliseconds Aug 20 15:08:43 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:43 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:43 ffdac volumio[878]: info: ------------------------------ 2ms Aug 20 15:08:43 ffdac volumio[878]: info: ------------------------------ 2ms Aug 20 15:08:43 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99540405" Aug 20 15:08:43 ffdac volumio[878]: info: Aug 20 15:08:43 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:43 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:43 ffdac volumio[878]: info: Aug 20 15:08:43 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:43 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:43 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:43 ffdac volumio[878]: info: Aug 20 15:08:43 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:43 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:43 ffdac volumio[878]: info: Aug 20 15:08:43 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:43 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:43 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:43 ffdac volumio[878]: error: updateQueue error: null Aug 20 15:08:43 ffdac volumio[878]: info: ------------------------------ 4ms Aug 20 15:08:43 ffdac volumio[878]: info: sendMpdCommand status took 3 milliseconds Aug 20 15:08:43 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:43 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:43 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:43 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:43 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 15:08:43 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:43 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:43 ffdac volumio[878]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 20 15:08:43 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:43 ffdac volumio[878]: info: CoreStateMachine::syncState stateService stop Aug 20 15:08:43 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus stop Aug 20 15:08:43 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:43 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:43 ffdac volumio[878]: info: No code Aug 20 15:08:43 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:43 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:43 ffdac volumio[878]: info: ------------------------------ 11ms Aug 20 15:08:43 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:43 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:43 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:43 ffdac volumio[878]: info: Aug 20 15:08:43 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:43 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:43 ffdac volumio[878]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99540405" took 249 milliseconds Aug 20 15:08:43 ffdac volumio[878]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 20 15:08:43 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand play Aug 20 15:08:43 ffdac volumio[878]: info: ------------------------------ 249ms Aug 20 15:08:43 ffdac volumio[878]: info: sendMpdCommand status took 249 milliseconds Aug 20 15:08:43 ffdac volumio[878]: info: ------------------------------ 249ms Aug 20 15:08:43 ffdac volumio[878]: info: sendMpdCommand status took 248 milliseconds Aug 20 15:08:43 ffdac volumio[878]: info: ------------------------------ 1ms Aug 20 15:08:43 ffdac volumio[878]: info: sendMpdCommand play took 1 milliseconds Aug 20 15:08:43 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:43 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:43 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:43 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:43 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:43 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 15:08:43 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:43 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:43 ffdac volumio[878]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 20 15:08:43 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:43 ffdac volumio[878]: info: CoreStateMachine::syncState stateService stop Aug 20 15:08:43 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus stop Aug 20 15:08:43 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:43 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:43 ffdac volumio[878]: info: No code Aug 20 15:08:43 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:43 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:43 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:43 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:43 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:43 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:43 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:43 ffdac volumio[878]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 20 15:08:43 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:43 ffdac volumio[878]: info: CoreStateMachine::syncState stateService stop Aug 20 15:08:43 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus stop Aug 20 15:08:43 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:43 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:43 ffdac volumio[878]: info: No code Aug 20 15:08:43 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:43 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:43 ffdac volumio[878]: info: ------------------------------ 266ms Aug 20 15:08:43 ffdac volumio[878]: info: ------------------------------ 265ms Aug 20 15:08:43 ffdac volumio[878]: info: Aug 20 15:08:43 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:43 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:43 ffdac volumio[878]: info: Aug 20 15:08:43 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:43 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:43 ffdac volumio[878]: info: ------------------------------ 1ms Aug 20 15:08:43 ffdac volumio[878]: info: ------------------------------ 0ms Aug 20 15:08:43 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:43 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:43 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:43 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:43 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:43 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:44 ffdac volumio[878]: info: Aug 20 15:08:44 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:44 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:44 ffdac volumio[878]: info: Aug 20 15:08:44 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:44 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:44 ffdac volumio[878]: info: Aug 20 15:08:44 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:44 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:44 ffdac volumio[878]: info: Aug 20 15:08:44 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:44 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:44 ffdac volumio[878]: info: Aug 20 15:08:44 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:44 ffdac volumio[878]: info: sendMpdCommand status took 3 milliseconds Aug 20 15:08:44 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:44 ffdac volumio[878]: info: sendMpdCommand status took 2 milliseconds Aug 20 15:08:44 ffdac volumio[878]: info: sendMpdCommand status took 1 milliseconds Aug 20 15:08:44 ffdac volumio[878]: info: sendMpdCommand status took 1 milliseconds Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:44 ffdac volumio[878]: info: Aug 20 15:08:44 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:44 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:44 ffdac volumio[878]: info: sendMpdCommand status took 3 milliseconds Aug 20 15:08:44 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 20 15:08:44 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 20 15:08:44 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 20 15:08:44 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 20 15:08:44 ffdac volumio[878]: info: sendMpdCommand status took 1 milliseconds Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:44 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:44 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:44 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 21/5000) TamilComedy Radio","album":null,"uri":"http://159.203.111.241:8035/stream","trackType":""} Aug 20 15:08:44 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus stop Aug 20 15:08:44 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:44 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:44 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 21/5000) TamilComedy Radio","album":null,"uri":"http://159.203.111.241:8035/stream","trackType":""} Aug 20 15:08:44 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus play Aug 20 15:08:44 ffdac volumio[878]: info: Received an update from plugin. extracting info from payload Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:44 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:44 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:44 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:44 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 21/5000) TamilComedy Radio","album":null,"uri":"http://159.203.111.241:8035/stream","trackType":""} Aug 20 15:08:44 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus play Aug 20 15:08:44 ffdac volumio[878]: info: Received an update from plugin. extracting info from payload Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:44 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:44 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:44 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:44 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 21/5000) TamilComedy Radio","album":null,"uri":"http://159.203.111.241:8035/stream","trackType":""} Aug 20 15:08:44 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus play Aug 20 15:08:44 ffdac volumio[878]: info: Received an update from plugin. extracting info from payload Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:44 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:44 ffdac volumio[878]: info: ------------------------------ 15ms Aug 20 15:08:44 ffdac volumio[878]: info: ------------------------------ 22ms Aug 20 15:08:44 ffdac volumio[878]: info: ------------------------------ 25ms Aug 20 15:08:44 ffdac volumio[878]: info: ------------------------------ 25ms Aug 20 15:08:44 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 20 milliseconds Aug 20 15:08:44 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 21 milliseconds Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:44 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:44 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:44 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 21/5000) TamilComedy Radio","album":null,"uri":"http://159.203.111.241:8035/stream","trackType":""} Aug 20 15:08:44 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus play Aug 20 15:08:44 ffdac volumio[878]: info: Received an update from plugin. extracting info from payload Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:44 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:44 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:44 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:44 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 21/5000) TamilComedy Radio","album":null,"uri":"http://159.203.111.241:8035/stream","trackType":""} Aug 20 15:08:44 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus play Aug 20 15:08:44 ffdac volumio[878]: info: Received an update from plugin. extracting info from payload Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:44 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:44 ffdac volumio[878]: info: ------------------------------ 39ms Aug 20 15:08:44 ffdac volumio[878]: info: ------------------------------ 37ms Aug 20 15:08:44 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:44 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:44 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:44 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:44 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:44 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:44 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:44 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:44 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:44 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:44 ffdac volumio[878]: info: Aug 20 15:08:44 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:44 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:44 ffdac volumio[878]: info: Aug 20 15:08:44 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:44 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:44 ffdac volumio[878]: info: Aug 20 15:08:44 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:44 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:44 ffdac volumio[878]: info: Aug 20 15:08:44 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:44 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:44 ffdac volumio[878]: info: ------------------------------ 5ms Aug 20 15:08:44 ffdac volumio[878]: info: sendMpdCommand status took 3 milliseconds Aug 20 15:08:44 ffdac volumio[878]: info: ------------------------------ 4ms Aug 20 15:08:44 ffdac volumio[878]: info: sendMpdCommand status took 2 milliseconds Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:44 ffdac volumio[878]: info: Aug 20 15:08:44 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:44 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:44 ffdac volumio[878]: info: Aug 20 15:08:44 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:44 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:44 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 4 milliseconds Aug 20 15:08:44 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 4 milliseconds Aug 20 15:08:44 ffdac volumio[878]: info: ------------------------------ 4ms Aug 20 15:08:44 ffdac volumio[878]: info: sendMpdCommand status took 2 milliseconds Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:44 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:44 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:44 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":80,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"santhanam,swaminathan - aepa_patti_mudiyamairukae[Aranmanai]@4CC","artist":"TamilComedy Radio","album":null,"uri":"http://159.203.111.241:8035/stream","trackType":""} Aug 20 15:08:44 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus play Aug 20 15:08:44 ffdac volumio[878]: info: Received an update from plugin. extracting info from payload Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:44 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:44 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:44 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":148,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"santhanam,swaminathan - aepa_patti_mudiyamairukae[Aranmanai]@4CC","artist":"TamilComedy Radio","album":null,"uri":"http://159.203.111.241:8035/stream","trackType":""} Aug 20 15:08:44 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus play Aug 20 15:08:44 ffdac volumio[878]: info: Received an update from plugin. extracting info from payload Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:44 ffdac volumio[878]: info: ------------------------------ 27ms Aug 20 15:08:44 ffdac volumio[878]: info: ------------------------------ 26ms Aug 20 15:08:44 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 16 milliseconds Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:44 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:44 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:44 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":331,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"santhanam,swaminathan - aepa_patti_mudiyamairukae[Aranmanai]@4CC","artist":"TamilComedy Radio","album":null,"uri":"http://159.203.111.241:8035/stream","trackType":""} Aug 20 15:08:44 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus play Aug 20 15:08:44 ffdac volumio[878]: info: Received an update from plugin. extracting info from payload Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:44 ffdac volumio[878]: info: ------------------------------ 29ms Aug 20 15:08:44 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:44 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:44 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:44 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:44 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:44 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:44 ffdac volumio[878]: info: Preload queue cleared Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::ClearQueue Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::stop Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::stPlaybackTimer Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::updateTrackBlock Aug 20 15:08:44 ffdac volumio[878]: info: CorePlayQueue::getTrackBlock Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:44 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::serviceStop Aug 20 15:08:44 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::serviceStop Aug 20 15:08:44 ffdac volumio[878]: info: [1724146724959] ControllerWebradio::stop Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand stop Aug 20 15:08:44 ffdac volumio[878]: info: CorePlayQueue::clearPlayQueue Aug 20 15:08:44 ffdac volumio[878]: info: CorePlayQueue::saveQueue Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::volumioPushQueue Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::addQueueItems Aug 20 15:08:44 ffdac volumio[878]: info: CorePlayQueue::addQueueItems Aug 20 15:08:44 ffdac volumio[878]: info: Preload queue cleared Aug 20 15:08:44 ffdac volumio[878]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99539706 Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::volumioPushQueue Aug 20 15:08:44 ffdac volumio[878]: info: CorePlayQueue::saveQueue Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::updateTrackBlock Aug 20 15:08:44 ffdac volumio[878]: info: CorePlayQueue::getTrackBlock Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::volumioPlay Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::play index 0 Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::stop Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::play index undefined Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 20 15:08:44 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::startPlaybackTimer Aug 20 15:08:44 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:44 ffdac volumio[878]: info: [1724146724968] ControllerWebradio::clearAddPlayTrack Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand stop Aug 20 15:08:44 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:44 ffdac volumio[878]: info: Aug 20 15:08:44 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:44 ffdac volumio[878]: info: sendMpdCommand stop took 15 milliseconds Aug 20 15:08:44 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:44 ffdac volumio[878]: info: sendMpdCommand stop took 6 milliseconds Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand clear Aug 20 15:08:44 ffdac volumio[878]: info: Aug 20 15:08:44 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:44 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:44 ffdac volumio[878]: info: Aug 20 15:08:44 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:44 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:44 ffdac volumio[878]: info: Aug 20 15:08:44 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:44 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:44 ffdac volumio[878]: info: sendMpdCommand status took 4 milliseconds Aug 20 15:08:44 ffdac volumio[878]: info: sendMpdCommand clear took 4 milliseconds Aug 20 15:08:44 ffdac volumio[878]: info: sendMpdCommand status took 3 milliseconds Aug 20 15:08:44 ffdac volumio[878]: info: sendMpdCommand status took 2 milliseconds Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99539706" Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:44 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:44 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:44 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:44 ffdac volumio[878]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Aug 20 15:08:44 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:44 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:44 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:44 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:44 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:44 ffdac volumio[878]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Aug 20 15:08:44 ffdac volumio[878]: info: ------------------------------ 13ms Aug 20 15:08:44 ffdac volumio[878]: info: ------------------------------ 13ms Aug 20 15:08:44 ffdac volumio[878]: info: Aug 20 15:08:44 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:44 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:44 ffdac volumio[878]: info: Aug 20 15:08:44 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:44 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:44 ffdac volumio[878]: error: updateQueue error: null Aug 20 15:08:44 ffdac volumio[878]: info: ------------------------------ 14ms Aug 20 15:08:44 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 12 milliseconds Aug 20 15:08:44 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:44 ffdac volumio[878]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 20 15:08:44 ffdac volumio[878]: info: ------------------------------ 20ms Aug 20 15:08:44 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:44 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:45 ffdac volumio[878]: info: Preload queue cleared Aug 20 15:08:45 ffdac volumio[878]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 20 15:08:45 ffdac volumio[878]: info: CoreStateMachine::ClearQueue Aug 20 15:08:45 ffdac volumio[878]: info: CoreStateMachine::stop Aug 20 15:08:45 ffdac volumio[878]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 20 15:08:45 ffdac volumio[878]: info: CorePlayQueue::clearPlayQueue Aug 20 15:08:45 ffdac volumio[878]: info: CorePlayQueue::saveQueue Aug 20 15:08:45 ffdac volumio[878]: info: CoreCommandRouter::volumioPushQueue Aug 20 15:08:45 ffdac volumio[878]: info: CoreStateMachine::addQueueItems Aug 20 15:08:45 ffdac volumio[878]: info: CorePlayQueue::addQueueItems Aug 20 15:08:45 ffdac volumio[878]: info: Preload queue cleared Aug 20 15:08:45 ffdac volumio[878]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99539706 Aug 20 15:08:45 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 20 15:08:45 ffdac volumio[878]: info: CoreCommandRouter::volumioPushQueue Aug 20 15:08:45 ffdac volumio[878]: info: CorePlayQueue::saveQueue Aug 20 15:08:45 ffdac volumio[878]: info: CoreStateMachine::updateTrackBlock Aug 20 15:08:45 ffdac volumio[878]: info: CorePlayQueue::getTrackBlock Aug 20 15:08:45 ffdac volumio[878]: info: CoreCommandRouter::volumioPlay Aug 20 15:08:45 ffdac volumio[878]: info: CoreStateMachine::play index 0 Aug 20 15:08:45 ffdac volumio[878]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 20 15:08:45 ffdac volumio[878]: info: CoreStateMachine::stop Aug 20 15:08:45 ffdac volumio[878]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 20 15:08:45 ffdac volumio[878]: info: CoreStateMachine::play index undefined Aug 20 15:08:45 ffdac volumio[878]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 20 15:08:45 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:45 ffdac volumio[878]: info: CoreStateMachine::startPlaybackTimer Aug 20 15:08:45 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:45 ffdac volumio[878]: info: [1724146725143] ControllerWebradio::clearAddPlayTrack Aug 20 15:08:45 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand stop Aug 20 15:08:45 ffdac volumio[878]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99539706" took 251 milliseconds Aug 20 15:08:45 ffdac volumio[878]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 20 15:08:45 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand play Aug 20 15:08:45 ffdac volumio[878]: info: Aug 20 15:08:45 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:45 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:45 ffdac volumio[878]: info: ------------------------------ 243ms Aug 20 15:08:45 ffdac volumio[878]: info: ------------------------------ 242ms Aug 20 15:08:45 ffdac volumio[878]: info: sendMpdCommand stop took 92 milliseconds Aug 20 15:08:45 ffdac volumio[878]: info: sendMpdCommand play took 2 milliseconds Aug 20 15:08:45 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand clear Aug 20 15:08:45 ffdac volumio[878]: info: Aug 20 15:08:45 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:45 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:45 ffdac volumio[878]: info: Aug 20 15:08:45 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:45 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:45 ffdac volumio[878]: info: Aug 20 15:08:45 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:45 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:45 ffdac volumio[878]: info: Aug 20 15:08:45 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:45 ffdac volumio[878]: error: updateQueue error: null Aug 20 15:08:45 ffdac volumio[878]: error: updateQueue error: null Aug 20 15:08:45 ffdac volumio[878]: info: ------------------------------ 6ms Aug 20 15:08:45 ffdac volumio[878]: info: sendMpdCommand clear took 4 milliseconds Aug 20 15:08:45 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:45 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:45 ffdac volumio[878]: info: ------------------------------ 4ms Aug 20 15:08:45 ffdac volumio[878]: info: ------------------------------ 3ms Aug 20 15:08:45 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99539706" Aug 20 15:08:45 ffdac volumio[878]: info: Aug 20 15:08:45 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:45 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:45 ffdac volumio[878]: info: Aug 20 15:08:45 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:45 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:45 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:45 ffdac volumio[878]: info: Aug 20 15:08:45 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:45 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:45 ffdac volumio[878]: info: Aug 20 15:08:45 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:45 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:45 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:45 ffdac volumio[878]: error: updateQueue error: null Aug 20 15:08:45 ffdac volumio[878]: info: ------------------------------ 7ms Aug 20 15:08:45 ffdac volumio[878]: info: sendMpdCommand status took 5 milliseconds Aug 20 15:08:45 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:45 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:45 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:45 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:45 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 15:08:45 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:45 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:45 ffdac volumio[878]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 20 15:08:45 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:45 ffdac volumio[878]: info: CoreStateMachine::syncState stateService stop Aug 20 15:08:45 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus stop Aug 20 15:08:45 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:45 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:45 ffdac volumio[878]: info: No code Aug 20 15:08:45 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:45 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:45 ffdac volumio[878]: info: ------------------------------ 17ms Aug 20 15:08:45 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:45 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:45 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:45 ffdac volumio[878]: info: Aug 20 15:08:45 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:45 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:45 ffdac volumio[878]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99539706" took 249 milliseconds Aug 20 15:08:45 ffdac volumio[878]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 20 15:08:45 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand play Aug 20 15:08:45 ffdac volumio[878]: info: ------------------------------ 250ms Aug 20 15:08:45 ffdac volumio[878]: info: sendMpdCommand status took 249 milliseconds Aug 20 15:08:45 ffdac volumio[878]: info: ------------------------------ 248ms Aug 20 15:08:45 ffdac volumio[878]: info: sendMpdCommand status took 248 milliseconds Aug 20 15:08:45 ffdac volumio[878]: info: ------------------------------ 4ms Aug 20 15:08:45 ffdac volumio[878]: info: sendMpdCommand play took 2 milliseconds Aug 20 15:08:45 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:45 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:45 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:45 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:45 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:45 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 15:08:45 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:45 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:45 ffdac volumio[878]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 20 15:08:45 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:45 ffdac volumio[878]: info: CoreStateMachine::syncState stateService stop Aug 20 15:08:45 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus stop Aug 20 15:08:45 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:45 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:45 ffdac volumio[878]: info: No code Aug 20 15:08:45 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:45 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:45 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:45 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:45 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:45 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:45 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:45 ffdac volumio[878]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 20 15:08:45 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:45 ffdac volumio[878]: info: CoreStateMachine::syncState stateService stop Aug 20 15:08:45 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus stop Aug 20 15:08:45 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:45 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:45 ffdac volumio[878]: info: No code Aug 20 15:08:45 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:45 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:45 ffdac volumio[878]: info: ------------------------------ 274ms Aug 20 15:08:45 ffdac volumio[878]: info: ------------------------------ 274ms Aug 20 15:08:45 ffdac volumio[878]: info: Aug 20 15:08:45 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:45 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:45 ffdac volumio[878]: info: Aug 20 15:08:45 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:45 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:45 ffdac volumio[878]: info: ------------------------------ 3ms Aug 20 15:08:45 ffdac volumio[878]: info: ------------------------------ 2ms Aug 20 15:08:45 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:45 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:45 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:45 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:45 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:45 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:46 ffdac volumio[878]: info: Aug 20 15:08:46 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:46 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:46 ffdac volumio[878]: info: Aug 20 15:08:46 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:46 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:46 ffdac volumio[878]: info: Aug 20 15:08:46 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:46 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:46 ffdac volumio[878]: info: Aug 20 15:08:46 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:46 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:46 ffdac volumio[878]: info: sendMpdCommand status took 4 milliseconds Aug 20 15:08:46 ffdac volumio[878]: info: sendMpdCommand status took 3 milliseconds Aug 20 15:08:46 ffdac volumio[878]: info: sendMpdCommand status took 2 milliseconds Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:46 ffdac volumio[878]: info: Aug 20 15:08:46 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:46 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:46 ffdac volumio[878]: info: Aug 20 15:08:46 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:46 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:46 ffdac volumio[878]: info: sendMpdCommand status took 7 milliseconds Aug 20 15:08:46 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 6 milliseconds Aug 20 15:08:46 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 6 milliseconds Aug 20 15:08:46 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 6 milliseconds Aug 20 15:08:46 ffdac volumio[878]: info: sendMpdCommand status took 3 milliseconds Aug 20 15:08:46 ffdac volumio[878]: info: sendMpdCommand status took 2 milliseconds Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:46 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:46 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:46 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 22/5000) MaduraMalli FM","album":null,"uri":"http://159.203.111.241:8030/stream","trackType":""} Aug 20 15:08:46 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus stop Aug 20 15:08:46 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:46 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:46 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 22/5000) MaduraMalli FM","album":null,"uri":"http://159.203.111.241:8030/stream","trackType":""} Aug 20 15:08:46 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus play Aug 20 15:08:46 ffdac volumio[878]: info: Received an update from plugin. extracting info from payload Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:46 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:46 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:46 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 22/5000) MaduraMalli FM","album":null,"uri":"http://159.203.111.241:8030/stream","trackType":""} Aug 20 15:08:46 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus play Aug 20 15:08:46 ffdac volumio[878]: info: Received an update from plugin. extracting info from payload Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:46 ffdac volumio[878]: info: ------------------------------ 27ms Aug 20 15:08:46 ffdac volumio[878]: info: ------------------------------ 29ms Aug 20 15:08:46 ffdac volumio[878]: info: ------------------------------ 29ms Aug 20 15:08:46 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 18 milliseconds Aug 20 15:08:46 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 18 milliseconds Aug 20 15:08:46 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 18 milliseconds Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:46 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:46 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:46 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 22/5000) MaduraMalli FM","album":null,"uri":"http://159.203.111.241:8030/stream","trackType":""} Aug 20 15:08:46 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus play Aug 20 15:08:46 ffdac volumio[878]: info: Received an update from plugin. extracting info from payload Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:46 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:46 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:46 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 22/5000) MaduraMalli FM","album":null,"uri":"http://159.203.111.241:8030/stream","trackType":""} Aug 20 15:08:46 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus play Aug 20 15:08:46 ffdac volumio[878]: info: Received an update from plugin. extracting info from payload Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:46 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:46 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:46 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 22/5000) MaduraMalli FM","album":null,"uri":"http://159.203.111.241:8030/stream","trackType":""} Aug 20 15:08:46 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus play Aug 20 15:08:46 ffdac volumio[878]: info: Received an update from plugin. extracting info from payload Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:46 ffdac volumio[878]: info: ------------------------------ 51ms Aug 20 15:08:46 ffdac volumio[878]: info: ------------------------------ 49ms Aug 20 15:08:46 ffdac volumio[878]: info: ------------------------------ 46ms Aug 20 15:08:46 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:46 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:46 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:46 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:46 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:46 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:46 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:46 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:46 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:46 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:46 ffdac volumio[878]: info: Aug 20 15:08:46 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:46 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:46 ffdac volumio[878]: info: Aug 20 15:08:46 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:46 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:46 ffdac volumio[878]: info: Aug 20 15:08:46 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:46 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:46 ffdac volumio[878]: info: Aug 20 15:08:46 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:46 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:46 ffdac volumio[878]: info: Aug 20 15:08:46 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:46 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:46 ffdac volumio[878]: info: Aug 20 15:08:46 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:46 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:46 ffdac volumio[878]: info: ------------------------------ 7ms Aug 20 15:08:46 ffdac volumio[878]: info: sendMpdCommand status took 6 milliseconds Aug 20 15:08:46 ffdac volumio[878]: info: ------------------------------ 6ms Aug 20 15:08:46 ffdac volumio[878]: info: sendMpdCommand status took 5 milliseconds Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:46 ffdac volumio[878]: info: Aug 20 15:08:46 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:46 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:46 ffdac volumio[878]: info: Aug 20 15:08:46 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:46 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:46 ffdac volumio[878]: info: Aug 20 15:08:46 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:46 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:46 ffdac volumio[878]: info: Aug 20 15:08:46 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:46 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:46 ffdac volumio[878]: info: ------------------------------ 11ms Aug 20 15:08:46 ffdac volumio[878]: info: sendMpdCommand status took 9 milliseconds Aug 20 15:08:46 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 6 milliseconds Aug 20 15:08:46 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 7 milliseconds Aug 20 15:08:46 ffdac volumio[878]: info: ------------------------------ 6ms Aug 20 15:08:46 ffdac volumio[878]: info: sendMpdCommand status took 4 milliseconds Aug 20 15:08:46 ffdac volumio[878]: info: ------------------------------ 4ms Aug 20 15:08:46 ffdac volumio[878]: info: sendMpdCommand status took 2 milliseconds Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:46 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:46 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:46 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":80,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Vijay Yesudas, Saindhavi, Saranya Ponvannan - Meesa Kokkuthan[Ennamo Nadakkudhu]@5DK","artist":"MaduraMalli FM","album":null,"uri":"http://159.203.111.241:8030/stream","trackType":""} Aug 20 15:08:46 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus play Aug 20 15:08:46 ffdac volumio[878]: info: Received an update from plugin. extracting info from payload Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:46 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:46 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:46 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":148,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Vijay Yesudas, Saindhavi, Saranya Ponvannan - Meesa Kokkuthan[Ennamo Nadakkudhu]@5DK","artist":"MaduraMalli FM","album":null,"uri":"http://159.203.111.241:8030/stream","trackType":""} Aug 20 15:08:46 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus play Aug 20 15:08:46 ffdac volumio[878]: info: Received an update from plugin. extracting info from payload Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:46 ffdac volumio[878]: info: ------------------------------ 32ms Aug 20 15:08:46 ffdac volumio[878]: info: ------------------------------ 31ms Aug 20 15:08:46 ffdac volumio[878]: info: Aug 20 15:08:46 ffdac volumio[878]: ---------------------------- MPD announces system playlist update Aug 20 15:08:46 ffdac volumio[878]: info: Ignoring MPD Status Update Aug 20 15:08:46 ffdac volumio[878]: info: Aug 20 15:08:46 ffdac volumio[878]: ---------------------------- MPD announces state update: player Aug 20 15:08:46 ffdac volumio[878]: info: ControllerMpd::getState Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand status Aug 20 15:08:46 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 18 milliseconds Aug 20 15:08:46 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 18 milliseconds Aug 20 15:08:46 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 18 milliseconds Aug 20 15:08:46 ffdac volumio[878]: info: ------------------------------ 3ms Aug 20 15:08:46 ffdac volumio[878]: info: sendMpdCommand status took 3 milliseconds Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::parseState Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 20 15:08:46 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:46 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:46 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":320,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Vijay Yesudas, Saindhavi, Saranya Ponvannan - Meesa Kokkuthan[Ennamo Nadakkudhu]@5DK","artist":"MaduraMalli FM","album":null,"uri":"http://159.203.111.241:8030/stream","trackType":""} Aug 20 15:08:46 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus play Aug 20 15:08:46 ffdac volumio[878]: info: Received an update from plugin. extracting info from payload Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:46 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:46 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:46 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":354,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Vijay Yesudas, Saindhavi, Saranya Ponvannan - Meesa Kokkuthan[Ennamo Nadakkudhu]@5DK","artist":"MaduraMalli FM","album":null,"uri":"http://159.203.111.241:8030/stream","trackType":""} Aug 20 15:08:46 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus play Aug 20 15:08:46 ffdac volumio[878]: info: Received an update from plugin. extracting info from payload Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:46 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:46 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:46 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":354,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Vijay Yesudas, Saindhavi, Saranya Ponvannan - Meesa Kokkuthan[Ennamo Nadakkudhu]@5DK","artist":"MaduraMalli FM","album":null,"uri":"http://159.203.111.241:8030/stream","trackType":""} Aug 20 15:08:46 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus play Aug 20 15:08:46 ffdac volumio[878]: info: Received an update from plugin. extracting info from payload Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:46 ffdac volumio[878]: info: ------------------------------ 54ms Aug 20 15:08:46 ffdac volumio[878]: info: ------------------------------ 49ms Aug 20 15:08:46 ffdac volumio[878]: info: ------------------------------ 48ms Aug 20 15:08:46 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:46 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:46 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:46 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:46 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:46 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:46 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:46 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:46 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:46 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:46 ffdac volumio[878]: info: sendMpdCommand playlistinfo took 38 milliseconds Aug 20 15:08:46 ffdac volumio[878]: verbose: ControllerMpd::parseTrackInfo Aug 20 15:08:46 ffdac volumio[878]: info: ControllerMpd::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::servicePushState Aug 20 15:08:46 ffdac volumio[878]: info: CorePlayQueue::getTrack 0 Aug 20 15:08:46 ffdac volumio[878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":354,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Vijay Yesudas, Saindhavi, Saranya Ponvannan - Meesa Kokkuthan[Ennamo Nadakkudhu]@5DK","artist":"MaduraMalli FM","album":null,"uri":"http://159.203.111.241:8030/stream","trackType":""} Aug 20 15:08:46 ffdac volumio[878]: verbose: CURRENT POSITION 0 Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::syncState stateService play Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::syncState currentStatus play Aug 20 15:08:46 ffdac volumio[878]: info: Received an update from plugin. extracting info from payload Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreStateMachine::pushState Aug 20 15:08:46 ffdac volumio[878]: info: CoreCommandRouter::volumioPushState Aug 20 15:08:46 ffdac volumio[878]: info: ------------------------------ 55ms Aug 20 15:08:46 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:46 ffdac volumio[878]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Aug 20 15:08:50 ffdac volumio[878]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 20 15:08:50 ffdac volumio[878]: Error: getaddrinfo ENOTFOUND lastfm.freetls.fastly.net Aug 20 15:08:50 ffdac volumio[878]: at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:67:26) { Aug 20 15:08:50 ffdac volumio[878]: errno: -3007, Aug 20 15:08:50 ffdac volumio[878]: code: 'ENOTFOUND', Aug 20 15:08:50 ffdac volumio[878]: syscall: 'getaddrinfo', Aug 20 15:08:50 ffdac volumio[878]: hostname: 'lastfm.freetls.fastly.net' Aug 20 15:08:50 ffdac volumio[878]: } Aug 20 15:08:50 ffdac volumio[878]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 20 15:08:50 ffdac sudo[6716]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-20 15:07 Aug 20 15:08:50 ffdac sudo[6716]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"