-- Logs begin at Fri 2025-02-21 13:19:34 UTC, end at Sun 2025-02-23 10:33:51 UTC. -- Feb 23 10:32:05 volumio volumio[794]: info: CoreCommandRouter::volumioSeek Feb 23 10:32:05 volumio volumio[794]: info: CoreStateMachine::seek Feb 23 10:32:05 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:05 volumio volumio[794]: info: TRACKBLOCK {"service":"webradio","type":"webradio","title":"Carmen McRae - Monkery's The Blues","icon":"fa fa-microphone","uri":"https://live.amperwave.net/direct/ppm-jazz24mp3-ibc1","name":"Carmen McRae - Monkery's The Blues","albumart":"/albumart","samplerate":"","bitdepth":0,"channels":0} Feb 23 10:32:05 volumio volumio[794]: info: CoreStateMachine::startPlaybackTimer Feb 23 10:32:05 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:05 volumio volumio[794]: info: [1740306725388] ControllerWebradio::seek Feb 23 10:32:05 volumio volumio[794]: info: ControllerMpd::seek Feb 23 10:32:05 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:05 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 10:32:05 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:06 volumio volumio[794]: error: null Feb 23 10:32:06 volumio volumio[794]: info: Feb 23 10:32:06 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:32:06 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:32:06 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:32:06 volumio volumio[794]: info: Feb 23 10:32:06 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:32:06 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:32:06 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:32:06 volumio volumio[794]: info: sendMpdCommand status took 2 milliseconds Feb 23 10:32:06 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:32:06 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 10:32:06 volumio volumio[794]: info: sendMpdCommand status took 2 milliseconds Feb 23 10:32:06 volumio volumio[794]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 23 10:32:06 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:32:06 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 10:32:06 volumio volumio[794]: verbose: ControllerMpd::parseTrackInfo Feb 23 10:32:06 volumio volumio[794]: info: ControllerMpd::pushState Feb 23 10:32:06 volumio volumio[794]: info: CoreCommandRouter::servicePushState Feb 23 10:32:06 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:06 volumio volumio[794]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"David \"Fathead\" Newman - Someone To Watch Over Me","artist":"Jazz24","album":null,"uri":"https://live.amperwave.net/direct/ppm-jazz24mp3-ibc1","trackType":""} Feb 23 10:32:06 volumio volumio[794]: verbose: CURRENT POSITION 0 Feb 23 10:32:06 volumio volumio[794]: info: CoreStateMachine::syncState stateService play Feb 23 10:32:06 volumio volumio[794]: info: CoreStateMachine::syncState currentStatus play Feb 23 10:32:06 volumio volumio[794]: info: Received an update from plugin. extracting info from payload Feb 23 10:32:06 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 23 10:32:06 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:06 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 10:32:06 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:06 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:06 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:06 volumio volumio[794]: info: ------------------------------ 26ms Feb 23 10:32:06 volumio volumio[794]: info: sendMpdCommand playlistinfo took 21 milliseconds Feb 23 10:32:06 volumio volumio[794]: verbose: ControllerMpd::parseTrackInfo Feb 23 10:32:06 volumio volumio[794]: info: ControllerMpd::pushState Feb 23 10:32:06 volumio volumio[794]: info: CoreCommandRouter::servicePushState Feb 23 10:32:06 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:06 volumio volumio[794]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"David \"Fathead\" Newman - Someone To Watch Over Me","artist":"Jazz24","album":null,"uri":"https://live.amperwave.net/direct/ppm-jazz24mp3-ibc1","trackType":""} Feb 23 10:32:06 volumio volumio[794]: verbose: CURRENT POSITION 0 Feb 23 10:32:06 volumio volumio[794]: info: CoreStateMachine::syncState stateService play Feb 23 10:32:06 volumio volumio[794]: info: CoreStateMachine::syncState currentStatus play Feb 23 10:32:06 volumio volumio[794]: info: Received an update from plugin. extracting info from payload Feb 23 10:32:06 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 23 10:32:06 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:06 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 10:32:06 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:06 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:06 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:06 volumio volumio[794]: info: ------------------------------ 45ms Feb 23 10:32:07 volumio volumio[794]: info: Feb 23 10:32:07 volumio volumio[794]: ---------------------------- MPD announces system playlist update Feb 23 10:32:07 volumio volumio[794]: info: Ignoring MPD Status Update Feb 23 10:32:07 volumio volumio[794]: info: Feb 23 10:32:07 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:32:07 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:32:07 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:32:07 volumio volumio[794]: info: Feb 23 10:32:07 volumio volumio[794]: ---------------------------- MPD announces system playlist update Feb 23 10:32:07 volumio volumio[794]: info: Ignoring MPD Status Update Feb 23 10:32:07 volumio volumio[794]: info: Feb 23 10:32:07 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:32:07 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:32:07 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:32:07 volumio volumio[794]: info: ------------------------------ 5ms Feb 23 10:32:07 volumio volumio[794]: info: sendMpdCommand status took 3 milliseconds Feb 23 10:32:07 volumio volumio[794]: info: ------------------------------ 3ms Feb 23 10:32:07 volumio volumio[794]: info: sendMpdCommand status took 3 milliseconds Feb 23 10:32:07 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:32:07 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 10:32:07 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:32:07 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 10:32:07 volumio volumio[794]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 23 10:32:07 volumio volumio[794]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 23 10:32:07 volumio volumio[794]: verbose: ControllerMpd::parseTrackInfo Feb 23 10:32:07 volumio volumio[794]: verbose: ControllerMpd::parseTrackInfo Feb 23 10:32:07 volumio volumio[794]: info: ControllerMpd::pushState Feb 23 10:32:07 volumio volumio[794]: info: CoreCommandRouter::servicePushState Feb 23 10:32:07 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:07 volumio volumio[794]: verbose: STATE SERVICE {"status":"play","position":0,"seek":387,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"David \"Fathead\" Newman - Someone To Watch Over Me","artist":"Jazz24","album":null,"uri":"https://live.amperwave.net/direct/ppm-jazz24mp3-ibc1","trackType":""} Feb 23 10:32:07 volumio volumio[794]: verbose: CURRENT POSITION 0 Feb 23 10:32:07 volumio volumio[794]: info: CoreStateMachine::syncState stateService play Feb 23 10:32:07 volumio volumio[794]: info: CoreStateMachine::syncState currentStatus play Feb 23 10:32:07 volumio volumio[794]: info: Received an update from plugin. extracting info from payload Feb 23 10:32:07 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 23 10:32:07 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:07 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 10:32:07 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:07 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:07 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:07 volumio volumio[794]: info: ControllerMpd::pushState Feb 23 10:32:07 volumio volumio[794]: info: CoreCommandRouter::servicePushState Feb 23 10:32:07 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:07 volumio volumio[794]: verbose: STATE SERVICE {"status":"play","position":0,"seek":387,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"David \"Fathead\" Newman - Someone To Watch Over Me","artist":"Jazz24","album":null,"uri":"https://live.amperwave.net/direct/ppm-jazz24mp3-ibc1","trackType":""} Feb 23 10:32:07 volumio volumio[794]: verbose: CURRENT POSITION 0 Feb 23 10:32:07 volumio volumio[794]: info: CoreStateMachine::syncState stateService play Feb 23 10:32:07 volumio volumio[794]: info: CoreStateMachine::syncState currentStatus play Feb 23 10:32:07 volumio volumio[794]: info: Received an update from plugin. extracting info from payload Feb 23 10:32:07 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 23 10:32:07 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:07 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:07 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:07 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:07 volumio volumio[794]: info: ------------------------------ 33ms Feb 23 10:32:07 volumio volumio[794]: info: ------------------------------ 31ms Feb 23 10:32:10 volumio volumio[794]: info: VolumeController::SetAlsaVolume89 Feb 23 10:32:10 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:10 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 10:32:10 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:25 volumio volumio[794]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 23 10:32:25 volumio volumio[794]: info: CoreStateMachine::ClearQueue Feb 23 10:32:25 volumio volumio[794]: info: CoreStateMachine::stop Feb 23 10:32:25 volumio volumio[794]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 10:32:25 volumio volumio[794]: info: CoreStateMachine::stPlaybackTimer Feb 23 10:32:25 volumio volumio[794]: info: CoreStateMachine::updateTrackBlock Feb 23 10:32:25 volumio volumio[794]: info: CorePlayQueue::getTrackBlock Feb 23 10:32:25 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:25 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:25 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 10:32:25 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:25 volumio volumio[794]: info: CoreStateMachine::serviceStop Feb 23 10:32:25 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:25 volumio volumio[794]: info: CoreCommandRouter::serviceStop Feb 23 10:32:25 volumio volumio[794]: info: [1740306745376] ControllerWebradio::stop Feb 23 10:32:25 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand stop Feb 23 10:32:25 volumio volumio[794]: info: CorePlayQueue::clearPlayQueue Feb 23 10:32:25 volumio volumio[794]: info: CorePlayQueue::saveQueue Feb 23 10:32:25 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:25 volumio volumio[794]: info: CoreCommandRouter::volumioPushQueue Feb 23 10:32:25 volumio volumio[794]: info: CoreStateMachine::addQueueItems Feb 23 10:32:25 volumio volumio[794]: info: CorePlayQueue::addQueueItems Feb 23 10:32:25 volumio volumio[794]: info: Adding Item to queue: http://185.33.21.112:80/ccountry_64a Feb 23 10:32:25 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 23 10:32:25 volumio volumio[794]: info: CorePlayQueue::saveQueue Feb 23 10:32:25 volumio volumio[794]: info: CoreCommandRouter::volumioPushQueue Feb 23 10:32:25 volumio volumio[794]: info: CoreStateMachine::updateTrackBlock Feb 23 10:32:25 volumio volumio[794]: info: CorePlayQueue::getTrackBlock Feb 23 10:32:25 volumio volumio[794]: info: CoreCommandRouter::volumioPlay Feb 23 10:32:25 volumio volumio[794]: info: CoreStateMachine::play index 0 Feb 23 10:32:25 volumio volumio[794]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 10:32:25 volumio volumio[794]: info: CoreStateMachine::stop Feb 23 10:32:25 volumio volumio[794]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 10:32:25 volumio volumio[794]: info: CoreStateMachine::play index undefined Feb 23 10:32:25 volumio volumio[794]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 10:32:25 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:25 volumio volumio[794]: info: CoreStateMachine::startPlaybackTimer Feb 23 10:32:25 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:25 volumio volumio[794]: info: [1740306745394] ControllerWebradio::clearAddPlayTrack Feb 23 10:32:25 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand stop Feb 23 10:32:25 volumio volumio[794]: info: sendMpdCommand stop took 79 milliseconds Feb 23 10:32:25 volumio volumio[794]: info: Feb 23 10:32:25 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:32:25 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:32:25 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:32:25 volumio volumio[794]: info: sendMpdCommand stop took 65 milliseconds Feb 23 10:32:25 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand clear Feb 23 10:32:25 volumio volumio[794]: info: Feb 23 10:32:25 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:32:25 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:32:25 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:32:25 volumio volumio[794]: info: Feb 23 10:32:25 volumio volumio[794]: ---------------------------- MPD announces system playlist update Feb 23 10:32:25 volumio volumio[794]: info: Ignoring MPD Status Update Feb 23 10:32:25 volumio volumio[794]: info: sendMpdCommand status took 4 milliseconds Feb 23 10:32:25 volumio volumio[794]: info: sendMpdCommand clear took 3 milliseconds Feb 23 10:32:25 volumio volumio[794]: info: sendMpdCommand status took 2 milliseconds Feb 23 10:32:25 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:32:25 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 10:32:25 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand load "http://185.33.21.112:80/ccountry_64a" Feb 23 10:32:25 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:32:25 volumio volumio[794]: info: ControllerMpd::pushState Feb 23 10:32:25 volumio volumio[794]: info: CoreCommandRouter::servicePushState Feb 23 10:32:25 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:25 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:25 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 10:32:25 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:25 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:25 volumio volumio[794]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 23 10:32:25 volumio volumio[794]: info: ------------------------------ 14ms Feb 23 10:32:25 volumio volumio[794]: info: Feb 23 10:32:25 volumio volumio[794]: ---------------------------- MPD announces system playlist update Feb 23 10:32:25 volumio volumio[794]: info: Ignoring MPD Status Update Feb 23 10:32:25 volumio volumio[794]: error: updateQueue error: null Feb 23 10:32:25 volumio volumio[794]: info: ------------------------------ 15ms Feb 23 10:32:25 volumio volumio[794]: info: sendMpdCommand playlistinfo took 13 milliseconds Feb 23 10:32:25 volumio volumio[794]: verbose: ControllerMpd::parseTrackInfo Feb 23 10:32:25 volumio volumio[794]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 23 10:32:25 volumio volumio[794]: info: ------------------------------ 23ms Feb 23 10:32:26 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand add "http://185.33.21.112:80/ccountry_64a" Feb 23 10:32:26 volumio volumio[794]: error: updateQueue error: null Feb 23 10:32:26 volumio volumio[794]: info: ------------------------------ 1412ms Feb 23 10:32:26 volumio volumio[794]: info: Feb 23 10:32:26 volumio volumio[794]: ---------------------------- MPD announces system playlist update Feb 23 10:32:26 volumio volumio[794]: info: Ignoring MPD Status Update Feb 23 10:32:26 volumio volumio[794]: info: sendMpdCommand add "http://185.33.21.112:80/ccountry_64a" took 3 milliseconds Feb 23 10:32:26 volumio volumio[794]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 23 10:32:26 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand play Feb 23 10:32:26 volumio volumio[794]: info: Feb 23 10:32:26 volumio volumio[794]: ---------------------------- MPD announces system playlist update Feb 23 10:32:26 volumio volumio[794]: info: Ignoring MPD Status Update Feb 23 10:32:26 volumio volumio[794]: info: ------------------------------ 4ms Feb 23 10:32:26 volumio volumio[794]: info: sendMpdCommand play took 4 milliseconds Feb 23 10:32:26 volumio volumio[794]: info: ------------------------------ 4ms Feb 23 10:32:28 volumio volumio[794]: info: Feb 23 10:32:28 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:32:28 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:32:28 volumio volumio[794]: info: Feb 23 10:32:28 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:32:28 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:32:28 volumio volumio[794]: info: Feb 23 10:32:28 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:32:28 volumio volumio[794]: info: sendMpdCommand status took 6 milliseconds Feb 23 10:32:28 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 10:32:28 volumio volumio[794]: info: sendMpdCommand status took 7 milliseconds Feb 23 10:32:28 volumio volumio[794]: info: sendMpdCommand status took 3 milliseconds Feb 23 10:32:28 volumio volumio[794]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::parseTrackInfo Feb 23 10:32:28 volumio volumio[794]: info: ControllerMpd::pushState Feb 23 10:32:28 volumio volumio[794]: info: CoreCommandRouter::servicePushState Feb 23 10:32:28 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:28 volumio volumio[794]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ccountry_64a","artist":null,"album":null,"uri":"http://185.33.21.112:80/ccountry_64a","trackType":""} Feb 23 10:32:28 volumio volumio[794]: verbose: CURRENT POSITION 0 Feb 23 10:32:28 volumio volumio[794]: info: CoreStateMachine::syncState stateService play Feb 23 10:32:28 volumio volumio[794]: info: CoreStateMachine::syncState currentStatus stop Feb 23 10:32:28 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:28 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 10:32:28 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:28 volumio volumio[794]: info: ------------------------------ 24ms Feb 23 10:32:28 volumio volumio[794]: info: Feb 23 10:32:28 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:32:28 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:32:28 volumio volumio[794]: info: sendMpdCommand playlistinfo took 18 milliseconds Feb 23 10:32:28 volumio volumio[794]: info: sendMpdCommand playlistinfo took 18 milliseconds Feb 23 10:32:28 volumio volumio[794]: info: sendMpdCommand status took 5 milliseconds Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::parseTrackInfo Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::parseTrackInfo Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 10:32:28 volumio volumio[794]: info: ControllerMpd::pushState Feb 23 10:32:28 volumio volumio[794]: info: CoreCommandRouter::servicePushState Feb 23 10:32:28 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:28 volumio volumio[794]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ccountry_64a","artist":null,"album":null,"uri":"http://185.33.21.112:80/ccountry_64a","trackType":""} Feb 23 10:32:28 volumio volumio[794]: verbose: CURRENT POSITION 0 Feb 23 10:32:28 volumio volumio[794]: info: CoreStateMachine::syncState stateService play Feb 23 10:32:28 volumio volumio[794]: info: CoreStateMachine::syncState currentStatus play Feb 23 10:32:28 volumio volumio[794]: info: Received an update from plugin. extracting info from payload Feb 23 10:32:28 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:28 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:28 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 10:32:28 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:28 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:28 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:28 volumio volumio[794]: info: ControllerMpd::pushState Feb 23 10:32:28 volumio volumio[794]: info: CoreCommandRouter::servicePushState Feb 23 10:32:28 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:28 volumio volumio[794]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ccountry_64a","artist":null,"album":null,"uri":"http://185.33.21.112:80/ccountry_64a","trackType":""} Feb 23 10:32:28 volumio volumio[794]: verbose: CURRENT POSITION 0 Feb 23 10:32:28 volumio volumio[794]: info: CoreStateMachine::syncState stateService play Feb 23 10:32:28 volumio volumio[794]: info: CoreStateMachine::syncState currentStatus play Feb 23 10:32:28 volumio volumio[794]: info: Received an update from plugin. extracting info from payload Feb 23 10:32:28 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:28 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:28 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:28 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:28 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:28 volumio volumio[794]: info: ------------------------------ 74ms Feb 23 10:32:28 volumio volumio[794]: info: ------------------------------ 69ms Feb 23 10:32:28 volumio volumio[794]: info: sendMpdCommand playlistinfo took 52 milliseconds Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::parseTrackInfo Feb 23 10:32:28 volumio volumio[794]: info: ControllerMpd::pushState Feb 23 10:32:28 volumio volumio[794]: info: CoreCommandRouter::servicePushState Feb 23 10:32:28 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:28 volumio volumio[794]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ccountry_64a","artist":null,"album":null,"uri":"http://185.33.21.112:80/ccountry_64a","trackType":""} Feb 23 10:32:28 volumio volumio[794]: verbose: CURRENT POSITION 0 Feb 23 10:32:28 volumio volumio[794]: info: CoreStateMachine::syncState stateService play Feb 23 10:32:28 volumio volumio[794]: info: CoreStateMachine::syncState currentStatus play Feb 23 10:32:28 volumio volumio[794]: info: Received an update from plugin. extracting info from payload Feb 23 10:32:28 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:28 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:28 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 10:32:28 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:28 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:28 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:28 volumio volumio[794]: info: ------------------------------ 87ms Feb 23 10:32:28 volumio volumio[794]: info: Feb 23 10:32:28 volumio volumio[794]: ---------------------------- MPD announces system playlist update Feb 23 10:32:28 volumio volumio[794]: info: Ignoring MPD Status Update Feb 23 10:32:28 volumio volumio[794]: info: Feb 23 10:32:28 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:32:28 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:32:28 volumio volumio[794]: info: Feb 23 10:32:28 volumio volumio[794]: ---------------------------- MPD announces system playlist update Feb 23 10:32:28 volumio volumio[794]: info: Ignoring MPD Status Update Feb 23 10:32:28 volumio volumio[794]: info: Feb 23 10:32:28 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:32:28 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:32:28 volumio volumio[794]: info: Feb 23 10:32:28 volumio volumio[794]: ---------------------------- MPD announces system playlist update Feb 23 10:32:28 volumio volumio[794]: info: Ignoring MPD Status Update Feb 23 10:32:28 volumio volumio[794]: info: Feb 23 10:32:28 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:32:28 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:32:28 volumio volumio[794]: info: Feb 23 10:32:28 volumio volumio[794]: ---------------------------- MPD announces system playlist update Feb 23 10:32:28 volumio volumio[794]: info: Ignoring MPD Status Update Feb 23 10:32:28 volumio volumio[794]: info: Feb 23 10:32:28 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:32:28 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:32:28 volumio volumio[794]: info: ------------------------------ 7ms Feb 23 10:32:28 volumio volumio[794]: info: sendMpdCommand status took 6 milliseconds Feb 23 10:32:28 volumio volumio[794]: info: ------------------------------ 5ms Feb 23 10:32:28 volumio volumio[794]: info: sendMpdCommand status took 4 milliseconds Feb 23 10:32:28 volumio volumio[794]: info: ------------------------------ 3ms Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 10:32:28 volumio volumio[794]: info: sendMpdCommand status took 5 milliseconds Feb 23 10:32:28 volumio volumio[794]: info: ------------------------------ 5ms Feb 23 10:32:28 volumio volumio[794]: info: sendMpdCommand status took 3 milliseconds Feb 23 10:32:28 volumio volumio[794]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 23 10:32:28 volumio volumio[794]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::parseTrackInfo Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::parseTrackInfo Feb 23 10:32:28 volumio volumio[794]: info: ControllerMpd::pushState Feb 23 10:32:28 volumio volumio[794]: info: CoreCommandRouter::servicePushState Feb 23 10:32:28 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:28 volumio volumio[794]: verbose: STATE SERVICE {"status":"play","position":0,"seek":778,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Alabama - Feels So Right","artist":"1.FM - Classic Country Radio","album":null,"uri":"http://185.33.21.112:80/ccountry_64a","trackType":""} Feb 23 10:32:28 volumio volumio[794]: verbose: CURRENT POSITION 0 Feb 23 10:32:28 volumio volumio[794]: info: CoreStateMachine::syncState stateService play Feb 23 10:32:28 volumio volumio[794]: info: CoreStateMachine::syncState currentStatus play Feb 23 10:32:28 volumio volumio[794]: info: Received an update from plugin. extracting info from payload Feb 23 10:32:28 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 23 10:32:28 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:28 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 10:32:28 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:28 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:28 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:28 volumio volumio[794]: info: ControllerMpd::pushState Feb 23 10:32:28 volumio volumio[794]: info: CoreCommandRouter::servicePushState Feb 23 10:32:28 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:28 volumio volumio[794]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Alabama - Feels So Right","artist":"1.FM - Classic Country Radio","album":null,"uri":"http://185.33.21.112:80/ccountry_64a","trackType":""} Feb 23 10:32:28 volumio volumio[794]: verbose: CURRENT POSITION 0 Feb 23 10:32:28 volumio volumio[794]: info: CoreStateMachine::syncState stateService play Feb 23 10:32:28 volumio volumio[794]: info: CoreStateMachine::syncState currentStatus play Feb 23 10:32:28 volumio volumio[794]: info: Received an update from plugin. extracting info from payload Feb 23 10:32:28 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 23 10:32:28 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:28 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:28 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:28 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:28 volumio volumio[794]: info: ------------------------------ 40ms Feb 23 10:32:28 volumio volumio[794]: info: ------------------------------ 39ms Feb 23 10:32:28 volumio volumio[794]: info: sendMpdCommand playlistinfo took 31 milliseconds Feb 23 10:32:28 volumio volumio[794]: info: sendMpdCommand playlistinfo took 30 milliseconds Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::parseTrackInfo Feb 23 10:32:28 volumio volumio[794]: verbose: ControllerMpd::parseTrackInfo Feb 23 10:32:28 volumio volumio[794]: info: ControllerMpd::pushState Feb 23 10:32:28 volumio volumio[794]: info: CoreCommandRouter::servicePushState Feb 23 10:32:28 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:28 volumio volumio[794]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Alabama - Feels So Right","artist":"1.FM - Classic Country Radio","album":null,"uri":"http://185.33.21.112:80/ccountry_64a","trackType":""} Feb 23 10:32:28 volumio volumio[794]: verbose: CURRENT POSITION 0 Feb 23 10:32:28 volumio volumio[794]: info: CoreStateMachine::syncState stateService play Feb 23 10:32:28 volumio volumio[794]: info: CoreStateMachine::syncState currentStatus play Feb 23 10:32:28 volumio volumio[794]: info: Received an update from plugin. extracting info from payload Feb 23 10:32:28 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 23 10:32:28 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:28 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:28 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:28 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:28 volumio volumio[794]: info: ControllerMpd::pushState Feb 23 10:32:28 volumio volumio[794]: info: CoreCommandRouter::servicePushState Feb 23 10:32:28 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:28 volumio volumio[794]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Alabama - Feels So Right","artist":"1.FM - Classic Country Radio","album":null,"uri":"http://185.33.21.112:80/ccountry_64a","trackType":""} Feb 23 10:32:28 volumio volumio[794]: verbose: CURRENT POSITION 0 Feb 23 10:32:28 volumio volumio[794]: info: CoreStateMachine::syncState stateService play Feb 23 10:32:28 volumio volumio[794]: info: CoreStateMachine::syncState currentStatus play Feb 23 10:32:28 volumio volumio[794]: info: Received an update from plugin. extracting info from payload Feb 23 10:32:28 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 23 10:32:28 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:28 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:28 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:28 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:28 volumio volumio[794]: info: ------------------------------ 85ms Feb 23 10:32:28 volumio volumio[794]: info: ------------------------------ 85ms Feb 23 10:32:38 volumio volumio[794]: info: CoreCommandRouter::volumioNext Feb 23 10:32:38 volumio volumio[794]: info: CoreStateMachine::next Feb 23 10:32:38 volumio volumio[794]: info: CoreStateMachine::stop Feb 23 10:32:38 volumio volumio[794]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 10:32:38 volumio volumio[794]: info: CoreStateMachine::stPlaybackTimer Feb 23 10:32:38 volumio volumio[794]: info: CoreStateMachine::updateTrackBlock Feb 23 10:32:38 volumio volumio[794]: info: CorePlayQueue::getTrackBlock Feb 23 10:32:38 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:38 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:38 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 10:32:38 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:38 volumio volumio[794]: info: CoreStateMachine::serviceStop Feb 23 10:32:38 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:38 volumio volumio[794]: info: CoreCommandRouter::serviceStop Feb 23 10:32:38 volumio volumio[794]: info: [1740306758782] ControllerWebradio::stop Feb 23 10:32:38 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand stop Feb 23 10:32:38 volumio volumio[794]: info: sendMpdCommand stop took 41 milliseconds Feb 23 10:32:38 volumio volumio[794]: info: CoreStateMachine::play index undefined Feb 23 10:32:38 volumio volumio[794]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 10:32:38 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:38 volumio volumio[794]: info: CoreStateMachine::startPlaybackTimer Feb 23 10:32:38 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:38 volumio volumio[794]: info: [1740306758825] ControllerWebradio::clearAddPlayTrack Feb 23 10:32:38 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand stop Feb 23 10:32:38 volumio volumio[794]: info: CoreStateMachine::updateTrackBlock Feb 23 10:32:38 volumio volumio[794]: info: CorePlayQueue::getTrackBlock Feb 23 10:32:38 volumio volumio[794]: info: Feb 23 10:32:38 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:32:38 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:32:38 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:32:38 volumio volumio[794]: info: sendMpdCommand stop took 2 milliseconds Feb 23 10:32:38 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand clear Feb 23 10:32:38 volumio volumio[794]: info: Feb 23 10:32:38 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:32:38 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:32:38 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:32:38 volumio volumio[794]: info: Feb 23 10:32:38 volumio volumio[794]: ---------------------------- MPD announces system playlist update Feb 23 10:32:38 volumio volumio[794]: info: Ignoring MPD Status Update Feb 23 10:32:38 volumio volumio[794]: info: sendMpdCommand status took 3 milliseconds Feb 23 10:32:38 volumio volumio[794]: info: sendMpdCommand clear took 3 milliseconds Feb 23 10:32:38 volumio volumio[794]: info: sendMpdCommand status took 2 milliseconds Feb 23 10:32:38 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:32:38 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 10:32:38 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand load "http://185.33.21.112:80/ccountry_64a" Feb 23 10:32:38 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:32:38 volumio volumio[794]: info: ControllerMpd::pushState Feb 23 10:32:38 volumio volumio[794]: info: CoreCommandRouter::servicePushState Feb 23 10:32:38 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:38 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:38 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:38 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:38 volumio volumio[794]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 23 10:32:38 volumio volumio[794]: info: ------------------------------ 17ms Feb 23 10:32:38 volumio volumio[794]: info: Feb 23 10:32:38 volumio volumio[794]: ---------------------------- MPD announces system playlist update Feb 23 10:32:38 volumio volumio[794]: info: Ignoring MPD Status Update Feb 23 10:32:38 volumio volumio[794]: error: updateQueue error: null Feb 23 10:32:38 volumio volumio[794]: info: ------------------------------ 18ms Feb 23 10:32:38 volumio volumio[794]: info: sendMpdCommand playlistinfo took 16 milliseconds Feb 23 10:32:38 volumio volumio[794]: verbose: ControllerMpd::parseTrackInfo Feb 23 10:32:38 volumio volumio[794]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 23 10:32:38 volumio volumio[794]: info: ------------------------------ 23ms Feb 23 10:32:40 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand add "http://185.33.21.112:80/ccountry_64a" Feb 23 10:32:40 volumio volumio[794]: error: updateQueue error: null Feb 23 10:32:40 volumio volumio[794]: info: ------------------------------ 1467ms Feb 23 10:32:40 volumio volumio[794]: info: Feb 23 10:32:40 volumio volumio[794]: ---------------------------- MPD announces system playlist update Feb 23 10:32:40 volumio volumio[794]: info: Ignoring MPD Status Update Feb 23 10:32:40 volumio volumio[794]: info: sendMpdCommand add "http://185.33.21.112:80/ccountry_64a" took 8 milliseconds Feb 23 10:32:40 volumio volumio[794]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 23 10:32:40 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand play Feb 23 10:32:40 volumio volumio[794]: info: Feb 23 10:32:40 volumio volumio[794]: ---------------------------- MPD announces system playlist update Feb 23 10:32:40 volumio volumio[794]: info: Ignoring MPD Status Update Feb 23 10:32:40 volumio volumio[794]: info: ------------------------------ 6ms Feb 23 10:32:40 volumio volumio[794]: info: sendMpdCommand play took 5 milliseconds Feb 23 10:32:40 volumio volumio[794]: info: ------------------------------ 2ms Feb 23 10:32:41 volumio volumio[794]: info: CoreCommandRouter::volumioNext Feb 23 10:32:41 volumio volumio[794]: info: CoreStateMachine::next Feb 23 10:32:41 volumio volumio[794]: info: ControllerMpd::next Feb 23 10:32:41 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand next Feb 23 10:32:41 volumio volumio[794]: info: sendMpdCommand next took 1 milliseconds Feb 23 10:32:41 volumio volumio[794]: info: Feb 23 10:32:41 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:32:41 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:32:41 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:32:41 volumio volumio[794]: info: Feb 23 10:32:41 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:32:41 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:32:41 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:32:41 volumio volumio[794]: info: sendMpdCommand status took 1 milliseconds Feb 23 10:32:41 volumio volumio[794]: info: sendMpdCommand status took 1 milliseconds Feb 23 10:32:41 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:32:41 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:32:41 volumio volumio[794]: info: ControllerMpd::pushState Feb 23 10:32:41 volumio volumio[794]: info: CoreCommandRouter::servicePushState Feb 23 10:32:41 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:41 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 10:32:41 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:41 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:41 volumio volumio[794]: 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} Feb 23 10:32:41 volumio volumio[794]: verbose: CURRENT POSITION 0 Feb 23 10:32:41 volumio volumio[794]: info: CoreStateMachine::syncState stateService stop Feb 23 10:32:41 volumio volumio[794]: info: CoreStateMachine::syncState currentStatus stop Feb 23 10:32:41 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:41 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:41 volumio volumio[794]: info: No code Feb 23 10:32:41 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:41 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:41 volumio volumio[794]: info: ControllerMpd::pushState Feb 23 10:32:41 volumio volumio[794]: info: CoreCommandRouter::servicePushState Feb 23 10:32:41 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:41 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:41 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:41 volumio volumio[794]: 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} Feb 23 10:32:41 volumio volumio[794]: verbose: CURRENT POSITION 0 Feb 23 10:32:41 volumio volumio[794]: info: CoreStateMachine::syncState stateService stop Feb 23 10:32:41 volumio volumio[794]: info: CoreStateMachine::syncState currentStatus stop Feb 23 10:32:41 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:41 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:41 volumio volumio[794]: info: No code Feb 23 10:32:41 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:41 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:41 volumio volumio[794]: info: ------------------------------ 36ms Feb 23 10:32:41 volumio volumio[794]: info: ------------------------------ 36ms Feb 23 10:32:43 volumio volumio[794]: info: CoreCommandRouter::volumioNext Feb 23 10:32:43 volumio volumio[794]: info: CoreStateMachine::next Feb 23 10:32:43 volumio volumio[794]: info: CoreStateMachine::stop Feb 23 10:32:43 volumio volumio[794]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 10:32:43 volumio volumio[794]: info: CoreStateMachine::play index undefined Feb 23 10:32:43 volumio volumio[794]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 10:32:43 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:43 volumio volumio[794]: info: CoreStateMachine::startPlaybackTimer Feb 23 10:32:43 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:43 volumio volumio[794]: info: [1740306763979] ControllerWebradio::clearAddPlayTrack Feb 23 10:32:43 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand stop Feb 23 10:32:43 volumio volumio[794]: info: CoreStateMachine::updateTrackBlock Feb 23 10:32:43 volumio volumio[794]: info: CorePlayQueue::getTrackBlock Feb 23 10:32:43 volumio volumio[794]: info: sendMpdCommand stop took 1 milliseconds Feb 23 10:32:43 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand clear Feb 23 10:32:43 volumio volumio[794]: info: sendMpdCommand clear took 1 milliseconds Feb 23 10:32:43 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand load "http://185.33.21.112:80/ccountry_64a" Feb 23 10:32:43 volumio volumio[794]: info: Feb 23 10:32:43 volumio volumio[794]: ---------------------------- MPD announces system playlist update Feb 23 10:32:43 volumio volumio[794]: info: Ignoring MPD Status Update Feb 23 10:32:43 volumio volumio[794]: info: Feb 23 10:32:43 volumio volumio[794]: ---------------------------- MPD announces system playlist update Feb 23 10:32:43 volumio volumio[794]: info: Ignoring MPD Status Update Feb 23 10:32:45 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand add "http://185.33.21.112:80/ccountry_64a" Feb 23 10:32:45 volumio volumio[794]: error: updateQueue error: null Feb 23 10:32:45 volumio volumio[794]: error: updateQueue error: null Feb 23 10:32:45 volumio volumio[794]: info: Feb 23 10:32:45 volumio volumio[794]: ---------------------------- MPD announces system playlist update Feb 23 10:32:45 volumio volumio[794]: info: Ignoring MPD Status Update Feb 23 10:32:45 volumio volumio[794]: info: ------------------------------ 1204ms Feb 23 10:32:45 volumio volumio[794]: info: ------------------------------ 1203ms Feb 23 10:32:45 volumio volumio[794]: info: sendMpdCommand add "http://185.33.21.112:80/ccountry_64a" took 4 milliseconds Feb 23 10:32:45 volumio volumio[794]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 23 10:32:45 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand play Feb 23 10:32:45 volumio volumio[794]: info: Feb 23 10:32:45 volumio volumio[794]: ---------------------------- MPD announces system playlist update Feb 23 10:32:45 volumio volumio[794]: info: Ignoring MPD Status Update Feb 23 10:32:45 volumio volumio[794]: info: ------------------------------ 6ms Feb 23 10:32:45 volumio volumio[794]: info: sendMpdCommand play took 4 milliseconds Feb 23 10:32:45 volumio volumio[794]: info: ------------------------------ 3ms Feb 23 10:32:45 volumio volumio[794]: info: CoreCommandRouter::volumioNext Feb 23 10:32:45 volumio volumio[794]: info: CoreStateMachine::next Feb 23 10:32:45 volumio volumio[794]: info: ControllerMpd::next Feb 23 10:32:45 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand next Feb 23 10:32:45 volumio volumio[794]: info: Feb 23 10:32:45 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:32:45 volumio volumio[794]: info: sendMpdCommand next took 1 milliseconds Feb 23 10:32:45 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:32:45 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:32:45 volumio volumio[794]: info: sendMpdCommand status took 1 milliseconds Feb 23 10:32:45 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:32:45 volumio volumio[794]: info: ControllerMpd::pushState Feb 23 10:32:45 volumio volumio[794]: info: CoreCommandRouter::servicePushState Feb 23 10:32:45 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:45 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 10:32:45 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:45 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:45 volumio volumio[794]: 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} Feb 23 10:32:45 volumio volumio[794]: verbose: CURRENT POSITION 0 Feb 23 10:32:45 volumio volumio[794]: info: CoreStateMachine::syncState stateService stop Feb 23 10:32:45 volumio volumio[794]: info: CoreStateMachine::syncState currentStatus stop Feb 23 10:32:45 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:45 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:45 volumio volumio[794]: info: No code Feb 23 10:32:45 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:45 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:45 volumio volumio[794]: info: ------------------------------ 19ms Feb 23 10:32:45 volumio volumio[794]: info: Feb 23 10:32:45 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:32:45 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:32:45 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:32:45 volumio volumio[794]: info: sendMpdCommand status took 0 milliseconds Feb 23 10:32:45 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:32:45 volumio volumio[794]: info: ControllerMpd::pushState Feb 23 10:32:45 volumio volumio[794]: info: CoreCommandRouter::servicePushState Feb 23 10:32:45 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:45 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:45 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:32:45 volumio volumio[794]: 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} Feb 23 10:32:45 volumio volumio[794]: verbose: CURRENT POSITION 0 Feb 23 10:32:45 volumio volumio[794]: info: CoreStateMachine::syncState stateService stop Feb 23 10:32:45 volumio volumio[794]: info: CoreStateMachine::syncState currentStatus stop Feb 23 10:32:45 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:45 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:45 volumio volumio[794]: info: No code Feb 23 10:32:45 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:32:45 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:32:45 volumio volumio[794]: info: ------------------------------ 25ms Feb 23 10:32:57 volumio volumio[794]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 23 10:32:57 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 23 10:32:57 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 10:32:57 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 23 10:32:57 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 10:32:57 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 10:32:57 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 10:32:57 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 10:32:57 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 10:32:57 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 10:32:57 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 10:32:57 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Feb 23 10:32:57 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 23 10:33:14 volumio volumio[794]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 23 10:33:14 volumio volumio[794]: info: CoreStateMachine::ClearQueue Feb 23 10:33:14 volumio volumio[794]: info: CoreStateMachine::stop Feb 23 10:33:14 volumio volumio[794]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 10:33:14 volumio volumio[794]: info: CorePlayQueue::clearPlayQueue Feb 23 10:33:14 volumio volumio[794]: info: CorePlayQueue::saveQueue Feb 23 10:33:14 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:33:14 volumio volumio[794]: info: CoreCommandRouter::volumioPushQueue Feb 23 10:33:14 volumio volumio[794]: info: CoreStateMachine::addQueueItems Feb 23 10:33:14 volumio volumio[794]: info: CorePlayQueue::addQueueItems Feb 23 10:33:14 volumio volumio[794]: info: Adding Item to queue: https://i4.streams.ovh:8352/stream Feb 23 10:33:14 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 23 10:33:14 volumio volumio[794]: info: CorePlayQueue::saveQueue Feb 23 10:33:14 volumio volumio[794]: info: CoreCommandRouter::volumioPushQueue Feb 23 10:33:14 volumio volumio[794]: info: CoreStateMachine::updateTrackBlock Feb 23 10:33:14 volumio volumio[794]: info: CorePlayQueue::getTrackBlock Feb 23 10:33:14 volumio volumio[794]: info: CoreCommandRouter::volumioPlay Feb 23 10:33:14 volumio volumio[794]: info: CoreStateMachine::play index 0 Feb 23 10:33:14 volumio volumio[794]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 10:33:14 volumio volumio[794]: info: CoreStateMachine::stop Feb 23 10:33:14 volumio volumio[794]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 10:33:14 volumio volumio[794]: info: CoreStateMachine::play index undefined Feb 23 10:33:14 volumio volumio[794]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 10:33:14 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:33:14 volumio volumio[794]: info: CoreStateMachine::startPlaybackTimer Feb 23 10:33:14 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:33:14 volumio volumio[794]: info: [1740306794969] ControllerWebradio::clearAddPlayTrack Feb 23 10:33:14 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand stop Feb 23 10:33:14 volumio volumio[794]: info: sendMpdCommand stop took 4 milliseconds Feb 23 10:33:14 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand clear Feb 23 10:33:14 volumio volumio[794]: info: Feb 23 10:33:14 volumio volumio[794]: ---------------------------- MPD announces system playlist update Feb 23 10:33:14 volumio volumio[794]: info: Ignoring MPD Status Update Feb 23 10:33:14 volumio volumio[794]: info: sendMpdCommand clear took 2 milliseconds Feb 23 10:33:14 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand load "https://i4.streams.ovh:8352/stream" Feb 23 10:33:14 volumio volumio[794]: info: Feb 23 10:33:14 volumio volumio[794]: ---------------------------- MPD announces system playlist update Feb 23 10:33:14 volumio volumio[794]: info: Ignoring MPD Status Update Feb 23 10:33:14 volumio volumio[794]: error: updateQueue error: null Feb 23 10:33:14 volumio volumio[794]: info: ------------------------------ 4ms Feb 23 10:33:16 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand add "https://i4.streams.ovh:8352/stream" Feb 23 10:33:16 volumio volumio[794]: error: updateQueue error: null Feb 23 10:33:16 volumio volumio[794]: info: ------------------------------ 1669ms Feb 23 10:33:16 volumio volumio[794]: info: Feb 23 10:33:16 volumio volumio[794]: ---------------------------- MPD announces system playlist update Feb 23 10:33:16 volumio volumio[794]: info: Ignoring MPD Status Update Feb 23 10:33:16 volumio volumio[794]: info: sendMpdCommand add "https://i4.streams.ovh:8352/stream" took 2 milliseconds Feb 23 10:33:16 volumio volumio[794]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 23 10:33:16 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand play Feb 23 10:33:16 volumio volumio[794]: info: Feb 23 10:33:16 volumio volumio[794]: ---------------------------- MPD announces system playlist update Feb 23 10:33:16 volumio volumio[794]: info: Ignoring MPD Status Update Feb 23 10:33:16 volumio volumio[794]: info: ------------------------------ 6ms Feb 23 10:33:16 volumio volumio[794]: info: sendMpdCommand play took 6 milliseconds Feb 23 10:33:16 volumio volumio[794]: info: ------------------------------ 5ms Feb 23 10:33:17 volumio volumio[794]: info: Feb 23 10:33:17 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:33:17 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:33:17 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:33:17 volumio volumio[794]: info: Feb 23 10:33:17 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:33:17 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:33:17 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:33:17 volumio volumio[794]: info: Feb 23 10:33:17 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:33:17 volumio volumio[794]: info: sendMpdCommand status took 20 milliseconds Feb 23 10:33:17 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:33:17 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:33:17 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:33:17 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 10:33:17 volumio volumio[794]: info: Feb 23 10:33:17 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:33:17 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:33:17 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:33:17 volumio volumio[794]: info: sendMpdCommand status took 22 milliseconds Feb 23 10:33:17 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:33:17 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 10:33:17 volumio volumio[794]: info: sendMpdCommand status took 3 milliseconds Feb 23 10:33:17 volumio volumio[794]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 23 10:33:17 volumio volumio[794]: info: sendMpdCommand status took 2 milliseconds Feb 23 10:33:17 volumio volumio[794]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 23 10:33:17 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:33:17 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 10:33:17 volumio volumio[794]: verbose: ControllerMpd::parseTrackInfo Feb 23 10:33:17 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:33:17 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 10:33:17 volumio volumio[794]: verbose: ControllerMpd::parseTrackInfo Feb 23 10:33:17 volumio volumio[794]: info: ControllerMpd::pushState Feb 23 10:33:17 volumio volumio[794]: info: CoreCommandRouter::servicePushState Feb 23 10:33:17 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:33:17 volumio volumio[794]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"https://i4.streams.ovh:8352/stream","trackType":""} Feb 23 10:33:17 volumio volumio[794]: verbose: CURRENT POSITION 0 Feb 23 10:33:17 volumio volumio[794]: info: CoreStateMachine::syncState stateService play Feb 23 10:33:17 volumio volumio[794]: info: CoreStateMachine::syncState currentStatus stop Feb 23 10:33:17 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:33:17 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 10:33:17 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:33:17 volumio volumio[794]: info: ControllerMpd::pushState Feb 23 10:33:17 volumio volumio[794]: info: CoreCommandRouter::servicePushState Feb 23 10:33:17 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:33:17 volumio volumio[794]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"https://i4.streams.ovh:8352/stream","trackType":""} Feb 23 10:33:17 volumio volumio[794]: verbose: CURRENT POSITION 0 Feb 23 10:33:17 volumio volumio[794]: info: CoreStateMachine::syncState stateService play Feb 23 10:33:17 volumio volumio[794]: info: CoreStateMachine::syncState currentStatus play Feb 23 10:33:17 volumio volumio[794]: info: Received an update from plugin. extracting info from payload Feb 23 10:33:17 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:33:17 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:33:17 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 10:33:17 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:33:17 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:33:17 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:33:17 volumio volumio[794]: info: ------------------------------ 55ms Feb 23 10:33:17 volumio volumio[794]: info: ------------------------------ 54ms Feb 23 10:33:18 volumio volumio[794]: info: sendMpdCommand playlistinfo took 30 milliseconds Feb 23 10:33:18 volumio volumio[794]: info: sendMpdCommand playlistinfo took 30 milliseconds Feb 23 10:33:18 volumio volumio[794]: verbose: ControllerMpd::parseTrackInfo Feb 23 10:33:18 volumio volumio[794]: verbose: ControllerMpd::parseTrackInfo Feb 23 10:33:18 volumio volumio[794]: info: ControllerMpd::pushState Feb 23 10:33:18 volumio volumio[794]: info: CoreCommandRouter::servicePushState Feb 23 10:33:18 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:33:18 volumio volumio[794]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"https://i4.streams.ovh:8352/stream","trackType":""} Feb 23 10:33:18 volumio volumio[794]: verbose: CURRENT POSITION 0 Feb 23 10:33:18 volumio volumio[794]: info: CoreStateMachine::syncState stateService play Feb 23 10:33:18 volumio volumio[794]: info: CoreStateMachine::syncState currentStatus play Feb 23 10:33:18 volumio volumio[794]: info: Received an update from plugin. extracting info from payload Feb 23 10:33:18 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:33:18 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:33:18 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 10:33:18 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:33:18 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:33:18 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:33:18 volumio volumio[794]: info: ControllerMpd::pushState Feb 23 10:33:18 volumio volumio[794]: info: CoreCommandRouter::servicePushState Feb 23 10:33:18 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:33:18 volumio volumio[794]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"https://i4.streams.ovh:8352/stream","trackType":""} Feb 23 10:33:18 volumio volumio[794]: verbose: CURRENT POSITION 0 Feb 23 10:33:18 volumio volumio[794]: info: CoreStateMachine::syncState stateService play Feb 23 10:33:18 volumio volumio[794]: info: CoreStateMachine::syncState currentStatus play Feb 23 10:33:18 volumio volumio[794]: info: Received an update from plugin. extracting info from payload Feb 23 10:33:18 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:33:18 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:33:18 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:33:18 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:33:18 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:33:18 volumio volumio[794]: info: ------------------------------ 84ms Feb 23 10:33:18 volumio volumio[794]: info: ------------------------------ 83ms Feb 23 10:33:18 volumio volumio[794]: info: Feb 23 10:33:18 volumio volumio[794]: ---------------------------- MPD announces system playlist update Feb 23 10:33:18 volumio volumio[794]: info: Ignoring MPD Status Update Feb 23 10:33:18 volumio volumio[794]: info: Feb 23 10:33:18 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:33:18 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:33:18 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:33:18 volumio volumio[794]: info: Feb 23 10:33:18 volumio volumio[794]: ---------------------------- MPD announces system playlist update Feb 23 10:33:18 volumio volumio[794]: info: Ignoring MPD Status Update Feb 23 10:33:18 volumio volumio[794]: info: Feb 23 10:33:18 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:33:18 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:33:18 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:33:18 volumio volumio[794]: info: ------------------------------ 4ms Feb 23 10:33:18 volumio volumio[794]: info: sendMpdCommand status took 2 milliseconds Feb 23 10:33:18 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:33:18 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 10:33:18 volumio volumio[794]: info: ------------------------------ 4ms Feb 23 10:33:18 volumio volumio[794]: info: sendMpdCommand status took 3 milliseconds Feb 23 10:33:18 volumio volumio[794]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 23 10:33:18 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:33:18 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 10:33:18 volumio volumio[794]: verbose: ControllerMpd::parseTrackInfo Feb 23 10:33:18 volumio volumio[794]: info: ControllerMpd::pushState Feb 23 10:33:18 volumio volumio[794]: info: CoreCommandRouter::servicePushState Feb 23 10:33:18 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:33:18 volumio volumio[794]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"The Mick Fleetwood Blues Band - Black Crow Blues","artist":"Blues Radio","album":null,"uri":"https://i4.streams.ovh:8352/stream","trackType":""} Feb 23 10:33:18 volumio volumio[794]: verbose: CURRENT POSITION 0 Feb 23 10:33:18 volumio volumio[794]: info: CoreStateMachine::syncState stateService play Feb 23 10:33:18 volumio volumio[794]: info: CoreStateMachine::syncState currentStatus play Feb 23 10:33:18 volumio volumio[794]: info: Received an update from plugin. extracting info from payload Feb 23 10:33:18 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 23 10:33:18 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:33:18 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 10:33:18 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:33:18 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:33:18 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:33:18 volumio volumio[794]: info: ------------------------------ 21ms Feb 23 10:33:18 volumio volumio[794]: info: sendMpdCommand playlistinfo took 15 milliseconds Feb 23 10:33:18 volumio volumio[794]: verbose: ControllerMpd::parseTrackInfo Feb 23 10:33:18 volumio volumio[794]: info: ControllerMpd::pushState Feb 23 10:33:18 volumio volumio[794]: info: CoreCommandRouter::servicePushState Feb 23 10:33:18 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:33:18 volumio volumio[794]: verbose: STATE SERVICE {"status":"play","position":0,"seek":888,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"The Mick Fleetwood Blues Band - Black Crow Blues","artist":"Blues Radio","album":null,"uri":"https://i4.streams.ovh:8352/stream","trackType":""} Feb 23 10:33:18 volumio volumio[794]: verbose: CURRENT POSITION 0 Feb 23 10:33:18 volumio volumio[794]: info: CoreStateMachine::syncState stateService play Feb 23 10:33:18 volumio volumio[794]: info: CoreStateMachine::syncState currentStatus play Feb 23 10:33:18 volumio volumio[794]: info: Received an update from plugin. extracting info from payload Feb 23 10:33:18 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 23 10:33:18 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:33:18 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:33:18 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:33:18 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:33:18 volumio volumio[794]: info: ------------------------------ 35ms Feb 23 10:33:18 volumio volumio[794]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Blues%20Radio/10a8f971-c4e7-4cb4-b2dc-7f3117608250.jpg' Feb 23 10:33:18 volumio volumio[794]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Blues%20Radio/10a8f971-c4e7-4cb4-b2dc-7f3117608250.jpg' Feb 23 10:33:28 volumio volumio[794]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 23 10:33:28 volumio volumio[794]: info: CoreStateMachine::ClearQueue Feb 23 10:33:28 volumio volumio[794]: info: CoreStateMachine::stop Feb 23 10:33:28 volumio volumio[794]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 10:33:28 volumio volumio[794]: info: CoreStateMachine::stPlaybackTimer Feb 23 10:33:28 volumio volumio[794]: info: CoreStateMachine::updateTrackBlock Feb 23 10:33:28 volumio volumio[794]: info: CorePlayQueue::getTrackBlock Feb 23 10:33:28 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:33:28 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:33:28 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 10:33:28 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:33:28 volumio volumio[794]: info: CoreStateMachine::serviceStop Feb 23 10:33:28 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:33:28 volumio volumio[794]: info: CoreCommandRouter::serviceStop Feb 23 10:33:28 volumio volumio[794]: info: [1740306808187] ControllerWebradio::stop Feb 23 10:33:28 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand stop Feb 23 10:33:28 volumio volumio[794]: info: CorePlayQueue::clearPlayQueue Feb 23 10:33:28 volumio volumio[794]: info: CorePlayQueue::saveQueue Feb 23 10:33:28 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:33:28 volumio volumio[794]: info: CoreCommandRouter::volumioPushQueue Feb 23 10:33:28 volumio volumio[794]: info: CoreStateMachine::addQueueItems Feb 23 10:33:28 volumio volumio[794]: info: CorePlayQueue::addQueueItems Feb 23 10:33:28 volumio volumio[794]: info: Adding Item to queue: http://51.89.148.171:8022/stream Feb 23 10:33:28 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 23 10:33:28 volumio volumio[794]: info: CorePlayQueue::saveQueue Feb 23 10:33:28 volumio volumio[794]: info: CoreCommandRouter::volumioPushQueue Feb 23 10:33:28 volumio volumio[794]: info: CoreStateMachine::updateTrackBlock Feb 23 10:33:28 volumio volumio[794]: info: CorePlayQueue::getTrackBlock Feb 23 10:33:28 volumio volumio[794]: info: CoreCommandRouter::volumioPlay Feb 23 10:33:28 volumio volumio[794]: info: CoreStateMachine::play index 0 Feb 23 10:33:28 volumio volumio[794]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 10:33:28 volumio volumio[794]: info: CoreStateMachine::stop Feb 23 10:33:28 volumio volumio[794]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 10:33:28 volumio volumio[794]: info: CoreStateMachine::play index undefined Feb 23 10:33:28 volumio volumio[794]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 23 10:33:28 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:33:28 volumio volumio[794]: info: CoreStateMachine::startPlaybackTimer Feb 23 10:33:28 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:33:28 volumio volumio[794]: info: [1740306808208] ControllerWebradio::clearAddPlayTrack Feb 23 10:33:28 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand stop Feb 23 10:33:28 volumio volumio[794]: info: sendMpdCommand stop took 74 milliseconds Feb 23 10:33:28 volumio volumio[794]: info: Feb 23 10:33:28 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:33:28 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:33:28 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:33:28 volumio volumio[794]: info: sendMpdCommand stop took 58 milliseconds Feb 23 10:33:28 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand clear Feb 23 10:33:28 volumio volumio[794]: info: Feb 23 10:33:28 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:33:28 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:33:28 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:33:28 volumio volumio[794]: info: Feb 23 10:33:28 volumio volumio[794]: ---------------------------- MPD announces system playlist update Feb 23 10:33:28 volumio volumio[794]: info: Ignoring MPD Status Update Feb 23 10:33:28 volumio volumio[794]: info: sendMpdCommand status took 3 milliseconds Feb 23 10:33:28 volumio volumio[794]: info: sendMpdCommand clear took 3 milliseconds Feb 23 10:33:28 volumio volumio[794]: info: sendMpdCommand status took 2 milliseconds Feb 23 10:33:28 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:33:28 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 10:33:28 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand load "http://51.89.148.171:8022/stream" Feb 23 10:33:28 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:33:28 volumio volumio[794]: info: ControllerMpd::pushState Feb 23 10:33:28 volumio volumio[794]: info: CoreCommandRouter::servicePushState Feb 23 10:33:28 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:33:28 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:33:28 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 10:33:28 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:33:28 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:33:28 volumio volumio[794]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 23 10:33:28 volumio volumio[794]: info: ------------------------------ 20ms Feb 23 10:33:28 volumio volumio[794]: info: Feb 23 10:33:28 volumio volumio[794]: ---------------------------- MPD announces system playlist update Feb 23 10:33:28 volumio volumio[794]: info: Ignoring MPD Status Update Feb 23 10:33:28 volumio volumio[794]: error: updateQueue error: null Feb 23 10:33:28 volumio volumio[794]: info: ------------------------------ 21ms Feb 23 10:33:28 volumio volumio[794]: info: sendMpdCommand playlistinfo took 20 milliseconds Feb 23 10:33:28 volumio volumio[794]: verbose: ControllerMpd::parseTrackInfo Feb 23 10:33:28 volumio volumio[794]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 23 10:33:28 volumio volumio[794]: info: ------------------------------ 25ms Feb 23 10:33:30 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand add "http://51.89.148.171:8022/stream" Feb 23 10:33:30 volumio volumio[794]: error: updateQueue error: null Feb 23 10:33:30 volumio volumio[794]: info: ------------------------------ 1787ms Feb 23 10:33:30 volumio volumio[794]: info: Feb 23 10:33:30 volumio volumio[794]: ---------------------------- MPD announces system playlist update Feb 23 10:33:30 volumio volumio[794]: info: Ignoring MPD Status Update Feb 23 10:33:30 volumio volumio[794]: info: sendMpdCommand add "http://51.89.148.171:8022/stream" took 2 milliseconds Feb 23 10:33:30 volumio volumio[794]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 23 10:33:30 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand play Feb 23 10:33:30 volumio volumio[794]: info: Feb 23 10:33:30 volumio volumio[794]: ---------------------------- MPD announces system playlist update Feb 23 10:33:30 volumio volumio[794]: info: Ignoring MPD Status Update Feb 23 10:33:30 volumio volumio[794]: info: ------------------------------ 4ms Feb 23 10:33:30 volumio volumio[794]: info: sendMpdCommand play took 3 milliseconds Feb 23 10:33:30 volumio volumio[794]: info: ------------------------------ 4ms Feb 23 10:33:31 volumio volumio[794]: info: Feb 23 10:33:31 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:33:31 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:33:31 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:33:31 volumio volumio[794]: info: Feb 23 10:33:31 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:33:31 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:33:31 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:33:31 volumio volumio[794]: info: Feb 23 10:33:31 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:33:31 volumio volumio[794]: info: sendMpdCommand status took 8 milliseconds Feb 23 10:33:31 volumio volumio[794]: info: sendMpdCommand status took 7 milliseconds Feb 23 10:33:31 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:33:31 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:33:31 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:33:31 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 10:33:31 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:33:31 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 10:33:31 volumio volumio[794]: info: sendMpdCommand status took 2 milliseconds Feb 23 10:33:31 volumio volumio[794]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 23 10:33:31 volumio volumio[794]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 23 10:33:31 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:33:31 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 10:33:31 volumio volumio[794]: verbose: ControllerMpd::parseTrackInfo Feb 23 10:33:31 volumio volumio[794]: verbose: ControllerMpd::parseTrackInfo Feb 23 10:33:31 volumio volumio[794]: info: ControllerMpd::pushState Feb 23 10:33:31 volumio volumio[794]: info: CoreCommandRouter::servicePushState Feb 23 10:33:31 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:33:31 volumio volumio[794]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://51.89.148.171:8022/stream","trackType":""} Feb 23 10:33:31 volumio volumio[794]: verbose: CURRENT POSITION 0 Feb 23 10:33:31 volumio volumio[794]: info: CoreStateMachine::syncState stateService play Feb 23 10:33:31 volumio volumio[794]: info: CoreStateMachine::syncState currentStatus stop Feb 23 10:33:31 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:33:31 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 10:33:31 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:33:31 volumio volumio[794]: info: ControllerMpd::pushState Feb 23 10:33:31 volumio volumio[794]: info: CoreCommandRouter::servicePushState Feb 23 10:33:31 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:33:31 volumio volumio[794]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://51.89.148.171:8022/stream","trackType":""} Feb 23 10:33:31 volumio volumio[794]: verbose: CURRENT POSITION 0 Feb 23 10:33:31 volumio volumio[794]: info: CoreStateMachine::syncState stateService play Feb 23 10:33:31 volumio volumio[794]: info: CoreStateMachine::syncState currentStatus play Feb 23 10:33:31 volumio volumio[794]: info: Received an update from plugin. extracting info from payload Feb 23 10:33:31 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:33:31 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:33:31 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 10:33:31 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:33:31 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:33:31 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:33:31 volumio volumio[794]: info: ------------------------------ 37ms Feb 23 10:33:31 volumio volumio[794]: info: ------------------------------ 35ms Feb 23 10:33:31 volumio volumio[794]: info: Feb 23 10:33:31 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:33:31 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:33:31 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:33:31 volumio volumio[794]: info: sendMpdCommand playlistinfo took 30 milliseconds Feb 23 10:33:31 volumio volumio[794]: info: sendMpdCommand status took 2 milliseconds Feb 23 10:33:31 volumio volumio[794]: verbose: ControllerMpd::parseTrackInfo Feb 23 10:33:31 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:33:31 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 10:33:31 volumio volumio[794]: info: ControllerMpd::pushState Feb 23 10:33:31 volumio volumio[794]: info: CoreCommandRouter::servicePushState Feb 23 10:33:31 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:33:31 volumio volumio[794]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://51.89.148.171:8022/stream","trackType":""} Feb 23 10:33:31 volumio volumio[794]: verbose: CURRENT POSITION 0 Feb 23 10:33:31 volumio volumio[794]: info: CoreStateMachine::syncState stateService play Feb 23 10:33:31 volumio volumio[794]: info: CoreStateMachine::syncState currentStatus play Feb 23 10:33:31 volumio volumio[794]: info: Received an update from plugin. extracting info from payload Feb 23 10:33:31 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:33:31 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:33:31 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:33:31 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:33:31 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:33:31 volumio volumio[794]: info: ------------------------------ 62ms Feb 23 10:33:31 volumio volumio[794]: info: sendMpdCommand playlistinfo took 33 milliseconds Feb 23 10:33:31 volumio volumio[794]: verbose: ControllerMpd::parseTrackInfo Feb 23 10:33:31 volumio volumio[794]: info: ControllerMpd::pushState Feb 23 10:33:31 volumio volumio[794]: info: CoreCommandRouter::servicePushState Feb 23 10:33:31 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:33:31 volumio volumio[794]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://51.89.148.171:8022/stream","trackType":""} Feb 23 10:33:31 volumio volumio[794]: verbose: CURRENT POSITION 0 Feb 23 10:33:31 volumio volumio[794]: info: CoreStateMachine::syncState stateService play Feb 23 10:33:31 volumio volumio[794]: info: CoreStateMachine::syncState currentStatus play Feb 23 10:33:31 volumio volumio[794]: info: Received an update from plugin. extracting info from payload Feb 23 10:33:31 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:33:31 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:33:31 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:33:31 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:33:31 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:33:31 volumio volumio[794]: info: ------------------------------ 61ms Feb 23 10:33:31 volumio volumio[794]: info: Feb 23 10:33:31 volumio volumio[794]: ---------------------------- MPD announces system playlist update Feb 23 10:33:31 volumio volumio[794]: info: Ignoring MPD Status Update Feb 23 10:33:31 volumio volumio[794]: info: Feb 23 10:33:31 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:33:31 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:33:31 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:33:31 volumio volumio[794]: info: Feb 23 10:33:31 volumio volumio[794]: ---------------------------- MPD announces system playlist update Feb 23 10:33:31 volumio volumio[794]: info: Ignoring MPD Status Update Feb 23 10:33:31 volumio volumio[794]: info: Feb 23 10:33:31 volumio volumio[794]: ---------------------------- MPD announces state update: player Feb 23 10:33:31 volumio volumio[794]: info: ControllerMpd::getState Feb 23 10:33:31 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand status Feb 23 10:33:31 volumio volumio[794]: info: ------------------------------ 4ms Feb 23 10:33:31 volumio volumio[794]: info: sendMpdCommand status took 3 milliseconds Feb 23 10:33:31 volumio volumio[794]: info: ------------------------------ 2ms Feb 23 10:33:31 volumio volumio[794]: info: sendMpdCommand status took 1 milliseconds Feb 23 10:33:31 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:33:31 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 10:33:31 volumio volumio[794]: verbose: ControllerMpd::parseState Feb 23 10:33:31 volumio volumio[794]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 23 10:33:31 volumio volumio[794]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 23 10:33:31 volumio volumio[794]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 23 10:33:31 volumio volumio[794]: verbose: ControllerMpd::parseTrackInfo Feb 23 10:33:31 volumio volumio[794]: verbose: ControllerMpd::parseTrackInfo Feb 23 10:33:31 volumio volumio[794]: info: ControllerMpd::pushState Feb 23 10:33:31 volumio volumio[794]: info: CoreCommandRouter::servicePushState Feb 23 10:33:31 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:33:31 volumio volumio[794]: verbose: STATE SERVICE {"status":"play","position":0,"seek":790,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Meduza - Phone (Trance Wax Remix)","artist":"Dance UK Radio danceradiouk","album":null,"uri":"http://51.89.148.171:8022/stream","trackType":""} Feb 23 10:33:31 volumio volumio[794]: verbose: CURRENT POSITION 0 Feb 23 10:33:31 volumio volumio[794]: info: CoreStateMachine::syncState stateService play Feb 23 10:33:31 volumio volumio[794]: info: CoreStateMachine::syncState currentStatus play Feb 23 10:33:31 volumio volumio[794]: info: Received an update from plugin. extracting info from payload Feb 23 10:33:31 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 23 10:33:31 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:33:31 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 10:33:31 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:33:31 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:33:31 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:33:31 volumio volumio[794]: info: ControllerMpd::pushState Feb 23 10:33:31 volumio volumio[794]: info: CoreCommandRouter::servicePushState Feb 23 10:33:31 volumio volumio[794]: info: CorePlayQueue::getTrack 0 Feb 23 10:33:31 volumio volumio[794]: verbose: STATE SERVICE {"status":"play","position":0,"seek":790,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Meduza - Phone (Trance Wax Remix)","artist":"Dance UK Radio danceradiouk","album":null,"uri":"http://51.89.148.171:8022/stream","trackType":""} Feb 23 10:33:31 volumio volumio[794]: verbose: CURRENT POSITION 0 Feb 23 10:33:31 volumio volumio[794]: info: CoreStateMachine::syncState stateService play Feb 23 10:33:31 volumio volumio[794]: info: CoreStateMachine::syncState currentStatus play Feb 23 10:33:31 volumio volumio[794]: info: Received an update from plugin. extracting info from payload Feb 23 10:33:31 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 23 10:33:31 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:33:31 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:33:31 volumio volumio[794]: info: CoreStateMachine::pushState Feb 23 10:33:31 volumio volumio[794]: info: CoreCommandRouter::volumioPushState Feb 23 10:33:31 volumio volumio[794]: info: ------------------------------ 28ms Feb 23 10:33:31 volumio volumio[794]: info: ------------------------------ 28ms Feb 23 10:33:42 volumio volumio[794]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 23 10:33:42 volumio volumio[794]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 23 10:33:42 volumio volumio[794]: info: Retrieving Cloud Streaming UI Feb 23 10:33:42 volumio volumio[794]: info: Getting Tidal Cloud Configuration Feb 23 10:33:42 volumio volumio[794]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 23 10:33:42 volumio volumio[794]: info: Getting Qobuz Cloud Configuration Feb 23 10:33:42 volumio volumio[794]: info: Asking plugin for UI Config Feb 23 10:33:42 volumio volumio[794]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 23 10:33:42 volumio volumio[794]: info: Getting Spotify Cloud Configuration Feb 23 10:33:42 volumio volumio[794]: info: Asking plugin for UI Config Feb 23 10:33:42 volumio volumio[794]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 23 10:33:42 volumio volumio[794]: info: Saving Spotify Acccount Feb 23 10:33:42 volumio volumio[794]: info: Got Tidal Cloud Configuration Feb 23 10:33:42 volumio volumio[794]: info: Got it Feb 23 10:33:42 volumio volumio[794]: info: Got it Feb 23 10:33:42 volumio volumio[794]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 23 10:33:42 volumio volumio[794]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 23 10:33:42 volumio volumio[794]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Feb 23 10:33:42 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 23 10:33:42 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 23 10:33:42 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 23 10:33:42 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 23 10:33:42 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 10:33:42 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 10:33:42 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 10:33:42 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 10:33:42 volumio volumio[794]: info: CoreCommandRouter::volumioGetBrowseSources Feb 23 10:33:43 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 23 10:33:43 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Feb 23 10:33:49 volumio volumio[794]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 23 10:33:49 volumio volumio[794]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 23 10:33:49 volumio volumio[794]: info: Retrieving Cloud Streaming UI Feb 23 10:33:49 volumio volumio[794]: info: Getting Tidal Cloud Configuration Feb 23 10:33:49 volumio volumio[794]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 23 10:33:49 volumio volumio[794]: info: Getting Qobuz Cloud Configuration Feb 23 10:33:49 volumio volumio[794]: info: Asking plugin for UI Config Feb 23 10:33:49 volumio volumio[794]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 23 10:33:49 volumio volumio[794]: info: Getting Spotify Cloud Configuration Feb 23 10:33:49 volumio volumio[794]: info: Asking plugin for UI Config Feb 23 10:33:49 volumio volumio[794]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 23 10:33:49 volumio volumio[794]: info: Saving Spotify Acccount Feb 23 10:33:49 volumio volumio[794]: info: Got Tidal Cloud Configuration Feb 23 10:33:49 volumio volumio[794]: info: Got it Feb 23 10:33:49 volumio volumio[794]: info: Got it Feb 23 10:33:49 volumio volumio[794]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 23 10:33:49 volumio volumio[794]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 23 10:33:49 volumio volumio[794]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Feb 23 10:33:49 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 23 10:33:49 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 23 10:33:49 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 23 10:33:49 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 23 10:33:49 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 10:33:49 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 10:33:49 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 10:33:49 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 10:33:49 volumio volumio[794]: info: CoreCommandRouter::volumioGetBrowseSources Feb 23 10:33:49 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 23 10:33:49 volumio volumio[794]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Feb 23 10:33:51 volumio volumio[794]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 23 10:33:51 volumio volumio[794]: Error: connect ETIMEDOUT 202.160.130.145:80 Feb 23 10:33:51 volumio volumio[794]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Feb 23 10:33:51 volumio volumio[794]: errno: -110, Feb 23 10:33:51 volumio volumio[794]: code: 'ETIMEDOUT', Feb 23 10:33:51 volumio volumio[794]: syscall: 'connect', Feb 23 10:33:51 volumio volumio[794]: address: '202.160.130.145', Feb 23 10:33:51 volumio volumio[794]: port: 80 Feb 23 10:33:51 volumio volumio[794]: } Feb 23 10:33:51 volumio volumio[794]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 23 10:33:51 volumio sudo[2192]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-23 10:32 Feb 23 10:33:51 volumio sudo[2192]: 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="91e88ea6c5c4ec4f00aff63f7c3a2944b14ec939" VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463" VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7" VOLUMIO_BE_VERSION="85acf7bbbceb3e3dec447156a39a88033f921210" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 30 Sep 2022 11:12:31 AM CEST" VOLUMIO_VERSION="3.378" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="4d8af4ba9bde4fed178dd6b058b1d778"