Dec 25 13:35:00 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Dec 25 13:35:00 volumio volumio[1165]: info: CURURI: artists://
Dec 25 13:35:00 volumio volumio[1165]: info: Preload queue cleared
Dec 25 13:35:05 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Dec 25 13:35:05 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:35:05 volumio volumio[1165]: info: Listing playlists
Dec 25 13:35:05 volumio volumio[1165]: info: Listing playlists
Dec 25 13:35:08 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Dec 25 13:35:08 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:35:12 volumio volumio[1165]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 25 13:35:12 volumio volumio[1165]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 25 13:35:12 volumio volumio[1165]: info: Retrieving Cloud Streaming UI
Dec 25 13:35:12 volumio volumio[1165]: info: Getting Tidal Cloud Configuration
Dec 25 13:35:12 volumio volumio[1165]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 25 13:35:12 volumio volumio[1165]: info: Getting Qobuz Cloud Configuration
Dec 25 13:35:12 volumio volumio[1165]: info: Asking plugin for UI Config
Dec 25 13:35:12 volumio volumio[1165]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 25 13:35:12 volumio volumio[1165]: info: Getting Spotify Cloud Configuration
Dec 25 13:35:12 volumio volumio[1165]: info: Asking plugin for UI Config
Dec 25 13:35:12 volumio volumio[1165]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 25 13:35:12 volumio volumio[1165]: info: Saving Spotify Acccount
Dec 25 13:35:12 volumio volumio[1165]: info: Got Tidal Cloud Configuration
Dec 25 13:35:12 volumio volumio[1165]: info: Got it
Dec 25 13:35:12 volumio volumio[1165]: info: Got it
Dec 25 13:35:12 volumio volumio[1165]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Dec 25 13:35:12 volumio volumio[1165]: info: CoreCommandRouter::getUIConfigOnPlugin
Dec 25 13:35:12 volumio volumio[1165]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave')
Dec 25 13:35:12 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Dec 25 13:35:12 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Dec 25 13:35:12 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Dec 25 13:35:12 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Dec 25 13:35:12 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 25 13:35:12 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 25 13:35:12 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 25 13:35:12 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 25 13:35:12 volumio volumio[1165]: info: CoreCommandRouter::volumioGetBrowseSources
Dec 25 13:35:12 volumio volumio[1165]: info: CoreCommandRouter::volumioGetBrowseSources
Dec 25 13:35:12 volumio volumio[1165]: info: CoreCommandRouter::volumioGetBrowseSources
Dec 25 13:35:12 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 25 13:35:12 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Dec 25 13:35:14 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb
Dec 25 13:35:14 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand update
Dec 25 13:35:14 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand status
Dec 25 13:35:14 volumio volumio[1165]: info:
Dec 25 13:35:14 volumio volumio[1165]: ---------------------------- MPD announces state update: update
Dec 25 13:35:14 volumio volumio[1165]: info: sendMpdCommand update took 2 milliseconds
Dec 25 13:35:14 volumio volumio[1165]: info: ControllerMpd::getState
Dec 25 13:35:14 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand status
Dec 25 13:35:14 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand status
Dec 25 13:35:14 volumio volumio[1165]: info:
Dec 25 13:35:14 volumio volumio[1165]: ---------------------------- MPD announces state update: update
Dec 25 13:35:14 volumio volumio[1165]: info: ControllerMpd::getState
Dec 25 13:35:14 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand status
Dec 25 13:35:14 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand status
Dec 25 13:35:14 volumio volumio[1165]: info:
Dec 25 13:35:14 volumio volumio[1165]: ---------------------------- MPD announces state update: update
Dec 25 13:35:14 volumio volumio[1165]: info: ControllerMpd::getState
Dec 25 13:35:14 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand status
Dec 25 13:35:14 volumio volumio[1165]: info: sendMpdCommand status took 6 milliseconds
Dec 25 13:35:14 volumio volumio[1165]: info: sendMpdCommand status took 4 milliseconds
Dec 25 13:35:14 volumio volumio[1165]: info: sendMpdCommand status took 3 milliseconds
Dec 25 13:35:14 volumio volumio[1165]: info: sendMpdCommand status took 2 milliseconds
Dec 25 13:35:14 volumio volumio[1165]: info: sendMpdCommand status took 2 milliseconds
Dec 25 13:35:14 volumio volumio[1165]: info: sendMpdCommand status took 2 milliseconds
Dec 25 13:35:14 volumio volumio[1165]: verbose: ControllerMpd::parseState
Dec 25 13:35:14 volumio volumio[1165]: info: Command Router : Notfying DB Updatetrue
Dec 25 13:35:14 volumio volumio[1165]: info: CoreCommandRouter::Close All Modals sent
Dec 25 13:35:14 volumio volumio[1165]: verbose: ControllerMpd::parseState
Dec 25 13:35:14 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 25 13:35:14 volumio volumio[1165]: verbose: ControllerMpd::parseState
Dec 25 13:35:14 volumio volumio[1165]: info: Command Router : Notfying DB Updatetrue
Dec 25 13:35:14 volumio volumio[1165]: info: CoreCommandRouter::Close All Modals sent
Dec 25 13:35:14 volumio volumio[1165]: verbose: ControllerMpd::parseState
Dec 25 13:35:14 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 25 13:35:14 volumio volumio[1165]: verbose: ControllerMpd::parseState
Dec 25 13:35:14 volumio volumio[1165]: info: Command Router : Notfying DB Updatetrue
Dec 25 13:35:14 volumio volumio[1165]: info: CoreCommandRouter::Close All Modals sent
Dec 25 13:35:14 volumio volumio[1165]: verbose: ControllerMpd::parseState
Dec 25 13:35:14 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 25 13:35:14 volumio volumio[1165]: info: sendMpdCommand playlistinfo took 28 milliseconds
Dec 25 13:35:14 volumio volumio[1165]: info: sendMpdCommand playlistinfo took 17 milliseconds
Dec 25 13:35:14 volumio volumio[1165]: info: sendMpdCommand playlistinfo took 5 milliseconds
Dec 25 13:35:14 volumio volumio[1165]: verbose: ControllerMpd::parseTrackInfo
Dec 25 13:35:14 volumio volumio[1165]: verbose: ControllerMpd::parseTrackInfo
Dec 25 13:35:14 volumio volumio[1165]: verbose: ControllerMpd::parseTrackInfo
Dec 25 13:35:14 volumio volumio[1165]: info: ControllerMpd::pushState
Dec 25 13:35:14 volumio volumio[1165]: info: CoreCommandRouter::servicePushState
Dec 25 13:35:14 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:35:14 volumio volumio[1165]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":182368,"duration":251,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"2717 Kbps","isStreaming":false,"title":"I’ll Be Home for Christmas","artist":"Norah Jones","album":"I Dream of Christmas","uri":"NAS/Music/Norah Jones/I Dream Of Christmas/15-norah_jones-ill_be_home_for_christmas.flac","trackType":"flac"}
Dec 25 13:35:14 volumio volumio[1165]: verbose: CURRENT POSITION 413
Dec 25 13:35:14 volumio volumio[1165]: info: CoreStateMachine::syncState stateService pause
Dec 25 13:35:14 volumio volumio[1165]: info: CoreStateMachine::syncState currentStatus pause
Dec 25 13:35:14 volumio volumio[1165]: info: CoreStateMachine::pushState
Dec 25 13:35:14 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:35:14 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 25 13:35:14 volumio volumio[1165]: info: CoreCommandRouter::volumioPushState
Dec 25 13:35:14 volumio volumio[1165]: info: CoreStateMachine::stPlaybackTimer
Dec 25 13:35:14 volumio volumio[1165]: info: ControllerMpd::pushState
Dec 25 13:35:14 volumio volumio[1165]: info: CoreCommandRouter::servicePushState
Dec 25 13:35:14 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:35:14 volumio volumio[1165]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":182368,"duration":251,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"2717 Kbps","isStreaming":false,"title":"I’ll Be Home for Christmas","artist":"Norah Jones","album":"I Dream of Christmas","uri":"NAS/Music/Norah Jones/I Dream Of Christmas/15-norah_jones-ill_be_home_for_christmas.flac","trackType":"flac"}
Dec 25 13:35:14 volumio volumio[1165]: verbose: CURRENT POSITION 413
Dec 25 13:35:14 volumio volumio[1165]: info: CoreStateMachine::syncState stateService pause
Dec 25 13:35:14 volumio volumio[1165]: info: CoreStateMachine::syncState currentStatus pause
Dec 25 13:35:14 volumio volumio[1165]: info: CoreStateMachine::pushState
Dec 25 13:35:14 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:35:14 volumio volumio[1165]: info: CoreCommandRouter::volumioPushState
Dec 25 13:35:14 volumio volumio[1165]: info: CoreStateMachine::stPlaybackTimer
Dec 25 13:35:14 volumio volumio[1165]: info: ControllerMpd::pushState
Dec 25 13:35:14 volumio volumio[1165]: info: CoreCommandRouter::servicePushState
Dec 25 13:35:14 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:35:14 volumio volumio[1165]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":182368,"duration":251,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"2717 Kbps","isStreaming":false,"title":"I’ll Be Home for Christmas","artist":"Norah Jones","album":"I Dream of Christmas","uri":"NAS/Music/Norah Jones/I Dream Of Christmas/15-norah_jones-ill_be_home_for_christmas.flac","trackType":"flac"}
Dec 25 13:35:14 volumio volumio[1165]: verbose: CURRENT POSITION 413
Dec 25 13:35:14 volumio volumio[1165]: info: CoreStateMachine::syncState stateService pause
Dec 25 13:35:14 volumio volumio[1165]: info: CoreStateMachine::syncState currentStatus pause
Dec 25 13:35:14 volumio volumio[1165]: info: CoreStateMachine::pushState
Dec 25 13:35:14 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:35:14 volumio volumio[1165]: info: CoreCommandRouter::volumioPushState
Dec 25 13:35:14 volumio volumio[1165]: info: CoreStateMachine::stPlaybackTimer
Dec 25 13:35:14 volumio volumio[1165]: info: ------------------------------ 83ms
Dec 25 13:35:14 volumio volumio[1165]: info: ------------------------------ 81ms
Dec 25 13:35:14 volumio volumio[1165]: info: ------------------------------ 80ms
Dec 25 13:35:15 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Dec 25 13:35:15 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:35:16 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 25 13:35:20 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 25 13:35:24 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 25 13:35:25 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Dec 25 13:35:25 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:35:25 volumio volumio[1165]: info: Listing playlists
Dec 25 13:35:25 volumio volumio[1165]: info: Listing playlists
Dec 25 13:35:28 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 25 13:35:33 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 25 13:35:35 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Dec 25 13:35:35 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:35:35 volumio volumio[1165]: info: MPD Database updated - AlbumList cache refreshed
Dec 25 13:35:35 volumio volumio[1165]: info:
Dec 25 13:35:35 volumio volumio[1165]: ---------------------------- MPD announces state update: database
Dec 25 13:35:35 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand status
Dec 25 13:35:35 volumio volumio[1165]: info:
Dec 25 13:35:35 volumio volumio[1165]: ---------------------------- MPD announces state update: update
Dec 25 13:35:35 volumio volumio[1165]: info: ControllerMpd::getState
Dec 25 13:35:35 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand status
Dec 25 13:35:35 volumio volumio[1165]: info: ControllerMpd::getState
Dec 25 13:35:35 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand status
Dec 25 13:35:35 volumio volumio[1165]: info: MPD Database updated - AlbumList cache refreshed
Dec 25 13:35:35 volumio volumio[1165]: info:
Dec 25 13:35:35 volumio volumio[1165]: ---------------------------- MPD announces state update: database
Dec 25 13:35:35 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand status
Dec 25 13:35:35 volumio volumio[1165]: info:
Dec 25 13:35:35 volumio volumio[1165]: ---------------------------- MPD announces state update: update
Dec 25 13:35:35 volumio volumio[1165]: info: ControllerMpd::getState
Dec 25 13:35:35 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand status
Dec 25 13:35:35 volumio volumio[1165]: info: ControllerMpd::getState
Dec 25 13:35:35 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand status
Dec 25 13:35:35 volumio volumio[1165]: info: MPD Database updated - AlbumList cache refreshed
Dec 25 13:35:35 volumio volumio[1165]: info:
Dec 25 13:35:35 volumio volumio[1165]: ---------------------------- MPD announces state update: database
Dec 25 13:35:35 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand status
Dec 25 13:35:35 volumio volumio[1165]: info:
Dec 25 13:35:35 volumio volumio[1165]: ---------------------------- MPD announces state update: update
Dec 25 13:35:35 volumio volumio[1165]: info: ControllerMpd::getState
Dec 25 13:35:35 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand status
Dec 25 13:35:35 volumio volumio[1165]: info: ControllerMpd::getState
Dec 25 13:35:35 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand status
Dec 25 13:35:37 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 25 13:35:43 volumio volumio[1165]: info: sendMpdCommand status took 7928 milliseconds
Dec 25 13:35:43 volumio volumio[1165]: info: sendMpdCommand status took 7927 milliseconds
Dec 25 13:35:43 volumio volumio[1165]: info: sendMpdCommand status took 7927 milliseconds
Dec 25 13:35:43 volumio volumio[1165]: verbose: ControllerMpd::parseState
Dec 25 13:35:43 volumio volumio[1165]: info: Command Router : Notfying DB Updatefalse
Dec 25 13:35:43 volumio volumio[1165]: info: CoreCommandRouter::Close All Modals sent
Dec 25 13:35:43 volumio volumio[1165]: verbose: ControllerMpd::parseState
Dec 25 13:35:43 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 25 13:35:43 volumio volumio[1165]: verbose: ControllerMpd::parseState
Dec 25 13:35:43 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 25 13:35:50 volumio volumio[1165]: info: sendMpdCommand status took 14678 milliseconds
Dec 25 13:35:50 volumio volumio[1165]: info: sendMpdCommand status took 14679 milliseconds
Dec 25 13:35:50 volumio volumio[1165]: info: sendMpdCommand status took 14678 milliseconds
Dec 25 13:35:50 volumio volumio[1165]: verbose: ControllerMpd::parseState
Dec 25 13:35:50 volumio volumio[1165]: info: Command Router : Notfying DB Updatefalse
Dec 25 13:35:50 volumio volumio[1165]: info: CoreCommandRouter::Close All Modals sent
Dec 25 13:35:50 volumio volumio[1165]: verbose: ControllerMpd::parseState
Dec 25 13:35:50 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 25 13:35:50 volumio volumio[1165]: verbose: ControllerMpd::parseState
Dec 25 13:35:50 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 25 13:35:52 volumio volumio[1165]: verbose: New Socket.io Connection to 192.168.0.207 from 192.168.0.252 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Edg/144.0.0.0 Engine version: 3 Transport: polling Total Clients: 5
Dec 25 13:35:53 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Dec 25 13:35:53 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:35:53 volumio volumio[1165]: verbose: New Socket.io Connection to 192.168.0.207 from 192.168.0.252 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Edg/144.0.0.0 Engine version: 3 Transport: polling Total Clients: 6
Dec 25 13:35:53 volumio volumio[1165]: info: Listing playlists
Dec 25 13:35:53 volumio volumio[1165]: info: Listing playlists
Dec 25 13:35:55 volumio volumio[1165]: verbose: New Socket.io Connection to 192.168.0.207 from 192.168.0.252 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Edg/144.0.0.0 Engine version: 3 Transport: polling Total Clients: 7
Dec 25 13:35:56 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Dec 25 13:35:56 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:35:56 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 25 13:35:57 volumio volumio[1165]: info: sendMpdCommand status took 21496 milliseconds
Dec 25 13:35:57 volumio volumio[1165]: info: sendMpdCommand status took 21495 milliseconds
Dec 25 13:35:57 volumio volumio[1165]: info: sendMpdCommand status took 21496 milliseconds
Dec 25 13:35:57 volumio volumio[1165]: verbose: ControllerMpd::parseState
Dec 25 13:35:57 volumio volumio[1165]: info: Command Router : Notfying DB Updatefalse
Dec 25 13:35:57 volumio volumio[1165]: info: CoreCommandRouter::Close All Modals sent
Dec 25 13:35:57 volumio volumio[1165]: verbose: ControllerMpd::parseState
Dec 25 13:35:57 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 25 13:35:57 volumio volumio[1165]: verbose: ControllerMpd::parseState
Dec 25 13:35:57 volumio volumio[1165]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 25 13:35:57 volumio volumio[1165]: info: sendMpdCommand playlistinfo took 13587 milliseconds
Dec 25 13:35:57 volumio volumio[1165]: info: sendMpdCommand playlistinfo took 13587 milliseconds
Dec 25 13:35:57 volumio volumio[1165]: info: sendMpdCommand playlistinfo took 6854 milliseconds
Dec 25 13:35:57 volumio volumio[1165]: info: sendMpdCommand playlistinfo took 6853 milliseconds
Dec 25 13:35:57 volumio volumio[1165]: verbose: ControllerMpd::parseTrackInfo
Dec 25 13:35:57 volumio volumio[1165]: verbose: ControllerMpd::parseTrackInfo
Dec 25 13:35:57 volumio volumio[1165]: verbose: ControllerMpd::parseTrackInfo
Dec 25 13:35:57 volumio volumio[1165]: verbose: ControllerMpd::parseTrackInfo
Dec 25 13:35:57 volumio volumio[1165]: info: ControllerMpd::pushState
Dec 25 13:35:57 volumio volumio[1165]: info: CoreCommandRouter::servicePushState
Dec 25 13:35:57 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:35:57 volumio volumio[1165]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":182368,"duration":251,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2717 Kbps","isStreaming":false,"title":"I’ll Be Home for Christmas","artist":"Norah Jones","album":"I Dream of Christmas","uri":"NAS/Music/Norah Jones/I Dream Of Christmas/15-norah_jones-ill_be_home_for_christmas.flac","trackType":"flac"}
Dec 25 13:35:57 volumio volumio[1165]: verbose: CURRENT POSITION 413
Dec 25 13:35:57 volumio volumio[1165]: info: CoreStateMachine::syncState stateService pause
Dec 25 13:35:57 volumio volumio[1165]: info: CoreStateMachine::syncState currentStatus pause
Dec 25 13:35:57 volumio volumio[1165]: info: CoreStateMachine::pushState
Dec 25 13:35:57 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:35:57 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 25 13:35:57 volumio volumio[1165]: info: CoreCommandRouter::volumioPushState
Dec 25 13:35:57 volumio volumio[1165]: info: CoreStateMachine::stPlaybackTimer
Dec 25 13:35:57 volumio volumio[1165]: info: ControllerMpd::pushState
Dec 25 13:35:57 volumio volumio[1165]: info: CoreCommandRouter::servicePushState
Dec 25 13:35:57 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:35:57 volumio volumio[1165]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":182368,"duration":251,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2717 Kbps","isStreaming":false,"title":"I’ll Be Home for Christmas","artist":"Norah Jones","album":"I Dream of Christmas","uri":"NAS/Music/Norah Jones/I Dream Of Christmas/15-norah_jones-ill_be_home_for_christmas.flac","trackType":"flac"}
Dec 25 13:35:57 volumio volumio[1165]: verbose: CURRENT POSITION 413
Dec 25 13:35:57 volumio volumio[1165]: info: CoreStateMachine::syncState stateService pause
Dec 25 13:35:57 volumio volumio[1165]: info: CoreStateMachine::syncState currentStatus pause
Dec 25 13:35:57 volumio volumio[1165]: info: CoreStateMachine::pushState
Dec 25 13:35:57 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:35:57 volumio volumio[1165]: info: CoreCommandRouter::volumioPushState
Dec 25 13:35:57 volumio volumio[1165]: info: CoreStateMachine::stPlaybackTimer
Dec 25 13:35:57 volumio volumio[1165]: info: ControllerMpd::pushState
Dec 25 13:35:57 volumio volumio[1165]: info: CoreCommandRouter::servicePushState
Dec 25 13:35:57 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:35:57 volumio volumio[1165]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":182368,"duration":251,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2717 Kbps","isStreaming":false,"title":"I’ll Be Home for Christmas","artist":"Norah Jones","album":"I Dream of Christmas","uri":"NAS/Music/Norah Jones/I Dream Of Christmas/15-norah_jones-ill_be_home_for_christmas.flac","trackType":"flac"}
Dec 25 13:35:57 volumio volumio[1165]: verbose: CURRENT POSITION 413
Dec 25 13:35:57 volumio volumio[1165]: info: CoreStateMachine::syncState stateService pause
Dec 25 13:35:57 volumio volumio[1165]: info: CoreStateMachine::syncState currentStatus pause
Dec 25 13:35:57 volumio volumio[1165]: info: CoreStateMachine::pushState
Dec 25 13:35:57 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:35:57 volumio volumio[1165]: info: CoreCommandRouter::volumioPushState
Dec 25 13:35:57 volumio volumio[1165]: info: CoreStateMachine::stPlaybackTimer
Dec 25 13:35:57 volumio volumio[1165]: info: ControllerMpd::pushState
Dec 25 13:35:57 volumio volumio[1165]: info: CoreCommandRouter::servicePushState
Dec 25 13:35:57 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:35:57 volumio volumio[1165]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":182368,"duration":251,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2717 Kbps","isStreaming":false,"title":"I’ll Be Home for Christmas","artist":"Norah Jones","album":"I Dream of Christmas","uri":"NAS/Music/Norah Jones/I Dream Of Christmas/15-norah_jones-ill_be_home_for_christmas.flac","trackType":"flac"}
Dec 25 13:35:57 volumio volumio[1165]: verbose: CURRENT POSITION 413
Dec 25 13:35:57 volumio volumio[1165]: info: CoreStateMachine::syncState stateService pause
Dec 25 13:35:57 volumio volumio[1165]: info: CoreStateMachine::syncState currentStatus pause
Dec 25 13:35:57 volumio volumio[1165]: info: CoreStateMachine::pushState
Dec 25 13:35:57 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:35:57 volumio volumio[1165]: info: CoreCommandRouter::volumioPushState
Dec 25 13:35:57 volumio volumio[1165]: info: CoreStateMachine::stPlaybackTimer
Dec 25 13:35:57 volumio volumio[1165]: info: ------------------------------ 21574ms
Dec 25 13:35:57 volumio volumio[1165]: info: ------------------------------ 21574ms
Dec 25 13:35:57 volumio volumio[1165]: info: ------------------------------ 21570ms
Dec 25 13:35:57 volumio volumio[1165]: info: ------------------------------ 21570ms
Dec 25 13:35:57 volumio volumio[1165]: info: sendMpdCommand playlistinfo took 31 milliseconds
Dec 25 13:35:57 volumio volumio[1165]: info: sendMpdCommand playlistinfo took 31 milliseconds
Dec 25 13:35:57 volumio volumio[1165]: verbose: ControllerMpd::parseTrackInfo
Dec 25 13:35:57 volumio volumio[1165]: verbose: ControllerMpd::parseTrackInfo
Dec 25 13:35:57 volumio volumio[1165]: info: ControllerMpd::pushState
Dec 25 13:35:57 volumio volumio[1165]: info: CoreCommandRouter::servicePushState
Dec 25 13:35:57 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:35:57 volumio volumio[1165]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":182368,"duration":251,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2717 Kbps","isStreaming":false,"title":"I’ll Be Home for Christmas","artist":"Norah Jones","album":"I Dream of Christmas","uri":"NAS/Music/Norah Jones/I Dream Of Christmas/15-norah_jones-ill_be_home_for_christmas.flac","trackType":"flac"}
Dec 25 13:35:57 volumio volumio[1165]: verbose: CURRENT POSITION 413
Dec 25 13:35:57 volumio volumio[1165]: info: CoreStateMachine::syncState stateService pause
Dec 25 13:35:57 volumio volumio[1165]: info: CoreStateMachine::syncState currentStatus pause
Dec 25 13:35:57 volumio volumio[1165]: info: CoreStateMachine::pushState
Dec 25 13:35:57 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:35:57 volumio volumio[1165]: info: CoreCommandRouter::volumioPushState
Dec 25 13:35:57 volumio volumio[1165]: info: CoreStateMachine::stPlaybackTimer
Dec 25 13:35:57 volumio volumio[1165]: info: ControllerMpd::pushState
Dec 25 13:35:57 volumio volumio[1165]: info: CoreCommandRouter::servicePushState
Dec 25 13:35:57 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:35:57 volumio volumio[1165]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":182368,"duration":251,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2717 Kbps","isStreaming":false,"title":"I’ll Be Home for Christmas","artist":"Norah Jones","album":"I Dream of Christmas","uri":"NAS/Music/Norah Jones/I Dream Of Christmas/15-norah_jones-ill_be_home_for_christmas.flac","trackType":"flac"}
Dec 25 13:35:57 volumio volumio[1165]: verbose: CURRENT POSITION 413
Dec 25 13:35:57 volumio volumio[1165]: info: CoreStateMachine::syncState stateService pause
Dec 25 13:35:57 volumio volumio[1165]: info: CoreStateMachine::syncState currentStatus pause
Dec 25 13:35:57 volumio volumio[1165]: info: CoreStateMachine::pushState
Dec 25 13:35:57 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:35:57 volumio volumio[1165]: info: CoreCommandRouter::volumioPushState
Dec 25 13:35:57 volumio volumio[1165]: info: CoreStateMachine::stPlaybackTimer
Dec 25 13:35:57 volumio volumio[1165]: info: ------------------------------ 21587ms
Dec 25 13:35:57 volumio volumio[1165]: info: ------------------------------ 21586ms
Dec 25 13:35:57 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 25 13:35:57 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 25 13:35:57 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Dec 25 13:35:57 volumio volumio[1165]: info: CoreCommandRouter::volumioGetVisibleSources
Dec 25 13:35:57 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 25 13:35:57 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Dec 25 13:35:57 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:35:57 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Dec 25 13:35:57 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:35:57 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Dec 25 13:35:57 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Dec 25 13:35:57 volumio volumio[1165]: info: Received Get System Info
Dec 25 13:35:57 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 25 13:35:57 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 25 13:35:57 volumio volumio[1165]: info: Discovery: Getting this device information
Dec 25 13:35:57 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Dec 25 13:35:57 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:35:57 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 25 13:35:57 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Dec 25 13:35:57 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:35:57 volumio volumio[1165]: info: Listing playlists
Dec 25 13:35:57 volumio volumio[1165]: info: CoreCommandRouter::volumioGetQueue
Dec 25 13:35:57 volumio volumio[1165]: info: CoreStateMachine::getQueue
Dec 25 13:35:57 volumio volumio[1165]: info: CorePlayQueue::getQueue
Dec 25 13:35:57 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Dec 25 13:35:57 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 25 13:36:01 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 25 13:36:05 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 25 13:36:05 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Dec 25 13:36:05 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:36:09 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 25 13:36:13 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 25 13:36:15 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Dec 25 13:36:15 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:36:15 volumio volumio[1165]: info: Listing playlists
Dec 25 13:36:15 volumio volumio[1165]: info: Listing playlists
Dec 25 13:36:17 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 25 13:36:17 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service...
Dec 25 13:36:18 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully.
Dec 25 13:36:18 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service.
Dec 25 13:36:21 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 25 13:36:25 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 25 13:36:25 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Dec 25 13:36:25 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:36:29 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Dec 25 13:36:35 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Dec 25 13:36:35 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:36:35 volumio volumio[1165]: info: Listing playlists
Dec 25 13:36:35 volumio volumio[1165]: info: Listing playlists
Dec 25 13:36:45 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState
Dec 25 13:36:45 volumio volumio[1165]: info: CorePlayQueue::getTrack 413
Dec 25 13:36:51 volumio volumio[1165]: Error in writing albumart JSON file: Error: ENOENT: no such file or directory, open '/data/albumart/web/Black%20Eyed%20Peas/info.json'
Dec 25 13:36:51 volumio volumio[1165]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 25 13:36:51 volumio volumio[1165]: [Error: ENOENT: no such file or directory, open '/data/albumart/web/Black%20Eyed%20Peas/635ec190-398c-498e-a440-9d2ceff9d9f7.jpg'] {
Dec 25 13:36:51 volumio volumio[1165]: errno: -2,
Dec 25 13:36:51 volumio volumio[1165]: code: 'ENOENT',
Dec 25 13:36:51 volumio volumio[1165]: syscall: 'open',
Dec 25 13:36:51 volumio volumio[1165]: path: '/data/albumart/web/Black%20Eyed%20Peas/635ec190-398c-498e-a440-9d2ceff9d9f7.jpg'
Dec 25 13:36:51 volumio volumio[1165]: }
Dec 25 13:36:51 volumio volumio[1165]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 25 13:36:51 volumio sudo[10919]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-25 13:35'
Dec 25 13:36:51 volumio sudo[10919]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)"
NAME="Raspbian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
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="cfdc872d40b979cca36352a7333c940c38dc64b5"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025"
VOLUMIO_VERSION="4.073"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"