-- Logs begin at Sun 2024-03-31 10:34:27 EDT, end at Tue 2025-07-01 22:44:22 EDT. -- Jul 01 22:43:08 minidsp-mr volumiologrotate[443]: ls: cannot access '/var/log/samba/log.wb-MINIDSP': No such file or directory Jul 01 22:43:08 minidsp-mr volumiologrotate[443]: ls: cannot access 'MR': No such file or directory Jul 01 22:43:36 minidsp-mr volumio[5872]: info: sendMpdCommand status took 120466 milliseconds Jul 01 22:43:36 minidsp-mr volumio[5872]: info: sendMpdCommand status took 120479 milliseconds Jul 01 22:43:36 minidsp-mr volumio[5872]: info: sendMpdCommand status took 120470 milliseconds Jul 01 22:43:36 minidsp-mr volumio[5872]: verbose: ControllerMpd::parseState Jul 01 22:43:36 minidsp-mr volumio[5872]: info: Command Router : Notfying DB Updatetrue Jul 01 22:43:36 minidsp-mr volumio[5872]: info: CoreCommandRouter::Close All Modals sent Jul 01 22:43:36 minidsp-mr volumio[5872]: verbose: ControllerMpd::parseState Jul 01 22:43:36 minidsp-mr volumio[5872]: verbose: ControllerMpd::parseState Jul 01 22:43:36 minidsp-mr volumio[5872]: info: ControllerMpd::pushState Jul 01 22:43:36 minidsp-mr volumio[5872]: info: CoreCommandRouter::servicePushState Jul 01 22:43:36 minidsp-mr volumio[5872]: info: CoreStateMachine::pushState Jul 01 22:43:36 minidsp-mr volumio[5872]: info: CorePlayQueue::getTrack 0 Jul 01 22:43:36 minidsp-mr volumio[5872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 22:43:36 minidsp-mr volumio[5872]: info: CoreCommandRouter::volumioPushState Jul 01 22:43:36 minidsp-mr volumio[5872]: info: MRS: Pushing multiroomSync output update for this device Jul 01 22:43:36 minidsp-mr volumio[5872]: info: MRS: Pushing multiroomSync output Jul 01 22:43:36 minidsp-mr volumio[5872]: info: CorePlayQueue::getTrack 0 Jul 01 22:43:36 minidsp-mr volumio[5872]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 01 22:43:36 minidsp-mr volumio[5872]: verbose: CURRENT POSITION 0 Jul 01 22:43:36 minidsp-mr volumio[5872]: info: CoreStateMachine::syncState stateService stop Jul 01 22:43:36 minidsp-mr volumio[5872]: info: CoreStateMachine::syncState currentStatus stop Jul 01 22:43:36 minidsp-mr volumio[5872]: info: CoreStateMachine::pushState Jul 01 22:43:36 minidsp-mr volumio[5872]: info: CorePlayQueue::getTrack 0 Jul 01 22:43:36 minidsp-mr volumio[5872]: info: CoreCommandRouter::volumioPushState Jul 01 22:43:36 minidsp-mr volumio[5872]: info: MRS: Pushing multiroomSync output update for this device Jul 01 22:43:36 minidsp-mr volumio[5872]: info: MRS: Pushing multiroomSync output Jul 01 22:43:36 minidsp-mr volumio[5872]: info: No code Jul 01 22:43:36 minidsp-mr volumio[5872]: info: CoreStateMachine::pushState Jul 01 22:43:36 minidsp-mr volumio[5872]: info: CorePlayQueue::getTrack 0 Jul 01 22:43:36 minidsp-mr volumio[5872]: info: CoreCommandRouter::volumioPushState Jul 01 22:43:36 minidsp-mr volumio[5872]: info: MRS: Pushing multiroomSync output update for this device Jul 01 22:43:36 minidsp-mr volumio[5872]: info: MRS: Pushing multiroomSync output Jul 01 22:43:36 minidsp-mr volumio[5872]: info: ControllerMpd::pushState Jul 01 22:43:36 minidsp-mr volumio[5872]: info: CoreCommandRouter::servicePushState Jul 01 22:43:36 minidsp-mr volumio[5872]: info: CoreStateMachine::pushState Jul 01 22:43:36 minidsp-mr volumio[5872]: info: CorePlayQueue::getTrack 0 Jul 01 22:43:36 minidsp-mr volumio[5872]: info: CoreCommandRouter::volumioPushState Jul 01 22:43:36 minidsp-mr volumio[5872]: info: MRS: Pushing multiroomSync output update for this device Jul 01 22:43:36 minidsp-mr volumio[5872]: info: MRS: Pushing multiroomSync output Jul 01 22:43:36 minidsp-mr volumio[5872]: info: CorePlayQueue::getTrack 0 Jul 01 22:43:36 minidsp-mr volumio[5872]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 01 22:43:36 minidsp-mr volumio[5872]: verbose: CURRENT POSITION 0 Jul 01 22:43:36 minidsp-mr volumio[5872]: info: CoreStateMachine::syncState stateService stop Jul 01 22:43:36 minidsp-mr volumio[5872]: info: CoreStateMachine::syncState currentStatus stop Jul 01 22:43:37 minidsp-mr volumio[5872]: info: CoreStateMachine::pushState Jul 01 22:43:37 minidsp-mr volumio[5872]: info: CorePlayQueue::getTrack 0 Jul 01 22:43:37 minidsp-mr volumio[5872]: info: CoreCommandRouter::volumioPushState Jul 01 22:43:37 minidsp-mr volumio[5872]: info: MRS: Pushing multiroomSync output update for this device Jul 01 22:43:37 minidsp-mr volumio[5872]: info: MRS: Pushing multiroomSync output Jul 01 22:43:37 minidsp-mr volumio[5872]: info: No code Jul 01 22:43:37 minidsp-mr volumio[5872]: info: CoreStateMachine::pushState Jul 01 22:43:37 minidsp-mr volumio[5872]: info: CorePlayQueue::getTrack 0 Jul 01 22:43:37 minidsp-mr volumio[5872]: info: CoreCommandRouter::volumioPushState Jul 01 22:43:37 minidsp-mr volumio[5872]: info: MRS: Pushing multiroomSync output update for this device Jul 01 22:43:37 minidsp-mr volumio[5872]: info: MRS: Pushing multiroomSync output Jul 01 22:43:37 minidsp-mr volumio[5872]: info: ------------------------------ 120861ms Jul 01 22:43:37 minidsp-mr volumio[5872]: info: ------------------------------ 120863ms Jul 01 22:43:37 minidsp-mr volumio[5872]: info: Preload queue cleared Jul 01 22:43:37 minidsp-mr volumio[5872]: info: Preloading song: mnt/NAS/Music/Joe Crookston/Fall Down As The Rain/02 Joe Crookston - Fall Down As The Rain.flac Jul 01 22:43:37 minidsp-mr volumio[5872]: info: Exploding uri mnt/NAS/Music/Joe Crookston/Fall Down As The Rain/02 Joe Crookston - Fall Down As The Rain.flac in service mpd Jul 01 22:43:42 minidsp-mr sudo[6837]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 01 22:43:42 minidsp-mr sudo[6837]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 22:43:42 minidsp-mr sudo[6839]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 01 22:43:42 minidsp-mr sudo[6839]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 22:43:42 minidsp-mr sudo[6837]: pam_unix(sudo:session): session closed for user root Jul 01 22:43:42 minidsp-mr sudo[6839]: pam_unix(sudo:session): session closed for user root Jul 01 22:43:43 minidsp-mr volumio[5872]: <--- Last few GCs ---> Jul 01 22:43:43 minidsp-mr volumio[5872]: [5872:0x5502008] 842380 ms: Scavenge 216.3 (223.5) -> 216.3 (223.5) MB, 1.0 / 0.0 ms (average mu = 0.910, current mu = 0.925) allocation failure Jul 01 22:43:43 minidsp-mr volumio[5872]: [5872:0x5502008] 842507 ms: Scavenge (reduce) 227.4 (234.5) -> 227.4 (234.5) MB, 9.9 / 0.0 ms (average mu = 0.910, current mu = 0.925) allocation failure Jul 01 22:43:43 minidsp-mr volumio[5872]: [5872:0x5502008] 842597 ms: Scavenge (reduce) 238.6 (243.7) -> 238.5 (243.7) MB, 9.7 / 0.0 ms (average mu = 0.910, current mu = 0.925) allocation failure Jul 01 22:43:43 minidsp-mr volumio[5872]: <--- JS stacktrace ---> Jul 01 22:43:43 minidsp-mr volumio[5872]: FATAL ERROR: MarkCompactCollector: young object promotion failed Allocation failed - JavaScript heap out of memory Jul 01 22:43:43 minidsp-mr volumio-remote-updater[477]: [2025-07-01 22:43:43] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jul 01 22:43:43 minidsp-mr volumio-remote-updater[477]: [2025-07-01 22:43:43] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jul 01 22:43:43 minidsp-mr systemd[1]: volumio.service: Main process exited, code=killed, status=6/ABRT Jul 01 22:43:43 minidsp-mr systemd[1]: volumio.service: Failed with result 'signal'. Jul 01 22:43:43 minidsp-mr systemd[1]: Started dynamicswap service. Jul 01 22:43:43 minidsp-mr systemd[1]: dynamicswap.service: Succeeded. Jul 01 22:43:43 minidsp-mr systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jul 01 22:43:43 minidsp-mr systemd[1]: volumio.service: Scheduled restart job, restart counter is at 8. Jul 01 22:43:43 minidsp-mr systemd[1]: Started dynamicswap service. Jul 01 22:43:43 minidsp-mr systemd[1]: Stopped Volumio Backend Module. Jul 01 22:43:43 minidsp-mr systemd[1]: Started Volumio Backend Module. Jul 01 22:43:43 minidsp-mr systemd[1]: dynamicswap.service: Succeeded. Jul 01 22:43:48 minidsp-mr volumio[6852]: info: ------------------------------------------- Jul 01 22:43:48 minidsp-mr volumio[6852]: info: ----- Volumio3 ---- Jul 01 22:43:48 minidsp-mr volumio[6852]: info: ------------------------------------------- Jul 01 22:43:48 minidsp-mr volumio[6852]: info: ----- System startup ---- Jul 01 22:43:48 minidsp-mr volumio[6852]: info: ------------------------------------------- Jul 01 22:43:48 minidsp-mr volumio-remote-updater[477]: [2025-07-01 22:43:48] [connect] Successful connection Jul 01 22:43:49 minidsp-mr volumio[6852]: info: MYVOLUMIO Environment detected Jul 01 22:43:50 minidsp-mr volumio[6852]: info: Plugin folders cleanup Jul 01 22:43:50 minidsp-mr volumio[6852]: info: Scanning into folder /volumio/app/plugins/ Jul 01 22:43:50 minidsp-mr volumio[6852]: info: Scanning category audio_interface Jul 01 22:43:50 minidsp-mr volumio[6852]: info: Scanning category miscellanea Jul 01 22:43:50 minidsp-mr volumio[6852]: info: Scanning category music_service Jul 01 22:43:50 minidsp-mr volumio[6852]: info: Scanning category plugins.json Jul 01 22:43:50 minidsp-mr volumio[6852]: info: Scanning category system_controller Jul 01 22:43:50 minidsp-mr volumio[6852]: info: Scanning category user_interface Jul 01 22:43:50 minidsp-mr volumio[6852]: info: Scanning into folder /data/plugins/ Jul 01 22:43:50 minidsp-mr volumio[6852]: info: Plugin folders cleanup completed Jul 01 22:43:50 minidsp-mr volumio[6852]: info: ------------------------------------------- Jul 01 22:43:50 minidsp-mr volumio[6852]: info: ----- Core plugins startup ---- Jul 01 22:43:50 minidsp-mr volumio[6852]: info: ------------------------------------------- Jul 01 22:43:50 minidsp-mr volumio[6852]: info: Loading plugins from folder /volumio/app/plugins/ Jul 01 22:43:50 minidsp-mr volumio[6852]: info: Adding plugin bluetooth to MyMusic Plugins Jul 01 22:43:50 minidsp-mr volumio[6852]: info: Adding plugin multiroom to MyMusic Plugins Jul 01 22:43:50 minidsp-mr volumio[6852]: info: Adding plugin upnp to MyMusic Plugins Jul 01 22:43:50 minidsp-mr volumio[6852]: info: Adding plugin metavolumio to MyMusic Plugins Jul 01 22:43:50 minidsp-mr volumio[6852]: info: Adding plugin ms_surface_dial to MyMusic Plugins Jul 01 22:43:50 minidsp-mr volumio[6852]: info: Adding plugin airplay_emulation to MyMusic Plugins Jul 01 22:43:50 minidsp-mr volumio[6852]: info: Adding plugin cd_controller to MyMusic Plugins Jul 01 22:43:50 minidsp-mr volumio[6852]: info: Adding plugin raat to MyMusic Plugins Jul 01 22:43:50 minidsp-mr volumio[6852]: info: Adding plugin tidalconnect to MyMusic Plugins Jul 01 22:43:50 minidsp-mr volumio[6852]: info: Adding plugin upnp_browser to MyMusic Plugins Jul 01 22:43:50 minidsp-mr volumio[6852]: info: Loading plugins from folder /data/plugins/ Jul 01 22:43:50 minidsp-mr volumio[6852]: info: Loading plugin "system"... Jul 01 22:43:50 minidsp-mr volumio[6852]: info: Loading plugin "appearance"... Jul 01 22:43:52 minidsp-mr volumio[6852]: info: Loading plugin "network"... Jul 01 22:43:52 minidsp-mr volumio[6852]: info: Refreshing Cached IP Addresses Jul 01 22:43:52 minidsp-mr sudo[6880]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 01 22:43:52 minidsp-mr sudo[6880]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 22:43:52 minidsp-mr sudo[6880]: pam_unix(sudo:session): session closed for user root Jul 01 22:43:52 minidsp-mr volumio[6852]: info: Loading plugin "services"... Jul 01 22:43:52 minidsp-mr sudo[6882]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 01 22:43:52 minidsp-mr sudo[6882]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 22:43:52 minidsp-mr volumio[6852]: info: Loading plugin "alsa_controller"... Jul 01 22:43:52 minidsp-mr sudo[6885]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jul 01 22:43:52 minidsp-mr sudo[6885]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 22:43:52 minidsp-mr sudo[6882]: pam_unix(sudo:session): session closed for user root Jul 01 22:43:52 minidsp-mr sudo[6885]: pam_unix(sudo:session): session closed for user root Jul 01 22:43:52 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 01 22:43:52 minidsp-mr volumio[6852]: info: Loading plugin "wizard"... Jul 01 22:43:52 minidsp-mr volumio[6852]: info: Loading plugin "networkfs"... Jul 01 22:43:53 minidsp-mr volumio[6852]: info: Cannot mount NAS Music at system boot, trial number 1 ,retrying in 5 seconds Jul 01 22:43:53 minidsp-mr volumio[6852]: info: Starting Udev Watcher for removable devices Jul 01 22:43:53 minidsp-mr volumio[6852]: info: Ignoring mount for partition: BOOT Jul 01 22:43:53 minidsp-mr volumio[6852]: info: Ignoring mount for partition: volumio Jul 01 22:43:53 minidsp-mr volumio[6852]: info: Ignoring mount for partition: volumio_data Jul 01 22:43:53 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 01 22:43:53 minidsp-mr volumio[6852]: info: Loading plugin "volumio_command_line_client"... Jul 01 22:43:53 minidsp-mr volumio[6852]: info: Loading plugin "upnp"... Jul 01 22:43:53 minidsp-mr volumio[6852]: info: [1751424233163] Starting Upmpd Daemon Jul 01 22:43:53 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 01 22:43:53 minidsp-mr volumio[6852]: info: Loading plugin "my_music"... Jul 01 22:43:53 minidsp-mr volumio[6852]: info: Loading plugin "mpd"... Jul 01 22:43:53 minidsp-mr volumio[6852]: info: Loading plugin "upnp_browser"... Jul 01 22:43:54 minidsp-mr volumio[6852]: info: Loading plugin "bluetooth"... Jul 01 22:43:54 minidsp-mr volumio[6852]: info: [1751424234849] Starting BluetoothController Jul 01 22:43:55 minidsp-mr volumio[6852]: info: Loading plugin "alarm-clock"... Jul 01 22:43:55 minidsp-mr volumio[6852]: info: Loading plugin "manifestui"... Jul 01 22:43:55 minidsp-mr volumio[6852]: info: Loading plugin "metavolumio"... Jul 01 22:43:57 minidsp-mr volumio[6852]: info: Loading plugin "airplay_emulation"... Jul 01 22:43:57 minidsp-mr volumio[6852]: info: Starting Shairport Sync Jul 01 22:43:57 minidsp-mr volumio[6852]: info: Loading plugin "cd_controller"... Jul 01 22:43:58 minidsp-mr volumio[6852]: info: Loading plugin "last_100"... Jul 01 22:43:58 minidsp-mr volumio[6852]: info: Plugin raat is not enabled Jul 01 22:43:58 minidsp-mr volumio[6852]: info: Loading plugin "streaming_services"... Jul 01 22:44:00 minidsp-mr volumio[6852]: info: Starting Streaming Service Transparent Proxy Jul 01 22:44:00 minidsp-mr volumio[6852]: info: Plugin tidalconnect is not enabled Jul 01 22:44:00 minidsp-mr volumio[6852]: info: Loading plugin "webradio"... Jul 01 22:44:00 minidsp-mr volumio[6852]: info: Loading plugin "i2s_dacs"... Jul 01 22:44:00 minidsp-mr volumio[6852]: info: I2S DAC not set, start Auto-detection Jul 01 22:44:00 minidsp-mr volumio[6852]: info: Loading plugin "volumiodiscovery"... Jul 01 22:44:00 minidsp-mr volumio[6852]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 01 22:44:00 minidsp-mr volumio[6852]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 01 22:44:00 minidsp-mr volumio[6852]: *** WARNING *** For more information see Jul 01 22:44:00 minidsp-mr volumio[6852]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 01 22:44:00 minidsp-mr node[6852]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jul 01 22:44:00 minidsp-mr volumio[6852]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 01 22:44:00 minidsp-mr volumio[6852]: *** WARNING *** For more information see Jul 01 22:44:00 minidsp-mr node[6852]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 01 22:44:00 minidsp-mr node[6852]: *** WARNING *** For more information see Jul 01 22:44:00 minidsp-mr node[6852]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jul 01 22:44:00 minidsp-mr node[6852]: *** WARNING *** Please fix your application to use the native API of Avahi! Jul 01 22:44:00 minidsp-mr node[6852]: *** WARNING *** For more information see Jul 01 22:44:00 minidsp-mr volumio[6852]: info: Applying required configuration parameters for plugin volumiodiscovery Jul 01 22:44:00 minidsp-mr volumio[6852]: info: Discovery: Started advertising with name: miniDSP MR Jul 01 22:44:00 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 01 22:44:00 minidsp-mr volumio[6852]: info: Loading plugin "multiroom"... Jul 01 22:44:01 minidsp-mr volumio-remote-updater[477]: [2025-07-01 22:44:01] [connect] Successful connection Jul 01 22:44:02 minidsp-mr volumio[6852]: STREAMING PROXY: Starting server on port 3245 Jul 01 22:44:02 minidsp-mr volumio[6852]: Node JS runtime: 14 Jul 01 22:44:03 minidsp-mr volumio[6852]: info: Applying required configuration parameters for plugin multiroom Jul 01 22:44:03 minidsp-mr sudo[6907]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Jul 01 22:44:03 minidsp-mr sudo[6907]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 22:44:03 minidsp-mr sudo[6907]: pam_unix(sudo:session): session closed for user root Jul 01 22:44:03 minidsp-mr volumio[6852]: /bin/mkdir: cannot create directory ‘/tmp/hls’: File exists Jul 01 22:44:03 minidsp-mr volumio[6852]: info: MRS: MultiRoom plugin initialized Jul 01 22:44:03 minidsp-mr volumio[6852]: info: MRS: STOPPING SNAPCLIENT Jul 01 22:44:03 minidsp-mr volumio[6852]: info: MRS: Snap server stop Jul 01 22:44:03 minidsp-mr sudo[6923]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Jul 01 22:44:03 minidsp-mr sudo[6923]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 22:44:03 minidsp-mr volumio[6852]: info: MRS: STOPPING volumioStreaming Jul 01 22:44:03 minidsp-mr sudo[6926]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Jul 01 22:44:03 minidsp-mr sudo[6926]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 22:44:03 minidsp-mr sudo[6928]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Jul 01 22:44:03 minidsp-mr sudo[6928]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 22:44:03 minidsp-mr volumio[6852]: info: Loading plugin "outputs"... Jul 01 22:44:03 minidsp-mr volumio[6852]: info: Loading plugin "albumart"... Jul 01 22:44:03 minidsp-mr sudo[6932]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Jul 01 22:44:03 minidsp-mr sudo[6932]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 22:44:03 minidsp-mr sudo[6932]: pam_unix(sudo:session): session closed for user root Jul 01 22:44:03 minidsp-mr volumio[6852]: info: Plugin ms_surface_dial is not enabled Jul 01 22:44:03 minidsp-mr sudo[6923]: pam_unix(sudo:session): session closed for user root Jul 01 22:44:03 minidsp-mr volumio[6852]: info: Plugin example_plugin is not enabled Jul 01 22:44:03 minidsp-mr volumio[6852]: info: Loading plugin "hi_res_audio"... Jul 01 22:44:03 minidsp-mr sudo[6926]: pam_unix(sudo:session): session closed for user root Jul 01 22:44:03 minidsp-mr sudo[6928]: pam_unix(sudo:session): session closed for user root Jul 01 22:44:04 minidsp-mr volumio[6852]: Forking 3 albumart workers Jul 01 22:44:05 minidsp-mr volumio[6852]: Starting albumart workers Jul 01 22:44:05 minidsp-mr volumio[6852]: Starting albumart workers Jul 01 22:44:05 minidsp-mr volumio[6852]: Starting albumart workers Jul 01 22:44:05 minidsp-mr volumio[6852]: info: Applying required configuration parameters for plugin hi_res_audio Jul 01 22:44:05 minidsp-mr volumio[6852]: info: Loading plugin "inputs"... Jul 01 22:44:06 minidsp-mr volumio[6852]: info: Loading plugin "qobuz"... Jul 01 22:44:08 minidsp-mr volumiologrotate[443]: ls: cannot access '/var/log/samba/log.wb-MINIDSP': No such file or directory Jul 01 22:44:08 minidsp-mr volumiologrotate[443]: ls: cannot access 'MR': No such file or directory Jul 01 22:44:09 minidsp-mr volumio[6852]: info: Loading plugin "tidal"... Jul 01 22:44:11 minidsp-mr volumio[6852]: info: Loading plugin "oem_helper"... Jul 01 22:44:12 minidsp-mr volumio[6852]: info: Applying required configuration parameters for plugin oem_helper Jul 01 22:44:12 minidsp-mr volumio[6852]: info: Loading plugin "updater_comm"... Jul 01 22:44:13 minidsp-mr volumio[6852]: info: Plugin mpdemulation is not enabled Jul 01 22:44:13 minidsp-mr volumio[6852]: info: Loading plugin "rest_api"... Jul 01 22:44:13 minidsp-mr volumio[6852]: info: Loading plugin "websocket"... Jul 01 22:44:13 minidsp-mr volumio[6852]: info: Loading i18n strings for locale en Jul 01 22:44:13 minidsp-mr volumio[6852]: Updating browse sources language Jul 01 22:44:13 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 01 22:44:13 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 01 22:44:13 minidsp-mr volumio[6852]: info: CoreCommandRouter::initPlayerControls Jul 01 22:44:13 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:13 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:13 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:13 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:13 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:13 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:13 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:13 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:13 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 01 22:44:13 minidsp-mr volumio[6852]: Express server listening on port 3000 Jul 01 22:44:13 minidsp-mr volumio[6852]: [Metrics] WebUI: 26s 413.80ms Jul 01 22:44:13 minidsp-mr volumio[6852]: info: CoreStateMachine::resetVolumioState Jul 01 22:44:13 minidsp-mr volumio[6852]: info: CoreStateMachine::getcurrentVolume Jul 01 22:44:13 minidsp-mr volumio[6852]: info: CoreCommandRouter::volumioRetrievevolume Jul 01 22:44:13 minidsp-mr volumio[6852]: info: CoreStateMachine::pushState Jul 01 22:44:13 minidsp-mr volumio[6852]: info: CorePlayQueue::getTrack 0 Jul 01 22:44:13 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 22:44:13 minidsp-mr volumio[6852]: info: CoreCommandRouter::volumioPushState Jul 01 22:44:13 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 01 22:44:13 minidsp-mr volumio[6852]: info: Cannot mount NAS Music at system boot, trial number 2 ,retrying in 5 seconds Jul 01 22:44:13 minidsp-mr sudo[7033]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 01 22:44:13 minidsp-mr sudo[7033]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 22:44:13 minidsp-mr sudo[7033]: pam_unix(sudo:session): session closed for user root Jul 01 22:44:13 minidsp-mr sudo[7036]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 01 22:44:13 minidsp-mr sudo[7036]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 22:44:13 minidsp-mr volumio[6852]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jul 01 22:44:13 minidsp-mr volumio[6852]: info: Completed loading Core Plugins Jul 01 22:44:13 minidsp-mr volumio[6852]: info: Preparing to generate the ALSA configuration file Jul 01 22:44:13 minidsp-mr sudo[7036]: pam_unix(sudo:session): session closed for user root Jul 01 22:44:13 minidsp-mr volumio[6852]: info: MRS: Removed streaming files Jul 01 22:44:13 minidsp-mr volumio[6852]: info: MRS: volumioStreaming STOPPED Jul 01 22:44:13 minidsp-mr volumio[6852]: info: MRS: SNAPSERVER STOPPED Jul 01 22:44:13 minidsp-mr volumio[6852]: info: MRS: SNAPCLIENT STOPPED Jul 01 22:44:13 minidsp-mr volumio[6852]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Jul 01 22:44:13 minidsp-mr volumio[6852]: wlan0 Interface doesn't support scanning. Jul 01 22:44:13 minidsp-mr volumio[6852]: info: Cannot use regular scanning, forcing with ap-force Jul 01 22:44:13 minidsp-mr sudo[7041]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Jul 01 22:44:13 minidsp-mr sudo[7041]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 22:44:13 minidsp-mr sudo[7041]: pam_unix(sudo:session): session closed for user root Jul 01 22:44:13 minidsp-mr volumio[6852]: command failed: No such device (-19) Jul 01 22:44:13 minidsp-mr volumio[6852]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Jul 01 22:44:13 minidsp-mr volumio[6852]: command failed: No such device (-19) Jul 01 22:44:13 minidsp-mr volumio[6852]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 01 22:44:13 minidsp-mr volumio[6852]: info: Reading ALSA contributions from plugins. Jul 01 22:44:14 minidsp-mr volumio[6852]: info: Reloading queue from file Jul 01 22:44:14 minidsp-mr volumio[6852]: info: Setting Device type: NanoPi NEO 2 Jul 01 22:44:14 minidsp-mr volumio[6852]: info: CoreStateMachine::setRepeat null single undefined Jul 01 22:44:14 minidsp-mr volumio[6852]: info: CoreStateMachine::pushState Jul 01 22:44:14 minidsp-mr volumio[6852]: info: CorePlayQueue::getTrack 0 Jul 01 22:44:14 minidsp-mr volumio[6852]: info: CoreCommandRouter::volumioPushState Jul 01 22:44:14 minidsp-mr volumio[6852]: info: CoreStateMachine::setRandom null Jul 01 22:44:14 minidsp-mr volumio[6852]: info: CoreStateMachine::pushState Jul 01 22:44:14 minidsp-mr volumio[6852]: info: CorePlayQueue::getTrack 0 Jul 01 22:44:14 minidsp-mr volumio[6852]: info: CoreCommandRouter::volumioPushState Jul 01 22:44:14 minidsp-mr sudo[7052]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jul 01 22:44:14 minidsp-mr sudo[7052]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 22:44:14 minidsp-mr volumio[6852]: info: Asound.conf file unchanged, so no further update is needed Jul 01 22:44:14 minidsp-mr volumio[6852]: info: Output device has changed, restarting MPD Jul 01 22:44:14 minidsp-mr sudo[7052]: pam_unix(sudo:session): session closed for user root Jul 01 22:44:14 minidsp-mr sudo[7056]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 01 22:44:14 minidsp-mr sudo[7056]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 22:44:14 minidsp-mr sudo[7056]: pam_unix(sudo:session): session closed for user root Jul 01 22:44:14 minidsp-mr volumio[6852]: info: Output device has changed, restarting Shairport Sync Jul 01 22:44:14 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:14 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 01 22:44:14 minidsp-mr sudo[7059]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 01 22:44:14 minidsp-mr sudo[7059]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 22:44:14 minidsp-mr systemd[1]: Stopping Music Player Daemon... Jul 01 22:44:14 minidsp-mr volumio[6852]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 01 22:44:14 minidsp-mr volumio[6852]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 01 22:44:14 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:14 minidsp-mr volumio[6852]: info: ___________ START PLUGINS ___________ Jul 01 22:44:14 minidsp-mr volumio[6852]: info: ControllerMpd::onStart: Initializing MPD Jul 01 22:44:14 minidsp-mr volumio[6852]: info: Creating MPD Configuration file Jul 01 22:44:14 minidsp-mr sudo[7067]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 01 22:44:14 minidsp-mr sudo[7067]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 22:44:14 minidsp-mr sudo[7067]: pam_unix(sudo:session): session closed for user root Jul 01 22:44:14 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 01 22:44:14 minidsp-mr volumio[6852]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 01 22:44:14 minidsp-mr volumio[6852]: info: [1751424254753] CoreMusicLibrary::Adding element Media Servers Jul 01 22:44:14 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 01 22:44:14 minidsp-mr sudo[7070]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 01 22:44:14 minidsp-mr sudo[7070]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 22:44:14 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 01 22:44:14 minidsp-mr volumio[6852]: info: Adding Manifest REST API Endpoints Jul 01 22:44:14 minidsp-mr volumio[6852]: info: Adding manifestui REST Endpoint for plugin: miscellanea/manifestui Jul 01 22:44:14 minidsp-mr volumio[6852]: info: Adding METAVOLUMIO REST API Endpoints Jul 01 22:44:14 minidsp-mr volumio[6852]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Jul 01 22:44:14 minidsp-mr volumio[6852]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Jul 01 22:44:14 minidsp-mr volumio[6852]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Jul 01 22:44:14 minidsp-mr sudo[7073]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name miniDSP MR Jul 01 22:44:14 minidsp-mr sudo[7073]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 22:44:14 minidsp-mr volumio[6852]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Jul 01 22:44:14 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:14 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 01 22:44:14 minidsp-mr sudo[7073]: pam_unix(sudo:session): session closed for user root Jul 01 22:44:14 minidsp-mr volumio[6852]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 01 22:44:14 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:14 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 01 22:44:15 minidsp-mr volumio[6852]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 01 22:44:15 minidsp-mr volumio[6852]: info: Preparing CD Folders Jul 01 22:44:15 minidsp-mr volumio[6852]: info: Adding CD REST API Endpoints Jul 01 22:44:15 minidsp-mr volumio[6852]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Jul 01 22:44:15 minidsp-mr volumio[6852]: info: Starting UDEV Watcher for CD Jul 01 22:44:15 minidsp-mr volumio[6852]: info: Detecting CD presence with UDEV Jul 01 22:44:15 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Jul 01 22:44:15 minidsp-mr volumio[6852]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 01 22:44:15 minidsp-mr volumio[6852]: info: [1751424255042] CoreMusicLibrary::Adding element Last_100 Jul 01 22:44:15 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 01 22:44:15 minidsp-mr volumio[6852]: info: Streaming services startup Jul 01 22:44:15 minidsp-mr volumio[6852]: info: Starting Streaming Daemon Jul 01 22:44:15 minidsp-mr sudo[7083]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 01 22:44:15 minidsp-mr sudo[7083]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 22:44:15 minidsp-mr sudo[7083]: pam_unix(sudo:session): session closed for user root Jul 01 22:44:15 minidsp-mr volumio[6852]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 01 22:44:15 minidsp-mr volumio[6852]: info: [1751424255192] CoreMusicLibrary::Adding element Webradio Jul 01 22:44:15 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 01 22:44:15 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 01 22:44:15 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Jul 01 22:44:15 minidsp-mr volumio[6852]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 01 22:44:15 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:15 minidsp-mr volumio[6852]: error: Hi Res Audio Failed Login: Missing Login Data Jul 01 22:44:15 minidsp-mr volumio[6852]: info: Adding HIGHRESAUDIO REST API Endpoints Jul 01 22:44:15 minidsp-mr volumio[6852]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Jul 01 22:44:15 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 01 22:44:15 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 01 22:44:15 minidsp-mr volumio[6852]: info: Volumio Calling Home Jul 01 22:44:15 minidsp-mr volumio[6852]: info: Stopping AccessToken refresher cron for QOBUZ Jul 01 22:44:15 minidsp-mr volumio[6852]: info: AccessToken refresher cron started for QOBUZ Jul 01 22:44:15 minidsp-mr volumio[6852]: info: Stopping AccessToken refresher cron Jul 01 22:44:15 minidsp-mr volumio[6852]: info: AccessToken refresher cron started Jul 01 22:44:15 minidsp-mr volumio[6852]: info: Adding TIDAL REST API Endpoints Jul 01 22:44:15 minidsp-mr volumio[6852]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Jul 01 22:44:15 minidsp-mr volumio[6852]: info: Adding QOBUZ REST API Endpoints Jul 01 22:44:15 minidsp-mr volumio[6852]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Jul 01 22:44:15 minidsp-mr volumio[6852]: info: Discovery: adding 55d32c03-7341-44b4-81b3-728bc5788e61 Jul 01 22:44:15 minidsp-mr volumio[6852]: info: Discovery: Found device miniDSP MR Jul 01 22:44:15 minidsp-mr volumio[6852]: info: CoreCommandRouter::volumioGetState Jul 01 22:44:15 minidsp-mr volumio[6852]: info: CorePlayQueue::getTrack 0 Jul 01 22:44:15 minidsp-mr volumio[6852]: info: MRS: Pushing multiroomSync output for this device Jul 01 22:44:15 minidsp-mr volumio[6852]: info: MRS: Pushing multiroomSync output Jul 01 22:44:15 minidsp-mr volumio[6852]: info: Adding audio output: Jul 01 22:44:15 minidsp-mr volumio[6852]: info: Adding audio output: Jul 01 22:44:15 minidsp-mr volumio[6852]: info: Serial port opened successfully Jul 01 22:44:15 minidsp-mr volumio[6852]: error: Cannot start Volumio Streaming Daemon Jul 01 22:44:15 minidsp-mr volumio[6852]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jul 01 22:44:15 minidsp-mr volumio[6852]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jul 01 22:44:15 minidsp-mr volumio[6852]: error: Cannot set new Bluetooth Name : Error: Command failed: /usr/bin/sudo /bin/hciconfig hci0 name 'miniDSP MR' Jul 01 22:44:15 minidsp-mr volumio[6852]: Can't get device info: No such device Jul 01 22:44:15 minidsp-mr volumio[6852]: info: MPD Permissions set Jul 01 22:44:15 minidsp-mr volumio[6852]: info: MPD Permissions set Jul 01 22:44:15 minidsp-mr volumio[6852]: info: Upmpdcli Daemon Started Jul 01 22:44:16 minidsp-mr volumio[6852]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 1 Jul 01 22:44:16 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:16 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:16 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:16 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:16 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:16 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:16 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:16 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:16 minidsp-mr volumio-remote-updater[477]: [2025-07-01 22:44:16] [connect] Successful connection Jul 01 22:44:16 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 01 22:44:16 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 01 22:44:16 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:16 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:16 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:16 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:16 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:16 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:16 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:16 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:16 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:16 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 01 22:44:16 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 01 22:44:16 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:16 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: raat , reconfigureAndRestartRaat Jul 01 22:44:16 minidsp-mr volumio[6852]: info: Adding MINIDSP Inputs Jul 01 22:44:16 minidsp-mr volumio[6852]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 01 22:44:16 minidsp-mr volumio[6852]: info: [1751424256302] CoreMusicLibrary::Adding element Inputs Jul 01 22:44:16 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 01 22:44:16 minidsp-mr volumio[6852]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 01 22:44:16 minidsp-mr volumio[6852]: info: [1751424256306] CoreMusicLibrary::Adding element Presets Jul 01 22:44:16 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 01 22:44:16 minidsp-mr volumio[6852]: Cannot find translation for source Presets Jul 01 22:44:16 minidsp-mr systemd[1]: mpd.service: Succeeded. Jul 01 22:44:16 minidsp-mr systemd[1]: Stopped Music Player Daemon. Jul 01 22:44:16 minidsp-mr systemd[1]: Starting Music Player Daemon... Jul 01 22:44:16 minidsp-mr sudo[7123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 01 22:44:16 minidsp-mr sudo[7123]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 22:44:16 minidsp-mr sudo[7123]: pam_unix(sudo:session): session closed for user root Jul 01 22:44:16 minidsp-mr sudo[7127]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 01 22:44:16 minidsp-mr sudo[7127]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 22:44:16 minidsp-mr volumio-remote-updater[477]: [2025-07-01 22:44:16] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751424256 101 Jul 01 22:44:16 minidsp-mr volumio[6852]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 2 Jul 01 22:44:16 minidsp-mr sudo[7127]: pam_unix(sudo:session): session closed for user root Jul 01 22:44:16 minidsp-mr volumio[6852]: info: Starting Shairport Sync Jul 01 22:44:16 minidsp-mr volumio[6852]: info: Starting Shairport Sync Jul 01 22:44:16 minidsp-mr sudo[7133]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 01 22:44:16 minidsp-mr sudo[7133]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 22:44:16 minidsp-mr volumio[6852]: info: Starting Shairport Sync Jul 01 22:44:16 minidsp-mr sudo[7136]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 01 22:44:16 minidsp-mr sudo[7136]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 22:44:16 minidsp-mr systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 01 22:44:16 minidsp-mr systemd[1]: shairport-sync.service: Succeeded. Jul 01 22:44:16 minidsp-mr systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 01 22:44:16 minidsp-mr systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 01 22:44:16 minidsp-mr sudo[7136]: pam_unix(sudo:session): session closed for user root Jul 01 22:44:16 minidsp-mr sudo[7139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 01 22:44:16 minidsp-mr sudo[7139]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 22:44:16 minidsp-mr sudo[7133]: pam_unix(sudo:session): session closed for user root Jul 01 22:44:16 minidsp-mr volumio[6852]: info: MRS: Found cast device: WiiM-Pro-Receiver-d81b2b4b0f63810f391449ce5e2dc823 Jul 01 22:44:16 minidsp-mr volumio[6852]: info: Adding audio output: Jul 01 22:44:16 minidsp-mr volumio[6852]: info: MRS: Found cast device: WiiM-Pro-Receiver-b5fafd8a5aec8b466e2eb80a6df668a3 Jul 01 22:44:16 minidsp-mr volumio[6852]: info: Adding audio output: Jul 01 22:44:16 minidsp-mr systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 01 22:44:16 minidsp-mr systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jul 01 22:44:16 minidsp-mr systemd[1]: shairport-sync.service: Succeeded. Jul 01 22:44:16 minidsp-mr systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 01 22:44:16 minidsp-mr systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 01 22:44:16 minidsp-mr sudo[7139]: pam_unix(sudo:session): session closed for user root Jul 01 22:44:16 minidsp-mr volumio[6852]: info: Shairport-Sync Started Jul 01 22:44:16 minidsp-mr volumio[6852]: Error adding Membership: Error: addMembership EINVAL Jul 01 22:44:16 minidsp-mr volumio[6852]: info: Shairport-Sync Started Jul 01 22:44:16 minidsp-mr volumio[6852]: info: Volumio called home Jul 01 22:44:16 minidsp-mr volumio[6852]: info: MRS: Found cast device: BRAVIA-4K-2015-1595ab582d5d24eacca99e5b2e05a464 Jul 01 22:44:16 minidsp-mr volumio[6852]: info: Adding audio output: Jul 01 22:44:16 minidsp-mr volumio[6852]: info: Shairport-Sync Started Jul 01 22:44:16 minidsp-mr volumio[6852]: verbose: New Socket.io Connection to 192.168.1.232 from 192.168.1.20 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_5 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.5 Mobile/15E148 Safari/604.1 Total Clients: 3 Jul 01 22:44:16 minidsp-mr volumio[6852]: info: CoreCommandRouter::volumioGetState Jul 01 22:44:16 minidsp-mr volumio[6852]: info: CorePlayQueue::getTrack 0 Jul 01 22:44:17 minidsp-mr volumio[6852]: info: CoreCommandRouter::volumiosetSourceActiveno-source Jul 01 22:44:17 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 01 22:44:17 minidsp-mr volumio[6852]: Cannot find translation for source Presets Jul 01 22:44:17 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 01 22:44:17 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 01 22:44:17 minidsp-mr volumio[6852]: info: CoreCommandRouter::volumioGetVisibleSources Jul 01 22:44:17 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 01 22:44:17 minidsp-mr volumio[6852]: info: CoreCommandRouter::volumioGetState Jul 01 22:44:17 minidsp-mr volumio[6852]: info: CorePlayQueue::getTrack 0 Jul 01 22:44:17 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 01 22:44:17 minidsp-mr volumio[6852]: info: CoreCommandRouter::volumioGetQueue Jul 01 22:44:17 minidsp-mr volumio[6852]: info: CoreStateMachine::getQueue Jul 01 22:44:17 minidsp-mr volumio[6852]: info: CorePlayQueue::getQueue Jul 01 22:44:17 minidsp-mr volumio[6852]: info: Listing playlists Jul 01 22:44:17 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 01 22:44:17 minidsp-mr volumio[6852]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jul 01 22:44:17 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: inputs , handleBrowseUri Jul 01 22:44:17 minidsp-mr volumio[6852]: info: Received Get System Info Jul 01 22:44:17 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 01 22:44:17 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 01 22:44:17 minidsp-mr volumio[6852]: info: Discovery: Getting this device information Jul 01 22:44:17 minidsp-mr volumio[6852]: info: CoreCommandRouter::volumioGetState Jul 01 22:44:17 minidsp-mr volumio[6852]: info: CorePlayQueue::getTrack 0 Jul 01 22:44:17 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 01 22:44:17 minidsp-mr volumio[6852]: info: CoreCommandRouter::volumioGetState Jul 01 22:44:17 minidsp-mr volumio[6852]: info: CorePlayQueue::getTrack 0 Jul 01 22:44:17 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 01 22:44:17 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 01 22:44:17 minidsp-mr volumio[6852]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 4 Jul 01 22:44:17 minidsp-mr sudo[7146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Jul 01 22:44:17 minidsp-mr sudo[7146]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 01 22:44:17 minidsp-mr sudo[7146]: pam_unix(sudo:session): session closed for user root Jul 01 22:44:17 minidsp-mr volumio[6852]: info: Volumio BT Module successfully started Jul 01 22:44:18 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 01 22:44:18 minidsp-mr volumio[6852]: info: Received Get System Info Jul 01 22:44:18 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 01 22:44:18 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 01 22:44:18 minidsp-mr volumio[6852]: info: Discovery: Getting this device information Jul 01 22:44:18 minidsp-mr volumio[6852]: info: CoreCommandRouter::volumioGetState Jul 01 22:44:18 minidsp-mr volumio[6852]: info: CorePlayQueue::getTrack 0 Jul 01 22:44:18 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 01 22:44:18 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jul 01 22:44:18 minidsp-mr volumio[6852]: info: Enabling external Volume Control Jul 01 22:44:18 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:18 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 01 22:44:18 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 01 22:44:18 minidsp-mr volumio[6852]: info: Received Get System Info Jul 01 22:44:18 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 01 22:44:18 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 01 22:44:18 minidsp-mr volumio[6852]: info: Discovery: Getting this device information Jul 01 22:44:18 minidsp-mr volumio[6852]: info: CoreCommandRouter::volumioGetState Jul 01 22:44:18 minidsp-mr volumio[6852]: info: CorePlayQueue::getTrack 0 Jul 01 22:44:18 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 01 22:44:18 minidsp-mr volumio[6852]: info: Cannot mount NAS Music at system boot, trial number 3 ,retrying in 5 seconds Jul 01 22:44:18 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Jul 01 22:44:18 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Jul 01 22:44:19 minidsp-mr volumio[6852]: info: CoreStateMachine::pushState Jul 01 22:44:19 minidsp-mr volumio[6852]: info: CorePlayQueue::getTrack 0 Jul 01 22:44:19 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 22:44:19 minidsp-mr volumio[6852]: info: CoreCommandRouter::volumioPushState Jul 01 22:44:19 minidsp-mr volumio[6852]: info: MRS: Pushing multiroomSync output update for this device Jul 01 22:44:19 minidsp-mr volumio[6852]: info: MRS: Pushing multiroomSync output Jul 01 22:44:19 minidsp-mr mpd[7125]: Jul 01 22:44 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 01 22:44:20 minidsp-mr volumio[6852]: info: MRS: Getting audio outputs on start Jul 01 22:44:20 minidsp-mr volumio[6852]: info: MRS: Requesting all other devices output Jul 01 22:44:20 minidsp-mr volumio[6852]: info: CoreStateMachine::pushState Jul 01 22:44:20 minidsp-mr volumio[6852]: info: CorePlayQueue::getTrack 0 Jul 01 22:44:20 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 01 22:44:20 minidsp-mr volumio[6852]: info: CoreCommandRouter::volumioPushState Jul 01 22:44:20 minidsp-mr volumio[6852]: info: MRS: Pushing multiroomSync output update for this device Jul 01 22:44:20 minidsp-mr volumio[6852]: info: MRS: Pushing multiroomSync output Jul 01 22:44:20 minidsp-mr volumio[6852]: info: CoreCommandRouter::executeOnPlugin: raat , updateRoonVolume Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preload queue cleared Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/My_Music_1/Willie Nelson/Stardust/08-Moonlight In Vermont.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/My_Music_1/Willie Nelson/Stardust/02-Georgia On My Mind.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/My_Music_1/Joe Crookston/Fall Down As The Rain/02 Joe Crookston - Fall Down As The Rain.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/My_Music_1/Rumer/Seasons of My Soul/01 Rumer - Slow.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/My_Music_1/Helen Merrill/Helen Merrill/03 Helen Merrill - What's New¿.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/My_Music_1/Nils Lofgren/Acoustic Live/05 Nils Lofgren - Keith Don't Go.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/My_Music_1/Linda Ronstadt/What's New/01-What's New.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/My_Music_1/Linda Ronstadt/What's New/07-What'll I Do_.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/My_Music_1/Joe Sample/Collection/07 Joe Sample - Fly With the Wings of Love.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/My_Music_1/Eva Cassidy/Live at Blues Alley/07 Eva Cassidy - Tall Trees in Georgia.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/My_Music_1/Eva Cassidy/Live at Blues Alley/08 Eva Cassidy - Fields of Gold.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/My_Music_1/Eva Cassidy/Songbird/10 Eva Cassidy - Over the Rainbow.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/My_Music_1/Fleetwood Mac/Rumours/11-Gold Dust Woman.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/My_Music_1/Muddy Waters/Folk Singer/04-Good Morning Little Schoolgirl.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/My_Music_1/Supertramp/Crime of the Century/01 Supertramp - School.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/My_Music_1/Rosanne Cash/The River & The Thread (Deluxe)/10-When The Master Calls The Roll.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/My_Music_1/Mazzy Star/So Tonight That I Might See/09 Mazzy Star - Into Dust.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/My_Music_1/Jennifer Warnes/Famous Blue Raincoat/07 Jennifer Warnes - Song Of Bernardette.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/My_Music_1/Jennifer Warnes/Famous Blue Raincoat/04 Jennifer Warnes - Joan of Arc.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/My_Music_1/Michael Jackson/Bad/08 Michael Jackson - I Just Can't Stop Loving You.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/My_Music_1/Adele/Skyfall - Single/01-Skyfall.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/My_Music_1/Lori Lieberman/Home of Whispers/04 Lori Leiberman - Home of Whispers.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/My_Music_1/Dan Fogelberg/Nether Lands/10 Dan Fogelberg - Sketches.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/Music/Patricia Barber/Café Blue/09 Patricia Barber - Too Rich for My Blood.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/Music/Beach Boys, The/Pet Sounds/08 Beach Boys, The - God Only Knows.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/Music/Billie Holiday/Lady in Satin/07 Billie Holiday - You've Changed.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/Music/Billie Holiday/Lady in Satin/01 Billie Holiday - I'm a Fool to Want You.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/Music/Billie Holiday/Ken Burns Jazz/16 Billie Holiday - Autumn in New York.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/Music/Diana Krall/This Dream Of You/03 Diana Krall - Autumn In New York.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/Music/The New Appalachians/From The Mountaintop/08 Wafaring Stranger 96K.wav Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/Music/Harry Babbitt/Pocketful of Dreams; The Best of Harry Babbitt/04 Harry Babbitt - Heaven Can Wait.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/Music/Alan Jackson/Like Red On A Rose/01 Alan Jackson - Anywhere On Earth You Are.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/Music/Rebecca Pidgeon/The Raven/03 Rebecca Pidgeon - The Raven.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/Music/Rebecca Pidgeon/The Raven/12 Rebecca Pidgeon - Spanish Harlem.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/Music/Cowboy Junkies/The Trinity Session/01 Cowboy Junkies - Mining for Gold.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/Music/Corinne West/Starlight Highway/04 Corinne West - Audrey Turn The Moon.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/Music/Dead Can Dance/Into the Labyrinth/03 Dead Can Dance - The Wind That Shakes the Barley.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/Music/Peter, Paul & Mary/Songs of Conscience & Concern/08 Peter, Paul & Mary - All My Trials.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/Music/Peter Gabriel/So/03 Peter Gabriel - Don't Give Up.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/Music/Amanda McBroom/The Best of Amanda Mcbroom/12 Amanda McBroom - Amanda.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/Music/Amanda McBroom/The Best of Amanda Mcbroom/08 Amanda McBroom - The Portrait.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Preloading song: mnt/NAS/Music/Joe Crookston/Fall Down As The Rain/02 Joe Crookston - Fall Down As The Rain.flac Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Exploding uri mnt/NAS/My_Music_1/Willie Nelson/Stardust/08-Moonlight In Vermont.flac in service mpd Jul 01 22:44:20 minidsp-mr volumio[6852]: error: scanFolder - failure to stat '/mnt/NAS/My_Music_1/Willie Nelson/Stardust/08-Moonlight In Vermont.flac' Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Exploding uri mnt/NAS/My_Music_1/Willie Nelson/Stardust/02-Georgia On My Mind.flac in service mpd Jul 01 22:44:20 minidsp-mr volumio[6852]: error: scanFolder - failure to stat '/mnt/NAS/My_Music_1/Willie Nelson/Stardust/02-Georgia On My Mind.flac' Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Exploding uri mnt/NAS/My_Music_1/Joe Crookston/Fall Down As The Rain/02 Joe Crookston - Fall Down As The Rain.flac in service mpd Jul 01 22:44:20 minidsp-mr volumio[6852]: error: scanFolder - failure to stat '/mnt/NAS/My_Music_1/Joe Crookston/Fall Down As The Rain/02 Joe Crookston - Fall Down As The Rain.flac' Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Exploding uri mnt/NAS/My_Music_1/Rumer/Seasons of My Soul/01 Rumer - Slow.flac in service mpd Jul 01 22:44:20 minidsp-mr volumio[6852]: error: scanFolder - failure to stat '/mnt/NAS/My_Music_1/Rumer/Seasons of My Soul/01 Rumer - Slow.flac' Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Exploding uri mnt/NAS/My_Music_1/Helen Merrill/Helen Merrill/03 Helen Merrill - What's New¿.flac in service mpd Jul 01 22:44:20 minidsp-mr volumio[6852]: error: scanFolder - failure to stat '/mnt/NAS/My_Music_1/Helen Merrill/Helen Merrill/03 Helen Merrill - What's New¿.flac' Jul 01 22:44:20 minidsp-mr volumio[6852]: info: Exploding uri mnt/NAS/My_Music_1/Nils Lofgren/Acoustic Live/05 Nils Lofgren - Keith Don't Go.flac in service mpd Jul 01 22:44:20 minidsp-mr volumio[6852]: error: scanFolder - failure to stat '/mnt/NAS/My_Music_1/Nils Lofgren/Acoustic Live/05 Nils Lofgren - Keith Don't Go.flac' Jul 01 22:44:21 minidsp-mr volumio[6852]: info: Exploding uri mnt/NAS/My_Music_1/Linda Ronstadt/What's New/01-What's New.flac in service mpd Jul 01 22:44:21 minidsp-mr volumio[6852]: error: scanFolder - failure to stat '/mnt/NAS/My_Music_1/Linda Ronstadt/What's New/01-What's New.flac' Jul 01 22:44:21 minidsp-mr volumio[6852]: info: Exploding uri mnt/NAS/My_Music_1/Linda Ronstadt/What's New/07-What'll I Do_.flac in service mpd Jul 01 22:44:21 minidsp-mr volumio[6852]: error: scanFolder - failure to stat '/mnt/NAS/My_Music_1/Linda Ronstadt/What's New/07-What'll I Do_.flac' Jul 01 22:44:21 minidsp-mr volumio[6852]: info: Exploding uri mnt/NAS/My_Music_1/Joe Sample/Collection/07 Joe Sample - Fly With the Wings of Love.flac in service mpd Jul 01 22:44:21 minidsp-mr volumio[6852]: error: scanFolder - failure to stat '/mnt/NAS/My_Music_1/Joe Sample/Collection/07 Joe Sample - Fly With the Wings of Love.flac' Jul 01 22:44:21 minidsp-mr volumio[6852]: info: Exploding uri mnt/NAS/My_Music_1/Eva Cassidy/Live at Blues Alley/07 Eva Cassidy - Tall Trees in Georgia.flac in service mpd Jul 01 22:44:21 minidsp-mr volumio[6852]: error: scanFolder - failure to stat '/mnt/NAS/My_Music_1/Eva Cassidy/Live at Blues Alley/07 Eva Cassidy - Tall Trees in Georgia.flac' Jul 01 22:44:21 minidsp-mr volumio[6852]: info: Exploding uri mnt/NAS/My_Music_1/Eva Cassidy/Live at Blues Alley/08 Eva Cassidy - Fields of Gold.flac in service mpd Jul 01 22:44:21 minidsp-mr volumio[6852]: error: scanFolder - failure to stat '/mnt/NAS/My_Music_1/Eva Cassidy/Live at Blues Alley/08 Eva Cassidy - Fields of Gold.flac' Jul 01 22:44:21 minidsp-mr volumio[6852]: info: Exploding uri mnt/NAS/My_Music_1/Eva Cassidy/Songbird/10 Eva Cassidy - Over the Rainbow.flac in service mpd Jul 01 22:44:21 minidsp-mr volumio[6852]: error: scanFolder - failure to stat '/mnt/NAS/My_Music_1/Eva Cassidy/Songbird/10 Eva Cassidy - Over the Rainbow.flac' Jul 01 22:44:21 minidsp-mr volumio[6852]: info: Exploding uri mnt/NAS/My_Music_1/Fleetwood Mac/Rumours/11-Gold Dust Woman.flac in service mpd Jul 01 22:44:21 minidsp-mr volumio[6852]: error: scanFolder - failure to stat '/mnt/NAS/My_Music_1/Fleetwood Mac/Rumours/11-Gold Dust Woman.flac' Jul 01 22:44:21 minidsp-mr volumio[6852]: info: Exploding uri mnt/NAS/My_Music_1/Muddy Waters/Folk Singer/04-Good Morning Little Schoolgirl.flac in service mpd Jul 01 22:44:21 minidsp-mr volumio[6852]: error: scanFolder - failure to stat '/mnt/NAS/My_Music_1/Muddy Waters/Folk Singer/04-Good Morning Little Schoolgirl.flac' Jul 01 22:44:21 minidsp-mr volumio[6852]: info: Exploding uri mnt/NAS/My_Music_1/Supertramp/Crime of the Century/01 Supertramp - School.flac in service mpd Jul 01 22:44:21 minidsp-mr volumio[6852]: error: scanFolder - failure to stat '/mnt/NAS/My_Music_1/Supertramp/Crime of the Century/01 Supertramp - School.flac' Jul 01 22:44:21 minidsp-mr volumio[6852]: info: Exploding uri mnt/NAS/My_Music_1/Rosanne Cash/The River & The Thread (Deluxe)/10-When The Master Calls The Roll.flac in service mpd Jul 01 22:44:21 minidsp-mr volumio[6852]: error: scanFolder - failure to stat '/mnt/NAS/My_Music_1/Rosanne Cash/The River & The Thread (Deluxe)/10-When The Master Calls The Roll.flac' Jul 01 22:44:21 minidsp-mr volumio[6852]: info: Exploding uri mnt/NAS/My_Music_1/Mazzy Star/So Tonight That I Might See/09 Mazzy Star - Into Dust.flac in service mpd Jul 01 22:44:21 minidsp-mr volumio[6852]: error: scanFolder - failure to stat '/mnt/NAS/My_Music_1/Mazzy Star/So Tonight That I Might See/09 Mazzy Star - Into Dust.flac' Jul 01 22:44:21 minidsp-mr volumio[6852]: info: Exploding uri mnt/NAS/My_Music_1/Jennifer Warnes/Famous Blue Raincoat/07 Jennifer Warnes - Song Of Bernardette.flac in service mpd Jul 01 22:44:21 minidsp-mr volumio[6852]: error: scanFolder - failure to stat '/mnt/NAS/My_Music_1/Jennifer Warnes/Famous Blue Raincoat/07 Jennifer Warnes - Song Of Bernardette.flac' Jul 01 22:44:21 minidsp-mr volumio[6852]: info: Exploding uri mnt/NAS/My_Music_1/Jennifer Warnes/Famous Blue Raincoat/04 Jennifer Warnes - Joan of Arc.flac in service mpd Jul 01 22:44:21 minidsp-mr volumio[6852]: error: scanFolder - failure to stat '/mnt/NAS/My_Music_1/Jennifer Warnes/Famous Blue Raincoat/04 Jennifer Warnes - Joan of Arc.flac' Jul 01 22:44:21 minidsp-mr volumio[6852]: info: Exploding uri mnt/NAS/My_Music_1/Michael Jackson/Bad/08 Michael Jackson - I Just Can't Stop Loving You.flac in service mpd Jul 01 22:44:21 minidsp-mr volumio[6852]: error: scanFolder - failure to stat '/mnt/NAS/My_Music_1/Michael Jackson/Bad/08 Michael Jackson - I Just Can't Stop Loving You.flac' Jul 01 22:44:21 minidsp-mr volumio[6852]: info: Exploding uri mnt/NAS/My_Music_1/Adele/Skyfall - Single/01-Skyfall.flac in service mpd Jul 01 22:44:21 minidsp-mr volumio[6852]: error: scanFolder - failure to stat '/mnt/NAS/My_Music_1/Adele/Skyfall - Single/01-Skyfall.flac' Jul 01 22:44:21 minidsp-mr volumio[6852]: info: Exploding uri mnt/NAS/My_Music_1/Lori Lieberman/Home of Whispers/04 Lori Leiberman - Home of Whispers.flac in service mpd Jul 01 22:44:21 minidsp-mr volumio[6852]: error: scanFolder - failure to stat '/mnt/NAS/My_Music_1/Lori Lieberman/Home of Whispers/04 Lori Leiberman - Home of Whispers.flac' Jul 01 22:44:21 minidsp-mr volumio[6852]: info: Exploding uri mnt/NAS/My_Music_1/Dan Fogelberg/Nether Lands/10 Dan Fogelberg - Sketches.flac in service mpd Jul 01 22:44:21 minidsp-mr volumio[6852]: error: scanFolder - failure to stat '/mnt/NAS/My_Music_1/Dan Fogelberg/Nether Lands/10 Dan Fogelberg - Sketches.flac' Jul 01 22:44:21 minidsp-mr volumio[6852]: info: Exploding uri mnt/NAS/Music/Patricia Barber/Café Blue/09 Patricia Barber - Too Rich for My Blood.flac in service mpd Jul 01 22:44:21 minidsp-mr volumio[6852]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 01 22:44:21 minidsp-mr volumio[6852]: TypeError: Cannot read property 'then' of undefined Jul 01 22:44:21 minidsp-mr volumio[6852]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2527:19) Jul 01 22:44:21 minidsp-mr volumio[6852]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2325:21) Jul 01 22:44:21 minidsp-mr volumio[6852]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1359:16) Jul 01 22:44:21 minidsp-mr volumio[6852]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Jul 01 22:44:21 minidsp-mr volumio[6852]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Jul 01 22:44:21 minidsp-mr volumio[6852]: at Timeout._onTimeout (/volumio/app/playqueue.js:146:100) Jul 01 22:44:21 minidsp-mr volumio[6852]: at listOnTimeout (internal/timers.js:557:17) Jul 01 22:44:21 minidsp-mr volumio[6852]: at processTimers (internal/timers.js:500:7) Jul 01 22:44:21 minidsp-mr volumio[6852]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 01 22:44:22 minidsp-mr systemd[1]: Started Music Player Daemon. Jul 01 22:44:22 minidsp-mr sudo[7059]: pam_unix(sudo:session): session closed for user root Jul 01 22:44:22 minidsp-mr sudo[7070]: pam_unix(sudo:session): session closed for user root Jul 01 22:44:22 minidsp-mr sudo[7195]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-01 22:43 Jul 01 22:44:22 minidsp-mr sudo[7195]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="17fcb754ddd6bd152b01008c46cc4ba1ca48bf35" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="281cefcd7a302aa7cfba569185cf7aae19b8c376" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="minidspshd" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 22 Mar 2024 03:00:28 PM CET" VOLUMIO_VERSION="3.608" VOLUMIO_HARDWARE="nanopineo2" VOLUMIO_DEVICENAME="NanoPi Neo2" VOLUMIO_VENDOR="miniDSP" VOLUMIO_MODEL="SHD" VOLUMIO_VENDOR_MODEL="miniDSP SHD" VOLUMIO_HASH="29ccfe8a9cff19911db4b736879ac117"