-- Logs begin at Fri 2024-07-19 14:18:15 MSK, end at Fri 2024-07-19 14:59:33 MSK. -- Jul 19 14:58:34 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 19 14:58:34 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 19 14:58:34 volumio volumio[1245]: info: Discovery: Getting this device information Jul 19 14:58:34 volumio volumio[1245]: info: CoreCommandRouter::volumioGetState Jul 19 14:58:34 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 19 14:58:44 volumio volumio[1245]: info: Preload queue cleared Jul 19 14:58:44 volumio volumio[1245]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 19 14:58:44 volumio volumio[1245]: info: CoreStateMachine::ClearQueue Jul 19 14:58:44 volumio volumio[1245]: info: CoreStateMachine::stop Jul 19 14:58:44 volumio volumio[1245]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 19 14:58:44 volumio volumio[1245]: info: CoreStateMachine::stPlaybackTimer Jul 19 14:58:44 volumio volumio[1245]: info: CoreStateMachine::updateTrackBlock Jul 19 14:58:44 volumio volumio[1245]: info: CorePlayQueue::getTrackBlock Jul 19 14:58:44 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:44 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:44 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 19 14:58:44 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:44 volumio volumio[1245]: info: CoreStateMachine::serviceStop Jul 19 14:58:44 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:44 volumio volumio[1245]: info: CoreCommandRouter::serviceStop Jul 19 14:58:44 volumio volumio[1245]: info: [1721390324540] ControllerWebradio::stop Jul 19 14:58:44 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand stop Jul 19 14:58:44 volumio volumio[1245]: info: CorePlayQueue::clearPlayQueue Jul 19 14:58:44 volumio volumio[1245]: info: CorePlayQueue::saveQueue Jul 19 14:58:44 volumio volumio[1245]: info: CoreCommandRouter::volumioPushQueue Jul 19 14:58:44 volumio volumio[1245]: info: CoreStateMachine::addQueueItems Jul 19 14:58:44 volumio volumio[1245]: info: CorePlayQueue::addQueueItems Jul 19 14:58:44 volumio volumio[1245]: info: Preload queue cleared Jul 19 14:58:44 volumio volumio[1245]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99572208 Jul 19 14:58:44 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jul 19 14:58:44 volumio volumio[1245]: info: CoreCommandRouter::volumioPushQueue Jul 19 14:58:44 volumio volumio[1245]: info: CorePlayQueue::saveQueue Jul 19 14:58:44 volumio volumio[1245]: info: CoreStateMachine::updateTrackBlock Jul 19 14:58:44 volumio volumio[1245]: info: CorePlayQueue::getTrackBlock Jul 19 14:58:44 volumio volumio[1245]: info: CoreCommandRouter::volumioPlay Jul 19 14:58:44 volumio volumio[1245]: info: CoreStateMachine::play index 0 Jul 19 14:58:44 volumio volumio[1245]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 19 14:58:44 volumio volumio[1245]: info: CoreStateMachine::stop Jul 19 14:58:44 volumio volumio[1245]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 19 14:58:44 volumio volumio[1245]: info: CoreStateMachine::play index undefined Jul 19 14:58:44 volumio volumio[1245]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 19 14:58:44 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:44 volumio volumio[1245]: info: CoreStateMachine::startPlaybackTimer Jul 19 14:58:44 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:44 volumio volumio[1245]: info: [1721390324550] ControllerWebradio::clearAddPlayTrack Jul 19 14:58:44 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand stop Jul 19 14:58:44 volumio volumio[1245]: info: Jul 19 14:58:44 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:58:44 volumio volumio[1245]: info: sendMpdCommand stop took 30 milliseconds Jul 19 14:58:44 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:58:44 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:58:44 volumio volumio[1245]: info: sendMpdCommand stop took 21 milliseconds Jul 19 14:58:44 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand clear Jul 19 14:58:44 volumio volumio[1245]: info: Jul 19 14:58:44 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:58:44 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:58:44 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:58:44 volumio volumio[1245]: info: Jul 19 14:58:44 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:58:44 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:58:44 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:58:44 volumio volumio[1245]: info: Jul 19 14:58:44 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:58:44 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:58:44 volumio volumio[1245]: info: sendMpdCommand status took 5 milliseconds Jul 19 14:58:44 volumio volumio[1245]: info: sendMpdCommand clear took 4 milliseconds Jul 19 14:58:44 volumio volumio[1245]: info: sendMpdCommand status took 3 milliseconds Jul 19 14:58:44 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:58:44 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:58:44 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99572208" Jul 19 14:58:44 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:58:44 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:58:44 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:58:44 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:44 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:44 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 19 14:58:44 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:44 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:44 volumio volumio[1245]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 19 14:58:44 volumio volumio[1245]: info: ------------------------------ 13ms Jul 19 14:58:44 volumio volumio[1245]: info: Jul 19 14:58:44 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:58:44 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:58:44 volumio volumio[1245]: info: Jul 19 14:58:44 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:58:44 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:58:44 volumio volumio[1245]: error: updateQueue error: null Jul 19 14:58:44 volumio volumio[1245]: info: sendMpdCommand status took 15 milliseconds Jul 19 14:58:44 volumio volumio[1245]: info: ------------------------------ 14ms Jul 19 14:58:44 volumio volumio[1245]: info: sendMpdCommand playlistinfo took 13 milliseconds Jul 19 14:58:44 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:58:44 volumio volumio[1245]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:58:44 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:58:44 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:58:44 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:44 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:44 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:44 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:44 volumio volumio[1245]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 19 14:58:44 volumio volumio[1245]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 19 14:58:44 volumio volumio[1245]: info: ------------------------------ 23ms Jul 19 14:58:44 volumio volumio[1245]: info: ------------------------------ 27ms Jul 19 14:58:45 volumio volumio[1245]: info: Jul 19 14:58:45 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:58:45 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:58:45 volumio volumio[1245]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99572208" took 1373 milliseconds Jul 19 14:58:45 volumio volumio[1245]: info: ------------------------------ 1364ms Jul 19 14:58:45 volumio volumio[1245]: info: ------------------------------ 1363ms Jul 19 14:58:45 volumio volumio[1245]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 19 14:58:45 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand play Jul 19 14:58:45 volumio volumio[1245]: info: Jul 19 14:58:45 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:58:45 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:58:45 volumio volumio[1245]: info: Jul 19 14:58:45 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:58:45 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:58:45 volumio volumio[1245]: info: ------------------------------ 12ms Jul 19 14:58:45 volumio volumio[1245]: info: sendMpdCommand play took 8 milliseconds Jul 19 14:58:45 volumio volumio[1245]: info: ------------------------------ 7ms Jul 19 14:58:45 volumio volumio[1245]: info: ------------------------------ 6ms Jul 19 14:58:46 volumio volumio[1245]: info: Jul 19 14:58:46 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:58:46 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:58:46 volumio volumio[1245]: info: Jul 19 14:58:46 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:58:46 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:58:46 volumio volumio[1245]: info: Jul 19 14:58:46 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:58:46 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:58:46 volumio volumio[1245]: info: sendMpdCommand status took 18 milliseconds Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:58:46 volumio volumio[1245]: info: Jul 19 14:58:46 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:58:46 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:58:46 volumio volumio[1245]: info: sendMpdCommand status took 19 milliseconds Jul 19 14:58:46 volumio volumio[1245]: info: sendMpdCommand status took 18 milliseconds Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:58:46 volumio volumio[1245]: info: Jul 19 14:58:46 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:58:46 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:58:46 volumio volumio[1245]: info: Jul 19 14:58:46 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:58:46 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:58:46 volumio volumio[1245]: info: sendMpdCommand playlistinfo took 9 milliseconds Jul 19 14:58:46 volumio volumio[1245]: info: sendMpdCommand status took 9 milliseconds Jul 19 14:58:46 volumio volumio[1245]: info: sendMpdCommand playlistinfo took 9 milliseconds Jul 19 14:58:46 volumio volumio[1245]: info: sendMpdCommand playlistinfo took 10 milliseconds Jul 19 14:58:46 volumio volumio[1245]: info: sendMpdCommand status took 8 milliseconds Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:58:46 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:58:46 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:46 volumio volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 21/9999) DISCO STUDIO 54","album":null,"uri":"http://142.44.212.114:8307/stream","trackType":""} Jul 19 14:58:46 volumio volumio[1245]: verbose: CURRENT POSITION 0 Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::syncState stateService play Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::syncState currentStatus stop Jul 19 14:58:46 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:58:46 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:46 volumio volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 21/9999) DISCO STUDIO 54","album":null,"uri":"http://142.44.212.114:8307/stream","trackType":""} Jul 19 14:58:46 volumio volumio[1245]: verbose: CURRENT POSITION 0 Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::syncState stateService play Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::syncState currentStatus play Jul 19 14:58:46 volumio volumio[1245]: info: Received an update from plugin. extracting info from payload Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:46 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:46 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:58:46 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:46 volumio volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 21/9999) DISCO STUDIO 54","album":null,"uri":"http://142.44.212.114:8307/stream","trackType":""} Jul 19 14:58:46 volumio volumio[1245]: verbose: CURRENT POSITION 0 Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::syncState stateService play Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::syncState currentStatus play Jul 19 14:58:46 volumio volumio[1245]: info: Received an update from plugin. extracting info from payload Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:46 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:46 volumio volumio[1245]: info: ------------------------------ 70ms Jul 19 14:58:46 volumio volumio[1245]: info: ------------------------------ 79ms Jul 19 14:58:46 volumio volumio[1245]: info: ------------------------------ 79ms Jul 19 14:58:46 volumio volumio[1245]: info: sendMpdCommand status took 55 milliseconds Jul 19 14:58:46 volumio volumio[1245]: info: sendMpdCommand playlistinfo took 49 milliseconds Jul 19 14:58:46 volumio volumio[1245]: info: sendMpdCommand playlistinfo took 35 milliseconds Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:58:46 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:58:46 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:46 volumio volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 21/9999) DISCO STUDIO 54","album":null,"uri":"http://142.44.212.114:8307/stream","trackType":""} Jul 19 14:58:46 volumio volumio[1245]: verbose: CURRENT POSITION 0 Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::syncState stateService play Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::syncState currentStatus play Jul 19 14:58:46 volumio volumio[1245]: info: Received an update from plugin. extracting info from payload Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:46 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:46 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:58:46 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:46 volumio volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 21/9999) DISCO STUDIO 54","album":null,"uri":"http://142.44.212.114:8307/stream","trackType":""} Jul 19 14:58:46 volumio volumio[1245]: verbose: CURRENT POSITION 0 Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::syncState stateService play Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::syncState currentStatus play Jul 19 14:58:46 volumio volumio[1245]: info: Received an update from plugin. extracting info from payload Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:46 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:46 volumio volumio[1245]: info: ------------------------------ 96ms Jul 19 14:58:46 volumio volumio[1245]: info: ------------------------------ 94ms Jul 19 14:58:46 volumio volumio[1245]: info: sendMpdCommand playlistinfo took 42 milliseconds Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:58:46 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:58:46 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:46 volumio volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 21/9999) DISCO STUDIO 54","album":null,"uri":"http://142.44.212.114:8307/stream","trackType":""} Jul 19 14:58:46 volumio volumio[1245]: verbose: CURRENT POSITION 0 Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::syncState stateService play Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::syncState currentStatus play Jul 19 14:58:46 volumio volumio[1245]: info: Received an update from plugin. extracting info from payload Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:46 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:46 volumio volumio[1245]: info: ------------------------------ 112ms Jul 19 14:58:46 volumio volumio[1245]: info: Jul 19 14:58:46 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:58:46 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:58:46 volumio volumio[1245]: info: Jul 19 14:58:46 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:58:46 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:58:46 volumio volumio[1245]: info: Jul 19 14:58:46 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:58:46 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:58:46 volumio volumio[1245]: info: Jul 19 14:58:46 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:58:46 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:58:46 volumio volumio[1245]: info: Jul 19 14:58:46 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:58:46 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:58:46 volumio volumio[1245]: info: Jul 19 14:58:46 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:58:46 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:58:46 volumio volumio[1245]: info: ------------------------------ 8ms Jul 19 14:58:46 volumio volumio[1245]: info: sendMpdCommand status took 6 milliseconds Jul 19 14:58:46 volumio volumio[1245]: info: ------------------------------ 6ms Jul 19 14:58:46 volumio volumio[1245]: info: sendMpdCommand status took 4 milliseconds Jul 19 14:58:46 volumio volumio[1245]: info: ------------------------------ 4ms Jul 19 14:58:46 volumio volumio[1245]: info: sendMpdCommand status took 4 milliseconds Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:58:46 volumio volumio[1245]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 19 14:58:46 volumio volumio[1245]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:58:46 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:58:46 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:46 volumio volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":980,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Cerrone - Orange 5th BCO","artist":"DISCO STUDIO 54","album":null,"uri":"http://142.44.212.114:8307/stream","trackType":""} Jul 19 14:58:46 volumio volumio[1245]: verbose: CURRENT POSITION 0 Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::syncState stateService play Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::syncState currentStatus play Jul 19 14:58:46 volumio volumio[1245]: info: Received an update from plugin. extracting info from payload Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:46 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:58:46 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:46 volumio volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":980,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Cerrone - Orange 5th BCO","artist":"DISCO STUDIO 54","album":null,"uri":"http://142.44.212.114:8307/stream","trackType":""} Jul 19 14:58:46 volumio volumio[1245]: verbose: CURRENT POSITION 0 Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::syncState stateService play Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::syncState currentStatus play Jul 19 14:58:46 volumio volumio[1245]: info: Received an update from plugin. extracting info from payload Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:46 volumio volumio[1245]: info: ------------------------------ 50ms Jul 19 14:58:46 volumio volumio[1245]: info: ------------------------------ 49ms Jul 19 14:58:46 volumio volumio[1245]: info: sendMpdCommand playlistinfo took 44 milliseconds Jul 19 14:58:46 volumio volumio[1245]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:58:46 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:58:46 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:46 volumio volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":980,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Cerrone - Orange 5th BCO","artist":"DISCO STUDIO 54","album":null,"uri":"http://142.44.212.114:8307/stream","trackType":""} Jul 19 14:58:46 volumio volumio[1245]: verbose: CURRENT POSITION 0 Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::syncState stateService play Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::syncState currentStatus play Jul 19 14:58:46 volumio volumio[1245]: info: Received an update from plugin. extracting info from payload Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:46 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:46 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:47 volumio volumio[1245]: info: ------------------------------ 65ms Jul 19 14:58:54 volumio volumio[1245]: info: Preload queue cleared Jul 19 14:58:54 volumio volumio[1245]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 19 14:58:54 volumio volumio[1245]: info: CoreStateMachine::ClearQueue Jul 19 14:58:54 volumio volumio[1245]: info: CoreStateMachine::stop Jul 19 14:58:54 volumio volumio[1245]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 19 14:58:54 volumio volumio[1245]: info: CoreStateMachine::stPlaybackTimer Jul 19 14:58:54 volumio volumio[1245]: info: CoreStateMachine::updateTrackBlock Jul 19 14:58:54 volumio volumio[1245]: info: CorePlayQueue::getTrackBlock Jul 19 14:58:54 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:54 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:54 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 19 14:58:54 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:54 volumio volumio[1245]: info: CoreStateMachine::serviceStop Jul 19 14:58:54 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:54 volumio volumio[1245]: info: CoreCommandRouter::serviceStop Jul 19 14:58:54 volumio volumio[1245]: info: [1721390334699] ControllerWebradio::stop Jul 19 14:58:54 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand stop Jul 19 14:58:54 volumio volumio[1245]: info: CorePlayQueue::clearPlayQueue Jul 19 14:58:54 volumio volumio[1245]: info: CorePlayQueue::saveQueue Jul 19 14:58:54 volumio volumio[1245]: info: CoreCommandRouter::volumioPushQueue Jul 19 14:58:54 volumio volumio[1245]: info: CoreStateMachine::addQueueItems Jul 19 14:58:54 volumio volumio[1245]: info: CorePlayQueue::addQueueItems Jul 19 14:58:54 volumio volumio[1245]: info: Preload queue cleared Jul 19 14:58:54 volumio volumio[1245]: info: Adding Item to queue: http://142.44.212.114:8307/stream Jul 19 14:58:54 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jul 19 14:58:54 volumio volumio[1245]: info: CoreCommandRouter::volumioPushQueue Jul 19 14:58:54 volumio volumio[1245]: info: CorePlayQueue::saveQueue Jul 19 14:58:54 volumio volumio[1245]: info: CoreStateMachine::updateTrackBlock Jul 19 14:58:54 volumio volumio[1245]: info: CorePlayQueue::getTrackBlock Jul 19 14:58:54 volumio volumio[1245]: info: CoreCommandRouter::volumioPlay Jul 19 14:58:54 volumio volumio[1245]: info: CoreStateMachine::play index 0 Jul 19 14:58:54 volumio volumio[1245]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 19 14:58:54 volumio volumio[1245]: info: CoreStateMachine::stop Jul 19 14:58:54 volumio volumio[1245]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 19 14:58:54 volumio volumio[1245]: info: CoreStateMachine::play index undefined Jul 19 14:58:54 volumio volumio[1245]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 19 14:58:54 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:54 volumio volumio[1245]: info: CoreStateMachine::startPlaybackTimer Jul 19 14:58:54 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:54 volumio volumio[1245]: info: [1721390334709] ControllerWebradio::clearAddPlayTrack Jul 19 14:58:54 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand stop Jul 19 14:58:54 volumio volumio[1245]: info: Jul 19 14:58:54 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:58:54 volumio volumio[1245]: info: sendMpdCommand stop took 14 milliseconds Jul 19 14:58:54 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:58:54 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:58:54 volumio volumio[1245]: info: sendMpdCommand stop took 4 milliseconds Jul 19 14:58:54 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand clear Jul 19 14:58:54 volumio volumio[1245]: info: Jul 19 14:58:54 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:58:54 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:58:54 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:58:54 volumio volumio[1245]: info: Jul 19 14:58:54 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:58:54 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:58:54 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:58:54 volumio volumio[1245]: info: Jul 19 14:58:54 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:58:54 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:58:54 volumio volumio[1245]: info: sendMpdCommand status took 4 milliseconds Jul 19 14:58:54 volumio volumio[1245]: info: sendMpdCommand clear took 4 milliseconds Jul 19 14:58:54 volumio volumio[1245]: info: sendMpdCommand status took 3 milliseconds Jul 19 14:58:54 volumio volumio[1245]: info: sendMpdCommand status took 2 milliseconds Jul 19 14:58:54 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:58:54 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:58:54 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand load "http://142.44.212.114:8307/stream" Jul 19 14:58:54 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:58:54 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:58:54 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:58:54 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:58:54 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:54 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:54 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 19 14:58:54 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:54 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:54 volumio volumio[1245]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 19 14:58:54 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:58:54 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:58:54 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:54 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:54 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:54 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:54 volumio volumio[1245]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 19 14:58:54 volumio volumio[1245]: info: ------------------------------ 14ms Jul 19 14:58:54 volumio volumio[1245]: info: ------------------------------ 13ms Jul 19 14:58:54 volumio volumio[1245]: info: Jul 19 14:58:54 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:58:54 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:58:54 volumio volumio[1245]: info: Jul 19 14:58:54 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:58:54 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:58:54 volumio volumio[1245]: error: updateQueue error: null Jul 19 14:58:54 volumio volumio[1245]: info: ------------------------------ 15ms Jul 19 14:58:54 volumio volumio[1245]: info: sendMpdCommand playlistinfo took 13 milliseconds Jul 19 14:58:54 volumio volumio[1245]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:58:54 volumio volumio[1245]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 19 14:58:54 volumio volumio[1245]: info: ------------------------------ 23ms Jul 19 14:58:55 volumio volumio[1245]: error: updateQueue error: null Jul 19 14:58:55 volumio volumio[1245]: error: updateQueue error: null Jul 19 14:58:55 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand add "http://142.44.212.114:8307/stream" Jul 19 14:58:55 volumio volumio[1245]: info: ------------------------------ 543ms Jul 19 14:58:55 volumio volumio[1245]: info: ------------------------------ 543ms Jul 19 14:58:55 volumio volumio[1245]: info: Jul 19 14:58:55 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:58:55 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:58:55 volumio volumio[1245]: info: sendMpdCommand add "http://142.44.212.114:8307/stream" took 4 milliseconds Jul 19 14:58:55 volumio volumio[1245]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 19 14:58:55 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand play Jul 19 14:58:55 volumio volumio[1245]: info: Jul 19 14:58:55 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:58:55 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:58:55 volumio volumio[1245]: info: Jul 19 14:58:55 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:58:55 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:58:55 volumio volumio[1245]: info: ------------------------------ 10ms Jul 19 14:58:55 volumio volumio[1245]: info: sendMpdCommand play took 8 milliseconds Jul 19 14:58:55 volumio volumio[1245]: info: ------------------------------ 6ms Jul 19 14:58:55 volumio volumio[1245]: info: ------------------------------ 5ms Jul 19 14:58:55 volumio volumio[1245]: info: Jul 19 14:58:55 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:58:55 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:58:55 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:58:55 volumio volumio[1245]: info: Jul 19 14:58:55 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:58:55 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:58:55 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:58:55 volumio volumio[1245]: info: Jul 19 14:58:55 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:58:55 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:58:55 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:58:55 volumio volumio[1245]: info: Jul 19 14:58:55 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:58:55 volumio volumio[1245]: info: sendMpdCommand status took 46 milliseconds Jul 19 14:58:55 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:58:55 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:58:55 volumio volumio[1245]: info: sendMpdCommand status took 46 milliseconds Jul 19 14:58:55 volumio volumio[1245]: info: sendMpdCommand status took 45 milliseconds Jul 19 14:58:55 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:58:55 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:58:55 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:58:55 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:58:55 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:58:55 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:58:55 volumio volumio[1245]: info: Jul 19 14:58:55 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:58:55 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:58:55 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:58:55 volumio volumio[1245]: info: Jul 19 14:58:55 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:58:55 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:58:55 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:58:55 volumio volumio[1245]: info: sendMpdCommand status took 15 milliseconds Jul 19 14:58:55 volumio volumio[1245]: info: sendMpdCommand playlistinfo took 13 milliseconds Jul 19 14:58:55 volumio volumio[1245]: info: sendMpdCommand playlistinfo took 11 milliseconds Jul 19 14:58:55 volumio volumio[1245]: info: sendMpdCommand playlistinfo took 11 milliseconds Jul 19 14:58:55 volumio volumio[1245]: info: sendMpdCommand status took 14 milliseconds Jul 19 14:58:55 volumio volumio[1245]: info: sendMpdCommand status took 12 milliseconds Jul 19 14:58:55 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:58:55 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:58:55 volumio volumio[1245]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:58:55 volumio volumio[1245]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:58:55 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:58:55 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:58:55 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:58:55 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:58:55 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:58:55 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:58:55 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:55 volumio volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://142.44.212.114:8307/stream","trackType":""} Jul 19 14:58:55 volumio volumio[1245]: verbose: CURRENT POSITION 0 Jul 19 14:58:55 volumio volumio[1245]: info: CoreStateMachine::syncState stateService play Jul 19 14:58:55 volumio volumio[1245]: info: CoreStateMachine::syncState currentStatus stop Jul 19 14:58:55 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:58:55 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:58:55 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:55 volumio volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://142.44.212.114:8307/stream","trackType":""} Jul 19 14:58:55 volumio volumio[1245]: verbose: CURRENT POSITION 0 Jul 19 14:58:55 volumio volumio[1245]: info: CoreStateMachine::syncState stateService play Jul 19 14:58:55 volumio volumio[1245]: info: CoreStateMachine::syncState currentStatus play Jul 19 14:58:55 volumio volumio[1245]: info: Received an update from plugin. extracting info from payload Jul 19 14:58:55 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:55 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:55 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 19 14:58:55 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:55 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:55 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:55 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:58:55 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:58:55 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:55 volumio volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://142.44.212.114:8307/stream","trackType":""} Jul 19 14:58:55 volumio volumio[1245]: verbose: CURRENT POSITION 0 Jul 19 14:58:55 volumio volumio[1245]: info: CoreStateMachine::syncState stateService play Jul 19 14:58:55 volumio volumio[1245]: info: CoreStateMachine::syncState currentStatus play Jul 19 14:58:55 volumio volumio[1245]: info: Received an update from plugin. extracting info from payload Jul 19 14:58:55 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:55 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:55 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:55 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:55 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:55 volumio volumio[1245]: info: ------------------------------ 99ms Jul 19 14:58:55 volumio volumio[1245]: info: ------------------------------ 108ms Jul 19 14:58:55 volumio volumio[1245]: info: ------------------------------ 108ms Jul 19 14:58:55 volumio volumio[1245]: info: sendMpdCommand playlistinfo took 40 milliseconds Jul 19 14:58:55 volumio volumio[1245]: info: sendMpdCommand playlistinfo took 38 milliseconds Jul 19 14:58:55 volumio volumio[1245]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:58:55 volumio volumio[1245]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:58:55 volumio volumio[1245]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:58:55 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:58:55 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:58:55 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:55 volumio volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://142.44.212.114:8307/stream","trackType":""} Jul 19 14:58:55 volumio volumio[1245]: verbose: CURRENT POSITION 0 Jul 19 14:58:55 volumio volumio[1245]: info: CoreStateMachine::syncState stateService play Jul 19 14:58:55 volumio volumio[1245]: info: CoreStateMachine::syncState currentStatus play Jul 19 14:58:55 volumio volumio[1245]: info: Received an update from plugin. extracting info from payload Jul 19 14:58:55 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:55 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:55 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:55 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:55 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:55 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:58:55 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:58:55 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:55 volumio volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://142.44.212.114:8307/stream","trackType":""} Jul 19 14:58:55 volumio volumio[1245]: verbose: CURRENT POSITION 0 Jul 19 14:58:55 volumio volumio[1245]: info: CoreStateMachine::syncState stateService play Jul 19 14:58:55 volumio volumio[1245]: info: CoreStateMachine::syncState currentStatus play Jul 19 14:58:55 volumio volumio[1245]: info: Received an update from plugin. extracting info from payload Jul 19 14:58:55 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:55 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:55 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:55 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:55 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:55 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:58:55 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:58:55 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:55 volumio volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://142.44.212.114:8307/stream","trackType":""} Jul 19 14:58:55 volumio volumio[1245]: verbose: CURRENT POSITION 0 Jul 19 14:58:55 volumio volumio[1245]: info: CoreStateMachine::syncState stateService play Jul 19 14:58:55 volumio volumio[1245]: info: CoreStateMachine::syncState currentStatus play Jul 19 14:58:55 volumio volumio[1245]: info: Received an update from plugin. extracting info from payload Jul 19 14:58:55 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:55 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:55 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:55 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:55 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:55 volumio volumio[1245]: info: ------------------------------ 113ms Jul 19 14:58:55 volumio volumio[1245]: info: ------------------------------ 104ms Jul 19 14:58:55 volumio volumio[1245]: info: ------------------------------ 101ms Jul 19 14:58:56 volumio volumio[1245]: info: Jul 19 14:58:56 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:58:56 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:58:56 volumio volumio[1245]: info: Jul 19 14:58:56 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:58:56 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:58:56 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:58:56 volumio volumio[1245]: info: Jul 19 14:58:56 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:58:56 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:58:56 volumio volumio[1245]: info: Jul 19 14:58:56 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:58:56 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:58:56 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:58:56 volumio volumio[1245]: info: Jul 19 14:58:56 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:58:56 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:58:56 volumio volumio[1245]: info: Jul 19 14:58:56 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:58:56 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:58:56 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:58:56 volumio volumio[1245]: info: Jul 19 14:58:56 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:58:56 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:58:56 volumio volumio[1245]: info: Jul 19 14:58:56 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:58:56 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:58:56 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:58:56 volumio volumio[1245]: info: ------------------------------ 13ms Jul 19 14:58:56 volumio volumio[1245]: info: sendMpdCommand status took 11 milliseconds Jul 19 14:58:56 volumio volumio[1245]: info: ------------------------------ 12ms Jul 19 14:58:56 volumio volumio[1245]: info: sendMpdCommand status took 10 milliseconds Jul 19 14:58:56 volumio volumio[1245]: info: ------------------------------ 10ms Jul 19 14:58:56 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:58:56 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:58:56 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:58:56 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:58:56 volumio volumio[1245]: info: Jul 19 14:58:56 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:58:56 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:58:56 volumio volumio[1245]: info: Jul 19 14:58:56 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:58:56 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:58:56 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:58:56 volumio volumio[1245]: info: Jul 19 14:58:56 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:58:56 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:58:56 volumio volumio[1245]: info: Jul 19 14:58:56 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:58:56 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:58:56 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:58:56 volumio volumio[1245]: info: sendMpdCommand status took 25 milliseconds Jul 19 14:58:56 volumio volumio[1245]: info: ------------------------------ 24ms Jul 19 14:58:56 volumio volumio[1245]: info: sendMpdCommand status took 20 milliseconds Jul 19 14:58:56 volumio volumio[1245]: info: sendMpdCommand playlistinfo took 17 milliseconds Jul 19 14:58:56 volumio volumio[1245]: info: sendMpdCommand playlistinfo took 16 milliseconds Jul 19 14:58:56 volumio volumio[1245]: info: ------------------------------ 16ms Jul 19 14:58:56 volumio volumio[1245]: info: sendMpdCommand status took 13 milliseconds Jul 19 14:58:56 volumio volumio[1245]: info: ------------------------------ 13ms Jul 19 14:58:56 volumio volumio[1245]: info: sendMpdCommand status took 11 milliseconds Jul 19 14:58:56 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:58:56 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:58:56 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:58:56 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:58:56 volumio volumio[1245]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:58:56 volumio volumio[1245]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:58:56 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:58:56 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:58:56 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:58:56 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:58:56 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:58:56 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:58:56 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:56 volumio volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":855,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Cerrone - Orange 5th BCO","artist":"DISCO STUDIO 54","album":null,"uri":"http://142.44.212.114:8307/stream","trackType":""} Jul 19 14:58:56 volumio volumio[1245]: verbose: CURRENT POSITION 0 Jul 19 14:58:56 volumio volumio[1245]: info: CoreStateMachine::syncState stateService play Jul 19 14:58:56 volumio volumio[1245]: info: CoreStateMachine::syncState currentStatus play Jul 19 14:58:56 volumio volumio[1245]: info: Received an update from plugin. extracting info from payload Jul 19 14:58:56 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:56 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 19 14:58:56 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:56 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:56 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:56 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:58:56 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:58:56 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:56 volumio volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":980,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Cerrone - Orange 5th BCO","artist":"DISCO STUDIO 54","album":null,"uri":"http://142.44.212.114:8307/stream","trackType":""} Jul 19 14:58:56 volumio volumio[1245]: verbose: CURRENT POSITION 0 Jul 19 14:58:56 volumio volumio[1245]: info: CoreStateMachine::syncState stateService play Jul 19 14:58:56 volumio volumio[1245]: info: CoreStateMachine::syncState currentStatus play Jul 19 14:58:56 volumio volumio[1245]: info: Received an update from plugin. extracting info from payload Jul 19 14:58:56 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:56 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:56 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:56 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:56 volumio volumio[1245]: info: ------------------------------ 67ms Jul 19 14:58:56 volumio volumio[1245]: info: ------------------------------ 66ms Jul 19 14:58:56 volumio volumio[1245]: info: sendMpdCommand playlistinfo took 34 milliseconds Jul 19 14:58:56 volumio volumio[1245]: info: sendMpdCommand playlistinfo took 33 milliseconds Jul 19 14:58:56 volumio volumio[1245]: info: sendMpdCommand playlistinfo took 31 milliseconds Jul 19 14:58:56 volumio volumio[1245]: info: sendMpdCommand playlistinfo took 31 milliseconds Jul 19 14:58:56 volumio volumio[1245]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:58:56 volumio volumio[1245]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:58:56 volumio volumio[1245]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:58:56 volumio volumio[1245]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:58:56 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:58:56 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:58:56 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:56 volumio volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":980,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Cerrone - Orange 5th BCO","artist":"DISCO STUDIO 54","album":null,"uri":"http://142.44.212.114:8307/stream","trackType":""} Jul 19 14:58:56 volumio volumio[1245]: verbose: CURRENT POSITION 0 Jul 19 14:58:56 volumio volumio[1245]: info: CoreStateMachine::syncState stateService play Jul 19 14:58:56 volumio volumio[1245]: info: CoreStateMachine::syncState currentStatus play Jul 19 14:58:56 volumio volumio[1245]: info: Received an update from plugin. extracting info from payload Jul 19 14:58:56 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:56 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 19 14:58:56 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:56 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:56 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:56 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:58:56 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:58:56 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:56 volumio volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":980,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Cerrone - Orange 5th BCO","artist":"DISCO STUDIO 54","album":null,"uri":"http://142.44.212.114:8307/stream","trackType":""} Jul 19 14:58:56 volumio volumio[1245]: verbose: CURRENT POSITION 0 Jul 19 14:58:56 volumio volumio[1245]: info: CoreStateMachine::syncState stateService play Jul 19 14:58:56 volumio volumio[1245]: info: CoreStateMachine::syncState currentStatus play Jul 19 14:58:56 volumio volumio[1245]: info: Received an update from plugin. extracting info from payload Jul 19 14:58:56 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:56 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:56 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:56 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:56 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:58:56 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:58:56 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:56 volumio volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":980,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Cerrone - Orange 5th BCO","artist":"DISCO STUDIO 54","album":null,"uri":"http://142.44.212.114:8307/stream","trackType":""} Jul 19 14:58:56 volumio volumio[1245]: verbose: CURRENT POSITION 0 Jul 19 14:58:56 volumio volumio[1245]: info: CoreStateMachine::syncState stateService play Jul 19 14:58:56 volumio volumio[1245]: info: CoreStateMachine::syncState currentStatus play Jul 19 14:58:56 volumio volumio[1245]: info: Received an update from plugin. extracting info from payload Jul 19 14:58:56 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:56 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:56 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:56 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:56 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:58:56 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:58:56 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:58:56 volumio volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":980,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Cerrone - Orange 5th BCO","artist":"DISCO STUDIO 54","album":null,"uri":"http://142.44.212.114:8307/stream","trackType":""} Jul 19 14:58:56 volumio volumio[1245]: verbose: CURRENT POSITION 0 Jul 19 14:58:56 volumio volumio[1245]: info: CoreStateMachine::syncState stateService play Jul 19 14:58:56 volumio volumio[1245]: info: CoreStateMachine::syncState currentStatus play Jul 19 14:58:56 volumio volumio[1245]: info: Received an update from plugin. extracting info from payload Jul 19 14:58:56 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:56 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:56 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:58:56 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:58:56 volumio volumio[1245]: info: ------------------------------ 104ms Jul 19 14:58:56 volumio volumio[1245]: info: ------------------------------ 100ms Jul 19 14:58:56 volumio volumio[1245]: info: ------------------------------ 91ms Jul 19 14:58:56 volumio volumio[1245]: info: ------------------------------ 88ms Jul 19 14:59:18 volumio volumio[1245]: info: Preload queue cleared Jul 19 14:59:18 volumio volumio[1245]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 19 14:59:18 volumio volumio[1245]: info: CoreStateMachine::ClearQueue Jul 19 14:59:18 volumio volumio[1245]: info: CoreStateMachine::stop Jul 19 14:59:18 volumio volumio[1245]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 19 14:59:18 volumio volumio[1245]: info: CoreStateMachine::stPlaybackTimer Jul 19 14:59:18 volumio volumio[1245]: info: CoreStateMachine::updateTrackBlock Jul 19 14:59:18 volumio volumio[1245]: info: CorePlayQueue::getTrackBlock Jul 19 14:59:18 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:59:18 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:59:18 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 19 14:59:18 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:59:18 volumio volumio[1245]: info: CoreStateMachine::serviceStop Jul 19 14:59:18 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:59:18 volumio volumio[1245]: info: CoreCommandRouter::serviceStop Jul 19 14:59:18 volumio volumio[1245]: info: [1721390358497] ControllerWebradio::stop Jul 19 14:59:18 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand stop Jul 19 14:59:18 volumio volumio[1245]: info: CorePlayQueue::clearPlayQueue Jul 19 14:59:18 volumio volumio[1245]: info: CorePlayQueue::saveQueue Jul 19 14:59:18 volumio volumio[1245]: info: CoreCommandRouter::volumioPushQueue Jul 19 14:59:18 volumio volumio[1245]: info: CoreStateMachine::addQueueItems Jul 19 14:59:18 volumio volumio[1245]: info: CorePlayQueue::addQueueItems Jul 19 14:59:18 volumio volumio[1245]: info: Preload queue cleared Jul 19 14:59:18 volumio volumio[1245]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99572208 Jul 19 14:59:18 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jul 19 14:59:18 volumio volumio[1245]: info: CoreCommandRouter::volumioPushQueue Jul 19 14:59:18 volumio volumio[1245]: info: CorePlayQueue::saveQueue Jul 19 14:59:18 volumio volumio[1245]: info: CoreStateMachine::updateTrackBlock Jul 19 14:59:18 volumio volumio[1245]: info: CorePlayQueue::getTrackBlock Jul 19 14:59:18 volumio volumio[1245]: info: CoreCommandRouter::volumioPlay Jul 19 14:59:18 volumio volumio[1245]: info: CoreStateMachine::play index 0 Jul 19 14:59:18 volumio volumio[1245]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 19 14:59:18 volumio volumio[1245]: info: CoreStateMachine::stop Jul 19 14:59:18 volumio volumio[1245]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 19 14:59:18 volumio volumio[1245]: info: CoreStateMachine::play index undefined Jul 19 14:59:18 volumio volumio[1245]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 19 14:59:18 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:59:18 volumio volumio[1245]: info: CoreStateMachine::startPlaybackTimer Jul 19 14:59:18 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:59:18 volumio volumio[1245]: info: [1721390358508] ControllerWebradio::clearAddPlayTrack Jul 19 14:59:18 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand stop Jul 19 14:59:18 volumio volumio[1245]: info: Jul 19 14:59:18 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:59:18 volumio volumio[1245]: info: sendMpdCommand stop took 21 milliseconds Jul 19 14:59:18 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:59:18 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:59:18 volumio volumio[1245]: info: sendMpdCommand stop took 10 milliseconds Jul 19 14:59:18 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand clear Jul 19 14:59:18 volumio volumio[1245]: info: Jul 19 14:59:18 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:59:18 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:59:18 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:59:18 volumio volumio[1245]: info: Jul 19 14:59:18 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:59:18 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:59:18 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:59:18 volumio volumio[1245]: info: Jul 19 14:59:18 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:59:18 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:59:18 volumio volumio[1245]: info: sendMpdCommand status took 5 milliseconds Jul 19 14:59:18 volumio volumio[1245]: info: sendMpdCommand clear took 5 milliseconds Jul 19 14:59:18 volumio volumio[1245]: info: sendMpdCommand status took 3 milliseconds Jul 19 14:59:18 volumio volumio[1245]: info: sendMpdCommand status took 2 milliseconds Jul 19 14:59:18 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:59:18 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:59:18 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99572208" Jul 19 14:59:18 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:59:18 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:59:18 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:59:18 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:59:18 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:59:18 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:59:18 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 19 14:59:18 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:59:18 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:59:18 volumio volumio[1245]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 19 14:59:18 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:59:18 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:59:18 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:59:18 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:59:18 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:59:18 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:59:18 volumio volumio[1245]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 19 14:59:18 volumio volumio[1245]: info: ------------------------------ 16ms Jul 19 14:59:18 volumio volumio[1245]: info: ------------------------------ 15ms Jul 19 14:59:18 volumio volumio[1245]: info: Jul 19 14:59:18 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:59:18 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:59:18 volumio volumio[1245]: info: Jul 19 14:59:18 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:59:18 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:59:18 volumio volumio[1245]: error: updateQueue error: null Jul 19 14:59:18 volumio volumio[1245]: info: ------------------------------ 17ms Jul 19 14:59:18 volumio volumio[1245]: info: sendMpdCommand playlistinfo took 15 milliseconds Jul 19 14:59:18 volumio volumio[1245]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:59:18 volumio volumio[1245]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 19 14:59:18 volumio volumio[1245]: info: ------------------------------ 24ms Jul 19 14:59:24 volumio volumio[1245]: info: CoreCommandRouter::volumioPlay Jul 19 14:59:24 volumio volumio[1245]: info: CoreStateMachine::play index undefined Jul 19 14:59:24 volumio volumio[1245]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 19 14:59:24 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:59:24 volumio volumio[1245]: info: CoreStateMachine::startPlaybackTimer Jul 19 14:59:24 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:59:24 volumio volumio[1245]: info: [1721390364925] ControllerWebradio::clearAddPlayTrack Jul 19 14:59:24 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand stop Jul 19 14:59:30 volumio volumio[1245]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99572208" took 12301 milliseconds Jul 19 14:59:30 volumio volumio[1245]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 19 14:59:30 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand play Jul 19 14:59:30 volumio volumio[1245]: info: Jul 19 14:59:30 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:59:30 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:59:30 volumio volumio[1245]: info: ------------------------------ 12294ms Jul 19 14:59:30 volumio volumio[1245]: info: sendMpdCommand stop took 5906 milliseconds Jul 19 14:59:30 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand clear Jul 19 14:59:30 volumio volumio[1245]: info: Jul 19 14:59:30 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:59:30 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:59:30 volumio volumio[1245]: info: Jul 19 14:59:30 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:59:30 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:59:30 volumio volumio[1245]: info: Jul 19 14:59:30 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:59:30 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:59:30 volumio volumio[1245]: info: Jul 19 14:59:30 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:59:30 volumio volumio[1245]: error: updateQueue error: null Jul 19 14:59:30 volumio volumio[1245]: error: updateQueue error: null Jul 19 14:59:30 volumio volumio[1245]: info: sendMpdCommand play took 24 milliseconds Jul 19 14:59:30 volumio volumio[1245]: info: ------------------------------ 23ms Jul 19 14:59:30 volumio volumio[1245]: info: sendMpdCommand clear took 19 milliseconds Jul 19 14:59:30 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:59:30 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:59:30 volumio volumio[1245]: info: ------------------------------ 20ms Jul 19 14:59:30 volumio volumio[1245]: info: ------------------------------ 18ms Jul 19 14:59:30 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99572208" Jul 19 14:59:30 volumio volumio[1245]: info: Jul 19 14:59:30 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:59:30 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:59:30 volumio volumio[1245]: info: Jul 19 14:59:30 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:59:30 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:59:30 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:59:30 volumio volumio[1245]: info: Jul 19 14:59:30 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:59:30 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:59:30 volumio volumio[1245]: info: Jul 19 14:59:30 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:59:30 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:59:30 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:59:30 volumio volumio[1245]: error: updateQueue error: null Jul 19 14:59:30 volumio volumio[1245]: info: ------------------------------ 19ms Jul 19 14:59:30 volumio volumio[1245]: info: sendMpdCommand status took 14 milliseconds Jul 19 14:59:30 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:59:30 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:59:30 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:59:30 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:59:30 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 19 14:59:30 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:59:30 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:59:30 volumio volumio[1245]: 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} Jul 19 14:59:30 volumio volumio[1245]: verbose: CURRENT POSITION 0 Jul 19 14:59:30 volumio volumio[1245]: info: CoreStateMachine::syncState stateService stop Jul 19 14:59:30 volumio volumio[1245]: info: CoreStateMachine::syncState currentStatus stop Jul 19 14:59:30 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:59:30 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:59:30 volumio volumio[1245]: info: No code Jul 19 14:59:30 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:59:30 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:59:30 volumio volumio[1245]: info: ------------------------------ 50ms Jul 19 14:59:31 volumio volumio[1245]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99572208" took 180 milliseconds Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 19 14:59:31 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand play Jul 19 14:59:31 volumio volumio[1245]: info: Jul 19 14:59:31 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:59:31 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:59:31 volumio volumio[1245]: info: ------------------------------ 183ms Jul 19 14:59:31 volumio volumio[1245]: info: sendMpdCommand status took 182 milliseconds Jul 19 14:59:31 volumio volumio[1245]: info: ------------------------------ 180ms Jul 19 14:59:31 volumio volumio[1245]: info: sendMpdCommand status took 178 milliseconds Jul 19 14:59:31 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:59:31 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:59:31 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:59:31 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:59:31 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 19 14:59:31 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:59:31 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:59:31 volumio volumio[1245]: 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} Jul 19 14:59:31 volumio volumio[1245]: verbose: CURRENT POSITION 0 Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::syncState stateService stop Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::syncState currentStatus stop Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:59:31 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:59:31 volumio volumio[1245]: info: No code Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:59:31 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:59:31 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:59:31 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:59:31 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:59:31 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:59:31 volumio volumio[1245]: 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} Jul 19 14:59:31 volumio volumio[1245]: verbose: CURRENT POSITION 0 Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::syncState stateService stop Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::syncState currentStatus stop Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:59:31 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:59:31 volumio volumio[1245]: info: No code Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:59:31 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:59:31 volumio volumio[1245]: info: ------------------------------ 226ms Jul 19 14:59:31 volumio volumio[1245]: info: ------------------------------ 223ms Jul 19 14:59:31 volumio volumio[1245]: info: Jul 19 14:59:31 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:59:31 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:59:31 volumio volumio[1245]: info: Jul 19 14:59:31 volumio volumio[1245]: ---------------------------- MPD announces system playlist update Jul 19 14:59:31 volumio volumio[1245]: info: Ignoring MPD Status Update Jul 19 14:59:31 volumio volumio[1245]: info: sendMpdCommand play took 54 milliseconds Jul 19 14:59:31 volumio volumio[1245]: info: ------------------------------ 53ms Jul 19 14:59:31 volumio volumio[1245]: info: ------------------------------ 3ms Jul 19 14:59:31 volumio volumio[1245]: info: ------------------------------ 3ms Jul 19 14:59:31 volumio volumio[1245]: info: Jul 19 14:59:31 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:59:31 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:59:31 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:59:31 volumio volumio[1245]: info: Jul 19 14:59:31 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:59:31 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:59:31 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:59:31 volumio volumio[1245]: info: Jul 19 14:59:31 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:59:31 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:59:31 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:59:31 volumio volumio[1245]: info: Jul 19 14:59:31 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:59:31 volumio volumio[1245]: info: sendMpdCommand status took 21 milliseconds Jul 19 14:59:31 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:59:31 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:59:31 volumio volumio[1245]: info: sendMpdCommand status took 21 milliseconds Jul 19 14:59:31 volumio volumio[1245]: info: sendMpdCommand status took 20 milliseconds Jul 19 14:59:31 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:59:31 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:59:31 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:59:31 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:59:31 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:59:31 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:59:31 volumio volumio[1245]: info: Jul 19 14:59:31 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:59:31 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:59:31 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:59:31 volumio volumio[1245]: info: Jul 19 14:59:31 volumio volumio[1245]: ---------------------------- MPD announces state update: player Jul 19 14:59:31 volumio volumio[1245]: info: ControllerMpd::getState Jul 19 14:59:31 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand status Jul 19 14:59:31 volumio volumio[1245]: info: sendMpdCommand status took 5 milliseconds Jul 19 14:59:31 volumio volumio[1245]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 19 14:59:31 volumio volumio[1245]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 19 14:59:31 volumio volumio[1245]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 19 14:59:31 volumio volumio[1245]: info: sendMpdCommand status took 3 milliseconds Jul 19 14:59:31 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:59:31 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:59:31 volumio volumio[1245]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:59:31 volumio volumio[1245]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:59:31 volumio volumio[1245]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:59:31 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:59:31 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:59:31 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:59:31 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:59:31 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:59:31 volumio volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 21/9999) DISCO STUDIO 54","album":null,"uri":"http://142.44.212.114:8307/stream","trackType":""} Jul 19 14:59:31 volumio volumio[1245]: verbose: CURRENT POSITION 0 Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::syncState stateService play Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::syncState currentStatus stop Jul 19 14:59:31 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:59:31 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:59:31 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:59:31 volumio volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 21/9999) DISCO STUDIO 54","album":null,"uri":"http://142.44.212.114:8307/stream","trackType":""} Jul 19 14:59:31 volumio volumio[1245]: verbose: CURRENT POSITION 0 Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::syncState stateService play Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::syncState currentStatus play Jul 19 14:59:31 volumio volumio[1245]: info: Received an update from plugin. extracting info from payload Jul 19 14:59:31 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:59:31 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:59:31 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 19 14:59:31 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:59:31 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:59:31 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:59:31 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:59:31 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:59:31 volumio volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 21/9999) DISCO STUDIO 54","album":null,"uri":"http://142.44.212.114:8307/stream","trackType":""} Jul 19 14:59:31 volumio volumio[1245]: verbose: CURRENT POSITION 0 Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::syncState stateService play Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::syncState currentStatus play Jul 19 14:59:31 volumio volumio[1245]: info: Received an update from plugin. extracting info from payload Jul 19 14:59:31 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:59:31 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:59:31 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:59:31 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:59:31 volumio volumio[1245]: info: ------------------------------ 41ms Jul 19 14:59:31 volumio volumio[1245]: info: ------------------------------ 46ms Jul 19 14:59:31 volumio volumio[1245]: info: ------------------------------ 45ms Jul 19 14:59:31 volumio volumio[1245]: info: sendMpdCommand status took 21 milliseconds Jul 19 14:59:31 volumio volumio[1245]: info: sendMpdCommand playlistinfo took 20 milliseconds Jul 19 14:59:31 volumio volumio[1245]: info: sendMpdCommand playlistinfo took 22 milliseconds Jul 19 14:59:31 volumio volumio[1245]: verbose: ControllerMpd::parseState Jul 19 14:59:31 volumio volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 19 14:59:31 volumio volumio[1245]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:59:31 volumio volumio[1245]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:59:31 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:59:31 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:59:31 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:59:31 volumio volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 21/9999) DISCO STUDIO 54","album":null,"uri":"http://142.44.212.114:8307/stream","trackType":""} Jul 19 14:59:31 volumio volumio[1245]: verbose: CURRENT POSITION 0 Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::syncState stateService play Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::syncState currentStatus play Jul 19 14:59:31 volumio volumio[1245]: info: Received an update from plugin. extracting info from payload Jul 19 14:59:31 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:59:31 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:59:31 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:59:31 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:59:31 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:59:31 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:59:31 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:59:31 volumio volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 21/9999) DISCO STUDIO 54","album":null,"uri":"http://142.44.212.114:8307/stream","trackType":""} Jul 19 14:59:31 volumio volumio[1245]: verbose: CURRENT POSITION 0 Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::syncState stateService play Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::syncState currentStatus play Jul 19 14:59:31 volumio volumio[1245]: info: Received an update from plugin. extracting info from payload Jul 19 14:59:31 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:59:31 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:59:31 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:59:31 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:59:31 volumio volumio[1245]: info: ------------------------------ 50ms Jul 19 14:59:31 volumio volumio[1245]: info: ------------------------------ 47ms Jul 19 14:59:31 volumio volumio[1245]: info: sendMpdCommand playlistinfo took 31 milliseconds Jul 19 14:59:31 volumio volumio[1245]: verbose: ControllerMpd::parseTrackInfo Jul 19 14:59:31 volumio volumio[1245]: info: ControllerMpd::pushState Jul 19 14:59:31 volumio volumio[1245]: info: CoreCommandRouter::servicePushState Jul 19 14:59:31 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:59:31 volumio volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 21/9999) DISCO STUDIO 54","album":null,"uri":"http://142.44.212.114:8307/stream","trackType":""} Jul 19 14:59:31 volumio volumio[1245]: verbose: CURRENT POSITION 0 Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::syncState stateService play Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::syncState currentStatus play Jul 19 14:59:31 volumio volumio[1245]: info: Received an update from plugin. extracting info from payload Jul 19 14:59:31 volumio volumio[1245]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:59:31 volumio volumio[1245]: info: CorePlayQueue::getTrack 0 Jul 19 14:59:31 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:59:31 volumio volumio[1245]: info: CoreStateMachine::pushState Jul 19 14:59:31 volumio volumio[1245]: info: CoreCommandRouter::volumioPushState Jul 19 14:59:31 volumio volumio[1245]: info: ------------------------------ 68ms Jul 19 14:59:32 volumio volumio[1245]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 19 14:59:32 volumio volumio[1245]: Error: getaddrinfo ENOTFOUND lastfm.freetls.fastly.net Jul 19 14:59:32 volumio volumio[1245]: at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:71:26) { Jul 19 14:59:32 volumio volumio[1245]: errno: -3007, Jul 19 14:59:32 volumio volumio[1245]: code: 'ENOTFOUND', Jul 19 14:59:32 volumio volumio[1245]: syscall: 'getaddrinfo', Jul 19 14:59:32 volumio volumio[1245]: hostname: 'lastfm.freetls.fastly.net' Jul 19 14:59:32 volumio volumio[1245]: } Jul 19 14:59:32 volumio volumio[1245]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 19 14:59:33 volumio sudo[4090]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-19 14:58 Jul 19 14:59:33 volumio sudo[4090]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 09:13:11 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ac782621640fcc70c07e91a81b6d958b"