-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Tue 2026-01-27 23:26:56 CET. -- Jan 27 23:26:06 volumioro systemd-timedated[993]: Changed local time to Tue Jan 27 23:26:06 2026 Jan 27 23:26:06 volumioro systemd[1]: Starting Daily apt download activities... Jan 27 23:26:06 volumioro sudo[991]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:06 volumioro volumio-time-update[579]: volumio-time-update-util: System time updated successfully. Jan 27 23:26:06 volumioro systemd[1]: Started Volumio Time Update Utility. Jan 27 23:26:06 volumioro volumio-cpu-tweak[1004]: Setting RT Priority for mpd Jan 27 23:26:06 volumioro volumio-cpu-tweak[1004]: pid 35's current scheduling policy: SCHED_OTHER Jan 27 23:26:06 volumioro volumio-cpu-tweak[1004]: pid 35's current scheduling priority: 0 Jan 27 23:26:06 volumioro volumio-cpu-tweak[1004]: Setting MPD Affinity Jan 27 23:26:06 volumioro volumio-cpu-tweak[1004]: pid 3's current affinity mask: f Jan 27 23:26:06 volumioro volumio-cpu-tweak[1004]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Jan 27 23:26:06 volumioro volumio-cpu-tweak[1004]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Jan 27 23:26:06 volumioro systemd[1]: volumio_cpu_tweak.service: Succeeded. Jan 27 23:26:06 volumioro nmbd[723]: [2026/01/27 23:26:06.529377, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jan 27 23:26:06 volumioro systemd[1]: Started Samba NMB Daemon. Jan 27 23:26:06 volumioro nmbd[723]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Jan 27 23:26:06 volumioro systemd[1]: Starting Samba Winbind Daemon... Jan 27 23:26:06 volumioro systemd[1]: apt-daily.service: Succeeded. Jan 27 23:26:06 volumioro systemd[1]: Started Daily apt download activities. Jan 27 23:26:06 volumioro systemd[1]: Starting Daily apt upgrade and clean activities... Jan 27 23:26:06 volumioro winbindd[1052]: [2026/01/27 23:26:06.846635, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Jan 27 23:26:06 volumioro winbindd[1052]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Jan 27 23:26:06 volumioro winbindd[1052]: [2026/01/27 23:26:06.864871, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jan 27 23:26:06 volumioro winbindd[1052]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Jan 27 23:26:06 volumioro systemd[1]: Started Samba Winbind Daemon. Jan 27 23:26:06 volumioro systemd[1]: Starting Samba SMB Daemon... Jan 27 23:26:06 volumioro ntpd[769]: Listen normally on 3 wlan0 192.168.1.168:123 Jan 27 23:26:06 volumioro ntpd[769]: new interface(s) found: waking up resolver Jan 27 23:26:07 volumioro smbd[1082]: [2026/01/27 23:26:07.307145, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jan 27 23:26:07 volumioro smbd[1082]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Jan 27 23:26:07 volumioro systemd[1]: Started Samba SMB Daemon. Jan 27 23:26:07 volumioro systemd[1]: Reached target Multi-User System. Jan 27 23:26:07 volumioro systemd[1]: Reached target Graphical Interface. Jan 27 23:26:07 volumioro systemd[1]: Starting Update UTMP about System Runlevel Changes... Jan 27 23:26:07 volumioro systemd[1]: apt-daily-upgrade.service: Succeeded. Jan 27 23:26:07 volumioro systemd[1]: Started Daily apt upgrade and clean activities. Jan 27 23:26:07 volumioro systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jan 27 23:26:07 volumioro systemd[1]: Started Update UTMP about System Runlevel Changes. Jan 27 23:26:07 volumioro systemd[1]: Startup finished in 12.061s (kernel) + 25.550s (userspace) = 37.612s. Jan 27 23:26:08 volumioro volumio[1003]: info: ------------------------------------------- Jan 27 23:26:08 volumioro volumio[1003]: info: ----- Volumio3 ---- Jan 27 23:26:08 volumioro volumio[1003]: info: ------------------------------------------- Jan 27 23:26:08 volumioro volumio[1003]: info: ----- System startup ---- Jan 27 23:26:08 volumioro volumio[1003]: info: ------------------------------------------- Jan 27 23:26:08 volumioro volumio-remote-updater[572]: [2026-01-27 23:26:08] [connect] Successful connection Jan 27 23:26:08 volumioro volumio[1003]: info: MYVOLUMIO Environment detected Jan 27 23:26:08 volumioro volumio[1003]: info: Plugin folders cleanup Jan 27 23:26:08 volumioro volumio[1003]: info: Scanning into folder /volumio/app/plugins/ Jan 27 23:26:08 volumioro volumio[1003]: info: Scanning category audio_interface Jan 27 23:26:08 volumioro volumio[1003]: info: Scanning category miscellanea Jan 27 23:26:08 volumioro volumio[1003]: info: Scanning category music_service Jan 27 23:26:08 volumioro volumio[1003]: info: Scanning category plugins.json Jan 27 23:26:08 volumioro volumio[1003]: info: Scanning category system_controller Jan 27 23:26:08 volumioro volumio[1003]: info: Scanning category user_interface Jan 27 23:26:08 volumioro volumio[1003]: info: Scanning into folder /data/plugins/ Jan 27 23:26:08 volumioro volumio[1003]: info: Scanning category music_service Jan 27 23:26:08 volumioro volumio[1003]: info: Scanning category system_controller Jan 27 23:26:08 volumioro volumio[1003]: info: Scanning category user_interface Jan 27 23:26:08 volumioro volumio[1003]: info: Plugin folders cleanup completed Jan 27 23:26:08 volumioro volumio[1003]: info: ------------------------------------------- Jan 27 23:26:08 volumioro volumio[1003]: info: ----- Core plugins startup ---- Jan 27 23:26:08 volumioro volumio[1003]: info: ------------------------------------------- Jan 27 23:26:08 volumioro volumio[1003]: info: Loading plugins from folder /volumio/app/plugins/ Jan 27 23:26:08 volumioro volumio[1003]: info: Adding plugin upnp to MyMusic Plugins Jan 27 23:26:08 volumioro volumio[1003]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 27 23:26:08 volumioro volumio[1003]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 27 23:26:08 volumioro volumio[1003]: info: Loading plugins from folder /data/plugins/ Jan 27 23:26:08 volumioro volumio[1003]: info: Loading plugin "system"... Jan 27 23:26:08 volumioro volumio[1003]: info: Loading plugin "appearance"... Jan 27 23:26:09 volumioro volumio[1003]: info: Loading plugin "network"... Jan 27 23:26:09 volumioro volumio[1003]: info: Refreshing Cached IP Addresses Jan 27 23:26:09 volumioro sudo[1147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 27 23:26:09 volumioro sudo[1147]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:09 volumioro sudo[1147]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:09 volumioro sudo[1149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 23:26:09 volumioro sudo[1149]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:09 volumioro sudo[1149]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:09 volumioro volumio[1003]: info: Loading plugin "services"... Jan 27 23:26:09 volumioro volumio[1003]: info: Loading plugin "alsa_controller"... Jan 27 23:26:09 volumioro sudo[1161]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 27 23:26:09 volumioro sudo[1161]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:10 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 27 23:26:10 volumioro volumio[1003]: info: Loading plugin "wizard"... Jan 27 23:26:10 volumioro volumio[1003]: info: Loading plugin "networkfs"... Jan 27 23:26:10 volumioro volumio[1003]: info: Starting Udev Watcher for removable devices Jan 27 23:26:10 volumioro sudo[1175]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=ri,password=Leben105%SyRo,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.105/music /mnt/NAS/Musicstation Jan 27 23:26:10 volumioro sudo[1175]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:10 volumioro volumio[1003]: info: Ignoring mount for partition: boot Jan 27 23:26:10 volumioro volumio[1003]: info: Ignoring mount for partition: volumio Jan 27 23:26:10 volumioro volumio[1003]: info: Ignoring mount for partition: volumio_data Jan 27 23:26:10 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 27 23:26:10 volumioro volumio[1003]: info: Loading plugin "volumio_command_line_client"... Jan 27 23:26:10 volumioro volumio[1003]: info: Loading plugin "upnp"... Jan 27 23:26:10 volumioro volumio[1003]: info: [1769552770110] Starting Upmpd Daemon Jan 27 23:26:10 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 27 23:26:10 volumioro volumio[1003]: info: Loading plugin "my_music"... Jan 27 23:26:10 volumioro volumio[1003]: info: Loading plugin "mpd"... Jan 27 23:26:10 volumioro kernel: Key type cifs.spnego registered Jan 27 23:26:10 volumioro kernel: Key type cifs.idmap registered Jan 27 23:26:10 volumioro 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. Jan 27 23:26:10 volumioro kernel: CIFS: Attempting to mount //192.168.1.105/music Jan 27 23:26:10 volumioro volumio[1003]: info: Loading plugin "upnp_browser"... Jan 27 23:26:10 volumioro volumio[1003]: info: Starting UPNP Browser Jan 27 23:26:10 volumioro volumio[1003]: info: Loading plugin "alarm-clock"... Jan 27 23:26:10 volumioro volumio[1003]: info: Loading plugin "airplay_emulation"... Jan 27 23:26:10 volumioro volumio[1003]: info: Starting Shairport Sync Jan 27 23:26:10 volumioro volumio[1003]: info: Loading plugin "last_100"... Jan 27 23:26:10 volumioro volumio[1003]: info: Loading plugin "webradio"... Jan 27 23:26:10 volumioro volumio[1003]: info: Loading plugin "i2s_dacs"... Jan 27 23:26:10 volumioro volumio[1003]: info: I2S DAC not set, start Auto-detection Jan 27 23:26:10 volumioro volumio[1003]: info: Loading plugin "volumiodiscovery"... Jan 27 23:26:11 volumioro volumio[1003]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 27 23:26:11 volumioro volumio[1003]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 27 23:26:11 volumioro node[1003]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 27 23:26:11 volumioro volumio[1003]: *** WARNING *** For more information see Jan 27 23:26:11 volumioro volumio[1003]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 27 23:26:11 volumioro volumio[1003]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 27 23:26:11 volumioro volumio[1003]: *** WARNING *** For more information see Jan 27 23:26:11 volumioro node[1003]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 27 23:26:11 volumioro node[1003]: *** WARNING *** For more information see Jan 27 23:26:11 volumioro node[1003]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 27 23:26:11 volumioro node[1003]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 27 23:26:11 volumioro node[1003]: *** WARNING *** For more information see Jan 27 23:26:11 volumioro volumio[1003]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 27 23:26:11 volumioro volumio[1003]: info: Discovery: Started advertising with name: VolumioRo Jan 27 23:26:11 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 27 23:26:11 volumioro volumio[1003]: info: Loading plugin "spop"... Jan 27 23:26:12 volumioro volumio[1003]: info: Loading plugin "outputs"... Jan 27 23:26:12 volumioro volumio[1003]: info: Loading plugin "albumart"... Jan 27 23:26:12 volumioro volumio[1003]: info: Plugin example_plugin is not enabled Jan 27 23:26:12 volumioro volumio[1003]: info: Loading plugin "inputs"... Jan 27 23:26:12 volumioro volumio[1003]: info: Loading plugin "updater_comm"... Jan 27 23:26:12 volumioro volumio[1003]: info: Plugin mpdemulation is not enabled Jan 27 23:26:12 volumioro volumio[1003]: info: Loading plugin "rest_api"... Jan 27 23:26:12 volumioro volumio[1003]: info: Loading plugin "websocket"... Jan 27 23:26:12 volumioro volumio[1003]: info: Starting Socket.io Server version 2.3.0 Jan 27 23:26:12 volumioro volumio[1003]: info: Loading plugin "backup_restore"... Jan 27 23:26:12 volumioro volumio[1003]: Forking 3 albumart workers Jan 27 23:26:12 volumioro volumio[1003]: info: Applying required configuration parameters for plugin backup_restore Jan 27 23:26:12 volumioro volumio[1003]: info: Loading plugin "Systeminfo"... Jan 27 23:26:12 volumioro volumio[1003]: Starting albumart workers Jan 27 23:26:12 volumioro volumio[1003]: Starting albumart workers Jan 27 23:26:12 volumioro volumio[1003]: Starting albumart workers Jan 27 23:26:13 volumioro volumio[1003]: info: Loading i18n strings for locale de Jan 27 23:26:13 volumioro volumio[1003]: Updating browse sources language Jan 27 23:26:13 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 27 23:26:13 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 27 23:26:13 volumioro volumio[1003]: info: CoreCommandRouter::initPlayerControls Jan 27 23:26:13 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:13 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:13 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:13 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:13 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:13 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:13 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:13 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:13 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 27 23:26:13 volumioro volumio[1003]: Express server listening on port 3000 Jan 27 23:26:13 volumioro volumio[1003]: [Metrics] WebUI: 6s 75.69ms Jan 27 23:26:13 volumioro volumio[1003]: info: CoreStateMachine::resetVolumioState Jan 27 23:26:13 volumioro volumio[1003]: info: CoreStateMachine::getcurrentVolume Jan 27 23:26:13 volumioro volumio[1003]: info: CoreCommandRouter::volumioRetrievevolume Jan 27 23:26:13 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 23:26:13 volumioro volumio[1003]: info: Volumio Network Manager: Network status updated: 2 Jan 27 23:26:13 volumioro sudo[1161]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:13 volumioro volumio[1003]: verbose: New Socket.io Connection to 192.168.1.168:3000 from 192.168.1.151 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Jan 27 23:26:13 volumioro volumio[1003]: info: Reloading queue from file Jan 27 23:26:13 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Jan 27 23:26:13 volumioro volumio[1003]: info: VolumeController:: Volume=45 Mute =false Jan 27 23:26:13 volumioro volumio[1003]: info: CoreStateMachine::pushState Jan 27 23:26:13 volumioro volumio[1003]: info: CorePlayQueue::getTrack 0 Jan 27 23:26:13 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 23:26:13 volumioro volumio[1003]: info: CoreCommandRouter::volumioPushState Jan 27 23:26:13 volumioro volumio[1003]: info: CoreStateMachine::updateTrackBlock Jan 27 23:26:13 volumioro volumio[1003]: info: CorePlayQueue::getTrackBlock Jan 27 23:26:13 volumioro volumio[1003]: info: CoreCommandRouter::volumioRetrievevolume Jan 27 23:26:13 volumioro volumio[1003]: info: Setting Device type: Raspberry PI Jan 27 23:26:13 volumioro volumio[1003]: info: CoreStateMachine::setRepeat null single undefined Jan 27 23:26:13 volumioro volumio[1003]: info: CoreStateMachine::pushState Jan 27 23:26:13 volumioro volumio[1003]: info: CorePlayQueue::getTrack 0 Jan 27 23:26:13 volumioro volumio[1003]: info: CoreCommandRouter::volumioPushState Jan 27 23:26:13 volumioro volumio[1003]: info: CoreStateMachine::setRandom null Jan 27 23:26:13 volumioro volumio[1003]: info: CoreStateMachine::pushState Jan 27 23:26:13 volumioro volumio[1003]: info: CorePlayQueue::getTrack 0 Jan 27 23:26:13 volumioro volumio[1003]: info: CoreCommandRouter::volumioPushState Jan 27 23:26:13 volumioro volumio[1003]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jan 27 23:26:13 volumioro volumio[1003]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03111 Jan 27 23:26:13 volumioro volumio[1003]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jan 27 23:26:13 volumioro volumio[1003]: info: CoreCommandRouter::volumioGetState Jan 27 23:26:13 volumioro volumio[1003]: info: CorePlayQueue::getTrack 0 Jan 27 23:26:13 volumioro volumio[1003]: info: Discovery: adding c18b25ad-11c6-4eaf-976f-dd148f0d85c5 Jan 27 23:26:13 volumioro volumio[1003]: info: Discovery: Found device VolumioRo Jan 27 23:26:13 volumioro volumio[1003]: info: CoreCommandRouter::volumioGetState Jan 27 23:26:13 volumioro volumio[1003]: info: CorePlayQueue::getTrack 0 Jan 27 23:26:13 volumioro volumio[1003]: info: VolumeController:: Volume=45 Mute =false Jan 27 23:26:13 volumioro volumio[1003]: info: CoreStateMachine::pushState Jan 27 23:26:13 volumioro volumio[1003]: info: CorePlayQueue::getTrack 0 Jan 27 23:26:13 volumioro volumio[1003]: info: CoreCommandRouter::volumioPushState Jan 27 23:26:13 volumioro volumio[1003]: info: Discovery: adding 2288a6c7-d3ba-4d9d-a04a-d3fcb4164ea0 Jan 27 23:26:13 volumioro volumio[1003]: info: Discovery: Found device VolumioWZ Jan 27 23:26:13 volumioro volumio[1003]: info: Discovery: Connecting to remote: 192.168.1.151 Jan 27 23:26:13 volumioro volumio[1003]: info: Discovery: Connected to remote: 192.168.1.151 Jan 27 23:26:14 volumioro sudo[1257]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 27 23:26:14 volumioro sudo[1257]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:14 volumioro sudo[1257]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:14 volumioro sudo[1259]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 23:26:14 volumioro sudo[1259]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:14 volumioro sudo[1259]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:14 volumioro volumio[1003]: verbose: New Socket.io Connection to 192.168.1.168 from 192.168.1.158 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.1 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 2 Jan 27 23:26:14 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 27 23:26:14 volumioro volumio[1003]: info: CoreCommandRouter::volumioGetVisibleSources Jan 27 23:26:14 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 27 23:26:14 volumioro volumio[1003]: info: CoreCommandRouter::volumioGetState Jan 27 23:26:14 volumioro volumio[1003]: info: CorePlayQueue::getTrack 0 Jan 27 23:26:14 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 27 23:26:14 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 27 23:26:14 volumioro volumio[1003]: info: Received Get System Info Jan 27 23:26:14 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 27 23:26:14 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 27 23:26:14 volumioro volumio[1003]: info: Discovery: Getting this device information Jan 27 23:26:14 volumioro volumio[1003]: info: CoreCommandRouter::volumioGetState Jan 27 23:26:14 volumioro volumio[1003]: info: CorePlayQueue::getTrack 0 Jan 27 23:26:14 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 27 23:26:14 volumioro volumio[1003]: info: CoreCommandRouter::volumioGetState Jan 27 23:26:14 volumioro volumio[1003]: info: CorePlayQueue::getTrack 0 Jan 27 23:26:14 volumioro volumio[1003]: info: Listing playlists Jan 27 23:26:14 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 27 23:26:14 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 27 23:26:14 volumioro systemd[1]: systemd-fsckd.service: Succeeded. Jan 27 23:26:15 volumioro sh[522]: timed out Jan 27 23:26:15 volumioro dhcpcd[560]: timed out Jan 27 23:26:15 volumioro sh[522]: dhcpcd exited Jan 27 23:26:15 volumioro dhcpcd[560]: dhcpcd exited Jan 27 23:26:15 volumioro sh[522]: ifup: failed to bring up eth0 Jan 27 23:26:15 volumioro systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Jan 27 23:26:15 volumioro systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Jan 27 23:26:15 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jan 27 23:26:15 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 27 23:26:15 volumioro volumio[1003]: info: Received Get System Info Jan 27 23:26:15 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 27 23:26:15 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 27 23:26:15 volumioro volumio[1003]: info: Discovery: Getting this device information Jan 27 23:26:15 volumioro volumio[1003]: info: CoreCommandRouter::volumioGetState Jan 27 23:26:15 volumioro volumio[1003]: info: CorePlayQueue::getTrack 0 Jan 27 23:26:15 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Jan 27 23:26:16 volumioro sudo[1175]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:16 volumioro volumio[1003]: info: Cannot mount NAS Musicstation at system boot, trial number 1 ,retrying in 5 seconds Jan 27 23:26:16 volumioro volumio[1003]: info: Completed loading Core Plugins Jan 27 23:26:16 volumioro volumio[1003]: info: Preparing to generate the ALSA configuration file Jan 27 23:26:16 volumioro kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jan 27 23:26:16 volumioro kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Jan 27 23:26:16 volumioro volumio[1003]: info: Asound.conf file unchanged, so no further update is needed Jan 27 23:26:16 volumioro volumio[1003]: info: Output device has changed, restarting MPD Jan 27 23:26:16 volumioro sudo[1264]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 27 23:26:16 volumioro volumio[1003]: info: Output device has changed, restarting Shairport Sync Jan 27 23:26:16 volumioro sudo[1264]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 23:26:16 volumioro sudo[1264]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:16 volumioro sudo[1266]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 27 23:26:16 volumioro sudo[1266]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:16 volumioro volumio[1003]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 27 23:26:16 volumioro volumio[1003]: info: ___________ START PLUGINS ___________ Jan 27 23:26:16 volumioro volumio[1003]: info: ControllerMpd::onStart: Initializing MPD Jan 27 23:26:16 volumioro volumio[1003]: info: Creating MPD Configuration file Jan 27 23:26:16 volumioro sudo[1274]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 27 23:26:16 volumioro sudo[1274]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 27 23:26:16 volumioro volumio[1003]: info: [1769552776530] CoreMusicLibrary::Adding element Medienserver Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 27 23:26:16 volumioro volumio[1003]: info: UPNP Browser: Client initialized successfully Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 23:26:16 volumioro sudo[1274]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:16 volumioro sudo[1276]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 27 23:26:16 volumioro sudo[1276]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:16 volumioro systemd[1]: Listening on mpd.socket. Jan 27 23:26:16 volumioro systemd[1]: Starting Music Player Daemon... Jan 27 23:26:16 volumioro systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jan 27 23:26:16 volumioro systemd[1]: mpd.service: Succeeded. Jan 27 23:26:16 volumioro systemd[1]: Stopped Music Player Daemon. Jan 27 23:26:16 volumioro systemd[1]: Starting Music Player Daemon... Jan 27 23:26:16 volumioro volumio[1003]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 23:26:16 volumioro volumio[1003]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 27 23:26:16 volumioro volumio[1003]: info: [1769552776616] CoreMusicLibrary::Adding element Last_100 Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 27 23:26:16 volumioro volumio[1003]: info: [1769552776618] CoreMusicLibrary::Adding element Webradio Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 27 23:26:16 volumioro volumio[1003]: info: Initializing BBC Radios Jan 27 23:26:16 volumioro sudo[1283]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 27 23:26:16 volumioro sudo[1283]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:16 volumioro sudo[1283]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jan 27 23:26:16 volumioro sudo[1283]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 23:26:16 volumioro volumio[1003]: info: Creating Spotify config file Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:16 volumioro volumio[1003]: info: Volumio Calling Home Jan 27 23:26:16 volumioro volumio[1003]: info: MPD Permissions set Jan 27 23:26:16 volumioro volumio[1003]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Jan 27 23:26:16 volumioro volumio[1003]: info: Spotify config file written Jan 27 23:26:16 volumioro sudo[1303]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Jan 27 23:26:16 volumioro sudo[1303]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:16 volumioro volumio[1003]: info: Volumio called home Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:16 volumioro systemd[1]: Started go-librespot Daemon. Jan 27 23:26:16 volumioro go-librespot[1305]: Librespot-go daemon starting... Jan 27 23:26:16 volumioro sudo[1303]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:16 volumioro volumio[1003]: info: CoreCommandRouter::volumioGetState Jan 27 23:26:16 volumioro volumio[1003]: info: CorePlayQueue::getTrack 0 Jan 27 23:26:16 volumioro volumio[1003]: info: Starting Shairport Sync Jan 27 23:26:16 volumioro volumio[1003]: info: Starting Shairport Sync Jan 27 23:26:16 volumioro volumio[1003]: info: Starting Shairport Sync Jan 27 23:26:17 volumioro sudo[1316]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 27 23:26:17 volumioro sudo[1316]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:17 volumioro sudo[1318]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 27 23:26:17 volumioro sudo[1318]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:17 volumioro sudo[1320]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 27 23:26:17 volumioro sudo[1320]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:17 volumioro systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 27 23:26:17 volumioro systemd[1]: shairport-sync.service: Succeeded. Jan 27 23:26:17 volumioro systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 27 23:26:17 volumioro systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 27 23:26:17 volumioro sudo[1316]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:17 volumioro sudo[1320]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:17 volumioro sudo[1318]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:17 volumioro volumio[1003]: info: Shairport-Sync Started Jan 27 23:26:17 volumioro volumio[1003]: Error adding Membership: Error: addMembership EINVAL Jan 27 23:26:17 volumioro volumio[1003]: info: Shairport-Sync Started Jan 27 23:26:17 volumioro volumio[1003]: info: Shairport-Sync Started Jan 27 23:26:17 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 27 23:26:17 volumioro volumio[1003]: info: Received Get System Info Jan 27 23:26:17 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 27 23:26:17 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 27 23:26:17 volumioro volumio[1003]: info: Discovery: Getting this device information Jan 27 23:26:17 volumioro volumio[1003]: info: CoreCommandRouter::volumioGetState Jan 27 23:26:17 volumioro volumio[1003]: info: CorePlayQueue::getTrack 0 Jan 27 23:26:17 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 27 23:26:17 volumioro go-librespot[1305]: time="2026-01-27T23:26:17+01:00" level=info msg="generated new device id: 74ff7603a4ff0fa625b7b6cc5471ae5e4f5c5ef3" Jan 27 23:26:17 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Jan 27 23:26:17 volumioro go-librespot[1305]: time="2026-01-27T23:26:17+01:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Jan 27 23:26:17 volumioro go-librespot[1305]: time="2026-01-27T23:26:17+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Jan 27 23:26:17 volumioro go-librespot[1305]: time="2026-01-27T23:26:17+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Jan 27 23:26:17 volumioro go-librespot[1305]: time="2026-01-27T23:26:17+01:00" level=debug msg="zeroconf server listening on port 41981" Jan 27 23:26:18 volumioro mpd[1290]: Jan 27 23:26 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 27 23:26:18 volumioro systemd[1]: Started Music Player Daemon. Jan 27 23:26:18 volumioro sudo[1266]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:18 volumioro sudo[1276]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:18 volumioro volumio[1003]: info: Completed starting Core Plugins Jan 27 23:26:18 volumioro volumio[1003]: info: ------------------------------------------- Jan 27 23:26:18 volumioro volumio[1003]: info: ----- MyVolumio plugins startup ---- Jan 27 23:26:18 volumioro volumio[1003]: info: ------------------------------------------- Jan 27 23:26:18 volumioro volumio[1003]: info: [MyVolumio PluginManager] Fetching plans data.... Jan 27 23:26:18 volumioro volumio[1003]: error: MPD error: The expression evaluated to a falsy value: Jan 27 23:26:18 volumioro volumio[1003]: assert.ok(self.idling) Jan 27 23:26:18 volumioro volumio[1003]: error: The expression evaluated to a falsy value: Jan 27 23:26:18 volumioro volumio[1003]: assert.ok(self.idling) Jan 27 23:26:18 volumioro volumio[1003]: info: MPD running with PID1290 Jan 27 23:26:18 volumioro volumio[1003]: ,establishing connection Jan 27 23:26:18 volumioro volumio[1003]: error: MPD error: The expression evaluated to a falsy value: Jan 27 23:26:18 volumioro volumio[1003]: assert.ok(self.idling) Jan 27 23:26:18 volumioro volumio[1003]: error: The expression evaluated to a falsy value: Jan 27 23:26:18 volumioro volumio[1003]: assert.ok(self.idling) Jan 27 23:26:18 volumioro volumio[1003]: error: updateQueue error: null Jan 27 23:26:19 volumioro volumio[1003]: info: go-librespot daemon successfully initialized Jan 27 23:26:20 volumioro sudo[1354]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 27 23:26:20 volumioro sudo[1354]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:20 volumioro sudo[1354]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:20 volumioro sudo[1356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 23:26:20 volumioro sudo[1356]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:20 volumioro sudo[1356]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:20 volumioro sudo[1360]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jan 27 23:26:20 volumioro sudo[1360]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:20 volumioro systemd[1]: Started UPnP Renderer front-end to MPD. Jan 27 23:26:20 volumioro sudo[1360]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:20 volumioro volumio[1003]: info: Upmpdcli Daemon Started Jan 27 23:26:20 volumioro volumio[1362]: Generating RSA private key, 4096 bit long modulus (2 primes) Jan 27 23:26:20 volumioro volumio[1003]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 27 23:26:20 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 27 23:26:20 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 23:26:20 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 27 23:26:21 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 27 23:26:21 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 27 23:26:21 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 27 23:26:21 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 27 23:26:21 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 27 23:26:21 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 27 23:26:21 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 27 23:26:21 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 27 23:26:21 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 27 23:26:21 volumioro sudo[1383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=ri,password=Leben105%SyRo,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.105/music /mnt/NAS/Musicstation Jan 27 23:26:21 volumioro sudo[1383]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:21 volumioro kernel: CIFS: Attempting to mount //192.168.1.105/music Jan 27 23:26:21 volumioro sudo[1388]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Jan 27 23:26:21 volumioro sudo[1388]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:21 volumioro sudo[1391]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Jan 27 23:26:21 volumioro sudo[1391]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:21 volumioro systemd[1]: Started MPD Monitor Service. Jan 27 23:26:21 volumioro mpd_monitor.sh[1392]: MPD Monitor Service: Starting MPD Monitor Service Jan 27 23:26:21 volumioro sudo[1388]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:21 volumioro volumio[1003]: info: Successfully started MPD Monitor Jan 27 23:26:21 volumioro systemd[1]: Stopping MPD Monitor Service... Jan 27 23:26:21 volumioro systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM Jan 27 23:26:21 volumioro systemd[1]: mpd_monitor.service: Succeeded. Jan 27 23:26:21 volumioro systemd[1]: Stopped MPD Monitor Service. Jan 27 23:26:21 volumioro systemd[1]: Started MPD Monitor Service. Jan 27 23:26:21 volumioro sudo[1391]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:21 volumioro mpd_monitor.sh[1395]: MPD Monitor Service: Starting MPD Monitor Service Jan 27 23:26:21 volumioro volumio[1003]: info: Successfully started MPD Monitor Jan 27 23:26:22 volumioro volumio[1003]: info: Initializing connection to go-librespot Websocket Jan 27 23:26:22 volumioro go-librespot[1305]: time="2026-01-27T23:26:22+01:00" level=debug msg="new websocket client" Jan 27 23:26:22 volumioro volumio[1003]: info: Connection to go-librespot Websocket established Jan 27 23:26:23 volumioro volumio-remote-updater[572]: [2026-01-27 23:26:23] [connect] Successful connection Jan 27 23:26:23 volumioro volumio-remote-updater[572]: [2026-01-27 23:26:23] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1769552783 101 Jan 27 23:26:23 volumioro volumio[1003]: 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: 4 Jan 27 23:26:23 volumioro volumio[1003]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jan 27 23:26:24 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 27 23:26:24 volumioro volumio[1362]: .............................................++++ Jan 27 23:26:25 volumioro volumio[1003]: info: Getting Spotify volume Jan 27 23:26:25 volumioro volumio[1003]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Jan 27 23:26:26 volumioro volumio[1003]: info: CoreCommandRouter::volumioGetState Jan 27 23:26:26 volumioro volumio[1003]: info: CorePlayQueue::getTrack 0 Jan 27 23:26:26 volumioro volumio[1003]: SPOTIFY: RECEIVED VOLUMIO VOLUME 45 Jan 27 23:26:26 volumioro volumio[1003]: SPOTIFY: SPOTIFY VOLUME undefined Jan 27 23:26:26 volumioro volumio[1003]: SPOTIFY: VOLUMIO VOLUME 45 Jan 27 23:26:26 volumioro volumio[1003]: info: Aligning Spotify Volume to Volumio Volume Jan 27 23:26:26 volumioro volumio[1003]: info: CoreCommandRouter::volumioGetState Jan 27 23:26:26 volumioro volumio[1003]: info: CorePlayQueue::getTrack 0 Jan 27 23:26:26 volumioro volumio[1003]: info: Setting Spotify Volume from Volumio: 45 Jan 27 23:26:26 volumioro volumio[1003]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jan 27 23:26:26 volumioro volumio[1003]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jan 27 23:26:26 volumioro volumio[1003]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jan 27 23:26:26 volumioro volumio[1003]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jan 27 23:26:26 volumioro volumio[1003]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jan 27 23:26:26 volumioro volumio[1003]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jan 27 23:26:26 volumioro volumio[1003]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jan 27 23:26:26 volumioro volumio[1003]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jan 27 23:26:26 volumioro volumio[1003]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jan 27 23:26:26 volumioro volumio[1003]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jan 27 23:26:26 volumioro volumio[1003]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jan 27 23:26:26 volumioro volumio[1003]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jan 27 23:26:26 volumioro volumio[1003]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jan 27 23:26:26 volumioro volumio[1003]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jan 27 23:26:26 volumioro volumio[1003]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jan 27 23:26:26 volumioro volumio[1003]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jan 27 23:26:26 volumioro volumio[1003]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jan 27 23:26:26 volumioro volumio[1003]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jan 27 23:26:26 volumioro volumio[1003]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jan 27 23:26:26 volumioro volumio[1003]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jan 27 23:26:26 volumioro volumio[1003]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jan 27 23:26:26 volumioro volumio[1003]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jan 27 23:26:26 volumioro volumio[1003]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jan 27 23:26:26 volumioro volumio[1003]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jan 27 23:26:26 volumioro volumio[1003]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jan 27 23:26:26 volumioro volumio[1003]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jan 27 23:26:26 volumioro volumio[1003]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jan 27 23:26:26 volumioro volumio[1003]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jan 27 23:26:26 volumioro volumio[1003]: info: Adding plugin bluetooth to MyMusic Plugins Jan 27 23:26:26 volumioro volumio[1003]: info: Adding plugin multiroom to MyMusic Plugins Jan 27 23:26:26 volumioro volumio[1003]: info: Adding plugin metavolumio to MyMusic Plugins Jan 27 23:26:26 volumioro volumio[1003]: info: Adding plugin cd_controller to MyMusic Plugins Jan 27 23:26:26 volumioro volumio[1003]: info: Adding plugin qobuzconnect to MyMusic Plugins Jan 27 23:26:26 volumioro volumio[1003]: info: Adding plugin smart_inputs to MyMusic Plugins Jan 27 23:26:26 volumioro volumio[1003]: info: Adding plugin tidalconnect to MyMusic Plugins Jan 27 23:26:26 volumioro volumio[1003]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jan 27 23:26:27 volumioro volumio[1362]: ............................++++ Jan 27 23:26:27 volumioro volumio[1362]: e is 65537 (0x010001) Jan 27 23:26:27 volumioro volumio[1362]: writing RSA key Jan 27 23:26:27 volumioro sudo[1383]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:27 volumioro kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jan 27 23:26:27 volumioro kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Jan 27 23:26:27 volumioro volumio[1003]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jan 27 23:26:27 volumioro volumio[1003]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jan 27 23:26:27 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 23:26:27 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 23:26:27 volumioro volumio[1003]: info: Starting MyVolumio Remote Streaming Endpoints Jan 27 23:26:27 volumioro volumio[1003]: info: MyVolumio login type: Token Jan 27 23:26:27 volumioro volumio[1003]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jan 27 23:26:27 volumioro volumio[1003]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jan 27 23:26:28 volumioro volumio[1003]: info: Starting Streaming Service Transparent Proxy Jan 27 23:26:28 volumioro volumio[1003]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jan 27 23:26:28 volumioro volumio[1003]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jan 27 23:26:28 volumioro volumio[1003]: info: Streaming services startup Jan 27 23:26:28 volumioro volumio[1003]: info: Starting Streaming Daemon Jan 27 23:26:28 volumioro sudo[1432]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jan 27 23:26:28 volumioro sudo[1432]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:28 volumioro volumio[1003]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jan 27 23:26:28 volumioro sudo[1432]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:28 volumioro volumio[1003]: SPOTIFY: SETTING SPOTIFY VOLUME 45 Jan 27 23:26:28 volumioro volumio[1003]: info: Sending Spotify command with payload to local API: /player/volume Jan 27 23:26:28 volumioro volumio[1003]: error: Cannot start Volumio Streaming Daemon Jan 27 23:26:28 volumioro volumio[1003]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jan 27 23:26:28 volumioro volumio[1003]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jan 27 23:26:28 volumioro volumio[1003]: info: Cannot mount NAS Musicstation at system boot, trial number 2 ,retrying in 5 seconds Jan 27 23:26:28 volumioro volumio[1003]: error: MyVolumio Custom Token format not valid, refreshing it Jan 27 23:26:29 volumioro volumio[1003]: STREAMING PROXY: Starting server on port 3245 Jan 27 23:26:29 volumioro volumio[1003]: Node JS runtime: 14 Jan 27 23:26:29 volumioro volumio[1003]: info: MyVolumio login type: Token Jan 27 23:26:29 volumioro volumio[1003]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jan 27 23:26:30 volumioro volumio[1003]: info: MyVolumio token set successfully Jan 27 23:26:30 volumioro volumio[1003]: info: MYVOLUMIO: Adding device Jan 27 23:26:30 volumioro volumio[1003]: info: MYVOLUMIO: Evaluating Server Jan 27 23:26:30 volumioro volumio[1003]: info: MyVolumio Plan changed: superstar Jan 27 23:26:30 volumioro volumio[1003]: info: [MyVolumio PluginManager] Subscribed plan changed to superstar Jan 27 23:26:30 volumioro volumio[1003]: info: Adding audio output: Jan 27 23:26:30 volumioro volumio[1003]: info: MYVOLUMIO: Adding device Jan 27 23:26:30 volumioro volumio[1003]: info: MYVOLUMIO: Evaluating Server Jan 27 23:26:30 volumioro volumio[1003]: info: Remote config written successfully Jan 27 23:26:30 volumioro volumio[1003]: info: Starting Tunnel 1 Jan 27 23:26:30 volumioro volumio[1003]: info: Starting Tunnel Connection Checker Jan 27 23:26:30 volumioro volumio[1003]: info: Completed starting MyVolumio Plugin Jan 27 23:26:30 volumioro volumio[1003]: info: MYVolumio Device enabled Jan 27 23:26:30 volumioro volumio[1003]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Jan 27 23:26:30 volumioro volumio[1003]: info: MyVolumio status changed Jan 27 23:26:30 volumioro volumio[1003]: info: Streaming services startup Jan 27 23:26:30 volumioro volumio[1003]: info: Starting Streaming Daemon Jan 27 23:26:30 volumioro volumio[1003]: info: Setting Geolocation for MyVolumio to eu11 Jan 27 23:26:30 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 23:26:30 volumioro sudo[1493]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jan 27 23:26:30 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 23:26:30 volumioro sudo[1493]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:30 volumioro sudo[1493]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:30 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Jan 27 23:26:30 volumioro volumio[1003]: error: [MyVolumio PluginManager] Cache data is invalid! Jan 27 23:26:30 volumioro volumio[1003]: error: Cannot start Volumio Streaming Daemon Jan 27 23:26:30 volumioro volumio[1003]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jan 27 23:26:30 volumioro volumio[1003]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jan 27 23:26:31 volumioro volumio[1003]: info: Setting Geolocation for MyVolumio to eu6 Jan 27 23:26:31 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 23:26:31 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 23:26:31 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 23:26:31 volumioro volumio[1003]: info: Successfully Added MyVolumio device Jan 27 23:26:31 volumioro volumio[1003]: info: Successfully Added MyVolumio device Jan 27 23:26:31 volumioro volumio[1003]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Jan 27 23:26:31 volumioro volumio[1003]: info: [1769552791731] Starting BluetoothController Jan 27 23:26:31 volumioro volumio[1003]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Jan 27 23:26:32 volumioro volumio[1003]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Jan 27 23:26:32 volumioro sudo[1496]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Jan 27 23:26:32 volumioro sudo[1496]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:32 volumioro sudo[1496]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:32 volumioro volumio[1003]: info: MRS: MultiRoom plugin initialized Jan 27 23:26:32 volumioro volumio[1003]: info: MRS: STOPPING SNAPCLIENT Jan 27 23:26:32 volumioro volumio[1003]: info: MRS: Snap server stop Jan 27 23:26:32 volumioro sudo[1512]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Jan 27 23:26:32 volumioro sudo[1512]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:32 volumioro volumio[1003]: info: MRS: STOPPING volumioStreaming Jan 27 23:26:32 volumioro sudo[1515]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Jan 27 23:26:32 volumioro sudo[1515]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:33 volumioro sudo[1512]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:33 volumioro sudo[1518]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Jan 27 23:26:33 volumioro volumio[1003]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Jan 27 23:26:33 volumioro sudo[1518]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:33 volumioro sudo[1515]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:33 volumioro volumio[1003]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Jan 27 23:26:33 volumioro sudo[1520]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Jan 27 23:26:33 volumioro sudo[1520]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:33 volumioro sudo[1518]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:33 volumioro sudo[1520]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:33 volumioro volumio[1003]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Jan 27 23:26:33 volumioro volumio[1003]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Jan 27 23:26:33 volumioro volumio[1003]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Jan 27 23:26:33 volumioro volumio[1003]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Jan 27 23:26:33 volumioro volumio[1003]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Jan 27 23:26:33 volumioro volumio[1003]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Jan 27 23:26:33 volumioro volumio[1003]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Jan 27 23:26:33 volumioro volumio[1003]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"... Jan 27 23:26:33 volumioro volumio[1003]: info: Preparing to generate the ALSA configuration file Jan 27 23:26:33 volumioro volumio[1003]: info: Updating MyVolumio device info Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 23:26:33 volumioro volumio[1003]: info: Updating MyVolumio device info Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Jan 27 23:26:33 volumioro volumio[1003]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jan 27 23:26:33 volumioro volumio[1003]: info: Reading ALSA contributions from plugins. Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 27 23:26:33 volumioro volumio[1003]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jan 27 23:26:33 volumioro volumio[1003]: info: Received Get System Version Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 27 23:26:33 volumioro volumio[1003]: info: Received Get System Info Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 27 23:26:33 volumioro volumio[1003]: info: Discovery: Getting this device information Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::volumioGetState Jan 27 23:26:33 volumioro volumio[1003]: info: CorePlayQueue::getTrack 0 Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 27 23:26:33 volumioro volumio[1003]: info: MRS: Removed streaming files Jan 27 23:26:33 volumioro volumio[1003]: info: MRS: volumioStreaming STOPPED Jan 27 23:26:33 volumioro volumio[1003]: info: MRS: SNAPSERVER STOPPED Jan 27 23:26:33 volumioro volumio[1003]: info: MRS: SNAPCLIENT STOPPED Jan 27 23:26:33 volumioro volumio[1003]: info: Asound.conf file written Jan 27 23:26:33 volumioro sudo[1524]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jan 27 23:26:33 volumioro sudo[1524]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:33 volumioro sudo[1524]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:33 volumioro volumio[1003]: info: Output device has changed, restarting MPD Jan 27 23:26:33 volumioro sudo[1529]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 27 23:26:33 volumioro sudo[1529]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:33 volumioro volumio[1003]: info: Output device has changed, restarting Shairport Sync Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 23:26:33 volumioro sudo[1529]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:33 volumioro sudo[1532]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 27 23:26:33 volumioro sudo[1532]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:33 volumioro systemd[1]: Stopping Music Player Daemon... Jan 27 23:26:33 volumioro volumio[1003]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 27 23:26:33 volumioro volumio[1003]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:33 volumioro volumio[1003]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 27 23:26:33 volumioro volumio[1003]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Jan 27 23:26:33 volumioro volumio[1003]: info: MRS: Pushing multiroomSync output for this device Jan 27 23:26:33 volumioro volumio[1003]: info: MRS: Pushing multiroomSync output Jan 27 23:26:33 volumioro volumio[1003]: info: Adding audio output: Jan 27 23:26:33 volumioro volumio[1003]: info: Adding audio output: Jan 27 23:26:33 volumioro sudo[1540]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name VolumioRo Jan 27 23:26:33 volumioro volumio[1003]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jan 27 23:26:33 volumioro sudo[1540]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:33 volumioro sudo[1540]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:33 volumioro volumio[1003]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Jan 27 23:26:33 volumioro volumio[1003]: info: Adding METAVOLUMIO REST API Endpoints Jan 27 23:26:33 volumioro volumio[1003]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Jan 27 23:26:33 volumioro volumio[1003]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Jan 27 23:26:33 volumioro volumio[1003]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Jan 27 23:26:33 volumioro volumio[1003]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Jan 27 23:26:33 volumioro volumio[1003]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Jan 27 23:26:33 volumioro volumio[1003]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Jan 27 23:26:33 volumioro volumio[1003]: info: Preparing CD Folders Jan 27 23:26:33 volumioro volumio[1003]: info: Adding CD REST API Endpoints Jan 27 23:26:33 volumioro volumio[1003]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Jan 27 23:26:33 volumioro volumio[1003]: info: Starting UDEV Watcher for CD Jan 27 23:26:33 volumioro volumio[1003]: info: Detecting CD presence with UDEV Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Jan 27 23:26:33 volumioro volumio[1003]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Jan 27 23:26:33 volumioro volumio[1003]: info: Adding inputs REST Endpoints Jan 27 23:26:33 volumioro volumio[1003]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Jan 27 23:26:33 volumioro volumio[1003]: info: Scanning Audio Inputs Jan 27 23:26:33 volumioro systemd[1]: mpd.service: Succeeded. Jan 27 23:26:33 volumioro systemd[1]: Stopped Music Player Daemon. Jan 27 23:26:33 volumioro volumio[1003]: info: Checking against Known Cards name Jan 27 23:26:33 volumioro volumio[1003]: info: Adding Server instance for streaming Jan 27 23:26:33 volumioro volumio[1003]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Jan 27 23:26:33 volumioro volumio[1003]: error: Hi Res Audio Failed Login: Missing Login Data Jan 27 23:26:33 volumioro volumio[1003]: info: Adding HIGHRESAUDIO REST API Endpoints Jan 27 23:26:33 volumioro volumio[1003]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Jan 27 23:26:33 volumioro volumio[1003]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Jan 27 23:26:33 volumioro volumio[1003]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Jan 27 23:26:33 volumioro volumio[1003]: info: Refreshing TIDAL token Jan 27 23:26:33 volumioro volumio[1003]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Jan 27 23:26:33 volumioro volumio[1003]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Jan 27 23:26:33 volumioro systemd[1]: Starting Music Player Daemon... Jan 27 23:26:33 volumioro volumio[1003]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuzconnect Jan 27 23:26:33 volumioro volumio[1003]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect Jan 27 23:26:33 volumioro sudo[1549]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 27 23:26:33 volumioro sudo[1549]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:33 volumioro volumio[1003]: info: QobuzConnect: Starting Qobuz Connect socket and service Jan 27 23:26:33 volumioro sudo[1549]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:33 volumioro volumio[1003]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections Jan 27 23:26:33 volumioro sudo[1556]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jan 27 23:26:33 volumioro volumio[1003]: info: Stopping AccessToken refresher cron for QOBUZ Jan 27 23:26:33 volumioro sudo[1556]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:33 volumioro sudo[1546]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 27 23:26:33 volumioro sudo[1546]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:33 volumioro sudo[1546]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:33 volumioro sudo[1556]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:33 volumioro volumio[1003]: info: AccessToken refresher cron started for QOBUZ Jan 27 23:26:33 volumioro volumio[1003]: info: Adding QOBUZ REST API Endpoints Jan 27 23:26:33 volumioro volumio[1003]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Jan 27 23:26:33 volumioro sudo[1560]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jan 27 23:26:33 volumioro sudo[1560]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:33 volumioro sudo[1563]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=ri,password=Leben105%SyRo,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.105/music /mnt/NAS/Musicstation Jan 27 23:26:33 volumioro sudo[1563]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:33 volumioro volumio[1003]: info: Bluetooth name changed to VolumioRo Jan 27 23:26:33 volumioro systemd[1]: Started Volumio Qobuz Connect Service. Jan 27 23:26:33 volumioro kernel: CIFS: Attempting to mount //192.168.1.105/music Jan 27 23:26:33 volumioro volumio[1003]: info: MPD Permissions set Jan 27 23:26:33 volumioro sudo[1560]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:33 volumioro volumio[1003]: info: Starting Shairport Sync Jan 27 23:26:33 volumioro sudo[1574]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 27 23:26:33 volumioro sudo[1574]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:33 volumioro systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 27 23:26:33 volumioro systemd[1]: shairport-sync.service: Succeeded. Jan 27 23:26:33 volumioro systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 27 23:26:33 volumioro volumio[1003]: info: Executing endpoint qc_getconfig Jan 27 23:26:33 volumioro qobuz-connect[1566]: 20260127 23:26:33.917 [1566.1566] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jan 27 23:26:33 volumioro systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 27 23:26:33 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jan 27 23:26:33 volumioro volumio[1003]: info: MRS: Found cast device: IP2000-59bd2a57da195b28bde4eface06fee7c Jan 27 23:26:33 volumioro volumio[1003]: info: Adding audio output: Jan 27 23:26:33 volumioro sudo[1574]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:33 volumioro volumio[1003]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jan 27 23:26:33 volumioro volumio[1003]: info: QobuzConnect: QOBUZ Connect daemon connected Jan 27 23:26:33 volumioro volumio[1003]: info: Shairport-Sync Started Jan 27 23:26:33 volumioro volumio[1003]: error: No access token received for TIDAL Jan 27 23:26:34 volumioro qobuz-connect[1566]: 20260127 23:26:34.050 [1566.1566] INFO VolumeManager: [0x8dc818]: Setting new playback volume: 75 Jan 27 23:26:34 volumioro qobuz-connect[1566]: 20260127 23:26:34.050 [1566.1566] INFO VolumeManager: [0x8dc818]: Setting new mute state: 0 Jan 27 23:26:34 volumioro qobuz-connect[1566]: 20260127 23:26:34.050 [1566.1566] INFO QobuzConnect: [0x8dd1e8]: Client initialized! Jan 27 23:26:34 volumioro qobuz-connect[1566]: 20260127 23:26:34.050 [1566.1566] INFO SampleApp: Starting Avahi advertising, name: VolumioRo, service name: _qobuz-connect._tcp Jan 27 23:26:34 volumioro qobuz-connect[1566]: 20260127 23:26:34.056 [1566.1566] INFO LocalConfigManager: [0x8dc0f8]: Starting Local Configuration server Jan 27 23:26:34 volumioro qobuz-connect[1566]: 20260127 23:26:34.056 [1566.1566] INFO SampleApp: Starting Local configuration server Jan 27 23:26:34 volumioro qobuz-connect[1566]: 20260127 23:26:34.056 [1566.1566] INFO SampleApp: Connected to UNIX socket client 0x8d1f60 Jan 27 23:26:34 volumioro qobuz-connect[1566]: 20260127 23:26:34.067 [1566.1566] INFO SampleApp: Playback volume changed: 75 Jan 27 23:26:34 volumioro volumio[1003]: info: CoreCommandRouter::volumioGetState Jan 27 23:26:34 volumioro volumio[1003]: info: CorePlayQueue::getTrack 0 Jan 27 23:26:34 volumioro volumio[1003]: info: Successfully Updated MyVolumio device Jan 27 23:26:34 volumioro mpd[1559]: Jan 27 23:26 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 27 23:26:34 volumioro systemd[1]: Started Music Player Daemon. Jan 27 23:26:34 volumioro sudo[1532]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:34 volumioro volumio[1003]: error: updateQueue error: null Jan 27 23:26:34 volumioro volumio[1003]: info: Successfully Updated MyVolumio device Jan 27 23:26:35 volumioro sudo[1590]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Jan 27 23:26:35 volumioro sudo[1590]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:35 volumioro systemd[1]: Started MyVolumio SSH Tunnel. Jan 27 23:26:35 volumioro sudo[1590]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:35 volumioro volumio[1003]: info: Remote SSH Started Jan 27 23:26:35 volumioro autossh[1593]: port set to 0, monitoring disabled Jan 27 23:26:35 volumioro autossh[1593]: starting ssh (count 1) Jan 27 23:26:35 volumioro autossh[1593]: ssh child pid is 1596 Jan 27 23:26:35 volumioro volumio[1003]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jan 27 23:26:35 volumioro volumio[1003]: info: CoreCommandRouter::volumioGetState Jan 27 23:26:35 volumioro volumio[1003]: info: CorePlayQueue::getTrack 0 Jan 27 23:26:35 volumioro volumiossh-tunnel[1592]: Warning: Permanently added '[eu6.myvolumio.org]:2222,[207.154.233.230]:2222' (RSA) to the list of known hosts. Jan 27 23:26:36 volumioro systemd[1]: systemd-timedated.service: Succeeded. Jan 27 23:26:36 volumioro sudo[1600]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Jan 27 23:26:36 volumioro sudo[1600]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:36 volumioro systemd[1]: Started Volumio Bluetooth Module. Jan 27 23:26:36 volumioro sudo[1600]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:36 volumioro volumio[1003]: info: Volumio BT Module successfully started Jan 27 23:26:36 volumioro sudo[1603]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Jan 27 23:26:36 volumioro sudo[1603]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:36 volumioro volumiobt[1602]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Jan 27 23:26:36 volumioro sudo[1603]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:36 volumioro volumio[1003]: info: TidalConnect service stoped! Jan 27 23:26:36 volumioro volumio[1003]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 27 23:26:36 volumioro volumio[1003]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 27 23:26:36 volumioro sudo[1615]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 27 23:26:36 volumioro sudo[1615]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:36 volumioro systemd[1]: Started Volumio Tidal Connect Service. Jan 27 23:26:36 volumioro sudo[1615]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:37 volumioro volumio[1003]: info: Executing endpoint tc_getconfig Jan 27 23:26:37 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jan 27 23:26:37 volumioro vtcs[1617]: STARTING TidalConnect services, version: 1.5.2.56 Jan 27 23:26:37 volumioro vtcs[1617]: STARTED TidalConnect services. Jan 27 23:26:37 volumioro volumio[1003]: info: Executing endpoint tc_connect Jan 27 23:26:37 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jan 27 23:26:37 volumioro volumio[1003]: info: Connecting to TidalConnect Jan 27 23:26:37 volumioro volumio[1003]: info: CoreCommandRouter::servicePushState Jan 27 23:26:37 volumioro volumio[1003]: info: CoreStateMachine::pushState Jan 27 23:26:37 volumioro volumio[1003]: info: CorePlayQueue::getTrack 0 Jan 27 23:26:37 volumioro volumio[1003]: info: CoreCommandRouter::volumioPushState Jan 27 23:26:37 volumioro volumio[1003]: info: MRS: Pushing multiroomSync output update for this device Jan 27 23:26:37 volumioro volumio[1003]: info: MRS: Pushing multiroomSync output Jan 27 23:26:37 volumioro volumio[1003]: info: CoreCommandRouter::volumioGetState Jan 27 23:26:37 volumioro volumio[1003]: info: CorePlayQueue::getTrack 0 Jan 27 23:26:37 volumioro volumio[1003]: info: CorePlayQueue::getTrack 0 Jan 27 23:26:37 volumioro volumio[1003]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Jan 27 23:26:37 volumioro volumio[1003]: info: CoreCommandRouter::servicePushState Jan 27 23:26:37 volumioro volumio[1003]: info: CoreStateMachine::pushState Jan 27 23:26:37 volumioro volumio[1003]: info: CorePlayQueue::getTrack 0 Jan 27 23:26:37 volumioro volumio[1003]: info: CoreCommandRouter::volumioPushState Jan 27 23:26:37 volumioro volumio[1003]: info: MRS: Pushing multiroomSync output update for this device Jan 27 23:26:37 volumioro volumio[1003]: info: MRS: Pushing multiroomSync output Jan 27 23:26:37 volumioro volumio[1003]: info: CoreCommandRouter::volumioGetState Jan 27 23:26:37 volumioro volumio[1003]: info: CorePlayQueue::getTrack 0 Jan 27 23:26:37 volumioro volumio[1003]: info: CorePlayQueue::getTrack 0 Jan 27 23:26:37 volumioro volumio[1003]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Jan 27 23:26:37 volumioro volumio[1003]: SPOTIFY: RECEIVED VOLUMIO VOLUME 45 Jan 27 23:26:37 volumioro volumio[1003]: SPOTIFY: RECEIVED VOLUMIO VOLUME 45 Jan 27 23:26:37 volumioro sudo[1637]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Jan 27 23:26:37 volumioro sudo[1637]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:37 volumioro systemd[1]: Stopping MPD Monitor Service... Jan 27 23:26:37 volumioro systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM Jan 27 23:26:37 volumioro systemd[1]: mpd_monitor.service: Succeeded. Jan 27 23:26:37 volumioro systemd[1]: Stopped MPD Monitor Service. Jan 27 23:26:37 volumioro volumio[1003]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 27 23:26:37 volumioro volumio[1003]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 27 23:26:37 volumioro systemd[1]: Started MPD Monitor Service. Jan 27 23:26:37 volumioro mpd_monitor.sh[1639]: MPD Monitor Service: Starting MPD Monitor Service Jan 27 23:26:37 volumioro sudo[1637]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:37 volumioro volumio[1003]: info: Successfully started MPD Monitor Jan 27 23:26:37 volumioro sudo[1643]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Jan 27 23:26:37 volumioro sudo[1643]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:37 volumioro volumiobt[1602]: pulseaudio: no process found Jan 27 23:26:37 volumioro sudo[1643]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:37 volumioro dbus-daemon[600]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.23' (uid=1000 pid=1647 comm="/usr/bin/pulseaudio --high-priority=true ") Jan 27 23:26:37 volumioro systemd[1]: Starting RealtimeKit Scheduling Policy Service... Jan 27 23:26:37 volumioro volumio[1003]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 27 23:26:37 volumioro dbus-daemon[600]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Jan 27 23:26:37 volumioro systemd[1]: Started RealtimeKit Scheduling Policy Service. Jan 27 23:26:37 volumioro rtkit-daemon[1648]: Successfully called chroot. Jan 27 23:26:37 volumioro rtkit-daemon[1648]: Successfully dropped privileges. Jan 27 23:26:37 volumioro rtkit-daemon[1648]: Successfully limited resources. Jan 27 23:26:37 volumioro rtkit-daemon[1648]: Running. Jan 27 23:26:37 volumioro rtkit-daemon[1648]: Canary thread running. Jan 27 23:26:37 volumioro rtkit-daemon[1648]: Watchdog thread running. Jan 27 23:26:37 volumioro dbus-daemon[600]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.24' (uid=0 pid=1648 comm="/usr/lib/rtkit/rtkit-daemon ") Jan 27 23:26:37 volumioro systemd[1]: Starting Authorization Manager... Jan 27 23:26:37 volumioro volumio[1003]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 27 23:26:37 volumioro polkitd[1652]: started daemon version 0.105 using authority implementation `local' version `0.105' Jan 27 23:26:37 volumioro dbus-daemon[600]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Jan 27 23:26:37 volumioro systemd[1]: Started Authorization Manager. Jan 27 23:26:37 volumioro volumio[1003]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 27 23:26:37 volumioro volumio[1003]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 27 23:26:37 volumioro volumio[1003]: info: Retrieving Cloud Streaming UI Jan 27 23:26:37 volumioro volumio[1003]: info: Getting Tidal Cloud Configuration Jan 27 23:26:37 volumioro volumio[1003]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 27 23:26:37 volumioro volumio[1003]: info: Getting Qobuz Cloud Configuration Jan 27 23:26:37 volumioro volumio[1003]: info: Asking plugin for UI Config Jan 27 23:26:37 volumioro volumio[1003]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 27 23:26:37 volumioro volumio[1003]: info: Getting Spotify Cloud Configuration Jan 27 23:26:37 volumioro volumio[1003]: info: Asking plugin for UI Config Jan 27 23:26:37 volumioro volumio[1003]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 27 23:26:37 volumioro volumio[1003]: info: Saving Spotify Acccount Jan 27 23:26:37 volumioro volumio[1003]: info: Got it Jan 27 23:26:37 volumioro volumio[1003]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jan 27 23:26:38 volumioro volumio[1003]: info: Got Tidal Cloud Configuration Jan 27 23:26:38 volumioro volumio[1003]: info: Got it Jan 27 23:26:38 volumioro volumio[1003]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 27 23:26:38 volumioro pulseaudio[1647]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Jan 27 23:26:38 volumioro pulseaudio[1647]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Jan 27 23:26:38 volumioro pulseaudio[1647]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files Jan 27 23:26:38 volumioro volumiobt[1602]: Applying permissions Jan 27 23:26:38 volumioro volumiobt[1602]: Setting BT discoverable and pairable Jan 27 23:26:38 volumioro bluetoothd[761]: Endpoint registered: sender=:1.44 path=/MediaEndpoint/A2DPSource Jan 27 23:26:38 volumioro bluetoothd[761]: Endpoint registered: sender=:1.44 path=/MediaEndpoint/A2DPSink Jan 27 23:26:38 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 27 23:26:38 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 27 23:26:38 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 27 23:26:38 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 27 23:26:38 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 27 23:26:38 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 27 23:26:38 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 27 23:26:38 volumioro volumio[1003]: info: CoreCommandRouter::volumioGetBrowseSources Jan 27 23:26:38 volumioro volumio[1003]: info: CoreCommandRouter::volumioGetBrowseSources Jan 27 23:26:38 volumioro volumio[1003]: info: CoreCommandRouter::volumioGetBrowseSources Jan 27 23:26:38 volumioro kernel: Bluetooth: RFCOMM TTY layer initialized Jan 27 23:26:38 volumioro kernel: Bluetooth: RFCOMM socket layer initialized Jan 27 23:26:38 volumioro kernel: Bluetooth: RFCOMM ver 1.11 Jan 27 23:26:38 volumioro volumiobt[1602]: [96B blob data] Jan 27 23:26:38 volumioro volumiobt[1602]: [77B blob data] Jan 27 23:26:38 volumioro volumiobt[1602]: [77B blob data] Jan 27 23:26:38 volumioro volumiobt[1602]: [95B blob data] Jan 27 23:26:38 volumioro volumiobt[1602]: [95B blob data] Jan 27 23:26:38 volumioro volumiobt[1602]: [95B blob data] Jan 27 23:26:38 volumioro volumiobt[1602]: [95B blob data] Jan 27 23:26:38 volumioro volumiobt[1602]: [95B blob data] Jan 27 23:26:38 volumioro volumiobt[1602]: [95B blob data] Jan 27 23:26:38 volumioro volumiobt[1602]: [95B blob data] Jan 27 23:26:38 volumioro volumiobt[1602]: [95B blob data] Jan 27 23:26:38 volumioro volumiobt[1602]: [95B blob data] Jan 27 23:26:38 volumioro volumiobt[1602]: [95B blob data] Jan 27 23:26:38 volumioro volumiobt[1602]: [79B blob data] Jan 27 23:26:38 volumioro volumiobt[1602]: [33B blob data] Jan 27 23:26:38 volumioro volumiobt[1602]: [95B blob data] Jan 27 23:26:38 volumioro volumiobt[1602]: [95B blob data] Jan 27 23:26:38 volumioro volumiobt[1602]: [95B blob data] Jan 27 23:26:38 volumioro volumiobt[1602]: [95B blob data] Jan 27 23:26:38 volumioro volumiobt[1602]: [95B blob data] Jan 27 23:26:38 volumioro volumiobt[1602]: [95B blob data] Jan 27 23:26:38 volumioro volumiobt[1602]: [95B blob data] Jan 27 23:26:38 volumioro volumiobt[1602]: [95B blob data] Jan 27 23:26:38 volumioro volumiobt[1602]: [95B blob data] Jan 27 23:26:38 volumioro volumiobt[1602]: [95B blob data] Jan 27 23:26:38 volumioro volumiobt[1602]: [65B blob data] Jan 27 23:26:38 volumioro volumiobt[1602]: [55B blob data] Jan 27 23:26:38 volumioro volumiobt[1602]: [bluetoothctl]> -e power on Jan 27 23:26:38 volumioro volumiobt[1602]: Invalid command in menu main: -e Jan 27 23:26:38 volumioro volumiobt[1602]: Jan 27 23:26:38 volumioro volumiobt[1602]: Use "help" for a list of available commands in a menu. Jan 27 23:26:38 volumioro volumiobt[1602]: Use "menu " if you want to enter any submenu. Jan 27 23:26:38 volumioro volumiobt[1602]: Use "back" if you want to return to menu main. Jan 27 23:26:38 volumioro volumiobt[1602]: [103B blob data] Jan 27 23:26:38 volumioro volumiobt[1602]: [bluetoothctl]> agent on Jan 27 23:26:38 volumioro volumiobt[1602]: Agent is already registered Jan 27 23:26:38 volumioro volumiobt[1602]: [bluetoothctl]> discoverable on Jan 27 23:26:38 volumioro volumiobt[1602]: Warning: setting discoverable while discoverable-timeout not set(0) is not recommended Jan 27 23:26:38 volumioro volumiobt[1602]: [bluetoothctl]> pairable on Jan 27 23:26:38 volumioro volumiobt[1602]: [bluetoothctl]> agent NoInputNoOutput Jan 27 23:26:38 volumioro volumiobt[1602]: Agent is already registered Jan 27 23:26:38 volumioro volumiobt[1602]: [bluetoothctl]> default-agent Jan 27 23:26:38 volumioro volumiobt[1602]: [bluetoothctl]> quit Jan 27 23:26:38 volumioro volumiobt[1602]: [65B blob data] Jan 27 23:26:38 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 27 23:26:38 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jan 27 23:26:38 volumioro volumio[1003]: info: MRS: Getting audio outputs on start Jan 27 23:26:38 volumioro volumio[1003]: info: MRS: Requesting all other devices output Jan 27 23:26:39 volumioro volumio[1003]: info: TidalConnect service started! Jan 27 23:26:39 volumioro volumio[1003]: [Metrics] CommandRouter: 31s 844.95ms Jan 27 23:26:39 volumioro volumio[1003]: info: CoreCommandRouter::volumiosetStartupVolume Jan 27 23:26:39 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:39 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 23:26:39 volumioro volumio[1003]: info: CoreCommandRouter::Close All Modals sent Jan 27 23:26:39 volumioro volumio[1003]: info: CoreCommandRouter::Close All Modals sent Jan 27 23:26:40 volumioro sudo[1563]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:40 volumioro volumio[1003]: info: Cannot mount NAS Musicstation at system boot, trial number 3 ,retrying in 5 seconds Jan 27 23:26:40 volumioro kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jan 27 23:26:40 volumioro kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Jan 27 23:26:40 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jan 27 23:26:40 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 27 23:26:40 volumioro volumio[1003]: xcb_connection_has_error() returned true Jan 27 23:26:40 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jan 27 23:26:42 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 27 23:26:42 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 27 23:26:42 volumioro volumio[1003]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jan 27 23:26:42 volumioro volumio[1003]: info: CoreCommandRouter::volumioGetState Jan 27 23:26:42 volumioro volumio[1003]: info: CorePlayQueue::getTrack 0 Jan 27 23:26:45 volumioro sudo[1684]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=ri,password=Leben105%SyRo,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.105/music /mnt/NAS/Musicstation Jan 27 23:26:45 volumioro sudo[1684]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 27 23:26:45 volumioro kernel: CIFS: Attempting to mount //192.168.1.105/music Jan 27 23:26:46 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 27 23:26:46 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 27 23:26:46 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 27 23:26:46 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 27 23:26:46 volumioro volumio[1003]: info: BOOT COMPLETED Jan 27 23:26:47 volumioro volumio-remote-updater[572]: No test mode Jan 27 23:26:47 volumioro volumio-remote-updater[572]: No alpha test mode Jan 27 23:26:47 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jan 27 23:26:47 volumioro volumio[1003]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jan 27 23:26:47 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jan 27 23:26:47 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:47 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 27 23:26:47 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jan 27 23:26:47 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jan 27 23:26:47 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jan 27 23:26:47 volumioro volumio[1003]: info: CoreCommandRouter::volumioGetBrowseSources Jan 27 23:26:47 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 27 23:26:50 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 27 23:26:50 volumioro ntpd[769]: Soliciting pool server 84.234.19.174 Jan 27 23:26:51 volumioro sudo[1684]: pam_unix(sudo:session): session closed for user root Jan 27 23:26:51 volumioro volumio[1003]: info: Cannot mount NAS Musicstation at system boot, trial number 4 ,retrying in 5 seconds Jan 27 23:26:51 volumioro kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jan 27 23:26:51 volumioro kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Jan 27 23:26:51 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Jan 27 23:26:51 volumioro ntpd[769]: Soliciting pool server 81.94.123.17 Jan 27 23:26:52 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jan 27 23:26:52 volumioro ntpd[769]: Soliciting pool server 84.16.69.149 Jan 27 23:26:53 volumioro ntpd[769]: Soliciting pool server 31.3.135.232 Jan 27 23:26:53 volumioro ntpd[769]: Soliciting pool server 192.33.96.102 Jan 27 23:26:54 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 27 23:26:54 volumioro ntpd[769]: Soliciting pool server 193.134.29.11 Jan 27 23:26:54 volumioro ntpd[769]: Soliciting pool server 193.134.29.12 Jan 27 23:26:54 volumioro ntpd[769]: Soliciting pool server 195.141.190.190 Jan 27 23:26:55 volumioro ntpd[769]: Soliciting pool server 84.16.73.33 Jan 27 23:26:55 volumioro ntpd[769]: Soliciting pool server 217.147.223.78 Jan 27 23:26:55 volumioro ntpd[769]: Soliciting pool server 217.147.208.1 Jan 27 23:26:55 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Jan 27 23:26:55 volumioro volumio[1003]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Jan 27 23:26:56 volumioro volumio[1003]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 27 23:26:56 volumioro volumio[1003]: TypeError: Cannot read property 'replace' of undefined Jan 27 23:26:56 volumioro volumio[1003]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:202:28) Jan 27 23:26:56 volumioro volumio[1003]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:255:20) Jan 27 23:26:56 volumioro volumio[1003]: at listOnTimeout (internal/timers.js:554:17) Jan 27 23:26:56 volumioro volumio[1003]: at processTimers (internal/timers.js:497:7) Jan 27 23:26:56 volumioro volumio[1003]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 27 23:26:56 volumioro sudo[1760]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-27 23:25 Jan 27 23:26:56 volumioro sudo[1760]: 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="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"