-- Logs begin at Thu 2026-04-02 02:05:09 BST, end at Fri 2026-04-10 13:24:15 BST. -- Apr 10 13:23:00 ffrolumio volumio[957]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Apr 10 13:23:01 ffrolumio volumio[957]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 10 13:23:01 ffrolumio volumio[957]: info: Received Get System Info Apr 10 13:23:01 ffrolumio volumio[957]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 10 13:23:01 ffrolumio volumio[957]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 10 13:23:01 ffrolumio volumio[957]: info: Discovery: Getting this device information Apr 10 13:23:01 ffrolumio volumio[957]: info: CoreCommandRouter::volumioGetState Apr 10 13:23:01 ffrolumio volumio[957]: info: CorePlayQueue::getTrack 1 Apr 10 13:23:01 ffrolumio volumio[957]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 10 13:23:01 ffrolumio volumio[957]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 10 13:23:02 ffrolumio volumio[957]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 10 13:23:02 ffrolumio volumio[957]: info: CURURI: music-library Apr 10 13:23:02 ffrolumio volumio[957]: info: Preload queue cleared Apr 10 13:23:03 ffrolumio volumio[957]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 10 13:23:03 ffrolumio volumio[957]: info: CURURI: music-library/NAS Apr 10 13:23:03 ffrolumio volumio[957]: info: Preload queue cleared Apr 10 13:23:03 ffrolumio volumio[957]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 10 13:23:03 ffrolumio volumio[957]: info: Received Get System Info Apr 10 13:23:03 ffrolumio volumio[957]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 10 13:23:03 ffrolumio volumio[957]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 10 13:23:03 ffrolumio volumio[957]: info: Discovery: Getting this device information Apr 10 13:23:03 ffrolumio volumio[957]: info: CoreCommandRouter::volumioGetState Apr 10 13:23:03 ffrolumio volumio[957]: info: CorePlayQueue::getTrack 1 Apr 10 13:23:03 ffrolumio volumio[957]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 10 13:23:06 ffrolumio volumio[957]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Apr 10 13:23:06 ffrolumio volumio[957]: verbose: ControllerMpd::sendMpdCommand update Apr 10 13:23:06 ffrolumio volumio[957]: verbose: ControllerMpd::sendMpdCommand status Apr 10 13:23:06 ffrolumio volumio[957]: info: Apr 10 13:23:06 ffrolumio volumio[957]: ---------------------------- MPD announces state update: update Apr 10 13:23:06 ffrolumio volumio[957]: info: sendMpdCommand update took 0 milliseconds Apr 10 13:23:06 ffrolumio volumio[957]: info: ControllerMpd::getState Apr 10 13:23:06 ffrolumio volumio[957]: verbose: ControllerMpd::sendMpdCommand status Apr 10 13:23:06 ffrolumio volumio[957]: info: sendMpdCommand status took 1 milliseconds Apr 10 13:23:06 ffrolumio volumio[957]: info: sendMpdCommand status took 0 milliseconds Apr 10 13:23:06 ffrolumio volumio[957]: verbose: ControllerMpd::parseState Apr 10 13:23:07 ffrolumio volumio[957]: info: Command Router : Notfying DB Updatetrue Apr 10 13:23:07 ffrolumio volumio[957]: verbose: ControllerMpd::parseState Apr 10 13:23:07 ffrolumio volumio[957]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 13:23:07 ffrolumio volumio[957]: verbose: ControllerMpd::sendMpdCommand status Apr 10 13:23:07 ffrolumio volumio[957]: info: Apr 10 13:23:07 ffrolumio volumio[957]: ---------------------------- MPD announces state update: update Apr 10 13:23:07 ffrolumio volumio[957]: info: ControllerMpd::getState Apr 10 13:23:07 ffrolumio volumio[957]: verbose: ControllerMpd::sendMpdCommand status Apr 10 13:23:07 ffrolumio volumio[957]: verbose: ControllerMpd::sendMpdCommand status Apr 10 13:23:07 ffrolumio volumio[957]: info: Apr 10 13:23:07 ffrolumio volumio[957]: ---------------------------- MPD announces state update: update Apr 10 13:23:07 ffrolumio volumio[957]: info: ControllerMpd::getState Apr 10 13:23:07 ffrolumio volumio[957]: verbose: ControllerMpd::sendMpdCommand status Apr 10 13:23:07 ffrolumio volumio[957]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 10 13:23:07 ffrolumio volumio[957]: info: sendMpdCommand status took 1 milliseconds Apr 10 13:23:07 ffrolumio volumio[957]: info: sendMpdCommand status took 0 milliseconds Apr 10 13:23:07 ffrolumio volumio[957]: info: sendMpdCommand status took 0 milliseconds Apr 10 13:23:07 ffrolumio volumio[957]: info: sendMpdCommand status took 0 milliseconds Apr 10 13:23:07 ffrolumio volumio[957]: verbose: ControllerMpd::parseTrackInfo Apr 10 13:23:07 ffrolumio volumio[957]: verbose: ControllerMpd::parseState Apr 10 13:23:07 ffrolumio volumio[957]: info: Command Router : Notfying DB Updatetrue Apr 10 13:23:07 ffrolumio volumio[957]: info: CoreCommandRouter::Close All Modals sent Apr 10 13:23:07 ffrolumio volumio[957]: verbose: ControllerMpd::parseState Apr 10 13:23:07 ffrolumio volumio[957]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 13:23:07 ffrolumio volumio[957]: verbose: ControllerMpd::parseState Apr 10 13:23:07 ffrolumio volumio[957]: info: Command Router : Notfying DB Updatetrue Apr 10 13:23:07 ffrolumio volumio[957]: info: CoreCommandRouter::Close All Modals sent Apr 10 13:23:07 ffrolumio volumio[957]: verbose: ControllerMpd::parseState Apr 10 13:23:07 ffrolumio volumio[957]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 13:23:07 ffrolumio volumio[957]: info: ControllerMpd::pushState Apr 10 13:23:07 ffrolumio volumio[957]: info: CoreCommandRouter::servicePushState Apr 10 13:23:07 ffrolumio volumio[957]: info: CorePlayQueue::getTrack 1 Apr 10 13:23:07 ffrolumio volumio[957]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":134830,"duration":200,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1122 Kbps","isStreaming":false,"title":"All The Wine","artist":"The National","album":"Cherry Tree","uri":"NAS/Flac/The National/2004 - Cherry Tree/02 - All The Wine.flac","trackType":"flac"} Apr 10 13:23:07 ffrolumio volumio[957]: verbose: CURRENT POSITION 1 Apr 10 13:23:07 ffrolumio volumio[957]: info: CoreStateMachine::syncState stateService pause Apr 10 13:23:07 ffrolumio volumio[957]: info: CoreStateMachine::syncState currentStatus pause Apr 10 13:23:07 ffrolumio volumio[957]: info: CoreStateMachine::pushState Apr 10 13:23:07 ffrolumio volumio[957]: info: CorePlayQueue::getTrack 1 Apr 10 13:23:07 ffrolumio volumio[957]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 13:23:07 ffrolumio volumio[957]: info: CoreCommandRouter::volumioPushState Apr 10 13:23:07 ffrolumio volumio[957]: info: CoreStateMachine::stPlaybackTimer Apr 10 13:23:07 ffrolumio volumio[957]: info: ------------------------------ 67ms Apr 10 13:23:07 ffrolumio volumio[957]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 10 13:23:07 ffrolumio volumio[957]: info: sendMpdCommand playlistinfo took 15 milliseconds Apr 10 13:23:07 ffrolumio volumio[957]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 10 13:23:07 ffrolumio volumio[957]: verbose: ControllerMpd::parseTrackInfo Apr 10 13:23:07 ffrolumio volumio[957]: verbose: ControllerMpd::parseTrackInfo Apr 10 13:23:07 ffrolumio volumio[957]: info: ControllerMpd::pushState Apr 10 13:23:07 ffrolumio volumio[957]: info: CoreCommandRouter::servicePushState Apr 10 13:23:07 ffrolumio volumio[957]: info: CorePlayQueue::getTrack 1 Apr 10 13:23:07 ffrolumio volumio[957]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":134830,"duration":200,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1122 Kbps","isStreaming":false,"title":"All The Wine","artist":"The National","album":"Cherry Tree","uri":"NAS/Flac/The National/2004 - Cherry Tree/02 - All The Wine.flac","trackType":"flac"} Apr 10 13:23:07 ffrolumio volumio[957]: verbose: CURRENT POSITION 1 Apr 10 13:23:07 ffrolumio volumio[957]: info: CoreStateMachine::syncState stateService pause Apr 10 13:23:07 ffrolumio volumio[957]: info: CoreStateMachine::syncState currentStatus pause Apr 10 13:23:07 ffrolumio volumio[957]: info: CoreStateMachine::pushState Apr 10 13:23:07 ffrolumio volumio[957]: info: CorePlayQueue::getTrack 1 Apr 10 13:23:07 ffrolumio volumio[957]: info: CoreCommandRouter::volumioPushState Apr 10 13:23:07 ffrolumio volumio[957]: info: CoreStateMachine::stPlaybackTimer Apr 10 13:23:07 ffrolumio volumio[957]: info: ControllerMpd::pushState Apr 10 13:23:07 ffrolumio volumio[957]: info: CoreCommandRouter::servicePushState Apr 10 13:23:07 ffrolumio volumio[957]: info: CorePlayQueue::getTrack 1 Apr 10 13:23:07 ffrolumio volumio[957]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":134830,"duration":200,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1122 Kbps","isStreaming":false,"title":"All The Wine","artist":"The National","album":"Cherry Tree","uri":"NAS/Flac/The National/2004 - Cherry Tree/02 - All The Wine.flac","trackType":"flac"} Apr 10 13:23:07 ffrolumio volumio[957]: verbose: CURRENT POSITION 1 Apr 10 13:23:07 ffrolumio volumio[957]: info: CoreStateMachine::syncState stateService pause Apr 10 13:23:07 ffrolumio volumio[957]: info: CoreStateMachine::syncState currentStatus pause Apr 10 13:23:07 ffrolumio volumio[957]: info: CoreStateMachine::pushState Apr 10 13:23:07 ffrolumio volumio[957]: info: CorePlayQueue::getTrack 1 Apr 10 13:23:07 ffrolumio volumio[957]: info: CoreCommandRouter::volumioPushState Apr 10 13:23:07 ffrolumio volumio[957]: info: CoreStateMachine::stPlaybackTimer Apr 10 13:23:07 ffrolumio volumio[957]: info: ------------------------------ 29ms Apr 10 13:23:07 ffrolumio volumio[957]: info: ------------------------------ 28ms Apr 10 13:23:07 ffrolumio volumio[957]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 10 13:23:07 ffrolumio volumio[957]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 10 13:23:09 ffrolumio volumio[957]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 10 13:23:12 ffrolumio volumio[957]: info: MPD Database updated - AlbumList cache refreshed Apr 10 13:23:12 ffrolumio volumio[957]: info: Apr 10 13:23:12 ffrolumio volumio[957]: ---------------------------- MPD announces state update: database Apr 10 13:23:12 ffrolumio volumio[957]: verbose: ControllerMpd::sendMpdCommand status Apr 10 13:23:12 ffrolumio volumio[957]: info: Apr 10 13:23:12 ffrolumio volumio[957]: ---------------------------- MPD announces state update: update Apr 10 13:23:12 ffrolumio volumio[957]: info: ControllerMpd::getState Apr 10 13:23:12 ffrolumio volumio[957]: verbose: ControllerMpd::sendMpdCommand status Apr 10 13:23:12 ffrolumio volumio[957]: info: ControllerMpd::getState Apr 10 13:23:12 ffrolumio volumio[957]: verbose: ControllerMpd::sendMpdCommand status Apr 10 13:23:12 ffrolumio volumio[957]: info: MPD Database updated - AlbumList cache refreshed Apr 10 13:23:12 ffrolumio volumio[957]: info: Apr 10 13:23:12 ffrolumio volumio[957]: ---------------------------- MPD announces state update: database Apr 10 13:23:12 ffrolumio volumio[957]: verbose: ControllerMpd::sendMpdCommand status Apr 10 13:23:12 ffrolumio volumio[957]: info: Apr 10 13:23:12 ffrolumio volumio[957]: ---------------------------- MPD announces state update: update Apr 10 13:23:12 ffrolumio volumio[957]: info: ControllerMpd::getState Apr 10 13:23:12 ffrolumio volumio[957]: verbose: ControllerMpd::sendMpdCommand status Apr 10 13:23:12 ffrolumio volumio[957]: info: ControllerMpd::getState Apr 10 13:23:12 ffrolumio volumio[957]: verbose: ControllerMpd::sendMpdCommand status Apr 10 13:23:12 ffrolumio volumio[957]: info: MPD Database updated - AlbumList cache refreshed Apr 10 13:23:12 ffrolumio volumio[957]: info: Apr 10 13:23:12 ffrolumio volumio[957]: ---------------------------- MPD announces state update: database Apr 10 13:23:12 ffrolumio volumio[957]: verbose: ControllerMpd::sendMpdCommand status Apr 10 13:23:12 ffrolumio volumio[957]: info: Apr 10 13:23:12 ffrolumio volumio[957]: ---------------------------- MPD announces state update: update Apr 10 13:23:12 ffrolumio volumio[957]: info: ControllerMpd::getState Apr 10 13:23:12 ffrolumio volumio[957]: verbose: ControllerMpd::sendMpdCommand status Apr 10 13:23:12 ffrolumio volumio[957]: info: ControllerMpd::getState Apr 10 13:23:12 ffrolumio volumio[957]: verbose: ControllerMpd::sendMpdCommand status Apr 10 13:23:17 ffrolumio volumio[957]: info: sendMpdCommand status took 4852 milliseconds Apr 10 13:23:17 ffrolumio volumio[957]: info: sendMpdCommand status took 4852 milliseconds Apr 10 13:23:17 ffrolumio volumio[957]: info: sendMpdCommand status took 4853 milliseconds Apr 10 13:23:17 ffrolumio volumio[957]: verbose: ControllerMpd::parseState Apr 10 13:23:17 ffrolumio volumio[957]: info: Command Router : Notfying DB Updatefalse Apr 10 13:23:17 ffrolumio volumio[957]: info: CoreCommandRouter::Close All Modals sent Apr 10 13:23:17 ffrolumio volumio[957]: verbose: ControllerMpd::parseState Apr 10 13:23:17 ffrolumio volumio[957]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 13:23:17 ffrolumio volumio[957]: verbose: ControllerMpd::parseState Apr 10 13:23:17 ffrolumio volumio[957]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 13:23:17 ffrolumio volumio[957]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 10 13:23:17 ffrolumio volumio[957]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 10 13:23:17 ffrolumio volumio[957]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 10 13:23:17 ffrolumio volumio[957]: info: Received Get System Version Apr 10 13:23:17 ffrolumio volumio[957]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 10 13:23:17 ffrolumio volumio[957]: info: Received Get System Info Apr 10 13:23:17 ffrolumio volumio[957]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 10 13:23:17 ffrolumio volumio[957]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 10 13:23:17 ffrolumio volumio[957]: info: Discovery: Getting this device information Apr 10 13:23:17 ffrolumio volumio[957]: info: CoreCommandRouter::volumioGetState Apr 10 13:23:17 ffrolumio volumio[957]: info: CorePlayQueue::getTrack 1 Apr 10 13:23:17 ffrolumio volumio[957]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 10 13:23:22 ffrolumio volumio[957]: info: sendMpdCommand status took 9148 milliseconds Apr 10 13:23:22 ffrolumio volumio[957]: info: sendMpdCommand status took 9148 milliseconds Apr 10 13:23:22 ffrolumio volumio[957]: verbose: ControllerMpd::parseState Apr 10 13:23:22 ffrolumio volumio[957]: info: Command Router : Notfying DB Updatefalse Apr 10 13:23:22 ffrolumio volumio[957]: info: CoreCommandRouter::Close All Modals sent Apr 10 13:23:22 ffrolumio volumio[957]: verbose: ControllerMpd::parseState Apr 10 13:23:22 ffrolumio volumio[957]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 13:23:22 ffrolumio volumio[957]: verbose: ControllerMpd::parseState Apr 10 13:23:22 ffrolumio volumio[957]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 13:23:26 ffrolumio volumio[957]: info: sendMpdCommand status took 13472 milliseconds Apr 10 13:23:26 ffrolumio volumio[957]: info: sendMpdCommand status took 13473 milliseconds Apr 10 13:23:26 ffrolumio volumio[957]: verbose: ControllerMpd::parseState Apr 10 13:23:26 ffrolumio volumio[957]: info: Command Router : Notfying DB Updatefalse Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreCommandRouter::Close All Modals sent Apr 10 13:23:26 ffrolumio volumio[957]: verbose: ControllerMpd::parseState Apr 10 13:23:26 ffrolumio volumio[957]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 13:23:26 ffrolumio volumio[957]: verbose: ControllerMpd::parseState Apr 10 13:23:26 ffrolumio volumio[957]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 13:23:26 ffrolumio volumio[957]: info: sendMpdCommand playlistinfo took 8618 milliseconds Apr 10 13:23:26 ffrolumio volumio[957]: info: sendMpdCommand playlistinfo took 8618 milliseconds Apr 10 13:23:26 ffrolumio volumio[957]: verbose: ControllerMpd::parseTrackInfo Apr 10 13:23:26 ffrolumio volumio[957]: verbose: ControllerMpd::parseTrackInfo Apr 10 13:23:26 ffrolumio volumio[957]: info: ControllerMpd::pushState Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreCommandRouter::servicePushState Apr 10 13:23:26 ffrolumio volumio[957]: info: CorePlayQueue::getTrack 1 Apr 10 13:23:26 ffrolumio volumio[957]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":134830,"duration":200,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1122 Kbps","isStreaming":false,"title":"All The Wine","artist":"The National","album":"Cherry Tree","uri":"NAS/Flac/The National/2004 - Cherry Tree/02 - All The Wine.flac","trackType":"flac"} Apr 10 13:23:26 ffrolumio volumio[957]: verbose: CURRENT POSITION 1 Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreStateMachine::syncState stateService pause Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreStateMachine::syncState currentStatus pause Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreStateMachine::pushState Apr 10 13:23:26 ffrolumio volumio[957]: info: CorePlayQueue::getTrack 1 Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreCommandRouter::volumioPushState Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreStateMachine::stPlaybackTimer Apr 10 13:23:26 ffrolumio volumio[957]: info: ControllerMpd::pushState Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreCommandRouter::servicePushState Apr 10 13:23:26 ffrolumio volumio[957]: info: CorePlayQueue::getTrack 1 Apr 10 13:23:26 ffrolumio volumio[957]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":134830,"duration":200,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1122 Kbps","isStreaming":false,"title":"All The Wine","artist":"The National","album":"Cherry Tree","uri":"NAS/Flac/The National/2004 - Cherry Tree/02 - All The Wine.flac","trackType":"flac"} Apr 10 13:23:26 ffrolumio volumio[957]: verbose: CURRENT POSITION 1 Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreStateMachine::syncState stateService pause Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreStateMachine::syncState currentStatus pause Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreStateMachine::pushState Apr 10 13:23:26 ffrolumio volumio[957]: info: CorePlayQueue::getTrack 1 Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreCommandRouter::volumioPushState Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreStateMachine::stPlaybackTimer Apr 10 13:23:26 ffrolumio volumio[957]: info: ------------------------------ 13515ms Apr 10 13:23:26 ffrolumio volumio[957]: info: ------------------------------ 13515ms Apr 10 13:23:26 ffrolumio volumio[957]: info: sendMpdCommand playlistinfo took 4320 milliseconds Apr 10 13:23:26 ffrolumio volumio[957]: info: sendMpdCommand playlistinfo took 4320 milliseconds Apr 10 13:23:26 ffrolumio volumio[957]: verbose: ControllerMpd::parseTrackInfo Apr 10 13:23:26 ffrolumio volumio[957]: verbose: ControllerMpd::parseTrackInfo Apr 10 13:23:26 ffrolumio volumio[957]: info: ControllerMpd::pushState Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreCommandRouter::servicePushState Apr 10 13:23:26 ffrolumio volumio[957]: info: CorePlayQueue::getTrack 1 Apr 10 13:23:26 ffrolumio volumio[957]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":134830,"duration":200,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1122 Kbps","isStreaming":false,"title":"All The Wine","artist":"The National","album":"Cherry Tree","uri":"NAS/Flac/The National/2004 - Cherry Tree/02 - All The Wine.flac","trackType":"flac"} Apr 10 13:23:26 ffrolumio volumio[957]: verbose: CURRENT POSITION 1 Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreStateMachine::syncState stateService pause Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreStateMachine::syncState currentStatus pause Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreStateMachine::pushState Apr 10 13:23:26 ffrolumio volumio[957]: info: CorePlayQueue::getTrack 1 Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreCommandRouter::volumioPushState Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreStateMachine::stPlaybackTimer Apr 10 13:23:26 ffrolumio volumio[957]: info: ControllerMpd::pushState Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreCommandRouter::servicePushState Apr 10 13:23:26 ffrolumio volumio[957]: info: CorePlayQueue::getTrack 1 Apr 10 13:23:26 ffrolumio volumio[957]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":134830,"duration":200,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1122 Kbps","isStreaming":false,"title":"All The Wine","artist":"The National","album":"Cherry Tree","uri":"NAS/Flac/The National/2004 - Cherry Tree/02 - All The Wine.flac","trackType":"flac"} Apr 10 13:23:26 ffrolumio volumio[957]: verbose: CURRENT POSITION 1 Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreStateMachine::syncState stateService pause Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreStateMachine::syncState currentStatus pause Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreStateMachine::pushState Apr 10 13:23:26 ffrolumio volumio[957]: info: CorePlayQueue::getTrack 1 Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreCommandRouter::volumioPushState Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreStateMachine::stPlaybackTimer Apr 10 13:23:26 ffrolumio volumio[957]: info: ------------------------------ 13519ms Apr 10 13:23:26 ffrolumio volumio[957]: info: ------------------------------ 13519ms Apr 10 13:23:26 ffrolumio volumio[957]: info: sendMpdCommand playlistinfo took 16 milliseconds Apr 10 13:23:26 ffrolumio volumio[957]: info: sendMpdCommand playlistinfo took 16 milliseconds Apr 10 13:23:26 ffrolumio volumio[957]: verbose: ControllerMpd::parseTrackInfo Apr 10 13:23:26 ffrolumio volumio[957]: verbose: ControllerMpd::parseTrackInfo Apr 10 13:23:26 ffrolumio volumio[957]: info: ControllerMpd::pushState Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreCommandRouter::servicePushState Apr 10 13:23:26 ffrolumio volumio[957]: info: CorePlayQueue::getTrack 1 Apr 10 13:23:26 ffrolumio volumio[957]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":134830,"duration":200,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1122 Kbps","isStreaming":false,"title":"All The Wine","artist":"The National","album":"Cherry Tree","uri":"NAS/Flac/The National/2004 - Cherry Tree/02 - All The Wine.flac","trackType":"flac"} Apr 10 13:23:26 ffrolumio volumio[957]: verbose: CURRENT POSITION 1 Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreStateMachine::syncState stateService pause Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreStateMachine::syncState currentStatus pause Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreStateMachine::pushState Apr 10 13:23:26 ffrolumio volumio[957]: info: CorePlayQueue::getTrack 1 Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreCommandRouter::volumioPushState Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreStateMachine::stPlaybackTimer Apr 10 13:23:26 ffrolumio volumio[957]: info: ControllerMpd::pushState Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreCommandRouter::servicePushState Apr 10 13:23:26 ffrolumio volumio[957]: info: CorePlayQueue::getTrack 1 Apr 10 13:23:26 ffrolumio volumio[957]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":134830,"duration":200,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1122 Kbps","isStreaming":false,"title":"All The Wine","artist":"The National","album":"Cherry Tree","uri":"NAS/Flac/The National/2004 - Cherry Tree/02 - All The Wine.flac","trackType":"flac"} Apr 10 13:23:26 ffrolumio volumio[957]: verbose: CURRENT POSITION 1 Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreStateMachine::syncState stateService pause Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreStateMachine::syncState currentStatus pause Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreStateMachine::pushState Apr 10 13:23:26 ffrolumio volumio[957]: info: CorePlayQueue::getTrack 1 Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreCommandRouter::volumioPushState Apr 10 13:23:26 ffrolumio volumio[957]: info: CoreStateMachine::stPlaybackTimer Apr 10 13:23:26 ffrolumio volumio[957]: info: ------------------------------ 13524ms Apr 10 13:23:26 ffrolumio volumio[957]: info: ------------------------------ 13524ms Apr 10 13:23:26 ffrolumio volumio[957]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 10 13:23:26 ffrolumio volumio[957]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 10 13:23:26 ffrolumio volumio[957]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 10 13:23:26 ffrolumio volumio[957]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 10 13:23:26 ffrolumio volumio[957]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 10 13:23:26 ffrolumio volumio[957]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 10 13:23:34 ffrolumio go-librespot[25438]: time="2026-04-10T13:23:34+01:00" level=trace msg="received accesspoint ping" Apr 10 13:23:34 ffrolumio go-librespot[25438]: time="2026-04-10T13:23:34+01:00" level=trace msg="received accesspoint pong ack" Apr 10 13:24:06 ffrolumio volumio[957]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 10 13:24:06 ffrolumio volumio[957]: info: CURURI: music-library Apr 10 13:24:06 ffrolumio volumio[957]: info: Preload queue cleared Apr 10 13:24:08 ffrolumio volumio[957]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 10 13:24:08 ffrolumio volumio[957]: info: CURURI: artists:// Apr 10 13:24:09 ffrolumio volumio[957]: info: Preload queue cleared Apr 10 13:24:15 ffrolumio volumio[957]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 10 13:24:15 ffrolumio volumio[957]: Error: connect ECONNREFUSED 158.69.210.98:443 Apr 10 13:24:15 ffrolumio volumio[957]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Apr 10 13:24:15 ffrolumio volumio[957]: errno: -111, Apr 10 13:24:15 ffrolumio volumio[957]: code: 'ECONNREFUSED', Apr 10 13:24:15 ffrolumio volumio[957]: syscall: 'connect', Apr 10 13:24:15 ffrolumio volumio[957]: address: '158.69.210.98', Apr 10 13:24:15 ffrolumio volumio[957]: port: 443 Apr 10 13:24:15 ffrolumio volumio[957]: } Apr 10 13:24:15 ffrolumio volumio[957]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 10 13:24:15 ffrolumio sudo[10236]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-04-10 13:23 Apr 10 13:24:15 ffrolumio sudo[10236]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"