-- Logs begin at Thu 2019-02-14 13:11:58 MSK, end at Mon 2025-09-08 18:08:15 MSK. -- Sep 08 18:07:00 volumio-nvme systemd[1]: systemd-timedated.service: Succeeded. Sep 08 18:07:02 volumio-nvme volumio[1198]: info: BOOT COMPLETED Sep 08 18:07:05 volumio-nvme ntpd[976]: Soliciting pool server 193.106.93.116 Sep 08 18:07:05 volumio-nvme volumio[1198]: info: [now-playing] OpenWeatherMap API key obtained. Sep 08 18:07:06 volumio-nvme ntpd[976]: Soliciting pool server 162.159.200.123 Sep 08 18:07:06 volumio-nvme ntpd[976]: Soliciting pool server 147.45.251.137 Sep 08 18:07:07 volumio-nvme ntpd[976]: Soliciting pool server 87.103.245.205 Sep 08 18:07:07 volumio-nvme ntpd[976]: Soliciting pool server 31.133.121.93 Sep 08 18:07:08 volumio-nvme ntpd[976]: Soliciting pool server 51.250.53.172 Sep 08 18:07:08 volumio-nvme ntpd[976]: Soliciting pool server 91.206.16.3 Sep 08 18:07:08 volumio-nvme ntpd[976]: Soliciting pool server 185.119.57.94 Sep 08 18:07:09 volumio-nvme ntpd[976]: Soliciting pool server 92.241.12.152 Sep 08 18:07:09 volumio-nvme ntpd[976]: Soliciting pool server 90.188.9.144 Sep 08 18:07:09 volumio-nvme ntpd[976]: Soliciting pool server 95.53.229.154 Sep 08 18:07:10 volumio-nvme ntpd[976]: Soliciting pool server 46.52.232.73 Sep 08 18:07:10 volumio-nvme ntpd[976]: Soliciting pool server 2001:678:68c::3 Sep 08 18:07:16 volumio-nvme ntpd[976]: receive: Unexpected origin timestamp 0xec696fa2.8f650dd2 does not match aorg 0000000000.00000000 from server@31.133.121.93 xmt 0xec696fa4.0797c229 Sep 08 18:07:16 volumio-nvme ntpd[976]: receive: Unexpected origin timestamp 0xec696fa2.8f5f4456 does not match aorg 0000000000.00000000 from server@95.53.229.154 xmt 0xec696fa4.083e2d93 Sep 08 18:07:16 volumio-nvme ntpd[976]: receive: Unexpected origin timestamp 0xec696fa2.8f61989d does not match aorg 0000000000.00000000 from server@51.250.53.172 xmt 0xec696fa4.08c929de Sep 08 18:07:16 volumio-nvme ntpd[976]: receive: Unexpected origin timestamp 0xec696fa2.8f606968 does not match aorg 0000000000.00000000 from server@91.206.16.3 xmt 0xec696fa4.0b5671ae Sep 08 18:07:16 volumio-nvme ntpd[976]: receive: Unexpected origin timestamp 0xec696fa2.8f59c04a does not match aorg 0000000000.00000000 from server@90.188.9.144 xmt 0xec696fa4.0e8e7147 Sep 08 18:07:16 volumio-nvme ntpd[976]: receive: Unexpected origin timestamp 0xec696fa2.8f63ecd2 does not match aorg 0000000000.00000000 from server@87.103.245.205 xmt 0xec696fa4.0f0ceb10 Sep 08 18:07:27 volumio-nvme sudo[2334]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 08 18:07:27 volumio-nvme sudo[2334]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 18:07:27 volumio-nvme sudo[2334]: pam_unix(sudo:session): session closed for user root Sep 08 18:07:27 volumio-nvme sudo[2336]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 08 18:07:27 volumio-nvme sudo[2336]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 18:07:27 volumio-nvme sudo[2336]: pam_unix(sudo:session): session closed for user root Sep 08 18:07:27 volumio-nvme volumio[1198]: verbose: New Socket.io Connection to 192.168.1.245 from 192.168.1.168 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Sep 08 18:07:27 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 08 18:07:27 volumio-nvme sudo[2340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 08 18:07:27 volumio-nvme sudo[2340]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 18:07:27 volumio-nvme sudo[2340]: pam_unix(sudo:session): session closed for user root Sep 08 18:07:27 volumio-nvme sudo[2343]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 08 18:07:27 volumio-nvme sudo[2343]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 18:07:27 volumio-nvme sudo[2343]: pam_unix(sudo:session): session closed for user root Sep 08 18:07:27 volumio-nvme volumio[1198]: verbose: New Socket.io Connection to 192.168.1.245 from 192.168.1.168 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Sep 08 18:07:27 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 08 18:07:27 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 08 18:07:27 volumio-nvme volumio[1198]: info: CoreCommandRouter::volumioGetVisibleSources Sep 08 18:07:27 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 08 18:07:27 volumio-nvme volumio[1198]: info: CoreCommandRouter::volumioGetState Sep 08 18:07:27 volumio-nvme volumio[1198]: info: CorePlayQueue::getTrack 0 Sep 08 18:07:27 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 08 18:07:27 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 08 18:07:27 volumio-nvme volumio[1198]: info: Received Get System Info Sep 08 18:07:27 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 08 18:07:27 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 08 18:07:27 volumio-nvme volumio[1198]: info: Discovery: Getting this device information Sep 08 18:07:27 volumio-nvme volumio[1198]: info: CoreCommandRouter::volumioGetState Sep 08 18:07:27 volumio-nvme volumio[1198]: info: CorePlayQueue::getTrack 0 Sep 08 18:07:27 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 08 18:07:27 volumio-nvme volumio[1198]: info: CoreCommandRouter::volumioGetState Sep 08 18:07:27 volumio-nvme volumio[1198]: info: CorePlayQueue::getTrack 0 Sep 08 18:07:27 volumio-nvme volumio[1198]: info: Listing playlists Sep 08 18:07:27 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 08 18:07:27 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 08 18:07:27 volumio-nvme volumio[1198]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 08 18:07:27 volumio-nvme volumio[1198]: info: FusionDsp - no preset used Sep 08 18:07:27 volumio-nvme volumio[1198]: info: FusionDsp - undefined Sep 08 18:07:27 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 08 18:07:29 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Sep 08 18:07:29 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 08 18:07:29 volumio-nvme volumio[1198]: info: Received Get System Info Sep 08 18:07:29 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 08 18:07:29 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 08 18:07:29 volumio-nvme volumio[1198]: info: Discovery: Getting this device information Sep 08 18:07:29 volumio-nvme volumio[1198]: info: CoreCommandRouter::volumioGetState Sep 08 18:07:29 volumio-nvme volumio[1198]: info: CorePlayQueue::getTrack 0 Sep 08 18:07:29 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 08 18:07:30 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 08 18:07:30 volumio-nvme volumio[1198]: info: Received Get System Info Sep 08 18:07:30 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 08 18:07:30 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 08 18:07:30 volumio-nvme volumio[1198]: info: Discovery: Getting this device information Sep 08 18:07:30 volumio-nvme volumio[1198]: info: CoreCommandRouter::volumioGetState Sep 08 18:07:30 volumio-nvme volumio[1198]: info: CorePlayQueue::getTrack 0 Sep 08 18:07:30 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 08 18:07:33 volumio-nvme volumio[1198]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 08 18:07:33 volumio-nvme volumio[1198]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 08 18:07:33 volumio-nvme volumio[1198]: info: Retrieving Cloud Streaming UI Sep 08 18:07:33 volumio-nvme volumio[1198]: info: Getting Tidal Cloud Configuration Sep 08 18:07:33 volumio-nvme volumio[1198]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 08 18:07:33 volumio-nvme volumio[1198]: info: Getting Qobuz Cloud Configuration Sep 08 18:07:33 volumio-nvme volumio[1198]: info: Asking plugin for UI Config Sep 08 18:07:33 volumio-nvme volumio[1198]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 08 18:07:33 volumio-nvme volumio[1198]: info: Getting Spotify Cloud Configuration Sep 08 18:07:33 volumio-nvme volumio[1198]: info: Asking plugin for UI Config Sep 08 18:07:33 volumio-nvme volumio[1198]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 08 18:07:33 volumio-nvme volumio[1198]: info: Saving Spotify Acccount Sep 08 18:07:33 volumio-nvme volumio[1198]: info: Got Tidal Cloud Configuration Sep 08 18:07:33 volumio-nvme volumio[1198]: info: Got it Sep 08 18:07:33 volumio-nvme volumio[1198]: info: Got it Sep 08 18:07:33 volumio-nvme volumio[1198]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Sep 08 18:07:33 volumio-nvme volumio[1198]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 08 18:07:33 volumio-nvme volumio[1198]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Sep 08 18:07:33 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 08 18:07:33 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 08 18:07:33 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 08 18:07:33 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 08 18:07:33 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 08 18:07:33 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 08 18:07:33 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 08 18:07:33 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 08 18:07:33 volumio-nvme volumio[1198]: info: CoreCommandRouter::volumioGetBrowseSources Sep 08 18:07:33 volumio-nvme volumio[1198]: info: CoreCommandRouter::volumioGetBrowseSources Sep 08 18:07:33 volumio-nvme volumio[1198]: info: CoreCommandRouter::volumioGetBrowseSources Sep 08 18:07:33 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 08 18:07:33 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Sep 08 18:07:37 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 08 18:07:37 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 08 18:07:39 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Sep 08 18:07:39 volumio-nvme volumio[1198]: verbose: ControllerMpd::sendMpdCommand update Sep 08 18:07:39 volumio-nvme volumio[1198]: verbose: ControllerMpd::sendMpdCommand status Sep 08 18:07:39 volumio-nvme volumio[1198]: info: Sep 08 18:07:39 volumio-nvme volumio[1198]: ---------------------------- MPD announces state update: update Sep 08 18:07:39 volumio-nvme volumio[1198]: info: sendMpdCommand update took 3 milliseconds Sep 08 18:07:39 volumio-nvme volumio[1198]: info: ControllerMpd::getState Sep 08 18:07:39 volumio-nvme volumio[1198]: verbose: ControllerMpd::sendMpdCommand status Sep 08 18:07:39 volumio-nvme volumio[1198]: info: sendMpdCommand status took 6 milliseconds Sep 08 18:07:39 volumio-nvme volumio[1198]: info: sendMpdCommand status took 4 milliseconds Sep 08 18:07:39 volumio-nvme volumio[1198]: verbose: ControllerMpd::parseState Sep 08 18:07:39 volumio-nvme volumio[1198]: info: Command Router : Notfying DB Updatetrue Sep 08 18:07:39 volumio-nvme volumio[1198]: verbose: ControllerMpd::parseState Sep 08 18:07:39 volumio-nvme volumio[1198]: info: ControllerMpd::pushState Sep 08 18:07:39 volumio-nvme volumio[1198]: info: CoreCommandRouter::servicePushState Sep 08 18:07:39 volumio-nvme volumio[1198]: info: CoreStateMachine::pushState Sep 08 18:07:39 volumio-nvme volumio[1198]: info: CorePlayQueue::getTrack 0 Sep 08 18:07:39 volumio-nvme volumio[1198]: info: CoreCommandRouter::volumioPushState Sep 08 18:07:39 volumio-nvme volumio[1198]: info: CorePlayQueue::getTrack 0 Sep 08 18:07:39 volumio-nvme volumio[1198]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 08 18:07:39 volumio-nvme volumio[1198]: verbose: CURRENT POSITION 0 Sep 08 18:07:39 volumio-nvme volumio[1198]: info: CoreStateMachine::syncState stateService stop Sep 08 18:07:39 volumio-nvme volumio[1198]: info: CoreStateMachine::syncState currentStatus stop Sep 08 18:07:39 volumio-nvme volumio[1198]: info: CoreStateMachine::pushState Sep 08 18:07:39 volumio-nvme volumio[1198]: info: CorePlayQueue::getTrack 0 Sep 08 18:07:39 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 08 18:07:39 volumio-nvme volumio[1198]: info: CoreCommandRouter::volumioPushState Sep 08 18:07:39 volumio-nvme volumio[1198]: info: No code Sep 08 18:07:39 volumio-nvme volumio[1198]: info: CoreStateMachine::pushState Sep 08 18:07:39 volumio-nvme volumio[1198]: info: CorePlayQueue::getTrack 0 Sep 08 18:07:39 volumio-nvme volumio[1198]: info: CoreCommandRouter::volumioPushState Sep 08 18:07:39 volumio-nvme volumio[1198]: info: ------------------------------ 42ms Sep 08 18:07:39 volumio-nvme volumio[1198]: verbose: ControllerMpd::sendMpdCommand status Sep 08 18:07:39 volumio-nvme volumio[1198]: info: Sep 08 18:07:39 volumio-nvme volumio[1198]: ---------------------------- MPD announces state update: update Sep 08 18:07:39 volumio-nvme volumio[1198]: info: ControllerMpd::getState Sep 08 18:07:39 volumio-nvme volumio[1198]: verbose: ControllerMpd::sendMpdCommand status Sep 08 18:07:39 volumio-nvme volumio[1198]: info: sendMpdCommand status took 0 milliseconds Sep 08 18:07:39 volumio-nvme volumio[1198]: info: sendMpdCommand status took 0 milliseconds Sep 08 18:07:39 volumio-nvme volumio[1198]: verbose: ControllerMpd::parseState Sep 08 18:07:39 volumio-nvme volumio[1198]: info: Command Router : Notfying DB Updatefalse Sep 08 18:07:39 volumio-nvme volumio[1198]: info: CoreCommandRouter::Close All Modals sent Sep 08 18:07:39 volumio-nvme volumio[1198]: verbose: ControllerMpd::parseState Sep 08 18:07:39 volumio-nvme volumio[1198]: info: ControllerMpd::pushState Sep 08 18:07:39 volumio-nvme volumio[1198]: info: CoreCommandRouter::servicePushState Sep 08 18:07:39 volumio-nvme volumio[1198]: info: CoreStateMachine::pushState Sep 08 18:07:39 volumio-nvme volumio[1198]: info: CorePlayQueue::getTrack 0 Sep 08 18:07:39 volumio-nvme volumio[1198]: info: CoreCommandRouter::volumioPushState Sep 08 18:07:39 volumio-nvme volumio[1198]: info: CorePlayQueue::getTrack 0 Sep 08 18:07:39 volumio-nvme volumio[1198]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 08 18:07:39 volumio-nvme volumio[1198]: verbose: CURRENT POSITION 0 Sep 08 18:07:39 volumio-nvme volumio[1198]: info: CoreStateMachine::syncState stateService stop Sep 08 18:07:39 volumio-nvme volumio[1198]: info: CoreStateMachine::syncState currentStatus stop Sep 08 18:07:39 volumio-nvme volumio[1198]: info: CoreStateMachine::pushState Sep 08 18:07:39 volumio-nvme volumio[1198]: info: CorePlayQueue::getTrack 0 Sep 08 18:07:39 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 08 18:07:39 volumio-nvme volumio[1198]: info: CoreCommandRouter::volumioPushState Sep 08 18:07:39 volumio-nvme volumio[1198]: info: No code Sep 08 18:07:39 volumio-nvme volumio[1198]: info: CoreStateMachine::pushState Sep 08 18:07:39 volumio-nvme volumio[1198]: info: CorePlayQueue::getTrack 0 Sep 08 18:07:39 volumio-nvme volumio[1198]: info: CoreCommandRouter::volumioPushState Sep 08 18:07:39 volumio-nvme volumio[1198]: info: ------------------------------ 22ms Sep 08 18:07:41 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Sep 08 18:07:41 volumio-nvme volumio[1198]: verbose: ControllerMpd::sendMpdCommand rescan Sep 08 18:07:41 volumio-nvme volumio[1198]: verbose: ControllerMpd::sendMpdCommand status Sep 08 18:07:41 volumio-nvme volumio[1198]: info: Sep 08 18:07:41 volumio-nvme volumio[1198]: ---------------------------- MPD announces state update: update Sep 08 18:07:41 volumio-nvme volumio[1198]: info: sendMpdCommand rescan took 2 milliseconds Sep 08 18:07:41 volumio-nvme volumio[1198]: info: ControllerMpd::getState Sep 08 18:07:41 volumio-nvme volumio[1198]: verbose: ControllerMpd::sendMpdCommand status Sep 08 18:07:41 volumio-nvme volumio[1198]: info: sendMpdCommand status took 1 milliseconds Sep 08 18:07:41 volumio-nvme volumio[1198]: verbose: ControllerMpd::parseState Sep 08 18:07:41 volumio-nvme volumio[1198]: info: Command Router : Notfying DB Updatetrue Sep 08 18:07:41 volumio-nvme volumio[1198]: info: CoreCommandRouter::Close All Modals sent Sep 08 18:07:41 volumio-nvme volumio[1198]: verbose: ControllerMpd::parseState Sep 08 18:07:41 volumio-nvme volumio[1198]: info: ControllerMpd::pushState Sep 08 18:07:41 volumio-nvme volumio[1198]: info: CoreCommandRouter::servicePushState Sep 08 18:07:41 volumio-nvme volumio[1198]: info: CoreStateMachine::pushState Sep 08 18:07:41 volumio-nvme volumio[1198]: info: CorePlayQueue::getTrack 0 Sep 08 18:07:41 volumio-nvme volumio[1198]: info: CoreCommandRouter::volumioPushState Sep 08 18:07:41 volumio-nvme volumio[1198]: info: CorePlayQueue::getTrack 0 Sep 08 18:07:41 volumio-nvme volumio[1198]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 08 18:07:41 volumio-nvme volumio[1198]: verbose: CURRENT POSITION 0 Sep 08 18:07:41 volumio-nvme volumio[1198]: info: CoreStateMachine::syncState stateService stop Sep 08 18:07:41 volumio-nvme volumio[1198]: info: CoreStateMachine::syncState currentStatus stop Sep 08 18:07:41 volumio-nvme volumio[1198]: info: CoreStateMachine::pushState Sep 08 18:07:41 volumio-nvme volumio[1198]: info: CorePlayQueue::getTrack 0 Sep 08 18:07:41 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 08 18:07:41 volumio-nvme volumio[1198]: info: CoreCommandRouter::volumioPushState Sep 08 18:07:41 volumio-nvme volumio[1198]: info: No code Sep 08 18:07:41 volumio-nvme volumio[1198]: info: CoreStateMachine::pushState Sep 08 18:07:41 volumio-nvme volumio[1198]: info: CorePlayQueue::getTrack 0 Sep 08 18:07:41 volumio-nvme volumio[1198]: info: CoreCommandRouter::volumioPushState Sep 08 18:07:41 volumio-nvme volumio[1198]: info: ------------------------------ 34ms Sep 08 18:07:41 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 08 18:07:45 volumio-nvme volumio[1198]: info: MPD Database updated - AlbumList cache refreshed Sep 08 18:07:45 volumio-nvme volumio[1198]: info: Sep 08 18:07:45 volumio-nvme volumio[1198]: ---------------------------- MPD announces state update: database Sep 08 18:07:45 volumio-nvme volumio[1198]: verbose: ControllerMpd::sendMpdCommand status Sep 08 18:07:45 volumio-nvme volumio[1198]: info: Sep 08 18:07:45 volumio-nvme volumio[1198]: ---------------------------- MPD announces state update: update Sep 08 18:07:45 volumio-nvme volumio[1198]: info: ControllerMpd::getState Sep 08 18:07:45 volumio-nvme volumio[1198]: verbose: ControllerMpd::sendMpdCommand status Sep 08 18:07:45 volumio-nvme volumio[1198]: info: ControllerMpd::getState Sep 08 18:07:45 volumio-nvme volumio[1198]: verbose: ControllerMpd::sendMpdCommand status Sep 08 18:07:45 volumio-nvme volumio[1198]: info: sendMpdCommand status took 20 milliseconds Sep 08 18:07:45 volumio-nvme volumio[1198]: info: sendMpdCommand status took 20 milliseconds Sep 08 18:07:45 volumio-nvme volumio[1198]: info: sendMpdCommand status took 20 milliseconds Sep 08 18:07:45 volumio-nvme volumio[1198]: verbose: ControllerMpd::parseState Sep 08 18:07:45 volumio-nvme volumio[1198]: info: Command Router : Notfying DB Updatefalse Sep 08 18:07:45 volumio-nvme volumio[1198]: info: CoreCommandRouter::Close All Modals sent Sep 08 18:07:45 volumio-nvme volumio[1198]: verbose: ControllerMpd::parseState Sep 08 18:07:45 volumio-nvme volumio[1198]: verbose: ControllerMpd::parseState Sep 08 18:07:45 volumio-nvme volumio[1198]: info: ControllerMpd::pushState Sep 08 18:07:45 volumio-nvme volumio[1198]: info: CoreCommandRouter::servicePushState Sep 08 18:07:45 volumio-nvme volumio[1198]: info: CoreStateMachine::pushState Sep 08 18:07:45 volumio-nvme volumio[1198]: info: CorePlayQueue::getTrack 0 Sep 08 18:07:45 volumio-nvme volumio[1198]: info: CoreCommandRouter::volumioPushState Sep 08 18:07:45 volumio-nvme volumio[1198]: info: CorePlayQueue::getTrack 0 Sep 08 18:07:45 volumio-nvme volumio[1198]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 08 18:07:45 volumio-nvme volumio[1198]: verbose: CURRENT POSITION 0 Sep 08 18:07:45 volumio-nvme volumio[1198]: info: CoreStateMachine::syncState stateService stop Sep 08 18:07:45 volumio-nvme volumio[1198]: info: CoreStateMachine::syncState currentStatus stop Sep 08 18:07:45 volumio-nvme volumio[1198]: info: CoreStateMachine::pushState Sep 08 18:07:45 volumio-nvme volumio[1198]: info: CorePlayQueue::getTrack 0 Sep 08 18:07:45 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 08 18:07:45 volumio-nvme volumio[1198]: info: CoreCommandRouter::volumioPushState Sep 08 18:07:45 volumio-nvme volumio[1198]: info: No code Sep 08 18:07:45 volumio-nvme volumio[1198]: info: CoreStateMachine::pushState Sep 08 18:07:45 volumio-nvme volumio[1198]: info: CorePlayQueue::getTrack 0 Sep 08 18:07:45 volumio-nvme volumio[1198]: info: CoreCommandRouter::volumioPushState Sep 08 18:07:45 volumio-nvme volumio[1198]: info: ControllerMpd::pushState Sep 08 18:07:45 volumio-nvme volumio[1198]: info: CoreCommandRouter::servicePushState Sep 08 18:07:45 volumio-nvme volumio[1198]: info: CoreStateMachine::pushState Sep 08 18:07:45 volumio-nvme volumio[1198]: info: CorePlayQueue::getTrack 0 Sep 08 18:07:45 volumio-nvme volumio[1198]: info: CoreCommandRouter::volumioPushState Sep 08 18:07:45 volumio-nvme volumio[1198]: info: CorePlayQueue::getTrack 0 Sep 08 18:07:45 volumio-nvme volumio[1198]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 08 18:07:45 volumio-nvme volumio[1198]: verbose: CURRENT POSITION 0 Sep 08 18:07:45 volumio-nvme volumio[1198]: info: CoreStateMachine::syncState stateService stop Sep 08 18:07:45 volumio-nvme volumio[1198]: info: CoreStateMachine::syncState currentStatus stop Sep 08 18:07:45 volumio-nvme volumio[1198]: info: CoreStateMachine::pushState Sep 08 18:07:45 volumio-nvme volumio[1198]: info: CorePlayQueue::getTrack 0 Sep 08 18:07:45 volumio-nvme volumio[1198]: info: CoreCommandRouter::volumioPushState Sep 08 18:07:45 volumio-nvme volumio[1198]: info: No code Sep 08 18:07:45 volumio-nvme volumio[1198]: info: CoreStateMachine::pushState Sep 08 18:07:45 volumio-nvme volumio[1198]: info: CorePlayQueue::getTrack 0 Sep 08 18:07:45 volumio-nvme volumio[1198]: info: CoreCommandRouter::volumioPushState Sep 08 18:07:45 volumio-nvme volumio[1198]: info: ------------------------------ 57ms Sep 08 18:07:45 volumio-nvme volumio[1198]: info: ------------------------------ 58ms Sep 08 18:07:45 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 08 18:07:46 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 08 18:07:46 volumio-nvme volumio[1198]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Sep 08 18:07:46 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Sep 08 18:07:46 volumio-nvme volumio[1198]: info: Received Get System Version Sep 08 18:07:46 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 08 18:07:46 volumio-nvme volumio[1198]: info: Received Get System Info Sep 08 18:07:46 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 08 18:07:46 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 08 18:07:46 volumio-nvme volumio[1198]: info: Discovery: Getting this device information Sep 08 18:07:46 volumio-nvme volumio[1198]: info: CoreCommandRouter::volumioGetState Sep 08 18:07:46 volumio-nvme volumio[1198]: info: CorePlayQueue::getTrack 0 Sep 08 18:07:46 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 08 18:07:49 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 08 18:07:53 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 08 18:07:56 volumio-nvme volumio[1198]: info: CoreCommandRouter::volumioGetQueue Sep 08 18:07:56 volumio-nvme volumio[1198]: info: CoreStateMachine::getQueue Sep 08 18:07:56 volumio-nvme volumio[1198]: info: CorePlayQueue::getQueue Sep 08 18:08:00 volumio-nvme volumiologrotate[692]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Sep 08 18:08:00 volumio-nvme volumiologrotate[692]: ls: cannot access 'NVME': No such file or directory Sep 08 18:08:04 volumio-nvme volumio[1198]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 08 18:08:04 volumio-nvme volumio[1198]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 08 18:08:04 volumio-nvme volumio[1198]: info: Retrieving Cloud Streaming UI Sep 08 18:08:04 volumio-nvme volumio[1198]: info: Getting Tidal Cloud Configuration Sep 08 18:08:04 volumio-nvme volumio[1198]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 08 18:08:04 volumio-nvme volumio[1198]: info: Getting Qobuz Cloud Configuration Sep 08 18:08:04 volumio-nvme volumio[1198]: info: Asking plugin for UI Config Sep 08 18:08:04 volumio-nvme volumio[1198]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 08 18:08:04 volumio-nvme volumio[1198]: info: Getting Spotify Cloud Configuration Sep 08 18:08:04 volumio-nvme volumio[1198]: info: Asking plugin for UI Config Sep 08 18:08:04 volumio-nvme volumio[1198]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 08 18:08:04 volumio-nvme volumio[1198]: info: Saving Spotify Acccount Sep 08 18:08:04 volumio-nvme volumio[1198]: info: Got Tidal Cloud Configuration Sep 08 18:08:04 volumio-nvme volumio[1198]: info: Got it Sep 08 18:08:04 volumio-nvme volumio[1198]: info: Got it Sep 08 18:08:04 volumio-nvme volumio[1198]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Sep 08 18:08:04 volumio-nvme volumio[1198]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 08 18:08:04 volumio-nvme volumio[1198]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Sep 08 18:08:04 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 08 18:08:04 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 08 18:08:04 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 08 18:08:04 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 08 18:08:04 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 08 18:08:04 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 08 18:08:04 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 08 18:08:04 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 08 18:08:04 volumio-nvme volumio[1198]: info: CoreCommandRouter::volumioGetBrowseSources Sep 08 18:08:04 volumio-nvme volumio[1198]: info: CoreCommandRouter::volumioGetBrowseSources Sep 08 18:08:04 volumio-nvme volumio[1198]: info: CoreCommandRouter::volumioGetBrowseSources Sep 08 18:08:04 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 08 18:08:04 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Sep 08 18:08:08 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 08 18:08:10 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Sep 08 18:08:10 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Sep 08 18:08:12 volumio-nvme volumio[1198]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L xigmanas.local. -m SMB3_11 Sep 08 18:08:12 volumio-nvme volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 08 18:08:15 volumio-nvme volumio[1198]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 08 18:08:15 volumio-nvme volumio[1198]: Error: dns service error: unknown Sep 08 18:08:15 volumio-nvme volumio[1198]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Sep 08 18:08:15 volumio-nvme volumio[1198]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Sep 08 18:08:15 volumio-nvme volumio[1198]: errorCode: -65537 Sep 08 18:08:15 volumio-nvme volumio[1198]: } Sep 08 18:08:15 volumio-nvme volumio[1198]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 08 18:08:15 volumio-nvme sudo[2496]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-08 18:07 Sep 08 18:08:15 volumio-nvme sudo[2496]: 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"