-- Logs begin at Thu 2019-02-14 10:11:58 UTC, end at Tue 2025-12-09 18:11:59 UTC. -- Dec 09 18:10:15 volumio systemd-timedated[1205]: Changed local time to Tue Dec 9 18:10:15 2025 Dec 09 18:10:15 volumio sudo[1203]: pam_unix(sudo:session): session closed for user root Dec 09 18:10:15 volumio volumio-time-update[601]: volumio-time-update-util: System time updated successfully. Dec 09 18:10:15 volumio systemd[1]: Started Volumio Time Update Utility. Dec 09 18:10:15 volumio volumio[1140]: info: Loading plugin "network"... Dec 09 18:10:15 volumio volumio[1140]: info: Refreshing Cached IP Addresses Dec 09 18:10:15 volumio sudo[1210]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 09 18:10:15 volumio sudo[1210]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 09 18:10:15 volumio sudo[1210]: pam_unix(sudo:session): session closed for user root Dec 09 18:10:15 volumio sudo[1212]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 09 18:10:15 volumio sudo[1212]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 09 18:10:15 volumio sudo[1212]: pam_unix(sudo:session): session closed for user root Dec 09 18:10:15 volumio volumio[1140]: info: Loading plugin "services"... Dec 09 18:10:15 volumio volumio[1140]: info: Loading plugin "alsa_controller"... Dec 09 18:10:15 volumio sudo[1221]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 09 18:10:15 volumio sudo[1221]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 09 18:10:15 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 09 18:10:15 volumio volumio[1140]: info: Loading plugin "wizard"... Dec 09 18:10:15 volumio volumio[1140]: info: Loading plugin "networkfs"... Dec 09 18:10:15 volumio volumio[1140]: info: Starting Udev Watcher for removable devices Dec 09 18:10:15 volumio sudo[1236]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=claudio,password=putrella,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.26/musica1 /mnt/NAS/musica1 Dec 09 18:10:15 volumio sudo[1236]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 09 18:10:15 volumio sudo[1238]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=claudio,password=putrella,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.26/musica2 /mnt/NAS/musica2 Dec 09 18:10:15 volumio sudo[1238]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 09 18:10:15 volumio volumio[1140]: info: Ignoring mount for partition: boot Dec 09 18:10:15 volumio volumio[1140]: info: Ignoring mount for partition: volumio Dec 09 18:10:15 volumio volumio[1140]: info: Ignoring mount for partition: volumio_data Dec 09 18:10:15 volumio volumio[1140]: error: Cannot associate FS Label, not mounting Dec 09 18:10:15 volumio volumio[1140]: info: Mounting Device EXTERNAL_US Dec 09 18:10:15 volumio sudo[1252]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda2 /mnt/USB/EXTERNAL_US -o noatime Dec 09 18:10:15 volumio sudo[1252]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 09 18:10:15 volumio kernel: Key type cifs.spnego registered Dec 09 18:10:15 volumio kernel: Key type cifs.idmap registered Dec 09 18:10:15 volumio kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Dec 09 18:10:15 volumio kernel: CIFS: Attempting to mount //192.168.1.26/musica1 Dec 09 18:10:16 volumio kernel: cryptd: max_cpu_qlen set to 1000 Dec 09 18:10:16 volumio nmbd[818]: [2025/12/09 18:10:16.353543, 0] ../lib/util/become_daemon.c:138(daemon_ready) Dec 09 18:10:16 volumio nmbd[818]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Dec 09 18:10:16 volumio systemd[1]: Started Samba NMB Daemon. Dec 09 18:10:16 volumio systemd[1]: Starting Samba Winbind Daemon... Dec 09 18:10:16 volumio sudo[1252]: pam_unix(sudo:session): session closed for user root Dec 09 18:10:16 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 09 18:10:16 volumio volumio[1140]: info: Loading plugin "volumio_command_line_client"... Dec 09 18:10:16 volumio volumio[1140]: info: Loading plugin "upnp"... Dec 09 18:10:16 volumio volumio[1140]: info: [1765303816460] Starting Upmpd Daemon Dec 09 18:10:16 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 09 18:10:16 volumio volumio[1140]: info: Loading plugin "my_music"... Dec 09 18:10:16 volumio volumio[1140]: info: Loading plugin "mpd"... Dec 09 18:10:16 volumio winbindd[1303]: [2025/12/09 18:10:16.639017, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Dec 09 18:10:16 volumio winbindd[1303]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Dec 09 18:10:16 volumio winbindd[1303]: [2025/12/09 18:10:16.663790, 0] ../lib/util/become_daemon.c:138(daemon_ready) Dec 09 18:10:16 volumio winbindd[1303]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Dec 09 18:10:16 volumio systemd[1]: Started Samba Winbind Daemon. Dec 09 18:10:16 volumio sudo[1236]: pam_unix(sudo:session): session closed for user root Dec 09 18:10:16 volumio kernel: CIFS: Attempting to mount //192.168.1.26/musica2 Dec 09 18:10:16 volumio systemd[1]: Starting Samba SMB Daemon... Dec 09 18:10:16 volumio volumio[1140]: info: Loading plugin "upnp_browser"... Dec 09 18:10:17 volumio volumio-remote-updater[604]: [2025-12-09 18:10:17] [connect] Successful connection Dec 09 18:10:17 volumio sudo[1238]: pam_unix(sudo:session): session closed for user root Dec 09 18:10:17 volumio smbd[1309]: [2025/12/09 18:10:17.087774, 0] ../lib/util/become_daemon.c:138(daemon_ready) Dec 09 18:10:17 volumio systemd[1]: Started Samba SMB Daemon. Dec 09 18:10:17 volumio smbd[1309]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Dec 09 18:10:17 volumio systemd[1]: Reached target Multi-User System. Dec 09 18:10:17 volumio systemd[1]: Reached target Graphical Interface. Dec 09 18:10:17 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Dec 09 18:10:17 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Dec 09 18:10:17 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Dec 09 18:10:17 volumio systemd[1]: Startup finished in 12.468s (kernel) + 26.822s (userspace) = 39.291s. Dec 09 18:10:17 volumio volumio[1140]: info: Loading plugin "alarm-clock"... Dec 09 18:10:17 volumio volumio[1140]: info: Loading plugin "airplay_emulation"... Dec 09 18:10:17 volumio volumio[1140]: info: Starting Shairport Sync Dec 09 18:10:17 volumio volumio[1140]: info: Loading plugin "last_100"... Dec 09 18:10:17 volumio volumio[1140]: info: Loading plugin "webradio"... Dec 09 18:10:17 volumio volumio[1140]: info: Loading plugin "i2s_dacs"... Dec 09 18:10:17 volumio volumio[1140]: info: I2S DAC not set, start Auto-detection Dec 09 18:10:17 volumio volumio[1140]: info: Loading plugin "volumiodiscovery"... Dec 09 18:10:17 volumio volumio[1140]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 09 18:10:17 volumio volumio[1140]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 09 18:10:17 volumio volumio[1140]: *** WARNING *** For more information see Dec 09 18:10:17 volumio node[1140]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 09 18:10:17 volumio volumio[1140]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 09 18:10:17 volumio volumio[1140]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 09 18:10:17 volumio volumio[1140]: *** WARNING *** For more information see Dec 09 18:10:17 volumio node[1140]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 09 18:10:17 volumio node[1140]: *** WARNING *** For more information see Dec 09 18:10:17 volumio node[1140]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 09 18:10:17 volumio node[1140]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 09 18:10:17 volumio node[1140]: *** WARNING *** For more information see Dec 09 18:10:17 volumio volumio[1140]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 09 18:10:17 volumio volumio[1140]: info: Discovery: Started advertising with name: Volumio Dec 09 18:10:17 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 09 18:10:17 volumio volumio[1140]: info: Loading plugin "outputs"... Dec 09 18:10:17 volumio volumio[1140]: info: Loading plugin "albumart"... Dec 09 18:10:17 volumio volumio[1140]: info: Plugin example_plugin is not enabled Dec 09 18:10:17 volumio volumio[1140]: info: Loading plugin "inputs"... Dec 09 18:10:17 volumio volumio[1140]: info: Loading plugin "updater_comm"... Dec 09 18:10:17 volumio volumio[1140]: info: Plugin mpdemulation is not enabled Dec 09 18:10:17 volumio volumio[1140]: info: Loading plugin "rest_api"... Dec 09 18:10:17 volumio volumio[1140]: info: Loading plugin "websocket"... Dec 09 18:10:17 volumio volumio[1140]: info: Starting Socket.io Server version 2.3.0 Dec 09 18:10:17 volumio volumio[1140]: info: Plugin fusiondsp is not enabled Dec 09 18:10:17 volumio volumio[1140]: Forking 3 albumart workers Dec 09 18:10:17 volumio volumio[1140]: info: Loading i18n strings for locale it Dec 09 18:10:17 volumio volumio[1140]: Updating browse sources language Dec 09 18:10:17 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::initPlayerControls Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 09 18:10:18 volumio volumio[1140]: Express server listening on port 3000 Dec 09 18:10:18 volumio volumio[1140]: [Metrics] WebUI: 5s 254.66ms Dec 09 18:10:18 volumio volumio[1140]: info: CoreStateMachine::resetVolumioState Dec 09 18:10:18 volumio volumio[1140]: info: CoreStateMachine::getcurrentVolume Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::volumioRetrievevolume Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 09 18:10:18 volumio volumio[1140]: info: Volumio Network Manager: Network status updated: 2 Dec 09 18:10:18 volumio volumio[1140]: verbose: New Socket.io Connection to 192.168.1.28 from 192.168.1.5 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Dec 09 18:10:18 volumio volumio-remote-updater[604]: [2025-12-09 18:10:18] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1765303817 101 Dec 09 18:10:18 volumio volumio[1140]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 2 Dec 09 18:10:18 volumio volumio[1140]: info: CoreStateMachine::pushState Dec 09 18:10:18 volumio volumio[1140]: info: CorePlayQueue::getTrack 0 Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::volumioPushState Dec 09 18:10:18 volumio volumio[1140]: info: CoreStateMachine::updateTrackBlock Dec 09 18:10:18 volumio volumio[1140]: info: CorePlayQueue::getTrackBlock Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::volumioRetrievevolume Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::volumioGetState Dec 09 18:10:18 volumio volumio[1140]: info: CorePlayQueue::getTrack 0 Dec 09 18:10:18 volumio volumio[1140]: Starting albumart workers Dec 09 18:10:18 volumio volumio[1140]: Starting albumart workers Dec 09 18:10:18 volumio volumio[1140]: info: Setting Device type: Raspberry PI Dec 09 18:10:18 volumio volumio[1140]: info: CoreStateMachine::setRepeat false single undefined Dec 09 18:10:18 volumio volumio[1140]: info: CoreStateMachine::pushState Dec 09 18:10:18 volumio volumio[1140]: info: CorePlayQueue::getTrack 0 Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::volumioPushState Dec 09 18:10:18 volumio volumio[1140]: info: CoreStateMachine::setRandom false Dec 09 18:10:18 volumio volumio[1140]: info: CoreStateMachine::pushState Dec 09 18:10:18 volumio volumio[1140]: info: CorePlayQueue::getTrack 0 Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::volumioPushState Dec 09 18:10:18 volumio volumio[1140]: Starting albumart workers Dec 09 18:10:18 volumio volumio[1140]: info: CoreStateMachine::pushState Dec 09 18:10:18 volumio volumio[1140]: info: CorePlayQueue::getTrack 0 Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::volumioPushState Dec 09 18:10:18 volumio volumio[1140]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Dec 09 18:10:18 volumio volumio[1140]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03112 Dec 09 18:10:18 volumio volumio[1140]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Dec 09 18:10:18 volumio volumio[1140]: info: Listing playlists Dec 09 18:10:18 volumio volumio[1140]: info: Listing playlists Dec 09 18:10:18 volumio volumio[1140]: info: Completed loading Core Plugins Dec 09 18:10:18 volumio volumio[1140]: info: Preparing to generate the ALSA configuration file Dec 09 18:10:18 volumio volumio[1140]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Dec 09 18:10:18 volumio volumio[1140]: info: Reading ALSA contributions from plugins. Dec 09 18:10:18 volumio volumio[1140]: info: Asound.conf file unchanged, so no further update is needed Dec 09 18:10:18 volumio volumio[1140]: info: Output device has changed, restarting MPD Dec 09 18:10:18 volumio volumio[1140]: info: Output device has changed, restarting Shairport Sync Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 09 18:10:18 volumio sudo[1369]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 09 18:10:18 volumio sudo[1369]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 09 18:10:18 volumio sudo[1371]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 09 18:10:18 volumio sudo[1371]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 09 18:10:18 volumio sudo[1369]: pam_unix(sudo:session): session closed for user root Dec 09 18:10:18 volumio volumio[1140]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 09 18:10:18 volumio volumio[1140]: info: ___________ START PLUGINS ___________ Dec 09 18:10:18 volumio volumio[1140]: info: ControllerMpd::onStart: Initializing MPD Dec 09 18:10:18 volumio volumio[1140]: info: Creating MPD Configuration file Dec 09 18:10:18 volumio sudo[1221]: pam_unix(sudo:session): session closed for user root Dec 09 18:10:18 volumio systemd[1]: Stopping Music Player Daemon... Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 09 18:10:18 volumio volumio[1140]: info: [1765303818779] CoreMusicLibrary::Adding element Server multimediali Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 09 18:10:18 volumio sudo[1380]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 09 18:10:18 volumio sudo[1380]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 09 18:10:18 volumio sudo[1378]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 09 18:10:18 volumio sudo[1378]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 09 18:10:18 volumio sudo[1378]: pam_unix(sudo:session): session closed for user root Dec 09 18:10:18 volumio volumio[1140]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 09 18:10:18 volumio systemd[1]: mpd.service: Succeeded. Dec 09 18:10:18 volumio volumio[1140]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 09 18:10:18 volumio volumio[1140]: info: [1765303818901] CoreMusicLibrary::Adding element Last_100 Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 09 18:10:18 volumio volumio[1140]: info: [1765303818903] CoreMusicLibrary::Adding element Webradio Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 09 18:10:18 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 09 18:10:18 volumio systemd[1]: Stopped Music Player Daemon. Dec 09 18:10:18 volumio volumio[1140]: info: Initializing BBC Radios Dec 09 18:10:18 volumio systemd[1]: Starting Music Player Daemon... Dec 09 18:10:19 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 09 18:10:19 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 09 18:10:19 volumio volumio[1140]: info: Volumio Calling Home Dec 09 18:10:19 volumio sudo[1389]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 09 18:10:19 volumio sudo[1389]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 09 18:10:19 volumio sudo[1389]: pam_unix(sudo:session): session closed for user root Dec 09 18:10:19 volumio volumio[1140]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Dec 09 18:10:19 volumio volumio[1140]: info: MPD Permissions set Dec 09 18:10:19 volumio volumio[1140]: info: MPD Permissions set Dec 09 18:10:19 volumio volumio[1140]: info: Volumio called home Dec 09 18:10:19 volumio volumio[1140]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Dec 09 18:10:19 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:19 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:19 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:19 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:19 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:19 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:19 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:19 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:19 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 09 18:10:19 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:19 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:19 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:19 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:19 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:19 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:19 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:19 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:19 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:19 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 09 18:10:19 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:19 volumio volumio[1140]: info: Starting Shairport Sync Dec 09 18:10:19 volumio volumio[1140]: info: Starting Shairport Sync Dec 09 18:10:19 volumio sudo[1440]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 09 18:10:19 volumio sudo[1440]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 09 18:10:19 volumio volumio[1140]: info: Starting Shairport Sync Dec 09 18:10:19 volumio sudo[1443]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 09 18:10:19 volumio sudo[1443]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 09 18:10:19 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 09 18:10:19 volumio sudo[1445]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 09 18:10:19 volumio sudo[1445]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 09 18:10:19 volumio systemd[1]: shairport-sync.service: Succeeded. Dec 09 18:10:19 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 09 18:10:19 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 09 18:10:19 volumio volumio[1140]: info: CoreCommandRouter::volumioGetState Dec 09 18:10:19 volumio volumio[1140]: info: CorePlayQueue::getTrack 0 Dec 09 18:10:19 volumio sudo[1440]: pam_unix(sudo:session): session closed for user root Dec 09 18:10:19 volumio sudo[1443]: pam_unix(sudo:session): session closed for user root Dec 09 18:10:19 volumio volumio[1140]: verbose: New Socket.io Connection to 192.168.1.28 from 192.168.1.5 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Dec 09 18:10:19 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 09 18:10:19 volumio systemd[1]: shairport-sync.service: Succeeded. Dec 09 18:10:19 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 09 18:10:19 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 09 18:10:19 volumio volumio[1140]: info: CoreCommandRouter::volumioGetState Dec 09 18:10:19 volumio volumio[1140]: info: CorePlayQueue::getTrack 0 Dec 09 18:10:19 volumio sudo[1445]: pam_unix(sudo:session): session closed for user root Dec 09 18:10:19 volumio volumio[1140]: info: Shairport-Sync Started Dec 09 18:10:19 volumio volumio[1140]: Error adding Membership: Error: addMembership EINVAL Dec 09 18:10:19 volumio volumio[1140]: info: Shairport-Sync Started Dec 09 18:10:19 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 09 18:10:19 volumio volumio[1140]: info: CoreCommandRouter::volumioGetVisibleSources Dec 09 18:10:19 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 09 18:10:19 volumio volumio[1140]: info: Listing playlists Dec 09 18:10:19 volumio volumio[1140]: info: Shairport-Sync Started Dec 09 18:10:19 volumio mpd[1413]: Dec 09 18:10 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 09 18:10:20 volumio volumio[1140]: info: Reloading queue from file Dec 09 18:10:20 volumio systemd[1]: Started Music Player Daemon. Dec 09 18:10:20 volumio sudo[1371]: pam_unix(sudo:session): session closed for user root Dec 09 18:10:20 volumio sudo[1380]: pam_unix(sudo:session): session closed for user root Dec 09 18:10:20 volumio volumio[1140]: info: Completed starting Core Plugins Dec 09 18:10:20 volumio volumio[1140]: info: ------------------------------------------- Dec 09 18:10:20 volumio volumio[1140]: info: ----- MyVolumio plugins startup ---- Dec 09 18:10:20 volumio volumio[1140]: info: ------------------------------------------- Dec 09 18:10:20 volumio volumio[1140]: info: [MyVolumio PluginManager] Fetching plans data.... Dec 09 18:10:20 volumio volumio[1140]: error: MPD error: The expression evaluated to a falsy value: Dec 09 18:10:20 volumio volumio[1140]: assert.ok(self.idling) Dec 09 18:10:20 volumio volumio[1140]: error: The expression evaluated to a falsy value: Dec 09 18:10:20 volumio volumio[1140]: assert.ok(self.idling) Dec 09 18:10:20 volumio volumio[1140]: info: MPD running with PID1413 Dec 09 18:10:20 volumio volumio[1140]: ,establishing connection Dec 09 18:10:20 volumio volumio[1140]: error: MPD error: The expression evaluated to a falsy value: Dec 09 18:10:20 volumio volumio[1140]: assert.ok(self.idling) Dec 09 18:10:20 volumio volumio[1140]: error: The expression evaluated to a falsy value: Dec 09 18:10:20 volumio volumio[1140]: assert.ok(self.idling) Dec 09 18:10:20 volumio volumio[1140]: error: updateQueue error: null Dec 09 18:10:23 volumio systemd[1]: systemd-fsckd.service: Succeeded. Dec 09 18:10:25 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Dec 09 18:10:26 volumio sudo[1477]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 09 18:10:26 volumio sudo[1477]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 09 18:10:26 volumio sudo[1477]: pam_unix(sudo:session): session closed for user root Dec 09 18:10:26 volumio sudo[1480]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 09 18:10:26 volumio sudo[1480]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 09 18:10:26 volumio sudo[1480]: pam_unix(sudo:session): session closed for user root Dec 09 18:10:28 volumio volumio[1140]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 09 18:10:30 volumio volumio[1140]: info: CoreCommandRouter::volumioGetState Dec 09 18:10:30 volumio volumio[1140]: info: CorePlayQueue::getTrack 0 Dec 09 18:10:34 volumio sudo[1483]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Dec 09 18:10:34 volumio sudo[1483]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 09 18:10:34 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 09 18:10:34 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 09 18:10:34 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 09 18:10:34 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 09 18:10:34 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 09 18:10:34 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 09 18:10:34 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 09 18:10:34 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 09 18:10:34 volumio volumio[1140]: info: CoreCommandRouter::volumioGetBrowseSources Dec 09 18:10:34 volumio volumio[1140]: info: CoreCommandRouter::volumioGetBrowseSources Dec 09 18:10:34 volumio volumio[1140]: info: CoreCommandRouter::volumioGetBrowseSources Dec 09 18:10:34 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Dec 09 18:10:34 volumio sudo[1483]: pam_unix(sudo:session): session closed for user root Dec 09 18:10:35 volumio volumio[1140]: info: Upmpdcli Daemon Started Dec 09 18:10:36 volumio volumio[1140]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Dec 09 18:10:36 volumio volumio[1140]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Dec 09 18:10:36 volumio volumio[1140]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Dec 09 18:10:36 volumio volumio[1140]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Dec 09 18:10:36 volumio volumio[1140]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Dec 09 18:10:36 volumio volumio[1140]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Dec 09 18:10:36 volumio volumio[1140]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Dec 09 18:10:36 volumio volumio[1140]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Dec 09 18:10:36 volumio volumio[1140]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Dec 09 18:10:36 volumio volumio[1140]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Dec 09 18:10:36 volumio volumio[1140]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Dec 09 18:10:36 volumio volumio[1140]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Dec 09 18:10:36 volumio volumio[1140]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Dec 09 18:10:36 volumio volumio[1140]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Dec 09 18:10:36 volumio volumio[1140]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Dec 09 18:10:36 volumio volumio[1140]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Dec 09 18:10:36 volumio volumio[1140]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Dec 09 18:10:36 volumio volumio[1140]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Dec 09 18:10:36 volumio volumio[1140]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Dec 09 18:10:36 volumio volumio[1140]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Dec 09 18:10:36 volumio volumio[1140]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Dec 09 18:10:36 volumio volumio[1140]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Dec 09 18:10:36 volumio volumio[1140]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Dec 09 18:10:36 volumio volumio[1140]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Dec 09 18:10:36 volumio volumio[1140]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Dec 09 18:10:36 volumio volumio[1140]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Dec 09 18:10:36 volumio volumio[1140]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Dec 09 18:10:36 volumio volumio[1140]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Dec 09 18:10:36 volumio volumio[1140]: info: Adding plugin bluetooth to MyMusic Plugins Dec 09 18:10:36 volumio volumio[1140]: info: Adding plugin multiroom to MyMusic Plugins Dec 09 18:10:36 volumio volumio[1140]: info: Adding plugin metavolumio to MyMusic Plugins Dec 09 18:10:36 volumio volumio[1140]: info: Adding plugin cd_controller to MyMusic Plugins Dec 09 18:10:36 volumio volumio[1140]: info: Adding plugin qobuzconnect to MyMusic Plugins Dec 09 18:10:36 volumio volumio[1140]: info: Adding plugin smart_inputs to MyMusic Plugins Dec 09 18:10:36 volumio volumio[1140]: info: Adding plugin tidalconnect to MyMusic Plugins Dec 09 18:10:36 volumio volumio[1140]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Dec 09 18:10:36 volumio volumio[1140]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Dec 09 18:10:36 volumio volumio[1140]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Dec 09 18:10:36 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 09 18:10:36 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 09 18:10:36 volumio volumio[1140]: info: Starting MyVolumio Remote Streaming Endpoints Dec 09 18:10:37 volumio volumio[1140]: info: MyVolumio login type: Token Dec 09 18:10:37 volumio volumio[1140]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Dec 09 18:10:37 volumio volumio[1140]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Dec 09 18:10:37 volumio volumio[1140]: info: Starting Streaming Service Transparent Proxy Dec 09 18:10:37 volumio volumio[1140]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Dec 09 18:10:37 volumio volumio[1140]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Dec 09 18:10:37 volumio volumio[1140]: info: Streaming services startup Dec 09 18:10:37 volumio volumio[1140]: info: Starting Streaming Daemon Dec 09 18:10:37 volumio sudo[1508]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 09 18:10:37 volumio sudo[1508]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 09 18:10:37 volumio sudo[1508]: pam_unix(sudo:session): session closed for user root Dec 09 18:10:38 volumio volumio[1140]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Dec 09 18:10:38 volumio volumio[1140]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 09 18:10:38 volumio volumio[1140]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 09 18:10:38 volumio volumio[1140]: info: Retrieving Cloud Streaming UI Dec 09 18:10:38 volumio volumio[1140]: Upnp client error: Error: This socket has been ended by the other party Dec 09 18:10:38 volumio volumio[1140]: error: Cannot start Volumio Streaming Daemon Dec 09 18:10:38 volumio volumio[1140]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Dec 09 18:10:38 volumio volumio[1140]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Dec 09 18:10:38 volumio volumio[1140]: STREAMING PROXY: Starting server on port 3245 Dec 09 18:10:38 volumio volumio[1140]: Node JS runtime: 14 Dec 09 18:10:39 volumio volumio[1140]: info: CoreCommandRouter::volumioGetState Dec 09 18:10:39 volumio volumio[1140]: info: CorePlayQueue::getTrack 0 Dec 09 18:10:40 volumio volumio[1140]: info: Getting Tidal Cloud Configuration Dec 09 18:10:40 volumio volumio[1140]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 09 18:10:40 volumio volumio[1140]: info: Getting Qobuz Cloud Configuration Dec 09 18:10:40 volumio volumio[1140]: info: Asking plugin for UI Config Dec 09 18:10:40 volumio volumio[1140]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 09 18:10:40 volumio volumio[1140]: info: Getting Spotify Cloud Configuration Dec 09 18:10:40 volumio volumio[1140]: info: Asking plugin for UI Config Dec 09 18:10:40 volumio volumio[1140]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 09 18:10:40 volumio volumio[1140]: info: Saving Spotify Acccount Dec 09 18:10:40 volumio volumio[1140]: info: Got Tidal Cloud Configuration Dec 09 18:10:40 volumio volumio[1140]: info: Got it Dec 09 18:10:40 volumio volumio[1140]: info: Got it Dec 09 18:10:40 volumio volumio[1140]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Dec 09 18:10:40 volumio volumio[1140]: info: Listing playlists Dec 09 18:10:40 volumio volumio[1140]: info: Listing playlists Dec 09 18:10:40 volumio volumio[1140]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 09 18:10:40 volumio volumio[1140]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Dec 09 18:10:40 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 09 18:10:40 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 09 18:10:40 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 09 18:10:40 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 09 18:10:40 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 09 18:10:40 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 09 18:10:40 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 09 18:10:40 volumio volumio[1140]: info: CoreCommandRouter::volumioGetBrowseSources Dec 09 18:10:40 volumio volumio[1140]: info: CoreCommandRouter::volumioGetBrowseSources Dec 09 18:10:40 volumio volumio[1140]: info: CoreCommandRouter::volumioGetBrowseSources Dec 09 18:10:40 volumio volumio[1140]: Upnp client error: Error: read ECONNRESET Dec 09 18:10:40 volumio volumio[1485]: Generating RSA private key, 4096 bit long modulus (2 primes) Dec 09 18:10:40 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 09 18:10:40 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Dec 09 18:10:41 volumio volumio[1140]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Dec 09 18:10:41 volumio volumio[1140]: info: MyVolumio token set successfully Dec 09 18:10:41 volumio volumio[1140]: info: MYVOLUMIO: Adding device Dec 09 18:10:41 volumio volumio[1140]: info: MYVOLUMIO: Evaluating Server Dec 09 18:10:42 volumio volumio[1140]: info: MyVolumio status changed Dec 09 18:10:42 volumio volumio[1140]: info: Streaming services startup Dec 09 18:10:42 volumio volumio[1140]: info: Starting Streaming Daemon Dec 09 18:10:42 volumio volumio[1140]: info: Removing browser output: myVolumio user plan is not superstar Dec 09 18:10:42 volumio volumio[1140]: info: Removing audio output: Dec 09 18:10:42 volumio volumio[1140]: info: Stoppping Tunnel 1 Dec 09 18:10:42 volumio sudo[1559]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 09 18:10:42 volumio sudo[1559]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 09 18:10:42 volumio sudo[1559]: pam_unix(sudo:session): session closed for user root Dec 09 18:10:42 volumio volumio[1140]: error: Cannot start Volumio Streaming Daemon Dec 09 18:10:42 volumio volumio[1140]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Dec 09 18:10:42 volumio volumio[1140]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Dec 09 18:10:42 volumio sudo[1562]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Dec 09 18:10:42 volumio sudo[1562]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 09 18:10:42 volumio sudo[1562]: pam_unix(sudo:session): session closed for user root Dec 09 18:10:42 volumio volumio[1140]: info: Remote SSH Stopped Dec 09 18:10:42 volumio volumio[1140]: info: Setting Geolocation for MyVolumio to eu9 Dec 09 18:10:42 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 09 18:10:42 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 09 18:10:42 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 09 18:10:43 volumio volumio[1140]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Dec 09 18:10:43 volumio volumio[1140]: info: Updating MyVolumio device info Dec 09 18:10:43 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 09 18:10:43 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 09 18:10:43 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 09 18:10:44 volumio volumio[1140]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Dec 09 18:10:44 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 09 18:10:45 volumio systemd[1]: systemd-timedated.service: Succeeded. Dec 09 18:10:46 volumio volumio[1140]: info: CoreCommandRouter::volumioGetState Dec 09 18:10:46 volumio volumio[1140]: info: CorePlayQueue::getTrack 0 Dec 09 18:10:47 volumio volumio[1140]: info: MYVOLUMIO: Adding device Dec 09 18:10:47 volumio volumio[1140]: info: MYVOLUMIO: Evaluating Server Dec 09 18:10:47 volumio volumio[1485]: ..............................................................................++++ Dec 09 18:10:47 volumio volumio[1140]: info: Setting Geolocation for MyVolumio to eu9 Dec 09 18:10:47 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 09 18:10:48 volumio volumio[1140]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Dec 09 18:10:48 volumio volumio[1485]: .......++++ Dec 09 18:10:48 volumio volumio[1485]: e is 65537 (0x010001) Dec 09 18:10:48 volumio volumio[1485]: writing RSA key Dec 09 18:10:48 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 09 18:10:48 volumio volumio[1140]: info: Updating MyVolumio device info Dec 09 18:10:48 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 09 18:10:49 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 09 18:10:49 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 09 18:10:49 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 09 18:10:49 volumio volumio-remote-updater[604]: No test mode Dec 09 18:10:49 volumio volumio-remote-updater[604]: No alpha test mode Dec 09 18:10:49 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Dec 09 18:10:49 volumio volumio[1140]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

\n
    \n
  • Fix for TIDAL Authentication refresh
    • \n
\n

NEW ADDITIONS

\n
    \n
  • Update Bluez to 5.83
    • \n
\n","title":"Update v3.874","updateavailable":true} Dec 09 18:10:49 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Dec 09 18:10:49 volumio volumio[1140]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Dec 09 18:10:51 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 09 18:10:52 volumio volumio[1140]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Dec 09 18:10:52 volumio volumio[1140]: info: CoreCommandRouter::volumioGetState Dec 09 18:10:52 volumio volumio[1140]: info: CorePlayQueue::getTrack 0 Dec 09 18:10:52 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 09 18:10:56 volumio volumio[1140]: info: CoreCommandRouter::volumioGetState Dec 09 18:10:56 volumio volumio[1140]: info: CorePlayQueue::getTrack 0 Dec 09 18:10:56 volumio volumio[1140]: info: Listing playlists Dec 09 18:10:56 volumio volumio[1140]: info: Listing playlists Dec 09 18:10:56 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 09 18:10:56 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:56 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:56 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Dec 09 18:10:56 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 09 18:10:56 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Dec 09 18:10:56 volumio volumio[1140]: info: CoreCommandRouter::volumioGetBrowseSources Dec 09 18:10:56 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 09 18:10:58 volumio volumio[1140]: error: MyVolumio Plugin failed to authenticate in a timely fashion Dec 09 18:10:58 volumio volumio[1140]: info: Completed starting MyVolumio Plugin Dec 09 18:10:58 volumio volumio[1140]: [Metrics] CommandRouter: 44s 456.49ms Dec 09 18:10:58 volumio volumio[1140]: info: CoreCommandRouter::volumiosetStartupVolume Dec 09 18:10:58 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 09 18:10:58 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 09 18:10:58 volumio volumio[1140]: info: CoreCommandRouter::Close All Modals sent Dec 09 18:10:58 volumio volumio[1140]: info: CoreCommandRouter::Close All Modals sent Dec 09 18:10:59 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 09 18:10:59 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 09 18:10:59 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 09 18:11:00 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 09 18:11:03 volumio kernel: xhci_hcd 0000:01:00.0: ERROR Transfer event for disabled endpoint slot 3 ep 1 Dec 09 18:11:03 volumio kernel: xhci_hcd 0000:01:00.0: @000000042951e080 00000000 00000000 0e000000 03028000 Dec 09 18:11:03 volumio ntpd[847]: Soliciting pool server 172.232.209.103 Dec 09 18:11:03 volumio ntpd[847]: Soliciting pool server 212.6.50.243 Dec 09 18:11:04 volumio ntpd[847]: Soliciting pool server 5.249.149.252 Dec 09 18:11:04 volumio ntpd[847]: Soliciting pool server 212.45.144.206 Dec 09 18:11:04 volumio ntpd[847]: Soliciting pool server 185.19.184.35 Dec 09 18:11:04 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 09 18:11:05 volumio volumio[1140]: info: BOOT COMPLETED Dec 09 18:11:05 volumio ntpd[847]: Soliciting pool server 37.247.53.178 Dec 09 18:11:05 volumio ntpd[847]: Soliciting pool server 162.159.200.1 Dec 09 18:11:05 volumio ntpd[847]: Soliciting pool server 162.159.200.123 Dec 09 18:11:05 volumio ntpd[847]: Soliciting pool server 162.159.200.1 Dec 09 18:11:06 volumio ntpd[847]: Soliciting pool server 93.94.88.51 Dec 09 18:11:06 volumio ntpd[847]: Soliciting pool server 151.22.209.90 Dec 09 18:11:06 volumio ntpd[847]: Soliciting pool server 89.46.74.148 Dec 09 18:11:06 volumio volumio[1140]: info: CoreCommandRouter::volumioGetState Dec 09 18:11:06 volumio volumio[1140]: info: CorePlayQueue::getTrack 0 Dec 09 18:11:07 volumio ntpd[847]: Soliciting pool server 2a00:6d41:200:2::13 Dec 09 18:11:08 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 09 18:11:10 volumio ntpd[847]: receive: Unexpected origin timestamp 0xece2e4be.60b15cac does not match aorg 0000000000.00000000 from server@212.45.144.206 xmt 0xece2e4be.f503ca95 Dec 09 18:11:10 volumio ntpd[847]: receive: Unexpected origin timestamp 0xece2e4be.60ad4bd0 does not match aorg 0000000000.00000000 from server@162.159.200.123 xmt 0xece2e4be.f53def26 Dec 09 18:11:10 volumio ntpd[847]: receive: Unexpected origin timestamp 0xece2e4be.60affb1b does not match aorg 0000000000.00000000 from server@5.249.149.252 xmt 0xece2e4be.f5fcc358 Dec 09 18:11:10 volumio ntpd[847]: receive: Unexpected origin timestamp 0xece2e4be.60b295dc does not match aorg 0000000000.00000000 from server@212.6.50.243 xmt 0xece2e4be.f70337da Dec 09 18:11:13 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 09 18:11:17 volumio volumio[1140]: info: CoreCommandRouter::volumioGetState Dec 09 18:11:17 volumio volumio[1140]: info: CorePlayQueue::getTrack 0 Dec 09 18:11:17 volumio volumio[1140]: info: Listing playlists Dec 09 18:11:17 volumio volumio[1140]: info: Listing playlists Dec 09 18:11:17 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 09 18:11:21 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 09 18:11:25 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 09 18:11:27 volumio volumio[1140]: info: CoreCommandRouter::volumioGetState Dec 09 18:11:27 volumio volumio[1140]: info: CorePlayQueue::getTrack 0 Dec 09 18:11:29 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 09 18:11:29 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare Dec 09 18:11:29 volumio sudo[1723]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/musica1 Dec 09 18:11:29 volumio sudo[1723]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 09 18:11:30 volumio systemd[1]: mnt-NAS-musica1.mount: Succeeded. Dec 09 18:11:30 volumio sudo[1723]: pam_unix(sudo:session): session closed for user root Dec 09 18:11:30 volumio volumio[1140]: info: Share musica1 successfully unmounted Dec 09 18:11:30 volumio sudo[1727]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.1.26:musica1 /mnt/NAS/musica1 Dec 09 18:11:30 volumio sudo[1727]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 09 18:11:30 volumio systemd[1]: /lib/systemd/system/rpc-statd.service:13: PIDFile= references path below legacy directory /var/run/, updating /var/run/rpc.statd.pid → /run/rpc.statd.pid; please update the unit file accordingly. Dec 09 18:11:30 volumio systemd[1]: Reached target Host and Network Name Lookups. Dec 09 18:11:30 volumio systemd[1]: Starting Preprocess NFS configuration... Dec 09 18:11:30 volumio systemd[1]: nfs-config.service: Succeeded. Dec 09 18:11:30 volumio systemd[1]: Started Preprocess NFS configuration. Dec 09 18:11:30 volumio systemd[1]: Starting NFS status monitor for NFSv2/3 locking.... Dec 09 18:11:30 volumio systemd[1]: Starting Notify NFS peers of a restart... Dec 09 18:11:30 volumio sm-notify[1740]: Version 1.3.3 starting Dec 09 18:11:30 volumio systemd[1]: rpc-statd-notify.service: Succeeded. Dec 09 18:11:30 volumio systemd[1]: Started Notify NFS peers of a restart. Dec 09 18:11:30 volumio rpc.statd[1741]: Version 1.3.3 starting Dec 09 18:11:30 volumio rpc.statd[1741]: Flags: TI-RPC Dec 09 18:11:30 volumio systemd[1]: Started NFS status monitor for NFSv2/3 locking.. Dec 09 18:11:30 volumio sudo[1727]: pam_unix(sudo:session): session closed for user root Dec 09 18:11:30 volumio volumio[1140]: info: An error occurred mounting the new share. Rolling back configuration Dec 09 18:11:31 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Dec 09 18:11:33 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 09 18:11:37 volumio volumio[1140]: info: CoreCommandRouter::volumioGetState Dec 09 18:11:37 volumio volumio[1140]: info: CorePlayQueue::getTrack 0 Dec 09 18:11:37 volumio volumio[1140]: info: Listing playlists Dec 09 18:11:37 volumio volumio[1140]: info: Listing playlists Dec 09 18:11:37 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 09 18:11:41 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 09 18:11:44 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Dec 09 18:11:45 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Dec 09 18:11:45 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 09 18:11:47 volumio volumio[1140]: info: CoreCommandRouter::volumioGetState Dec 09 18:11:47 volumio volumio[1140]: info: CorePlayQueue::getTrack 0 Dec 09 18:11:48 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Dec 09 18:11:48 volumio sudo[1787]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/musica2 Dec 09 18:11:48 volumio sudo[1787]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 09 18:11:48 volumio systemd[1]: mnt-NAS-musica2.mount: Succeeded. Dec 09 18:11:48 volumio sudo[1787]: pam_unix(sudo:session): session closed for user root Dec 09 18:11:48 volumio volumio[1140]: info: Share musica2 successfully unmounted Dec 09 18:11:49 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 09 18:11:49 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Dec 09 18:11:51 volumio volumio[1140]: verbose: ControllerMpd::sendMpdCommand status Dec 09 18:11:51 volumio volumio[1140]: info: Dec 09 18:11:51 volumio volumio[1140]: ---------------------------- MPD announces state update: update Dec 09 18:11:51 volumio volumio[1140]: info: ControllerMpd::getState Dec 09 18:11:51 volumio volumio[1140]: verbose: ControllerMpd::sendMpdCommand status Dec 09 18:11:51 volumio volumio[1140]: verbose: ControllerMpd::sendMpdCommand status Dec 09 18:11:51 volumio volumio[1140]: info: Dec 09 18:11:51 volumio volumio[1140]: ---------------------------- MPD announces state update: update Dec 09 18:11:51 volumio volumio[1140]: info: ControllerMpd::getState Dec 09 18:11:51 volumio volumio[1140]: verbose: ControllerMpd::sendMpdCommand status Dec 09 18:11:51 volumio volumio[1140]: verbose: ControllerMpd::sendMpdCommand status Dec 09 18:11:51 volumio volumio[1140]: info: Dec 09 18:11:51 volumio volumio[1140]: ---------------------------- MPD announces state update: update Dec 09 18:11:51 volumio volumio[1140]: info: ControllerMpd::getState Dec 09 18:11:51 volumio volumio[1140]: verbose: ControllerMpd::sendMpdCommand status Dec 09 18:11:51 volumio volumio[1140]: info: sendMpdCommand status took 10 milliseconds Dec 09 18:11:51 volumio volumio[1140]: info: sendMpdCommand status took 8 milliseconds Dec 09 18:11:51 volumio volumio[1140]: info: sendMpdCommand status took 8 milliseconds Dec 09 18:11:51 volumio volumio[1140]: info: sendMpdCommand status took 8 milliseconds Dec 09 18:11:51 volumio volumio[1140]: info: sendMpdCommand status took 7 milliseconds Dec 09 18:11:51 volumio volumio[1140]: info: sendMpdCommand status took 6 milliseconds Dec 09 18:11:51 volumio volumio[1140]: verbose: ControllerMpd::parseState Dec 09 18:11:51 volumio volumio[1140]: info: Command Router : Notfying DB Updatetrue Dec 09 18:11:51 volumio volumio[1140]: verbose: ControllerMpd::parseState Dec 09 18:11:51 volumio volumio[1140]: verbose: ControllerMpd::parseState Dec 09 18:11:51 volumio volumio[1140]: info: Command Router : Notfying DB Updatetrue Dec 09 18:11:51 volumio volumio[1140]: info: CoreCommandRouter::Close All Modals sent Dec 09 18:11:51 volumio volumio[1140]: verbose: ControllerMpd::parseState Dec 09 18:11:51 volumio volumio[1140]: verbose: ControllerMpd::parseState Dec 09 18:11:51 volumio volumio[1140]: info: Command Router : Notfying DB Updatetrue Dec 09 18:11:51 volumio volumio[1140]: info: CoreCommandRouter::Close All Modals sent Dec 09 18:11:51 volumio volumio[1140]: verbose: ControllerMpd::parseState Dec 09 18:11:51 volumio volumio[1140]: info: ControllerMpd::pushState Dec 09 18:11:51 volumio volumio[1140]: info: CoreCommandRouter::servicePushState Dec 09 18:11:51 volumio volumio[1140]: info: CoreStateMachine::pushState Dec 09 18:11:51 volumio volumio[1140]: info: CorePlayQueue::getTrack 0 Dec 09 18:11:51 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 09 18:11:51 volumio volumio[1140]: info: CoreCommandRouter::volumioPushState Dec 09 18:11:51 volumio volumio[1140]: info: CorePlayQueue::getTrack 0 Dec 09 18:11:51 volumio volumio[1140]: 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} Dec 09 18:11:51 volumio volumio[1140]: verbose: CURRENT POSITION 0 Dec 09 18:11:51 volumio volumio[1140]: info: CoreStateMachine::syncState stateService stop Dec 09 18:11:51 volumio volumio[1140]: info: CoreStateMachine::syncState currentStatus stop Dec 09 18:11:51 volumio volumio[1140]: info: CoreStateMachine::pushState Dec 09 18:11:51 volumio volumio[1140]: info: CorePlayQueue::getTrack 0 Dec 09 18:11:51 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 09 18:11:51 volumio volumio[1140]: info: CoreCommandRouter::volumioPushState Dec 09 18:11:51 volumio volumio[1140]: info: No code Dec 09 18:11:51 volumio volumio[1140]: info: CoreStateMachine::pushState Dec 09 18:11:51 volumio volumio[1140]: info: CorePlayQueue::getTrack 0 Dec 09 18:11:51 volumio volumio[1140]: info: CoreCommandRouter::volumioPushState Dec 09 18:11:51 volumio volumio[1140]: info: ControllerMpd::pushState Dec 09 18:11:51 volumio volumio[1140]: info: CoreCommandRouter::servicePushState Dec 09 18:11:51 volumio volumio[1140]: info: CoreStateMachine::pushState Dec 09 18:11:51 volumio volumio[1140]: info: CorePlayQueue::getTrack 0 Dec 09 18:11:51 volumio volumio[1140]: info: CoreCommandRouter::volumioPushState Dec 09 18:11:51 volumio volumio[1140]: info: CorePlayQueue::getTrack 0 Dec 09 18:11:51 volumio volumio[1140]: 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} Dec 09 18:11:51 volumio volumio[1140]: verbose: CURRENT POSITION 0 Dec 09 18:11:51 volumio volumio[1140]: info: CoreStateMachine::syncState stateService stop Dec 09 18:11:51 volumio volumio[1140]: info: CoreStateMachine::syncState currentStatus stop Dec 09 18:11:51 volumio volumio[1140]: info: CoreStateMachine::pushState Dec 09 18:11:51 volumio volumio[1140]: info: CorePlayQueue::getTrack 0 Dec 09 18:11:51 volumio volumio[1140]: info: CoreCommandRouter::volumioPushState Dec 09 18:11:51 volumio volumio[1140]: info: No code Dec 09 18:11:51 volumio volumio[1140]: info: CoreStateMachine::pushState Dec 09 18:11:51 volumio volumio[1140]: info: CorePlayQueue::getTrack 0 Dec 09 18:11:51 volumio volumio[1140]: info: CoreCommandRouter::volumioPushState Dec 09 18:11:51 volumio volumio[1140]: info: ControllerMpd::pushState Dec 09 18:11:51 volumio volumio[1140]: info: CoreCommandRouter::servicePushState Dec 09 18:11:51 volumio volumio[1140]: info: CoreStateMachine::pushState Dec 09 18:11:51 volumio volumio[1140]: info: CorePlayQueue::getTrack 0 Dec 09 18:11:51 volumio volumio[1140]: info: CoreCommandRouter::volumioPushState Dec 09 18:11:51 volumio volumio[1140]: info: CorePlayQueue::getTrack 0 Dec 09 18:11:51 volumio volumio[1140]: 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} Dec 09 18:11:51 volumio volumio[1140]: verbose: CURRENT POSITION 0 Dec 09 18:11:51 volumio volumio[1140]: info: CoreStateMachine::syncState stateService stop Dec 09 18:11:51 volumio volumio[1140]: info: CoreStateMachine::syncState currentStatus stop Dec 09 18:11:51 volumio volumio[1140]: info: CoreStateMachine::pushState Dec 09 18:11:51 volumio volumio[1140]: info: CorePlayQueue::getTrack 0 Dec 09 18:11:51 volumio volumio[1140]: info: CoreCommandRouter::volumioPushState Dec 09 18:11:51 volumio volumio[1140]: info: No code Dec 09 18:11:51 volumio volumio[1140]: info: CoreStateMachine::pushState Dec 09 18:11:51 volumio volumio[1140]: info: CorePlayQueue::getTrack 0 Dec 09 18:11:51 volumio volumio[1140]: info: CoreCommandRouter::volumioPushState Dec 09 18:11:51 volumio volumio[1140]: info: ------------------------------ 165ms Dec 09 18:11:51 volumio volumio[1140]: info: ------------------------------ 163ms Dec 09 18:11:51 volumio volumio[1140]: info: ------------------------------ 163ms Dec 09 18:11:51 volumio volumio[1140]: info: [1765303911671] Database update started Dec 09 18:11:53 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 09 18:11:57 volumio volumio[1140]: info: CoreCommandRouter::volumioGetState Dec 09 18:11:57 volumio volumio[1140]: info: CorePlayQueue::getTrack 0 Dec 09 18:11:57 volumio volumio[1140]: info: Listing playlists Dec 09 18:11:57 volumio volumio[1140]: info: Listing playlists Dec 09 18:11:57 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 09 18:11:59 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Dec 09 18:11:59 volumio volumio[1140]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Dec 09 18:11:59 volumio volumio[1140]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 09 18:11:59 volumio volumio[1140]: Error: getaddrinfo -3007 Dec 09 18:11:59 volumio volumio[1140]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11) Dec 09 18:11:59 volumio volumio[1140]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10) Dec 09 18:11:59 volumio volumio[1140]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) { Dec 09 18:11:59 volumio volumio[1140]: code: -3007, Dec 09 18:11:59 volumio volumio[1140]: errno: -3007, Dec 09 18:11:59 volumio volumio[1140]: syscall: 'getaddrinfo' Dec 09 18:11:59 volumio volumio[1140]: } Dec 09 18:11:59 volumio volumio[1140]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 09 18:11:59 volumio sudo[1862]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-09 18:10 Dec 09 18:11:59 volumio sudo[1862]: 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"