Jan 28 11:20:33 volumio sudo[14765]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 28 11:20:33 volumio sudo[14765]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 11:20:33 volumio sudo[14765]: pam_unix(sudo:session): session closed for user root Jan 28 11:20:33 volumio sudo[14766]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 28 11:20:33 volumio sudo[14766]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 11:20:33 volumio sudo[14766]: pam_unix(sudo:session): session closed for user root Jan 28 11:20:33 volumio volumio[3086]: verbose: New Socket.io Connection to 192.168.178.112 from 192.168.178.187 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Jan 28 11:20:33 volumio sudo[14771]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 28 11:20:33 volumio sudo[14771]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 11:20:33 volumio sudo[14771]: pam_unix(sudo:session): session closed for user root Jan 28 11:20:34 volumio sudo[14772]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 28 11:20:34 volumio sudo[14772]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 28 11:20:34 volumio sudo[14772]: pam_unix(sudo:session): session closed for user root Jan 28 11:20:34 volumio volumio[3086]: verbose: New Socket.io Connection to 192.168.178.112 from 192.168.178.187 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Jan 28 11:20:34 volumio volumio[3086]: info: CoreCommandRouter::volumioGetState Jan 28 11:20:34 volumio volumio[3086]: info: CorePlayQueue::getTrack 0 Jan 28 11:20:34 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 28 11:20:34 volumio volumio[3086]: info: Listing playlists Jan 28 11:20:34 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 28 11:20:34 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 28 11:20:34 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 28 11:20:34 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 28 11:20:35 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 28 11:20:35 volumio volumio[3086]: info: Received Get System Info Jan 28 11:20:35 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 28 11:20:35 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 28 11:20:35 volumio volumio[3086]: info: Discovery: Getting this device information Jan 28 11:20:35 volumio volumio[3086]: info: CoreCommandRouter::volumioGetState Jan 28 11:20:35 volumio volumio[3086]: info: CorePlayQueue::getTrack 0 Jan 28 11:20:35 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 28 11:20:36 volumio volumio[3086]: info: CoreCommandRouter::volumioGetVisibleSources Jan 28 11:20:36 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 28 11:20:36 volumio volumio[3086]: info: CoreCommandRouter::volumioGetQueue Jan 28 11:20:36 volumio volumio[3086]: info: CoreStateMachine::getQueue Jan 28 11:20:36 volumio volumio[3086]: info: CorePlayQueue::getQueue Jan 28 11:20:36 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 28 11:20:36 volumio volumio[3086]: info: Received Get System Info Jan 28 11:20:36 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 28 11:20:36 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 28 11:20:36 volumio volumio[3086]: info: Discovery: Getting this device information Jan 28 11:20:36 volumio volumio[3086]: info: CoreCommandRouter::volumioGetState Jan 28 11:20:36 volumio volumio[3086]: info: CorePlayQueue::getTrack 0 Jan 28 11:20:36 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 28 11:20:50 volumio volumio[3086]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 28 11:20:50 volumio volumio[3086]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 28 11:20:50 volumio volumio[3086]: info: Retrieving Cloud Streaming UI Jan 28 11:20:50 volumio volumio[3086]: info: Getting Tidal Cloud Configuration Jan 28 11:20:50 volumio volumio[3086]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 28 11:20:50 volumio volumio[3086]: info: Getting Qobuz Cloud Configuration Jan 28 11:20:50 volumio volumio[3086]: info: Asking plugin for UI Config Jan 28 11:20:50 volumio volumio[3086]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 28 11:20:50 volumio volumio[3086]: info: Getting Spotify Cloud Configuration Jan 28 11:20:50 volumio volumio[3086]: info: Asking plugin for UI Config Jan 28 11:20:50 volumio volumio[3086]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 28 11:20:50 volumio volumio[3086]: info: Saving Spotify Acccount Jan 28 11:20:50 volumio volumio[3086]: info: Got Tidal Cloud Configuration Jan 28 11:20:50 volumio volumio[3086]: info: Got it Jan 28 11:20:50 volumio volumio[3086]: info: Got it Jan 28 11:20:50 volumio volumio[3086]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jan 28 11:20:50 volumio volumio[3086]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 28 11:20:50 volumio volumio[3086]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Jan 28 11:20:50 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 28 11:20:50 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 28 11:20:50 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 28 11:20:50 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 28 11:20:50 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 28 11:20:50 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 28 11:20:50 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 28 11:20:50 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 28 11:20:50 volumio volumio[3086]: info: CoreCommandRouter::volumioGetBrowseSources Jan 28 11:20:50 volumio volumio[3086]: info: CoreCommandRouter::volumioGetBrowseSources Jan 28 11:20:50 volumio volumio[3086]: info: CoreCommandRouter::volumioGetBrowseSources Jan 28 11:20:50 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 11:20:50 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jan 28 11:20:52 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 28 11:20:52 volumio volumio[3086]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jan 28 11:20:52 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jan 28 11:20:52 volumio volumio[3086]: info: Received Get System Version Jan 28 11:20:52 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 28 11:20:52 volumio volumio[3086]: info: Received Get System Info Jan 28 11:20:52 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 28 11:20:52 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 28 11:20:52 volumio volumio[3086]: info: Discovery: Getting this device information Jan 28 11:20:52 volumio volumio[3086]: info: CoreCommandRouter::volumioGetState Jan 28 11:20:52 volumio volumio[3086]: info: CorePlayQueue::getTrack 0 Jan 28 11:20:52 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 28 11:20:53 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Jan 28 11:20:53 volumio volumio[3086]: verbose: ControllerMpd::sendMpdCommand update Jan 28 11:20:53 volumio volumio[3086]: info: sendMpdCommand update took 1 milliseconds Jan 28 11:20:53 volumio volumio[3086]: verbose: ControllerMpd::sendMpdCommand status Jan 28 11:20:53 volumio volumio[3086]: info: Jan 28 11:20:53 volumio volumio[3086]: ---------------------------- MPD announces state update: update Jan 28 11:20:53 volumio volumio[3086]: info: ControllerMpd::getState Jan 28 11:20:53 volumio volumio[3086]: verbose: ControllerMpd::sendMpdCommand status Jan 28 11:20:53 volumio volumio[3086]: verbose: ControllerMpd::sendMpdCommand status Jan 28 11:20:53 volumio volumio[3086]: info: Jan 28 11:20:53 volumio volumio[3086]: ---------------------------- MPD announces state update: update Jan 28 11:20:53 volumio volumio[3086]: info: ControllerMpd::getState Jan 28 11:20:53 volumio volumio[3086]: verbose: ControllerMpd::sendMpdCommand status Jan 28 11:20:53 volumio volumio[3086]: verbose: ControllerMpd::sendMpdCommand status Jan 28 11:20:53 volumio volumio[3086]: info: Jan 28 11:20:53 volumio volumio[3086]: ---------------------------- MPD announces state update: update Jan 28 11:20:53 volumio volumio[3086]: info: ControllerMpd::getState Jan 28 11:20:53 volumio volumio[3086]: verbose: ControllerMpd::sendMpdCommand status Jan 28 11:20:53 volumio volumio[3086]: info: sendMpdCommand status took 4 milliseconds Jan 28 11:20:53 volumio volumio[3086]: info: sendMpdCommand status took 4 milliseconds Jan 28 11:20:53 volumio volumio[3086]: info: sendMpdCommand status took 4 milliseconds Jan 28 11:20:53 volumio volumio[3086]: info: sendMpdCommand status took 4 milliseconds Jan 28 11:20:53 volumio volumio[3086]: verbose: ControllerMpd::parseState Jan 28 11:20:53 volumio volumio[3086]: info: Command Router : Notfying DB Updatetrue Jan 28 11:20:53 volumio volumio[3086]: info: CoreCommandRouter::Close All Modals sent Jan 28 11:20:53 volumio volumio[3086]: verbose: ControllerMpd::parseState Jan 28 11:20:53 volumio volumio[3086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 11:20:53 volumio volumio[3086]: verbose: ControllerMpd::parseState Jan 28 11:20:53 volumio volumio[3086]: info: Command Router : Notfying DB Updatetrue Jan 28 11:20:53 volumio volumio[3086]: info: CoreCommandRouter::Close All Modals sent Jan 28 11:20:53 volumio volumio[3086]: verbose: ControllerMpd::parseState Jan 28 11:20:53 volumio volumio[3086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 11:20:53 volumio volumio[3086]: info: sendMpdCommand status took 33 milliseconds Jan 28 11:20:53 volumio volumio[3086]: info: sendMpdCommand status took 37 milliseconds Jan 28 11:20:53 volumio volumio[3086]: verbose: ControllerMpd::parseState Jan 28 11:20:53 volumio volumio[3086]: info: Command Router : Notfying DB Updatetrue Jan 28 11:20:53 volumio volumio[3086]: info: CoreCommandRouter::Close All Modals sent Jan 28 11:20:53 volumio volumio[3086]: verbose: ControllerMpd::parseState Jan 28 11:20:53 volumio volumio[3086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 11:20:53 volumio volumio[3086]: info: sendMpdCommand playlistinfo took 50 milliseconds Jan 28 11:20:53 volumio volumio[3086]: info: sendMpdCommand playlistinfo took 40 milliseconds Jan 28 11:20:53 volumio volumio[3086]: info: sendMpdCommand playlistinfo took 9 milliseconds Jan 28 11:20:53 volumio volumio[3086]: verbose: ControllerMpd::parseTrackInfo Jan 28 11:20:53 volumio volumio[3086]: verbose: ControllerMpd::parseTrackInfo Jan 28 11:20:53 volumio volumio[3086]: verbose: ControllerMpd::parseTrackInfo Jan 28 11:20:53 volumio volumio[3086]: info: ControllerMpd::pushState Jan 28 11:20:53 volumio volumio[3086]: info: CoreCommandRouter::servicePushState Jan 28 11:20:53 volumio volumio[3086]: info: CorePlayQueue::getTrack 0 Jan 28 11:20:53 volumio volumio[3086]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":17975,"duration":177,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Good Morning Judge","artist":"10Cc","album":"Deceptive Bends[ Expanded & Remas]","uri":"INTERNAL/10CC - (1977) - Deceptive Bends (Expanded & Remastered)/01 Good Morning Judge.mp3","trackType":"mp3"} Jan 28 11:20:53 volumio volumio[3086]: verbose: CURRENT POSITION 0 Jan 28 11:20:53 volumio volumio[3086]: info: CoreStateMachine::syncState stateService pause Jan 28 11:20:53 volumio volumio[3086]: info: CoreStateMachine::syncState currentStatus pause Jan 28 11:20:53 volumio volumio[3086]: info: CoreStateMachine::pushState Jan 28 11:20:53 volumio volumio[3086]: info: CorePlayQueue::getTrack 0 Jan 28 11:20:53 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 11:20:53 volumio volumio[3086]: info: CoreCommandRouter::volumioPushState Jan 28 11:20:53 volumio volumio[3086]: info: CoreStateMachine::stPlaybackTimer Jan 28 11:20:53 volumio volumio[3086]: info: ControllerMpd::pushState Jan 28 11:20:53 volumio volumio[3086]: info: CoreCommandRouter::servicePushState Jan 28 11:20:53 volumio volumio[3086]: info: CorePlayQueue::getTrack 0 Jan 28 11:20:53 volumio volumio[3086]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":17975,"duration":177,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Good Morning Judge","artist":"10Cc","album":"Deceptive Bends[ Expanded & Remas]","uri":"INTERNAL/10CC - (1977) - Deceptive Bends (Expanded & Remastered)/01 Good Morning Judge.mp3","trackType":"mp3"} Jan 28 11:20:53 volumio volumio[3086]: verbose: CURRENT POSITION 0 Jan 28 11:20:53 volumio volumio[3086]: info: CoreStateMachine::syncState stateService pause Jan 28 11:20:53 volumio volumio[3086]: info: CoreStateMachine::syncState currentStatus pause Jan 28 11:20:53 volumio volumio[3086]: info: CoreStateMachine::pushState Jan 28 11:20:53 volumio volumio[3086]: info: CorePlayQueue::getTrack 0 Jan 28 11:20:53 volumio volumio[3086]: info: CoreCommandRouter::volumioPushState Jan 28 11:20:53 volumio volumio[3086]: info: CoreStateMachine::stPlaybackTimer Jan 28 11:20:53 volumio volumio[3086]: info: ControllerMpd::pushState Jan 28 11:20:53 volumio volumio[3086]: info: CoreCommandRouter::servicePushState Jan 28 11:20:53 volumio volumio[3086]: info: CorePlayQueue::getTrack 0 Jan 28 11:20:53 volumio volumio[3086]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":17975,"duration":177,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Good Morning Judge","artist":"10Cc","album":"Deceptive Bends[ Expanded & Remas]","uri":"INTERNAL/10CC - (1977) - Deceptive Bends (Expanded & Remastered)/01 Good Morning Judge.mp3","trackType":"mp3"} Jan 28 11:20:53 volumio volumio[3086]: verbose: CURRENT POSITION 0 Jan 28 11:20:53 volumio volumio[3086]: info: CoreStateMachine::syncState stateService pause Jan 28 11:20:53 volumio volumio[3086]: info: CoreStateMachine::syncState currentStatus pause Jan 28 11:20:53 volumio volumio[3086]: info: CoreStateMachine::pushState Jan 28 11:20:53 volumio volumio[3086]: info: CorePlayQueue::getTrack 0 Jan 28 11:20:53 volumio volumio[3086]: info: CoreCommandRouter::volumioPushState Jan 28 11:20:53 volumio volumio[3086]: info: CoreStateMachine::stPlaybackTimer Jan 28 11:20:53 volumio volumio[3086]: info: ------------------------------ 84ms Jan 28 11:20:53 volumio volumio[3086]: info: ------------------------------ 84ms Jan 28 11:20:53 volumio volumio[3086]: info: ------------------------------ 84ms Jan 28 11:20:54 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 11:20:56 volumio volumio[3086]: info: MPD Database updated - AlbumList cache refreshed Jan 28 11:20:56 volumio volumio[3086]: info: Jan 28 11:20:56 volumio volumio[3086]: ---------------------------- MPD announces state update: database Jan 28 11:20:56 volumio volumio[3086]: verbose: ControllerMpd::sendMpdCommand status Jan 28 11:20:56 volumio volumio[3086]: info: Jan 28 11:20:56 volumio volumio[3086]: ---------------------------- MPD announces state update: update Jan 28 11:20:56 volumio volumio[3086]: info: ControllerMpd::getState Jan 28 11:20:56 volumio volumio[3086]: verbose: ControllerMpd::sendMpdCommand status Jan 28 11:20:56 volumio volumio[3086]: info: ControllerMpd::getState Jan 28 11:20:56 volumio volumio[3086]: verbose: ControllerMpd::sendMpdCommand status Jan 28 11:20:56 volumio volumio[3086]: info: MPD Database updated - AlbumList cache refreshed Jan 28 11:20:56 volumio volumio[3086]: info: Jan 28 11:20:56 volumio volumio[3086]: ---------------------------- MPD announces state update: database Jan 28 11:20:56 volumio volumio[3086]: verbose: ControllerMpd::sendMpdCommand status Jan 28 11:20:56 volumio volumio[3086]: info: Jan 28 11:20:56 volumio volumio[3086]: ---------------------------- MPD announces state update: update Jan 28 11:20:56 volumio volumio[3086]: info: ControllerMpd::getState Jan 28 11:20:56 volumio volumio[3086]: verbose: ControllerMpd::sendMpdCommand status Jan 28 11:20:56 volumio volumio[3086]: info: ControllerMpd::getState Jan 28 11:20:56 volumio volumio[3086]: verbose: ControllerMpd::sendMpdCommand status Jan 28 11:20:56 volumio volumio[3086]: info: MPD Database updated - AlbumList cache refreshed Jan 28 11:20:56 volumio volumio[3086]: info: Jan 28 11:20:56 volumio volumio[3086]: ---------------------------- MPD announces state update: database Jan 28 11:20:56 volumio volumio[3086]: verbose: ControllerMpd::sendMpdCommand status Jan 28 11:20:56 volumio volumio[3086]: info: Jan 28 11:20:56 volumio volumio[3086]: ---------------------------- MPD announces state update: update Jan 28 11:20:56 volumio volumio[3086]: info: ControllerMpd::getState Jan 28 11:20:56 volumio volumio[3086]: verbose: ControllerMpd::sendMpdCommand status Jan 28 11:20:56 volumio volumio[3086]: info: ControllerMpd::getState Jan 28 11:20:56 volumio volumio[3086]: verbose: ControllerMpd::sendMpdCommand status Jan 28 11:20:59 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 11:21:00 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:00 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:00 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:00 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:00 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:00 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:00 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:00 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:00 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:00 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:00 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:00 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:00 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:00 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:00 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:00 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:00 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:00 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:00 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:00 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:01 volumio volumio[3086]: info: sendMpdCommand status took 5504 milliseconds Jan 28 11:21:01 volumio volumio[3086]: info: sendMpdCommand status took 5504 milliseconds Jan 28 11:21:01 volumio volumio[3086]: info: sendMpdCommand status took 5504 milliseconds Jan 28 11:21:01 volumio volumio[3086]: verbose: ControllerMpd::parseState Jan 28 11:21:01 volumio volumio[3086]: info: Command Router : Notfying DB Updatefalse Jan 28 11:21:01 volumio volumio[3086]: info: CoreCommandRouter::Close All Modals sent Jan 28 11:21:01 volumio volumio[3086]: verbose: ControllerMpd::parseState Jan 28 11:21:01 volumio volumio[3086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 11:21:01 volumio volumio[3086]: verbose: ControllerMpd::parseState Jan 28 11:21:01 volumio volumio[3086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 11:21:03 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 11:21:04 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:04 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:04 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:04 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:04 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:04 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:04 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:04 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:04 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:04 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:04 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:04 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:04 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:04 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:04 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:04 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:04 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:04 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:04 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:04 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:05 volumio volumio[3086]: info: sendMpdCommand status took 9228 milliseconds Jan 28 11:21:05 volumio volumio[3086]: info: sendMpdCommand status took 9228 milliseconds Jan 28 11:21:05 volumio volumio[3086]: info: sendMpdCommand status took 9228 milliseconds Jan 28 11:21:05 volumio volumio[3086]: verbose: ControllerMpd::parseState Jan 28 11:21:05 volumio volumio[3086]: info: Command Router : Notfying DB Updatefalse Jan 28 11:21:05 volumio volumio[3086]: info: CoreCommandRouter::Close All Modals sent Jan 28 11:21:05 volumio volumio[3086]: verbose: ControllerMpd::parseState Jan 28 11:21:05 volumio volumio[3086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 11:21:05 volumio volumio[3086]: verbose: ControllerMpd::parseState Jan 28 11:21:05 volumio volumio[3086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 11:21:07 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 11:21:08 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:08 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:08 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:08 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:08 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:08 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:08 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:08 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:08 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:08 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:08 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:08 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:08 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:08 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:08 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:08 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:08 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:08 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:08 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:08 volumio volumio[3086]: Cannot compose Albumart path Jan 28 11:21:09 volumio volumio[3086]: info: sendMpdCommand status took 13201 milliseconds Jan 28 11:21:09 volumio volumio[3086]: info: sendMpdCommand status took 13201 milliseconds Jan 28 11:21:09 volumio volumio[3086]: info: sendMpdCommand status took 13201 milliseconds Jan 28 11:21:09 volumio volumio[3086]: verbose: ControllerMpd::parseState Jan 28 11:21:09 volumio volumio[3086]: info: Command Router : Notfying DB Updatefalse Jan 28 11:21:09 volumio volumio[3086]: info: CoreCommandRouter::Close All Modals sent Jan 28 11:21:09 volumio volumio[3086]: verbose: ControllerMpd::parseState Jan 28 11:21:09 volumio volumio[3086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 11:21:09 volumio volumio[3086]: verbose: ControllerMpd::parseState Jan 28 11:21:09 volumio volumio[3086]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 11:21:09 volumio volumio[3086]: info: sendMpdCommand playlistinfo took 7731 milliseconds Jan 28 11:21:09 volumio volumio[3086]: info: sendMpdCommand playlistinfo took 7731 milliseconds Jan 28 11:21:09 volumio volumio[3086]: verbose: ControllerMpd::parseTrackInfo Jan 28 11:21:09 volumio volumio[3086]: verbose: ControllerMpd::parseTrackInfo Jan 28 11:21:09 volumio volumio[3086]: info: ControllerMpd::pushState Jan 28 11:21:09 volumio volumio[3086]: info: CoreCommandRouter::servicePushState Jan 28 11:21:09 volumio volumio[3086]: info: CorePlayQueue::getTrack 0 Jan 28 11:21:09 volumio volumio[3086]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":17975,"duration":177,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Good Morning Judge","artist":"10Cc","album":"Deceptive Bends[ Expanded & Remas]","uri":"INTERNAL/10CC - (1977) - Deceptive Bends (Expanded & Remastered)/01 Good Morning Judge.mp3","trackType":"mp3"} Jan 28 11:21:09 volumio volumio[3086]: verbose: CURRENT POSITION 0 Jan 28 11:21:09 volumio volumio[3086]: info: CoreStateMachine::syncState stateService pause Jan 28 11:21:09 volumio volumio[3086]: info: CoreStateMachine::syncState currentStatus pause Jan 28 11:21:09 volumio volumio[3086]: info: CoreStateMachine::pushState Jan 28 11:21:09 volumio volumio[3086]: info: CorePlayQueue::getTrack 0 Jan 28 11:21:09 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 11:21:09 volumio volumio[3086]: info: CoreCommandRouter::volumioPushState Jan 28 11:21:09 volumio volumio[3086]: info: CoreStateMachine::stPlaybackTimer Jan 28 11:21:09 volumio volumio[3086]: info: ControllerMpd::pushState Jan 28 11:21:09 volumio volumio[3086]: info: CoreCommandRouter::servicePushState Jan 28 11:21:09 volumio volumio[3086]: info: CorePlayQueue::getTrack 0 Jan 28 11:21:09 volumio volumio[3086]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":17975,"duration":177,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Good Morning Judge","artist":"10Cc","album":"Deceptive Bends[ Expanded & Remas]","uri":"INTERNAL/10CC - (1977) - Deceptive Bends (Expanded & Remastered)/01 Good Morning Judge.mp3","trackType":"mp3"} Jan 28 11:21:09 volumio volumio[3086]: verbose: CURRENT POSITION 0 Jan 28 11:21:09 volumio volumio[3086]: info: CoreStateMachine::syncState stateService pause Jan 28 11:21:09 volumio volumio[3086]: info: CoreStateMachine::syncState currentStatus pause Jan 28 11:21:09 volumio volumio[3086]: info: CoreStateMachine::pushState Jan 28 11:21:09 volumio volumio[3086]: info: CorePlayQueue::getTrack 0 Jan 28 11:21:09 volumio volumio[3086]: info: CoreCommandRouter::volumioPushState Jan 28 11:21:09 volumio volumio[3086]: info: CoreStateMachine::stPlaybackTimer Jan 28 11:21:09 volumio volumio[3086]: info: ------------------------------ 13247ms Jan 28 11:21:09 volumio volumio[3086]: info: ------------------------------ 13247ms Jan 28 11:21:09 volumio volumio[3086]: info: sendMpdCommand playlistinfo took 4072 milliseconds Jan 28 11:21:09 volumio volumio[3086]: info: sendMpdCommand playlistinfo took 4072 milliseconds Jan 28 11:21:09 volumio volumio[3086]: verbose: ControllerMpd::parseTrackInfo Jan 28 11:21:09 volumio volumio[3086]: verbose: ControllerMpd::parseTrackInfo Jan 28 11:21:09 volumio volumio[3086]: info: ControllerMpd::pushState Jan 28 11:21:09 volumio volumio[3086]: info: CoreCommandRouter::servicePushState Jan 28 11:21:09 volumio volumio[3086]: info: CorePlayQueue::getTrack 0 Jan 28 11:21:09 volumio volumio[3086]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":17975,"duration":177,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Good Morning Judge","artist":"10Cc","album":"Deceptive Bends[ Expanded & Remas]","uri":"INTERNAL/10CC - (1977) - Deceptive Bends (Expanded & Remastered)/01 Good Morning Judge.mp3","trackType":"mp3"} Jan 28 11:21:09 volumio volumio[3086]: verbose: CURRENT POSITION 0 Jan 28 11:21:09 volumio volumio[3086]: info: CoreStateMachine::syncState stateService pause Jan 28 11:21:09 volumio volumio[3086]: info: CoreStateMachine::syncState currentStatus pause Jan 28 11:21:09 volumio volumio[3086]: info: CoreStateMachine::pushState Jan 28 11:21:09 volumio volumio[3086]: info: CorePlayQueue::getTrack 0 Jan 28 11:21:09 volumio volumio[3086]: info: CoreCommandRouter::volumioPushState Jan 28 11:21:09 volumio volumio[3086]: info: CoreStateMachine::stPlaybackTimer Jan 28 11:21:09 volumio volumio[3086]: info: ControllerMpd::pushState Jan 28 11:21:09 volumio volumio[3086]: info: CoreCommandRouter::servicePushState Jan 28 11:21:09 volumio volumio[3086]: info: CorePlayQueue::getTrack 0 Jan 28 11:21:09 volumio volumio[3086]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":17975,"duration":177,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Good Morning Judge","artist":"10Cc","album":"Deceptive Bends[ Expanded & Remas]","uri":"INTERNAL/10CC - (1977) - Deceptive Bends (Expanded & Remastered)/01 Good Morning Judge.mp3","trackType":"mp3"} Jan 28 11:21:09 volumio volumio[3086]: verbose: CURRENT POSITION 0 Jan 28 11:21:09 volumio volumio[3086]: info: CoreStateMachine::syncState stateService pause Jan 28 11:21:09 volumio volumio[3086]: info: CoreStateMachine::syncState currentStatus pause Jan 28 11:21:09 volumio volumio[3086]: info: CoreStateMachine::pushState Jan 28 11:21:09 volumio volumio[3086]: info: CorePlayQueue::getTrack 0 Jan 28 11:21:09 volumio volumio[3086]: info: CoreCommandRouter::volumioPushState Jan 28 11:21:09 volumio volumio[3086]: info: CoreStateMachine::stPlaybackTimer Jan 28 11:21:09 volumio volumio[3086]: info: ------------------------------ 13311ms Jan 28 11:21:09 volumio volumio[3086]: info: ------------------------------ 13312ms Jan 28 11:21:09 volumio volumio[3086]: info: sendMpdCommand playlistinfo took 144 milliseconds Jan 28 11:21:09 volumio volumio[3086]: info: sendMpdCommand playlistinfo took 143 milliseconds Jan 28 11:21:09 volumio volumio[3086]: verbose: ControllerMpd::parseTrackInfo Jan 28 11:21:09 volumio volumio[3086]: verbose: ControllerMpd::parseTrackInfo Jan 28 11:21:09 volumio volumio[3086]: info: ControllerMpd::pushState Jan 28 11:21:09 volumio volumio[3086]: info: CoreCommandRouter::servicePushState Jan 28 11:21:09 volumio volumio[3086]: info: CorePlayQueue::getTrack 0 Jan 28 11:21:09 volumio volumio[3086]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":17975,"duration":177,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Good Morning Judge","artist":"10Cc","album":"Deceptive Bends[ Expanded & Remas]","uri":"INTERNAL/10CC - (1977) - Deceptive Bends (Expanded & Remastered)/01 Good Morning Judge.mp3","trackType":"mp3"} Jan 28 11:21:09 volumio volumio[3086]: verbose: CURRENT POSITION 0 Jan 28 11:21:09 volumio volumio[3086]: info: CoreStateMachine::syncState stateService pause Jan 28 11:21:09 volumio volumio[3086]: info: CoreStateMachine::syncState currentStatus pause Jan 28 11:21:09 volumio volumio[3086]: info: CoreStateMachine::pushState Jan 28 11:21:09 volumio volumio[3086]: info: CorePlayQueue::getTrack 0 Jan 28 11:21:09 volumio volumio[3086]: info: CoreCommandRouter::volumioPushState Jan 28 11:21:09 volumio volumio[3086]: info: CoreStateMachine::stPlaybackTimer Jan 28 11:21:09 volumio volumio[3086]: info: ControllerMpd::pushState Jan 28 11:21:09 volumio volumio[3086]: info: CoreCommandRouter::servicePushState Jan 28 11:21:09 volumio volumio[3086]: info: CorePlayQueue::getTrack 0 Jan 28 11:21:09 volumio volumio[3086]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":17975,"duration":177,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Good Morning Judge","artist":"10Cc","album":"Deceptive Bends[ Expanded & Remas]","uri":"INTERNAL/10CC - (1977) - Deceptive Bends (Expanded & Remastered)/01 Good Morning Judge.mp3","trackType":"mp3"} Jan 28 11:21:09 volumio volumio[3086]: verbose: CURRENT POSITION 0 Jan 28 11:21:09 volumio volumio[3086]: info: CoreStateMachine::syncState stateService pause Jan 28 11:21:09 volumio volumio[3086]: info: CoreStateMachine::syncState currentStatus pause Jan 28 11:21:09 volumio volumio[3086]: info: CoreStateMachine::pushState Jan 28 11:21:09 volumio volumio[3086]: info: CorePlayQueue::getTrack 0 Jan 28 11:21:09 volumio volumio[3086]: info: CoreCommandRouter::volumioPushState Jan 28 11:21:09 volumio volumio[3086]: info: CoreStateMachine::stPlaybackTimer Jan 28 11:21:09 volumio volumio[3086]: info: ------------------------------ 13359ms Jan 28 11:21:09 volumio volumio[3086]: info: ------------------------------ 13360ms Jan 28 11:21:10 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 28 11:21:15 volumio volumio[3086]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 28 11:21:15 volumio volumio[3086]: info: CURURI: artists:// Jan 28 11:21:15 volumio volumio[3086]: info: Preload queue cleared Jan 28 11:21:28 volumio volumio[3086]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 28 11:21:28 volumio volumio[3086]: TypeError: Cannot read properties of null (reading 'slice') Jan 28 11:21:28 volumio volumio[3086]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Jan 28 11:21:28 volumio volumio[3086]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Jan 28 11:21:28 volumio volumio[3086]: at Object.onceWrapper (node:events:629:26) Jan 28 11:21:28 volumio volumio[3086]: at ClientRequest.emit (node:events:514:28) Jan 28 11:21:28 volumio volumio[3086]: at HTTPParser.parserOnIncomingClient [as onIncoming] (node:_http_client:693:27) Jan 28 11:21:28 volumio volumio[3086]: at HTTPParser.parserOnHeadersComplete (node:_http_common:119:17) Jan 28 11:21:28 volumio volumio[3086]: at TLSSocket.socketOnData (node:_http_client:535:22) Jan 28 11:21:28 volumio volumio[3086]: at TLSSocket.emit (node:events:514:28) Jan 28 11:21:28 volumio volumio[3086]: at addChunk (node:internal/streams/readable:343:12) Jan 28 11:21:28 volumio volumio[3086]: at readableAddChunk (node:internal/streams/readable:316:9) Jan 28 11:21:28 volumio volumio[3086]: at Readable.push (node:internal/streams/readable:253:10) Jan 28 11:21:28 volumio volumio[3086]: at TLSWrap.onStreamRead (node:internal/stream_base_commons:190:23) Jan 28 11:21:28 volumio volumio[3086]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 28 11:21:29 volumio sudo[14953]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-28 11:20' Jan 28 11:21:29 volumio sudo[14953]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 25 09:38:19 UTC 2025" VOLUMIO_VERSION="4.084" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="00e933ebe3692ad8aea9910d2289bf23"